Test Date: 2016-10-11 09:45
Analysis date: 2016-10-11 12:12
Logfile
commander_PixelAlive.log
[07:46:00.667] <TB1> INFO: *** Welcome to pxar ***
[07:46:00.667] <TB1> INFO: *** Today: 2016/10/11
[07:46:00.759] <TB1> INFO: *** Version: f5d3-dirty
[07:46:00.759] <TB1> INFO: readRocDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//000_PixelAlive_p17//dacParameters35_C15.dat
[07:46:00.761] <TB1> INFO: readTbmDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//000_PixelAlive_p17//tbmParameters_C0b.dat
[07:46:00.761] <TB1> INFO: readMaskFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//000_PixelAlive_p17//defaultMaskFile.dat
[07:46:00.761] <TB1> INFO: readTrimFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//000_PixelAlive_p17//trimParameters35_C15.dat
[07:46:00.835] <TB1> INFO: clk: 4
[07:46:00.835] <TB1> INFO: ctr: 4
[07:46:00.836] <TB1> INFO: sda: 19
[07:46:00.836] <TB1> INFO: tin: 9
[07:46:00.836] <TB1> INFO: level: 15
[07:46:00.836] <TB1> INFO: triggerdelay: 0
[07:46:00.836] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[07:46:00.836] <TB1> INFO: Log level: INFO
[07:46:00.848] <TB1> INFO: Found DTB DTB_WWXTQT
[07:46:00.858] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[07:46:00.859] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[07:46:00.861] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[07:46:02.426] <TB1> INFO: DUT info:
[07:46:02.426] <TB1> INFO: The DUT currently contains the following objects:
[07:46:02.426] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[07:46:02.426] <TB1> INFO: TBM Core alpha (0): 7 registers set
[07:46:02.426] <TB1> INFO: TBM Core beta (1): 7 registers set
[07:46:02.426] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[07:46:02.426] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[07:46:02.426] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[07:46:02.426] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[07:46:02.426] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[07:46:02.426] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[07:46:02.426] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[07:46:02.426] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[07:46:02.426] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[07:46:02.426] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[07:46:02.426] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[07:46:02.426] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[07:46:02.426] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[07:46:02.426] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[07:46:02.426] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[07:46:02.426] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[07:46:02.426] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[07:46:02.827] <TB1> INFO: enter 'restricted' command line mode
[07:46:02.827] <TB1> INFO: enter test to run
[07:46:02.827] <TB1> INFO: test: PixelAlive no parameter change
[07:46:02.827] <TB1> INFO: running: pixelalive
[07:46:02.832] <TB1> INFO: ######################################################################
[07:46:02.832] <TB1> INFO: PixTestAlive::doTest()
[07:46:02.832] <TB1> INFO: ######################################################################
[07:46:02.833] <TB1> INFO: ----------------------------------------------------------------------
[07:46:02.833] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[07:46:02.833] <TB1> INFO: ----------------------------------------------------------------------
[07:46:03.113] <TB1> INFO: Expecting 41600 events.
[07:46:06.308] <TB1> INFO: 41600 events read in total (2636ms).
[07:46:06.349] <TB1> INFO: Test took 3515ms.
[07:46:06.569] <TB1> INFO: PixTestAlive::aliveTest() done
[07:46:06.569] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[07:46:06.570] <TB1> INFO: ----------------------------------------------------------------------
[07:46:06.570] <TB1> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[07:46:06.570] <TB1> INFO: ----------------------------------------------------------------------
[07:46:06.825] <TB1> INFO: Expecting 41600 events.
[07:46:09.446] <TB1> INFO: 41600 events read in total (2065ms).
[07:46:09.446] <TB1> INFO: Test took 2874ms.
[07:46:09.447] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[07:46:09.686] <TB1> INFO: PixTestAlive::maskTest() done
[07:46:09.686] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[07:46:09.687] <TB1> INFO: ----------------------------------------------------------------------
[07:46:09.687] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[07:46:09.687] <TB1> INFO: ----------------------------------------------------------------------
[07:46:09.944] <TB1> INFO: Expecting 41600 events.
[07:46:13.236] <TB1> INFO: 41600 events read in total (2735ms).
[07:46:13.237] <TB1> INFO: Test took 3548ms.
[07:46:13.460] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[07:46:13.460] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[07:46:13.460] <TB1> INFO: PixTestAlive::doTest() done, duration: 10 seconds
[07:46:13.489] <TB1> INFO: enter test to run
[07:46:13.489] <TB1> INFO: test: no parameter change
[07:46:13.737] <TB1> QUIET: Connection to board 147 closed.
[07:46:13.817] <TB1> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[07:51:38.438] <TB1> INFO: *** Welcome to pxar ***
[07:51:38.438] <TB1> INFO: *** Today: 2016/10/11
[07:51:38.511] <TB1> INFO: *** Version: f5d3-dirty
[07:51:38.511] <TB1> INFO: readRocDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//dacParameters35_C15.dat
[07:51:38.512] <TB1> INFO: readTbmDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[07:51:38.512] <TB1> INFO: readMaskFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//defaultMaskFile.dat
[07:51:38.512] <TB1> INFO: readTrimFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C15.dat
[07:51:38.598] <TB1> INFO: clk: 4
[07:51:38.598] <TB1> INFO: ctr: 4
[07:51:38.598] <TB1> INFO: sda: 19
[07:51:38.598] <TB1> INFO: tin: 9
[07:51:38.598] <TB1> INFO: level: 15
[07:51:38.598] <TB1> INFO: triggerdelay: 0
[07:51:38.598] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[07:51:38.598] <TB1> INFO: Log level: INFO
[07:51:38.610] <TB1> INFO: Found DTB DTB_WWXTQT
[07:51:38.620] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[07:51:38.622] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[07:51:38.623] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[07:51:40.158] <TB1> INFO: DUT info:
[07:51:40.158] <TB1> INFO: The DUT currently contains the following objects:
[07:51:40.158] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[07:51:40.158] <TB1> INFO: TBM Core alpha (0): 7 registers set
[07:51:40.158] <TB1> INFO: TBM Core beta (1): 7 registers set
[07:51:40.158] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[07:51:40.158] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.559] <TB1> INFO: enter 'restricted' command line mode
[07:51:40.559] <TB1> INFO: enter test to run
[07:51:40.559] <TB1> INFO: test: delay setting parameters: ->5<-
[07:51:40.559] <TB1> INFO: delay test by 5 seconds...
[07:51:45.559] <TB1> INFO: enter test to run
[07:51:45.560] <TB1> INFO: test: highrate no parameter change
[07:51:45.560] <TB1> INFO: running: highrate
[07:51:45.560] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[07:51:45.693] <TB1> INFO: ----------------------------------------------------------------------
[07:51:45.693] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[07:51:45.693] <TB1> INFO: ----------------------------------------------------------------------
[07:51:45.693] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[07:51:45.693] <TB1> INFO: edge/corner pixel THR is adjusted
[07:51:45.693] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[07:51:46.410] <TB1> INFO: Collecting data for 1 seconds...
[07:51:47.411] <TB1> INFO: Done with hot pixel readout
[07:51:52.179] <TB1> INFO: PixTest:: pg_setup set to default.
[07:51:52.180] <TB1> INFO: 0 hot pixels found in step 0
[07:51:52.200] <TB1> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[07:51:52.227] <TB1> INFO: PixTest::trimHotPixels() done
[07:51:52.227] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C0.dat
[07:51:52.234] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C1.dat
[07:51:52.241] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C2.dat
[07:51:52.247] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C3.dat
[07:51:52.253] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C4.dat
[07:51:52.260] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C5.dat
[07:51:52.266] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C6.dat
[07:51:52.272] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C7.dat
[07:51:52.279] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C8.dat
[07:51:52.285] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C9.dat
[07:51:52.291] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C10.dat
[07:51:52.298] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C11.dat
[07:51:52.304] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C12.dat
[07:51:52.310] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C13.dat
[07:51:52.316] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C14.dat
[07:51:52.323] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C15.dat
[07:51:52.329] <TB1> INFO: write masked pixels into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//defaultMaskFile.dat
[07:51:52.360] <TB1> INFO: enter test to run
[07:51:52.360] <TB1> INFO: test: no parameter change
[07:51:52.575] <TB1> QUIET: Connection to board 147 closed.
[07:51:52.654] <TB1> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[07:51:38.438] <TB1> INFO: *** Welcome to pxar ***
[07:51:38.438] <TB1> INFO: *** Today: 2016/10/11
[07:51:38.511] <TB1> INFO: *** Version: f5d3-dirty
[07:51:38.511] <TB1> INFO: readRocDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//dacParameters35_C15.dat
[07:51:38.512] <TB1> INFO: readTbmDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[07:51:38.512] <TB1> INFO: readMaskFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//defaultMaskFile.dat
[07:51:38.512] <TB1> INFO: readTrimFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C15.dat
[07:51:38.598] <TB1> INFO: clk: 4
[07:51:38.598] <TB1> INFO: ctr: 4
[07:51:38.598] <TB1> INFO: sda: 19
[07:51:38.598] <TB1> INFO: tin: 9
[07:51:38.598] <TB1> INFO: level: 15
[07:51:38.598] <TB1> INFO: triggerdelay: 0
[07:51:38.598] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[07:51:38.598] <TB1> INFO: Log level: INFO
[07:51:38.610] <TB1> INFO: Found DTB DTB_WWXTQT
[07:51:38.620] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[07:51:38.622] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[07:51:38.623] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[07:51:40.158] <TB1> INFO: DUT info:
[07:51:40.158] <TB1> INFO: The DUT currently contains the following objects:
[07:51:40.158] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[07:51:40.158] <TB1> INFO: TBM Core alpha (0): 7 registers set
[07:51:40.158] <TB1> INFO: TBM Core beta (1): 7 registers set
[07:51:40.158] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[07:51:40.158] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.158] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[07:51:40.559] <TB1> INFO: enter 'restricted' command line mode
[07:51:40.559] <TB1> INFO: enter test to run
[07:51:40.559] <TB1> INFO: test: delay setting parameters: ->5<-
[07:51:40.559] <TB1> INFO: delay test by 5 seconds...
[07:51:45.559] <TB1> INFO: enter test to run
[07:51:45.560] <TB1> INFO: test: highrate no parameter change
[07:51:45.560] <TB1> INFO: running: highrate
[07:51:45.560] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[07:51:45.693] <TB1> INFO: ----------------------------------------------------------------------
[07:51:45.693] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[07:51:45.693] <TB1> INFO: ----------------------------------------------------------------------
[07:51:45.693] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[07:51:45.693] <TB1> INFO: edge/corner pixel THR is adjusted
[07:51:45.693] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[07:51:46.410] <TB1> INFO: Collecting data for 1 seconds...
[07:51:47.411] <TB1> INFO: Done with hot pixel readout
[07:51:52.179] <TB1> INFO: PixTest:: pg_setup set to default.
[07:51:52.180] <TB1> INFO: 0 hot pixels found in step 0
[07:51:52.200] <TB1> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[07:51:52.227] <TB1> INFO: PixTest::trimHotPixels() done
[07:51:52.227] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C0.dat
[07:51:52.234] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C1.dat
[07:51:52.241] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C2.dat
[07:51:52.247] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C3.dat
[07:51:52.253] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C4.dat
[07:51:52.260] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C5.dat
[07:51:52.266] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C6.dat
[07:51:52.272] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C7.dat
[07:51:52.279] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C8.dat
[07:51:52.285] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C9.dat
[07:51:52.291] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C10.dat
[07:51:52.298] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C11.dat
[07:51:52.304] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C12.dat
[07:51:52.310] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C13.dat
[07:51:52.316] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C14.dat
[07:51:52.323] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//trimParameters35_C15.dat
[07:51:52.329] <TB1> INFO: write masked pixels into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//002_RetrimHotPixels_150//defaultMaskFile.dat
[07:51:52.360] <TB1> INFO: enter test to run
[07:51:52.360] <TB1> INFO: test: no parameter change
[07:51:52.575] <TB1> QUIET: Connection to board 147 closed.
[07:51:52.654] <TB1> INFO: pXar: this is the end, my friend
[07:52:43.627] <TB1> INFO: *** Welcome to pxar ***
[07:52:43.627] <TB1> INFO: *** Today: 2016/10/11
[07:52:43.692] <TB1> INFO: *** Version: f5d3-dirty
[07:52:43.692] <TB1> INFO: readRocDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//dacParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//dacParameters35_C15.dat
[07:52:43.693] <TB1> INFO: readTbmDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//tbmParameters_C0a.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//tbmParameters_C0b.dat
[07:52:43.693] <TB1> INFO: readMaskFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//defaultMaskFile.dat
[07:52:43.693] <TB1> INFO: readTrimFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//trimParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//trimParameters35_C15.dat
[07:52:43.766] <TB1> INFO: clk: 4
[07:52:43.766] <TB1> INFO: ctr: 4
[07:52:43.766] <TB1> INFO: sda: 19
[07:52:43.766] <TB1> INFO: tin: 9
[07:52:43.766] <TB1> INFO: level: 15
[07:52:43.766] <TB1> INFO: triggerdelay: 0
[07:52:43.766] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[07:52:43.766] <TB1> INFO: Log level: INFO
[07:52:43.779] <TB1> INFO: Found DTB DTB_WWXTQT
[07:52:43.789] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[07:52:43.791] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[07:52:43.793] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[07:52:45.364] <TB1> INFO: DUT info:
[07:52:45.364] <TB1> INFO: The DUT currently contains the following objects:
[07:52:45.364] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[07:52:45.364] <TB1> INFO: TBM Core alpha (0): 7 registers set
[07:52:45.364] <TB1> INFO: TBM Core beta (1): 7 registers set
[07:52:45.364] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[07:52:45.364] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:45.365] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:45.365] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:45.365] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:45.365] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:45.365] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:45.365] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:45.365] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:45.365] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:45.365] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:45.365] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:45.365] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:45.365] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:45.365] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:45.365] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:45.365] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:45.766] <TB1> INFO: enter 'restricted' command line mode
[07:52:45.766] <TB1> INFO: enter test to run
[07:52:45.766] <TB1> INFO: test: delay setting parameters: ->5<-
[07:52:45.766] <TB1> INFO: delay test by 5 seconds...
[07:52:50.767] <TB1> INFO: enter test to run
[07:52:50.767] <TB1> INFO: test: highrate no parameter change
[07:52:50.767] <TB1> INFO: running: highrate
[07:52:50.767] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//phCalibrationFitErr35_C15.dat
[07:52:50.905] <TB1> INFO: ----------------------------------------------------------------------
[07:52:50.905] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[07:52:50.905] <TB1> INFO: ----------------------------------------------------------------------
[07:52:50.905] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[07:52:50.905] <TB1> INFO: edge/corner pixel THR is adjusted
[07:52:50.905] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[07:52:51.622] <TB1> INFO: Collecting data for 1 seconds...
[07:52:52.623] <TB1> INFO: Done with hot pixel readout
[07:52:55.613] <TB1> INFO: PixTest:: pg_setup set to default.
[07:52:55.623] <TB1> INFO: 0 hot pixels found in step 0
[07:52:55.630] <TB1> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[07:52:55.665] <TB1> INFO: PixTest::trimHotPixels() done
[07:52:55.665] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//trimParameters35_C0.dat
[07:52:55.671] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//trimParameters35_C1.dat
[07:52:55.677] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//trimParameters35_C2.dat
[07:52:55.683] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//trimParameters35_C3.dat
[07:52:55.689] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//trimParameters35_C4.dat
[07:52:55.695] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//trimParameters35_C5.dat
[07:52:55.702] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//trimParameters35_C6.dat
[07:52:55.708] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//trimParameters35_C7.dat
[07:52:55.714] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//trimParameters35_C8.dat
[07:52:55.720] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//trimParameters35_C9.dat
[07:52:55.726] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//trimParameters35_C10.dat
[07:52:55.732] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//trimParameters35_C11.dat
[07:52:55.738] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//trimParameters35_C12.dat
[07:52:55.744] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//trimParameters35_C13.dat
[07:52:55.750] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//trimParameters35_C14.dat
[07:52:55.756] <TB1> INFO: write trim parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//trimParameters35_C15.dat
[07:52:55.762] <TB1> INFO: write masked pixels into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//003_RetrimHotPixels_50//defaultMaskFile.dat
[07:52:55.793] <TB1> INFO: enter test to run
[07:52:55.793] <TB1> INFO: test: no parameter change
[07:52:56.031] <TB1> QUIET: Connection to board 147 closed.
[07:52:56.111] <TB1> INFO: pXar: this is the end, my friend
commander_HRData.log
[07:53:48.339] <TB1> INFO: *** Welcome to pxar ***
[07:53:48.339] <TB1> INFO: *** Today: 2016/10/11
[07:53:48.405] <TB1> INFO: *** Version: f5d3-dirty
[07:53:48.406] <TB1> INFO: readRocDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//004_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//004_HRData_50//dacParameters35_C15.dat
[07:53:48.407] <TB1> INFO: readTbmDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//004_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//004_HRData_50//tbmParameters_C0b.dat
[07:53:48.407] <TB1> INFO: readMaskFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//004_HRData_50//defaultMaskFile.dat
[07:53:48.407] <TB1> INFO: readTrimFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//004_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//004_HRData_50//trimParameters35_C15.dat
[07:53:48.499] <TB1> INFO: clk: 4
[07:53:48.499] <TB1> INFO: ctr: 4
[07:53:48.499] <TB1> INFO: sda: 19
[07:53:48.499] <TB1> INFO: tin: 9
[07:53:48.499] <TB1> INFO: level: 15
[07:53:48.499] <TB1> INFO: triggerdelay: 0
[07:53:48.499] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[07:53:48.499] <TB1> INFO: Log level: INFO
[07:53:48.512] <TB1> INFO: Found DTB DTB_WWXTQT
[07:53:48.522] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[07:53:48.524] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[07:53:48.526] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[07:53:50.080] <TB1> INFO: DUT info:
[07:53:50.080] <TB1> INFO: The DUT currently contains the following objects:
[07:53:50.080] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[07:53:50.080] <TB1> INFO: TBM Core alpha (0): 7 registers set
[07:53:50.080] <TB1> INFO: TBM Core beta (1): 7 registers set
[07:53:50.080] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[07:53:50.080] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[07:53:50.080] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[07:53:50.080] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[07:53:50.080] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[07:53:50.080] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[07:53:50.080] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[07:53:50.080] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[07:53:50.080] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[07:53:50.080] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[07:53:50.080] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[07:53:50.080] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[07:53:50.080] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[07:53:50.080] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[07:53:50.080] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[07:53:50.080] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[07:53:50.080] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[07:53:50.481] <TB1> INFO: enter 'restricted' command line mode
[07:53:50.481] <TB1> INFO: enter test to run
[07:53:50.481] <TB1> INFO: test: delay setting parameters: ->5<-
[07:53:50.481] <TB1> INFO: delay test by 5 seconds...
[07:53:55.481] <TB1> INFO: enter test to run
[07:53:55.481] <TB1> INFO: test: Xray no parameter change
[07:53:55.481] <TB1> INFO: running: xray
[07:53:55.482] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//004_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//004_HRData_50//phCalibrationFitErr35_C15.dat
[07:53:55.616] <TB1> INFO: ######################################################################
[07:53:55.616] <TB1> INFO: PixTestXray::doTest()
[07:53:55.616] <TB1> INFO: ######################################################################
[07:53:55.616] <TB1> INFO: ----------------------------------------------------------------------
[07:53:55.616] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[07:53:55.616] <TB1> INFO: ----------------------------------------------------------------------
[07:53:56.339] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[07:54:03.948] <TB1> INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[07:54:28.912] <TB1> INFO: Resuming triggers.
[07:54:36.527] <TB1> INFO: run duration 15 seconds, buffer almost full (81%), pausing triggers.
[07:55:02.697] <TB1> INFO: Resuming triggers.
[07:55:10.307] <TB1> INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[07:55:36.340] <TB1> INFO: Resuming triggers.
[07:55:43.947] <TB1> INFO: run duration 30 seconds, buffer almost full (81%), pausing triggers.
[07:56:09.799] <TB1> INFO: Resuming triggers.
[07:56:17.411] <TB1> INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[07:56:42.943] <TB1> INFO: Resuming triggers.
[07:56:50.551] <TB1> INFO: run duration 45 seconds, buffer almost full (81%), pausing triggers.
[07:57:16.617] <TB1> INFO: Resuming triggers.
[07:57:24.227] <TB1> INFO: run duration 53 seconds, buffer almost full (81%), pausing triggers.
[07:57:50.519] <TB1> INFO: Resuming triggers.
[07:57:58.127] <TB1> INFO: run duration 60 seconds, buffer almost full (81%), pausing triggers.
[07:58:24.204] <TB1> INFO: Resuming triggers.
[07:58:31.815] <TB1> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[07:58:57.993] <TB1> INFO: Resuming triggers.
[07:59:05.594] <TB1> INFO: run duration 76 seconds, buffer almost full (81%), pausing triggers.
[07:59:31.857] <TB1> INFO: Resuming triggers.
[07:59:39.458] <TB1> INFO: run duration 83 seconds, buffer almost full (81%), pausing triggers.
[08:00:06.742] <TB1> INFO: Resuming triggers.
[08:00:14.343] <TB1> INFO: run duration 91 seconds, buffer almost full (81%), pausing triggers.
[08:00:41.290] <TB1> INFO: Resuming triggers.
[08:00:48.895] <TB1> INFO: run duration 98 seconds, buffer almost full (81%), pausing triggers.
[08:01:12.935] <TB1> INFO: Resuming triggers.
[08:01:14.130] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[08:01:18.597] <TB1> INFO: PixTest:: pg_setup set to default.
[08:01:18.599] <TB1> INFO: PixTestXray::doPhRun() done
[08:01:18.599] <TB1> INFO: PixTestXray::doTest() done
[08:01:18.837] <TB1> INFO: enter test to run
[08:01:18.837] <TB1> INFO: test: no parameter change
[08:01:19.144] <TB1> QUIET: Connection to board 147 closed.
[08:01:19.223] <TB1> INFO: pXar: this is the end, my friend
commander_HRData.log
[08:02:03.314] <TB1> INFO: *** Welcome to pxar ***
[08:02:03.314] <TB1> INFO: *** Today: 2016/10/11
[08:02:03.384] <TB1> INFO: *** Version: f5d3-dirty
[08:02:03.384] <TB1> INFO: readRocDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//005_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//005_HRData_150//dacParameters35_C15.dat
[08:02:03.384] <TB1> INFO: readTbmDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//005_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//005_HRData_150//tbmParameters_C0b.dat
[08:02:03.384] <TB1> INFO: readMaskFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//005_HRData_150//defaultMaskFile.dat
[08:02:03.384] <TB1> INFO: readTrimFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//005_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//005_HRData_150//trimParameters35_C15.dat
[08:02:03.472] <TB1> INFO: clk: 4
[08:02:03.472] <TB1> INFO: ctr: 4
[08:02:03.472] <TB1> INFO: sda: 19
[08:02:03.472] <TB1> INFO: tin: 9
[08:02:03.472] <TB1> INFO: level: 15
[08:02:03.472] <TB1> INFO: triggerdelay: 0
[08:02:03.472] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[08:02:03.472] <TB1> INFO: Log level: INFO
[08:02:03.486] <TB1> INFO: Found DTB DTB_WWXTQT
[08:02:03.496] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[08:02:03.498] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[08:02:03.500] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[08:02:05.069] <TB1> INFO: DUT info:
[08:02:05.069] <TB1> INFO: The DUT currently contains the following objects:
[08:02:05.069] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[08:02:05.069] <TB1> INFO: TBM Core alpha (0): 7 registers set
[08:02:05.069] <TB1> INFO: TBM Core beta (1): 7 registers set
[08:02:05.069] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:02:05.069] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:02:05.069] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:02:05.069] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:02:05.069] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:02:05.069] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:02:05.069] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:02:05.069] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:02:05.069] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:02:05.069] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:02:05.069] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:02:05.069] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:02:05.069] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:02:05.069] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:02:05.069] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:02:05.069] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:02:05.069] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:02:05.470] <TB1> INFO: enter 'restricted' command line mode
[08:02:05.470] <TB1> INFO: enter test to run
[08:02:05.470] <TB1> INFO: test: delay setting parameters: ->5<-
[08:02:05.470] <TB1> INFO: delay test by 5 seconds...
[08:02:10.470] <TB1> INFO: enter test to run
[08:02:10.470] <TB1> INFO: test: Xray no parameter change
[08:02:10.470] <TB1> INFO: running: xray
[08:02:10.470] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//005_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//005_HRData_150//phCalibrationFitErr35_C15.dat
[08:02:10.601] <TB1> INFO: ######################################################################
[08:02:10.601] <TB1> INFO: PixTestXray::doTest()
[08:02:10.601] <TB1> INFO: ######################################################################
[08:02:10.601] <TB1> INFO: ----------------------------------------------------------------------
[08:02:10.601] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[08:02:10.601] <TB1> INFO: ----------------------------------------------------------------------
[08:02:11.323] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[08:02:15.551] <TB1> INFO: run duration 4 seconds, buffer almost full (81%), pausing triggers.
[08:02:41.084] <TB1> INFO: Resuming triggers.
[08:02:45.324] <TB1> INFO: run duration 8 seconds, buffer almost full (81%), pausing triggers.
[08:03:12.606] <TB1> INFO: Resuming triggers.
[08:03:16.841] <TB1> INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[08:03:28.162] <TB1> WARNING: Channel 1 ROC 1: Readback start marker after 5 readouts!

[08:03:28.162] <TB1> ERROR: <datapipe.cc/CheckEventValidity:L523> Channel 1 Number of ROCs (5) != Token Chain Length (4)

[08:03:28.163] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[08:03:28.163] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a1b7 8041 41c0 161 224e 75a 2869 41c0 4d5 244a 508 2242 521 2a45 43c0 84 242c 43c0 603 2245 e000 c000

[08:03:28.163] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a1b1 80c1 41c1 281 2a4d 2cb 284e 744 2260 43c1 8c 2040 80 244f 10d 2269 253 2665 43c1 149 2884 24a 2665 41c1 c9 2464 2c5 204c 35b 2263 e000 c000

[08:03:28.163] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a1b2 8001 41c0 10 240c 104 2a44 61b 2881 43c0 35b 2866 351 206a 6d9 244a 41c1 45d 2061 44d 204b 810 2262 43c1 e000 c000

[08:03:28.163] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a1b3 8041 41c0 60 2a44 44a 282f 440 2a45 74b 2045 41c1 d 204f 862 284f 852 2664 43c0 280 2444 4a0 244c 43c1 9b 2244 e0 224f 320 2889 602 2862 61a 2663 e000 c000

[08:03:28.163] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a1b4 80b1 43c0 43c3 c49 2128 d0d 20b4 41c0 6cb 2888 43c0 8b 2245 43c0 290 2a49 e000 c000

[08:03:28.163] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a1b5 80c1 41c0 10d 2864 50c 226f 541 2668 65d 2441 43c0 2c9 244f 660 224f 6d9 2846 41c0 41c0 159 2464 143 284f 545 246d e000 c000

[08:03:28.163] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a1b6 8001 41c0 2cd 2a62 353 266f 61d 2842 43c0 8c 224c 2c9 2a67 4cd 242f 4cd 2642 543 2646 614 244f 43c0 648 2660 64d 226d 804 2262 43c0 154 2848 44a 246c 822 2080 844 2847 e000 c000

[08:03:42.610] <TB1> INFO: Resuming triggers.
[08:03:46.846] <TB1> INFO: run duration 16 seconds, buffer almost full (81%), pausing triggers.
[08:04:13.401] <TB1> INFO: Resuming triggers.
[08:04:17.631] <TB1> INFO: run duration 21 seconds, buffer almost full (81%), pausing triggers.
[08:04:44.899] <TB1> INFO: Resuming triggers.
[08:04:49.127] <TB1> INFO: run duration 25 seconds, buffer almost full (81%), pausing triggers.
[08:05:15.942] <TB1> INFO: Resuming triggers.
[08:05:20.171] <TB1> INFO: run duration 29 seconds, buffer almost full (81%), pausing triggers.
[08:05:46.468] <TB1> INFO: Resuming triggers.
[08:05:50.693] <TB1> INFO: run duration 33 seconds, buffer almost full (81%), pausing triggers.
[08:06:17.087] <TB1> INFO: Resuming triggers.
[08:06:21.310] <TB1> INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[08:06:48.660] <TB1> INFO: Resuming triggers.
[08:06:52.886] <TB1> INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[08:07:20.992] <TB1> INFO: Resuming triggers.
[08:07:25.211] <TB1> INFO: run duration 46 seconds, buffer almost full (81%), pausing triggers.
[08:07:52.661] <TB1> INFO: Resuming triggers.
[08:07:56.879] <TB1> INFO: run duration 50 seconds, buffer almost full (81%), pausing triggers.
[08:08:24.145] <TB1> INFO: Resuming triggers.
[08:08:28.359] <TB1> INFO: run duration 54 seconds, buffer almost full (81%), pausing triggers.
[08:08:55.915] <TB1> INFO: Resuming triggers.
[08:09:00.125] <TB1> INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[08:09:26.770] <TB1> INFO: Resuming triggers.
[08:09:30.977] <TB1> INFO: run duration 63 seconds, buffer almost full (81%), pausing triggers.
[08:09:57.536] <TB1> INFO: Resuming triggers.
[08:10:01.742] <TB1> INFO: run duration 67 seconds, buffer almost full (81%), pausing triggers.
[08:10:29.250] <TB1> INFO: Resuming triggers.
[08:10:33.460] <TB1> INFO: run duration 71 seconds, buffer almost full (81%), pausing triggers.
[08:11:00.496] <TB1> INFO: Resuming triggers.
[08:11:04.701] <TB1> INFO: run duration 75 seconds, buffer almost full (81%), pausing triggers.
[08:11:32.350] <TB1> INFO: Resuming triggers.
[08:11:36.553] <TB1> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[08:12:03.709] <TB1> INFO: Resuming triggers.
[08:12:07.913] <TB1> INFO: run duration 84 seconds, buffer almost full (81%), pausing triggers.
[08:12:33.970] <TB1> INFO: Resuming triggers.
[08:12:38.172] <TB1> INFO: run duration 88 seconds, buffer almost full (81%), pausing triggers.
[08:13:04.541] <TB1> INFO: Resuming triggers.
[08:13:08.740] <TB1> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[08:13:33.339] <TB1> INFO: Resuming triggers.
[08:13:37.539] <TB1> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[08:14:02.325] <TB1> INFO: Resuming triggers.
[08:14:05.414] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[08:14:24.594] <TB1> INFO: PixTest:: pg_setup set to default.
[08:14:24.595] <TB1> INFO: PixTestXray::doPhRun() done
[08:14:24.595] <TB1> INFO: PixTestXray::doTest() done
[08:14:24.778] <TB1> INFO: enter test to run
[08:14:24.778] <TB1> INFO: test: no parameter change
[08:14:25.063] <TB1> QUIET: Connection to board 147 closed.
[08:14:25.146] <TB1> INFO: pXar: this is the end, my friend
commander_HRSCurves.log
[08:15:31.789] <TB1> INFO: *** Welcome to pxar ***
[08:15:31.789] <TB1> INFO: *** Today: 2016/10/11
[08:15:31.856] <TB1> INFO: *** Version: f5d3-dirty
[08:15:31.856] <TB1> INFO: readRocDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//006_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//006_HRSCurves_100//dacParameters35_C15.dat
[08:15:31.856] <TB1> INFO: readTbmDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//006_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//006_HRSCurves_100//tbmParameters_C0b.dat
[08:15:31.856] <TB1> INFO: readMaskFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//006_HRSCurves_100//defaultMaskFile.dat
[08:15:31.856] <TB1> INFO: readTrimFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//006_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//006_HRSCurves_100//trimParameters35_C15.dat
[08:15:31.926] <TB1> INFO: clk: 4
[08:15:31.926] <TB1> INFO: ctr: 4
[08:15:31.926] <TB1> INFO: sda: 19
[08:15:31.926] <TB1> INFO: tin: 9
[08:15:31.926] <TB1> INFO: level: 15
[08:15:31.926] <TB1> INFO: triggerdelay: 0
[08:15:31.926] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[08:15:31.926] <TB1> INFO: Log level: INFO
[08:15:31.938] <TB1> INFO: Found DTB DTB_WWXTQT
[08:15:31.948] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[08:15:31.950] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[08:15:31.951] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[08:15:33.521] <TB1> INFO: DUT info:
[08:15:33.522] <TB1> INFO: The DUT currently contains the following objects:
[08:15:33.522] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[08:15:33.522] <TB1> INFO: TBM Core alpha (0): 7 registers set
[08:15:33.522] <TB1> INFO: TBM Core beta (1): 7 registers set
[08:15:33.522] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:15:33.522] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:15:33.522] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:15:33.522] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:15:33.522] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:15:33.522] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:15:33.522] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:15:33.522] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:15:33.522] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:15:33.522] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:15:33.522] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:15:33.522] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:15:33.522] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:15:33.522] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:15:33.522] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:15:33.522] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:15:33.522] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:15:33.923] <TB1> INFO: enter 'restricted' command line mode
[08:15:33.923] <TB1> INFO: enter test to run
[08:15:33.923] <TB1> INFO: test: Highrate no parameter change
[08:15:33.923] <TB1> INFO: running: highrate
[08:15:33.923] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//006_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//006_HRSCurves_100//phCalibrationFitErr35_C15.dat
[08:15:34.063] <TB1> INFO: ----------------------------------------------------------------------
[08:15:34.063] <TB1> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[08:15:34.063] <TB1> INFO: ----------------------------------------------------------------------
[08:15:34.069] <TB1> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 896 (plus default)
[08:15:34.080] <TB1> INFO: dacScan step from 15 .. 34
[08:15:34.080] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[08:15:34.080] <TB1> INFO: run 1 of 1
[08:15:34.573] <TB1> INFO: Expecting 4160000 events.
[08:16:00.982] <TB1> INFO: 465950 events read in total (26006ms).
[08:16:27.260] <TB1> INFO: 934200 events read in total (52284ms).
[08:16:53.654] <TB1> INFO: 1402250 events read in total (78678ms).
[08:17:19.880] <TB1> INFO: 1870000 events read in total (104904ms).
[08:17:46.077] <TB1> INFO: 2337700 events read in total (131101ms).
[08:18:12.648] <TB1> INFO: 2805600 events read in total (157672ms).
[08:18:39.169] <TB1> INFO: 3273050 events read in total (184193ms).
[08:19:05.416] <TB1> INFO: 3740500 events read in total (210440ms).
[08:19:28.857] <TB1> INFO: 4160000 events read in total (233881ms).
[08:19:29.069] <TB1> INFO: Test took 234989ms.
commander_CalDelScanAndSaveDacs.log
[08:49:29.513] <TB1> INFO: *** Welcome to pxar ***
[08:49:29.513] <TB1> INFO: *** Today: 2016/10/11
[08:49:29.580] <TB1> INFO: *** Version: f5d3-dirty
[08:49:29.580] <TB1> INFO: readRocDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[08:49:29.581] <TB1> INFO: readTbmDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[08:49:29.581] <TB1> INFO: readMaskFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[08:49:29.581] <TB1> INFO: readTrimFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[08:49:29.655] <TB1> INFO: clk: 4
[08:49:29.655] <TB1> INFO: ctr: 4
[08:49:29.655] <TB1> INFO: sda: 19
[08:49:29.655] <TB1> INFO: tin: 9
[08:49:29.655] <TB1> INFO: level: 15
[08:49:29.655] <TB1> INFO: triggerdelay: 0
[08:49:29.655] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[08:49:29.655] <TB1> INFO: Log level: INFO
[08:49:29.668] <TB1> INFO: Found DTB DTB_WWXTQT
[08:49:29.678] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[08:49:29.680] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[08:49:29.682] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[08:49:31.219] <TB1> INFO: DUT info:
[08:49:31.219] <TB1> INFO: The DUT currently contains the following objects:
[08:49:31.219] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[08:49:31.219] <TB1> INFO: TBM Core alpha (0): 7 registers set
[08:49:31.219] <TB1> INFO: TBM Core beta (1): 7 registers set
[08:49:31.219] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:49:31.219] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:31.219] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:31.219] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:31.219] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:31.219] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:31.219] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:31.219] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:31.219] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:31.219] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:31.219] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:31.219] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:31.220] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:31.220] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:31.220] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:31.220] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:31.220] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:31.621] <TB1> INFO: enter 'restricted' command line mode
[08:49:31.621] <TB1> INFO: enter test to run
[08:49:31.621] <TB1> INFO: test: HighRate no parameter change
[08:49:31.621] <TB1> INFO: running: highrate
[08:49:31.621] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[08:49:31.749] <TB1> INFO: ----------------------------------------------------------------------
[08:49:31.750] <TB1> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[08:49:31.750] <TB1> INFO: ----------------------------------------------------------------------
[08:49:31.845] <TB1> INFO: Expecting 768 events.
[08:49:32.838] <TB1> INFO: 768 events read in total (435ms).
[08:49:32.901] <TB1> INFO: Test took 1145ms.
[08:49:33.390] <TB1> INFO: Expecting 41600 events.
[08:49:36.240] <TB1> INFO: 41600 events read in total (2448ms).
[08:49:36.242] <TB1> INFO: Test took 3338ms.
[08:49:36.826] <TB1> INFO: Expecting 41600 events.
[08:49:39.679] <TB1> INFO: 41600 events read in total (2452ms).
[08:49:39.681] <TB1> INFO: Test took 3334ms.
[08:49:40.276] <TB1> INFO: Expecting 41600 events.
[08:49:43.260] <TB1> INFO: 41600 events read in total (2582ms).
[08:49:43.262] <TB1> INFO: Test took 3469ms.
[08:49:43.869] <TB1> INFO: Expecting 41600 events.
[08:49:46.855] <TB1> INFO: 41600 events read in total (2585ms).
[08:49:46.857] <TB1> INFO: Test took 3481ms.
[08:49:47.483] <TB1> INFO: Expecting 41600 events.
[08:49:50.452] <TB1> INFO: 41600 events read in total (2567ms).
[08:49:50.454] <TB1> INFO: Test took 3484ms.
[08:49:51.076] <TB1> INFO: Expecting 41600 events.
[08:49:54.037] <TB1> INFO: 41600 events read in total (2560ms).
[08:49:54.039] <TB1> INFO: Test took 3469ms.
[08:49:54.633] <TB1> INFO: Expecting 41600 events.
[08:49:57.684] <TB1> INFO: 41600 events read in total (2650ms).
[08:49:57.686] <TB1> INFO: Test took 3535ms.
[08:49:58.271] <TB1> INFO: Expecting 41600 events.
[08:50:01.230] <TB1> INFO: 41600 events read in total (2558ms).
[08:50:01.233] <TB1> INFO: Test took 3442ms.
[08:50:01.828] <TB1> INFO: Expecting 41600 events.
[08:50:04.799] <TB1> INFO: 41600 events read in total (2569ms).
[08:50:04.801] <TB1> INFO: Test took 3461ms.
[08:50:05.402] <TB1> INFO: Expecting 41600 events.
[08:50:08.341] <TB1> INFO: 41600 events read in total (2537ms).
[08:50:08.343] <TB1> INFO: Test took 3432ms.
[08:50:08.933] <TB1> INFO: Expecting 41600 events.
[08:50:11.930] <TB1> INFO: 41600 events read in total (2595ms).
[08:50:11.932] <TB1> INFO: Test took 3483ms.
[08:50:12.523] <TB1> INFO: Expecting 41600 events.
[08:50:15.554] <TB1> INFO: 41600 events read in total (2630ms).
[08:50:15.556] <TB1> INFO: Test took 3516ms.
[08:50:16.152] <TB1> INFO: Expecting 41600 events.
[08:50:19.183] <TB1> INFO: 41600 events read in total (2629ms).
[08:50:19.185] <TB1> INFO: Test took 3512ms.
[08:50:19.781] <TB1> INFO: Expecting 41600 events.
[08:50:22.790] <TB1> INFO: 41600 events read in total (2608ms).
[08:50:22.792] <TB1> INFO: Test took 3496ms.
[08:50:23.389] <TB1> INFO: Expecting 41600 events.
[08:50:26.387] <TB1> INFO: 41600 events read in total (2596ms).
[08:50:26.389] <TB1> INFO: Test took 3490ms.
[08:50:27.035] <TB1> INFO: Expecting 41600 events.
[08:50:30.101] <TB1> INFO: 41600 events read in total (2664ms).
[08:50:30.103] <TB1> INFO: Test took 3603ms.
[08:50:30.751] <TB1> INFO: Expecting 41600 events.
[08:50:33.787] <TB1> INFO: 41600 events read in total (2634ms).
[08:50:33.789] <TB1> INFO: Test took 3578ms.
[08:50:34.417] <TB1> INFO: Expecting 41600 events.
[08:50:37.362] <TB1> INFO: 41600 events read in total (2544ms).
[08:50:37.364] <TB1> INFO: Test took 3452ms.
[08:50:37.952] <TB1> INFO: Expecting 41600 events.
[08:50:40.875] <TB1> INFO: 41600 events read in total (2522ms).
[08:50:40.877] <TB1> INFO: Test took 3407ms.
[08:50:41.460] <TB1> INFO: Expecting 41600 events.
[08:50:44.311] <TB1> INFO: 41600 events read in total (2448ms).
[08:50:44.313] <TB1> INFO: Test took 3332ms.
[08:50:44.680] <TB1> INFO: enter test to run
[08:50:44.680] <TB1> INFO: test: Pretest no parameter change
[08:50:44.680] <TB1> INFO: running: pretest
[08:50:44.680] <TB1> INFO: write dac parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[08:50:44.680] <TB1> INFO: write dac parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[08:50:44.681] <TB1> INFO: write dac parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[08:50:44.681] <TB1> INFO: write dac parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[08:50:44.681] <TB1> INFO: write dac parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[08:50:44.681] <TB1> INFO: write dac parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[08:50:44.681] <TB1> INFO: write dac parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[08:50:44.681] <TB1> INFO: write dac parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[08:50:44.681] <TB1> INFO: write dac parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[08:50:44.682] <TB1> INFO: write dac parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[08:50:44.682] <TB1> INFO: write dac parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[08:50:44.682] <TB1> INFO: write dac parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[08:50:44.682] <TB1> INFO: write dac parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[08:50:44.682] <TB1> INFO: write dac parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[08:50:44.682] <TB1> INFO: write dac parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[08:50:44.682] <TB1> INFO: write dac parameters into /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[08:50:44.683] <TB1> INFO: enter test to run
[08:50:44.683] <TB1> INFO: test: no parameter change
[08:50:44.876] <TB1> QUIET: Connection to board 147 closed.
[08:50:44.956] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[08:51:31.515] <TB1> INFO: *** Welcome to pxar ***
[08:51:31.515] <TB1> INFO: *** Today: 2016/10/11
[08:51:31.582] <TB1> INFO: *** Version: f5d3-dirty
[08:51:31.582] <TB1> INFO: readRocDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//012_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//012_HREfficiency_50//dacParameters35_C15.dat
[08:51:31.583] <TB1> INFO: readTbmDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//012_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//012_HREfficiency_50//tbmParameters_C0b.dat
[08:51:31.583] <TB1> INFO: readMaskFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//012_HREfficiency_50//defaultMaskFile.dat
[08:51:31.583] <TB1> INFO: readTrimFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//012_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//012_HREfficiency_50//trimParameters35_C15.dat
[08:51:31.653] <TB1> INFO: clk: 4
[08:51:31.653] <TB1> INFO: ctr: 4
[08:51:31.653] <TB1> INFO: sda: 19
[08:51:31.653] <TB1> INFO: tin: 9
[08:51:31.653] <TB1> INFO: level: 15
[08:51:31.653] <TB1> INFO: triggerdelay: 0
[08:51:31.653] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[08:51:31.653] <TB1> INFO: Log level: INFO
[08:51:31.665] <TB1> INFO: Found DTB DTB_WWXTQT
[08:51:31.675] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[08:51:31.677] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[08:51:31.679] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[08:51:33.220] <TB1> INFO: DUT info:
[08:51:33.220] <TB1> INFO: The DUT currently contains the following objects:
[08:51:33.220] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[08:51:33.220] <TB1> INFO: TBM Core alpha (0): 7 registers set
[08:51:33.220] <TB1> INFO: TBM Core beta (1): 7 registers set
[08:51:33.220] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:51:33.220] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:51:33.220] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:51:33.220] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:51:33.220] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:51:33.221] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:51:33.221] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:51:33.221] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:51:33.221] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:51:33.221] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:51:33.221] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:51:33.221] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:51:33.221] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:51:33.221] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:51:33.221] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:51:33.221] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:51:33.221] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:51:33.621] <TB1> INFO: enter 'restricted' command line mode
[08:51:33.621] <TB1> INFO: enter test to run
[08:51:33.621] <TB1> INFO: test: PixelAlive no parameter change
[08:51:33.621] <TB1> INFO: running: pixelalive
[08:51:33.625] <TB1> INFO: ######################################################################
[08:51:33.625] <TB1> INFO: PixTestAlive::doTest()
[08:51:33.625] <TB1> INFO: ######################################################################
[08:51:33.626] <TB1> INFO: ----------------------------------------------------------------------
[08:51:33.626] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:51:33.626] <TB1> INFO: ----------------------------------------------------------------------
[08:51:33.885] <TB1> INFO: Expecting 208000 events.
[08:51:43.350] <TB1> INFO: 208000 events read in total (8906ms).
[08:51:43.352] <TB1> INFO: Test took 9724ms.
[08:51:43.577] <TB1> INFO: PixTestAlive::aliveTest() done
[08:51:43.577] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:51:43.578] <TB1> INFO: ----------------------------------------------------------------------
[08:51:43.578] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:51:43.578] <TB1> INFO: ----------------------------------------------------------------------
[08:51:43.866] <TB1> INFO: Expecting 208000 events.
[08:51:50.374] <TB1> INFO: 208000 events read in total (5952ms).
[08:51:50.375] <TB1> INFO: Test took 6796ms.
[08:51:50.375] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[08:51:50.572] <TB1> INFO: PixTestAlive::maskTest() done
[08:51:50.572] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:51:50.573] <TB1> INFO: ----------------------------------------------------------------------
[08:51:50.573] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:51:50.573] <TB1> INFO: ----------------------------------------------------------------------
[08:51:50.864] <TB1> INFO: Expecting 208000 events.
[08:52:00.201] <TB1> INFO: 208000 events read in total (8780ms).
[08:52:00.202] <TB1> INFO: Test took 9628ms.
[08:52:00.406] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[08:52:00.406] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:52:00.406] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[08:52:00.446] <TB1> INFO: enter test to run
[08:52:00.446] <TB1> INFO: test: delay setting parameters: ->2<-
[08:52:00.446] <TB1> INFO: delay test by 2 seconds...
[08:52:02.446] <TB1> INFO: enter test to run
[08:52:02.446] <TB1> INFO: test: HighRate no parameter change
[08:52:02.446] <TB1> INFO: running: highrate
[08:52:02.446] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//012_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//012_HREfficiency_50//phCalibrationFitErr35_C15.dat
[08:52:02.587] <TB1> INFO: ----------------------------------------------------------------------
[08:52:02.587] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[08:52:02.587] <TB1> INFO: ----------------------------------------------------------------------
[08:52:03.077] <TB1> INFO: Expecting 208000 events.
[08:52:14.801] <TB1> INFO: 208000 events read in total (11323ms).
[08:52:14.806] <TB1> INFO: Test took 12216ms.
[08:52:15.357] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:52:15.358] <TB1> INFO: number of red-efficiency pixels: 136 143 124 225 381 372 312 368 469 317 294 278 233 139 126 99
[08:52:15.358] <TB1> INFO: number of X-ray hits detected: 95486 102959 83449 150782 174011 202556 183906 204223 221075 190805 182809 171984 157853 79914 94733 86847
[08:52:15.358] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[08:52:15.358] <TB1> INFO: number of Vcal hits detected: 207862 207854 207870 207765 207593 207604 207656 207616 207491 207657 207686 207711 207759 207853 207871 207896
[08:52:15.358] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.9 99.8 99.8 99.9 99.8 99.8 99.9 99.9 99.9 99.9 99.9 99.9 100.0
[08:52:15.358] <TB1> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.9 99.9 99.9 99.9 100.0
[08:52:15.358] <TB1> INFO: X-ray hit rate [MHz/cm2]: 28.0 30.2 24.5 44.2 51.0 59.4 53.9 59.9 64.8 55.9 53.6 50.4 46.3 23.4 27.8 25.5
[08:52:15.358] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[08:52:15.387] <TB1> INFO: PixTest:: pg_setup set to default.
[08:52:15.398] <TB1> INFO: enter test to run
[08:52:15.398] <TB1> INFO: test: no parameter change
[08:52:15.687] <TB1> QUIET: Connection to board 147 closed.
[08:52:15.767] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[08:53:00.794] <TB1> INFO: *** Welcome to pxar ***
[08:53:00.794] <TB1> INFO: *** Today: 2016/10/11
[08:53:00.864] <TB1> INFO: *** Version: f5d3-dirty
[08:53:00.864] <TB1> INFO: readRocDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//013_HREfficiency_75//dacParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//013_HREfficiency_75//dacParameters35_C15.dat
[08:53:00.865] <TB1> INFO: readTbmDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//013_HREfficiency_75//tbmParameters_C0a.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//013_HREfficiency_75//tbmParameters_C0b.dat
[08:53:00.865] <TB1> INFO: readMaskFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//013_HREfficiency_75//defaultMaskFile.dat
[08:53:00.865] <TB1> INFO: readTrimFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//013_HREfficiency_75//trimParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//013_HREfficiency_75//trimParameters35_C15.dat
[08:53:00.942] <TB1> INFO: clk: 4
[08:53:00.942] <TB1> INFO: ctr: 4
[08:53:00.942] <TB1> INFO: sda: 19
[08:53:00.942] <TB1> INFO: tin: 9
[08:53:00.942] <TB1> INFO: level: 15
[08:53:00.942] <TB1> INFO: triggerdelay: 0
[08:53:00.942] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[08:53:00.942] <TB1> INFO: Log level: INFO
[08:53:00.956] <TB1> INFO: Found DTB DTB_WWXTQT
[08:53:00.966] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[08:53:00.968] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[08:53:00.969] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[08:53:02.515] <TB1> INFO: DUT info:
[08:53:02.515] <TB1> INFO: The DUT currently contains the following objects:
[08:53:02.515] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[08:53:02.515] <TB1> INFO: TBM Core alpha (0): 7 registers set
[08:53:02.515] <TB1> INFO: TBM Core beta (1): 7 registers set
[08:53:02.515] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:53:02.515] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:02.515] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:02.515] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:02.515] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:02.515] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:02.516] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:02.516] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:02.516] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:02.516] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:02.516] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:02.516] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:02.516] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:02.516] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:02.516] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:02.516] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:02.516] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:02.917] <TB1> INFO: enter 'restricted' command line mode
[08:53:02.917] <TB1> INFO: enter test to run
[08:53:02.917] <TB1> INFO: test: PixelAlive no parameter change
[08:53:02.917] <TB1> INFO: running: pixelalive
[08:53:02.922] <TB1> INFO: ######################################################################
[08:53:02.923] <TB1> INFO: PixTestAlive::doTest()
[08:53:02.923] <TB1> INFO: ######################################################################
[08:53:02.924] <TB1> INFO: ----------------------------------------------------------------------
[08:53:02.924] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:53:02.924] <TB1> INFO: ----------------------------------------------------------------------
[08:53:03.209] <TB1> INFO: Expecting 208000 events.
[08:53:12.253] <TB1> INFO: 208000 events read in total (8486ms).
[08:53:12.255] <TB1> INFO: Test took 9329ms.
[08:53:12.486] <TB1> INFO: PixTestAlive::aliveTest() done
[08:53:12.486] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:53:12.488] <TB1> INFO: ----------------------------------------------------------------------
[08:53:12.488] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:53:12.488] <TB1> INFO: ----------------------------------------------------------------------
[08:53:12.773] <TB1> INFO: Expecting 208000 events.
[08:53:19.288] <TB1> INFO: 208000 events read in total (5959ms).
[08:53:19.288] <TB1> INFO: Test took 6798ms.
[08:53:19.288] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[08:53:19.489] <TB1> INFO: PixTestAlive::maskTest() done
[08:53:19.489] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:53:19.490] <TB1> INFO: ----------------------------------------------------------------------
[08:53:19.490] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:53:19.490] <TB1> INFO: ----------------------------------------------------------------------
[08:53:19.751] <TB1> INFO: Expecting 208000 events.
[08:53:29.155] <TB1> INFO: 208000 events read in total (8847ms).
[08:53:29.156] <TB1> INFO: Test took 9665ms.
[08:53:29.356] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[08:53:29.357] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:53:29.357] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[08:53:29.394] <TB1> INFO: enter test to run
[08:53:29.394] <TB1> INFO: test: delay setting parameters: ->2<-
[08:53:29.394] <TB1> INFO: delay test by 2 seconds...
[08:53:31.394] <TB1> INFO: enter test to run
[08:53:31.394] <TB1> INFO: test: HighRate no parameter change
[08:53:31.394] <TB1> INFO: running: highrate
[08:53:31.394] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//013_HREfficiency_75//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//013_HREfficiency_75//phCalibrationFitErr35_C15.dat
[08:53:31.545] <TB1> INFO: ----------------------------------------------------------------------
[08:53:31.545] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[08:53:31.545] <TB1> INFO: ----------------------------------------------------------------------
[08:53:32.039] <TB1> INFO: Expecting 208000 events.
[08:53:45.328] <TB1> INFO: 208000 events read in total (12888ms).
[08:53:45.338] <TB1> INFO: Test took 13790ms.
[08:53:46.027] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:53:46.027] <TB1> INFO: number of red-efficiency pixels: 240 243 240 413 756 677 628 745 855 637 660 530 445 221 209 165
[08:53:46.027] <TB1> INFO: number of X-ray hits detected: 140686 151522 124768 221801 254146 297930 268273 298965 323239 278709 267454 252431 231324 120015 140701 127084
[08:53:46.027] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[08:53:46.027] <TB1> INFO: number of Vcal hits detected: 207752 207745 207733 207549 207119 207226 207275 207165 207010 207253 207259 207396 207501 207763 207789 207831
[08:53:46.027] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.8 99.6 99.7 99.7 99.6 99.6 99.7 99.7 99.7 99.8 99.9 99.9 99.9
[08:53:46.027] <TB1> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.8 99.6 99.6 99.7 99.6 99.5 99.6 99.6 99.7 99.8 99.9 99.9 99.9
[08:53:46.027] <TB1> INFO: X-ray hit rate [MHz/cm2]: 41.2 44.4 36.6 65.0 74.5 87.3 78.6 87.6 94.7 81.7 78.4 74.0 67.8 35.2 41.2 37.2
[08:53:46.027] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[08:53:46.057] <TB1> INFO: PixTest:: pg_setup set to default.
[08:53:46.066] <TB1> INFO: enter test to run
[08:53:46.066] <TB1> INFO: test: no parameter change
[08:53:46.391] <TB1> QUIET: Connection to board 147 closed.
[08:53:46.471] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[08:54:30.029] <TB1> INFO: *** Welcome to pxar ***
[08:54:30.029] <TB1> INFO: *** Today: 2016/10/11
[08:54:30.094] <TB1> INFO: *** Version: f5d3-dirty
[08:54:30.094] <TB1> INFO: readRocDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//014_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//014_HREfficiency_100//dacParameters35_C15.dat
[08:54:30.095] <TB1> INFO: readTbmDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//014_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//014_HREfficiency_100//tbmParameters_C0b.dat
[08:54:30.095] <TB1> INFO: readMaskFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//014_HREfficiency_100//defaultMaskFile.dat
[08:54:30.095] <TB1> INFO: readTrimFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//014_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//014_HREfficiency_100//trimParameters35_C15.dat
[08:54:30.166] <TB1> INFO: clk: 4
[08:54:30.166] <TB1> INFO: ctr: 4
[08:54:30.166] <TB1> INFO: sda: 19
[08:54:30.166] <TB1> INFO: tin: 9
[08:54:30.166] <TB1> INFO: level: 15
[08:54:30.166] <TB1> INFO: triggerdelay: 0
[08:54:30.166] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[08:54:30.166] <TB1> INFO: Log level: INFO
[08:54:30.179] <TB1> INFO: Found DTB DTB_WWXTQT
[08:54:30.190] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[08:54:30.191] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[08:54:30.193] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[08:54:31.733] <TB1> INFO: DUT info:
[08:54:31.733] <TB1> INFO: The DUT currently contains the following objects:
[08:54:31.733] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[08:54:31.733] <TB1> INFO: TBM Core alpha (0): 7 registers set
[08:54:31.733] <TB1> INFO: TBM Core beta (1): 7 registers set
[08:54:31.734] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:54:31.734] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:31.734] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:31.734] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:31.734] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:31.734] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:31.734] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:31.734] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:31.734] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:31.734] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:31.734] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:31.734] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:31.734] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:31.734] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:31.734] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:31.734] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:31.734] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:32.134] <TB1> INFO: enter 'restricted' command line mode
[08:54:32.134] <TB1> INFO: enter test to run
[08:54:32.134] <TB1> INFO: test: PixelAlive no parameter change
[08:54:32.135] <TB1> INFO: running: pixelalive
[08:54:32.141] <TB1> INFO: ######################################################################
[08:54:32.141] <TB1> INFO: PixTestAlive::doTest()
[08:54:32.141] <TB1> INFO: ######################################################################
[08:54:32.142] <TB1> INFO: ----------------------------------------------------------------------
[08:54:32.142] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:54:32.142] <TB1> INFO: ----------------------------------------------------------------------
[08:54:32.448] <TB1> INFO: Expecting 208000 events.
[08:54:42.282] <TB1> INFO: 208000 events read in total (9276ms).
[08:54:42.284] <TB1> INFO: Test took 10140ms.
[08:54:42.518] <TB1> INFO: PixTestAlive::aliveTest() done
[08:54:42.518] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:54:42.520] <TB1> INFO: ----------------------------------------------------------------------
[08:54:42.520] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:54:42.520] <TB1> INFO: ----------------------------------------------------------------------
[08:54:42.795] <TB1> INFO: Expecting 208000 events.
[08:54:49.177] <TB1> INFO: 208000 events read in total (5826ms).
[08:54:49.178] <TB1> INFO: Test took 6656ms.
[08:54:49.178] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[08:54:49.387] <TB1> INFO: PixTestAlive::maskTest() done
[08:54:49.387] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:54:49.388] <TB1> INFO: ----------------------------------------------------------------------
[08:54:49.388] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:54:49.388] <TB1> INFO: ----------------------------------------------------------------------
[08:54:49.649] <TB1> INFO: Expecting 208000 events.
[08:54:58.832] <TB1> INFO: 208000 events read in total (8627ms).
[08:54:58.833] <TB1> INFO: Test took 9443ms.
[08:54:59.026] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[08:54:59.026] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:54:59.026] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[08:54:59.056] <TB1> INFO: enter test to run
[08:54:59.056] <TB1> INFO: test: delay setting parameters: ->2<-
[08:54:59.056] <TB1> INFO: delay test by 2 seconds...
[08:55:01.056] <TB1> INFO: enter test to run
[08:55:01.056] <TB1> INFO: test: HighRate no parameter change
[08:55:01.056] <TB1> INFO: running: highrate
[08:55:01.057] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//014_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//014_HREfficiency_100//phCalibrationFitErr35_C15.dat
[08:55:01.210] <TB1> INFO: ----------------------------------------------------------------------
[08:55:01.210] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[08:55:01.210] <TB1> INFO: ----------------------------------------------------------------------
[08:55:01.696] <TB1> INFO: Expecting 208000 events.
[08:55:16.339] <TB1> INFO: 208000 events read in total (14242ms).
[08:55:16.347] <TB1> INFO: Test took 15134ms.
[08:55:17.228] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:55:17.228] <TB1> INFO: number of red-efficiency pixels: 442 426 462 823 1331 1391 1108 1377 1662 1250 1121 987 870 433 319 326
[08:55:17.228] <TB1> INFO: number of X-ray hits detected: 194254 210314 174623 304037 349308 405829 369682 411992 444911 382982 367545 346318 318856 167018 194809 177425
[08:55:17.228] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[08:55:17.228] <TB1> INFO: number of Vcal hits detected: 207521 207549 207421 207028 206090 206122 206523 206203 205730 206329 206532 206761 206956 207468 207664 207652
[08:55:17.228] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.8 99.8 99.8 99.6 99.2 99.2 99.4 99.2 99.0 99.3 99.4 99.5 99.6 99.8 99.9 99.9
[08:55:17.228] <TB1> INFO: Vcal hit overall efficiency (%): 99.8 99.8 99.7 99.5 99.1 99.1 99.3 99.1 98.9 99.2 99.3 99.4 99.5 99.7 99.8 99.8
[08:55:17.228] <TB1> INFO: X-ray hit rate [MHz/cm2]: 56.9 61.6 51.2 89.1 102.4 119.0 108.4 120.8 130.4 112.3 107.7 101.5 93.5 49.0 57.1 52.0
[08:55:17.228] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[08:55:17.257] <TB1> INFO: PixTest:: pg_setup set to default.
[08:55:17.268] <TB1> INFO: enter test to run
[08:55:17.268] <TB1> INFO: test: no parameter change
[08:55:17.526] <TB1> QUIET: Connection to board 147 closed.
[08:55:17.606] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[08:56:05.519] <TB1> INFO: *** Welcome to pxar ***
[08:56:05.519] <TB1> INFO: *** Today: 2016/10/11
[08:56:05.595] <TB1> INFO: *** Version: f5d3-dirty
[08:56:05.595] <TB1> INFO: readRocDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//015_HREfficiency_125//dacParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//015_HREfficiency_125//dacParameters35_C15.dat
[08:56:05.595] <TB1> INFO: readTbmDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//015_HREfficiency_125//tbmParameters_C0a.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//015_HREfficiency_125//tbmParameters_C0b.dat
[08:56:05.595] <TB1> INFO: readMaskFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//015_HREfficiency_125//defaultMaskFile.dat
[08:56:05.595] <TB1> INFO: readTrimFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//015_HREfficiency_125//trimParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//015_HREfficiency_125//trimParameters35_C15.dat
[08:56:05.664] <TB1> INFO: clk: 4
[08:56:05.664] <TB1> INFO: ctr: 4
[08:56:05.664] <TB1> INFO: sda: 19
[08:56:05.664] <TB1> INFO: tin: 9
[08:56:05.664] <TB1> INFO: level: 15
[08:56:05.664] <TB1> INFO: triggerdelay: 0
[08:56:05.664] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[08:56:05.664] <TB1> INFO: Log level: INFO
[08:56:05.677] <TB1> INFO: Found DTB DTB_WWXTQT
[08:56:05.686] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[08:56:05.688] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[08:56:05.690] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[08:56:07.225] <TB1> INFO: DUT info:
[08:56:07.225] <TB1> INFO: The DUT currently contains the following objects:
[08:56:07.225] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[08:56:07.225] <TB1> INFO: TBM Core alpha (0): 7 registers set
[08:56:07.225] <TB1> INFO: TBM Core beta (1): 7 registers set
[08:56:07.225] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:56:07.225] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:07.225] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:07.225] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:07.225] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:07.225] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:07.225] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:07.225] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:07.225] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:07.225] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:07.225] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:07.225] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:07.225] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:07.226] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:07.226] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:07.226] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:07.226] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:07.626] <TB1> INFO: enter 'restricted' command line mode
[08:56:07.626] <TB1> INFO: enter test to run
[08:56:07.626] <TB1> INFO: test: PixelAlive no parameter change
[08:56:07.626] <TB1> INFO: running: pixelalive
[08:56:07.636] <TB1> INFO: ######################################################################
[08:56:07.636] <TB1> INFO: PixTestAlive::doTest()
[08:56:07.636] <TB1> INFO: ######################################################################
[08:56:07.637] <TB1> INFO: ----------------------------------------------------------------------
[08:56:07.637] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:56:07.637] <TB1> INFO: ----------------------------------------------------------------------
[08:56:07.914] <TB1> INFO: Expecting 208000 events.
[08:56:17.123] <TB1> INFO: 208000 events read in total (8651ms).
[08:56:17.125] <TB1> INFO: Test took 9486ms.
[08:56:17.353] <TB1> INFO: PixTestAlive::aliveTest() done
[08:56:17.353] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:56:17.354] <TB1> INFO: ----------------------------------------------------------------------
[08:56:17.354] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:56:17.354] <TB1> INFO: ----------------------------------------------------------------------
[08:56:17.622] <TB1> INFO: Expecting 208000 events.
[08:56:23.961] <TB1> INFO: 208000 events read in total (5783ms).
[08:56:23.963] <TB1> INFO: Test took 6607ms.
[08:56:23.963] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[08:56:24.170] <TB1> INFO: PixTestAlive::maskTest() done
[08:56:24.170] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:56:24.171] <TB1> INFO: ----------------------------------------------------------------------
[08:56:24.171] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:56:24.171] <TB1> INFO: ----------------------------------------------------------------------
[08:56:24.428] <TB1> INFO: Expecting 208000 events.
[08:56:33.544] <TB1> INFO: 208000 events read in total (8560ms).
[08:56:33.545] <TB1> INFO: Test took 9372ms.
[08:56:33.741] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[08:56:33.741] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:56:33.741] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[08:56:33.777] <TB1> INFO: enter test to run
[08:56:33.777] <TB1> INFO: test: delay setting parameters: ->2<-
[08:56:33.777] <TB1> INFO: delay test by 2 seconds...
[08:56:35.777] <TB1> INFO: enter test to run
[08:56:35.777] <TB1> INFO: test: HighRate no parameter change
[08:56:35.777] <TB1> INFO: running: highrate
[08:56:35.777] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//015_HREfficiency_125//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//015_HREfficiency_125//phCalibrationFitErr35_C15.dat
[08:56:35.946] <TB1> INFO: ----------------------------------------------------------------------
[08:56:35.946] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[08:56:35.946] <TB1> INFO: ----------------------------------------------------------------------
[08:56:36.481] <TB1> INFO: Expecting 208000 events.
[08:56:52.728] <TB1> INFO: 208000 events read in total (15845ms).
[08:56:52.738] <TB1> INFO: Test took 16788ms.
[08:56:53.754] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:56:53.754] <TB1> INFO: number of red-efficiency pixels: 615 623 615 1167 1951 1914 1678 2063 2428 1777 1644 1455 1257 607 505 413
[08:56:53.754] <TB1> INFO: number of X-ray hits detected: 237308 256940 214397 370433 426487 491710 449468 498039 540927 465379 445373 419588 386610 204783 238447 215638
[08:56:53.754] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[08:56:53.754] <TB1> INFO: number of Vcal hits detected: 207312 207316 207158 206444 204698 204891 205334 204856 203834 205145 205486 205840 206299 207160 207446 207550
[08:56:53.754] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.7 99.7 99.7 99.4 98.6 98.7 98.9 98.6 98.2 98.8 99.0 99.1 99.3 99.7 99.8 99.8
[08:56:53.754] <TB1> INFO: Vcal hit overall efficiency (%): 99.7 99.7 99.6 99.3 98.4 98.5 98.7 98.5 98.0 98.6 98.8 99.0 99.2 99.6 99.7 99.8
[08:56:53.754] <TB1> INFO: X-ray hit rate [MHz/cm2]: 69.6 75.3 62.8 108.6 125.0 144.1 131.7 146.0 158.5 136.4 130.5 123.0 113.3 60.0 69.9 63.2
[08:56:53.754] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[08:56:53.784] <TB1> INFO: PixTest:: pg_setup set to default.
[08:56:53.794] <TB1> INFO: enter test to run
[08:56:53.794] <TB1> INFO: test: no parameter change
[08:56:54.082] <TB1> QUIET: Connection to board 147 closed.
[08:56:54.161] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[08:57:42.443] <TB1> INFO: *** Welcome to pxar ***
[08:57:42.443] <TB1> INFO: *** Today: 2016/10/11
[08:57:42.511] <TB1> INFO: *** Version: f5d3-dirty
[08:57:42.511] <TB1> INFO: readRocDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//016_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//016_HREfficiency_150//dacParameters35_C15.dat
[08:57:42.511] <TB1> INFO: readTbmDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//016_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//016_HREfficiency_150//tbmParameters_C0b.dat
[08:57:42.511] <TB1> INFO: readMaskFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//016_HREfficiency_150//defaultMaskFile.dat
[08:57:42.511] <TB1> INFO: readTrimFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//016_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//016_HREfficiency_150//trimParameters35_C15.dat
[08:57:42.581] <TB1> INFO: clk: 4
[08:57:42.582] <TB1> INFO: ctr: 4
[08:57:42.582] <TB1> INFO: sda: 19
[08:57:42.582] <TB1> INFO: tin: 9
[08:57:42.582] <TB1> INFO: level: 15
[08:57:42.582] <TB1> INFO: triggerdelay: 0
[08:57:42.582] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[08:57:42.582] <TB1> INFO: Log level: INFO
[08:57:42.595] <TB1> INFO: Found DTB DTB_WWXTQT
[08:57:42.605] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[08:57:42.607] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[08:57:42.608] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[08:57:44.172] <TB1> INFO: DUT info:
[08:57:44.172] <TB1> INFO: The DUT currently contains the following objects:
[08:57:44.172] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[08:57:44.172] <TB1> INFO: TBM Core alpha (0): 7 registers set
[08:57:44.172] <TB1> INFO: TBM Core beta (1): 7 registers set
[08:57:44.172] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:57:44.172] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:44.172] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:44.172] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:44.172] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:44.172] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:44.172] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:44.172] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:44.172] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:44.172] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:44.172] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:44.172] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:44.173] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:44.173] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:44.173] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:44.173] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:44.173] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:44.573] <TB1> INFO: enter 'restricted' command line mode
[08:57:44.574] <TB1> INFO: enter test to run
[08:57:44.574] <TB1> INFO: test: PixelAlive no parameter change
[08:57:44.574] <TB1> INFO: running: pixelalive
[08:57:44.577] <TB1> INFO: ######################################################################
[08:57:44.577] <TB1> INFO: PixTestAlive::doTest()
[08:57:44.577] <TB1> INFO: ######################################################################
[08:57:44.578] <TB1> INFO: ----------------------------------------------------------------------
[08:57:44.578] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:57:44.578] <TB1> INFO: ----------------------------------------------------------------------
[08:57:44.842] <TB1> INFO: Expecting 208000 events.
[08:57:53.927] <TB1> INFO: 208000 events read in total (8527ms).
[08:57:53.929] <TB1> INFO: Test took 9349ms.
[08:57:54.143] <TB1> INFO: PixTestAlive::aliveTest() done
[08:57:54.143] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:57:54.144] <TB1> INFO: ----------------------------------------------------------------------
[08:57:54.144] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:57:54.144] <TB1> INFO: ----------------------------------------------------------------------
[08:57:54.405] <TB1> INFO: Expecting 208000 events.
[08:58:00.706] <TB1> INFO: 208000 events read in total (5744ms).
[08:58:00.707] <TB1> INFO: Test took 6561ms.
[08:58:00.708] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[08:58:00.905] <TB1> INFO: PixTestAlive::maskTest() done
[08:58:00.905] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:58:00.906] <TB1> INFO: ----------------------------------------------------------------------
[08:58:00.906] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:58:00.906] <TB1> INFO: ----------------------------------------------------------------------
[08:58:01.167] <TB1> INFO: Expecting 208000 events.
[08:58:10.465] <TB1> INFO: 208000 events read in total (8742ms).
[08:58:10.466] <TB1> INFO: Test took 9559ms.
[08:58:10.665] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[08:58:10.665] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:58:10.665] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[08:58:10.700] <TB1> INFO: enter test to run
[08:58:10.700] <TB1> INFO: test: delay setting parameters: ->2<-
[08:58:10.700] <TB1> INFO: delay test by 2 seconds...
[08:58:12.700] <TB1> INFO: enter test to run
[08:58:12.700] <TB1> INFO: test: HighRate no parameter change
[08:58:12.700] <TB1> INFO: running: highrate
[08:58:12.700] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//016_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//016_HREfficiency_150//phCalibrationFitErr35_C15.dat
[08:58:12.848] <TB1> INFO: ----------------------------------------------------------------------
[08:58:12.848] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[08:58:12.848] <TB1> INFO: ----------------------------------------------------------------------
[08:58:13.354] <TB1> INFO: Expecting 208000 events.
[08:58:31.460] <TB1> INFO: 208000 events read in total (17704ms).
[08:58:31.472] <TB1> INFO: Test took 18621ms.
[08:58:32.642] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:58:32.642] <TB1> INFO: number of red-efficiency pixels: 868 883 887 1658 2562 2566 2257 2713 3097 2426 2263 2027 1778 790 665 634
[08:58:32.642] <TB1> INFO: number of X-ray hits detected: 282818 306497 256716 440746 508789 584510 533969 592345 644369 554967 528963 500752 459170 245163 285748 259043
[08:58:32.642] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[08:58:32.642] <TB1> INFO: number of Vcal hits detected: 206953 206949 206541 205527 202641 202775 203593 203120 201305 203295 203799 204531 205218 206666 207268 207273
[08:58:32.642] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.6 99.5 99.4 99.0 97.7 97.8 98.1 97.8 97.1 98.0 98.3 98.6 98.8 99.5 99.7 99.7
[08:58:32.642] <TB1> INFO: Vcal hit overall efficiency (%): 99.5 99.5 99.3 98.8 97.4 97.5 97.9 97.7 96.8 97.7 98.0 98.3 98.7 99.4 99.6 99.7
[08:58:32.642] <TB1> INFO: X-ray hit rate [MHz/cm2]: 82.9 89.8 75.2 129.2 149.1 171.3 156.5 173.6 188.9 162.7 155.0 146.8 134.6 71.9 83.8 75.9
[08:58:32.642] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[08:58:32.672] <TB1> INFO: PixTest:: pg_setup set to default.
[08:58:32.685] <TB1> INFO: enter test to run
[08:58:32.685] <TB1> INFO: test: no parameter change
[08:58:32.972] <TB1> QUIET: Connection to board 147 closed.
[08:58:33.052] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[08:59:20.322] <TB1> INFO: *** Welcome to pxar ***
[08:59:20.322] <TB1> INFO: *** Today: 2016/10/11
[08:59:20.388] <TB1> INFO: *** Version: f5d3-dirty
[08:59:20.388] <TB1> INFO: readRocDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//017_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//017_HREfficiency_200//dacParameters35_C15.dat
[08:59:20.388] <TB1> INFO: readTbmDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//017_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//017_HREfficiency_200//tbmParameters_C0b.dat
[08:59:20.388] <TB1> INFO: readMaskFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//017_HREfficiency_200//defaultMaskFile.dat
[08:59:20.388] <TB1> INFO: readTrimFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//017_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//017_HREfficiency_200//trimParameters35_C15.dat
[08:59:20.463] <TB1> INFO: clk: 4
[08:59:20.463] <TB1> INFO: ctr: 4
[08:59:20.463] <TB1> INFO: sda: 19
[08:59:20.463] <TB1> INFO: tin: 9
[08:59:20.463] <TB1> INFO: level: 15
[08:59:20.463] <TB1> INFO: triggerdelay: 0
[08:59:20.463] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[08:59:20.463] <TB1> INFO: Log level: INFO
[08:59:20.476] <TB1> INFO: Found DTB DTB_WWXTQT
[08:59:20.486] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[08:59:20.488] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[08:59:20.490] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[08:59:22.023] <TB1> INFO: DUT info:
[08:59:22.023] <TB1> INFO: The DUT currently contains the following objects:
[08:59:22.023] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[08:59:22.023] <TB1> INFO: TBM Core alpha (0): 7 registers set
[08:59:22.023] <TB1> INFO: TBM Core beta (1): 7 registers set
[08:59:22.023] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:59:22.023] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:22.023] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:22.023] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:22.023] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:22.023] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:22.023] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:22.023] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:22.023] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:22.023] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:22.023] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:22.023] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:22.023] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:22.023] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:22.023] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:22.023] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:22.023] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:22.424] <TB1> INFO: enter 'restricted' command line mode
[08:59:22.424] <TB1> INFO: enter test to run
[08:59:22.424] <TB1> INFO: test: PixelAlive no parameter change
[08:59:22.424] <TB1> INFO: running: pixelalive
[08:59:22.428] <TB1> INFO: ######################################################################
[08:59:22.428] <TB1> INFO: PixTestAlive::doTest()
[08:59:22.428] <TB1> INFO: ######################################################################
[08:59:22.429] <TB1> INFO: ----------------------------------------------------------------------
[08:59:22.429] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:59:22.429] <TB1> INFO: ----------------------------------------------------------------------
[08:59:22.699] <TB1> INFO: Expecting 208000 events.
[08:59:31.740] <TB1> INFO: 208000 events read in total (8483ms).
[08:59:31.742] <TB1> INFO: Test took 9311ms.
[08:59:31.993] <TB1> INFO: PixTestAlive::aliveTest() done
[08:59:31.994] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:59:31.995] <TB1> INFO: ----------------------------------------------------------------------
[08:59:31.995] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:59:31.995] <TB1> INFO: ----------------------------------------------------------------------
[08:59:32.302] <TB1> INFO: Expecting 208000 events.
[08:59:38.903] <TB1> INFO: 208000 events read in total (6045ms).
[08:59:38.904] <TB1> INFO: Test took 6907ms.
[08:59:38.905] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[08:59:39.106] <TB1> INFO: PixTestAlive::maskTest() done
[08:59:39.106] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:59:39.107] <TB1> INFO: ----------------------------------------------------------------------
[08:59:39.107] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:59:39.107] <TB1> INFO: ----------------------------------------------------------------------
[08:59:39.383] <TB1> INFO: Expecting 208000 events.
[08:59:48.712] <TB1> INFO: 208000 events read in total (8773ms).
[08:59:48.713] <TB1> INFO: Test took 9604ms.
[08:59:48.921] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[08:59:48.921] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:59:48.921] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[08:59:48.951] <TB1> INFO: enter test to run
[08:59:48.951] <TB1> INFO: test: delay setting parameters: ->2<-
[08:59:48.951] <TB1> INFO: delay test by 2 seconds...
[08:59:50.951] <TB1> INFO: enter test to run
[08:59:50.951] <TB1> INFO: test: HighRate no parameter change
[08:59:50.951] <TB1> INFO: running: highrate
[08:59:50.951] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//017_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//017_HREfficiency_200//phCalibrationFitErr35_C15.dat
[08:59:51.082] <TB1> INFO: ----------------------------------------------------------------------
[08:59:51.082] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[08:59:51.082] <TB1> INFO: ----------------------------------------------------------------------
[08:59:51.567] <TB1> INFO: Expecting 208000 events.
[09:00:04.322] <TB1> ERROR: <datapipe.cc/CheckEventValidity:L512> Channel 0 has NoTokenPass but 1 ROCs were found

[09:00:04.322] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[09:00:04.322] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a007 8041 43c0 600 2a6c 6c5 202f 43c0 405 2649 600 2a8f 43c0 600 2aa2 43c0 202 2269 212 2a67 600 2a6c 854 264b e002 c000

[09:00:04.322] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a001 80c1 43c0 600 2a6d 69d 246c 698 2445 43c0 488 2a49 600 2aa2 43c0 118 2a49 600 2a89 60d 2a63 43c0 600 2a68 852 284f e002 c000

[09:00:04.322] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a002 8001 43c0 20b 226f 48c 262f 600 2a8a 43c0 44a 2a46 55b 2088 600 2a8f 43c1 1a 284d 102 244f 600 2aa2 6db 206d 43c1 119 2a67 504 244f 600 2a88 84d 2a4d e002 c000

[09:00:04.322] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a003 8041 43c0 e0 2865 28a 2649 345 2461 600 2a63 43c1 105 2845 105 2465 25a 2066 459 244c 61b 2888 600 2a89 65c 2885 64c 284f 75b 2a4c 43c0 205 2645 600 2aa1 6dc 202f 43c1 d8 2044 113 2682 405 2a2b 600 2a65 e002 c000

[09:00:04.322] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a004 80b1 43c0 2e0 2666 e0e7 c026

[09:00:04.322] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a005 80c1 43c0 59 2246 e0 204b 614 2445 600 2a6b 65a 262f 43c0 4b 2668 93 264f 9d 224a 321 224f 600 2aa5 851 2a4c 855 2a2b 43c0 241 2461 240 2463 31d 2046 30c 204d 600 2a89 4380 600 2a83 e002 c000

[09:00:04.322] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a006 8001 43c0 600 2a6d 65c 282f 43c0 610 2040 600 2a85 43c0 4a0 264d 4a0 2a6a 600 2a8f 43c0 293 2868 50a 2a49 50c 222f 554 206d 550 2067 600 2a68 693 284a 802 202d e002 c000

[09:00:13.644] <TB1> INFO: 208000 events read in total (21676ms).
[09:00:13.659] <TB1> INFO: Test took 22573ms.
[09:00:15.153] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:00:15.153] <TB1> INFO: number of red-efficiency pixels: 1568 1726 1413 2707 3625 3701 3360 3848 4016 3548 3428 3157 2906 1296 1280 1150
[09:00:15.153] <TB1> INFO: number of X-ray hits detected: 386506 419252 353694 595675 686245 785720 725487 803026 874283 747646 715317 673128 621908 338748 389821 354291
[09:00:15.153] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[09:00:15.153] <TB1> INFO: number of Vcal hits detected: 205682 205581 204615 202014 195358 195132 197346 195277 190992 196480 198086 199757 201454 204916 206389 206456
[09:00:15.153] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.0 98.9 98.7 97.5 94.6 94.5 95.5 94.3 92.5 95.1 95.9 96.6 97.3 98.8 99.3 99.4
[09:00:15.153] <TB1> INFO: Vcal hit overall efficiency (%): 98.9 98.8 98.4 97.1 93.9 93.8 94.9 93.9 91.8 94.5 95.2 96.0 96.9 98.5 99.2 99.3
[09:00:15.153] <TB1> INFO: X-ray hit rate [MHz/cm2]: 113.3 122.9 103.7 174.6 201.1 230.3 212.6 235.4 256.3 219.1 209.7 197.3 182.3 99.3 114.3 103.8
[09:00:15.153] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[09:00:15.182] <TB1> INFO: PixTest:: pg_setup set to default.
[09:00:15.195] <TB1> INFO: enter test to run
[09:00:15.195] <TB1> INFO: test: no parameter change
[09:00:15.424] <TB1> QUIET: Connection to board 147 closed.
[09:00:15.503] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[09:01:04.101] <TB1> INFO: *** Welcome to pxar ***
[09:01:04.101] <TB1> INFO: *** Today: 2016/10/11
[09:01:04.166] <TB1> INFO: *** Version: f5d3-dirty
[09:01:04.166] <TB1> INFO: readRocDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//018_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//018_HREfficiency_250//dacParameters35_C15.dat
[09:01:04.167] <TB1> INFO: readTbmDacs: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//018_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//018_HREfficiency_250//tbmParameters_C0b.dat
[09:01:04.167] <TB1> INFO: readMaskFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//018_HREfficiency_250//defaultMaskFile.dat
[09:01:04.167] <TB1> INFO: readTrimFile: /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//018_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//018_HREfficiency_250//trimParameters35_C15.dat
[09:01:04.243] <TB1> INFO: clk: 4
[09:01:04.243] <TB1> INFO: ctr: 4
[09:01:04.243] <TB1> INFO: sda: 19
[09:01:04.243] <TB1> INFO: tin: 9
[09:01:04.243] <TB1> INFO: level: 15
[09:01:04.243] <TB1> INFO: triggerdelay: 0
[09:01:04.243] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[09:01:04.243] <TB1> INFO: Log level: INFO
[09:01:04.256] <TB1> INFO: Found DTB DTB_WWXTQT
[09:01:04.265] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[09:01:04.267] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[09:01:04.269] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[09:01:05.800] <TB1> INFO: DUT info:
[09:01:05.800] <TB1> INFO: The DUT currently contains the following objects:
[09:01:05.800] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[09:01:05.801] <TB1> INFO: TBM Core alpha (0): 7 registers set
[09:01:05.801] <TB1> INFO: TBM Core beta (1): 7 registers set
[09:01:05.801] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:01:05.801] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:05.801] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:05.801] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:05.801] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:05.801] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:05.801] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:05.801] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:05.801] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:05.801] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:05.801] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:05.801] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:05.801] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:05.801] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:05.801] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:05.801] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:05.801] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:06.201] <TB1> INFO: enter 'restricted' command line mode
[09:01:06.201] <TB1> INFO: enter test to run
[09:01:06.201] <TB1> INFO: test: PixelAlive no parameter change
[09:01:06.201] <TB1> INFO: running: pixelalive
[09:01:06.205] <TB1> INFO: ######################################################################
[09:01:06.205] <TB1> INFO: PixTestAlive::doTest()
[09:01:06.205] <TB1> INFO: ######################################################################
[09:01:06.207] <TB1> INFO: ----------------------------------------------------------------------
[09:01:06.207] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:01:06.207] <TB1> INFO: ----------------------------------------------------------------------
[09:01:06.466] <TB1> INFO: Expecting 208000 events.
[09:01:15.969] <TB1> INFO: 208000 events read in total (8945ms).
[09:01:15.970] <TB1> INFO: Test took 9762ms.
[09:01:16.188] <TB1> INFO: PixTestAlive::aliveTest() done
[09:01:16.188] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:01:16.189] <TB1> INFO: ----------------------------------------------------------------------
[09:01:16.189] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:01:16.189] <TB1> INFO: ----------------------------------------------------------------------
[09:01:16.469] <TB1> INFO: Expecting 208000 events.
[09:01:22.907] <TB1> INFO: 208000 events read in total (5881ms).
[09:01:22.909] <TB1> INFO: Test took 6718ms.
[09:01:22.910] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[09:01:23.110] <TB1> INFO: PixTestAlive::maskTest() done
[09:01:23.110] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:01:23.112] <TB1> INFO: ----------------------------------------------------------------------
[09:01:23.112] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:01:23.112] <TB1> INFO: ----------------------------------------------------------------------
[09:01:23.381] <TB1> INFO: Expecting 208000 events.
[09:01:32.706] <TB1> INFO: 208000 events read in total (8769ms).
[09:01:32.707] <TB1> INFO: Test took 9593ms.
[09:01:32.906] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[09:01:32.906] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:01:32.907] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[09:01:32.941] <TB1> INFO: enter test to run
[09:01:32.941] <TB1> INFO: test: delay setting parameters: ->2<-
[09:01:32.941] <TB1> INFO: delay test by 2 seconds...
[09:01:34.941] <TB1> INFO: enter test to run
[09:01:34.941] <TB1> INFO: test: HighRate no parameter change
[09:01:34.941] <TB1> INFO: running: highrate
[09:01:34.941] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//018_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2357_XrayQualification_2016-10-11_09h45m_1476171913//018_HREfficiency_250//phCalibrationFitErr35_C15.dat
[09:01:35.077] <TB1> INFO: ----------------------------------------------------------------------
[09:01:35.077] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[09:01:35.077] <TB1> INFO: ----------------------------------------------------------------------
[09:01:35.561] <TB1> INFO: Expecting 208000 events.
[09:02:02.793] <TB1> INFO: 203800 events read in total (26831ms).
[09:02:03.553] <TB1> INFO: 208000 events read in total (27591ms).
[09:02:03.570] <TB1> INFO: Test took 28490ms.
[09:02:05.430] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:02:05.430] <TB1> INFO: number of red-efficiency pixels: 2262 2514 1914 3528 4023 4105 3944 4118 4144 4031 3988 3783 3701 1738 1958 1725
[09:02:05.430] <TB1> INFO: number of X-ray hits detected: 478197 519081 436045 737768 847113 969717 892137 988329 1082323 921911 881270 829777 769467 418558 482837 438197
[09:02:05.430] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[09:02:05.430] <TB1> INFO: number of Vcal hits detected: 203752 203610 202163 196984 185679 184576 188090 184566 177011 187006 189856 192904 195555 202610 205063 205210
[09:02:05.430] <TB1> INFO: Vcal hit fiducial efficiency (%): 98.3 98.1 97.7 95.4 90.3 89.8 91.5 89.4 86.1 91.0 92.3 93.6 94.7 97.9 98.7 98.9
[09:02:05.430] <TB1> INFO: Vcal hit overall efficiency (%): 98.0 97.9 97.2 94.7 89.3 88.7 90.4 88.7 85.1 89.9 91.3 92.7 94.0 97.4 98.6 98.7
[09:02:05.430] <TB1> INFO: X-ray hit rate [MHz/cm2]: 140.2 152.1 127.8 216.2 248.3 284.2 261.5 289.7 317.2 270.2 258.3 243.2 225.5 122.7 141.5 128.4
[09:02:05.430] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[09:02:05.460] <TB1> INFO: PixTest:: pg_setup set to default.
[09:02:05.473] <TB1> INFO: enter test to run
[09:02:05.473] <TB1> INFO: test: no parameter change
[09:02:05.744] <TB1> QUIET: Connection to board 147 closed.
[09:02:05.824] <TB1> INFO: pXar: this is the end, my friend
MoReWeb-v1.0.4-4-g297680c on branch psi46master