Test Date: 2016-09-19 15:21
Analysis date: 2016-09-19 17:33
Logfile
commander_PixelAlive.log
[13:23:51.088] <TB3> INFO: *** Welcome to pxar ***
[13:23:51.088] <TB3> INFO: *** Today: 2016/09/19
[13:23:51.156] <TB3> INFO: *** Version: f5d3-dirty
[13:23:51.156] <TB3> INFO: readRocDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//000_PixelAlive_p17//dacParameters35_C15.dat
[13:23:51.157] <TB3> INFO: readTbmDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//000_PixelAlive_p17//tbmParameters_C0b.dat
[13:23:51.157] <TB3> INFO: readMaskFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//000_PixelAlive_p17//defaultMaskFile.dat
[13:23:51.157] <TB3> INFO: readTrimFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//000_PixelAlive_p17//trimParameters35_C15.dat
[13:23:51.236] <TB3> INFO: clk: 4
[13:23:51.236] <TB3> INFO: ctr: 4
[13:23:51.236] <TB3> INFO: sda: 19
[13:23:51.236] <TB3> INFO: tin: 9
[13:23:51.236] <TB3> INFO: level: 15
[13:23:51.236] <TB3> INFO: triggerdelay: 0
[13:23:51.236] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[13:23:51.236] <TB3> INFO: Log level: INFO
[13:23:51.249] <TB3> INFO: Found DTB DTB_WWV6Z5
[13:23:51.258] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[13:23:51.260] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[13:23:51.262] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[13:23:52.804] <TB3> INFO: DUT info:
[13:23:52.804] <TB3> INFO: The DUT currently contains the following objects:
[13:23:52.804] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[13:23:52.804] <TB3> INFO: TBM Core alpha (0): 7 registers set
[13:23:52.804] <TB3> INFO: TBM Core beta (1): 7 registers set
[13:23:52.804] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:23:52.804] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:23:52.804] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:23:52.804] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:23:52.804] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:23:52.804] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:23:52.804] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:23:52.804] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:23:52.804] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:23:52.804] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:23:52.804] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:23:52.804] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:23:52.804] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:23:52.804] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:23:52.804] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:23:52.804] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:23:52.804] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:23:53.205] <TB3> INFO: enter 'restricted' command line mode
[13:23:53.205] <TB3> INFO: enter test to run
[13:23:53.205] <TB3> INFO: test: PixelAlive no parameter change
[13:23:53.205] <TB3> INFO: running: pixelalive
[13:23:53.210] <TB3> INFO: ######################################################################
[13:23:53.210] <TB3> INFO: PixTestAlive::doTest()
[13:23:53.210] <TB3> INFO: ######################################################################
[13:23:53.211] <TB3> INFO: ----------------------------------------------------------------------
[13:23:53.211] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:23:53.211] <TB3> INFO: ----------------------------------------------------------------------
[13:23:53.477] <TB3> INFO: Expecting 41600 events.
[13:23:57.195] <TB3> INFO: 41600 events read in total (3159ms).
[13:23:57.243] <TB3> INFO: Test took 4029ms.
[13:23:57.481] <TB3> INFO: PixTestAlive::aliveTest() done
[13:23:57.481] <TB3> INFO: number of dead pixels (per ROC): 1 1 0 0 0 2 0 0 0 0 1 0 0 0 0 0
[13:23:57.483] <TB3> INFO: ----------------------------------------------------------------------
[13:23:57.483] <TB3> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:23:57.483] <TB3> INFO: ----------------------------------------------------------------------
[13:23:57.744] <TB3> INFO: Expecting 41600 events.
[13:24:00.669] <TB3> INFO: 41600 events read in total (2368ms).
[13:24:00.669] <TB3> INFO: Test took 3184ms.
[13:24:00.670] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:24:00.933] <TB3> INFO: PixTestAlive::maskTest() done
[13:24:00.933] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:24:00.934] <TB3> INFO: ----------------------------------------------------------------------
[13:24:00.934] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:24:00.934] <TB3> INFO: ----------------------------------------------------------------------
[13:24:01.193] <TB3> INFO: Expecting 41600 events.
[13:24:04.887] <TB3> INFO: 41600 events read in total (3137ms).
[13:24:04.888] <TB3> INFO: Test took 3952ms.
[13:24:05.135] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[13:24:05.135] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:24:05.135] <TB3> INFO: PixTestAlive::doTest() done, duration: 11 seconds
[13:24:05.166] <TB3> INFO: enter test to run
[13:24:05.166] <TB3> INFO: test: no parameter change
[13:24:05.360] <TB3> QUIET: Connection to board 121 closed.
[13:24:05.439] <TB3> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[13:29:39.497] <TB3> INFO: *** Welcome to pxar ***
[13:29:39.497] <TB3> INFO: *** Today: 2016/09/19
[13:29:39.566] <TB3> INFO: *** Version: f5d3-dirty
[13:29:39.566] <TB3> INFO: readRocDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//dacParameters35_C15.dat
[13:29:39.566] <TB3> INFO: readTbmDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[13:29:39.567] <TB3> INFO: readMaskFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//defaultMaskFile.dat
[13:29:39.567] <TB3> INFO: readTrimFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C15.dat
[13:29:39.651] <TB3> INFO: clk: 4
[13:29:39.651] <TB3> INFO: ctr: 4
[13:29:39.651] <TB3> INFO: sda: 19
[13:29:39.651] <TB3> INFO: tin: 9
[13:29:39.651] <TB3> INFO: level: 15
[13:29:39.651] <TB3> INFO: triggerdelay: 0
[13:29:39.651] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[13:29:39.651] <TB3> INFO: Log level: INFO
[13:29:39.664] <TB3> INFO: Found DTB DTB_WWV6Z5
[13:29:39.672] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[13:29:39.674] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[13:29:39.676] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[13:29:41.250] <TB3> INFO: DUT info:
[13:29:41.250] <TB3> INFO: The DUT currently contains the following objects:
[13:29:41.250] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[13:29:41.250] <TB3> INFO: TBM Core alpha (0): 7 registers set
[13:29:41.250] <TB3> INFO: TBM Core beta (1): 7 registers set
[13:29:41.250] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:29:41.250] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.251] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.251] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.651] <TB3> INFO: enter 'restricted' command line mode
[13:29:41.651] <TB3> INFO: enter test to run
[13:29:41.651] <TB3> INFO: test: delay setting parameters: ->5<-
[13:29:41.651] <TB3> INFO: delay test by 5 seconds...
[13:29:46.651] <TB3> INFO: enter test to run
[13:29:46.651] <TB3> INFO: test: highrate no parameter change
[13:29:46.651] <TB3> INFO: running: highrate
[13:29:46.652] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[13:29:46.806] <TB3> INFO: ----------------------------------------------------------------------
[13:29:46.806] <TB3> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[13:29:46.806] <TB3> INFO: ----------------------------------------------------------------------
[13:29:46.806] <TB3> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[13:29:46.806] <TB3> INFO: edge/corner pixel THR is adjusted
[13:29:46.806] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[13:29:47.527] <TB3> INFO: Collecting data for 1 seconds...
[13:29:48.528] <TB3> INFO: Done with hot pixel readout
[13:29:54.717] <TB3> INFO: PixTest:: pg_setup set to default.
[13:29:54.718] <TB3> INFO: 2 hot pixels found in step 0
[13:29:55.443] <TB3> INFO: Collecting data for 1 seconds...
[13:29:56.445] <TB3> INFO: Done with hot pixel readout
[13:30:02.934] <TB3> INFO: PixTest:: pg_setup set to default.
[13:30:02.935] <TB3> INFO: 2 hot pixels found in step 1
[13:30:03.659] <TB3> INFO: Collecting data for 1 seconds...
[13:30:04.660] <TB3> INFO: Done with hot pixel readout
[13:30:11.022] <TB3> INFO: PixTest:: pg_setup set to default.
[13:30:11.023] <TB3> INFO: 2 hot pixels found in step 2
[13:30:11.748] <TB3> INFO: Collecting data for 1 seconds...
[13:30:12.749] <TB3> INFO: Done with hot pixel readout
[13:30:18.846] <TB3> INFO: PixTest:: pg_setup set to default.
[13:30:18.847] <TB3> INFO: 0 hot pixels found in step 3
[13:30:18.854] <TB3> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[13:30:18.883] <TB3> INFO: PixTest::trimHotPixels() done
[13:30:18.883] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C0.dat
[13:30:18.889] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C1.dat
[13:30:18.896] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C2.dat
[13:30:18.902] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C3.dat
[13:30:18.909] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C4.dat
[13:30:18.915] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C5.dat
[13:30:18.922] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C6.dat
[13:30:18.928] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C7.dat
[13:30:18.935] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C8.dat
[13:30:18.941] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C9.dat
[13:30:18.948] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C10.dat
[13:30:18.954] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C11.dat
[13:30:18.961] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C12.dat
[13:30:18.967] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C13.dat
[13:30:18.974] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C14.dat
[13:30:18.980] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C15.dat
[13:30:18.987] <TB3> INFO: write masked pixels into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//defaultMaskFile.dat
[13:30:19.018] <TB3> INFO: enter test to run
[13:30:19.018] <TB3> INFO: test: no parameter change
[13:30:19.257] <TB3> QUIET: Connection to board 121 closed.
[13:30:19.337] <TB3> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[13:29:39.497] <TB3> INFO: *** Welcome to pxar ***
[13:29:39.497] <TB3> INFO: *** Today: 2016/09/19
[13:29:39.566] <TB3> INFO: *** Version: f5d3-dirty
[13:29:39.566] <TB3> INFO: readRocDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//dacParameters35_C15.dat
[13:29:39.566] <TB3> INFO: readTbmDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[13:29:39.567] <TB3> INFO: readMaskFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//defaultMaskFile.dat
[13:29:39.567] <TB3> INFO: readTrimFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C15.dat
[13:29:39.651] <TB3> INFO: clk: 4
[13:29:39.651] <TB3> INFO: ctr: 4
[13:29:39.651] <TB3> INFO: sda: 19
[13:29:39.651] <TB3> INFO: tin: 9
[13:29:39.651] <TB3> INFO: level: 15
[13:29:39.651] <TB3> INFO: triggerdelay: 0
[13:29:39.651] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[13:29:39.651] <TB3> INFO: Log level: INFO
[13:29:39.664] <TB3> INFO: Found DTB DTB_WWV6Z5
[13:29:39.672] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[13:29:39.674] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[13:29:39.676] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[13:29:41.250] <TB3> INFO: DUT info:
[13:29:41.250] <TB3> INFO: The DUT currently contains the following objects:
[13:29:41.250] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[13:29:41.250] <TB3> INFO: TBM Core alpha (0): 7 registers set
[13:29:41.250] <TB3> INFO: TBM Core beta (1): 7 registers set
[13:29:41.250] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:29:41.250] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.250] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.251] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.251] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:29:41.651] <TB3> INFO: enter 'restricted' command line mode
[13:29:41.651] <TB3> INFO: enter test to run
[13:29:41.651] <TB3> INFO: test: delay setting parameters: ->5<-
[13:29:41.651] <TB3> INFO: delay test by 5 seconds...
[13:29:46.651] <TB3> INFO: enter test to run
[13:29:46.651] <TB3> INFO: test: highrate no parameter change
[13:29:46.651] <TB3> INFO: running: highrate
[13:29:46.652] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[13:29:46.806] <TB3> INFO: ----------------------------------------------------------------------
[13:29:46.806] <TB3> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[13:29:46.806] <TB3> INFO: ----------------------------------------------------------------------
[13:29:46.806] <TB3> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[13:29:46.806] <TB3> INFO: edge/corner pixel THR is adjusted
[13:29:46.806] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[13:29:47.527] <TB3> INFO: Collecting data for 1 seconds...
[13:29:48.528] <TB3> INFO: Done with hot pixel readout
[13:29:54.717] <TB3> INFO: PixTest:: pg_setup set to default.
[13:29:54.718] <TB3> INFO: 2 hot pixels found in step 0
[13:29:55.443] <TB3> INFO: Collecting data for 1 seconds...
[13:29:56.445] <TB3> INFO: Done with hot pixel readout
[13:30:02.934] <TB3> INFO: PixTest:: pg_setup set to default.
[13:30:02.935] <TB3> INFO: 2 hot pixels found in step 1
[13:30:03.659] <TB3> INFO: Collecting data for 1 seconds...
[13:30:04.660] <TB3> INFO: Done with hot pixel readout
[13:30:11.022] <TB3> INFO: PixTest:: pg_setup set to default.
[13:30:11.023] <TB3> INFO: 2 hot pixels found in step 2
[13:30:11.748] <TB3> INFO: Collecting data for 1 seconds...
[13:30:12.749] <TB3> INFO: Done with hot pixel readout
[13:30:18.846] <TB3> INFO: PixTest:: pg_setup set to default.
[13:30:18.847] <TB3> INFO: 0 hot pixels found in step 3
[13:30:18.854] <TB3> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[13:30:18.883] <TB3> INFO: PixTest::trimHotPixels() done
[13:30:18.883] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C0.dat
[13:30:18.889] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C1.dat
[13:30:18.896] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C2.dat
[13:30:18.902] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C3.dat
[13:30:18.909] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C4.dat
[13:30:18.915] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C5.dat
[13:30:18.922] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C6.dat
[13:30:18.928] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C7.dat
[13:30:18.935] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C8.dat
[13:30:18.941] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C9.dat
[13:30:18.948] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C10.dat
[13:30:18.954] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C11.dat
[13:30:18.961] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C12.dat
[13:30:18.967] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C13.dat
[13:30:18.974] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C14.dat
[13:30:18.980] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//trimParameters35_C15.dat
[13:30:18.987] <TB3> INFO: write masked pixels into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//002_RetrimHotPixels_150//defaultMaskFile.dat
[13:30:19.018] <TB3> INFO: enter test to run
[13:30:19.018] <TB3> INFO: test: no parameter change
[13:30:19.257] <TB3> QUIET: Connection to board 121 closed.
[13:30:19.337] <TB3> INFO: pXar: this is the end, my friend
[13:31:07.877] <TB3> INFO: *** Welcome to pxar ***
[13:31:07.877] <TB3> INFO: *** Today: 2016/09/19
[13:31:07.943] <TB3> INFO: *** Version: f5d3-dirty
[13:31:07.943] <TB3> INFO: readRocDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//dacParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//dacParameters35_C15.dat
[13:31:07.944] <TB3> INFO: readTbmDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//tbmParameters_C0a.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//tbmParameters_C0b.dat
[13:31:07.944] <TB3> INFO: readMaskFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//defaultMaskFile.dat
[13:31:07.944] <TB3> INFO: readTrimFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//trimParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//trimParameters35_C15.dat
[13:31:08.011] <TB3> INFO: clk: 4
[13:31:08.011] <TB3> INFO: ctr: 4
[13:31:08.011] <TB3> INFO: sda: 19
[13:31:08.012] <TB3> INFO: tin: 9
[13:31:08.012] <TB3> INFO: level: 15
[13:31:08.012] <TB3> INFO: triggerdelay: 0
[13:31:08.012] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[13:31:08.012] <TB3> INFO: Log level: INFO
[13:31:08.025] <TB3> INFO: Found DTB DTB_WWV6Z5
[13:31:08.033] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[13:31:08.035] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[13:31:08.037] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[13:31:09.581] <TB3> INFO: DUT info:
[13:31:09.581] <TB3> INFO: The DUT currently contains the following objects:
[13:31:09.581] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[13:31:09.581] <TB3> INFO: TBM Core alpha (0): 7 registers set
[13:31:09.581] <TB3> INFO: TBM Core beta (1): 7 registers set
[13:31:09.581] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:31:09.581] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:09.581] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:09.581] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:09.581] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:09.581] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:09.581] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:09.581] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:09.581] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:09.581] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:09.581] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:09.581] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:09.581] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:09.581] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:09.582] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:09.582] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:09.582] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:09.983] <TB3> INFO: enter 'restricted' command line mode
[13:31:09.983] <TB3> INFO: enter test to run
[13:31:09.983] <TB3> INFO: test: delay setting parameters: ->5<-
[13:31:09.983] <TB3> INFO: delay test by 5 seconds...
[13:31:14.983] <TB3> INFO: enter test to run
[13:31:14.983] <TB3> INFO: test: highrate no parameter change
[13:31:14.983] <TB3> INFO: running: highrate
[13:31:14.983] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//phCalibrationFitErr35_C15.dat
[13:31:15.113] <TB3> INFO: ----------------------------------------------------------------------
[13:31:15.113] <TB3> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[13:31:15.113] <TB3> INFO: ----------------------------------------------------------------------
[13:31:15.113] <TB3> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[13:31:15.113] <TB3> INFO: edge/corner pixel THR is adjusted
[13:31:15.113] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[13:31:15.835] <TB3> INFO: Collecting data for 1 seconds...
[13:31:16.836] <TB3> INFO: Done with hot pixel readout
[13:31:20.540] <TB3> INFO: PixTest:: pg_setup set to default.
[13:31:20.545] <TB3> INFO: 0 hot pixels found in step 0
[13:31:20.548] <TB3> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[13:31:20.578] <TB3> INFO: PixTest::trimHotPixels() done
[13:31:20.579] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//trimParameters35_C0.dat
[13:31:20.585] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//trimParameters35_C1.dat
[13:31:20.591] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//trimParameters35_C2.dat
[13:31:20.597] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//trimParameters35_C3.dat
[13:31:20.603] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//trimParameters35_C4.dat
[13:31:20.609] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//trimParameters35_C5.dat
[13:31:20.616] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//trimParameters35_C6.dat
[13:31:20.622] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//trimParameters35_C7.dat
[13:31:20.628] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//trimParameters35_C8.dat
[13:31:20.634] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//trimParameters35_C9.dat
[13:31:20.640] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//trimParameters35_C10.dat
[13:31:20.647] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//trimParameters35_C11.dat
[13:31:20.653] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//trimParameters35_C12.dat
[13:31:20.659] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//trimParameters35_C13.dat
[13:31:20.665] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//trimParameters35_C14.dat
[13:31:20.671] <TB3> INFO: write trim parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//trimParameters35_C15.dat
[13:31:20.677] <TB3> INFO: write masked pixels into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//003_RetrimHotPixels_50//defaultMaskFile.dat
[13:31:20.707] <TB3> INFO: enter test to run
[13:31:20.707] <TB3> INFO: test: no parameter change
[13:31:20.936] <TB3> QUIET: Connection to board 121 closed.
[13:31:21.300] <TB3> INFO: pXar: this is the end, my friend
commander_HRData.log
[13:32:12.277] <TB3> INFO: *** Welcome to pxar ***
[13:32:12.277] <TB3> INFO: *** Today: 2016/09/19
[13:32:12.344] <TB3> INFO: *** Version: f5d3-dirty
[13:32:12.345] <TB3> INFO: readRocDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//004_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//004_HRData_50//dacParameters35_C15.dat
[13:32:12.346] <TB3> INFO: readTbmDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//004_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//004_HRData_50//tbmParameters_C0b.dat
[13:32:12.346] <TB3> INFO: readMaskFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//004_HRData_50//defaultMaskFile.dat
[13:32:12.346] <TB3> INFO: readTrimFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//004_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//004_HRData_50//trimParameters35_C15.dat
[13:32:12.429] <TB3> INFO: clk: 4
[13:32:12.429] <TB3> INFO: ctr: 4
[13:32:12.429] <TB3> INFO: sda: 19
[13:32:12.429] <TB3> INFO: tin: 9
[13:32:12.429] <TB3> INFO: level: 15
[13:32:12.429] <TB3> INFO: triggerdelay: 0
[13:32:12.429] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[13:32:12.429] <TB3> INFO: Log level: INFO
[13:32:12.442] <TB3> INFO: Found DTB DTB_WWV6Z5
[13:32:12.450] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[13:32:12.452] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[13:32:12.454] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[13:32:14.001] <TB3> INFO: DUT info:
[13:32:14.001] <TB3> INFO: The DUT currently contains the following objects:
[13:32:14.001] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[13:32:14.001] <TB3> INFO: TBM Core alpha (0): 7 registers set
[13:32:14.001] <TB3> INFO: TBM Core beta (1): 7 registers set
[13:32:14.001] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:32:14.001] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:14.001] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:14.001] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:14.001] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:14.001] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:14.001] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:14.001] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:14.001] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:14.001] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:14.001] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:14.001] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:14.001] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:14.001] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:14.001] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:14.001] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:14.001] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:14.402] <TB3> INFO: enter 'restricted' command line mode
[13:32:14.402] <TB3> INFO: enter test to run
[13:32:14.402] <TB3> INFO: test: delay setting parameters: ->5<-
[13:32:14.402] <TB3> INFO: delay test by 5 seconds...
[13:32:19.402] <TB3> INFO: enter test to run
[13:32:19.402] <TB3> INFO: test: Xray no parameter change
[13:32:19.402] <TB3> INFO: running: xray
[13:32:19.402] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//004_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//004_HRData_50//phCalibrationFitErr35_C15.dat
[13:32:19.547] <TB3> INFO: ######################################################################
[13:32:19.547] <TB3> INFO: PixTestXray::doTest()
[13:32:19.547] <TB3> INFO: ######################################################################
[13:32:19.547] <TB3> INFO: ----------------------------------------------------------------------
[13:32:19.547] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[13:32:19.547] <TB3> INFO: ----------------------------------------------------------------------
[13:32:20.274] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[13:32:27.313] <TB3> INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[13:32:56.568] <TB3> INFO: Resuming triggers.
[13:33:03.610] <TB3> INFO: run duration 14 seconds, buffer almost full (81%), pausing triggers.
[13:33:32.878] <TB3> INFO: Resuming triggers.
[13:33:39.920] <TB3> INFO: run duration 21 seconds, buffer almost full (81%), pausing triggers.
[13:34:08.977] <TB3> INFO: Resuming triggers.
[13:34:16.018] <TB3> INFO: run duration 28 seconds, buffer almost full (81%), pausing triggers.
[13:34:45.494] <TB3> INFO: Resuming triggers.
[13:34:52.532] <TB3> INFO: run duration 35 seconds, buffer almost full (81%), pausing triggers.
[13:35:21.762] <TB3> INFO: Resuming triggers.
[13:35:28.801] <TB3> INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[13:35:58.186] <TB3> INFO: Resuming triggers.
[13:36:05.221] <TB3> INFO: run duration 49 seconds, buffer almost full (81%), pausing triggers.
[13:36:34.052] <TB3> INFO: Resuming triggers.
[13:36:41.091] <TB3> INFO: run duration 56 seconds, buffer almost full (81%), pausing triggers.
[13:37:09.580] <TB3> INFO: Resuming triggers.
[13:37:16.618] <TB3> INFO: run duration 63 seconds, buffer almost full (81%), pausing triggers.
[13:37:45.167] <TB3> INFO: Resuming triggers.
[13:37:52.201] <TB3> INFO: run duration 70 seconds, buffer almost full (81%), pausing triggers.
[13:38:20.487] <TB3> INFO: Resuming triggers.
[13:38:27.519] <TB3> INFO: run duration 77 seconds, buffer almost full (81%), pausing triggers.
[13:38:56.744] <TB3> INFO: Resuming triggers.
[13:39:03.777] <TB3> INFO: run duration 84 seconds, buffer almost full (81%), pausing triggers.
[13:39:32.801] <TB3> INFO: Resuming triggers.
[13:39:39.831] <TB3> INFO: run duration 91 seconds, buffer almost full (81%), pausing triggers.
[13:40:08.998] <TB3> INFO: Resuming triggers.
[13:40:16.028] <TB3> INFO: run duration 98 seconds, buffer almost full (81%), pausing triggers.
[13:40:44.144] <TB3> INFO: Resuming triggers.
[13:40:45.690] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[13:40:52.149] <TB3> INFO: PixTest:: pg_setup set to default.
[13:40:52.151] <TB3> INFO: PixTestXray::doPhRun() done
[13:40:52.151] <TB3> INFO: PixTestXray::doTest() done
[13:40:52.337] <TB3> INFO: enter test to run
[13:40:52.337] <TB3> INFO: test: no parameter change
[13:40:52.602] <TB3> QUIET: Connection to board 121 closed.
[13:40:52.682] <TB3> INFO: pXar: this is the end, my friend
commander_HRData.log
[13:42:11.203] <TB3> INFO: *** Welcome to pxar ***
[13:42:11.203] <TB3> INFO: *** Today: 2016/09/19
[13:42:11.269] <TB3> INFO: *** Version: f5d3-dirty
[13:42:11.269] <TB3> INFO: readRocDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//005_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//005_HRData_150//dacParameters35_C15.dat
[13:42:11.270] <TB3> INFO: readTbmDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//005_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//005_HRData_150//tbmParameters_C0b.dat
[13:42:11.270] <TB3> INFO: readMaskFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//005_HRData_150//defaultMaskFile.dat
[13:42:11.270] <TB3> INFO: readTrimFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//005_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//005_HRData_150//trimParameters35_C15.dat
[13:42:11.349] <TB3> INFO: clk: 4
[13:42:11.349] <TB3> INFO: ctr: 4
[13:42:11.349] <TB3> INFO: sda: 19
[13:42:11.349] <TB3> INFO: tin: 9
[13:42:11.349] <TB3> INFO: level: 15
[13:42:11.349] <TB3> INFO: triggerdelay: 0
[13:42:11.349] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[13:42:11.349] <TB3> INFO: Log level: INFO
[13:42:11.361] <TB3> INFO: Found DTB DTB_WWV6Z5
[13:42:11.370] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[13:42:11.372] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[13:42:11.374] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[13:42:12.918] <TB3> INFO: DUT info:
[13:42:12.918] <TB3> INFO: The DUT currently contains the following objects:
[13:42:12.918] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[13:42:12.918] <TB3> INFO: TBM Core alpha (0): 7 registers set
[13:42:12.918] <TB3> INFO: TBM Core beta (1): 7 registers set
[13:42:12.918] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:42:12.918] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:12.918] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:12.918] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:12.918] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:12.918] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:12.918] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:12.918] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:12.918] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:12.918] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:12.918] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:12.918] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:12.918] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:12.918] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:12.918] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:12.918] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:12.918] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:13.319] <TB3> INFO: enter 'restricted' command line mode
[13:42:13.319] <TB3> INFO: enter test to run
[13:42:13.319] <TB3> INFO: test: delay setting parameters: ->5<-
[13:42:13.319] <TB3> INFO: delay test by 5 seconds...
[13:42:18.319] <TB3> INFO: enter test to run
[13:42:18.319] <TB3> INFO: test: Xray no parameter change
[13:42:18.319] <TB3> INFO: running: xray
[13:42:18.319] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//005_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//005_HRData_150//phCalibrationFitErr35_C15.dat
[13:42:18.504] <TB3> INFO: ######################################################################
[13:42:18.504] <TB3> INFO: PixTestXray::doTest()
[13:42:18.504] <TB3> INFO: ######################################################################
[13:42:18.504] <TB3> INFO: ----------------------------------------------------------------------
[13:42:18.504] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[13:42:18.504] <TB3> INFO: ----------------------------------------------------------------------
[13:42:19.233] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[13:42:23.164] <TB3> INFO: run duration 3 seconds, buffer almost full (81%), pausing triggers.
[13:42:52.853] <TB3> INFO: Resuming triggers.
[13:42:56.789] <TB3> INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[13:43:26.884] <TB3> INFO: Resuming triggers.
[13:43:30.823] <TB3> INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[13:43:59.855] <TB3> INFO: Resuming triggers.
[13:44:03.792] <TB3> INFO: run duration 15 seconds, buffer almost full (81%), pausing triggers.
[13:44:33.412] <TB3> INFO: Resuming triggers.
[13:44:37.346] <TB3> INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[13:45:06.789] <TB3> INFO: Resuming triggers.
[13:45:10.728] <TB3> INFO: run duration 23 seconds, buffer almost full (81%), pausing triggers.
[13:45:11.859] <TB3> WARNING: Channel 3 ROC 2: Readback start marker after 32 readouts!

[13:45:11.859] <TB3> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[13:45:11.885] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a332 8000 4070 1b 2268 601 2065 4070 4071 153 264d 280 2469 4071 fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e000 c000

[13:45:11.885] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a32c 80b0 4070 95 2240 259 2a4a 80c 246c 4070 8d 2a4f 413 2068 45b 2262 4070 121 224c 4071 fff 2fff fff 2fff fff 2fff fff 2fff e000 c000

[13:45:11.885] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a32d 80c0 4070 0 2442 4070 4db 2468 701 2641 4070 160 2041 751 264f 4070 509 2447 fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e000 c000

[13:45:11.885] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a32e 8000 4070 219 2266 2d4 2660 4070 4070 4070 305 2445 30c 2a49 fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e000 c000

[13:45:11.885] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a32f 8040 4072 98 2a21 541 266a 4072 4072 4072 2e0 2a83 fff 2fff fff 2fff fff 2fff e000 c000

[13:45:11.885] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a330 80b0 4071 4071 35a 2244 4071 51d 2846 81c 2240 4071 492 2641 fff 2fff fff 2fff fff 2fff fff 2fff e000 c000

[13:45:11.885] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a331 80c0 4071 482 2468 4071 4071 320 2641 6da 206b 4071 159 224e 71a 2281 fff 2fff fff 2fff fff 2fff e000 c000

[13:45:39.902] <TB3> INFO: Resuming triggers.
[13:45:43.842] <TB3> INFO: run duration 27 seconds, buffer almost full (81%), pausing triggers.
[13:46:13.422] <TB3> INFO: Resuming triggers.
[13:46:17.361] <TB3> INFO: run duration 31 seconds, buffer almost full (81%), pausing triggers.
[13:46:37.529] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L507> Channel 3 Number of ROCs (2) != Token Chain Length (4)

[13:46:37.530] <TB3> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[13:46:37.530] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a315 80c0 4070 d1 2a4c 4070 254 2a44 294 2849 619 284f 603 264f 655 2062 743 2062 4060 860 2640 4070 550 2643 fff 2fff fff 2fff fff 2fff e000 c000

[13:46:37.530] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a30f 8040 4072 4072 6da 2049 4072 4072 111 2a45 fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e000 c000

[13:46:37.530] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a310 80b0 4071 4071 4 2447 25b 284f 4071 99 2645 4071 611 2245 fff 2fff fff 2fff fff 2fff fff 2fff e000 c000

[13:46:37.530] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a311 80c0 4071 10a 2a42 45a 2249 494 284d 4071 811 244f 844 2640 4071 4071 58 264a cc 2843 fff 2fff fff 2fff fff 2fff e000 c000

[13:46:37.530] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a312 8000 4070 64b 2a4c 744 2643 4070 9 244f 7f0 2000 62d 2210 64d 280d 446 27f9 e000 c000

[13:46:37.530] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a313 8040 4070 51 224f 352 2681 4071 4070 59 2846 e2 286b 4071 d3 2865 fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e000 c000

[13:46:37.530] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a314 80b0 4070 90 2426 205 286f 559 2a68 4070 1a 286d 4a 2661 8a 244f 619 262f 68a 224d 4070 61 2a4e 4070 820 2649 fff 2fff fff 2fff fff 2fff e000 c000

[13:46:47.106] <TB3> INFO: Resuming triggers.
[13:46:51.044] <TB3> INFO: run duration 35 seconds, buffer almost full (81%), pausing triggers.
[13:47:19.929] <TB3> INFO: Resuming triggers.
[13:47:23.863] <TB3> INFO: run duration 39 seconds, buffer almost full (81%), pausing triggers.
[13:47:53.105] <TB3> INFO: Resuming triggers.
[13:47:57.037] <TB3> INFO: run duration 43 seconds, buffer almost full (81%), pausing triggers.
[13:48:26.112] <TB3> INFO: Resuming triggers.
[13:48:30.062] <TB3> INFO: run duration 47 seconds, buffer almost full (81%), pausing triggers.
[13:48:59.317] <TB3> INFO: Resuming triggers.
[13:49:03.250] <TB3> INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[13:49:32.817] <TB3> INFO: Resuming triggers.
[13:49:36.749] <TB3> INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[13:50:05.838] <TB3> INFO: Resuming triggers.
[13:50:09.769] <TB3> INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[13:50:39.122] <TB3> INFO: Resuming triggers.
[13:50:43.053] <TB3> INFO: run duration 62 seconds, buffer almost full (81%), pausing triggers.
[13:51:12.147] <TB3> INFO: Resuming triggers.
[13:51:16.079] <TB3> INFO: run duration 66 seconds, buffer almost full (81%), pausing triggers.
[13:51:19.004] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L507> Channel 3 Number of ROCs (2) != Token Chain Length (4)

[13:51:19.004] <TB3> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[13:51:19.004] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3a7 8041 4060 301 2a86 759 2043 4070 4070 552 222d 4071 fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e000 c000

[13:51:19.004] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3a1 80c0 4071 118 2829 344 2a62 4071 245 224a 4071 4d9 2a4c 4071 90 2449 fff 2fff fff 2fff fff 2fff fff 2fff e000 c000

[13:51:19.004] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3a2 8000 4070 714 2847 4070 4071 6d3 2a4f 4071 159 2045 fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e000 c000

[13:51:19.004] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3a3 8040 4070 25c 2448 292 2463 4071 69b 244e 4070 682 2464 4071 80b 2865 fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e000 c000

[13:51:19.004] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3a4 80b0 4070 4070 1a 2449 c5 266f 2e0 282a 7f0 2004 29 2154 64d 2415 482 26d1 a66 27f8 112 2446 315 2665 fff 2fff fff 2fff e000 c000

[13:51:19.004] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3a5 80c0 4070 818 2a42 4070 4070 4070 755 2a4f fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e000 c000

[13:51:19.004] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3a6 8000 4070 4070 4070 4070 158 2462 503 2068 6dd 2662 819 264c 819 2a61 fff 2fff fff 2fff e000 c000

[13:51:45.204] <TB3> INFO: Resuming triggers.
[13:51:49.135] <TB3> INFO: run duration 70 seconds, buffer almost full (81%), pausing triggers.
[13:52:18.522] <TB3> INFO: Resuming triggers.
[13:52:22.453] <TB3> INFO: run duration 74 seconds, buffer almost full (81%), pausing triggers.
[13:52:52.033] <TB3> INFO: Resuming triggers.
[13:52:55.966] <TB3> INFO: run duration 78 seconds, buffer almost full (81%), pausing triggers.
[13:53:25.725] <TB3> INFO: Resuming triggers.
[13:53:29.659] <TB3> INFO: run duration 82 seconds, buffer almost full (81%), pausing triggers.
[13:53:59.708] <TB3> INFO: Resuming triggers.
[13:54:03.636] <TB3> INFO: run duration 86 seconds, buffer almost full (81%), pausing triggers.
[13:54:33.483] <TB3> INFO: Resuming triggers.
[13:54:37.415] <TB3> INFO: run duration 90 seconds, buffer almost full (81%), pausing triggers.
[13:55:07.057] <TB3> INFO: Resuming triggers.
[13:55:10.985] <TB3> INFO: run duration 94 seconds, buffer almost full (81%), pausing triggers.
[13:55:40.327] <TB3> INFO: Resuming triggers.
[13:55:44.256] <TB3> INFO: run duration 98 seconds, buffer almost full (81%), pausing triggers.
[13:56:12.398] <TB3> INFO: Resuming triggers.
[13:56:14.098] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[13:56:26.840] <TB3> INFO: PixTest:: pg_setup set to default.
[13:56:26.841] <TB3> INFO: PixTestXray::doPhRun() done
[13:56:26.841] <TB3> INFO: PixTestXray::doTest() done
[13:56:27.025] <TB3> INFO: enter test to run
[13:56:27.025] <TB3> INFO: test: no parameter change
[13:56:27.283] <TB3> QUIET: Connection to board 121 closed.
[13:56:27.365] <TB3> INFO: pXar: this is the end, my friend
commander_HRSCurves.log
[13:59:16.577] <TB3> INFO: *** Welcome to pxar ***
[13:59:16.577] <TB3> INFO: *** Today: 2016/09/19
[13:59:16.645] <TB3> INFO: *** Version: f5d3-dirty
[13:59:16.645] <TB3> INFO: readRocDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//006_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//006_HRSCurves_100//dacParameters35_C15.dat
[13:59:16.646] <TB3> INFO: readTbmDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//006_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//006_HRSCurves_100//tbmParameters_C0b.dat
[13:59:16.646] <TB3> INFO: readMaskFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//006_HRSCurves_100//defaultMaskFile.dat
[13:59:16.646] <TB3> INFO: readTrimFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//006_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//006_HRSCurves_100//trimParameters35_C15.dat
[13:59:16.722] <TB3> INFO: clk: 4
[13:59:16.722] <TB3> INFO: ctr: 4
[13:59:16.722] <TB3> INFO: sda: 19
[13:59:16.722] <TB3> INFO: tin: 9
[13:59:16.722] <TB3> INFO: level: 15
[13:59:16.722] <TB3> INFO: triggerdelay: 0
[13:59:16.722] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[13:59:16.722] <TB3> INFO: Log level: INFO
[13:59:16.736] <TB3> INFO: Found DTB DTB_WWV6Z5
[13:59:16.744] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[13:59:16.746] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[13:59:16.748] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[13:59:18.304] <TB3> INFO: DUT info:
[13:59:18.304] <TB3> INFO: The DUT currently contains the following objects:
[13:59:18.304] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[13:59:18.304] <TB3> INFO: TBM Core alpha (0): 7 registers set
[13:59:18.304] <TB3> INFO: TBM Core beta (1): 7 registers set
[13:59:18.304] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:59:18.304] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:18.304] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:18.304] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:18.304] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:18.304] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:18.304] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:18.304] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:18.304] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:18.304] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:18.304] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:18.304] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:18.304] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:18.304] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:18.304] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:18.304] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:18.304] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:18.705] <TB3> INFO: enter 'restricted' command line mode
[13:59:18.705] <TB3> INFO: enter test to run
[13:59:18.705] <TB3> INFO: test: Highrate no parameter change
[13:59:18.705] <TB3> INFO: running: highrate
[13:59:18.706] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//006_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//006_HRSCurves_100//phCalibrationFitErr35_C15.dat
[13:59:18.844] <TB3> INFO: ----------------------------------------------------------------------
[13:59:18.844] <TB3> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[13:59:18.844] <TB3> INFO: ----------------------------------------------------------------------
[13:59:18.850] <TB3> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 896 (plus default)
[13:59:18.861] <TB3> INFO: dacScan step from 15 .. 34
[13:59:18.861] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[13:59:18.861] <TB3> INFO: run 1 of 1
[13:59:19.353] <TB3> INFO: Expecting 4160000 events.
[13:59:53.472] <TB3> INFO: 497250 events read in total (33715ms).
[14:00:27.063] <TB3> INFO: 995900 events read in total (67306ms).
[14:01:01.392] <TB3> INFO: 1494550 events read in total (101635ms).
[14:01:35.062] <TB3> INFO: 1992950 events read in total (135306ms).
[14:02:08.717] <TB3> INFO: 2491600 events read in total (168960ms).
[14:02:42.268] <TB3> INFO: 2990050 events read in total (202511ms).
[14:03:15.581] <TB3> INFO: 3488350 events read in total (235824ms).
[14:03:49.247] <TB3> INFO: 3985950 events read in total (269490ms).
[14:04:01.159] <TB3> INFO: 4160000 events read in total (281402ms).
[14:04:01.328] <TB3> INFO: Test took 282466ms.
[14:04:07.328] <TB3> INFO: dacScan step from 35 .. 54
[14:04:07.328] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[14:04:07.328] <TB3> INFO: run 1 of 1
[14:04:07.816] <TB3> INFO: Expecting 4160000 events.
[14:04:40.130] <TB3> INFO: 402900 events read in total (31906ms).
[14:05:11.929] <TB3> INFO: 806150 events read in total (63705ms).
[14:05:43.658] <TB3> INFO: 1208900 events read in total (95434ms).
[14:06:15.274] <TB3> INFO: 1610050 events read in total (127050ms).
[14:06:47.374] <TB3> INFO: 2010400 events read in total (159150ms).
[14:07:19.036] <TB3> INFO: 2408650 events read in total (190812ms).
[14:07:50.626] <TB3> INFO: 2804000 events read in total (222402ms).
[14:08:22.209] <TB3> INFO: 3196400 events read in total (253985ms).
[14:08:53.653] <TB3> INFO: 3586400 events read in total (285429ms).
[14:09:24.888] <TB3> INFO: 3974950 events read in total (316664ms).
[14:09:40.172] <TB3> INFO: 4160000 events read in total (331948ms).
[14:09:40.311] <TB3> INFO: Test took 332983ms.
[14:09:46.394] <TB3> INFO: dacScan step from 55 .. 74
[14:09:46.394] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[14:09:46.394] <TB3> INFO: run 1 of 1
[14:09:46.899] <TB3> INFO: Expecting 4160000 events.
[14:10:18.054] <TB3> INFO: 360500 events read in total (30753ms).
[14:10:49.247] <TB3> INFO: 721650 events read in total (61946ms).
[14:11:20.086] <TB3> INFO: 1082950 events read in total (92785ms).
[14:11:50.820] <TB3> INFO: 1444350 events read in total (123519ms).
[14:12:21.736] <TB3> INFO: 1805700 events read in total (154435ms).
[14:12:52.345] <TB3> INFO: 2167100 events read in total (185044ms).
[14:13:23.142] <TB3> INFO: 2528400 events read in total (215841ms).
[14:13:54.295] <TB3> INFO: 2889650 events read in total (246994ms).
[14:14:25.251] <TB3> INFO: 3250750 events read in total (277950ms).
[14:14:56.628] <TB3> INFO: 3612150 events read in total (309327ms).
[14:15:27.899] <TB3> INFO: 3973300 events read in total (340598ms).
[14:15:43.683] <TB3> INFO: 4160000 events read in total (356382ms).
[14:15:43.828] <TB3> INFO: Test took 357434ms.
[14:15:49.904] <TB3> INFO: dacScan step from 75 .. 75
[14:15:49.904] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[14:15:49.904] <TB3> INFO: run 1 of 1
[14:15:50.387] <TB3> INFO: Expecting 208000 events.
[14:16:08.937] <TB3> INFO: 208000 events read in total (18148ms).
[14:16:08.943] <TB3> INFO: Test took 19038ms.
[14:16:09.230] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[14:16:10.344] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[14:16:11.373] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[14:16:12.401] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[14:16:13.445] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[14:16:14.496] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[14:16:15.558] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[14:16:16.620] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[14:16:17.675] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[14:16:18.740] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[14:16:19.804] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[14:16:20.877] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[14:16:22.019] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[14:16:23.186] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[14:16:24.269] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[14:16:25.327] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[14:16:26.462] <TB3> INFO: PixTest:: pg_setup set to default.
[14:16:26.464] <TB3> INFO: vcal mean: 38.21 38.32 37.23 39.68 39.88 41.69 41.08 41.60 41.88 41.78 41.18 41.09 39.59 38.23 38.43 38.47
[14:16:26.464] <TB3> INFO: vcal RMS: 1.01 1.20 0.86 1.17 1.07 1.58 1.34 1.36 1.29 1.30 1.46 1.36 1.02 0.99 0.91 1.02
[14:16:26.464] <TB3> INFO: number of X-ray hits detected: 154008 170402 136860 236560 266056 345332 306081 313936 338967 342613 330009 305671 238834 164566 178134 180420
[14:16:26.464] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[14:16:26.464] <TB3> INFO: X-ray hit rate [MHz/cm2]: 45.1 49.9 40.1 69.3 78.0 101.2 89.7 92.0 99.4 100.4 96.7 89.6 70.0 48.2 52.2 52.9
[14:16:26.464] <TB3> INFO: PixTestHighRate::doXNoiseMaps() done
[14:16:26.572] <TB3> INFO: enter test to run
[14:16:26.572] <TB3> INFO: test: no parameter change
[14:16:26.827] <TB3> QUIET: Connection to board 121 closed.
[14:16:26.907] <TB3> INFO: pXar: this is the end, my friend
commander_CalDelScanAndSaveDacs.log
[14:38:56.853] <TB3> INFO: *** Welcome to pxar ***
[14:38:56.853] <TB3> INFO: *** Today: 2016/09/19
[14:38:56.918] <TB3> INFO: *** Version: f5d3-dirty
[14:38:56.918] <TB3> INFO: readRocDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[14:38:56.919] <TB3> INFO: readTbmDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[14:38:56.919] <TB3> INFO: readMaskFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[14:38:56.919] <TB3> INFO: readTrimFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[14:38:56.991] <TB3> INFO: clk: 4
[14:38:56.991] <TB3> INFO: ctr: 4
[14:38:56.991] <TB3> INFO: sda: 19
[14:38:56.991] <TB3> INFO: tin: 9
[14:38:56.991] <TB3> INFO: level: 15
[14:38:56.991] <TB3> INFO: triggerdelay: 0
[14:38:56.991] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[14:38:56.991] <TB3> INFO: Log level: INFO
[14:38:57.005] <TB3> INFO: Found DTB DTB_WWV6Z5
[14:38:57.013] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[14:38:57.015] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[14:38:57.017] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[14:38:58.558] <TB3> INFO: DUT info:
[14:38:58.558] <TB3> INFO: The DUT currently contains the following objects:
[14:38:58.558] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[14:38:58.558] <TB3> INFO: TBM Core alpha (0): 7 registers set
[14:38:58.558] <TB3> INFO: TBM Core beta (1): 7 registers set
[14:38:58.558] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:38:58.558] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:58.558] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:58.558] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:58.558] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:58.558] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:58.559] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:58.559] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:58.559] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:58.559] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:58.559] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:58.559] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:58.559] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:58.559] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:58.559] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:58.559] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:58.559] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:58.960] <TB3> INFO: enter 'restricted' command line mode
[14:38:58.960] <TB3> INFO: enter test to run
[14:38:58.960] <TB3> INFO: test: HighRate no parameter change
[14:38:58.960] <TB3> INFO: running: highrate
[14:38:58.960] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[14:38:59.104] <TB3> INFO: ----------------------------------------------------------------------
[14:38:59.104] <TB3> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[14:38:59.104] <TB3> INFO: ----------------------------------------------------------------------
[14:38:59.200] <TB3> INFO: Expecting 768 events.
[14:39:00.192] <TB3> INFO: 768 events read in total (432ms).
[14:39:00.256] <TB3> INFO: Test took 1146ms.
[14:39:00.748] <TB3> INFO: Expecting 41600 events.
[14:39:04.229] <TB3> INFO: 41600 events read in total (3079ms).
[14:39:04.231] <TB3> INFO: Test took 3970ms.
[14:39:04.812] <TB3> INFO: Expecting 41600 events.
[14:39:08.419] <TB3> INFO: 41600 events read in total (3204ms).
[14:39:08.421] <TB3> INFO: Test took 4100ms.
[14:39:09.000] <TB3> INFO: Expecting 41600 events.
[14:39:12.694] <TB3> INFO: 41600 events read in total (3291ms).
[14:39:12.696] <TB3> INFO: Test took 4181ms.
[14:39:13.289] <TB3> INFO: Expecting 41600 events.
[14:39:16.967] <TB3> INFO: 41600 events read in total (3275ms).
[14:39:16.969] <TB3> INFO: Test took 4178ms.
[14:39:17.541] <TB3> INFO: Expecting 41600 events.
[14:39:21.224] <TB3> INFO: 41600 events read in total (3281ms).
[14:39:21.225] <TB3> INFO: Test took 4166ms.
[14:39:21.798] <TB3> INFO: Expecting 41600 events.
[14:39:25.410] <TB3> INFO: 41600 events read in total (3209ms).
[14:39:25.411] <TB3> INFO: Test took 4095ms.
[14:39:25.984] <TB3> INFO: Expecting 41600 events.
[14:39:29.714] <TB3> INFO: 41600 events read in total (3328ms).
[14:39:29.715] <TB3> INFO: Test took 4213ms.
[14:39:30.289] <TB3> INFO: Expecting 41600 events.
[14:39:33.991] <TB3> INFO: 41600 events read in total (3300ms).
[14:39:33.992] <TB3> INFO: Test took 4185ms.
[14:39:34.566] <TB3> INFO: Expecting 41600 events.
[14:39:38.198] <TB3> INFO: 41600 events read in total (3230ms).
[14:39:38.201] <TB3> INFO: Test took 4117ms.
[14:39:38.775] <TB3> INFO: Expecting 41600 events.
[14:39:42.371] <TB3> INFO: 41600 events read in total (3193ms).
[14:39:42.373] <TB3> INFO: Test took 4079ms.
[14:39:42.946] <TB3> INFO: Expecting 41600 events.
[14:39:46.640] <TB3> INFO: 41600 events read in total (3292ms).
[14:39:46.641] <TB3> INFO: Test took 4177ms.
[14:39:47.232] <TB3> INFO: Expecting 41600 events.
[14:39:50.917] <TB3> INFO: 41600 events read in total (3283ms).
[14:39:50.919] <TB3> INFO: Test took 4179ms.
[14:39:51.533] <TB3> INFO: Expecting 41600 events.
[14:39:55.252] <TB3> INFO: 41600 events read in total (3317ms).
[14:39:55.253] <TB3> INFO: Test took 4228ms.
[14:39:55.836] <TB3> INFO: Expecting 41600 events.
[14:39:59.496] <TB3> INFO: 41600 events read in total (3258ms).
[14:39:59.498] <TB3> INFO: Test took 4151ms.
[14:40:00.071] <TB3> INFO: Expecting 41600 events.
[14:40:03.863] <TB3> INFO: 41600 events read in total (3390ms).
[14:40:03.864] <TB3> INFO: Test took 4275ms.
[14:40:04.437] <TB3> INFO: Expecting 41600 events.
[14:40:08.046] <TB3> INFO: 41600 events read in total (3206ms).
[14:40:08.047] <TB3> INFO: Test took 4092ms.
[14:40:08.620] <TB3> INFO: Expecting 41600 events.
[14:40:12.204] <TB3> INFO: 41600 events read in total (3181ms).
[14:40:12.206] <TB3> INFO: Test took 4068ms.
[14:40:12.783] <TB3> INFO: Expecting 41600 events.
[14:40:16.341] <TB3> INFO: 41600 events read in total (3155ms).
[14:40:16.343] <TB3> INFO: Test took 4041ms.
[14:40:16.934] <TB3> INFO: Expecting 41600 events.
[14:40:20.475] <TB3> INFO: 41600 events read in total (3138ms).
[14:40:20.476] <TB3> INFO: Test took 4035ms.
[14:40:21.044] <TB3> INFO: Expecting 41600 events.
[14:40:24.436] <TB3> INFO: 41600 events read in total (2990ms).
[14:40:24.438] <TB3> INFO: Test took 3871ms.
[14:40:24.782] <TB3> INFO: enter test to run
[14:40:24.782] <TB3> INFO: test: Pretest no parameter change
[14:40:24.782] <TB3> INFO: running: pretest
[14:40:24.782] <TB3> INFO: write dac parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[14:40:24.783] <TB3> INFO: write dac parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[14:40:24.783] <TB3> INFO: write dac parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[14:40:24.783] <TB3> INFO: write dac parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[14:40:24.783] <TB3> INFO: write dac parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[14:40:24.783] <TB3> INFO: write dac parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[14:40:24.783] <TB3> INFO: write dac parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[14:40:24.783] <TB3> INFO: write dac parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[14:40:24.783] <TB3> INFO: write dac parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[14:40:24.783] <TB3> INFO: write dac parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[14:40:24.783] <TB3> INFO: write dac parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[14:40:24.783] <TB3> INFO: write dac parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[14:40:24.784] <TB3> INFO: write dac parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[14:40:24.784] <TB3> INFO: write dac parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[14:40:24.784] <TB3> INFO: write dac parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[14:40:24.784] <TB3> INFO: write dac parameters into /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[14:40:24.784] <TB3> INFO: enter test to run
[14:40:24.784] <TB3> INFO: test: no parameter change
[14:40:25.038] <TB3> QUIET: Connection to board 121 closed.
[14:40:25.118] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[14:41:14.090] <TB3> INFO: *** Welcome to pxar ***
[14:41:14.090] <TB3> INFO: *** Today: 2016/09/19
[14:41:14.153] <TB3> INFO: *** Version: f5d3-dirty
[14:41:14.153] <TB3> INFO: readRocDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//012_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//012_HREfficiency_50//dacParameters35_C15.dat
[14:41:14.154] <TB3> INFO: readTbmDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//012_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//012_HREfficiency_50//tbmParameters_C0b.dat
[14:41:14.154] <TB3> INFO: readMaskFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//012_HREfficiency_50//defaultMaskFile.dat
[14:41:14.154] <TB3> INFO: readTrimFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//012_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//012_HREfficiency_50//trimParameters35_C15.dat
[14:41:14.222] <TB3> INFO: clk: 4
[14:41:14.222] <TB3> INFO: ctr: 4
[14:41:14.222] <TB3> INFO: sda: 19
[14:41:14.222] <TB3> INFO: tin: 9
[14:41:14.222] <TB3> INFO: level: 15
[14:41:14.222] <TB3> INFO: triggerdelay: 0
[14:41:14.223] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[14:41:14.223] <TB3> INFO: Log level: INFO
[14:41:14.236] <TB3> INFO: Found DTB DTB_WWV6Z5
[14:41:14.244] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[14:41:14.246] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[14:41:14.248] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[14:41:15.793] <TB3> INFO: DUT info:
[14:41:15.793] <TB3> INFO: The DUT currently contains the following objects:
[14:41:15.793] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[14:41:15.793] <TB3> INFO: TBM Core alpha (0): 7 registers set
[14:41:15.793] <TB3> INFO: TBM Core beta (1): 7 registers set
[14:41:15.793] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:41:15.793] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:41:15.793] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:41:15.793] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:41:15.793] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:41:15.793] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:41:15.793] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:41:15.793] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:41:15.793] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:41:15.793] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:41:15.793] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:41:15.793] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:41:15.793] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:41:15.793] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:41:15.793] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:41:15.793] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:41:15.793] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:41:16.194] <TB3> INFO: enter 'restricted' command line mode
[14:41:16.194] <TB3> INFO: enter test to run
[14:41:16.194] <TB3> INFO: test: PixelAlive no parameter change
[14:41:16.194] <TB3> INFO: running: pixelalive
[14:41:16.199] <TB3> INFO: ######################################################################
[14:41:16.199] <TB3> INFO: PixTestAlive::doTest()
[14:41:16.199] <TB3> INFO: ######################################################################
[14:41:16.200] <TB3> INFO: ----------------------------------------------------------------------
[14:41:16.200] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:41:16.200] <TB3> INFO: ----------------------------------------------------------------------
[14:41:16.467] <TB3> INFO: Expecting 208000 events.
[14:41:27.712] <TB3> INFO: 208000 events read in total (10687ms).
[14:41:27.714] <TB3> INFO: Test took 11512ms.
[14:41:27.956] <TB3> INFO: PixTestAlive::aliveTest() done
[14:41:27.956] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 2 0 0 0 0 1 0 0 0 0 0
[14:41:27.958] <TB3> INFO: ----------------------------------------------------------------------
[14:41:27.958] <TB3> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:41:27.958] <TB3> INFO: ----------------------------------------------------------------------
[14:41:28.225] <TB3> INFO: Expecting 208000 events.
[14:41:35.673] <TB3> INFO: 208000 events read in total (6891ms).
[14:41:35.674] <TB3> INFO: Test took 7714ms.
[14:41:35.675] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:41:35.932] <TB3> INFO: PixTestAlive::maskTest() done
[14:41:35.932] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:41:35.934] <TB3> INFO: ----------------------------------------------------------------------
[14:41:35.934] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:41:35.934] <TB3> INFO: ----------------------------------------------------------------------
[14:41:36.202] <TB3> INFO: Expecting 208000 events.
[14:41:47.482] <TB3> INFO: 208000 events read in total (10724ms).
[14:41:47.482] <TB3> INFO: Test took 11546ms.
[14:41:47.697] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[14:41:47.697] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:41:47.697] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[14:41:47.729] <TB3> INFO: enter test to run
[14:41:47.729] <TB3> INFO: test: delay setting parameters: ->2<-
[14:41:47.729] <TB3> INFO: delay test by 2 seconds...
[14:41:49.730] <TB3> INFO: enter test to run
[14:41:49.730] <TB3> INFO: test: HighRate no parameter change
[14:41:49.730] <TB3> INFO: running: highrate
[14:41:49.730] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//012_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//012_HREfficiency_50//phCalibrationFitErr35_C15.dat
[14:41:49.968] <TB3> INFO: ----------------------------------------------------------------------
[14:41:49.968] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:41:49.968] <TB3> INFO: ----------------------------------------------------------------------
[14:41:50.480] <TB3> INFO: Expecting 208000 events.
[14:42:05.063] <TB3> INFO: 208000 events read in total (14181ms).
[14:42:05.068] <TB3> INFO: Test took 15096ms.
[14:42:05.526] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 2 0 0 0 0 1 0 0 0 0 0
[14:42:05.526] <TB3> INFO: number of red-efficiency pixels: 121 98 89 156 191 266 220 209 244 253 239 223 189 114 3396 124
[14:42:05.526] <TB3> INFO: number of X-ray hits detected: 75102 82414 65355 115614 130390 172565 150961 156114 168032 170448 164097 149940 115643 79966 89154 88277
[14:42:05.526] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[14:42:05.526] <TB3> INFO: number of Vcal hits detected: 207879 207902 207909 207841 207807 207623 207771 207788 207752 207726 207700 207767 207800 207885 204510 207875
[14:42:05.526] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 100.0 100.0 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 100.0 98.3 99.9
[14:42:05.526] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 100.0 100.0 99.9 99.9 99.8 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 98.3 99.9
[14:42:05.526] <TB3> INFO: X-ray hit rate [MHz/cm2]: 22.0 24.2 19.2 33.9 38.2 50.6 44.2 45.8 49.3 50.0 48.1 43.9 33.9 23.4 26.1 25.9
[14:42:05.526] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[14:42:05.571] <TB3> INFO: PixTest:: pg_setup set to default.
[14:42:05.579] <TB3> INFO: enter test to run
[14:42:05.579] <TB3> INFO: test: no parameter change
[14:42:05.861] <TB3> QUIET: Connection to board 121 closed.
[14:42:05.941] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[14:42:51.888] <TB3> INFO: *** Welcome to pxar ***
[14:42:51.888] <TB3> INFO: *** Today: 2016/09/19
[14:42:51.960] <TB3> INFO: *** Version: f5d3-dirty
[14:42:51.960] <TB3> INFO: readRocDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//013_HREfficiency_75//dacParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//013_HREfficiency_75//dacParameters35_C15.dat
[14:42:51.961] <TB3> INFO: readTbmDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//013_HREfficiency_75//tbmParameters_C0a.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//013_HREfficiency_75//tbmParameters_C0b.dat
[14:42:51.961] <TB3> INFO: readMaskFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//013_HREfficiency_75//defaultMaskFile.dat
[14:42:51.961] <TB3> INFO: readTrimFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//013_HREfficiency_75//trimParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//013_HREfficiency_75//trimParameters35_C15.dat
[14:42:52.037] <TB3> INFO: clk: 4
[14:42:52.037] <TB3> INFO: ctr: 4
[14:42:52.037] <TB3> INFO: sda: 19
[14:42:52.037] <TB3> INFO: tin: 9
[14:42:52.037] <TB3> INFO: level: 15
[14:42:52.037] <TB3> INFO: triggerdelay: 0
[14:42:52.037] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[14:42:52.037] <TB3> INFO: Log level: INFO
[14:42:52.051] <TB3> INFO: Found DTB DTB_WWV6Z5
[14:42:52.059] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[14:42:52.061] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[14:42:52.063] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[14:42:53.610] <TB3> INFO: DUT info:
[14:42:53.610] <TB3> INFO: The DUT currently contains the following objects:
[14:42:53.610] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[14:42:53.610] <TB3> INFO: TBM Core alpha (0): 7 registers set
[14:42:53.610] <TB3> INFO: TBM Core beta (1): 7 registers set
[14:42:53.610] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:42:53.610] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:53.610] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:53.610] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:53.610] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:53.610] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:53.610] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:53.610] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:53.610] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:53.610] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:53.610] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:53.610] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:53.610] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:53.610] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:53.610] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:53.610] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:53.610] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:54.011] <TB3> INFO: enter 'restricted' command line mode
[14:42:54.011] <TB3> INFO: enter test to run
[14:42:54.011] <TB3> INFO: test: PixelAlive no parameter change
[14:42:54.011] <TB3> INFO: running: pixelalive
[14:42:54.014] <TB3> INFO: ######################################################################
[14:42:54.014] <TB3> INFO: PixTestAlive::doTest()
[14:42:54.014] <TB3> INFO: ######################################################################
[14:42:54.016] <TB3> INFO: ----------------------------------------------------------------------
[14:42:54.016] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:42:54.016] <TB3> INFO: ----------------------------------------------------------------------
[14:42:54.306] <TB3> INFO: Expecting 208000 events.
[14:43:05.588] <TB3> INFO: 208000 events read in total (10723ms).
[14:43:05.589] <TB3> INFO: Test took 11571ms.
[14:43:05.836] <TB3> INFO: PixTestAlive::aliveTest() done
[14:43:05.836] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 2 0 0 0 0 1 0 0 0 0 0
[14:43:05.838] <TB3> INFO: ----------------------------------------------------------------------
[14:43:05.838] <TB3> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:43:05.838] <TB3> INFO: ----------------------------------------------------------------------
[14:43:06.128] <TB3> INFO: Expecting 208000 events.
[14:43:13.675] <TB3> INFO: 208000 events read in total (6990ms).
[14:43:13.676] <TB3> INFO: Test took 7836ms.
[14:43:13.676] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:43:13.935] <TB3> INFO: PixTestAlive::maskTest() done
[14:43:13.935] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:43:13.936] <TB3> INFO: ----------------------------------------------------------------------
[14:43:13.936] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:43:13.936] <TB3> INFO: ----------------------------------------------------------------------
[14:43:14.235] <TB3> INFO: Expecting 208000 events.
[14:43:25.373] <TB3> INFO: 208000 events read in total (10581ms).
[14:43:25.374] <TB3> INFO: Test took 11435ms.
[14:43:25.594] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[14:43:25.594] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:43:25.594] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[14:43:25.626] <TB3> INFO: enter test to run
[14:43:25.626] <TB3> INFO: test: delay setting parameters: ->2<-
[14:43:25.626] <TB3> INFO: delay test by 2 seconds...
[14:43:27.626] <TB3> INFO: enter test to run
[14:43:27.626] <TB3> INFO: test: HighRate no parameter change
[14:43:27.626] <TB3> INFO: running: highrate
[14:43:27.626] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//013_HREfficiency_75//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//013_HREfficiency_75//phCalibrationFitErr35_C15.dat
[14:43:27.881] <TB3> INFO: ----------------------------------------------------------------------
[14:43:27.881] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:43:27.881] <TB3> INFO: ----------------------------------------------------------------------
[14:43:28.366] <TB3> INFO: Expecting 208000 events.
[14:43:44.654] <TB3> INFO: 208000 events read in total (15885ms).
[14:43:44.660] <TB3> INFO: Test took 16774ms.
[14:43:45.247] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 2 0 0 0 0 1 0 0 0 0 0
[14:43:45.248] <TB3> INFO: number of red-efficiency pixels: 160 170 182 271 344 501 434 453 459 550 495 443 345 241 3258 220
[14:43:45.248] <TB3> INFO: number of X-ray hits detected: 110497 123268 97485 170513 192720 252099 222282 230225 246658 249340 240063 221215 172537 118653 129134 131552
[14:43:45.248] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[14:43:45.248] <TB3> INFO: number of Vcal hits detected: 207835 207824 207804 207713 207635 207360 207528 207514 207501 207386 207408 207518 207636 207746 204587 207769
[14:43:45.248] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.7 99.8 99.8 99.8 99.9 98.4 99.9
[14:43:45.248] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.9 99.8 99.7 99.8 99.8 99.8 99.7 99.7 99.8 99.8 99.9 98.4 99.9
[14:43:45.248] <TB3> INFO: X-ray hit rate [MHz/cm2]: 32.4 36.1 28.6 50.0 56.5 73.9 65.2 67.5 72.3 73.1 70.4 64.8 50.6 34.8 37.9 38.6
[14:43:45.248] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[14:43:45.292] <TB3> INFO: PixTest:: pg_setup set to default.
[14:43:45.301] <TB3> INFO: enter test to run
[14:43:45.301] <TB3> INFO: test: no parameter change
[14:43:45.596] <TB3> QUIET: Connection to board 121 closed.
[14:43:45.675] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[14:44:35.646] <TB3> INFO: *** Welcome to pxar ***
[14:44:35.646] <TB3> INFO: *** Today: 2016/09/19
[14:44:35.710] <TB3> INFO: *** Version: f5d3-dirty
[14:44:35.710] <TB3> INFO: readRocDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//014_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//014_HREfficiency_100//dacParameters35_C15.dat
[14:44:35.711] <TB3> INFO: readTbmDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//014_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//014_HREfficiency_100//tbmParameters_C0b.dat
[14:44:35.711] <TB3> INFO: readMaskFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//014_HREfficiency_100//defaultMaskFile.dat
[14:44:35.711] <TB3> INFO: readTrimFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//014_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//014_HREfficiency_100//trimParameters35_C15.dat
[14:44:35.794] <TB3> INFO: clk: 4
[14:44:35.794] <TB3> INFO: ctr: 4
[14:44:35.794] <TB3> INFO: sda: 19
[14:44:35.794] <TB3> INFO: tin: 9
[14:44:35.794] <TB3> INFO: level: 15
[14:44:35.794] <TB3> INFO: triggerdelay: 0
[14:44:35.794] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[14:44:35.794] <TB3> INFO: Log level: INFO
[14:44:35.808] <TB3> INFO: Found DTB DTB_WWV6Z5
[14:44:35.816] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[14:44:35.818] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[14:44:35.820] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[14:44:37.388] <TB3> INFO: DUT info:
[14:44:37.388] <TB3> INFO: The DUT currently contains the following objects:
[14:44:37.388] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[14:44:37.388] <TB3> INFO: TBM Core alpha (0): 7 registers set
[14:44:37.388] <TB3> INFO: TBM Core beta (1): 7 registers set
[14:44:37.388] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:44:37.388] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:37.388] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:37.388] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:37.388] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:37.388] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:37.388] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:37.388] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:37.388] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:37.388] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:37.388] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:37.388] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:37.388] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:37.388] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:37.388] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:37.388] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:37.388] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:37.789] <TB3> INFO: enter 'restricted' command line mode
[14:44:37.789] <TB3> INFO: enter test to run
[14:44:37.789] <TB3> INFO: test: PixelAlive no parameter change
[14:44:37.789] <TB3> INFO: running: pixelalive
[14:44:37.793] <TB3> INFO: ######################################################################
[14:44:37.793] <TB3> INFO: PixTestAlive::doTest()
[14:44:37.793] <TB3> INFO: ######################################################################
[14:44:37.794] <TB3> INFO: ----------------------------------------------------------------------
[14:44:37.795] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:44:37.795] <TB3> INFO: ----------------------------------------------------------------------
[14:44:38.068] <TB3> INFO: Expecting 208000 events.
[14:44:49.192] <TB3> INFO: 208000 events read in total (10564ms).
[14:44:49.194] <TB3> INFO: Test took 11397ms.
[14:44:49.434] <TB3> INFO: PixTestAlive::aliveTest() done
[14:44:49.434] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 2 0 0 0 0 1 0 0 0 0 0
[14:44:49.436] <TB3> INFO: ----------------------------------------------------------------------
[14:44:49.436] <TB3> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:44:49.436] <TB3> INFO: ----------------------------------------------------------------------
[14:44:49.698] <TB3> INFO: Expecting 208000 events.
[14:44:57.117] <TB3> INFO: 208000 events read in total (6862ms).
[14:44:57.118] <TB3> INFO: Test took 7680ms.
[14:44:57.118] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:44:57.376] <TB3> INFO: PixTestAlive::maskTest() done
[14:44:57.376] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:44:57.377] <TB3> INFO: ----------------------------------------------------------------------
[14:44:57.377] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:44:57.377] <TB3> INFO: ----------------------------------------------------------------------
[14:44:57.664] <TB3> INFO: Expecting 208000 events.
[14:45:08.743] <TB3> INFO: 208000 events read in total (10522ms).
[14:45:08.743] <TB3> INFO: Test took 11363ms.
[14:45:08.955] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[14:45:08.955] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:45:08.955] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[14:45:08.987] <TB3> INFO: enter test to run
[14:45:08.987] <TB3> INFO: test: delay setting parameters: ->2<-
[14:45:08.987] <TB3> INFO: delay test by 2 seconds...
[14:45:10.987] <TB3> INFO: enter test to run
[14:45:10.987] <TB3> INFO: test: HighRate no parameter change
[14:45:10.987] <TB3> INFO: running: highrate
[14:45:10.987] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//014_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//014_HREfficiency_100//phCalibrationFitErr35_C15.dat
[14:45:11.145] <TB3> INFO: ----------------------------------------------------------------------
[14:45:11.145] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:45:11.145] <TB3> INFO: ----------------------------------------------------------------------
[14:45:11.663] <TB3> INFO: Expecting 208000 events.
[14:45:29.881] <TB3> INFO: 208000 events read in total (17816ms).
[14:45:29.889] <TB3> INFO: Test took 18739ms.
[14:45:30.604] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 2 0 0 0 0 1 0 0 0 0 0
[14:45:30.604] <TB3> INFO: number of red-efficiency pixels: 310 263 312 432 600 955 759 822 907 1003 877 821 615 431 2882 362
[14:45:30.604] <TB3> INFO: number of X-ray hits detected: 154703 169764 136626 237296 267145 346637 305551 316405 339536 343349 330355 306514 239446 164936 178301 179741
[14:45:30.604] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[14:45:30.604] <TB3> INFO: number of Vcal hits detected: 207666 207719 207648 207536 207312 206721 207104 207035 206939 206751 206911 207014 207308 207487 204848 207607
[14:45:30.604] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.8 99.7 99.5 99.6 99.6 99.5 99.5 99.5 99.6 99.7 99.8 98.5 99.8
[14:45:30.604] <TB3> INFO: Vcal hit overall efficiency (%): 99.8 99.9 99.8 99.8 99.7 99.4 99.6 99.5 99.5 99.4 99.5 99.5 99.7 99.8 98.5 99.8
[14:45:30.604] <TB3> INFO: X-ray hit rate [MHz/cm2]: 45.3 49.8 40.0 69.6 78.3 101.6 89.6 92.7 99.5 100.6 96.8 89.8 70.2 48.3 52.3 52.7
[14:45:30.604] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[14:45:30.649] <TB3> INFO: PixTest:: pg_setup set to default.
[14:45:30.659] <TB3> INFO: enter test to run
[14:45:30.659] <TB3> INFO: test: no parameter change
[14:45:30.950] <TB3> QUIET: Connection to board 121 closed.
[14:45:30.998] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[14:46:19.303] <TB3> INFO: *** Welcome to pxar ***
[14:46:19.303] <TB3> INFO: *** Today: 2016/09/19
[14:46:19.369] <TB3> INFO: *** Version: f5d3-dirty
[14:46:19.369] <TB3> INFO: readRocDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//015_HREfficiency_125//dacParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//015_HREfficiency_125//dacParameters35_C15.dat
[14:46:19.370] <TB3> INFO: readTbmDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//015_HREfficiency_125//tbmParameters_C0a.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//015_HREfficiency_125//tbmParameters_C0b.dat
[14:46:19.370] <TB3> INFO: readMaskFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//015_HREfficiency_125//defaultMaskFile.dat
[14:46:19.370] <TB3> INFO: readTrimFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//015_HREfficiency_125//trimParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//015_HREfficiency_125//trimParameters35_C15.dat
[14:46:19.439] <TB3> INFO: clk: 4
[14:46:19.439] <TB3> INFO: ctr: 4
[14:46:19.439] <TB3> INFO: sda: 19
[14:46:19.439] <TB3> INFO: tin: 9
[14:46:19.439] <TB3> INFO: level: 15
[14:46:19.439] <TB3> INFO: triggerdelay: 0
[14:46:19.439] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[14:46:19.439] <TB3> INFO: Log level: INFO
[14:46:19.453] <TB3> INFO: Found DTB DTB_WWV6Z5
[14:46:19.461] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[14:46:19.463] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[14:46:19.465] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[14:46:21.026] <TB3> INFO: DUT info:
[14:46:21.026] <TB3> INFO: The DUT currently contains the following objects:
[14:46:21.026] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[14:46:21.026] <TB3> INFO: TBM Core alpha (0): 7 registers set
[14:46:21.026] <TB3> INFO: TBM Core beta (1): 7 registers set
[14:46:21.026] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:46:21.026] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:46:21.026] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:46:21.027] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:46:21.027] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:46:21.027] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:46:21.027] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:46:21.027] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:46:21.027] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:46:21.027] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:46:21.027] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:46:21.027] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:46:21.027] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:46:21.027] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:46:21.027] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:46:21.027] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:46:21.027] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:46:21.428] <TB3> INFO: enter 'restricted' command line mode
[14:46:21.428] <TB3> INFO: enter test to run
[14:46:21.428] <TB3> INFO: test: PixelAlive no parameter change
[14:46:21.428] <TB3> INFO: running: pixelalive
[14:46:21.433] <TB3> INFO: ######################################################################
[14:46:21.433] <TB3> INFO: PixTestAlive::doTest()
[14:46:21.433] <TB3> INFO: ######################################################################
[14:46:21.434] <TB3> INFO: ----------------------------------------------------------------------
[14:46:21.434] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:46:21.434] <TB3> INFO: ----------------------------------------------------------------------
[14:46:21.716] <TB3> INFO: Expecting 208000 events.
[14:46:32.920] <TB3> INFO: 208000 events read in total (10645ms).
[14:46:32.922] <TB3> INFO: Test took 11486ms.
[14:46:33.159] <TB3> INFO: PixTestAlive::aliveTest() done
[14:46:33.159] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 2 0 0 0 0 1 0 0 0 0 0
[14:46:33.161] <TB3> INFO: ----------------------------------------------------------------------
[14:46:33.161] <TB3> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:46:33.161] <TB3> INFO: ----------------------------------------------------------------------
[14:46:33.424] <TB3> INFO: Expecting 208000 events.
[14:46:40.877] <TB3> INFO: 208000 events read in total (6896ms).
[14:46:40.877] <TB3> INFO: Test took 7714ms.
[14:46:40.878] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:46:41.138] <TB3> INFO: PixTestAlive::maskTest() done
[14:46:41.138] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:46:41.139] <TB3> INFO: ----------------------------------------------------------------------
[14:46:41.139] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:46:41.139] <TB3> INFO: ----------------------------------------------------------------------
[14:46:41.403] <TB3> INFO: Expecting 208000 events.
[14:46:52.628] <TB3> INFO: 208000 events read in total (10668ms).
[14:46:52.628] <TB3> INFO: Test took 11487ms.
[14:46:52.843] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[14:46:52.843] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:46:52.843] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[14:46:52.875] <TB3> INFO: enter test to run
[14:46:52.875] <TB3> INFO: test: delay setting parameters: ->2<-
[14:46:52.875] <TB3> INFO: delay test by 2 seconds...
[14:46:54.875] <TB3> INFO: enter test to run
[14:46:54.875] <TB3> INFO: test: HighRate no parameter change
[14:46:54.875] <TB3> INFO: running: highrate
[14:46:54.875] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//015_HREfficiency_125//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//015_HREfficiency_125//phCalibrationFitErr35_C15.dat
[14:46:55.014] <TB3> INFO: ----------------------------------------------------------------------
[14:46:55.014] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:46:55.014] <TB3> INFO: ----------------------------------------------------------------------
[14:46:55.500] <TB3> INFO: Expecting 208000 events.
[14:47:15.269] <TB3> INFO: 208000 events read in total (19367ms).
[14:47:15.279] <TB3> INFO: Test took 20261ms.
[14:47:16.126] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 2 0 0 0 0 1 0 0 0 0 0
[14:47:16.126] <TB3> INFO: number of red-efficiency pixels: 440 401 403 744 843 1462 1145 1142 1339 1428 1415 1159 974 613 2485 546
[14:47:16.126] <TB3> INFO: number of X-ray hits detected: 188492 208318 168004 288911 323548 420856 372167 384211 413176 416461 400927 371179 293256 202715 217724 219899
[14:47:16.126] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[14:47:16.126] <TB3> INFO: number of Vcal hits detected: 207531 207578 207521 207145 206984 205904 206509 206603 206291 205949 206045 206442 206811 207183 205199 207399
[14:47:16.126] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.8 99.8 99.8 99.6 99.6 99.1 99.4 99.4 99.2 99.1 99.2 99.3 99.5 99.7 98.7 99.7
[14:47:16.126] <TB3> INFO: Vcal hit overall efficiency (%): 99.8 99.8 99.8 99.6 99.5 99.0 99.3 99.3 99.2 99.0 99.1 99.3 99.4 99.6 98.7 99.7
[14:47:16.126] <TB3> INFO: X-ray hit rate [MHz/cm2]: 55.2 61.1 49.2 84.7 94.8 123.4 109.1 112.6 121.1 122.1 117.5 108.8 86.0 59.4 63.8 64.5
[14:47:16.126] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[14:47:16.170] <TB3> INFO: PixTest:: pg_setup set to default.
[14:47:16.180] <TB3> INFO: enter test to run
[14:47:16.180] <TB3> INFO: test: no parameter change
[14:47:16.465] <TB3> QUIET: Connection to board 121 closed.
[14:47:16.545] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[14:48:04.004] <TB3> INFO: *** Welcome to pxar ***
[14:48:04.004] <TB3> INFO: *** Today: 2016/09/19
[14:48:04.071] <TB3> INFO: *** Version: f5d3-dirty
[14:48:04.071] <TB3> INFO: readRocDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//016_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//016_HREfficiency_150//dacParameters35_C15.dat
[14:48:04.072] <TB3> INFO: readTbmDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//016_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//016_HREfficiency_150//tbmParameters_C0b.dat
[14:48:04.072] <TB3> INFO: readMaskFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//016_HREfficiency_150//defaultMaskFile.dat
[14:48:04.072] <TB3> INFO: readTrimFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//016_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//016_HREfficiency_150//trimParameters35_C15.dat
[14:48:04.156] <TB3> INFO: clk: 4
[14:48:04.156] <TB3> INFO: ctr: 4
[14:48:04.156] <TB3> INFO: sda: 19
[14:48:04.156] <TB3> INFO: tin: 9
[14:48:04.156] <TB3> INFO: level: 15
[14:48:04.156] <TB3> INFO: triggerdelay: 0
[14:48:04.156] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[14:48:04.156] <TB3> INFO: Log level: INFO
[14:48:04.170] <TB3> INFO: Found DTB DTB_WWV6Z5
[14:48:04.178] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[14:48:04.180] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[14:48:04.182] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[14:48:05.727] <TB3> INFO: DUT info:
[14:48:05.727] <TB3> INFO: The DUT currently contains the following objects:
[14:48:05.727] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[14:48:05.727] <TB3> INFO: TBM Core alpha (0): 7 registers set
[14:48:05.727] <TB3> INFO: TBM Core beta (1): 7 registers set
[14:48:05.727] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:48:05.727] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:05.727] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:05.727] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:05.727] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:05.727] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:05.727] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:05.727] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:05.727] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:05.727] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:05.727] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:05.727] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:05.727] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:05.727] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:05.727] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:05.727] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:05.727] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:06.128] <TB3> INFO: enter 'restricted' command line mode
[14:48:06.128] <TB3> INFO: enter test to run
[14:48:06.128] <TB3> INFO: test: PixelAlive no parameter change
[14:48:06.128] <TB3> INFO: running: pixelalive
[14:48:06.132] <TB3> INFO: ######################################################################
[14:48:06.132] <TB3> INFO: PixTestAlive::doTest()
[14:48:06.132] <TB3> INFO: ######################################################################
[14:48:06.134] <TB3> INFO: ----------------------------------------------------------------------
[14:48:06.134] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:48:06.134] <TB3> INFO: ----------------------------------------------------------------------
[14:48:06.422] <TB3> INFO: Expecting 208000 events.
[14:48:17.706] <TB3> INFO: 208000 events read in total (10725ms).
[14:48:17.708] <TB3> INFO: Test took 11572ms.
[14:48:17.957] <TB3> INFO: PixTestAlive::aliveTest() done
[14:48:17.957] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 2 0 0 0 0 1 0 0 0 0 0
[14:48:17.959] <TB3> INFO: ----------------------------------------------------------------------
[14:48:17.959] <TB3> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:48:17.959] <TB3> INFO: ----------------------------------------------------------------------
[14:48:18.223] <TB3> INFO: Expecting 208000 events.
[14:48:25.556] <TB3> INFO: 208000 events read in total (6776ms).
[14:48:25.557] <TB3> INFO: Test took 7596ms.
[14:48:25.557] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:48:25.816] <TB3> INFO: PixTestAlive::maskTest() done
[14:48:25.816] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:48:25.818] <TB3> INFO: ----------------------------------------------------------------------
[14:48:25.818] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:48:25.818] <TB3> INFO: ----------------------------------------------------------------------
[14:48:26.112] <TB3> INFO: Expecting 208000 events.
[14:48:37.087] <TB3> INFO: 208000 events read in total (10418ms).
[14:48:37.088] <TB3> INFO: Test took 11268ms.
[14:48:37.301] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[14:48:37.301] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:48:37.301] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[14:48:37.335] <TB3> INFO: enter test to run
[14:48:37.335] <TB3> INFO: test: delay setting parameters: ->2<-
[14:48:37.335] <TB3> INFO: delay test by 2 seconds...
[14:48:39.335] <TB3> INFO: enter test to run
[14:48:39.335] <TB3> INFO: test: HighRate no parameter change
[14:48:39.335] <TB3> INFO: running: highrate
[14:48:39.335] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//016_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//016_HREfficiency_150//phCalibrationFitErr35_C15.dat
[14:48:39.503] <TB3> INFO: ----------------------------------------------------------------------
[14:48:39.503] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:48:39.503] <TB3> INFO: ----------------------------------------------------------------------
[14:48:40.019] <TB3> INFO: Expecting 208000 events.
[14:49:01.800] <TB3> INFO: 208000 events read in total (21379ms).
[14:49:01.811] <TB3> INFO: Test took 22303ms.
[14:49:02.790] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 2 0 0 0 0 1 0 0 0 0 0
[14:49:02.790] <TB3> INFO: number of red-efficiency pixels: 580 566 568 1011 1229 1980 1541 1727 1950 2007 1889 1645 1407 811 2149 758
[14:49:02.790] <TB3> INFO: number of X-ray hits detected: 225920 248217 202980 345445 386476 500219 443057 457313 492345 496625 476406 442912 350464 243976 258976 262412
[14:49:02.790] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[14:49:02.790] <TB3> INFO: number of Vcal hits detected: 207350 207382 207231 206690 206335 204749 205643 205624 205083 204617 205066 205458 206094 206728 205445 207115
[14:49:02.790] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.7 99.7 99.7 99.5 99.3 98.7 99.0 99.0 98.7 98.6 98.8 98.9 99.2 99.5 98.8 99.6
[14:49:02.790] <TB3> INFO: Vcal hit overall efficiency (%): 99.7 99.7 99.6 99.4 99.2 98.4 98.9 98.9 98.6 98.4 98.6 98.8 99.1 99.4 98.8 99.6
[14:49:02.790] <TB3> INFO: X-ray hit rate [MHz/cm2]: 66.2 72.8 59.5 101.3 113.3 146.6 129.9 134.0 144.3 145.6 139.6 129.8 102.7 71.5 75.9 76.9
[14:49:02.791] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[14:49:02.835] <TB3> INFO: PixTest:: pg_setup set to default.
[14:49:02.845] <TB3> INFO: enter test to run
[14:49:02.845] <TB3> INFO: test: no parameter change
[14:49:03.178] <TB3> QUIET: Connection to board 121 closed.
[14:49:03.258] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[14:49:50.783] <TB3> INFO: *** Welcome to pxar ***
[14:49:50.783] <TB3> INFO: *** Today: 2016/09/19
[14:49:50.849] <TB3> INFO: *** Version: f5d3-dirty
[14:49:50.849] <TB3> INFO: readRocDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//017_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//017_HREfficiency_200//dacParameters35_C15.dat
[14:49:50.850] <TB3> INFO: readTbmDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//017_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//017_HREfficiency_200//tbmParameters_C0b.dat
[14:49:50.850] <TB3> INFO: readMaskFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//017_HREfficiency_200//defaultMaskFile.dat
[14:49:50.850] <TB3> INFO: readTrimFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//017_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//017_HREfficiency_200//trimParameters35_C15.dat
[14:49:50.935] <TB3> INFO: clk: 4
[14:49:50.935] <TB3> INFO: ctr: 4
[14:49:50.935] <TB3> INFO: sda: 19
[14:49:50.935] <TB3> INFO: tin: 9
[14:49:50.935] <TB3> INFO: level: 15
[14:49:50.935] <TB3> INFO: triggerdelay: 0
[14:49:50.935] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[14:49:50.935] <TB3> INFO: Log level: INFO
[14:49:50.949] <TB3> INFO: Found DTB DTB_WWV6Z5
[14:49:50.957] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[14:49:50.959] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[14:49:50.961] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[14:49:52.509] <TB3> INFO: DUT info:
[14:49:52.509] <TB3> INFO: The DUT currently contains the following objects:
[14:49:52.509] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[14:49:52.509] <TB3> INFO: TBM Core alpha (0): 7 registers set
[14:49:52.510] <TB3> INFO: TBM Core beta (1): 7 registers set
[14:49:52.510] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:49:52.510] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:49:52.510] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:49:52.510] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:49:52.510] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:49:52.510] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:49:52.510] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:49:52.510] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:49:52.510] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:49:52.510] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:49:52.510] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:49:52.510] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:49:52.510] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:49:52.510] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:49:52.510] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:49:52.510] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:49:52.510] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:49:52.911] <TB3> INFO: enter 'restricted' command line mode
[14:49:52.911] <TB3> INFO: enter test to run
[14:49:52.911] <TB3> INFO: test: PixelAlive no parameter change
[14:49:52.911] <TB3> INFO: running: pixelalive
[14:49:52.915] <TB3> INFO: ######################################################################
[14:49:52.915] <TB3> INFO: PixTestAlive::doTest()
[14:49:52.915] <TB3> INFO: ######################################################################
[14:49:52.916] <TB3> INFO: ----------------------------------------------------------------------
[14:49:52.916] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:49:52.916] <TB3> INFO: ----------------------------------------------------------------------
[14:49:53.183] <TB3> INFO: Expecting 208000 events.
[14:50:04.263] <TB3> INFO: 208000 events read in total (10520ms).
[14:50:04.264] <TB3> INFO: Test took 11346ms.
[14:50:04.508] <TB3> INFO: PixTestAlive::aliveTest() done
[14:50:04.508] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 2 0 0 0 0 1 0 0 0 0 0
[14:50:04.509] <TB3> INFO: ----------------------------------------------------------------------
[14:50:04.509] <TB3> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:50:04.509] <TB3> INFO: ----------------------------------------------------------------------
[14:50:04.779] <TB3> INFO: Expecting 208000 events.
[14:50:12.186] <TB3> INFO: 208000 events read in total (6850ms).
[14:50:12.187] <TB3> INFO: Test took 7675ms.
[14:50:12.188] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:50:12.445] <TB3> INFO: PixTestAlive::maskTest() done
[14:50:12.445] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:50:12.446] <TB3> INFO: ----------------------------------------------------------------------
[14:50:12.446] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:50:12.446] <TB3> INFO: ----------------------------------------------------------------------
[14:50:12.729] <TB3> INFO: Expecting 208000 events.
[14:50:24.033] <TB3> INFO: 208000 events read in total (10747ms).
[14:50:24.033] <TB3> INFO: Test took 11584ms.
[14:50:24.249] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[14:50:24.249] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:50:24.249] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[14:50:24.291] <TB3> INFO: enter test to run
[14:50:24.291] <TB3> INFO: test: delay setting parameters: ->2<-
[14:50:24.291] <TB3> INFO: delay test by 2 seconds...
[14:50:26.291] <TB3> INFO: enter test to run
[14:50:26.291] <TB3> INFO: test: HighRate no parameter change
[14:50:26.292] <TB3> INFO: running: highrate
[14:50:26.292] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//017_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//017_HREfficiency_200//phCalibrationFitErr35_C15.dat
[14:50:26.461] <TB3> INFO: ----------------------------------------------------------------------
[14:50:26.461] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:50:26.461] <TB3> INFO: ----------------------------------------------------------------------
[14:50:26.963] <TB3> INFO: Expecting 208000 events.
[14:50:34.040] <TB3> WARNING: Channel 3 ROC 2: Readback start marker after 32 readouts!

[14:50:34.040] <TB3> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[14:50:34.040] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3e2 8000 4070 148 20c0 44a 262a 70d 206f 4070 89 2267 148 2084 4071 108 2649 148 206e 4071 148 2085 740 264c 85b 2261 fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e002 c000

[14:50:34.040] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3dc 80b0 4071 148 24ac 211 2460 54b 204a 4071 102 2265 148 246f 4071 148 2485 248 2625 519 2665 559 2441 4071 121 266b 152 2461 148 2488 15b 266f 41a 2062 558 224f fff 2fff fff 2fff e002 c000

[14:50:34.040] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3dd 80c0 4070 148 20ae 510 2a40 4070 148 206d 498 2864 4070 160 2a4f 4070 148 208f fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e002 c000

[14:50:34.040] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3de 8000 4070 1d 2040 c8 2448 148 20ae 294 2840 641 2660 4070 148 206a 4070 148 2082 522 2865 611 2446 655 284e 755 2a84 4070 148 208f 51a 2467 e002 c000

[14:50:34.040] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3df 8040 4072 148 20a9 2c0 2649 4c3 2869 683 2266 4072 1a 2445 4 2866 148 2080 209 266f 815 2842 4072 148 2089 705 2049 4072 22 286f 94 22a1 148 20a2 209 2669 51c 2467 fff 2fff fff 2fff e002 c000

[14:50:34.040] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3e0 80b0 4071 148 20ae 4dd 2867 4071 15c 2841 148 2080 711 2241 4071 155 244c 148 206d 155 264f 301 2040 4cb 244d 4071 148 208d 299 244a 4db 2869 fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e002 c000

[14:50:34.040] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3e1 80c0 4071 a1 2a4c 148 208e 2c8 2868 50c 2844 4071 14 224c 148 206f 4071 148 2085 4071 148 208d 444 2662 758 2a42 848 2040 845 284d 840 2a45 fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e002 c000

[14:50:48.257] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L507> Channel 3 Number of ROCs (2) != Token Chain Length (4)

[14:50:48.257] <TB3> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[14:50:48.257] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a39d 80c0 4070 810 2664 4070 61 2661 104 2a2d 718 2040 810 2685 4070 701 2461 810 2680 4070 59 2281 31b 284f fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e002 c000

[14:50:48.257] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a397 8040 4070 1b 2862 810 268f 4070 c0 2484 810 266e 4070 810 266c 4070 810 268b fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e002 c000

[14:50:48.257] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a398 80b0 4071 810 2686 4071 810 2685 4071 15a 2867 688 2648 810 2669 4061 810 26a9 fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e002 c000

[14:50:48.257] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a399 80c0 4071 319 2680 810 26a0 4071 2e0 2440 801 2a66 810 266f 4071 22 2467 810 266f 4071 810 2689 822 228d fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e002 c000

[14:50:48.257] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a39a 8000 4070 810 266f 4070 499 2a4f 810 268f 7f0 2298 a6d 2321 44f 2810 689 2849 a2f 27f8 25d 2062 691 2a65 803 266b 803 2a6f 810 26a1 fff 2fff fff 2fff fff 2fff fff 2fff e002 c000

[14:50:48.257] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a39b 8040 4070 319 2862 515 244c 6cb 2460 810 268e 4070 89 2a68 810 268f 4070 d 244c 444 242b 810 268f 4070 212 2863 61c 204b 810 268d fff 2fff e002 c000

[14:50:48.257] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a39c 80b0 4071 52 284f 450 2a40 810 2665 4071 8a 2265 810 268f 4071 5a 286a 9c 2642 159 2462 220 2262 810 268a 4071 15c 2a4f 810 26a5 fff 2fff fff 2fff fff 2fff fff 2fff e002 c000

[14:50:53.343] <TB3> INFO: 208000 events read in total (25977ms).
[14:50:53.357] <TB3> INFO: Test took 26892ms.
[14:50:54.612] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 2 0 0 0 0 1 0 0 0 0 0
[14:50:54.612] <TB3> INFO: number of red-efficiency pixels: 1074 1141 962 1803 2176 3227 2673 2862 3144 3227 3104 2792 2389 1391 1898 1447
[14:50:54.612] <TB3> INFO: number of X-ray hits detected: 309124 341314 276743 471326 526197 677593 600285 621150 666659 672561 641993 604011 478322 332864 354440 359494
[14:50:54.612] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[14:50:54.612] <TB3> INFO: number of Vcal hits detected: 206646 206582 206219 205124 204198 200049 202090 202251 201022 199493 200765 201888 203725 204962 205423 206038
[14:50:54.612] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.4 99.4 99.3 98.8 98.4 96.7 97.6 97.5 96.9 96.4 97.0 97.4 98.2 98.8 98.8 99.2
[14:50:54.612] <TB3> INFO: Vcal hit overall efficiency (%): 99.3 99.3 99.1 98.6 98.2 96.2 97.2 97.2 96.6 95.9 96.5 97.1 97.9 98.5 98.8 99.1
[14:50:54.612] <TB3> INFO: X-ray hit rate [MHz/cm2]: 90.6 100.0 81.1 138.1 154.2 198.6 175.9 182.1 195.4 197.1 188.2 177.0 140.2 97.6 103.9 105.4
[14:50:54.612] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[14:50:54.657] <TB3> INFO: PixTest:: pg_setup set to default.
[14:50:54.668] <TB3> INFO: enter test to run
[14:50:54.669] <TB3> INFO: test: no parameter change
[14:50:54.968] <TB3> QUIET: Connection to board 121 closed.
[14:50:55.048] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[14:51:43.485] <TB3> INFO: *** Welcome to pxar ***
[14:51:43.485] <TB3> INFO: *** Today: 2016/09/19
[14:51:43.552] <TB3> INFO: *** Version: f5d3-dirty
[14:51:43.552] <TB3> INFO: readRocDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//018_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//018_HREfficiency_250//dacParameters35_C15.dat
[14:51:43.553] <TB3> INFO: readTbmDacs: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//018_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//018_HREfficiency_250//tbmParameters_C0b.dat
[14:51:43.553] <TB3> INFO: readMaskFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//018_HREfficiency_250//defaultMaskFile.dat
[14:51:43.553] <TB3> INFO: readTrimFile: /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//018_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//018_HREfficiency_250//trimParameters35_C15.dat
[14:51:43.649] <TB3> INFO: clk: 4
[14:51:43.649] <TB3> INFO: ctr: 4
[14:51:43.649] <TB3> INFO: sda: 19
[14:51:43.649] <TB3> INFO: tin: 9
[14:51:43.649] <TB3> INFO: level: 15
[14:51:43.649] <TB3> INFO: triggerdelay: 0
[14:51:43.649] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[14:51:43.649] <TB3> INFO: Log level: INFO
[14:51:43.662] <TB3> INFO: Found DTB DTB_WWV6Z5
[14:51:43.670] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[14:51:43.672] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[14:51:43.674] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[14:51:45.236] <TB3> INFO: DUT info:
[14:51:45.236] <TB3> INFO: The DUT currently contains the following objects:
[14:51:45.236] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[14:51:45.236] <TB3> INFO: TBM Core alpha (0): 7 registers set
[14:51:45.236] <TB3> INFO: TBM Core beta (1): 7 registers set
[14:51:45.236] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:51:45.236] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:51:45.236] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:51:45.236] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:51:45.236] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:51:45.236] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:51:45.236] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:51:45.236] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:51:45.236] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:51:45.236] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:51:45.236] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:51:45.236] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:51:45.236] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:51:45.236] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:51:45.236] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:51:45.236] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:51:45.236] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:51:45.637] <TB3> INFO: enter 'restricted' command line mode
[14:51:45.637] <TB3> INFO: enter test to run
[14:51:45.637] <TB3> INFO: test: PixelAlive no parameter change
[14:51:45.637] <TB3> INFO: running: pixelalive
[14:51:45.643] <TB3> INFO: ######################################################################
[14:51:45.643] <TB3> INFO: PixTestAlive::doTest()
[14:51:45.643] <TB3> INFO: ######################################################################
[14:51:45.644] <TB3> INFO: ----------------------------------------------------------------------
[14:51:45.644] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:51:45.644] <TB3> INFO: ----------------------------------------------------------------------
[14:51:45.924] <TB3> INFO: Expecting 208000 events.
[14:51:57.456] <TB3> INFO: 208000 events read in total (10973ms).
[14:51:57.458] <TB3> INFO: Test took 11811ms.
[14:51:57.696] <TB3> INFO: PixTestAlive::aliveTest() done
[14:51:57.696] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 2 0 0 0 0 1 0 0 0 0 0
[14:51:57.698] <TB3> INFO: ----------------------------------------------------------------------
[14:51:57.698] <TB3> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:51:57.698] <TB3> INFO: ----------------------------------------------------------------------
[14:51:57.967] <TB3> INFO: Expecting 208000 events.
[14:52:05.325] <TB3> INFO: 208000 events read in total (6801ms).
[14:52:05.325] <TB3> INFO: Test took 7625ms.
[14:52:05.326] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:52:05.584] <TB3> INFO: PixTestAlive::maskTest() done
[14:52:05.584] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:52:05.585] <TB3> INFO: ----------------------------------------------------------------------
[14:52:05.585] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:52:05.585] <TB3> INFO: ----------------------------------------------------------------------
[14:52:05.867] <TB3> INFO: Expecting 208000 events.
[14:52:17.637] <TB3> INFO: 208000 events read in total (11213ms).
[14:52:17.638] <TB3> INFO: Test took 12050ms.
[14:52:17.857] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[14:52:17.857] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:52:17.857] <TB3> INFO: PixTestAlive::doTest() done, duration: 32 seconds
[14:52:17.907] <TB3> INFO: enter test to run
[14:52:17.908] <TB3> INFO: test: delay setting parameters: ->2<-
[14:52:17.908] <TB3> INFO: delay test by 2 seconds...
[14:52:19.908] <TB3> INFO: enter test to run
[14:52:19.908] <TB3> INFO: test: HighRate no parameter change
[14:52:19.908] <TB3> INFO: running: highrate
[14:52:19.908] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//018_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2318_XrayQualification_2016-09-19_15h21m_1474291317//018_HREfficiency_250//phCalibrationFitErr35_C15.dat
[14:52:20.112] <TB3> INFO: ----------------------------------------------------------------------
[14:52:20.112] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:52:20.112] <TB3> INFO: ----------------------------------------------------------------------
[14:52:20.618] <TB3> INFO: Expecting 208000 events.
[14:52:23.987] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L507> Channel 3 Number of ROCs (2) != Token Chain Length (4)

[14:52:23.987] <TB3> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[14:52:23.987] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3ec 80b0 4071 20 2488 522 204d 4071 20 24a2 8 2869 2 266c 14b 284b 4071 20 248d 302 2a4a 400 2441 540 2a2f 4071 20 24a4 1b 288f 145 2665 413 264f 481 2661 fff 2fff fff 2fff e002 c000

[14:52:23.987] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3e6 8000 4070 20 24a4 12 284d 74b 2428 862 284d 844 2447 844 2a60 4070 20 24a1 2 2047 45d 2647 4070 20 24a6 68a 244d 4070 20 24af 49a 2089 484 264f 6d2 2a47 fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e002 c000

[14:52:23.987] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3e7 8040 4070 6c3 262c 4070 4070 20 24a9 143 2264 21c 206d 4070 20 2489 102 2449 322 2a65 75c 2642 815 2443 fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e002 c000

[14:52:23.987] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3e8 80b0 4061 319 2686 762 2041 4071 20 24a5 862 2a6a 4071 20 248e 4061 20 24a9 fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e002 c000

[14:52:23.987] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3e9 80c0 4061 20 2486 155 288d 354 2869 70b 244f 4061 20 2484 651 2064 81b 2044 84d 226e 859 2264 7f0 2020 48f 2302 243 2502 66a 2860 64f 27f9 20 248f 49b 206f 859 2249 862 2a67 fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e002 c000

[14:52:23.987] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3ea 8000 4070 20 2488 9c 2042 495 286f 4070 20 2485 c2 2a6c c4 2665 c5 2288 cc 2a69 e0 2a4e 203 2a69 51a 204f 61d 2a62 65d 284d 4060 20 248c 4070 20 248f 159 2847 218 2262 520 264b e002 c000

[14:52:23.987] <TB3> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3eb 8040 4070 20 2488 2db 288d 4d8 2847 553 2662 850 2443 4070 20 248d 4060 20 24a1 60d 2240 740 2449 4070 20 24a9 2d1 2667 555 2849 fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e002 c000

[14:52:51.738] <TB3> INFO: 208000 events read in total (30718ms).
[14:52:51.755] <TB3> INFO: Test took 31639ms.
[14:52:53.274] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 2 0 0 0 0 1 0 0 0 0 0
[14:52:53.274] <TB3> INFO: number of red-efficiency pixels: 1611 1672 1392 2611 3008 3872 3472 3670 3849 3829 3778 3596 3232 1712 2237 2146
[14:52:53.274] <TB3> INFO: number of X-ray hits detected: 383709 423015 344314 583554 650811 833640 740014 765878 820836 832149 792016 743100 589567 411271 439858 445036
[14:52:53.274] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[14:52:53.274] <TB3> INFO: number of Vcal hits detected: 205650 205670 204869 202512 200676 193224 196912 197136 194744 192814 195073 196463 200029 202731 204511 204240
[14:52:53.274] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.0 99.0 98.8 97.7 96.9 93.7 95.3 95.2 94.1 93.5 94.5 95.1 96.6 97.9 98.4 98.4
[14:52:53.274] <TB3> INFO: Vcal hit overall efficiency (%): 98.9 98.9 98.5 97.4 96.5 92.9 94.7 94.8 93.6 92.7 93.8 94.5 96.2 97.5 98.3 98.2
[14:52:53.274] <TB3> INFO: X-ray hit rate [MHz/cm2]: 112.5 124.0 100.9 171.0 190.8 244.3 216.9 224.5 240.6 243.9 232.1 217.8 172.8 120.5 128.9 130.4
[14:52:53.274] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[14:52:53.318] <TB3> INFO: PixTest:: pg_setup set to default.
[14:52:53.330] <TB3> INFO: enter test to run
[14:52:53.330] <TB3> INFO: test: no parameter change
[14:52:53.647] <TB3> QUIET: Connection to board 121 closed.
[14:52:53.727] <TB3> INFO: pXar: this is the end, my friend
MoReWeb-v1.0.2-10-gbc52a17 on branch psi46master