Test Date: 1973-11-29 16:33
Analysis date: 2016-06-03 16:21
Logfile
hrData_40.log
[10:43:17.612] INFO: *** Welcome to pxar ***
[10:43:17.612] INFO: *** Today: 2016/06/03
[10:43:17.635] INFO: *** Version: v1.9.0-805-geb36
[10:43:17.635] INFO: readRocDacs: data/mybna/dacParameters35_C0.dat .. data/mybna/dacParameters35_C15.dat
[10:43:17.636] INFO: readTbmDacs: data/mybna/tbmParameters_C0a.dat .. data/mybna/tbmParameters_C0b.dat
[10:43:17.637] INFO: readMaskFile: data/mybna/defaultMaskFile.dat
[10:43:17.637] INFO: readTrimFile: data/mybna/trimParameters35_C0.dat .. data/mybna/trimParameters35_C15.dat
[10:43:17.785] INFO: clk: 4
[10:43:17.785] INFO: ctr: 4
[10:43:17.785] INFO: sda: 19
[10:43:17.785] INFO: tin: 9
[10:43:17.785] INFO: level: 15
[10:43:17.785] INFO: triggerdelay: 0
[10:43:17.785] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[10:43:17.785] INFO: Log level: DEBUG
[10:43:17.796] QUIET: Connection to board DTB_WRPRHI opened.
[10:43:17.800] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 58
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WRPRHI
MAC address: 40D85511803A
Hostname: pixelDTB058
Comment:
------------------------------------------------------
[10:43:17.802] INFO: RPC call hashes of host and DTB match: 398089610
[10:43:19.402] INFO: DUT info:
[10:43:19.402] INFO: The DUT currently contains the following objects:
[10:43:19.402] INFO: 2 TBM Cores tbm08c (2 ON)
[10:43:19.402] INFO: TBM Core alpha (0): 7 registers set
[10:43:19.402] INFO: TBM Core beta (1): 7 registers set
[10:43:19.402] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:43:19.402] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:19.402] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:19.402] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:19.402] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:19.402] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:19.402] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:19.402] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:19.402] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:19.402] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:19.403] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:19.403] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:19.403] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:19.403] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:19.403] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:19.403] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:19.403] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[10:43:19.403] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:43:19.404] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:43:19.405] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:43:19.407] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 33497088
[10:43:19.408] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x10fe0e0
[10:43:19.408] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0xea0360
[10:43:19.408] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7ff799d94010
[10:43:19.408] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7ff79ffff510
[10:43:19.408] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 33505280 fPxarMemory = 0x7ff799d94010
[10:43:19.409] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 390.7mA
[10:43:19.410] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 468.7mA
[10:43:19.410] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.2 C
[10:43:19.899] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x14e8dc0
[10:43:19.959] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[10:43:19.959] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[10:43:19.959] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[10:43:19.965] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[10:43:19.965] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[10:43:19.965] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[10:43:19.975] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[10:43:19.975] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[10:43:19.987] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[10:43:19.987] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[10:43:20.001] INFO: PixTestCmd::init()
[10:43:20.014] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[10:43:20.014] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[10:43:20.014] INFO: readGainPedestalParameters data/mybna/phCalibrationFitErr35_C0.dat .. data/mybna/phCalibrationFitErr35_C15.dat
[10:43:20.256] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[10:43:20.257] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[10:43:20.270] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[10:43:20.276] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[10:43:20.276] DEBUG: <PixTestHighRate.cc/init:L198> PixTestHighRate::init()
[10:43:20.276] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[10:43:20.301] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[10:43:20.301] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[10:43:20.301] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[10:43:20.301] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[10:43:20.301] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[10:43:20.310] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[10:43:20.310] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[10:43:20.334] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[10:43:20.334] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[10:43:20.334] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[10:43:20.334] INFO: readReadbackCal: data/mybna/readbackCal_C0.dat .. data/mybna/readbackCal_C15.dat
[10:43:20.343] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[10:43:20.358] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[10:43:20.359] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[10:43:20.359] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[10:43:20.359] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[10:43:20.371] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[10:43:20.371] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[10:43:30.417] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 1 -> source to value 02ma
[10:43:33.889] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 2 -> runseconds to value 60
[10:43:35.097] INFO: ######################################################################
[10:43:35.097] INFO: PixTestXray::doTest()
[10:43:35.097] INFO: ######################################################################
[10:43:35.097] INFO: ----------------------------------------------------------------------
[10:43:35.097] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[10:43:35.097] INFO: ----------------------------------------------------------------------
[10:43:36.069] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[10:43:46.842] INFO: run duration 10 seconds, buffer almost full (81%), pausing triggers.
[10:43:46.846] DEBUG: <PixTestXray.cc/processData:L740> Getting Event Buffer
[10:44:10.942] DEBUG: <PixTestXray.cc/processData:L758> Processing Data: 1061385 events.
[10:44:19.039] DEBUG: <PixTestXray.cc/processData:L809> # events read: 1061385, pixels seen in all events: 7516102
[10:44:19.315] INFO: Resuming triggers.
[10:44:30.099] INFO: run duration 21 seconds, buffer almost full (81%), pausing triggers.
[10:44:30.128] DEBUG: <PixTestXray.cc/processData:L740> Getting Event Buffer
[10:44:54.098] DEBUG: <PixTestXray.cc/processData:L758> Processing Data: 1062431 events.
[10:45:02.190] DEBUG: <PixTestXray.cc/processData:L809> # events read: 1062431, pixels seen in all events: 7501945
[10:45:02.460] INFO: Resuming triggers.
[10:45:13.246] INFO: run duration 32 seconds, buffer almost full (81%), pausing triggers.
[10:45:13.276] DEBUG: <PixTestXray.cc/processData:L740> Getting Event Buffer
[10:45:37.183] DEBUG: <PixTestXray.cc/processData:L758> Processing Data: 1062577 events.
[10:45:45.325] DEBUG: <PixTestXray.cc/processData:L809> # events read: 1062577, pixels seen in all events: 7500615
[10:45:45.600] INFO: Resuming triggers.
[10:45:56.402] INFO: run duration 43 seconds, buffer almost full (81%), pausing triggers.
[10:45:56.430] DEBUG: <PixTestXray.cc/processData:L740> Getting Event Buffer
[10:46:20.505] DEBUG: <PixTestXray.cc/processData:L758> Processing Data: 1064201 events.
[10:46:28.622] DEBUG: <PixTestXray.cc/processData:L809> # events read: 1064201, pixels seen in all events: 7503726
[10:46:28.896] INFO: Resuming triggers.
[10:46:39.690] INFO: run duration 53 seconds, buffer almost full (81%), pausing triggers.
[10:46:39.718] DEBUG: <PixTestXray.cc/processData:L740> Getting Event Buffer
[10:47:03.731] DEBUG: <PixTestXray.cc/processData:L758> Processing Data: 1063438 events.
[10:47:11.940] DEBUG: <PixTestXray.cc/processData:L809> # events read: 1063438, pixels seen in all events: 7489715
[10:47:12.020] INFO: Resuming triggers.
[10:47:18.155] INFO: data taking finished, elapsed time: 60 seconds.
[10:47:18.351] DEBUG: <PixTestXray.cc/processData:L740> Getting Event Buffer
[10:47:32.056] DEBUG: <PixTestXray.cc/processData:L758> Processing Data: 604372 events.
[10:47:36.643] DEBUG: <PixTestXray.cc/processData:L809> # events read: 604372, pixels seen in all events: 4257997
[10:47:36.758] INFO: PixTest:: pg_setup set to default.
[10:47:36.802] INFO: PixTestXray::doPhRun() done
[10:47:36.802] INFO: PixTestXray::doTest() done
[10:47:44.849] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[10:47:44.850] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 393.1mA
[10:47:44.850] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 470.3mA
[10:47:44.850] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.4 C
[10:47:44.850] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[10:47:44.850] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[10:47:44.850] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[10:47:44.851] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[10:47:44.851] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[10:47:44.851] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[10:47:44.851] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[10:47:44.851] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[10:47:44.851] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[10:47:44.851] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L245> PixTestHighRate dtor
[10:47:44.851] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[10:47:44.851] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[10:47:44.851] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[10:47:44.851] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[10:47:44.851] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[10:47:44.851] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[10:47:44.851] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[10:47:44.851] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[10:47:45.129] QUIET: Connection to board 58 closed.
[10:47:45.209] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrData_120.log
[10:35:13.896] INFO: *** Welcome to pxar ***
[10:35:13.896] INFO: *** Today: 2016/06/03
[10:35:13.919] INFO: *** Version: v1.9.0-805-geb36
[10:35:13.919] INFO: readRocDacs: data/mybna/dacParameters35_C0.dat .. data/mybna/dacParameters35_C15.dat
[10:35:13.920] INFO: readTbmDacs: data/mybna/tbmParameters_C0a.dat .. data/mybna/tbmParameters_C0b.dat
[10:35:13.920] INFO: readMaskFile: data/mybna/defaultMaskFile.dat
[10:35:13.920] INFO: readTrimFile: data/mybna/trimParameters35_C0.dat .. data/mybna/trimParameters35_C15.dat
[10:35:14.069] INFO: clk: 4
[10:35:14.069] INFO: ctr: 4
[10:35:14.069] INFO: sda: 19
[10:35:14.069] INFO: tin: 9
[10:35:14.069] INFO: level: 15
[10:35:14.069] INFO: triggerdelay: 0
[10:35:14.069] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[10:35:14.069] INFO: Log level: DEBUG
[10:35:14.080] QUIET: Connection to board DTB_WRPRHI opened.
[10:35:14.084] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 58
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WRPRHI
MAC address: 40D85511803A
Hostname: pixelDTB058
Comment:
------------------------------------------------------
[10:35:14.086] INFO: RPC call hashes of host and DTB match: 398089610
[10:35:15.686] INFO: DUT info:
[10:35:15.686] INFO: The DUT currently contains the following objects:
[10:35:15.686] INFO: 2 TBM Cores tbm08c (2 ON)
[10:35:15.686] INFO: TBM Core alpha (0): 7 registers set
[10:35:15.686] INFO: TBM Core beta (1): 7 registers set
[10:35:15.686] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:35:15.686] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:15.686] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:15.686] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:15.686] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:15.686] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:15.686] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:15.686] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:15.686] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:15.686] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:15.686] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:15.686] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:15.686] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:15.686] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:15.686] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:15.686] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:15.687] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:35:15.687] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[10:35:15.688] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:35:15.689] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:35:15.691] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 35270656
[10:35:15.691] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x26060e0
[10:35:15.691] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x23a8360
[10:35:15.691] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f57c5d94010
[10:35:15.691] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f57cbfff510
[10:35:15.691] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 35278848 fPxarMemory = 0x7f57c5d94010
[10:35:15.693] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 390.7mA
[10:35:15.694] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 468.7mA
[10:35:15.694] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.1 C
[10:35:16.183] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x29f0e30
[10:35:16.243] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[10:35:16.243] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[10:35:16.243] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[10:35:16.249] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[10:35:16.249] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[10:35:16.249] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[10:35:16.268] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[10:35:16.268] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[10:35:16.277] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[10:35:16.277] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[10:35:16.295] INFO: PixTestCmd::init()
[10:35:16.307] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[10:35:16.308] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[10:35:16.308] INFO: readGainPedestalParameters data/mybna/phCalibrationFitErr35_C0.dat .. data/mybna/phCalibrationFitErr35_C15.dat
[10:35:16.572] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[10:35:16.572] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[10:35:16.585] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[10:35:16.591] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[10:35:16.591] DEBUG: <PixTestHighRate.cc/init:L198> PixTestHighRate::init()
[10:35:16.591] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[10:35:16.616] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[10:35:16.616] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[10:35:16.616] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[10:35:16.616] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[10:35:16.616] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[10:35:16.622] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[10:35:16.622] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[10:35:16.648] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[10:35:16.648] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[10:35:16.648] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[10:35:16.648] INFO: readReadbackCal: data/mybna/readbackCal_C0.dat .. data/mybna/readbackCal_C15.dat
[10:35:16.657] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[10:35:16.665] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[10:35:16.665] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[10:35:16.665] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[10:35:16.665] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[10:35:16.686] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[10:35:16.687] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[10:35:22.841] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 1 -> source to value 06ma
[10:35:26.017] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 2 -> runseconds to value 60
[10:35:27.361] INFO: ######################################################################
[10:35:27.361] INFO: PixTestXray::doTest()
[10:35:27.361] INFO: ######################################################################
[10:35:27.361] INFO: ----------------------------------------------------------------------
[10:35:27.361] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[10:35:27.361] INFO: ----------------------------------------------------------------------
[10:35:28.333] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[10:35:35.138] INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[10:35:35.142] DEBUG: <PixTestXray.cc/processData:L740> Getting Event Buffer
[10:35:57.630] DEBUG: <PixTestXray.cc/processData:L758> Processing Data: 670495 events.
[10:36:10.674] DEBUG: <PixTestXray.cc/processData:L809> # events read: 670495, pixels seen in all events: 12208017
[10:36:10.864] INFO: Resuming triggers.
[10:36:17.672] INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[10:36:17.700] DEBUG: <PixTestXray.cc/processData:L740> Getting Event Buffer
[10:36:40.215] DEBUG: <PixTestXray.cc/processData:L758> Processing Data: 670586 events.
[10:36:52.919] DEBUG: <PixTestXray.cc/processData:L809> # events read: 670586, pixels seen in all events: 12204447
[10:36:53.077] INFO: Resuming triggers.
[10:36:59.883] INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[10:36:59.922] DEBUG: <PixTestXray.cc/processData:L740> Getting Event Buffer
[10:37:22.501] DEBUG: <PixTestXray.cc/processData:L758> Processing Data: 670516 events.
[10:37:34.624] DEBUG: <PixTestXray.cc/processData:L809> # events read: 670516, pixels seen in all events: 12206406
[10:37:34.790] INFO: Resuming triggers.
[10:37:41.594] INFO: run duration 27 seconds, buffer almost full (81%), pausing triggers.
[10:37:41.633] DEBUG: <PixTestXray.cc/processData:L740> Getting Event Buffer
[10:38:04.140] DEBUG: <PixTestXray.cc/processData:L758> Processing Data: 670232 events.
[10:38:16.240] DEBUG: <PixTestXray.cc/processData:L809> # events read: 670232, pixels seen in all events: 12208763
[10:38:16.406] INFO: Resuming triggers.
[10:38:23.211] INFO: run duration 33 seconds, buffer almost full (81%), pausing triggers.
[10:38:23.242] DEBUG: <PixTestXray.cc/processData:L740> Getting Event Buffer
[10:38:45.769] DEBUG: <PixTestXray.cc/processData:L758> Processing Data: 670328 events.
[10:38:57.900] DEBUG: <PixTestXray.cc/processData:L809> # events read: 670328, pixels seen in all events: 12208886
[10:38:58.064] INFO: Resuming triggers.
[10:39:04.868] INFO: run duration 40 seconds, buffer almost full (81%), pausing triggers.
[10:39:04.898] DEBUG: <PixTestXray.cc/processData:L740> Getting Event Buffer
[10:39:27.356] DEBUG: <PixTestXray.cc/processData:L758> Processing Data: 670313 events.
[10:39:39.457] DEBUG: <PixTestXray.cc/processData:L809> # events read: 670313, pixels seen in all events: 12210195
[10:39:39.620] INFO: Resuming triggers.
[10:39:46.429] INFO: run duration 47 seconds, buffer almost full (81%), pausing triggers.
[10:39:46.457] DEBUG: <PixTestXray.cc/processData:L740> Getting Event Buffer
[10:40:08.993] DEBUG: <PixTestXray.cc/processData:L758> Processing Data: 670675 events.
[10:40:21.014] DEBUG: <PixTestXray.cc/processData:L809> # events read: 670675, pixels seen in all events: 12204568
[10:40:21.180] INFO: Resuming triggers.
[10:40:27.984] INFO: run duration 54 seconds, buffer almost full (81%), pausing triggers.
[10:40:28.014] DEBUG: <PixTestXray.cc/processData:L740> Getting Event Buffer
[10:40:50.482] DEBUG: <PixTestXray.cc/processData:L758> Processing Data: 670332 events.
[10:41:02.510] DEBUG: <PixTestXray.cc/processData:L809> # events read: 670332, pixels seen in all events: 12208807
[10:41:02.678] INFO: Resuming triggers.
[10:41:08.313] INFO: data taking finished, elapsed time: 60 seconds.
[10:41:08.509] DEBUG: <PixTestXray.cc/processData:L740> Getting Event Buffer
[10:41:27.164] DEBUG: <PixTestXray.cc/processData:L758> Processing Data: 555062 events.
[10:41:37.109] DEBUG: <PixTestXray.cc/processData:L809> # events read: 555062, pixels seen in all events: 10108223
[10:41:37.233] INFO: PixTest:: pg_setup set to default.
[10:41:37.273] INFO: PixTestXray::doPhRun() done
[10:41:37.274] INFO: PixTestXray::doTest() done
[10:43:11.841] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[10:43:11.841] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 393.1mA
[10:43:11.842] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 469.5mA
[10:43:11.842] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.2 C
[10:43:11.842] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[10:43:11.842] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[10:43:11.842] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[10:43:11.842] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[10:43:11.843] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[10:43:11.843] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[10:43:11.843] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[10:43:11.843] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[10:43:11.843] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[10:43:11.843] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L245> PixTestHighRate dtor
[10:43:11.843] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[10:43:11.843] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[10:43:11.843] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[10:43:11.843] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[10:43:11.844] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[10:43:11.844] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[10:43:11.844] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[10:43:11.844] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[10:43:12.156] QUIET: Connection to board 58 closed.
[10:43:12.236] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrEff_40.log
[10:30:13.430] INFO: *** Welcome to pxar ***
[10:30:13.430] INFO: *** Today: 2016/06/03
[10:30:13.456] INFO: *** Version: v1.9.0-805-geb36
[10:30:13.456] INFO: readRocDacs: data/mybna/dacParameters35_C0.dat .. data/mybna/dacParameters35_C15.dat
[10:30:13.457] INFO: readTbmDacs: data/mybna/tbmParameters_C0a.dat .. data/mybna/tbmParameters_C0b.dat
[10:30:13.457] INFO: readMaskFile: data/mybna/defaultMaskFile.dat
[10:30:13.457] INFO: readTrimFile: data/mybna/trimParameters35_C0.dat .. data/mybna/trimParameters35_C15.dat
[10:30:13.606] INFO: clk: 4
[10:30:13.606] INFO: ctr: 4
[10:30:13.606] INFO: sda: 19
[10:30:13.606] INFO: tin: 9
[10:30:13.606] INFO: level: 15
[10:30:13.606] INFO: triggerdelay: 0
[10:30:13.606] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[10:30:13.606] INFO: Log level: DEBUG
[10:30:13.618] QUIET: Connection to board DTB_WRPRHI opened.
[10:30:13.622] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 58
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WRPRHI
MAC address: 40D85511803A
Hostname: pixelDTB058
Comment:
------------------------------------------------------
[10:30:13.625] INFO: RPC call hashes of host and DTB match: 398089610
[10:30:15.224] INFO: DUT info:
[10:30:15.224] INFO: The DUT currently contains the following objects:
[10:30:15.224] INFO: 2 TBM Cores tbm08c (2 ON)
[10:30:15.224] INFO: TBM Core alpha (0): 7 registers set
[10:30:15.224] INFO: TBM Core beta (1): 7 registers set
[10:30:15.224] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:30:15.224] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:15.224] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:15.224] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:15.224] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:15.224] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:15.224] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:15.224] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:15.224] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:15.224] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:15.224] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:15.224] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:15.225] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:15.225] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:15.225] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:15.225] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:15.225] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[10:30:15.225] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[10:30:15.226] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:30:15.227] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:30:15.229] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 37462016
[10:30:15.230] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x10700e0
[10:30:15.230] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0xe12360
[10:30:15.230] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f9e5d393010
[10:30:15.230] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f9e635fe510
[10:30:15.230] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 37470208 fPxarMemory = 0x7f9e5d393010
[10:30:15.231] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 390.7mA
[10:30:15.232] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 468.7mA
[10:30:15.232] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.4 C
[10:30:15.723] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x145adc0
[10:30:15.786] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[10:30:15.786] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[10:30:15.786] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[10:30:15.792] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[10:30:15.792] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[10:30:15.792] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[10:30:15.802] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[10:30:15.802] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[10:30:15.824] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[10:30:15.824] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[10:30:15.836] INFO: PixTestCmd::init()
[10:30:15.841] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[10:30:15.841] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[10:30:15.841] INFO: readGainPedestalParameters data/mybna/phCalibrationFitErr35_C0.dat .. data/mybna/phCalibrationFitErr35_C15.dat
[10:30:16.090] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[10:30:16.090] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[10:30:16.104] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[10:30:16.109] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[10:30:16.110] DEBUG: <PixTestHighRate.cc/init:L198> PixTestHighRate::init()
[10:30:16.110] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[10:30:16.135] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[10:30:16.135] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[10:30:16.135] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[10:30:16.135] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[10:30:16.135] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[10:30:16.141] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[10:30:16.141] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[10:30:16.156] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[10:30:16.156] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[10:30:16.156] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[10:30:16.156] INFO: readReadbackCal: data/mybna/readbackCal_C0.dat .. data/mybna/readbackCal_C15.dat
[10:30:16.170] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[10:30:16.178] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[10:30:16.178] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[10:30:16.178] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[10:30:16.178] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[10:30:16.199] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[10:30:16.199] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[10:30:21.908] INFO: ######################################################################
[10:30:21.908] INFO: PixTestAlive::doTest()
[10:30:21.908] INFO: ######################################################################
[10:30:21.911] INFO: ----------------------------------------------------------------------
[10:30:21.911] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:30:21.911] INFO: ----------------------------------------------------------------------
[10:30:21.913] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:30:22.290] INFO: Expecting 41600 events.
[10:30:26.555] INFO: 41600 events read in total (3547ms).
[10:30:26.703] INFO: Test took 4789ms.
[10:30:26.712] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:30:26.712] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66557
[10:30:26.712] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists PixelAlive_C0 .. PixelAlive_C15
[10:30:26.988] INFO: PixTestAlive::aliveTest() done
[10:30:26.988] INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 2 0 0 0 0 0 0 0
[10:30:26.988] DEBUG: <PixTestAlive.cc/aliveTest:L199> number of red-efficiency pixels: 37 23 38 53 51 58 49 45 58 61 47 39 41 32 20 25
[10:30:27.010] INFO: ----------------------------------------------------------------------
[10:30:27.010] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:30:27.010] INFO: ----------------------------------------------------------------------
[10:30:27.012] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:30:27.386] INFO: Expecting 41600 events.
[10:30:30.444] INFO: 41600 events read in total (2342ms).
[10:30:30.444] INFO: Test took 3432ms.
[10:30:30.444] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:30:30.444] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 0
[10:30:30.444] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists MaskTest_C0 .. MaskTest_C15
[10:30:30.445] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[10:30:30.869] INFO: PixTestAlive::maskTest() done
[10:30:30.869] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:30:30.887] INFO: ----------------------------------------------------------------------
[10:30:30.887] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:30:30.887] INFO: ----------------------------------------------------------------------
[10:30:30.889] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:30:31.264] INFO: Expecting 41600 events.
[10:30:35.498] INFO: 41600 events read in total (3519ms).
[10:30:35.500] INFO: Test took 4611ms.
[10:30:35.510] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:30:35.510] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66556
[10:30:35.510] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists AddressDecodingTest_C0 .. AddressDecodingTest_C15
[10:30:35.882] INFO: PixTestAlive::addressDecodingTest() done
[10:30:35.882] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:30:35.882] INFO: PixTestAlive::doTest() done, duration: 13 seconds
[10:30:45.744] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): caldelscan
[10:30:45.745] DEBUG: <PixTestHighRate.cc/runCommand:L157> running command: caldelscan
[10:30:45.745] INFO: ----------------------------------------------------------------------
[10:30:45.745] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[10:30:45.745] INFO: ----------------------------------------------------------------------
[10:30:45.884] INFO: Expecting 768 events.
[10:30:47.016] INFO: 768 events read in total (417ms).
[10:30:47.017] INFO: Test took 1267ms.
[10:30:47.022] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:30:47.820] INFO: Expecting 41600 events.
[10:30:51.128] INFO: 41600 events read in total (2781ms).
[10:30:51.133] INFO: Test took 4111ms.
[10:30:51.242] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:30:51.242] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 613484
[10:30:51.242] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step0_C0 .. HR_xeff_CalDelScan_step0_C15
[10:30:51.243] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:30:51.290] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:30:51.955] INFO: Expecting 41600 events.
[10:30:55.368] INFO: 41600 events read in total (2887ms).
[10:30:55.375] INFO: Test took 4085ms.
[10:30:55.482] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:30:55.482] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 623156
[10:30:55.482] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step1_C0 .. HR_xeff_CalDelScan_step1_C15
[10:30:55.482] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:30:55.532] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:30:56.197] INFO: Expecting 41600 events.
[10:30:59.682] INFO: 41600 events read in total (2959ms).
[10:30:59.686] INFO: Test took 4154ms.
[10:30:59.792] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:30:59.792] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 627188
[10:30:59.792] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step2_C0 .. HR_xeff_CalDelScan_step2_C15
[10:30:59.792] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:30:59.842] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:31:00.507] INFO: Expecting 41600 events.
[10:31:04.026] INFO: 41600 events read in total (2993ms).
[10:31:04.030] INFO: Test took 4188ms.
[10:31:04.137] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:31:04.137] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 627384
[10:31:04.137] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step3_C0 .. HR_xeff_CalDelScan_step3_C15
[10:31:04.137] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:31:04.187] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:31:04.852] INFO: Expecting 41600 events.
[10:31:08.349] INFO: 41600 events read in total (2970ms).
[10:31:08.353] INFO: Test took 4166ms.
[10:31:08.460] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:31:08.461] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 628212
[10:31:08.461] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step4_C0 .. HR_xeff_CalDelScan_step4_C15
[10:31:08.461] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:31:08.511] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:31:09.175] INFO: Expecting 41600 events.
[10:31:12.673] INFO: 41600 events read in total (2971ms).
[10:31:12.678] INFO: Test took 4167ms.
[10:31:12.786] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:31:12.786] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 628409
[10:31:12.786] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step5_C0 .. HR_xeff_CalDelScan_step5_C15
[10:31:12.786] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:31:12.835] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:31:13.500] INFO: Expecting 41600 events.
[10:31:17.012] INFO: 41600 events read in total (2985ms).
[10:31:17.016] INFO: Test took 4181ms.
[10:31:17.123] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:31:17.123] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 628343
[10:31:17.123] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step6_C0 .. HR_xeff_CalDelScan_step6_C15
[10:31:17.123] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:31:17.173] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:31:17.838] INFO: Expecting 41600 events.
[10:31:21.355] INFO: 41600 events read in total (2990ms).
[10:31:21.360] INFO: Test took 4187ms.
[10:31:21.466] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:31:21.466] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 628032
[10:31:21.466] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step7_C0 .. HR_xeff_CalDelScan_step7_C15
[10:31:21.466] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:31:21.515] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:31:22.180] INFO: Expecting 41600 events.
[10:31:25.699] INFO: 41600 events read in total (2992ms).
[10:31:25.703] INFO: Test took 4188ms.
[10:31:25.811] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:31:25.811] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 626916
[10:31:25.811] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step8_C0 .. HR_xeff_CalDelScan_step8_C15
[10:31:25.812] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:31:25.861] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:31:26.526] INFO: Expecting 41600 events.
[10:31:30.044] INFO: 41600 events read in total (2991ms).
[10:31:30.048] INFO: Test took 4187ms.
[10:31:30.154] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:31:30.154] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 627801
[10:31:30.154] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step9_C0 .. HR_xeff_CalDelScan_step9_C15
[10:31:30.154] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:31:30.204] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:31:30.869] INFO: Expecting 41600 events.
[10:31:34.391] INFO: 41600 events read in total (2996ms).
[10:31:34.395] INFO: Test took 4191ms.
[10:31:34.501] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:31:34.501] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 627251
[10:31:34.501] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step10_C0 .. HR_xeff_CalDelScan_step10_C15
[10:31:34.502] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:31:34.551] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:31:35.216] INFO: Expecting 41600 events.
[10:31:38.744] INFO: 41600 events read in total (3002ms).
[10:31:38.749] INFO: Test took 4198ms.
[10:31:38.857] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:31:38.857] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 626127
[10:31:38.857] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step11_C0 .. HR_xeff_CalDelScan_step11_C15
[10:31:38.858] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:31:38.907] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:31:39.574] INFO: Expecting 41600 events.
[10:31:43.094] INFO: 41600 events read in total (2993ms).
[10:31:43.099] INFO: Test took 4192ms.
[10:31:43.205] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:31:43.205] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 627920
[10:31:43.205] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step12_C0 .. HR_xeff_CalDelScan_step12_C15
[10:31:43.205] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:31:43.255] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:31:43.920] INFO: Expecting 41600 events.
[10:31:47.426] INFO: 41600 events read in total (2979ms).
[10:31:47.431] INFO: Test took 4176ms.
[10:31:47.538] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:31:47.538] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 627484
[10:31:47.538] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step13_C0 .. HR_xeff_CalDelScan_step13_C15
[10:31:47.539] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:31:47.588] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:31:48.253] INFO: Expecting 41600 events.
[10:31:51.774] INFO: 41600 events read in total (2994ms).
[10:31:51.778] INFO: Test took 4190ms.
[10:31:51.883] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:31:51.883] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 627921
[10:31:51.883] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step14_C0 .. HR_xeff_CalDelScan_step14_C15
[10:31:51.884] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:31:51.933] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:31:52.598] INFO: Expecting 41600 events.
[10:31:56.111] INFO: 41600 events read in total (2986ms).
[10:31:56.116] INFO: Test took 4183ms.
[10:31:56.222] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:31:56.223] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 628063
[10:31:56.223] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step15_C0 .. HR_xeff_CalDelScan_step15_C15
[10:31:56.223] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:31:56.273] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:31:56.938] INFO: Expecting 41600 events.
[10:32:00.452] INFO: 41600 events read in total (2987ms).
[10:32:00.457] INFO: Test took 4184ms.
[10:32:00.565] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:32:00.565] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 626688
[10:32:00.565] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step16_C0 .. HR_xeff_CalDelScan_step16_C15
[10:32:00.565] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:32:00.617] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:32:01.284] INFO: Expecting 41600 events.
[10:32:04.799] INFO: 41600 events read in total (2989ms).
[10:32:04.803] INFO: Test took 4186ms.
[10:32:04.909] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:32:04.909] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 625457
[10:32:04.909] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step17_C0 .. HR_xeff_CalDelScan_step17_C15
[10:32:04.909] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:32:04.959] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:32:05.624] INFO: Expecting 41600 events.
[10:32:09.142] INFO: 41600 events read in total (2991ms).
[10:32:09.146] INFO: Test took 4187ms.
[10:32:09.253] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:32:09.253] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 627333
[10:32:09.253] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step18_C0 .. HR_xeff_CalDelScan_step18_C15
[10:32:09.253] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:32:09.303] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:32:09.968] INFO: Expecting 41600 events.
[10:32:13.378] INFO: 41600 events read in total (2883ms).
[10:32:13.383] INFO: Test took 4080ms.
[10:32:13.488] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:32:13.488] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 622891
[10:32:13.488] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step19_C0 .. HR_xeff_CalDelScan_step19_C15
[10:32:13.488] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:32:13.761] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 0: caldel = 174 eff = 0.999423
[10:32:13.761] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 1: caldel = 168 eff = 0.999543
[10:32:13.761] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 2: caldel = 179 eff = 0.999111
[10:32:13.762] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 3: caldel = 191 eff = 0.998269
[10:32:13.762] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 4: caldel = 172 eff = 0.997957
[10:32:13.762] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 5: caldel = 176 eff = 0.998197
[10:32:13.762] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 6: caldel = 171 eff = 0.998389
[10:32:13.763] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 7: caldel = 133 eff = 0.998438
[10:32:13.763] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 8: caldel = 163 eff = 0.997332
[10:32:13.763] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 9: caldel = 149 eff = 0.998053
[10:32:13.763] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 10: caldel = 160 eff = 0.998029
[10:32:13.764] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 11: caldel = 170 eff = 0.998197
[10:32:13.764] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 12: caldel = 172 eff = 0.998245
[10:32:13.764] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 13: caldel = 183 eff = 0.998966
[10:32:13.764] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 14: caldel = 176 eff = 0.999639
[10:32:13.765] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 15: caldel = 163 eff = 0.999519
[10:32:23.209] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): xpixelalive
[10:32:23.209] DEBUG: <PixTestHighRate.cc/runCommand:L157> running command: xpixelalive
[10:32:23.209] INFO: ----------------------------------------------------------------------
[10:32:23.209] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[10:32:23.209] INFO: ----------------------------------------------------------------------
[10:32:23.209] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L451> old set: clk: 4
[10:32:23.209] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L451> old set: ctr: 4
[10:32:23.209] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L451> old set: sda: 19
[10:32:23.209] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L451> old set: tin: 9
[10:32:23.209] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L451> old set: level: 15
[10:32:23.209] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L451> old set: triggerdelay: 0
[10:32:23.209] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L467> setting: clk: 4
[10:32:23.209] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L467> setting: ctr: 4
[10:32:23.209] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L467> setting: sda: 19
[10:32:23.209] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L467> setting: tin: 9
[10:32:23.209] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L467> setting: level: 15
[10:32:23.209] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L467> setting: triggerdelay: 20
[10:32:23.225] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:32:23.890] INFO: Expecting 208000 events.
[10:32:37.669] INFO: 208000 events read in total (13252ms).
[10:32:37.684] INFO: Test took 14459ms.
[10:32:38.189] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:32:38.189] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 2841497
[10:32:38.189] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists highRate_C0 .. highRate_C15
[10:32:38.190] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:32:38.604] INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 3 0 0 0 0 0 0 0
[10:32:38.604] INFO: number of red-efficiency pixels: 141 108 220 346 373 348 339 402 383 450 373 440 385 203 120 142
[10:32:38.604] INFO: number of X-ray hits detected: 115861 81190 133107 203793 217616 215398 208517 195372 214050 225476 222449 212531 211619 139545 78385 100032
[10:32:38.604] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[10:32:38.604] INFO: number of Vcal hits detected: 207853 207890 207769 207639 207552 207633 207641 207560 207432 207524 207605 207528 207588 207787 207874 207852
[10:32:38.604] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.9 99.9 99.9
[10:32:38.604] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.7 99.8 99.8 99.8 99.8 99.9 99.9 99.9
[10:32:38.604] INFO: X-ray hit rate [MHz/cm2]: 34.0 23.8 39.0 59.7 63.8 63.1 61.1 57.3 62.7 66.1 65.2 62.3 62.0 40.9 23.0 29.3
[10:32:38.604] INFO: PixTestHighRate::doXPixelAlive() done
[10:32:38.652] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L586> resetting: clk: 4
[10:32:38.652] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L586> resetting: ctr: 4
[10:32:38.652] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L586> resetting: sda: 19
[10:32:38.652] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L586> resetting: tin: 9
[10:32:38.652] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L586> resetting: level: 15
[10:32:38.652] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L586> resetting: triggerdelay: 0
[10:32:38.652] INFO: PixTest:: pg_setup set to default.
[10:32:42.144] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[10:32:42.145] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 393.1mA
[10:32:42.146] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 470.3mA
[10:32:42.146] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.2 C
[10:32:42.146] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[10:32:42.146] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[10:32:42.146] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[10:32:42.146] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[10:32:42.146] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[10:32:42.146] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[10:32:42.146] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[10:32:42.147] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[10:32:42.147] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[10:32:42.147] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L245> PixTestHighRate dtor
[10:32:42.224] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[10:32:42.224] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[10:32:42.233] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[10:32:42.233] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[10:32:42.233] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[10:32:42.233] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[10:32:42.233] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[10:32:42.233] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[10:32:42.235] QUIET: Connection to board 58 closed.
[10:32:42.316] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrEff_80.log
[10:27:35.380] INFO: *** Welcome to pxar ***
[10:27:35.380] INFO: *** Today: 2016/06/03
[10:27:35.402] INFO: *** Version: v1.9.0-805-geb36
[10:27:35.403] INFO: readRocDacs: data/mybna/dacParameters35_C0.dat .. data/mybna/dacParameters35_C15.dat
[10:27:35.404] INFO: readTbmDacs: data/mybna/tbmParameters_C0a.dat .. data/mybna/tbmParameters_C0b.dat
[10:27:35.404] INFO: readMaskFile: data/mybna/defaultMaskFile.dat
[10:27:35.404] INFO: readTrimFile: data/mybna/trimParameters35_C0.dat .. data/mybna/trimParameters35_C15.dat
[10:27:35.552] INFO: clk: 4
[10:27:35.552] INFO: ctr: 4
[10:27:35.552] INFO: sda: 19
[10:27:35.552] INFO: tin: 9
[10:27:35.552] INFO: level: 15
[10:27:35.552] INFO: triggerdelay: 0
[10:27:35.553] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[10:27:35.553] INFO: Log level: DEBUG
[10:27:35.565] QUIET: Connection to board DTB_WRPRHI opened.
[10:27:35.569] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 58
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WRPRHI
MAC address: 40D85511803A
Hostname: pixelDTB058
Comment:
------------------------------------------------------
[10:27:35.572] INFO: RPC call hashes of host and DTB match: 398089610
[10:27:37.170] INFO: DUT info:
[10:27:37.171] INFO: The DUT currently contains the following objects:
[10:27:37.171] INFO: 2 TBM Cores tbm08c (2 ON)
[10:27:37.171] INFO: TBM Core alpha (0): 7 registers set
[10:27:37.171] INFO: TBM Core beta (1): 7 registers set
[10:27:37.171] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:27:37.171] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:27:37.171] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:27:37.171] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:27:37.171] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:27:37.171] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:27:37.171] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:27:37.171] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:27:37.171] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:27:37.171] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:27:37.171] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:27:37.171] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:27:37.171] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:27:37.171] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:27:37.171] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:27:37.171] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:27:37.171] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:27:37.171] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[10:27:37.171] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:27:37.171] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:27:37.171] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:27:37.171] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[10:27:37.171] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[10:27:37.171] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:27:37.171] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[10:27:37.171] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[10:27:37.171] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:27:37.171] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[10:27:37.171] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[10:27:37.171] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:27:37.171] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:27:37.171] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[10:27:37.172] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[10:27:37.173] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[10:27:37.174] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[10:27:37.174] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[10:27:37.174] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[10:27:37.174] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[10:27:37.174] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[10:27:37.174] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[10:27:37.174] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[10:27:37.174] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:27:37.174] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:27:37.176] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 33468416
[10:27:37.176] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x21840e0
[10:27:37.176] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x1f26360
[10:27:37.176] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7fa73dd94010
[10:27:37.176] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7fa743fff510
[10:27:37.176] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 33476608 fPxarMemory = 0x7fa73dd94010
[10:27:37.177] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 390.7mA
[10:27:37.178] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 468.7mA
[10:27:37.178] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.2 C
[10:27:37.668] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x256ed70
[10:27:37.728] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[10:27:37.729] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[10:27:37.729] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[10:27:37.734] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[10:27:37.734] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[10:27:37.734] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[10:27:37.745] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[10:27:37.745] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[10:27:37.758] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[10:27:37.758] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[10:27:37.775] INFO: PixTestCmd::init()
[10:27:37.783] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[10:27:37.783] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[10:27:37.783] INFO: readGainPedestalParameters data/mybna/phCalibrationFitErr35_C0.dat .. data/mybna/phCalibrationFitErr35_C15.dat
[10:27:38.027] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[10:27:38.027] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[10:27:38.041] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[10:27:38.049] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[10:27:38.049] DEBUG: <PixTestHighRate.cc/init:L198> PixTestHighRate::init()
[10:27:38.049] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[10:27:38.073] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[10:27:38.073] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[10:27:38.073] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[10:27:38.073] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[10:27:38.073] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[10:27:38.079] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[10:27:38.080] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[10:27:38.102] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[10:27:38.102] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[10:27:38.102] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[10:27:38.102] INFO: readReadbackCal: data/mybna/readbackCal_C0.dat .. data/mybna/readbackCal_C15.dat
[10:27:38.111] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[10:27:38.120] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[10:27:38.120] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[10:27:38.120] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[10:27:38.120] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[10:27:38.141] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[10:27:38.141] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[10:27:47.516] INFO: ######################################################################
[10:27:47.516] INFO: PixTestAlive::doTest()
[10:27:47.516] INFO: ######################################################################
[10:27:47.519] INFO: ----------------------------------------------------------------------
[10:27:47.519] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:27:47.519] INFO: ----------------------------------------------------------------------
[10:27:47.521] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:27:47.897] INFO: Expecting 41600 events.
[10:27:52.176] INFO: 41600 events read in total (3561ms).
[10:27:52.320] INFO: Test took 4799ms.
[10:27:52.330] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:27:52.330] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66556
[10:27:52.330] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists PixelAlive_C0 .. PixelAlive_C15
[10:27:52.607] INFO: PixTestAlive::aliveTest() done
[10:27:52.607] INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 3 0 0 0 0 0 0 0
[10:27:52.607] DEBUG: <PixTestAlive.cc/aliveTest:L199> number of red-efficiency pixels: 53 39 33 64 70 89 62 73 88 85 82 68 66 47 38 41
[10:27:52.630] INFO: ----------------------------------------------------------------------
[10:27:52.630] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:27:52.630] INFO: ----------------------------------------------------------------------
[10:27:52.632] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:27:53.006] INFO: Expecting 41600 events.
[10:27:56.061] INFO: 41600 events read in total (2339ms).
[10:27:56.062] INFO: Test took 3430ms.
[10:27:56.062] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:27:56.062] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 0
[10:27:56.062] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists MaskTest_C0 .. MaskTest_C15
[10:27:56.062] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[10:27:56.489] INFO: PixTestAlive::maskTest() done
[10:27:56.489] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:27:56.508] INFO: ----------------------------------------------------------------------
[10:27:56.508] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:27:56.508] INFO: ----------------------------------------------------------------------
[10:27:56.510] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:27:56.885] INFO: Expecting 41600 events.
[10:28:01.128] INFO: 41600 events read in total (3528ms).
[10:28:01.130] INFO: Test took 4620ms.
[10:28:01.141] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:28:01.141] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66558
[10:28:01.141] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists AddressDecodingTest_C0 .. AddressDecodingTest_C15
[10:28:01.510] INFO: PixTestAlive::addressDecodingTest() done
[10:28:01.510] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:28:01.511] INFO: PixTestAlive::doTest() done, duration: 13 seconds
[10:28:03.872] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): caldelscan
[10:28:03.873] DEBUG: <PixTestHighRate.cc/runCommand:L157> running command: caldelscan
[10:28:03.873] INFO: ----------------------------------------------------------------------
[10:28:03.873] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[10:28:03.873] INFO: ----------------------------------------------------------------------
[10:28:04.013] INFO: Expecting 768 events.
[10:28:05.145] INFO: 768 events read in total (417ms).
[10:28:05.145] INFO: Test took 1267ms.
[10:28:05.151] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:28:05.948] INFO: Expecting 41600 events.
[10:28:09.560] INFO: 41600 events read in total (3085ms).
[10:28:09.565] INFO: Test took 4414ms.
[10:28:09.717] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:28:09.717] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 882811
[10:28:09.717] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step0_C0 .. HR_xeff_CalDelScan_step0_C15
[10:28:09.717] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:28:09.782] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:28:10.447] INFO: Expecting 41600 events.
[10:28:14.190] INFO: 41600 events read in total (3216ms).
[10:28:14.196] INFO: Test took 4414ms.
[10:28:14.341] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:28:14.341] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 895244
[10:28:14.341] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step1_C0 .. HR_xeff_CalDelScan_step1_C15
[10:28:14.342] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:28:14.410] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:28:15.075] INFO: Expecting 41600 events.
[10:28:18.917] INFO: 41600 events read in total (3316ms).
[10:28:18.923] INFO: Test took 4513ms.
[10:28:19.071] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:28:19.071] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 898624
[10:28:19.071] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step2_C0 .. HR_xeff_CalDelScan_step2_C15
[10:28:19.072] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:28:19.140] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:28:19.806] INFO: Expecting 41600 events.
[10:28:23.639] INFO: 41600 events read in total (3306ms).
[10:28:23.644] INFO: Test took 4504ms.
[10:28:23.794] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:28:23.794] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 900970
[10:28:23.794] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step3_C0 .. HR_xeff_CalDelScan_step3_C15
[10:28:23.794] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:28:23.863] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:28:24.528] INFO: Expecting 41600 events.
[10:28:28.364] INFO: 41600 events read in total (3309ms).
[10:28:28.369] INFO: Test took 4506ms.
[10:28:28.519] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:28:28.519] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 899042
[10:28:28.519] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step4_C0 .. HR_xeff_CalDelScan_step4_C15
[10:28:28.520] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:28:28.588] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:28:29.253] INFO: Expecting 41600 events.
[10:28:33.053] INFO: 41600 events read in total (3273ms).
[10:28:33.058] INFO: Test took 4471ms.
[10:28:33.208] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:28:33.208] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 899799
[10:28:33.208] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step5_C0 .. HR_xeff_CalDelScan_step5_C15
[10:28:33.209] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:28:33.278] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:28:33.944] INFO: Expecting 41600 events.
[10:28:37.764] INFO: 41600 events read in total (3294ms).
[10:28:37.769] INFO: Test took 4491ms.
[10:28:37.917] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:28:37.917] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 902300
[10:28:37.918] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step6_C0 .. HR_xeff_CalDelScan_step6_C15
[10:28:37.918] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:28:37.986] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:28:38.651] INFO: Expecting 41600 events.
[10:28:42.501] INFO: 41600 events read in total (3323ms).
[10:28:42.507] INFO: Test took 4521ms.
[10:28:42.654] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:28:42.654] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 900923
[10:28:42.654] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step7_C0 .. HR_xeff_CalDelScan_step7_C15
[10:28:42.654] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:28:42.723] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:28:43.388] INFO: Expecting 41600 events.
[10:28:47.246] INFO: 41600 events read in total (3331ms).
[10:28:47.252] INFO: Test took 4529ms.
[10:28:47.399] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:28:47.399] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 899666
[10:28:47.399] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step8_C0 .. HR_xeff_CalDelScan_step8_C15
[10:28:47.399] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:28:47.468] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:28:48.133] INFO: Expecting 41600 events.
[10:28:51.982] INFO: 41600 events read in total (3322ms).
[10:28:51.988] INFO: Test took 4520ms.
[10:28:52.135] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:28:52.135] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 900228
[10:28:52.135] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step9_C0 .. HR_xeff_CalDelScan_step9_C15
[10:28:52.135] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:28:52.204] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:28:52.870] INFO: Expecting 41600 events.
[10:28:56.707] INFO: 41600 events read in total (3310ms).
[10:28:56.713] INFO: Test took 4509ms.
[10:28:56.860] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:28:56.861] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 900350
[10:28:56.861] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step10_C0 .. HR_xeff_CalDelScan_step10_C15
[10:28:56.861] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:28:56.930] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:28:57.595] INFO: Expecting 41600 events.
[10:29:01.479] INFO: 41600 events read in total (3358ms).
[10:29:01.484] INFO: Test took 4554ms.
[10:29:01.632] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:01.632] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 900080
[10:29:01.632] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step11_C0 .. HR_xeff_CalDelScan_step11_C15
[10:29:01.632] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:29:01.702] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:29:02.369] INFO: Expecting 41600 events.
[10:29:06.220] INFO: 41600 events read in total (3324ms).
[10:29:06.227] INFO: Test took 4525ms.
[10:29:06.380] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:06.380] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 900180
[10:29:06.380] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step12_C0 .. HR_xeff_CalDelScan_step12_C15
[10:29:06.381] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:29:06.449] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:29:07.115] INFO: Expecting 41600 events.
[10:29:10.985] INFO: 41600 events read in total (3344ms).
[10:29:10.990] INFO: Test took 4541ms.
[10:29:11.138] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:11.138] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 902045
[10:29:11.138] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step13_C0 .. HR_xeff_CalDelScan_step13_C15
[10:29:11.138] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:29:11.207] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:29:11.873] INFO: Expecting 41600 events.
[10:29:15.712] INFO: 41600 events read in total (3313ms).
[10:29:15.718] INFO: Test took 4511ms.
[10:29:15.865] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:15.865] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 901147
[10:29:15.865] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step14_C0 .. HR_xeff_CalDelScan_step14_C15
[10:29:15.865] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:29:15.933] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:29:16.599] INFO: Expecting 41600 events.
[10:29:20.429] INFO: 41600 events read in total (3304ms).
[10:29:20.435] INFO: Test took 4502ms.
[10:29:20.583] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:20.583] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 901666
[10:29:20.583] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step15_C0 .. HR_xeff_CalDelScan_step15_C15
[10:29:20.583] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:29:20.651] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:29:21.317] INFO: Expecting 41600 events.
[10:29:25.145] INFO: 41600 events read in total (3302ms).
[10:29:25.150] INFO: Test took 4498ms.
[10:29:25.296] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:25.296] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 899322
[10:29:25.296] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step16_C0 .. HR_xeff_CalDelScan_step16_C15
[10:29:25.297] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:29:25.366] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:29:26.033] INFO: Expecting 41600 events.
[10:29:29.875] INFO: 41600 events read in total (3315ms).
[10:29:29.881] INFO: Test took 4515ms.
[10:29:30.026] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:30.026] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 901580
[10:29:30.026] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step17_C0 .. HR_xeff_CalDelScan_step17_C15
[10:29:30.027] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:29:30.095] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:29:30.760] INFO: Expecting 41600 events.
[10:29:34.585] INFO: 41600 events read in total (3298ms).
[10:29:34.591] INFO: Test took 4496ms.
[10:29:34.737] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:34.737] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 900594
[10:29:34.737] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step18_C0 .. HR_xeff_CalDelScan_step18_C15
[10:29:34.738] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:29:34.807] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:29:35.472] INFO: Expecting 41600 events.
[10:29:39.188] INFO: 41600 events read in total (3190ms).
[10:29:39.194] INFO: Test took 4387ms.
[10:29:39.340] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:39.340] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 895258
[10:29:39.340] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step19_C0 .. HR_xeff_CalDelScan_step19_C15
[10:29:39.341] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:29:39.630] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 0: caldel = 174 eff = 0.998774
[10:29:39.630] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 1: caldel = 171 eff = 0.999038
[10:29:39.631] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 2: caldel = 179 eff = 0.998077
[10:29:39.631] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 3: caldel = 190 eff = 0.995769
[10:29:39.631] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 4: caldel = 173 eff = 0.995192
[10:29:39.631] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 5: caldel = 176 eff = 0.99488
[10:29:39.632] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 6: caldel = 170 eff = 0.996106
[10:29:39.632] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 7: caldel = 145 eff = 0.996394
[10:29:39.632] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 8: caldel = 160 eff = 0.995481
[10:29:39.632] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 9: caldel = 153 eff = 0.995529
[10:29:39.633] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 10: caldel = 161 eff = 0.994808
[10:29:39.633] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 11: caldel = 172 eff = 0.996106
[10:29:39.633] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 12: caldel = 172 eff = 0.995409
[10:29:39.633] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 13: caldel = 183 eff = 0.997837
[10:29:39.634] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 14: caldel = 174 eff = 0.999255
[10:29:39.634] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 15: caldel = 150 eff = 0.998918
[10:29:44.160] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): xpixelalive
[10:29:44.160] DEBUG: <PixTestHighRate.cc/runCommand:L157> running command: xpixelalive
[10:29:44.161] INFO: ----------------------------------------------------------------------
[10:29:44.161] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[10:29:44.161] INFO: ----------------------------------------------------------------------
[10:29:44.161] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L451> old set: clk: 4
[10:29:44.161] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L451> old set: ctr: 4
[10:29:44.161] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L451> old set: sda: 19
[10:29:44.161] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L451> old set: tin: 9
[10:29:44.161] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L451> old set: level: 15
[10:29:44.161] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L451> old set: triggerdelay: 0
[10:29:44.161] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L467> setting: clk: 4
[10:29:44.161] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L467> setting: ctr: 4
[10:29:44.161] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L467> setting: sda: 19
[10:29:44.161] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L467> setting: tin: 9
[10:29:44.161] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L467> setting: level: 15
[10:29:44.161] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L467> setting: triggerdelay: 20
[10:29:44.176] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:29:44.846] INFO: Expecting 208000 events.
[10:30:00.878] INFO: 208000 events read in total (15505ms).
[10:30:00.900] INFO: Test took 16719ms.
[10:30:01.653] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:30:01.653] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 4185793
[10:30:01.653] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists highRate_C0 .. highRate_C15
[10:30:01.654] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:30:02.160] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 2 0 0 0 0 0 0 0
[10:30:02.160] INFO: number of red-efficiency pixels: 245 183 415 726 808 789 769 701 827 882 821 781 805 460 165 267
[10:30:02.160] INFO: number of X-ray hits detected: 170558 121509 197077 301976 323281 320309 309896 289545 319374 333473 328938 316241 314773 207528 116874 147883
[10:30:02.160] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[10:30:02.160] INFO: number of Vcal hits detected: 207748 207805 207534 207171 207000 207108 207129 207214 206905 206958 207046 207070 207077 207471 207825 207716
[10:30:02.161] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.8 99.6 99.6 99.6 99.6 99.6 99.6 99.5 99.6 99.6 99.6 99.8 99.9 99.9
[10:30:02.161] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.8 99.6 99.5 99.6 99.6 99.6 99.5 99.5 99.5 99.6 99.6 99.7 99.9 99.9
[10:30:02.161] INFO: X-ray hit rate [MHz/cm2]: 50.0 35.6 57.8 88.5 94.8 93.9 90.8 84.9 93.6 97.7 96.4 92.7 92.3 60.8 34.3 43.3
[10:30:02.161] INFO: PixTestHighRate::doXPixelAlive() done
[10:30:02.208] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L586> resetting: clk: 4
[10:30:02.208] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L586> resetting: ctr: 4
[10:30:02.208] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L586> resetting: sda: 19
[10:30:02.208] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L586> resetting: tin: 9
[10:30:02.208] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L586> resetting: level: 15
[10:30:02.208] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L586> resetting: triggerdelay: 0
[10:30:02.208] INFO: PixTest:: pg_setup set to default.
[10:30:08.425] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[10:30:08.425] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 392.3mA
[10:30:08.426] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 470.3mA
[10:30:08.426] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.2 C
[10:30:08.426] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[10:30:08.426] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[10:30:08.426] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[10:30:08.426] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[10:30:08.426] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[10:30:08.426] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[10:30:08.427] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[10:30:08.427] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[10:30:08.427] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[10:30:08.427] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L245> PixTestHighRate dtor
[10:30:08.505] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[10:30:08.505] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[10:30:08.514] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[10:30:08.514] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[10:30:08.514] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[10:30:08.514] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[10:30:08.514] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[10:30:08.514] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[10:30:08.517] QUIET: Connection to board 58 closed.
[10:30:08.596] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrEff_120.log
[10:24:37.652] INFO: *** Welcome to pxar ***
[10:24:37.652] INFO: *** Today: 2016/06/03
[10:24:37.675] INFO: *** Version: v1.9.0-805-geb36
[10:24:37.675] INFO: readRocDacs: data/mybna/dacParameters35_C0.dat .. data/mybna/dacParameters35_C15.dat
[10:24:37.676] INFO: readTbmDacs: data/mybna/tbmParameters_C0a.dat .. data/mybna/tbmParameters_C0b.dat
[10:24:37.676] INFO: readMaskFile: data/mybna/defaultMaskFile.dat
[10:24:37.676] INFO: readTrimFile: data/mybna/trimParameters35_C0.dat .. data/mybna/trimParameters35_C15.dat
[10:24:37.826] INFO: clk: 4
[10:24:37.826] INFO: ctr: 4
[10:24:37.826] INFO: sda: 19
[10:24:37.826] INFO: tin: 9
[10:24:37.826] INFO: level: 15
[10:24:37.826] INFO: triggerdelay: 0
[10:24:37.826] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[10:24:37.826] INFO: Log level: DEBUG
[10:24:37.837] QUIET: Connection to board DTB_WRPRHI opened.
[10:24:37.840] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 58
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WRPRHI
MAC address: 40D85511803A
Hostname: pixelDTB058
Comment:
------------------------------------------------------
[10:24:37.843] INFO: RPC call hashes of host and DTB match: 398089610
[10:24:39.442] INFO: DUT info:
[10:24:39.442] INFO: The DUT currently contains the following objects:
[10:24:39.442] INFO: 2 TBM Cores tbm08c (2 ON)
[10:24:39.442] INFO: TBM Core alpha (0): 7 registers set
[10:24:39.442] INFO: TBM Core beta (1): 7 registers set
[10:24:39.442] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:24:39.442] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:39.442] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:39.442] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:39.442] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:39.442] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:39.443] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:39.443] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:39.443] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:39.443] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:39.443] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:39.443] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:39.443] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:39.443] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:39.443] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:39.443] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:39.443] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[10:24:39.443] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[10:24:39.444] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:24:39.445] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:24:39.448] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 33280000
[10:24:39.448] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x188a0e0
[10:24:39.448] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x162c360
[10:24:39.448] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f5501d94010
[10:24:39.448] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f5507fff510
[10:24:39.448] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 33288192 fPxarMemory = 0x7f5501d94010
[10:24:39.449] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 390.7mA
[10:24:39.450] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 468.7mA
[10:24:39.450] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.4 C
[10:24:39.937] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x1c74d80
[10:24:40.000] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[10:24:40.000] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[10:24:40.000] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[10:24:40.006] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[10:24:40.006] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[10:24:40.006] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[10:24:40.016] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[10:24:40.016] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[10:24:40.038] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[10:24:40.038] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[10:24:40.051] INFO: PixTestCmd::init()
[10:24:40.066] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[10:24:40.066] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[10:24:40.066] INFO: readGainPedestalParameters data/mybna/phCalibrationFitErr35_C0.dat .. data/mybna/phCalibrationFitErr35_C15.dat
[10:24:40.318] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[10:24:40.318] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[10:24:40.332] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[10:24:40.338] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[10:24:40.338] DEBUG: <PixTestHighRate.cc/init:L198> PixTestHighRate::init()
[10:24:40.338] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[10:24:40.356] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[10:24:40.356] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[10:24:40.356] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[10:24:40.356] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[10:24:40.356] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[10:24:40.370] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[10:24:40.370] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[10:24:40.391] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[10:24:40.391] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[10:24:40.391] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[10:24:40.391] INFO: readReadbackCal: data/mybna/readbackCal_C0.dat .. data/mybna/readbackCal_C15.dat
[10:24:40.401] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[10:24:40.409] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[10:24:40.409] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[10:24:40.409] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[10:24:40.409] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[10:24:40.429] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[10:24:40.429] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[10:24:44.692] INFO: ######################################################################
[10:24:44.692] INFO: PixTestAlive::doTest()
[10:24:44.692] INFO: ######################################################################
[10:24:44.695] INFO: ----------------------------------------------------------------------
[10:24:44.695] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:24:44.695] INFO: ----------------------------------------------------------------------
[10:24:44.698] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:24:45.074] INFO: Expecting 41600 events.
[10:24:49.335] INFO: 41600 events read in total (3543ms).
[10:24:49.481] INFO: Test took 4783ms.
[10:24:49.491] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:24:49.491] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66556
[10:24:49.491] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists PixelAlive_C0 .. PixelAlive_C15
[10:24:49.767] INFO: PixTestAlive::aliveTest() done
[10:24:49.767] INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 3 0 0 0 0 0 0 0
[10:24:49.767] DEBUG: <PixTestAlive.cc/aliveTest:L199> number of red-efficiency pixels: 46 39 59 114 110 95 82 84 103 117 104 88 103 74 49 53
[10:24:49.789] INFO: ----------------------------------------------------------------------
[10:24:49.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)
[10:24:49.789] INFO: ----------------------------------------------------------------------
[10:24:49.791] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:24:50.165] INFO: Expecting 41600 events.
[10:24:53.216] INFO: 41600 events read in total (2336ms).
[10:24:53.217] INFO: Test took 3426ms.
[10:24:53.217] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:24:53.217] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 0
[10:24:53.217] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists MaskTest_C0 .. MaskTest_C15
[10:24:53.217] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[10:24:53.639] INFO: PixTestAlive::maskTest() done
[10:24:53.639] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:24:53.656] INFO: ----------------------------------------------------------------------
[10:24:53.656] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:24:53.656] INFO: ----------------------------------------------------------------------
[10:24:53.659] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:24:54.033] INFO: Expecting 41600 events.
[10:24:58.298] INFO: 41600 events read in total (3550ms).
[10:24:58.300] INFO: Test took 4641ms.
[10:24:58.310] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:24:58.310] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66556
[10:24:58.310] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists AddressDecodingTest_C0 .. AddressDecodingTest_C15
[10:24:58.680] INFO: PixTestAlive::addressDecodingTest() done
[10:24:58.680] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:24:58.681] INFO: PixTestAlive::doTest() done, duration: 13 seconds
[10:25:01.288] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): caldelscan
[10:25:01.288] DEBUG: <PixTestHighRate.cc/runCommand:L157> running command: caldelscan
[10:25:01.289] INFO: ----------------------------------------------------------------------
[10:25:01.289] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[10:25:01.289] INFO: ----------------------------------------------------------------------
[10:25:01.427] INFO: Expecting 768 events.
[10:25:02.560] INFO: 768 events read in total (417ms).
[10:25:02.560] INFO: Test took 1266ms.
[10:25:02.566] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:25:03.364] INFO: Expecting 41600 events.
[10:25:07.269] INFO: 41600 events read in total (3379ms).
[10:25:07.275] INFO: Test took 4709ms.
[10:25:07.469] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:25:07.469] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1113770
[10:25:07.469] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step0_C0 .. HR_xeff_CalDelScan_step0_C15
[10:25:07.470] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:25:07.552] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:25:08.219] INFO: Expecting 41600 events.
[10:25:12.235] INFO: 41600 events read in total (3489ms).
[10:25:12.241] INFO: Test took 4689ms.
[10:25:12.430] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:25:12.430] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1123827
[10:25:12.430] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step1_C0 .. HR_xeff_CalDelScan_step1_C15
[10:25:12.430] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:25:12.515] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:25:13.182] INFO: Expecting 41600 events.
[10:25:17.267] INFO: 41600 events read in total (3558ms).
[10:25:17.275] INFO: Test took 4760ms.
[10:25:17.474] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:25:17.474] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1128945
[10:25:17.474] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step2_C0 .. HR_xeff_CalDelScan_step2_C15
[10:25:17.474] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:25:17.566] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:25:18.249] INFO: Expecting 41600 events.
[10:25:22.437] INFO: 41600 events read in total (3661ms).
[10:25:22.444] INFO: Test took 4878ms.
[10:25:22.641] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:25:22.641] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1129621
[10:25:22.641] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step3_C0 .. HR_xeff_CalDelScan_step3_C15
[10:25:22.642] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:25:22.725] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:25:23.394] INFO: Expecting 41600 events.
[10:25:27.525] INFO: 41600 events read in total (3604ms).
[10:25:27.531] INFO: Test took 4806ms.
[10:25:27.718] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:25:27.718] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1130883
[10:25:27.718] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step4_C0 .. HR_xeff_CalDelScan_step4_C15
[10:25:27.719] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:25:27.803] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:25:28.468] INFO: Expecting 41600 events.
[10:25:32.635] INFO: 41600 events read in total (3641ms).
[10:25:32.644] INFO: Test took 4841ms.
[10:25:32.837] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:25:32.837] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1130487
[10:25:32.837] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step5_C0 .. HR_xeff_CalDelScan_step5_C15
[10:25:32.838] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:25:32.921] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:25:33.587] INFO: Expecting 41600 events.
[10:25:37.707] INFO: 41600 events read in total (3593ms).
[10:25:37.714] INFO: Test took 4793ms.
[10:25:37.901] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:25:37.901] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1131618
[10:25:37.901] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step6_C0 .. HR_xeff_CalDelScan_step6_C15
[10:25:37.901] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:25:37.984] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:25:38.650] INFO: Expecting 41600 events.
[10:25:42.758] INFO: 41600 events read in total (3582ms).
[10:25:42.764] INFO: Test took 4780ms.
[10:25:42.950] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:25:42.950] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1130802
[10:25:42.950] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step7_C0 .. HR_xeff_CalDelScan_step7_C15
[10:25:42.951] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:25:43.033] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:25:43.702] INFO: Expecting 41600 events.
[10:25:47.968] INFO: 41600 events read in total (3739ms).
[10:25:47.977] INFO: Test took 4944ms.
[10:25:48.175] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:25:48.176] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1132287
[10:25:48.176] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step8_C0 .. HR_xeff_CalDelScan_step8_C15
[10:25:48.176] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:25:48.259] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:25:48.928] INFO: Expecting 41600 events.
[10:25:53.170] INFO: 41600 events read in total (3716ms).
[10:25:53.179] INFO: Test took 4920ms.
[10:25:53.386] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:25:53.387] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1130595
[10:25:53.387] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step9_C0 .. HR_xeff_CalDelScan_step9_C15
[10:25:53.387] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:25:53.472] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:25:54.146] INFO: Expecting 41600 events.
[10:25:58.332] INFO: 41600 events read in total (3660ms).
[10:25:58.340] INFO: Test took 4868ms.
[10:25:58.535] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:25:58.535] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1131494
[10:25:58.535] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step10_C0 .. HR_xeff_CalDelScan_step10_C15
[10:25:58.535] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:25:58.619] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:25:59.287] INFO: Expecting 41600 events.
[10:26:03.488] INFO: 41600 events read in total (3674ms).
[10:26:03.494] INFO: Test took 4875ms.
[10:26:03.689] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:26:03.689] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1132440
[10:26:03.689] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step11_C0 .. HR_xeff_CalDelScan_step11_C15
[10:26:03.690] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:26:03.777] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:26:04.444] INFO: Expecting 41600 events.
[10:26:08.652] INFO: 41600 events read in total (3682ms).
[10:26:08.658] INFO: Test took 4881ms.
[10:26:08.850] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:26:08.850] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1131544
[10:26:08.850] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step12_C0 .. HR_xeff_CalDelScan_step12_C15
[10:26:08.850] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:26:08.933] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:26:09.601] INFO: Expecting 41600 events.
[10:26:13.762] INFO: 41600 events read in total (3634ms).
[10:26:13.768] INFO: Test took 4834ms.
[10:26:13.961] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:26:13.961] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1131775
[10:26:13.961] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step13_C0 .. HR_xeff_CalDelScan_step13_C15
[10:26:13.961] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:26:14.044] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:26:14.711] INFO: Expecting 41600 events.
[10:26:18.977] INFO: 41600 events read in total (3739ms).
[10:26:18.987] INFO: Test took 4942ms.
[10:26:19.185] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:26:19.185] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1129495
[10:26:19.186] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step14_C0 .. HR_xeff_CalDelScan_step14_C15
[10:26:19.186] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:26:19.273] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:26:19.946] INFO: Expecting 41600 events.
[10:26:24.230] INFO: 41600 events read in total (3757ms).
[10:26:24.239] INFO: Test took 4966ms.
[10:26:24.438] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:26:24.438] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1131044
[10:26:24.438] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step15_C0 .. HR_xeff_CalDelScan_step15_C15
[10:26:24.438] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:26:24.521] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:26:25.192] INFO: Expecting 41600 events.
[10:26:29.472] INFO: 41600 events read in total (3753ms).
[10:26:29.479] INFO: Test took 4958ms.
[10:26:29.679] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:26:29.680] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1130751
[10:26:29.680] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step16_C0 .. HR_xeff_CalDelScan_step16_C15
[10:26:29.680] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:26:29.768] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:26:30.437] INFO: Expecting 41600 events.
[10:26:34.617] INFO: 41600 events read in total (3653ms).
[10:26:34.624] INFO: Test took 4856ms.
[10:26:34.814] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:26:34.814] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1132972
[10:26:34.814] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step17_C0 .. HR_xeff_CalDelScan_step17_C15
[10:26:34.814] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:26:34.897] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:26:35.564] INFO: Expecting 41600 events.
[10:26:39.691] INFO: 41600 events read in total (3601ms).
[10:26:39.698] INFO: Test took 4800ms.
[10:26:39.890] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:26:39.890] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1129939
[10:26:39.890] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step18_C0 .. HR_xeff_CalDelScan_step18_C15
[10:26:39.891] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:26:39.975] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:26:40.647] INFO: Expecting 41600 events.
[10:26:44.654] INFO: 41600 events read in total (3480ms).
[10:26:44.660] INFO: Test took 4685ms.
[10:26:44.852] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:26:44.852] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1125649
[10:26:44.852] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step19_C0 .. HR_xeff_CalDelScan_step19_C15
[10:26:44.853] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:26:45.157] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 0: caldel = 174 eff = 0.996827
[10:26:45.157] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 1: caldel = 169 eff = 0.997356
[10:26:45.157] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 2: caldel = 179 eff = 0.99476
[10:26:45.158] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 3: caldel = 190 eff = 0.990865
[10:26:45.158] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 4: caldel = 172 eff = 0.989784
[10:26:45.158] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 5: caldel = 177 eff = 0.990962
[10:26:45.158] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 6: caldel = 168 eff = 0.99137
[10:26:45.158] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 7: caldel = 145 eff = 0.992284
[10:26:45.158] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 8: caldel = 161 eff = 0.989063
[10:26:45.158] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 9: caldel = 152 eff = 0.98863
[10:26:45.159] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 10: caldel = 161 eff = 0.98875
[10:26:45.159] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 11: caldel = 167 eff = 0.99
[10:26:45.159] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 12: caldel = 172 eff = 0.989688
[10:26:45.159] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 13: caldel = 185 eff = 0.994351
[10:26:45.160] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 14: caldel = 164 eff = 0.996779
[10:26:45.160] DEBUG: <PixTestHighRate.cc/doCalDelScan:L422> roc 15: caldel = 163 eff = 0.996707
[10:26:54.760] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): xpixelalive
[10:26:54.761] DEBUG: <PixTestHighRate.cc/runCommand:L157> running command: xpixelalive
[10:26:54.761] INFO: ----------------------------------------------------------------------
[10:26:54.761] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[10:26:54.761] INFO: ----------------------------------------------------------------------
[10:26:54.761] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L451> old set: clk: 4
[10:26:54.761] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L451> old set: ctr: 4
[10:26:54.761] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L451> old set: sda: 19
[10:26:54.761] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L451> old set: tin: 9
[10:26:54.761] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L451> old set: level: 15
[10:26:54.761] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L451> old set: triggerdelay: 0
[10:26:54.761] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L467> setting: clk: 4
[10:26:54.761] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L467> setting: ctr: 4
[10:26:54.761] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L467> setting: sda: 19
[10:26:54.761] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L467> setting: tin: 9
[10:26:54.761] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L467> setting: level: 15
[10:26:54.761] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L467> setting: triggerdelay: 20
[10:26:54.777] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:26:55.444] INFO: Expecting 208000 events.
[10:27:14.357] INFO: 208000 events read in total (18387ms).
[10:27:14.385] INFO: Test took 19608ms.
[10:27:15.386] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:27:15.386] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 5330431
[10:27:15.386] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists highRate_C0 .. highRate_C15
[10:27:15.386] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:27:15.967] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 3 0 0 0 0 0 0 0
[10:27:15.967] INFO: number of red-efficiency pixels: 401 258 686 1185 1316 1317 1295 1168 1278 1510 1390 1349 1310 696 311 332
[10:27:15.967] INFO: number of X-ray hits detected: 219296 154923 251280 387662 413505 408544 396389 369592 407429 427354 419381 402371 401875 264439 150625 189209
[10:27:15.967] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[10:27:15.967] INFO: number of Vcal hits detected: 207574 207726 207102 206506 206246 206272 206314 206511 206214 205975 206152 206203 206321 207102 207655 207652
[10:27:15.967] INFO: Vcal hit fiducial efficiency (%): 99.8 99.9 99.6 99.4 99.3 99.2 99.3 99.3 99.3 99.1 99.2 99.2 99.3 99.6 99.8 99.8
[10:27:15.967] INFO: Vcal hit overall efficiency (%): 99.8 99.9 99.6 99.3 99.2 99.2 99.2 99.3 99.1 99.0 99.1 99.1 99.2 99.6 99.8 99.8
[10:27:15.967] INFO: X-ray hit rate [MHz/cm2]: 64.3 45.4 73.7 113.6 121.2 119.7 116.2 108.3 119.4 125.3 122.9 117.9 117.8 77.5 44.1 55.5
[10:27:15.967] INFO: PixTestHighRate::doXPixelAlive() done
[10:27:16.016] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L586> resetting: clk: 4
[10:27:16.016] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L586> resetting: ctr: 4
[10:27:16.016] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L586> resetting: sda: 19
[10:27:16.016] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L586> resetting: tin: 9
[10:27:16.016] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L586> resetting: level: 15
[10:27:16.016] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L586> resetting: triggerdelay: 0
[10:27:16.016] INFO: PixTest:: pg_setup set to default.
[10:27:25.392] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[10:27:25.393] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = highRate_xraymap_C12_V0 -> highRate_xraymap_mod
[10:27:28.648] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[10:27:28.649] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 393.1mA
[10:27:28.650] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 470.3mA
[10:27:28.650] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: 0.2 C
[10:27:28.650] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[10:27:28.650] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[10:27:28.650] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[10:27:28.650] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[10:27:28.650] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[10:27:28.650] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[10:27:28.650] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[10:27:28.651] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[10:27:28.651] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[10:27:28.651] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L245> PixTestHighRate dtor
[10:27:28.743] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[10:27:28.743] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[10:27:28.752] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[10:27:28.752] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[10:27:28.752] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[10:27:28.752] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[10:27:28.752] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[10:27:28.752] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[10:27:28.755] QUIET: Connection to board 58 closed.
[10:27:28.834] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
MoReWeb-v0.5.1-895-gd4c3d74 on branch master