Test Date: 1973-11-29 16:33
Analysis date: 2016-07-28 12:00
Logfile
hrData_40.log
[11:29:06.587] INFO: *** Welcome to pxar ***
[11:29:06.587] INFO: *** Today: 2016/07/20
[11:29:06.611] INFO: *** Version: v1.9.0-814-g7497
[11:29:06.611] INFO: readRocDacs: data/mp220/dacParameters35_C0.dat .. data/mp220/dacParameters35_C15.dat
[11:29:06.612] INFO: readTbmDacs: data/mp220/tbmParameters_C0a.dat .. data/mp220/tbmParameters_C0b.dat
[11:29:06.612] INFO: readMaskFile: data/mp220/defaultMaskFile.dat
[11:29:06.612] INFO: readTrimFile: data/mp220/trimParameters35_C0.dat .. data/mp220/trimParameters35_C15.dat
[11:29:06.762] INFO: clk: 4
[11:29:06.762] INFO: ctr: 4
[11:29:06.762] INFO: sda: 19
[11:29:06.762] INFO: tin: 9
[11:29:06.762] INFO: level: 15
[11:29:06.762] INFO: triggerdelay: 0
[11:29:06.762] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[11:29:06.762] INFO: Log level: DEBUG
[11:29:06.773] QUIET: Connection to board DTB_WRPRHI opened.
[11:29:06.777] 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:
------------------------------------------------------
[11:29:06.780] INFO: RPC call hashes of host and DTB match: 398089610
[11:29:08.379] INFO: DUT info:
[11:29:08.379] INFO: The DUT currently contains the following objects:
[11:29:08.380] INFO: 2 TBM Cores tbm08c (2 ON)
[11:29:08.380] INFO: TBM Core alpha (0): 7 registers set
[11:29:08.380] INFO: TBM Core beta (1): 7 registers set
[11:29:08.380] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:29:08.380] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:08.380] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:08.380] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:08.380] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:08.380] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:08.380] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:08.380] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:08.380] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:08.380] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:08.380] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:08.380] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:08.380] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:08.380] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:08.380] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:08.380] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:08.380] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:08.380] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[11:29:08.380] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[11:29:08.380] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[11:29:08.380] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[11:29:08.380] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[11:29:08.380] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[11:29:08.380] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:29:08.380] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[11:29:08.380] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[11:29:08.380] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:29:08.380] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[11:29:08.380] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[11:29:08.381] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[11:29:08.382] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[11:29:08.383] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[11:29:08.385] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 30367744
[11:29:08.385] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x273f0d0
[11:29:08.385] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x24e1360
[11:29:08.385] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f71e1393010
[11:29:08.385] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f71e75fe510
[11:29:08.385] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 30375936 fPxarMemory = 0x7f71e1393010
[11:29:08.386] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 389.1mA
[11:29:08.388] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 471.1mA
[11:29:08.388] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.4 C
[11:29:08.876] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x2b29da0
[11:29:08.936] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[11:29:08.936] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[11:29:08.937] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[11:29:08.942] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[11:29:08.942] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[11:29:08.942] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[11:29:08.952] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[11:29:08.952] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[11:29:08.960] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[11:29:08.961] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[11:29:08.982] INFO: PixTestCmd::init()
[11:29:08.987] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[11:29:08.987] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[11:29:08.987] INFO: readGainPedestalParameters data/mp220/phCalibrationFitErr35_C0.dat .. data/mp220/phCalibrationFitErr35_C15.dat
[11:29:09.236] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[11:29:09.237] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[11:29:09.250] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[11:29:09.256] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[11:29:09.256] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[11:29:09.256] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[11:29:09.280] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[11:29:09.280] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[11:29:09.280] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[11:29:09.280] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[11:29:09.280] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[11:29:09.286] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[11:29:09.286] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[11:29:09.302] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[11:29:09.302] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[11:29:09.302] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[11:29:09.303] INFO: readReadbackCal: data/mp220/readbackCal_C0.dat .. data/mp220/readbackCal_C15.dat
[11:29:09.312] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[11:29:09.320] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[11:29:09.320] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[11:29:09.320] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[11:29:09.320] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[11:29:09.336] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[11:29:09.336] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[11:29:18.390] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 1 -> source to value 02ma
[11:29:20.422] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 2 -> runseconds to value 60
[11:29:21.675] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): phrun
[11:29:21.675] DEBUG: <PixTestXray.cc/runCommand:L109> running command: phrun
[11:29:21.675] INFO: ----------------------------------------------------------------------
[11:29:21.675] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[11:29:21.675] INFO: ----------------------------------------------------------------------
[11:29:22.647] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[11:29:36.592] INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[11:29:36.596] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[11:30:01.909] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1373946 events.
[11:30:05.988] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1373946, pixels seen in all events: 3764335
[11:30:06.135] INFO: Resuming triggers.
[11:30:20.079] INFO: run duration 27 seconds, buffer almost full (81%), pausing triggers.
[11:30:20.108] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[11:30:45.221] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1373725 events.
[11:30:49.313] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1373725, pixels seen in all events: 3766092
[11:30:49.452] INFO: Resuming triggers.
[11:31:03.401] INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[11:31:03.473] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[11:31:28.365] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1374228 events.
[11:31:32.494] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1374228, pixels seen in all events: 3760330
[11:31:32.587] INFO: Resuming triggers.
[11:31:46.539] INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[11:31:46.567] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[11:32:11.458] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1374486 events.
[11:32:15.532] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1374486, pixels seen in all events: 3757168
[11:32:15.672] INFO: Resuming triggers.
[11:32:19.965] INFO: data taking finished, elapsed time: 60 seconds.
[11:32:20.161] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[11:32:27.944] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 422938 events.
[11:32:29.210] DEBUG: <PixTestXray.cc/processData:L823> # events read: 422938, pixels seen in all events: 1156986
[11:32:29.268] INFO: PixTest:: pg_setup set to default.
[11:32:29.305] INFO: PixTestXray::doPhRun() done
[11:32:43.427] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[11:32:43.428] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 393.1mA
[11:32:43.428] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 471.1mA
[11:32:43.428] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.1 C
[11:32:43.428] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[11:32:43.429] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[11:32:43.429] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[11:32:43.429] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[11:32:43.429] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[11:32:43.429] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[11:32:43.429] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[11:32:43.429] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[11:32:43.429] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[11:32:43.429] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[11:32:43.429] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[11:32:43.429] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[11:32:43.429] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[11:32:43.429] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[11:32:43.429] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[11:32:43.429] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[11:32:43.429] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[11:32:43.429] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[11:32:43.691] QUIET: Connection to board 58 closed.
[11:32:43.770] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrData_120.log
[11:32:49.319] INFO: *** Welcome to pxar ***
[11:32:49.319] INFO: *** Today: 2016/07/20
[11:32:49.343] INFO: *** Version: v1.9.0-814-g7497
[11:32:49.343] INFO: readRocDacs: data/mp220/dacParameters35_C0.dat .. data/mp220/dacParameters35_C15.dat
[11:32:49.344] INFO: readTbmDacs: data/mp220/tbmParameters_C0a.dat .. data/mp220/tbmParameters_C0b.dat
[11:32:49.344] INFO: readMaskFile: data/mp220/defaultMaskFile.dat
[11:32:49.344] INFO: readTrimFile: data/mp220/trimParameters35_C0.dat .. data/mp220/trimParameters35_C15.dat
[11:32:49.495] INFO: clk: 4
[11:32:49.495] INFO: ctr: 4
[11:32:49.495] INFO: sda: 19
[11:32:49.495] INFO: tin: 9
[11:32:49.495] INFO: level: 15
[11:32:49.495] INFO: triggerdelay: 0
[11:32:49.495] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[11:32:49.495] INFO: Log level: DEBUG
[11:32:49.506] QUIET: Connection to board DTB_WRPRHI opened.
[11:32:49.509] 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:
------------------------------------------------------
[11:32:49.512] INFO: RPC call hashes of host and DTB match: 398089610
[11:32:51.117] INFO: DUT info:
[11:32:51.117] INFO: The DUT currently contains the following objects:
[11:32:51.117] INFO: 2 TBM Cores tbm08c (2 ON)
[11:32:51.117] INFO: TBM Core alpha (0): 7 registers set
[11:32:51.117] INFO: TBM Core beta (1): 7 registers set
[11:32:51.117] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:32:51.117] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:32:51.117] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:32:51.118] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:32:51.118] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:32:51.118] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:32:51.118] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:32:51.118] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:32:51.118] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:32:51.118] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:32:51.118] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:32:51.118] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:32:51.118] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:32:51.118] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:32:51.118] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:32:51.118] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:32:51.118] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[11:32:51.118] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[11:32:51.119] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[11:32:51.120] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[11:32:51.121] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[11:32:51.121] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[11:32:51.121] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[11:32:51.121] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[11:32:51.121] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[11:32:51.121] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[11:32:51.121] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[11:32:51.121] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[11:32:51.121] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[11:32:51.121] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[11:32:51.121] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[11:32:51.121] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[11:32:51.121] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[11:32:51.121] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[11:32:51.121] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[11:32:51.121] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[11:32:51.123] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 33083392
[11:32:51.123] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0xc580d0
[11:32:51.123] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x9fa360
[11:32:51.123] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f5655d94010
[11:32:51.123] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f565bfff510
[11:32:51.123] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 33091584 fPxarMemory = 0x7f5655d94010
[11:32:51.124] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 388.3mA
[11:32:51.125] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 471.1mA
[11:32:51.126] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.2 C
[11:32:51.613] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x1042ea0
[11:32:51.672] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[11:32:51.672] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[11:32:51.673] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[11:32:51.678] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[11:32:51.678] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[11:32:51.678] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[11:32:51.690] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[11:32:51.690] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[11:32:51.709] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[11:32:51.709] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[11:32:51.719] INFO: PixTestCmd::init()
[11:32:51.733] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[11:32:51.733] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[11:32:51.733] INFO: readGainPedestalParameters data/mp220/phCalibrationFitErr35_C0.dat .. data/mp220/phCalibrationFitErr35_C15.dat
[11:32:51.984] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[11:32:51.984] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[11:32:52.001] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[11:32:52.011] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[11:32:52.011] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[11:32:52.011] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[11:32:52.032] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[11:32:52.032] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[11:32:52.032] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[11:32:52.032] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[11:32:52.032] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[11:32:52.038] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[11:32:52.038] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[11:32:52.059] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[11:32:52.059] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[11:32:52.059] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[11:32:52.059] INFO: readReadbackCal: data/mp220/readbackCal_C0.dat .. data/mp220/readbackCal_C15.dat
[11:32:52.068] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[11:32:52.077] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[11:32:52.077] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[11:32:52.077] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[11:32:52.077] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[11:32:52.092] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[11:32:52.092] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[11:33:35.622] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 1 -> source to value 06ma
[11:33:37.910] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 2 -> runseconds to value 60
[11:33:39.515] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): phrun
[11:33:39.515] DEBUG: <PixTestXray.cc/runCommand:L109> running command: phrun
[11:33:39.515] INFO: ----------------------------------------------------------------------
[11:33:39.515] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[11:33:39.515] INFO: ----------------------------------------------------------------------
[11:33:40.487] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[11:33:54.441] INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[11:33:54.445] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[11:34:19.660] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1374831 events.
[11:34:23.755] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1374831, pixels seen in all events: 3753515
[11:34:23.901] INFO: Resuming triggers.
[11:34:37.856] INFO: run duration 27 seconds, buffer almost full (81%), pausing triggers.
[11:34:37.886] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[11:35:02.757] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1374878 events.
[11:35:06.885] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1374878, pixels seen in all events: 3752437
[11:35:06.975] INFO: Resuming triggers.
[11:35:20.929] INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[11:35:20.956] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[11:35:46.017] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1374658 events.
[11:35:50.158] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1374658, pixels seen in all events: 3755010
[11:35:50.248] INFO: Resuming triggers.
[11:36:04.204] INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[11:36:04.232] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[11:36:29.162] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1374867 events.
[11:36:33.297] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1374867, pixels seen in all events: 3752562
[11:36:33.389] INFO: Resuming triggers.
[11:36:37.650] INFO: data taking finished, elapsed time: 60 seconds.
[11:36:37.846] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[11:36:45.545] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 419721 events.
[11:36:46.793] DEBUG: <PixTestXray.cc/processData:L823> # events read: 419721, pixels seen in all events: 1145744
[11:36:46.852] INFO: PixTest:: pg_setup set to default.
[11:36:46.888] INFO: PixTestXray::doPhRun() done
[11:37:15.035] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[11:37:15.036] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 393.1mA
[11:37:15.036] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 471.1mA
[11:37:15.037] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.4 C
[11:37:15.037] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[11:37:15.037] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[11:37:15.037] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[11:37:15.037] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[11:37:15.037] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[11:37:15.037] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[11:37:15.037] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[11:37:15.037] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[11:37:15.037] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[11:37:15.037] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[11:37:15.037] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[11:37:15.037] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[11:37:15.037] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[11:37:15.037] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[11:37:15.037] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[11:37:15.037] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[11:37:15.038] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[11:37:15.038] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[11:37:15.302] QUIET: Connection to board 58 closed.
[11:37:15.381] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrEff_40.log
[11:22:26.426] INFO: *** Welcome to pxar ***
[11:22:26.426] INFO: *** Today: 2016/07/20
[11:22:26.450] INFO: *** Version: v1.9.0-814-g7497
[11:22:26.450] INFO: readRocDacs: data/mp220/dacParameters35_C0.dat .. data/mp220/dacParameters35_C15.dat
[11:22:26.451] INFO: readTbmDacs: data/mp220/tbmParameters_C0a.dat .. data/mp220/tbmParameters_C0b.dat
[11:22:26.451] INFO: readMaskFile: data/mp220/defaultMaskFile.dat
[11:22:26.451] INFO: readTrimFile: data/mp220/trimParameters35_C0.dat .. data/mp220/trimParameters35_C15.dat
[11:22:26.601] INFO: clk: 4
[11:22:26.601] INFO: ctr: 4
[11:22:26.601] INFO: sda: 19
[11:22:26.601] INFO: tin: 9
[11:22:26.601] INFO: level: 15
[11:22:26.601] INFO: triggerdelay: 0
[11:22:26.601] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[11:22:26.601] INFO: Log level: DEBUG
[11:22:26.613] QUIET: Connection to board DTB_WRPRHI opened.
[11:22:26.616] 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:
------------------------------------------------------
[11:22:26.619] INFO: RPC call hashes of host and DTB match: 398089610
[11:22:28.223] INFO: DUT info:
[11:22:28.223] INFO: The DUT currently contains the following objects:
[11:22:28.223] INFO: 2 TBM Cores tbm08c (2 ON)
[11:22:28.223] INFO: TBM Core alpha (0): 7 registers set
[11:22:28.223] INFO: TBM Core beta (1): 7 registers set
[11:22:28.223] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:22:28.223] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:28.223] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:28.223] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:28.223] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:28.223] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:28.223] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:28.223] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:28.223] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:28.223] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:28.223] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:28.223] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:28.223] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:28.223] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:28.223] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:28.223] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:28.223] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[11:22:28.224] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:22:28.225] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[11:22:28.226] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[11:22:28.228] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 31526912
[11:22:28.228] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x19cc0d0
[11:22:28.229] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x176e360
[11:22:28.229] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f5861393010
[11:22:28.229] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f58675fe510
[11:22:28.229] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 31535104 fPxarMemory = 0x7f5861393010
[11:22:28.230] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 388.3mA
[11:22:28.231] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 471.9mA
[11:22:28.231] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: 0.1 C
[11:22:28.719] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x1db6da0
[11:22:28.779] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[11:22:28.780] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[11:22:28.780] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[11:22:28.785] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[11:22:28.786] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[11:22:28.786] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[11:22:28.795] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[11:22:28.795] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[11:22:28.806] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[11:22:28.806] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[11:22:28.818] INFO: PixTestCmd::init()
[11:22:28.832] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[11:22:28.832] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[11:22:28.832] INFO: readGainPedestalParameters data/mp220/phCalibrationFitErr35_C0.dat .. data/mp220/phCalibrationFitErr35_C15.dat
[11:22:29.082] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[11:22:29.083] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[11:22:29.096] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[11:22:29.102] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[11:22:29.102] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[11:22:29.102] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[11:22:29.122] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[11:22:29.122] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[11:22:29.122] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[11:22:29.122] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[11:22:29.122] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[11:22:29.128] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[11:22:29.128] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[11:22:29.143] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[11:22:29.143] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[11:22:29.143] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[11:22:29.143] INFO: readReadbackCal: data/mp220/readbackCal_C0.dat .. data/mp220/readbackCal_C15.dat
[11:22:29.153] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[11:22:29.161] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[11:22:29.161] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[11:22:29.161] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[11:22:29.161] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[11:22:29.174] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[11:22:29.175] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[11:22:33.206] INFO: ######################################################################
[11:22:33.206] INFO: PixTestAlive::doTest()
[11:22:33.206] INFO: ######################################################################
[11:22:33.209] INFO: ----------------------------------------------------------------------
[11:22:33.209] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:22:33.209] INFO: ----------------------------------------------------------------------
[11:22:33.212] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:22:33.587] INFO: Expecting 41600 events.
[11:22:37.836] INFO: 41600 events read in total (3531ms).
[11:22:37.984] INFO: Test took 4772ms.
[11:22:37.993] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:22:37.993] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[11:22:37.993] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists PixelAlive_C0 .. PixelAlive_C15
[11:22:38.262] INFO: PixTestAlive::aliveTest() done
[11:22:38.263] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:22:38.263] DEBUG: <PixTestAlive.cc/aliveTest:L199> number of red-efficiency pixels: 13 25 33 27 41 28 27 36 35 31 41 33 31 21 12 17
[11:22:38.285] INFO: ----------------------------------------------------------------------
[11:22:38.285] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:22:38.285] INFO: ----------------------------------------------------------------------
[11:22:38.287] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:22:38.661] INFO: Expecting 41600 events.
[11:22:41.705] INFO: 41600 events read in total (2328ms).
[11:22:41.705] INFO: Test took 3418ms.
[11:22:41.705] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:22:41.705] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 0
[11:22:41.705] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists MaskTest_C0 .. MaskTest_C15
[11:22:41.706] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:22:42.129] INFO: PixTestAlive::maskTest() done
[11:22:42.129] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:22:42.147] INFO: ----------------------------------------------------------------------
[11:22:42.147] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:22:42.147] INFO: ----------------------------------------------------------------------
[11:22:42.149] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:22:42.524] INFO: Expecting 41600 events.
[11:22:46.770] INFO: 41600 events read in total (3531ms).
[11:22:46.773] INFO: Test took 4624ms.
[11:22:46.783] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:22:46.783] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[11:22:46.783] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists AddressDecodingTest_C0 .. AddressDecodingTest_C15
[11:22:47.154] INFO: PixTestAlive::addressDecodingTest() done
[11:22:47.154] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:22:47.155] INFO: PixTestAlive::doTest() done, duration: 13 seconds
[11:22:53.043] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[11:22:53.043] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = PixelAlive_C5_V0 -> PixelAlive_mod
[11:22:55.955] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): caldelscan
[11:22:55.955] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: caldelscan
[11:22:55.955] INFO: ----------------------------------------------------------------------
[11:22:55.955] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[11:22:55.955] INFO: ----------------------------------------------------------------------
[11:22:56.094] INFO: Expecting 768 events.
[11:22:57.226] INFO: 768 events read in total (417ms).
[11:22:57.226] INFO: Test took 1266ms.
[11:22:57.232] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:22:58.030] INFO: Expecting 41600 events.
[11:23:01.220] INFO: 41600 events read in total (2664ms).
[11:23:01.223] INFO: Test took 3991ms.
[11:23:01.300] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:23:01.300] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 429320
[11:23:01.300] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step0_C0 .. HR_xeff_CalDelScan_step0_C15
[11:23:01.301] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:23:01.336] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:23:02.002] INFO: Expecting 41600 events.
[11:23:05.269] INFO: 41600 events read in total (2741ms).
[11:23:05.273] INFO: Test took 3937ms.
[11:23:05.345] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:23:05.345] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 434490
[11:23:05.345] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step1_C0 .. HR_xeff_CalDelScan_step1_C15
[11:23:05.346] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:23:05.383] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:23:06.049] INFO: Expecting 41600 events.
[11:23:09.332] INFO: 41600 events read in total (2756ms).
[11:23:09.336] INFO: Test took 3953ms.
[11:23:09.407] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:23:09.408] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 435334
[11:23:09.408] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step2_C0 .. HR_xeff_CalDelScan_step2_C15
[11:23:09.408] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:23:09.445] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:23:10.110] INFO: Expecting 41600 events.
[11:23:13.403] INFO: 41600 events read in total (2766ms).
[11:23:13.406] INFO: Test took 3961ms.
[11:23:13.478] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:23:13.478] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 434604
[11:23:13.478] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step3_C0 .. HR_xeff_CalDelScan_step3_C15
[11:23:13.479] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:23:13.516] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:23:14.181] INFO: Expecting 41600 events.
[11:23:17.473] INFO: 41600 events read in total (2765ms).
[11:23:17.476] INFO: Test took 3960ms.
[11:23:17.548] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:23:17.548] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 434469
[11:23:17.548] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step4_C0 .. HR_xeff_CalDelScan_step4_C15
[11:23:17.548] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:23:17.585] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:23:18.250] INFO: Expecting 41600 events.
[11:23:21.555] INFO: 41600 events read in total (2778ms).
[11:23:21.559] INFO: Test took 3974ms.
[11:23:21.631] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:23:21.631] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 434910
[11:23:21.631] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step5_C0 .. HR_xeff_CalDelScan_step5_C15
[11:23:21.631] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:23:21.668] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:23:22.333] INFO: Expecting 41600 events.
[11:23:25.631] INFO: 41600 events read in total (2771ms).
[11:23:25.635] INFO: Test took 3967ms.
[11:23:25.706] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:23:25.707] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 434240
[11:23:25.707] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step6_C0 .. HR_xeff_CalDelScan_step6_C15
[11:23:25.707] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:23:25.743] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:23:26.409] INFO: Expecting 41600 events.
[11:23:29.710] INFO: 41600 events read in total (2775ms).
[11:23:29.713] INFO: Test took 3970ms.
[11:23:29.784] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:23:29.784] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 434734
[11:23:29.784] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step7_C0 .. HR_xeff_CalDelScan_step7_C15
[11:23:29.785] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:23:29.822] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:23:30.487] INFO: Expecting 41600 events.
[11:23:33.794] INFO: 41600 events read in total (2780ms).
[11:23:33.797] INFO: Test took 3975ms.
[11:23:33.868] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:23:33.868] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 433877
[11:23:33.868] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step8_C0 .. HR_xeff_CalDelScan_step8_C15
[11:23:33.869] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:23:33.905] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:23:34.571] INFO: Expecting 41600 events.
[11:23:37.880] INFO: 41600 events read in total (2783ms).
[11:23:37.883] INFO: Test took 3978ms.
[11:23:37.956] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:23:37.956] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 434026
[11:23:37.956] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step9_C0 .. HR_xeff_CalDelScan_step9_C15
[11:23:37.956] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:23:37.993] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:23:38.659] INFO: Expecting 41600 events.
[11:23:41.965] INFO: 41600 events read in total (2779ms).
[11:23:41.969] INFO: Test took 3976ms.
[11:23:42.041] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:23:42.041] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 435455
[11:23:42.041] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step10_C0 .. HR_xeff_CalDelScan_step10_C15
[11:23:42.041] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:23:42.078] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:23:42.743] INFO: Expecting 41600 events.
[11:23:46.046] INFO: 41600 events read in total (2776ms).
[11:23:46.050] INFO: Test took 3972ms.
[11:23:46.121] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:23:46.121] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 434454
[11:23:46.122] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step11_C0 .. HR_xeff_CalDelScan_step11_C15
[11:23:46.122] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:23:46.159] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:23:46.825] INFO: Expecting 41600 events.
[11:23:50.136] INFO: 41600 events read in total (2785ms).
[11:23:50.140] INFO: Test took 3981ms.
[11:23:50.212] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:23:50.212] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 435207
[11:23:50.212] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step12_C0 .. HR_xeff_CalDelScan_step12_C15
[11:23:50.212] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:23:50.249] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:23:50.915] INFO: Expecting 41600 events.
[11:23:54.213] INFO: 41600 events read in total (2772ms).
[11:23:54.216] INFO: Test took 3967ms.
[11:23:54.288] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:23:54.288] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 434009
[11:23:54.288] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step13_C0 .. HR_xeff_CalDelScan_step13_C15
[11:23:54.289] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:23:54.326] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:23:54.991] INFO: Expecting 41600 events.
[11:23:58.307] INFO: 41600 events read in total (2789ms).
[11:23:58.311] INFO: Test took 3985ms.
[11:23:58.382] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:23:58.382] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 434935
[11:23:58.382] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step14_C0 .. HR_xeff_CalDelScan_step14_C15
[11:23:58.383] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:23:58.419] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:23:59.085] INFO: Expecting 41600 events.
[11:24:02.392] INFO: 41600 events read in total (2780ms).
[11:24:02.396] INFO: Test took 3976ms.
[11:24:02.468] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:24:02.468] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 435176
[11:24:02.468] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step15_C0 .. HR_xeff_CalDelScan_step15_C15
[11:24:02.469] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:24:02.505] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:24:03.171] INFO: Expecting 41600 events.
[11:24:06.477] INFO: 41600 events read in total (2780ms).
[11:24:06.480] INFO: Test took 3975ms.
[11:24:06.551] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:24:06.552] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 433362
[11:24:06.552] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step16_C0 .. HR_xeff_CalDelScan_step16_C15
[11:24:06.552] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:24:06.589] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:24:07.254] INFO: Expecting 41600 events.
[11:24:10.582] INFO: 41600 events read in total (2801ms).
[11:24:10.586] INFO: Test took 3997ms.
[11:24:10.658] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:24:10.658] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 434098
[11:24:10.658] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step17_C0 .. HR_xeff_CalDelScan_step17_C15
[11:24:10.658] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:24:10.695] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:24:11.360] INFO: Expecting 41600 events.
[11:24:14.612] INFO: 41600 events read in total (2725ms).
[11:24:14.616] INFO: Test took 3921ms.
[11:24:14.687] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:24:14.687] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 433125
[11:24:14.687] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step18_C0 .. HR_xeff_CalDelScan_step18_C15
[11:24:14.687] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:24:14.724] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:24:15.390] INFO: Expecting 41600 events.
[11:24:18.475] INFO: 41600 events read in total (2559ms).
[11:24:18.479] INFO: Test took 3755ms.
[11:24:18.549] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:24:18.549] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 422573
[11:24:18.550] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step19_C0 .. HR_xeff_CalDelScan_step19_C15
[11:24:18.550] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:24:18.807] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 0: caldel = 121 eff = 0.999784
[11:24:18.807] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 1: caldel = 130 eff = 0.999736
[11:24:18.807] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 2: caldel = 145 eff = 0.999351
[11:24:18.808] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 3: caldel = 147 eff = 0.999183
[11:24:18.808] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 4: caldel = 148 eff = 0.998894
[11:24:18.808] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 5: caldel = 156 eff = 0.999327
[11:24:18.808] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 6: caldel = 135 eff = 0.999279
[11:24:18.808] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 7: caldel = 139 eff = 0.960673
[11:24:18.809] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 8: caldel = 150 eff = 0.999135
[11:24:18.809] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 9: caldel = 153 eff = 0.998894
[11:24:18.809] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 10: caldel = 143 eff = 0.999135
[11:24:18.809] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 11: caldel = 137 eff = 0.999159
[11:24:18.809] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 12: caldel = 156 eff = 0.999327
[11:24:18.809] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 13: caldel = 152 eff = 0.999543
[11:24:18.810] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 14: caldel = 134 eff = 0.999784
[11:24:18.810] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 15: caldel = 126 eff = 0.999736
[11:25:12.643] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): xpixelalive
[11:25:12.643] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: xpixelalive
[11:25:12.643] INFO: ----------------------------------------------------------------------
[11:25:12.643] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:25:12.643] INFO: ----------------------------------------------------------------------
[11:25:12.643] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: clk: 4
[11:25:12.643] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: ctr: 4
[11:25:12.643] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: sda: 19
[11:25:12.643] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: tin: 9
[11:25:12.643] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: level: 15
[11:25:12.643] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: triggerdelay: 0
[11:25:12.643] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: clk: 4
[11:25:12.643] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: ctr: 4
[11:25:12.643] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: sda: 19
[11:25:12.643] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: tin: 9
[11:25:12.643] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: level: 15
[11:25:12.643] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: triggerdelay: 20
[11:25:12.659] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:25:13.325] INFO: Expecting 208000 events.
[11:25:25.717] INFO: 208000 events read in total (11866ms).
[11:25:25.728] INFO: Test took 13069ms.
[11:25:26.053] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:25:26.053] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1896743
[11:25:26.053] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists highRate_C0 .. highRate_C15
[11:25:26.053] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:25:26.406] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 160 0 0 0 0 0 0 0 0
[11:25:26.406] INFO: number of red-efficiency pixels: 72 72 119 176 270 211 242 375 232 225 239 210 193 121 72 88
[11:25:26.406] INFO: number of X-ray hits detected: 58529 54335 93504 138353 149800 143818 142691 130576 146344 153166 148838 136943 133701 90176 55400 54169
[11:25:26.406] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:25:26.406] INFO: number of Vcal hits detected: 207925 207928 207881 207821 207722 207779 207753 199776 207761 207764 207753 207786 207803 207877 207927 207911
[11:25:26.406] INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 100.0 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 100.0 100.0
[11:25:26.406] INFO: Vcal hit overall efficiency (%): 100.0 100.0 99.9 99.9 99.9 99.9 99.9 96.0 99.9 99.9 99.9 99.9 99.9 99.9 100.0 100.0
[11:25:26.406] INFO: X-ray hit rate [MHz/cm2]: 17.2 15.9 27.4 40.6 43.9 42.2 41.8 38.3 42.9 44.9 43.6 40.1 39.2 26.4 16.2 15.9
[11:25:26.406] INFO: PixTestHighRate::doXPixelAlive() done
[11:25:26.451] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: clk: 4
[11:25:26.451] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: ctr: 4
[11:25:26.451] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: sda: 19
[11:25:26.451] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: tin: 9
[11:25:26.451] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: level: 15
[11:25:26.452] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: triggerdelay: 0
[11:25:26.452] INFO: PixTest:: pg_setup set to default.
[11:26:15.635] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[11:26:15.635] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = highRate_xraymap_C11_V0 -> highRate_xraymap_mod
[11:26:18.683] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[11:26:18.684] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 393.9mA
[11:26:18.684] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 471.1mA
[11:26:18.684] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.2 C
[11:26:18.684] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[11:26:18.684] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[11:26:18.684] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[11:26:18.685] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[11:26:18.685] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[11:26:18.685] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[11:26:18.685] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[11:26:18.685] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[11:26:18.685] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[11:26:18.685] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[11:26:18.772] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[11:26:18.773] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[11:26:18.787] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[11:26:18.787] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[11:26:18.787] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[11:26:18.787] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[11:26:18.787] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[11:26:18.787] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[11:26:18.789] QUIET: Connection to board 58 closed.
[11:26:18.868] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrEff_80.log
[11:19:40.822] INFO: *** Welcome to pxar ***
[11:19:40.822] INFO: *** Today: 2016/07/20
[11:19:40.845] INFO: *** Version: v1.9.0-814-g7497
[11:19:40.845] INFO: readRocDacs: data/mp220/dacParameters35_C0.dat .. data/mp220/dacParameters35_C15.dat
[11:19:40.846] INFO: readTbmDacs: data/mp220/tbmParameters_C0a.dat .. data/mp220/tbmParameters_C0b.dat
[11:19:40.846] INFO: readMaskFile: data/mp220/defaultMaskFile.dat
[11:19:40.846] INFO: readTrimFile: data/mp220/trimParameters35_C0.dat .. data/mp220/trimParameters35_C15.dat
[11:19:40.997] INFO: clk: 4
[11:19:40.997] INFO: ctr: 4
[11:19:40.997] INFO: sda: 19
[11:19:40.997] INFO: tin: 9
[11:19:40.997] INFO: level: 15
[11:19:40.997] INFO: triggerdelay: 0
[11:19:40.997] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[11:19:40.997] INFO: Log level: DEBUG
[11:19:41.008] QUIET: Connection to board DTB_WRPRHI opened.
[11:19:41.011] 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:
------------------------------------------------------
[11:19:41.014] INFO: RPC call hashes of host and DTB match: 398089610
[11:19:42.618] INFO: DUT info:
[11:19:42.618] INFO: The DUT currently contains the following objects:
[11:19:42.618] INFO: 2 TBM Cores tbm08c (2 ON)
[11:19:42.618] INFO: TBM Core alpha (0): 7 registers set
[11:19:42.618] INFO: TBM Core beta (1): 7 registers set
[11:19:42.618] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:19:42.618] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:42.618] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:42.618] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:42.618] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:42.618] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:42.618] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:42.618] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:42.618] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:42.618] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:42.618] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:42.618] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:42.618] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:42.618] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:42.618] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:42.618] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:42.618] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[11:19:42.619] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[11:19:42.620] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[11:19:42.621] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[11:19:42.624] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 31379456
[11:19:42.624] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x263d0d0
[11:19:42.624] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x23df360
[11:19:42.624] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f2f05d94010
[11:19:42.624] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f2f0bfff510
[11:19:42.624] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 31387648 fPxarMemory = 0x7f2f05d94010
[11:19:42.625] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 389.1mA
[11:19:42.626] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 471.9mA
[11:19:42.626] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.4 C
[11:19:43.162] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x2a27cf0
[11:19:43.233] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[11:19:43.233] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[11:19:43.234] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[11:19:43.239] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[11:19:43.239] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[11:19:43.239] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[11:19:43.250] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[11:19:43.250] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[11:19:43.269] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[11:19:43.269] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[11:19:43.279] INFO: PixTestCmd::init()
[11:19:43.291] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[11:19:43.291] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[11:19:43.291] INFO: readGainPedestalParameters data/mp220/phCalibrationFitErr35_C0.dat .. data/mp220/phCalibrationFitErr35_C15.dat
[11:19:43.543] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[11:19:43.543] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[11:19:43.557] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[11:19:43.563] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[11:19:43.563] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[11:19:43.563] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[11:19:43.586] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[11:19:43.586] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[11:19:43.586] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[11:19:43.586] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[11:19:43.586] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[11:19:43.592] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[11:19:43.592] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[11:19:43.605] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[11:19:43.605] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[11:19:43.605] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[11:19:43.605] INFO: readReadbackCal: data/mp220/readbackCal_C0.dat .. data/mp220/readbackCal_C15.dat
[11:19:43.614] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[11:19:43.622] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[11:19:43.622] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[11:19:43.622] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[11:19:43.622] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[11:19:43.634] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[11:19:43.634] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[11:19:48.438] INFO: ######################################################################
[11:19:48.438] INFO: PixTestAlive::doTest()
[11:19:48.438] INFO: ######################################################################
[11:19:48.441] INFO: ----------------------------------------------------------------------
[11:19:48.441] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:19:48.441] INFO: ----------------------------------------------------------------------
[11:19:48.444] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:19:48.819] INFO: Expecting 41600 events.
[11:19:53.080] INFO: 41600 events read in total (3543ms).
[11:19:53.227] INFO: Test took 4783ms.
[11:19:53.237] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:19:53.237] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[11:19:53.237] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists PixelAlive_C0 .. PixelAlive_C15
[11:19:53.506] INFO: PixTestAlive::aliveTest() done
[11:19:53.506] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:19:53.506] DEBUG: <PixTestAlive.cc/aliveTest:L199> number of red-efficiency pixels: 19 13 40 47 61 45 45 50 50 53 55 43 48 35 23 16
[11:19:53.529] INFO: ----------------------------------------------------------------------
[11:19:53.529] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:19:53.529] INFO: ----------------------------------------------------------------------
[11:19:53.531] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:19:53.905] INFO: Expecting 41600 events.
[11:19:56.947] INFO: 41600 events read in total (2327ms).
[11:19:56.948] INFO: Test took 3417ms.
[11:19:56.948] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:19:56.948] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 0
[11:19:56.948] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists MaskTest_C0 .. MaskTest_C15
[11:19:56.948] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:19:57.370] INFO: PixTestAlive::maskTest() done
[11:19:57.370] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:19:57.389] INFO: ----------------------------------------------------------------------
[11:19:57.389] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:19:57.389] INFO: ----------------------------------------------------------------------
[11:19:57.391] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:19:57.765] INFO: Expecting 41600 events.
[11:20:02.004] INFO: 41600 events read in total (3524ms).
[11:20:02.006] INFO: Test took 4615ms.
[11:20:02.017] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:02.017] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[11:20:02.017] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists AddressDecodingTest_C0 .. AddressDecodingTest_C15
[11:20:02.389] INFO: PixTestAlive::addressDecodingTest() done
[11:20:02.389] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:20:02.389] INFO: PixTestAlive::doTest() done, duration: 13 seconds
[11:20:09.683] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[11:20:09.683] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = PixelAlive_C4_V0 -> PixelAlive_mod
[11:20:11.779] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): caldelscan
[11:20:11.779] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: caldelscan
[11:20:11.779] INFO: ----------------------------------------------------------------------
[11:20:11.779] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[11:20:11.779] INFO: ----------------------------------------------------------------------
[11:20:11.918] INFO: Expecting 768 events.
[11:20:13.050] INFO: 768 events read in total (417ms).
[11:20:13.050] INFO: Test took 1266ms.
[11:20:13.056] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:20:13.854] INFO: Expecting 41600 events.
[11:20:17.223] INFO: 41600 events read in total (2843ms).
[11:20:17.228] INFO: Test took 4172ms.
[11:20:17.331] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:17.331] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 599392
[11:20:17.331] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step0_C0 .. HR_xeff_CalDelScan_step0_C15
[11:20:17.331] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:20:17.377] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:20:18.042] INFO: Expecting 41600 events.
[11:20:21.501] INFO: 41600 events read in total (2932ms).
[11:20:21.506] INFO: Test took 4129ms.
[11:20:21.607] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:21.607] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 606342
[11:20:21.608] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step1_C0 .. HR_xeff_CalDelScan_step1_C15
[11:20:21.608] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:20:21.656] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:20:22.322] INFO: Expecting 41600 events.
[11:20:25.810] INFO: 41600 events read in total (2962ms).
[11:20:25.814] INFO: Test took 4158ms.
[11:20:25.918] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:25.919] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 606102
[11:20:25.919] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step2_C0 .. HR_xeff_CalDelScan_step2_C15
[11:20:25.919] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:20:25.967] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:20:26.632] INFO: Expecting 41600 events.
[11:20:30.120] INFO: 41600 events read in total (2961ms).
[11:20:30.124] INFO: Test took 4157ms.
[11:20:30.228] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:30.228] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 606742
[11:20:30.228] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step3_C0 .. HR_xeff_CalDelScan_step3_C15
[11:20:30.228] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:20:30.277] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:20:30.941] INFO: Expecting 41600 events.
[11:20:34.430] INFO: 41600 events read in total (2962ms).
[11:20:34.434] INFO: Test took 4157ms.
[11:20:34.538] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:34.538] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 607262
[11:20:34.538] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step4_C0 .. HR_xeff_CalDelScan_step4_C15
[11:20:34.539] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:20:34.587] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:20:35.252] INFO: Expecting 41600 events.
[11:20:38.752] INFO: 41600 events read in total (2973ms).
[11:20:38.756] INFO: Test took 4169ms.
[11:20:38.858] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:38.858] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 608316
[11:20:38.858] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step5_C0 .. HR_xeff_CalDelScan_step5_C15
[11:20:38.859] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:20:38.907] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:20:39.572] INFO: Expecting 41600 events.
[11:20:43.062] INFO: 41600 events read in total (2963ms).
[11:20:43.067] INFO: Test took 4160ms.
[11:20:43.169] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:43.169] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 607953
[11:20:43.169] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step6_C0 .. HR_xeff_CalDelScan_step6_C15
[11:20:43.170] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:20:43.218] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:20:43.883] INFO: Expecting 41600 events.
[11:20:47.380] INFO: 41600 events read in total (2970ms).
[11:20:47.384] INFO: Test took 4166ms.
[11:20:47.488] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:47.488] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 608704
[11:20:47.488] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step7_C0 .. HR_xeff_CalDelScan_step7_C15
[11:20:47.488] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:20:47.536] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:20:48.201] INFO: Expecting 41600 events.
[11:20:51.706] INFO: 41600 events read in total (2978ms).
[11:20:51.710] INFO: Test took 4174ms.
[11:20:51.812] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:51.812] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 607786
[11:20:51.812] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step8_C0 .. HR_xeff_CalDelScan_step8_C15
[11:20:51.813] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:20:51.861] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:20:52.526] INFO: Expecting 41600 events.
[11:20:56.037] INFO: 41600 events read in total (2984ms).
[11:20:56.041] INFO: Test took 4180ms.
[11:20:56.145] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:56.145] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 606888
[11:20:56.145] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step9_C0 .. HR_xeff_CalDelScan_step9_C15
[11:20:56.145] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:20:56.193] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:20:56.858] INFO: Expecting 41600 events.
[11:21:00.359] INFO: 41600 events read in total (2974ms).
[11:21:00.364] INFO: Test took 4171ms.
[11:21:00.466] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:00.466] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 606798
[11:21:00.466] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step10_C0 .. HR_xeff_CalDelScan_step10_C15
[11:21:00.467] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:21:00.515] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:21:01.181] INFO: Expecting 41600 events.
[11:21:04.689] INFO: 41600 events read in total (2982ms).
[11:21:04.693] INFO: Test took 4178ms.
[11:21:04.797] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:04.797] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 607607
[11:21:04.798] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step11_C0 .. HR_xeff_CalDelScan_step11_C15
[11:21:04.798] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:21:04.847] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:21:05.512] INFO: Expecting 41600 events.
[11:21:09.013] INFO: 41600 events read in total (2974ms).
[11:21:09.017] INFO: Test took 4170ms.
[11:21:09.120] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:09.120] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 607576
[11:21:09.120] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step12_C0 .. HR_xeff_CalDelScan_step12_C15
[11:21:09.120] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:21:09.168] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:21:09.833] INFO: Expecting 41600 events.
[11:21:13.341] INFO: 41600 events read in total (2981ms).
[11:21:13.345] INFO: Test took 4177ms.
[11:21:13.449] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:13.449] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 606817
[11:21:13.449] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step13_C0 .. HR_xeff_CalDelScan_step13_C15
[11:21:13.449] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:21:13.498] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:21:14.163] INFO: Expecting 41600 events.
[11:21:17.666] INFO: 41600 events read in total (2977ms).
[11:21:17.671] INFO: Test took 4173ms.
[11:21:17.773] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:17.773] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 606382
[11:21:17.773] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step14_C0 .. HR_xeff_CalDelScan_step14_C15
[11:21:17.774] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:21:17.823] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:21:18.488] INFO: Expecting 41600 events.
[11:21:21.997] INFO: 41600 events read in total (2982ms).
[11:21:22.002] INFO: Test took 4179ms.
[11:21:22.105] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:22.105] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 607361
[11:21:22.105] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step15_C0 .. HR_xeff_CalDelScan_step15_C15
[11:21:22.105] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:21:22.154] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:21:22.819] INFO: Expecting 41600 events.
[11:21:26.320] INFO: 41600 events read in total (2974ms).
[11:21:26.325] INFO: Test took 4171ms.
[11:21:26.428] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:26.428] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 606237
[11:21:26.428] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step16_C0 .. HR_xeff_CalDelScan_step16_C15
[11:21:26.428] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:21:26.477] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:21:27.143] INFO: Expecting 41600 events.
[11:21:30.643] INFO: 41600 events read in total (2974ms).
[11:21:30.648] INFO: Test took 4171ms.
[11:21:30.795] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:30.795] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 607065
[11:21:30.795] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step17_C0 .. HR_xeff_CalDelScan_step17_C15
[11:21:30.796] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:21:30.844] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:21:31.509] INFO: Expecting 41600 events.
[11:21:34.954] INFO: 41600 events read in total (2918ms).
[11:21:34.960] INFO: Test took 4116ms.
[11:21:35.065] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:35.065] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 605013
[11:21:35.065] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step18_C0 .. HR_xeff_CalDelScan_step18_C15
[11:21:35.065] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:21:35.114] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:21:35.780] INFO: Expecting 41600 events.
[11:21:39.053] INFO: 41600 events read in total (2747ms).
[11:21:39.058] INFO: Test took 3943ms.
[11:21:39.155] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:39.156] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 595739
[11:21:39.156] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step19_C0 .. HR_xeff_CalDelScan_step19_C15
[11:21:39.156] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:21:39.425] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 0: caldel = 140 eff = 0.999688
[11:21:39.425] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 1: caldel = 147 eff = 0.999639
[11:21:39.425] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 2: caldel = 147 eff = 0.999207
[11:21:39.425] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 3: caldel = 146 eff = 0.998389
[11:21:39.425] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 4: caldel = 162 eff = 0.998101
[11:21:39.426] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 5: caldel = 159 eff = 0.998053
[11:21:39.426] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 6: caldel = 154 eff = 0.998125
[11:21:39.426] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 7: caldel = 124 eff = 0.959808
[11:21:39.426] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 8: caldel = 153 eff = 0.998149
[11:21:39.426] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 9: caldel = 160 eff = 0.998293
[11:21:39.426] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 10: caldel = 145 eff = 0.998173
[11:21:39.426] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 11: caldel = 146 eff = 0.998365
[11:21:39.427] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 12: caldel = 158 eff = 0.998413
[11:21:39.427] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 13: caldel = 135 eff = 0.999063
[11:21:39.427] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 14: caldel = 139 eff = 0.999591
[11:21:39.427] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 15: caldel = 120 eff = 0.999639
[11:21:59.299] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): xpixelalive
[11:21:59.299] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: xpixelalive
[11:21:59.299] INFO: ----------------------------------------------------------------------
[11:21:59.299] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:21:59.299] INFO: ----------------------------------------------------------------------
[11:21:59.299] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: clk: 4
[11:21:59.299] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: ctr: 4
[11:21:59.299] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: sda: 19
[11:21:59.299] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: tin: 9
[11:21:59.299] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: level: 15
[11:21:59.299] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: triggerdelay: 0
[11:21:59.299] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: clk: 4
[11:21:59.299] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: ctr: 4
[11:21:59.299] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: sda: 19
[11:21:59.299] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: tin: 9
[11:21:59.299] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: level: 15
[11:21:59.299] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: triggerdelay: 20
[11:21:59.315] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:21:59.982] INFO: Expecting 208000 events.
[11:22:13.498] INFO: 208000 events read in total (12990ms).
[11:22:13.513] INFO: Test took 14197ms.
[11:22:13.994] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:22:13.994] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 2747525
[11:22:13.994] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists highRate_C0 .. highRate_C15
[11:22:13.995] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:22:14.408] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 160 0 0 0 0 0 0 0 0
[11:22:14.408] INFO: number of red-efficiency pixels: 92 97 212 321 392 384 320 584 436 421 393 350 341 291 118 125
[11:22:14.408] INFO: number of X-ray hits detected: 85663 80280 137346 202425 219438 210190 209931 189998 215041 223717 217920 200078 195848 132379 80914 79957
[11:22:14.409] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:22:14.409] INFO: number of Vcal hits detected: 207904 207902 207777 207656 207571 207578 207667 199549 207534 207548 207588 207618 207572 207684 207881 207871
[11:22:14.409] INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 99.9 99.8 99.8 99.8 99.9 99.8 99.8 99.8 99.8 99.8 99.8 99.9 99.9 99.9
[11:22:14.409] INFO: Vcal hit overall efficiency (%): 100.0 100.0 99.9 99.8 99.8 99.8 99.8 95.9 99.8 99.8 99.8 99.8 99.8 99.8 99.9 99.9
[11:22:14.409] INFO: X-ray hit rate [MHz/cm2]: 25.1 23.5 40.3 59.3 64.3 61.6 61.5 55.7 63.0 65.6 63.9 58.6 57.4 38.8 23.7 23.4
[11:22:14.409] INFO: PixTestHighRate::doXPixelAlive() done
[11:22:14.453] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: clk: 4
[11:22:14.453] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: ctr: 4
[11:22:14.453] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: sda: 19
[11:22:14.453] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: tin: 9
[11:22:14.453] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: level: 15
[11:22:14.453] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: triggerdelay: 0
[11:22:14.453] INFO: PixTest:: pg_setup set to default.
[11:22:18.883] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[11:22:18.883] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = highRate_xraymap_C10_V0 -> highRate_xraymap_mod
[11:22:20.267] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[11:22:20.268] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 393.1mA
[11:22:20.268] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 471.9mA
[11:22:20.268] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.4 C
[11:22:20.268] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[11:22:20.269] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[11:22:20.269] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[11:22:20.269] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[11:22:20.269] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[11:22:20.269] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[11:22:20.269] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[11:22:20.269] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[11:22:20.269] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[11:22:20.269] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[11:22:20.358] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[11:22:20.358] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[11:22:20.371] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[11:22:20.371] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[11:22:20.371] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[11:22:20.371] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[11:22:20.371] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[11:22:20.371] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[11:22:20.374] QUIET: Connection to board 58 closed.
[11:22:20.453] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrEff_120.log
[11:16:47.260] INFO: *** Welcome to pxar ***
[11:16:47.260] INFO: *** Today: 2016/07/20
[11:16:47.312] INFO: *** Version: v1.9.0-814-g7497
[11:16:47.312] INFO: readRocDacs: data/mp220/dacParameters35_C0.dat .. data/mp220/dacParameters35_C15.dat
[11:16:47.313] INFO: readTbmDacs: data/mp220/tbmParameters_C0a.dat .. data/mp220/tbmParameters_C0b.dat
[11:16:47.313] INFO: readMaskFile: data/mp220/defaultMaskFile.dat
[11:16:47.313] INFO: readTrimFile: data/mp220/trimParameters35_C0.dat .. data/mp220/trimParameters35_C15.dat
[11:16:47.462] INFO: clk: 4
[11:16:47.462] INFO: ctr: 4
[11:16:47.462] INFO: sda: 19
[11:16:47.462] INFO: tin: 9
[11:16:47.462] INFO: level: 15
[11:16:47.462] INFO: triggerdelay: 0
[11:16:47.462] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[11:16:47.462] INFO: Log level: DEBUG
[11:16:47.473] QUIET: Connection to board DTB_WRPRHI opened.
[11:16:47.476] 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:
------------------------------------------------------
[11:16:47.479] INFO: RPC call hashes of host and DTB match: 398089610
[11:16:49.079] INFO: DUT info:
[11:16:49.079] INFO: The DUT currently contains the following objects:
[11:16:49.079] INFO: 2 TBM Cores tbm08c (2 ON)
[11:16:49.079] INFO: TBM Core alpha (0): 7 registers set
[11:16:49.079] INFO: TBM Core beta (1): 7 registers set
[11:16:49.079] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:16:49.079] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:49.079] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:49.079] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:49.079] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:49.079] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:49.079] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:49.079] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:49.079] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:49.079] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:49.079] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:49.079] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:49.079] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:49.079] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:49.079] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:49.079] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:49.079] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[11:16:49.080] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[11:16:49.081] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[11:16:49.082] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[11:16:49.084] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 32768000
[11:16:49.084] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0xc870d0
[11:16:49.085] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0xa29360
[11:16:49.085] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f1f05d94010
[11:16:49.085] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f1f0bfff510
[11:16:49.085] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 32776192 fPxarMemory = 0x7f1f05d94010
[11:16:49.086] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 388.3mA
[11:16:49.087] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 471.1mA
[11:16:49.087] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.2 C
[11:16:49.600] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x1071cc0
[11:16:49.660] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[11:16:49.660] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[11:16:49.661] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[11:16:49.666] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[11:16:49.666] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[11:16:49.666] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[11:16:49.677] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[11:16:49.677] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[11:16:49.687] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[11:16:49.687] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[11:16:49.705] INFO: PixTestCmd::init()
[11:16:49.710] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[11:16:49.711] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[11:16:49.711] INFO: readGainPedestalParameters data/mp220/phCalibrationFitErr35_C0.dat .. data/mp220/phCalibrationFitErr35_C15.dat
[11:16:49.958] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[11:16:49.958] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[11:16:49.972] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[11:16:49.977] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[11:16:49.978] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[11:16:49.978] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[11:16:49.999] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[11:16:49.999] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[11:16:49.999] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[11:16:49.999] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[11:16:49.999] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[11:16:50.005] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[11:16:50.005] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[11:16:50.018] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[11:16:50.018] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[11:16:50.019] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[11:16:50.019] INFO: readReadbackCal: data/mp220/readbackCal_C0.dat .. data/mp220/readbackCal_C15.dat
[11:16:50.029] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[11:16:50.037] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[11:16:50.037] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[11:16:50.037] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[11:16:50.037] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[11:16:50.049] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[11:16:50.049] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[11:16:55.982] INFO: ######################################################################
[11:16:55.982] INFO: PixTestAlive::doTest()
[11:16:55.982] INFO: ######################################################################
[11:16:55.985] INFO: ----------------------------------------------------------------------
[11:16:55.985] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:16:55.985] INFO: ----------------------------------------------------------------------
[11:16:55.987] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:16:56.363] INFO: Expecting 41600 events.
[11:17:00.619] INFO: 41600 events read in total (3538ms).
[11:17:00.768] INFO: Test took 4781ms.
[11:17:00.778] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:17:00.778] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[11:17:00.778] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists PixelAlive_C0 .. PixelAlive_C15
[11:17:01.047] INFO: PixTestAlive::aliveTest() done
[11:17:01.047] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:17:01.048] DEBUG: <PixTestAlive.cc/aliveTest:L199> number of red-efficiency pixels: 31 29 47 49 56 63 63 67 58 66 64 71 73 42 29 23
[11:17:01.070] INFO: ----------------------------------------------------------------------
[11:17:01.070] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:17:01.070] INFO: ----------------------------------------------------------------------
[11:17:01.073] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:17:01.447] INFO: Expecting 41600 events.
[11:17:04.494] INFO: 41600 events read in total (2331ms).
[11:17:04.494] INFO: Test took 3421ms.
[11:17:04.494] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:17:04.494] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 0
[11:17:04.495] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists MaskTest_C0 .. MaskTest_C15
[11:17:04.495] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:17:04.916] INFO: PixTestAlive::maskTest() done
[11:17:04.916] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:17:04.934] INFO: ----------------------------------------------------------------------
[11:17:04.934] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:17:04.934] INFO: ----------------------------------------------------------------------
[11:17:04.937] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:17:05.311] INFO: Expecting 41600 events.
[11:17:09.556] INFO: 41600 events read in total (3530ms).
[11:17:09.557] INFO: Test took 4620ms.
[11:17:09.567] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:17:09.567] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[11:17:09.567] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists AddressDecodingTest_C0 .. AddressDecodingTest_C15
[11:17:09.940] INFO: PixTestAlive::addressDecodingTest() done
[11:17:09.940] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:17:09.940] INFO: PixTestAlive::doTest() done, duration: 13 seconds
[11:17:18.203] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[11:17:18.203] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = PixelAlive_C3_V0 -> PixelAlive_mod
[11:17:20.259] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): caldelscan
[11:17:20.259] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: caldelscan
[11:17:20.259] INFO: ----------------------------------------------------------------------
[11:17:20.259] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[11:17:20.259] INFO: ----------------------------------------------------------------------
[11:17:20.398] INFO: Expecting 768 events.
[11:17:21.530] INFO: 768 events read in total (417ms).
[11:17:21.531] INFO: Test took 1267ms.
[11:17:21.536] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:17:22.334] INFO: Expecting 41600 events.
[11:17:25.925] INFO: 41600 events read in total (3064ms).
[11:17:25.930] INFO: Test took 4393ms.
[11:17:26.064] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:17:26.065] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 776142
[11:17:26.065] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step0_C0 .. HR_xeff_CalDelScan_step0_C15
[11:17:26.065] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:17:26.123] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:17:26.789] INFO: Expecting 41600 events.
[11:17:30.447] INFO: 41600 events read in total (3131ms).
[11:17:30.452] INFO: Test took 4329ms.
[11:17:30.582] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:17:30.582] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 782958
[11:17:30.582] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step1_C0 .. HR_xeff_CalDelScan_step1_C15
[11:17:30.583] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:17:30.641] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:17:31.307] INFO: Expecting 41600 events.
[11:17:34.983] INFO: 41600 events read in total (3150ms).
[11:17:34.989] INFO: Test took 4348ms.
[11:17:35.119] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:17:35.119] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 784256
[11:17:35.119] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step2_C0 .. HR_xeff_CalDelScan_step2_C15
[11:17:35.119] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:17:35.180] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:17:35.846] INFO: Expecting 41600 events.
[11:17:39.526] INFO: 41600 events read in total (3154ms).
[11:17:39.531] INFO: Test took 4351ms.
[11:17:39.660] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:17:39.660] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 785527
[11:17:39.660] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step3_C0 .. HR_xeff_CalDelScan_step3_C15
[11:17:39.660] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:17:39.721] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:17:40.387] INFO: Expecting 41600 events.
[11:17:44.061] INFO: 41600 events read in total (3147ms).
[11:17:44.066] INFO: Test took 4345ms.
[11:17:44.222] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:17:44.222] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 783042
[11:17:44.222] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step4_C0 .. HR_xeff_CalDelScan_step4_C15
[11:17:44.222] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:17:44.282] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:17:44.948] INFO: Expecting 41600 events.
[11:17:48.631] INFO: 41600 events read in total (3157ms).
[11:17:48.636] INFO: Test took 4354ms.
[11:17:48.766] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:17:48.766] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 784562
[11:17:48.766] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step5_C0 .. HR_xeff_CalDelScan_step5_C15
[11:17:48.766] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:17:48.826] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:17:49.492] INFO: Expecting 41600 events.
[11:17:53.199] INFO: 41600 events read in total (3181ms).
[11:17:53.204] INFO: Test took 4378ms.
[11:17:53.362] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:17:53.362] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 784980
[11:17:53.362] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step6_C0 .. HR_xeff_CalDelScan_step6_C15
[11:17:53.363] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:17:53.423] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:17:54.089] INFO: Expecting 41600 events.
[11:17:57.810] INFO: 41600 events read in total (3195ms).
[11:17:57.815] INFO: Test took 4392ms.
[11:17:57.944] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:17:57.944] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 786108
[11:17:57.944] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step7_C0 .. HR_xeff_CalDelScan_step7_C15
[11:17:57.945] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:17:58.004] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:17:58.669] INFO: Expecting 41600 events.
[11:18:02.376] INFO: 41600 events read in total (3180ms).
[11:18:02.381] INFO: Test took 4377ms.
[11:18:02.632] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:18:02.632] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 783302
[11:18:02.632] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step8_C0 .. HR_xeff_CalDelScan_step8_C15
[11:18:02.633] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:18:02.692] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:18:03.358] INFO: Expecting 41600 events.
[11:18:07.071] INFO: 41600 events read in total (3187ms).
[11:18:07.076] INFO: Test took 4384ms.
[11:18:07.243] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:18:07.243] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 784809
[11:18:07.243] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step9_C0 .. HR_xeff_CalDelScan_step9_C15
[11:18:07.244] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:18:07.305] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:18:07.971] INFO: Expecting 41600 events.
[11:18:11.686] INFO: 41600 events read in total (3189ms).
[11:18:11.691] INFO: Test took 4386ms.
[11:18:11.821] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:18:11.821] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 785413
[11:18:11.821] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step10_C0 .. HR_xeff_CalDelScan_step10_C15
[11:18:11.821] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:18:11.882] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:18:12.547] INFO: Expecting 41600 events.
[11:18:16.259] INFO: 41600 events read in total (3186ms).
[11:18:16.264] INFO: Test took 4382ms.
[11:18:16.394] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:18:16.395] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 785034
[11:18:16.395] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step11_C0 .. HR_xeff_CalDelScan_step11_C15
[11:18:16.395] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:18:16.455] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:18:17.120] INFO: Expecting 41600 events.
[11:18:20.839] INFO: 41600 events read in total (3192ms).
[11:18:20.844] INFO: Test took 4389ms.
[11:18:21.008] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:18:21.008] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 785078
[11:18:21.008] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step12_C0 .. HR_xeff_CalDelScan_step12_C15
[11:18:21.009] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:18:21.069] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:18:21.734] INFO: Expecting 41600 events.
[11:18:25.452] INFO: 41600 events read in total (3191ms).
[11:18:25.457] INFO: Test took 4388ms.
[11:18:25.589] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:18:25.589] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 785306
[11:18:25.590] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step13_C0 .. HR_xeff_CalDelScan_step13_C15
[11:18:25.590] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:18:25.650] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:18:26.316] INFO: Expecting 41600 events.
[11:18:30.027] INFO: 41600 events read in total (3184ms).
[11:18:30.032] INFO: Test took 4382ms.
[11:18:30.162] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:18:30.162] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 783989
[11:18:30.162] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step14_C0 .. HR_xeff_CalDelScan_step14_C15
[11:18:30.163] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:18:30.223] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:18:30.889] INFO: Expecting 41600 events.
[11:18:34.601] INFO: 41600 events read in total (3186ms).
[11:18:34.606] INFO: Test took 4383ms.
[11:18:34.737] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:18:34.737] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 784544
[11:18:34.737] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step15_C0 .. HR_xeff_CalDelScan_step15_C15
[11:18:34.737] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:18:34.798] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:18:35.463] INFO: Expecting 41600 events.
[11:18:39.175] INFO: 41600 events read in total (3185ms).
[11:18:39.180] INFO: Test took 4382ms.
[11:18:39.308] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:18:39.308] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 784927
[11:18:39.308] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step16_C0 .. HR_xeff_CalDelScan_step16_C15
[11:18:39.308] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:18:39.369] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:18:40.034] INFO: Expecting 41600 events.
[11:18:43.747] INFO: 41600 events read in total (3186ms).
[11:18:43.752] INFO: Test took 4383ms.
[11:18:43.879] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:18:43.879] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 783244
[11:18:43.879] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step17_C0 .. HR_xeff_CalDelScan_step17_C15
[11:18:43.879] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:18:43.940] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:18:44.605] INFO: Expecting 41600 events.
[11:18:48.260] INFO: 41600 events read in total (3128ms).
[11:18:48.265] INFO: Test took 4325ms.
[11:18:48.394] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:18:48.394] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 783347
[11:18:48.394] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step18_C0 .. HR_xeff_CalDelScan_step18_C15
[11:18:48.394] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:18:48.454] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:18:49.119] INFO: Expecting 41600 events.
[11:18:52.577] INFO: 41600 events read in total (2931ms).
[11:18:52.582] INFO: Test took 4128ms.
[11:18:52.708] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:18:52.708] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 773416
[11:18:52.708] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step19_C0 .. HR_xeff_CalDelScan_step19_C15
[11:18:52.708] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:18:52.988] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 0: caldel = 121 eff = 0.999423
[11:18:52.989] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 1: caldel = 147 eff = 0.999351
[11:18:52.989] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 2: caldel = 150 eff = 0.997837
[11:18:52.989] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 3: caldel = 146 eff = 0.996707
[11:18:52.989] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 4: caldel = 159 eff = 0.996298
[11:18:52.990] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 5: caldel = 158 eff = 0.997308
[11:18:52.990] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 6: caldel = 155 eff = 0.997091
[11:18:52.990] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 7: caldel = 144 eff = 0.95851
[11:18:52.990] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 8: caldel = 155 eff = 0.996827
[11:18:52.991] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 9: caldel = 163 eff = 0.995962
[11:18:52.991] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 10: caldel = 144 eff = 0.995721
[11:18:52.991] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 11: caldel = 146 eff = 0.99649
[11:18:52.991] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 12: caldel = 155 eff = 0.997308
[11:18:52.992] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 13: caldel = 155 eff = 0.99851
[11:18:52.992] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 14: caldel = 142 eff = 0.999351
[11:18:52.992] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 15: caldel = 134 eff = 0.999375
[11:19:00.747] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): xpixelalive
[11:19:00.747] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: xpixelalive
[11:19:00.747] INFO: ----------------------------------------------------------------------
[11:19:00.747] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:19:00.747] INFO: ----------------------------------------------------------------------
[11:19:00.747] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: clk: 4
[11:19:00.747] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: ctr: 4
[11:19:00.747] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: sda: 19
[11:19:00.747] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: tin: 9
[11:19:00.747] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: level: 15
[11:19:00.747] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: triggerdelay: 0
[11:19:00.747] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: clk: 4
[11:19:00.747] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: ctr: 4
[11:19:00.747] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: sda: 19
[11:19:00.747] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: tin: 9
[11:19:00.747] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: level: 15
[11:19:00.747] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: triggerdelay: 20
[11:19:00.763] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[11:19:01.429] INFO: Expecting 208000 events.
[11:19:16.403] INFO: 208000 events read in total (14448ms).
[11:19:16.422] INFO: Test took 15659ms.
[11:19:17.098] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:19:17.098] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 3615368
[11:19:17.098] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists highRate_C0 .. highRate_C15
[11:19:17.099] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[11:19:17.567] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 160 0 0 0 0 0 0 0 0
[11:19:17.567] INFO: number of red-efficiency pixels: 174 150 406 602 639 624 577 697 642 696 722 647 548 303 161 158
[11:19:17.567] INFO: number of X-ray hits detected: 113820 106241 181560 267903 291912 278127 277076 251699 284079 295124 288785 264363 260014 174253 107997 106015
[11:19:17.567] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:19:17.567] INFO: number of Vcal hits detected: 207814 207845 207512 207335 207282 207303 207364 199413 207289 207212 207188 207265 207398 207663 207832 207836
[11:19:17.567] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.8 99.7 99.7 99.7 99.7 99.7 99.7 99.7 99.6 99.7 99.7 99.9 99.9 99.9
[11:19:17.567] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.8 99.7 99.7 99.7 99.7 95.9 99.7 99.6 99.6 99.6 99.7 99.8 99.9 99.9
[11:19:17.567] INFO: X-ray hit rate [MHz/cm2]: 33.4 31.1 53.2 78.5 85.6 81.5 81.2 73.8 83.3 86.5 84.6 77.5 76.2 51.1 31.7 31.1
[11:19:17.567] INFO: PixTestHighRate::doXPixelAlive() done
[11:19:17.612] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: clk: 4
[11:19:17.612] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: ctr: 4
[11:19:17.612] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: sda: 19
[11:19:17.612] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: tin: 9
[11:19:17.612] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: level: 15
[11:19:17.612] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: triggerdelay: 0
[11:19:17.612] INFO: PixTest:: pg_setup set to default.
[11:19:31.683] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[11:19:31.683] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = highRate_xraymap_C10_V0 -> highRate_xraymap_mod
[11:19:35.203] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[11:19:35.203] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 393.1mA
[11:19:35.204] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 471.1mA
[11:19:35.204] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.4 C
[11:19:35.204] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[11:19:35.205] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[11:19:35.205] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[11:19:35.205] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[11:19:35.205] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[11:19:35.205] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[11:19:35.205] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[11:19:35.205] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[11:19:35.205] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[11:19:35.205] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[11:19:35.323] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[11:19:35.323] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[11:19:35.336] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[11:19:35.336] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[11:19:35.336] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[11:19:35.336] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[11:19:35.337] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[11:19:35.337] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[11:19:35.339] QUIET: Connection to board 58 closed.
[11:19:35.418] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
MoReWeb-v0.5.1-901-g16ebcc5 on branch master