Test Date: 2015-07-13 11:39
Analysis date: 2016-05-25 21:59
Logfile
commander_PixelAlive.log
[09:39:37.680] <TB1> INFO: *** Welcome to pxar ***
[09:39:37.680] <TB1> INFO: *** Today: 2015/07/13
[09:39:37.680] <TB1> INFO: readRocDacs: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//000_PixelAlive_p17//dacParameters35_C15.dat
[09:39:37.682] <TB1> INFO: readTbmDacs: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//000_PixelAlive_p17//tbmParameters_C0b.dat
[09:39:37.682] <TB1> INFO: readMaskFile: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//000_PixelAlive_p17//defaultMaskFile.dat
[09:39:37.682] <TB1> INFO: readTrimFile: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//000_PixelAlive_p17//trimParameters35_C15.dat
[09:39:37.776] <TB1> INFO: clk: 4
[09:39:37.776] <TB1> INFO: ctr: 4
[09:39:37.776] <TB1> INFO: sda: 19
[09:39:37.776] <TB1> INFO: tin: 9
[09:39:37.776] <TB1> INFO: level: 15
[09:39:37.776] <TB1> INFO: triggerdelay: 0
[09:39:37.776] <TB1> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[09:39:37.776] <TB1> INFO: Log level: INFO
[09:39:37.788] <TB1> INFO: Found DTB DTB_WWXJGB
[09:39:37.803] <TB1> QUIET: Connection to board DTB_WWXJGB opened.
[09:39:37.806] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 137
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXJGB
MAC address: 40D855118089
Hostname: pixelDTB137
Comment:
------------------------------------------------------
[09:39:37.809] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[09:39:39.357] <TB1> INFO: DUT info:
[09:39:39.357] <TB1> INFO: The DUT currently contains the following objects:
[09:39:39.357] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[09:39:39.357] <TB1> INFO: TBM Core alpha (0): 7 registers set
[09:39:39.357] <TB1> INFO: TBM Core beta (1): 7 registers set
[09:39:39.357] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:39:39.357] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:39.357] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:39.358] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:39.358] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:39.358] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:39.358] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:39.358] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:39.358] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:39.358] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:39.358] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:39.358] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:39.358] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:39.358] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:39.358] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:39.358] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:39.358] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:39.759] <TB1> INFO: enter 'restricted' command line mode
[09:39:39.759] <TB1> INFO: enter test to run
[09:39:39.759] <TB1> INFO: test: PixelAlive no parameter change
[09:39:39.759] <TB1> INFO: running: pixelalive
[09:39:39.767] <TB1> INFO: ######################################################################
[09:39:39.767] <TB1> INFO: PixTestAlive::doTest()
[09:39:39.767] <TB1> INFO: ######################################################################
[09:39:39.769] <TB1> INFO: ----------------------------------------------------------------------
[09:39:39.769] <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)
[09:39:39.769] <TB1> INFO: ----------------------------------------------------------------------
[09:39:43.132] <TB1> INFO: Test took 3361ms.
[09:39:43.151] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:39:43.402] <TB1> INFO: PixTestAlive::aliveTest() done
[09:39:43.402] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 1 0 0 0 0 0 0 1 0 0
[09:39:43.404] <TB1> INFO: ----------------------------------------------------------------------
[09:39:43.404] <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)
[09:39:43.404] <TB1> INFO: ----------------------------------------------------------------------
[09:39:46.065] <TB1> INFO: Test took 2659ms.
[09:39:46.066] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:39:46.067] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[09:39:46.290] <TB1> INFO: PixTestAlive::maskTest() done
[09:39:46.290] <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:39:46.291] <TB1> INFO: ----------------------------------------------------------------------
[09:39:46.291] <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)
[09:39:46.291] <TB1> INFO: ----------------------------------------------------------------------
[09:39:49.784] <TB1> INFO: Test took 3492ms.
[09:39:49.817] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:39:50.053] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[09:39:50.053] <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:39:50.053] <TB1> INFO: PixTestAlive::doTest() done, duration: 10 seconds
[09:39:50.083] <TB1> INFO: enter test to run
[09:39:50.083] <TB1> INFO: test: no parameter change
[09:39:50.207] <TB1> QUIET: Connection to board 137 closed.
[09:39:50.287] <TB1> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[09:42:53.495] <TB1> INFO: *** Welcome to pxar ***
[09:42:53.495] <TB1> INFO: *** Today: 2015/07/13
[09:42:53.495] <TB1> INFO: readRocDacs: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//dacParameters35_C15.dat
[09:42:53.495] <TB1> INFO: readTbmDacs: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[09:42:53.495] <TB1> INFO: readMaskFile: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//defaultMaskFile.dat
[09:42:53.495] <TB1> INFO: readTrimFile: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//trimParameters35_C15.dat
[09:42:53.566] <TB1> INFO: clk: 4
[09:42:53.566] <TB1> INFO: ctr: 4
[09:42:53.566] <TB1> INFO: sda: 19
[09:42:53.566] <TB1> INFO: tin: 9
[09:42:53.566] <TB1> INFO: level: 15
[09:42:53.566] <TB1> INFO: triggerdelay: 0
[09:42:53.566] <TB1> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[09:42:53.566] <TB1> INFO: Log level: INFO
[09:42:53.577] <TB1> INFO: Found DTB DTB_WWXJGB
[09:42:53.591] <TB1> QUIET: Connection to board DTB_WWXJGB opened.
[09:42:53.594] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 137
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXJGB
MAC address: 40D855118089
Hostname: pixelDTB137
Comment:
------------------------------------------------------
[09:42:53.598] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[09:42:55.151] <TB1> INFO: DUT info:
[09:42:55.151] <TB1> INFO: The DUT currently contains the following objects:
[09:42:55.151] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[09:42:55.151] <TB1> INFO: TBM Core alpha (0): 7 registers set
[09:42:55.151] <TB1> INFO: TBM Core beta (1): 7 registers set
[09:42:55.151] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:42:55.151] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:42:55.151] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:42:55.151] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:42:55.151] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:42:55.151] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:42:55.151] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:42:55.151] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:42:55.151] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:42:55.151] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:42:55.151] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:42:55.151] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:42:55.151] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:42:55.151] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:42:55.151] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:42:55.151] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:42:55.151] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:42:55.552] <TB1> INFO: enter 'restricted' command line mode
[09:42:55.552] <TB1> INFO: enter test to run
[09:42:55.552] <TB1> INFO: test: delay setting parameters: ->5<-
[09:42:55.552] <TB1> INFO: delay test by 5 seconds...
[09:43:00.552] <TB1> INFO: enter test to run
[09:43:00.552] <TB1> INFO: test: highrate no parameter change
[09:43:00.552] <TB1> INFO: running: highrate
[09:43:00.553] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[09:43:00.703] <TB1> INFO: ----------------------------------------------------------------------
[09:43:00.704] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[09:43:00.704] <TB1> INFO: ----------------------------------------------------------------------
[09:43:00.704] <TB1> INFO: THR = 150, corresponding to ~ 400 MHz/cm2
[09:43:00.704] <TB1> INFO: edge/corner pixel THR is adjusted
[09:43:00.704] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[09:43:01.666] <TB1> INFO: Collecting data for 1 seconds...
[09:43:02.668] <TB1> INFO: Done with hot pixel readout
[09:43:10.150] <TB1> INFO: PixTest:: pg_setup set to default.
[09:43:10.151] <TB1> INFO: 4 hot pixels found in step 0
[09:43:11.116] <TB1> INFO: Collecting data for 1 seconds...
[09:43:12.118] <TB1> INFO: Done with hot pixel readout
[09:43:19.461] <TB1> INFO: PixTest:: pg_setup set to default.
[09:43:19.462] <TB1> INFO: 3 hot pixels found in step 1
[09:43:20.426] <TB1> INFO: Collecting data for 1 seconds...
[09:43:21.428] <TB1> INFO: Done with hot pixel readout
[09:43:27.286] <TB1> INFO: PixTest:: pg_setup set to default.
[09:43:27.287] <TB1> INFO: 1 hot pixels found in step 2
[09:43:28.249] <TB1> INFO: Collecting data for 1 seconds...
[09:43:29.251] <TB1> INFO: Done with hot pixel readout
[09:43:35.078] <TB1> INFO: PixTest:: pg_setup set to default.
[09:43:35.080] <TB1> INFO: 0 hot pixels found in step 3
[09:43:35.093] <TB1> INFO: 0 hot pixels could not be trimmed and have been masked.
[09:43:35.143] <TB1> INFO: PixTest::trimHotPixels() done
[09:43:35.143] <TB1> INFO: write trim parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//trimParameters35_C0.dat
[09:43:35.156] <TB1> INFO: write trim parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//trimParameters35_C1.dat
[09:43:35.164] <TB1> INFO: write trim parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//trimParameters35_C2.dat
[09:43:35.170] <TB1> INFO: write trim parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//trimParameters35_C3.dat
[09:43:35.176] <TB1> INFO: write trim parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//trimParameters35_C4.dat
[09:43:35.182] <TB1> INFO: write trim parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//trimParameters35_C5.dat
[09:43:35.188] <TB1> INFO: write trim parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//trimParameters35_C6.dat
[09:43:35.195] <TB1> INFO: write trim parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//trimParameters35_C7.dat
[09:43:35.201] <TB1> INFO: write trim parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//trimParameters35_C8.dat
[09:43:35.207] <TB1> INFO: write trim parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//trimParameters35_C9.dat
[09:43:35.213] <TB1> INFO: write trim parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//trimParameters35_C10.dat
[09:43:35.219] <TB1> INFO: write trim parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//trimParameters35_C11.dat
[09:43:35.225] <TB1> INFO: write trim parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//trimParameters35_C12.dat
[09:43:35.231] <TB1> INFO: write trim parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//trimParameters35_C13.dat
[09:43:35.237] <TB1> INFO: write trim parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//trimParameters35_C14.dat
[09:43:35.243] <TB1> INFO: write trim parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//trimParameters35_C15.dat
[09:43:35.249] <TB1> INFO: write masked pixels into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//002_RetrimHotPixels_150//defaultMaskFile.dat
[09:43:35.281] <TB1> INFO: enter test to run
[09:43:35.281] <TB1> INFO: test: no parameter change
[09:43:35.435] <TB1> QUIET: Connection to board 137 closed.
[09:43:35.515] <TB1> INFO: pXar: this is the end, my friend
commander_CalDelScanAndSaveDacs.log
[09:43:54.301] <TB1> INFO: *** Welcome to pxar ***
[09:43:54.301] <TB1> INFO: *** Today: 2015/07/13
[09:43:54.301] <TB1> INFO: readRocDacs: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[09:43:54.301] <TB1> INFO: readTbmDacs: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[09:43:54.301] <TB1> INFO: readMaskFile: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[09:43:54.301] <TB1> INFO: readTrimFile: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[09:43:54.410] <TB1> INFO: clk: 4
[09:43:54.410] <TB1> INFO: ctr: 4
[09:43:54.410] <TB1> INFO: sda: 19
[09:43:54.410] <TB1> INFO: tin: 9
[09:43:54.410] <TB1> INFO: level: 15
[09:43:54.410] <TB1> INFO: triggerdelay: 0
[09:43:54.410] <TB1> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[09:43:54.410] <TB1> INFO: Log level: INFO
[09:43:54.422] <TB1> INFO: Found DTB DTB_WWXJGB
[09:43:54.436] <TB1> QUIET: Connection to board DTB_WWXJGB opened.
[09:43:54.440] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 137
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXJGB
MAC address: 40D855118089
Hostname: pixelDTB137
Comment:
------------------------------------------------------
[09:43:54.442] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[09:43:55.993] <TB1> INFO: DUT info:
[09:43:55.993] <TB1> INFO: The DUT currently contains the following objects:
[09:43:55.993] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[09:43:55.993] <TB1> INFO: TBM Core alpha (0): 7 registers set
[09:43:55.993] <TB1> INFO: TBM Core beta (1): 7 registers set
[09:43:55.993] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:43:55.993] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:55.993] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:55.993] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:55.993] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:55.993] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:55.993] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:55.993] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:55.993] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:55.993] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:55.993] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:55.993] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:55.993] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:55.993] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:55.993] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:55.993] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:55.994] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:56.395] <TB1> INFO: enter 'restricted' command line mode
[09:43:56.395] <TB1> INFO: enter test to run
[09:43:56.395] <TB1> INFO: test: HighRate no parameter change
[09:43:56.395] <TB1> INFO: running: highrate
[09:43:56.395] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[09:43:56.545] <TB1> INFO: ----------------------------------------------------------------------
[09:43:56.545] <TB1> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[09:43:56.545] <TB1> INFO: ----------------------------------------------------------------------
[09:43:57.629] <TB1> INFO: Test took 1079ms.
[09:44:01.968] <TB1> INFO: Test took 4334ms.
[09:44:02.190] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:06.618] <TB1> INFO: Test took 4382ms.
[09:44:06.796] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:11.370] <TB1> INFO: Test took 4543ms.
[09:44:11.578] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:15.948] <TB1> INFO: Test took 4323ms.
[09:44:16.121] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:20.398] <TB1> INFO: Test took 4244ms.
[09:44:20.589] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:24.923] <TB1> INFO: Test took 4300ms.
[09:44:25.103] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:29.092] <TB1> INFO: Test took 3957ms.
[09:44:29.266] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:33.327] <TB1> INFO: Test took 4028ms.
[09:44:33.500] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:37.525] <TB1> INFO: Test took 3993ms.
[09:44:37.714] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:41.480] <TB1> INFO: Test took 3734ms.
[09:44:41.687] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:45.581] <TB1> INFO: Test took 3862ms.
[09:44:45.759] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:49.840] <TB1> INFO: Test took 4049ms.
[09:44:50.016] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:54.218] <TB1> INFO: Test took 4170ms.
[09:44:54.400] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:58.628] <TB1> INFO: Test took 4196ms.
[09:44:58.820] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:45:03.162] <TB1> INFO: Test took 4298ms.
[09:45:03.336] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:45:07.772] <TB1> INFO: Test took 4404ms.
[09:45:07.956] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:45:11.701] <TB1> INFO: Test took 3712ms.
[09:45:11.895] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:45:15.711] <TB1> INFO: Test took 3784ms.
[09:45:15.953] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:45:19.753] <TB1> INFO: Test took 3748ms.
[09:45:19.939] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:45:23.290] <TB1> INFO: Test took 3316ms.
[09:45:23.449] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:45:23.755] <TB1> INFO: enter test to run
[09:45:23.755] <TB1> INFO: test: Pretest no parameter change
[09:45:23.755] <TB1> INFO: running: pretest
[09:45:23.755] <TB1> INFO: write dac parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[09:45:23.755] <TB1> INFO: write dac parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[09:45:23.755] <TB1> INFO: write dac parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[09:45:23.755] <TB1> INFO: write dac parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[09:45:23.755] <TB1> INFO: write dac parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[09:45:23.755] <TB1> INFO: write dac parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[09:45:23.755] <TB1> INFO: write dac parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[09:45:23.756] <TB1> INFO: write dac parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[09:45:23.756] <TB1> INFO: write dac parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[09:45:23.756] <TB1> INFO: write dac parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[09:45:23.756] <TB1> INFO: write dac parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[09:45:23.756] <TB1> INFO: write dac parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[09:45:23.756] <TB1> INFO: write dac parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[09:45:23.756] <TB1> INFO: write dac parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[09:45:23.756] <TB1> INFO: write dac parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[09:45:23.756] <TB1> INFO: write dac parameters into /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[09:45:23.756] <TB1> INFO: enter test to run
[09:45:23.756] <TB1> INFO: test: no parameter change
[09:45:23.918] <TB1> QUIET: Connection to board 137 closed.
[09:45:23.997] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[09:45:37.948] <TB1> INFO: *** Welcome to pxar ***
[09:45:37.948] <TB1> INFO: *** Today: 2015/07/13
[09:45:37.948] <TB1> INFO: readRocDacs: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//004_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//004_HREfficiency_50//dacParameters35_C15.dat
[09:45:37.949] <TB1> INFO: readTbmDacs: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//004_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//004_HREfficiency_50//tbmParameters_C0b.dat
[09:45:37.950] <TB1> INFO: readMaskFile: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//004_HREfficiency_50//defaultMaskFile.dat
[09:45:37.950] <TB1> INFO: readTrimFile: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//004_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//004_HREfficiency_50//trimParameters35_C15.dat
[09:45:38.023] <TB1> INFO: clk: 4
[09:45:38.023] <TB1> INFO: ctr: 4
[09:45:38.023] <TB1> INFO: sda: 19
[09:45:38.023] <TB1> INFO: tin: 9
[09:45:38.023] <TB1> INFO: level: 15
[09:45:38.023] <TB1> INFO: triggerdelay: 0
[09:45:38.023] <TB1> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[09:45:38.024] <TB1> INFO: Log level: INFO
[09:45:38.036] <TB1> INFO: Found DTB DTB_WWXJGB
[09:45:38.050] <TB1> QUIET: Connection to board DTB_WWXJGB opened.
[09:45:38.053] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 137
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXJGB
MAC address: 40D855118089
Hostname: pixelDTB137
Comment:
------------------------------------------------------
[09:45:38.056] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[09:45:39.612] <TB1> INFO: DUT info:
[09:45:39.612] <TB1> INFO: The DUT currently contains the following objects:
[09:45:39.612] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[09:45:39.612] <TB1> INFO: TBM Core alpha (0): 7 registers set
[09:45:39.612] <TB1> INFO: TBM Core beta (1): 7 registers set
[09:45:39.612] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:45:39.612] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:45:39.612] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:45:39.612] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:45:39.612] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:45:39.612] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:45:39.612] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:45:39.612] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:45:39.612] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:45:39.612] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:45:39.612] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:45:39.612] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:45:39.612] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:45:39.612] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:45:39.612] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:45:39.612] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:45:39.612] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:45:40.013] <TB1> INFO: enter 'restricted' command line mode
[09:45:40.014] <TB1> INFO: enter test to run
[09:45:40.014] <TB1> INFO: test: HighRate no parameter change
[09:45:40.014] <TB1> INFO: running: highrate
[09:45:40.014] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//004_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//004_HREfficiency_50//phCalibrationFitErr35_C15.dat
[09:45:40.147] <TB1> INFO: ----------------------------------------------------------------------
[09:45:40.147] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[09:45:40.147] <TB1> INFO: ----------------------------------------------------------------------
[09:45:51.781] <TB1> INFO: Test took 11628ms.
[09:45:52.874] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:45:53.203] <TB1> INFO: number of dead pixels (per ROC): 128 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:45:53.203] <TB1> INFO: number of red-efficiency pixels: 294 144 227 437 447 588 451 414 394 472 412 330 507 146 149 123
[09:45:53.203] <TB1> INFO: number of X-ray hits detected: 184432 103004 106575 203938 198244 241314 240388 237770 222358 241298 226505 192651 183148 100161 100007 96172
[09:45:53.203] <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:45:53.203] <TB1> INFO: number of Vcal hits detected: 199900 207847 207766 207533 207509 207362 207505 207560 207580 207495 207557 207644 207467 207848 207849 207875
[09:45:53.204] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.2 99.9 99.9 99.8 99.8 99.7 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.9 99.9 99.9
[09:45:53.204] <TB1> INFO: Vcal hit overall efficiency (%): 96.1 99.9 99.9 99.8 99.8 99.7 99.8 99.8 99.8 99.8 99.8 99.8 99.7 99.9 99.9 99.9
[09:45:53.204] <TB1> INFO: X-ray hit rate [MHz/cm2]: 54.1 30.2 31.2 59.8 58.1 70.7 70.5 69.7 65.2 70.7 66.4 56.5 53.7 29.4 29.3 28.2
[09:45:53.204] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[09:45:53.239] <TB1> INFO: PixTest:: pg_setup set to default.
[09:45:53.274] <TB1> INFO: enter test to run
[09:45:53.274] <TB1> INFO: test: no parameter change
[09:45:53.428] <TB1> QUIET: Connection to board 137 closed.
[09:45:53.508] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[09:46:17.475] <TB1> INFO: *** Welcome to pxar ***
[09:46:17.475] <TB1> INFO: *** Today: 2015/07/13
[09:46:17.475] <TB1> INFO: readRocDacs: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//005_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//005_HREfficiency_100//dacParameters35_C15.dat
[09:46:17.475] <TB1> INFO: readTbmDacs: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//005_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//005_HREfficiency_100//tbmParameters_C0b.dat
[09:46:17.475] <TB1> INFO: readMaskFile: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//005_HREfficiency_100//defaultMaskFile.dat
[09:46:17.475] <TB1> INFO: readTrimFile: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//005_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//005_HREfficiency_100//trimParameters35_C15.dat
[09:46:17.545] <TB1> INFO: clk: 4
[09:46:17.545] <TB1> INFO: ctr: 4
[09:46:17.545] <TB1> INFO: sda: 19
[09:46:17.545] <TB1> INFO: tin: 9
[09:46:17.545] <TB1> INFO: level: 15
[09:46:17.545] <TB1> INFO: triggerdelay: 0
[09:46:17.545] <TB1> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[09:46:17.545] <TB1> INFO: Log level: INFO
[09:46:17.556] <TB1> INFO: Found DTB DTB_WWXJGB
[09:46:17.570] <TB1> QUIET: Connection to board DTB_WWXJGB opened.
[09:46:17.573] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 137
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXJGB
MAC address: 40D855118089
Hostname: pixelDTB137
Comment:
------------------------------------------------------
[09:46:17.576] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[09:46:19.124] <TB1> INFO: DUT info:
[09:46:19.124] <TB1> INFO: The DUT currently contains the following objects:
[09:46:19.124] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[09:46:19.124] <TB1> INFO: TBM Core alpha (0): 7 registers set
[09:46:19.124] <TB1> INFO: TBM Core beta (1): 7 registers set
[09:46:19.124] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:46:19.124] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:19.124] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:19.124] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:19.124] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:19.124] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:19.124] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:19.124] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:19.124] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:19.124] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:19.124] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:19.124] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:19.124] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:19.124] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:19.124] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:19.124] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:19.124] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:19.526] <TB1> INFO: enter 'restricted' command line mode
[09:46:19.526] <TB1> INFO: enter test to run
[09:46:19.526] <TB1> INFO: test: HighRate no parameter change
[09:46:19.526] <TB1> INFO: running: highrate
[09:46:19.526] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//005_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//005_HREfficiency_100//phCalibrationFitErr35_C15.dat
[09:46:19.691] <TB1> INFO: ----------------------------------------------------------------------
[09:46:19.691] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[09:46:19.691] <TB1> INFO: ----------------------------------------------------------------------
[09:46:34.668] <TB1> INFO: Test took 14972ms.
[09:46:37.844] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:46:38.287] <TB1> INFO: number of dead pixels (per ROC): 125 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:46:38.287] <TB1> INFO: number of red-efficiency pixels: 605 461 642 1677 1694 2189 1722 1731 1515 1793 1573 1129 911 491 469 301
[09:46:38.287] <TB1> INFO: number of X-ray hits detected: 296785 210279 216582 406779 395126 474793 480016 473055 443187 479862 445157 378591 362344 205202 204390 193756
[09:46:38.287] <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:46:38.287] <TB1> INFO: number of Vcal hits detected: 199548 207510 207080 205442 205401 204162 205319 205545 205926 205204 205746 206486 206904 207399 207501 207687
[09:46:38.288] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.0 99.8 99.6 98.9 98.9 98.4 98.9 98.9 99.1 98.8 99.1 99.4 99.5 99.8 99.8 99.9
[09:46:38.288] <TB1> INFO: Vcal hit overall efficiency (%): 95.9 99.8 99.6 98.8 98.8 98.2 98.7 98.8 99.0 98.7 98.9 99.3 99.5 99.7 99.8 99.8
[09:46:38.288] <TB1> INFO: X-ray hit rate [MHz/cm2]: 87.0 61.6 63.5 119.2 115.8 139.2 140.7 138.7 129.9 140.7 130.5 111.0 106.2 60.1 59.9 56.8
[09:46:38.288] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[09:46:38.326] <TB1> INFO: PixTest:: pg_setup set to default.
[09:46:38.390] <TB1> INFO: enter test to run
[09:46:38.390] <TB1> INFO: test: no parameter change
[09:46:38.591] <TB1> QUIET: Connection to board 137 closed.
[09:46:38.670] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[09:47:00.347] <TB1> INFO: *** Welcome to pxar ***
[09:47:00.347] <TB1> INFO: *** Today: 2015/07/13
[09:47:00.347] <TB1> INFO: readRocDacs: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//006_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//006_HREfficiency_150//dacParameters35_C15.dat
[09:47:00.348] <TB1> INFO: readTbmDacs: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//006_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//006_HREfficiency_150//tbmParameters_C0b.dat
[09:47:00.348] <TB1> INFO: readMaskFile: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//006_HREfficiency_150//defaultMaskFile.dat
[09:47:00.348] <TB1> INFO: readTrimFile: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//006_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//006_HREfficiency_150//trimParameters35_C15.dat
[09:47:00.420] <TB1> INFO: clk: 4
[09:47:00.420] <TB1> INFO: ctr: 4
[09:47:00.420] <TB1> INFO: sda: 19
[09:47:00.420] <TB1> INFO: tin: 9
[09:47:00.420] <TB1> INFO: level: 15
[09:47:00.420] <TB1> INFO: triggerdelay: 0
[09:47:00.420] <TB1> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[09:47:00.420] <TB1> INFO: Log level: INFO
[09:47:00.434] <TB1> INFO: Found DTB DTB_WWXJGB
[09:47:00.447] <TB1> QUIET: Connection to board DTB_WWXJGB opened.
[09:47:00.451] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 137
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXJGB
MAC address: 40D855118089
Hostname: pixelDTB137
Comment:
------------------------------------------------------
[09:47:00.453] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[09:47:02.011] <TB1> INFO: DUT info:
[09:47:02.011] <TB1> INFO: The DUT currently contains the following objects:
[09:47:02.011] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[09:47:02.011] <TB1> INFO: TBM Core alpha (0): 7 registers set
[09:47:02.011] <TB1> INFO: TBM Core beta (1): 7 registers set
[09:47:02.011] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:47:02.011] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:02.011] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:02.011] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:02.011] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:02.011] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:02.011] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:02.011] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:02.011] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:02.012] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:02.012] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:02.012] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:02.012] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:02.012] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:02.012] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:02.012] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:02.012] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:02.413] <TB1> INFO: enter 'restricted' command line mode
[09:47:02.413] <TB1> INFO: enter test to run
[09:47:02.413] <TB1> INFO: test: HighRate no parameter change
[09:47:02.413] <TB1> INFO: running: highrate
[09:47:02.414] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//006_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//006_HREfficiency_150//phCalibrationFitErr35_C15.dat
[09:47:02.582] <TB1> INFO: ----------------------------------------------------------------------
[09:47:02.582] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[09:47:02.582] <TB1> INFO: ----------------------------------------------------------------------
[09:47:22.082] <TB1> INFO: Test took 19492ms.
[09:47:27.308] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:47:27.813] <TB1> INFO: number of dead pixels (per ROC): 119 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:47:27.813] <TB1> INFO: number of red-efficiency pixels: 1254 1076 1214 3060 2976 3612 3154 3251 2930 3204 2905 2157 1826 797 931 649
[09:47:27.813] <TB1> INFO: number of X-ray hits detected: 394710 306359 316710 584409 567741 680412 688731 676511 640666 692513 635960 540119 517502 299207 298492 283108
[09:47:27.813] <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:47:27.813] <TB1> INFO: number of Vcal hits detected: 198701 206694 205516 200775 200745 196786 199892 200580 201939 199625 201522 203979 205141 206676 206926 207288
[09:47:27.814] <TB1> INFO: Vcal hit fiducial efficiency (%): 98.6 99.4 99.0 96.9 96.9 95.2 96.6 96.8 97.3 96.4 97.3 98.3 98.8 99.5 99.5 99.7
[09:47:27.814] <TB1> INFO: Vcal hit overall efficiency (%): 95.5 99.4 98.8 96.5 96.5 94.6 96.1 96.4 97.1 96.0 96.9 98.1 98.6 99.4 99.5 99.7
[09:47:27.814] <TB1> INFO: X-ray hit rate [MHz/cm2]: 115.7 89.8 92.8 171.3 166.4 199.4 201.9 198.3 187.8 203.0 186.4 158.3 151.7 87.7 87.5 83.0
[09:47:27.814] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[09:47:27.848] <TB1> INFO: PixTest:: pg_setup set to default.
[09:47:27.909] <TB1> INFO: enter test to run
[09:47:27.909] <TB1> INFO: test: no parameter change
[09:47:28.141] <TB1> QUIET: Connection to board 137 closed.
[09:47:28.225] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[09:47:47.241] <TB1> INFO: *** Welcome to pxar ***
[09:47:47.241] <TB1> INFO: *** Today: 2015/07/13
[09:47:47.241] <TB1> INFO: readRocDacs: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//007_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//007_HREfficiency_200//dacParameters35_C15.dat
[09:47:47.242] <TB1> INFO: readTbmDacs: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//007_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//007_HREfficiency_200//tbmParameters_C0b.dat
[09:47:47.242] <TB1> INFO: readMaskFile: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//007_HREfficiency_200//defaultMaskFile.dat
[09:47:47.242] <TB1> INFO: readTrimFile: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//007_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//007_HREfficiency_200//trimParameters35_C15.dat
[09:47:47.312] <TB1> INFO: clk: 4
[09:47:47.312] <TB1> INFO: ctr: 4
[09:47:47.312] <TB1> INFO: sda: 19
[09:47:47.312] <TB1> INFO: tin: 9
[09:47:47.312] <TB1> INFO: level: 15
[09:47:47.312] <TB1> INFO: triggerdelay: 0
[09:47:47.312] <TB1> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[09:47:47.312] <TB1> INFO: Log level: INFO
[09:47:47.324] <TB1> INFO: Found DTB DTB_WWXJGB
[09:47:47.338] <TB1> QUIET: Connection to board DTB_WWXJGB opened.
[09:47:47.342] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 137
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXJGB
MAC address: 40D855118089
Hostname: pixelDTB137
Comment:
------------------------------------------------------
[09:47:47.344] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[09:47:48.893] <TB1> INFO: DUT info:
[09:47:48.893] <TB1> INFO: The DUT currently contains the following objects:
[09:47:48.893] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[09:47:48.893] <TB1> INFO: TBM Core alpha (0): 7 registers set
[09:47:48.893] <TB1> INFO: TBM Core beta (1): 7 registers set
[09:47:48.893] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:47:48.893] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:48.893] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:48.893] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:48.893] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:48.893] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:48.893] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:48.893] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:48.893] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:48.893] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:48.893] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:48.893] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:48.893] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:48.893] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:48.893] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:48.893] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:48.893] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:49.294] <TB1> INFO: enter 'restricted' command line mode
[09:47:49.294] <TB1> INFO: enter test to run
[09:47:49.295] <TB1> INFO: test: HighRate no parameter change
[09:47:49.295] <TB1> INFO: running: highrate
[09:47:49.295] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//007_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//007_HREfficiency_200//phCalibrationFitErr35_C15.dat
[09:47:49.566] <TB1> INFO: ----------------------------------------------------------------------
[09:47:49.566] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[09:47:49.566] <TB1> INFO: ----------------------------------------------------------------------
[09:48:12.017] <TB1> INFO: Test took 22443ms.
[09:48:20.823] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:48:21.419] <TB1> INFO: number of dead pixels (per ROC): 129 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:48:21.419] <TB1> INFO: number of red-efficiency pixels: 2228 2087 2070 3954 3882 4104 3958 4048 3901 4007 3884 3333 3094 1341 1839 1182
[09:48:21.419] <TB1> INFO: number of X-ray hits detected: 493650 418204 430552 786657 762274 906947 930299 902106 864699 933546 852912 724679 693251 406630 404536 385025
[09:48:21.419] <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:48:21.419] <TB1> INFO: number of Vcal hits detected: 196920 204895 201870 190498 190989 182576 188127 190078 192723 187493 192828 198262 200734 204630 205447 206503
[09:48:21.419] <TB1> INFO: Vcal hit fiducial efficiency (%): 97.9 98.6 97.6 92.4 92.7 88.9 91.5 92.1 93.3 91.1 93.6 95.9 96.9 98.7 98.8 99.3
[09:48:21.419] <TB1> INFO: Vcal hit overall efficiency (%): 94.7 98.5 97.1 91.6 91.8 87.8 90.4 91.4 92.7 90.1 92.7 95.3 96.5 98.4 98.8 99.3
[09:48:21.419] <TB1> INFO: X-ray hit rate [MHz/cm2]: 144.7 122.6 126.2 230.6 223.4 265.8 272.7 264.4 253.4 273.6 250.0 212.4 203.2 119.2 118.6 112.9
[09:48:21.419] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[09:48:21.449] <TB1> INFO: PixTest:: pg_setup set to default.
[09:48:21.484] <TB1> INFO: enter test to run
[09:48:21.484] <TB1> INFO: test: no parameter change
[09:48:21.628] <TB1> QUIET: Connection to board 137 closed.
[09:48:21.708] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[09:48:38.679] <TB1> INFO: *** Welcome to pxar ***
[09:48:38.679] <TB1> INFO: *** Today: 2015/07/13
[09:48:38.680] <TB1> INFO: readRocDacs: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//008_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//008_HREfficiency_250//dacParameters35_C15.dat
[09:48:38.681] <TB1> INFO: readTbmDacs: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//008_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//008_HREfficiency_250//tbmParameters_C0b.dat
[09:48:38.681] <TB1> INFO: readMaskFile: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//008_HREfficiency_250//defaultMaskFile.dat
[09:48:38.681] <TB1> INFO: readTrimFile: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//008_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//008_HREfficiency_250//trimParameters35_C15.dat
[09:48:38.750] <TB1> INFO: clk: 4
[09:48:38.750] <TB1> INFO: ctr: 4
[09:48:38.750] <TB1> INFO: sda: 19
[09:48:38.750] <TB1> INFO: tin: 9
[09:48:38.750] <TB1> INFO: level: 15
[09:48:38.750] <TB1> INFO: triggerdelay: 0
[09:48:38.750] <TB1> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[09:48:38.750] <TB1> INFO: Log level: INFO
[09:48:38.763] <TB1> INFO: Found DTB DTB_WWXJGB
[09:48:38.777] <TB1> QUIET: Connection to board DTB_WWXJGB opened.
[09:48:38.780] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 137
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXJGB
MAC address: 40D855118089
Hostname: pixelDTB137
Comment:
------------------------------------------------------
[09:48:38.783] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[09:48:40.354] <TB1> INFO: DUT info:
[09:48:40.354] <TB1> INFO: The DUT currently contains the following objects:
[09:48:40.354] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[09:48:40.354] <TB1> INFO: TBM Core alpha (0): 7 registers set
[09:48:40.354] <TB1> INFO: TBM Core beta (1): 7 registers set
[09:48:40.354] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:48:40.354] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:48:40.354] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:48:40.354] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:48:40.354] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:48:40.354] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:48:40.354] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:48:40.354] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:48:40.354] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:48:40.354] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:48:40.354] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:48:40.354] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:48:40.354] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:48:40.354] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:48:40.354] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:48:40.354] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:48:40.354] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:48:40.755] <TB1> INFO: enter 'restricted' command line mode
[09:48:40.755] <TB1> INFO: enter test to run
[09:48:40.756] <TB1> INFO: test: HighRate no parameter change
[09:48:40.756] <TB1> INFO: running: highrate
[09:48:40.757] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//008_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//008_HREfficiency_250//phCalibrationFitErr35_C15.dat
[09:48:40.995] <TB1> INFO: ----------------------------------------------------------------------
[09:48:40.995] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[09:48:40.995] <TB1> INFO: ----------------------------------------------------------------------
[09:49:03.866] <TB1> INFO: Test took 22864ms.
[09:49:14.139] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:49:14.938] <TB1> INFO: number of dead pixels (per ROC): 127 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:49:14.938] <TB1> INFO: number of red-efficiency pixels: 2414 2313 2167 3999 3953 4125 4028 4069 3993 4063 3923 3437 3187 1425 1922 1260
[09:49:14.938] <TB1> INFO: number of X-ray hits detected: 509308 433724 448089 804791 782509 929401 955580 927380 892830 958912 874568 750142 712221 422494 420844 397636
[09:49:14.938] <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:49:14.938] <TB1> INFO: number of Vcal hits detected: 196536 204416 201715 189331 190062 181154 186318 188485 191200 185834 191891 197407 200227 204530 205301 206398
[09:49:14.938] <TB1> INFO: Vcal hit fiducial efficiency (%): 97.8 98.4 97.5 91.9 92.3 88.2 90.6 91.3 92.6 90.3 93.1 95.5 96.7 98.6 98.8 99.3
[09:49:14.938] <TB1> INFO: Vcal hit overall efficiency (%): 94.5 98.3 97.0 91.0 91.4 87.1 89.6 90.6 91.9 89.3 92.3 94.9 96.3 98.3 98.7 99.2
[09:49:14.938] <TB1> INFO: X-ray hit rate [MHz/cm2]: 149.3 127.1 131.3 235.9 229.4 272.4 280.1 271.8 261.7 281.1 256.3 219.9 208.8 123.8 123.4 116.6
[09:49:14.938] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[09:49:14.968] <TB1> INFO: PixTest:: pg_setup set to default.
[09:49:15.027] <TB1> INFO: enter test to run
[09:49:15.027] <TB1> INFO: test: no parameter change
[09:49:15.298] <TB1> QUIET: Connection to board 137 closed.
[09:49:15.377] <TB1> INFO: pXar: this is the end, my friend
commander_HRData.log
[09:49:31.268] <TB1> INFO: *** Welcome to pxar ***
[09:49:31.268] <TB1> INFO: *** Today: 2015/07/13
[09:49:31.268] <TB1> INFO: readRocDacs: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//009_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//009_HRData_50//dacParameters35_C15.dat
[09:49:31.268] <TB1> INFO: readTbmDacs: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//009_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//009_HRData_50//tbmParameters_C0b.dat
[09:49:31.268] <TB1> INFO: readMaskFile: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//009_HRData_50//defaultMaskFile.dat
[09:49:31.268] <TB1> INFO: readTrimFile: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//009_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//009_HRData_50//trimParameters35_C15.dat
[09:49:31.349] <TB1> INFO: clk: 4
[09:49:31.349] <TB1> INFO: ctr: 4
[09:49:31.349] <TB1> INFO: sda: 19
[09:49:31.349] <TB1> INFO: tin: 9
[09:49:31.349] <TB1> INFO: level: 15
[09:49:31.349] <TB1> INFO: triggerdelay: 0
[09:49:31.349] <TB1> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[09:49:31.349] <TB1> INFO: Log level: INFO
[09:49:31.361] <TB1> INFO: Found DTB DTB_WWXJGB
[09:49:31.377] <TB1> QUIET: Connection to board DTB_WWXJGB opened.
[09:49:31.380] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 137
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXJGB
MAC address: 40D855118089
Hostname: pixelDTB137
Comment:
------------------------------------------------------
[09:49:31.383] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[09:49:32.971] <TB1> INFO: DUT info:
[09:49:32.971] <TB1> INFO: The DUT currently contains the following objects:
[09:49:32.971] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[09:49:32.971] <TB1> INFO: TBM Core alpha (0): 7 registers set
[09:49:32.971] <TB1> INFO: TBM Core beta (1): 7 registers set
[09:49:32.971] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:49:32.971] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:49:32.971] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:49:32.971] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:49:32.971] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:49:32.971] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:49:32.971] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:49:32.971] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:49:32.971] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:49:32.972] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:49:32.972] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:49:32.972] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:49:32.972] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:49:32.972] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:49:32.972] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:49:32.972] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:49:32.972] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:49:33.373] <TB1> INFO: enter 'restricted' command line mode
[09:49:33.373] <TB1> INFO: enter test to run
[09:49:33.373] <TB1> INFO: test: delay setting parameters: ->5<-
[09:49:33.373] <TB1> INFO: delay test by 5 seconds...
[09:49:38.374] <TB1> INFO: enter test to run
[09:49:38.374] <TB1> INFO: test: Xray no parameter change
[09:49:38.374] <TB1> INFO: running: xray
[09:49:38.374] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//009_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//009_HRData_50//phCalibrationFitErr35_C15.dat
[09:49:38.519] <TB1> INFO: ######################################################################
[09:49:38.519] <TB1> INFO: PixTestXray::doTest()
[09:49:38.519] <TB1> INFO: ######################################################################
[09:49:38.519] <TB1> INFO: ----------------------------------------------------------------------
[09:49:38.519] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[09:49:38.519] <TB1> INFO: ----------------------------------------------------------------------
[09:49:39.489] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[09:49:45.444] <TB1> INFO: run duration 5 seconds, buffer almost full (81%), pausing triggers.
[09:50:12.765] <TB1> INFO: Resuming triggers.
[09:50:18.724] <TB1> INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[09:50:43.084] <TB1> INFO: Resuming triggers.
[09:50:49.041] <TB1> INFO: run duration 17 seconds, buffer almost full (81%), pausing triggers.
[09:51:10.289] <TB1> INFO: Resuming triggers.
[09:51:16.253] <TB1> INFO: run duration 23 seconds, buffer almost full (81%), pausing triggers.
[09:51:40.466] <TB1> INFO: Resuming triggers.
[09:51:46.424] <TB1> INFO: run duration 29 seconds, buffer almost full (81%), pausing triggers.
[09:52:08.041] <TB1> INFO: Resuming triggers.
[09:52:13.997] <TB1> INFO: run duration 35 seconds, buffer almost full (81%), pausing triggers.
[09:52:39.007] <TB1> INFO: Resuming triggers.
[09:52:44.969] <TB1> INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[09:53:10.727] <TB1> INFO: Resuming triggers.
[09:53:16.689] <TB1> INFO: run duration 47 seconds, buffer almost full (81%), pausing triggers.
[09:53:41.264] <TB1> INFO: Resuming triggers.
[09:53:47.220] <TB1> INFO: run duration 53 seconds, buffer almost full (81%), pausing triggers.
[09:54:11.916] <TB1> INFO: Resuming triggers.
[09:54:17.874] <TB1> INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[09:54:48.378] <TB1> INFO: Resuming triggers.
[09:54:54.334] <TB1> INFO: run duration 65 seconds, buffer almost full (81%), pausing triggers.
[09:55:20.356] <TB1> INFO: Resuming triggers.
[09:55:26.314] <TB1> INFO: run duration 71 seconds, buffer almost full (81%), pausing triggers.
[09:55:52.189] <TB1> INFO: Resuming triggers.
[09:55:58.143] <TB1> INFO: run duration 77 seconds, buffer almost full (81%), pausing triggers.
[09:56:18.954] <TB1> INFO: Resuming triggers.
[09:56:24.909] <TB1> INFO: run duration 83 seconds, buffer almost full (81%), pausing triggers.
[09:56:52.222] <TB1> INFO: Resuming triggers.
[09:56:58.175] <TB1> INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[09:57:26.371] <TB1> INFO: Resuming triggers.
[09:57:32.328] <TB1> INFO: run duration 95 seconds, buffer almost full (81%), pausing triggers.
[09:57:50.092] <TB1> INFO: Resuming triggers.
[09:57:54.898] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[09:58:09.400] <TB1> INFO: PixTest:: pg_setup set to default.
[09:58:09.402] <TB1> INFO: PixTestXray::doPhRun() done
[09:58:09.402] <TB1> INFO: PixTestXray::doTest() done
[09:58:09.580] <TB1> INFO: enter test to run
[09:58:09.580] <TB1> INFO: test: no parameter change
[09:58:09.815] <TB1> QUIET: Connection to board 137 closed.
[09:58:09.894] <TB1> INFO: pXar: this is the end, my friend
commander_HRData.log
[09:58:26.500] <TB1> INFO: *** Welcome to pxar ***
[09:58:26.500] <TB1> INFO: *** Today: 2015/07/13
[09:58:26.500] <TB1> INFO: readRocDacs: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//010_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//010_HRData_150//dacParameters35_C15.dat
[09:58:26.501] <TB1> INFO: readTbmDacs: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//010_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//010_HRData_150//tbmParameters_C0b.dat
[09:58:26.501] <TB1> INFO: readMaskFile: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//010_HRData_150//defaultMaskFile.dat
[09:58:26.501] <TB1> INFO: readTrimFile: /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//010_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//010_HRData_150//trimParameters35_C15.dat
[09:58:26.573] <TB1> INFO: clk: 4
[09:58:26.573] <TB1> INFO: ctr: 4
[09:58:26.573] <TB1> INFO: sda: 19
[09:58:26.573] <TB1> INFO: tin: 9
[09:58:26.573] <TB1> INFO: level: 15
[09:58:26.573] <TB1> INFO: triggerdelay: 0
[09:58:26.573] <TB1> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[09:58:26.573] <TB1> INFO: Log level: INFO
[09:58:26.584] <TB1> INFO: Found DTB DTB_WWXJGB
[09:58:26.602] <TB1> QUIET: Connection to board DTB_WWXJGB opened.
[09:58:26.605] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 137
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXJGB
MAC address: 40D855118089
Hostname: pixelDTB137
Comment:
------------------------------------------------------
[09:58:26.608] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[09:58:28.174] <TB1> INFO: DUT info:
[09:58:28.174] <TB1> INFO: The DUT currently contains the following objects:
[09:58:28.174] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[09:58:28.174] <TB1> INFO: TBM Core alpha (0): 7 registers set
[09:58:28.174] <TB1> INFO: TBM Core beta (1): 7 registers set
[09:58:28.174] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:58:28.174] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:28.174] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:28.174] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:28.174] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:28.174] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:28.174] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:28.175] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:28.175] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:28.175] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:28.175] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:28.175] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:28.175] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:28.175] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:28.175] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:28.175] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:28.175] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:28.576] <TB1> INFO: enter 'restricted' command line mode
[09:58:28.576] <TB1> INFO: enter test to run
[09:58:28.576] <TB1> INFO: test: delay setting parameters: ->5<-
[09:58:28.576] <TB1> INFO: delay test by 5 seconds...
[09:58:33.576] <TB1> INFO: enter test to run
[09:58:33.576] <TB1> INFO: test: Xray no parameter change
[09:58:33.576] <TB1> INFO: running: xray
[09:58:33.577] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//010_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-13_11h39m_1436780355//010_HRData_150//phCalibrationFitErr35_C15.dat
[09:58:33.798] <TB1> INFO: ######################################################################
[09:58:33.798] <TB1> INFO: PixTestXray::doTest()
[09:58:33.798] <TB1> INFO: ######################################################################
[09:58:33.798] <TB1> INFO: ----------------------------------------------------------------------
[09:58:33.798] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[09:58:33.798] <TB1> INFO: ----------------------------------------------------------------------
[09:58:34.768] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[09:58:37.866] <TB1> INFO: run duration 3 seconds, buffer almost full (81%), pausing triggers.
[09:59:05.291] <TB1> INFO: Resuming triggers.
[09:59:08.399] <TB1> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[09:59:32.037] <TB1> INFO: Resuming triggers.
[09:59:35.147] <TB1> INFO: run duration 9 seconds, buffer almost full (81%), pausing triggers.
[09:59:55.459] <TB1> ERROR: <datapipe.cc/CheckEventValidity:L437> Number of ROCs (5) != Token Chain Length (4)

[10:00:04.140] <TB1> INFO: Resuming triggers.
[10:00:07.249] <TB1> INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[10:00:33.334] <TB1> INFO: Resuming triggers.
[10:00:36.440] <TB1> INFO: run duration 15 seconds, buffer almost full (81%), pausing triggers.
[10:01:06.132] <TB1> INFO: Resuming triggers.
[10:01:09.237] <TB1> INFO: run duration 18 seconds, buffer almost full (81%), pausing triggers.
[10:01:33.085] <TB1> INFO: Resuming triggers.
[10:01:36.189] <TB1> INFO: run duration 21 seconds, buffer almost full (81%), pausing triggers.
[10:02:05.971] <TB1> INFO: Resuming triggers.
[10:02:09.076] <TB1> INFO: run duration 24 seconds, buffer almost full (81%), pausing triggers.
[10:02:36.309] <TB1> INFO: Resuming triggers.
[10:02:39.413] <TB1> INFO: run duration 27 seconds, buffer almost full (81%), pausing triggers.
[10:03:05.746] <TB1> INFO: Resuming triggers.
[10:03:08.851] <TB1> INFO: run duration 31 seconds, buffer almost full (81%), pausing triggers.
[10:03:35.555] <TB1> INFO: Resuming triggers.
[10:03:38.659] <TB1> INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[10:04:05.826] <TB1> INFO: Resuming triggers.
[10:04:08.929] <TB1> INFO: run duration 37 seconds, buffer almost full (81%), pausing triggers.
[10:04:37.720] <TB1> INFO: Resuming triggers.
[10:04:40.821] <TB1> INFO: run duration 40 seconds, buffer almost full (81%), pausing triggers.
[10:05:10.305] <TB1> INFO: Resuming triggers.
[10:05:13.411] <TB1> INFO: run duration 43 seconds, buffer almost full (81%), pausing triggers.
[10:05:41.928] <TB1> INFO: Resuming triggers.
[10:05:45.034] <TB1> INFO: run duration 46 seconds, buffer almost full (81%), pausing triggers.
[10:06:10.316] <TB1> INFO: Resuming triggers.
[10:06:13.422] <TB1> INFO: run duration 49 seconds, buffer almost full (81%), pausing triggers.
[10:06:40.803] <TB1> INFO: Resuming triggers.
[10:06:43.907] <TB1> INFO: run duration 52 seconds, buffer almost full (81%), pausing triggers.
[10:07:13.800] <TB1> INFO: Resuming triggers.
[10:07:16.903] <TB1> INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[10:07:40.355] <TB1> INFO: Resuming triggers.
[10:07:43.457] <TB1> INFO: run duration 58 seconds, buffer almost full (81%), pausing triggers.
[10:08:12.287] <TB1> INFO: Resuming triggers.
[10:08:15.391] <TB1> INFO: run duration 62 seconds, buffer almost full (81%), pausing triggers.
[10:08:37.391] <TB1> INFO: Resuming triggers.
[10:08:40.492] <TB1> INFO: run duration 65 seconds, buffer almost full (81%), pausing triggers.
[10:09:03.658] <TB1> INFO: Resuming triggers.
[10:09:06.765] <TB1> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[10:09:31.211] <TB1> INFO: Resuming triggers.
[10:09:34.317] <TB1> INFO: run duration 71 seconds, buffer almost full (81%), pausing triggers.
[10:09:58.935] <TB1> INFO: Resuming triggers.
[10:10:02.039] <TB1> INFO: run duration 74 seconds, buffer almost full (81%), pausing triggers.
[10:10:28.981] <TB1> INFO: Resuming triggers.
[10:10:32.087] <TB1> INFO: run duration 77 seconds, buffer almost full (81%), pausing triggers.
[10:10:59.582] <TB1> INFO: Resuming triggers.
[10:11:02.683] <TB1> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[10:11:31.684] <TB1> INFO: Resuming triggers.
[10:11:34.790] <TB1> INFO: run duration 83 seconds, buffer almost full (81%), pausing triggers.
[10:11:54.446] <TB1> INFO: Resuming triggers.
[10:11:57.549] <TB1> INFO: run duration 86 seconds, buffer almost full (81%), pausing triggers.
[10:12:16.423] <TB1> INFO: Resuming triggers.
[10:12:19.524] <TB1> INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[10:12:38.620] <TB1> INFO: Resuming triggers.
[10:12:41.721] <TB1> INFO: run duration 93 seconds, buffer almost full (81%), pausing triggers.
[10:13:00.842] <TB1> INFO: Resuming triggers.
[10:13:03.945] <TB1> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[10:13:23.070] <TB1> INFO: Resuming triggers.
[10:13:26.172] <TB1> INFO: run duration 99 seconds, buffer almost full (81%), pausing triggers.
[10:13:45.122] <TB1> INFO: Resuming triggers.
[10:13:45.886] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[10:13:50.774] <TB1> INFO: PixTest:: pg_setup set to default.
[10:13:50.776] <TB1> INFO: PixTestXray::doPhRun() done
[10:13:50.783] <TB1> INFO: PixTestXray::doTest() done
[10:13:50.965] <TB1> INFO: enter test to run
[10:13:50.965] <TB1> INFO: test: no parameter change
[10:13:51.174] <TB1> QUIET: Connection to board 137 closed.
[10:13:51.254] <TB1> INFO: pXar: this is the end, my friend
commander_HRSCurves.log
[09:29:58.145] <TB2> INFO: *** Welcome to pxar ***
[09:29:58.145] <TB2> INFO: *** Today: 2015/07/17
[09:29:58.146] <TB2> INFO: readRocDacs: /usr/local/data/M2035_XrayQualification_2015-07-17_11h27m_1437125266//001_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-17_11h27m_1437125266//001_HRSCurves_100//dacParameters35_C15.dat
[09:29:58.147] <TB2> INFO: readTbmDacs: /usr/local/data/M2035_XrayQualification_2015-07-17_11h27m_1437125266//001_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2035_XrayQualification_2015-07-17_11h27m_1437125266//001_HRSCurves_100//tbmParameters_C0b.dat
[09:29:58.147] <TB2> INFO: readMaskFile: /usr/local/data/M2035_XrayQualification_2015-07-17_11h27m_1437125266//001_HRSCurves_100//defaultMaskFile.dat
[09:29:58.147] <TB2> INFO: readTrimFile: /usr/local/data/M2035_XrayQualification_2015-07-17_11h27m_1437125266//001_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-17_11h27m_1437125266//001_HRSCurves_100//trimParameters35_C15.dat
[09:29:58.224] <TB2> INFO: clk: 4
[09:29:58.224] <TB2> INFO: ctr: 4
[09:29:58.224] <TB2> INFO: sda: 19
[09:29:58.224] <TB2> INFO: tin: 9
[09:29:58.224] <TB2> INFO: level: 15
[09:29:58.224] <TB2> INFO: triggerdelay: 0
[09:29:58.224] <TB2> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[09:29:58.224] <TB2> INFO: Log level: INFO
[09:29:58.237] <TB2> INFO: Found DTB DTB_WXENWR
[09:29:58.246] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[09:29:58.249] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[09:29:58.253] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[09:29:59.805] <TB2> INFO: DUT info:
[09:29:59.805] <TB2> INFO: The DUT currently contains the following objects:
[09:29:59.805] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[09:29:59.805] <TB2> INFO: TBM Core alpha (0): 7 registers set
[09:29:59.805] <TB2> INFO: TBM Core beta (1): 7 registers set
[09:29:59.805] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:29:59.805] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:29:59.805] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:29:59.805] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:29:59.805] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:29:59.805] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:29:59.805] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:29:59.805] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:29:59.805] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:29:59.805] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:29:59.806] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:29:59.806] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:29:59.806] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:29:59.806] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:29:59.806] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:29:59.806] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:29:59.806] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:30:00.207] <TB2> INFO: enter 'restricted' command line mode
[09:30:00.207] <TB2> INFO: enter test to run
[09:30:00.207] <TB2> INFO: test: Highrate no parameter change
[09:30:00.207] <TB2> INFO: running: highrate
[09:30:00.208] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2035_XrayQualification_2015-07-17_11h27m_1437125266//001_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2035_XrayQualification_2015-07-17_11h27m_1437125266//001_HRSCurves_100//phCalibrationFitErr35_C15.dat
[09:30:00.361] <TB2> INFO: ----------------------------------------------------------------------
[09:30:00.361] <TB2> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[09:30:00.361] <TB2> INFO: ----------------------------------------------------------------------
[09:30:00.368] <TB2> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 0 .. 150 (1) hits flags = 384 (plus default)
[09:30:00.379] <TB2> INFO: dacScan step from 0 .. 0
[09:30:12.609] <TB2> INFO: Test took 12230ms.
[09:30:14.853] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:30:15.153] <TB2> INFO: dacScan step from 1 .. 1
[09:30:27.368] <TB2> INFO: Test took 12215ms.
[09:30:29.671] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:30:29.969] <TB2> INFO: dacScan step from 2 .. 2
[09:30:42.410] <TB2> INFO: Test took 12441ms.
[09:30:44.881] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:30:45.197] <TB2> INFO: dacScan step from 3 .. 3
[09:30:57.544] <TB2> INFO: Test took 12347ms.
[09:30:59.914] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:31:00.225] <TB2> INFO: dacScan step from 4 .. 4
[09:31:12.513] <TB2> INFO: Test took 12287ms.
[09:31:14.808] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:31:15.117] <TB2> INFO: dacScan step from 5 .. 5
[09:31:27.316] <TB2> INFO: Test took 12199ms.
[09:31:29.574] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:31:29.889] <TB2> INFO: dacScan step from 6 .. 6
[09:31:41.868] <TB2> INFO: Test took 11979ms.
[09:31:44.174] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:31:44.488] <TB2> INFO: dacScan step from 7 .. 7
[09:31:56.587] <TB2> INFO: Test took 12098ms.
[09:31:58.918] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:31:59.226] <TB2> INFO: dacScan step from 8 .. 8
[09:32:11.763] <TB2> INFO: Test took 12536ms.
[09:32:14.074] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:32:14.404] <TB2> INFO: dacScan step from 9 .. 9
[09:32:26.705] <TB2> INFO: Test took 12301ms.
[09:32:28.912] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:32:29.209] <TB2> INFO: dacScan step from 10 .. 10
[09:32:41.655] <TB2> INFO: Test took 12445ms.
[09:32:44.015] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:32:44.329] <TB2> INFO: dacScan step from 11 .. 11
[09:32:56.682] <TB2> INFO: Test took 12353ms.
[09:32:58.925] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:32:59.236] <TB2> INFO: dacScan step from 12 .. 12
[09:33:11.281] <TB2> INFO: Test took 12044ms.
[09:33:13.415] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:33:13.727] <TB2> INFO: dacScan step from 13 .. 13
[09:33:25.632] <TB2> INFO: Test took 11904ms.
[09:33:27.982] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:33:28.343] <TB2> INFO: dacScan step from 14 .. 14
[09:33:40.798] <TB2> INFO: Test took 12455ms.
[09:33:43.514] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:33:43.818] <TB2> INFO: dacScan step from 15 .. 15
[09:33:56.534] <TB2> INFO: Test took 12715ms.
[09:33:58.805] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:33:59.122] <TB2> INFO: dacScan step from 16 .. 16
[09:34:11.838] <TB2> INFO: Test took 12715ms.
[09:34:14.096] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:34:14.395] <TB2> INFO: dacScan step from 17 .. 17
[09:34:27.010] <TB2> INFO: Test took 12614ms.
[09:34:29.278] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:34:29.573] <TB2> INFO: dacScan step from 18 .. 18
[09:34:41.800] <TB2> INFO: Test took 12226ms.
[09:34:43.991] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:34:44.285] <TB2> INFO: dacScan step from 19 .. 19
[09:34:56.561] <TB2> INFO: Test took 12276ms.
[09:34:58.821] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:34:59.140] <TB2> INFO: dacScan step from 20 .. 20
[09:35:11.477] <TB2> INFO: Test took 12337ms.
[09:35:13.724] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:35:14.031] <TB2> INFO: dacScan step from 21 .. 21
[09:35:26.633] <TB2> INFO: Test took 12602ms.
[09:35:29.130] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:35:29.483] <TB2> INFO: dacScan step from 22 .. 22
[09:35:42.242] <TB2> INFO: Test took 12759ms.
[09:35:44.657] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:35:44.969] <TB2> INFO: dacScan step from 23 .. 23
[09:35:57.636] <TB2> INFO: Test took 12666ms.
[09:35:59.914] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:36:00.240] <TB2> INFO: dacScan step from 24 .. 24
[09:36:12.482] <TB2> INFO: Test took 12242ms.
[09:36:14.863] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:36:15.170] <TB2> INFO: dacScan step from 25 .. 25
[09:36:27.255] <TB2> INFO: Test took 12084ms.
[09:36:29.446] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:36:29.751] <TB2> INFO: dacScan step from 26 .. 26
[09:36:41.923] <TB2> INFO: Test took 12172ms.
[09:36:44.347] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:36:44.645] <TB2> INFO: dacScan step from 27 .. 27
[09:36:57.072] <TB2> INFO: Test took 12427ms.
[09:36:59.218] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:36:59.515] <TB2> INFO: dacScan step from 28 .. 28
[09:37:11.894] <TB2> INFO: Test took 12378ms.
[09:37:14.167] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:37:14.465] <TB2> INFO: dacScan step from 29 .. 29
[09:37:26.898] <TB2> INFO: Test took 12432ms.
[09:37:29.387] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:37:29.700] <TB2> INFO: dacScan step from 30 .. 30
[09:37:41.804] <TB2> INFO: Test took 12103ms.
[09:37:44.333] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:37:44.631] <TB2> INFO: dacScan step from 31 .. 31
[09:37:56.487] <TB2> INFO: Test took 11855ms.
[09:37:58.641] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:37:58.935] <TB2> INFO: dacScan step from 32 .. 32
[09:38:11.157] <TB2> INFO: Test took 12222ms.
[09:38:13.353] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:38:13.648] <TB2> INFO: dacScan step from 33 .. 33
[09:38:26.066] <TB2> INFO: Test took 12418ms.
[09:38:28.234] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:38:28.604] <TB2> INFO: dacScan step from 34 .. 34
[09:38:41.094] <TB2> INFO: Test took 12489ms.
[09:38:43.353] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:38:43.676] <TB2> INFO: dacScan step from 35 .. 35
[09:38:56.143] <TB2> INFO: Test took 12467ms.
[09:38:58.476] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:38:58.773] <TB2> INFO: dacScan step from 36 .. 36
[09:39:10.965] <TB2> INFO: Test took 12192ms.
[09:39:13.235] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:39:13.546] <TB2> INFO: dacScan step from 37 .. 37
[09:39:25.675] <TB2> INFO: Test took 12128ms.
[09:39:28.261] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:39:28.578] <TB2> INFO: dacScan step from 38 .. 38
[09:39:40.994] <TB2> INFO: Test took 12416ms.
[09:39:43.251] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:39:43.563] <TB2> INFO: dacScan step from 39 .. 39
[09:39:56.280] <TB2> INFO: Test took 12717ms.
[09:39:58.605] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:39:58.925] <TB2> INFO: dacScan step from 40 .. 40
[09:40:11.875] <TB2> INFO: Test took 12949ms.
[09:40:14.500] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:40:14.809] <TB2> INFO: dacScan step from 41 .. 41
[09:40:27.953] <TB2> INFO: Test took 13143ms.
[09:40:30.308] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:40:30.615] <TB2> INFO: dacScan step from 42 .. 42
[09:40:43.936] <TB2> INFO: Test took 13320ms.
[09:40:46.281] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:40:46.588] <TB2> INFO: dacScan step from 43 .. 43
[09:40:59.787] <TB2> INFO: Test took 13198ms.
[09:41:02.129] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:41:02.430] <TB2> INFO: dacScan step from 44 .. 44
[09:41:15.824] <TB2> INFO: Test took 13393ms.
[09:41:18.349] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:41:18.661] <TB2> INFO: dacScan step from 45 .. 45
[09:41:32.429] <TB2> INFO: Test took 13767ms.
[09:41:34.770] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:41:35.078] <TB2> INFO: dacScan step from 46 .. 46
[09:41:49.421] <TB2> INFO: Test took 14342ms.
[09:41:51.817] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:41:52.117] <TB2> INFO: dacScan step from 47 .. 47
[09:42:06.691] <TB2> INFO: Test took 14574ms.
[09:42:09.096] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:42:09.398] <TB2> INFO: dacScan step from 48 .. 48
[09:42:24.361] <TB2> INFO: Test took 14963ms.
[09:42:26.845] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:42:27.166] <TB2> INFO: dacScan step from 49 .. 49
[09:42:42.032] <TB2> INFO: Test took 14865ms.
[09:42:44.568] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:42:44.865] <TB2> INFO: dacScan step from 50 .. 50
[09:42:59.370] <TB2> INFO: Test took 14504ms.
[09:43:01.916] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:43:02.234] <TB2> INFO: dacScan step from 51 .. 51
[09:43:16.889] <TB2> INFO: Test took 14654ms.
[09:43:19.240] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:43:19.544] <TB2> INFO: dacScan step from 52 .. 52
[09:43:34.236] <TB2> INFO: Test took 14691ms.
[09:43:36.614] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:43:36.919] <TB2> INFO: dacScan step from 53 .. 53
[09:43:51.572] <TB2> INFO: Test took 14652ms.
[09:43:53.999] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:43:54.298] <TB2> INFO: dacScan step from 54 .. 54
[09:44:09.355] <TB2> INFO: Test took 15057ms.
[09:44:11.800] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:12.120] <TB2> INFO: dacScan step from 55 .. 55
[09:44:27.328] <TB2> INFO: Test took 15207ms.
[09:44:29.838] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:30.166] <TB2> INFO: dacScan step from 56 .. 56
[09:44:45.360] <TB2> INFO: Test took 15193ms.
[09:44:47.912] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:48.224] <TB2> INFO: dacScan step from 57 .. 57
[09:45:02.905] <TB2> INFO: Test took 14681ms.
[09:45:05.316] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:45:05.614] <TB2> INFO: dacScan step from 58 .. 58
[09:45:20.124] <TB2> INFO: Test took 14509ms.
[09:45:22.506] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:45:22.827] <TB2> INFO: dacScan step from 59 .. 59
[09:45:37.657] <TB2> INFO: Test took 14829ms.
[09:45:40.045] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:45:40.346] <TB2> INFO: dacScan step from 60 .. 60
[09:45:55.560] <TB2> INFO: Test took 15213ms.
[09:45:58.122] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:45:58.449] <TB2> INFO: dacScan step from 61 .. 61
[09:46:13.652] <TB2> INFO: Test took 15202ms.
[09:46:16.153] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:46:16.467] <TB2> INFO: dacScan step from 62 .. 62
[09:46:31.398] <TB2> INFO: Test took 14930ms.
[09:46:33.869] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:46:34.179] <TB2> INFO: dacScan step from 63 .. 63
[09:46:48.526] <TB2> INFO: Test took 14347ms.
[09:46:51.038] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:46:51.362] <TB2> INFO: dacScan step from 64 .. 64
[09:47:05.714] <TB2> INFO: Test took 14352ms.
[09:47:08.159] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:47:08.477] <TB2> INFO: dacScan step from 65 .. 65
[09:47:23.355] <TB2> INFO: Test took 14877ms.
[09:47:25.933] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:47:26.254] <TB2> INFO: dacScan step from 66 .. 66
[09:47:41.200] <TB2> INFO: Test took 14945ms.
[09:47:43.693] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:47:44.007] <TB2> INFO: dacScan step from 67 .. 67
[09:47:58.911] <TB2> INFO: Test took 14903ms.
[09:48:01.440] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:48:01.764] <TB2> INFO: dacScan step from 68 .. 68
[09:48:16.594] <TB2> INFO: Test took 14829ms.
[09:48:18.991] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:48:19.295] <TB2> INFO: dacScan step from 69 .. 69
[09:48:33.362] <TB2> INFO: Test took 14067ms.
[09:48:35.884] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:48:36.202] <TB2> INFO: dacScan step from 70 .. 70
[09:48:50.603] <TB2> INFO: Test took 14400ms.
[09:48:53.133] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:48:53.455] <TB2> INFO: dacScan step from 71 .. 71
[09:49:08.230] <TB2> INFO: Test took 14774ms.
[09:49:10.684] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:49:10.992] <TB2> INFO: dacScan step from 72 .. 72
[09:49:25.856] <TB2> INFO: Test took 14863ms.
[09:49:28.374] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:49:28.700] <TB2> INFO: dacScan step from 73 .. 73
[09:49:43.373] <TB2> INFO: Test took 14673ms.
[09:49:45.955] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:49:46.270] <TB2> INFO: dacScan step from 74 .. 74
[09:50:00.712] <TB2> INFO: Test took 14441ms.
[09:50:03.234] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:50:03.552] <TB2> INFO: dacScan step from 75 .. 75
[09:50:17.961] <TB2> INFO: Test took 14408ms.
[09:50:20.552] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:50:20.881] <TB2> INFO: dacScan step from 76 .. 76
[09:50:35.454] <TB2> INFO: Test took 14572ms.
[09:50:37.836] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:50:38.140] <TB2> INFO: dacScan step from 77 .. 77
[09:50:53.004] <TB2> INFO: Test took 14863ms.
[09:50:55.498] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:50:55.815] <TB2> INFO: dacScan step from 78 .. 78
[09:51:10.629] <TB2> INFO: Test took 14813ms.
[09:51:13.256] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:51:13.566] <TB2> INFO: dacScan step from 79 .. 79
[09:51:27.287] <TB2> INFO: Test took 13720ms.
[09:51:29.927] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:51:30.242] <TB2> INFO: dacScan step from 80 .. 80
[09:51:44.089] <TB2> INFO: Test took 13846ms.
[09:51:46.456] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:51:46.756] <TB2> INFO: dacScan step from 81 .. 81
[09:52:00.628] <TB2> INFO: Test took 13871ms.
[09:52:03.485] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:52:03.793] <TB2> INFO: dacScan step from 82 .. 82
[09:52:17.706] <TB2> INFO: Test took 13912ms.
[09:52:20.118] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:52:20.425] <TB2> INFO: dacScan step from 83 .. 83
[09:52:34.288] <TB2> INFO: Test took 13862ms.
[09:52:37.396] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:52:37.694] <TB2> INFO: dacScan step from 84 .. 84
[09:52:51.410] <TB2> INFO: Test took 13715ms.
[09:52:53.874] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:52:54.169] <TB2> INFO: dacScan step from 85 .. 85
[09:53:09.543] <TB2> INFO: Test took 15374ms.
[09:53:11.843] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:53:12.140] <TB2> INFO: dacScan step from 86 .. 86
[09:53:27.855] <TB2> INFO: Test took 15714ms.
[09:53:30.345] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:53:30.635] <TB2> INFO: dacScan step from 87 .. 87
[09:53:45.934] <TB2> INFO: Test took 15298ms.
[09:53:48.430] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:53:48.726] <TB2> INFO: dacScan step from 88 .. 88
[09:54:04.113] <TB2> INFO: Test took 15386ms.
[09:54:06.874] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:54:07.174] <TB2> INFO: dacScan step from 89 .. 89
[09:54:22.958] <TB2> INFO: Test took 15783ms.
[09:54:25.275] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:54:25.569] <TB2> INFO: dacScan step from 90 .. 90
[09:54:41.511] <TB2> INFO: Test took 15941ms.
[09:54:43.934] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:54:44.232] <TB2> INFO: dacScan step from 91 .. 91
[09:54:59.288] <TB2> INFO: Test took 15056ms.
[09:55:01.742] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:55:02.051] <TB2> INFO: dacScan step from 92 .. 92
[09:55:17.789] <TB2> INFO: Test took 15737ms.
[09:55:20.574] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:55:20.870] <TB2> INFO: dacScan step from 93 .. 93
[09:55:36.157] <TB2> INFO: Test took 15287ms.
[09:55:38.898] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:55:39.189] <TB2> INFO: dacScan step from 94 .. 94
[09:55:54.383] <TB2> INFO: Test took 15193ms.
[09:55:56.797] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:55:57.135] <TB2> INFO: dacScan step from 95 .. 95
[09:56:12.460] <TB2> INFO: Test took 15324ms.
[09:56:14.830] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:56:15.195] <TB2> INFO: dacScan step from 96 .. 96
[09:56:30.586] <TB2> INFO: Test took 15390ms.
[09:56:32.905] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:56:33.224] <TB2> INFO: dacScan step from 97 .. 97
[09:56:48.797] <TB2> INFO: Test took 15572ms.
[09:56:51.338] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:56:51.661] <TB2> INFO: dacScan step from 98 .. 98
[09:57:07.381] <TB2> INFO: Test took 15719ms.
[09:57:09.971] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:57:10.272] <TB2> INFO: dacScan step from 99 .. 99
[09:57:25.367] <TB2> INFO: Test took 15094ms.
[09:57:27.695] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:57:27.987] <TB2> INFO: dacScan step from 100 .. 100
[09:57:43.518] <TB2> INFO: Test took 15530ms.
[09:57:46.122] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:57:46.547] <TB2> INFO: dacScan step from 101 .. 101
[09:58:02.084] <TB2> INFO: Test took 15536ms.
[09:58:04.640] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:58:04.936] <TB2> INFO: dacScan step from 102 .. 102
[09:58:20.493] <TB2> INFO: Test took 15556ms.
[09:58:23.119] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:58:23.409] <TB2> INFO: dacScan step from 103 .. 103
[09:58:39.072] <TB2> INFO: Test took 15662ms.
[09:58:41.523] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:58:41.811] <TB2> INFO: dacScan step from 104 .. 104
[09:58:57.418] <TB2> INFO: Test took 15606ms.
[09:58:59.921] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:59:00.270] <TB2> INFO: dacScan step from 105 .. 105
[09:59:15.548] <TB2> INFO: Test took 15277ms.
[09:59:18.071] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:59:18.365] <TB2> INFO: dacScan step from 106 .. 106
[09:59:34.351] <TB2> INFO: Test took 15985ms.
[09:59:36.649] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:59:36.942] <TB2> INFO: dacScan step from 107 .. 107
[09:59:52.303] <TB2> INFO: Test took 15360ms.
[09:59:55.106] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:59:55.404] <TB2> INFO: dacScan step from 108 .. 108
[10:00:10.799] <TB2> INFO: Test took 15394ms.
[10:00:13.421] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:00:13.709] <TB2> INFO: dacScan step from 109 .. 109
[10:00:29.027] <TB2> INFO: Test took 15318ms.
[10:00:31.825] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:00:32.114] <TB2> INFO: dacScan step from 110 .. 110
[10:00:47.660] <TB2> INFO: Test took 15545ms.
[10:00:50.026] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:00:50.320] <TB2> INFO: dacScan step from 111 .. 111
[10:01:05.779] <TB2> INFO: Test took 15458ms.
[10:01:08.308] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:01:08.609] <TB2> INFO: dacScan step from 112 .. 112
[10:01:23.859] <TB2> INFO: Test took 15249ms.
[10:01:26.187] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:01:26.489] <TB2> INFO: dacScan step from 113 .. 113
[10:01:42.348] <TB2> INFO: Test took 15858ms.
[10:01:44.911] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:01:45.251] <TB2> INFO: dacScan step from 114 .. 114
[10:02:00.875] <TB2> INFO: Test took 15623ms.
[10:02:03.540] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:02:03.833] <TB2> INFO: dacScan step from 115 .. 115
[10:02:19.603] <TB2> INFO: Test took 15769ms.
[10:02:22.042] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:02:22.370] <TB2> INFO: dacScan step from 116 .. 116
[10:02:38.270] <TB2> INFO: Test took 15899ms.
[10:02:40.646] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:02:40.941] <TB2> INFO: dacScan step from 117 .. 117
[10:02:56.024] <TB2> INFO: Test took 15082ms.
[10:02:58.544] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:02:58.909] <TB2> INFO: dacScan step from 118 .. 118
[10:03:14.323] <TB2> INFO: Test took 15413ms.
[10:03:16.636] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:03:16.925] <TB2> INFO: dacScan step from 119 .. 119
[10:03:32.314] <TB2> INFO: Test took 15388ms.
[10:03:34.960] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:03:35.392] <TB2> INFO: dacScan step from 120 .. 120
[10:03:50.572] <TB2> INFO: Test took 15178ms.
[10:03:53.304] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:03:53.595] <TB2> INFO: dacScan step from 121 .. 121
[10:04:08.616] <TB2> INFO: Test took 15020ms.
[10:04:11.457] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:04:11.746] <TB2> INFO: dacScan step from 122 .. 122
[10:04:27.479] <TB2> INFO: Test took 15732ms.
[10:04:30.220] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:04:30.523] <TB2> INFO: dacScan step from 123 .. 123
[10:04:45.913] <TB2> INFO: Test took 15389ms.
[10:04:48.498] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:04:48.807] <TB2> INFO: dacScan step from 124 .. 124
[10:05:04.199] <TB2> INFO: Test took 15390ms.
[10:05:06.911] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:05:07.201] <TB2> INFO: dacScan step from 125 .. 125
[10:05:22.264] <TB2> INFO: Test took 15061ms.
[10:05:24.723] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:05:25.020] <TB2> INFO: dacScan step from 126 .. 126
[10:05:40.701] <TB2> INFO: Test took 15679ms.
[10:05:43.333] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:05:43.691] <TB2> INFO: dacScan step from 127 .. 127
[10:05:58.927] <TB2> INFO: Test took 15235ms.
[10:06:01.776] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:06:02.134] <TB2> INFO: dacScan step from 128 .. 128
[10:06:17.589] <TB2> INFO: Test took 15454ms.
[10:06:19.950] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:06:20.243] <TB2> INFO: dacScan step from 129 .. 129
[10:06:35.684] <TB2> INFO: Test took 15440ms.
[10:06:38.157] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:06:38.456] <TB2> INFO: dacScan step from 130 .. 130
[10:06:53.835] <TB2> INFO: Test took 15378ms.
[10:06:56.503] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:06:56.929] <TB2> INFO: dacScan step from 131 .. 131
[10:07:12.237] <TB2> INFO: Test took 15306ms.
[10:07:14.591] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:07:14.892] <TB2> INFO: dacScan step from 132 .. 132
[10:07:30.096] <TB2> INFO: Test took 15203ms.
[10:07:32.897] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:07:33.189] <TB2> INFO: dacScan step from 133 .. 133
[10:07:48.560] <TB2> INFO: Test took 15369ms.
[10:07:50.890] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:07:51.180] <TB2> INFO: dacScan step from 134 .. 134
[10:08:06.411] <TB2> INFO: Test took 15230ms.
[10:08:08.921] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:08:09.213] <TB2> INFO: dacScan step from 135 .. 135
[10:08:24.810] <TB2> INFO: Test took 15595ms.
[10:08:27.262] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:08:27.592] <TB2> INFO: dacScan step from 136 .. 136
[10:08:43.231] <TB2> INFO: Test took 15638ms.
[10:08:45.901] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:08:46.199] <TB2> INFO: dacScan step from 137 .. 137
[10:09:01.515] <TB2> INFO: Test took 15314ms.
[10:09:04.109] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:09:04.400] <TB2> INFO: dacScan step from 138 .. 138
[10:09:20.167] <TB2> INFO: Test took 15766ms.
[10:09:22.921] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:09:23.245] <TB2> INFO: dacScan step from 139 .. 139
[10:09:38.553] <TB2> INFO: Test took 15307ms.
[10:09:41.322] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:09:41.661] <TB2> INFO: dacScan step from 140 .. 140
[10:09:57.000] <TB2> INFO: Test took 15338ms.
[10:09:59.343] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:09:59.753] <TB2> INFO: dacScan step from 141 .. 141
[10:10:15.191] <TB2> INFO: Test took 15436ms.
[10:10:17.583] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:10:17.883] <TB2> INFO: dacScan step from 142 .. 142
[10:10:33.307] <TB2> INFO: Test took 15423ms.
[10:10:35.639] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:10:35.938] <TB2> INFO: dacScan step from 143 .. 143
[10:10:51.558] <TB2> INFO: Test took 15619ms.
[10:10:53.983] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:10:54.283] <TB2> INFO: dacScan step from 144 .. 144
[10:11:09.910] <TB2> INFO: Test took 15626ms.
[10:11:12.711] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:11:13.011] <TB2> INFO: dacScan step from 145 .. 145
[10:11:28.270] <TB2> INFO: Test took 15257ms.
[10:11:31.038] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:11:31.344] <TB2> INFO: dacScan step from 146 .. 146
[10:11:46.741] <TB2> INFO: Test took 15395ms.
[10:11:49.624] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:11:49.933] <TB2> INFO: dacScan step from 147 .. 147
[10:12:05.657] <TB2> INFO: Test took 15722ms.
[10:12:08.280] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:12:08.570] <TB2> INFO: dacScan step from 148 .. 148
[10:12:24.234] <TB2> INFO: Test took 15662ms.
[10:12:26.854] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:12:27.146] <TB2> INFO: dacScan step from 149 .. 149
[10:12:42.598] <TB2> INFO: Test took 15451ms.
[10:12:45.259] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:12:45.549] <TB2> INFO: dacScan step from 150 .. 150
[10:13:00.930] <TB2> INFO: Test took 15379ms.
[10:13:03.341] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:13:03.637] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[10:13:05.313] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[10:13:06.971] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[10:13:08.636] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[10:13:10.415] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[10:13:12.278] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[10:13:14.181] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[10:13:16.077] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[10:13:17.972] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[10:13:19.850] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[10:13:21.722] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[10:13:23.562] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[10:13:25.360] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[10:13:27.111] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[10:13:28.747] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[10:13:30.409] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[10:13:32.054] <TB2> INFO: PixTest:: pg_setup set to default.
[10:13:32.056] <TB2> INFO: vcal mean: 40.19 39.91 39.60 43.46 43.79 44.73 45.41 44.22 44.76 45.52 44.58 44.03 44.89 40.32 40.37 40.32
[10:13:32.056] <TB2> INFO: vcal RMS: 14.64 1.27 1.13 1.80 1.30 1.59 1.71 1.55 1.61 1.67 1.67 1.65 1.70 1.53 1.37 1.37
[10:13:32.056] <TB2> INFO: number of X-ray hits detected: 295207 207691 209211 403345 381277 472893 470139 458136 447187 489169 457292 387910 371398 211366 210345 195751
[10:13:32.056] <TB2> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[10:13:32.056] <TB2> INFO: X-ray hit rate [MHz/cm2]: 86.5 60.9 61.3 118.2 111.8 138.6 137.8 134.3 131.1 143.4 134.0 113.7 108.9 62.0 61.7 57.4
[10:13:32.056] <TB2> INFO: PixTestHighRate::doXNoiseMaps() done
[10:13:32.150] <TB2> INFO: enter test to run
[10:13:32.151] <TB2> INFO: test: no parameter change
[10:13:32.332] <TB2> QUIET: Connection to board 162 closed.
[10:13:32.412] <TB2> INFO: pXar: this is the end, my friend
MoReWeb-v1.0.0-5-g82d9ff6 on branch psi46master