[09:28:38.158] <TB3> INFO: *** Welcome to pxar ***
[09:28:38.158] <TB3> INFO: *** Today: 2015/12/16
[09:28:38.483] <TB3> INFO: *** Version: b2d3
[09:28:38.483] <TB3> INFO: readRocDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//000_PixelAlive_p17//dacParameters35_C15.dat
[09:28:38.484] <TB3> INFO: readTbmDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//000_PixelAlive_p17//tbmParameters_C0b.dat
[09:28:38.485] <TB3> INFO: readMaskFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//000_PixelAlive_p17//defaultMaskFile.dat
[09:28:38.485] <TB3> INFO: readTrimFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//000_PixelAlive_p17//trimParameters35_C15.dat
[09:28:38.558] <TB3> INFO: clk: 4
[09:28:38.558] <TB3> INFO: ctr: 4
[09:28:38.558] <TB3> INFO: sda: 19
[09:28:38.558] <TB3> INFO: tin: 9
[09:28:38.558] <TB3> INFO: level: 15
[09:28:38.558] <TB3> INFO: triggerdelay: 0
[09:28:38.558] <TB3> QUIET: Instanciating API for pxar prod-12
[09:28:38.558] <TB3> INFO: Log level: INFO
[09:28:38.570] <TB3> INFO: Found DTB DTB_WWV6Z5
[09:28:38.582] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[09:28:38.585] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[09:28:38.587] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[09:28:40.122] <TB3> INFO: DUT info:
[09:28:40.122] <TB3> INFO: The DUT currently contains the following objects:
[09:28:40.122] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[09:28:40.122] <TB3> INFO: TBM Core alpha (0): 7 registers set
[09:28:40.122] <TB3> INFO: TBM Core beta (1): 7 registers set
[09:28:40.122] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:28:40.122] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:40.122] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:40.122] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:40.122] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:40.122] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:40.123] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:40.123] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:40.123] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:40.123] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:40.123] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:40.123] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:40.123] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:40.123] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:40.123] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:40.123] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:40.123] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:40.524] <TB3> INFO: enter 'restricted' command line mode
[09:28:40.524] <TB3> INFO: enter test to run
[09:28:40.524] <TB3> INFO: test: PixelAlive no parameter change
[09:28:40.524] <TB3> INFO: running: pixelalive
[09:28:40.531] <TB3> INFO: ######################################################################
[09:28:40.531] <TB3> INFO: PixTestAlive::doTest()
[09:28:40.531] <TB3> INFO: ######################################################################
[09:28:40.533] <TB3> INFO: ----------------------------------------------------------------------
[09:28:40.533] <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)
[09:28:40.533] <TB3> INFO: ----------------------------------------------------------------------
[09:28:40.848] <TB3> INFO: Expecting 41600 events.
[09:28:45.126] <TB3> INFO: 41600 events read in total (3560ms).
[09:28:45.207] <TB3> INFO: Test took 4672ms.
[09:28:45.213] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:28:45.462] <TB3> INFO: PixTestAlive::aliveTest() done
[09:28:45.462] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1
[09:28:45.463] <TB3> INFO: ----------------------------------------------------------------------
[09:28:45.463] <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)
[09:28:45.463] <TB3> INFO: ----------------------------------------------------------------------
[09:28:45.761] <TB3> INFO: Expecting 41600 events.
[09:28:48.916] <TB3> INFO: 41600 events read in total (2440ms).
[09:28:48.916] <TB3> INFO: Test took 3452ms.
[09:28:48.916] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:28:48.917] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[09:28:49.226] <TB3> INFO: PixTestAlive::maskTest() done
[09:28:49.226] <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
[09:28:49.227] <TB3> INFO: ----------------------------------------------------------------------
[09:28:49.227] <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)
[09:28:49.227] <TB3> INFO: ----------------------------------------------------------------------
[09:28:49.524] <TB3> INFO: Expecting 41600 events.
[09:28:53.819] <TB3> INFO: 41600 events read in total (3579ms).
[09:28:53.820] <TB3> INFO: Test took 4592ms.
[09:28:53.826] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:28:54.114] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[09:28:54.114] <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
[09:28:54.115] <TB3> INFO: PixTestAlive::doTest() done, duration: 13 seconds
[09:28:54.145] <TB3> INFO: enter test to run
[09:28:54.145] <TB3> INFO: test: no parameter change
[09:28:54.186] <TB3> QUIET: Connection to board 121 closed.
[09:28:54.265] <TB3> INFO: pXar: this is the end, my friend

[09:34:18.869] <TB3> INFO: *** Welcome to pxar ***
[09:34:18.869] <TB3> INFO: *** Today: 2015/12/16
[09:34:18.931] <TB3> INFO: *** Version: b2d3
[09:34:18.931] <TB3> INFO: readRocDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//dacParameters35_C15.dat
[09:34:18.932] <TB3> INFO: readTbmDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[09:34:18.932] <TB3> INFO: readMaskFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//defaultMaskFile.dat
[09:34:18.932] <TB3> INFO: readTrimFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C15.dat
[09:34:19.005] <TB3> INFO: clk: 4
[09:34:19.005] <TB3> INFO: ctr: 4
[09:34:19.005] <TB3> INFO: sda: 19
[09:34:19.005] <TB3> INFO: tin: 9
[09:34:19.005] <TB3> INFO: level: 15
[09:34:19.005] <TB3> INFO: triggerdelay: 0
[09:34:19.005] <TB3> QUIET: Instanciating API for pxar prod-12
[09:34:19.005] <TB3> INFO: Log level: INFO
[09:34:19.018] <TB3> INFO: Found DTB DTB_WWV6Z5
[09:34:19.030] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[09:34:19.033] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[09:34:19.035] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[09:34:20.576] <TB3> INFO: DUT info:
[09:34:20.576] <TB3> INFO: The DUT currently contains the following objects:
[09:34:20.576] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[09:34:20.576] <TB3> INFO: TBM Core alpha (0): 7 registers set
[09:34:20.576] <TB3> INFO: TBM Core beta (1): 7 registers set
[09:34:20.576] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:34:20.576] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:20.576] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:20.576] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:20.576] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:20.576] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:20.576] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:20.576] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:20.576] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:20.576] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:20.576] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:20.576] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:20.576] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:20.576] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:20.576] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:20.576] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:20.576] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:20.977] <TB3> INFO: enter 'restricted' command line mode
[09:34:20.977] <TB3> INFO: enter test to run
[09:34:20.977] <TB3> INFO: test: delay setting parameters: ->5<-
[09:34:20.977] <TB3> INFO: delay test by 5 seconds...
[09:34:25.977] <TB3> INFO: enter test to run
[09:34:25.977] <TB3> INFO: test: highrate no parameter change
[09:34:25.977] <TB3> INFO: running: highrate
[09:34:25.980] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[09:34:26.158] <TB3> INFO: ----------------------------------------------------------------------
[09:34:26.158] <TB3> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[09:34:26.158] <TB3> INFO: ----------------------------------------------------------------------
[09:34:26.158] <TB3> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[09:34:26.158] <TB3> INFO: edge/corner pixel THR is adjusted
[09:34:26.158] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[09:34:27.119] <TB3> INFO: Collecting data for 1 seconds...
[09:34:28.120] <TB3> INFO: Done with hot pixel readout
[09:34:34.606] <TB3> INFO: PixTest:: pg_setup set to default.
[09:34:34.607] <TB3> INFO: 1 hot pixels found in step 0
[09:34:35.569] <TB3> INFO: Collecting data for 1 seconds...
[09:34:36.570] <TB3> INFO: Done with hot pixel readout
[09:34:43.123] <TB3> INFO: PixTest:: pg_setup set to default.
[09:34:43.124] <TB3> INFO: 1 hot pixels found in step 1
[09:34:44.086] <TB3> INFO: Collecting data for 1 seconds...
[09:34:45.088] <TB3> INFO: Done with hot pixel readout
[09:34:51.870] <TB3> INFO: PixTest:: pg_setup set to default.
[09:34:51.871] <TB3> INFO: 1 hot pixels found in step 2
[09:34:52.832] <TB3> INFO: Collecting data for 1 seconds...
[09:34:53.834] <TB3> INFO: Done with hot pixel readout
[09:35:00.987] <TB3> INFO: PixTest:: pg_setup set to default.
[09:35:00.988] <TB3> INFO: 0 hot pixels found in step 3
[09:35:00.999] <TB3> INFO: 0 hot pixels could not be trimmed and have been masked.
[09:35:01.040] <TB3> INFO: PixTest::trimHotPixels() done
[09:35:01.040] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C0.dat
[09:35:01.048] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C1.dat
[09:35:01.061] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C2.dat
[09:35:01.074] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C3.dat
[09:35:01.087] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C4.dat
[09:35:01.100] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C5.dat
[09:35:01.113] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C6.dat
[09:35:01.125] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C7.dat
[09:35:01.138] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C8.dat
[09:35:01.151] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C9.dat
[09:35:01.163] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C10.dat
[09:35:01.176] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C11.dat
[09:35:01.188] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C12.dat
[09:35:01.201] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C13.dat
[09:35:01.214] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C14.dat
[09:35:01.226] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C15.dat
[09:35:01.232] <TB3> INFO: write masked pixels into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//defaultMaskFile.dat
[09:35:01.265] <TB3> INFO: enter test to run
[09:35:01.265] <TB3> INFO: test: no parameter change
[09:35:01.356] <TB3> QUIET: Connection to board 121 closed.
[09:35:01.435] <TB3> INFO: pXar: this is the end, my friend

[09:35:41.648] <TB3> INFO: *** Welcome to pxar ***
[09:35:41.648] <TB3> INFO: *** Today: 2015/12/16
[09:35:41.710] <TB3> INFO: *** Version: b2d3
[09:35:41.710] <TB3> INFO: readRocDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//dacParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//dacParameters35_C15.dat
[09:35:41.711] <TB3> INFO: readTbmDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//tbmParameters_C0a.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//tbmParameters_C0b.dat
[09:35:41.711] <TB3> INFO: readMaskFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//defaultMaskFile.dat
[09:35:41.711] <TB3> INFO: readTrimFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C15.dat
[09:35:41.793] <TB3> INFO: clk: 4
[09:35:41.793] <TB3> INFO: ctr: 4
[09:35:41.793] <TB3> INFO: sda: 19
[09:35:41.793] <TB3> INFO: tin: 9
[09:35:41.793] <TB3> INFO: level: 15
[09:35:41.793] <TB3> INFO: triggerdelay: 0
[09:35:41.793] <TB3> QUIET: Instanciating API for pxar prod-12
[09:35:41.793] <TB3> INFO: Log level: INFO
[09:35:41.807] <TB3> INFO: Found DTB DTB_WWV6Z5
[09:35:41.818] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[09:35:41.821] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[09:35:41.824] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[09:35:43.343] <TB3> INFO: DUT info:
[09:35:43.343] <TB3> INFO: The DUT currently contains the following objects:
[09:35:43.343] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[09:35:43.343] <TB3> INFO: TBM Core alpha (0): 7 registers set
[09:35:43.343] <TB3> INFO: TBM Core beta (1): 7 registers set
[09:35:43.343] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:35:43.343] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:43.343] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:43.343] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:43.343] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:43.343] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:43.343] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:43.343] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:43.343] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:43.343] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:43.343] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:43.343] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:43.343] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:43.343] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:43.343] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:43.343] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:43.343] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:43.744] <TB3> INFO: enter 'restricted' command line mode
[09:35:43.744] <TB3> INFO: enter test to run
[09:35:43.744] <TB3> INFO: test: delay setting parameters: ->5<-
[09:35:43.744] <TB3> INFO: delay test by 5 seconds...
[09:35:48.744] <TB3> INFO: enter test to run
[09:35:48.744] <TB3> INFO: test: highrate no parameter change
[09:35:48.744] <TB3> INFO: running: highrate
[09:35:48.746] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//phCalibrationFitErr35_C15.dat
[09:35:48.931] <TB3> INFO: ----------------------------------------------------------------------
[09:35:48.931] <TB3> INFO: PixTest::trimHotPixels() running for 5 seconds with 100 kHz trigger rate
[09:35:48.931] <TB3> INFO: ----------------------------------------------------------------------
[09:35:48.931] <TB3> INFO: THR = 10, corresponding to ~ 5.33333 MHz/cm2
[09:35:48.931] <TB3> INFO: edge/corner pixel THR is adjusted
[09:35:48.931] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[09:35:49.890] <TB3> INFO: Collecting data for 5 seconds...
[09:35:54.895] <TB3> INFO: Done with hot pixel readout
[09:36:05.339] <TB3> INFO: PixTest:: pg_setup set to default.
[09:36:05.340] <TB3> INFO: 1 hot pixels found in step 0
[09:36:06.382] <TB3> INFO: Collecting data for 5 seconds...
[09:36:11.388] <TB3> INFO: Done with hot pixel readout
[09:36:20.279] <TB3> INFO: PixTest:: pg_setup set to default.
[09:36:20.280] <TB3> INFO: 0 hot pixels found in step 1
[09:36:20.282] <TB3> INFO: 0 hot pixels could not be trimmed and have been masked.
[09:36:20.365] <TB3> INFO: PixTest::trimHotPixels() done
[09:36:20.365] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C0.dat
[09:36:20.371] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C1.dat
[09:36:20.377] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C2.dat
[09:36:20.383] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C3.dat
[09:36:20.389] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C4.dat
[09:36:20.395] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C5.dat
[09:36:20.401] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C6.dat
[09:36:20.407] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C7.dat
[09:36:20.413] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C8.dat
[09:36:20.419] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C9.dat
[09:36:20.425] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C10.dat
[09:36:20.431] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C11.dat
[09:36:20.437] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C12.dat
[09:36:20.443] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C13.dat
[09:36:20.450] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C14.dat
[09:36:20.456] <TB3> INFO: write trim parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C15.dat
[09:36:20.462] <TB3> INFO: write masked pixels into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//defaultMaskFile.dat
[09:36:20.491] <TB3> INFO: enter test to run
[09:36:20.491] <TB3> INFO: test: no parameter change
[09:36:20.541] <TB3> QUIET: Connection to board 121 closed.
[09:36:20.620] <TB3> INFO: pXar: this is the end, my friend

[09:36:57.011] <TB3> INFO: *** Welcome to pxar ***
[09:36:57.011] <TB3> INFO: *** Today: 2015/12/16
[09:36:57.089] <TB3> INFO: *** Version: b2d3
[09:36:57.089] <TB3> INFO: readRocDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//004_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//004_HRData_50//dacParameters35_C15.dat
[09:36:57.091] <TB3> INFO: readTbmDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//004_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//004_HRData_50//tbmParameters_C0b.dat
[09:36:57.091] <TB3> INFO: readMaskFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//004_HRData_50//defaultMaskFile.dat
[09:36:57.091] <TB3> INFO: readTrimFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//004_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//004_HRData_50//trimParameters35_C15.dat
[09:36:57.173] <TB3> INFO: clk: 4
[09:36:57.173] <TB3> INFO: ctr: 4
[09:36:57.173] <TB3> INFO: sda: 19
[09:36:57.173] <TB3> INFO: tin: 9
[09:36:57.173] <TB3> INFO: level: 15
[09:36:57.173] <TB3> INFO: triggerdelay: 0
[09:36:57.173] <TB3> QUIET: Instanciating API for pxar prod-12
[09:36:57.173] <TB3> INFO: Log level: INFO
[09:36:57.187] <TB3> INFO: Found DTB DTB_WWV6Z5
[09:36:57.198] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[09:36:57.202] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[09:36:57.204] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[09:36:58.755] <TB3> INFO: DUT info:
[09:36:58.755] <TB3> INFO: The DUT currently contains the following objects:
[09:36:58.755] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[09:36:58.755] <TB3> INFO: TBM Core alpha (0): 7 registers set
[09:36:58.755] <TB3> INFO: TBM Core beta (1): 7 registers set
[09:36:58.755] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:36:58.755] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:58.755] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:58.755] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:58.755] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:58.755] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:58.755] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:58.755] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:58.755] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:58.755] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:58.755] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:58.755] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:58.755] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:58.755] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:58.755] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:58.755] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:58.755] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:59.156] <TB3> INFO: enter 'restricted' command line mode
[09:36:59.156] <TB3> INFO: enter test to run
[09:36:59.156] <TB3> INFO: test: delay setting parameters: ->5<-
[09:36:59.156] <TB3> INFO: delay test by 5 seconds...
[09:37:04.157] <TB3> INFO: enter test to run
[09:37:04.157] <TB3> INFO: test: Xray no parameter change
[09:37:04.157] <TB3> INFO: running: xray
[09:37:04.160] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//004_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//004_HRData_50//phCalibrationFitErr35_C15.dat
[09:37:04.295] <TB3> INFO: ######################################################################
[09:37:04.295] <TB3> INFO: PixTestXray::doTest()
[09:37:04.295] <TB3> INFO: ######################################################################
[09:37:04.295] <TB3> INFO: ----------------------------------------------------------------------
[09:37:04.295] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[09:37:04.295] <TB3> INFO: ----------------------------------------------------------------------
[09:37:05.262] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[09:37:12.200] <TB3> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[09:37:39.878] <TB3> INFO: Resuming triggers.
[09:37:46.819] <TB3> INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[09:38:14.986] <TB3> INFO: Resuming triggers.
[09:38:21.928] <TB3> INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[09:38:51.443] <TB3> INFO: Resuming triggers.
[09:38:58.381] <TB3> INFO: run duration 27 seconds, buffer almost full (81%), pausing triggers.
[09:39:27.858] <TB3> INFO: Resuming triggers.
[09:39:34.797] <TB3> INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[09:40:02.725] <TB3> INFO: Resuming triggers.
[09:40:09.660] <TB3> INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[09:40:38.186] <TB3> INFO: Resuming triggers.
[09:40:45.121] <TB3> INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[09:41:13.910] <TB3> INFO: Resuming triggers.
[09:41:20.848] <TB3> INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[09:41:49.037] <TB3> INFO: Resuming triggers.
[09:41:55.976] <TB3> INFO: run duration 62 seconds, buffer almost full (81%), pausing triggers.
[09:42:24.505] <TB3> INFO: Resuming triggers.
[09:42:31.444] <TB3> INFO: run duration 69 seconds, buffer almost full (81%), pausing triggers.
[09:42:59.699] <TB3> INFO: Resuming triggers.
[09:43:06.633] <TB3> INFO: run duration 76 seconds, buffer almost full (81%), pausing triggers.
[09:43:33.816] <TB3> INFO: Resuming triggers.
[09:43:40.749] <TB3> INFO: run duration 83 seconds, buffer almost full (81%), pausing triggers.
[09:44:08.437] <TB3> INFO: Resuming triggers.
[09:44:15.374] <TB3> INFO: run duration 90 seconds, buffer almost full (81%), pausing triggers.
[09:44:43.730] <TB3> INFO: Resuming triggers.
[09:44:50.662] <TB3> INFO: run duration 97 seconds, buffer almost full (81%), pausing triggers.
[09:45:18.996] <TB3> INFO: Resuming triggers.
[09:45:21.960] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[09:45:34.185] <TB3> INFO: PixTest:: pg_setup set to default.
[09:45:34.187] <TB3> INFO: PixTestXray::doPhRun() done
[09:45:34.187] <TB3> INFO: PixTestXray::doTest() done
[09:45:34.362] <TB3> INFO: enter test to run
[09:45:34.362] <TB3> INFO: test: no parameter change
[09:45:34.472] <TB3> QUIET: Connection to board 121 closed.
[09:45:34.551] <TB3> INFO: pXar: this is the end, my friend

[09:47:32.067] <TB3> INFO: *** Welcome to pxar ***
[09:47:32.067] <TB3> INFO: *** Today: 2015/12/16
[09:47:32.129] <TB3> INFO: *** Version: b2d3
[09:47:32.129] <TB3> INFO: readRocDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//005_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//005_HRData_150//dacParameters35_C15.dat
[09:47:32.130] <TB3> INFO: readTbmDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//005_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//005_HRData_150//tbmParameters_C0b.dat
[09:47:32.130] <TB3> INFO: readMaskFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//005_HRData_150//defaultMaskFile.dat
[09:47:32.130] <TB3> INFO: readTrimFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//005_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//005_HRData_150//trimParameters35_C15.dat
[09:47:32.215] <TB3> INFO: clk: 4
[09:47:32.215] <TB3> INFO: ctr: 4
[09:47:32.215] <TB3> INFO: sda: 19
[09:47:32.215] <TB3> INFO: tin: 9
[09:47:32.215] <TB3> INFO: level: 15
[09:47:32.215] <TB3> INFO: triggerdelay: 0
[09:47:32.215] <TB3> QUIET: Instanciating API for pxar prod-12
[09:47:32.215] <TB3> INFO: Log level: INFO
[09:47:32.229] <TB3> INFO: Found DTB DTB_WWV6Z5
[09:47:32.240] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[09:47:32.245] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[09:47:32.247] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[09:47:33.766] <TB3> INFO: DUT info:
[09:47:33.766] <TB3> INFO: The DUT currently contains the following objects:
[09:47:33.766] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[09:47:33.766] <TB3> INFO: TBM Core alpha (0): 7 registers set
[09:47:33.766] <TB3> INFO: TBM Core beta (1): 7 registers set
[09:47:33.766] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:47:33.766] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:33.766] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:33.766] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:33.766] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:33.766] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:33.766] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:33.766] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:33.766] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:33.766] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:33.766] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:33.766] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:33.767] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:33.767] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:33.767] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:33.767] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:33.767] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:34.168] <TB3> INFO: enter 'restricted' command line mode
[09:47:34.168] <TB3> INFO: enter test to run
[09:47:34.168] <TB3> INFO: test: delay setting parameters: ->5<-
[09:47:34.168] <TB3> INFO: delay test by 5 seconds...
[09:47:39.168] <TB3> INFO: enter test to run
[09:47:39.169] <TB3> INFO: test: Xray no parameter change
[09:47:39.169] <TB3> INFO: running: xray
[09:47:39.171] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//005_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//005_HRData_150//phCalibrationFitErr35_C15.dat
[09:47:39.336] <TB3> INFO: ######################################################################
[09:47:39.336] <TB3> INFO: PixTestXray::doTest()
[09:47:39.336] <TB3> INFO: ######################################################################
[09:47:39.336] <TB3> INFO: ----------------------------------------------------------------------
[09:47:39.336] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[09:47:39.336] <TB3> INFO: ----------------------------------------------------------------------
[09:47:40.302] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[09:47:44.178] <TB3> INFO: run duration 3 seconds, buffer almost full (81%), pausing triggers.
[09:48:12.895] <TB3> INFO: Resuming triggers.
[09:48:16.785] <TB3> INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[09:48:44.405] <TB3> INFO: Resuming triggers.
[09:48:48.295] <TB3> INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[09:49:17.497] <TB3> INFO: Resuming triggers.
[09:49:21.384] <TB3> INFO: run duration 15 seconds, buffer almost full (81%), pausing triggers.
[09:49:50.717] <TB3> INFO: Resuming triggers.
[09:49:54.605] <TB3> INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[09:50:25.129] <TB3> INFO: Resuming triggers.
[09:50:29.018] <TB3> INFO: run duration 23 seconds, buffer almost full (81%), pausing triggers.
[09:50:58.645] <TB3> INFO: Resuming triggers.
[09:51:02.527] <TB3> INFO: run duration 27 seconds, buffer almost full (81%), pausing triggers.
[09:51:31.355] <TB3> INFO: Resuming triggers.
[09:51:35.239] <TB3> INFO: run duration 31 seconds, buffer almost full (81%), pausing triggers.
[09:52:04.882] <TB3> INFO: Resuming triggers.
[09:52:08.769] <TB3> INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[09:52:37.739] <TB3> INFO: Resuming triggers.
[09:52:41.621] <TB3> INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[09:53:10.859] <TB3> INFO: Resuming triggers.
[09:53:14.741] <TB3> INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[09:53:43.486] <TB3> INFO: Resuming triggers.
[09:53:47.367] <TB3> INFO: run duration 46 seconds, buffer almost full (81%), pausing triggers.
[09:54:16.733] <TB3> INFO: Resuming triggers.
[09:54:20.613] <TB3> INFO: run duration 50 seconds, buffer almost full (81%), pausing triggers.
[09:54:49.463] <TB3> INFO: Resuming triggers.
[09:54:53.349] <TB3> INFO: run duration 54 seconds, buffer almost full (81%), pausing triggers.
[09:55:21.608] <TB3> INFO: Resuming triggers.
[09:55:25.493] <TB3> INFO: run duration 58 seconds, buffer almost full (81%), pausing triggers.
[09:55:54.703] <TB3> INFO: Resuming triggers.
[09:55:58.588] <TB3> INFO: run duration 62 seconds, buffer almost full (81%), pausing triggers.
[09:56:28.456] <TB3> INFO: Resuming triggers.
[09:56:32.338] <TB3> INFO: run duration 65 seconds, buffer almost full (81%), pausing triggers.
[09:57:01.471] <TB3> INFO: Resuming triggers.
[09:57:05.349] <TB3> INFO: run duration 69 seconds, buffer almost full (81%), pausing triggers.
[09:57:33.792] <TB3> INFO: Resuming triggers.
[09:57:37.674] <TB3> INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[09:58:06.967] <TB3> INFO: Resuming triggers.
[09:58:10.847] <TB3> INFO: run duration 77 seconds, buffer almost full (81%), pausing triggers.
[09:58:39.863] <TB3> INFO: Resuming triggers.
[09:58:43.742] <TB3> INFO: run duration 81 seconds, buffer almost full (81%), pausing triggers.
[09:59:12.492] <TB3> INFO: Resuming triggers.
[09:59:16.375] <TB3> INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[09:59:44.669] <TB3> INFO: Resuming triggers.
[09:59:48.546] <TB3> INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[10:00:17.962] <TB3> INFO: Resuming triggers.
[10:00:21.842] <TB3> INFO: run duration 93 seconds, buffer almost full (81%), pausing triggers.
[10:00:51.374] <TB3> INFO: Resuming triggers.
[10:00:55.250] <TB3> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[10:01:24.367] <TB3> INFO: Resuming triggers.
[10:01:27.385] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[10:01:49.645] <TB3> INFO: PixTest:: pg_setup set to default.
[10:01:49.646] <TB3> INFO: PixTestXray::doPhRun() done
[10:01:49.646] <TB3> INFO: PixTestXray::doTest() done
[10:01:49.843] <TB3> INFO: enter test to run
[10:01:49.843] <TB3> INFO: test: no parameter change
[10:01:49.988] <TB3> QUIET: Connection to board 121 closed.
[10:01:50.073] <TB3> INFO: pXar: this is the end, my friend

[10:05:07.557] <TB3> INFO: *** Welcome to pxar ***
[10:05:07.557] <TB3> INFO: *** Today: 2015/12/16
[10:05:07.629] <TB3> INFO: *** Version: b2d3
[10:05:07.629] <TB3> INFO: readRocDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//006_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//006_HRSCurves_100//dacParameters35_C15.dat
[10:05:07.630] <TB3> INFO: readTbmDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//006_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//006_HRSCurves_100//tbmParameters_C0b.dat
[10:05:07.630] <TB3> INFO: readMaskFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//006_HRSCurves_100//defaultMaskFile.dat
[10:05:07.630] <TB3> INFO: readTrimFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//006_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//006_HRSCurves_100//trimParameters35_C15.dat
[10:05:07.722] <TB3> INFO: clk: 4
[10:05:07.722] <TB3> INFO: ctr: 4
[10:05:07.722] <TB3> INFO: sda: 19
[10:05:07.722] <TB3> INFO: tin: 9
[10:05:07.722] <TB3> INFO: level: 15
[10:05:07.722] <TB3> INFO: triggerdelay: 0
[10:05:07.722] <TB3> QUIET: Instanciating API for pxar prod-12
[10:05:07.722] <TB3> INFO: Log level: INFO
[10:05:07.735] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:05:07.747] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:05:07.750] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[10:05:07.753] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[10:05:09.273] <TB3> INFO: DUT info:
[10:05:09.273] <TB3> INFO: The DUT currently contains the following objects:
[10:05:09.273] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[10:05:09.274] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:05:09.274] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:05:09.274] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:05:09.274] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:09.274] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:09.274] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:09.274] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:09.274] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:09.274] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:09.274] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:09.274] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:09.274] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:09.274] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:09.274] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:09.274] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:09.274] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:09.274] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:09.274] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:09.274] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:09.675] <TB3> INFO: enter 'restricted' command line mode
[10:05:09.675] <TB3> INFO: enter test to run
[10:05:09.675] <TB3> INFO: test: Highrate no parameter change
[10:05:09.675] <TB3> INFO: running: highrate
[10:05:09.678] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//006_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//006_HRSCurves_100//phCalibrationFitErr35_C15.dat
[10:05:09.811] <TB3> INFO: ----------------------------------------------------------------------
[10:05:09.811] <TB3> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[10:05:09.812] <TB3> INFO: ----------------------------------------------------------------------
[10:05:09.816] <TB3> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 896 (plus default)
[10:05:09.827] <TB3> INFO: dacScan step from 15 .. 34
[10:05:09.827] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[10:05:09.827] <TB3> INFO: run 1 of 1
[10:05:10.425] <TB3> INFO: Expecting 4160000 events.
[10:05:44.535] <TB3> INFO: 487500 events read in total (33581ms).
[10:06:18.583] <TB3> INFO: 976500 events read in total (67629ms).
[10:06:51.600] <TB3> INFO: 1465500 events read in total (100646ms).
[10:07:25.546] <TB3> INFO: 1954600 events read in total (134592ms).
[10:08:00.032] <TB3> INFO: 2443350 events read in total (169078ms).
[10:08:33.014] <TB3> INFO: 2931800 events read in total (202060ms).
[10:09:05.630] <TB3> INFO: 3420300 events read in total (234676ms).
[10:09:38.007] <TB3> INFO: 3908450 events read in total (267053ms).
[10:09:55.351] <TB3> INFO: 4160000 events read in total (284397ms).
[10:09:55.625] <TB3> INFO: Test took 285797ms.
[10:09:57.600] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:10:02.204] <TB3> INFO: dacScan step from 35 .. 54
[10:10:02.204] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[10:10:02.204] <TB3> INFO: run 1 of 1
[10:10:02.807] <TB3> INFO: Expecting 4160000 events.
[10:10:35.714] <TB3> INFO: 399300 events read in total (32370ms).
[10:11:07.522] <TB3> INFO: 798900 events read in total (64178ms).
[10:11:39.866] <TB3> INFO: 1197550 events read in total (96522ms).
[10:12:11.794] <TB3> INFO: 1594800 events read in total (128450ms).
[10:12:44.375] <TB3> INFO: 1991050 events read in total (161031ms).
[10:13:16.912] <TB3> INFO: 2384750 events read in total (193568ms).
[10:13:49.032] <TB3> INFO: 2775600 events read in total (225688ms).
[10:14:21.257] <TB3> INFO: 3162850 events read in total (257913ms).
[10:14:53.634] <TB3> INFO: 3547500 events read in total (290290ms).
[10:15:24.900] <TB3> INFO: 3930800 events read in total (321556ms).
[10:15:43.872] <TB3> INFO: 4160000 events read in total (340528ms).
[10:15:44.043] <TB3> INFO: Test took 341838ms.
[10:15:45.496] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:15:50.497] <TB3> INFO: dacScan step from 55 .. 74
[10:15:50.497] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[10:15:50.497] <TB3> INFO: run 1 of 1
[10:15:51.127] <TB3> INFO: Expecting 4160000 events.
[10:16:23.114] <TB3> INFO: 355100 events read in total (31451ms).
[10:16:54.120] <TB3> INFO: 711050 events read in total (62457ms).
[10:17:25.260] <TB3> INFO: 1067300 events read in total (93597ms).
[10:17:56.707] <TB3> INFO: 1423500 events read in total (125044ms).
[10:18:27.868] <TB3> INFO: 1779650 events read in total (156205ms).
[10:18:58.336] <TB3> INFO: 2135800 events read in total (186673ms).
[10:19:30.113] <TB3> INFO: 2492000 events read in total (218450ms).
[10:20:01.391] <TB3> INFO: 2848250 events read in total (249728ms).
[10:20:32.586] <TB3> INFO: 3204500 events read in total (280923ms).
[10:21:03.793] <TB3> INFO: 3560800 events read in total (312130ms).
[10:21:35.121] <TB3> INFO: 3917000 events read in total (343458ms).
[10:21:56.135] <TB3> INFO: 4160000 events read in total (364472ms).
[10:21:56.301] <TB3> INFO: Test took 365804ms.
[10:21:57.731] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:22:02.724] <TB3> INFO: dacScan step from 75 .. 75
[10:22:02.724] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[10:22:02.724] <TB3> INFO: run 1 of 1
[10:22:03.318] <TB3> INFO: Expecting 208000 events.
[10:22:22.200] <TB3> INFO: 208000 events read in total (18355ms).
[10:22:22.207] <TB3> INFO: Test took 19483ms.
[10:22:22.273] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:22:22.497] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:22:23.825] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:22:24.897] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:22:25.991] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:22:27.090] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:22:28.268] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:22:29.404] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:22:30.496] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:22:31.694] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:22:32.944] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:22:34.223] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:22:35.472] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:22:36.697] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:22:37.893] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:22:39.018] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:22:40.078] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:22:41.268] <TB3> INFO: PixTest:: pg_setup set to default.
[10:22:41.270] <TB3> INFO: vcal mean: 37.57 37.76 37.46 40.58 40.24 41.66 40.47 41.39 42.95 42.02 41.98 40.71 39.79 37.82 38.20 37.99
[10:22:41.270] <TB3> INFO: vcal RMS: 0.96 1.03 0.84 1.30 1.09 1.34 1.28 1.43 1.47 1.41 1.45 1.44 1.23 1.16 1.02 1.04
[10:22:41.270] <TB3> INFO: number of X-ray hits detected: 145791 163677 144741 267642 289691 340024 287233 334584 384548 337842 348718 292682 258634 162589 174409 172253
[10:22:41.270] <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:41.270] <TB3> INFO: X-ray hit rate [MHz/cm2]: 42.7 48.0 42.4 78.4 84.9 99.7 84.2 98.1 112.7 99.0 102.2 85.8 75.8 47.7 51.1 50.5
[10:22:41.270] <TB3> INFO: PixTestHighRate::doXNoiseMaps() done
[10:22:41.392] <TB3> INFO: enter test to run
[10:22:41.392] <TB3> INFO: test: no parameter change
[10:22:41.492] <TB3> QUIET: Connection to board 121 closed.
[10:22:41.571] <TB3> INFO: pXar: this is the end, my friend

[11:47:33.294] <TB3> INFO: *** Welcome to pxar ***
[11:47:33.294] <TB3> INFO: *** Today: 2015/12/16
[11:47:33.372] <TB3> INFO: *** Version: b2d3
[11:47:33.372] <TB3> INFO: readRocDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[11:47:33.374] <TB3> INFO: readTbmDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[11:47:33.374] <TB3> INFO: readMaskFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[11:47:33.374] <TB3> INFO: readTrimFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[11:47:33.446] <TB3> INFO: clk: 4
[11:47:33.446] <TB3> INFO: ctr: 4
[11:47:33.446] <TB3> INFO: sda: 19
[11:47:33.446] <TB3> INFO: tin: 9
[11:47:33.446] <TB3> INFO: level: 15
[11:47:33.446] <TB3> INFO: triggerdelay: 0
[11:47:33.446] <TB3> QUIET: Instanciating API for pxar prod-12
[11:47:33.446] <TB3> INFO: Log level: INFO
[11:47:33.461] <TB3> INFO: Found DTB DTB_WWV6Z5
[11:47:33.473] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[11:47:33.476] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[11:47:33.478] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[11:47:35.012] <TB3> INFO: DUT info:
[11:47:35.012] <TB3> INFO: The DUT currently contains the following objects:
[11:47:35.012] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[11:47:35.012] <TB3> INFO: TBM Core alpha (0): 7 registers set
[11:47:35.012] <TB3> INFO: TBM Core beta (1): 7 registers set
[11:47:35.012] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:47:35.012] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:35.012] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:35.012] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:35.012] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:35.012] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:35.012] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:35.012] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:35.012] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:35.012] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:35.012] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:35.012] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:35.012] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:35.012] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:35.012] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:35.012] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:35.012] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:35.413] <TB3> INFO: enter 'restricted' command line mode
[11:47:35.413] <TB3> INFO: enter test to run
[11:47:35.413] <TB3> INFO: test: HighRate no parameter change
[11:47:35.413] <TB3> INFO: running: highrate
[11:47:35.417] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[11:47:35.597] <TB3> INFO: ----------------------------------------------------------------------
[11:47:35.597] <TB3> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[11:47:35.597] <TB3> INFO: ----------------------------------------------------------------------
[11:47:35.734] <TB3> INFO: Expecting 768 events.
[11:47:36.961] <TB3> INFO: 768 events read in total (509ms).
[11:47:37.056] <TB3> INFO: Test took 1455ms.
[11:47:37.686] <TB3> INFO: Expecting 41600 events.
[11:47:41.699] <TB3> INFO: 41600 events read in total (3486ms).
[11:47:41.701] <TB3> INFO: Test took 4641ms.
[11:47:41.776] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:47:42.417] <TB3> INFO: Expecting 41600 events.
[11:47:46.469] <TB3> INFO: 41600 events read in total (3524ms).
[11:47:46.471] <TB3> INFO: Test took 4667ms.
[11:47:46.542] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:47:47.186] <TB3> INFO: Expecting 41600 events.
[11:47:51.229] <TB3> INFO: 41600 events read in total (3516ms).
[11:47:51.232] <TB3> INFO: Test took 4658ms.
[11:47:51.303] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:47:51.953] <TB3> INFO: Expecting 41600 events.
[11:47:56.024] <TB3> INFO: 41600 events read in total (3544ms).
[11:47:56.025] <TB3> INFO: Test took 4693ms.
[11:47:56.091] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:47:56.728] <TB3> INFO: Expecting 41600 events.
[11:48:00.711] <TB3> INFO: 41600 events read in total (3456ms).
[11:48:00.712] <TB3> INFO: Test took 4596ms.
[11:48:00.790] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:01.430] <TB3> INFO: Expecting 41600 events.
[11:48:05.536] <TB3> INFO: 41600 events read in total (3579ms).
[11:48:05.537] <TB3> INFO: Test took 4719ms.
[11:48:05.606] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:06.263] <TB3> INFO: Expecting 41600 events.
[11:48:10.299] <TB3> INFO: 41600 events read in total (3509ms).
[11:48:10.301] <TB3> INFO: Test took 4664ms.
[11:48:10.366] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:11.004] <TB3> INFO: Expecting 41600 events.
[11:48:15.107] <TB3> INFO: 41600 events read in total (3575ms).
[11:48:15.108] <TB3> INFO: Test took 4716ms.
[11:48:15.183] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:15.834] <TB3> INFO: Expecting 41600 events.
[11:48:19.870] <TB3> INFO: 41600 events read in total (3509ms).
[11:48:19.871] <TB3> INFO: Test took 4661ms.
[11:48:19.938] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:20.586] <TB3> INFO: Expecting 41600 events.
[11:48:24.786] <TB3> INFO: 41600 events read in total (3673ms).
[11:48:24.787] <TB3> INFO: Test took 4821ms.
[11:48:24.860] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:25.507] <TB3> INFO: Expecting 41600 events.
[11:48:29.631] <TB3> INFO: 41600 events read in total (3597ms).
[11:48:29.632] <TB3> INFO: Test took 4742ms.
[11:48:29.706] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:30.361] <TB3> INFO: Expecting 41600 events.
[11:48:34.508] <TB3> INFO: 41600 events read in total (3620ms).
[11:48:34.510] <TB3> INFO: Test took 4771ms.
[11:48:34.581] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:35.236] <TB3> INFO: Expecting 41600 events.
[11:48:39.211] <TB3> INFO: 41600 events read in total (3448ms).
[11:48:39.212] <TB3> INFO: Test took 4598ms.
[11:48:39.284] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:39.929] <TB3> INFO: Expecting 41600 events.
[11:48:43.984] <TB3> INFO: 41600 events read in total (3528ms).
[11:48:43.985] <TB3> INFO: Test took 4668ms.
[11:48:44.051] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:44.709] <TB3> INFO: Expecting 41600 events.
[11:48:48.928] <TB3> INFO: 41600 events read in total (3692ms).
[11:48:48.929] <TB3> INFO: Test took 4846ms.
[11:48:48.998] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:49.638] <TB3> INFO: Expecting 41600 events.
[11:48:53.632] <TB3> INFO: 41600 events read in total (3467ms).
[11:48:53.634] <TB3> INFO: Test took 4610ms.
[11:48:53.699] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:54.339] <TB3> INFO: Expecting 41600 events.
[11:48:58.379] <TB3> INFO: 41600 events read in total (3513ms).
[11:48:58.381] <TB3> INFO: Test took 4655ms.
[11:48:58.448] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:59.086] <TB3> INFO: Expecting 41600 events.
[11:49:03.112] <TB3> INFO: 41600 events read in total (3499ms).
[11:49:03.113] <TB3> INFO: Test took 4640ms.
[11:49:03.187] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:49:03.825] <TB3> INFO: Expecting 41600 events.
[11:49:07.413] <TB3> INFO: 41600 events read in total (3061ms).
[11:49:07.415] <TB3> INFO: Test took 4201ms.
[11:49:07.478] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:49:08.114] <TB3> INFO: Expecting 41600 events.
[11:49:11.772] <TB3> INFO: 41600 events read in total (3131ms).
[11:49:11.773] <TB3> INFO: Test took 4270ms.
[11:49:11.834] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:49:12.135] <TB3> INFO: enter test to run
[11:49:12.135] <TB3> INFO: test: Pretest no parameter change
[11:49:12.135] <TB3> INFO: running: pretest
[11:49:12.135] <TB3> INFO: write dac parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[11:49:12.135] <TB3> INFO: write dac parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[11:49:12.135] <TB3> INFO: write dac parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[11:49:12.135] <TB3> INFO: write dac parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[11:49:12.135] <TB3> INFO: write dac parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[11:49:12.135] <TB3> INFO: write dac parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[11:49:12.136] <TB3> INFO: write dac parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[11:49:12.136] <TB3> INFO: write dac parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[11:49:12.136] <TB3> INFO: write dac parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[11:49:12.136] <TB3> INFO: write dac parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[11:49:12.136] <TB3> INFO: write dac parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[11:49:12.136] <TB3> INFO: write dac parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[11:49:12.136] <TB3> INFO: write dac parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[11:49:12.136] <TB3> INFO: write dac parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[11:49:12.136] <TB3> INFO: write dac parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[11:49:12.136] <TB3> INFO: write dac parameters into /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[11:49:12.136] <TB3> INFO: enter test to run
[11:49:12.136] <TB3> INFO: test: no parameter change
[11:49:12.240] <TB3> QUIET: Connection to board 121 closed.
[11:49:12.321] <TB3> INFO: pXar: this is the end, my friend

[11:49:47.495] <TB3> INFO: *** Welcome to pxar ***
[11:49:47.495] <TB3> INFO: *** Today: 2015/12/16
[11:49:47.557] <TB3> INFO: *** Version: b2d3
[11:49:47.557] <TB3> INFO: readRocDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//012_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//012_HREfficiency_50//dacParameters35_C15.dat
[11:49:47.558] <TB3> INFO: readTbmDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//012_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//012_HREfficiency_50//tbmParameters_C0b.dat
[11:49:47.558] <TB3> INFO: readMaskFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//012_HREfficiency_50//defaultMaskFile.dat
[11:49:47.558] <TB3> INFO: readTrimFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//012_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//012_HREfficiency_50//trimParameters35_C15.dat
[11:49:47.631] <TB3> INFO: clk: 4
[11:49:47.631] <TB3> INFO: ctr: 4
[11:49:47.631] <TB3> INFO: sda: 19
[11:49:47.631] <TB3> INFO: tin: 9
[11:49:47.631] <TB3> INFO: level: 15
[11:49:47.631] <TB3> INFO: triggerdelay: 0
[11:49:47.631] <TB3> QUIET: Instanciating API for pxar prod-12
[11:49:47.631] <TB3> INFO: Log level: INFO
[11:49:47.644] <TB3> INFO: Found DTB DTB_WWV6Z5
[11:49:47.655] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[11:49:47.658] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[11:49:47.661] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[11:49:49.212] <TB3> INFO: DUT info:
[11:49:49.212] <TB3> INFO: The DUT currently contains the following objects:
[11:49:49.212] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[11:49:49.212] <TB3> INFO: TBM Core alpha (0): 7 registers set
[11:49:49.212] <TB3> INFO: TBM Core beta (1): 7 registers set
[11:49:49.212] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:49:49.212] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:49.212] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:49.212] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:49.212] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:49.212] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:49.212] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:49.212] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:49.212] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:49.212] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:49.212] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:49.212] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:49.212] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:49.212] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:49.212] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:49.213] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:49.213] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:49.613] <TB3> INFO: enter 'restricted' command line mode
[11:49:49.613] <TB3> INFO: enter test to run
[11:49:49.613] <TB3> INFO: test: PixelAlive no parameter change
[11:49:49.613] <TB3> INFO: running: pixelalive
[11:49:49.621] <TB3> INFO: ######################################################################
[11:49:49.621] <TB3> INFO: PixTestAlive::doTest()
[11:49:49.621] <TB3> INFO: ######################################################################
[11:49:49.623] <TB3> INFO: ----------------------------------------------------------------------
[11:49:49.623] <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)
[11:49:49.623] <TB3> INFO: ----------------------------------------------------------------------
[11:49:49.958] <TB3> INFO: Expecting 208000 events.
[11:50:02.178] <TB3> INFO: 208000 events read in total (11502ms).
[11:50:02.196] <TB3> INFO: Test took 12571ms.
[11:50:02.207] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:50:02.463] <TB3> INFO: PixTestAlive::aliveTest() done
[11:50:02.463] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:50:02.464] <TB3> INFO: ----------------------------------------------------------------------
[11:50:02.464] <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)
[11:50:02.465] <TB3> INFO: ----------------------------------------------------------------------
[11:50:02.777] <TB3> INFO: Expecting 208000 events.
[11:50:10.397] <TB3> INFO: 208000 events read in total (6905ms).
[11:50:10.397] <TB3> INFO: Test took 7931ms.
[11:50:10.397] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:50:10.398] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:50:10.703] <TB3> INFO: PixTestAlive::maskTest() done
[11:50:10.703] <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
[11:50:10.704] <TB3> INFO: ----------------------------------------------------------------------
[11:50:10.704] <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)
[11:50:10.704] <TB3> INFO: ----------------------------------------------------------------------
[11:50:11.008] <TB3> INFO: Expecting 208000 events.
[11:50:23.121] <TB3> INFO: 208000 events read in total (11397ms).
[11:50:23.122] <TB3> INFO: Test took 12416ms.
[11:50:23.130] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:50:23.348] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[11:50:23.348] <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
[11:50:23.348] <TB3> INFO: PixTestAlive::doTest() done, duration: 33 seconds
[11:50:23.383] <TB3> INFO: enter test to run
[11:50:23.383] <TB3> INFO: test: delay setting parameters: ->2<-
[11:50:23.383] <TB3> INFO: delay test by 2 seconds...
[11:50:25.384] <TB3> INFO: enter test to run
[11:50:25.384] <TB3> INFO: test: HighRate no parameter change
[11:50:25.384] <TB3> INFO: running: highrate
[11:50:25.384] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//012_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//012_HREfficiency_50//phCalibrationFitErr35_C15.dat
[11:50:25.526] <TB3> INFO: ----------------------------------------------------------------------
[11:50:25.526] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:50:25.526] <TB3> INFO: ----------------------------------------------------------------------
[11:50:26.176] <TB3> INFO: Expecting 208000 events.
[11:50:40.026] <TB3> INFO: 208000 events read in total (13323ms).
[11:50:40.030] <TB3> INFO: Test took 14501ms.
[11:50:40.265] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:50:40.535] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:50:40.535] <TB3> INFO: number of red-efficiency pixels: 87 103 94 179 214 235 206 231 338 259 255 189 189 94 101 123
[11:50:40.535] <TB3> INFO: number of X-ray hits detected: 71549 79346 69472 133378 144466 173462 143514 168589 193065 170030 175226 144545 128614 79443 84649 85790
[11:50:40.535] <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
[11:50:40.535] <TB3> INFO: number of Vcal hits detected: 207913 207895 207903 207819 207779 207756 207790 207764 207646 207731 207737 207808 207805 207903 207897 207874
[11:50:40.535] <TB3> INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 100.0 99.9 99.9 99.9 99.9 99.9 99.8 99.9 99.9 99.9 99.9 100.0 100.0 99.9
[11:50:40.535] <TB3> INFO: Vcal hit overall efficiency (%): 100.0 99.9 100.0 99.9 99.9 99.9 99.9 99.9 99.8 99.9 99.9 99.9 99.9 100.0 100.0 99.9
[11:50:40.535] <TB3> INFO: X-ray hit rate [MHz/cm2]: 21.0 23.3 20.4 39.1 42.3 50.8 42.1 49.4 56.6 49.8 51.4 42.4 37.7 23.3 24.8 25.1
[11:50:40.535] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[11:50:40.561] <TB3> INFO: PixTest:: pg_setup set to default.
[11:50:40.569] <TB3> INFO: enter test to run
[11:50:40.569] <TB3> INFO: test: no parameter change
[11:50:40.656] <TB3> QUIET: Connection to board 121 closed.
[11:50:40.735] <TB3> INFO: pXar: this is the end, my friend

[11:51:14.203] <TB3> INFO: *** Welcome to pxar ***
[11:51:14.203] <TB3> INFO: *** Today: 2015/12/16
[11:51:14.279] <TB3> INFO: *** Version: b2d3
[11:51:14.279] <TB3> INFO: readRocDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//013_HREfficiency_75//dacParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//013_HREfficiency_75//dacParameters35_C15.dat
[11:51:14.280] <TB3> INFO: readTbmDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//013_HREfficiency_75//tbmParameters_C0a.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//013_HREfficiency_75//tbmParameters_C0b.dat
[11:51:14.280] <TB3> INFO: readMaskFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//013_HREfficiency_75//defaultMaskFile.dat
[11:51:14.280] <TB3> INFO: readTrimFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//013_HREfficiency_75//trimParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//013_HREfficiency_75//trimParameters35_C15.dat
[11:51:14.371] <TB3> INFO: clk: 4
[11:51:14.371] <TB3> INFO: ctr: 4
[11:51:14.371] <TB3> INFO: sda: 19
[11:51:14.371] <TB3> INFO: tin: 9
[11:51:14.371] <TB3> INFO: level: 15
[11:51:14.371] <TB3> INFO: triggerdelay: 0
[11:51:14.371] <TB3> QUIET: Instanciating API for pxar prod-12
[11:51:14.371] <TB3> INFO: Log level: INFO
[11:51:14.385] <TB3> INFO: Found DTB DTB_WWV6Z5
[11:51:14.396] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[11:51:14.399] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[11:51:14.401] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[11:51:15.935] <TB3> INFO: DUT info:
[11:51:15.935] <TB3> INFO: The DUT currently contains the following objects:
[11:51:15.935] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[11:51:15.935] <TB3> INFO: TBM Core alpha (0): 7 registers set
[11:51:15.936] <TB3> INFO: TBM Core beta (1): 7 registers set
[11:51:15.936] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:51:15.936] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:51:15.936] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:51:15.936] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:51:15.936] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:51:15.936] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:51:15.936] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:51:15.936] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:51:15.936] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:51:15.936] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:51:15.936] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:51:15.936] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:51:15.936] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:51:15.936] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:51:15.936] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:51:15.936] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:51:15.936] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:51:16.337] <TB3> INFO: enter 'restricted' command line mode
[11:51:16.337] <TB3> INFO: enter test to run
[11:51:16.337] <TB3> INFO: test: PixelAlive no parameter change
[11:51:16.337] <TB3> INFO: running: pixelalive
[11:51:16.343] <TB3> INFO: ######################################################################
[11:51:16.343] <TB3> INFO: PixTestAlive::doTest()
[11:51:16.343] <TB3> INFO: ######################################################################
[11:51:16.345] <TB3> INFO: ----------------------------------------------------------------------
[11:51:16.345] <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)
[11:51:16.345] <TB3> INFO: ----------------------------------------------------------------------
[11:51:16.656] <TB3> INFO: Expecting 208000 events.
[11:51:28.764] <TB3> INFO: 208000 events read in total (11390ms).
[11:51:28.776] <TB3> INFO: Test took 12430ms.
[11:51:28.789] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:51:29.041] <TB3> INFO: PixTestAlive::aliveTest() done
[11:51:29.041] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:51:29.043] <TB3> INFO: ----------------------------------------------------------------------
[11:51:29.043] <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)
[11:51:29.043] <TB3> INFO: ----------------------------------------------------------------------
[11:51:29.364] <TB3> INFO: Expecting 208000 events.
[11:51:37.159] <TB3> INFO: 208000 events read in total (7078ms).
[11:51:37.160] <TB3> INFO: Test took 8115ms.
[11:51:37.160] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:51:37.161] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:51:37.470] <TB3> INFO: PixTestAlive::maskTest() done
[11:51:37.470] <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
[11:51:37.472] <TB3> INFO: ----------------------------------------------------------------------
[11:51:37.472] <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)
[11:51:37.472] <TB3> INFO: ----------------------------------------------------------------------
[11:51:37.805] <TB3> INFO: Expecting 208000 events.
[11:51:49.383] <TB3> INFO: 208000 events read in total (10862ms).
[11:51:49.384] <TB3> INFO: Test took 11911ms.
[11:51:49.393] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:51:49.627] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[11:51:49.627] <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
[11:51:49.627] <TB3> INFO: PixTestAlive::doTest() done, duration: 33 seconds
[11:51:49.668] <TB3> INFO: enter test to run
[11:51:49.668] <TB3> INFO: test: delay setting parameters: ->2<-
[11:51:49.668] <TB3> INFO: delay test by 2 seconds...
[11:51:51.668] <TB3> INFO: enter test to run
[11:51:51.668] <TB3> INFO: test: HighRate no parameter change
[11:51:51.668] <TB3> INFO: running: highrate
[11:51:51.668] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//013_HREfficiency_75//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//013_HREfficiency_75//phCalibrationFitErr35_C15.dat
[11:51:51.832] <TB3> INFO: ----------------------------------------------------------------------
[11:51:51.832] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:51:51.832] <TB3> INFO: ----------------------------------------------------------------------
[11:51:52.493] <TB3> INFO: Expecting 208000 events.
[11:52:10.594] <TB3> INFO: 208000 events read in total (17574ms).
[11:52:10.600] <TB3> INFO: Test took 18765ms.
[11:52:10.933] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:52:11.240] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:52:11.240] <TB3> INFO: number of red-efficiency pixels: 170 149 162 300 429 465 358 503 636 497 514 348 309 201 163 182
[11:52:11.240] <TB3> INFO: number of X-ray hits detected: 106002 117409 103466 197493 212239 252700 210949 245774 281912 250226 257412 212648 189159 117703 125375 126254
[11:52:11.240] <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
[11:52:11.240] <TB3> INFO: number of Vcal hits detected: 207824 207831 207822 207681 207546 207486 207622 207470 207282 207444 207443 207628 207675 207791 207833 207809
[11:52:11.240] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.7 99.8 99.8 99.8 99.9 99.9 99.9 99.9
[11:52:11.240] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.7 99.7 99.7 99.7 99.8 99.8 99.9 99.9 99.9
[11:52:11.240] <TB3> INFO: X-ray hit rate [MHz/cm2]: 31.1 34.4 30.3 57.9 62.2 74.1 61.8 72.0 82.6 73.3 75.4 62.3 55.4 34.5 36.7 37.0
[11:52:11.240] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[11:52:11.267] <TB3> INFO: PixTest:: pg_setup set to default.
[11:52:11.278] <TB3> INFO: enter test to run
[11:52:11.278] <TB3> INFO: test: no parameter change
[11:52:11.360] <TB3> QUIET: Connection to board 121 closed.
[11:52:11.439] <TB3> INFO: pXar: this is the end, my friend

[11:53:19.345] <TB3> INFO: *** Welcome to pxar ***
[11:53:19.345] <TB3> INFO: *** Today: 2015/12/16
[11:53:19.406] <TB3> INFO: *** Version: b2d3
[11:53:19.406] <TB3> INFO: readRocDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//014_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//014_HREfficiency_100//dacParameters35_C15.dat
[11:53:19.407] <TB3> INFO: readTbmDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//014_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//014_HREfficiency_100//tbmParameters_C0b.dat
[11:53:19.407] <TB3> INFO: readMaskFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//014_HREfficiency_100//defaultMaskFile.dat
[11:53:19.407] <TB3> INFO: readTrimFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//014_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//014_HREfficiency_100//trimParameters35_C15.dat
[11:53:19.494] <TB3> INFO: clk: 4
[11:53:19.494] <TB3> INFO: ctr: 4
[11:53:19.494] <TB3> INFO: sda: 19
[11:53:19.494] <TB3> INFO: tin: 9
[11:53:19.494] <TB3> INFO: level: 15
[11:53:19.494] <TB3> INFO: triggerdelay: 0
[11:53:19.494] <TB3> QUIET: Instanciating API for pxar prod-12
[11:53:19.494] <TB3> INFO: Log level: INFO
[11:53:19.508] <TB3> INFO: Found DTB DTB_WWV6Z5
[11:53:19.520] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[11:53:19.523] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[11:53:19.525] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[11:53:21.053] <TB3> INFO: DUT info:
[11:53:21.053] <TB3> INFO: The DUT currently contains the following objects:
[11:53:21.053] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[11:53:21.053] <TB3> INFO: TBM Core alpha (0): 7 registers set
[11:53:21.053] <TB3> INFO: TBM Core beta (1): 7 registers set
[11:53:21.053] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:53:21.053] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:21.054] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:21.054] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:21.054] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:21.054] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:21.054] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:21.054] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:21.054] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:21.054] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:21.054] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:21.054] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:21.054] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:21.054] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:21.054] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:21.054] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:21.054] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:21.455] <TB3> INFO: enter 'restricted' command line mode
[11:53:21.455] <TB3> INFO: enter test to run
[11:53:21.455] <TB3> INFO: test: PixelAlive no parameter change
[11:53:21.455] <TB3> INFO: running: pixelalive
[11:53:21.460] <TB3> INFO: ######################################################################
[11:53:21.460] <TB3> INFO: PixTestAlive::doTest()
[11:53:21.460] <TB3> INFO: ######################################################################
[11:53:21.461] <TB3> INFO: ----------------------------------------------------------------------
[11:53:21.461] <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)
[11:53:21.461] <TB3> INFO: ----------------------------------------------------------------------
[11:53:21.777] <TB3> INFO: Expecting 208000 events.
[11:53:34.058] <TB3> INFO: 208000 events read in total (11563ms).
[11:53:34.060] <TB3> INFO: Test took 12597ms.
[11:53:34.067] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:53:34.331] <TB3> INFO: PixTestAlive::aliveTest() done
[11:53:34.331] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:53:34.332] <TB3> INFO: ----------------------------------------------------------------------
[11:53:34.332] <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)
[11:53:34.332] <TB3> INFO: ----------------------------------------------------------------------
[11:53:34.677] <TB3> INFO: Expecting 208000 events.
[11:53:42.174] <TB3> INFO: 208000 events read in total (6781ms).
[11:53:42.174] <TB3> INFO: Test took 7840ms.
[11:53:42.175] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:53:42.175] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:53:42.487] <TB3> INFO: PixTestAlive::maskTest() done
[11:53:42.487] <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
[11:53:42.489] <TB3> INFO: ----------------------------------------------------------------------
[11:53:42.489] <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)
[11:53:42.489] <TB3> INFO: ----------------------------------------------------------------------
[11:53:42.827] <TB3> INFO: Expecting 208000 events.
[11:53:54.501] <TB3> INFO: 208000 events read in total (10958ms).
[11:53:54.501] <TB3> INFO: Test took 12010ms.
[11:53:54.508] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:53:54.739] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[11:53:54.739] <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
[11:53:54.739] <TB3> INFO: PixTestAlive::doTest() done, duration: 33 seconds
[11:53:54.776] <TB3> INFO: enter test to run
[11:53:54.776] <TB3> INFO: test: delay setting parameters: ->2<-
[11:53:54.776] <TB3> INFO: delay test by 2 seconds...
[11:53:56.776] <TB3> INFO: enter test to run
[11:53:56.776] <TB3> INFO: test: HighRate no parameter change
[11:53:56.776] <TB3> INFO: running: highrate
[11:53:56.776] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//014_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//014_HREfficiency_100//phCalibrationFitErr35_C15.dat
[11:53:56.951] <TB3> INFO: ----------------------------------------------------------------------
[11:53:56.951] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:53:56.951] <TB3> INFO: ----------------------------------------------------------------------
[11:53:57.582] <TB3> INFO: Expecting 208000 events.
[11:54:17.594] <TB3> INFO: 208000 events read in total (19485ms).
[11:54:17.603] <TB3> INFO: Test took 20648ms.
[11:54:18.059] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:54:18.405] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:54:18.405] <TB3> INFO: number of red-efficiency pixels: 272 234 281 566 725 904 641 826 1129 860 873 654 508 300 272 310
[11:54:18.405] <TB3> INFO: number of X-ray hits detected: 148018 163623 144362 269181 289643 343259 289738 336621 386105 342391 348874 293401 260615 163982 174788 174480
[11:54:18.405] <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
[11:54:18.405] <TB3> INFO: number of Vcal hits detected: 207715 207742 207695 207377 207146 206924 207264 207034 206617 206972 206956 207257 207447 207678 207716 207676
[11:54:18.405] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.7 99.6 99.5 99.7 99.6 99.4 99.6 99.6 99.7 99.8 99.9 99.9 99.9
[11:54:18.405] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.7 99.6 99.5 99.6 99.5 99.3 99.5 99.5 99.6 99.7 99.8 99.9 99.8
[11:54:18.405] <TB3> INFO: X-ray hit rate [MHz/cm2]: 43.4 48.0 42.3 78.9 84.9 100.6 84.9 98.7 113.2 100.4 102.3 86.0 76.4 48.1 51.2 51.1
[11:54:18.405] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[11:54:18.437] <TB3> INFO: PixTest:: pg_setup set to default.
[11:54:18.452] <TB3> INFO: enter test to run
[11:54:18.452] <TB3> INFO: test: no parameter change
[11:54:18.542] <TB3> QUIET: Connection to board 121 closed.
[11:54:18.621] <TB3> INFO: pXar: this is the end, my friend

[11:55:45.475] <TB3> INFO: *** Welcome to pxar ***
[11:55:45.475] <TB3> INFO: *** Today: 2015/12/16
[11:55:45.539] <TB3> INFO: *** Version: b2d3
[11:55:45.539] <TB3> INFO: readRocDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//015_HREfficiency_125//dacParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//015_HREfficiency_125//dacParameters35_C15.dat
[11:55:45.540] <TB3> INFO: readTbmDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//015_HREfficiency_125//tbmParameters_C0a.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//015_HREfficiency_125//tbmParameters_C0b.dat
[11:55:45.540] <TB3> INFO: readMaskFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//015_HREfficiency_125//defaultMaskFile.dat
[11:55:45.541] <TB3> INFO: readTrimFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//015_HREfficiency_125//trimParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//015_HREfficiency_125//trimParameters35_C15.dat
[11:55:45.632] <TB3> INFO: clk: 4
[11:55:45.632] <TB3> INFO: ctr: 4
[11:55:45.632] <TB3> INFO: sda: 19
[11:55:45.632] <TB3> INFO: tin: 9
[11:55:45.632] <TB3> INFO: level: 15
[11:55:45.632] <TB3> INFO: triggerdelay: 0
[11:55:45.632] <TB3> QUIET: Instanciating API for pxar prod-12
[11:55:45.632] <TB3> INFO: Log level: INFO
[11:55:45.645] <TB3> INFO: Found DTB DTB_WWV6Z5
[11:55:45.656] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[11:55:45.659] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[11:55:45.662] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[11:55:47.209] <TB3> INFO: DUT info:
[11:55:47.209] <TB3> INFO: The DUT currently contains the following objects:
[11:55:47.209] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[11:55:47.209] <TB3> INFO: TBM Core alpha (0): 7 registers set
[11:55:47.209] <TB3> INFO: TBM Core beta (1): 7 registers set
[11:55:47.209] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:55:47.209] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:47.209] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:47.209] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:47.210] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:47.210] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:47.210] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:47.210] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:47.210] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:47.210] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:47.210] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:47.210] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:47.210] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:47.210] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:47.210] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:47.210] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:47.210] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:47.611] <TB3> INFO: enter 'restricted' command line mode
[11:55:47.611] <TB3> INFO: enter test to run
[11:55:47.611] <TB3> INFO: test: PixelAlive no parameter change
[11:55:47.611] <TB3> INFO: running: pixelalive
[11:55:47.617] <TB3> INFO: ######################################################################
[11:55:47.617] <TB3> INFO: PixTestAlive::doTest()
[11:55:47.617] <TB3> INFO: ######################################################################
[11:55:47.618] <TB3> INFO: ----------------------------------------------------------------------
[11:55:47.618] <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)
[11:55:47.618] <TB3> INFO: ----------------------------------------------------------------------
[11:55:47.939] <TB3> INFO: Expecting 208000 events.
[11:56:00.432] <TB3> INFO: 208000 events read in total (11775ms).
[11:56:00.434] <TB3> INFO: Test took 12814ms.
[11:56:00.441] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:56:00.710] <TB3> INFO: PixTestAlive::aliveTest() done
[11:56:00.710] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:56:00.712] <TB3> INFO: ----------------------------------------------------------------------
[11:56:00.712] <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)
[11:56:00.712] <TB3> INFO: ----------------------------------------------------------------------
[11:56:01.054] <TB3> INFO: Expecting 208000 events.
[11:56:08.726] <TB3> INFO: 208000 events read in total (6956ms).
[11:56:08.726] <TB3> INFO: Test took 8012ms.
[11:56:08.726] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:56:08.727] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:56:09.039] <TB3> INFO: PixTestAlive::maskTest() done
[11:56:09.039] <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
[11:56:09.041] <TB3> INFO: ----------------------------------------------------------------------
[11:56:09.041] <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)
[11:56:09.041] <TB3> INFO: ----------------------------------------------------------------------
[11:56:09.377] <TB3> INFO: Expecting 208000 events.
[11:56:21.243] <TB3> INFO: 208000 events read in total (11151ms).
[11:56:21.243] <TB3> INFO: Test took 12200ms.
[11:56:21.250] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:56:21.481] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[11:56:21.481] <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
[11:56:21.482] <TB3> INFO: PixTestAlive::doTest() done, duration: 33 seconds
[11:56:21.520] <TB3> INFO: enter test to run
[11:56:21.520] <TB3> INFO: test: delay setting parameters: ->2<-
[11:56:21.520] <TB3> INFO: delay test by 2 seconds...
[11:56:23.520] <TB3> INFO: enter test to run
[11:56:23.520] <TB3> INFO: test: HighRate no parameter change
[11:56:23.520] <TB3> INFO: running: highrate
[11:56:23.520] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//015_HREfficiency_125//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//015_HREfficiency_125//phCalibrationFitErr35_C15.dat
[11:56:23.700] <TB3> INFO: ----------------------------------------------------------------------
[11:56:23.700] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:56:23.700] <TB3> INFO: ----------------------------------------------------------------------
[11:56:24.306] <TB3> INFO: Expecting 208000 events.
[11:56:45.386] <TB3> INFO: 208000 events read in total (20553ms).
[11:56:45.395] <TB3> INFO: Test took 21692ms.
[11:56:46.055] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:56:46.449] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:56:46.449] <TB3> INFO: number of red-efficiency pixels: 356 358 382 808 1044 1298 969 1275 1632 1322 1310 957 742 410 377 428
[11:56:46.449] <TB3> INFO: number of X-ray hits detected: 180119 199289 176124 327144 351202 415241 353318 407034 467221 413068 423515 359229 317629 199905 214308 213419
[11:56:46.449] <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
[11:56:46.449] <TB3> INFO: number of Vcal hits detected: 207620 207618 207547 207035 206633 206267 206776 206405 205682 206256 206244 206813 207126 207508 207605 207529
[11:56:46.449] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.8 99.8 99.8 99.6 99.4 99.3 99.5 99.3 99.0 99.3 99.3 99.5 99.6 99.8 99.8 99.8
[11:56:46.449] <TB3> INFO: Vcal hit overall efficiency (%): 99.8 99.8 99.8 99.5 99.3 99.2 99.4 99.2 98.9 99.2 99.2 99.4 99.6 99.8 99.8 99.8
[11:56:46.449] <TB3> INFO: X-ray hit rate [MHz/cm2]: 52.8 58.4 51.6 95.9 102.9 121.7 103.6 119.3 136.9 121.1 124.1 105.3 93.1 58.6 62.8 62.6
[11:56:46.449] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[11:56:46.479] <TB3> INFO: PixTest:: pg_setup set to default.
[11:56:46.493] <TB3> INFO: enter test to run
[11:56:46.493] <TB3> INFO: test: no parameter change
[11:56:46.603] <TB3> QUIET: Connection to board 121 closed.
[11:56:46.684] <TB3> INFO: pXar: this is the end, my friend

[11:57:44.093] <TB3> INFO: *** Welcome to pxar ***
[11:57:44.093] <TB3> INFO: *** Today: 2015/12/16
[11:57:44.161] <TB3> INFO: *** Version: b2d3
[11:57:44.161] <TB3> INFO: readRocDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//016_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//016_HREfficiency_150//dacParameters35_C15.dat
[11:57:44.163] <TB3> INFO: readTbmDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//016_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//016_HREfficiency_150//tbmParameters_C0b.dat
[11:57:44.163] <TB3> INFO: readMaskFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//016_HREfficiency_150//defaultMaskFile.dat
[11:57:44.163] <TB3> INFO: readTrimFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//016_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//016_HREfficiency_150//trimParameters35_C15.dat
[11:57:44.239] <TB3> INFO: clk: 4
[11:57:44.239] <TB3> INFO: ctr: 4
[11:57:44.239] <TB3> INFO: sda: 19
[11:57:44.239] <TB3> INFO: tin: 9
[11:57:44.239] <TB3> INFO: level: 15
[11:57:44.239] <TB3> INFO: triggerdelay: 0
[11:57:44.239] <TB3> QUIET: Instanciating API for pxar prod-12
[11:57:44.239] <TB3> INFO: Log level: INFO
[11:57:44.253] <TB3> INFO: Found DTB DTB_WWV6Z5
[11:57:44.265] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[11:57:44.268] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[11:57:44.270] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[11:57:45.804] <TB3> INFO: DUT info:
[11:57:45.804] <TB3> INFO: The DUT currently contains the following objects:
[11:57:45.804] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[11:57:45.804] <TB3> INFO: TBM Core alpha (0): 7 registers set
[11:57:45.804] <TB3> INFO: TBM Core beta (1): 7 registers set
[11:57:45.804] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:57:45.804] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:45.805] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:45.805] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:45.805] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:45.805] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:45.805] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:45.805] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:45.805] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:45.805] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:45.805] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:45.805] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:45.805] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:45.805] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:45.805] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:45.805] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:45.805] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:46.206] <TB3> INFO: enter 'restricted' command line mode
[11:57:46.206] <TB3> INFO: enter test to run
[11:57:46.206] <TB3> INFO: test: PixelAlive no parameter change
[11:57:46.206] <TB3> INFO: running: pixelalive
[11:57:46.211] <TB3> INFO: ######################################################################
[11:57:46.211] <TB3> INFO: PixTestAlive::doTest()
[11:57:46.211] <TB3> INFO: ######################################################################
[11:57:46.213] <TB3> INFO: ----------------------------------------------------------------------
[11:57:46.213] <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)
[11:57:46.213] <TB3> INFO: ----------------------------------------------------------------------
[11:57:46.546] <TB3> INFO: Expecting 208000 events.
[11:57:58.816] <TB3> INFO: 208000 events read in total (11552ms).
[11:57:58.818] <TB3> INFO: Test took 12604ms.
[11:57:58.826] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:57:59.081] <TB3> INFO: PixTestAlive::aliveTest() done
[11:57:59.081] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:57:59.083] <TB3> INFO: ----------------------------------------------------------------------
[11:57:59.083] <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)
[11:57:59.083] <TB3> INFO: ----------------------------------------------------------------------
[11:57:59.427] <TB3> INFO: Expecting 208000 events.
[11:58:06.902] <TB3> INFO: 208000 events read in total (6759ms).
[11:58:06.902] <TB3> INFO: Test took 7818ms.
[11:58:06.902] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:58:06.903] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:58:07.209] <TB3> INFO: PixTestAlive::maskTest() done
[11:58:07.210] <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
[11:58:07.211] <TB3> INFO: ----------------------------------------------------------------------
[11:58:07.211] <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)
[11:58:07.211] <TB3> INFO: ----------------------------------------------------------------------
[11:58:07.539] <TB3> INFO: Expecting 208000 events.
[11:58:19.048] <TB3> INFO: 208000 events read in total (10794ms).
[11:58:19.049] <TB3> INFO: Test took 11836ms.
[11:58:19.057] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:58:19.281] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[11:58:19.281] <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
[11:58:19.281] <TB3> INFO: PixTestAlive::doTest() done, duration: 33 seconds
[11:58:19.315] <TB3> INFO: enter test to run
[11:58:19.315] <TB3> INFO: test: delay setting parameters: ->2<-
[11:58:19.315] <TB3> INFO: delay test by 2 seconds...
[11:58:21.315] <TB3> INFO: enter test to run
[11:58:21.315] <TB3> INFO: test: HighRate no parameter change
[11:58:21.315] <TB3> INFO: running: highrate
[11:58:21.315] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//016_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//016_HREfficiency_150//phCalibrationFitErr35_C15.dat
[11:58:21.465] <TB3> INFO: ----------------------------------------------------------------------
[11:58:21.465] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:58:21.465] <TB3> INFO: ----------------------------------------------------------------------
[11:58:22.090] <TB3> INFO: Expecting 208000 events.
[11:58:45.508] <TB3> INFO: 208000 events read in total (22891ms).
[11:58:45.520] <TB3> INFO: Test took 24051ms.
[11:58:46.243] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:58:46.649] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:58:46.649] <TB3> INFO: number of red-efficiency pixels: 481 487 503 1167 1444 1828 1316 1814 2270 1882 1857 1341 1034 513 561 596
[11:58:46.649] <TB3> INFO: number of X-ray hits detected: 216925 239679 211606 389251 419579 494938 420427 484109 555752 491921 502171 426815 377673 238320 255684 254375
[11:58:46.649] <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
[11:58:46.649] <TB3> INFO: number of Vcal hits detected: 207481 207447 207338 206491 205879 205158 206162 205421 204253 205088 205098 206052 206664 207288 207397 207322
[11:58:46.649] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.8 99.7 99.7 99.4 99.1 98.8 99.2 98.9 98.4 98.8 98.8 99.2 99.4 99.7 99.7 99.7
[11:58:46.649] <TB3> INFO: Vcal hit overall efficiency (%): 99.8 99.7 99.7 99.3 99.0 98.6 99.1 98.8 98.2 98.6 98.6 99.1 99.4 99.7 99.7 99.7
[11:58:46.649] <TB3> INFO: X-ray hit rate [MHz/cm2]: 63.6 70.3 62.0 114.1 123.0 145.1 123.2 141.9 162.9 144.2 147.2 125.1 110.7 69.9 74.9 74.6
[11:58:46.649] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[11:58:46.681] <TB3> INFO: PixTest:: pg_setup set to default.
[11:58:46.691] <TB3> INFO: enter test to run
[11:58:46.691] <TB3> INFO: test: no parameter change
[11:58:46.759] <TB3> QUIET: Connection to board 121 closed.
[11:58:46.838] <TB3> INFO: pXar: this is the end, my friend

[12:00:24.617] <TB3> INFO: *** Welcome to pxar ***
[12:00:24.617] <TB3> INFO: *** Today: 2015/12/16
[12:00:24.682] <TB3> INFO: *** Version: b2d3
[12:00:24.682] <TB3> INFO: readRocDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//017_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//017_HREfficiency_200//dacParameters35_C15.dat
[12:00:24.684] <TB3> INFO: readTbmDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//017_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//017_HREfficiency_200//tbmParameters_C0b.dat
[12:00:24.684] <TB3> INFO: readMaskFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//017_HREfficiency_200//defaultMaskFile.dat
[12:00:24.684] <TB3> INFO: readTrimFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//017_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//017_HREfficiency_200//trimParameters35_C15.dat
[12:00:24.765] <TB3> INFO: clk: 4
[12:00:24.765] <TB3> INFO: ctr: 4
[12:00:24.765] <TB3> INFO: sda: 19
[12:00:24.765] <TB3> INFO: tin: 9
[12:00:24.765] <TB3> INFO: level: 15
[12:00:24.765] <TB3> INFO: triggerdelay: 0
[12:00:24.765] <TB3> QUIET: Instanciating API for pxar prod-12
[12:00:24.765] <TB3> INFO: Log level: INFO
[12:00:24.781] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:00:24.792] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:00:24.795] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:00:24.797] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[12:00:26.335] <TB3> INFO: DUT info:
[12:00:26.335] <TB3> INFO: The DUT currently contains the following objects:
[12:00:26.335] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[12:00:26.335] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:00:26.335] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:00:26.335] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:00:26.335] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:26.335] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:26.335] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:26.335] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:26.335] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:26.335] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:26.335] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:26.335] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:26.335] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:26.335] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:26.335] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:26.335] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:26.335] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:26.335] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:26.335] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:26.335] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:26.736] <TB3> INFO: enter 'restricted' command line mode
[12:00:26.736] <TB3> INFO: enter test to run
[12:00:26.736] <TB3> INFO: test: PixelAlive no parameter change
[12:00:26.736] <TB3> INFO: running: pixelalive
[12:00:26.741] <TB3> INFO: ######################################################################
[12:00:26.741] <TB3> INFO: PixTestAlive::doTest()
[12:00:26.741] <TB3> INFO: ######################################################################
[12:00:26.743] <TB3> INFO: ----------------------------------------------------------------------
[12:00:26.743] <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)
[12:00:26.743] <TB3> INFO: ----------------------------------------------------------------------
[12:00:27.051] <TB3> INFO: Expecting 208000 events.
[12:00:39.388] <TB3> INFO: 208000 events read in total (11619ms).
[12:00:39.390] <TB3> INFO: Test took 12646ms.
[12:00:39.400] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:00:39.662] <TB3> INFO: PixTestAlive::aliveTest() done
[12:00:39.662] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:00:39.664] <TB3> INFO: ----------------------------------------------------------------------
[12:00:39.664] <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)
[12:00:39.664] <TB3> INFO: ----------------------------------------------------------------------
[12:00:40.006] <TB3> INFO: Expecting 208000 events.
[12:00:47.850] <TB3> INFO: 208000 events read in total (7128ms).
[12:00:47.851] <TB3> INFO: Test took 8186ms.
[12:00:47.851] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:00:47.852] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:00:48.161] <TB3> INFO: PixTestAlive::maskTest() done
[12:00:48.161] <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
[12:00:48.163] <TB3> INFO: ----------------------------------------------------------------------
[12:00:48.163] <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)
[12:00:48.163] <TB3> INFO: ----------------------------------------------------------------------
[12:00:48.503] <TB3> INFO: Expecting 208000 events.
[12:01:00.663] <TB3> INFO: 208000 events read in total (11444ms).
[12:01:00.663] <TB3> INFO: Test took 12498ms.
[12:01:00.672] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:01:00.895] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[12:01:00.895] <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
[12:01:00.895] <TB3> INFO: PixTestAlive::doTest() done, duration: 34 seconds
[12:01:00.929] <TB3> INFO: enter test to run
[12:01:00.929] <TB3> INFO: test: delay setting parameters: ->2<-
[12:01:00.930] <TB3> INFO: delay test by 2 seconds...
[12:01:02.930] <TB3> INFO: enter test to run
[12:01:02.930] <TB3> INFO: test: HighRate no parameter change
[12:01:02.930] <TB3> INFO: running: highrate
[12:01:02.930] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//017_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//017_HREfficiency_200//phCalibrationFitErr35_C15.dat
[12:01:03.069] <TB3> INFO: ----------------------------------------------------------------------
[12:01:03.069] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:01:03.069] <TB3> INFO: ----------------------------------------------------------------------
[12:01:03.684] <TB3> INFO: Expecting 208000 events.
[12:01:29.720] <TB3> INFO: 208000 events read in total (25509ms).
[12:01:29.740] <TB3> INFO: Test took 26668ms.
[12:01:30.579] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:01:31.049] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:01:31.049] <TB3> INFO: number of red-efficiency pixels: 895 856 875 2014 2502 2980 2353 3034 3476 2936 2988 2373 1910 914 1018 1143
[12:01:31.049] <TB3> INFO: number of X-ray hits detected: 296060 327398 288946 525695 566757 661960 568205 654441 747397 661806 675376 575796 510920 325378 348915 347073
[12:01:31.049] <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
[12:01:31.049] <TB3> INFO: number of Vcal hits detected: 206939 206979 206499 204529 202957 201231 203396 201610 198728 201082 200982 203474 204948 206325 206796 206556
[12:01:31.049] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.5 99.5 99.4 98.5 97.9 97.2 98.1 97.2 96.0 97.1 97.1 98.1 98.7 99.4 99.5 99.4
[12:01:31.049] <TB3> INFO: Vcal hit overall efficiency (%): 99.5 99.5 99.3 98.3 97.6 96.7 97.8 96.9 95.5 96.7 96.6 97.8 98.5 99.2 99.4 99.3
[12:01:31.049] <TB3> INFO: X-ray hit rate [MHz/cm2]: 86.8 96.0 84.7 154.1 166.1 194.0 166.5 191.8 219.1 194.0 198.0 168.8 149.8 95.4 102.3 101.7
[12:01:31.049] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[12:01:31.075] <TB3> INFO: PixTest:: pg_setup set to default.
[12:01:31.086] <TB3> INFO: enter test to run
[12:01:31.086] <TB3> INFO: test: no parameter change
[12:01:31.163] <TB3> QUIET: Connection to board 121 closed.
[12:01:31.243] <TB3> INFO: pXar: this is the end, my friend

[12:02:05.825] <TB3> INFO: *** Welcome to pxar ***
[12:02:05.826] <TB3> INFO: *** Today: 2015/12/16
[12:02:05.892] <TB3> INFO: *** Version: b2d3
[12:02:05.892] <TB3> INFO: readRocDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//018_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//018_HREfficiency_250//dacParameters35_C15.dat
[12:02:05.893] <TB3> INFO: readTbmDacs: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//018_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//018_HREfficiency_250//tbmParameters_C0b.dat
[12:02:05.893] <TB3> INFO: readMaskFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//018_HREfficiency_250//defaultMaskFile.dat
[12:02:05.893] <TB3> INFO: readTrimFile: /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//018_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//018_HREfficiency_250//trimParameters35_C15.dat
[12:02:05.980] <TB3> INFO: clk: 4
[12:02:05.980] <TB3> INFO: ctr: 4
[12:02:05.980] <TB3> INFO: sda: 19
[12:02:05.980] <TB3> INFO: tin: 9
[12:02:05.980] <TB3> INFO: level: 15
[12:02:05.980] <TB3> INFO: triggerdelay: 0
[12:02:05.980] <TB3> QUIET: Instanciating API for pxar prod-12
[12:02:05.980] <TB3> INFO: Log level: INFO
[12:02:05.994] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:02:06.006] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:02:06.012] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:02:06.014] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[12:02:07.535] <TB3> INFO: DUT info:
[12:02:07.535] <TB3> INFO: The DUT currently contains the following objects:
[12:02:07.535] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[12:02:07.535] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:02:07.535] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:02:07.535] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:02:07.535] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:07.535] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:07.535] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:07.535] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:07.535] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:07.535] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:07.535] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:07.535] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:07.536] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:07.536] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:07.536] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:07.536] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:07.536] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:07.536] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:07.536] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:07.536] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:07.936] <TB3> INFO: enter 'restricted' command line mode
[12:02:07.937] <TB3> INFO: enter test to run
[12:02:07.937] <TB3> INFO: test: PixelAlive no parameter change
[12:02:07.937] <TB3> INFO: running: pixelalive
[12:02:07.942] <TB3> INFO: ######################################################################
[12:02:07.942] <TB3> INFO: PixTestAlive::doTest()
[12:02:07.942] <TB3> INFO: ######################################################################
[12:02:07.943] <TB3> INFO: ----------------------------------------------------------------------
[12:02:07.943] <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)
[12:02:07.943] <TB3> INFO: ----------------------------------------------------------------------
[12:02:08.280] <TB3> INFO: Expecting 208000 events.
[12:02:20.690] <TB3> INFO: 208000 events read in total (11692ms).
[12:02:20.697] <TB3> INFO: Test took 12752ms.
[12:02:20.706] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:02:20.960] <TB3> INFO: PixTestAlive::aliveTest() done
[12:02:20.960] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:02:20.961] <TB3> INFO: ----------------------------------------------------------------------
[12:02:20.961] <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)
[12:02:20.961] <TB3> INFO: ----------------------------------------------------------------------
[12:02:21.293] <TB3> INFO: Expecting 208000 events.
[12:02:28.915] <TB3> INFO: 208000 events read in total (6907ms).
[12:02:28.916] <TB3> INFO: Test took 7953ms.
[12:02:28.916] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:02:28.917] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:02:29.226] <TB3> INFO: PixTestAlive::maskTest() done
[12:02:29.226] <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
[12:02:29.228] <TB3> INFO: ----------------------------------------------------------------------
[12:02:29.228] <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)
[12:02:29.228] <TB3> INFO: ----------------------------------------------------------------------
[12:02:29.571] <TB3> INFO: Expecting 208000 events.
[12:02:41.436] <TB3> INFO: 208000 events read in total (11148ms).
[12:02:41.436] <TB3> INFO: Test took 12206ms.
[12:02:41.443] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:02:41.665] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[12:02:41.665] <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
[12:02:41.665] <TB3> INFO: PixTestAlive::doTest() done, duration: 33 seconds
[12:02:41.702] <TB3> INFO: enter test to run
[12:02:41.702] <TB3> INFO: test: delay setting parameters: ->2<-
[12:02:41.702] <TB3> INFO: delay test by 2 seconds...
[12:02:43.702] <TB3> INFO: enter test to run
[12:02:43.702] <TB3> INFO: test: HighRate no parameter change
[12:02:43.702] <TB3> INFO: running: highrate
[12:02:43.703] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//018_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2128_XrayQualification_2015-12-16_10h27m_1450258068//018_HREfficiency_250//phCalibrationFitErr35_C15.dat
[12:02:43.840] <TB3> INFO: ----------------------------------------------------------------------
[12:02:43.840] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:02:43.840] <TB3> INFO: ----------------------------------------------------------------------
[12:02:44.464] <TB3> INFO: Expecting 208000 events.
[12:03:15.231] <TB3> INFO: 208000 events read in total (30239ms).
[12:03:15.248] <TB3> INFO: Test took 31404ms.
[12:03:16.403] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:03:16.950] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:03:16.950] <TB3> INFO: number of red-efficiency pixels: 1414 1326 1229 2863 3265 3675 3162 3813 4004 3653 3750 3158 2741 1308 1558 1664
[12:03:16.950] <TB3> INFO: number of X-ray hits detected: 366752 406684 358681 650092 699113 814051 701137 807164 922303 812490 832201 711386 629535 402179 430944 427619
[12:03:16.950] <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
[12:03:16.950] <TB3> INFO: number of Vcal hits detected: 206166 206219 205360 201521 198466 195514 199514 195871 190703 195303 194887 199442 202195 205016 205910 205530
[12:03:16.950] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.2 99.2 99.0 97.3 96.0 94.7 96.5 94.7 92.4 94.6 94.5 96.4 97.6 98.8 99.1 99.0
[12:03:16.950] <TB3> INFO: Vcal hit overall efficiency (%): 99.1 99.1 98.7 96.9 95.4 94.0 95.9 94.2 91.7 93.9 93.7 95.9 97.2 98.6 99.0 98.8
[12:03:16.950] <TB3> INFO: X-ray hit rate [MHz/cm2]: 107.5 119.2 105.1 190.5 204.9 238.6 205.5 236.6 270.3 238.1 243.9 208.5 184.5 117.9 126.3 125.3
[12:03:16.950] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[12:03:16.984] <TB3> INFO: PixTest:: pg_setup set to default.
[12:03:17.007] <TB3> INFO: enter test to run
[12:03:17.007] <TB3> INFO: test: no parameter change
[12:03:17.147] <TB3> QUIET: Connection to board 121 closed.
[12:03:17.227] <TB3> INFO: pXar: this is the end, my friend