Test Date: 1973-11-29 16:33
Analysis date: 2016-06-28 11:22
Logfile
hrData_40.log
[14:29:06.915] INFO: *** Welcome to pxar ***
[14:29:06.915] INFO: *** Today: 2016/06/20
[14:29:06.938] INFO: *** Version: v1.9.0-814-g7497
[14:29:06.938] INFO: readRocDacs: data/mp342/dacParameters35_C0.dat .. data/mp342/dacParameters35_C15.dat
[14:29:06.939] INFO: readTbmDacs: data/mp342/tbmParameters_C0a.dat .. data/mp342/tbmParameters_C0b.dat
[14:29:06.939] INFO: readMaskFile: data/mp342/defaultMaskFile.dat
[14:29:06.940] INFO: readTrimFile: data/mp342/trimParameters35_C0.dat .. data/mp342/trimParameters35_C15.dat
[14:29:07.090] INFO: clk: 4
[14:29:07.090] INFO: ctr: 4
[14:29:07.090] INFO: sda: 19
[14:29:07.090] INFO: tin: 9
[14:29:07.090] INFO: level: 15
[14:29:07.090] INFO: triggerdelay: 0
[14:29:07.091] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[14:29:07.091] INFO: Log level: DEBUG
[14:29:07.104] QUIET: Connection to board DTB_WRPRHI opened.
[14:29:07.107] 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:
------------------------------------------------------
[14:29:07.110] INFO: RPC call hashes of host and DTB match: 398089610
[14:29:08.714] INFO: DUT info:
[14:29:08.714] INFO: The DUT currently contains the following objects:
[14:29:08.714] INFO: 2 TBM Cores tbm08c (2 ON)
[14:29:08.714] INFO: TBM Core alpha (0): 7 registers set
[14:29:08.714] INFO: TBM Core beta (1): 7 registers set
[14:29:08.714] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:29:08.714] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:29:08.714] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:29:08.714] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:29:08.714] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:29:08.714] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:29:08.714] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:29:08.714] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:29:08.714] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:29:08.715] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:29:08.715] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:29:08.715] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:29:08.715] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:29:08.715] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:29:08.715] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:29:08.715] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:29:08.715] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[14:29:08.715] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[14:29:08.716] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[14:29:08.717] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[14:29:08.718] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[14:29:08.720] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 35577856
[14:29:08.720] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x27a8110
[14:29:08.720] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x2736360
[14:29:08.720] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f5e79393010
[14:29:08.720] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f5e7f5fe510
[14:29:08.720] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 35586048 fPxarMemory = 0x7f5e79393010
[14:29:08.722] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 390.7mA
[14:29:08.723] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 464.7mA
[14:29:08.723] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.4 C
[14:29:09.223] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x2d7edc0
[14:29:09.285] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[14:29:09.285] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[14:29:09.285] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[14:29:09.290] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[14:29:09.290] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[14:29:09.290] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[14:29:09.298] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[14:29:09.298] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[14:29:09.310] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[14:29:09.310] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[14:29:09.334] INFO: PixTestCmd::init()
[14:29:09.350] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[14:29:09.350] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[14:29:09.350] INFO: readGainPedestalParameters data/mp342/phCalibrationFitErr35_C0.dat .. data/mp342/phCalibrationFitErr35_C15.dat
[14:29:09.593] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[14:29:09.593] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[14:29:09.605] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[14:29:09.611] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[14:29:09.611] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[14:29:09.611] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[14:29:09.631] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[14:29:09.631] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[14:29:09.631] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[14:29:09.631] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[14:29:09.631] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[14:29:09.637] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[14:29:09.637] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[14:29:09.650] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[14:29:09.650] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[14:29:09.650] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[14:29:09.650] INFO: readReadbackCal: data/mp342/readbackCal_C0.dat .. data/mp342/readbackCal_C15.dat
[14:29:09.662] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[14:29:09.668] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[14:29:09.668] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[14:29:09.668] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[14:29:09.668] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[14:29:09.681] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[14:29:09.681] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[14:29:13.596] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 1 -> source to value 02ma
[14:29:15.356] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 2 -> runseconds to value 60
[14:29:16.825] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): phrun
[14:29:16.825] DEBUG: <PixTestXray.cc/runCommand:L109> running command: phrun
[14:29:16.825] INFO: ----------------------------------------------------------------------
[14:29:16.825] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[14:29:16.825] INFO: ----------------------------------------------------------------------
[14:29:17.799] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[14:29:30.043] INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[14:29:30.047] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:29:57.168] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1206384 events.
[14:30:03.507] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1206384, pixels seen in all events: 5774900
[14:30:03.601] INFO: Resuming triggers.
[14:30:15.846] INFO: run duration 24 seconds, buffer almost full (81%), pausing triggers.
[14:30:15.878] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:30:42.839] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1206344 events.
[14:30:49.186] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1206344, pixels seen in all events: 5775047
[14:30:49.358] INFO: Resuming triggers.
[14:31:01.604] INFO: run duration 36 seconds, buffer almost full (81%), pausing triggers.
[14:31:01.639] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:31:28.738] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1206466 events.
[14:31:35.002] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1206466, pixels seen in all events: 5773788
[14:31:35.248] INFO: Resuming triggers.
[14:31:47.493] INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[14:31:47.530] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:32:14.579] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1206258 events.
[14:32:20.932] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1206258, pixels seen in all events: 5775752
[14:32:21.106] INFO: Resuming triggers.
[14:32:32.203] INFO: data taking finished, elapsed time: 60 seconds.
[14:32:32.399] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:32:56.818] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1093168 events.
[14:33:02.557] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1093168, pixels seen in all events: 5224818
[14:33:02.720] INFO: PixTest:: pg_setup set to default.
[14:33:02.757] INFO: PixTestXray::doPhRun() done
[14:33:06.921] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[14:33:06.922] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 393.1mA
[14:33:06.923] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 464.7mA
[14:33:06.923] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.2 C
[14:33:06.923] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[14:33:06.923] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[14:33:06.923] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[14:33:06.923] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[14:33:06.923] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[14:33:06.923] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[14:33:06.923] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[14:33:06.923] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[14:33:06.923] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[14:33:06.923] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[14:33:06.924] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[14:33:06.924] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[14:33:06.924] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[14:33:06.924] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[14:33:06.924] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[14:33:06.924] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[14:33:06.924] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[14:33:06.924] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[14:33:07.201] QUIET: Connection to board 58 closed.
[14:33:07.280] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrData_120.log
[14:33:13.268] INFO: *** Welcome to pxar ***
[14:33:13.268] INFO: *** Today: 2016/06/20
[14:33:13.294] INFO: *** Version: v1.9.0-814-g7497
[14:33:13.294] INFO: readRocDacs: data/mp342/dacParameters35_C0.dat .. data/mp342/dacParameters35_C15.dat
[14:33:13.296] INFO: readTbmDacs: data/mp342/tbmParameters_C0a.dat .. data/mp342/tbmParameters_C0b.dat
[14:33:13.296] INFO: readMaskFile: data/mp342/defaultMaskFile.dat
[14:33:13.296] INFO: readTrimFile: data/mp342/trimParameters35_C0.dat .. data/mp342/trimParameters35_C15.dat
[14:33:13.446] INFO: clk: 4
[14:33:13.446] INFO: ctr: 4
[14:33:13.446] INFO: sda: 19
[14:33:13.446] INFO: tin: 9
[14:33:13.446] INFO: level: 15
[14:33:13.446] INFO: triggerdelay: 0
[14:33:13.446] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[14:33:13.446] INFO: Log level: DEBUG
[14:33:13.457] QUIET: Connection to board DTB_WRPRHI opened.
[14:33:13.461] 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:
------------------------------------------------------
[14:33:13.463] INFO: RPC call hashes of host and DTB match: 398089610
[14:33:15.066] INFO: DUT info:
[14:33:15.066] INFO: The DUT currently contains the following objects:
[14:33:15.066] INFO: 2 TBM Cores tbm08c (2 ON)
[14:33:15.066] INFO: TBM Core alpha (0): 7 registers set
[14:33:15.067] INFO: TBM Core beta (1): 7 registers set
[14:33:15.067] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:33:15.067] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:15.067] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:15.067] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:15.067] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:15.067] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:15.067] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:15.067] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:15.067] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:15.067] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:15.067] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:15.067] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:15.067] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:15.067] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:15.067] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:15.067] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:15.067] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:15.067] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[14:33:15.067] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[14:33:15.067] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[14:33:15.067] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[14:33:15.067] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[14:33:15.067] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[14:33:15.068] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[14:33:15.069] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[14:33:15.070] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[14:33:15.071] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[14:33:15.071] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[14:33:15.073] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 33615872
[14:33:15.073] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x2923110
[14:33:15.073] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x28b1360
[14:33:15.073] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7fc8b5d94010
[14:33:15.073] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7fc8bbfff510
[14:33:15.073] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 33624064 fPxarMemory = 0x7fc8b5d94010
[14:33:15.074] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 390.7mA
[14:33:15.075] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 464.7mA
[14:33:15.075] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.4 C
[14:33:15.570] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x2ef9da0
[14:33:15.632] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[14:33:15.632] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[14:33:15.633] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[14:33:15.638] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[14:33:15.638] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[14:33:15.638] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[14:33:15.646] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[14:33:15.646] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[14:33:15.671] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[14:33:15.671] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[14:33:15.686] INFO: PixTestCmd::init()
[14:33:15.690] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[14:33:15.690] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[14:33:15.690] INFO: readGainPedestalParameters data/mp342/phCalibrationFitErr35_C0.dat .. data/mp342/phCalibrationFitErr35_C15.dat
[14:33:15.932] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[14:33:15.933] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[14:33:15.944] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[14:33:15.951] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[14:33:15.951] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[14:33:15.951] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[14:33:15.971] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[14:33:15.971] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[14:33:15.971] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[14:33:15.971] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[14:33:15.971] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[14:33:15.978] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[14:33:15.978] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[14:33:16.002] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[14:33:16.002] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[14:33:16.002] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[14:33:16.002] INFO: readReadbackCal: data/mp342/readbackCal_C0.dat .. data/mp342/readbackCal_C15.dat
[14:33:16.011] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[14:33:16.020] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[14:33:16.020] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[14:33:16.020] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[14:33:16.020] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[14:33:16.038] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[14:33:16.038] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[14:33:21.868] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 1 -> source to value 06ma
[14:33:23.644] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 2 -> runseconds to value 60
[14:33:25.433] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): phrun
[14:33:25.433] DEBUG: <PixTestXray.cc/runCommand:L109> running command: phrun
[14:33:25.433] INFO: ----------------------------------------------------------------------
[14:33:25.433] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[14:33:25.433] INFO: ----------------------------------------------------------------------
[14:33:26.407] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[14:33:34.737] INFO: run duration 8 seconds, buffer almost full (81%), pausing triggers.
[14:33:34.741] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:34:00.258] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 820762 events.
[14:34:11.543] DEBUG: <PixTestXray.cc/processData:L823> # events read: 820762, pixels seen in all events: 10404214
[14:34:11.755] INFO: Resuming triggers.
[14:34:20.083] INFO: run duration 16 seconds, buffer almost full (81%), pausing triggers.
[14:34:20.173] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:34:45.579] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 820511 events.
[14:34:56.892] DEBUG: <PixTestXray.cc/processData:L823> # events read: 820511, pixels seen in all events: 10404984
[14:34:57.147] INFO: Resuming triggers.
[14:35:05.478] INFO: run duration 24 seconds, buffer almost full (81%), pausing triggers.
[14:35:05.515] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:35:30.954] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 820784 events.
[14:35:42.273] DEBUG: <PixTestXray.cc/processData:L823> # events read: 820784, pixels seen in all events: 10402131
[14:35:42.531] INFO: Resuming triggers.
[14:35:50.864] INFO: run duration 33 seconds, buffer almost full (81%), pausing triggers.
[14:35:50.901] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:36:16.326] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 820967 events.
[14:36:27.628] DEBUG: <PixTestXray.cc/processData:L823> # events read: 820967, pixels seen in all events: 10400142
[14:36:27.802] INFO: Resuming triggers.
[14:36:36.128] INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[14:36:36.241] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:37:01.712] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 820281 events.
[14:37:13.317] DEBUG: <PixTestXray.cc/processData:L823> # events read: 820281, pixels seen in all events: 10408010
[14:37:13.572] INFO: Resuming triggers.
[14:37:21.904] INFO: run duration 49 seconds, buffer almost full (81%), pausing triggers.
[14:37:21.941] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:37:47.302] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 820771 events.
[14:37:58.244] DEBUG: <PixTestXray.cc/processData:L823> # events read: 820771, pixels seen in all events: 10402291
[14:37:58.502] INFO: Resuming triggers.
[14:38:06.830] INFO: run duration 58 seconds, buffer almost full (81%), pausing triggers.
[14:38:06.866] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:38:32.257] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 820388 events.
[14:38:42.754] DEBUG: <PixTestXray.cc/processData:L823> # events read: 820388, pixels seen in all events: 10406876
[14:38:43.010] INFO: Resuming triggers.
[14:38:44.783] INFO: data taking finished, elapsed time: 60 seconds.
[14:38:44.979] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:38:50.545] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 174574 events.
[14:38:52.778] DEBUG: <PixTestXray.cc/processData:L823> # events read: 174574, pixels seen in all events: 2214055
[14:38:52.848] INFO: PixTest:: pg_setup set to default.
[14:38:52.884] INFO: PixTestXray::doPhRun() done
[14:38:59.073] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[14:38:59.074] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 393.9mA
[14:38:59.074] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 466.3mA
[14:38:59.075] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.1 C
[14:38:59.075] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[14:38:59.075] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[14:38:59.075] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[14:38:59.075] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[14:38:59.075] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[14:38:59.075] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[14:38:59.075] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[14:38:59.075] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[14:38:59.075] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[14:38:59.075] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[14:38:59.075] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[14:38:59.075] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[14:38:59.075] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[14:38:59.076] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[14:38:59.076] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[14:38:59.076] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[14:38:59.076] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[14:38:59.076] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[14:38:59.377] QUIET: Connection to board 58 closed.
[14:38:59.456] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrEff_40.log
[14:22:07.003] INFO: *** Welcome to pxar ***
[14:22:07.003] INFO: *** Today: 2016/06/20
[14:22:07.028] INFO: *** Version: v1.9.0-814-g7497
[14:22:07.028] INFO: readRocDacs: data/mp342/dacParameters35_C0.dat .. data/mp342/dacParameters35_C15.dat
[14:22:07.029] INFO: readTbmDacs: data/mp342/tbmParameters_C0a.dat .. data/mp342/tbmParameters_C0b.dat
[14:22:07.030] INFO: readMaskFile: data/mp342/defaultMaskFile.dat
[14:22:07.030] INFO: readTrimFile: data/mp342/trimParameters35_C0.dat .. data/mp342/trimParameters35_C15.dat
[14:22:07.179] INFO: clk: 4
[14:22:07.179] INFO: ctr: 4
[14:22:07.179] INFO: sda: 19
[14:22:07.179] INFO: tin: 9
[14:22:07.179] INFO: level: 15
[14:22:07.179] INFO: triggerdelay: 0
[14:22:07.179] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[14:22:07.180] INFO: Log level: DEBUG
[14:22:07.191] QUIET: Connection to board DTB_WRPRHI opened.
[14:22:07.194] 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:
------------------------------------------------------
[14:22:07.197] INFO: RPC call hashes of host and DTB match: 398089610
[14:22:08.799] INFO: DUT info:
[14:22:08.799] INFO: The DUT currently contains the following objects:
[14:22:08.799] INFO: 2 TBM Cores tbm08c (2 ON)
[14:22:08.799] INFO: TBM Core alpha (0): 7 registers set
[14:22:08.799] INFO: TBM Core beta (1): 7 registers set
[14:22:08.799] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:22:08.799] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:22:08.799] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:22:08.799] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:22:08.799] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:22:08.799] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:22:08.799] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:22:08.799] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:22:08.799] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:22:08.799] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:22:08.799] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:22:08.799] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:22:08.799] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:22:08.799] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:22:08.799] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:22:08.799] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:22:08.800] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[14:22:08.800] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[14:22:08.801] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[14:22:08.802] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[14:22:08.803] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[14:22:08.803] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[14:22:08.803] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[14:22:08.803] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[14:22:08.803] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[14:22:08.803] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[14:22:08.803] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[14:22:08.803] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[14:22:08.803] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[14:22:08.803] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[14:22:08.803] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[14:22:08.803] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[14:22:08.803] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[14:22:08.803] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[14:22:08.803] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[14:22:08.803] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[14:22:08.803] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[14:22:08.803] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[14:22:08.803] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[14:22:08.803] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[14:22:08.803] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[14:22:08.805] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 34914304
[14:22:08.805] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0xf1f110
[14:22:08.805] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0xead360
[14:22:08.805] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7fabe9d94010
[14:22:08.805] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7fabeffff510
[14:22:08.805] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 34922496 fPxarMemory = 0x7fabe9d94010
[14:22:08.806] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 390.7mA
[14:22:08.807] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 464.7mA
[14:22:08.807] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.2 C
[14:22:09.303] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x14f5e10
[14:22:09.367] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[14:22:09.368] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[14:22:09.368] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[14:22:09.373] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[14:22:09.373] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[14:22:09.373] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[14:22:09.382] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[14:22:09.382] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[14:22:09.408] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[14:22:09.408] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[14:22:09.423] INFO: PixTestCmd::init()
[14:22:09.431] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[14:22:09.432] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[14:22:09.432] INFO: readGainPedestalParameters data/mp342/phCalibrationFitErr35_C0.dat .. data/mp342/phCalibrationFitErr35_C15.dat
[14:22:09.674] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[14:22:09.674] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[14:22:09.687] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[14:22:09.694] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[14:22:09.694] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[14:22:09.694] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[14:22:09.716] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[14:22:09.716] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[14:22:09.716] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[14:22:09.716] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[14:22:09.716] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[14:22:09.722] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[14:22:09.723] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[14:22:09.740] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[14:22:09.740] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[14:22:09.740] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[14:22:09.740] INFO: readReadbackCal: data/mp342/readbackCal_C0.dat .. data/mp342/readbackCal_C15.dat
[14:22:09.749] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[14:22:09.757] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[14:22:09.757] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[14:22:09.757] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[14:22:09.757] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[14:22:09.773] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[14:22:09.773] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[14:22:14.988] INFO: ######################################################################
[14:22:14.988] INFO: PixTestAlive::doTest()
[14:22:14.988] INFO: ######################################################################
[14:22:14.992] INFO: ----------------------------------------------------------------------
[14:22:14.992] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:22:14.992] INFO: ----------------------------------------------------------------------
[14:22:14.994] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:22:15.374] INFO: Expecting 41600 events.
[14:22:19.770] INFO: 41600 events read in total (3678ms).
[14:22:19.917] INFO: Test took 4923ms.
[14:22:19.928] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:22:19.928] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66558
[14:22:19.928] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists PixelAlive_C0 .. PixelAlive_C15
[14:22:20.199] INFO: PixTestAlive::aliveTest() done
[14:22:20.199] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 2 0 0 0 0
[14:22:20.199] DEBUG: <PixTestAlive.cc/aliveTest:L199> number of red-efficiency pixels: 16 9 17 38 29 34 27 30 32 34 39 33 28 22 7 14
[14:22:20.225] INFO: ----------------------------------------------------------------------
[14:22:20.225] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:22:20.225] INFO: ----------------------------------------------------------------------
[14:22:20.227] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:22:20.605] INFO: Expecting 41600 events.
[14:22:23.726] INFO: 41600 events read in total (2406ms).
[14:22:23.727] INFO: Test took 3500ms.
[14:22:23.727] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:22:23.727] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 0
[14:22:23.727] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists MaskTest_C0 .. MaskTest_C15
[14:22:23.727] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:22:24.149] INFO: PixTestAlive::maskTest() done
[14:22:24.149] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:22:24.168] INFO: ----------------------------------------------------------------------
[14:22:24.168] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:22:24.168] INFO: ----------------------------------------------------------------------
[14:22:24.171] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:22:24.547] INFO: Expecting 41600 events.
[14:22:28.934] INFO: 41600 events read in total (3671ms).
[14:22:28.935] INFO: Test took 4764ms.
[14:22:28.946] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:22:28.946] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66558
[14:22:28.946] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists AddressDecodingTest_C0 .. AddressDecodingTest_C15
[14:22:29.316] INFO: PixTestAlive::addressDecodingTest() done
[14:22:29.317] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:22:29.317] INFO: PixTestAlive::doTest() done, duration: 14 seconds
[14:22:31.481] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): caldelscan
[14:22:31.481] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: caldelscan
[14:22:31.481] INFO: ----------------------------------------------------------------------
[14:22:31.481] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[14:22:31.481] INFO: ----------------------------------------------------------------------
[14:22:31.620] INFO: Expecting 768 events.
[14:22:32.754] INFO: 768 events read in total (419ms).
[14:22:32.754] INFO: Test took 1268ms.
[14:22:32.760] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:22:33.558] INFO: Expecting 41600 events.
[14:22:36.834] INFO: 41600 events read in total (2750ms).
[14:22:36.838] INFO: Test took 4078ms.
[14:22:36.909] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:22:36.909] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 421259
[14:22:36.909] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step0_C0 .. HR_xeff_CalDelScan_step0_C15
[14:22:36.909] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:22:36.944] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:22:37.609] INFO: Expecting 41600 events.
[14:22:41.014] INFO: 41600 events read in total (2878ms).
[14:22:41.017] INFO: Test took 4073ms.
[14:22:41.090] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:22:41.090] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 428376
[14:22:41.090] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step1_C0 .. HR_xeff_CalDelScan_step1_C15
[14:22:41.090] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:22:41.125] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:22:41.791] INFO: Expecting 41600 events.
[14:22:45.231] INFO: 41600 events read in total (2914ms).
[14:22:45.235] INFO: Test took 4110ms.
[14:22:45.306] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:22:45.306] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 429839
[14:22:45.306] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step2_C0 .. HR_xeff_CalDelScan_step2_C15
[14:22:45.307] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:22:45.343] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:22:46.009] INFO: Expecting 41600 events.
[14:22:49.457] INFO: 41600 events read in total (2922ms).
[14:22:49.461] INFO: Test took 4118ms.
[14:22:49.533] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:22:49.533] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 430923
[14:22:49.533] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step3_C0 .. HR_xeff_CalDelScan_step3_C15
[14:22:49.533] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:22:49.569] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:22:50.235] INFO: Expecting 41600 events.
[14:22:53.690] INFO: 41600 events read in total (2929ms).
[14:22:53.693] INFO: Test took 4124ms.
[14:22:53.765] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:22:53.765] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 431113
[14:22:53.765] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step4_C0 .. HR_xeff_CalDelScan_step4_C15
[14:22:53.765] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:22:53.802] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:22:54.467] INFO: Expecting 41600 events.
[14:22:57.928] INFO: 41600 events read in total (2934ms).
[14:22:57.931] INFO: Test took 4129ms.
[14:22:58.001] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:22:58.001] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 430026
[14:22:58.001] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step5_C0 .. HR_xeff_CalDelScan_step5_C15
[14:22:58.001] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:22:58.038] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:22:58.703] INFO: Expecting 41600 events.
[14:23:02.167] INFO: 41600 events read in total (2937ms).
[14:23:02.170] INFO: Test took 4132ms.
[14:23:02.242] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:23:02.242] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 431085
[14:23:02.242] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step6_C0 .. HR_xeff_CalDelScan_step6_C15
[14:23:02.242] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:23:02.279] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:23:02.943] INFO: Expecting 41600 events.
[14:23:06.408] INFO: 41600 events read in total (2938ms).
[14:23:06.411] INFO: Test took 4132ms.
[14:23:06.481] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:23:06.481] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 431219
[14:23:06.481] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step7_C0 .. HR_xeff_CalDelScan_step7_C15
[14:23:06.482] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:23:06.518] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:23:07.183] INFO: Expecting 41600 events.
[14:23:10.648] INFO: 41600 events read in total (2938ms).
[14:23:10.652] INFO: Test took 4134ms.
[14:23:10.722] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:23:10.722] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 429359
[14:23:10.722] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step8_C0 .. HR_xeff_CalDelScan_step8_C15
[14:23:10.723] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:23:10.759] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:23:11.424] INFO: Expecting 41600 events.
[14:23:14.891] INFO: 41600 events read in total (2941ms).
[14:23:14.894] INFO: Test took 4135ms.
[14:23:14.965] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:23:14.965] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 431590
[14:23:14.966] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step9_C0 .. HR_xeff_CalDelScan_step9_C15
[14:23:14.966] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:23:15.002] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:23:15.668] INFO: Expecting 41600 events.
[14:23:19.135] INFO: 41600 events read in total (2941ms).
[14:23:19.139] INFO: Test took 4136ms.
[14:23:19.210] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:23:19.210] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 430553
[14:23:19.210] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step10_C0 .. HR_xeff_CalDelScan_step10_C15
[14:23:19.210] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:23:19.248] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:23:19.913] INFO: Expecting 41600 events.
[14:23:23.373] INFO: 41600 events read in total (2934ms).
[14:23:23.377] INFO: Test took 4129ms.
[14:23:23.447] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:23:23.448] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 430213
[14:23:23.448] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step11_C0 .. HR_xeff_CalDelScan_step11_C15
[14:23:23.448] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:23:23.484] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:23:24.149] INFO: Expecting 41600 events.
[14:23:27.612] INFO: 41600 events read in total (2936ms).
[14:23:27.615] INFO: Test took 4131ms.
[14:23:27.686] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:23:27.686] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 430195
[14:23:27.686] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step12_C0 .. HR_xeff_CalDelScan_step12_C15
[14:23:27.687] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:23:27.723] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:23:28.388] INFO: Expecting 41600 events.
[14:23:31.848] INFO: 41600 events read in total (2933ms).
[14:23:31.851] INFO: Test took 4128ms.
[14:23:31.923] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:23:31.923] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 431289
[14:23:31.923] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step13_C0 .. HR_xeff_CalDelScan_step13_C15
[14:23:31.923] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:23:31.960] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:23:32.625] INFO: Expecting 41600 events.
[14:23:36.090] INFO: 41600 events read in total (2938ms).
[14:23:36.094] INFO: Test took 4134ms.
[14:23:36.165] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:23:36.165] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 430659
[14:23:36.165] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step14_C0 .. HR_xeff_CalDelScan_step14_C15
[14:23:36.165] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:23:36.202] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:23:36.868] INFO: Expecting 41600 events.
[14:23:40.330] INFO: 41600 events read in total (2936ms).
[14:23:40.333] INFO: Test took 4130ms.
[14:23:40.405] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:23:40.405] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 430311
[14:23:40.405] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step15_C0 .. HR_xeff_CalDelScan_step15_C15
[14:23:40.405] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:23:40.442] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:23:41.107] INFO: Expecting 41600 events.
[14:23:44.572] INFO: 41600 events read in total (2938ms).
[14:23:44.575] INFO: Test took 4133ms.
[14:23:44.647] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:23:44.647] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 431155
[14:23:44.647] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step16_C0 .. HR_xeff_CalDelScan_step16_C15
[14:23:44.647] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:23:44.684] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:23:45.350] INFO: Expecting 41600 events.
[14:23:48.814] INFO: 41600 events read in total (2938ms).
[14:23:48.817] INFO: Test took 4133ms.
[14:23:48.888] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:23:48.888] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 429512
[14:23:48.888] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step17_C0 .. HR_xeff_CalDelScan_step17_C15
[14:23:48.889] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:23:48.925] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:23:49.590] INFO: Expecting 41600 events.
[14:23:53.022] INFO: 41600 events read in total (2905ms).
[14:23:53.025] INFO: Test took 4100ms.
[14:23:53.096] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:23:53.096] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 429328
[14:23:53.096] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step18_C0 .. HR_xeff_CalDelScan_step18_C15
[14:23:53.096] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:23:53.133] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:23:53.798] INFO: Expecting 41600 events.
[14:23:57.101] INFO: 41600 events read in total (2776ms).
[14:23:57.105] INFO: Test took 3972ms.
[14:23:57.175] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:23:57.175] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 423011
[14:23:57.175] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step19_C0 .. HR_xeff_CalDelScan_step19_C15
[14:23:57.175] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:23:57.432] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 0: caldel = 149 eff = 0.999832
[14:23:57.433] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 1: caldel = 167 eff = 0.999808
[14:23:57.433] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 2: caldel = 157 eff = 0.999639
[14:23:57.433] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 3: caldel = 171 eff = 0.999135
[14:23:57.433] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 4: caldel = 153 eff = 0.999135
[14:23:57.433] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 5: caldel = 150 eff = 0.999207
[14:23:57.433] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 6: caldel = 159 eff = 0.999135
[14:23:57.433] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 7: caldel = 152 eff = 0.999327
[14:23:57.434] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 8: caldel = 146 eff = 0.999159
[14:23:57.434] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 9: caldel = 142 eff = 0.999183
[14:23:57.434] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 10: caldel = 152 eff = 0.999135
[14:23:57.434] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 11: caldel = 155 eff = 0.998702
[14:23:57.434] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 12: caldel = 161 eff = 0.999303
[14:23:57.434] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 13: caldel = 165 eff = 0.999543
[14:23:57.434] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 14: caldel = 162 eff = 0.999808
[14:23:57.435] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 15: caldel = 175 eff = 0.999784
[14:24:32.161] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): xpixelalive
[14:24:32.161] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: xpixelalive
[14:24:32.161] INFO: ----------------------------------------------------------------------
[14:24:32.161] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:24:32.161] INFO: ----------------------------------------------------------------------
[14:24:32.162] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: clk: 4
[14:24:32.162] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: ctr: 4
[14:24:32.162] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: sda: 19
[14:24:32.162] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: tin: 9
[14:24:32.162] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: level: 15
[14:24:32.162] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: triggerdelay: 0
[14:24:32.162] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: clk: 4
[14:24:32.162] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: ctr: 4
[14:24:32.162] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: sda: 19
[14:24:32.162] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: tin: 9
[14:24:32.162] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: level: 15
[14:24:32.162] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: triggerdelay: 20
[14:24:32.180] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:24:32.848] INFO: Expecting 208000 events.
[14:24:45.968] INFO: 208000 events read in total (12593ms).
[14:24:45.978] INFO: Test took 13798ms.
[14:24:46.294] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:24:46.294] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1870956
[14:24:46.294] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists highRate_C0 .. highRate_C15
[14:24:46.295] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:24:46.651] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 2 0 0 0 0
[14:24:46.651] INFO: number of red-efficiency pixels: 66 64 120 178 236 214 232 189 223 281 242 219 188 114 61 77
[14:24:46.651] INFO: number of X-ray hits detected: 57736 51821 86035 133782 144073 141143 141312 134918 149720 151215 148470 136025 134757 87644 50470 55277
[14:24:46.651] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[14:24:46.651] INFO: number of Vcal hits detected: 207934 207936 207876 207818 207754 207779 207755 207807 207769 207715 207747 207667 207802 207882 207938 207922
[14:24:46.651] 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
[14:24:46.651] 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.8 99.9 99.9 100.0 100.0
[14:24:46.651] INFO: X-ray hit rate [MHz/cm2]: 16.9 15.2 25.2 39.2 42.2 41.4 41.4 39.5 43.9 44.3 43.5 39.9 39.5 25.7 14.8 16.2
[14:24:46.651] INFO: PixTestHighRate::doXPixelAlive() done
[14:24:46.696] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: clk: 4
[14:24:46.696] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: ctr: 4
[14:24:46.696] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: sda: 19
[14:24:46.696] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: tin: 9
[14:24:46.696] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: level: 15
[14:24:46.696] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: triggerdelay: 0
[14:24:46.696] INFO: PixTest:: pg_setup set to default.
[14:25:50.001] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[14:25:50.001] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = highRate_xraymap_C10_V0 -> highRate_xraymap_mod
[14:26:29.825] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[14:26:29.826] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 393.1mA
[14:26:29.827] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 464.7mA
[14:26:29.827] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.2 C
[14:26:29.827] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[14:26:29.827] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[14:26:29.827] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[14:26:29.827] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[14:26:29.827] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[14:26:29.827] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[14:26:29.827] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[14:26:29.827] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[14:26:29.827] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[14:26:29.827] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[14:26:29.914] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[14:26:29.914] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[14:26:29.923] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[14:26:29.923] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[14:26:29.923] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[14:26:29.923] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[14:26:29.923] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[14:26:29.923] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[14:26:29.926] QUIET: Connection to board 58 closed.
[14:26:30.005] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrEff_80.log
[14:18:49.568] INFO: *** Welcome to pxar ***
[14:18:49.568] INFO: *** Today: 2016/06/20
[14:18:49.594] INFO: *** Version: v1.9.0-814-g7497
[14:18:49.594] INFO: readRocDacs: data/mp342/dacParameters35_C0.dat .. data/mp342/dacParameters35_C15.dat
[14:18:49.595] INFO: readTbmDacs: data/mp342/tbmParameters_C0a.dat .. data/mp342/tbmParameters_C0b.dat
[14:18:49.595] INFO: readMaskFile: data/mp342/defaultMaskFile.dat
[14:18:49.595] INFO: readTrimFile: data/mp342/trimParameters35_C0.dat .. data/mp342/trimParameters35_C15.dat
[14:18:49.745] INFO: clk: 4
[14:18:49.745] INFO: ctr: 4
[14:18:49.745] INFO: sda: 19
[14:18:49.745] INFO: tin: 9
[14:18:49.745] INFO: level: 15
[14:18:49.745] INFO: triggerdelay: 0
[14:18:49.745] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[14:18:49.745] INFO: Log level: DEBUG
[14:18:49.756] QUIET: Connection to board DTB_WRPRHI opened.
[14:18:49.759] 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:
------------------------------------------------------
[14:18:49.762] INFO: RPC call hashes of host and DTB match: 398089610
[14:18:51.362] INFO: DUT info:
[14:18:51.362] INFO: The DUT currently contains the following objects:
[14:18:51.362] INFO: 2 TBM Cores tbm08c (2 ON)
[14:18:51.363] INFO: TBM Core alpha (0): 7 registers set
[14:18:51.363] INFO: TBM Core beta (1): 7 registers set
[14:18:51.363] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:18:51.363] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:18:51.363] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:18:51.363] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:18:51.363] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:18:51.363] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:18:51.363] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:18:51.363] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:18:51.363] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:18:51.363] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:18:51.363] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:18:51.363] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:18:51.363] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:18:51.363] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:18:51.363] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:18:51.363] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:18:51.363] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:18:51.363] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[14:18:51.363] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[14:18:51.363] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[14:18:51.363] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[14:18:51.363] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[14:18:51.364] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[14:18:51.365] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[14:18:51.366] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[14:18:51.369] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 32755712
[14:18:51.369] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x2928110
[14:18:51.369] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x28b6360
[14:18:51.369] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f2ee5d94010
[14:18:51.369] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f2eebfff510
[14:18:51.369] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 32763904 fPxarMemory = 0x7f2ee5d94010
[14:18:51.370] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 389.9mA
[14:18:51.371] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 464.7mA
[14:18:51.371] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.2 C
[14:18:51.866] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x2efedb0
[14:18:51.925] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[14:18:51.925] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[14:18:51.925] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[14:18:51.931] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[14:18:51.931] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[14:18:51.931] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[14:18:51.939] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[14:18:51.939] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[14:18:51.962] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[14:18:51.962] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[14:18:51.977] INFO: PixTestCmd::init()
[14:18:51.982] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[14:18:51.982] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[14:18:51.982] INFO: readGainPedestalParameters data/mp342/phCalibrationFitErr35_C0.dat .. data/mp342/phCalibrationFitErr35_C15.dat
[14:18:52.227] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[14:18:52.227] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[14:18:52.242] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[14:18:52.247] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[14:18:52.247] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[14:18:52.247] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[14:18:52.267] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[14:18:52.267] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[14:18:52.267] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[14:18:52.267] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[14:18:52.267] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[14:18:52.273] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[14:18:52.273] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[14:18:52.287] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[14:18:52.287] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[14:18:52.287] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[14:18:52.287] INFO: readReadbackCal: data/mp342/readbackCal_C0.dat .. data/mp342/readbackCal_C15.dat
[14:18:52.297] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[14:18:52.303] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[14:18:52.303] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[14:18:52.303] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[14:18:52.303] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[14:18:52.314] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[14:18:52.314] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[14:18:56.964] INFO: ######################################################################
[14:18:56.964] INFO: PixTestAlive::doTest()
[14:18:56.965] INFO: ######################################################################
[14:18:56.968] INFO: ----------------------------------------------------------------------
[14:18:56.968] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:18:56.968] INFO: ----------------------------------------------------------------------
[14:18:56.970] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:18:57.349] INFO: Expecting 41600 events.
[14:19:01.770] INFO: 41600 events read in total (3703ms).
[14:19:01.917] INFO: Test took 4947ms.
[14:19:01.929] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:19:01.929] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66558
[14:19:01.929] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists PixelAlive_C0 .. PixelAlive_C15
[14:19:02.204] INFO: PixTestAlive::aliveTest() done
[14:19:02.204] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 2 0 0 0 0
[14:19:02.204] DEBUG: <PixTestAlive.cc/aliveTest:L199> number of red-efficiency pixels: 13 15 34 43 58 58 55 46 76 65 55 53 39 39 15 24
[14:19:02.230] INFO: ----------------------------------------------------------------------
[14:19:02.230] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:19:02.230] INFO: ----------------------------------------------------------------------
[14:19:02.232] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:19:02.609] INFO: Expecting 41600 events.
[14:19:05.712] INFO: 41600 events read in total (2388ms).
[14:19:05.712] INFO: Test took 3480ms.
[14:19:05.712] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:19:05.713] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 0
[14:19:05.713] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists MaskTest_C0 .. MaskTest_C15
[14:19:05.713] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:19:06.136] INFO: PixTestAlive::maskTest() done
[14:19:06.136] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:19:06.158] INFO: ----------------------------------------------------------------------
[14:19:06.158] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:19:06.158] INFO: ----------------------------------------------------------------------
[14:19:06.160] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:19:06.537] INFO: Expecting 41600 events.
[14:19:10.936] INFO: 41600 events read in total (3683ms).
[14:19:10.937] INFO: Test took 4777ms.
[14:19:10.948] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:19:10.948] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66558
[14:19:10.948] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists AddressDecodingTest_C0 .. AddressDecodingTest_C15
[14:19:11.319] INFO: PixTestAlive::addressDecodingTest() done
[14:19:11.319] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:19:11.319] INFO: PixTestAlive::doTest() done, duration: 14 seconds
[14:19:15.673] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): caldelscan
[14:19:15.673] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: caldelscan
[14:19:15.673] INFO: ----------------------------------------------------------------------
[14:19:15.673] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[14:19:15.673] INFO: ----------------------------------------------------------------------
[14:19:15.812] INFO: Expecting 768 events.
[14:19:16.946] INFO: 768 events read in total (418ms).
[14:19:16.947] INFO: Test took 1268ms.
[14:19:16.952] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:19:17.750] INFO: Expecting 41600 events.
[14:19:21.241] INFO: 41600 events read in total (2964ms).
[14:19:21.246] INFO: Test took 4294ms.
[14:19:21.353] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:19:21.353] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 605973
[14:19:21.353] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step0_C0 .. HR_xeff_CalDelScan_step0_C15
[14:19:21.353] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:19:21.400] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:19:22.065] INFO: Expecting 41600 events.
[14:19:25.688] INFO: 41600 events read in total (3097ms).
[14:19:25.694] INFO: Test took 4294ms.
[14:19:25.800] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:19:25.800] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 615303
[14:19:25.800] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step1_C0 .. HR_xeff_CalDelScan_step1_C15
[14:19:25.801] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:19:25.849] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:19:26.513] INFO: Expecting 41600 events.
[14:19:30.166] INFO: 41600 events read in total (3126ms).
[14:19:30.170] INFO: Test took 4321ms.
[14:19:30.273] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:19:30.273] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 616454
[14:19:30.273] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step2_C0 .. HR_xeff_CalDelScan_step2_C15
[14:19:30.274] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:19:30.323] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:19:30.988] INFO: Expecting 41600 events.
[14:19:34.666] INFO: 41600 events read in total (3151ms).
[14:19:34.670] INFO: Test took 4347ms.
[14:19:34.776] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:19:34.776] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 618920
[14:19:34.776] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step3_C0 .. HR_xeff_CalDelScan_step3_C15
[14:19:34.776] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:19:34.824] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:19:35.489] INFO: Expecting 41600 events.
[14:19:39.163] INFO: 41600 events read in total (3147ms).
[14:19:39.167] INFO: Test took 4343ms.
[14:19:39.273] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:19:39.273] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 618211
[14:19:39.273] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step4_C0 .. HR_xeff_CalDelScan_step4_C15
[14:19:39.273] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:19:39.322] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:19:39.986] INFO: Expecting 41600 events.
[14:19:43.668] INFO: 41600 events read in total (3155ms).
[14:19:43.673] INFO: Test took 4351ms.
[14:19:43.777] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:19:43.777] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 616968
[14:19:43.777] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step5_C0 .. HR_xeff_CalDelScan_step5_C15
[14:19:43.778] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:19:43.827] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:19:44.492] INFO: Expecting 41600 events.
[14:19:48.185] INFO: 41600 events read in total (3167ms).
[14:19:48.190] INFO: Test took 4363ms.
[14:19:48.293] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:19:48.293] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 617997
[14:19:48.293] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step6_C0 .. HR_xeff_CalDelScan_step6_C15
[14:19:48.293] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:19:48.342] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:19:49.007] INFO: Expecting 41600 events.
[14:19:52.706] INFO: 41600 events read in total (3173ms).
[14:19:52.711] INFO: Test took 4369ms.
[14:19:52.815] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:19:52.815] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 620157
[14:19:52.815] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step7_C0 .. HR_xeff_CalDelScan_step7_C15
[14:19:52.815] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:19:52.863] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:19:53.528] INFO: Expecting 41600 events.
[14:19:57.219] INFO: 41600 events read in total (3164ms).
[14:19:57.223] INFO: Test took 4360ms.
[14:19:57.328] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:19:57.328] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 620433
[14:19:57.328] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step8_C0 .. HR_xeff_CalDelScan_step8_C15
[14:19:57.328] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:19:57.377] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:19:58.042] INFO: Expecting 41600 events.
[14:20:01.735] INFO: 41600 events read in total (3166ms).
[14:20:01.739] INFO: Test took 4362ms.
[14:20:01.846] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:20:01.846] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 619669
[14:20:01.846] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step9_C0 .. HR_xeff_CalDelScan_step9_C15
[14:20:01.847] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:20:01.895] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:20:02.560] INFO: Expecting 41600 events.
[14:20:06.249] INFO: 41600 events read in total (3163ms).
[14:20:06.254] INFO: Test took 4359ms.
[14:20:06.360] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:20:06.360] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 618579
[14:20:06.360] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step10_C0 .. HR_xeff_CalDelScan_step10_C15
[14:20:06.360] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:20:06.410] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:20:07.076] INFO: Expecting 41600 events.
[14:20:10.776] INFO: 41600 events read in total (3173ms).
[14:20:10.780] INFO: Test took 4370ms.
[14:20:10.886] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:20:10.886] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 619223
[14:20:10.886] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step11_C0 .. HR_xeff_CalDelScan_step11_C15
[14:20:10.886] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:20:10.935] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:20:11.600] INFO: Expecting 41600 events.
[14:20:15.293] INFO: 41600 events read in total (3167ms).
[14:20:15.298] INFO: Test took 4363ms.
[14:20:15.404] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:20:15.404] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 619509
[14:20:15.404] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step12_C0 .. HR_xeff_CalDelScan_step12_C15
[14:20:15.405] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:20:15.454] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:20:16.121] INFO: Expecting 41600 events.
[14:20:19.816] INFO: 41600 events read in total (3168ms).
[14:20:19.820] INFO: Test took 4366ms.
[14:20:19.925] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:20:19.925] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 620198
[14:20:19.925] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step13_C0 .. HR_xeff_CalDelScan_step13_C15
[14:20:19.926] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:20:19.974] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:20:20.639] INFO: Expecting 41600 events.
[14:20:24.314] INFO: 41600 events read in total (3149ms).
[14:20:24.319] INFO: Test took 4345ms.
[14:20:24.424] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:20:24.424] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 617901
[14:20:24.424] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step14_C0 .. HR_xeff_CalDelScan_step14_C15
[14:20:24.424] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:20:24.474] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:20:25.139] INFO: Expecting 41600 events.
[14:20:28.836] INFO: 41600 events read in total (3171ms).
[14:20:28.841] INFO: Test took 4367ms.
[14:20:28.945] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:20:28.945] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 619051
[14:20:28.946] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step15_C0 .. HR_xeff_CalDelScan_step15_C15
[14:20:28.946] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:20:28.995] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:20:29.660] INFO: Expecting 41600 events.
[14:20:33.337] INFO: 41600 events read in total (3151ms).
[14:20:33.341] INFO: Test took 4346ms.
[14:20:33.446] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:20:33.446] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 618416
[14:20:33.446] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step16_C0 .. HR_xeff_CalDelScan_step16_C15
[14:20:33.446] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:20:33.495] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:20:34.160] INFO: Expecting 41600 events.
[14:20:37.863] INFO: 41600 events read in total (3177ms).
[14:20:37.867] INFO: Test took 4372ms.
[14:20:37.971] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:20:37.971] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 619198
[14:20:37.971] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step17_C0 .. HR_xeff_CalDelScan_step17_C15
[14:20:37.971] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:20:38.020] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:20:38.687] INFO: Expecting 41600 events.
[14:20:42.340] INFO: 41600 events read in total (3126ms).
[14:20:42.344] INFO: Test took 4324ms.
[14:20:42.449] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:20:42.449] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 617477
[14:20:42.449] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step18_C0 .. HR_xeff_CalDelScan_step18_C15
[14:20:42.449] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:20:42.498] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:20:43.162] INFO: Expecting 41600 events.
[14:20:46.695] INFO: 41600 events read in total (3006ms).
[14:20:46.699] INFO: Test took 4201ms.
[14:20:46.802] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:20:46.802] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 613265
[14:20:46.802] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step19_C0 .. HR_xeff_CalDelScan_step19_C15
[14:20:46.803] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:20:47.072] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 0: caldel = 158 eff = 0.999591
[14:20:47.073] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 1: caldel = 159 eff = 0.999567
[14:20:47.073] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 2: caldel = 161 eff = 0.999038
[14:20:47.073] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 3: caldel = 175 eff = 0.998389
[14:20:47.073] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 4: caldel = 141 eff = 0.997933
[14:20:47.073] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 5: caldel = 148 eff = 0.998197
[14:20:47.073] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 6: caldel = 166 eff = 0.998413
[14:20:47.073] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 7: caldel = 151 eff = 0.998341
[14:20:47.074] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 8: caldel = 149 eff = 0.998221
[14:20:47.074] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 9: caldel = 155 eff = 0.997788
[14:20:47.074] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 10: caldel = 150 eff = 0.997933
[14:20:47.074] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 11: caldel = 153 eff = 0.997813
[14:20:47.074] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 12: caldel = 158 eff = 0.998245
[14:20:47.074] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 13: caldel = 162 eff = 0.999183
[14:20:47.074] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 14: caldel = 148 eff = 0.999615
[14:20:47.075] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 15: caldel = 154 eff = 0.999591
[14:21:17.289] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): xpixelalive
[14:21:17.289] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: xpixelalive
[14:21:17.289] INFO: ----------------------------------------------------------------------
[14:21:17.289] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:21:17.289] INFO: ----------------------------------------------------------------------
[14:21:17.290] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: clk: 4
[14:21:17.290] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: ctr: 4
[14:21:17.290] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: sda: 19
[14:21:17.290] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: tin: 9
[14:21:17.290] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: level: 15
[14:21:17.290] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: triggerdelay: 0
[14:21:17.290] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: clk: 4
[14:21:17.290] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: ctr: 4
[14:21:17.290] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: sda: 19
[14:21:17.290] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: tin: 9
[14:21:17.290] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: level: 15
[14:21:17.290] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: triggerdelay: 20
[14:21:17.311] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:21:17.978] INFO: Expecting 208000 events.
[14:21:32.573] INFO: 208000 events read in total (14068ms).
[14:21:32.587] INFO: Test took 15276ms.
[14:21:33.079] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:21:33.079] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 2804739
[14:21:33.079] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists highRate_C0 .. highRate_C15
[14:21:33.079] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:21:33.498] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 2 0 0 0 0
[14:21:33.499] INFO: number of red-efficiency pixels: 135 136 228 315 557 447 396 367 424 452 426 382 395 200 121 130
[14:21:33.499] INFO: number of X-ray hits detected: 87507 78592 130651 203000 218386 215517 214879 203601 225844 229032 226440 206218 205295 132933 76116 84170
[14:21:33.499] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[14:21:33.499] INFO: number of Vcal hits detected: 207862 207858 207761 207673 207400 207520 207579 207611 207553 207518 207537 207499 207576 207783 207874 207868
[14:21:33.499] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.9 99.7 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.9 99.9 99.9
[14:21:33.499] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.8 99.7 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.9 99.9 99.9
[14:21:33.499] INFO: X-ray hit rate [MHz/cm2]: 25.6 23.0 38.3 59.5 64.0 63.2 63.0 59.7 66.2 67.1 66.4 60.4 60.2 39.0 22.3 24.7
[14:21:33.499] INFO: PixTestHighRate::doXPixelAlive() done
[14:21:33.544] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: clk: 4
[14:21:33.544] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: ctr: 4
[14:21:33.544] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: sda: 19
[14:21:33.544] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: tin: 9
[14:21:33.544] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: level: 15
[14:21:33.544] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: triggerdelay: 0
[14:21:33.544] INFO: PixTest:: pg_setup set to default.
[14:21:56.841] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[14:21:56.841] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = highRate_xraymap_C11_V0 -> highRate_xraymap_mod
[14:22:01.977] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[14:22:01.978] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 393.1mA
[14:22:01.979] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 465.5mA
[14:22:01.979] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.2 C
[14:22:01.979] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[14:22:01.979] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[14:22:01.979] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[14:22:01.979] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[14:22:01.979] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[14:22:01.979] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[14:22:01.979] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[14:22:01.979] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[14:22:01.979] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[14:22:01.979] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[14:22:02.070] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[14:22:02.071] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[14:22:02.080] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[14:22:02.080] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[14:22:02.080] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[14:22:02.080] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[14:22:02.080] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[14:22:02.080] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[14:22:02.083] QUIET: Connection to board 58 closed.
[14:22:02.162] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrEff_120.log
[14:15:38.533] INFO: *** Welcome to pxar ***
[14:15:38.533] INFO: *** Today: 2016/06/20
[14:15:38.558] INFO: *** Version: v1.9.0-814-g7497
[14:15:38.558] INFO: readRocDacs: data/mp342/dacParameters35_C0.dat .. data/mp342/dacParameters35_C15.dat
[14:15:38.559] INFO: readTbmDacs: data/mp342/tbmParameters_C0a.dat .. data/mp342/tbmParameters_C0b.dat
[14:15:38.559] INFO: readMaskFile: data/mp342/defaultMaskFile.dat
[14:15:38.559] INFO: readTrimFile: data/mp342/trimParameters35_C0.dat .. data/mp342/trimParameters35_C15.dat
[14:15:38.708] INFO: clk: 4
[14:15:38.708] INFO: ctr: 4
[14:15:38.708] INFO: sda: 19
[14:15:38.708] INFO: tin: 9
[14:15:38.708] INFO: level: 15
[14:15:38.708] INFO: triggerdelay: 0
[14:15:38.708] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[14:15:38.708] INFO: Log level: DEBUG
[14:15:38.719] QUIET: Connection to board DTB_WRPRHI opened.
[14:15:38.723] 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:
------------------------------------------------------
[14:15:38.725] INFO: RPC call hashes of host and DTB match: 398089610
[14:15:40.328] INFO: DUT info:
[14:15:40.328] INFO: The DUT currently contains the following objects:
[14:15:40.328] INFO: 2 TBM Cores tbm08c (2 ON)
[14:15:40.328] INFO: TBM Core alpha (0): 7 registers set
[14:15:40.328] INFO: TBM Core beta (1): 7 registers set
[14:15:40.328] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:15:40.328] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:15:40.328] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:15:40.328] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:15:40.328] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:15:40.328] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:15:40.328] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:15:40.328] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:15:40.328] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:15:40.328] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:15:40.328] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:15:40.328] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:15:40.328] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:15:40.329] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:15:40.329] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:15:40.329] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:15:40.329] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[14:15:40.329] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[14:15:40.330] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[14:15:40.331] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[14:15:40.332] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[14:15:40.334] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 35172352
[14:15:40.334] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x22c7110
[14:15:40.334] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x2255360
[14:15:40.334] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f7f8dd94010
[14:15:40.334] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f7f93fff510
[14:15:40.334] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 35180544 fPxarMemory = 0x7f7f8dd94010
[14:15:40.336] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 389.9mA
[14:15:40.337] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 464.7mA
[14:15:40.337] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.2 C
[14:15:40.833] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x289dc90
[14:15:40.894] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[14:15:40.894] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[14:15:40.894] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[14:15:40.900] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[14:15:40.900] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[14:15:40.900] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[14:15:40.911] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[14:15:40.911] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[14:15:40.917] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[14:15:40.918] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[14:15:40.929] INFO: PixTestCmd::init()
[14:15:40.942] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[14:15:40.942] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[14:15:40.942] INFO: readGainPedestalParameters data/mp342/phCalibrationFitErr35_C0.dat .. data/mp342/phCalibrationFitErr35_C15.dat
[14:15:41.184] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[14:15:41.184] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[14:15:41.195] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[14:15:41.203] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[14:15:41.203] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[14:15:41.203] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[14:15:41.223] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[14:15:41.223] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[14:15:41.223] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[14:15:41.223] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[14:15:41.223] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[14:15:41.230] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[14:15:41.230] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[14:15:41.245] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[14:15:41.245] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[14:15:41.245] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[14:15:41.245] INFO: readReadbackCal: data/mp342/readbackCal_C0.dat .. data/mp342/readbackCal_C15.dat
[14:15:41.255] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[14:15:41.262] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[14:15:41.262] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[14:15:41.262] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[14:15:41.262] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[14:15:41.272] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[14:15:41.272] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[14:15:49.788] INFO: ######################################################################
[14:15:49.788] INFO: PixTestAlive::doTest()
[14:15:49.788] INFO: ######################################################################
[14:15:49.792] INFO: ----------------------------------------------------------------------
[14:15:49.792] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:15:49.792] INFO: ----------------------------------------------------------------------
[14:15:49.794] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:15:50.174] INFO: Expecting 41600 events.
[14:15:54.596] INFO: 41600 events read in total (3704ms).
[14:15:54.742] INFO: Test took 4948ms.
[14:15:54.752] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:15:54.752] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66558
[14:15:54.752] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists PixelAlive_C0 .. PixelAlive_C15
[14:15:55.022] INFO: PixTestAlive::aliveTest() done
[14:15:55.022] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 2 0 0 0 0
[14:15:55.022] DEBUG: <PixTestAlive.cc/aliveTest:L199> number of red-efficiency pixels: 26 27 50 69 80 56 70 77 72 72 68 71 77 35 19 27
[14:15:55.049] INFO: ----------------------------------------------------------------------
[14:15:55.049] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:15:55.049] INFO: ----------------------------------------------------------------------
[14:15:55.051] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:15:55.428] INFO: Expecting 41600 events.
[14:15:58.568] INFO: 41600 events read in total (2425ms).
[14:15:58.569] INFO: Test took 3518ms.
[14:15:58.569] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:15:58.569] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 0
[14:15:58.569] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists MaskTest_C0 .. MaskTest_C15
[14:15:58.570] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:15:58.993] INFO: PixTestAlive::maskTest() done
[14:15:58.993] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:15:59.015] INFO: ----------------------------------------------------------------------
[14:15:59.015] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:15:59.015] INFO: ----------------------------------------------------------------------
[14:15:59.017] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:15:59.395] INFO: Expecting 41600 events.
[14:16:03.810] INFO: 41600 events read in total (3700ms).
[14:16:03.812] INFO: Test took 4795ms.
[14:16:03.822] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:16:03.822] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66558
[14:16:03.823] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists AddressDecodingTest_C0 .. AddressDecodingTest_C15
[14:16:04.194] INFO: PixTestAlive::addressDecodingTest() done
[14:16:04.194] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:16:04.194] INFO: PixTestAlive::doTest() done, duration: 14 seconds
[14:16:06.209] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): caldelscan
[14:16:06.209] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: caldelscan
[14:16:06.209] INFO: ----------------------------------------------------------------------
[14:16:06.209] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[14:16:06.209] INFO: ----------------------------------------------------------------------
[14:16:06.348] INFO: Expecting 768 events.
[14:16:07.482] INFO: 768 events read in total (419ms).
[14:16:07.482] INFO: Test took 1267ms.
[14:16:07.488] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:16:08.286] INFO: Expecting 41600 events.
[14:16:12.018] INFO: 41600 events read in total (3206ms).
[14:16:12.023] INFO: Test took 4535ms.
[14:16:12.161] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:16:12.162] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 805119
[14:16:12.162] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step0_C0 .. HR_xeff_CalDelScan_step0_C15
[14:16:12.162] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:16:12.220] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:16:12.885] INFO: Expecting 41600 events.
[14:16:16.758] INFO: 41600 events read in total (3346ms).
[14:16:16.763] INFO: Test took 4542ms.
[14:16:16.895] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:16:16.895] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 816473
[14:16:16.895] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step1_C0 .. HR_xeff_CalDelScan_step1_C15
[14:16:16.896] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:16:16.957] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:16:17.622] INFO: Expecting 41600 events.
[14:16:21.532] INFO: 41600 events read in total (3383ms).
[14:16:21.537] INFO: Test took 4580ms.
[14:16:21.670] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:16:21.670] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 817720
[14:16:21.670] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step2_C0 .. HR_xeff_CalDelScan_step2_C15
[14:16:21.671] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:16:21.732] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:16:22.397] INFO: Expecting 41600 events.
[14:16:26.318] INFO: 41600 events read in total (3394ms).
[14:16:26.323] INFO: Test took 4591ms.
[14:16:26.457] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:16:26.457] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 819720
[14:16:26.457] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step3_C0 .. HR_xeff_CalDelScan_step3_C15
[14:16:26.458] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:16:26.520] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:16:27.185] INFO: Expecting 41600 events.
[14:16:31.113] INFO: 41600 events read in total (3402ms).
[14:16:31.118] INFO: Test took 4598ms.
[14:16:31.253] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:16:31.253] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 819886
[14:16:31.253] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step4_C0 .. HR_xeff_CalDelScan_step4_C15
[14:16:31.254] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:16:31.316] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:16:31.981] INFO: Expecting 41600 events.
[14:16:35.912] INFO: 41600 events read in total (3405ms).
[14:16:35.917] INFO: Test took 4601ms.
[14:16:36.049] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:16:36.049] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 819234
[14:16:36.049] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step5_C0 .. HR_xeff_CalDelScan_step5_C15
[14:16:36.050] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:16:36.112] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:16:36.777] INFO: Expecting 41600 events.
[14:16:40.714] INFO: 41600 events read in total (3411ms).
[14:16:40.719] INFO: Test took 4607ms.
[14:16:40.854] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:16:40.854] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 820229
[14:16:40.854] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step6_C0 .. HR_xeff_CalDelScan_step6_C15
[14:16:40.855] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:16:40.917] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:16:41.582] INFO: Expecting 41600 events.
[14:16:45.469] INFO: 41600 events read in total (3360ms).
[14:16:45.474] INFO: Test took 4557ms.
[14:16:45.609] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:16:45.609] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 820797
[14:16:45.609] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step7_C0 .. HR_xeff_CalDelScan_step7_C15
[14:16:45.609] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:16:45.672] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:16:46.337] INFO: Expecting 41600 events.
[14:16:50.284] INFO: 41600 events read in total (3420ms).
[14:16:50.289] INFO: Test took 4617ms.
[14:16:50.422] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:16:50.422] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 819328
[14:16:50.422] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step8_C0 .. HR_xeff_CalDelScan_step8_C15
[14:16:50.422] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:16:50.485] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:16:51.151] INFO: Expecting 41600 events.
[14:16:55.100] INFO: 41600 events read in total (3423ms).
[14:16:55.105] INFO: Test took 4620ms.
[14:16:55.237] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:16:55.237] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 820793
[14:16:55.237] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step9_C0 .. HR_xeff_CalDelScan_step9_C15
[14:16:55.237] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:16:55.299] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:16:55.964] INFO: Expecting 41600 events.
[14:16:59.911] INFO: 41600 events read in total (3420ms).
[14:16:59.916] INFO: Test took 4617ms.
[14:17:00.049] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:17:00.049] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 822257
[14:17:00.049] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step10_C0 .. HR_xeff_CalDelScan_step10_C15
[14:17:00.049] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:17:00.112] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:17:00.777] INFO: Expecting 41600 events.
[14:17:04.719] INFO: 41600 events read in total (3415ms).
[14:17:04.724] INFO: Test took 4612ms.
[14:17:04.858] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:17:04.858] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 820287
[14:17:04.858] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step11_C0 .. HR_xeff_CalDelScan_step11_C15
[14:17:04.859] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:17:04.920] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:17:05.585] INFO: Expecting 41600 events.
[14:17:09.532] INFO: 41600 events read in total (3420ms).
[14:17:09.537] INFO: Test took 4617ms.
[14:17:09.670] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:17:09.670] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 820591
[14:17:09.670] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step12_C0 .. HR_xeff_CalDelScan_step12_C15
[14:17:09.671] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:17:09.733] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:17:10.398] INFO: Expecting 41600 events.
[14:17:14.342] INFO: 41600 events read in total (3418ms).
[14:17:14.347] INFO: Test took 4614ms.
[14:17:14.480] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:17:14.480] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 819371
[14:17:14.480] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step13_C0 .. HR_xeff_CalDelScan_step13_C15
[14:17:14.480] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:17:14.543] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:17:15.208] INFO: Expecting 41600 events.
[14:17:19.164] INFO: 41600 events read in total (3429ms).
[14:17:19.169] INFO: Test took 4626ms.
[14:17:19.303] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:17:19.303] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 819940
[14:17:19.303] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step14_C0 .. HR_xeff_CalDelScan_step14_C15
[14:17:19.303] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:17:19.367] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:17:20.032] INFO: Expecting 41600 events.
[14:17:23.975] INFO: 41600 events read in total (3417ms).
[14:17:23.980] INFO: Test took 4613ms.
[14:17:24.113] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:17:24.113] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 819240
[14:17:24.113] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step15_C0 .. HR_xeff_CalDelScan_step15_C15
[14:17:24.114] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:17:24.176] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:17:24.841] INFO: Expecting 41600 events.
[14:17:28.792] INFO: 41600 events read in total (3424ms).
[14:17:28.797] INFO: Test took 4621ms.
[14:17:28.934] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:17:28.934] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 820721
[14:17:28.934] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step16_C0 .. HR_xeff_CalDelScan_step16_C15
[14:17:28.934] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:17:28.995] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:17:29.660] INFO: Expecting 41600 events.
[14:17:33.600] INFO: 41600 events read in total (3414ms).
[14:17:33.605] INFO: Test took 4610ms.
[14:17:33.739] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:17:33.739] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 821146
[14:17:33.739] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step17_C0 .. HR_xeff_CalDelScan_step17_C15
[14:17:33.739] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:17:33.802] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:17:34.466] INFO: Expecting 41600 events.
[14:17:38.369] INFO: 41600 events read in total (3376ms).
[14:17:38.374] INFO: Test took 4572ms.
[14:17:38.506] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:17:38.506] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 816926
[14:17:38.506] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step18_C0 .. HR_xeff_CalDelScan_step18_C15
[14:17:38.506] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:17:38.569] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:17:39.233] INFO: Expecting 41600 events.
[14:17:43.012] INFO: 41600 events read in total (3252ms).
[14:17:43.017] INFO: Test took 4448ms.
[14:17:43.149] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:17:43.149] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 811903
[14:17:43.149] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step19_C0 .. HR_xeff_CalDelScan_step19_C15
[14:17:43.150] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:17:43.432] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 0: caldel = 170 eff = 0.999351
[14:17:43.432] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 1: caldel = 182 eff = 0.999423
[14:17:43.432] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 2: caldel = 145 eff = 0.998029
[14:17:43.433] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 3: caldel = 174 eff = 0.997308
[14:17:43.433] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 4: caldel = 156 eff = 0.996394
[14:17:43.433] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 5: caldel = 154 eff = 0.996827
[14:17:43.433] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 6: caldel = 168 eff = 0.996466
[14:17:43.433] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 7: caldel = 152 eff = 0.996827
[14:17:43.433] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 8: caldel = 146 eff = 0.996178
[14:17:43.433] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 9: caldel = 158 eff = 0.995793
[14:17:43.434] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 10: caldel = 151 eff = 0.995865
[14:17:43.434] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 11: caldel = 150 eff = 0.995577
[14:17:43.434] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 12: caldel = 164 eff = 0.996731
[14:17:43.434] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 13: caldel = 171 eff = 0.998197
[14:17:43.434] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 14: caldel = 165 eff = 0.999471
[14:17:43.434] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 15: caldel = 184 eff = 0.999255
[14:18:13.073] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): xpixelalive
[14:18:13.073] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: xpixelalive
[14:18:13.073] INFO: ----------------------------------------------------------------------
[14:18:13.073] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:18:13.073] INFO: ----------------------------------------------------------------------
[14:18:13.074] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: clk: 4
[14:18:13.074] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: ctr: 4
[14:18:13.074] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: sda: 19
[14:18:13.074] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: tin: 9
[14:18:13.074] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: level: 15
[14:18:13.074] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: triggerdelay: 0
[14:18:13.074] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: clk: 4
[14:18:13.074] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: ctr: 4
[14:18:13.074] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: sda: 19
[14:18:13.074] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: tin: 9
[14:18:13.074] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: level: 15
[14:18:13.074] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: triggerdelay: 20
[14:18:13.092] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[14:18:13.760] INFO: Expecting 208000 events.
[14:18:30.218] INFO: 208000 events read in total (15932ms).
[14:18:30.237] INFO: Test took 17145ms.
[14:18:30.888] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:18:30.888] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 3790003
[14:18:30.888] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists highRate_C0 .. highRate_C15
[14:18:30.888] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[14:18:31.367] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 2 0 0 0 0
[14:18:31.367] INFO: number of red-efficiency pixels: 165 134 431 582 727 665 669 689 754 717 691 784 631 313 164 154
[14:18:31.367] INFO: number of X-ray hits detected: 119514 106404 177344 275490 296871 293095 292085 277899 307817 310776 308074 281629 278308 180579 103833 113727
[14:18:31.367] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[14:18:31.367] INFO: number of Vcal hits detected: 207832 207854 207501 207365 207164 207256 207222 207237 207154 207154 207210 206974 207302 207634 207828 207843
[14:18:31.367] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.8 99.7 99.6 99.7 99.7 99.7 99.6 99.6 99.7 99.6 99.7 99.8 99.9 99.9
[14:18:31.367] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.8 99.7 99.6 99.6 99.6 99.6 99.6 99.6 99.6 99.5 99.7 99.8 99.9 99.9
[14:18:31.367] INFO: X-ray hit rate [MHz/cm2]: 35.0 31.2 52.0 80.7 87.0 85.9 85.6 81.5 90.2 91.1 90.3 82.5 81.6 52.9 30.4 33.3
[14:18:31.367] INFO: PixTestHighRate::doXPixelAlive() done
[14:18:31.412] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: clk: 4
[14:18:31.412] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: ctr: 4
[14:18:31.412] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: sda: 19
[14:18:31.412] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: tin: 9
[14:18:31.412] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: level: 15
[14:18:31.412] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: triggerdelay: 0
[14:18:31.412] INFO: PixTest:: pg_setup set to default.
[14:18:35.649] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[14:18:35.649] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = highRate_xraymap_C11_V0 -> highRate_xraymap_mod
[14:18:37.489] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[14:18:37.490] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 393.9mA
[14:18:37.491] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 465.5mA
[14:18:37.491] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.5 C
[14:18:37.491] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[14:18:37.491] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[14:18:37.491] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[14:18:37.491] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[14:18:37.491] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[14:18:37.491] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[14:18:37.491] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[14:18:37.491] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[14:18:37.491] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[14:18:37.491] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[14:18:37.581] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[14:18:37.581] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[14:18:37.590] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[14:18:37.590] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[14:18:37.590] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[14:18:37.590] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[14:18:37.590] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[14:18:37.590] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[14:18:37.593] QUIET: Connection to board 58 closed.
[14:18:37.673] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
MoReWeb-v0.5.1-895-gd4c3d74 on branch master