[16:01:14.478] INFO: *** Welcome to pxar ***
[16:01:14.478] INFO: *** Today: 2016/06/01
[16:01:14.501] INFO: *** Version: v1.9.0-805-geb36
[16:01:14.501] INFO: readRocDacs: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/dacParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/dacParameters35_C15.dat
[16:01:14.502] INFO: readTbmDacs: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/tbmParameters_C0a.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/tbmParameters_C0b.dat
[16:01:14.502] INFO: readMaskFile: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/defaultMaskFile.dat
[16:01:14.503] INFO: readTrimFile: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/trimParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/trimParameters35_C15.dat
[16:01:14.653] INFO: clk: 4
[16:01:14.653] INFO: ctr: 4
[16:01:14.653] INFO: sda: 19
[16:01:14.653] INFO: tin: 9
[16:01:14.653] INFO: level: 15
[16:01:14.653] INFO: triggerdelay: 0
[16:01:14.653] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[16:01:14.653] INFO: Log level: INFO
[16:01:14.664] QUIET: Connection to board DTB_WRPRHI opened.
[16:01:14.667] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 58
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WRPRHI
MAC address: 40D85511803A
Hostname: pixelDTB058
Comment:
------------------------------------------------------
[16:01:14.670] INFO: RPC call hashes of host and DTB match: 398089610
[16:01:16.269] INFO: DUT info:
[16:01:16.269] INFO: The DUT currently contains the following objects:
[16:01:16.269] INFO: 2 TBM Cores tbm08c (2 ON)
[16:01:16.269] INFO: TBM Core alpha (0): 7 registers set
[16:01:16.269] INFO: TBM Core beta (1): 7 registers set
[16:01:16.269] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:01:16.269] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:16.269] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:16.269] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:16.269] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:16.269] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:16.269] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:16.269] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:16.269] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:16.269] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:16.269] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:16.269] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:16.269] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:16.269] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:16.269] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:16.269] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:16.269] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:16.863] INFO: PixTestCmd::init()
[16:01:16.871] INFO: readGainPedestalParameters /home/CMS_pixel/Testing/pxar_fermi/data/myanv/phCalibrationFitErr35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/phCalibrationFitErr35_C15.dat
[16:01:17.179] INFO: readReadbackCal: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/readbackCal_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/readbackCal_C15.dat
[16:01:38.697] INFO: ----------------------------------------------------------------------
[16:01:38.697] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[16:01:38.697] INFO: ----------------------------------------------------------------------
[16:01:39.669] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[16:01:50.881] INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[16:02:23.191] INFO: Resuming triggers.
[16:02:34.409] INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[16:03:06.688] INFO: Resuming triggers.
[16:03:17.915] INFO: run duration 33 seconds, buffer almost full (81%), pausing triggers.
[16:03:49.969] INFO: Resuming triggers.
[16:04:01.189] INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[16:04:33.260] INFO: Resuming triggers.
[16:04:44.483] INFO: run duration 56 seconds, buffer almost full (81%), pausing triggers.
[16:05:16.489] INFO: Resuming triggers.
[16:05:20.465] INFO: data taking finished, elapsed time: 60 seconds.
[16:05:32.094] INFO: PixTest:: pg_setup set to default.
[16:05:32.131] INFO: PixTestXray::doPhRun() done
[16:06:12.073] QUIET: Connection to board 58 closed.
[16:06:25.169] INFO: *** Welcome to pxar ***
[16:06:25.169] INFO: *** Today: 2016/06/01
[16:06:25.191] INFO: *** Version: v1.9.0-805-geb36
[16:06:25.191] INFO: readRocDacs: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/dacParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/dacParameters35_C15.dat
[16:06:25.192] INFO: readTbmDacs: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/tbmParameters_C0a.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/tbmParameters_C0b.dat
[16:06:25.192] INFO: readMaskFile: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/defaultMaskFile.dat
[16:06:25.192] INFO: readTrimFile: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/trimParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/trimParameters35_C15.dat
[16:06:25.341] INFO: clk: 4
[16:06:25.341] INFO: ctr: 4
[16:06:25.341] INFO: sda: 19
[16:06:25.341] INFO: tin: 9
[16:06:25.341] INFO: level: 15
[16:06:25.341] INFO: triggerdelay: 0
[16:06:25.341] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[16:06:25.341] INFO: Log level: INFO
[16:06:25.353] QUIET: Connection to board DTB_WRPRHI opened.
[16:06:25.356] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 58
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WRPRHI
MAC address: 40D85511803A
Hostname: pixelDTB058
Comment:
------------------------------------------------------
[16:06:25.359] INFO: RPC call hashes of host and DTB match: 398089610
[16:06:26.958] INFO: DUT info:
[16:06:26.958] INFO: The DUT currently contains the following objects:
[16:06:26.958] INFO: 2 TBM Cores tbm08c (2 ON)
[16:06:26.958] INFO: TBM Core alpha (0): 7 registers set
[16:06:26.958] INFO: TBM Core beta (1): 7 registers set
[16:06:26.958] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:06:26.958] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:06:26.958] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:06:26.958] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:06:26.958] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:06:26.958] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:06:26.958] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:06:26.958] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:06:26.958] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:06:26.959] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:06:26.959] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:06:26.959] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:06:26.959] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:06:26.959] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:06:26.959] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:06:26.959] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:06:26.959] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:06:27.552] INFO: PixTestCmd::init()
[16:06:27.561] INFO: readGainPedestalParameters /home/CMS_pixel/Testing/pxar_fermi/data/myanv/phCalibrationFitErr35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/phCalibrationFitErr35_C15.dat
[16:06:27.861] INFO: readReadbackCal: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/readbackCal_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/readbackCal_C15.dat
[16:06:39.857] INFO: ######################################################################
[16:06:39.857] INFO: PixTestXray::doTest()
[16:06:39.857] INFO: ######################################################################
[16:06:39.857] INFO: ----------------------------------------------------------------------
[16:06:39.857] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[16:06:39.857] INFO: ----------------------------------------------------------------------
[16:06:40.829] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[16:06:52.051] INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[16:07:24.391] INFO: Resuming triggers.
[16:07:35.619] INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[16:08:07.517] INFO: Resuming triggers.
[16:08:18.747] INFO: run duration 33 seconds, buffer almost full (81%), pausing triggers.
[16:08:50.596] INFO: Resuming triggers.
[16:09:01.821] INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[16:09:33.740] INFO: Resuming triggers.
[16:09:44.966] INFO: run duration 56 seconds, buffer almost full (81%), pausing triggers.
[16:10:16.691] INFO: Resuming triggers.
[16:10:20.634] INFO: data taking finished, elapsed time: 60 seconds.
[16:10:31.953] INFO: PixTest:: pg_setup set to default.
[16:10:31.988] INFO: PixTestXray::doPhRun() done
[16:10:31.988] INFO: PixTestXray::doTest() done
[16:12:30.630] QUIET: Connection to board 58 closed.
[15:54:01.466] INFO: *** Welcome to pxar ***
[15:54:01.466] INFO: *** Today: 2016/06/01
[15:54:01.489] INFO: *** Version: v1.9.0-805-geb36
[15:54:01.489] INFO: readRocDacs: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/dacParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/dacParameters35_C15.dat
[15:54:01.490] INFO: readTbmDacs: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/tbmParameters_C0a.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/tbmParameters_C0b.dat
[15:54:01.490] INFO: readMaskFile: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/defaultMaskFile.dat
[15:54:01.490] INFO: readTrimFile: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/trimParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/trimParameters35_C15.dat
[15:54:01.638] INFO: clk: 4
[15:54:01.638] INFO: ctr: 4
[15:54:01.638] INFO: sda: 19
[15:54:01.638] INFO: tin: 9
[15:54:01.638] INFO: level: 15
[15:54:01.639] INFO: triggerdelay: 0
[15:54:01.639] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[15:54:01.639] INFO: Log level: INFO
[15:54:01.650] QUIET: Connection to board DTB_WRPRHI opened.
[15:54:01.653] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 58
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WRPRHI
MAC address: 40D85511803A
Hostname: pixelDTB058
Comment:
------------------------------------------------------
[15:54:01.656] INFO: RPC call hashes of host and DTB match: 398089610
[15:54:03.255] INFO: DUT info:
[15:54:03.255] INFO: The DUT currently contains the following objects:
[15:54:03.255] INFO: 2 TBM Cores tbm08c (2 ON)
[15:54:03.255] INFO: TBM Core alpha (0): 7 registers set
[15:54:03.255] INFO: TBM Core beta (1): 7 registers set
[15:54:03.255] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:54:03.256] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.256] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.256] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.256] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.256] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.256] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.256] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.256] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.256] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.256] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.256] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.256] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.256] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.256] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.256] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.256] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.852] INFO: PixTestCmd::init()
[15:54:03.865] INFO: readGainPedestalParameters /home/CMS_pixel/Testing/pxar_fermi/data/myanv/phCalibrationFitErr35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/phCalibrationFitErr35_C15.dat
[15:54:04.166] INFO: readReadbackCal: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/readbackCal_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/readbackCal_C15.dat
[15:54:11.196] INFO: ######################################################################
[15:54:11.196] INFO: PixTestAlive::doTest()
[15:54:11.196] INFO: ######################################################################
[15:54:11.199] INFO: ----------------------------------------------------------------------
[15:54:11.199] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:54:11.199] INFO: ----------------------------------------------------------------------
[15:54:11.576] INFO: Expecting 41600 events.
[15:54:15.843] INFO: 41600 events read in total (3549ms).
[15:54:15.992] INFO: Test took 4791ms.
[15:54:16.002] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:16.273] INFO: PixTestAlive::aliveTest() done
[15:54:16.273] INFO: number of dead pixels (per ROC): 0 0 0 2 0 0 0 0 0 0 0 0 0 0 0 0
[15:54:16.295] INFO: ----------------------------------------------------------------------
[15:54:16.295] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:54:16.295] INFO: ----------------------------------------------------------------------
[15:54:16.671] INFO: Expecting 41600 events.
[15:54:19.718] INFO: 41600 events read in total (2332ms).
[15:54:19.718] INFO: Test took 3420ms.
[15:54:19.718] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:19.719] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:54:20.142] INFO: PixTestAlive::maskTest() done
[15:54:20.142] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:54:20.160] INFO: ----------------------------------------------------------------------
[15:54:20.160] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:54:20.160] INFO: ----------------------------------------------------------------------
[15:54:20.536] INFO: Expecting 41600 events.
[15:54:24.803] INFO: 41600 events read in total (3552ms).
[15:54:24.804] INFO: Test took 4642ms.
[15:54:24.815] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:25.178] INFO: PixTestAlive::addressDecodingTest() done
[15:54:25.178] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:54:25.179] INFO: PixTestAlive::doTest() done, duration: 13 seconds
[15:54:27.880] INFO: ----------------------------------------------------------------------
[15:54:27.880] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[15:54:27.880] INFO: ----------------------------------------------------------------------
[15:54:28.019] INFO: Expecting 768 events.
[15:54:29.151] INFO: 768 events read in total (418ms).
[15:54:29.152] INFO: Test took 1266ms.
[15:54:29.955] INFO: Expecting 41600 events.
[15:54:33.264] INFO: 41600 events read in total (2782ms).
[15:54:33.269] INFO: Test took 4111ms.
[15:54:33.371] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:34.081] INFO: Expecting 41600 events.
[15:54:37.500] INFO: 41600 events read in total (2892ms).
[15:54:37.506] INFO: Test took 4090ms.
[15:54:37.606] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:38.317] INFO: Expecting 41600 events.
[15:54:41.758] INFO: 41600 events read in total (2915ms).
[15:54:41.762] INFO: Test took 4110ms.
[15:54:41.860] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:42.570] INFO: Expecting 41600 events.
[15:54:46.023] INFO: 41600 events read in total (2926ms).
[15:54:46.027] INFO: Test took 4122ms.
[15:54:46.125] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:46.836] INFO: Expecting 41600 events.
[15:54:50.285] INFO: 41600 events read in total (2923ms).
[15:54:50.289] INFO: Test took 4118ms.
[15:54:50.386] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:51.097] INFO: Expecting 41600 events.
[15:54:54.557] INFO: 41600 events read in total (2934ms).
[15:54:54.561] INFO: Test took 4129ms.
[15:54:54.659] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:55.371] INFO: Expecting 41600 events.
[15:54:58.831] INFO: 41600 events read in total (2934ms).
[15:54:58.835] INFO: Test took 4129ms.
[15:54:58.933] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:59.644] INFO: Expecting 41600 events.
[15:55:03.105] INFO: 41600 events read in total (2934ms).
[15:55:03.109] INFO: Test took 4130ms.
[15:55:03.208] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:55:03.919] INFO: Expecting 41600 events.
[15:55:07.382] INFO: 41600 events read in total (2937ms).
[15:55:07.386] INFO: Test took 4132ms.
[15:55:07.485] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:55:08.197] INFO: Expecting 41600 events.
[15:55:11.661] INFO: 41600 events read in total (2938ms).
[15:55:11.666] INFO: Test took 4134ms.
[15:55:11.764] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:55:12.476] INFO: Expecting 41600 events.
[15:55:15.942] INFO: 41600 events read in total (2940ms).
[15:55:15.946] INFO: Test took 4135ms.
[15:55:16.044] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:55:16.756] INFO: Expecting 41600 events.
[15:55:20.218] INFO: 41600 events read in total (2935ms).
[15:55:20.222] INFO: Test took 4131ms.
[15:55:20.321] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:55:21.032] INFO: Expecting 41600 events.
[15:55:24.496] INFO: 41600 events read in total (2937ms).
[15:55:24.500] INFO: Test took 4132ms.
[15:55:24.599] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:55:25.311] INFO: Expecting 41600 events.
[15:55:28.785] INFO: 41600 events read in total (2947ms).
[15:55:28.789] INFO: Test took 4143ms.
[15:55:28.887] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:55:29.597] INFO: Expecting 41600 events.
[15:55:33.062] INFO: 41600 events read in total (2938ms).
[15:55:33.066] INFO: Test took 4133ms.
[15:55:33.164] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:55:33.876] INFO: Expecting 41600 events.
[15:55:37.339] INFO: 41600 events read in total (2937ms).
[15:55:37.343] INFO: Test took 4132ms.
[15:55:37.441] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:55:38.153] INFO: Expecting 41600 events.
[15:55:41.614] INFO: 41600 events read in total (2934ms).
[15:55:41.619] INFO: Test took 4131ms.
[15:55:41.717] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:55:42.428] INFO: Expecting 41600 events.
[15:55:45.897] INFO: 41600 events read in total (2943ms).
[15:55:45.901] INFO: Test took 4138ms.
[15:55:45.998] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:55:46.709] INFO: Expecting 41600 events.
[15:55:50.169] INFO: 41600 events read in total (2933ms).
[15:55:50.174] INFO: Test took 4130ms.
[15:55:50.271] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:55:50.983] INFO: Expecting 41600 events.
[15:55:54.309] INFO: 41600 events read in total (2800ms).
[15:55:54.313] INFO: Test took 3996ms.
[15:55:54.410] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:56:21.384] INFO: ----------------------------------------------------------------------
[15:56:21.384] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[15:56:21.384] INFO: ----------------------------------------------------------------------
[15:56:22.066] INFO: Expecting 208000 events.
[15:56:35.417] INFO: 208000 events read in total (12825ms).
[15:56:35.431] INFO: Test took 14031ms.
[15:56:35.882] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:56:36.283] INFO: number of dead pixels (per ROC): 0 0 0 2 0 0 0 0 0 0 0 0 0 0 0 0
[15:56:36.283] INFO: number of red-efficiency pixels: 120 78 202 386 355 323 302 252 342 353 333 409 299 201 97 130
[15:56:36.283] INFO: number of X-ray hits detected: 93553 72602 123867 188534 200570 196229 195558 173087 193193 204637 201733 192340 194553 124661 74055 92807
[15:56:36.283] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[15:56:36.283] INFO: number of Vcal hits detected: 207877 207920 207785 207493 207626 207652 207682 207738 207640 207630 207645 207560 207690 207789 207901 207868
[15:56:36.283] INFO: Vcal hit fiducial efficiency (%): 99.9 100.0 99.9 99.8 99.8 99.8 99.9 99.9 99.8 99.8 99.8 99.8 99.9 99.9 100.0 99.9
[15:56:36.283] INFO: Vcal hit overall efficiency (%): 99.9 100.0 99.9 99.8 99.8 99.8 99.8 99.9 99.8 99.8 99.8 99.8 99.9 99.9 100.0 99.9
[15:56:36.283] INFO: X-ray hit rate [MHz/cm2]: 27.4 21.3 36.3 55.3 58.8 57.5 57.3 50.7 56.6 60.0 59.1 56.4 57.0 36.5 21.7 27.2
[15:56:36.283] INFO: PixTestHighRate::doXPixelAlive() done
[15:56:36.329] INFO: PixTest:: pg_setup set to default.
[15:57:33.163] QUIET: Connection to board 58 closed.
[15:49:46.185] INFO: *** Welcome to pxar ***
[15:49:46.185] INFO: *** Today: 2016/06/01
[15:49:46.208] INFO: *** Version: v1.9.0-805-geb36
[15:49:46.208] INFO: readRocDacs: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/dacParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/dacParameters35_C15.dat
[15:49:46.209] INFO: readTbmDacs: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/tbmParameters_C0a.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/tbmParameters_C0b.dat
[15:49:46.209] INFO: readMaskFile: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/defaultMaskFile.dat
[15:49:46.209] INFO: readTrimFile: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/trimParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/trimParameters35_C15.dat
[15:49:46.357] INFO: clk: 4
[15:49:46.357] INFO: ctr: 4
[15:49:46.357] INFO: sda: 19
[15:49:46.357] INFO: tin: 9
[15:49:46.357] INFO: level: 15
[15:49:46.357] INFO: triggerdelay: 0
[15:49:46.357] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[15:49:46.357] INFO: Log level: INFO
[15:49:46.368] QUIET: Connection to board DTB_WRPRHI opened.
[15:49:46.371] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 58
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WRPRHI
MAC address: 40D85511803A
Hostname: pixelDTB058
Comment:
------------------------------------------------------
[15:49:46.374] INFO: RPC call hashes of host and DTB match: 398089610
[15:49:47.973] INFO: DUT info:
[15:49:47.973] INFO: The DUT currently contains the following objects:
[15:49:47.973] INFO: 2 TBM Cores tbm08c (2 ON)
[15:49:47.973] INFO: TBM Core alpha (0): 7 registers set
[15:49:47.973] INFO: TBM Core beta (1): 7 registers set
[15:49:47.973] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:49:47.973] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:47.973] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:47.973] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:47.973] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:47.973] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:47.973] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:47.973] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:47.973] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:47.973] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:47.973] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:47.973] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:47.973] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:47.973] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:47.973] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:47.973] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:47.974] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:48.567] INFO: PixTestCmd::init()
[15:49:48.573] INFO: readGainPedestalParameters /home/CMS_pixel/Testing/pxar_fermi/data/myanv/phCalibrationFitErr35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/phCalibrationFitErr35_C15.dat
[15:49:48.872] INFO: readReadbackCal: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/readbackCal_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/readbackCal_C15.dat
[15:49:54.451] INFO: ######################################################################
[15:49:54.451] INFO: PixTestAlive::doTest()
[15:49:54.451] INFO: ######################################################################
[15:49:54.455] INFO: ----------------------------------------------------------------------
[15:49:54.455] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:49:54.455] INFO: ----------------------------------------------------------------------
[15:49:54.832] INFO: Expecting 41600 events.
[15:49:59.085] INFO: 41600 events read in total (3534ms).
[15:49:59.232] INFO: Test took 4775ms.
[15:49:59.242] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:49:59.512] INFO: PixTestAlive::aliveTest() done
[15:49:59.512] INFO: number of dead pixels (per ROC): 0 0 0 2 0 0 0 0 0 0 0 0 0 0 0 0
[15:49:59.534] INFO: ----------------------------------------------------------------------
[15:49:59.534] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:49:59.534] INFO: ----------------------------------------------------------------------
[15:49:59.910] INFO: Expecting 41600 events.
[15:50:02.961] INFO: 41600 events read in total (2336ms).
[15:50:02.961] INFO: Test took 3425ms.
[15:50:02.961] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:02.962] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:50:03.384] INFO: PixTestAlive::maskTest() done
[15:50:03.384] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:50:03.402] INFO: ----------------------------------------------------------------------
[15:50:03.402] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:50:03.402] INFO: ----------------------------------------------------------------------
[15:50:03.778] INFO: Expecting 41600 events.
[15:50:08.035] INFO: 41600 events read in total (3543ms).
[15:50:08.037] INFO: Test took 4633ms.
[15:50:08.046] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:08.418] INFO: PixTestAlive::addressDecodingTest() done
[15:50:08.418] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:50:08.418] INFO: PixTestAlive::doTest() done, duration: 13 seconds
[15:50:11.336] INFO: ----------------------------------------------------------------------
[15:50:11.336] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[15:50:11.336] INFO: ----------------------------------------------------------------------
[15:50:11.475] INFO: Expecting 768 events.
[15:50:12.607] INFO: 768 events read in total (417ms).
[15:50:12.607] INFO: Test took 1265ms.
[15:50:13.410] INFO: Expecting 41600 events.
[15:50:17.045] INFO: 41600 events read in total (3108ms).
[15:50:17.050] INFO: Test took 4437ms.
[15:50:17.194] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:17.919] INFO: Expecting 41600 events.
[15:50:21.622] INFO: 41600 events read in total (3176ms).
[15:50:21.627] INFO: Test took 4372ms.
[15:50:21.766] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:22.494] INFO: Expecting 41600 events.
[15:50:26.233] INFO: 41600 events read in total (3213ms).
[15:50:26.239] INFO: Test took 4410ms.
[15:50:26.379] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:27.107] INFO: Expecting 41600 events.
[15:50:30.848] INFO: 41600 events read in total (3214ms).
[15:50:30.853] INFO: Test took 4411ms.
[15:50:30.991] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:31.722] INFO: Expecting 41600 events.
[15:50:35.469] INFO: 41600 events read in total (3221ms).
[15:50:35.474] INFO: Test took 4417ms.
[15:50:35.614] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:36.344] INFO: Expecting 41600 events.
[15:50:40.108] INFO: 41600 events read in total (3238ms).
[15:50:40.113] INFO: Test took 4434ms.
[15:50:40.251] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:40.981] INFO: Expecting 41600 events.
[15:50:44.747] INFO: 41600 events read in total (3240ms).
[15:50:44.752] INFO: Test took 4436ms.
[15:50:44.889] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:45.618] INFO: Expecting 41600 events.
[15:50:49.388] INFO: 41600 events read in total (3244ms).
[15:50:49.393] INFO: Test took 4441ms.
[15:50:49.531] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:50.261] INFO: Expecting 41600 events.
[15:50:54.046] INFO: 41600 events read in total (3258ms).
[15:50:54.052] INFO: Test took 4455ms.
[15:50:54.192] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:54.923] INFO: Expecting 41600 events.
[15:50:58.739] INFO: 41600 events read in total (3290ms).
[15:50:58.744] INFO: Test took 4486ms.
[15:50:58.884] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:59.613] INFO: Expecting 41600 events.
[15:51:03.410] INFO: 41600 events read in total (3271ms).
[15:51:03.415] INFO: Test took 4467ms.
[15:51:03.556] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:51:04.284] INFO: Expecting 41600 events.
[15:51:08.071] INFO: 41600 events read in total (3260ms).
[15:51:08.076] INFO: Test took 4457ms.
[15:51:08.214] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:51:08.944] INFO: Expecting 41600 events.
[15:51:12.739] INFO: 41600 events read in total (3269ms).
[15:51:12.744] INFO: Test took 4465ms.
[15:51:12.881] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:51:13.610] INFO: Expecting 41600 events.
[15:51:17.401] INFO: 41600 events read in total (3264ms).
[15:51:17.406] INFO: Test took 4461ms.
[15:51:17.543] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:51:18.272] INFO: Expecting 41600 events.
[15:51:22.060] INFO: 41600 events read in total (3261ms).
[15:51:22.065] INFO: Test took 4458ms.
[15:51:22.201] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:51:22.930] INFO: Expecting 41600 events.
[15:51:26.728] INFO: 41600 events read in total (3271ms).
[15:51:26.733] INFO: Test took 4467ms.
[15:51:26.870] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:51:27.599] INFO: Expecting 41600 events.
[15:51:31.394] INFO: 41600 events read in total (3268ms).
[15:51:31.399] INFO: Test took 4465ms.
[15:51:31.536] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:51:32.265] INFO: Expecting 41600 events.
[15:51:36.048] INFO: 41600 events read in total (3257ms).
[15:51:36.053] INFO: Test took 4453ms.
[15:51:36.191] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:51:36.920] INFO: Expecting 41600 events.
[15:51:40.687] INFO: 41600 events read in total (3240ms).
[15:51:40.693] INFO: Test took 4437ms.
[15:51:40.831] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:51:41.560] INFO: Expecting 41600 events.
[15:51:45.174] INFO: 41600 events read in total (3087ms).
[15:51:45.179] INFO: Test took 4283ms.
[15:51:45.315] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:52:16.552] INFO: ----------------------------------------------------------------------
[15:52:16.552] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[15:52:16.552] INFO: ----------------------------------------------------------------------
[15:52:17.233] INFO: Expecting 208000 events.
[15:52:32.781] INFO: 208000 events read in total (15021ms).
[15:52:32.801] INFO: Test took 16233ms.
[15:52:33.472] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:52:33.955] INFO: number of dead pixels (per ROC): 0 0 0 2 0 0 0 0 0 0 0 0 0 0 0 0
[15:52:33.955] INFO: number of red-efficiency pixels: 213 174 377 655 746 710 679 577 656 780 825 718 656 376 159 215
[15:52:33.955] INFO: number of X-ray hits detected: 143512 110806 188958 288321 306336 300045 301787 265409 295319 313439 308570 293411 298550 190553 113863 142229
[15:52:33.955] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[15:52:33.955] INFO: number of Vcal hits detected: 207780 207818 207587 207162 207157 207206 207227 207353 207293 207100 207028 207180 207257 207593 207834 207773
[15:52:33.955] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.8 99.7 99.6 99.6 99.7 99.7 99.7 99.6 99.6 99.6 99.7 99.8 99.9 99.9
[15:52:33.955] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.8 99.6 99.6 99.6 99.6 99.7 99.7 99.6 99.5 99.6 99.6 99.8 99.9 99.9
[15:52:33.955] INFO: X-ray hit rate [MHz/cm2]: 42.1 32.5 55.4 84.5 89.8 87.9 88.5 77.8 86.6 91.9 90.4 86.0 87.5 55.9 33.4 41.7
[15:52:33.955] INFO: PixTestHighRate::doXPixelAlive() done
[15:52:34.001] INFO: PixTest:: pg_setup set to default.
[15:53:53.988] QUIET: Connection to board 58 closed.
[15:45:28.304] INFO: *** Welcome to pxar ***
[15:45:28.304] INFO: *** Today: 2016/06/01
[15:45:28.326] INFO: *** Version: v1.9.0-805-geb36
[15:45:28.326] INFO: readRocDacs: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/dacParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/dacParameters35_C15.dat
[15:45:28.327] INFO: readTbmDacs: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/tbmParameters_C0a.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/tbmParameters_C0b.dat
[15:45:28.327] INFO: readMaskFile: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/defaultMaskFile.dat
[15:45:28.327] INFO: readTrimFile: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/trimParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/trimParameters35_C15.dat
[15:45:28.476] INFO: clk: 4
[15:45:28.476] INFO: ctr: 4
[15:45:28.477] INFO: sda: 19
[15:45:28.477] INFO: tin: 9
[15:45:28.477] INFO: level: 15
[15:45:28.477] INFO: triggerdelay: 0
[15:45:28.477] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[15:45:28.477] INFO: Log level: INFO
[15:45:28.487] QUIET: Connection to board DTB_WRPRHI opened.
[15:45:28.491] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 58
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WRPRHI
MAC address: 40D85511803A
Hostname: pixelDTB058
Comment:
------------------------------------------------------
[15:45:28.493] INFO: RPC call hashes of host and DTB match: 398089610
[15:45:30.092] INFO: DUT info:
[15:45:30.092] INFO: The DUT currently contains the following objects:
[15:45:30.093] INFO: 2 TBM Cores tbm08c (2 ON)
[15:45:30.093] INFO: TBM Core alpha (0): 7 registers set
[15:45:30.093] INFO: TBM Core beta (1): 7 registers set
[15:45:30.093] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:45:30.093] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:45:30.093] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:45:30.093] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:45:30.093] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:45:30.093] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:45:30.093] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:45:30.093] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:45:30.093] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:45:30.093] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:45:30.093] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:45:30.093] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:45:30.093] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:45:30.093] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:45:30.093] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:45:30.093] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:45:30.093] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:45:30.690] INFO: PixTestCmd::init()
[15:45:30.694] INFO: readGainPedestalParameters /home/CMS_pixel/Testing/pxar_fermi/data/myanv/phCalibrationFitErr35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/phCalibrationFitErr35_C15.dat
[15:45:30.991] INFO: readReadbackCal: /home/CMS_pixel/Testing/pxar_fermi/data/myanv/readbackCal_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myanv/readbackCal_C15.dat
[15:45:38.195] INFO: ######################################################################
[15:45:38.196] INFO: PixTestAlive::doTest()
[15:45:38.196] INFO: ######################################################################
[15:45:38.199] INFO: ----------------------------------------------------------------------
[15:45:38.199] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:45:38.199] INFO: ----------------------------------------------------------------------
[15:45:38.578] INFO: Expecting 41600 events.
[15:45:42.849] INFO: 41600 events read in total (3553ms).
[15:45:42.995] INFO: Test took 4794ms.
[15:45:43.005] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:45:43.274] INFO: PixTestAlive::aliveTest() done
[15:45:43.274] INFO: number of dead pixels (per ROC): 0 0 0 2 0 0 0 0 0 0 0 0 0 0 0 0
[15:45:43.297] INFO: ----------------------------------------------------------------------
[15:45:43.297] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:45:43.297] INFO: ----------------------------------------------------------------------
[15:45:43.674] INFO: Expecting 41600 events.
[15:45:46.721] INFO: 41600 events read in total (2332ms).
[15:45:46.722] INFO: Test took 3422ms.
[15:45:46.722] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:45:46.722] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:45:47.148] INFO: PixTestAlive::maskTest() done
[15:45:47.148] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:45:47.167] INFO: ----------------------------------------------------------------------
[15:45:47.167] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:45:47.167] INFO: ----------------------------------------------------------------------
[15:45:47.544] INFO: Expecting 41600 events.
[15:45:51.792] INFO: 41600 events read in total (3533ms).
[15:45:51.794] INFO: Test took 4625ms.
[15:45:51.803] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:45:52.175] INFO: PixTestAlive::addressDecodingTest() done
[15:45:52.175] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:45:52.175] INFO: PixTestAlive::doTest() done, duration: 13 seconds
[15:46:26.608] INFO: ----------------------------------------------------------------------
[15:46:26.608] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[15:46:26.608] INFO: ----------------------------------------------------------------------
[15:46:26.747] INFO: Expecting 768 events.
[15:46:27.879] INFO: 768 events read in total (416ms).
[15:46:27.879] INFO: Test took 1265ms.
[15:46:28.683] INFO: Expecting 41600 events.
[15:46:32.572] INFO: 41600 events read in total (3362ms).
[15:46:32.578] INFO: Test took 4693ms.
[15:46:32.759] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:46:33.501] INFO: Expecting 41600 events.
[15:46:37.501] INFO: 41600 events read in total (3473ms).
[15:46:37.507] INFO: Test took 4671ms.
[15:46:37.687] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:46:38.433] INFO: Expecting 41600 events.
[15:46:42.460] INFO: 41600 events read in total (3501ms).
[15:46:42.466] INFO: Test took 4698ms.
[15:46:42.644] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:46:43.389] INFO: Expecting 41600 events.
[15:46:47.422] INFO: 41600 events read in total (3507ms).
[15:46:47.428] INFO: Test took 4704ms.
[15:46:47.607] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:46:48.352] INFO: Expecting 41600 events.
[15:46:52.375] INFO: 41600 events read in total (3497ms).
[15:46:52.381] INFO: Test took 4694ms.
[15:46:52.561] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:46:53.305] INFO: Expecting 41600 events.
[15:46:57.349] INFO: 41600 events read in total (3517ms).
[15:46:57.355] INFO: Test took 4715ms.
[15:46:57.534] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:46:58.279] INFO: Expecting 41600 events.
[15:47:02.337] INFO: 41600 events read in total (3531ms).
[15:47:02.343] INFO: Test took 4729ms.
[15:47:02.521] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:03.267] INFO: Expecting 41600 events.
[15:47:07.326] INFO: 41600 events read in total (3533ms).
[15:47:07.332] INFO: Test took 4730ms.
[15:47:07.513] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:08.259] INFO: Expecting 41600 events.
[15:47:12.308] INFO: 41600 events read in total (3523ms).
[15:47:12.314] INFO: Test took 4720ms.
[15:47:12.492] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:13.237] INFO: Expecting 41600 events.
[15:47:17.291] INFO: 41600 events read in total (3527ms).
[15:47:17.297] INFO: Test took 4725ms.
[15:47:17.477] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:18.222] INFO: Expecting 41600 events.
[15:47:22.270] INFO: 41600 events read in total (3521ms).
[15:47:22.276] INFO: Test took 4719ms.
[15:47:22.456] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:23.201] INFO: Expecting 41600 events.
[15:47:27.254] INFO: 41600 events read in total (3526ms).
[15:47:27.260] INFO: Test took 4724ms.
[15:47:27.438] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:28.184] INFO: Expecting 41600 events.
[15:47:32.234] INFO: 41600 events read in total (3524ms).
[15:47:32.240] INFO: Test took 4721ms.
[15:47:32.420] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:33.165] INFO: Expecting 41600 events.
[15:47:37.240] INFO: 41600 events read in total (3548ms).
[15:47:37.246] INFO: Test took 4745ms.
[15:47:37.427] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:38.172] INFO: Expecting 41600 events.
[15:47:42.258] INFO: 41600 events read in total (3559ms).
[15:47:42.264] INFO: Test took 4757ms.
[15:47:42.443] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:43.189] INFO: Expecting 41600 events.
[15:47:47.270] INFO: 41600 events read in total (3554ms).
[15:47:47.276] INFO: Test took 4752ms.
[15:47:47.455] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:48.201] INFO: Expecting 41600 events.
[15:47:52.281] INFO: 41600 events read in total (3554ms).
[15:47:52.287] INFO: Test took 4751ms.
[15:47:52.469] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:53.214] INFO: Expecting 41600 events.
[15:47:57.287] INFO: 41600 events read in total (3547ms).
[15:47:57.294] INFO: Test took 4745ms.
[15:47:57.475] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:58.220] INFO: Expecting 41600 events.
[15:48:02.275] INFO: 41600 events read in total (3528ms).
[15:48:02.281] INFO: Test took 4726ms.
[15:48:02.460] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:03.206] INFO: Expecting 41600 events.
[15:48:07.088] INFO: 41600 events read in total (3355ms).
[15:48:07.094] INFO: Test took 4553ms.
[15:48:07.274] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:39.872] INFO: ----------------------------------------------------------------------
[15:48:39.872] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[15:48:39.872] INFO: ----------------------------------------------------------------------
[15:48:40.554] INFO: Expecting 208000 events.
[15:48:58.295] INFO: 208000 events read in total (17214ms).
[15:48:58.320] INFO: Test took 18431ms.
[15:48:59.207] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:59.765] INFO: number of dead pixels (per ROC): 0 0 0 2 0 0 0 0 0 0 0 0 0 0 0 0
[15:48:59.765] INFO: number of red-efficiency pixels: 322 245 656 1103 1312 1251 1201 1006 1081 1305 1273 1214 1108 620 254 307
[15:48:59.765] INFO: number of X-ray hits detected: 186184 144054 246286 374761 398974 389396 391445 345322 384419 407998 402332 383393 386615 246762 148172 185535
[15:48:59.766] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[15:48:59.766] INFO: number of Vcal hits detected: 207655 207746 207181 206572 206336 206393 206488 206767 206665 206320 206388 206447 206638 207187 207733 207671
[15:48:59.766] INFO: Vcal hit fiducial efficiency (%): 99.8 99.9 99.6 99.4 99.3 99.3 99.3 99.4 99.4 99.3 99.3 99.3 99.4 99.6 99.9 99.8
[15:48:59.766] INFO: Vcal hit overall efficiency (%): 99.8 99.9 99.6 99.3 99.2 99.2 99.3 99.4 99.4 99.2 99.2 99.3 99.3 99.6 99.9 99.8
[15:48:59.766] INFO: X-ray hit rate [MHz/cm2]: 54.6 42.2 72.2 109.8 116.9 114.1 114.7 101.2 112.7 119.6 117.9 112.4 113.3 72.3 43.4 54.4
[15:48:59.766] INFO: PixTestHighRate::doXPixelAlive() done
[15:48:59.811] INFO: PixTest:: pg_setup set to default.
[15:49:39.038] QUIET: Connection to board 58 closed.