Test Date: 1973-11-29 16:33
Analysis date: 2016-07-01 15:56
Logfile
hrData_40.log
[15:44:38.638] INFO: *** Welcome to pxar ***
[15:44:38.638] INFO: *** Today: 2016/06/30
[15:44:38.664] INFO: *** Version: v1.9.0-814-g7497
[15:44:38.664] INFO: readRocDacs: data/mp501/dacParameters35_C0.dat .. data/mp501/dacParameters35_C15.dat
[15:44:38.665] INFO: readTbmDacs: data/mp501/tbmParameters_C0a.dat .. data/mp501/tbmParameters_C0b.dat
[15:44:38.665] INFO: readMaskFile: data/mp501/defaultMaskFile.dat
[15:44:38.665] INFO: readTrimFile: data/mp501/trimParameters35_C0.dat .. data/mp501/trimParameters35_C15.dat
[15:44:38.820] INFO: clk: 4
[15:44:38.820] INFO: ctr: 4
[15:44:38.820] INFO: sda: 19
[15:44:38.820] INFO: tin: 9
[15:44:38.820] INFO: level: 15
[15:44:38.820] INFO: triggerdelay: 0
[15:44:38.820] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[15:44:38.820] INFO: Log level: DEBUG
[15:44:38.833] QUIET: Connection to board DTB_WRPRHI opened.
[15:44:38.836] 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:44:38.839] INFO: RPC call hashes of host and DTB match: 398089610
[15:44:40.443] INFO: DUT info:
[15:44:40.443] INFO: The DUT currently contains the following objects:
[15:44:40.443] INFO: 2 TBM Cores tbm08c (2 ON)
[15:44:40.443] INFO: TBM Core alpha (0): 7 registers set
[15:44:40.443] INFO: TBM Core beta (1): 7 registers set
[15:44:40.443] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:44:40.443] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:40.443] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:40.443] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:40.443] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:40.443] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:40.443] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:40.443] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:40.443] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:40.443] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:40.443] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:40.443] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:40.443] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:40.443] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:40.443] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:40.443] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:40.443] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[15:44:40.444] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[15:44:40.445] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[15:44:40.446] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[15:44:40.447] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[15:44:40.447] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[15:44:40.447] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[15:44:40.447] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[15:44:40.447] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[15:44:40.447] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[15:44:40.447] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:44:40.447] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:44:40.449] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 33538048
[15:44:40.449] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x102a0d0
[15:44:40.449] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0xdcc360
[15:44:40.449] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7fc2b9d94010
[15:44:40.449] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7fc2bffff510
[15:44:40.449] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 33546240 fPxarMemory = 0x7fc2b9d94010
[15:44:40.450] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 380.2mA
[15:44:40.451] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 475.1mA
[15:44:40.451] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.2 C
[15:44:40.950] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x1414dc0
[15:44:41.010] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[15:44:41.010] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[15:44:41.011] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[15:44:41.016] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[15:44:41.016] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[15:44:41.016] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[15:44:41.028] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[15:44:41.028] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[15:44:41.048] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[15:44:41.049] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[15:44:41.060] INFO: PixTestCmd::init()
[15:44:41.068] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[15:44:41.068] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[15:44:41.068] INFO: readGainPedestalParameters data/mp501/phCalibrationFitErr35_C0.dat .. data/mp501/phCalibrationFitErr35_C15.dat
[15:44:41.314] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[15:44:41.314] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[15:44:41.328] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[15:44:41.333] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[15:44:41.333] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[15:44:41.333] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[15:44:41.358] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[15:44:41.358] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[15:44:41.358] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[15:44:41.358] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[15:44:41.358] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[15:44:41.365] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[15:44:41.365] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[15:44:41.385] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[15:44:41.386] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[15:44:41.386] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[15:44:41.386] INFO: readReadbackCal: data/mp501/readbackCal_C0.dat .. data/mp501/readbackCal_C15.dat
[15:44:41.395] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[15:44:41.402] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[15:44:41.403] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[15:44:41.403] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[15:44:41.403] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[15:44:41.421] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[15:44:41.422] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[15:44:46.321] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 1 -> source to value 02ma
[15:44:48.881] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 2 -> runseconds to value 60
[15:44:50.262] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): phrun
[15:44:50.262] DEBUG: <PixTestXray.cc/runCommand:L109> running command: phrun
[15:44:50.262] INFO: ----------------------------------------------------------------------
[15:44:50.262] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[15:44:50.262] INFO: ----------------------------------------------------------------------
[15:44:51.236] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[15:45:03.968] INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[15:45:03.972] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:45:31.539] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1254425 events.
[15:45:37.261] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1254425, pixels seen in all events: 5198684
[15:45:37.367] INFO: Resuming triggers.
[15:45:50.104] INFO: run duration 25 seconds, buffer almost full (81%), pausing triggers.
[15:45:50.141] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:46:17.767] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1254843 events.
[15:46:23.461] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1254843, pixels seen in all events: 5192760
[15:46:23.559] INFO: Resuming triggers.
[15:46:36.302] INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[15:46:36.401] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:47:03.852] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1255495 events.
[15:47:09.464] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1255495, pixels seen in all events: 5185450
[15:47:09.697] INFO: Resuming triggers.
[15:47:22.438] INFO: run duration 50 seconds, buffer almost full (81%), pausing triggers.
[15:47:22.478] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:47:49.901] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1255127 events.
[15:47:55.507] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1255127, pixels seen in all events: 5189719
[15:47:55.740] INFO: Resuming triggers.
[15:48:04.874] INFO: data taking finished, elapsed time: 60 seconds.
[15:48:05.070] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:48:24.896] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 899811 events.
[15:48:28.909] DEBUG: <PixTestXray.cc/processData:L823> # events read: 899811, pixels seen in all events: 3720608
[15:48:28.991] INFO: PixTest:: pg_setup set to default.
[15:48:29.077] INFO: PixTestXray::doPhRun() done
[15:48:59.206] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[15:48:59.207] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 383.5mA
[15:48:59.207] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 475.1mA
[15:48:59.207] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.4 C
[15:48:59.207] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[15:48:59.208] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[15:48:59.208] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[15:48:59.208] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[15:48:59.208] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[15:48:59.208] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[15:48:59.208] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[15:48:59.208] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[15:48:59.208] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[15:48:59.208] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[15:48:59.208] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[15:48:59.208] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[15:48:59.208] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[15:48:59.208] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[15:48:59.208] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[15:48:59.208] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[15:48:59.209] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[15:48:59.209] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[15:48:59.482] QUIET: Connection to board 58 closed.
[15:48:59.562] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrData_120.log
[15:49:05.621] INFO: *** Welcome to pxar ***
[15:49:05.621] INFO: *** Today: 2016/06/30
[15:49:05.645] INFO: *** Version: v1.9.0-814-g7497
[15:49:05.645] INFO: readRocDacs: data/mp501/dacParameters35_C0.dat .. data/mp501/dacParameters35_C15.dat
[15:49:05.646] INFO: readTbmDacs: data/mp501/tbmParameters_C0a.dat .. data/mp501/tbmParameters_C0b.dat
[15:49:05.646] INFO: readMaskFile: data/mp501/defaultMaskFile.dat
[15:49:05.646] INFO: readTrimFile: data/mp501/trimParameters35_C0.dat .. data/mp501/trimParameters35_C15.dat
[15:49:05.795] INFO: clk: 4
[15:49:05.795] INFO: ctr: 4
[15:49:05.795] INFO: sda: 19
[15:49:05.795] INFO: tin: 9
[15:49:05.795] INFO: level: 15
[15:49:05.795] INFO: triggerdelay: 0
[15:49:05.795] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[15:49:05.795] INFO: Log level: DEBUG
[15:49:05.806] QUIET: Connection to board DTB_WRPRHI opened.
[15:49:05.809] 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:49:05.812] INFO: RPC call hashes of host and DTB match: 398089610
[15:49:07.413] INFO: DUT info:
[15:49:07.413] INFO: The DUT currently contains the following objects:
[15:49:07.413] INFO: 2 TBM Cores tbm08c (2 ON)
[15:49:07.413] INFO: TBM Core alpha (0): 7 registers set
[15:49:07.413] INFO: TBM Core beta (1): 7 registers set
[15:49:07.413] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:49:07.413] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:07.413] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:07.413] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:07.413] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:07.413] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:07.413] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:07.413] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:07.413] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:07.413] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:07.413] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:07.413] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:07.413] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:07.413] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:07.413] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:07.413] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:07.413] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[15:49:07.414] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[15:49:07.415] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:49:07.416] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:49:07.417] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:49:07.419] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 31399936
[15:49:07.419] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x1ccd0d0
[15:49:07.419] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x1a6f360
[15:49:07.419] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f3d49d94010
[15:49:07.419] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f3d4ffff510
[15:49:07.419] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 31408128 fPxarMemory = 0x7f3d49d94010
[15:49:07.420] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 380.2mA
[15:49:07.422] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 475.1mA
[15:49:07.422] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.2 C
[15:49:07.919] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x20b7d60
[15:49:07.979] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[15:49:07.979] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[15:49:07.979] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[15:49:07.985] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[15:49:07.985] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[15:49:07.985] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[15:49:07.995] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[15:49:07.995] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[15:49:08.019] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[15:49:08.020] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[15:49:08.033] INFO: PixTestCmd::init()
[15:49:08.050] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[15:49:08.050] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[15:49:08.050] INFO: readGainPedestalParameters data/mp501/phCalibrationFitErr35_C0.dat .. data/mp501/phCalibrationFitErr35_C15.dat
[15:49:08.299] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[15:49:08.299] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[15:49:08.313] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[15:49:08.318] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[15:49:08.318] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[15:49:08.318] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[15:49:08.343] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[15:49:08.343] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[15:49:08.343] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[15:49:08.343] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[15:49:08.343] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[15:49:08.352] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[15:49:08.352] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[15:49:08.375] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[15:49:08.375] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[15:49:08.376] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[15:49:08.376] INFO: readReadbackCal: data/mp501/readbackCal_C0.dat .. data/mp501/readbackCal_C15.dat
[15:49:08.387] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[15:49:08.403] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[15:49:08.403] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[15:49:08.403] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[15:49:08.403] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[15:49:08.415] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[15:49:08.415] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[15:49:20.849] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 1 -> source to value 06ma
[15:49:23.137] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 2 -> runseconds to value 60
[15:49:25.454] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): phrun
[15:49:25.454] DEBUG: <PixTestXray.cc/runCommand:L109> running command: phrun
[15:49:25.454] INFO: ----------------------------------------------------------------------
[15:49:25.454] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[15:49:25.454] INFO: ----------------------------------------------------------------------
[15:49:26.428] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[15:49:34.425] INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[15:49:34.429] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:49:59.669] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 787981 events.
[15:50:11.242] DEBUG: <PixTestXray.cc/processData:L823> # events read: 787981, pixels seen in all events: 10797030
[15:50:11.508] INFO: Resuming triggers.
[15:50:19.513] INFO: run duration 15 seconds, buffer almost full (81%), pausing triggers.
[15:50:19.552] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:50:44.734] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 788580 events.
[15:50:56.287] DEBUG: <PixTestXray.cc/processData:L823> # events read: 788580, pixels seen in all events: 10788615
[15:50:56.492] INFO: Resuming triggers.
[15:51:04.496] INFO: run duration 23 seconds, buffer almost full (81%), pausing triggers.
[15:51:04.565] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:51:29.783] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 788594 events.
[15:51:41.406] DEBUG: <PixTestXray.cc/processData:L823> # events read: 788594, pixels seen in all events: 10788073
[15:51:41.652] INFO: Resuming triggers.
[15:51:49.656] INFO: run duration 31 seconds, buffer almost full (81%), pausing triggers.
[15:51:49.698] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:52:14.885] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 788421 events.
[15:52:26.451] DEBUG: <PixTestXray.cc/processData:L823> # events read: 788421, pixels seen in all events: 10790835
[15:52:26.698] INFO: Resuming triggers.
[15:52:34.705] INFO: run duration 39 seconds, buffer almost full (81%), pausing triggers.
[15:52:34.748] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:52:59.977] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 788802 events.
[15:53:11.579] DEBUG: <PixTestXray.cc/processData:L823> # events read: 788802, pixels seen in all events: 10785687
[15:53:11.788] INFO: Resuming triggers.
[15:53:19.795] INFO: run duration 47 seconds, buffer almost full (81%), pausing triggers.
[15:53:19.867] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:53:45.093] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 788852 events.
[15:53:56.699] DEBUG: <PixTestXray.cc/processData:L823> # events read: 788852, pixels seen in all events: 10785447
[15:53:56.947] INFO: Resuming triggers.
[15:54:04.956] INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[15:54:04.995] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:54:30.182] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 788990 events.
[15:54:41.731] DEBUG: <PixTestXray.cc/processData:L823> # events read: 788990, pixels seen in all events: 10783809
[15:54:41.979] INFO: Resuming triggers.
[15:54:46.029] INFO: data taking finished, elapsed time: 60 seconds.
[15:54:46.225] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[15:54:59.096] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 398981 events.
[15:55:04.954] DEBUG: <PixTestXray.cc/processData:L823> # events read: 398981, pixels seen in all events: 5449943
[15:55:05.063] INFO: PixTest:: pg_setup set to default.
[15:55:05.107] INFO: PixTestXray::doPhRun() done
[15:55:08.950] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[15:55:08.951] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 383.5mA
[15:55:08.951] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 475.9mA
[15:55:08.951] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.2 C
[15:55:08.951] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[15:55:08.951] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[15:55:08.952] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[15:55:08.952] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[15:55:08.952] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[15:55:08.952] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[15:55:08.952] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[15:55:08.952] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[15:55:08.952] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[15:55:08.952] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[15:55:08.952] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[15:55:08.952] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[15:55:08.952] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[15:55:08.952] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[15:55:08.952] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[15:55:08.953] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[15:55:08.953] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[15:55:08.953] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[15:55:09.272] QUIET: Connection to board 58 closed.
[15:55:09.352] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrEff_40.log
[15:36:53.093] INFO: *** Welcome to pxar ***
[15:36:53.093] INFO: *** Today: 2016/06/30
[15:36:53.117] INFO: *** Version: v1.9.0-814-g7497
[15:36:53.117] INFO: readRocDacs: data/mp501/dacParameters35_C0.dat .. data/mp501/dacParameters35_C15.dat
[15:36:53.118] INFO: readTbmDacs: data/mp501/tbmParameters_C0a.dat .. data/mp501/tbmParameters_C0b.dat
[15:36:53.118] INFO: readMaskFile: data/mp501/defaultMaskFile.dat
[15:36:53.118] INFO: readTrimFile: data/mp501/trimParameters35_C0.dat .. data/mp501/trimParameters35_C15.dat
[15:36:53.270] INFO: clk: 4
[15:36:53.270] INFO: ctr: 4
[15:36:53.270] INFO: sda: 19
[15:36:53.270] INFO: tin: 9
[15:36:53.270] INFO: level: 15
[15:36:53.270] INFO: triggerdelay: 0
[15:36:53.270] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[15:36:53.270] INFO: Log level: DEBUG
[15:36:53.282] QUIET: Connection to board DTB_WRPRHI opened.
[15:36:53.286] 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:53.288] INFO: RPC call hashes of host and DTB match: 398089610
[15:36:54.890] INFO: DUT info:
[15:36:54.890] INFO: The DUT currently contains the following objects:
[15:36:54.890] INFO: 2 TBM Cores tbm08c (2 ON)
[15:36:54.890] INFO: TBM Core alpha (0): 7 registers set
[15:36:54.890] INFO: TBM Core beta (1): 7 registers set
[15:36:54.890] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:36:54.890] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:54.890] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:54.890] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:54.890] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:54.890] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:54.890] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:54.890] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:54.890] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:54.890] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:54.890] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:54.890] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:54.890] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:54.890] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:54.890] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:54.890] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:54.890] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[15:36:54.891] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[15:36:54.892] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[15:36:54.893] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[15:36:54.894] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[15:36:54.894] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[15:36:54.894] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[15:36:54.894] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[15:36:54.894] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[15:36:54.894] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[15:36:54.894] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[15:36:54.894] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:36:54.894] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[15:36:54.894] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[15:36:54.894] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[15:36:54.894] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[15:36:54.894] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[15:36:54.894] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[15:36:54.894] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[15:36:54.894] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[15:36:54.894] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[15:36:54.894] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[15:36:54.894] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:36:54.894] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:36:54.896] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 33492992
[15:36:54.896] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x13080d0
[15:36:54.896] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x10aa360
[15:36:54.896] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7ff723f91010
[15:36:54.896] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7ff72a1fc510
[15:36:54.896] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 33501184 fPxarMemory = 0x7ff723f91010
[15:36:54.897] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 380.2mA
[15:36:54.899] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 475.1mA
[15:36:54.899] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.2 C
[15:36:55.397] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x16f2d50
[15:36:55.463] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[15:36:55.463] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[15:36:55.464] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[15:36:55.469] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[15:36:55.469] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[15:36:55.469] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[15:36:55.478] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[15:36:55.479] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[15:36:55.488] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[15:36:55.488] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[15:36:55.507] INFO: PixTestCmd::init()
[15:36:55.512] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[15:36:55.512] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[15:36:55.512] INFO: readGainPedestalParameters data/mp501/phCalibrationFitErr35_C0.dat .. data/mp501/phCalibrationFitErr35_C15.dat
[15:36:55.755] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[15:36:55.755] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[15:36:55.769] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[15:36:55.775] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[15:36:55.775] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[15:36:55.775] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[15:36:55.800] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[15:36:55.800] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[15:36:55.800] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[15:36:55.800] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[15:36:55.800] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[15:36:55.807] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[15:36:55.807] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[15:36:55.828] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[15:36:55.828] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[15:36:55.828] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[15:36:55.828] INFO: readReadbackCal: data/mp501/readbackCal_C0.dat .. data/mp501/readbackCal_C15.dat
[15:36:55.838] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[15:36:55.848] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[15:36:55.849] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[15:36:55.849] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[15:36:55.849] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[15:36:55.866] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[15:36:55.866] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[15:36:59.561] INFO: ######################################################################
[15:36:59.561] INFO: PixTestAlive::doTest()
[15:36:59.561] INFO: ######################################################################
[15:36:59.564] INFO: ----------------------------------------------------------------------
[15:36:59.564] 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:36:59.564] INFO: ----------------------------------------------------------------------
[15:36:59.566] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:36:59.946] INFO: Expecting 41600 events.
[15:37:04.358] INFO: 41600 events read in total (3694ms).
[15:37:04.506] INFO: Test took 4939ms.
[15:37:04.517] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:37:04.517] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[15:37:04.517] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists PixelAlive_C0 .. PixelAlive_C15
[15:37:04.796] INFO: PixTestAlive::aliveTest() done
[15:37:04.796] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:37:04.796] DEBUG: <PixTestAlive.cc/aliveTest:L199> number of red-efficiency pixels: 16 14 31 33 36 39 39 24 33 26 42 37 39 24 6 12
[15:37:04.822] INFO: ----------------------------------------------------------------------
[15:37:04.822] 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:37:04.822] INFO: ----------------------------------------------------------------------
[15:37:04.825] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:37:05.206] INFO: Expecting 41600 events.
[15:37:08.316] INFO: 41600 events read in total (2395ms).
[15:37:08.317] INFO: Test took 3492ms.
[15:37:08.317] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:37:08.317] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 0
[15:37:08.317] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists MaskTest_C0 .. MaskTest_C15
[15:37:08.317] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:37:08.739] INFO: PixTestAlive::maskTest() done
[15:37:08.739] 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:37:08.760] INFO: ----------------------------------------------------------------------
[15:37:08.760] 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:37:08.760] INFO: ----------------------------------------------------------------------
[15:37:08.763] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:37:09.141] INFO: Expecting 41600 events.
[15:37:13.538] INFO: 41600 events read in total (3682ms).
[15:37:13.540] INFO: Test took 4777ms.
[15:37:13.550] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:37:13.550] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[15:37:13.550] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists AddressDecodingTest_C0 .. AddressDecodingTest_C15
[15:37:13.920] INFO: PixTestAlive::addressDecodingTest() done
[15:37:13.920] 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:37:13.921] INFO: PixTestAlive::doTest() done, duration: 14 seconds
[15:37:46.965] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[15:37:46.966] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = PixelAlive_C3_V0 -> PixelAlive_mod
[15:37:50.261] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): caldelscan
[15:37:50.262] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: caldelscan
[15:37:50.262] INFO: ----------------------------------------------------------------------
[15:37:50.262] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[15:37:50.262] INFO: ----------------------------------------------------------------------
[15:37:50.401] INFO: Expecting 768 events.
[15:37:51.535] INFO: 768 events read in total (419ms).
[15:37:51.535] INFO: Test took 1268ms.
[15:37:51.541] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:37:52.338] INFO: Expecting 41600 events.
[15:37:55.648] INFO: 41600 events read in total (2783ms).
[15:37:55.652] INFO: Test took 4111ms.
[15:37:55.733] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:37:55.733] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 459067
[15:37:55.733] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step0_C0 .. HR_xeff_CalDelScan_step0_C15
[15:37:55.733] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:37:55.770] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:37:56.437] INFO: Expecting 41600 events.
[15:37:59.873] INFO: 41600 events read in total (2909ms).
[15:37:59.876] INFO: Test took 4106ms.
[15:37:59.953] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:37:59.953] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 466129
[15:37:59.953] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step1_C0 .. HR_xeff_CalDelScan_step1_C15
[15:37:59.953] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:37:59.992] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:38:00.657] INFO: Expecting 41600 events.
[15:38:04.142] INFO: 41600 events read in total (2958ms).
[15:38:04.145] INFO: Test took 4153ms.
[15:38:04.222] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:04.223] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 469391
[15:38:04.223] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step2_C0 .. HR_xeff_CalDelScan_step2_C15
[15:38:04.223] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:38:04.262] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:38:04.927] INFO: Expecting 41600 events.
[15:38:08.415] INFO: 41600 events read in total (2961ms).
[15:38:08.419] INFO: Test took 4157ms.
[15:38:08.497] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:08.497] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 469968
[15:38:08.497] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step3_C0 .. HR_xeff_CalDelScan_step3_C15
[15:38:08.497] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:38:08.537] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:38:09.202] INFO: Expecting 41600 events.
[15:38:12.688] INFO: 41600 events read in total (2960ms).
[15:38:12.691] INFO: Test took 4154ms.
[15:38:12.768] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:12.768] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 469530
[15:38:12.768] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step4_C0 .. HR_xeff_CalDelScan_step4_C15
[15:38:12.768] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:38:12.808] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:38:13.473] INFO: Expecting 41600 events.
[15:38:16.959] INFO: 41600 events read in total (2959ms).
[15:38:16.963] INFO: Test took 4155ms.
[15:38:17.039] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:17.040] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 468826
[15:38:17.040] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step5_C0 .. HR_xeff_CalDelScan_step5_C15
[15:38:17.040] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:38:17.079] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:38:17.744] INFO: Expecting 41600 events.
[15:38:21.243] INFO: 41600 events read in total (2972ms).
[15:38:21.247] INFO: Test took 4168ms.
[15:38:21.324] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:21.324] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 470158
[15:38:21.324] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step6_C0 .. HR_xeff_CalDelScan_step6_C15
[15:38:21.325] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:38:21.364] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:38:22.029] INFO: Expecting 41600 events.
[15:38:25.536] INFO: 41600 events read in total (2980ms).
[15:38:25.540] INFO: Test took 4176ms.
[15:38:25.617] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:25.617] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 470968
[15:38:25.617] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step7_C0 .. HR_xeff_CalDelScan_step7_C15
[15:38:25.618] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:38:25.656] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:38:26.321] INFO: Expecting 41600 events.
[15:38:29.821] INFO: 41600 events read in total (2972ms).
[15:38:29.825] INFO: Test took 4169ms.
[15:38:29.903] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:29.903] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 471375
[15:38:29.903] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step8_C0 .. HR_xeff_CalDelScan_step8_C15
[15:38:29.903] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:38:29.943] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:38:30.612] INFO: Expecting 41600 events.
[15:38:34.119] INFO: 41600 events read in total (2980ms).
[15:38:34.123] INFO: Test took 4180ms.
[15:38:34.200] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:34.200] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 470338
[15:38:34.200] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step9_C0 .. HR_xeff_CalDelScan_step9_C15
[15:38:34.201] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:38:34.241] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:38:34.906] INFO: Expecting 41600 events.
[15:38:38.415] INFO: 41600 events read in total (2983ms).
[15:38:38.419] INFO: Test took 4178ms.
[15:38:38.496] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:38.496] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 470871
[15:38:38.496] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step10_C0 .. HR_xeff_CalDelScan_step10_C15
[15:38:38.497] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:38:38.536] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:38:39.201] INFO: Expecting 41600 events.
[15:38:42.692] INFO: 41600 events read in total (2964ms).
[15:38:42.695] INFO: Test took 4159ms.
[15:38:42.773] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:42.773] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 470647
[15:38:42.773] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step11_C0 .. HR_xeff_CalDelScan_step11_C15
[15:38:42.774] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:38:42.813] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:38:43.478] INFO: Expecting 41600 events.
[15:38:46.981] INFO: 41600 events read in total (2976ms).
[15:38:46.985] INFO: Test took 4172ms.
[15:38:47.061] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:47.061] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 470358
[15:38:47.061] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step12_C0 .. HR_xeff_CalDelScan_step12_C15
[15:38:47.062] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:38:47.101] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:38:47.766] INFO: Expecting 41600 events.
[15:38:51.274] INFO: 41600 events read in total (2982ms).
[15:38:51.278] INFO: Test took 4177ms.
[15:38:51.357] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:51.357] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 470466
[15:38:51.357] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step13_C0 .. HR_xeff_CalDelScan_step13_C15
[15:38:51.358] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:38:51.399] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:38:52.065] INFO: Expecting 41600 events.
[15:38:55.575] INFO: 41600 events read in total (2983ms).
[15:38:55.578] INFO: Test took 4179ms.
[15:38:55.656] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:55.656] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 470213
[15:38:55.656] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step14_C0 .. HR_xeff_CalDelScan_step14_C15
[15:38:55.656] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:38:55.696] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:38:56.361] INFO: Expecting 41600 events.
[15:38:59.870] INFO: 41600 events read in total (2983ms).
[15:38:59.873] INFO: Test took 4177ms.
[15:38:59.953] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:59.953] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 471002
[15:38:59.953] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step15_C0 .. HR_xeff_CalDelScan_step15_C15
[15:38:59.953] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:38:59.994] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:39:00.661] INFO: Expecting 41600 events.
[15:39:04.161] INFO: 41600 events read in total (2974ms).
[15:39:04.165] INFO: Test took 4171ms.
[15:39:04.244] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:39:04.244] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 469729
[15:39:04.244] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step16_C0 .. HR_xeff_CalDelScan_step16_C15
[15:39:04.244] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:39:04.284] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:39:04.949] INFO: Expecting 41600 events.
[15:39:08.430] INFO: 41600 events read in total (2954ms).
[15:39:08.434] INFO: Test took 4150ms.
[15:39:08.511] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:39:08.511] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 470006
[15:39:08.511] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step17_C0 .. HR_xeff_CalDelScan_step17_C15
[15:39:08.512] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:39:08.551] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:39:09.216] INFO: Expecting 41600 events.
[15:39:12.706] INFO: 41600 events read in total (2963ms).
[15:39:12.709] INFO: Test took 4158ms.
[15:39:12.787] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:39:12.787] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 468935
[15:39:12.787] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step18_C0 .. HR_xeff_CalDelScan_step18_C15
[15:39:12.787] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:39:12.827] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:39:13.492] INFO: Expecting 41600 events.
[15:39:16.860] INFO: 41600 events read in total (2842ms).
[15:39:16.864] INFO: Test took 4037ms.
[15:39:16.941] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:39:16.941] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 465131
[15:39:16.941] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step19_C0 .. HR_xeff_CalDelScan_step19_C15
[15:39:16.941] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:39:17.201] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 0: caldel = 157 eff = 0.999712
[15:39:17.202] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 1: caldel = 155 eff = 0.999784
[15:39:17.202] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 2: caldel = 167 eff = 0.999399
[15:39:17.202] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 3: caldel = 182 eff = 0.999111
[15:39:17.202] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 4: caldel = 143 eff = 0.999038
[15:39:17.202] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 5: caldel = 151 eff = 0.999135
[15:39:17.202] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 6: caldel = 159 eff = 0.998966
[15:39:17.203] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 7: caldel = 167 eff = 0.999063
[15:39:17.203] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 8: caldel = 148 eff = 0.999135
[15:39:17.203] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 9: caldel = 155 eff = 0.998918
[15:39:17.203] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 10: caldel = 148 eff = 0.99887
[15:39:17.203] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 11: caldel = 154 eff = 0.998966
[15:39:17.203] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 12: caldel = 135 eff = 0.99899
[15:39:17.203] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 13: caldel = 165 eff = 0.999423
[15:39:17.204] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 14: caldel = 155 eff = 0.999688
[15:39:17.204] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 15: caldel = 141 eff = 0.999736
[15:39:31.861] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): xpixelalive
[15:39:31.862] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: xpixelalive
[15:39:31.862] INFO: ----------------------------------------------------------------------
[15:39:31.862] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[15:39:31.862] INFO: ----------------------------------------------------------------------
[15:39:31.862] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: clk: 4
[15:39:31.862] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: ctr: 4
[15:39:31.862] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: sda: 19
[15:39:31.862] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: tin: 9
[15:39:31.862] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: level: 15
[15:39:31.862] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: triggerdelay: 0
[15:39:31.862] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: clk: 4
[15:39:31.862] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: ctr: 4
[15:39:31.862] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: sda: 19
[15:39:31.862] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: tin: 9
[15:39:31.862] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: level: 15
[15:39:31.862] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: triggerdelay: 20
[15:39:31.879] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:39:32.548] INFO: Expecting 208000 events.
[15:39:46.012] INFO: 208000 events read in total (12937ms).
[15:39:46.023] INFO: Test took 14144ms.
[15:39:46.382] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:39:46.382] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 2072804
[15:39:46.382] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists highRate_C0 .. highRate_C15
[15:39:46.382] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:39:46.751] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:39:46.751] INFO: number of red-efficiency pixels: 81 87 122 200 255 256 256 259 267 209 244 250 197 142 79 87
[15:39:46.751] INFO: number of X-ray hits detected: 75347 57223 98745 152075 157260 155793 155045 148113 155657 160800 163791 148181 151193 101755 58896 66370
[15:39:46.751] 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:39:46.751] INFO: number of Vcal hits detected: 207919 207912 207855 207797 207728 207732 207733 207730 207723 207786 207745 207738 207795 207851 207920 207913
[15:39:46.751] INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 100.0 100.0
[15:39:46.751] INFO: Vcal hit overall efficiency (%): 100.0 100.0 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 100.0 100.0
[15:39:46.751] INFO: X-ray hit rate [MHz/cm2]: 22.1 16.8 28.9 44.6 46.1 45.7 45.4 43.4 45.6 47.1 48.0 43.4 44.3 29.8 17.3 19.5
[15:39:46.751] INFO: PixTestHighRate::doXPixelAlive() done
[15:39:46.796] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: clk: 4
[15:39:46.796] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: ctr: 4
[15:39:46.796] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: sda: 19
[15:39:46.796] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: tin: 9
[15:39:46.796] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: level: 15
[15:39:46.796] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: triggerdelay: 0
[15:39:46.796] INFO: PixTest:: pg_setup set to default.
[15:39:52.910] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[15:39:52.910] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = highRate_xraymap_C9_V0 -> highRate_xraymap_mod
[15:40:22.622] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[15:40:22.622] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 383.5mA
[15:40:22.623] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 475.1mA
[15:40:22.623] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.4 C
[15:40:22.623] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[15:40:22.623] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[15:40:22.623] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[15:40:22.623] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[15:40:22.623] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[15:40:22.624] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[15:40:22.624] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[15:40:22.624] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[15:40:22.624] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[15:40:22.624] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[15:40:22.714] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[15:40:22.714] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[15:40:22.728] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[15:40:22.728] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[15:40:22.728] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[15:40:22.728] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[15:40:22.728] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[15:40:22.728] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[15:40:22.730] QUIET: Connection to board 58 closed.
[15:40:22.810] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrEff_80.log
[15:33:38.329] INFO: *** Welcome to pxar ***
[15:33:38.329] INFO: *** Today: 2016/06/30
[15:33:38.355] INFO: *** Version: v1.9.0-814-g7497
[15:33:38.355] INFO: readRocDacs: data/mp501/dacParameters35_C0.dat .. data/mp501/dacParameters35_C15.dat
[15:33:38.356] INFO: readTbmDacs: data/mp501/tbmParameters_C0a.dat .. data/mp501/tbmParameters_C0b.dat
[15:33:38.356] INFO: readMaskFile: data/mp501/defaultMaskFile.dat
[15:33:38.356] INFO: readTrimFile: data/mp501/trimParameters35_C0.dat .. data/mp501/trimParameters35_C15.dat
[15:33:38.508] INFO: clk: 4
[15:33:38.508] INFO: ctr: 4
[15:33:38.508] INFO: sda: 19
[15:33:38.508] INFO: tin: 9
[15:33:38.508] INFO: level: 15
[15:33:38.508] INFO: triggerdelay: 0
[15:33:38.508] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[15:33:38.508] INFO: Log level: DEBUG
[15:33:38.520] QUIET: Connection to board DTB_WRPRHI opened.
[15:33:38.523] 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:33:38.526] INFO: RPC call hashes of host and DTB match: 398089610
[15:33:40.128] INFO: DUT info:
[15:33:40.128] INFO: The DUT currently contains the following objects:
[15:33:40.128] INFO: 2 TBM Cores tbm08c (2 ON)
[15:33:40.128] INFO: TBM Core alpha (0): 7 registers set
[15:33:40.128] INFO: TBM Core beta (1): 7 registers set
[15:33:40.128] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:33:40.128] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:33:40.128] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:33:40.128] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:33:40.128] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:33:40.128] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:33:40.128] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:33:40.128] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:33:40.128] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:33:40.128] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:33:40.128] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:33:40.128] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:33:40.128] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:33:40.128] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:33:40.128] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:33:40.128] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:33:40.128] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:33:40.129] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[15:33:40.130] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[15:33:40.131] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[15:33:40.132] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[15:33:40.132] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[15:33:40.132] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[15:33:40.132] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[15:33:40.132] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[15:33:40.132] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[15:33:40.132] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[15:33:40.132] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:33:40.132] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:33:40.134] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 34840576
[15:33:40.134] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x25970d0
[15:33:40.134] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x2339360
[15:33:40.134] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f1299d94010
[15:33:40.134] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f129ffff510
[15:33:40.134] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 34848768 fPxarMemory = 0x7f1299d94010
[15:33:40.135] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 380.2mA
[15:33:40.136] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 475.1mA
[15:33:40.136] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.1 C
[15:33:40.630] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x2981cf0
[15:33:40.696] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[15:33:40.697] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[15:33:40.697] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[15:33:40.702] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[15:33:40.702] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[15:33:40.703] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[15:33:40.716] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[15:33:40.716] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[15:33:40.725] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[15:33:40.726] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[15:33:40.740] INFO: PixTestCmd::init()
[15:33:40.749] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[15:33:40.749] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[15:33:40.749] INFO: readGainPedestalParameters data/mp501/phCalibrationFitErr35_C0.dat .. data/mp501/phCalibrationFitErr35_C15.dat
[15:33:40.996] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[15:33:40.996] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[15:33:41.012] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[15:33:41.018] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[15:33:41.018] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[15:33:41.018] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[15:33:41.045] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[15:33:41.045] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[15:33:41.045] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[15:33:41.045] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[15:33:41.045] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[15:33:41.051] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[15:33:41.051] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[15:33:41.071] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[15:33:41.071] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[15:33:41.071] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[15:33:41.071] INFO: readReadbackCal: data/mp501/readbackCal_C0.dat .. data/mp501/readbackCal_C15.dat
[15:33:41.080] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[15:33:41.089] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[15:33:41.089] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[15:33:41.089] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[15:33:41.089] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[15:33:41.108] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[15:33:41.108] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[15:33:44.537] INFO: ######################################################################
[15:33:44.537] INFO: PixTestAlive::doTest()
[15:33:44.537] INFO: ######################################################################
[15:33:44.540] INFO: ----------------------------------------------------------------------
[15:33:44.540] 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:33:44.540] INFO: ----------------------------------------------------------------------
[15:33:44.543] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:33:44.920] INFO: Expecting 41600 events.
[15:33:49.320] INFO: 41600 events read in total (3682ms).
[15:33:49.468] INFO: Test took 4925ms.
[15:33:49.482] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:33:49.482] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[15:33:49.482] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists PixelAlive_C0 .. PixelAlive_C15
[15:33:49.759] INFO: PixTestAlive::aliveTest() done
[15:33:49.759] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:33:49.759] DEBUG: <PixTestAlive.cc/aliveTest:L199> number of red-efficiency pixels: 32 28 31 48 54 77 49 53 57 58 62 43 51 41 36 29
[15:33:49.783] INFO: ----------------------------------------------------------------------
[15:33:49.783] 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:33:49.783] INFO: ----------------------------------------------------------------------
[15:33:49.785] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:33:50.163] INFO: Expecting 41600 events.
[15:33:53.285] INFO: 41600 events read in total (2406ms).
[15:33:53.286] INFO: Test took 3501ms.
[15:33:53.286] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:33:53.286] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 0
[15:33:53.286] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists MaskTest_C0 .. MaskTest_C15
[15:33:53.286] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:33:53.708] INFO: PixTestAlive::maskTest() done
[15:33:53.708] 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:33:53.730] INFO: ----------------------------------------------------------------------
[15:33:53.730] 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:33:53.730] INFO: ----------------------------------------------------------------------
[15:33:53.732] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:33:54.109] INFO: Expecting 41600 events.
[15:33:58.489] INFO: 41600 events read in total (3665ms).
[15:33:58.491] INFO: Test took 4759ms.
[15:33:58.502] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:33:58.502] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[15:33:58.502] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists AddressDecodingTest_C0 .. AddressDecodingTest_C15
[15:33:58.872] INFO: PixTestAlive::addressDecodingTest() done
[15:33:58.873] 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:33:58.873] INFO: PixTestAlive::doTest() done, duration: 14 seconds
[15:34:09.445] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[15:34:09.445] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = PixelAlive_C3_V0 -> PixelAlive_mod
[15:34:11.461] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): caldelscan
[15:34:11.461] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: caldelscan
[15:34:11.462] INFO: ----------------------------------------------------------------------
[15:34:11.462] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[15:34:11.462] INFO: ----------------------------------------------------------------------
[15:34:11.601] INFO: Expecting 768 events.
[15:34:12.735] INFO: 768 events read in total (419ms).
[15:34:12.735] INFO: Test took 1268ms.
[15:34:12.741] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:34:13.538] INFO: Expecting 41600 events.
[15:34:17.072] INFO: 41600 events read in total (3007ms).
[15:34:17.077] INFO: Test took 4336ms.
[15:34:17.194] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:34:17.194] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 660458
[15:34:17.194] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step0_C0 .. HR_xeff_CalDelScan_step0_C15
[15:34:17.194] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:34:17.245] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:34:17.912] INFO: Expecting 41600 events.
[15:34:21.583] INFO: 41600 events read in total (3145ms).
[15:34:21.588] INFO: Test took 4343ms.
[15:34:21.702] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:34:21.702] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 671210
[15:34:21.703] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step1_C0 .. HR_xeff_CalDelScan_step1_C15
[15:34:21.703] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:34:21.757] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:34:22.423] INFO: Expecting 41600 events.
[15:34:26.181] INFO: 41600 events read in total (3195ms).
[15:34:26.186] INFO: Test took 4429ms.
[15:34:26.301] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:34:26.301] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 674459
[15:34:26.301] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step2_C0 .. HR_xeff_CalDelScan_step2_C15
[15:34:26.301] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:34:26.354] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:34:27.021] INFO: Expecting 41600 events.
[15:34:30.760] INFO: 41600 events read in total (3212ms).
[15:34:30.765] INFO: Test took 4410ms.
[15:34:30.878] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:34:30.878] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 674490
[15:34:30.878] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step3_C0 .. HR_xeff_CalDelScan_step3_C15
[15:34:30.879] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:34:30.932] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:34:31.599] INFO: Expecting 41600 events.
[15:34:35.334] INFO: 41600 events read in total (3208ms).
[15:34:35.338] INFO: Test took 4406ms.
[15:34:35.454] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:34:35.454] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 675635
[15:34:35.454] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step4_C0 .. HR_xeff_CalDelScan_step4_C15
[15:34:35.454] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:34:35.508] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:34:36.174] INFO: Expecting 41600 events.
[15:34:39.922] INFO: 41600 events read in total (3221ms).
[15:34:39.927] INFO: Test took 4419ms.
[15:34:40.040] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:34:40.040] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 675905
[15:34:40.040] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step5_C0 .. HR_xeff_CalDelScan_step5_C15
[15:34:40.040] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:34:40.093] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:34:40.758] INFO: Expecting 41600 events.
[15:34:44.512] INFO: 41600 events read in total (3227ms).
[15:34:44.517] INFO: Test took 4424ms.
[15:34:44.630] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:34:44.630] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 674919
[15:34:44.630] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step6_C0 .. HR_xeff_CalDelScan_step6_C15
[15:34:44.630] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:34:44.684] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:34:45.351] INFO: Expecting 41600 events.
[15:34:49.114] INFO: 41600 events read in total (3237ms).
[15:34:49.119] INFO: Test took 4435ms.
[15:34:49.234] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:34:49.234] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 676948
[15:34:49.234] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step7_C0 .. HR_xeff_CalDelScan_step7_C15
[15:34:49.234] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:34:49.289] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:34:49.955] INFO: Expecting 41600 events.
[15:34:53.716] INFO: 41600 events read in total (3235ms).
[15:34:53.721] INFO: Test took 4432ms.
[15:34:53.834] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:34:53.834] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 674621
[15:34:53.834] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step8_C0 .. HR_xeff_CalDelScan_step8_C15
[15:34:53.834] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:34:53.886] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:34:54.551] INFO: Expecting 41600 events.
[15:34:58.306] INFO: 41600 events read in total (3228ms).
[15:34:58.311] INFO: Test took 4424ms.
[15:34:58.423] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:34:58.423] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 674948
[15:34:58.423] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step9_C0 .. HR_xeff_CalDelScan_step9_C15
[15:34:58.423] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:34:58.476] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:34:59.141] INFO: Expecting 41600 events.
[15:35:02.944] INFO: 41600 events read in total (3277ms).
[15:35:02.949] INFO: Test took 4473ms.
[15:35:03.063] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:35:03.063] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 675653
[15:35:03.063] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step10_C0 .. HR_xeff_CalDelScan_step10_C15
[15:35:03.063] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:35:03.116] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:35:03.781] INFO: Expecting 41600 events.
[15:35:07.549] INFO: 41600 events read in total (3242ms).
[15:35:07.554] INFO: Test took 4438ms.
[15:35:07.667] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:35:07.667] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 675739
[15:35:07.667] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step11_C0 .. HR_xeff_CalDelScan_step11_C15
[15:35:07.668] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:35:07.720] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:35:08.386] INFO: Expecting 41600 events.
[15:35:12.146] INFO: 41600 events read in total (3234ms).
[15:35:12.150] INFO: Test took 4430ms.
[15:35:12.264] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:35:12.264] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 675759
[15:35:12.264] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step12_C0 .. HR_xeff_CalDelScan_step12_C15
[15:35:12.264] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:35:12.317] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:35:12.982] INFO: Expecting 41600 events.
[15:35:16.735] INFO: 41600 events read in total (3226ms).
[15:35:16.739] INFO: Test took 4422ms.
[15:35:16.853] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:35:16.853] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 675425
[15:35:16.853] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step13_C0 .. HR_xeff_CalDelScan_step13_C15
[15:35:16.854] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:35:16.906] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:35:17.572] INFO: Expecting 41600 events.
[15:35:21.324] INFO: 41600 events read in total (3226ms).
[15:35:21.329] INFO: Test took 4422ms.
[15:35:21.443] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:35:21.443] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 675389
[15:35:21.443] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step14_C0 .. HR_xeff_CalDelScan_step14_C15
[15:35:21.443] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:35:21.497] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:35:22.162] INFO: Expecting 41600 events.
[15:35:25.935] INFO: 41600 events read in total (3246ms).
[15:35:25.939] INFO: Test took 4442ms.
[15:35:26.053] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:35:26.053] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 675831
[15:35:26.053] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step15_C0 .. HR_xeff_CalDelScan_step15_C15
[15:35:26.053] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:35:26.107] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:35:26.772] INFO: Expecting 41600 events.
[15:35:30.527] INFO: 41600 events read in total (3229ms).
[15:35:30.532] INFO: Test took 4425ms.
[15:35:30.644] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:35:30.644] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 675223
[15:35:30.644] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step16_C0 .. HR_xeff_CalDelScan_step16_C15
[15:35:30.645] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:35:30.697] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:35:31.362] INFO: Expecting 41600 events.
[15:35:35.136] INFO: 41600 events read in total (3247ms).
[15:35:35.141] INFO: Test took 4443ms.
[15:35:35.257] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:35:35.257] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 676348
[15:35:35.257] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step17_C0 .. HR_xeff_CalDelScan_step17_C15
[15:35:35.257] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:35:35.311] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:35:35.976] INFO: Expecting 41600 events.
[15:35:39.716] INFO: 41600 events read in total (3214ms).
[15:35:39.721] INFO: Test took 4410ms.
[15:35:39.836] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:35:39.836] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 676423
[15:35:39.836] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step18_C0 .. HR_xeff_CalDelScan_step18_C15
[15:35:39.836] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:35:39.889] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:35:40.554] INFO: Expecting 41600 events.
[15:35:44.136] INFO: 41600 events read in total (3055ms).
[15:35:44.140] INFO: Test took 4251ms.
[15:35:44.252] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:35:44.252] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 669222
[15:35:44.252] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step19_C0 .. HR_xeff_CalDelScan_step19_C15
[15:35:44.253] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:35:44.527] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 0: caldel = 175 eff = 0.999375
[15:35:44.527] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 1: caldel = 161 eff = 0.999543
[15:35:44.527] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 2: caldel = 167 eff = 0.998702
[15:35:44.528] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 3: caldel = 182 eff = 0.997764
[15:35:44.528] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 4: caldel = 149 eff = 0.997572
[15:35:44.528] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 5: caldel = 159 eff = 0.997837
[15:35:44.528] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 6: caldel = 159 eff = 0.997933
[15:35:44.528] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 7: caldel = 174 eff = 0.998125
[15:35:44.528] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 8: caldel = 154 eff = 0.997933
[15:35:44.528] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 9: caldel = 158 eff = 0.997885
[15:35:44.529] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 10: caldel = 149 eff = 0.997572
[15:35:44.529] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 11: caldel = 179 eff = 0.998101
[15:35:44.529] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 12: caldel = 141 eff = 0.997885
[15:35:44.529] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 13: caldel = 150 eff = 0.998894
[15:35:44.529] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 14: caldel = 155 eff = 0.999495
[15:35:44.529] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 15: caldel = 147 eff = 0.999375
[15:35:59.397] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): xpixelalive
[15:35:59.397] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: xpixelalive
[15:35:59.398] INFO: ----------------------------------------------------------------------
[15:35:59.398] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[15:35:59.398] INFO: ----------------------------------------------------------------------
[15:35:59.398] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: clk: 4
[15:35:59.398] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: ctr: 4
[15:35:59.398] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: sda: 19
[15:35:59.398] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: tin: 9
[15:35:59.398] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: level: 15
[15:35:59.398] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: triggerdelay: 0
[15:35:59.398] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: clk: 4
[15:35:59.398] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: ctr: 4
[15:35:59.398] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: sda: 19
[15:35:59.398] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: tin: 9
[15:35:59.398] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: level: 15
[15:35:59.398] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: triggerdelay: 20
[15:35:59.415] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:36:00.087] INFO: Expecting 208000 events.
[15:36:15.007] INFO: 208000 events read in total (14393ms).
[15:36:15.023] INFO: Test took 15608ms.
[15:36:15.624] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:36:15.624] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 3079908
[15:36:15.624] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists highRate_C0 .. highRate_C15
[15:36:15.624] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:36:16.060] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:36:16.060] INFO: number of red-efficiency pixels: 127 113 229 397 477 385 445 403 475 470 486 408 390 291 146 125
[15:36:16.060] INFO: number of X-ray hits detected: 112806 86735 147650 228238 237514 233504 233452 223144 233952 241153 245346 222708 226004 152502 88902 99738
[15:36:16.060] 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:36:16.061] INFO: number of Vcal hits detected: 207867 207886 207732 207565 207448 207586 207526 207580 207483 207449 207467 207554 207585 207675 207851 207873
[15:36:16.061] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.8 99.7 99.8 99.8 99.8 99.9 99.9 99.9
[15:36:16.061] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.8 99.7 99.8 99.8 99.8 99.8 99.7 99.7 99.8 99.8 99.8 99.9 99.9
[15:36:16.061] INFO: X-ray hit rate [MHz/cm2]: 33.1 25.4 43.3 66.9 69.6 68.4 68.4 65.4 68.6 70.7 71.9 65.3 66.2 44.7 26.1 29.2
[15:36:16.061] INFO: PixTestHighRate::doXPixelAlive() done
[15:36:16.106] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: clk: 4
[15:36:16.106] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: ctr: 4
[15:36:16.106] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: sda: 19
[15:36:16.106] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: tin: 9
[15:36:16.106] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: level: 15
[15:36:16.106] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: triggerdelay: 0
[15:36:16.106] INFO: PixTest:: pg_setup set to default.
[15:36:45.933] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[15:36:45.934] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = highRate_xraymap_C10_V0 -> highRate_xraymap_mod
[15:36:47.709] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[15:36:47.710] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 383.5mA
[15:36:47.711] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 475.9mA
[15:36:47.711] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.2 C
[15:36:47.711] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[15:36:47.711] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[15:36:47.711] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[15:36:47.711] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[15:36:47.711] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[15:36:47.711] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[15:36:47.711] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[15:36:47.711] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[15:36:47.712] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[15:36:47.712] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[15:36:47.803] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[15:36:47.803] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[15:36:47.817] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[15:36:47.817] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[15:36:47.817] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[15:36:47.817] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[15:36:47.817] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[15:36:47.817] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[15:36:47.820] QUIET: Connection to board 58 closed.
[15:36:47.899] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrEff_120.log
[15:30:33.370] INFO: *** Welcome to pxar ***
[15:30:33.370] INFO: *** Today: 2016/06/30
[15:30:33.395] INFO: *** Version: v1.9.0-814-g7497
[15:30:33.395] INFO: readRocDacs: data/mp501/dacParameters35_C0.dat .. data/mp501/dacParameters35_C15.dat
[15:30:33.396] INFO: readTbmDacs: data/mp501/tbmParameters_C0a.dat .. data/mp501/tbmParameters_C0b.dat
[15:30:33.396] INFO: readMaskFile: data/mp501/defaultMaskFile.dat
[15:30:33.396] INFO: readTrimFile: data/mp501/trimParameters35_C0.dat .. data/mp501/trimParameters35_C15.dat
[15:30:33.547] INFO: clk: 4
[15:30:33.547] INFO: ctr: 4
[15:30:33.547] INFO: sda: 19
[15:30:33.547] INFO: tin: 9
[15:30:33.547] INFO: level: 15
[15:30:33.547] INFO: triggerdelay: 0
[15:30:33.547] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[15:30:33.547] INFO: Log level: DEBUG
[15:30:33.558] QUIET: Connection to board DTB_WRPRHI opened.
[15:30:33.561] 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:30:33.564] INFO: RPC call hashes of host and DTB match: 398089610
[15:30:35.167] INFO: DUT info:
[15:30:35.167] INFO: The DUT currently contains the following objects:
[15:30:35.167] INFO: 2 TBM Cores tbm08c (2 ON)
[15:30:35.167] INFO: TBM Core alpha (0): 7 registers set
[15:30:35.167] INFO: TBM Core beta (1): 7 registers set
[15:30:35.167] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:30:35.167] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:30:35.167] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:30:35.167] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:30:35.167] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:30:35.167] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:30:35.167] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:30:35.167] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:30:35.167] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:30:35.167] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:30:35.167] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:30:35.167] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:30:35.167] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:30:35.167] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:30:35.167] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:30:35.167] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:30:35.167] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[15:30:35.168] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[15:30:35.169] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[15:30:35.170] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[15:30:35.171] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[15:30:35.171] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[15:30:35.171] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[15:30:35.171] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[15:30:35.171] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[15:30:35.171] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[15:30:35.171] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[15:30:35.173] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 35233792
[15:30:35.173] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x27fb0d0
[15:30:35.173] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x259d360
[15:30:35.173] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f3a2dd94010
[15:30:35.173] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f3a33fff510
[15:30:35.173] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 35241984 fPxarMemory = 0x7f3a2dd94010
[15:30:35.174] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 380.2mA
[15:30:35.175] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 475.1mA
[15:30:35.175] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.1 C
[15:30:35.673] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x2be5cf0
[15:30:35.741] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[15:30:35.742] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[15:30:35.742] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[15:30:35.748] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[15:30:35.748] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[15:30:35.748] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[15:30:35.758] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[15:30:35.758] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[15:30:35.773] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[15:30:35.773] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[15:30:35.786] INFO: PixTestCmd::init()
[15:30:35.797] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[15:30:35.797] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[15:30:35.797] INFO: readGainPedestalParameters data/mp501/phCalibrationFitErr35_C0.dat .. data/mp501/phCalibrationFitErr35_C15.dat
[15:30:36.041] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[15:30:36.041] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[15:30:36.056] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[15:30:36.063] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[15:30:36.063] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[15:30:36.063] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[15:30:36.093] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[15:30:36.093] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[15:30:36.093] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[15:30:36.093] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[15:30:36.093] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[15:30:36.099] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[15:30:36.099] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[15:30:36.122] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[15:30:36.122] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[15:30:36.122] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[15:30:36.122] INFO: readReadbackCal: data/mp501/readbackCal_C0.dat .. data/mp501/readbackCal_C15.dat
[15:30:36.132] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[15:30:36.145] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[15:30:36.145] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[15:30:36.145] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[15:30:36.145] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[15:30:36.159] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[15:30:36.159] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[15:30:39.529] INFO: ######################################################################
[15:30:39.529] INFO: PixTestAlive::doTest()
[15:30:39.529] INFO: ######################################################################
[15:30:39.532] INFO: ----------------------------------------------------------------------
[15:30:39.532] 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:30:39.532] INFO: ----------------------------------------------------------------------
[15:30:39.535] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:30:39.915] INFO: Expecting 41600 events.
[15:30:44.333] INFO: 41600 events read in total (3700ms).
[15:30:44.479] INFO: Test took 4944ms.
[15:30:44.489] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:30:44.489] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[15:30:44.489] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists PixelAlive_C0 .. PixelAlive_C15
[15:30:44.765] INFO: PixTestAlive::aliveTest() done
[15:30:44.765] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:30:44.765] DEBUG: <PixTestAlive.cc/aliveTest:L199> number of red-efficiency pixels: 37 32 53 67 79 76 69 76 66 81 90 75 75 46 25 42
[15:30:44.791] INFO: ----------------------------------------------------------------------
[15:30:44.791] 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:30:44.791] INFO: ----------------------------------------------------------------------
[15:30:44.794] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:30:45.172] INFO: Expecting 41600 events.
[15:30:48.307] INFO: 41600 events read in total (2420ms).
[15:30:48.307] INFO: Test took 3513ms.
[15:30:48.308] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:30:48.308] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 0
[15:30:48.308] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists MaskTest_C0 .. MaskTest_C15
[15:30:48.308] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:30:48.730] INFO: PixTestAlive::maskTest() done
[15:30:48.730] 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:30:48.752] INFO: ----------------------------------------------------------------------
[15:30:48.752] 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:30:48.752] INFO: ----------------------------------------------------------------------
[15:30:48.754] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:30:49.133] INFO: Expecting 41600 events.
[15:30:53.546] INFO: 41600 events read in total (3698ms).
[15:30:53.547] INFO: Test took 4793ms.
[15:30:53.559] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:30:53.559] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[15:30:53.559] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists AddressDecodingTest_C0 .. AddressDecodingTest_C15
[15:30:53.928] INFO: PixTestAlive::addressDecodingTest() done
[15:30:53.928] 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:30:53.928] INFO: PixTestAlive::doTest() done, duration: 14 seconds
[15:31:12.221] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[15:31:12.221] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = PixelAlive_C3_V0 -> PixelAlive_mod
[15:31:14.381] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): caldelscan
[15:31:14.381] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: caldelscan
[15:31:14.381] INFO: ----------------------------------------------------------------------
[15:31:14.381] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[15:31:14.381] INFO: ----------------------------------------------------------------------
[15:31:14.521] INFO: Expecting 768 events.
[15:31:15.655] INFO: 768 events read in total (419ms).
[15:31:15.655] INFO: Test took 1268ms.
[15:31:15.661] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:31:16.458] INFO: Expecting 41600 events.
[15:31:20.315] INFO: 41600 events read in total (3330ms).
[15:31:20.321] INFO: Test took 4660ms.
[15:31:20.479] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:31:20.479] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 914330
[15:31:20.479] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step0_C0 .. HR_xeff_CalDelScan_step0_C15
[15:31:20.479] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:31:20.545] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:31:21.210] INFO: Expecting 41600 events.
[15:31:25.233] INFO: 41600 events read in total (3497ms).
[15:31:25.238] INFO: Test took 4693ms.
[15:31:25.389] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:31:25.389] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 926610
[15:31:25.390] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step1_C0 .. HR_xeff_CalDelScan_step1_C15
[15:31:25.390] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:31:25.460] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:31:26.127] INFO: Expecting 41600 events.
[15:31:30.212] INFO: 41600 events read in total (3558ms).
[15:31:30.218] INFO: Test took 4758ms.
[15:31:30.369] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:31:30.369] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 932101
[15:31:30.369] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step2_C0 .. HR_xeff_CalDelScan_step2_C15
[15:31:30.369] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:31:30.439] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:31:31.150] INFO: Expecting 41600 events.
[15:31:35.238] INFO: 41600 events read in total (3562ms).
[15:31:35.244] INFO: Test took 4761ms.
[15:31:35.396] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:31:35.396] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 932900
[15:31:35.396] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step3_C0 .. HR_xeff_CalDelScan_step3_C15
[15:31:35.396] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:31:35.466] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:31:36.131] INFO: Expecting 41600 events.
[15:31:40.219] INFO: 41600 events read in total (3562ms).
[15:31:40.225] INFO: Test took 4759ms.
[15:31:40.376] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:31:40.376] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 930294
[15:31:40.376] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step4_C0 .. HR_xeff_CalDelScan_step4_C15
[15:31:40.377] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:31:40.446] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:31:41.111] INFO: Expecting 41600 events.
[15:31:45.207] INFO: 41600 events read in total (3569ms).
[15:31:45.213] INFO: Test took 4767ms.
[15:31:45.365] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:31:45.365] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 930654
[15:31:45.365] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step5_C0 .. HR_xeff_CalDelScan_step5_C15
[15:31:45.365] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:31:45.436] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:31:46.104] INFO: Expecting 41600 events.
[15:31:50.203] INFO: 41600 events read in total (3572ms).
[15:31:50.208] INFO: Test took 4772ms.
[15:31:50.360] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:31:50.360] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 932044
[15:31:50.360] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step6_C0 .. HR_xeff_CalDelScan_step6_C15
[15:31:50.361] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:31:50.430] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:31:51.096] INFO: Expecting 41600 events.
[15:31:55.220] INFO: 41600 events read in total (3598ms).
[15:31:55.226] INFO: Test took 4796ms.
[15:31:55.377] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:31:55.377] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 932038
[15:31:55.377] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step7_C0 .. HR_xeff_CalDelScan_step7_C15
[15:31:55.378] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:31:55.448] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:31:56.113] INFO: Expecting 41600 events.
[15:32:00.224] INFO: 41600 events read in total (3584ms).
[15:32:00.230] INFO: Test took 4782ms.
[15:32:00.382] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:32:00.382] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 931353
[15:32:00.382] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step8_C0 .. HR_xeff_CalDelScan_step8_C15
[15:32:00.383] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:32:00.452] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:32:01.117] INFO: Expecting 41600 events.
[15:32:05.230] INFO: 41600 events read in total (3586ms).
[15:32:05.236] INFO: Test took 4784ms.
[15:32:05.388] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:32:05.389] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 929996
[15:32:05.389] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step9_C0 .. HR_xeff_CalDelScan_step9_C15
[15:32:05.389] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:32:05.461] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:32:06.128] INFO: Expecting 41600 events.
[15:32:10.254] INFO: 41600 events read in total (3599ms).
[15:32:10.259] INFO: Test took 4798ms.
[15:32:10.410] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:32:10.411] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 933232
[15:32:10.411] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step10_C0 .. HR_xeff_CalDelScan_step10_C15
[15:32:10.411] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:32:10.484] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:32:11.150] INFO: Expecting 41600 events.
[15:32:15.273] INFO: 41600 events read in total (3596ms).
[15:32:15.279] INFO: Test took 4795ms.
[15:32:15.432] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:32:15.432] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 933403
[15:32:15.432] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step11_C0 .. HR_xeff_CalDelScan_step11_C15
[15:32:15.433] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:32:15.505] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:32:16.171] INFO: Expecting 41600 events.
[15:32:20.287] INFO: 41600 events read in total (3589ms).
[15:32:20.292] INFO: Test took 4787ms.
[15:32:20.449] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:32:20.449] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 930025
[15:32:20.449] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step12_C0 .. HR_xeff_CalDelScan_step12_C15
[15:32:20.449] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:32:20.518] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:32:21.185] INFO: Expecting 41600 events.
[15:32:25.299] INFO: 41600 events read in total (3588ms).
[15:32:25.304] INFO: Test took 4786ms.
[15:32:25.460] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:32:25.460] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 931590
[15:32:25.460] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step13_C0 .. HR_xeff_CalDelScan_step13_C15
[15:32:25.460] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:32:25.528] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:32:26.193] INFO: Expecting 41600 events.
[15:32:30.303] INFO: 41600 events read in total (3583ms).
[15:32:30.309] INFO: Test took 4781ms.
[15:32:30.465] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:32:30.465] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 932487
[15:32:30.466] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step14_C0 .. HR_xeff_CalDelScan_step14_C15
[15:32:30.466] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:32:30.535] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:32:31.202] INFO: Expecting 41600 events.
[15:32:35.309] INFO: 41600 events read in total (3580ms).
[15:32:35.314] INFO: Test took 4779ms.
[15:32:35.537] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:32:35.537] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 930723
[15:32:35.538] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step15_C0 .. HR_xeff_CalDelScan_step15_C15
[15:32:35.538] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:32:35.606] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:32:36.271] INFO: Expecting 41600 events.
[15:32:40.394] INFO: 41600 events read in total (3596ms).
[15:32:40.400] INFO: Test took 4794ms.
[15:32:40.551] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:32:40.551] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 932371
[15:32:40.551] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step16_C0 .. HR_xeff_CalDelScan_step16_C15
[15:32:40.552] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:32:40.623] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:32:41.288] INFO: Expecting 41600 events.
[15:32:45.387] INFO: 41600 events read in total (3572ms).
[15:32:45.392] INFO: Test took 4769ms.
[15:32:45.545] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:32:45.545] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 931248
[15:32:45.545] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step17_C0 .. HR_xeff_CalDelScan_step17_C15
[15:32:45.545] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:32:45.614] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:32:46.279] INFO: Expecting 41600 events.
[15:32:50.385] INFO: 41600 events read in total (3579ms).
[15:32:50.391] INFO: Test took 4777ms.
[15:32:50.545] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:32:50.545] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 929023
[15:32:50.545] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step18_C0 .. HR_xeff_CalDelScan_step18_C15
[15:32:50.545] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:32:50.614] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:32:51.279] INFO: Expecting 41600 events.
[15:32:55.240] INFO: 41600 events read in total (3434ms).
[15:32:55.246] INFO: Test took 4632ms.
[15:32:55.398] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:32:55.398] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 925774
[15:32:55.398] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step19_C0 .. HR_xeff_CalDelScan_step19_C15
[15:32:55.398] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:32:55.689] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 0: caldel = 175 eff = 0.998942
[15:32:55.689] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 1: caldel = 143 eff = 0.999014
[15:32:55.689] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 2: caldel = 164 eff = 0.99726
[15:32:55.689] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 3: caldel = 181 eff = 0.995361
[15:32:55.690] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 4: caldel = 146 eff = 0.99476
[15:32:55.690] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 5: caldel = 160 eff = 0.995361
[15:32:55.690] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 6: caldel = 159 eff = 0.995385
[15:32:55.690] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 7: caldel = 175 eff = 0.995793
[15:32:55.690] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 8: caldel = 158 eff = 0.995481
[15:32:55.690] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 9: caldel = 157 eff = 0.994543
[15:32:55.690] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 10: caldel = 148 eff = 0.994303
[15:32:55.691] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 11: caldel = 176 eff = 0.995962
[15:32:55.691] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 12: caldel = 142 eff = 0.995288
[15:32:55.691] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 13: caldel = 165 eff = 0.99726
[15:32:55.691] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 14: caldel = 164 eff = 0.999038
[15:32:55.691] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 15: caldel = 147 eff = 0.999231
[15:33:01.933] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): xpixelalive
[15:33:01.933] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: xpixelalive
[15:33:01.934] INFO: ----------------------------------------------------------------------
[15:33:01.934] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[15:33:01.934] INFO: ----------------------------------------------------------------------
[15:33:01.934] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: clk: 4
[15:33:01.934] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: ctr: 4
[15:33:01.934] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: sda: 19
[15:33:01.934] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: tin: 9
[15:33:01.934] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: level: 15
[15:33:01.934] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: triggerdelay: 0
[15:33:01.934] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: clk: 4
[15:33:01.934] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: ctr: 4
[15:33:01.934] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: sda: 19
[15:33:01.934] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: tin: 9
[15:33:01.934] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: level: 15
[15:33:01.934] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: triggerdelay: 20
[15:33:01.953] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[15:33:02.623] INFO: Expecting 208000 events.
[15:33:20.110] INFO: 208000 events read in total (16960ms).
[15:33:20.132] INFO: Test took 18179ms.
[15:33:20.999] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:33:20.999] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 4342930
[15:33:20.999] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists highRate_C0 .. highRate_C15
[15:33:20.999] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[15:33:21.514] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:33:21.514] INFO: number of red-efficiency pixels: 234 227 485 835 884 832 863 805 826 908 1044 827 780 442 182 201
[15:33:21.514] INFO: number of X-ray hits detected: 160731 123309 211044 323129 336234 332313 331436 316742 331174 341592 347391 315730 320635 216426 127494 140990
[15:33:21.514] 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:33:21.514] INFO: number of Vcal hits detected: 207756 207766 207407 207038 206984 207023 206971 207044 207071 206908 206708 207014 207067 207502 207782 207791
[15:33:21.514] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.7 99.6 99.6 99.6 99.6 99.6 99.6 99.5 99.4 99.6 99.6 99.8 99.9 99.9
[15:33:21.514] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.7 99.5 99.5 99.5 99.5 99.5 99.6 99.5 99.4 99.5 99.6 99.8 99.9 99.9
[15:33:21.514] INFO: X-ray hit rate [MHz/cm2]: 47.1 36.1 61.9 94.7 98.6 97.4 97.1 92.8 97.1 100.1 101.8 92.5 94.0 63.4 37.4 41.3
[15:33:21.514] INFO: PixTestHighRate::doXPixelAlive() done
[15:33:21.560] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: clk: 4
[15:33:21.560] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: ctr: 4
[15:33:21.560] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: sda: 19
[15:33:21.560] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: tin: 9
[15:33:21.560] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: level: 15
[15:33:21.560] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: triggerdelay: 0
[15:33:21.560] INFO: PixTest:: pg_setup set to default.
[15:33:31.422] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[15:33:31.422] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = highRate_xraymap_C10_V0 -> highRate_xraymap_mod
[15:33:33.326] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[15:33:33.326] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 383.5mA
[15:33:33.327] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 475.9mA
[15:33:33.327] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.2 C
[15:33:33.327] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[15:33:33.327] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[15:33:33.327] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[15:33:33.327] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[15:33:33.327] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[15:33:33.328] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[15:33:33.328] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[15:33:33.328] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[15:33:33.328] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[15:33:33.328] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[15:33:33.422] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[15:33:33.422] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[15:33:33.436] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[15:33:33.436] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[15:33:33.436] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[15:33:33.436] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[15:33:33.436] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[15:33:33.436] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[15:33:33.439] QUIET: Connection to board 58 closed.
[15:33:33.518] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
MoReWeb-v0.5.1-895-gd4c3d74 on branch master