Test Date: 1973-11-29 16:33
Analysis date: 2016-09-13 19:45
Logfile
hrData_40.log
[15:32:09.603] INFO: *** Welcome to pxar ***
[15:32:09.603] INFO: *** Today: 2016/09/12
[15:32:09.627] INFO: *** Version: v1.9.0-818-g96727
[15:32:09.627] INFO: readRocDacs: data/mqa46/dacParameters35_C0.dat .. data/mqa46/dacParameters35_C15.dat
[15:32:09.628] INFO: readTbmDacs: data/mqa46/tbmParameters_C0a.dat .. data/mqa46/tbmParameters_C0b.dat
[15:32:09.628] INFO: readMaskFile: data/mqa46/defaultMaskFile.dat
[15:32:09.628] INFO: readTrimFile: data/mqa46/trimParameters35_C0.dat .. data/mqa46/trimParameters35_C15.dat
[15:32:09.777] INFO: clk: 4
[15:32:09.777] INFO: ctr: 4
[15:32:09.777] INFO: sda: 19
[15:32:09.777] INFO: tin: 9
[15:32:09.777] INFO: level: 15
[15:32:09.777] INFO: triggerdelay: 0
[15:32:09.777] QUIET: Instanciating API for pxar v1.9.0+818~g9672706
[15:32:09.777] INFO: Log level: DEBUG
[15:32:09.788] QUIET: Connection to board DTB_WRPRHI opened.
[15:32:09.791] 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:
------------------------------------------------------
[15:32:09.794] INFO: RPC call hashes of host and DTB match: 398089610
[15:32:11.397] INFO: DUT info:
[15:32:11.397] INFO: The DUT currently contains the following objects:
[15:32:11.397] INFO: 2 TBM Cores tbm08c (2 ON)
[15:32:11.397] INFO: TBM Core alpha (0): 7 registers set
[15:32:11.397] INFO: TBM Core beta (1): 7 registers set
[15:32:11.397] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:32:11.397] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:11.397] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:11.397] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:11.397] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:11.397] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:11.397] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:11.397] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:11.398] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:11.398] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:11.398] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:11.398] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:11.398] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:11.398] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:11.398] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:11.398] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:11.398] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:11.398] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[15:32:11.398] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:32:11.398] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:32:11.398] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:32:11.398] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[15:32:11.398] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[15:32:11.398] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:32:11.398] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[15:32:11.398] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[15:32:11.398] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:32:11.398] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[15:32:11.398] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[15:32:11.398] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:32:11.398] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:32:11.398] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:32:11.398] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[15:32:11.398] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[15:32:11.398] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[15:32:11.398] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[15:32:11.398] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[15:32:11.399] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[15:32:11.400] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:32:11.401] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:32:11.403] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 30330880
[15:32:11.403] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x13390e0
[15:32:11.403] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x10db370
[15:32:11.403] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7feca5d94010
[15:32:11.403] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7fecabfff510
[15:32:11.404] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 30339072 fPxarMemory = 0x7feca5d94010
[15:32:11.405] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 379.4mA
[15:32:11.406] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 468.7mA
[15:32:11.406] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.2 C
[15:32:11.903] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x1727eb0
[15:32:11.973] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[15:32:11.974] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[15:32:11.974] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[15:32:11.979] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[15:32:11.980] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[15:32:11.980] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[15:32:11.993] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[15:32:11.993] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[15:32:12.018] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[15:32:12.018] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[15:32:12.029] INFO: PixTestCmd::init()
[15:32:12.034] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[15:32:12.034] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[15:32:12.035] INFO: readGainPedestalParameters data/mqa46/phCalibrationFitErr35_C0.dat .. data/mqa46/phCalibrationFitErr35_C15.dat
[15:32:12.283] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[15:32:12.283] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[15:32:12.297] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[15:32:12.303] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[15:32:12.304] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[15:32:12.304] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[15:32:12.326] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[15:32:12.326] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[15:32:12.326] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[15:32:12.326] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[15:32:12.326] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[15:32:12.333] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[15:32:12.333] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[15:32:12.357] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[15:32:12.357] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[15:32:12.357] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[15:32:12.357] INFO: readReadbackCal: data/mqa46/readbackCal_C0.dat .. data/mqa46/readbackCal_C15.dat
[15:32:12.366] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[15:32:12.377] DEBUG: <PixTestTiming.cc/setParameter:L59> PixTestTiming::PixTest() targetclk = 4
[15:32:12.377] DEBUG: <PixTestTiming.cc/setParameter:L63> PixTestTiming::PixTest() ntrig = 10
[15:32:12.377] DEBUG: <PixTestTiming.cc/setParameter:L47> fNoTokenPass: 0
[15:32:12.377] DEBUG: <PixTestTiming.cc/init:L73> PixTestTiming::init()
[15:32:12.393] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[15:32:12.393] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[15:32:16.243] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 2 -> runseconds to value 60
[15:32:17.960] INFO: ######################################################################
[15:32:17.960] INFO: PixTestXray::doTest()
[15:32:17.960] INFO: ######################################################################
[15:32:17.960] INFO: ----------------------------------------------------------------------
[15:32:17.961] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[15:32:17.961] INFO: ----------------------------------------------------------------------
[15:32:18.935] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[15:32:30.723] INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[15:32:30.726] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:32:57.615] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1161434 events.
[15:33:04.626] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1161434, pixels seen in all events: 6314622
[15:33:04.891] INFO: Resuming triggers.
[15:33:16.678] INFO: run duration 23 seconds, buffer almost full (81%), pausing triggers.
[15:33:16.716] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:33:43.531] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1161150 events.
[15:33:50.658] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1161150, pixels seen in all events: 6317241
[15:33:50.836] INFO: Resuming triggers.
[15:34:02.627] INFO: run duration 35 seconds, buffer almost full (81%), pausing triggers.
[15:34:02.668] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:34:29.533] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1161619 events.
[15:34:36.654] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1161619, pixels seen in all events: 6311796
[15:34:36.835] INFO: Resuming triggers.
[15:34:48.627] INFO: run duration 47 seconds, buffer almost full (81%), pausing triggers.
[15:34:48.665] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:35:15.577] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1161718 events.
[15:35:22.586] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1161718, pixels seen in all events: 6310438
[15:35:22.843] INFO: Resuming triggers.
[15:35:34.635] INFO: run duration 58 seconds, buffer almost full (81%), pausing triggers.
[15:35:34.674] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:36:01.632] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1161617 events.
[15:36:08.682] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1161617, pixels seen in all events: 6311910
[15:36:08.945] INFO: Resuming triggers.
[15:36:10.075] INFO: data taking finished, elapsed time: 60 seconds.
[15:36:10.271] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:36:13.010] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 111264 events.
[15:36:13.687] DEBUG: <PixTestXray.cc/processData:L823> # events read: 111264, pixels seen in all events: 603865
[15:36:13.744] INFO: PixTest:: pg_setup set to default.
[15:36:13.789] INFO: PixTestXray::doPhRun() done
[15:36:13.789] INFO: PixTestXray::doTest() done
[15:36:19.873] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[15:36:19.873] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = hMap_Ag_C12_V0 -> hMap_Ag_mod
[15:36:21.176] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[15:36:21.177] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 382.7mA
[15:36:21.178] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 469.5mA
[15:36:21.178] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.2 C
[15:36:21.178] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[15:36:21.178] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[15:36:21.178] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[15:36:21.178] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[15:36:21.178] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[15:36:21.178] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[15:36:21.179] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[15:36:21.179] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[15:36:21.179] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[15:36:21.179] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[15:36:21.179] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[15:36:21.179] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[15:36:21.179] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[15:36:21.179] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[15:36:21.179] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[15:36:21.179] DEBUG: <PixTestTiming.cc/~PixTestTiming:L96> PixTestTiming dtor
[15:36:21.179] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[15:36:21.179] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[15:36:21.474] QUIET: Connection to board 58 closed.
[15:36:21.553] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrData_120.log
[15:36:26.372] INFO: *** Welcome to pxar ***
[15:36:26.372] INFO: *** Today: 2016/09/12
[15:36:26.397] INFO: *** Version: v1.9.0-818-g96727
[15:36:26.397] INFO: readRocDacs: data/mqa46/dacParameters35_C0.dat .. data/mqa46/dacParameters35_C15.dat
[15:36:26.398] INFO: readTbmDacs: data/mqa46/tbmParameters_C0a.dat .. data/mqa46/tbmParameters_C0b.dat
[15:36:26.398] INFO: readMaskFile: data/mqa46/defaultMaskFile.dat
[15:36:26.398] INFO: readTrimFile: data/mqa46/trimParameters35_C0.dat .. data/mqa46/trimParameters35_C15.dat
[15:36:26.551] INFO: clk: 4
[15:36:26.551] INFO: ctr: 4
[15:36:26.551] INFO: sda: 19
[15:36:26.551] INFO: tin: 9
[15:36:26.551] INFO: level: 15
[15:36:26.551] INFO: triggerdelay: 0
[15:36:26.551] QUIET: Instanciating API for pxar v1.9.0+818~g9672706
[15:36:26.551] INFO: Log level: DEBUG
[15:36:26.562] QUIET: Connection to board DTB_WRPRHI opened.
[15:36:26.565] 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:
------------------------------------------------------
[15:36:26.568] INFO: RPC call hashes of host and DTB match: 398089610
[15:36:28.167] INFO: DUT info:
[15:36:28.167] INFO: The DUT currently contains the following objects:
[15:36:28.167] INFO: 2 TBM Cores tbm08c (2 ON)
[15:36:28.167] INFO: TBM Core alpha (0): 7 registers set
[15:36:28.167] INFO: TBM Core beta (1): 7 registers set
[15:36:28.167] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:36:28.168] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:28.168] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:28.168] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:28.168] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:28.168] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:28.168] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:28.168] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:28.168] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:28.168] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:28.168] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:28.168] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:28.168] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:28.168] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:28.168] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:28.168] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:28.168] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:28.168] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[15:36:28.168] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:36:28.168] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:36:28.168] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:36:28.168] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[15:36:28.168] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[15:36:28.168] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:36:28.168] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[15:36:28.168] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[15:36:28.169] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[15:36:28.170] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:36:28.171] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:36:28.174] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 30334976
[15:36:28.174] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x2ab20e0
[15:36:28.174] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x2854370
[15:36:28.174] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f2229d94010
[15:36:28.174] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f222ffff510
[15:36:28.174] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 30343168 fPxarMemory = 0x7f2229d94010
[15:36:28.175] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 378.6mA
[15:36:28.176] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 468.7mA
[15:36:28.176] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.4 C
[15:36:28.675] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x2ea0f80
[15:36:28.741] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[15:36:28.741] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[15:36:28.741] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[15:36:28.748] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[15:36:28.748] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[15:36:28.748] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[15:36:28.762] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[15:36:28.762] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[15:36:28.772] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[15:36:28.772] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[15:36:28.789] INFO: PixTestCmd::init()
[15:36:28.796] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[15:36:28.796] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[15:36:28.796] INFO: readGainPedestalParameters data/mqa46/phCalibrationFitErr35_C0.dat .. data/mqa46/phCalibrationFitErr35_C15.dat
[15:36:29.042] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[15:36:29.042] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[15:36:29.057] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[15:36:29.063] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[15:36:29.063] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[15:36:29.063] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[15:36:29.084] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[15:36:29.084] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[15:36:29.084] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[15:36:29.084] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[15:36:29.084] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[15:36:29.090] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[15:36:29.091] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[15:36:29.106] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[15:36:29.106] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[15:36:29.106] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[15:36:29.106] INFO: readReadbackCal: data/mqa46/readbackCal_C0.dat .. data/mqa46/readbackCal_C15.dat
[15:36:29.117] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[15:36:29.124] DEBUG: <PixTestTiming.cc/setParameter:L59> PixTestTiming::PixTest() targetclk = 4
[15:36:29.124] DEBUG: <PixTestTiming.cc/setParameter:L63> PixTestTiming::PixTest() ntrig = 10
[15:36:29.125] DEBUG: <PixTestTiming.cc/setParameter:L47> fNoTokenPass: 0
[15:36:29.125] DEBUG: <PixTestTiming.cc/init:L73> PixTestTiming::init()
[15:36:29.146] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[15:36:29.146] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[15:36:33.699] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 2 -> runseconds to value 60
[15:36:35.433] INFO: ######################################################################
[15:36:35.433] INFO: PixTestXray::doTest()
[15:36:35.433] INFO: ######################################################################
[15:36:35.433] INFO: ----------------------------------------------------------------------
[15:36:35.433] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[15:36:35.433] INFO: ----------------------------------------------------------------------
[15:36:36.406] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[15:36:44.255] INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[15:36:44.259] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:37:09.560] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 773394 events.
[15:37:21.434] DEBUG: <PixTestXray.cc/processData:L823> # events read: 773394, pixels seen in all events: 10972215
[15:37:21.692] INFO: Resuming triggers.
[15:37:29.546] INFO: run duration 15 seconds, buffer almost full (81%), pausing triggers.
[15:37:29.586] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:37:54.782] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 773679 events.
[15:38:06.697] DEBUG: <PixTestXray.cc/processData:L823> # events read: 773679, pixels seen in all events: 10967733
[15:38:06.904] INFO: Resuming triggers.
[15:38:14.763] INFO: run duration 23 seconds, buffer almost full (81%), pausing triggers.
[15:38:14.809] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:38:39.987] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 774248 events.
[15:38:51.906] DEBUG: <PixTestXray.cc/processData:L823> # events read: 774248, pixels seen in all events: 10961231
[15:38:52.113] INFO: Resuming triggers.
[15:38:59.971] INFO: run duration 31 seconds, buffer almost full (81%), pausing triggers.
[15:39:00.040] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:39:25.181] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 774148 events.
[15:39:37.116] DEBUG: <PixTestXray.cc/processData:L823> # events read: 774148, pixels seen in all events: 10962134
[15:39:37.360] INFO: Resuming triggers.
[15:39:45.218] INFO: run duration 39 seconds, buffer almost full (81%), pausing triggers.
[15:39:45.262] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:40:10.435] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 774109 events.
[15:40:22.372] DEBUG: <PixTestXray.cc/processData:L823> # events read: 774109, pixels seen in all events: 10963082
[15:40:22.613] INFO: Resuming triggers.
[15:40:30.472] INFO: run duration 47 seconds, buffer almost full (81%), pausing triggers.
[15:40:30.512] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:40:55.727] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 774220 events.
[15:41:07.660] DEBUG: <PixTestXray.cc/processData:L823> # events read: 774220, pixels seen in all events: 10961389
[15:41:07.904] INFO: Resuming triggers.
[15:41:15.763] INFO: run duration 54 seconds, buffer almost full (81%), pausing triggers.
[15:41:15.804] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:41:41.031] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 774186 events.
[15:41:52.968] DEBUG: <PixTestXray.cc/processData:L823> # events read: 774186, pixels seen in all events: 10961918
[15:41:53.215] INFO: Resuming triggers.
[15:41:58.292] INFO: data taking finished, elapsed time: 60 seconds.
[15:41:58.488] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:42:14.833] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 500051 events.
[15:42:22.545] DEBUG: <PixTestXray.cc/processData:L823> # events read: 500051, pixels seen in all events: 7075765
[15:42:22.669] INFO: PixTest:: pg_setup set to default.
[15:42:22.712] INFO: PixTestXray::doPhRun() done
[15:42:22.712] INFO: PixTestXray::doTest() done
[15:42:53.617] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[15:42:53.617] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = hMap_Ag_C12_V0 -> hMap_Ag_mod
[15:42:54.849] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[15:42:54.849] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 382.7mA
[15:42:54.850] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 469.5mA
[15:42:54.850] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.2 C
[15:42:54.850] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[15:42:54.850] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[15:42:54.850] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[15:42:54.850] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[15:42:54.851] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[15:42:54.851] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[15:42:54.851] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[15:42:54.851] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[15:42:54.851] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[15:42:54.851] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[15:42:54.851] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[15:42:54.851] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[15:42:54.851] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[15:42:54.851] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[15:42:54.851] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[15:42:54.851] DEBUG: <PixTestTiming.cc/~PixTestTiming:L96> PixTestTiming dtor
[15:42:54.851] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[15:42:54.851] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[15:42:55.173] QUIET: Connection to board 58 closed.
[15:42:55.253] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrEff_40.log
[15:27:35.704] INFO: *** Welcome to pxar ***
[15:27:35.704] INFO: *** Today: 2016/09/12
[15:27:35.729] INFO: *** Version: v1.9.0-818-g96727
[15:27:35.729] INFO: readRocDacs: data/mqa46/dacParameters35_C0.dat .. data/mqa46/dacParameters35_C15.dat
[15:27:35.730] INFO: readTbmDacs: data/mqa46/tbmParameters_C0a.dat .. data/mqa46/tbmParameters_C0b.dat
[15:27:35.730] INFO: readMaskFile: data/mqa46/defaultMaskFile.dat
[15:27:35.730] INFO: readTrimFile: data/mqa46/trimParameters35_C0.dat .. data/mqa46/trimParameters35_C15.dat
[15:27:35.879] INFO: clk: 4
[15:27:35.879] INFO: ctr: 4
[15:27:35.879] INFO: sda: 19
[15:27:35.879] INFO: tin: 9
[15:27:35.879] INFO: level: 15
[15:27:35.879] INFO: triggerdelay: 0
[15:27:35.879] QUIET: Instanciating API for pxar v1.9.0+818~g9672706
[15:27:35.879] INFO: Log level: DEBUG
[15:27:35.890] QUIET: Connection to board DTB_WRPRHI opened.
[15:27:35.893] 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:
------------------------------------------------------
[15:27:35.896] INFO: RPC call hashes of host and DTB match: 398089610
[15:27:37.499] INFO: DUT info:
[15:27:37.499] INFO: The DUT currently contains the following objects:
[15:27:37.499] INFO: 2 TBM Cores tbm08c (2 ON)
[15:27:37.499] INFO: TBM Core alpha (0): 7 registers set
[15:27:37.499] INFO: TBM Core beta (1): 7 registers set
[15:27:37.499] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:27:37.499] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:27:37.499] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:27:37.499] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:27:37.499] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:27:37.499] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:27:37.499] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:27:37.499] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:27:37.499] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:27:37.499] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:27:37.499] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:27:37.499] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:27:37.499] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:27:37.499] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:27:37.499] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:27:37.499] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:27:37.499] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[15:27:37.500] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[15:27:37.501] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[15:27:37.502] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[15:27:37.503] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[15:27:37.503] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[15:27:37.503] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[15:27:37.503] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[15:27:37.503] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[15:27:37.503] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[15:27:37.503] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[15:27:37.503] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[15:27:37.503] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:27:37.503] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[15:27:37.503] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[15:27:37.503] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[15:27:37.503] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[15:27:37.503] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[15:27:37.503] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[15:27:37.503] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[15:27:37.503] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[15:27:37.503] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[15:27:37.503] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[15:27:37.503] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:27:37.503] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:27:37.505] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 30334976
[15:27:37.505] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x1a4d0e0
[15:27:37.505] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x17ef370
[15:27:37.505] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7fe04dd94010
[15:27:37.505] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7fe053fff510
[15:27:37.505] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 30343168 fPxarMemory = 0x7fe04dd94010
[15:27:37.506] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 379.4mA
[15:27:37.508] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 468.7mA
[15:27:37.508] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: 0.1 C
[15:27:38.005] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x1e3bf10
[15:27:38.073] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[15:27:38.074] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[15:27:38.074] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[15:27:38.079] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[15:27:38.079] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[15:27:38.079] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[15:27:38.089] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[15:27:38.089] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[15:27:38.101] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[15:27:38.101] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[15:27:38.124] INFO: PixTestCmd::init()
[15:27:38.142] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[15:27:38.142] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[15:27:38.142] INFO: readGainPedestalParameters data/mqa46/phCalibrationFitErr35_C0.dat .. data/mqa46/phCalibrationFitErr35_C15.dat
[15:27:38.391] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[15:27:38.391] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[15:27:38.406] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[15:27:38.412] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[15:27:38.412] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[15:27:38.412] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[15:27:38.435] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[15:27:38.435] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[15:27:38.435] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[15:27:38.435] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[15:27:38.435] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[15:27:38.443] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[15:27:38.443] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[15:27:38.463] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[15:27:38.463] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[15:27:38.463] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[15:27:38.463] INFO: readReadbackCal: data/mqa46/readbackCal_C0.dat .. data/mqa46/readbackCal_C15.dat
[15:27:38.473] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[15:27:38.481] DEBUG: <PixTestTiming.cc/setParameter:L59> PixTestTiming::PixTest() targetclk = 4
[15:27:38.482] DEBUG: <PixTestTiming.cc/setParameter:L63> PixTestTiming::PixTest() ntrig = 10
[15:27:38.482] DEBUG: <PixTestTiming.cc/setParameter:L47> fNoTokenPass: 0
[15:27:38.482] DEBUG: <PixTestTiming.cc/init:L73> PixTestTiming::init()
[15:27:38.497] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[15:27:38.498] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[15:27:41.515] INFO: ######################################################################
[15:27:41.515] INFO: PixTestAlive::doTest()
[15:27:41.516] INFO: ######################################################################
[15:27:41.519] INFO: ----------------------------------------------------------------------
[15:27:41.519] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:27:41.519] INFO: ----------------------------------------------------------------------
[15:27:41.521] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:27:41.900] INFO: Expecting 41600 events.
[15:27:46.308] INFO: 41600 events read in total (3690ms).
[15:27:46.455] INFO: Test took 4934ms.
[15:27:46.466] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:27:46.466] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66559
[15:27:46.466] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists PixelAlive_C0 .. PixelAlive_C15
[15:27:46.743] INFO: PixTestAlive::aliveTest() done
[15:27:46.743] INFO: number of dead pixels (per ROC): 0 0 1 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:27:46.743] DEBUG: <PixTestAlive.cc/aliveTest:L199> number of red-efficiency pixels: 25 16 28 39 45 38 38 31 49 48 40 32 30 33 12 11
[15:27:46.771] INFO: ----------------------------------------------------------------------
[15:27:46.771] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:27:46.771] INFO: ----------------------------------------------------------------------
[15:27:46.773] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:27:47.150] INFO: Expecting 41600 events.
[15:27:50.267] INFO: 41600 events read in total (2402ms).
[15:27:50.267] INFO: Test took 3494ms.
[15:27:50.267] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:27:50.267] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 0
[15:27:50.267] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists MaskTest_C0 .. MaskTest_C15
[15:27:50.268] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:27:50.690] INFO: PixTestAlive::maskTest() done
[15:27:50.690] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:27:50.713] INFO: ----------------------------------------------------------------------
[15:27:50.713] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:27:50.713] INFO: ----------------------------------------------------------------------
[15:27:50.716] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:27:51.094] INFO: Expecting 41600 events.
[15:27:55.496] INFO: 41600 events read in total (3686ms).
[15:27:55.498] INFO: Test took 4782ms.
[15:27:55.508] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:27:55.508] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66559
[15:27:55.508] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists AddressDecodingTest_C0 .. AddressDecodingTest_C15
[15:27:55.878] INFO: PixTestAlive::addressDecodingTest() done
[15:27:55.878] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:27:55.878] INFO: PixTestAlive::doTest() done, duration: 14 seconds
[15:28:00.248] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): caldelscan
[15:28:00.248] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: caldelscan
[15:28:00.248] INFO: ----------------------------------------------------------------------
[15:28:00.248] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[15:28:00.248] INFO: ----------------------------------------------------------------------
[15:28:00.387] INFO: Expecting 768 events.
[15:28:01.521] INFO: 768 events read in total (418ms).
[15:28:01.521] INFO: Test took 1267ms.
[15:28:01.527] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:28:02.324] INFO: Expecting 41600 events.
[15:28:05.621] INFO: 41600 events read in total (2770ms).
[15:28:05.624] INFO: Test took 4097ms.
[15:28:05.734] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:28:05.734] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 461227
[15:28:05.734] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step0_C0 .. HR_xeff_CalDelScan_step0_C15
[15:28:05.734] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:28:05.772] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:28:06.437] INFO: Expecting 41600 events.
[15:28:09.863] INFO: 41600 events read in total (2899ms).
[15:28:09.866] INFO: Test took 4094ms.
[15:28:09.946] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:28:09.946] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 469283
[15:28:09.946] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step1_C0 .. HR_xeff_CalDelScan_step1_C15
[15:28:09.947] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:28:09.986] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:28:10.652] INFO: Expecting 41600 events.
[15:28:14.132] INFO: 41600 events read in total (2953ms).
[15:28:14.135] INFO: Test took 4150ms.
[15:28:14.215] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:28:14.216] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 472650
[15:28:14.216] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step2_C0 .. HR_xeff_CalDelScan_step2_C15
[15:28:14.216] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:28:14.255] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:28:14.920] INFO: Expecting 41600 events.
[15:28:18.421] INFO: 41600 events read in total (2974ms).
[15:28:18.425] INFO: Test took 4170ms.
[15:28:18.504] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:28:18.504] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 474917
[15:28:18.504] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step3_C0 .. HR_xeff_CalDelScan_step3_C15
[15:28:18.504] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:28:18.545] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:28:19.212] INFO: Expecting 41600 events.
[15:28:22.703] INFO: 41600 events read in total (2964ms).
[15:28:22.706] INFO: Test took 4160ms.
[15:28:22.783] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:28:22.783] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 474265
[15:28:22.783] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step4_C0 .. HR_xeff_CalDelScan_step4_C15
[15:28:22.784] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:28:22.823] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:28:23.488] INFO: Expecting 41600 events.
[15:28:26.994] INFO: 41600 events read in total (2980ms).
[15:28:26.998] INFO: Test took 4175ms.
[15:28:27.077] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:28:27.077] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 475186
[15:28:27.077] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step5_C0 .. HR_xeff_CalDelScan_step5_C15
[15:28:27.077] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:28:27.117] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:28:27.782] INFO: Expecting 41600 events.
[15:28:31.291] INFO: 41600 events read in total (2983ms).
[15:28:31.295] INFO: Test took 4178ms.
[15:28:31.372] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:28:31.372] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 473913
[15:28:31.372] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step6_C0 .. HR_xeff_CalDelScan_step6_C15
[15:28:31.372] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:28:31.412] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:28:32.077] INFO: Expecting 41600 events.
[15:28:35.588] INFO: 41600 events read in total (2984ms).
[15:28:35.591] INFO: Test took 4179ms.
[15:28:35.669] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:28:35.669] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 474265
[15:28:35.669] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step7_C0 .. HR_xeff_CalDelScan_step7_C15
[15:28:35.669] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:28:35.709] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:28:36.374] INFO: Expecting 41600 events.
[15:28:39.878] INFO: 41600 events read in total (2977ms).
[15:28:39.882] INFO: Test took 4173ms.
[15:28:39.960] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:28:39.960] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 474268
[15:28:39.960] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step8_C0 .. HR_xeff_CalDelScan_step8_C15
[15:28:39.960] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:28:40.000] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:28:40.665] INFO: Expecting 41600 events.
[15:28:44.182] INFO: 41600 events read in total (2990ms).
[15:28:44.186] INFO: Test took 4186ms.
[15:28:44.265] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:28:44.265] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 474599
[15:28:44.265] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step9_C0 .. HR_xeff_CalDelScan_step9_C15
[15:28:44.266] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:28:44.307] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:28:44.973] INFO: Expecting 41600 events.
[15:28:48.482] INFO: 41600 events read in total (2982ms).
[15:28:48.485] INFO: Test took 4178ms.
[15:28:48.564] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:28:48.564] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 472626
[15:28:48.564] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step10_C0 .. HR_xeff_CalDelScan_step10_C15
[15:28:48.564] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:28:48.604] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:28:49.269] INFO: Expecting 41600 events.
[15:28:52.783] INFO: 41600 events read in total (2987ms).
[15:28:52.787] INFO: Test took 4183ms.
[15:28:52.867] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:28:52.867] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 475788
[15:28:52.867] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step11_C0 .. HR_xeff_CalDelScan_step11_C15
[15:28:52.868] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:28:52.908] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:28:53.575] INFO: Expecting 41600 events.
[15:28:57.099] INFO: 41600 events read in total (2997ms).
[15:28:57.102] INFO: Test took 4193ms.
[15:28:57.183] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:28:57.183] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 474624
[15:28:57.183] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step12_C0 .. HR_xeff_CalDelScan_step12_C15
[15:28:57.183] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:28:57.224] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:28:57.890] INFO: Expecting 41600 events.
[15:29:01.410] INFO: 41600 events read in total (2993ms).
[15:29:01.414] INFO: Test took 4190ms.
[15:29:01.491] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:29:01.491] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 474315
[15:29:01.491] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step13_C0 .. HR_xeff_CalDelScan_step13_C15
[15:29:01.492] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:29:01.531] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:29:02.196] INFO: Expecting 41600 events.
[15:29:05.717] INFO: 41600 events read in total (2994ms).
[15:29:05.721] INFO: Test took 4190ms.
[15:29:05.799] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:29:05.800] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 474111
[15:29:05.800] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step14_C0 .. HR_xeff_CalDelScan_step14_C15
[15:29:05.800] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:29:05.840] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:29:06.505] INFO: Expecting 41600 events.
[15:29:10.024] INFO: 41600 events read in total (2992ms).
[15:29:10.027] INFO: Test took 4187ms.
[15:29:10.105] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:29:10.105] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 474499
[15:29:10.105] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step15_C0 .. HR_xeff_CalDelScan_step15_C15
[15:29:10.105] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:29:10.145] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:29:10.810] INFO: Expecting 41600 events.
[15:29:14.325] INFO: 41600 events read in total (2989ms).
[15:29:14.329] INFO: Test took 4184ms.
[15:29:14.407] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:29:14.407] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 473763
[15:29:14.407] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step16_C0 .. HR_xeff_CalDelScan_step16_C15
[15:29:14.407] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:29:14.447] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:29:15.113] INFO: Expecting 41600 events.
[15:29:18.638] INFO: 41600 events read in total (2999ms).
[15:29:18.642] INFO: Test took 4195ms.
[15:29:18.720] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:29:18.720] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 474027
[15:29:18.720] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step17_C0 .. HR_xeff_CalDelScan_step17_C15
[15:29:18.720] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:29:18.760] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:29:19.425] INFO: Expecting 41600 events.
[15:29:22.910] INFO: 41600 events read in total (2958ms).
[15:29:22.914] INFO: Test took 4154ms.
[15:29:22.992] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:29:22.993] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 473921
[15:29:22.993] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step18_C0 .. HR_xeff_CalDelScan_step18_C15
[15:29:22.993] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:29:23.032] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:29:23.697] INFO: Expecting 41600 events.
[15:29:27.032] INFO: 41600 events read in total (2808ms).
[15:29:27.037] INFO: Test took 4004ms.
[15:29:27.115] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:29:27.115] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 467514
[15:29:27.115] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step19_C0 .. HR_xeff_CalDelScan_step19_C15
[15:29:27.116] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:29:27.377] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 0: caldel = 115 eff = 0.999639
[15:29:27.377] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 1: caldel = 112 eff = 0.999808
[15:29:27.377] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 2: caldel = 174 eff = 0.999183
[15:29:27.378] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 3: caldel = 168 eff = 0.998966
[15:29:27.378] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 4: caldel = 172 eff = 0.998822
[15:29:27.378] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 5: caldel = 138 eff = 0.998918
[15:29:27.378] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 6: caldel = 205 eff = 0.999063
[15:29:27.378] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 7: caldel = 188 eff = 0.999183
[15:29:27.378] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 8: caldel = 164 eff = 0.998798
[15:29:27.379] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 9: caldel = 152 eff = 0.998678
[15:29:27.379] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 10: caldel = 161 eff = 0.99887
[15:29:27.379] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 11: caldel = 201 eff = 0.999303
[15:29:27.379] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 12: caldel = 157 eff = 0.999183
[15:29:27.379] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 13: caldel = 149 eff = 0.999495
[15:29:27.379] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 14: caldel = 140 eff = 0.999663
[15:29:27.379] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 15: caldel = 157 eff = 0.99976
[15:29:29.664] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): xpixelalive
[15:29:29.664] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: xpixelalive
[15:29:29.664] INFO: ----------------------------------------------------------------------
[15:29:29.664] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[15:29:29.664] INFO: ----------------------------------------------------------------------
[15:29:29.665] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: clk: 4
[15:29:29.665] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: ctr: 4
[15:29:29.665] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: sda: 19
[15:29:29.665] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: tin: 9
[15:29:29.665] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: level: 15
[15:29:29.665] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: triggerdelay: 0
[15:29:29.665] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: clk: 4
[15:29:29.665] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: ctr: 4
[15:29:29.665] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: sda: 19
[15:29:29.665] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: tin: 9
[15:29:29.665] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: level: 15
[15:29:29.665] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: triggerdelay: 20
[15:29:29.683] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:29:30.351] INFO: Expecting 208000 events.
[15:29:43.889] INFO: 208000 events read in total (13012ms).
[15:29:43.901] INFO: Test took 14218ms.
[15:29:44.264] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:29:44.265] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 2091714
[15:29:44.265] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists highRate_C0 .. highRate_C15
[15:29:44.265] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:29:44.634] INFO: number of dead pixels (per ROC): 0 0 1 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:29:44.634] INFO: number of red-efficiency pixels: 130 74 130 238 244 277 206 206 250 255 288 187 230 151 84 90
[15:29:44.634] INFO: number of X-ray hits detected: 79427 57268 97620 147099 158601 155203 159363 147762 164482 165483 160763 150403 150128 99073 59957 72523
[15:29:44.634] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[15:29:44.634] INFO: number of Vcal hits detected: 207867 207924 207820 207755 207748 207714 207787 207770 207743 207733 207698 207805 207764 207844 207914 207907
[15:29:44.634] INFO: Vcal hit fiducial efficiency (%): 99.9 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
[15:29:44.634] INFO: Vcal hit overall efficiency (%): 99.9 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
[15:29:44.634] INFO: X-ray hit rate [MHz/cm2]: 23.3 16.8 28.6 43.1 46.5 45.5 46.7 43.3 48.2 48.5 47.1 44.1 44.0 29.0 17.6 21.3
[15:29:44.634] INFO: PixTestHighRate::doXPixelAlive() done
[15:29:44.679] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: clk: 4
[15:29:44.679] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: ctr: 4
[15:29:44.679] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: sda: 19
[15:29:44.679] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: tin: 9
[15:29:44.679] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: level: 15
[15:29:44.679] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: triggerdelay: 0
[15:29:44.679] INFO: PixTest:: pg_setup set to default.
[15:29:47.520] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[15:29:47.520] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = highRate_xraymap_C12_V0 -> highRate_xraymap_mod
[15:29:48.552] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[15:29:48.553] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 382.7mA
[15:29:48.554] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 468.7mA
[15:29:48.554] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.1 C
[15:29:48.554] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[15:29:48.554] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[15:29:48.554] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[15:29:48.554] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[15:29:48.554] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[15:29:48.554] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[15:29:48.554] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[15:29:48.554] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[15:29:48.555] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[15:29:48.555] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[15:29:48.643] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[15:29:48.643] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[15:29:48.652] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[15:29:48.652] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[15:29:48.652] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[15:29:48.652] DEBUG: <PixTestTiming.cc/~PixTestTiming:L96> PixTestTiming dtor
[15:29:48.653] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[15:29:48.653] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[15:29:48.655] QUIET: Connection to board 58 closed.
[15:29:48.735] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrEff_80.log
[15:24:58.449] INFO: *** Welcome to pxar ***
[15:24:58.450] INFO: *** Today: 2016/09/12
[15:24:58.475] INFO: *** Version: v1.9.0-818-g96727
[15:24:58.475] INFO: readRocDacs: data/mqa46/dacParameters35_C0.dat .. data/mqa46/dacParameters35_C15.dat
[15:24:58.476] INFO: readTbmDacs: data/mqa46/tbmParameters_C0a.dat .. data/mqa46/tbmParameters_C0b.dat
[15:24:58.476] INFO: readMaskFile: data/mqa46/defaultMaskFile.dat
[15:24:58.476] INFO: readTrimFile: data/mqa46/trimParameters35_C0.dat .. data/mqa46/trimParameters35_C15.dat
[15:24:58.630] INFO: clk: 4
[15:24:58.630] INFO: ctr: 4
[15:24:58.630] INFO: sda: 19
[15:24:58.630] INFO: tin: 9
[15:24:58.630] INFO: level: 15
[15:24:58.630] INFO: triggerdelay: 0
[15:24:58.630] QUIET: Instanciating API for pxar v1.9.0+818~g9672706
[15:24:58.630] INFO: Log level: DEBUG
[15:24:58.640] QUIET: Connection to board DTB_WRPRHI opened.
[15:24:58.644] 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:
------------------------------------------------------
[15:24:58.646] INFO: RPC call hashes of host and DTB match: 398089610
[15:25:00.247] INFO: DUT info:
[15:25:00.247] INFO: The DUT currently contains the following objects:
[15:25:00.247] INFO: 2 TBM Cores tbm08c (2 ON)
[15:25:00.247] INFO: TBM Core alpha (0): 7 registers set
[15:25:00.247] INFO: TBM Core beta (1): 7 registers set
[15:25:00.247] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:25:00.247] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:25:00.247] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:25:00.247] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:25:00.247] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:25:00.247] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:25:00.247] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:25:00.247] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:25:00.247] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:25:00.247] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:25:00.247] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:25:00.247] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:25:00.247] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:25:00.247] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:25:00.247] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:25:00.247] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:25:00.247] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[15:25:00.248] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[15:25:00.249] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[15:25:00.250] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:25:00.251] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[15:25:00.251] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[15:25:00.251] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[15:25:00.251] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[15:25:00.251] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[15:25:00.251] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[15:25:00.251] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[15:25:00.251] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[15:25:00.251] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[15:25:00.251] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[15:25:00.251] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:25:00.251] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:25:00.253] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 30330880
[15:25:00.253] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x270f0e0
[15:25:00.253] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x24b1370
[15:25:00.253] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f38f5d94010
[15:25:00.253] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f38fbfff510
[15:25:00.253] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 30339072 fPxarMemory = 0x7f38f5d94010
[15:25:00.254] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 379.4mA
[15:25:00.256] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 468.7mA
[15:25:00.256] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.2 C
[15:25:00.755] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x2afdf20
[15:25:00.819] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[15:25:00.819] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[15:25:00.819] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[15:25:00.825] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[15:25:00.825] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[15:25:00.825] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[15:25:00.838] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[15:25:00.838] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[15:25:00.867] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[15:25:00.867] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[15:25:00.879] INFO: PixTestCmd::init()
[15:25:00.896] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[15:25:00.896] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[15:25:00.896] INFO: readGainPedestalParameters data/mqa46/phCalibrationFitErr35_C0.dat .. data/mqa46/phCalibrationFitErr35_C15.dat
[15:25:01.142] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[15:25:01.142] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[15:25:01.158] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[15:25:01.165] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[15:25:01.165] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[15:25:01.165] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[15:25:01.191] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[15:25:01.191] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[15:25:01.191] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[15:25:01.191] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[15:25:01.191] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[15:25:01.197] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[15:25:01.197] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[15:25:01.217] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[15:25:01.217] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[15:25:01.218] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[15:25:01.218] INFO: readReadbackCal: data/mqa46/readbackCal_C0.dat .. data/mqa46/readbackCal_C15.dat
[15:25:01.227] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[15:25:01.236] DEBUG: <PixTestTiming.cc/setParameter:L59> PixTestTiming::PixTest() targetclk = 4
[15:25:01.236] DEBUG: <PixTestTiming.cc/setParameter:L63> PixTestTiming::PixTest() ntrig = 10
[15:25:01.236] DEBUG: <PixTestTiming.cc/setParameter:L47> fNoTokenPass: 0
[15:25:01.236] DEBUG: <PixTestTiming.cc/init:L73> PixTestTiming::init()
[15:25:01.252] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[15:25:01.252] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[15:25:04.931] INFO: ######################################################################
[15:25:04.931] INFO: PixTestAlive::doTest()
[15:25:04.931] INFO: ######################################################################
[15:25:04.935] INFO: ----------------------------------------------------------------------
[15:25:04.935] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:25:04.935] INFO: ----------------------------------------------------------------------
[15:25:04.937] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:25:05.317] INFO: Expecting 41600 events.
[15:25:09.711] INFO: 41600 events read in total (3676ms).
[15:25:09.859] INFO: Test took 4922ms.
[15:25:09.871] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:25:09.871] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66559
[15:25:09.871] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists PixelAlive_C0 .. PixelAlive_C15
[15:25:10.149] INFO: PixTestAlive::aliveTest() done
[15:25:10.149] INFO: number of dead pixels (per ROC): 0 0 1 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:25:10.149] DEBUG: <PixTestAlive.cc/aliveTest:L199> number of red-efficiency pixels: 40 22 34 58 78 65 55 48 72 55 49 74 61 33 21 37
[15:25:10.175] INFO: ----------------------------------------------------------------------
[15:25:10.175] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:25:10.175] INFO: ----------------------------------------------------------------------
[15:25:10.178] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:25:10.558] INFO: Expecting 41600 events.
[15:25:13.684] INFO: 41600 events read in total (2411ms).
[15:25:13.684] INFO: Test took 3506ms.
[15:25:13.684] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:25:13.684] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 0
[15:25:13.684] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists MaskTest_C0 .. MaskTest_C15
[15:25:13.685] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:25:14.107] INFO: PixTestAlive::maskTest() done
[15:25:14.107] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:25:14.129] INFO: ----------------------------------------------------------------------
[15:25:14.129] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:25:14.129] INFO: ----------------------------------------------------------------------
[15:25:14.132] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:25:14.509] INFO: Expecting 41600 events.
[15:25:18.882] INFO: 41600 events read in total (3658ms).
[15:25:18.884] INFO: Test took 4752ms.
[15:25:18.895] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:25:18.895] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66559
[15:25:18.895] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists AddressDecodingTest_C0 .. AddressDecodingTest_C15
[15:25:19.265] INFO: PixTestAlive::addressDecodingTest() done
[15:25:19.265] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:25:19.265] INFO: PixTestAlive::doTest() done, duration: 14 seconds
[15:25:29.520] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): caldelscan
[15:25:29.520] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: caldelscan
[15:25:29.520] INFO: ----------------------------------------------------------------------
[15:25:29.521] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[15:25:29.521] INFO: ----------------------------------------------------------------------
[15:25:29.660] INFO: Expecting 768 events.
[15:25:30.794] INFO: 768 events read in total (419ms).
[15:25:30.794] INFO: Test took 1268ms.
[15:25:30.800] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:25:31.598] INFO: Expecting 41600 events.
[15:25:35.271] INFO: 41600 events read in total (3147ms).
[15:25:35.276] INFO: Test took 4476ms.
[15:25:35.405] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:25:35.405] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 729316
[15:25:35.405] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step0_C0 .. HR_xeff_CalDelScan_step0_C15
[15:25:35.405] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:25:35.462] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:25:36.128] INFO: Expecting 41600 events.
[15:25:39.900] INFO: 41600 events read in total (3245ms).
[15:25:39.905] INFO: Test took 4443ms.
[15:25:40.031] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:25:40.031] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 735410
[15:25:40.031] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step1_C0 .. HR_xeff_CalDelScan_step1_C15
[15:25:40.031] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:25:40.092] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:25:40.757] INFO: Expecting 41600 events.
[15:25:44.583] INFO: 41600 events read in total (3299ms).
[15:25:44.588] INFO: Test took 4496ms.
[15:25:44.713] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:25:44.713] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 739409
[15:25:44.713] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step2_C0 .. HR_xeff_CalDelScan_step2_C15
[15:25:44.713] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:25:44.773] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:25:45.437] INFO: Expecting 41600 events.
[15:25:49.281] INFO: 41600 events read in total (3317ms).
[15:25:49.286] INFO: Test took 4513ms.
[15:25:49.410] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:25:49.411] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 741096
[15:25:49.411] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step3_C0 .. HR_xeff_CalDelScan_step3_C15
[15:25:49.411] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:25:49.471] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:25:50.136] INFO: Expecting 41600 events.
[15:25:53.926] INFO: 41600 events read in total (3264ms).
[15:25:53.931] INFO: Test took 4460ms.
[15:25:54.051] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:25:54.051] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 739686
[15:25:54.052] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step4_C0 .. HR_xeff_CalDelScan_step4_C15
[15:25:54.052] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:25:54.112] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:25:54.779] INFO: Expecting 41600 events.
[15:25:58.630] INFO: 41600 events read in total (3324ms).
[15:25:58.635] INFO: Test took 4523ms.
[15:25:58.759] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:25:58.759] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 742010
[15:25:58.759] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step5_C0 .. HR_xeff_CalDelScan_step5_C15
[15:25:58.759] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:25:58.822] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:25:59.488] INFO: Expecting 41600 events.
[15:26:03.332] INFO: 41600 events read in total (3317ms).
[15:26:03.337] INFO: Test took 4515ms.
[15:26:03.460] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:26:03.460] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 740766
[15:26:03.460] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step6_C0 .. HR_xeff_CalDelScan_step6_C15
[15:26:03.460] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:26:03.520] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:26:04.185] INFO: Expecting 41600 events.
[15:26:08.042] INFO: 41600 events read in total (3330ms).
[15:26:08.047] INFO: Test took 4527ms.
[15:26:08.172] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:26:08.172] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 743028
[15:26:08.172] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step7_C0 .. HR_xeff_CalDelScan_step7_C15
[15:26:08.172] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:26:08.233] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:26:08.898] INFO: Expecting 41600 events.
[15:26:12.764] INFO: 41600 events read in total (3340ms).
[15:26:12.769] INFO: Test took 4536ms.
[15:26:12.891] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:26:12.891] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 741353
[15:26:12.891] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step8_C0 .. HR_xeff_CalDelScan_step8_C15
[15:26:12.892] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:26:12.951] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:26:13.616] INFO: Expecting 41600 events.
[15:26:17.473] INFO: 41600 events read in total (3330ms).
[15:26:17.478] INFO: Test took 4527ms.
[15:26:17.602] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:26:17.602] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 742369
[15:26:17.602] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step9_C0 .. HR_xeff_CalDelScan_step9_C15
[15:26:17.602] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:26:17.662] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:26:18.327] INFO: Expecting 41600 events.
[15:26:22.200] INFO: 41600 events read in total (3347ms).
[15:26:22.204] INFO: Test took 4542ms.
[15:26:22.329] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:26:22.329] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 741908
[15:26:22.329] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step10_C0 .. HR_xeff_CalDelScan_step10_C15
[15:26:22.330] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:26:22.390] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:26:23.055] INFO: Expecting 41600 events.
[15:26:26.920] INFO: 41600 events read in total (3339ms).
[15:26:26.924] INFO: Test took 4534ms.
[15:26:27.047] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:26:27.047] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 741743
[15:26:27.047] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step11_C0 .. HR_xeff_CalDelScan_step11_C15
[15:26:27.047] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:26:27.108] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:26:27.773] INFO: Expecting 41600 events.
[15:26:31.641] INFO: 41600 events read in total (3341ms).
[15:26:31.646] INFO: Test took 4538ms.
[15:26:31.771] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:26:31.771] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 741838
[15:26:31.771] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step12_C0 .. HR_xeff_CalDelScan_step12_C15
[15:26:31.771] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:26:31.831] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:26:32.496] INFO: Expecting 41600 events.
[15:26:36.362] INFO: 41600 events read in total (3339ms).
[15:26:36.367] INFO: Test took 4536ms.
[15:26:36.492] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:26:36.492] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 741761
[15:26:36.492] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step13_C0 .. HR_xeff_CalDelScan_step13_C15
[15:26:36.492] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:26:36.553] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:26:37.217] INFO: Expecting 41600 events.
[15:26:41.073] INFO: 41600 events read in total (3329ms).
[15:26:41.077] INFO: Test took 4524ms.
[15:26:41.200] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:26:41.200] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 741629
[15:26:41.200] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step14_C0 .. HR_xeff_CalDelScan_step14_C15
[15:26:41.201] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:26:41.261] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:26:41.926] INFO: Expecting 41600 events.
[15:26:45.784] INFO: 41600 events read in total (3331ms).
[15:26:45.789] INFO: Test took 4528ms.
[15:26:45.913] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:26:45.913] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 739661
[15:26:45.913] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step15_C0 .. HR_xeff_CalDelScan_step15_C15
[15:26:45.914] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:26:45.974] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:26:46.639] INFO: Expecting 41600 events.
[15:26:50.511] INFO: 41600 events read in total (3346ms).
[15:26:50.516] INFO: Test took 4542ms.
[15:26:50.641] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:26:50.641] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 738888
[15:26:50.641] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step16_C0 .. HR_xeff_CalDelScan_step16_C15
[15:26:50.641] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:26:50.702] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:26:51.368] INFO: Expecting 41600 events.
[15:26:55.231] INFO: 41600 events read in total (3336ms).
[15:26:55.236] INFO: Test took 4534ms.
[15:26:55.360] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:26:55.360] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 740479
[15:26:55.361] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step17_C0 .. HR_xeff_CalDelScan_step17_C15
[15:26:55.361] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:26:55.421] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:26:56.086] INFO: Expecting 41600 events.
[15:26:59.922] INFO: 41600 events read in total (3309ms).
[15:26:59.927] INFO: Test took 4506ms.
[15:27:00.051] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:27:00.051] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 740944
[15:27:00.051] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step18_C0 .. HR_xeff_CalDelScan_step18_C15
[15:27:00.051] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:27:00.111] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:27:00.776] INFO: Expecting 41600 events.
[15:27:04.437] INFO: 41600 events read in total (3134ms).
[15:27:04.442] INFO: Test took 4331ms.
[15:27:04.563] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:27:04.563] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 733189
[15:27:04.563] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step19_C0 .. HR_xeff_CalDelScan_step19_C15
[15:27:04.564] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:27:04.844] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 0: caldel = 139 eff = 0.999087
[15:27:04.844] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 1: caldel = 130 eff = 0.999567
[15:27:04.845] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 2: caldel = 174 eff = 0.998077
[15:27:04.845] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 3: caldel = 172 eff = 0.99726
[15:27:04.845] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 4: caldel = 167 eff = 0.997212
[15:27:04.845] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 5: caldel = 148 eff = 0.997091
[15:27:04.846] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 6: caldel = 204 eff = 0.997404
[15:27:04.846] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 7: caldel = 183 eff = 0.997861
[15:27:04.846] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 8: caldel = 160 eff = 0.996827
[15:27:04.846] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 9: caldel = 155 eff = 0.996587
[15:27:04.846] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 10: caldel = 164 eff = 0.996803
[15:27:04.847] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 11: caldel = 201 eff = 0.997861
[15:27:04.847] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 12: caldel = 155 eff = 0.997115
[15:27:04.847] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 13: caldel = 155 eff = 0.998389
[15:27:04.847] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 14: caldel = 143 eff = 0.999351
[15:27:04.848] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 15: caldel = 145 eff = 0.999231
[15:27:08.424] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): xpixelalive
[15:27:08.424] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: xpixelalive
[15:27:08.424] INFO: ----------------------------------------------------------------------
[15:27:08.424] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[15:27:08.424] INFO: ----------------------------------------------------------------------
[15:27:08.425] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: clk: 4
[15:27:08.425] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: ctr: 4
[15:27:08.425] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: sda: 19
[15:27:08.425] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: tin: 9
[15:27:08.425] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: level: 15
[15:27:08.425] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: triggerdelay: 0
[15:27:08.425] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: clk: 4
[15:27:08.425] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: ctr: 4
[15:27:08.425] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: sda: 19
[15:27:08.425] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: tin: 9
[15:27:08.425] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: level: 15
[15:27:08.425] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: triggerdelay: 20
[15:27:08.443] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:27:09.113] INFO: Expecting 208000 events.
[15:27:24.670] INFO: 208000 events read in total (15030ms).
[15:27:24.687] INFO: Test took 16244ms.
[15:27:25.285] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:27:25.285] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 3407013
[15:27:25.285] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists highRate_C0 .. highRate_C15
[15:27:25.285] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:27:25.744] INFO: number of dead pixels (per ROC): 0 0 1 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:27:25.744] INFO: number of red-efficiency pixels: 198 136 316 535 633 597 528 485 617 618 560 463 587 305 191 205
[15:27:25.744] INFO: number of X-ray hits detected: 130843 94739 160191 242124 262035 256766 263259 243839 271181 273717 263899 248526 247772 162562 99440 119561
[15:27:25.744] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[15:27:25.744] INFO: number of Vcal hits detected: 207797 207860 207604 207403 207298 207332 207416 207473 207316 207285 207396 207490 207338 207673 207799 207789
[15:27:25.744] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.8 99.7 99.7 99.7 99.7 99.8 99.7 99.7 99.7 99.8 99.7 99.9 99.9 99.9
[15:27:25.744] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.8 99.7 99.7 99.7 99.7 99.7 99.7 99.7 99.7 99.8 99.7 99.8 99.9 99.9
[15:27:25.744] INFO: X-ray hit rate [MHz/cm2]: 38.4 27.8 47.0 71.0 76.8 75.3 77.2 71.5 79.5 80.2 77.4 72.8 72.6 47.6 29.1 35.0
[15:27:25.744] INFO: PixTestHighRate::doXPixelAlive() done
[15:27:25.789] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: clk: 4
[15:27:25.789] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: ctr: 4
[15:27:25.789] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: sda: 19
[15:27:25.789] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: tin: 9
[15:27:25.789] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: level: 15
[15:27:25.789] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: triggerdelay: 0
[15:27:25.789] INFO: PixTest:: pg_setup set to default.
[15:27:28.200] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[15:27:28.200] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = highRate_xraymap_C12_V0 -> highRate_xraymap_mod
[15:27:29.368] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[15:27:29.369] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 382.7mA
[15:27:29.370] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 468.7mA
[15:27:29.370] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.4 C
[15:27:29.370] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[15:27:29.370] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[15:27:29.370] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[15:27:29.370] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[15:27:29.370] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[15:27:29.370] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[15:27:29.370] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[15:27:29.370] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[15:27:29.370] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[15:27:29.371] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[15:27:29.464] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[15:27:29.464] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[15:27:29.473] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[15:27:29.473] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[15:27:29.473] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[15:27:29.473] DEBUG: <PixTestTiming.cc/~PixTestTiming:L96> PixTestTiming dtor
[15:27:29.473] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[15:27:29.474] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[15:27:29.476] QUIET: Connection to board 58 closed.
[15:27:29.555] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrEff_120.log
[15:22:21.229] INFO: *** Welcome to pxar ***
[15:22:21.229] INFO: *** Today: 2016/09/12
[15:22:21.252] INFO: *** Version: v1.9.0-818-g96727
[15:22:21.252] INFO: readRocDacs: data/mqa46/dacParameters35_C0.dat .. data/mqa46/dacParameters35_C15.dat
[15:22:21.253] INFO: readTbmDacs: data/mqa46/tbmParameters_C0a.dat .. data/mqa46/tbmParameters_C0b.dat
[15:22:21.253] INFO: readMaskFile: data/mqa46/defaultMaskFile.dat
[15:22:21.253] INFO: readTrimFile: data/mqa46/trimParameters35_C0.dat .. data/mqa46/trimParameters35_C15.dat
[15:22:21.404] INFO: clk: 4
[15:22:21.404] INFO: ctr: 4
[15:22:21.404] INFO: sda: 19
[15:22:21.404] INFO: tin: 9
[15:22:21.404] INFO: level: 15
[15:22:21.404] INFO: triggerdelay: 0
[15:22:21.404] QUIET: Instanciating API for pxar v1.9.0+818~g9672706
[15:22:21.404] INFO: Log level: DEBUG
[15:22:21.415] QUIET: Connection to board DTB_WRPRHI opened.
[15:22:21.418] 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:
------------------------------------------------------
[15:22:21.421] INFO: RPC call hashes of host and DTB match: 398089610
[15:22:23.025] INFO: DUT info:
[15:22:23.025] INFO: The DUT currently contains the following objects:
[15:22:23.025] INFO: 2 TBM Cores tbm08c (2 ON)
[15:22:23.025] INFO: TBM Core alpha (0): 7 registers set
[15:22:23.025] INFO: TBM Core beta (1): 7 registers set
[15:22:23.025] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:22:23.025] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:23.025] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:23.025] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:23.025] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:23.025] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:23.025] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:23.025] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:23.026] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:23.026] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:23.026] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:23.026] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:23.026] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:23.026] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:23.026] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:23.026] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:23.026] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:23.026] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[15:22:23.026] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:22:23.026] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:22:23.026] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:22:23.026] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[15:22:23.026] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[15:22:23.026] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:22:23.026] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[15:22:23.026] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[15:22:23.026] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:22:23.026] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[15:22:23.026] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[15:22:23.026] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:22:23.026] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:22:23.026] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:22:23.026] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[15:22:23.026] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[15:22:23.026] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[15:22:23.026] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[15:22:23.026] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:22:23.027] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[15:22:23.028] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:22:23.029] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:22:23.031] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 30334976
[15:22:23.031] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x26980e0
[15:22:23.031] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x243a370
[15:22:23.031] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7fb281d94010
[15:22:23.031] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7fb287fff510
[15:22:23.032] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 30343168 fPxarMemory = 0x7fb281d94010
[15:22:23.033] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 379.4mA
[15:22:23.034] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 468.7mA
[15:22:23.034] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.2 C
[15:22:23.529] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x2a86f70
[15:22:23.597] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[15:22:23.598] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[15:22:23.598] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[15:22:23.603] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[15:22:23.603] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[15:22:23.603] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[15:22:23.614] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[15:22:23.614] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[15:22:23.634] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[15:22:23.634] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[15:22:23.646] INFO: PixTestCmd::init()
[15:22:23.660] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[15:22:23.660] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[15:22:23.660] INFO: readGainPedestalParameters data/mqa46/phCalibrationFitErr35_C0.dat .. data/mqa46/phCalibrationFitErr35_C15.dat
[15:22:23.915] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[15:22:23.915] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[15:22:23.928] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[15:22:23.935] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[15:22:23.936] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[15:22:23.936] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[15:22:23.960] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[15:22:23.960] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[15:22:23.960] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[15:22:23.960] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[15:22:23.960] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[15:22:23.967] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[15:22:23.967] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[15:22:23.986] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[15:22:23.986] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[15:22:23.986] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[15:22:23.986] INFO: readReadbackCal: data/mqa46/readbackCal_C0.dat .. data/mqa46/readbackCal_C15.dat
[15:22:23.995] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[15:22:24.002] DEBUG: <PixTestTiming.cc/setParameter:L59> PixTestTiming::PixTest() targetclk = 4
[15:22:24.003] DEBUG: <PixTestTiming.cc/setParameter:L63> PixTestTiming::PixTest() ntrig = 10
[15:22:24.003] DEBUG: <PixTestTiming.cc/setParameter:L47> fNoTokenPass: 0
[15:22:24.003] DEBUG: <PixTestTiming.cc/init:L73> PixTestTiming::init()
[15:22:24.020] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[15:22:24.020] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[15:22:28.804] INFO: ######################################################################
[15:22:28.804] INFO: PixTestAlive::doTest()
[15:22:28.804] INFO: ######################################################################
[15:22:28.807] INFO: ----------------------------------------------------------------------
[15:22:28.807] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:22:28.807] INFO: ----------------------------------------------------------------------
[15:22:28.810] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:22:29.189] INFO: Expecting 41600 events.
[15:22:33.585] INFO: 41600 events read in total (3678ms).
[15:22:33.732] INFO: Test took 4922ms.
[15:22:33.741] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:22:33.742] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66559
[15:22:33.742] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists PixelAlive_C0 .. PixelAlive_C15
[15:22:34.020] INFO: PixTestAlive::aliveTest() done
[15:22:34.020] INFO: number of dead pixels (per ROC): 0 0 1 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:22:34.020] DEBUG: <PixTestAlive.cc/aliveTest:L199> number of red-efficiency pixels: 44 29 42 90 85 68 73 85 81 75 74 62 75 64 35 38
[15:22:34.047] INFO: ----------------------------------------------------------------------
[15:22:34.047] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:22:34.047] INFO: ----------------------------------------------------------------------
[15:22:34.050] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:22:34.429] INFO: Expecting 41600 events.
[15:22:37.547] INFO: 41600 events read in total (2403ms).
[15:22:37.547] INFO: Test took 3497ms.
[15:22:37.547] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:22:37.547] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 0
[15:22:37.547] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists MaskTest_C0 .. MaskTest_C15
[15:22:37.548] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:22:37.970] INFO: PixTestAlive::maskTest() done
[15:22:37.970] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:22:37.992] INFO: ----------------------------------------------------------------------
[15:22:37.992] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:22:37.992] INFO: ----------------------------------------------------------------------
[15:22:37.995] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:22:38.371] INFO: Expecting 41600 events.
[15:22:42.767] INFO: 41600 events read in total (3681ms).
[15:22:42.768] INFO: Test took 4773ms.
[15:22:42.779] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:22:42.780] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66559
[15:22:42.780] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists AddressDecodingTest_C0 .. AddressDecodingTest_C15
[15:22:43.149] INFO: PixTestAlive::addressDecodingTest() done
[15:22:43.149] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:22:43.149] INFO: PixTestAlive::doTest() done, duration: 14 seconds
[15:22:45.171] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): caldelscan
[15:22:45.171] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: caldelscan
[15:22:45.171] INFO: ----------------------------------------------------------------------
[15:22:45.171] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[15:22:45.171] INFO: ----------------------------------------------------------------------
[15:22:45.310] INFO: Expecting 768 events.
[15:22:46.444] INFO: 768 events read in total (419ms).
[15:22:46.444] INFO: Test took 1267ms.
[15:22:46.450] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:22:47.248] INFO: Expecting 41600 events.
[15:22:51.101] INFO: 41600 events read in total (3327ms).
[15:22:51.106] INFO: Test took 4655ms.
[15:22:51.265] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:22:51.265] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 892428
[15:22:51.265] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step0_C0 .. HR_xeff_CalDelScan_step0_C15
[15:22:51.265] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:22:51.332] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:22:51.999] INFO: Expecting 41600 events.
[15:22:55.977] INFO: 41600 events read in total (3452ms).
[15:22:55.982] INFO: Test took 4650ms.
[15:22:56.130] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:22:56.130] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 902780
[15:22:56.130] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step1_C0 .. HR_xeff_CalDelScan_step1_C15
[15:22:56.130] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:22:56.200] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:22:56.865] INFO: Expecting 41600 events.
[15:23:00.888] INFO: 41600 events read in total (3497ms).
[15:23:00.894] INFO: Test took 4694ms.
[15:23:01.041] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:23:01.041] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 905688
[15:23:01.041] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step2_C0 .. HR_xeff_CalDelScan_step2_C15
[15:23:01.042] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:23:01.110] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:23:01.775] INFO: Expecting 41600 events.
[15:23:05.791] INFO: 41600 events read in total (3489ms).
[15:23:05.797] INFO: Test took 4687ms.
[15:23:05.941] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:23:05.941] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 905942
[15:23:05.941] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step3_C0 .. HR_xeff_CalDelScan_step3_C15
[15:23:05.942] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:23:06.011] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:23:06.678] INFO: Expecting 41600 events.
[15:23:10.720] INFO: 41600 events read in total (3515ms).
[15:23:10.725] INFO: Test took 4714ms.
[15:23:10.873] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:23:10.873] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 907433
[15:23:10.873] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step4_C0 .. HR_xeff_CalDelScan_step4_C15
[15:23:10.874] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:23:10.943] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:23:11.608] INFO: Expecting 41600 events.
[15:23:15.641] INFO: 41600 events read in total (3507ms).
[15:23:15.646] INFO: Test took 4703ms.
[15:23:15.793] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:23:15.794] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 907901
[15:23:15.794] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step5_C0 .. HR_xeff_CalDelScan_step5_C15
[15:23:15.794] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:23:15.863] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:23:16.528] INFO: Expecting 41600 events.
[15:23:20.593] INFO: 41600 events read in total (3538ms).
[15:23:20.598] INFO: Test took 4735ms.
[15:23:20.745] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:23:20.745] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 906064
[15:23:20.745] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step6_C0 .. HR_xeff_CalDelScan_step6_C15
[15:23:20.746] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:23:20.815] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:23:21.480] INFO: Expecting 41600 events.
[15:23:25.550] INFO: 41600 events read in total (3543ms).
[15:23:25.555] INFO: Test took 4740ms.
[15:23:25.702] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:23:25.702] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 909719
[15:23:25.702] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step7_C0 .. HR_xeff_CalDelScan_step7_C15
[15:23:25.702] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:23:25.771] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:23:26.436] INFO: Expecting 41600 events.
[15:23:30.508] INFO: 41600 events read in total (3545ms).
[15:23:30.513] INFO: Test took 4742ms.
[15:23:30.661] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:23:30.661] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 908382
[15:23:30.661] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step8_C0 .. HR_xeff_CalDelScan_step8_C15
[15:23:30.661] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:23:30.731] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:23:31.396] INFO: Expecting 41600 events.
[15:23:35.470] INFO: 41600 events read in total (3547ms).
[15:23:35.475] INFO: Test took 4744ms.
[15:23:35.625] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:23:35.626] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 908960
[15:23:35.626] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step9_C0 .. HR_xeff_CalDelScan_step9_C15
[15:23:35.626] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:23:35.695] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:23:36.360] INFO: Expecting 41600 events.
[15:23:40.434] INFO: 41600 events read in total (3547ms).
[15:23:40.440] INFO: Test took 4745ms.
[15:23:40.589] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:23:40.589] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 908462
[15:23:40.589] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step10_C0 .. HR_xeff_CalDelScan_step10_C15
[15:23:40.590] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:23:40.661] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:23:41.328] INFO: Expecting 41600 events.
[15:23:45.415] INFO: 41600 events read in total (3561ms).
[15:23:45.421] INFO: Test took 4760ms.
[15:23:45.567] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:23:45.567] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 908789
[15:23:45.567] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step11_C0 .. HR_xeff_CalDelScan_step11_C15
[15:23:45.567] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:23:45.638] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:23:46.304] INFO: Expecting 41600 events.
[15:23:50.371] INFO: 41600 events read in total (3540ms).
[15:23:50.377] INFO: Test took 4739ms.
[15:23:50.523] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:23:50.524] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 906529
[15:23:50.524] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step12_C0 .. HR_xeff_CalDelScan_step12_C15
[15:23:50.524] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:23:50.593] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:23:51.259] INFO: Expecting 41600 events.
[15:23:55.331] INFO: 41600 events read in total (3546ms).
[15:23:55.336] INFO: Test took 4743ms.
[15:23:55.488] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:23:55.488] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 906770
[15:23:55.488] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step13_C0 .. HR_xeff_CalDelScan_step13_C15
[15:23:55.488] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:23:55.555] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:23:56.220] INFO: Expecting 41600 events.
[15:24:00.288] INFO: 41600 events read in total (3541ms).
[15:24:00.293] INFO: Test took 4738ms.
[15:24:00.441] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:24:00.441] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 906808
[15:24:00.441] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step14_C0 .. HR_xeff_CalDelScan_step14_C15
[15:24:00.441] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:24:00.510] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:24:01.175] INFO: Expecting 41600 events.
[15:24:05.244] INFO: 41600 events read in total (3542ms).
[15:24:05.249] INFO: Test took 4739ms.
[15:24:05.396] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:24:05.396] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 906601
[15:24:05.396] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step15_C0 .. HR_xeff_CalDelScan_step15_C15
[15:24:05.396] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:24:05.466] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:24:06.131] INFO: Expecting 41600 events.
[15:24:10.192] INFO: 41600 events read in total (3535ms).
[15:24:10.197] INFO: Test took 4731ms.
[15:24:10.344] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:24:10.344] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 907185
[15:24:10.344] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step16_C0 .. HR_xeff_CalDelScan_step16_C15
[15:24:10.344] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:24:10.413] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:24:11.079] INFO: Expecting 41600 events.
[15:24:15.164] INFO: 41600 events read in total (3558ms).
[15:24:15.169] INFO: Test took 4756ms.
[15:24:15.317] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:24:15.318] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 906758
[15:24:15.318] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step17_C0 .. HR_xeff_CalDelScan_step17_C15
[15:24:15.318] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:24:15.387] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:24:16.053] INFO: Expecting 41600 events.
[15:24:20.098] INFO: 41600 events read in total (3519ms).
[15:24:20.103] INFO: Test took 4716ms.
[15:24:20.252] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:24:20.252] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 902615
[15:24:20.252] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step18_C0 .. HR_xeff_CalDelScan_step18_C15
[15:24:20.253] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:24:20.321] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:24:20.987] INFO: Expecting 41600 events.
[15:24:24.860] INFO: 41600 events read in total (3347ms).
[15:24:24.865] INFO: Test took 4544ms.
[15:24:25.014] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:24:25.014] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 897600
[15:24:25.014] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step19_C0 .. HR_xeff_CalDelScan_step19_C15
[15:24:25.014] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:24:25.306] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 0: caldel = 140 eff = 0.998654
[15:24:25.306] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 1: caldel = 112 eff = 0.999111
[15:24:25.306] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 2: caldel = 174 eff = 0.997043
[15:24:25.307] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 3: caldel = 173 eff = 0.995865
[15:24:25.307] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 4: caldel = 171 eff = 0.994399
[15:24:25.307] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 5: caldel = 151 eff = 0.995793
[15:24:25.307] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 6: caldel = 205 eff = 0.995481
[15:24:25.307] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 7: caldel = 188 eff = 0.995913
[15:24:25.307] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 8: caldel = 161 eff = 0.995
[15:24:25.308] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 9: caldel = 155 eff = 0.994399
[15:24:25.308] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 10: caldel = 164 eff = 0.994231
[15:24:25.308] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 11: caldel = 203 eff = 0.995841
[15:24:25.308] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 12: caldel = 164 eff = 0.995986
[15:24:25.308] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 13: caldel = 155 eff = 0.997668
[15:24:25.308] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 14: caldel = 158 eff = 0.998918
[15:24:25.308] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 15: caldel = 157 eff = 0.998822
[15:24:27.344] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): xpixelalive
[15:24:27.344] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: xpixelalive
[15:24:27.344] INFO: ----------------------------------------------------------------------
[15:24:27.344] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[15:24:27.344] INFO: ----------------------------------------------------------------------
[15:24:27.345] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: clk: 4
[15:24:27.345] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: ctr: 4
[15:24:27.345] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: sda: 19
[15:24:27.345] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: tin: 9
[15:24:27.345] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: level: 15
[15:24:27.345] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: triggerdelay: 0
[15:24:27.345] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: clk: 4
[15:24:27.345] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: ctr: 4
[15:24:27.345] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: sda: 19
[15:24:27.345] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: tin: 9
[15:24:27.345] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: level: 15
[15:24:27.345] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: triggerdelay: 20
[15:24:27.364] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:24:28.035] INFO: Expecting 208000 events.
[15:24:45.096] INFO: 208000 events read in total (16534ms).
[15:24:45.117] INFO: Test took 17753ms.
[15:24:45.988] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:24:45.988] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 4223553
[15:24:45.988] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists highRate_C0 .. highRate_C15
[15:24:45.988] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:24:46.498] INFO: number of dead pixels (per ROC): 0 0 1 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:24:46.498] INFO: number of red-efficiency pixels: 263 232 456 791 952 823 787 772 945 972 897 762 755 487 215 241
[15:24:46.498] INFO: number of X-ray hits detected: 162580 117839 199688 300637 327200 317899 327918 304526 337044 340700 329216 309358 307235 202828 123402 148924
[15:24:46.498] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[15:24:46.498] INFO: number of Vcal hits detected: 207719 207752 207422 207092 206884 206979 207084 207045 206907 206819 206955 207110 207105 207443 207772 207747
[15:24:46.498] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.8 99.6 99.5 99.6 99.6 99.6 99.5 99.5 99.5 99.6 99.6 99.8 99.9 99.9
[15:24:46.498] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.7 99.6 99.5 99.5 99.6 99.5 99.5 99.4 99.5 99.6 99.6 99.7 99.9 99.9
[15:24:46.498] INFO: X-ray hit rate [MHz/cm2]: 47.7 34.5 58.5 88.1 95.9 93.2 96.1 89.3 98.8 99.9 96.5 90.7 90.1 59.5 36.2 43.7
[15:24:46.498] INFO: PixTestHighRate::doXPixelAlive() done
[15:24:46.546] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: clk: 4
[15:24:46.546] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: ctr: 4
[15:24:46.546] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: sda: 19
[15:24:46.546] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: tin: 9
[15:24:46.546] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: level: 15
[15:24:46.546] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: triggerdelay: 0
[15:24:46.546] INFO: PixTest:: pg_setup set to default.
[15:24:52.480] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[15:24:52.480] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = highRate_xraymap_C12_V0 -> highRate_xraymap_mod
[15:24:53.472] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[15:24:53.473] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 382.7mA
[15:24:53.474] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 468.7mA
[15:24:53.474] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.4 C
[15:24:53.474] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[15:24:53.474] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[15:24:53.474] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[15:24:53.474] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[15:24:53.474] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[15:24:53.474] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[15:24:53.474] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[15:24:53.474] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[15:24:53.474] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[15:24:53.474] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[15:24:53.566] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[15:24:53.567] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[15:24:53.576] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[15:24:53.576] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[15:24:53.576] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[15:24:53.576] DEBUG: <PixTestTiming.cc/~PixTestTiming:L96> PixTestTiming dtor
[15:24:53.576] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[15:24:53.576] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[15:24:53.578] QUIET: Connection to board 58 closed.
[15:24:53.657] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
MoReWeb-v0.5.1-904-gd94b9f2 on branch master