Test Date: 1973-11-29 16:33
Analysis date: 2016-06-28 14:32
Logfile
hrData_40.log
[13:59:19.245] INFO: *** Welcome to pxar ***
[13:59:19.246] INFO: *** Today: 2016/06/27
[13:59:19.270] INFO: *** Version: v1.9.0-814-g7497
[13:59:19.270] INFO: readRocDacs: data/myong/dacParameters35_C0.dat .. data/myong/dacParameters35_C15.dat
[13:59:19.271] INFO: readTbmDacs: data/myong/tbmParameters_C0a.dat .. data/myong/tbmParameters_C0b.dat
[13:59:19.271] INFO: readMaskFile: data/myong/defaultMaskFile.dat
[13:59:19.271] INFO: readTrimFile: data/myong/trimParameters35_C0.dat .. data/myong/trimParameters35_C15.dat
[13:59:19.421] INFO: clk: 4
[13:59:19.421] INFO: ctr: 4
[13:59:19.421] INFO: sda: 19
[13:59:19.421] INFO: tin: 9
[13:59:19.421] INFO: level: 15
[13:59:19.421] INFO: triggerdelay: 0
[13:59:19.421] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[13:59:19.421] INFO: Log level: DEBUG
[13:59:19.432] QUIET: Connection to board DTB_WRMNMR opened.
[13:59:19.436] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 43
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WRMNMR
MAC address: 40D85511802B
Hostname: pixelDTB043
Comment: sent to Frank Meier (UNL)
------------------------------------------------------
[13:59:19.438] INFO: RPC call hashes of host and DTB match: 398089610
[13:59:21.039] INFO: DUT info:
[13:59:21.039] INFO: The DUT currently contains the following objects:
[13:59:21.039] INFO: 2 TBM Cores tbm08c (2 ON)
[13:59:21.040] INFO: TBM Core alpha (0): 7 registers set
[13:59:21.040] INFO: TBM Core beta (1): 7 registers set
[13:59:21.040] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:59:21.040] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:21.040] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:21.040] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:21.040] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:21.040] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:21.040] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:21.040] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:21.040] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:21.040] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:21.040] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:21.040] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:21.040] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:21.040] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:21.040] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:21.040] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:21.040] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:21.040] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[13:59:21.040] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[13:59:21.040] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[13:59:21.041] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[13:59:21.042] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[13:59:21.043] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[13:59:21.045] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 30363648
[13:59:21.045] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x212e0d0
[13:59:21.045] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x1ed0360
[13:59:21.045] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f5a59d94010
[13:59:21.045] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f5a5ffff510
[13:59:21.045] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 30371840 fPxarMemory = 0x7f5a59d94010
[13:59:21.047] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 390.7mA
[13:59:21.048] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 469.5mA
[13:59:21.048] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.2 C
[13:59:21.543] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x2518db0
[13:59:21.609] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[13:59:21.610] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[13:59:21.610] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[13:59:21.615] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[13:59:21.615] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[13:59:21.615] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[13:59:21.625] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[13:59:21.626] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[13:59:21.635] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[13:59:21.635] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[13:59:21.656] INFO: PixTestCmd::init()
[13:59:21.677] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[13:59:21.677] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[13:59:21.678] INFO: readGainPedestalParameters data/myong/phCalibrationFitErr35_C0.dat .. data/myong/phCalibrationFitErr35_C15.dat
[13:59:21.923] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[13:59:21.923] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[13:59:21.938] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[13:59:21.944] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[13:59:21.944] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[13:59:21.944] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[13:59:21.964] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[13:59:21.964] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[13:59:21.964] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[13:59:21.964] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[13:59:21.964] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[13:59:21.972] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[13:59:21.972] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[13:59:21.994] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[13:59:21.994] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[13:59:21.994] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[13:59:21.994] INFO: readReadbackCal: data/myong/readbackCal_C0.dat .. data/myong/readbackCal_C15.dat
[13:59:22.004] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[13:59:22.012] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[13:59:22.012] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[13:59:22.012] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[13:59:22.012] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[13:59:22.030] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[13:59:22.030] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[13:59:42.283] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 1 -> source to value 02ma
[13:59:44.011] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 2 -> runseconds to value 60
[13:59:45.840] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): phrun
[13:59:45.840] DEBUG: <PixTestXray.cc/runCommand:L109> running command: phrun
[13:59:45.841] INFO: ----------------------------------------------------------------------
[13:59:45.841] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[13:59:45.841] INFO: ----------------------------------------------------------------------
[13:59:46.815] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[13:59:58.952] INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[13:59:58.956] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:00:26.195] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1195842 events.
[14:00:32.658] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1195842, pixels seen in all events: 5902053
[14:00:32.838] INFO: Resuming triggers.
[14:00:44.975] INFO: run duration 24 seconds, buffer almost full (81%), pausing triggers.
[14:00:45.084] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:01:12.033] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1195717 events.
[14:01:18.589] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1195717, pixels seen in all events: 5902787
[14:01:18.766] INFO: Resuming triggers.
[14:01:30.898] INFO: run duration 36 seconds, buffer almost full (81%), pausing triggers.
[14:01:30.934] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:01:58.133] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1195219 events.
[14:02:04.614] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1195219, pixels seen in all events: 5908283
[14:02:04.868] INFO: Resuming triggers.
[14:02:17.003] INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[14:02:17.040] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:02:44.163] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1195495 events.
[14:02:50.687] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1195495, pixels seen in all events: 5905382
[14:02:50.861] INFO: Resuming triggers.
[14:03:02.391] INFO: data taking finished, elapsed time: 60 seconds.
[14:03:02.588] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:03:28.308] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1135938 events.
[14:03:34.530] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1135938, pixels seen in all events: 5607959
[14:03:34.697] INFO: PixTest:: pg_setup set to default.
[14:03:34.737] INFO: PixTestXray::doPhRun() done
[14:03:51.936] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[14:03:51.937] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 393.1mA
[14:03:51.938] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 470.3mA
[14:03:51.938] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.2 C
[14:03:51.938] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[14:03:51.938] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[14:03:51.938] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[14:03:51.938] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[14:03:51.938] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[14:03:51.938] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[14:03:51.938] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[14:03:51.938] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[14:03:51.939] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[14:03:51.939] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[14:03:51.939] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[14:03:51.939] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[14:03:51.939] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[14:03:51.939] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[14:03:51.939] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[14:03:51.939] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[14:03:51.939] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[14:03:51.939] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[14:03:52.216] QUIET: Connection to board 43 closed.
[14:03:52.296] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrData_120.log
[14:03:56.056] INFO: *** Welcome to pxar ***
[14:03:56.056] INFO: *** Today: 2016/06/27
[14:03:56.080] INFO: *** Version: v1.9.0-814-g7497
[14:03:56.080] INFO: readRocDacs: data/myong/dacParameters35_C0.dat .. data/myong/dacParameters35_C15.dat
[14:03:56.081] INFO: readTbmDacs: data/myong/tbmParameters_C0a.dat .. data/myong/tbmParameters_C0b.dat
[14:03:56.081] INFO: readMaskFile: data/myong/defaultMaskFile.dat
[14:03:56.081] INFO: readTrimFile: data/myong/trimParameters35_C0.dat .. data/myong/trimParameters35_C15.dat
[14:03:56.230] INFO: clk: 4
[14:03:56.230] INFO: ctr: 4
[14:03:56.230] INFO: sda: 19
[14:03:56.230] INFO: tin: 9
[14:03:56.230] INFO: level: 15
[14:03:56.230] INFO: triggerdelay: 0
[14:03:56.230] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[14:03:56.230] INFO: Log level: DEBUG
[14:03:56.241] QUIET: Connection to board DTB_WRMNMR opened.
[14:03:56.244] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 43
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WRMNMR
MAC address: 40D85511802B
Hostname: pixelDTB043
Comment: sent to Frank Meier (UNL)
------------------------------------------------------
[14:03:56.247] INFO: RPC call hashes of host and DTB match: 398089610
[14:03:57.849] INFO: DUT info:
[14:03:57.849] INFO: The DUT currently contains the following objects:
[14:03:57.849] INFO: 2 TBM Cores tbm08c (2 ON)
[14:03:57.849] INFO: TBM Core alpha (0): 7 registers set
[14:03:57.849] INFO: TBM Core beta (1): 7 registers set
[14:03:57.849] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:03:57.849] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:57.849] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:57.849] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:57.849] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:57.849] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:57.849] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:57.849] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:57.849] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:57.849] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:57.849] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:57.849] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:57.849] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:57.849] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:57.849] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:57.849] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:57.849] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[14:03:57.850] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[14:03:57.851] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[14:03:57.852] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[14:03:57.853] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[14:03:57.855] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 30355456
[14:03:57.855] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x11a50d0
[14:03:57.855] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0xf47360
[14:03:57.855] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7fd174992010
[14:03:57.855] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7fd17abfd510
[14:03:57.855] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 30363648 fPxarMemory = 0x7fd174992010
[14:03:57.856] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 390.7mA
[14:03:57.858] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 470.3mA
[14:03:57.858] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.4 C
[14:03:58.351] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x158fc30
[14:03:58.417] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[14:03:58.418] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[14:03:58.418] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[14:03:58.424] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[14:03:58.424] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[14:03:58.424] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[14:03:58.435] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[14:03:58.435] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[14:03:58.454] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[14:03:58.454] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[14:03:58.464] INFO: PixTestCmd::init()
[14:03:58.474] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[14:03:58.474] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[14:03:58.474] INFO: readGainPedestalParameters data/myong/phCalibrationFitErr35_C0.dat .. data/myong/phCalibrationFitErr35_C15.dat
[14:03:58.720] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[14:03:58.720] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[14:03:58.735] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[14:03:58.741] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[14:03:58.741] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[14:03:58.741] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[14:03:58.761] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[14:03:58.761] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[14:03:58.761] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[14:03:58.761] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[14:03:58.761] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[14:03:58.767] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[14:03:58.767] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[14:03:58.783] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[14:03:58.783] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[14:03:58.783] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[14:03:58.783] INFO: readReadbackCal: data/myong/readbackCal_C0.dat .. data/myong/readbackCal_C15.dat
[14:03:58.792] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[14:03:58.800] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[14:03:58.800] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[14:03:58.800] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[14:03:58.800] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[14:03:58.814] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[14:03:58.814] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[14:04:06.507] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 1 -> source to value 06ma
[14:04:08.555] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 1 -> source to value 06mA
[14:04:10.315] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 1 -> source to value 06ma
[14:04:12.475] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 2 -> runseconds to value 60
[14:04:13.960] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): phrun
[14:04:13.960] DEBUG: <PixTestXray.cc/runCommand:L109> running command: phrun
[14:04:13.960] INFO: ----------------------------------------------------------------------
[14:04:13.960] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[14:04:13.960] INFO: ----------------------------------------------------------------------
[14:04:14.935] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[14:04:21.918] INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[14:04:21.922] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:04:46.911] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 688042 events.
[14:04:59.947] DEBUG: <PixTestXray.cc/processData:L823> # events read: 688042, pixels seen in all events: 11997547
[14:05:00.147] INFO: Resuming triggers.
[14:05:07.135] INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[14:05:07.169] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:05:32.032] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 688408 events.
[14:05:45.078] DEBUG: <PixTestXray.cc/processData:L823> # events read: 688408, pixels seen in all events: 11991243
[14:05:45.249] INFO: Resuming triggers.
[14:05:52.237] INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[14:05:52.286] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:06:17.127] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 688396 events.
[14:06:30.160] DEBUG: <PixTestXray.cc/processData:L823> # events read: 688396, pixels seen in all events: 11991932
[14:06:30.351] INFO: Resuming triggers.
[14:06:37.342] INFO: run duration 27 seconds, buffer almost full (81%), pausing triggers.
[14:06:37.376] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:07:02.232] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 688717 events.
[14:07:15.265] DEBUG: <PixTestXray.cc/processData:L823> # events read: 688717, pixels seen in all events: 11986750
[14:07:15.455] INFO: Resuming triggers.
[14:07:22.444] INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[14:07:22.480] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:07:47.303] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 688482 events.
[14:08:00.315] DEBUG: <PixTestXray.cc/processData:L823> # events read: 688482, pixels seen in all events: 11989782
[14:08:00.502] INFO: Resuming triggers.
[14:08:07.496] INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[14:08:07.529] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:08:32.367] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 688975 events.
[14:08:45.407] DEBUG: <PixTestXray.cc/processData:L823> # events read: 688975, pixels seen in all events: 11984487
[14:08:45.582] INFO: Resuming triggers.
[14:08:52.576] INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[14:08:52.628] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:09:17.503] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 688950 events.
[14:09:30.578] DEBUG: <PixTestXray.cc/processData:L823> # events read: 688950, pixels seen in all events: 11984865
[14:09:30.767] INFO: Resuming triggers.
[14:09:37.760] INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[14:09:37.799] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:10:02.543] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 688950 events.
[14:10:15.537] DEBUG: <PixTestXray.cc/processData:L823> # events read: 688950, pixels seen in all events: 11984429
[14:10:15.726] INFO: Resuming triggers.
[14:10:19.882] INFO: data taking finished, elapsed time: 60 seconds.
[14:10:20.078] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[14:10:34.883] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 409461 events.
[14:10:42.603] DEBUG: <PixTestXray.cc/processData:L823> # events read: 409461, pixels seen in all events: 7117070
[14:10:42.698] INFO: PixTest:: pg_setup set to default.
[14:10:42.739] INFO: PixTestXray::doPhRun() done
[14:10:53.344] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[14:10:53.345] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 393.1mA
[14:10:53.346] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 471.1mA
[14:10:53.346] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.2 C
[14:10:53.346] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[14:10:53.346] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[14:10:53.346] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[14:10:53.346] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[14:10:53.346] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[14:10:53.346] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[14:10:53.347] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[14:10:53.347] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[14:10:53.347] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[14:10:53.347] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[14:10:53.347] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[14:10:53.347] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[14:10:53.347] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[14:10:53.347] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[14:10:53.347] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[14:10:53.347] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[14:10:53.347] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[14:10:53.347] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[14:10:53.665] QUIET: Connection to board 43 closed.
[14:10:53.744] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrEff_40.log
[13:54:22.851] INFO: *** Welcome to pxar ***
[13:54:22.851] INFO: *** Today: 2016/06/27
[13:54:22.876] INFO: *** Version: v1.9.0-814-g7497
[13:54:22.876] INFO: readRocDacs: data/myong/dacParameters35_C0.dat .. data/myong/dacParameters35_C15.dat
[13:54:22.877] INFO: readTbmDacs: data/myong/tbmParameters_C0a.dat .. data/myong/tbmParameters_C0b.dat
[13:54:22.877] INFO: readMaskFile: data/myong/defaultMaskFile.dat
[13:54:22.877] INFO: readTrimFile: data/myong/trimParameters35_C0.dat .. data/myong/trimParameters35_C15.dat
[13:54:23.027] INFO: clk: 4
[13:54:23.028] INFO: ctr: 4
[13:54:23.028] INFO: sda: 19
[13:54:23.028] INFO: tin: 9
[13:54:23.028] INFO: level: 15
[13:54:23.028] INFO: triggerdelay: 0
[13:54:23.028] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[13:54:23.028] INFO: Log level: DEBUG
[13:54:23.038] QUIET: Connection to board DTB_WRMNMR opened.
[13:54:23.042] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 43
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WRMNMR
MAC address: 40D85511802B
Hostname: pixelDTB043
Comment: sent to Frank Meier (UNL)
------------------------------------------------------
[13:54:23.044] INFO: RPC call hashes of host and DTB match: 398089610
[13:54:24.647] INFO: DUT info:
[13:54:24.647] INFO: The DUT currently contains the following objects:
[13:54:24.647] INFO: 2 TBM Cores tbm08c (2 ON)
[13:54:24.647] INFO: TBM Core alpha (0): 7 registers set
[13:54:24.647] INFO: TBM Core beta (1): 7 registers set
[13:54:24.647] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:54:24.647] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:24.647] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:24.647] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:24.647] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:24.647] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:24.647] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:24.647] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:24.647] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:24.647] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:24.647] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:24.647] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:24.647] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:24.647] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:24.647] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:24.647] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:24.647] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:54:24.648] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[13:54:24.649] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[13:54:24.650] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[13:54:24.651] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[13:54:24.651] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[13:54:24.651] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[13:54:24.651] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[13:54:24.651] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[13:54:24.651] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[13:54:24.651] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[13:54:24.651] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[13:54:24.651] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[13:54:24.651] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[13:54:24.651] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[13:54:24.651] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[13:54:24.651] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[13:54:24.651] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[13:54:24.651] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[13:54:24.651] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[13:54:24.651] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[13:54:24.651] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[13:54:24.653] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 30359552
[13:54:24.653] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x101f0d0
[13:54:24.653] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0xdc1360
[13:54:24.653] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f7939d94010
[13:54:24.653] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f793ffff510
[13:54:24.653] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 30367744 fPxarMemory = 0x7f7939d94010
[13:54:24.654] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 390.7mA
[13:54:24.655] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 469.5mA
[13:54:24.655] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.2 C
[13:54:25.153] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x1409d60
[13:54:25.218] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[13:54:25.218] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[13:54:25.218] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[13:54:25.224] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[13:54:25.224] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[13:54:25.224] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[13:54:25.234] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[13:54:25.234] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[13:54:25.245] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[13:54:25.245] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[13:54:25.270] INFO: PixTestCmd::init()
[13:54:25.287] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[13:54:25.287] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[13:54:25.287] INFO: readGainPedestalParameters data/myong/phCalibrationFitErr35_C0.dat .. data/myong/phCalibrationFitErr35_C15.dat
[13:54:25.531] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[13:54:25.531] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[13:54:25.545] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[13:54:25.551] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[13:54:25.551] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[13:54:25.551] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[13:54:25.571] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[13:54:25.571] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[13:54:25.571] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[13:54:25.571] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[13:54:25.571] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[13:54:25.577] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[13:54:25.577] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[13:54:25.594] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[13:54:25.594] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[13:54:25.594] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[13:54:25.594] INFO: readReadbackCal: data/myong/readbackCal_C0.dat .. data/myong/readbackCal_C15.dat
[13:54:25.604] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[13:54:25.611] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[13:54:25.611] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[13:54:25.611] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[13:54:25.611] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[13:54:25.628] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[13:54:25.628] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[13:54:28.539] INFO: ######################################################################
[13:54:28.539] INFO: PixTestAlive::doTest()
[13:54:28.539] INFO: ######################################################################
[13:54:28.543] INFO: ----------------------------------------------------------------------
[13:54:28.543] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:54:28.543] INFO: ----------------------------------------------------------------------
[13:54:28.545] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:54:28.925] INFO: Expecting 41600 events.
[13:54:33.121] INFO: 41600 events read in total (3478ms).
[13:54:33.268] INFO: Test took 4723ms.
[13:54:33.278] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:54:33.278] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[13:54:33.278] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists PixelAlive_C0 .. PixelAlive_C15
[13:54:33.550] INFO: PixTestAlive::aliveTest() done
[13:54:33.550] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:54:33.550] DEBUG: <PixTestAlive.cc/aliveTest:L199> number of red-efficiency pixels: 28 17 22 31 29 35 31 39 50 46 43 49 53 25 15 17
[13:54:33.573] INFO: ----------------------------------------------------------------------
[13:54:33.573] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:54:33.573] INFO: ----------------------------------------------------------------------
[13:54:33.575] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:54:33.954] INFO: Expecting 41600 events.
[13:54:36.870] INFO: 41600 events read in total (2201ms).
[13:54:36.871] INFO: Test took 3296ms.
[13:54:36.871] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:54:36.871] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 0
[13:54:36.871] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists MaskTest_C0 .. MaskTest_C15
[13:54:36.871] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:54:37.293] INFO: PixTestAlive::maskTest() done
[13:54:37.294] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:54:37.315] INFO: ----------------------------------------------------------------------
[13:54:37.315] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:54:37.315] INFO: ----------------------------------------------------------------------
[13:54:37.318] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:54:37.695] INFO: Expecting 41600 events.
[13:54:41.883] INFO: 41600 events read in total (3472ms).
[13:54:41.884] INFO: Test took 4566ms.
[13:54:41.896] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:54:41.896] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[13:54:41.896] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists AddressDecodingTest_C0 .. AddressDecodingTest_C15
[13:54:42.265] INFO: PixTestAlive::addressDecodingTest() done
[13:54:42.265] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:54:42.265] INFO: PixTestAlive::doTest() done, duration: 13 seconds
[13:54:44.440] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[13:54:44.440] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = PixelAlive_C3_V0 -> PixelAlive_mod
[13:54:46.608] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): caldelscan
[13:54:46.608] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: caldelscan
[13:54:46.608] INFO: ----------------------------------------------------------------------
[13:54:46.608] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[13:54:46.608] INFO: ----------------------------------------------------------------------
[13:54:46.748] INFO: Expecting 768 events.
[13:54:47.876] INFO: 768 events read in total (412ms).
[13:54:47.877] INFO: Test took 1263ms.
[13:54:47.883] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:54:48.680] INFO: Expecting 41600 events.
[13:54:51.896] INFO: 41600 events read in total (2690ms).
[13:54:51.902] INFO: Test took 4019ms.
[13:54:51.989] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:54:51.989] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 493429
[13:54:51.989] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step0_C0 .. HR_xeff_CalDelScan_step0_C15
[13:54:51.990] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:54:52.029] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:54:52.694] INFO: Expecting 41600 events.
[13:54:56.023] INFO: 41600 events read in total (2802ms).
[13:54:56.026] INFO: Test took 3997ms.
[13:54:56.110] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:54:56.110] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 501804
[13:54:56.110] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step1_C0 .. HR_xeff_CalDelScan_step1_C15
[13:54:56.110] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:54:56.151] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:54:56.817] INFO: Expecting 41600 events.
[13:55:00.175] INFO: 41600 events read in total (2832ms).
[13:55:00.178] INFO: Test took 4027ms.
[13:55:00.261] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:55:00.261] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 502878
[13:55:00.261] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step2_C0 .. HR_xeff_CalDelScan_step2_C15
[13:55:00.262] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:55:00.303] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:55:00.968] INFO: Expecting 41600 events.
[13:55:04.333] INFO: 41600 events read in total (2839ms).
[13:55:04.337] INFO: Test took 4034ms.
[13:55:04.421] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:55:04.421] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 504360
[13:55:04.421] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step3_C0 .. HR_xeff_CalDelScan_step3_C15
[13:55:04.421] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:55:04.462] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:55:05.128] INFO: Expecting 41600 events.
[13:55:08.497] INFO: 41600 events read in total (2843ms).
[13:55:08.500] INFO: Test took 4038ms.
[13:55:08.584] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:55:08.584] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 503455
[13:55:08.584] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step4_C0 .. HR_xeff_CalDelScan_step4_C15
[13:55:08.584] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:55:08.625] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:55:09.290] INFO: Expecting 41600 events.
[13:55:12.661] INFO: 41600 events read in total (2844ms).
[13:55:12.665] INFO: Test took 4040ms.
[13:55:12.748] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:55:12.748] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 503207
[13:55:12.748] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step5_C0 .. HR_xeff_CalDelScan_step5_C15
[13:55:12.748] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:55:12.790] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:55:13.455] INFO: Expecting 41600 events.
[13:55:16.828] INFO: 41600 events read in total (2847ms).
[13:55:16.831] INFO: Test took 4041ms.
[13:55:16.915] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:55:16.915] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 503046
[13:55:16.915] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step6_C0 .. HR_xeff_CalDelScan_step6_C15
[13:55:16.915] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:55:16.957] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:55:17.621] INFO: Expecting 41600 events.
[13:55:20.993] INFO: 41600 events read in total (2845ms).
[13:55:20.997] INFO: Test took 4040ms.
[13:55:21.080] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:55:21.080] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 503000
[13:55:21.080] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step7_C0 .. HR_xeff_CalDelScan_step7_C15
[13:55:21.081] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:55:21.122] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:55:21.787] INFO: Expecting 41600 events.
[13:55:25.177] INFO: 41600 events read in total (2864ms).
[13:55:25.180] INFO: Test took 4058ms.
[13:55:25.263] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:55:25.263] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 502598
[13:55:25.263] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step8_C0 .. HR_xeff_CalDelScan_step8_C15
[13:55:25.263] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:55:25.305] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:55:25.971] INFO: Expecting 41600 events.
[13:55:29.354] INFO: 41600 events read in total (2857ms).
[13:55:29.358] INFO: Test took 4053ms.
[13:55:29.441] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:55:29.441] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 502262
[13:55:29.441] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step9_C0 .. HR_xeff_CalDelScan_step9_C15
[13:55:29.442] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:55:29.483] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:55:30.148] INFO: Expecting 41600 events.
[13:55:33.527] INFO: 41600 events read in total (2852ms).
[13:55:33.531] INFO: Test took 4048ms.
[13:55:33.612] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:55:33.612] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 502997
[13:55:33.612] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step10_C0 .. HR_xeff_CalDelScan_step10_C15
[13:55:33.613] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:55:33.654] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:55:34.319] INFO: Expecting 41600 events.
[13:55:37.702] INFO: 41600 events read in total (2856ms).
[13:55:37.706] INFO: Test took 4052ms.
[13:55:37.789] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:55:37.789] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 501286
[13:55:37.789] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step11_C0 .. HR_xeff_CalDelScan_step11_C15
[13:55:37.789] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:55:37.833] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:55:38.498] INFO: Expecting 41600 events.
[13:55:41.841] INFO: 41600 events read in total (2816ms).
[13:55:41.845] INFO: Test took 4012ms.
[13:55:41.927] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:55:41.927] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 501282
[13:55:41.927] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step12_C0 .. HR_xeff_CalDelScan_step12_C15
[13:55:41.928] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:55:41.969] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:55:42.634] INFO: Expecting 41600 events.
[13:55:46.013] INFO: 41600 events read in total (2853ms).
[13:55:46.017] INFO: Test took 4048ms.
[13:55:46.099] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:55:46.099] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 502386
[13:55:46.099] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step13_C0 .. HR_xeff_CalDelScan_step13_C15
[13:55:46.100] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:55:46.142] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:55:46.807] INFO: Expecting 41600 events.
[13:55:50.208] INFO: 41600 events read in total (2875ms).
[13:55:50.212] INFO: Test took 4070ms.
[13:55:50.294] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:55:50.295] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 502152
[13:55:50.295] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step14_C0 .. HR_xeff_CalDelScan_step14_C15
[13:55:50.295] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:55:50.336] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:55:51.001] INFO: Expecting 41600 events.
[13:55:54.372] INFO: 41600 events read in total (2844ms).
[13:55:54.376] INFO: Test took 4040ms.
[13:55:54.459] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:55:54.459] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 502658
[13:55:54.459] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step15_C0 .. HR_xeff_CalDelScan_step15_C15
[13:55:54.459] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:55:54.501] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:55:55.166] INFO: Expecting 41600 events.
[13:55:58.536] INFO: 41600 events read in total (2844ms).
[13:55:58.539] INFO: Test took 4039ms.
[13:55:58.622] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:55:58.622] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 501690
[13:55:58.622] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step16_C0 .. HR_xeff_CalDelScan_step16_C15
[13:55:58.622] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:55:58.663] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:55:59.328] INFO: Expecting 41600 events.
[13:56:02.717] INFO: 41600 events read in total (2862ms).
[13:56:02.721] INFO: Test took 4058ms.
[13:56:02.804] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:56:02.804] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 503267
[13:56:02.804] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step17_C0 .. HR_xeff_CalDelScan_step17_C15
[13:56:02.804] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:56:02.846] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:56:03.511] INFO: Expecting 41600 events.
[13:56:06.850] INFO: 41600 events read in total (2813ms).
[13:56:06.854] INFO: Test took 4008ms.
[13:56:06.937] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:56:06.938] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 499709
[13:56:06.938] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step18_C0 .. HR_xeff_CalDelScan_step18_C15
[13:56:06.938] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:56:06.979] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:56:07.644] INFO: Expecting 41600 events.
[13:56:10.814] INFO: 41600 events read in total (2643ms).
[13:56:10.818] INFO: Test took 3839ms.
[13:56:10.900] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:56:10.900] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 494176
[13:56:10.900] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step19_C0 .. HR_xeff_CalDelScan_step19_C15
[13:56:10.900] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:56:11.162] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 0: caldel = 166 eff = 0.999712
[13:56:11.163] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 1: caldel = 109 eff = 0.999688
[13:56:11.163] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 2: caldel = 154 eff = 0.999471
[13:56:11.163] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 3: caldel = 152 eff = 0.998822
[13:56:11.163] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 4: caldel = 147 eff = 0.998774
[13:56:11.163] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 5: caldel = 150 eff = 0.998918
[13:56:11.163] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 6: caldel = 142 eff = 0.999087
[13:56:11.164] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 7: caldel = 132 eff = 0.99887
[13:56:11.164] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 8: caldel = 159 eff = 0.998702
[13:56:11.164] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 9: caldel = 182 eff = 0.99887
[13:56:11.164] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 10: caldel = 173 eff = 0.998966
[13:56:11.164] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 11: caldel = 146 eff = 0.998846
[13:56:11.164] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 12: caldel = 168 eff = 0.998894
[13:56:11.164] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 13: caldel = 166 eff = 0.999303
[13:56:11.165] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 14: caldel = 176 eff = 0.999832
[13:56:11.165] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 15: caldel = 157 eff = 0.999688
[13:56:13.560] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): xpixelalive
[13:56:13.560] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: xpixelalive
[13:56:13.560] INFO: ----------------------------------------------------------------------
[13:56:13.560] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:56:13.560] INFO: ----------------------------------------------------------------------
[13:56:13.561] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: clk: 4
[13:56:13.561] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: ctr: 4
[13:56:13.561] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: sda: 19
[13:56:13.561] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: tin: 9
[13:56:13.561] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: level: 15
[13:56:13.561] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: triggerdelay: 0
[13:56:13.561] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: clk: 4
[13:56:13.561] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: ctr: 4
[13:56:13.561] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: sda: 19
[13:56:13.561] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: tin: 9
[13:56:13.561] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: level: 15
[13:56:13.561] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: triggerdelay: 20
[13:56:13.579] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:56:14.247] INFO: Expecting 208000 events.
[13:56:27.760] INFO: 208000 events read in total (12986ms).
[13:56:27.773] INFO: Test took 14194ms.
[13:56:28.216] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:56:28.216] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 2228975
[13:56:28.216] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists highRate_C0 .. highRate_C15
[13:56:28.216] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:56:28.594] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:56:28.594] INFO: number of red-efficiency pixels: 105 65 167 262 275 305 242 257 339 300 305 321 286 179 73 82
[13:56:28.594] INFO: number of X-ray hits detected: 88372 61442 105102 161405 173730 166635 169257 155030 159015 176823 176346 167049 167682 106549 62570 65408
[13:56:28.594] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:56:28.595] INFO: number of Vcal hits detected: 207894 207933 207829 207724 207711 207679 207745 207737 207644 207689 207679 207664 207698 207817 207923 207914
[13:56:28.595] INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 99.9 99.9 99.9 99.9 99.9 99.9 99.8 99.9 99.9 99.9 99.9 99.9 100.0 100.0
[13:56:28.595] INFO: Vcal hit overall efficiency (%): 99.9 100.0 99.9 99.9 99.9 99.8 99.9 99.9 99.8 99.9 99.8 99.8 99.9 99.9 100.0 100.0
[13:56:28.595] INFO: X-ray hit rate [MHz/cm2]: 25.9 18.0 30.8 47.3 50.9 48.8 49.6 45.4 46.6 51.8 51.7 49.0 49.1 31.2 18.3 19.2
[13:56:28.595] INFO: PixTestHighRate::doXPixelAlive() done
[13:56:28.639] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: clk: 4
[13:56:28.639] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: ctr: 4
[13:56:28.639] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: sda: 19
[13:56:28.639] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: tin: 9
[13:56:28.639] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: level: 15
[13:56:28.639] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: triggerdelay: 0
[13:56:28.639] INFO: PixTest:: pg_setup set to default.
[13:56:32.624] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[13:56:32.624] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = highRate_xraymap_C11_V0 -> highRate_xraymap_mod
[13:56:33.832] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[13:56:33.833] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 393.1mA
[13:56:33.834] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 470.3mA
[13:56:33.834] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.2 C
[13:56:33.834] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[13:56:33.834] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[13:56:33.834] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[13:56:33.834] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[13:56:33.834] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[13:56:33.834] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[13:56:33.834] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[13:56:33.834] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[13:56:33.834] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[13:56:33.834] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[13:56:33.924] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[13:56:33.924] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[13:56:33.938] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[13:56:33.938] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[13:56:33.938] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[13:56:33.938] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[13:56:33.938] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[13:56:33.938] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[13:56:33.941] QUIET: Connection to board 43 closed.
[13:56:34.020] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrEff_80.log
[13:50:51.170] INFO: *** Welcome to pxar ***
[13:50:51.170] INFO: *** Today: 2016/06/27
[13:50:51.195] INFO: *** Version: v1.9.0-814-g7497
[13:50:51.196] INFO: readRocDacs: data/myong/dacParameters35_C0.dat .. data/myong/dacParameters35_C15.dat
[13:50:51.197] INFO: readTbmDacs: data/myong/tbmParameters_C0a.dat .. data/myong/tbmParameters_C0b.dat
[13:50:51.197] INFO: readMaskFile: data/myong/defaultMaskFile.dat
[13:50:51.197] INFO: readTrimFile: data/myong/trimParameters35_C0.dat .. data/myong/trimParameters35_C15.dat
[13:50:51.349] INFO: clk: 4
[13:50:51.349] INFO: ctr: 4
[13:50:51.349] INFO: sda: 19
[13:50:51.349] INFO: tin: 9
[13:50:51.349] INFO: level: 15
[13:50:51.349] INFO: triggerdelay: 0
[13:50:51.349] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[13:50:51.349] INFO: Log level: DEBUG
[13:50:51.360] QUIET: Connection to board DTB_WRMNMR opened.
[13:50:51.363] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 43
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WRMNMR
MAC address: 40D85511802B
Hostname: pixelDTB043
Comment: sent to Frank Meier (UNL)
------------------------------------------------------
[13:50:51.366] INFO: RPC call hashes of host and DTB match: 398089610
[13:50:52.968] INFO: DUT info:
[13:50:52.968] INFO: The DUT currently contains the following objects:
[13:50:52.968] INFO: 2 TBM Cores tbm08c (2 ON)
[13:50:52.968] INFO: TBM Core alpha (0): 7 registers set
[13:50:52.968] INFO: TBM Core beta (1): 7 registers set
[13:50:52.968] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:50:52.968] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:52.968] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:52.968] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:52.968] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:52.968] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:52.968] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:52.969] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:52.969] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:52.969] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:52.969] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:52.969] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:52.969] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:52.969] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:52.969] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:52.969] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:52.969] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:52.969] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[13:50:52.969] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[13:50:52.969] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[13:50:52.969] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[13:50:52.969] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[13:50:52.969] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[13:50:52.969] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:50:52.969] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[13:50:52.969] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[13:50:52.969] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[13:50:52.969] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[13:50:52.969] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[13:50:52.969] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[13:50:52.969] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[13:50:52.969] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[13:50:52.969] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[13:50:52.970] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[13:50:52.971] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[13:50:52.972] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[13:50:52.974] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 30355456
[13:50:52.974] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x145e0d0
[13:50:52.974] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x1200360
[13:50:52.974] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7fb339d94010
[13:50:52.974] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7fb33ffff510
[13:50:52.974] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 30363648 fPxarMemory = 0x7fb339d94010
[13:50:52.976] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 390.7mA
[13:50:52.977] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 470.3mA
[13:50:52.977] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.2 C
[13:50:53.470] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x1848d50
[13:50:53.530] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[13:50:53.530] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[13:50:53.530] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[13:50:53.535] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[13:50:53.535] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[13:50:53.536] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[13:50:53.546] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[13:50:53.547] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[13:50:53.558] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[13:50:53.558] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[13:50:53.569] INFO: PixTestCmd::init()
[13:50:53.588] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[13:50:53.588] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[13:50:53.588] INFO: readGainPedestalParameters data/myong/phCalibrationFitErr35_C0.dat .. data/myong/phCalibrationFitErr35_C15.dat
[13:50:53.845] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[13:50:53.845] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[13:50:53.858] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[13:50:53.865] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[13:50:53.865] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[13:50:53.865] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[13:50:53.886] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[13:50:53.886] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[13:50:53.886] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[13:50:53.886] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[13:50:53.886] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[13:50:53.892] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[13:50:53.892] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[13:50:53.906] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[13:50:53.906] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[13:50:53.906] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[13:50:53.906] INFO: readReadbackCal: data/myong/readbackCal_C0.dat .. data/myong/readbackCal_C15.dat
[13:50:53.916] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[13:50:53.924] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[13:50:53.924] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[13:50:53.924] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[13:50:53.924] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[13:50:53.936] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[13:50:53.936] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[13:50:57.747] INFO: ######################################################################
[13:50:57.747] INFO: PixTestAlive::doTest()
[13:50:57.747] INFO: ######################################################################
[13:50:57.751] INFO: ----------------------------------------------------------------------
[13:50:57.751] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:50:57.751] INFO: ----------------------------------------------------------------------
[13:50:57.753] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:50:58.133] INFO: Expecting 41600 events.
[13:51:02.336] INFO: 41600 events read in total (3484ms).
[13:51:02.481] INFO: Test took 4728ms.
[13:51:02.491] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:51:02.491] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[13:51:02.491] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists PixelAlive_C0 .. PixelAlive_C15
[13:51:02.761] INFO: PixTestAlive::aliveTest() done
[13:51:02.761] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:51:02.761] DEBUG: <PixTestAlive.cc/aliveTest:L199> number of red-efficiency pixels: 44 21 46 61 71 55 67 78 71 83 98 60 59 46 20 38
[13:51:02.789] INFO: ----------------------------------------------------------------------
[13:51:02.789] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:51:02.789] INFO: ----------------------------------------------------------------------
[13:51:02.791] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:51:03.167] INFO: Expecting 41600 events.
[13:51:06.102] INFO: 41600 events read in total (2219ms).
[13:51:06.103] INFO: Test took 3312ms.
[13:51:06.103] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:51:06.103] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 0
[13:51:06.103] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists MaskTest_C0 .. MaskTest_C15
[13:51:06.104] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:51:06.527] INFO: PixTestAlive::maskTest() done
[13:51:06.527] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:51:06.549] INFO: ----------------------------------------------------------------------
[13:51:06.549] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:51:06.549] INFO: ----------------------------------------------------------------------
[13:51:06.551] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:51:06.928] INFO: Expecting 41600 events.
[13:51:11.129] INFO: 41600 events read in total (3486ms).
[13:51:11.130] INFO: Test took 4579ms.
[13:51:11.141] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:51:11.141] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[13:51:11.142] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists AddressDecodingTest_C0 .. AddressDecodingTest_C15
[13:51:11.512] INFO: PixTestAlive::addressDecodingTest() done
[13:51:11.512] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:51:11.512] INFO: PixTestAlive::doTest() done, duration: 13 seconds
[13:51:17.808] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[13:51:17.808] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = PixelAlive_C2_V0 -> PixelAlive_mod
[13:51:20.216] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): caldelscan
[13:51:20.216] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: caldelscan
[13:51:20.216] INFO: ----------------------------------------------------------------------
[13:51:20.216] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[13:51:20.216] INFO: ----------------------------------------------------------------------
[13:51:20.355] INFO: Expecting 768 events.
[13:51:21.485] INFO: 768 events read in total (414ms).
[13:51:21.485] INFO: Test took 1263ms.
[13:51:21.491] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:51:22.288] INFO: Expecting 41600 events.
[13:51:25.917] INFO: 41600 events read in total (3102ms).
[13:51:25.922] INFO: Test took 4431ms.
[13:51:26.067] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:51:26.067] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 823619
[13:51:26.067] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step0_C0 .. HR_xeff_CalDelScan_step0_C15
[13:51:26.067] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:51:26.128] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:51:26.792] INFO: Expecting 41600 events.
[13:51:30.502] INFO: 41600 events read in total (3183ms).
[13:51:30.507] INFO: Test took 4379ms.
[13:51:30.641] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:51:30.641] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 830068
[13:51:30.641] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step1_C0 .. HR_xeff_CalDelScan_step1_C15
[13:51:30.642] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:51:30.706] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:51:31.371] INFO: Expecting 41600 events.
[13:51:35.116] INFO: 41600 events read in total (3219ms).
[13:51:35.121] INFO: Test took 4415ms.
[13:51:35.257] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:51:35.257] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 831846
[13:51:35.257] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step2_C0 .. HR_xeff_CalDelScan_step2_C15
[13:51:35.257] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:51:35.322] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:51:35.987] INFO: Expecting 41600 events.
[13:51:39.763] INFO: 41600 events read in total (3250ms).
[13:51:39.769] INFO: Test took 4447ms.
[13:51:39.904] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:51:39.904] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 833393
[13:51:39.904] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step3_C0 .. HR_xeff_CalDelScan_step3_C15
[13:51:39.904] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:51:39.968] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:51:40.634] INFO: Expecting 41600 events.
[13:51:44.405] INFO: 41600 events read in total (3244ms).
[13:51:44.411] INFO: Test took 4443ms.
[13:51:44.546] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:51:44.546] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 831490
[13:51:44.546] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step4_C0 .. HR_xeff_CalDelScan_step4_C15
[13:51:44.547] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:51:44.611] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:51:45.275] INFO: Expecting 41600 events.
[13:51:49.051] INFO: 41600 events read in total (3249ms).
[13:51:49.056] INFO: Test took 4445ms.
[13:51:49.193] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:51:49.194] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 833912
[13:51:49.194] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step5_C0 .. HR_xeff_CalDelScan_step5_C15
[13:51:49.194] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:51:49.258] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:51:49.923] INFO: Expecting 41600 events.
[13:51:53.709] INFO: 41600 events read in total (3259ms).
[13:51:53.714] INFO: Test took 4456ms.
[13:51:53.850] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:51:53.850] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 834064
[13:51:53.850] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step6_C0 .. HR_xeff_CalDelScan_step6_C15
[13:51:53.851] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:51:53.915] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:51:54.580] INFO: Expecting 41600 events.
[13:51:58.367] INFO: 41600 events read in total (3260ms).
[13:51:58.373] INFO: Test took 4458ms.
[13:51:58.508] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:51:58.508] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 833202
[13:51:58.508] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step7_C0 .. HR_xeff_CalDelScan_step7_C15
[13:51:58.509] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:51:58.574] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:51:59.239] INFO: Expecting 41600 events.
[13:52:03.006] INFO: 41600 events read in total (3241ms).
[13:52:03.011] INFO: Test took 4437ms.
[13:52:03.149] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:52:03.149] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 833101
[13:52:03.149] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step8_C0 .. HR_xeff_CalDelScan_step8_C15
[13:52:03.150] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:52:03.215] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:52:03.880] INFO: Expecting 41600 events.
[13:52:07.689] INFO: 41600 events read in total (3282ms).
[13:52:07.695] INFO: Test took 4480ms.
[13:52:07.831] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:52:07.831] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 833939
[13:52:07.831] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step9_C0 .. HR_xeff_CalDelScan_step9_C15
[13:52:07.831] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:52:07.896] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:52:08.562] INFO: Expecting 41600 events.
[13:52:12.332] INFO: 41600 events read in total (3243ms).
[13:52:12.337] INFO: Test took 4441ms.
[13:52:12.475] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:52:12.475] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 832729
[13:52:12.475] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step10_C0 .. HR_xeff_CalDelScan_step10_C15
[13:52:12.475] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:52:12.541] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:52:13.207] INFO: Expecting 41600 events.
[13:52:16.980] INFO: 41600 events read in total (3246ms).
[13:52:16.985] INFO: Test took 4444ms.
[13:52:17.122] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:52:17.122] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 833517
[13:52:17.122] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step11_C0 .. HR_xeff_CalDelScan_step11_C15
[13:52:17.122] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:52:17.187] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:52:17.853] INFO: Expecting 41600 events.
[13:52:21.641] INFO: 41600 events read in total (3261ms).
[13:52:21.646] INFO: Test took 4459ms.
[13:52:21.781] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:52:21.781] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 832875
[13:52:21.781] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step12_C0 .. HR_xeff_CalDelScan_step12_C15
[13:52:21.782] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:52:21.847] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:52:22.511] INFO: Expecting 41600 events.
[13:52:26.303] INFO: 41600 events read in total (3265ms).
[13:52:26.308] INFO: Test took 4461ms.
[13:52:26.446] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:52:26.446] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 833585
[13:52:26.446] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step13_C0 .. HR_xeff_CalDelScan_step13_C15
[13:52:26.446] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:52:26.512] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:52:27.178] INFO: Expecting 41600 events.
[13:52:30.973] INFO: 41600 events read in total (3268ms).
[13:52:30.979] INFO: Test took 4467ms.
[13:52:31.115] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:52:31.115] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 832939
[13:52:31.115] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step14_C0 .. HR_xeff_CalDelScan_step14_C15
[13:52:31.116] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:52:31.181] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:52:31.847] INFO: Expecting 41600 events.
[13:52:35.631] INFO: 41600 events read in total (3257ms).
[13:52:35.636] INFO: Test took 4455ms.
[13:52:35.773] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:52:35.773] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 832187
[13:52:35.773] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step15_C0 .. HR_xeff_CalDelScan_step15_C15
[13:52:35.774] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:52:35.840] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:52:36.506] INFO: Expecting 41600 events.
[13:52:40.297] INFO: 41600 events read in total (3264ms).
[13:52:40.302] INFO: Test took 4462ms.
[13:52:40.437] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:52:40.437] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 832846
[13:52:40.437] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step16_C0 .. HR_xeff_CalDelScan_step16_C15
[13:52:40.437] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:52:40.503] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:52:41.169] INFO: Expecting 41600 events.
[13:52:44.956] INFO: 41600 events read in total (3261ms).
[13:52:44.961] INFO: Test took 4458ms.
[13:52:45.101] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:52:45.101] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 832379
[13:52:45.101] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step17_C0 .. HR_xeff_CalDelScan_step17_C15
[13:52:45.102] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:52:45.167] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:52:45.832] INFO: Expecting 41600 events.
[13:52:49.570] INFO: 41600 events read in total (3211ms).
[13:52:49.575] INFO: Test took 4408ms.
[13:52:49.713] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:52:49.713] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 832060
[13:52:49.713] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step18_C0 .. HR_xeff_CalDelScan_step18_C15
[13:52:49.713] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:52:49.779] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:52:50.445] INFO: Expecting 41600 events.
[13:52:54.042] INFO: 41600 events read in total (3071ms).
[13:52:54.047] INFO: Test took 4268ms.
[13:52:54.183] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:52:54.183] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 824690
[13:52:54.183] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step19_C0 .. HR_xeff_CalDelScan_step19_C15
[13:52:54.183] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:52:54.468] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 0: caldel = 169 eff = 0.999014
[13:52:54.468] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 1: caldel = 125 eff = 0.999519
[13:52:54.469] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 2: caldel = 170 eff = 0.998173
[13:52:54.469] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 3: caldel = 155 eff = 0.996538
[13:52:54.469] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 4: caldel = 149 eff = 0.996394
[13:52:54.469] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 5: caldel = 151 eff = 0.996683
[13:52:54.469] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 6: caldel = 141 eff = 0.99601
[13:52:54.469] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 7: caldel = 142 eff = 0.996731
[13:52:54.469] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 8: caldel = 172 eff = 0.996707
[13:52:54.470] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 9: caldel = 187 eff = 0.995673
[13:52:54.470] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 10: caldel = 174 eff = 0.99524
[13:52:54.470] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 11: caldel = 161 eff = 0.996202
[13:52:54.470] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 12: caldel = 175 eff = 0.996322
[13:52:54.471] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 13: caldel = 168 eff = 0.998221
[13:52:54.471] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 14: caldel = 167 eff = 0.999279
[13:52:54.471] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 15: caldel = 149 eff = 0.999255
[13:53:09.360] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): xpixelalive
[13:53:09.360] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: xpixelalive
[13:53:09.360] INFO: ----------------------------------------------------------------------
[13:53:09.360] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:53:09.360] INFO: ----------------------------------------------------------------------
[13:53:09.361] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: clk: 4
[13:53:09.361] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: ctr: 4
[13:53:09.361] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: sda: 19
[13:53:09.361] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: tin: 9
[13:53:09.361] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: level: 15
[13:53:09.361] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: triggerdelay: 0
[13:53:09.361] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: clk: 4
[13:53:09.361] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: ctr: 4
[13:53:09.361] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: sda: 19
[13:53:09.361] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: tin: 9
[13:53:09.361] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: level: 15
[13:53:09.361] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: triggerdelay: 20
[13:53:09.379] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:53:10.048] INFO: Expecting 208000 events.
[13:53:26.343] INFO: 208000 events read in total (15769ms).
[13:53:26.363] INFO: Test took 16983ms.
[13:53:27.090] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:53:27.090] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 3860837
[13:53:27.090] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists highRate_C0 .. highRate_C15
[13:53:27.090] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:53:27.578] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:53:27.578] INFO: number of red-efficiency pixels: 224 123 347 659 699 735 688 600 679 790 774 744 686 377 221 181
[13:53:27.578] INFO: number of X-ray hits detected: 155059 107215 184653 283511 303251 290978 297303 272573 279482 310063 309710 295427 292030 186005 110854 116163
[13:53:27.578] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:53:27.578] INFO: number of Vcal hits detected: 207770 207873 207615 207251 207218 207167 207242 207330 207230 207073 207116 207139 207222 207578 207772 207811
[13:53:27.578] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.8 99.7 99.6 99.6 99.7 99.7 99.7 99.6 99.6 99.6 99.7 99.8 99.9 99.9
[13:53:27.578] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.8 99.6 99.6 99.6 99.6 99.7 99.6 99.6 99.6 99.6 99.6 99.8 99.9 99.9
[13:53:27.578] INFO: X-ray hit rate [MHz/cm2]: 45.4 31.4 54.1 83.1 88.9 85.3 87.1 79.9 81.9 90.9 90.8 86.6 85.6 54.5 32.5 34.0
[13:53:27.578] INFO: PixTestHighRate::doXPixelAlive() done
[13:53:27.623] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: clk: 4
[13:53:27.623] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: ctr: 4
[13:53:27.623] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: sda: 19
[13:53:27.623] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: tin: 9
[13:53:27.623] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: level: 15
[13:53:27.623] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: triggerdelay: 0
[13:53:27.623] INFO: PixTest:: pg_setup set to default.
[13:54:15.056] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[13:54:15.056] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = highRate_xraymap_C11_V0 -> highRate_xraymap_mod
[13:54:16.904] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[13:54:16.905] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 393.1mA
[13:54:16.906] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 470.3mA
[13:54:16.906] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.2 C
[13:54:16.906] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[13:54:16.906] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[13:54:16.906] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[13:54:16.906] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[13:54:16.906] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[13:54:16.906] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[13:54:16.906] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[13:54:16.906] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[13:54:16.906] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[13:54:16.906] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[13:54:16.998] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[13:54:16.999] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[13:54:17.012] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[13:54:17.012] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[13:54:17.012] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[13:54:17.012] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[13:54:17.012] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[13:54:17.012] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[13:54:17.015] QUIET: Connection to board 43 closed.
[13:54:17.095] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrEff_120.log
[13:47:27.638] INFO: *** Welcome to pxar ***
[13:47:27.638] INFO: *** Today: 2016/06/27
[13:47:27.662] INFO: *** Version: v1.9.0-814-g7497
[13:47:27.662] INFO: readRocDacs: data/myong/dacParameters35_C0.dat .. data/myong/dacParameters35_C15.dat
[13:47:27.663] INFO: readTbmDacs: data/myong/tbmParameters_C0a.dat .. data/myong/tbmParameters_C0b.dat
[13:47:27.663] INFO: readMaskFile: data/myong/defaultMaskFile.dat
[13:47:27.663] INFO: readTrimFile: data/myong/trimParameters35_C0.dat .. data/myong/trimParameters35_C15.dat
[13:47:27.813] INFO: clk: 4
[13:47:27.813] INFO: ctr: 4
[13:47:27.813] INFO: sda: 19
[13:47:27.813] INFO: tin: 9
[13:47:27.813] INFO: level: 15
[13:47:27.813] INFO: triggerdelay: 0
[13:47:27.813] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[13:47:27.813] INFO: Log level: DEBUG
[13:47:27.824] QUIET: Connection to board DTB_WRMNMR opened.
[13:47:27.827] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 43
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WRMNMR
MAC address: 40D85511802B
Hostname: pixelDTB043
Comment: sent to Frank Meier (UNL)
------------------------------------------------------
[13:47:27.830] INFO: RPC call hashes of host and DTB match: 398089610
[13:47:29.434] INFO: DUT info:
[13:47:29.434] INFO: The DUT currently contains the following objects:
[13:47:29.434] INFO: 2 TBM Cores tbm08c (2 ON)
[13:47:29.434] INFO: TBM Core alpha (0): 7 registers set
[13:47:29.434] INFO: TBM Core beta (1): 7 registers set
[13:47:29.434] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:47:29.434] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:29.434] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:29.434] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:29.434] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:29.434] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:29.434] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:29.434] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:29.434] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:29.434] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:29.434] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:29.434] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:29.434] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:29.434] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:29.434] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:29.434] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:29.434] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[13:47:29.435] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[13:47:29.436] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[13:47:29.437] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[13:47:29.438] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[13:47:29.438] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[13:47:29.438] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[13:47:29.438] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[13:47:29.438] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[13:47:29.438] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[13:47:29.438] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[13:47:29.438] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[13:47:29.438] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[13:47:29.438] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[13:47:29.438] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[13:47:29.438] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[13:47:29.440] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 30363648
[13:47:29.440] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x19fa0d0
[13:47:29.440] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x179c360
[13:47:29.440] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f6361393010
[13:47:29.440] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f63675fe510
[13:47:29.440] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 30371840 fPxarMemory = 0x7f6361393010
[13:47:29.441] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 389.9mA
[13:47:29.442] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 469.5mA
[13:47:29.442] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.4 C
[13:47:29.938] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x1de4cf0
[13:47:29.999] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[13:47:29.999] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[13:47:30.000] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[13:47:30.005] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[13:47:30.005] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[13:47:30.005] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[13:47:30.016] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[13:47:30.016] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[13:47:30.027] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[13:47:30.027] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[13:47:30.047] INFO: PixTestCmd::init()
[13:47:30.067] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[13:47:30.067] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[13:47:30.067] INFO: readGainPedestalParameters data/myong/phCalibrationFitErr35_C0.dat .. data/myong/phCalibrationFitErr35_C15.dat
[13:47:30.311] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[13:47:30.311] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[13:47:30.327] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[13:47:30.333] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[13:47:30.333] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[13:47:30.333] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[13:47:30.354] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[13:47:30.355] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[13:47:30.355] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[13:47:30.355] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[13:47:30.355] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[13:47:30.361] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[13:47:30.361] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[13:47:30.381] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[13:47:30.381] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[13:47:30.381] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[13:47:30.381] INFO: readReadbackCal: data/myong/readbackCal_C0.dat .. data/myong/readbackCal_C15.dat
[13:47:30.393] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[13:47:30.404] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[13:47:30.404] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[13:47:30.404] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[13:47:30.404] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[13:47:30.421] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[13:47:30.422] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[13:47:35.883] INFO: ######################################################################
[13:47:35.883] INFO: PixTestAlive::doTest()
[13:47:35.883] INFO: ######################################################################
[13:47:35.887] INFO: ----------------------------------------------------------------------
[13:47:35.887] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:47:35.887] INFO: ----------------------------------------------------------------------
[13:47:35.889] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:47:36.268] INFO: Expecting 41600 events.
[13:47:40.456] INFO: 41600 events read in total (3471ms).
[13:47:40.602] INFO: Test took 4713ms.
[13:47:40.614] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:47:40.614] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[13:47:40.614] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists PixelAlive_C0 .. PixelAlive_C15
[13:47:40.886] INFO: PixTestAlive::aliveTest() done
[13:47:40.886] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:47:40.886] DEBUG: <PixTestAlive.cc/aliveTest:L199> number of red-efficiency pixels: 56 34 46 86 100 86 93 102 95 98 100 103 106 61 31 41
[13:47:40.913] INFO: ----------------------------------------------------------------------
[13:47:40.914] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:47:40.914] INFO: ----------------------------------------------------------------------
[13:47:40.916] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:47:41.294] INFO: Expecting 41600 events.
[13:47:44.228] INFO: 41600 events read in total (2218ms).
[13:47:44.228] INFO: Test took 3312ms.
[13:47:44.228] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:47:44.228] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 0
[13:47:44.228] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists MaskTest_C0 .. MaskTest_C15
[13:47:44.229] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:47:44.651] INFO: PixTestAlive::maskTest() done
[13:47:44.651] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:47:44.674] INFO: ----------------------------------------------------------------------
[13:47:44.674] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:47:44.674] INFO: ----------------------------------------------------------------------
[13:47:44.676] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:47:45.054] INFO: Expecting 41600 events.
[13:47:49.268] INFO: 41600 events read in total (3499ms).
[13:47:49.269] INFO: Test took 4593ms.
[13:47:49.279] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:47:49.279] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[13:47:49.279] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists AddressDecodingTest_C0 .. AddressDecodingTest_C15
[13:47:49.649] INFO: PixTestAlive::addressDecodingTest() done
[13:47:49.649] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:47:49.649] INFO: PixTestAlive::doTest() done, duration: 13 seconds
[13:47:53.216] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[13:47:53.216] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = PixelAlive_C2_V0 -> PixelAlive_mod
[13:47:56.224] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): caldelscan
[13:47:56.224] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: caldelscan
[13:47:56.224] INFO: ----------------------------------------------------------------------
[13:47:56.224] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[13:47:56.224] INFO: ----------------------------------------------------------------------
[13:47:56.364] INFO: Expecting 768 events.
[13:47:57.492] INFO: 768 events read in total (413ms).
[13:47:57.493] INFO: Test took 1263ms.
[13:47:57.498] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:47:58.296] INFO: Expecting 41600 events.
[13:48:02.255] INFO: 41600 events read in total (3433ms).
[13:48:02.261] INFO: Test took 4762ms.
[13:48:02.450] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:48:02.450] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1089442
[13:48:02.450] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step0_C0 .. HR_xeff_CalDelScan_step0_C15
[13:48:02.451] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:48:02.528] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:48:03.193] INFO: Expecting 41600 events.
[13:48:07.228] INFO: 41600 events read in total (3508ms).
[13:48:07.234] INFO: Test took 4706ms.
[13:48:07.415] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:48:07.415] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1096548
[13:48:07.415] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step1_C0 .. HR_xeff_CalDelScan_step1_C15
[13:48:07.416] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:48:07.497] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:48:08.162] INFO: Expecting 41600 events.
[13:48:12.253] INFO: 41600 events read in total (3564ms).
[13:48:12.260] INFO: Test took 4763ms.
[13:48:12.443] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:48:12.443] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1097884
[13:48:12.443] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step2_C0 .. HR_xeff_CalDelScan_step2_C15
[13:48:12.444] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:48:12.525] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:48:13.190] INFO: Expecting 41600 events.
[13:48:17.291] INFO: 41600 events read in total (3575ms).
[13:48:17.297] INFO: Test took 4772ms.
[13:48:17.481] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:48:17.481] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1096702
[13:48:17.481] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step3_C0 .. HR_xeff_CalDelScan_step3_C15
[13:48:17.481] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:48:17.562] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:48:18.229] INFO: Expecting 41600 events.
[13:48:22.330] INFO: 41600 events read in total (3575ms).
[13:48:22.336] INFO: Test took 4773ms.
[13:48:22.519] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:48:22.519] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1098683
[13:48:22.519] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step4_C0 .. HR_xeff_CalDelScan_step4_C15
[13:48:22.519] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:48:22.600] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:48:23.265] INFO: Expecting 41600 events.
[13:48:27.393] INFO: 41600 events read in total (3601ms).
[13:48:27.399] INFO: Test took 4799ms.
[13:48:27.584] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:48:27.584] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1099227
[13:48:27.584] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step5_C0 .. HR_xeff_CalDelScan_step5_C15
[13:48:27.584] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:48:27.666] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:48:28.331] INFO: Expecting 41600 events.
[13:48:32.469] INFO: 41600 events read in total (3611ms).
[13:48:32.476] INFO: Test took 4810ms.
[13:48:32.659] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:48:32.659] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1099395
[13:48:32.659] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step6_C0 .. HR_xeff_CalDelScan_step6_C15
[13:48:32.659] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:48:32.742] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:48:33.407] INFO: Expecting 41600 events.
[13:48:37.540] INFO: 41600 events read in total (3606ms).
[13:48:37.546] INFO: Test took 4804ms.
[13:48:37.728] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:48:37.728] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1098949
[13:48:37.728] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step7_C0 .. HR_xeff_CalDelScan_step7_C15
[13:48:37.728] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:48:37.811] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:48:38.476] INFO: Expecting 41600 events.
[13:48:42.596] INFO: 41600 events read in total (3594ms).
[13:48:42.602] INFO: Test took 4791ms.
[13:48:42.782] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:48:42.782] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1099921
[13:48:42.782] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step8_C0 .. HR_xeff_CalDelScan_step8_C15
[13:48:42.783] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:48:42.865] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:48:43.530] INFO: Expecting 41600 events.
[13:48:47.655] INFO: 41600 events read in total (3598ms).
[13:48:47.661] INFO: Test took 4796ms.
[13:48:47.844] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:48:47.844] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1100698
[13:48:47.844] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step9_C0 .. HR_xeff_CalDelScan_step9_C15
[13:48:47.845] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:48:47.927] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:48:48.592] INFO: Expecting 41600 events.
[13:48:52.748] INFO: 41600 events read in total (3630ms).
[13:48:52.755] INFO: Test took 4828ms.
[13:48:52.940] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:48:52.940] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1102726
[13:48:52.940] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step10_C0 .. HR_xeff_CalDelScan_step10_C15
[13:48:52.940] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:48:53.022] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:48:53.687] INFO: Expecting 41600 events.
[13:48:57.820] INFO: 41600 events read in total (3607ms).
[13:48:57.827] INFO: Test took 4805ms.
[13:48:58.008] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:48:58.008] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1101078
[13:48:58.008] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step11_C0 .. HR_xeff_CalDelScan_step11_C15
[13:48:58.009] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:48:58.090] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:48:58.755] INFO: Expecting 41600 events.
[13:49:02.842] INFO: 41600 events read in total (3560ms).
[13:49:02.848] INFO: Test took 4758ms.
[13:49:03.030] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:49:03.030] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1100847
[13:49:03.030] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step12_C0 .. HR_xeff_CalDelScan_step12_C15
[13:49:03.030] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:49:03.111] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:49:03.776] INFO: Expecting 41600 events.
[13:49:07.901] INFO: 41600 events read in total (3599ms).
[13:49:07.908] INFO: Test took 4797ms.
[13:49:08.091] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:49:08.091] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1101337
[13:49:08.091] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step13_C0 .. HR_xeff_CalDelScan_step13_C15
[13:49:08.091] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:49:08.173] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:49:08.838] INFO: Expecting 41600 events.
[13:49:12.968] INFO: 41600 events read in total (3603ms).
[13:49:12.974] INFO: Test took 4801ms.
[13:49:13.157] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:49:13.157] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1098809
[13:49:13.157] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step14_C0 .. HR_xeff_CalDelScan_step14_C15
[13:49:13.157] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:49:13.240] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:49:13.905] INFO: Expecting 41600 events.
[13:49:18.042] INFO: 41600 events read in total (3610ms).
[13:49:18.048] INFO: Test took 4808ms.
[13:49:18.232] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:49:18.232] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1099434
[13:49:18.232] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step15_C0 .. HR_xeff_CalDelScan_step15_C15
[13:49:18.233] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:49:18.316] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:49:18.981] INFO: Expecting 41600 events.
[13:49:23.122] INFO: 41600 events read in total (3614ms).
[13:49:23.128] INFO: Test took 4812ms.
[13:49:23.312] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:49:23.312] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1100971
[13:49:23.312] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step16_C0 .. HR_xeff_CalDelScan_step16_C15
[13:49:23.312] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:49:23.394] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:49:24.059] INFO: Expecting 41600 events.
[13:49:28.189] INFO: 41600 events read in total (3604ms).
[13:49:28.195] INFO: Test took 4801ms.
[13:49:28.374] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:49:28.374] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1099067
[13:49:28.374] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step17_C0 .. HR_xeff_CalDelScan_step17_C15
[13:49:28.375] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:49:28.456] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:49:29.121] INFO: Expecting 41600 events.
[13:49:33.189] INFO: 41600 events read in total (3541ms).
[13:49:33.195] INFO: Test took 4739ms.
[13:49:33.378] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:49:33.378] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1098062
[13:49:33.378] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step18_C0 .. HR_xeff_CalDelScan_step18_C15
[13:49:33.379] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:49:33.460] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:49:34.125] INFO: Expecting 41600 events.
[13:49:38.057] INFO: 41600 events read in total (3405ms).
[13:49:38.063] INFO: Test took 4603ms.
[13:49:38.296] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:49:38.297] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1089611
[13:49:38.297] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step19_C0 .. HR_xeff_CalDelScan_step19_C15
[13:49:38.297] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:49:38.600] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 0: caldel = 152 eff = 0.997212
[13:49:38.600] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 1: caldel = 122 eff = 0.998125
[13:49:38.600] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 2: caldel = 167 eff = 0.995385
[13:49:38.600] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 3: caldel = 151 eff = 0.991563
[13:49:38.601] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 4: caldel = 149 eff = 0.990769
[13:49:38.601] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 5: caldel = 156 eff = 0.991106
[13:49:38.601] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 6: caldel = 141 eff = 0.990505
[13:49:38.601] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 7: caldel = 141 eff = 0.991731
[13:49:38.602] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 8: caldel = 174 eff = 0.991899
[13:49:38.602] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 9: caldel = 182 eff = 0.989038
[13:49:38.602] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 10: caldel = 174 eff = 0.989663
[13:49:38.602] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 11: caldel = 161 eff = 0.989615
[13:49:38.602] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 12: caldel = 171 eff = 0.991466
[13:49:38.603] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 13: caldel = 174 eff = 0.995216
[13:49:38.603] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 14: caldel = 186 eff = 0.997885
[13:49:38.603] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 15: caldel = 152 eff = 0.997837
[13:50:04.392] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): xpixelalive
[13:50:04.392] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: xpixelalive
[13:50:04.392] INFO: ----------------------------------------------------------------------
[13:50:04.392] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:50:04.392] INFO: ----------------------------------------------------------------------
[13:50:04.393] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: clk: 4
[13:50:04.393] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: ctr: 4
[13:50:04.393] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: sda: 19
[13:50:04.393] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: tin: 9
[13:50:04.393] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: level: 15
[13:50:04.393] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: triggerdelay: 0
[13:50:04.393] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: clk: 4
[13:50:04.393] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: ctr: 4
[13:50:04.393] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: sda: 19
[13:50:04.393] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: tin: 9
[13:50:04.393] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: level: 15
[13:50:04.393] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: triggerdelay: 20
[13:50:04.411] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[13:50:05.079] INFO: Expecting 208000 events.
[13:50:23.910] INFO: 208000 events read in total (18305ms).
[13:50:23.936] INFO: Test took 19525ms.
[13:50:24.916] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:50:24.916] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 5166735
[13:50:24.916] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists highRate_C0 .. highRate_C15
[13:50:24.916] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[13:50:25.486] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:50:25.486] INFO: number of red-efficiency pixels: 461 218 651 1223 1327 1230 1229 1123 1135 1482 1396 1295 1238 713 240 286
[13:50:25.486] INFO: number of X-ray hits detected: 207840 145541 249204 381623 406899 391167 399515 367253 376628 415658 414722 395923 393302 250696 148544 155660
[13:50:25.486] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:50:25.486] INFO: number of Vcal hits detected: 207508 207773 207193 206431 206288 206421 206389 206576 206596 206009 206114 206266 206385 207115 207752 207696
[13:50:25.486] INFO: Vcal hit fiducial efficiency (%): 99.8 99.9 99.6 99.3 99.3 99.3 99.3 99.4 99.4 99.1 99.2 99.3 99.3 99.6 99.9 99.9
[13:50:25.486] INFO: Vcal hit overall efficiency (%): 99.8 99.9 99.6 99.2 99.2 99.2 99.2 99.3 99.3 99.0 99.1 99.2 99.2 99.6 99.9 99.9
[13:50:25.486] INFO: X-ray hit rate [MHz/cm2]: 60.9 42.7 73.0 111.9 119.3 114.7 117.1 107.6 110.4 121.8 121.6 116.0 115.3 73.5 43.5 45.6
[13:50:25.486] INFO: PixTestHighRate::doXPixelAlive() done
[13:50:25.531] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: clk: 4
[13:50:25.531] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: ctr: 4
[13:50:25.531] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: sda: 19
[13:50:25.531] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: tin: 9
[13:50:25.531] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: level: 15
[13:50:25.531] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: triggerdelay: 0
[13:50:25.531] INFO: PixTest:: pg_setup set to default.
[13:50:44.336] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[13:50:44.336] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = highRate_xraymap_C10_V0 -> highRate_xraymap_mod
[13:50:45.536] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[13:50:45.537] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 392.3mA
[13:50:45.538] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 470.3mA
[13:50:45.538] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.1 C
[13:50:45.538] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[13:50:45.538] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[13:50:45.538] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[13:50:45.538] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[13:50:45.538] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[13:50:45.538] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[13:50:45.538] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[13:50:45.538] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[13:50:45.538] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[13:50:45.538] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[13:50:45.632] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[13:50:45.632] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[13:50:45.646] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[13:50:45.646] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[13:50:45.646] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[13:50:45.646] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[13:50:45.646] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[13:50:45.646] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[13:50:45.649] QUIET: Connection to board 43 closed.
[13:50:45.728] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
MoReWeb-v0.5.1-895-gd4c3d74 on branch master