Test Date: 2015-12-02 12:14
Analysis date: 2016-05-25 23:11
Logfile
commander_PixelAlive.log
[11:14:31.148] <TB1> INFO: *** Welcome to pxar ***
[11:14:31.148] <TB1> INFO: *** Today: 2015/12/02
[11:14:32.738] <TB1> INFO: *** Version: fb79
[11:14:32.738] <TB1> INFO: readRocDacs: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//000_PixelAlive_p17//dacParameters35_C15.dat
[11:14:32.738] <TB1> INFO: readTbmDacs: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//000_PixelAlive_p17//tbmParameters_C0b.dat
[11:14:32.738] <TB1> INFO: readMaskFile: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//000_PixelAlive_p17//defaultMaskFile.dat
[11:14:32.738] <TB1> INFO: MASKED Roc 7 col/row: 48 2
[11:14:32.738] <TB1> INFO: MASKED Roc 14 col/row: 13 69
[11:14:32.738] <TB1> INFO: readTrimFile: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//000_PixelAlive_p17//trimParameters35_C15.dat
[11:14:32.769] <TB1> INFO: masking Roc 7 col/row: 48 2
[11:14:32.798] <TB1> INFO: masking Roc 14 col/row: 13 69
[11:14:32.807] <TB1> INFO: clk: 4
[11:14:32.807] <TB1> INFO: ctr: 4
[11:14:32.807] <TB1> INFO: sda: 19
[11:14:32.807] <TB1> INFO: tin: 9
[11:14:32.807] <TB1> INFO: level: 15
[11:14:32.807] <TB1> INFO: triggerdelay: 0
[11:14:32.807] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:14:32.807] <TB1> INFO: Log level: INFO
[11:14:32.819] <TB1> INFO: Found DTB DTB_WWXTQT
[11:14:32.829] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:14:32.832] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[11:14:32.834] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[11:14:34.368] <TB1> INFO: DUT info:
[11:14:34.368] <TB1> INFO: The DUT currently contains the following objects:
[11:14:34.368] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[11:14:34.368] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:14:34.368] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:14:34.368] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:14:34.368] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:34.368] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:34.368] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:34.368] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:34.368] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:34.368] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:34.368] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:34.369] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 1 masked, 0 active.
[11:14:34.369] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:34.369] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:34.369] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:34.369] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:34.369] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:34.369] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:34.369] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 1 masked, 0 active.
[11:14:34.369] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:34.769] <TB1> INFO: enter 'restricted' command line mode
[11:14:34.769] <TB1> INFO: enter test to run
[11:14:34.769] <TB1> INFO: test: PixelAlive no parameter change
[11:14:34.769] <TB1> INFO: running: pixelalive
[11:14:34.773] <TB1> INFO: ######################################################################
[11:14:34.774] <TB1> INFO: PixTestAlive::doTest()
[11:14:34.774] <TB1> INFO: ######################################################################
[11:14:34.775] <TB1> INFO: ----------------------------------------------------------------------
[11:14:34.775] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:14:34.775] <TB1> INFO: ----------------------------------------------------------------------
[11:14:34.776] <TB1> INFO: ROC 7 masking pixel 48/2
[11:14:34.776] <TB1> INFO: ROC 14 masking pixel 13/69
[11:14:35.078] <TB1> INFO: Expecting 41600 events.
[11:14:39.229] <TB1> INFO: 41600 events read in total (3433ms).
[11:14:39.309] <TB1> INFO: Test took 4533ms.
[11:14:39.315] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:14:39.572] <TB1> INFO: PixTestAlive::aliveTest() done
[11:14:39.572] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 1 0 0 0 0 0 0 1 0
[11:14:39.572] <TB1> INFO: ROC 7 masking pixel 48/2
[11:14:39.572] <TB1> INFO: ROC 14 masking pixel 13/69
[11:14:39.573] <TB1> INFO: ----------------------------------------------------------------------
[11:14:39.573] <TB1> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:14:39.573] <TB1> INFO: ----------------------------------------------------------------------
[11:14:39.875] <TB1> INFO: Expecting 41600 events.
[11:14:42.986] <TB1> INFO: 41600 events read in total (2396ms).
[11:14:42.987] <TB1> INFO: Test took 3412ms.
[11:14:42.987] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:14:42.987] <TB1> INFO: ROC 7 masking pixel 48/2
[11:14:42.987] <TB1> INFO: ROC 14 masking pixel 13/69
[11:14:42.987] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:14:43.300] <TB1> INFO: PixTestAlive::maskTest() done
[11:14:43.300] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:14:43.301] <TB1> INFO: ROC 7 masking pixel 48/2
[11:14:43.301] <TB1> INFO: ROC 14 masking pixel 13/69
[11:14:43.302] <TB1> INFO: ----------------------------------------------------------------------
[11:14:43.302] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:14:43.302] <TB1> INFO: ----------------------------------------------------------------------
[11:14:43.303] <TB1> INFO: ROC 7 masking pixel 48/2
[11:14:43.303] <TB1> INFO: ROC 14 masking pixel 13/69
[11:14:43.603] <TB1> INFO: Expecting 41600 events.
[11:14:47.802] <TB1> INFO: 41600 events read in total (3483ms).
[11:14:47.802] <TB1> INFO: Test took 4499ms.
[11:14:47.809] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:14:48.100] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[11:14:48.100] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:14:48.100] <TB1> INFO: ROC 7 masking pixel 48/2
[11:14:48.100] <TB1> INFO: ROC 14 masking pixel 13/69
[11:14:48.100] <TB1> INFO: PixTestAlive::doTest() done, duration: 13 seconds
[11:14:48.129] <TB1> INFO: enter test to run
[11:14:48.129] <TB1> INFO: test: no parameter change
[11:14:48.184] <TB1> QUIET: Connection to board 147 closed.
[11:14:48.264] <TB1> INFO: pXar: this is the end, my friend
pxar.log
[12:03:11.593] INFO: *** Welcome to pxar ***
[12:03:11.594] INFO: *** Today: 2015/12/02
[12:03:12.518] INFO: *** Version: v2.6.1-2-g42ad
[12:03:12.518] INFO: readRocDacs: ../data/M2047/dacParameters35_C0.dat .. ../data/M2047/dacParameters35_C15.dat
[12:03:12.535] INFO: readTbmDacs: ../data/M2047/tbmParameters_C0a.dat .. ../data/M2047/tbmParameters_C0b.dat
[12:03:12.536] INFO: readMaskFile: ../data/M2047/defaultMaskFile.dat
[12:03:12.537] INFO: MASKED Roc 14 col/row: 13 69
[12:03:12.537] INFO: readTrimFile: ../data/M2047/trimParameters35_C0.dat .. ../data/M2047/trimParameters35_C15.dat
[12:03:12.683] INFO: masking Roc 14 col/row: 13 69
[12:03:13.175] INFO: clk: 4
[12:03:13.184] INFO: ctr: 4
[12:03:13.184] INFO: sda: 19
[12:03:13.184] INFO: tin: 9
[12:03:13.184] INFO: level: 15
[12:03:13.184] INFO: triggerdelay: 0
[12:03:13.184] QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[12:03:13.184] INFO: Log level: INFO
[12:03:13.198] INFO: Connected DTBs:
[12:03:13.198] INFO: 0: DTB_WS6UZO on USB
[12:03:13.207] INFO: BID = 83
[12:03:13.286] INFO: 1: DTB_WWXTQT on USB
[12:03:13.320] INFO: BID = 147
[12:03:13.400] INFO: 2: DTB_WXENWR on USB
[12:03:13.412] INFO: BID = 162
[12:03:13.588] INFO: 3: DTB_WWV6Z5 on USB
[12:03:13.600] INFO: BID = 121
[12:03:13.680] INFO: Please choose DTB (0-3):
[12:03:16.799] QUIET: Connection to board DTB_WWXTQT opened.
[12:03:16.807] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:03:16.810] INFO: RPC call hashes of host and DTB match: 398089610
[12:03:18.351] INFO: DUT info:
[12:03:18.351] INFO: The DUT currently contains the following objects:
[12:03:18.351] INFO: 2 TBM Cores tbm09c (2 ON)
[12:03:18.351] INFO: TBM Core alpha (0): 7 registers set
[12:03:18.351] INFO: TBM Core beta (1): 7 registers set
[12:03:18.351] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:03:18.351] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:03:18.351] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:03:18.351] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:03:18.351] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:03:18.351] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:03:18.351] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:03:18.352] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:03:18.352] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:03:18.352] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:03:18.352] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:03:18.352] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:03:18.352] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:03:18.352] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:03:18.352] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:03:18.352] INFO: ROC 14: 19 DACs set, Pixels: 1 masked, 0 active.
[12:03:18.352] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:03:18.955] INFO: PixTestCmd::init()
[12:03:18.977] INFO: readGainPedestalParameters ../data/M2047/phCalibrationFitErr35_C0.dat .. ../data/M2047/phCalibrationFitErr35_C15.dat
[12:03:19.315] INFO: readReadbackCal: ../data/M2047/readbackCal_C0.dat .. ../data/M2047/readbackCal_C15.dat
[12:03:55.815] INFO: ----------------------------------------------------------------------
[12:03:55.816] INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[12:03:55.816] INFO: ----------------------------------------------------------------------
[12:03:55.816] INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[12:03:55.816] INFO: edge/corner pixel THR is adjusted
[12:03:55.816] INFO: PixTestHighRate::trimHotPixels: step 0...
[12:03:56.778] INFO: Collecting data for 1 seconds...
[12:03:57.780] INFO: Done with hot pixel readout
[12:04:05.499] INFO: PixTest:: pg_setup set to default.
[12:04:05.501] INFO: 3 hot pixels found in step 0
[12:04:06.473] INFO: Collecting data for 1 seconds...
[12:04:07.475] INFO: Done with hot pixel readout
[12:04:15.146] INFO: PixTest:: pg_setup set to default.
[12:04:15.148] INFO: 3 hot pixels found in step 1
[12:04:16.115] INFO: Collecting data for 1 seconds...
[12:04:17.117] INFO: Done with hot pixel readout
[12:04:24.836] INFO: PixTest:: pg_setup set to default.
[12:04:24.838] INFO: 3 hot pixels found in step 2
[12:04:25.806] INFO: Collecting data for 1 seconds...
[12:04:26.808] INFO: Done with hot pixel readout
[12:04:34.434] INFO: PixTest:: pg_setup set to default.
[12:04:34.437] INFO: 1 hot pixels found in step 3
[12:04:35.404] INFO: Collecting data for 1 seconds...
[12:04:36.406] INFO: Done with hot pixel readout
[12:04:44.085] INFO: PixTest:: pg_setup set to default.
[12:04:44.087] INFO: 2 hot pixels found in step 4
[12:04:45.052] INFO: Collecting data for 1 seconds...
[12:04:46.053] INFO: Done with hot pixel readout
[12:04:53.750] INFO: PixTest:: pg_setup set to default.
[12:04:53.752] INFO: 1 hot pixels found in step 5
[12:04:54.718] INFO: Collecting data for 1 seconds...
[12:04:55.720] INFO: Done with hot pixel readout
[12:05:03.407] INFO: PixTest:: pg_setup set to default.
[12:05:03.409] INFO: 1 hot pixels found in step 6
[12:05:04.376] INFO: Collecting data for 1 seconds...
[12:05:05.378] INFO: Done with hot pixel readout
[12:05:13.008] INFO: PixTest:: pg_setup set to default.
[12:05:13.010] INFO: 1 hot pixels found in step 7
[12:05:13.977] INFO: Collecting data for 1 seconds...
[12:05:14.978] INFO: Done with hot pixel readout
[12:05:22.683] INFO: PixTest:: pg_setup set to default.
[12:05:22.686] INFO: 1 hot pixels found in step 8
[12:05:23.654] INFO: Collecting data for 1 seconds...
[12:05:24.656] INFO: Done with hot pixel readout
[12:05:32.346] INFO: PixTest:: pg_setup set to default.
[12:05:32.348] INFO: 1 hot pixels found in step 9
[12:05:33.315] INFO: Collecting data for 1 seconds...
[12:05:34.317] INFO: Done with hot pixel readout
[12:05:42.015] INFO: PixTest:: pg_setup set to default.
[12:05:42.016] INFO: 1 hot pixels found in step 10
[12:05:42.980] INFO: Collecting data for 1 seconds...
[12:05:43.982] INFO: Done with hot pixel readout
[12:05:51.646] INFO: PixTest:: pg_setup set to default.
[12:05:51.647] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found

[12:05:51.648] INFO: 1 hot pixels found in step 11
[12:05:51.659] INFO: 1 hot pixels could not be trimmed and have been masked.
[12:05:51.703] INFO: PixTest::trimHotPixels() done
[12:05:51.953] INFO: write trim parameters into ../data/M2047/trimParameters35_C0.dat
[12:05:52.103] INFO: write trim parameters into ../data/M2047/trimParameters35_C1.dat
[12:05:52.140] INFO: write trim parameters into ../data/M2047/trimParameters35_C2.dat
[12:05:52.172] INFO: write trim parameters into ../data/M2047/trimParameters35_C3.dat
[12:05:52.200] INFO: write trim parameters into ../data/M2047/trimParameters35_C4.dat
[12:05:52.224] INFO: write trim parameters into ../data/M2047/trimParameters35_C5.dat
[12:05:52.255] INFO: write trim parameters into ../data/M2047/trimParameters35_C6.dat
[12:05:52.329] INFO: write trim parameters into ../data/M2047/trimParameters35_C7.dat
[12:05:52.349] INFO: write trim parameters into ../data/M2047/trimParameters35_C8.dat
[12:05:52.381] INFO: write trim parameters into ../data/M2047/trimParameters35_C9.dat
[12:05:52.411] INFO: write trim parameters into ../data/M2047/trimParameters35_C10.dat
[12:05:52.434] INFO: write trim parameters into ../data/M2047/trimParameters35_C11.dat
[12:05:52.454] INFO: write trim parameters into ../data/M2047/trimParameters35_C12.dat
[12:05:52.486] INFO: write trim parameters into ../data/M2047/trimParameters35_C13.dat
[12:05:52.521] INFO: write trim parameters into ../data/M2047/trimParameters35_C14.dat
[12:05:52.543] INFO: write trim parameters into ../data/M2047/trimParameters35_C15.dat
[12:05:52.569] INFO: write masked pixels into ../data/M2047/defaultMaskFile.dat
[12:06:20.800] INFO: ----------------------------------------------------------------------
[12:06:20.800] INFO: PixTest::trimHotPixels() running for 2 seconds with 100 kHz trigger rate
[12:06:20.800] INFO: ----------------------------------------------------------------------
[12:06:20.800] INFO: THR = 5, corresponding to ~ 6.66667 MHz/cm2
[12:06:20.800] INFO: edge/corner pixel THR is adjusted
[12:06:20.800] INFO: PixTestHighRate::trimHotPixels: step 0...
[12:06:21.758] INFO: Collecting data for 2 seconds...
[12:06:23.762] INFO: Done with hot pixel readout
[12:06:28.398] INFO: PixTest:: pg_setup set to default.
[12:06:28.401] INFO: 2 hot pixels found in step 0
[12:06:29.444] INFO: Collecting data for 2 seconds...
[12:06:31.447] INFO: Done with hot pixel readout
[12:06:36.005] INFO: PixTest:: pg_setup set to default.
[12:06:36.008] INFO: 2 hot pixels found in step 1
[12:06:37.049] INFO: Collecting data for 2 seconds...
[12:06:39.052] INFO: Done with hot pixel readout
[12:06:43.592] INFO: PixTest:: pg_setup set to default.
[12:06:43.593] INFO: 2 hot pixels found in step 2
[12:06:44.635] INFO: Collecting data for 2 seconds...
[12:06:46.638] INFO: Done with hot pixel readout
[12:06:51.152] INFO: PixTest:: pg_setup set to default.
[12:06:51.154] INFO: 1 hot pixels found in step 3
[12:06:52.196] INFO: Collecting data for 2 seconds...
[12:06:54.199] INFO: Done with hot pixel readout
[12:06:58.640] INFO: PixTest:: pg_setup set to default.
[12:06:58.643] INFO: 1 hot pixels found in step 4
[12:06:59.684] INFO: Collecting data for 2 seconds...
[12:07:01.687] INFO: Done with hot pixel readout
[12:07:06.091] INFO: PixTest:: pg_setup set to default.
[12:07:06.093] INFO: 1 hot pixels found in step 5
[12:07:07.134] INFO: Collecting data for 2 seconds...
[12:07:09.138] INFO: Done with hot pixel readout
[12:07:13.512] INFO: PixTest:: pg_setup set to default.
[12:07:13.514] INFO: 1 hot pixels found in step 6
[12:07:14.554] INFO: Collecting data for 2 seconds...
[12:07:16.558] INFO: Done with hot pixel readout
[12:07:20.941] INFO: PixTest:: pg_setup set to default.
[12:07:20.943] INFO: 1 hot pixels found in step 7
[12:07:21.985] INFO: Collecting data for 2 seconds...
[12:07:23.988] INFO: Done with hot pixel readout
[12:07:28.370] INFO: PixTest:: pg_setup set to default.
[12:07:28.373] INFO: 0 hot pixels found in step 8
[12:07:28.374] INFO: 0 hot pixels could not be trimmed and have been masked.
[12:07:28.459] INFO: PixTest::trimHotPixels() done
[12:07:28.480] INFO: write trim parameters into ../data/M2047/trimParameters35_C0.dat
[12:07:28.759] INFO: write trim parameters into ../data/M2047/trimParameters35_C1.dat
[12:07:28.807] INFO: write trim parameters into ../data/M2047/trimParameters35_C2.dat
[12:07:28.829] INFO: write trim parameters into ../data/M2047/trimParameters35_C3.dat
[12:07:28.855] INFO: write trim parameters into ../data/M2047/trimParameters35_C4.dat
[12:07:28.881] INFO: write trim parameters into ../data/M2047/trimParameters35_C5.dat
[12:07:28.904] INFO: write trim parameters into ../data/M2047/trimParameters35_C6.dat
[12:07:28.931] INFO: write trim parameters into ../data/M2047/trimParameters35_C7.dat
[12:07:28.966] INFO: write trim parameters into ../data/M2047/trimParameters35_C8.dat
[12:07:28.991] INFO: write trim parameters into ../data/M2047/trimParameters35_C9.dat
[12:07:29.013] INFO: write trim parameters into ../data/M2047/trimParameters35_C10.dat
[12:07:29.037] INFO: write trim parameters into ../data/M2047/trimParameters35_C11.dat
[12:07:29.061] INFO: write trim parameters into ../data/M2047/trimParameters35_C12.dat
[12:07:29.086] INFO: write trim parameters into ../data/M2047/trimParameters35_C13.dat
[12:07:29.111] INFO: write trim parameters into ../data/M2047/trimParameters35_C14.dat
[12:07:29.131] INFO: write trim parameters into ../data/M2047/trimParameters35_C15.dat
[12:07:29.154] INFO: write masked pixels into ../data/M2047/defaultMaskFile.dat
[12:08:04.955] INFO: ----------------------------------------------------------------------
[12:08:04.955] INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[12:08:04.956] INFO: ----------------------------------------------------------------------
[12:08:04.956] INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[12:08:04.956] INFO: edge/corner pixel THR is adjusted
[12:08:04.956] INFO: PixTestHighRate::trimHotPixels: step 0...
[12:08:05.914] INFO: Collecting data for 1 seconds...
[12:08:06.916] INFO: Done with hot pixel readout
[12:08:14.527] INFO: PixTest:: pg_setup set to default.
[12:08:14.529] INFO: 1 hot pixels found in step 0
[12:08:15.492] INFO: Collecting data for 1 seconds...
[12:08:16.494] INFO: Done with hot pixel readout
[12:08:24.227] INFO: PixTest:: pg_setup set to default.
[12:08:24.229] INFO: 1 hot pixels found in step 1
[12:08:25.193] INFO: Collecting data for 1 seconds...
[12:08:26.195] INFO: Done with hot pixel readout
[12:08:33.915] INFO: PixTest:: pg_setup set to default.
[12:08:33.918] INFO: 1 hot pixels found in step 2
[12:08:34.884] INFO: Collecting data for 1 seconds...
[12:08:35.886] INFO: Done with hot pixel readout
[12:08:43.596] INFO: PixTest:: pg_setup set to default.
[12:08:43.598] INFO: 1 hot pixels found in step 3
[12:08:44.567] INFO: Collecting data for 1 seconds...
[12:08:45.569] INFO: Done with hot pixel readout
[12:08:53.262] INFO: PixTest:: pg_setup set to default.
[12:08:53.263] INFO: 1 hot pixels found in step 4
[12:08:54.231] INFO: Collecting data for 1 seconds...
[12:08:55.232] INFO: Done with hot pixel readout
[12:09:02.907] INFO: PixTest:: pg_setup set to default.
[12:09:02.908] INFO: 1 hot pixels found in step 5
[12:09:03.875] INFO: Collecting data for 1 seconds...
[12:09:04.877] INFO: Done with hot pixel readout
[12:09:06.565] ERROR: <datapipe.cc/CheckEventValidity:L488> Channel 3 Number of ROCs (2) != Token Chain Length (4)

[12:09:06.565] ERROR: <datapipe.cc/CheckEventID:L461> Channel 3 Event ID mismatch: local ID (213) != TBM ID (2)

[12:09:06.566] ERROR: <datapipe.cc/CheckEventValidity:L488> Channel 3 Number of ROCs (0) != Token Chain Length (4)

[12:09:06.566] ERROR: <datapipe.cc/CheckEventID:L461> Channel 3 Event ID mismatch: local ID (3) != TBM ID (213)

[12:09:06.566] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:

[12:09:06.566] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a3d8 80b0 4788 30c 2a46 6ca 2a2c 6e2 2a6e 819 2867 4788 4788 4788 361 204b 841 2223 fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e000 c000

[12:09:06.566] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a3d3 8040 4788 51 224c 40b 2267 684 2268 4789 cb 204a 4788 2c3 284a 358 2a4f 6db 2a86 4788 500 260f fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e000 c000

[12:09:06.566] ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a3d4 80b0 4788 800 2848 4788 51b 206e 74a 264c 4788

[12:09:06.566] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a302 805a 66 2285 82e 234b 66f 4788 704 202f fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e000 c000

[12:09:06.566] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a3d5 80c1 4788 2a0 244a 753 2444 4788 4788 5 282f c 224a 24d 2a4b 4788 2e0 2645 fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e000 c000

[12:09:06.566] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a3d6 8000 4788 208 2048 4788 112 206f 688 2247 4788 5 2848 861 2249 4788 31b 2265 75a 2064 760 2a47 fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff e000 c000

[12:09:06.566] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a3d7 8040 4788 2c8 2862 45b 2067 45b 226f 4788 34a 2449 34a 204c 4788 642 2a2d 4788 519 2649 55d 206d e000 c000

[12:09:12.872] INFO: PixTest:: pg_setup set to default.
[12:09:12.874] INFO: 1 hot pixels found in step 6
[12:09:13.843] INFO: Collecting data for 1 seconds...
[12:09:14.844] INFO: Done with hot pixel readout
[12:09:22.565] INFO: PixTest:: pg_setup set to default.
[12:09:22.566] INFO: 1 hot pixels found in step 7
[12:09:23.531] INFO: Collecting data for 1 seconds...
[12:09:24.533] INFO: Done with hot pixel readout
[12:09:32.255] INFO: PixTest:: pg_setup set to default.
[12:09:32.258] INFO: 1 hot pixels found in step 8
[12:09:33.225] INFO: Collecting data for 1 seconds...
[12:09:34.227] INFO: Done with hot pixel readout
[12:09:42.001] INFO: PixTest:: pg_setup set to default.
[12:09:42.002] INFO: 1 hot pixels found in step 9
[12:09:42.966] INFO: Collecting data for 1 seconds...
[12:09:43.968] INFO: Done with hot pixel readout
[12:09:51.688] INFO: PixTest:: pg_setup set to default.
[12:09:51.690] INFO: 1 hot pixels found in step 10
[12:09:52.656] INFO: Collecting data for 1 seconds...
[12:09:53.658] INFO: Done with hot pixel readout
[12:10:01.343] INFO: PixTest:: pg_setup set to default.
[12:10:01.344] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found

[12:10:01.345] INFO: 1 hot pixels found in step 11
[12:10:01.353] INFO: 1 hot pixels could not be trimmed and have been masked.
[12:10:01.390] INFO: PixTest::trimHotPixels() done
[12:10:01.406] INFO: write trim parameters into ../data/M2047/trimParameters35_C0.dat
[12:10:01.798] INFO: write trim parameters into ../data/M2047/trimParameters35_C1.dat
[12:10:02.016] INFO: write trim parameters into ../data/M2047/trimParameters35_C2.dat
[12:10:02.300] INFO: write trim parameters into ../data/M2047/trimParameters35_C3.dat
[12:10:02.426] INFO: write trim parameters into ../data/M2047/trimParameters35_C4.dat
[12:10:02.635] INFO: write trim parameters into ../data/M2047/trimParameters35_C5.dat
[12:10:02.795] INFO: write trim parameters into ../data/M2047/trimParameters35_C6.dat
[12:10:03.022] INFO: write trim parameters into ../data/M2047/trimParameters35_C7.dat
[12:10:03.206] INFO: write trim parameters into ../data/M2047/trimParameters35_C8.dat
[12:10:03.365] INFO: write trim parameters into ../data/M2047/trimParameters35_C9.dat
[12:10:03.659] INFO: write trim parameters into ../data/M2047/trimParameters35_C10.dat
[12:10:03.826] INFO: write trim parameters into ../data/M2047/trimParameters35_C11.dat
[12:10:04.002] INFO: write trim parameters into ../data/M2047/trimParameters35_C12.dat
[12:10:04.195] INFO: write trim parameters into ../data/M2047/trimParameters35_C13.dat
[12:10:04.412] INFO: write trim parameters into ../data/M2047/trimParameters35_C14.dat
[12:10:04.584] INFO: write trim parameters into ../data/M2047/trimParameters35_C15.dat
[12:10:04.626] INFO: write masked pixels into ../data/M2047/defaultMaskFile.dat
[12:10:18.597] QUIET: Connection to board 147 closed.
commander_HRData.log
[11:18:51.699] <TB1> INFO: *** Welcome to pxar ***
[11:18:51.699] <TB1> INFO: *** Today: 2015/12/02
[11:18:52.078] <TB1> INFO: *** Version: fb79
[11:18:52.078] <TB1> INFO: readRocDacs: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//002_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//002_HRData_50//dacParameters35_C15.dat
[11:18:52.079] <TB1> INFO: readTbmDacs: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//002_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//002_HRData_50//tbmParameters_C0b.dat
[11:18:52.079] <TB1> INFO: readMaskFile: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//002_HRData_50//defaultMaskFile.dat
[11:18:52.079] <TB1> INFO: MASKED Roc 7 col/row: 48 2
[11:18:52.079] <TB1> INFO: MASKED Roc 14 col/row: 13 69
[11:18:52.079] <TB1> INFO: readTrimFile: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//002_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//002_HRData_50//trimParameters35_C15.dat
[11:18:52.109] <TB1> INFO: masking Roc 7 col/row: 48 2
[11:18:52.138] <TB1> INFO: masking Roc 14 col/row: 13 69
[11:18:52.146] <TB1> INFO: clk: 4
[11:18:52.146] <TB1> INFO: ctr: 4
[11:18:52.147] <TB1> INFO: sda: 19
[11:18:52.147] <TB1> INFO: tin: 9
[11:18:52.147] <TB1> INFO: level: 15
[11:18:52.147] <TB1> INFO: triggerdelay: 0
[11:18:52.147] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:18:52.147] <TB1> INFO: Log level: INFO
[11:18:52.160] <TB1> INFO: Found DTB DTB_WWXTQT
[11:18:52.169] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:18:52.173] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[11:18:52.175] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[11:18:53.718] <TB1> INFO: DUT info:
[11:18:53.718] <TB1> INFO: The DUT currently contains the following objects:
[11:18:53.718] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[11:18:53.718] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:18:53.718] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:18:53.718] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:18:53.718] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:53.718] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:53.718] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:53.718] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:53.718] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:53.718] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:53.718] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:53.718] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 1 masked, 0 active.
[11:18:53.718] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:53.718] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:53.718] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:53.718] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:53.718] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:53.718] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:53.718] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 1 masked, 0 active.
[11:18:53.718] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:54.119] <TB1> INFO: enter 'restricted' command line mode
[11:18:54.119] <TB1> INFO: enter test to run
[11:18:54.119] <TB1> INFO: test: delay setting parameters: ->5<-
[11:18:54.119] <TB1> INFO: delay test by 5 seconds...
[11:18:59.119] <TB1> INFO: enter test to run
[11:18:59.119] <TB1> INFO: test: Xray no parameter change
[11:18:59.119] <TB1> INFO: running: xray
[11:18:59.121] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//002_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//002_HRData_50//phCalibrationFitErr35_C15.dat
[11:18:59.250] <TB1> INFO: ######################################################################
[11:18:59.250] <TB1> INFO: PixTestXray::doTest()
[11:18:59.250] <TB1> INFO: ######################################################################
[11:18:59.251] <TB1> INFO: ----------------------------------------------------------------------
[11:18:59.251] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[11:18:59.251] <TB1> INFO: ----------------------------------------------------------------------
[11:18:59.253] <TB1> INFO: ROC 7 masking pixel 48/2
[11:18:59.253] <TB1> INFO: ROC 14 masking pixel 13/69
[11:19:00.215] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[11:19:06.271] <TB1> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[11:19:28.898] <TB1> INFO: Resuming triggers.
[11:19:34.964] <TB1> INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[11:19:57.455] <TB1> INFO: Resuming triggers.
[11:20:03.516] <TB1> INFO: run duration 18 seconds, buffer almost full (81%), pausing triggers.
[11:20:25.893] <TB1> INFO: Resuming triggers.
[11:20:31.957] <TB1> INFO: run duration 24 seconds, buffer almost full (81%), pausing triggers.
[11:20:54.281] <TB1> INFO: Resuming triggers.
[11:21:00.341] <TB1> INFO: run duration 30 seconds, buffer almost full (81%), pausing triggers.
[11:21:23.168] <TB1> INFO: Resuming triggers.
[11:21:29.229] <TB1> INFO: run duration 36 seconds, buffer almost full (81%), pausing triggers.
[11:21:51.737] <TB1> INFO: Resuming triggers.
[11:21:57.795] <TB1> INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[11:22:20.227] <TB1> INFO: Resuming triggers.
[11:22:26.284] <TB1> INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[11:22:48.883] <TB1> INFO: Resuming triggers.
[11:22:54.941] <TB1> INFO: run duration 54 seconds, buffer almost full (81%), pausing triggers.
[11:23:17.428] <TB1> INFO: Resuming triggers.
[11:23:23.486] <TB1> INFO: run duration 60 seconds, buffer almost full (81%), pausing triggers.
[11:23:46.048] <TB1> INFO: Resuming triggers.
[11:23:52.108] <TB1> INFO: run duration 66 seconds, buffer almost full (81%), pausing triggers.
[11:24:14.603] <TB1> INFO: Resuming triggers.
[11:24:20.661] <TB1> INFO: run duration 72 seconds, buffer almost full (81%), pausing triggers.
[11:24:43.026] <TB1> INFO: Resuming triggers.
[11:24:49.082] <TB1> INFO: run duration 78 seconds, buffer almost full (81%), pausing triggers.
[11:25:11.663] <TB1> INFO: Resuming triggers.
[11:25:17.723] <TB1> INFO: run duration 84 seconds, buffer almost full (81%), pausing triggers.
[11:25:40.084] <TB1> INFO: Resuming triggers.
[11:25:46.139] <TB1> INFO: run duration 90 seconds, buffer almost full (81%), pausing triggers.
[11:26:08.712] <TB1> INFO: Resuming triggers.
[11:26:14.769] <TB1> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[11:26:37.297] <TB1> INFO: Resuming triggers.
[11:26:40.421] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[11:26:52.290] <TB1> INFO: PixTest:: pg_setup set to default.
[11:26:52.292] <TB1> INFO: PixTestXray::doPhRun() done
[11:26:52.292] <TB1> INFO: PixTestXray::doTest() done
[11:26:52.476] <TB1> INFO: enter test to run
[11:26:52.476] <TB1> INFO: test: no parameter change
[11:26:52.618] <TB1> QUIET: Connection to board 147 closed.
[11:26:52.698] <TB1> INFO: pXar: this is the end, my friend
commander_HRData.log
[11:26:58.629] <TB1> INFO: *** Welcome to pxar ***
[11:26:58.629] <TB1> INFO: *** Today: 2015/12/02
[11:26:59.121] <TB1> INFO: *** Version: fb79
[11:26:59.121] <TB1> INFO: readRocDacs: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//003_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//003_HRData_150//dacParameters35_C15.dat
[11:26:59.121] <TB1> INFO: readTbmDacs: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//003_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//003_HRData_150//tbmParameters_C0b.dat
[11:26:59.121] <TB1> INFO: readMaskFile: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//003_HRData_150//defaultMaskFile.dat
[11:26:59.121] <TB1> INFO: MASKED Roc 7 col/row: 48 2
[11:26:59.121] <TB1> INFO: MASKED Roc 14 col/row: 13 69
[11:26:59.121] <TB1> INFO: readTrimFile: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//003_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//003_HRData_150//trimParameters35_C15.dat
[11:26:59.152] <TB1> INFO: masking Roc 7 col/row: 48 2
[11:26:59.181] <TB1> INFO: masking Roc 14 col/row: 13 69
[11:26:59.190] <TB1> INFO: clk: 4
[11:26:59.190] <TB1> INFO: ctr: 4
[11:26:59.190] <TB1> INFO: sda: 19
[11:26:59.190] <TB1> INFO: tin: 9
[11:26:59.190] <TB1> INFO: level: 15
[11:26:59.190] <TB1> INFO: triggerdelay: 0
[11:26:59.190] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:26:59.190] <TB1> INFO: Log level: INFO
[11:26:59.203] <TB1> INFO: Found DTB DTB_WWXTQT
[11:26:59.213] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:26:59.217] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[11:26:59.219] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[11:27:00.756] <TB1> INFO: DUT info:
[11:27:00.756] <TB1> INFO: The DUT currently contains the following objects:
[11:27:00.756] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[11:27:00.756] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:27:00.756] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:27:00.756] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:27:00.756] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:27:00.756] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:27:00.756] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:27:00.756] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:27:00.756] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:27:00.756] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:27:00.756] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:27:00.756] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 1 masked, 0 active.
[11:27:00.756] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:27:00.756] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:27:00.756] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:27:00.756] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:27:00.756] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:27:00.756] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:27:00.756] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 1 masked, 0 active.
[11:27:00.756] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:27:01.157] <TB1> INFO: enter 'restricted' command line mode
[11:27:01.157] <TB1> INFO: enter test to run
[11:27:01.157] <TB1> INFO: test: delay setting parameters: ->5<-
[11:27:01.157] <TB1> INFO: delay test by 5 seconds...
[11:27:06.157] <TB1> INFO: enter test to run
[11:27:06.157] <TB1> INFO: test: Xray no parameter change
[11:27:06.157] <TB1> INFO: running: xray
[11:27:06.159] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//003_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//003_HRData_150//phCalibrationFitErr35_C15.dat
[11:27:06.289] <TB1> INFO: ######################################################################
[11:27:06.289] <TB1> INFO: PixTestXray::doTest()
[11:27:06.289] <TB1> INFO: ######################################################################
[11:27:06.289] <TB1> INFO: ----------------------------------------------------------------------
[11:27:06.289] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[11:27:06.289] <TB1> INFO: ----------------------------------------------------------------------
[11:27:06.291] <TB1> INFO: ROC 7 masking pixel 48/2
[11:27:06.291] <TB1> INFO: ROC 14 masking pixel 13/69
[11:27:07.254] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[11:27:10.431] <TB1> INFO: run duration 3 seconds, buffer almost full (81%), pausing triggers.
[11:27:33.648] <TB1> INFO: Resuming triggers.
[11:27:36.839] <TB1> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[11:28:00.318] <TB1> INFO: Resuming triggers.
[11:28:03.504] <TB1> INFO: run duration 9 seconds, buffer almost full (81%), pausing triggers.
[11:28:26.843] <TB1> INFO: Resuming triggers.
[11:28:30.033] <TB1> INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[11:28:53.191] <TB1> INFO: Resuming triggers.
[11:28:56.380] <TB1> INFO: run duration 15 seconds, buffer almost full (81%), pausing triggers.
[11:29:19.712] <TB1> INFO: Resuming triggers.
[11:29:22.901] <TB1> INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[11:29:46.199] <TB1> INFO: Resuming triggers.
[11:29:49.385] <TB1> INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[11:30:12.541] <TB1> INFO: Resuming triggers.
[11:30:15.727] <TB1> INFO: run duration 25 seconds, buffer almost full (81%), pausing triggers.
[11:30:39.435] <TB1> INFO: Resuming triggers.
[11:30:42.622] <TB1> INFO: run duration 28 seconds, buffer almost full (81%), pausing triggers.
[11:31:05.991] <TB1> INFO: Resuming triggers.
[11:31:09.175] <TB1> INFO: run duration 31 seconds, buffer almost full (81%), pausing triggers.
[11:31:32.671] <TB1> INFO: Resuming triggers.
[11:31:35.858] <TB1> INFO: run duration 35 seconds, buffer almost full (81%), pausing triggers.
[11:31:59.288] <TB1> INFO: Resuming triggers.
[11:32:02.469] <TB1> INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[11:32:26.006] <TB1> INFO: Resuming triggers.
[11:32:29.192] <TB1> INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[11:32:52.398] <TB1> INFO: Resuming triggers.
[11:32:55.581] <TB1> INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[11:33:19.089] <TB1> INFO: Resuming triggers.
[11:33:22.275] <TB1> INFO: run duration 47 seconds, buffer almost full (81%), pausing triggers.
[11:33:45.695] <TB1> INFO: Resuming triggers.
[11:33:48.878] <TB1> INFO: run duration 50 seconds, buffer almost full (81%), pausing triggers.
[11:34:12.460] <TB1> INFO: Resuming triggers.
[11:34:15.641] <TB1> INFO: run duration 54 seconds, buffer almost full (81%), pausing triggers.
[11:34:39.153] <TB1> INFO: Resuming triggers.
[11:34:42.337] <TB1> INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.
[11:35:05.702] <TB1> INFO: Resuming triggers.
[11:35:08.885] <TB1> INFO: run duration 60 seconds, buffer almost full (81%), pausing triggers.
[11:35:32.283] <TB1> INFO: Resuming triggers.
[11:35:35.465] <TB1> INFO: run duration 63 seconds, buffer almost full (81%), pausing triggers.
[11:35:58.959] <TB1> INFO: Resuming triggers.
[11:36:02.142] <TB1> INFO: run duration 66 seconds, buffer almost full (81%), pausing triggers.
[11:36:25.511] <TB1> INFO: Resuming triggers.
[11:36:28.696] <TB1> INFO: run duration 70 seconds, buffer almost full (81%), pausing triggers.
[11:36:51.927] <TB1> INFO: Resuming triggers.
[11:36:55.110] <TB1> INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[11:37:18.515] <TB1> INFO: Resuming triggers.
[11:37:21.696] <TB1> INFO: run duration 76 seconds, buffer almost full (81%), pausing triggers.
[11:37:45.101] <TB1> INFO: Resuming triggers.
[11:37:48.285] <TB1> INFO: run duration 79 seconds, buffer almost full (81%), pausing triggers.
[11:38:11.519] <TB1> INFO: Resuming triggers.
[11:38:14.697] <TB1> INFO: run duration 82 seconds, buffer almost full (81%), pausing triggers.
[11:38:38.132] <TB1> INFO: Resuming triggers.
[11:38:41.315] <TB1> INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[11:39:04.791] <TB1> INFO: Resuming triggers.
[11:39:07.977] <TB1> INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[11:39:31.227] <TB1> INFO: Resuming triggers.
[11:39:34.408] <TB1> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[11:39:57.777] <TB1> INFO: Resuming triggers.
[11:40:00.960] <TB1> INFO: run duration 95 seconds, buffer almost full (81%), pausing triggers.
[11:40:24.478] <TB1> INFO: Resuming triggers.
[11:40:27.658] <TB1> INFO: run duration 98 seconds, buffer almost full (81%), pausing triggers.
[11:40:51.171] <TB1> INFO: Resuming triggers.
[11:40:52.525] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[11:41:02.813] <TB1> INFO: PixTest:: pg_setup set to default.
[11:41:02.815] <TB1> INFO: PixTestXray::doPhRun() done
[11:41:02.815] <TB1> INFO: PixTestXray::doTest() done
[11:41:03.003] <TB1> INFO: enter test to run
[11:41:03.003] <TB1> INFO: test: no parameter change
[11:41:03.115] <TB1> QUIET: Connection to board 147 closed.
[11:41:03.198] <TB1> INFO: pXar: this is the end, my friend
commander_HRSCurves.log
[11:41:08.310] <TB1> INFO: *** Welcome to pxar ***
[11:41:08.310] <TB1> INFO: *** Today: 2015/12/02
[11:41:09.126] <TB1> INFO: *** Version: fb79
[11:41:09.126] <TB1> INFO: readRocDacs: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//004_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//004_HRSCurves_100//dacParameters35_C15.dat
[11:41:09.127] <TB1> INFO: readTbmDacs: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//004_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//004_HRSCurves_100//tbmParameters_C0b.dat
[11:41:09.127] <TB1> INFO: readMaskFile: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//004_HRSCurves_100//defaultMaskFile.dat
[11:41:09.127] <TB1> INFO: MASKED Roc 7 col/row: 48 2
[11:41:09.127] <TB1> INFO: MASKED Roc 14 col/row: 13 69
[11:41:09.127] <TB1> INFO: readTrimFile: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//004_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//004_HRSCurves_100//trimParameters35_C15.dat
[11:41:09.157] <TB1> INFO: masking Roc 7 col/row: 48 2
[11:41:09.188] <TB1> INFO: masking Roc 14 col/row: 13 69
[11:41:09.197] <TB1> INFO: clk: 4
[11:41:09.197] <TB1> INFO: ctr: 4
[11:41:09.197] <TB1> INFO: sda: 19
[11:41:09.197] <TB1> INFO: tin: 9
[11:41:09.197] <TB1> INFO: level: 15
[11:41:09.197] <TB1> INFO: triggerdelay: 0
[11:41:09.197] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:41:09.197] <TB1> INFO: Log level: INFO
[11:41:09.210] <TB1> INFO: Found DTB DTB_WWXTQT
[11:41:09.219] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:41:09.222] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[11:41:09.225] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[11:41:10.761] <TB1> INFO: DUT info:
[11:41:10.761] <TB1> INFO: The DUT currently contains the following objects:
[11:41:10.761] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[11:41:10.761] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:41:10.761] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:41:10.761] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:41:10.761] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:10.761] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:10.761] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:10.761] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:10.761] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:10.761] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:10.761] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:10.761] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 1 masked, 0 active.
[11:41:10.761] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:10.761] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:10.761] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:10.761] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:10.761] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:10.761] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:10.761] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 1 masked, 0 active.
[11:41:10.761] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:11.162] <TB1> INFO: enter 'restricted' command line mode
[11:41:11.162] <TB1> INFO: enter test to run
[11:41:11.162] <TB1> INFO: test: Highrate no parameter change
[11:41:11.162] <TB1> INFO: running: highrate
[11:41:11.165] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//004_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//004_HRSCurves_100//phCalibrationFitErr35_C15.dat
[11:41:11.297] <TB1> INFO: ----------------------------------------------------------------------
[11:41:11.297] <TB1> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[11:41:11.297] <TB1> INFO: ----------------------------------------------------------------------
[11:41:11.301] <TB1> INFO: ROC 7 masking pixel 48/2
[11:41:11.301] <TB1> INFO: ROC 14 masking pixel 13/69
[11:41:11.302] <TB1> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 896 (plus default)
[11:41:11.312] <TB1> INFO: dacScan step from 15 .. 34
[11:41:11.312] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[11:41:11.312] <TB1> INFO: run 1 of 1
[11:41:11.900] <TB1> INFO: Expecting 4160000 events.
[11:41:39.840] <TB1> INFO: 415650 events read in total (27410ms).
[11:42:07.428] <TB1> INFO: 832100 events read in total (54998ms).
[11:42:35.200] <TB1> INFO: 1248500 events read in total (82770ms).
[11:43:02.876] <TB1> INFO: 1664950 events read in total (110446ms).
[11:43:30.376] <TB1> INFO: 2081500 events read in total (137946ms).
[11:43:57.907] <TB1> INFO: 2497700 events read in total (165477ms).
[11:44:25.333] <TB1> INFO: 2913550 events read in total (192903ms).
[11:44:52.720] <TB1> INFO: 3329700 events read in total (220290ms).
[11:45:20.124] <TB1> INFO: 3745250 events read in total (247694ms).
[11:45:47.473] <TB1> INFO: 4160000 events read in total (275043ms).
[11:45:47.723] <TB1> INFO: Test took 276411ms.
[11:45:51.682] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:45:57.056] <TB1> INFO: dacScan step from 35 .. 54
[11:45:57.056] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[11:45:57.056] <TB1> INFO: run 1 of 1
[11:45:57.644] <TB1> INFO: Expecting 4160000 events.
[11:46:24.324] <TB1> INFO: 352150 events read in total (26153ms).
[11:46:50.544] <TB1> INFO: 705000 events read in total (52373ms).
[11:47:16.898] <TB1> INFO: 1057350 events read in total (78727ms).
[11:47:43.104] <TB1> INFO: 1409150 events read in total (104933ms).
[11:48:09.196] <TB1> INFO: 1759800 events read in total (131025ms).
[11:48:35.156] <TB1> INFO: 2109400 events read in total (156985ms).
[11:49:01.244] <TB1> INFO: 2456300 events read in total (183073ms).
[11:49:27.079] <TB1> INFO: 2801050 events read in total (208908ms).
[11:49:52.981] <TB1> INFO: 3143300 events read in total (234810ms).
[11:50:19.015] <TB1> INFO: 3483500 events read in total (260844ms).
[11:50:44.851] <TB1> INFO: 3822200 events read in total (286680ms).
[11:51:10.621] <TB1> INFO: 4160000 events read in total (312450ms).
[11:51:10.837] <TB1> INFO: Test took 313781ms.
[11:51:15.321] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:51:20.951] <TB1> INFO: dacScan step from 55 .. 74
[11:51:20.951] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[11:51:20.951] <TB1> INFO: run 1 of 1
[11:51:21.543] <TB1> INFO: Expecting 4160000 events.
[11:51:47.305] <TB1> INFO: 315150 events read in total (25235ms).
[11:52:12.767] <TB1> INFO: 631050 events read in total (50697ms).
[11:52:38.333] <TB1> INFO: 946850 events read in total (76263ms).
[11:53:03.697] <TB1> INFO: 1262600 events read in total (101627ms).
[11:53:28.852] <TB1> INFO: 1578350 events read in total (126782ms).
[11:53:54.244] <TB1> INFO: 1894100 events read in total (152174ms).
[11:54:19.780] <TB1> INFO: 2210050 events read in total (177710ms).
[11:54:45.137] <TB1> INFO: 2525550 events read in total (203067ms).
[11:55:10.492] <TB1> INFO: 2841500 events read in total (228422ms).
[11:55:35.862] <TB1> INFO: 3157300 events read in total (253792ms).
[11:56:01.078] <TB1> INFO: 3473050 events read in total (279008ms).
[11:56:26.211] <TB1> INFO: 3788850 events read in total (304141ms).
[11:56:51.300] <TB1> INFO: 4104200 events read in total (329230ms).
[11:56:55.978] <TB1> INFO: 4160000 events read in total (333908ms).
[11:56:56.193] <TB1> INFO: Test took 335241ms.
[11:57:00.312] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:57:05.860] <TB1> INFO: dacScan step from 75 .. 75
[11:57:05.860] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[11:57:05.860] <TB1> INFO: run 1 of 1
[11:57:06.451] <TB1> INFO: Expecting 208000 events.
[11:57:24.410] <TB1> INFO: 208000 events read in total (17432ms).
[11:57:24.418] <TB1> INFO: Test took 18557ms.
[11:57:24.509] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:57:24.794] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[11:57:26.055] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[11:57:27.050] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[11:57:28.051] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[11:57:29.097] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[11:57:30.141] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[11:57:31.194] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[11:57:32.229] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[11:57:33.274] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[11:57:34.311] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[11:57:35.336] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[11:57:36.388] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[11:57:37.415] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[11:57:38.436] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[11:57:39.431] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[11:57:40.451] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[11:57:41.466] <TB1> INFO: PixTest:: pg_setup set to default.
[11:57:41.468] <TB1> INFO: vcal mean: 38.46 38.79 38.12 40.81 41.67 42.48 42.70 42.90 42.04 41.30 42.14 41.55 41.54 38.92 37.98 37.52
[11:57:41.468] <TB1> INFO: vcal RMS: 1.39 1.40 1.22 1.63 1.41 1.65 1.69 1.81 1.74 1.63 1.70 1.86 1.56 1.57 1.40 1.24
[11:57:41.468] <TB1> INFO: number of X-ray hits detected: 221112 233352 216323 351848 374408 453534 457241 470941 433628 428224 434300 385902 382310 227089 207889 229981
[11:57:41.468] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:57:41.468] <TB1> INFO: X-ray hit rate [MHz/cm2]: 64.8 68.4 63.4 103.1 109.7 132.9 134.0 138.0 127.1 125.5 127.3 113.1 112.1 66.6 60.9 67.4
[11:57:41.468] <TB1> INFO: PixTestHighRate::doXNoiseMaps() done
[11:57:41.565] <TB1> INFO: enter test to run
[11:57:41.565] <TB1> INFO: test: no parameter change
[11:57:41.657] <TB1> QUIET: Connection to board 147 closed.
[11:57:41.737] <TB1> INFO: pXar: this is the end, my friend
commander_CalDelScanAndSaveDacs.log
[12:13:09.084] <TB1> INFO: *** Welcome to pxar ***
[12:13:09.084] <TB1> INFO: *** Today: 2015/12/02
[12:13:09.451] <TB1> INFO: *** Version: fb79
[12:13:09.451] <TB1> INFO: readRocDacs: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[12:13:09.451] <TB1> INFO: readTbmDacs: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[12:13:09.451] <TB1> INFO: readMaskFile: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[12:13:09.451] <TB1> INFO: MASKED Roc 7 col/row: 48 2
[12:13:09.451] <TB1> INFO: MASKED Roc 14 col/row: 13 69
[12:13:09.451] <TB1> INFO: readTrimFile: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[12:13:09.482] <TB1> INFO: masking Roc 7 col/row: 48 2
[12:13:09.511] <TB1> INFO: masking Roc 14 col/row: 13 69
[12:13:09.520] <TB1> INFO: clk: 4
[12:13:09.520] <TB1> INFO: ctr: 4
[12:13:09.520] <TB1> INFO: sda: 19
[12:13:09.520] <TB1> INFO: tin: 9
[12:13:09.520] <TB1> INFO: level: 15
[12:13:09.520] <TB1> INFO: triggerdelay: 0
[12:13:09.520] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[12:13:09.520] <TB1> INFO: Log level: INFO
[12:13:09.532] <TB1> INFO: Found DTB DTB_WWXTQT
[12:13:09.541] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:13:09.545] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:13:09.547] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[12:13:11.080] <TB1> INFO: DUT info:
[12:13:11.080] <TB1> INFO: The DUT currently contains the following objects:
[12:13:11.080] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:13:11.080] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:13:11.080] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:13:11.080] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:13:11.081] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:11.081] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:11.081] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:11.081] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:11.081] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:11.081] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:11.081] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:11.081] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 1 masked, 0 active.
[12:13:11.081] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:11.081] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:11.081] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:11.081] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:11.081] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:11.081] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:11.081] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 1 masked, 0 active.
[12:13:11.081] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:11.481] <TB1> INFO: enter 'restricted' command line mode
[12:13:11.482] <TB1> INFO: enter test to run
[12:13:11.482] <TB1> INFO: test: HighRate no parameter change
[12:13:11.482] <TB1> INFO: running: highrate
[12:13:11.484] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[12:13:11.613] <TB1> INFO: ----------------------------------------------------------------------
[12:13:11.613] <TB1> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[12:13:11.613] <TB1> INFO: ----------------------------------------------------------------------
[12:13:11.749] <TB1> INFO: Expecting 768 events.
[12:13:12.976] <TB1> INFO: 768 events read in total (509ms).
[12:13:13.071] <TB1> INFO: Test took 1454ms.
[12:13:13.073] <TB1> INFO: ROC 7 masking pixel 48/2
[12:13:13.073] <TB1> INFO: ROC 14 masking pixel 13/69
[12:13:13.685] <TB1> INFO: Expecting 41600 events.
[12:13:17.215] <TB1> INFO: 41600 events read in total (3002ms).
[12:13:17.216] <TB1> INFO: Test took 4141ms.
[12:13:17.295] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:13:17.935] <TB1> INFO: Expecting 41600 events.
[12:13:21.474] <TB1> INFO: 41600 events read in total (3011ms).
[12:13:21.475] <TB1> INFO: Test took 4151ms.
[12:13:21.554] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:13:22.195] <TB1> INFO: Expecting 41600 events.
[12:13:25.778] <TB1> INFO: 41600 events read in total (3056ms).
[12:13:25.780] <TB1> INFO: Test took 4196ms.
[12:13:25.858] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:13:26.500] <TB1> INFO: Expecting 41600 events.
[12:13:30.078] <TB1> INFO: 41600 events read in total (3051ms).
[12:13:30.080] <TB1> INFO: Test took 4192ms.
[12:13:30.157] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:13:30.800] <TB1> INFO: Expecting 41600 events.
[12:13:34.508] <TB1> INFO: 41600 events read in total (3180ms).
[12:13:34.510] <TB1> INFO: Test took 4321ms.
[12:13:34.591] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:13:35.233] <TB1> INFO: Expecting 41600 events.
[12:13:38.830] <TB1> INFO: 41600 events read in total (3070ms).
[12:13:38.831] <TB1> INFO: Test took 4209ms.
[12:13:38.912] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:13:39.553] <TB1> INFO: Expecting 41600 events.
[12:13:43.179] <TB1> INFO: 41600 events read in total (3099ms).
[12:13:43.181] <TB1> INFO: Test took 4239ms.
[12:13:43.261] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:13:43.904] <TB1> INFO: Expecting 41600 events.
[12:13:47.492] <TB1> INFO: 41600 events read in total (3062ms).
[12:13:47.494] <TB1> INFO: Test took 4202ms.
[12:13:47.576] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:13:48.219] <TB1> INFO: Expecting 41600 events.
[12:13:51.817] <TB1> INFO: 41600 events read in total (3071ms).
[12:13:51.818] <TB1> INFO: Test took 4211ms.
[12:13:51.900] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:13:52.544] <TB1> INFO: Expecting 41600 events.
[12:13:56.206] <TB1> INFO: 41600 events read in total (3135ms).
[12:13:56.208] <TB1> INFO: Test took 4276ms.
[12:13:56.289] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:13:56.931] <TB1> INFO: Expecting 41600 events.
[12:14:00.519] <TB1> INFO: 41600 events read in total (3060ms).
[12:14:00.521] <TB1> INFO: Test took 4200ms.
[12:14:00.600] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:01.241] <TB1> INFO: Expecting 41600 events.
[12:14:04.914] <TB1> INFO: 41600 events read in total (3146ms).
[12:14:04.916] <TB1> INFO: Test took 4286ms.
[12:14:04.996] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:05.638] <TB1> INFO: Expecting 41600 events.
[12:14:09.271] <TB1> INFO: 41600 events read in total (3106ms).
[12:14:09.272] <TB1> INFO: Test took 4246ms.
[12:14:09.355] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:10.000] <TB1> INFO: Expecting 41600 events.
[12:14:13.629] <TB1> INFO: 41600 events read in total (3102ms).
[12:14:13.630] <TB1> INFO: Test took 4241ms.
[12:14:13.710] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:14.351] <TB1> INFO: Expecting 41600 events.
[12:14:17.951] <TB1> INFO: 41600 events read in total (3073ms).
[12:14:17.952] <TB1> INFO: Test took 4212ms.
[12:14:18.034] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:18.678] <TB1> INFO: Expecting 41600 events.
[12:14:22.339] <TB1> INFO: 41600 events read in total (3134ms).
[12:14:22.341] <TB1> INFO: Test took 4275ms.
[12:14:22.420] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:23.062] <TB1> INFO: Expecting 41600 events.
[12:14:26.688] <TB1> INFO: 41600 events read in total (3099ms).
[12:14:26.690] <TB1> INFO: Test took 4239ms.
[12:14:26.768] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:27.410] <TB1> INFO: Expecting 41600 events.
[12:14:31.083] <TB1> INFO: 41600 events read in total (3146ms).
[12:14:31.085] <TB1> INFO: Test took 4286ms.
[12:14:31.163] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:31.807] <TB1> INFO: Expecting 41600 events.
[12:14:35.414] <TB1> INFO: 41600 events read in total (3080ms).
[12:14:35.416] <TB1> INFO: Test took 4220ms.
[12:14:35.494] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:36.137] <TB1> INFO: Expecting 41600 events.
[12:14:39.653] <TB1> INFO: 41600 events read in total (2989ms).
[12:14:39.654] <TB1> INFO: Test took 4128ms.
[12:14:39.733] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:40.051] <TB1> INFO: enter test to run
[12:14:40.051] <TB1> INFO: test: Pretest no parameter change
[12:14:40.051] <TB1> INFO: running: pretest
[12:14:40.052] <TB1> INFO: write dac parameters into /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[12:14:40.052] <TB1> INFO: write dac parameters into /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[12:14:40.052] <TB1> INFO: write dac parameters into /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[12:14:40.052] <TB1> INFO: write dac parameters into /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[12:14:40.052] <TB1> INFO: write dac parameters into /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[12:14:40.052] <TB1> INFO: write dac parameters into /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[12:14:40.052] <TB1> INFO: write dac parameters into /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[12:14:40.052] <TB1> INFO: write dac parameters into /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[12:14:40.053] <TB1> INFO: write dac parameters into /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[12:14:40.053] <TB1> INFO: write dac parameters into /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[12:14:40.053] <TB1> INFO: write dac parameters into /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[12:14:40.053] <TB1> INFO: write dac parameters into /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[12:14:40.053] <TB1> INFO: write dac parameters into /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[12:14:40.053] <TB1> INFO: write dac parameters into /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[12:14:40.053] <TB1> INFO: write dac parameters into /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[12:14:40.053] <TB1> INFO: write dac parameters into /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//009_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[12:14:40.053] <TB1> INFO: enter test to run
[12:14:40.053] <TB1> INFO: test: no parameter change
[12:14:40.152] <TB1> QUIET: Connection to board 147 closed.
[12:14:40.231] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:14:45.339] <TB1> INFO: *** Welcome to pxar ***
[12:14:45.339] <TB1> INFO: *** Today: 2015/12/02
[12:14:45.671] <TB1> INFO: *** Version: fb79
[12:14:45.671] <TB1> INFO: readRocDacs: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//010_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//010_HREfficiency_50//dacParameters35_C15.dat
[12:14:45.671] <TB1> INFO: readTbmDacs: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//010_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//010_HREfficiency_50//tbmParameters_C0b.dat
[12:14:45.672] <TB1> INFO: readMaskFile: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//010_HREfficiency_50//defaultMaskFile.dat
[12:14:45.672] <TB1> INFO: MASKED Roc 7 col/row: 48 2
[12:14:45.672] <TB1> INFO: MASKED Roc 14 col/row: 13 69
[12:14:45.672] <TB1> INFO: readTrimFile: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//010_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//010_HREfficiency_50//trimParameters35_C15.dat
[12:14:45.701] <TB1> INFO: masking Roc 7 col/row: 48 2
[12:14:45.729] <TB1> INFO: masking Roc 14 col/row: 13 69
[12:14:45.738] <TB1> INFO: clk: 4
[12:14:45.738] <TB1> INFO: ctr: 4
[12:14:45.738] <TB1> INFO: sda: 19
[12:14:45.738] <TB1> INFO: tin: 9
[12:14:45.738] <TB1> INFO: level: 15
[12:14:45.738] <TB1> INFO: triggerdelay: 0
[12:14:45.738] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[12:14:45.738] <TB1> INFO: Log level: INFO
[12:14:45.751] <TB1> INFO: Found DTB DTB_WWXTQT
[12:14:45.761] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:14:45.764] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:14:45.766] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[12:14:47.305] <TB1> INFO: DUT info:
[12:14:47.305] <TB1> INFO: The DUT currently contains the following objects:
[12:14:47.305] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:14:47.305] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:14:47.305] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:14:47.305] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:14:47.305] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:14:47.305] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:14:47.305] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:14:47.305] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:14:47.305] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:14:47.305] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:14:47.305] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:14:47.305] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 1 masked, 0 active.
[12:14:47.305] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:14:47.305] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:14:47.305] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:14:47.305] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:14:47.305] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:14:47.305] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:14:47.305] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 1 masked, 0 active.
[12:14:47.305] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:14:47.706] <TB1> INFO: enter 'restricted' command line mode
[12:14:47.706] <TB1> INFO: enter test to run
[12:14:47.706] <TB1> INFO: test: PixelAlive no parameter change
[12:14:47.706] <TB1> INFO: running: pixelalive
[12:14:47.710] <TB1> INFO: ######################################################################
[12:14:47.710] <TB1> INFO: PixTestAlive::doTest()
[12:14:47.710] <TB1> INFO: ######################################################################
[12:14:47.712] <TB1> INFO: ----------------------------------------------------------------------
[12:14:47.712] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:14:47.712] <TB1> INFO: ----------------------------------------------------------------------
[12:14:47.713] <TB1> INFO: ROC 7 masking pixel 48/2
[12:14:47.713] <TB1> INFO: ROC 14 masking pixel 13/69
[12:14:48.014] <TB1> INFO: Expecting 208000 events.
[12:14:58.113] <TB1> INFO: 208000 events read in total (9381ms).
[12:14:58.142] <TB1> INFO: Test took 10429ms.
[12:14:58.149] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:58.402] <TB1> INFO: PixTestAlive::aliveTest() done
[12:14:58.402] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 1 0 0 0 0 0 0 1 0
[12:14:58.402] <TB1> INFO: ROC 7 masking pixel 48/2
[12:14:58.402] <TB1> INFO: ROC 14 masking pixel 13/69
[12:14:58.403] <TB1> INFO: ----------------------------------------------------------------------
[12:14:58.403] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:14:58.403] <TB1> INFO: ----------------------------------------------------------------------
[12:14:58.700] <TB1> INFO: Expecting 208000 events.
[12:15:05.488] <TB1> INFO: 208000 events read in total (6073ms).
[12:15:05.489] <TB1> INFO: Test took 7084ms.
[12:15:05.489] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:15:05.490] <TB1> INFO: ROC 7 masking pixel 48/2
[12:15:05.490] <TB1> INFO: ROC 14 masking pixel 13/69
[12:15:05.490] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:15:05.799] <TB1> INFO: PixTestAlive::maskTest() done
[12:15:05.799] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:15:05.799] <TB1> INFO: ROC 7 masking pixel 48/2
[12:15:05.799] <TB1> INFO: ROC 14 masking pixel 13/69
[12:15:05.800] <TB1> INFO: ----------------------------------------------------------------------
[12:15:05.800] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:15:05.800] <TB1> INFO: ----------------------------------------------------------------------
[12:15:05.802] <TB1> INFO: ROC 7 masking pixel 48/2
[12:15:05.802] <TB1> INFO: ROC 14 masking pixel 13/69
[12:15:06.101] <TB1> INFO: Expecting 208000 events.
[12:15:16.117] <TB1> INFO: 208000 events read in total (9301ms).
[12:15:16.118] <TB1> INFO: Test took 10316ms.
[12:15:16.124] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:15:16.362] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[12:15:16.362] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:15:16.362] <TB1> INFO: ROC 7 masking pixel 48/2
[12:15:16.362] <TB1> INFO: ROC 14 masking pixel 13/69
[12:15:16.362] <TB1> INFO: PixTestAlive::doTest() done, duration: 28 seconds
[12:15:16.391] <TB1> INFO: enter test to run
[12:15:16.391] <TB1> INFO: test: delay setting parameters: ->2<-
[12:15:16.391] <TB1> INFO: delay test by 2 seconds...
[12:15:18.391] <TB1> INFO: enter test to run
[12:15:18.391] <TB1> INFO: test: HighRate no parameter change
[12:15:18.391] <TB1> INFO: running: highrate
[12:15:18.391] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//010_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//010_HREfficiency_50//phCalibrationFitErr35_C15.dat
[12:15:18.523] <TB1> INFO: ----------------------------------------------------------------------
[12:15:18.523] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:15:18.523] <TB1> INFO: ----------------------------------------------------------------------
[12:15:18.527] <TB1> INFO: ROC 7 masking pixel 48/2
[12:15:18.527] <TB1> INFO: ROC 14 masking pixel 13/69
[12:15:19.120] <TB1> INFO: Expecting 208000 events.
[12:15:32.433] <TB1> INFO: 208000 events read in total (12786ms).
[12:15:32.440] <TB1> INFO: Test took 13913ms.
[12:15:32.736] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:15:33.027] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 1 0 0 0 0 0 0 1 0
[12:15:33.027] <TB1> INFO: number of red-efficiency pixels: 146 158 151 290 289 428 431 384 377 378 425 329 353 202 137 167
[12:15:33.027] <TB1> INFO: number of X-ray hits detected: 109462 114790 105755 176367 187675 227313 228316 236776 217844 215456 220989 193427 191009 111361 101215 113632
[12:15:33.027] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[12:15:33.027] <TB1> INFO: number of Vcal hits detected: 207852 207840 207844 207699 207697 207545 207526 207539 207603 207585 207545 207652 207600 207786 207810 207826
[12:15:33.027] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.9 99.9 99.9
[12:15:33.027] <TB1> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.9 99.9 99.9
[12:15:33.027] <TB1> INFO: X-ray hit rate [MHz/cm2]: 32.1 33.6 31.0 51.7 55.0 66.6 66.9 69.4 63.9 63.2 64.8 56.7 56.0 32.6 29.7 33.3
[12:15:33.027] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[12:15:33.057] <TB1> INFO: PixTest:: pg_setup set to default.
[12:15:33.066] <TB1> INFO: enter test to run
[12:15:33.066] <TB1> INFO: test: no parameter change
[12:15:33.170] <TB1> QUIET: Connection to board 147 closed.
[12:15:33.252] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:15:37.617] <TB1> INFO: *** Welcome to pxar ***
[12:15:37.617] <TB1> INFO: *** Today: 2015/12/02
[12:15:37.935] <TB1> INFO: *** Version: fb79
[12:15:37.935] <TB1> INFO: readRocDacs: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//011_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//011_HREfficiency_100//dacParameters35_C15.dat
[12:15:37.935] <TB1> INFO: readTbmDacs: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//011_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//011_HREfficiency_100//tbmParameters_C0b.dat
[12:15:37.935] <TB1> INFO: readMaskFile: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//011_HREfficiency_100//defaultMaskFile.dat
[12:15:37.935] <TB1> INFO: MASKED Roc 7 col/row: 48 2
[12:15:37.935] <TB1> INFO: MASKED Roc 14 col/row: 13 69
[12:15:37.935] <TB1> INFO: readTrimFile: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//011_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//011_HREfficiency_100//trimParameters35_C15.dat
[12:15:37.964] <TB1> INFO: masking Roc 7 col/row: 48 2
[12:15:37.992] <TB1> INFO: masking Roc 14 col/row: 13 69
[12:15:38.000] <TB1> INFO: clk: 4
[12:15:38.000] <TB1> INFO: ctr: 4
[12:15:38.000] <TB1> INFO: sda: 19
[12:15:38.000] <TB1> INFO: tin: 9
[12:15:38.000] <TB1> INFO: level: 15
[12:15:38.000] <TB1> INFO: triggerdelay: 0
[12:15:38.000] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[12:15:38.000] <TB1> INFO: Log level: INFO
[12:15:38.013] <TB1> INFO: Found DTB DTB_WWXTQT
[12:15:38.022] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:15:38.026] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:15:38.028] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[12:15:39.568] <TB1> INFO: DUT info:
[12:15:39.568] <TB1> INFO: The DUT currently contains the following objects:
[12:15:39.568] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:15:39.568] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:15:39.568] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:15:39.568] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:15:39.568] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:39.568] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:39.568] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:39.568] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:39.568] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:39.568] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:39.568] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:39.568] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 1 masked, 0 active.
[12:15:39.568] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:39.568] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:39.568] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:39.568] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:39.568] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:39.568] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:39.568] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 1 masked, 0 active.
[12:15:39.568] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:39.969] <TB1> INFO: enter 'restricted' command line mode
[12:15:39.969] <TB1> INFO: enter test to run
[12:15:39.969] <TB1> INFO: test: PixelAlive no parameter change
[12:15:39.969] <TB1> INFO: running: pixelalive
[12:15:39.973] <TB1> INFO: ######################################################################
[12:15:39.973] <TB1> INFO: PixTestAlive::doTest()
[12:15:39.973] <TB1> INFO: ######################################################################
[12:15:39.975] <TB1> INFO: ----------------------------------------------------------------------
[12:15:39.975] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:15:39.975] <TB1> INFO: ----------------------------------------------------------------------
[12:15:39.976] <TB1> INFO: ROC 7 masking pixel 48/2
[12:15:39.976] <TB1> INFO: ROC 14 masking pixel 13/69
[12:15:40.278] <TB1> INFO: Expecting 208000 events.
[12:15:50.364] <TB1> INFO: 208000 events read in total (9368ms).
[12:15:50.393] <TB1> INFO: Test took 10417ms.
[12:15:50.402] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:15:50.655] <TB1> INFO: PixTestAlive::aliveTest() done
[12:15:50.655] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 1 0 0 0 0 0 0 1 0
[12:15:50.656] <TB1> INFO: ROC 7 masking pixel 48/2
[12:15:50.656] <TB1> INFO: ROC 14 masking pixel 13/69
[12:15:50.657] <TB1> INFO: ----------------------------------------------------------------------
[12:15:50.657] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:15:50.657] <TB1> INFO: ----------------------------------------------------------------------
[12:15:50.954] <TB1> INFO: Expecting 208000 events.
[12:15:57.628] <TB1> INFO: 208000 events read in total (5958ms).
[12:15:57.628] <TB1> INFO: Test took 6970ms.
[12:15:57.628] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:15:57.629] <TB1> INFO: ROC 7 masking pixel 48/2
[12:15:57.629] <TB1> INFO: ROC 14 masking pixel 13/69
[12:15:57.629] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:15:57.939] <TB1> INFO: PixTestAlive::maskTest() done
[12:15:57.939] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:15:57.939] <TB1> INFO: ROC 7 masking pixel 48/2
[12:15:57.939] <TB1> INFO: ROC 14 masking pixel 13/69
[12:15:57.940] <TB1> INFO: ----------------------------------------------------------------------
[12:15:57.940] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:15:57.940] <TB1> INFO: ----------------------------------------------------------------------
[12:15:57.942] <TB1> INFO: ROC 7 masking pixel 48/2
[12:15:57.942] <TB1> INFO: ROC 14 masking pixel 13/69
[12:15:58.242] <TB1> INFO: Expecting 208000 events.
[12:16:08.299] <TB1> INFO: 208000 events read in total (9341ms).
[12:16:08.300] <TB1> INFO: Test took 10358ms.
[12:16:08.308] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:16:08.544] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[12:16:08.544] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:16:08.544] <TB1> INFO: ROC 7 masking pixel 48/2
[12:16:08.544] <TB1> INFO: ROC 14 masking pixel 13/69
[12:16:08.544] <TB1> INFO: PixTestAlive::doTest() done, duration: 28 seconds
[12:16:08.574] <TB1> INFO: enter test to run
[12:16:08.574] <TB1> INFO: test: delay setting parameters: ->2<-
[12:16:08.574] <TB1> INFO: delay test by 2 seconds...
[12:16:10.574] <TB1> INFO: enter test to run
[12:16:10.574] <TB1> INFO: test: HighRate no parameter change
[12:16:10.574] <TB1> INFO: running: highrate
[12:16:10.574] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//011_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//011_HREfficiency_100//phCalibrationFitErr35_C15.dat
[12:16:10.700] <TB1> INFO: ----------------------------------------------------------------------
[12:16:10.700] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:16:10.700] <TB1> INFO: ----------------------------------------------------------------------
[12:16:10.704] <TB1> INFO: ROC 7 masking pixel 48/2
[12:16:10.704] <TB1> INFO: ROC 14 masking pixel 13/69
[12:16:11.300] <TB1> INFO: Expecting 208000 events.
[12:16:28.876] <TB1> INFO: 208000 events read in total (17049ms).
[12:16:28.886] <TB1> INFO: Test took 18182ms.
[12:16:29.464] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:16:29.851] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 1 0 0 0 0 0 0 1 0
[12:16:29.851] <TB1> INFO: number of red-efficiency pixels: 403 459 513 961 1068 1597 1599 1670 1377 1487 1420 1141 1270 602 455 431
[12:16:29.851] <TB1> INFO: number of X-ray hits detected: 220550 233983 217314 352851 373389 450951 456283 470125 436238 429336 433157 387060 381683 227572 208639 228641
[12:16:29.851] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[12:16:29.851] <TB1> INFO: number of Vcal hits detected: 207566 207512 207325 206791 206594 205633 205586 205577 206158 205843 205984 206421 206214 207167 207459 207530
[12:16:29.851] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.8 99.8 99.7 99.5 99.4 99.0 99.0 99.0 99.2 99.1 99.2 99.3 99.2 99.7 99.8 99.8
[12:16:29.851] <TB1> INFO: Vcal hit overall efficiency (%): 99.8 99.8 99.7 99.4 99.3 98.9 98.8 98.8 99.1 99.0 99.0 99.2 99.1 99.6 99.7 99.8
[12:16:29.851] <TB1> INFO: X-ray hit rate [MHz/cm2]: 64.6 68.6 63.7 103.4 109.4 132.2 133.7 137.8 127.9 125.8 127.0 113.5 111.9 66.7 61.2 67.0
[12:16:29.851] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[12:16:29.883] <TB1> INFO: PixTest:: pg_setup set to default.
[12:16:29.893] <TB1> INFO: enter test to run
[12:16:29.893] <TB1> INFO: test: no parameter change
[12:16:29.970] <TB1> QUIET: Connection to board 147 closed.
[12:16:30.049] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:16:36.198] <TB1> INFO: *** Welcome to pxar ***
[12:16:36.198] <TB1> INFO: *** Today: 2015/12/02
[12:16:36.805] <TB1> INFO: *** Version: fb79
[12:16:36.805] <TB1> INFO: readRocDacs: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//012_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//012_HREfficiency_150//dacParameters35_C15.dat
[12:16:36.806] <TB1> INFO: readTbmDacs: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//012_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//012_HREfficiency_150//tbmParameters_C0b.dat
[12:16:36.806] <TB1> INFO: readMaskFile: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//012_HREfficiency_150//defaultMaskFile.dat
[12:16:36.806] <TB1> INFO: MASKED Roc 7 col/row: 48 2
[12:16:36.806] <TB1> INFO: MASKED Roc 14 col/row: 13 69
[12:16:36.806] <TB1> INFO: readTrimFile: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//012_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//012_HREfficiency_150//trimParameters35_C15.dat
[12:16:36.837] <TB1> INFO: masking Roc 7 col/row: 48 2
[12:16:36.867] <TB1> INFO: masking Roc 14 col/row: 13 69
[12:16:36.876] <TB1> INFO: clk: 4
[12:16:36.876] <TB1> INFO: ctr: 4
[12:16:36.876] <TB1> INFO: sda: 19
[12:16:36.876] <TB1> INFO: tin: 9
[12:16:36.876] <TB1> INFO: level: 15
[12:16:36.876] <TB1> INFO: triggerdelay: 0
[12:16:36.876] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[12:16:36.876] <TB1> INFO: Log level: INFO
[12:16:36.888] <TB1> INFO: Found DTB DTB_WWXTQT
[12:16:36.898] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:16:36.901] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:16:36.903] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[12:16:38.442] <TB1> INFO: DUT info:
[12:16:38.442] <TB1> INFO: The DUT currently contains the following objects:
[12:16:38.442] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:16:38.442] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:16:38.442] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:16:38.442] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:16:38.442] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:38.442] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:38.442] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:38.442] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:38.442] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:38.442] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:38.442] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:38.442] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 1 masked, 0 active.
[12:16:38.442] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:38.442] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:38.442] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:38.442] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:38.442] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:38.442] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:38.442] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 1 masked, 0 active.
[12:16:38.442] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:38.843] <TB1> INFO: enter 'restricted' command line mode
[12:16:38.843] <TB1> INFO: enter test to run
[12:16:38.843] <TB1> INFO: test: PixelAlive no parameter change
[12:16:38.843] <TB1> INFO: running: pixelalive
[12:16:38.847] <TB1> INFO: ######################################################################
[12:16:38.847] <TB1> INFO: PixTestAlive::doTest()
[12:16:38.847] <TB1> INFO: ######################################################################
[12:16:38.849] <TB1> INFO: ----------------------------------------------------------------------
[12:16:38.849] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:16:38.849] <TB1> INFO: ----------------------------------------------------------------------
[12:16:38.850] <TB1> INFO: ROC 7 masking pixel 48/2
[12:16:38.850] <TB1> INFO: ROC 14 masking pixel 13/69
[12:16:39.150] <TB1> INFO: Expecting 208000 events.
[12:16:49.419] <TB1> INFO: 208000 events read in total (9550ms).
[12:16:49.446] <TB1> INFO: Test took 10596ms.
[12:16:49.452] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:16:49.705] <TB1> INFO: PixTestAlive::aliveTest() done
[12:16:49.705] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 1 0 0 0 0 0 0 1 0
[12:16:49.705] <TB1> INFO: ROC 7 masking pixel 48/2
[12:16:49.705] <TB1> INFO: ROC 14 masking pixel 13/69
[12:16:49.706] <TB1> INFO: ----------------------------------------------------------------------
[12:16:49.706] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:16:49.706] <TB1> INFO: ----------------------------------------------------------------------
[12:16:50.006] <TB1> INFO: Expecting 208000 events.
[12:16:56.736] <TB1> INFO: 208000 events read in total (6014ms).
[12:16:56.737] <TB1> INFO: Test took 7029ms.
[12:16:56.737] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:16:56.737] <TB1> INFO: ROC 7 masking pixel 48/2
[12:16:56.737] <TB1> INFO: ROC 14 masking pixel 13/69
[12:16:56.738] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:16:57.047] <TB1> INFO: PixTestAlive::maskTest() done
[12:16:57.047] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:16:57.048] <TB1> INFO: ROC 7 masking pixel 48/2
[12:16:57.048] <TB1> INFO: ROC 14 masking pixel 13/69
[12:16:57.049] <TB1> INFO: ----------------------------------------------------------------------
[12:16:57.049] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:16:57.049] <TB1> INFO: ----------------------------------------------------------------------
[12:16:57.050] <TB1> INFO: ROC 7 masking pixel 48/2
[12:16:57.050] <TB1> INFO: ROC 14 masking pixel 13/69
[12:16:57.348] <TB1> INFO: Expecting 208000 events.
[12:17:07.344] <TB1> INFO: 208000 events read in total (9281ms).
[12:17:07.344] <TB1> INFO: Test took 10294ms.
[12:17:07.351] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:17:07.588] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[12:17:07.588] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:17:07.588] <TB1> INFO: ROC 7 masking pixel 48/2
[12:17:07.588] <TB1> INFO: ROC 14 masking pixel 13/69
[12:17:07.588] <TB1> INFO: PixTestAlive::doTest() done, duration: 28 seconds
[12:17:07.619] <TB1> INFO: enter test to run
[12:17:07.619] <TB1> INFO: test: delay setting parameters: ->2<-
[12:17:07.619] <TB1> INFO: delay test by 2 seconds...
[12:17:09.619] <TB1> INFO: enter test to run
[12:17:09.619] <TB1> INFO: test: HighRate no parameter change
[12:17:09.619] <TB1> INFO: running: highrate
[12:17:09.619] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//012_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//012_HREfficiency_150//phCalibrationFitErr35_C15.dat
[12:17:09.749] <TB1> INFO: ----------------------------------------------------------------------
[12:17:09.749] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:17:09.749] <TB1> INFO: ----------------------------------------------------------------------
[12:17:09.752] <TB1> INFO: ROC 7 masking pixel 48/2
[12:17:09.752] <TB1> INFO: ROC 14 masking pixel 13/69
[12:17:10.344] <TB1> INFO: Expecting 208000 events.
[12:17:32.172] <TB1> INFO: 208000 events read in total (21301ms).
[12:17:32.184] <TB1> INFO: Test took 22431ms.
[12:17:33.011] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:17:33.478] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 1 0 0 0 0 0 0 1 0
[12:17:33.478] <TB1> INFO: number of red-efficiency pixels: 820 975 936 1996 2159 2917 2895 3132 2828 2816 2760 2295 2470 1079 891 968
[12:17:33.478] <TB1> INFO: number of X-ray hits detected: 319820 339150 317759 504401 536906 644368 658593 678217 626760 618594 622319 556995 553757 330161 304791 331520
[12:17:33.478] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[12:17:33.478] <TB1> INFO: number of Vcal hits detected: 207023 206828 206280 204685 203992 201459 200792 201009 202248 201771 202225 203482 203232 205965 206895 206832
[12:17:33.478] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.6 99.5 99.3 98.6 98.3 97.3 97.0 97.0 97.5 97.4 97.6 98.1 98.0 99.2 99.5 99.5
[12:17:33.478] <TB1> INFO: Vcal hit overall efficiency (%): 99.5 99.4 99.2 98.4 98.1 96.9 96.5 96.6 97.2 97.0 97.2 97.8 97.7 99.0 99.5 99.4
[12:17:33.478] <TB1> INFO: X-ray hit rate [MHz/cm2]: 93.7 99.4 93.1 147.8 157.4 188.9 193.0 198.8 183.7 181.3 182.4 163.3 162.3 96.8 89.3 97.2
[12:17:33.478] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[12:17:33.508] <TB1> INFO: PixTest:: pg_setup set to default.
[12:17:33.519] <TB1> INFO: enter test to run
[12:17:33.519] <TB1> INFO: test: no parameter change
[12:17:33.603] <TB1> QUIET: Connection to board 147 closed.
[12:17:33.684] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:17:37.806] <TB1> INFO: *** Welcome to pxar ***
[12:17:37.807] <TB1> INFO: *** Today: 2015/12/02
[12:17:38.197] <TB1> INFO: *** Version: fb79
[12:17:38.197] <TB1> INFO: readRocDacs: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//013_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//013_HREfficiency_200//dacParameters35_C15.dat
[12:17:38.198] <TB1> INFO: readTbmDacs: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//013_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//013_HREfficiency_200//tbmParameters_C0b.dat
[12:17:38.198] <TB1> INFO: readMaskFile: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//013_HREfficiency_200//defaultMaskFile.dat
[12:17:38.198] <TB1> INFO: MASKED Roc 7 col/row: 48 2
[12:17:38.198] <TB1> INFO: MASKED Roc 14 col/row: 13 69
[12:17:38.198] <TB1> INFO: readTrimFile: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//013_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//013_HREfficiency_200//trimParameters35_C15.dat
[12:17:38.228] <TB1> INFO: masking Roc 7 col/row: 48 2
[12:17:38.257] <TB1> INFO: masking Roc 14 col/row: 13 69
[12:17:38.266] <TB1> INFO: clk: 4
[12:17:38.266] <TB1> INFO: ctr: 4
[12:17:38.266] <TB1> INFO: sda: 19
[12:17:38.266] <TB1> INFO: tin: 9
[12:17:38.266] <TB1> INFO: level: 15
[12:17:38.266] <TB1> INFO: triggerdelay: 0
[12:17:38.266] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[12:17:38.266] <TB1> INFO: Log level: INFO
[12:17:38.279] <TB1> INFO: Found DTB DTB_WWXTQT
[12:17:38.289] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:17:38.292] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:17:38.294] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[12:17:39.830] <TB1> INFO: DUT info:
[12:17:39.830] <TB1> INFO: The DUT currently contains the following objects:
[12:17:39.830] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:17:39.830] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:17:39.830] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:17:39.830] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:17:39.830] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:39.830] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:39.830] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:39.830] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:39.830] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:39.830] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:39.830] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:39.830] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 1 masked, 0 active.
[12:17:39.830] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:39.830] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:39.830] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:39.830] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:39.830] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:39.830] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:39.830] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 1 masked, 0 active.
[12:17:39.830] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:40.231] <TB1> INFO: enter 'restricted' command line mode
[12:17:40.231] <TB1> INFO: enter test to run
[12:17:40.231] <TB1> INFO: test: PixelAlive no parameter change
[12:17:40.231] <TB1> INFO: running: pixelalive
[12:17:40.235] <TB1> INFO: ######################################################################
[12:17:40.235] <TB1> INFO: PixTestAlive::doTest()
[12:17:40.235] <TB1> INFO: ######################################################################
[12:17:40.236] <TB1> INFO: ----------------------------------------------------------------------
[12:17:40.236] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:17:40.236] <TB1> INFO: ----------------------------------------------------------------------
[12:17:40.238] <TB1> INFO: ROC 7 masking pixel 48/2
[12:17:40.238] <TB1> INFO: ROC 14 masking pixel 13/69
[12:17:40.535] <TB1> INFO: Expecting 208000 events.
[12:17:50.588] <TB1> INFO: 208000 events read in total (9335ms).
[12:17:50.613] <TB1> INFO: Test took 10375ms.
[12:17:50.621] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:17:50.875] <TB1> INFO: PixTestAlive::aliveTest() done
[12:17:50.875] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 1 0 0 0 0 0 0 1 0
[12:17:50.875] <TB1> INFO: ROC 7 masking pixel 48/2
[12:17:50.875] <TB1> INFO: ROC 14 masking pixel 13/69
[12:17:50.877] <TB1> INFO: ----------------------------------------------------------------------
[12:17:50.877] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:17:50.877] <TB1> INFO: ----------------------------------------------------------------------
[12:17:51.176] <TB1> INFO: Expecting 208000 events.
[12:17:57.871] <TB1> INFO: 208000 events read in total (5979ms).
[12:17:57.872] <TB1> INFO: Test took 6994ms.
[12:17:57.872] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:17:57.872] <TB1> INFO: ROC 7 masking pixel 48/2
[12:17:57.873] <TB1> INFO: ROC 14 masking pixel 13/69
[12:17:57.873] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:17:58.182] <TB1> INFO: PixTestAlive::maskTest() done
[12:17:58.182] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:17:58.182] <TB1> INFO: ROC 7 masking pixel 48/2
[12:17:58.183] <TB1> INFO: ROC 14 masking pixel 13/69
[12:17:58.184] <TB1> INFO: ----------------------------------------------------------------------
[12:17:58.184] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:17:58.184] <TB1> INFO: ----------------------------------------------------------------------
[12:17:58.185] <TB1> INFO: ROC 7 masking pixel 48/2
[12:17:58.185] <TB1> INFO: ROC 14 masking pixel 13/69
[12:17:58.485] <TB1> INFO: Expecting 208000 events.
[12:18:08.570] <TB1> INFO: 208000 events read in total (9370ms).
[12:18:08.571] <TB1> INFO: Test took 10386ms.
[12:18:08.580] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:18:08.819] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[12:18:08.819] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:18:08.819] <TB1> INFO: ROC 7 masking pixel 48/2
[12:18:08.819] <TB1> INFO: ROC 14 masking pixel 13/69
[12:18:08.819] <TB1> INFO: PixTestAlive::doTest() done, duration: 28 seconds
[12:18:08.852] <TB1> INFO: enter test to run
[12:18:08.852] <TB1> INFO: test: delay setting parameters: ->2<-
[12:18:08.852] <TB1> INFO: delay test by 2 seconds...
[12:18:10.852] <TB1> INFO: enter test to run
[12:18:10.852] <TB1> INFO: test: HighRate no parameter change
[12:18:10.852] <TB1> INFO: running: highrate
[12:18:10.852] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//013_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//013_HREfficiency_200//phCalibrationFitErr35_C15.dat
[12:18:10.985] <TB1> INFO: ----------------------------------------------------------------------
[12:18:10.985] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:18:10.985] <TB1> INFO: ----------------------------------------------------------------------
[12:18:10.989] <TB1> INFO: ROC 7 masking pixel 48/2
[12:18:10.989] <TB1> INFO: ROC 14 masking pixel 13/69
[12:18:11.581] <TB1> INFO: Expecting 208000 events.
[12:18:39.474] <TB1> INFO: 208000 events read in total (27366ms).
[12:18:39.491] <TB1> INFO: Test took 28502ms.
[12:18:40.575] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:18:41.124] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 1 0 0 0 0 0 0 1 0
[12:18:41.124] <TB1> INFO: number of red-efficiency pixels: 1557 1794 1531 3168 3332 3897 3895 4024 3850 3764 3853 3468 3598 1690 1817 1685
[12:18:41.124] <TB1> INFO: number of X-ray hits detected: 433778 460860 431770 684266 721541 864647 893152 914188 849077 833360 836819 751656 748687 452614 414818 448173
[12:18:41.124] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[12:18:41.124] <TB1> INFO: number of Vcal hits detected: 205795 205461 203950 199916 198395 191979 189997 190368 193675 193066 193614 197101 196688 203094 205403 205510
[12:18:41.124] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.1 98.9 98.5 96.6 95.9 93.1 92.3 92.2 93.8 93.7 93.9 95.4 95.1 98.1 98.9 98.9
[12:18:41.124] <TB1> INFO: Vcal hit overall efficiency (%): 98.9 98.8 98.1 96.1 95.4 92.3 91.3 91.5 93.1 92.8 93.1 94.8 94.6 97.6 98.8 98.8
[12:18:41.124] <TB1> INFO: X-ray hit rate [MHz/cm2]: 127.1 135.1 126.6 200.6 211.5 253.4 261.8 268.0 248.9 244.3 245.3 220.3 219.4 132.7 121.6 131.4
[12:18:41.124] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[12:18:41.154] <TB1> INFO: PixTest:: pg_setup set to default.
[12:18:41.166] <TB1> INFO: enter test to run
[12:18:41.166] <TB1> INFO: test: no parameter change
[12:18:41.267] <TB1> QUIET: Connection to board 147 closed.
[12:18:41.347] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:18:45.620] <TB1> INFO: *** Welcome to pxar ***
[12:18:45.620] <TB1> INFO: *** Today: 2015/12/02
[12:18:45.994] <TB1> INFO: *** Version: fb79
[12:18:45.994] <TB1> INFO: readRocDacs: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//014_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//014_HREfficiency_250//dacParameters35_C15.dat
[12:18:45.995] <TB1> INFO: readTbmDacs: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//014_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//014_HREfficiency_250//tbmParameters_C0b.dat
[12:18:45.995] <TB1> INFO: readMaskFile: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//014_HREfficiency_250//defaultMaskFile.dat
[12:18:45.995] <TB1> INFO: MASKED Roc 7 col/row: 48 2
[12:18:45.995] <TB1> INFO: MASKED Roc 14 col/row: 13 69
[12:18:45.995] <TB1> INFO: readTrimFile: /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//014_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//014_HREfficiency_250//trimParameters35_C15.dat
[12:18:46.026] <TB1> INFO: masking Roc 7 col/row: 48 2
[12:18:46.056] <TB1> INFO: masking Roc 14 col/row: 13 69
[12:18:46.065] <TB1> INFO: clk: 4
[12:18:46.065] <TB1> INFO: ctr: 4
[12:18:46.065] <TB1> INFO: sda: 19
[12:18:46.065] <TB1> INFO: tin: 9
[12:18:46.065] <TB1> INFO: level: 15
[12:18:46.065] <TB1> INFO: triggerdelay: 0
[12:18:46.065] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[12:18:46.065] <TB1> INFO: Log level: INFO
[12:18:46.077] <TB1> INFO: Found DTB DTB_WWXTQT
[12:18:46.086] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:18:46.089] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:18:46.092] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[12:18:47.627] <TB1> INFO: DUT info:
[12:18:47.627] <TB1> INFO: The DUT currently contains the following objects:
[12:18:47.627] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:18:47.627] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:18:47.627] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:18:47.627] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:18:47.627] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.627] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.627] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.627] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.627] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.627] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.627] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.627] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 1 masked, 0 active.
[12:18:47.627] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.627] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.627] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.627] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.627] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.627] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.627] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 1 masked, 0 active.
[12:18:47.627] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:48.028] <TB1> INFO: enter 'restricted' command line mode
[12:18:48.028] <TB1> INFO: enter test to run
[12:18:48.028] <TB1> INFO: test: PixelAlive no parameter change
[12:18:48.028] <TB1> INFO: running: pixelalive
[12:18:48.032] <TB1> INFO: ######################################################################
[12:18:48.032] <TB1> INFO: PixTestAlive::doTest()
[12:18:48.032] <TB1> INFO: ######################################################################
[12:18:48.033] <TB1> INFO: ----------------------------------------------------------------------
[12:18:48.033] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:18:48.033] <TB1> INFO: ----------------------------------------------------------------------
[12:18:48.035] <TB1> INFO: ROC 7 masking pixel 48/2
[12:18:48.035] <TB1> INFO: ROC 14 masking pixel 13/69
[12:18:48.337] <TB1> INFO: Expecting 208000 events.
[12:18:58.386] <TB1> INFO: 208000 events read in total (9331ms).
[12:18:58.412] <TB1> INFO: Test took 10377ms.
[12:18:58.421] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:18:58.674] <TB1> INFO: PixTestAlive::aliveTest() done
[12:18:58.674] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 1 0 0 0 0 0 0 1 0
[12:18:58.674] <TB1> INFO: ROC 7 masking pixel 48/2
[12:18:58.674] <TB1> INFO: ROC 14 masking pixel 13/69
[12:18:58.676] <TB1> INFO: ----------------------------------------------------------------------
[12:18:58.676] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:18:58.676] <TB1> INFO: ----------------------------------------------------------------------
[12:18:58.974] <TB1> INFO: Expecting 208000 events.
[12:19:05.640] <TB1> INFO: 208000 events read in total (5950ms).
[12:19:05.640] <TB1> INFO: Test took 6963ms.
[12:19:05.640] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:19:05.641] <TB1> INFO: ROC 7 masking pixel 48/2
[12:19:05.641] <TB1> INFO: ROC 14 masking pixel 13/69
[12:19:05.641] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:19:05.951] <TB1> INFO: PixTestAlive::maskTest() done
[12:19:05.951] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:19:05.951] <TB1> INFO: ROC 7 masking pixel 48/2
[12:19:05.951] <TB1> INFO: ROC 14 masking pixel 13/69
[12:19:05.952] <TB1> INFO: ----------------------------------------------------------------------
[12:19:05.952] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:19:05.952] <TB1> INFO: ----------------------------------------------------------------------
[12:19:05.953] <TB1> INFO: ROC 7 masking pixel 48/2
[12:19:05.954] <TB1> INFO: ROC 14 masking pixel 13/69
[12:19:06.255] <TB1> INFO: Expecting 208000 events.
[12:19:16.186] <TB1> INFO: 208000 events read in total (9216ms).
[12:19:16.186] <TB1> INFO: Test took 10232ms.
[12:19:16.193] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:19:16.425] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[12:19:16.425] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:19:16.425] <TB1> INFO: ROC 7 masking pixel 48/2
[12:19:16.425] <TB1> INFO: ROC 14 masking pixel 13/69
[12:19:16.425] <TB1> INFO: PixTestAlive::doTest() done, duration: 28 seconds
[12:19:16.455] <TB1> INFO: enter test to run
[12:19:16.455] <TB1> INFO: test: delay setting parameters: ->2<-
[12:19:16.455] <TB1> INFO: delay test by 2 seconds...
[12:19:18.456] <TB1> INFO: enter test to run
[12:19:18.456] <TB1> INFO: test: HighRate no parameter change
[12:19:18.456] <TB1> INFO: running: highrate
[12:19:18.456] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//014_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2047_XrayQualification_2015-12-02_12h14m_1449054851//014_HREfficiency_250//phCalibrationFitErr35_C15.dat
[12:19:18.584] <TB1> INFO: ----------------------------------------------------------------------
[12:19:18.584] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:19:18.584] <TB1> INFO: ----------------------------------------------------------------------
[12:19:18.587] <TB1> INFO: ROC 7 masking pixel 48/2
[12:19:18.587] <TB1> INFO: ROC 14 masking pixel 13/69
[12:19:19.183] <TB1> INFO: Expecting 208000 events.
[12:19:49.479] <TB1> INFO: 184000 events read in total (29769ms).
[12:19:53.620] <TB1> INFO: 208000 events read in total (33910ms).
[12:19:53.638] <TB1> INFO: Test took 35050ms.
[12:19:54.967] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:19:55.602] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 1 0 0 0 0 0 0 1 0
[12:19:55.602] <TB1> INFO: number of red-efficiency pixels: 2343 2593 2011 3803 3896 4134 4126 4158 4111 4097 4116 3968 4041 2114 2599 2501
[12:19:55.602] <TB1> INFO: number of X-ray hits detected: 538228 568412 535658 846091 892069 1076743 1107032 1129461 1049191 1026151 1027159 926316 929430 560866 513222 555865
[12:19:55.602] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[12:19:55.602] <TB1> INFO: number of Vcal hits detected: 203952 203201 200844 193115 190379 178400 175917 175878 181016 181070 181607 187691 186904 199193 203437 203352
[12:19:55.602] <TB1> INFO: Vcal hit fiducial efficiency (%): 98.3 97.9 97.2 93.7 92.4 87.1 86.1 85.6 88.0 88.3 88.5 91.3 90.8 96.5 98.0 98.0
[12:19:55.602] <TB1> INFO: Vcal hit overall efficiency (%): 98.1 97.7 96.6 92.8 91.5 85.8 84.6 84.6 87.0 87.1 87.3 90.2 89.9 95.8 97.8 97.8
[12:19:55.602] <TB1> INFO: X-ray hit rate [MHz/cm2]: 157.8 166.6 157.0 248.0 261.5 315.6 324.5 331.1 307.5 300.8 301.1 271.5 272.4 164.4 150.4 162.9
[12:19:55.603] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[12:19:55.633] <TB1> INFO: PixTest:: pg_setup set to default.
[12:19:55.645] <TB1> INFO: enter test to run
[12:19:55.645] <TB1> INFO: test: no parameter change
[12:19:55.748] <TB1> QUIET: Connection to board 147 closed.
[12:19:55.828] <TB1> INFO: pXar: this is the end, my friend
MoReWeb-v1.0.0-5-g82d9ff6 on branch psi46master