[08:59:30.466] <TB3> INFO: *** Welcome to pxar ***
[08:59:30.466] <TB3> INFO: *** Today: 2016/02/24
[08:59:30.531] <TB3> INFO: *** Version: 9751
[08:59:30.531] <TB3> INFO: readRocDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//000_PixelAlive_p17//dacParameters35_C15.dat
[08:59:30.531] <TB3> INFO: readTbmDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//000_PixelAlive_p17//tbmParameters_C0b.dat
[08:59:30.531] <TB3> INFO: readMaskFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//000_PixelAlive_p17//defaultMaskFile.dat
[08:59:30.531] <TB3> INFO: readTrimFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//000_PixelAlive_p17//trimParameters35_C15.dat
[08:59:30.601] <TB3> INFO: clk: 4
[08:59:30.601] <TB3> INFO: ctr: 4
[08:59:30.601] <TB3> INFO: sda: 19
[08:59:30.601] <TB3> INFO: tin: 9
[08:59:30.601] <TB3> INFO: level: 15
[08:59:30.601] <TB3> INFO: triggerdelay: 0
[08:59:30.601] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[08:59:30.601] <TB3> INFO: Log level: INFO
[08:59:30.614] <TB3> INFO: Found DTB DTB_WWV6Z5
[08:59:30.626] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[08:59:30.628] <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:
------------------------------------------------------
[08:59:30.629] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[08:59:32.164] <TB3> INFO: DUT info:
[08:59:32.164] <TB3> INFO: The DUT currently contains the following objects:
[08:59:32.164] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[08:59:32.164] <TB3> INFO: TBM Core alpha (0): 7 registers set
[08:59:32.164] <TB3> INFO: TBM Core beta (1): 7 registers set
[08:59:32.164] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:59:32.164] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:32.164] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:32.164] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:32.164] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:32.165] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:32.165] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:32.165] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:32.165] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:32.165] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:32.165] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:32.165] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:32.165] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:32.165] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:32.165] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:32.165] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:32.165] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:59:32.565] <TB3> INFO: enter 'restricted' command line mode
[08:59:32.565] <TB3> INFO: enter test to run
[08:59:32.565] <TB3> INFO: test: PixelAlive no parameter change
[08:59:32.566] <TB3> INFO: running: pixelalive
[08:59:32.569] <TB3> INFO: ######################################################################
[08:59:32.569] <TB3> INFO: PixTestAlive::doTest()
[08:59:32.569] <TB3> INFO: ######################################################################
[08:59:32.570] <TB3> INFO: ----------------------------------------------------------------------
[08:59:32.570] <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)
[08:59:32.570] <TB3> INFO: ----------------------------------------------------------------------
[08:59:32.844] <TB3> INFO: Expecting 41600 events.
[08:59:36.538] <TB3> INFO: 41600 events read in total (3136ms).
[08:59:36.588] <TB3> INFO: Test took 4017ms.
[08:59:36.805] <TB3> INFO: PixTestAlive::aliveTest() done
[08:59:36.805] <TB3> INFO: number of dead pixels (per ROC): 1 0 0 0 2 1 0 0 0 1 0 0 0 0 0 0
[08:59:36.806] <TB3> INFO: ----------------------------------------------------------------------
[08:59:36.806] <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)
[08:59:36.806] <TB3> INFO: ----------------------------------------------------------------------
[08:59:37.063] <TB3> INFO: Expecting 41600 events.
[08:59:39.979] <TB3> INFO: 41600 events read in total (2360ms).
[08:59:39.979] <TB3> INFO: Test took 3171ms.
[08:59:39.979] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[08:59:40.222] <TB3> INFO: PixTestAlive::maskTest() done
[08:59:40.222] <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
[08:59:40.223] <TB3> INFO: ----------------------------------------------------------------------
[08:59:40.223] <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)
[08:59:40.223] <TB3> INFO: ----------------------------------------------------------------------
[08:59:40.480] <TB3> INFO: Expecting 41600 events.
[08:59:44.169] <TB3> INFO: 41600 events read in total (3133ms).
[08:59:44.170] <TB3> INFO: Test took 3946ms.

[08:59:44.399] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[08:59:44.399] <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
[08:59:44.399] <TB3> INFO: PixTestAlive::doTest() done, duration: 11 seconds
[08:59:44.426] <TB3> INFO: enter test to run
[08:59:44.426] <TB3> INFO: test: no parameter change
[08:59:44.659] <TB3> QUIET: Connection to board 121 closed.
[08:59:44.738] <TB3> INFO: pXar: this is the end, my friend

[09:04:51.001] <TB3> INFO: *** Welcome to pxar ***
[09:04:51.001] <TB3> INFO: *** Today: 2016/02/24
[09:04:51.064] <TB3> INFO: *** Version: 9751
[09:04:51.064] <TB3> INFO: readRocDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//dacParameters35_C15.dat
[09:04:51.065] <TB3> INFO: readTbmDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[09:04:51.065] <TB3> INFO: readMaskFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//defaultMaskFile.dat
[09:04:51.065] <TB3> INFO: readTrimFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C15.dat
[09:04:51.141] <TB3> INFO: clk: 4
[09:04:51.141] <TB3> INFO: ctr: 4
[09:04:51.141] <TB3> INFO: sda: 19
[09:04:51.141] <TB3> INFO: tin: 9
[09:04:51.141] <TB3> INFO: level: 15
[09:04:51.141] <TB3> INFO: triggerdelay: 0
[09:04:51.141] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[09:04:51.141] <TB3> INFO: Log level: INFO
[09:04:51.154] <TB3> INFO: Found DTB DTB_WWV6Z5
[09:04:51.165] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[09:04:51.167] <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:
------------------------------------------------------
[09:04:51.169] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[09:04:52.729] <TB3> INFO: DUT info:
[09:04:52.729] <TB3> INFO: The DUT currently contains the following objects:
[09:04:52.729] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[09:04:52.729] <TB3> INFO: TBM Core alpha (0): 7 registers set
[09:04:52.729] <TB3> INFO: TBM Core beta (1): 7 registers set
[09:04:52.729] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:04:52.729] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.729] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:53.130] <TB3> INFO: enter 'restricted' command line mode
[09:04:53.130] <TB3> INFO: enter test to run
[09:04:53.130] <TB3> INFO: test: delay setting parameters: ->5<-
[09:04:53.130] <TB3> INFO: delay test by 5 seconds...
[09:04:58.130] <TB3> INFO: enter test to run
[09:04:58.130] <TB3> INFO: test: highrate no parameter change
[09:04:58.131] <TB3> INFO: running: highrate
[09:04:58.131] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[09:04:58.287] <TB3> INFO: ----------------------------------------------------------------------
[09:04:58.287] <TB3> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[09:04:58.287] <TB3> INFO: ----------------------------------------------------------------------
[09:04:58.287] <TB3> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[09:04:58.287] <TB3> INFO: edge/corner pixel THR is adjusted
[09:04:58.287] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[09:04:59.004] <TB3> INFO: Collecting data for 1 seconds...
[09:05:00.019] <TB3> INFO: Done with hot pixel readout
[09:05:06.518] <TB3> INFO: PixTest:: pg_setup set to default.
[09:05:06.519] <TB3> INFO: 2 hot pixels found in step 0
[09:05:07.242] <TB3> INFO: Collecting data for 1 seconds...
[09:05:08.244] <TB3> INFO: Done with hot pixel readout
[09:05:14.550] <TB3> INFO: PixTest:: pg_setup set to default.
[09:05:14.551] <TB3> INFO: 2 hot pixels found in step 1
[09:05:15.271] <TB3> INFO: Collecting data for 1 seconds...
[09:05:16.273] <TB3> INFO: Done with hot pixel readout
[09:05:22.382] <TB3> INFO: PixTest:: pg_setup set to default.
[09:05:22.383] <TB3> INFO: 2 hot pixels found in step 2
[09:05:23.102] <TB3> INFO: Collecting data for 1 seconds...
[09:05:24.103] <TB3> INFO: Done with hot pixel readout
[09:05:30.185] <TB3> INFO: PixTest:: pg_setup set to default.
[09:05:30.185] <TB3> INFO: 0 hot pixels found in step 3
[09:05:30.192] <TB3> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[09:05:30.218] <TB3> INFO: PixTest::trimHotPixels() done
[09:05:30.219] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C0.dat
[09:05:30.225] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C1.dat
[09:05:30.231] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C2.dat
[09:05:30.238] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C3.dat
[09:05:30.244] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C4.dat
[09:05:30.250] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C5.dat
[09:05:30.256] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C6.dat
[09:05:30.263] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C7.dat
[09:05:30.269] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C8.dat
[09:05:30.275] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C9.dat
[09:05:30.281] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C10.dat
[09:05:30.288] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C11.dat
[09:05:30.294] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C12.dat
[09:05:30.300] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C13.dat
[09:05:30.307] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C14.dat
[09:05:30.313] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C15.dat
[09:05:30.319] <TB3> INFO: write masked pixels into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//defaultMaskFile.dat
[09:05:30.352] <TB3> INFO: enter test to run
[09:05:30.352] <TB3> INFO: test: no parameter change
[09:05:30.573] <TB3> QUIET: Connection to board 121 closed.
[09:05:30.652] <TB3> INFO: pXar: this is the end, my friend

[09:04:51.001] <TB3> INFO: *** Welcome to pxar ***
[09:04:51.001] <TB3> INFO: *** Today: 2016/02/24
[09:04:51.064] <TB3> INFO: *** Version: 9751
[09:04:51.064] <TB3> INFO: readRocDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//dacParameters35_C15.dat
[09:04:51.065] <TB3> INFO: readTbmDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[09:04:51.065] <TB3> INFO: readMaskFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//defaultMaskFile.dat
[09:04:51.065] <TB3> INFO: readTrimFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C15.dat
[09:04:51.141] <TB3> INFO: clk: 4
[09:04:51.141] <TB3> INFO: ctr: 4
[09:04:51.141] <TB3> INFO: sda: 19
[09:04:51.141] <TB3> INFO: tin: 9
[09:04:51.141] <TB3> INFO: level: 15
[09:04:51.141] <TB3> INFO: triggerdelay: 0
[09:04:51.141] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[09:04:51.141] <TB3> INFO: Log level: INFO
[09:04:51.154] <TB3> INFO: Found DTB DTB_WWV6Z5
[09:04:51.165] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[09:04:51.167] <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:
------------------------------------------------------
[09:04:51.169] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[09:04:52.729] <TB3> INFO: DUT info:
[09:04:52.729] <TB3> INFO: The DUT currently contains the following objects:
[09:04:52.729] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[09:04:52.729] <TB3> INFO: TBM Core alpha (0): 7 registers set
[09:04:52.729] <TB3> INFO: TBM Core beta (1): 7 registers set
[09:04:52.729] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:04:52.729] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.729] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:52.730] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:53.130] <TB3> INFO: enter 'restricted' command line mode
[09:04:53.130] <TB3> INFO: enter test to run
[09:04:53.130] <TB3> INFO: test: delay setting parameters: ->5<-
[09:04:53.130] <TB3> INFO: delay test by 5 seconds...
[09:04:58.130] <TB3> INFO: enter test to run
[09:04:58.130] <TB3> INFO: test: highrate no parameter change
[09:04:58.131] <TB3> INFO: running: highrate
[09:04:58.131] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[09:04:58.287] <TB3> INFO: ----------------------------------------------------------------------
[09:04:58.287] <TB3> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[09:04:58.287] <TB3> INFO: ----------------------------------------------------------------------
[09:04:58.287] <TB3> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[09:04:58.287] <TB3> INFO: edge/corner pixel THR is adjusted
[09:04:58.287] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[09:04:59.004] <TB3> INFO: Collecting data for 1 seconds...
[09:05:00.019] <TB3> INFO: Done with hot pixel readout
[09:05:06.518] <TB3> INFO: PixTest:: pg_setup set to default.
[09:05:06.519] <TB3> INFO: 2 hot pixels found in step 0
[09:05:07.242] <TB3> INFO: Collecting data for 1 seconds...
[09:05:08.244] <TB3> INFO: Done with hot pixel readout
[09:05:14.550] <TB3> INFO: PixTest:: pg_setup set to default.
[09:05:14.551] <TB3> INFO: 2 hot pixels found in step 1
[09:05:15.271] <TB3> INFO: Collecting data for 1 seconds...
[09:05:16.273] <TB3> INFO: Done with hot pixel readout
[09:05:22.382] <TB3> INFO: PixTest:: pg_setup set to default.
[09:05:22.383] <TB3> INFO: 2 hot pixels found in step 2
[09:05:23.102] <TB3> INFO: Collecting data for 1 seconds...
[09:05:24.103] <TB3> INFO: Done with hot pixel readout
[09:05:30.185] <TB3> INFO: PixTest:: pg_setup set to default.
[09:05:30.185] <TB3> INFO: 0 hot pixels found in step 3
[09:05:30.192] <TB3> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[09:05:30.218] <TB3> INFO: PixTest::trimHotPixels() done
[09:05:30.219] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C0.dat
[09:05:30.225] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C1.dat
[09:05:30.231] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C2.dat
[09:05:30.238] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C3.dat
[09:05:30.244] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C4.dat
[09:05:30.250] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C5.dat
[09:05:30.256] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C6.dat
[09:05:30.263] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C7.dat
[09:05:30.269] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C8.dat
[09:05:30.275] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C9.dat
[09:05:30.281] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C10.dat
[09:05:30.288] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C11.dat
[09:05:30.294] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C12.dat
[09:05:30.300] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C13.dat
[09:05:30.307] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C14.dat
[09:05:30.313] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//trimParameters35_C15.dat
[09:05:30.319] <TB3> INFO: write masked pixels into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//002_RetrimHotPixels_150//defaultMaskFile.dat
[09:05:30.352] <TB3> INFO: enter test to run
[09:05:30.352] <TB3> INFO: test: no parameter change
[09:05:30.573] <TB3> QUIET: Connection to board 121 closed.
[09:05:30.652] <TB3> INFO: pXar: this is the end, my friend
[09:06:06.407] <TB3> INFO: *** Welcome to pxar ***
[09:06:06.407] <TB3> INFO: *** Today: 2016/02/24
[09:06:06.476] <TB3> INFO: *** Version: 9751
[09:06:06.476] <TB3> INFO: readRocDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//dacParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//dacParameters35_C15.dat
[09:06:06.476] <TB3> INFO: readTbmDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//tbmParameters_C0a.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//tbmParameters_C0b.dat
[09:06:06.476] <TB3> INFO: readMaskFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//defaultMaskFile.dat
[09:06:06.476] <TB3> INFO: readTrimFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//trimParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//trimParameters35_C15.dat
[09:06:06.557] <TB3> INFO: clk: 4
[09:06:06.557] <TB3> INFO: ctr: 4
[09:06:06.557] <TB3> INFO: sda: 19
[09:06:06.557] <TB3> INFO: tin: 9
[09:06:06.557] <TB3> INFO: level: 15
[09:06:06.557] <TB3> INFO: triggerdelay: 0
[09:06:06.557] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[09:06:06.557] <TB3> INFO: Log level: INFO
[09:06:06.569] <TB3> INFO: Found DTB DTB_WWV6Z5
[09:06:06.580] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[09:06:06.582] <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:
------------------------------------------------------
[09:06:06.584] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[09:06:08.117] <TB3> INFO: DUT info:
[09:06:08.117] <TB3> INFO: The DUT currently contains the following objects:
[09:06:08.117] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[09:06:08.117] <TB3> INFO: TBM Core alpha (0): 7 registers set
[09:06:08.117] <TB3> INFO: TBM Core beta (1): 7 registers set
[09:06:08.117] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:06:08.117] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:06:08.117] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:06:08.117] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:06:08.117] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:06:08.117] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:06:08.117] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:06:08.117] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:06:08.117] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:06:08.117] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:06:08.117] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:06:08.117] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:06:08.117] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:06:08.117] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:06:08.117] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:06:08.117] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:06:08.117] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:06:08.518] <TB3> INFO: enter 'restricted' command line mode
[09:06:08.518] <TB3> INFO: enter test to run
[09:06:08.518] <TB3> INFO: test: delay setting parameters: ->5<-
[09:06:08.518] <TB3> INFO: delay test by 5 seconds...
[09:06:13.518] <TB3> INFO: enter test to run
[09:06:13.518] <TB3> INFO: test: highrate no parameter change
[09:06:13.518] <TB3> INFO: running: highrate
[09:06:13.518] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//phCalibrationFitErr35_C15.dat
[09:06:13.653] <TB3> INFO: ----------------------------------------------------------------------
[09:06:13.653] <TB3> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[09:06:13.653] <TB3> INFO: ----------------------------------------------------------------------
[09:06:13.653] <TB3> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[09:06:13.653] <TB3> INFO: edge/corner pixel THR is adjusted
[09:06:13.653] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[09:06:14.370] <TB3> INFO: Collecting data for 1 seconds...
[09:06:15.371] <TB3> INFO: Done with hot pixel readout
[09:06:19.089] <TB3> INFO: PixTest:: pg_setup set to default.
[09:06:19.090] <TB3> INFO: 0 hot pixels found in step 0
[09:06:19.094] <TB3> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[09:06:19.129] <TB3> INFO: PixTest::trimHotPixels() done
[09:06:19.130] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//trimParameters35_C0.dat
[09:06:19.136] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//trimParameters35_C1.dat
[09:06:19.142] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//trimParameters35_C2.dat
[09:06:19.148] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//trimParameters35_C3.dat
[09:06:19.155] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//trimParameters35_C4.dat
[09:06:19.161] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//trimParameters35_C5.dat
[09:06:19.167] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//trimParameters35_C6.dat
[09:06:19.173] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//trimParameters35_C7.dat
[09:06:19.179] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//trimParameters35_C8.dat
[09:06:19.185] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//trimParameters35_C9.dat
[09:06:19.191] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//trimParameters35_C10.dat
[09:06:19.198] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//trimParameters35_C11.dat
[09:06:19.204] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//trimParameters35_C12.dat
[09:06:19.210] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//trimParameters35_C13.dat
[09:06:19.216] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//trimParameters35_C14.dat
[09:06:19.223] <TB3> INFO: write trim parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//trimParameters35_C15.dat
[09:06:19.229] <TB3> INFO: write masked pixels into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//003_RetrimHotPixels_50//defaultMaskFile.dat
[09:06:19.260] <TB3> INFO: enter test to run
[09:06:19.260] <TB3> INFO: test: no parameter change
[09:06:19.483] <TB3> QUIET: Connection to board 121 closed.
[09:06:19.563] <TB3> INFO: pXar: this is the end, my friend

[09:06:59.021] <TB3> INFO: *** Welcome to pxar ***
[09:06:59.021] <TB3> INFO: *** Today: 2016/02/24
[09:06:59.088] <TB3> INFO: *** Version: 9751
[09:06:59.088] <TB3> INFO: readRocDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//004_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//004_HRData_50//dacParameters35_C15.dat
[09:06:59.089] <TB3> INFO: readTbmDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//004_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//004_HRData_50//tbmParameters_C0b.dat
[09:06:59.089] <TB3> INFO: readMaskFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//004_HRData_50//defaultMaskFile.dat
[09:06:59.089] <TB3> INFO: readTrimFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//004_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//004_HRData_50//trimParameters35_C15.dat
[09:06:59.171] <TB3> INFO: clk: 4
[09:06:59.171] <TB3> INFO: ctr: 4
[09:06:59.171] <TB3> INFO: sda: 19
[09:06:59.171] <TB3> INFO: tin: 9
[09:06:59.171] <TB3> INFO: level: 15
[09:06:59.171] <TB3> INFO: triggerdelay: 0
[09:06:59.171] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[09:06:59.171] <TB3> INFO: Log level: INFO
[09:06:59.184] <TB3> INFO: Found DTB DTB_WWV6Z5
[09:06:59.195] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[09:06:59.197] <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:
------------------------------------------------------
[09:06:59.199] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[09:07:00.735] <TB3> INFO: DUT info:
[09:07:00.735] <TB3> INFO: The DUT currently contains the following objects:
[09:07:00.735] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[09:07:00.735] <TB3> INFO: TBM Core alpha (0): 7 registers set
[09:07:00.735] <TB3> INFO: TBM Core beta (1): 7 registers set
[09:07:00.735] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:07:00.735] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:07:00.735] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:07:00.735] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:07:00.735] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:07:00.735] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:07:00.735] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:07:00.735] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:07:00.735] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:07:00.735] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:07:00.735] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:07:00.736] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:07:00.736] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:07:00.736] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:07:00.736] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:07:00.736] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:07:00.736] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:07:01.136] <TB3> INFO: enter 'restricted' command line mode
[09:07:01.136] <TB3> INFO: enter test to run
[09:07:01.136] <TB3> INFO: test: delay setting parameters: ->5<-
[09:07:01.136] <TB3> INFO: delay test by 5 seconds...
[09:07:06.136] <TB3> INFO: enter test to run
[09:07:06.136] <TB3> INFO: test: Xray no parameter change
[09:07:06.136] <TB3> INFO: running: xray
[09:07:06.137] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//004_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//004_HRData_50//phCalibrationFitErr35_C15.dat
[09:07:06.300] <TB3> INFO: ######################################################################
[09:07:06.300] <TB3> INFO: PixTestXray::doTest()
[09:07:06.300] <TB3> INFO: ######################################################################
[09:07:06.300] <TB3> INFO: ----------------------------------------------------------------------
[09:07:06.300] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[09:07:06.300] <TB3> INFO: ----------------------------------------------------------------------
[09:07:07.026] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[09:07:13.933] <TB3> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[09:07:41.839] <TB3> INFO: Resuming triggers.
[09:07:48.752] <TB3> INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[09:08:17.201] <TB3> INFO: Resuming triggers.
[09:08:24.117] <TB3> INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[09:08:52.371] <TB3> INFO: Resuming triggers.
[09:08:59.287] <TB3> INFO: run duration 27 seconds, buffer almost full (81%), pausing triggers.
[09:09:27.805] <TB3> INFO: Resuming triggers.
[09:09:34.717] <TB3> INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[09:10:02.516] <TB3> INFO: Resuming triggers.
[09:10:09.431] <TB3> INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[09:10:37.682] <TB3> INFO: Resuming triggers.
[09:10:44.592] <TB3> INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[09:11:12.635] <TB3> INFO: Resuming triggers.
[09:11:19.548] <TB3> INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[09:11:47.612] <TB3> INFO: Resuming triggers.
[09:11:54.524] <TB3> INFO: run duration 62 seconds, buffer almost full (81%), pausing triggers.
[09:12:23.126] <TB3> INFO: Resuming triggers.
[09:12:30.040] <TB3> INFO: run duration 69 seconds, buffer almost full (81%), pausing triggers.
[09:12:58.469] <TB3> INFO: Resuming triggers.
[09:13:05.379] <TB3> INFO: run duration 75 seconds, buffer almost full (81%), pausing triggers.
[09:13:33.589] <TB3> INFO: Resuming triggers.
[09:13:40.498] <TB3> INFO: run duration 82 seconds, buffer almost full (81%), pausing triggers.
[09:14:09.286] <TB3> INFO: Resuming triggers.
[09:14:16.197] <TB3> INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[09:14:44.508] <TB3> INFO: Resuming triggers.
[09:14:51.417] <TB3> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[09:15:19.054] <TB3> INFO: Resuming triggers.
[09:15:22.380] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[09:15:35.697] <TB3> INFO: PixTest:: pg_setup set to default.
[09:15:35.698] <TB3> INFO: PixTestXray::doPhRun() done
[09:15:35.698] <TB3> INFO: PixTestXray::doTest() done
[09:15:35.876] <TB3> INFO: enter test to run
[09:15:35.876] <TB3> INFO: test: no parameter change
[09:15:36.100] <TB3> QUIET: Connection to board 121 closed.
[09:15:36.179] <TB3> INFO: pXar: this is the end, my friend

[09:16:58.628] <TB3> INFO: *** Welcome to pxar ***
[09:16:58.628] <TB3> INFO: *** Today: 2016/02/24
[09:16:58.693] <TB3> INFO: *** Version: 9751
[09:16:58.694] <TB3> INFO: readRocDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//005_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//005_HRData_150//dacParameters35_C15.dat
[09:16:58.694] <TB3> INFO: readTbmDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//005_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//005_HRData_150//tbmParameters_C0b.dat
[09:16:58.694] <TB3> INFO: readMaskFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//005_HRData_150//defaultMaskFile.dat
[09:16:58.694] <TB3> INFO: readTrimFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//005_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//005_HRData_150//trimParameters35_C15.dat
[09:16:58.779] <TB3> INFO: clk: 4
[09:16:58.779] <TB3> INFO: ctr: 4
[09:16:58.779] <TB3> INFO: sda: 19
[09:16:58.779] <TB3> INFO: tin: 9
[09:16:58.779] <TB3> INFO: level: 15
[09:16:58.779] <TB3> INFO: triggerdelay: 0
[09:16:58.779] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[09:16:58.779] <TB3> INFO: Log level: INFO
[09:16:58.792] <TB3> INFO: Found DTB DTB_WWV6Z5
[09:16:58.803] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[09:16:58.805] <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:
------------------------------------------------------
[09:16:58.807] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[09:17:00.363] <TB3> INFO: DUT info:
[09:17:00.363] <TB3> INFO: The DUT currently contains the following objects:
[09:17:00.363] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[09:17:00.363] <TB3> INFO: TBM Core alpha (0): 7 registers set
[09:17:00.363] <TB3> INFO: TBM Core beta (1): 7 registers set
[09:17:00.363] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:17:00.363] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:17:00.363] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:17:00.363] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:17:00.363] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:17:00.363] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:17:00.363] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:17:00.363] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:17:00.363] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:17:00.363] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:17:00.363] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:17:00.363] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:17:00.363] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:17:00.364] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:17:00.364] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:17:00.364] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:17:00.364] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:17:00.764] <TB3> INFO: enter 'restricted' command line mode
[09:17:00.764] <TB3> INFO: enter test to run
[09:17:00.764] <TB3> INFO: test: delay setting parameters: ->5<-
[09:17:00.764] <TB3> INFO: delay test by 5 seconds...
[09:17:05.764] <TB3> INFO: enter test to run
[09:17:05.764] <TB3> INFO: test: Xray no parameter change
[09:17:05.764] <TB3> INFO: running: xray
[09:17:05.765] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//005_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//005_HRData_150//phCalibrationFitErr35_C15.dat
[09:17:05.998] <TB3> INFO: ######################################################################
[09:17:05.998] <TB3> INFO: PixTestXray::doTest()
[09:17:05.998] <TB3> INFO: ######################################################################
[09:17:05.998] <TB3> INFO: ----------------------------------------------------------------------
[09:17:05.998] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[09:17:05.998] <TB3> INFO: ----------------------------------------------------------------------
[09:17:06.724] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[09:17:10.575] <TB3> INFO: run duration 3 seconds, buffer almost full (81%), pausing triggers.
[09:17:39.865] <TB3> INFO: Resuming triggers.
[09:17:43.728] <TB3> INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[09:18:13.029] <TB3> INFO: Resuming triggers.
[09:18:16.889] <TB3> INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[09:18:46.538] <TB3> INFO: Resuming triggers.
[09:18:50.407] <TB3> INFO: run duration 15 seconds, buffer almost full (81%), pausing triggers.
[09:19:19.841] <TB3> INFO: Resuming triggers.
[09:19:23.704] <TB3> INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[09:19:53.077] <TB3> INFO: Resuming triggers.
[09:19:56.941] <TB3> INFO: run duration 23 seconds, buffer almost full (81%), pausing triggers.
[09:20:26.573] <TB3> INFO: Resuming triggers.
[09:20:30.435] <TB3> INFO: run duration 27 seconds, buffer almost full (81%), pausing triggers.
[09:20:58.996] <TB3> INFO: Resuming triggers.
[09:21:02.857] <TB3> INFO: run duration 30 seconds, buffer almost full (81%), pausing triggers.
[09:21:32.051] <TB3> INFO: Resuming triggers.
[09:21:35.912] <TB3> INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[09:22:04.768] <TB3> INFO: Resuming triggers.
[09:22:08.629] <TB3> INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[09:22:37.401] <TB3> INFO: Resuming triggers.
[09:22:41.261] <TB3> INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[09:23:10.590] <TB3> INFO: Resuming triggers.
[09:23:14.450] <TB3> INFO: run duration 46 seconds, buffer almost full (81%), pausing triggers.
[09:23:43.022] <TB3> INFO: Resuming triggers.
[09:23:46.880] <TB3> INFO: run duration 50 seconds, buffer almost full (81%), pausing triggers.
[09:24:16.032] <TB3> INFO: Resuming triggers.
[09:24:19.888] <TB3> INFO: run duration 53 seconds, buffer almost full (81%), pausing triggers.
[09:24:48.738] <TB3> INFO: Resuming triggers.
[09:24:52.597] <TB3> INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.
[09:25:22.282] <TB3> INFO: Resuming triggers.
[09:25:26.139] <TB3> INFO: run duration 61 seconds, buffer almost full (81%), pausing triggers.
[09:25:54.976] <TB3> INFO: Resuming triggers.
[09:25:58.834] <TB3> INFO: run duration 65 seconds, buffer almost full (81%), pausing triggers.
[09:26:27.689] <TB3> INFO: Resuming triggers.
[09:26:31.547] <TB3> INFO: run duration 69 seconds, buffer almost full (81%), pausing triggers.
[09:27:00.859] <TB3> INFO: Resuming triggers.
[09:27:04.715] <TB3> INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[09:27:33.955] <TB3> INFO: Resuming triggers.
[09:27:37.808] <TB3> INFO: run duration 77 seconds, buffer almost full (81%), pausing triggers.
[09:28:07.466] <TB3> INFO: Resuming triggers.
[09:28:11.323] <TB3> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[09:28:41.141] <TB3> INFO: Resuming triggers.
[09:28:44.999] <TB3> INFO: run duration 84 seconds, buffer almost full (81%), pausing triggers.
[09:29:14.283] <TB3> INFO: Resuming triggers.
[09:29:18.139] <TB3> INFO: run duration 88 seconds, buffer almost full (81%), pausing triggers.
[09:29:47.484] <TB3> INFO: Resuming triggers.
[09:29:51.340] <TB3> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[09:30:19.686] <TB3> INFO: Resuming triggers.
[09:30:23.543] <TB3> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[09:30:51.970] <TB3> INFO: Resuming triggers.
[09:30:55.588] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[09:31:21.789] <TB3> INFO: PixTest:: pg_setup set to default.
[09:31:21.790] <TB3> INFO: PixTestXray::doPhRun() done
[09:31:21.790] <TB3> INFO: PixTestXray::doTest() done
[09:31:21.975] <TB3> INFO: enter test to run
[09:31:21.975] <TB3> INFO: test: no parameter change
[09:31:22.223] <TB3> QUIET: Connection to board 121 closed.
[09:31:22.303] <TB3> INFO: pXar: this is the end, my friend

[09:34:00.907] <TB3> INFO: *** Welcome to pxar ***
[09:34:00.907] <TB3> INFO: *** Today: 2016/02/24
[09:34:00.969] <TB3> INFO: *** Version: 9751
[09:34:00.969] <TB3> INFO: readRocDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//006_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//006_HRSCurves_100//dacParameters35_C15.dat
[09:34:00.970] <TB3> INFO: readTbmDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//006_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//006_HRSCurves_100//tbmParameters_C0b.dat
[09:34:00.970] <TB3> INFO: readMaskFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//006_HRSCurves_100//defaultMaskFile.dat
[09:34:00.970] <TB3> INFO: readTrimFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//006_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//006_HRSCurves_100//trimParameters35_C15.dat
[09:34:01.052] <TB3> INFO: clk: 4
[09:34:01.052] <TB3> INFO: ctr: 4
[09:34:01.052] <TB3> INFO: sda: 19
[09:34:01.052] <TB3> INFO: tin: 9
[09:34:01.052] <TB3> INFO: level: 15
[09:34:01.052] <TB3> INFO: triggerdelay: 0
[09:34:01.052] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[09:34:01.052] <TB3> INFO: Log level: INFO
[09:34:01.066] <TB3> INFO: Found DTB DTB_WWV6Z5
[09:34:01.077] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[09:34:01.079] <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:
------------------------------------------------------
[09:34:01.080] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[09:34:02.632] <TB3> INFO: DUT info:
[09:34:02.632] <TB3> INFO: The DUT currently contains the following objects:
[09:34:02.632] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[09:34:02.632] <TB3> INFO: TBM Core alpha (0): 7 registers set
[09:34:02.632] <TB3> INFO: TBM Core beta (1): 7 registers set
[09:34:02.632] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:34:02.632] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:02.632] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:02.632] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:02.632] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:02.632] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:02.632] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:02.632] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:02.632] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:02.632] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:02.632] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:02.632] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:02.632] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:02.632] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:02.632] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:02.632] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:02.632] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:03.033] <TB3> INFO: enter 'restricted' command line mode
[09:34:03.033] <TB3> INFO: enter test to run
[09:34:03.033] <TB3> INFO: test: Highrate no parameter change
[09:34:03.033] <TB3> INFO: running: highrate
[09:34:03.033] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//006_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//006_HRSCurves_100//phCalibrationFitErr35_C15.dat
[09:34:03.208] <TB3> INFO: ----------------------------------------------------------------------
[09:34:03.208] <TB3> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[09:34:03.208] <TB3> INFO: ----------------------------------------------------------------------
[09:34:03.213] <TB3> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 896 (plus default)
[09:34:03.242] <TB3> INFO: dacScan step from 15 .. 34
[09:34:03.243] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[09:34:03.243] <TB3> INFO: run 1 of 1
[09:34:03.745] <TB3> INFO: Expecting 4160000 events.
[09:34:37.302] <TB3> INFO: 485250 events read in total (33153ms).
[09:35:10.498] <TB3> INFO: 972100 events read in total (66349ms).
[09:35:44.240] <TB3> INFO: 1458600 events read in total (100091ms).
[09:36:17.705] <TB3> INFO: 1945300 events read in total (133556ms).
[09:36:51.218] <TB3> INFO: 2431950 events read in total (167069ms).
[09:37:24.953] <TB3> INFO: 2918500 events read in total (200804ms).
[09:37:58.277] <TB3> INFO: 3404250 events read in total (234128ms).
[09:38:31.593] <TB3> INFO: 3889900 events read in total (267444ms).
[09:38:50.171] <TB3> INFO: 4160000 events read in total (286022ms).
[09:38:50.386] <TB3> INFO: Test took 287144ms.
[09:38:56.503] <TB3> INFO: dacScan step from 35 .. 54
[09:38:56.503] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[09:38:56.503] <TB3> INFO: run 1 of 1
[09:38:57.005] <TB3> INFO: Expecting 4160000 events.
[09:39:29.279] <TB3> INFO: 397850 events read in total (31873ms).
[09:40:00.854] <TB3> INFO: 796700 events read in total (63448ms).
[09:40:32.415] <TB3> INFO: 1194550 events read in total (95009ms).
[09:41:03.724] <TB3> INFO: 1590950 events read in total (126318ms).
[09:41:35.507] <TB3> INFO: 1986250 events read in total (158101ms).
[09:42:06.659] <TB3> INFO: 2379400 events read in total (189253ms).
[09:42:38.211] <TB3> INFO: 2769800 events read in total (220805ms).
[09:43:09.530] <TB3> INFO: 3157000 events read in total (252124ms).
[09:43:41.077] <TB3> INFO: 3541350 events read in total (283671ms).
[09:44:12.927] <TB3> INFO: 3924450 events read in total (315521ms).
[09:44:32.313] <TB3> INFO: 4160000 events read in total (334907ms).
[09:44:32.506] <TB3> INFO: Test took 336003ms.
[09:44:38.528] <TB3> INFO: dacScan step from 55 .. 74
[09:44:38.528] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[09:44:38.528] <TB3> INFO: run 1 of 1
[09:44:39.009] <TB3> INFO: Expecting 4160000 events.
[09:45:10.039] <TB3> INFO: 354500 events read in total (30628ms).
[09:45:41.060] <TB3> INFO: 709800 events read in total (61649ms).
[09:46:11.674] <TB3> INFO: 1065200 events read in total (92263ms).
[09:46:42.409] <TB3> INFO: 1420650 events read in total (122998ms).
[09:47:12.998] <TB3> INFO: 1775800 events read in total (153587ms).
[09:47:43.834] <TB3> INFO: 2131100 events read in total (184423ms).
[09:48:14.255] <TB3> INFO: 2486550 events read in total (214844ms).
[09:48:45.446] <TB3> INFO: 2841550 events read in total (246035ms).
[09:49:16.040] <TB3> INFO: 3196700 events read in total (276629ms).
[09:49:46.933] <TB3> INFO: 3551950 events read in total (307522ms).
[09:50:18.071] <TB3> INFO: 3907250 events read in total (338660ms).
[09:50:39.786] <TB3> INFO: 4160000 events read in total (360375ms).
[09:50:39.951] <TB3> INFO: Test took 361422ms.
[09:50:46.569] <TB3> INFO: dacScan step from 75 .. 75
[09:50:46.569] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[09:50:46.569] <TB3> INFO: run 1 of 1
[09:50:47.069] <TB3> INFO: Expecting 208000 events.
[09:51:06.017] <TB3> INFO: 208000 events read in total (18546ms).
[09:51:06.024] <TB3> INFO: Test took 19455ms.
[09:51:06.340] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[09:51:07.515] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[09:51:08.616] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[09:51:09.640] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[09:51:10.716] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[09:51:11.756] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[09:51:12.811] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[09:51:13.855] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[09:51:14.901] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[09:51:15.956] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[09:51:17.018] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[09:51:18.082] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[09:51:19.127] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[09:51:20.167] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[09:51:21.191] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[09:51:22.224] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[09:51:23.253] <TB3> INFO: PixTest:: pg_setup set to default.
[09:51:23.255] <TB3> INFO: vcal mean: 37.63 37.51 37.14 39.85 40.93 41.56 41.21 40.99 41.63 42.06 42.70 41.20 40.26 37.98 38.21 37.83
[09:51:23.255] <TB3> INFO: vcal RMS: 1.17 1.04 0.89 1.24 1.57 1.27 1.40 1.43 1.37 1.54 1.40 1.55 1.22 1.08 1.01 0.98
[09:51:23.255] <TB3> INFO: number of X-ray hits detected: 164123 153011 136367 252915 281521 333430 322042 327995 329330 346866 381721 312237 280936 158795 170148 163632
[09:51:23.255] <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
[09:51:23.255] <TB3> INFO: X-ray hit rate [MHz/cm2]: 48.1 44.8 40.0 74.1 82.5 97.7 94.4 96.1 96.5 101.7 111.9 91.5 82.3 46.5 49.9 48.0
[09:51:23.255] <TB3> INFO: PixTestHighRate::doXNoiseMaps() done
[09:51:23.368] <TB3> INFO: enter test to run
[09:51:23.368] <TB3> INFO: test: no parameter change
[09:51:23.576] <TB3> QUIET: Connection to board 121 closed.
[09:51:23.656] <TB3> INFO: pXar: this is the end, my friend

[10:13:04.158] <TB3> INFO: *** Welcome to pxar ***
[10:13:04.158] <TB3> INFO: *** Today: 2016/02/24
[10:13:04.222] <TB3> INFO: *** Version: 9751
[10:13:04.222] <TB3> INFO: readRocDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[10:13:04.223] <TB3> INFO: readTbmDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[10:13:04.223] <TB3> INFO: readMaskFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[10:13:04.223] <TB3> INFO: readTrimFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[10:13:04.307] <TB3> INFO: clk: 4
[10:13:04.307] <TB3> INFO: ctr: 4
[10:13:04.307] <TB3> INFO: sda: 19
[10:13:04.307] <TB3> INFO: tin: 9
[10:13:04.307] <TB3> INFO: level: 15
[10:13:04.307] <TB3> INFO: triggerdelay: 0
[10:13:04.307] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[10:13:04.307] <TB3> INFO: Log level: INFO
[10:13:04.320] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:13:04.331] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:13:04.333] <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:
------------------------------------------------------
[10:13:04.335] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[10:13:05.944] <TB3> INFO: DUT info:
[10:13:05.944] <TB3> INFO: The DUT currently contains the following objects:
[10:13:05.944] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[10:13:05.944] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:13:05.944] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:13:05.944] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:13:05.944] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:13:05.944] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:13:05.944] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:13:05.944] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:13:05.944] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:13:05.944] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:13:05.944] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:13:05.944] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:13:05.944] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:13:05.944] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:13:05.944] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:13:05.944] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:13:05.944] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:13:05.944] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:13:05.944] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:13:05.944] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:13:06.345] <TB3> INFO: enter 'restricted' command line mode
[10:13:06.345] <TB3> INFO: enter test to run
[10:13:06.345] <TB3> INFO: test: HighRate no parameter change
[10:13:06.345] <TB3> INFO: running: highrate
[10:13:06.345] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[10:13:06.486] <TB3> INFO: ----------------------------------------------------------------------
[10:13:06.486] <TB3> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[10:13:06.486] <TB3> INFO: ----------------------------------------------------------------------
[10:13:06.579] <TB3> INFO: Expecting 768 events.
[10:13:07.570] <TB3> INFO: 768 events read in total (433ms).
[10:13:07.633] <TB3> INFO: Test took 1143ms.
[10:13:08.130] <TB3> INFO: Expecting 41600 events.
[10:13:11.695] <TB3> INFO: 41600 events read in total (3164ms).
[10:13:11.697] <TB3> INFO: Test took 4061ms.
[10:13:12.281] <TB3> INFO: Expecting 41600 events.
[10:13:15.866] <TB3> INFO: 41600 events read in total (3183ms).
[10:13:15.867] <TB3> INFO: Test took 4081ms.
[10:13:16.462] <TB3> INFO: Expecting 41600 events.
[10:13:20.073] <TB3> INFO: 41600 events read in total (3209ms).
[10:13:20.074] <TB3> INFO: Test took 4103ms.
[10:13:20.657] <TB3> INFO: Expecting 41600 events.
[10:13:24.328] <TB3> INFO: 41600 events read in total (3270ms).
[10:13:24.330] <TB3> INFO: Test took 4152ms.
[10:13:24.974] <TB3> INFO: Expecting 41600 events.
[10:13:28.588] <TB3> INFO: 41600 events read in total (3212ms).
[10:13:28.590] <TB3> INFO: Test took 4133ms.
[10:13:29.162] <TB3> INFO: Expecting 41600 events.
[10:13:32.802] <TB3> INFO: 41600 events read in total (3239ms).
[10:13:32.803] <TB3> INFO: Test took 4121ms.
[10:13:33.391] <TB3> INFO: Expecting 41600 events.
[10:13:36.976] <TB3> INFO: 41600 events read in total (3183ms).
[10:13:36.978] <TB3> INFO: Test took 4071ms.
[10:13:37.571] <TB3> INFO: Expecting 41600 events.
[10:13:41.230] <TB3> INFO: 41600 events read in total (3258ms).
[10:13:41.232] <TB3> INFO: Test took 4159ms.
[10:13:41.847] <TB3> INFO: Expecting 41600 events.
[10:13:45.482] <TB3> INFO: 41600 events read in total (3233ms).
[10:13:45.484] <TB3> INFO: Test took 4137ms.
[10:13:46.090] <TB3> INFO: Expecting 41600 events.
[10:13:49.704] <TB3> INFO: 41600 events read in total (3212ms).
[10:13:49.706] <TB3> INFO: Test took 4118ms.
[10:13:50.300] <TB3> INFO: Expecting 41600 events.
[10:13:53.928] <TB3> INFO: 41600 events read in total (3227ms).
[10:13:53.930] <TB3> INFO: Test took 4133ms.
[10:13:54.506] <TB3> INFO: Expecting 41600 events.
[10:13:58.101] <TB3> INFO: 41600 events read in total (3193ms).
[10:13:58.103] <TB3> INFO: Test took 4079ms.
[10:13:58.713] <TB3> INFO: Expecting 41600 events.
[10:14:02.349] <TB3> INFO: 41600 events read in total (3234ms).
[10:14:02.351] <TB3> INFO: Test took 4142ms.
[10:14:02.963] <TB3> INFO: Expecting 41600 events.
[10:14:06.520] <TB3> INFO: 41600 events read in total (3156ms).
[10:14:06.521] <TB3> INFO: Test took 4076ms.
[10:14:07.107] <TB3> INFO: Expecting 41600 events.
[10:14:10.713] <TB3> INFO: 41600 events read in total (3205ms).
[10:14:10.715] <TB3> INFO: Test took 4091ms.
[10:14:11.311] <TB3> INFO: Expecting 41600 events.
[10:14:14.997] <TB3> INFO: 41600 events read in total (3285ms).
[10:14:14.998] <TB3> INFO: Test took 4177ms.
[10:14:15.575] <TB3> INFO: Expecting 41600 events.
[10:14:19.123] <TB3> INFO: 41600 events read in total (3146ms).
[10:14:19.124] <TB3> INFO: Test took 4033ms.
[10:14:19.691] <TB3> INFO: Expecting 41600 events.
[10:14:23.244] <TB3> INFO: 41600 events read in total (3151ms).
[10:14:23.246] <TB3> INFO: Test took 4034ms.
[10:14:23.817] <TB3> INFO: Expecting 41600 events.
[10:14:27.356] <TB3> INFO: 41600 events read in total (3138ms).
[10:14:27.357] <TB3> INFO: Test took 4019ms.
[10:14:27.926] <TB3> INFO: Expecting 41600 events.
[10:14:31.272] <TB3> INFO: 41600 events read in total (2944ms).
[10:14:31.273] <TB3> INFO: Test took 3826ms.
[10:14:31.598] <TB3> INFO: enter test to run
[10:14:31.598] <TB3> INFO: test: Pretest no parameter change
[10:14:31.598] <TB3> INFO: running: pretest
[10:14:31.598] <TB3> INFO: write dac parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[10:14:31.598] <TB3> INFO: write dac parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[10:14:31.598] <TB3> INFO: write dac parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[10:14:31.598] <TB3> INFO: write dac parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[10:14:31.598] <TB3> INFO: write dac parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[10:14:31.598] <TB3> INFO: write dac parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[10:14:31.599] <TB3> INFO: write dac parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[10:14:31.599] <TB3> INFO: write dac parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[10:14:31.599] <TB3> INFO: write dac parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[10:14:31.599] <TB3> INFO: write dac parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[10:14:31.599] <TB3> INFO: write dac parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[10:14:31.599] <TB3> INFO: write dac parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[10:14:31.599] <TB3> INFO: write dac parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[10:14:31.599] <TB3> INFO: write dac parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[10:14:31.599] <TB3> INFO: write dac parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[10:14:31.599] <TB3> INFO: write dac parameters into /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[10:14:31.600] <TB3> INFO: enter test to run
[10:14:31.600] <TB3> INFO: test: no parameter change
[10:14:31.847] <TB3> QUIET: Connection to board 121 closed.
[10:14:31.927] <TB3> INFO: pXar: this is the end, my friend

[10:15:09.100] <TB3> INFO: *** Welcome to pxar ***
[10:15:09.100] <TB3> INFO: *** Today: 2016/02/24
[10:15:09.170] <TB3> INFO: *** Version: 9751
[10:15:09.170] <TB3> INFO: readRocDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//012_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//012_HREfficiency_50//dacParameters35_C15.dat
[10:15:09.171] <TB3> INFO: readTbmDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//012_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//012_HREfficiency_50//tbmParameters_C0b.dat
[10:15:09.171] <TB3> INFO: readMaskFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//012_HREfficiency_50//defaultMaskFile.dat
[10:15:09.171] <TB3> INFO: readTrimFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//012_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//012_HREfficiency_50//trimParameters35_C15.dat
[10:15:09.251] <TB3> INFO: clk: 4
[10:15:09.251] <TB3> INFO: ctr: 4
[10:15:09.251] <TB3> INFO: sda: 19
[10:15:09.251] <TB3> INFO: tin: 9
[10:15:09.251] <TB3> INFO: level: 15
[10:15:09.251] <TB3> INFO: triggerdelay: 0
[10:15:09.251] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[10:15:09.251] <TB3> INFO: Log level: INFO
[10:15:09.265] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:15:09.276] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:15:09.278] <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:
------------------------------------------------------
[10:15:09.280] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[10:15:10.828] <TB3> INFO: DUT info:
[10:15:10.828] <TB3> INFO: The DUT currently contains the following objects:
[10:15:10.828] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[10:15:10.828] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:15:10.828] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:15:10.828] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:15:10.828] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:10.828] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:10.828] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:10.828] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:10.828] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:10.828] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:10.828] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:10.828] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:10.828] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:10.828] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:10.828] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:10.828] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:10.828] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:10.828] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:10.828] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:10.828] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:11.229] <TB3> INFO: enter 'restricted' command line mode
[10:15:11.229] <TB3> INFO: enter test to run
[10:15:11.229] <TB3> INFO: test: PixelAlive no parameter change
[10:15:11.229] <TB3> INFO: running: pixelalive
[10:15:11.233] <TB3> INFO: ######################################################################
[10:15:11.233] <TB3> INFO: PixTestAlive::doTest()
[10:15:11.233] <TB3> INFO: ######################################################################
[10:15:11.234] <TB3> INFO: ----------------------------------------------------------------------
[10:15:11.234] <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)
[10:15:11.234] <TB3> INFO: ----------------------------------------------------------------------
[10:15:11.517] <TB3> INFO: Expecting 208000 events.
[10:15:22.874] <TB3> INFO: 208000 events read in total (10799ms).
[10:15:22.875] <TB3> INFO: Test took 11639ms.
[10:15:23.099] <TB3> INFO: PixTestAlive::aliveTest() done
[10:15:23.099] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 3 0 0 0 0 1 0 0 0 0 0 0
[10:15:23.100] <TB3> INFO: ----------------------------------------------------------------------
[10:15:23.100] <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)
[10:15:23.100] <TB3> INFO: ----------------------------------------------------------------------
[10:15:23.373] <TB3> INFO: Expecting 208000 events.
[10:15:30.738] <TB3> INFO: 208000 events read in total (6809ms).
[10:15:30.739] <TB3> INFO: Test took 7637ms.
[10:15:30.739] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[10:15:30.979] <TB3> INFO: PixTestAlive::maskTest() done
[10:15:30.979] <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
[10:15:30.980] <TB3> INFO: ----------------------------------------------------------------------
[10:15:30.980] <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)
[10:15:30.980] <TB3> INFO: ----------------------------------------------------------------------
[10:15:31.251] <TB3> INFO: Expecting 208000 events.
[10:15:42.506] <TB3> INFO: 208000 events read in total (10698ms).
[10:15:42.507] <TB3> INFO: Test took 11526ms.


[10:15:42.727] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[10:15:42.727] <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
[10:15:42.727] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[10:15:42.780] <TB3> INFO: enter test to run
[10:15:42.780] <TB3> INFO: test: delay setting parameters: ->2<-
[10:15:42.780] <TB3> INFO: delay test by 2 seconds...
[10:15:44.780] <TB3> INFO: enter test to run
[10:15:44.780] <TB3> INFO: test: HighRate no parameter change
[10:15:44.780] <TB3> INFO: running: highrate
[10:15:44.780] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//012_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//012_HREfficiency_50//phCalibrationFitErr35_C15.dat
[10:15:44.940] <TB3> INFO: ----------------------------------------------------------------------
[10:15:44.940] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[10:15:44.940] <TB3> INFO: ----------------------------------------------------------------------
[10:15:45.421] <TB3> INFO: Expecting 208000 events.
[10:15:59.880] <TB3> INFO: 208000 events read in total (14057ms).
[10:15:59.884] <TB3> INFO: Test took 14941ms.
[10:16:00.346] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 3 0 0 0 0 1 0 0 0 0 0 0
[10:16:00.346] <TB3> INFO: number of red-efficiency pixels: 95 92 57 203 242 241 247 226 215 254 304 181 224 114 92 87
[10:16:00.346] <TB3> INFO: number of X-ray hits detected: 80724 73871 66041 125040 140285 166757 160975 163479 163538 174253 191993 156162 139758 77988 83393 80163
[10:16:00.346] <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
[10:16:00.346] <TB3> INFO: number of Vcal hits detected: 207903 207907 207943 207785 207595 207750 207745 207772 207773 207684 207688 207811 207768 207882 207905 207911
[10:16:00.346] <TB3> INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 100.0 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 100.0 100.0 100.0
[10:16:00.346] <TB3> INFO: Vcal hit overall efficiency (%): 100.0 100.0 100.0 99.9 99.8 99.9 99.9 99.9 99.9 99.8 99.9 99.9 99.9 99.9 100.0 100.0
[10:16:00.346] <TB3> INFO: X-ray hit rate [MHz/cm2]: 23.7 21.7 19.4 36.7 41.1 48.9 47.2 47.9 47.9 51.1 56.3 45.8 41.0 22.9 24.4 23.5
[10:16:00.346] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[10:16:00.372] <TB3> INFO: PixTest:: pg_setup set to default.
[10:16:00.380] <TB3> INFO: enter test to run
[10:16:00.380] <TB3> INFO: test: no parameter change
[10:16:00.617] <TB3> QUIET: Connection to board 121 closed.
[10:16:00.697] <TB3> INFO: pXar: this is the end, my friend

[10:16:34.718] <TB3> INFO: *** Welcome to pxar ***
[10:16:34.718] <TB3> INFO: *** Today: 2016/02/24
[10:16:34.781] <TB3> INFO: *** Version: 9751
[10:16:34.781] <TB3> INFO: readRocDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//013_HREfficiency_75//dacParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//013_HREfficiency_75//dacParameters35_C15.dat
[10:16:34.782] <TB3> INFO: readTbmDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//013_HREfficiency_75//tbmParameters_C0a.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//013_HREfficiency_75//tbmParameters_C0b.dat
[10:16:34.782] <TB3> INFO: readMaskFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//013_HREfficiency_75//defaultMaskFile.dat
[10:16:34.782] <TB3> INFO: readTrimFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//013_HREfficiency_75//trimParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//013_HREfficiency_75//trimParameters35_C15.dat
[10:16:34.887] <TB3> INFO: clk: 4
[10:16:34.887] <TB3> INFO: ctr: 4
[10:16:34.887] <TB3> INFO: sda: 19
[10:16:34.887] <TB3> INFO: tin: 9
[10:16:34.887] <TB3> INFO: level: 15
[10:16:34.887] <TB3> INFO: triggerdelay: 0
[10:16:34.887] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[10:16:34.887] <TB3> INFO: Log level: INFO
[10:16:34.900] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:16:34.911] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:16:34.913] <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:
------------------------------------------------------
[10:16:34.915] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[10:16:36.457] <TB3> INFO: DUT info:
[10:16:36.457] <TB3> INFO: The DUT currently contains the following objects:
[10:16:36.457] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[10:16:36.457] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:16:36.457] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:16:36.457] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:16:36.457] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:36.457] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:36.457] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:36.457] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:36.457] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:36.457] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:36.457] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:36.457] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:36.457] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:36.457] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:36.457] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:36.457] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:36.457] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:36.457] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:36.457] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:36.457] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:36.858] <TB3> INFO: enter 'restricted' command line mode
[10:16:36.858] <TB3> INFO: enter test to run
[10:16:36.858] <TB3> INFO: test: PixelAlive no parameter change
[10:16:36.858] <TB3> INFO: running: pixelalive
[10:16:36.861] <TB3> INFO: ######################################################################
[10:16:36.861] <TB3> INFO: PixTestAlive::doTest()
[10:16:36.861] <TB3> INFO: ######################################################################
[10:16:36.863] <TB3> INFO: ----------------------------------------------------------------------
[10:16:36.863] <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)
[10:16:36.863] <TB3> INFO: ----------------------------------------------------------------------
[10:16:37.123] <TB3> INFO: Expecting 208000 events.
[10:16:48.353] <TB3> INFO: 208000 events read in total (10672ms).
[10:16:48.355] <TB3> INFO: Test took 11491ms.
[10:16:48.577] <TB3> INFO: PixTestAlive::aliveTest() done
[10:16:48.577] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 3 0 0 0 0 0 0 0 0 0 0 0
[10:16:48.578] <TB3> INFO: ----------------------------------------------------------------------
[10:16:48.578] <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)
[10:16:48.578] <TB3> INFO: ----------------------------------------------------------------------
[10:16:48.847] <TB3> INFO: Expecting 208000 events.
[10:16:56.251] <TB3> INFO: 208000 events read in total (6848ms).
[10:16:56.252] <TB3> INFO: Test took 7673ms.
[10:16:56.252] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[10:16:56.489] <TB3> INFO: PixTestAlive::maskTest() done
[10:16:56.489] <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
[10:16:56.491] <TB3> INFO: ----------------------------------------------------------------------
[10:16:56.491] <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)
[10:16:56.491] <TB3> INFO: ----------------------------------------------------------------------
[10:16:56.875] <TB3> INFO: Expecting 208000 events.
[10:17:07.927] <TB3> INFO: 208000 events read in total (10496ms).
[10:17:07.927] <TB3> INFO: Test took 11435ms.






[10:17:08.127] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[10:17:08.127] <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
[10:17:08.127] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[10:17:08.162] <TB3> INFO: enter test to run
[10:17:08.163] <TB3> INFO: test: delay setting parameters: ->2<-
[10:17:08.163] <TB3> INFO: delay test by 2 seconds...
[10:17:10.163] <TB3> INFO: enter test to run
[10:17:10.164] <TB3> INFO: test: HighRate no parameter change
[10:17:10.164] <TB3> INFO: running: highrate
[10:17:10.164] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//013_HREfficiency_75//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//013_HREfficiency_75//phCalibrationFitErr35_C15.dat
[10:17:10.304] <TB3> INFO: ----------------------------------------------------------------------
[10:17:10.304] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[10:17:10.304] <TB3> INFO: ----------------------------------------------------------------------
[10:17:10.793] <TB3> INFO: Expecting 208000 events.
[10:17:26.761] <TB3> INFO: 208000 events read in total (15567ms).
[10:17:26.767] <TB3> INFO: Test took 16460ms.
[10:17:27.360] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 3 0 0 0 0 1 0 0 0 0 0 0
[10:17:27.360] <TB3> INFO: number of red-efficiency pixels: 132 128 120 376 448 445 473 402 421 452 574 384 425 250 140 144
[10:17:27.360] <TB3> INFO: number of X-ray hits detected: 119284 109732 97285 184876 206232 243239 234558 238670 240353 255305 278747 229561 205280 115210 122267 118843
[10:17:27.360] <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
[10:17:27.360] <TB3> INFO: number of Vcal hits detected: 207862 207867 207877 207589 207354 207510 207479 207578 207551 207455 207376 207578 207537 207727 207856 207852
[10:17:27.360] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 100.0 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.7 99.8 99.8 99.9 99.9 99.9
[10:17:27.360] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.8 99.7 99.8 99.7 99.8 99.8 99.7 99.7 99.8 99.8 99.9 99.9 99.9
[10:17:27.360] <TB3> INFO: X-ray hit rate [MHz/cm2]: 35.0 32.2 28.5 54.2 60.4 71.3 68.8 70.0 70.4 74.8 81.7 67.3 60.2 33.8 35.8 34.8
[10:17:27.360] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[10:17:27.385] <TB3> INFO: PixTest:: pg_setup set to default.
[10:17:27.394] <TB3> INFO: enter test to run
[10:17:27.394] <TB3> INFO: test: no parameter change
[10:17:27.652] <TB3> QUIET: Connection to board 121 closed.
[10:17:27.731] <TB3> INFO: pXar: this is the end, my friend

[10:18:00.884] <TB3> INFO: *** Welcome to pxar ***
[10:18:00.884] <TB3> INFO: *** Today: 2016/02/24
[10:18:00.947] <TB3> INFO: *** Version: 9751
[10:18:00.947] <TB3> INFO: readRocDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//014_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//014_HREfficiency_100//dacParameters35_C15.dat
[10:18:00.948] <TB3> INFO: readTbmDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//014_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//014_HREfficiency_100//tbmParameters_C0b.dat
[10:18:00.948] <TB3> INFO: readMaskFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//014_HREfficiency_100//defaultMaskFile.dat
[10:18:00.948] <TB3> INFO: readTrimFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//014_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//014_HREfficiency_100//trimParameters35_C15.dat
[10:18:01.020] <TB3> INFO: clk: 4
[10:18:01.020] <TB3> INFO: ctr: 4
[10:18:01.020] <TB3> INFO: sda: 19
[10:18:01.020] <TB3> INFO: tin: 9
[10:18:01.020] <TB3> INFO: level: 15
[10:18:01.020] <TB3> INFO: triggerdelay: 0
[10:18:01.020] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[10:18:01.020] <TB3> INFO: Log level: INFO
[10:18:01.035] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:18:01.046] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:18:01.047] <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:
------------------------------------------------------
[10:18:01.049] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[10:18:02.604] <TB3> INFO: DUT info:
[10:18:02.604] <TB3> INFO: The DUT currently contains the following objects:
[10:18:02.604] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[10:18:02.604] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:18:02.604] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:18:02.604] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:18:02.604] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:18:02.604] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:18:02.605] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:18:02.605] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:18:02.605] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:18:02.605] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:18:02.605] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:18:02.605] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:18:02.605] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:18:02.605] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:18:02.605] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:18:02.605] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:18:02.605] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:18:02.605] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:18:02.605] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:18:02.605] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:18:03.006] <TB3> INFO: enter 'restricted' command line mode
[10:18:03.006] <TB3> INFO: enter test to run
[10:18:03.006] <TB3> INFO: test: PixelAlive no parameter change
[10:18:03.006] <TB3> INFO: running: pixelalive
[10:18:03.012] <TB3> INFO: ######################################################################
[10:18:03.012] <TB3> INFO: PixTestAlive::doTest()
[10:18:03.012] <TB3> INFO: ######################################################################
[10:18:03.013] <TB3> INFO: ----------------------------------------------------------------------
[10:18:03.013] <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)
[10:18:03.014] <TB3> INFO: ----------------------------------------------------------------------
[10:18:03.286] <TB3> INFO: Expecting 208000 events.
[10:18:14.324] <TB3> INFO: 208000 events read in total (10480ms).
[10:18:14.326] <TB3> INFO: Test took 11311ms.
[10:18:14.542] <TB3> INFO: PixTestAlive::aliveTest() done
[10:18:14.542] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 3 0 0 0 0 1 0 0 0 0 0 0
[10:18:14.543] <TB3> INFO: ----------------------------------------------------------------------
[10:18:14.543] <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)
[10:18:14.543] <TB3> INFO: ----------------------------------------------------------------------
[10:18:14.806] <TB3> INFO: Expecting 208000 events.
[10:18:22.087] <TB3> INFO: 208000 events read in total (6725ms).
[10:18:22.087] <TB3> INFO: Test took 7543ms.
[10:18:22.088] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[10:18:22.327] <TB3> INFO: PixTestAlive::maskTest() done
[10:18:22.327] <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
[10:18:22.328] <TB3> INFO: ----------------------------------------------------------------------
[10:18:22.328] <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)
[10:18:22.328] <TB3> INFO: ----------------------------------------------------------------------
[10:18:22.621] <TB3> INFO: Expecting 208000 events.
[10:18:33.662] <TB3> INFO: 208000 events read in total (10485ms).
[10:18:33.662] <TB3> INFO: Test took 11332ms.





[10:18:33.858] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[10:18:33.858] <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
[10:18:33.858] <TB3> INFO: PixTestAlive::doTest() done, duration: 30 seconds
[10:18:33.889] <TB3> INFO: enter test to run
[10:18:33.889] <TB3> INFO: test: delay setting parameters: ->2<-
[10:18:33.889] <TB3> INFO: delay test by 2 seconds...
[10:18:35.889] <TB3> INFO: enter test to run
[10:18:35.889] <TB3> INFO: test: HighRate no parameter change
[10:18:35.889] <TB3> INFO: running: highrate
[10:18:35.890] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//014_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//014_HREfficiency_100//phCalibrationFitErr35_C15.dat
[10:18:36.023] <TB3> INFO: ----------------------------------------------------------------------
[10:18:36.023] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[10:18:36.023] <TB3> INFO: ----------------------------------------------------------------------
[10:18:36.506] <TB3> INFO: Expecting 208000 events.
[10:18:54.996] <TB3> INFO: 208000 events read in total (18089ms).
[10:18:55.004] <TB3> INFO: Test took 18978ms.
[10:18:55.738] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 3 0 0 0 0 1 0 0 0 0 0 0
[10:18:55.738] <TB3> INFO: number of red-efficiency pixels: 220 235 214 658 665 801 857 707 739 871 1024 735 774 411 225 230
[10:18:55.738] <TB3> INFO: number of X-ray hits detected: 164379 153028 136733 253177 282923 331662 321555 326765 329196 346614 381686 315150 282102 159805 169607 164137
[10:18:55.738] <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
[10:18:55.738] <TB3> INFO: number of Vcal hits detected: 207769 207754 207764 207248 207097 207023 206936 207207 207140 206907 206685 207145 207103 207517 207764 207759
[10:18:55.738] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.7 99.7 99.6 99.6 99.6 99.6 99.6 99.5 99.6 99.6 99.8 99.9 99.9
[10:18:55.738] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.6 99.6 99.5 99.5 99.6 99.6 99.5 99.4 99.6 99.6 99.8 99.9 99.9
[10:18:55.738] <TB3> INFO: X-ray hit rate [MHz/cm2]: 48.2 44.9 40.1 74.2 82.9 97.2 94.3 95.8 96.5 101.6 111.9 92.4 82.7 46.8 49.7 48.1
[10:18:55.738] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[10:18:55.764] <TB3> INFO: PixTest:: pg_setup set to default.
[10:18:55.773] <TB3> INFO: enter test to run
[10:18:55.773] <TB3> INFO: test: no parameter change
[10:18:56.025] <TB3> QUIET: Connection to board 121 closed.
[10:18:56.105] <TB3> INFO: pXar: this is the end, my friend

[10:19:32.742] <TB3> INFO: *** Welcome to pxar ***
[10:19:32.742] <TB3> INFO: *** Today: 2016/02/24
[10:19:32.811] <TB3> INFO: *** Version: 9751
[10:19:32.811] <TB3> INFO: readRocDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//015_HREfficiency_125//dacParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//015_HREfficiency_125//dacParameters35_C15.dat
[10:19:32.812] <TB3> INFO: readTbmDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//015_HREfficiency_125//tbmParameters_C0a.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//015_HREfficiency_125//tbmParameters_C0b.dat
[10:19:32.812] <TB3> INFO: readMaskFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//015_HREfficiency_125//defaultMaskFile.dat
[10:19:32.812] <TB3> INFO: readTrimFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//015_HREfficiency_125//trimParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//015_HREfficiency_125//trimParameters35_C15.dat
[10:19:32.884] <TB3> INFO: clk: 4
[10:19:32.884] <TB3> INFO: ctr: 4
[10:19:32.884] <TB3> INFO: sda: 19
[10:19:32.884] <TB3> INFO: tin: 9
[10:19:32.884] <TB3> INFO: level: 15
[10:19:32.884] <TB3> INFO: triggerdelay: 0
[10:19:32.884] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[10:19:32.884] <TB3> INFO: Log level: INFO
[10:19:32.896] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:19:32.907] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:19:32.909] <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:
------------------------------------------------------
[10:19:32.910] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[10:19:34.463] <TB3> INFO: DUT info:
[10:19:34.463] <TB3> INFO: The DUT currently contains the following objects:
[10:19:34.463] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[10:19:34.463] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:19:34.464] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:19:34.464] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:19:34.464] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:19:34.464] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:19:34.464] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:19:34.464] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:19:34.464] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:19:34.464] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:19:34.464] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:19:34.464] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:19:34.464] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:19:34.464] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:19:34.464] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:19:34.464] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:19:34.464] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:19:34.464] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:19:34.464] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:19:34.464] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:19:34.865] <TB3> INFO: enter 'restricted' command line mode
[10:19:34.865] <TB3> INFO: enter test to run
[10:19:34.865] <TB3> INFO: test: PixelAlive no parameter change
[10:19:34.865] <TB3> INFO: running: pixelalive
[10:19:34.868] <TB3> INFO: ######################################################################
[10:19:34.868] <TB3> INFO: PixTestAlive::doTest()
[10:19:34.868] <TB3> INFO: ######################################################################
[10:19:34.869] <TB3> INFO: ----------------------------------------------------------------------
[10:19:34.869] <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)
[10:19:34.869] <TB3> INFO: ----------------------------------------------------------------------
[10:19:35.140] <TB3> INFO: Expecting 208000 events.
[10:19:46.199] <TB3> INFO: 208000 events read in total (10501ms).
[10:19:46.201] <TB3> INFO: Test took 11331ms.
[10:19:46.420] <TB3> INFO: PixTestAlive::aliveTest() done
[10:19:46.420] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 3 0 0 0 0 1 0 0 0 0 0 0
[10:19:46.421] <TB3> INFO: ----------------------------------------------------------------------
[10:19:46.421] <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)
[10:19:46.421] <TB3> INFO: ----------------------------------------------------------------------
[10:19:46.698] <TB3> INFO: Expecting 208000 events.
[10:19:54.098] <TB3> INFO: 208000 events read in total (6843ms).
[10:19:54.098] <TB3> INFO: Test took 7676ms.
[10:19:54.098] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[10:19:54.336] <TB3> INFO: PixTestAlive::maskTest() done
[10:19:54.336] <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
[10:19:54.338] <TB3> INFO: ----------------------------------------------------------------------
[10:19:54.338] <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)
[10:19:54.338] <TB3> INFO: ----------------------------------------------------------------------
[10:19:54.607] <TB3> INFO: Expecting 208000 events.
[10:20:05.807] <TB3> INFO: 208000 events read in total (10644ms).
[10:20:05.808] <TB3> INFO: Test took 11469ms.


[10:20:06.005] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[10:20:06.005] <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
[10:20:06.005] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[10:20:06.036] <TB3> INFO: enter test to run
[10:20:06.036] <TB3> INFO: test: delay setting parameters: ->2<-
[10:20:06.036] <TB3> INFO: delay test by 2 seconds...
[10:20:08.036] <TB3> INFO: enter test to run
[10:20:08.036] <TB3> INFO: test: HighRate no parameter change
[10:20:08.036] <TB3> INFO: running: highrate
[10:20:08.036] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//015_HREfficiency_125//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//015_HREfficiency_125//phCalibrationFitErr35_C15.dat
[10:20:08.197] <TB3> INFO: ----------------------------------------------------------------------
[10:20:08.197] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[10:20:08.197] <TB3> INFO: ----------------------------------------------------------------------
[10:20:08.692] <TB3> INFO: Expecting 208000 events.
[10:20:28.677] <TB3> INFO: 208000 events read in total (19584ms).
[10:20:28.685] <TB3> INFO: Test took 20485ms.
[10:20:29.533] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 3 0 0 0 0 1 0 0 0 0 0 0
[10:20:29.533] <TB3> INFO: number of red-efficiency pixels: 312 322 315 953 901 1215 1275 1083 1116 1293 1591 1085 1206 574 311 329
[10:20:29.533] <TB3> INFO: number of X-ray hits detected: 200459 187354 166634 307667 343916 403909 391418 396574 397959 422240 462705 382836 343508 195834 206747 199927
[10:20:29.533] <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
[10:20:29.533] <TB3> INFO: number of Vcal hits detected: 207669 207665 207635 206820 206752 206389 206233 206672 206593 206221 205659 206553 206485 207234 207670 207652
[10:20:29.533] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.5 99.5 99.3 99.3 99.4 99.4 99.3 99.0 99.4 99.4 99.7 99.9 99.8
[10:20:29.533] <TB3> INFO: Vcal hit overall efficiency (%): 99.8 99.8 99.8 99.4 99.4 99.2 99.2 99.4 99.3 99.1 98.9 99.3 99.3 99.6 99.8 99.8
[10:20:29.533] <TB3> INFO: X-ray hit rate [MHz/cm2]: 58.8 54.9 48.8 90.2 100.8 118.4 114.7 116.2 116.6 123.8 135.6 112.2 100.7 57.4 60.6 58.6
[10:20:29.533] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[10:20:29.559] <TB3> INFO: PixTest:: pg_setup set to default.
[10:20:29.570] <TB3> INFO: enter test to run
[10:20:29.570] <TB3> INFO: test: no parameter change
[10:20:29.817] <TB3> QUIET: Connection to board 121 closed.
[10:20:29.897] <TB3> INFO: pXar: this is the end, my friend

[10:21:06.575] <TB3> INFO: *** Welcome to pxar ***
[10:21:06.575] <TB3> INFO: *** Today: 2016/02/24
[10:21:06.640] <TB3> INFO: *** Version: 9751
[10:21:06.640] <TB3> INFO: readRocDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//016_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//016_HREfficiency_150//dacParameters35_C15.dat
[10:21:06.640] <TB3> INFO: readTbmDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//016_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//016_HREfficiency_150//tbmParameters_C0b.dat
[10:21:06.640] <TB3> INFO: readMaskFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//016_HREfficiency_150//defaultMaskFile.dat
[10:21:06.641] <TB3> INFO: readTrimFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//016_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//016_HREfficiency_150//trimParameters35_C15.dat
[10:21:06.716] <TB3> INFO: clk: 4
[10:21:06.716] <TB3> INFO: ctr: 4
[10:21:06.716] <TB3> INFO: sda: 19
[10:21:06.716] <TB3> INFO: tin: 9
[10:21:06.716] <TB3> INFO: level: 15
[10:21:06.716] <TB3> INFO: triggerdelay: 0
[10:21:06.716] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[10:21:06.716] <TB3> INFO: Log level: INFO
[10:21:06.729] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:21:06.740] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:21:06.742] <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:
------------------------------------------------------
[10:21:06.744] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[10:21:08.306] <TB3> INFO: DUT info:
[10:21:08.306] <TB3> INFO: The DUT currently contains the following objects:
[10:21:08.306] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[10:21:08.306] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:21:08.306] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:21:08.306] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:21:08.306] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:08.306] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:08.306] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:08.306] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:08.306] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:08.306] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:08.306] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:08.306] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:08.306] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:08.306] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:08.306] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:08.306] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:08.306] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:08.306] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:08.306] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:08.306] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:08.707] <TB3> INFO: enter 'restricted' command line mode
[10:21:08.707] <TB3> INFO: enter test to run
[10:21:08.707] <TB3> INFO: test: PixelAlive no parameter change
[10:21:08.707] <TB3> INFO: running: pixelalive
[10:21:08.711] <TB3> INFO: ######################################################################
[10:21:08.711] <TB3> INFO: PixTestAlive::doTest()
[10:21:08.711] <TB3> INFO: ######################################################################
[10:21:08.712] <TB3> INFO: ----------------------------------------------------------------------
[10:21:08.712] <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)
[10:21:08.712] <TB3> INFO: ----------------------------------------------------------------------
[10:21:09.000] <TB3> INFO: Expecting 208000 events.
[10:21:20.128] <TB3> INFO: 208000 events read in total (10570ms).
[10:21:20.130] <TB3> INFO: Test took 11416ms.
[10:21:20.350] <TB3> INFO: PixTestAlive::aliveTest() done
[10:21:20.350] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 3 0 0 0 0 0 0 0 0 0 0 0
[10:21:20.352] <TB3> INFO: ----------------------------------------------------------------------
[10:21:20.352] <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)
[10:21:20.352] <TB3> INFO: ----------------------------------------------------------------------
[10:21:20.639] <TB3> INFO: Expecting 208000 events.
[10:21:27.948] <TB3> INFO: 208000 events read in total (6752ms).
[10:21:27.948] <TB3> INFO: Test took 7595ms.
[10:21:27.949] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[10:21:28.186] <TB3> INFO: PixTestAlive::maskTest() done
[10:21:28.186] <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
[10:21:28.187] <TB3> INFO: ----------------------------------------------------------------------
[10:21:28.187] <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)
[10:21:28.187] <TB3> INFO: ----------------------------------------------------------------------
[10:21:28.474] <TB3> INFO: Expecting 208000 events.
[10:21:39.594] <TB3> INFO: 208000 events read in total (10564ms).
[10:21:39.595] <TB3> INFO: Test took 11407ms.

[10:21:39.791] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[10:21:39.791] <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
[10:21:39.791] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[10:21:39.823] <TB3> INFO: enter test to run
[10:21:39.823] <TB3> INFO: test: delay setting parameters: ->2<-
[10:21:39.823] <TB3> INFO: delay test by 2 seconds...
[10:21:41.823] <TB3> INFO: enter test to run
[10:21:41.823] <TB3> INFO: test: HighRate no parameter change
[10:21:41.823] <TB3> INFO: running: highrate
[10:21:41.823] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//016_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//016_HREfficiency_150//phCalibrationFitErr35_C15.dat
[10:21:41.978] <TB3> INFO: ----------------------------------------------------------------------
[10:21:41.978] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[10:21:41.978] <TB3> INFO: ----------------------------------------------------------------------
[10:21:42.461] <TB3> INFO: Expecting 208000 events.
[10:22:04.131] <TB3> INFO: 208000 events read in total (21268ms).
[10:22:04.143] <TB3> INFO: Test took 22162ms.
[10:22:05.141] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 3 0 0 0 0 1 0 0 0 0 0 0
[10:22:05.141] <TB3> INFO: number of red-efficiency pixels: 420 448 441 1395 1233 1681 1729 1567 1566 1735 2154 1471 1622 723 451 457
[10:22:05.141] <TB3> INFO: number of X-ray hits detected: 239390 224657 200372 366742 409096 480608 465728 472212 475130 500940 549458 455740 408933 234296 248132 240267
[10:22:05.141] <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
[10:22:05.141] <TB3> INFO: number of Vcal hits detected: 207542 207514 207448 206065 206178 205457 205181 205839 205841 205236 204273 205747 205727 206861 207511 207499
[10:22:05.141] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.8 99.8 99.8 99.2 99.3 98.9 98.8 99.1 99.1 98.9 98.4 99.1 99.0 99.6 99.8 99.8
[10:22:05.141] <TB3> INFO: Vcal hit overall efficiency (%): 99.8 99.8 99.7 99.1 99.1 98.8 98.6 99.0 99.0 98.7 98.2 98.9 98.9 99.5 99.8 99.8
[10:22:05.141] <TB3> INFO: X-ray hit rate [MHz/cm2]: 70.2 65.8 58.7 107.5 119.9 140.9 136.5 138.4 139.3 146.8 161.1 133.6 119.9 68.7 72.7 70.4
[10:22:05.141] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[10:22:05.167] <TB3> INFO: PixTest:: pg_setup set to default.
[10:22:05.177] <TB3> INFO: enter test to run
[10:22:05.177] <TB3> INFO: test: no parameter change
[10:22:05.438] <TB3> QUIET: Connection to board 121 closed.
[10:22:05.518] <TB3> INFO: pXar: this is the end, my friend

[10:22:41.586] <TB3> INFO: *** Welcome to pxar ***
[10:22:41.586] <TB3> INFO: *** Today: 2016/02/24
[10:22:41.649] <TB3> INFO: *** Version: 9751
[10:22:41.649] <TB3> INFO: readRocDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//017_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//017_HREfficiency_200//dacParameters35_C15.dat
[10:22:41.649] <TB3> INFO: readTbmDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//017_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//017_HREfficiency_200//tbmParameters_C0b.dat
[10:22:41.650] <TB3> INFO: readMaskFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//017_HREfficiency_200//defaultMaskFile.dat
[10:22:41.650] <TB3> INFO: readTrimFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//017_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//017_HREfficiency_200//trimParameters35_C15.dat
[10:22:41.728] <TB3> INFO: clk: 4
[10:22:41.728] <TB3> INFO: ctr: 4
[10:22:41.728] <TB3> INFO: sda: 19
[10:22:41.728] <TB3> INFO: tin: 9
[10:22:41.728] <TB3> INFO: level: 15
[10:22:41.728] <TB3> INFO: triggerdelay: 0
[10:22:41.728] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[10:22:41.728] <TB3> INFO: Log level: INFO
[10:22:41.742] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:22:41.753] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:22:41.755] <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:
------------------------------------------------------
[10:22:41.756] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[10:22:43.314] <TB3> INFO: DUT info:
[10:22:43.314] <TB3> INFO: The DUT currently contains the following objects:
[10:22:43.314] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[10:22:43.314] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:22:43.314] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:22:43.314] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:22:43.314] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:43.314] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:43.314] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:43.314] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:43.314] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:43.314] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:43.314] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:43.314] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:43.314] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:43.314] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:43.314] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:43.314] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:43.314] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:43.314] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:43.314] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:43.314] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:43.715] <TB3> INFO: enter 'restricted' command line mode
[10:22:43.715] <TB3> INFO: enter test to run
[10:22:43.715] <TB3> INFO: test: PixelAlive no parameter change
[10:22:43.715] <TB3> INFO: running: pixelalive
[10:22:43.719] <TB3> INFO: ######################################################################
[10:22:43.719] <TB3> INFO: PixTestAlive::doTest()
[10:22:43.719] <TB3> INFO: ######################################################################
[10:22:43.720] <TB3> INFO: ----------------------------------------------------------------------
[10:22:43.720] <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)
[10:22:43.720] <TB3> INFO: ----------------------------------------------------------------------
[10:22:44.007] <TB3> INFO: Expecting 208000 events.
[10:22:55.358] <TB3> INFO: 208000 events read in total (10793ms).
[10:22:55.359] <TB3> INFO: Test took 11638ms.
[10:22:55.588] <TB3> INFO: PixTestAlive::aliveTest() done
[10:22:55.588] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 3 0 0 0 0 1 0 0 0 0 0 0
[10:22:55.589] <TB3> INFO: ----------------------------------------------------------------------
[10:22:55.589] <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)
[10:22:55.589] <TB3> INFO: ----------------------------------------------------------------------
[10:22:55.850] <TB3> INFO: Expecting 208000 events.
[10:23:03.213] <TB3> INFO: 208000 events read in total (6806ms).
[10:23:03.214] <TB3> INFO: Test took 7623ms.
[10:23:03.214] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[10:23:03.455] <TB3> INFO: PixTestAlive::maskTest() done
[10:23:03.455] <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
[10:23:03.456] <TB3> INFO: ----------------------------------------------------------------------
[10:23:03.456] <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)
[10:23:03.456] <TB3> INFO: ----------------------------------------------------------------------
[10:23:03.735] <TB3> INFO: Expecting 208000 events.
[10:23:14.845] <TB3> INFO: 208000 events read in total (10554ms).
[10:23:14.845] <TB3> INFO: Test took 11387ms.


[10:23:15.041] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[10:23:15.041] <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
[10:23:15.041] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[10:23:15.074] <TB3> INFO: enter test to run
[10:23:15.074] <TB3> INFO: test: delay setting parameters: ->2<-
[10:23:15.074] <TB3> INFO: delay test by 2 seconds...
[10:23:17.074] <TB3> INFO: enter test to run
[10:23:17.074] <TB3> INFO: test: HighRate no parameter change
[10:23:17.074] <TB3> INFO: running: highrate
[10:23:17.074] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//017_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//017_HREfficiency_200//phCalibrationFitErr35_C15.dat
[10:23:17.260] <TB3> INFO: ----------------------------------------------------------------------
[10:23:17.260] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[10:23:17.260] <TB3> INFO: ----------------------------------------------------------------------
[10:23:17.768] <TB3> INFO: Expecting 208000 events.
[10:23:45.037] <TB3> INFO: 208000 events read in total (26868ms).
[10:23:45.052] <TB3> INFO: Test took 27788ms.
[10:23:46.326] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 3 0 0 0 0 0 0 0 0 0 0 0
[10:23:46.326] <TB3> INFO: number of red-efficiency pixels: 767 837 704 2361 2046 2814 2873 2735 2752 2868 3354 2603 2690 1205 835 840
[10:23:46.326] <TB3> INFO: number of X-ray hits detected: 326612 306635 274933 494237 550030 643809 625600 636617 642498 676158 738706 616170 556002 321114 340292 326073
[10:23:46.326] <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
[10:23:46.326] <TB3> INFO: number of Vcal hits detected: 207106 207026 206786 203569 204140 201921 201187 202821 202630 201035 198775 202418 202439 205362 207022 206987
[10:23:46.326] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.6 99.6 99.5 98.1 98.5 97.5 97.2 97.7 97.7 97.1 96.1 97.7 97.7 99.0 99.6 99.6
[10:23:46.326] <TB3> INFO: Vcal hit overall efficiency (%): 99.6 99.5 99.4 97.9 98.1 97.1 96.7 97.5 97.4 96.7 95.6 97.3 97.3 98.7 99.5 99.5
[10:23:46.326] <TB3> INFO: X-ray hit rate [MHz/cm2]: 95.7 89.9 80.6 144.9 161.2 188.7 183.4 186.6 188.3 198.2 216.5 180.6 163.0 94.1 99.7 95.6
[10:23:46.326] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[10:23:46.351] <TB3> INFO: PixTest:: pg_setup set to default.
[10:23:46.362] <TB3> INFO: enter test to run
[10:23:46.362] <TB3> INFO: test: no parameter change
[10:23:46.670] <TB3> QUIET: Connection to board 121 closed.
[10:23:46.749] <TB3> INFO: pXar: this is the end, my friend

[10:24:23.265] <TB3> INFO: *** Welcome to pxar ***
[10:24:23.265] <TB3> INFO: *** Today: 2016/02/24
[10:24:23.328] <TB3> INFO: *** Version: 9751
[10:24:23.328] <TB3> INFO: readRocDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//018_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//018_HREfficiency_250//dacParameters35_C15.dat
[10:24:23.329] <TB3> INFO: readTbmDacs: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//018_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//018_HREfficiency_250//tbmParameters_C0b.dat
[10:24:23.329] <TB3> INFO: readMaskFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//018_HREfficiency_250//defaultMaskFile.dat
[10:24:23.329] <TB3> INFO: readTrimFile: /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//018_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//018_HREfficiency_250//trimParameters35_C15.dat
[10:24:23.429] <TB3> INFO: clk: 4
[10:24:23.429] <TB3> INFO: ctr: 4
[10:24:23.429] <TB3> INFO: sda: 19
[10:24:23.429] <TB3> INFO: tin: 9
[10:24:23.429] <TB3> INFO: level: 15
[10:24:23.429] <TB3> INFO: triggerdelay: 0
[10:24:23.429] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[10:24:23.429] <TB3> INFO: Log level: INFO
[10:24:23.440] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:24:23.451] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:24:23.453] <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:
------------------------------------------------------
[10:24:23.455] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[10:24:25.013] <TB3> INFO: DUT info:
[10:24:25.013] <TB3> INFO: The DUT currently contains the following objects:
[10:24:25.013] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[10:24:25.013] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:24:25.014] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:24:25.014] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:24:25.014] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:25.014] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:25.014] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:25.014] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:25.014] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:25.014] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:25.014] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:25.014] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:25.014] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:25.014] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:25.014] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:25.014] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:25.014] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:25.014] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:25.014] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:25.014] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:24:25.414] <TB3> INFO: enter 'restricted' command line mode
[10:24:25.415] <TB3> INFO: enter test to run
[10:24:25.415] <TB3> INFO: test: PixelAlive no parameter change
[10:24:25.415] <TB3> INFO: running: pixelalive
[10:24:25.418] <TB3> INFO: ######################################################################
[10:24:25.418] <TB3> INFO: PixTestAlive::doTest()
[10:24:25.418] <TB3> INFO: ######################################################################
[10:24:25.419] <TB3> INFO: ----------------------------------------------------------------------
[10:24:25.419] <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)
[10:24:25.419] <TB3> INFO: ----------------------------------------------------------------------
[10:24:25.681] <TB3> INFO: Expecting 208000 events.
[10:24:36.817] <TB3> INFO: 208000 events read in total (10578ms).
[10:24:36.819] <TB3> INFO: Test took 11398ms.
[10:24:37.040] <TB3> INFO: PixTestAlive::aliveTest() done
[10:24:37.040] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 3 0 0 0 0 1 0 0 0 0 0 0
[10:24:37.041] <TB3> INFO: ----------------------------------------------------------------------
[10:24:37.041] <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)
[10:24:37.041] <TB3> INFO: ----------------------------------------------------------------------
[10:24:37.314] <TB3> INFO: Expecting 208000 events.
[10:24:44.602] <TB3> INFO: 208000 events read in total (6732ms).
[10:24:44.603] <TB3> INFO: Test took 7560ms.
[10:24:44.603] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[10:24:44.843] <TB3> INFO: PixTestAlive::maskTest() done
[10:24:44.843] <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
[10:24:44.844] <TB3> INFO: ----------------------------------------------------------------------
[10:24:44.844] <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)
[10:24:44.844] <TB3> INFO: ----------------------------------------------------------------------
[10:24:45.104] <TB3> INFO: Expecting 208000 events.
[10:24:56.155] <TB3> INFO: 208000 events read in total (10495ms).
[10:24:56.156] <TB3> INFO: Test took 11311ms.


[10:24:56.356] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[10:24:56.356] <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
[10:24:56.356] <TB3> INFO: PixTestAlive::doTest() done, duration: 30 seconds
[10:24:56.389] <TB3> INFO: enter test to run
[10:24:56.389] <TB3> INFO: test: delay setting parameters: ->2<-
[10:24:56.389] <TB3> INFO: delay test by 2 seconds...
[10:24:58.389] <TB3> INFO: enter test to run
[10:24:58.389] <TB3> INFO: test: HighRate no parameter change
[10:24:58.389] <TB3> INFO: running: highrate
[10:24:58.389] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//018_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2164_XrayQualification_2016-02-24_09h58m_1456304322//018_HREfficiency_250//phCalibrationFitErr35_C15.dat
[10:24:58.528] <TB3> INFO: ----------------------------------------------------------------------
[10:24:58.528] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[10:24:58.528] <TB3> INFO: ----------------------------------------------------------------------
[10:24:59.012] <TB3> INFO: Expecting 208000 events.
[10:25:29.933] <TB3> INFO: 208000 events read in total (30520ms).
[10:25:29.953] <TB3> INFO: Test took 31422ms.
[10:25:31.509] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 3 0 0 0 0 1 0 0 0 0 0 0
[10:25:31.509] <TB3> INFO: number of red-efficiency pixels: 1246 1314 1051 3174 2892 3613 3578 3587 3605 3636 3935 3338 3503 1533 1356 1269
[10:25:31.509] <TB3> INFO: number of X-ray hits detected: 405434 380203 339996 610066 677883 793996 772039 781180 788028 836052 909064 757957 680558 396531 419843 402888
[10:25:31.509] <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
[10:25:31.509] <TB3> INFO: number of Vcal hits detected: 206388 206326 205807 199920 200882 196603 195522 198187 197771 194872 190830 197828 197844 203417 206218 206297
[10:25:31.509] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.3 99.3 99.2 96.6 97.1 95.2 94.8 95.7 95.6 94.5 92.7 95.8 95.7 98.2 99.2 99.3
[10:25:31.509] <TB3> INFO: Vcal hit overall efficiency (%): 99.2 99.2 98.9 96.1 96.6 94.5 94.0 95.3 95.1 93.7 91.7 95.1 95.1 97.8 99.1 99.2
[10:25:31.509] <TB3> INFO: X-ray hit rate [MHz/cm2]: 118.8 111.4 99.7 178.8 198.7 232.7 226.3 229.0 231.0 245.1 266.5 222.2 199.5 116.2 123.1 118.1
[10:25:31.509] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[10:25:31.534] <TB3> INFO: PixTest:: pg_setup set to default.
[10:25:31.546] <TB3> INFO: enter test to run
[10:25:31.546] <TB3> INFO: test: no parameter change
[10:25:31.828] <TB3> QUIET: Connection to board 121 closed.
[10:25:31.908] <TB3> INFO: pXar: this is the end, my friend