[11:35:46.579] INFO: *** Welcome to pxar ***
[11:35:46.579] INFO: *** Today: 2016/06/06
[11:35:46.602] INFO: *** Version: v1.9.0-805-geb36
[11:35:46.602] INFO: readRocDacs: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/dacParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/dacParameters35_C15.dat
[11:35:46.603] INFO: readTbmDacs: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/tbmParameters_C0a.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/tbmParameters_C0b.dat
[11:35:46.603] INFO: readMaskFile: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/defaultMaskFile.dat
[11:35:46.603] INFO: readTrimFile: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/trimParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/trimParameters35_C15.dat
[11:35:46.753] INFO: clk: 4
[11:35:46.753] INFO: ctr: 4
[11:35:46.753] INFO: sda: 19
[11:35:46.753] INFO: tin: 9
[11:35:46.753] INFO: level: 15
[11:35:46.753] INFO: triggerdelay: 0
[11:35:46.753] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[11:35:46.753] INFO: Log level: INFO
[11:35:46.764] QUIET: Connection to board DTB_WRPRHI opened.
[11:35:46.768] 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:
------------------------------------------------------
[11:35:46.770] INFO: RPC call hashes of host and DTB match: 398089610
[11:35:48.370] INFO: DUT info:
[11:35:48.370] INFO: The DUT currently contains the following objects:
[11:35:48.370] INFO: 2 TBM Cores tbm08c (2 ON)
[11:35:48.370] INFO: TBM Core alpha (0): 7 registers set
[11:35:48.370] INFO: TBM Core beta (1): 7 registers set
[11:35:48.370] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:35:48.370] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:35:48.370] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:35:48.370] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:35:48.370] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:35:48.370] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:35:48.370] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:35:48.370] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:35:48.370] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:35:48.370] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:35:48.370] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:35:48.370] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:35:48.370] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:35:48.370] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:35:48.370] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:35:48.370] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:35:48.370] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:35:48.962] INFO: PixTestCmd::init()
[11:35:48.968] INFO: readGainPedestalParameters /home/CMS_pixel/Testing/pxar_fermi/data/mi202/phCalibrationFitErr35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/phCalibrationFitErr35_C15.dat
[11:35:49.273] INFO: readReadbackCal: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/readbackCal_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/readbackCal_C15.dat
[11:35:59.999] INFO: ----------------------------------------------------------------------
[11:35:59.999] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[11:35:59.999] INFO: ----------------------------------------------------------------------
[11:36:00.972] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[11:36:12.940] INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[11:36:44.180] INFO: Resuming triggers.
[11:36:56.151] INFO: run duration 23 seconds, buffer almost full (81%), pausing triggers.
[11:37:27.111] INFO: Resuming triggers.
[11:37:39.074] INFO: run duration 35 seconds, buffer almost full (81%), pausing triggers.
[11:38:10.084] INFO: Resuming triggers.
[11:38:22.048] INFO: run duration 47 seconds, buffer almost full (81%), pausing triggers.
[11:38:53.145] INFO: Resuming triggers.
[11:39:05.103] INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[11:39:36.102] INFO: Resuming triggers.
[11:39:36.363] INFO: data taking finished, elapsed time: 60 seconds.
[11:39:37.456] INFO: PixTest:: pg_setup set to default.
[11:39:37.493] INFO: PixTestXray::doPhRun() done
[11:39:49.579] QUIET: Connection to board 58 closed.
[11:39:54.516] INFO: *** Welcome to pxar ***
[11:39:54.516] INFO: *** Today: 2016/06/06
[11:39:54.539] INFO: *** Version: v1.9.0-805-geb36
[11:39:54.539] INFO: readRocDacs: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/dacParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/dacParameters35_C15.dat
[11:39:54.540] INFO: readTbmDacs: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/tbmParameters_C0a.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/tbmParameters_C0b.dat
[11:39:54.540] INFO: readMaskFile: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/defaultMaskFile.dat
[11:39:54.540] INFO: readTrimFile: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/trimParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/trimParameters35_C15.dat
[11:39:54.691] INFO: clk: 4
[11:39:54.691] INFO: ctr: 4
[11:39:54.691] INFO: sda: 19
[11:39:54.691] INFO: tin: 9
[11:39:54.691] INFO: level: 15
[11:39:54.691] INFO: triggerdelay: 0
[11:39:54.691] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[11:39:54.691] INFO: Log level: INFO
[11:39:54.702] QUIET: Connection to board DTB_WRPRHI opened.
[11:39:54.706] 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:
------------------------------------------------------
[11:39:54.708] INFO: RPC call hashes of host and DTB match: 398089610
[11:39:56.308] INFO: DUT info:
[11:39:56.308] INFO: The DUT currently contains the following objects:
[11:39:56.308] INFO: 2 TBM Cores tbm08c (2 ON)
[11:39:56.308] INFO: TBM Core alpha (0): 7 registers set
[11:39:56.308] INFO: TBM Core beta (1): 7 registers set
[11:39:56.308] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:39:56.308] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:39:56.308] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:39:56.308] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:39:56.308] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:39:56.308] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:39:56.308] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:39:56.308] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:39:56.308] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:39:56.308] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:39:56.308] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:39:56.308] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:39:56.309] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:39:56.309] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:39:56.309] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:39:56.309] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:39:56.309] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:39:56.912] INFO: PixTestCmd::init()
[11:39:56.917] INFO: readGainPedestalParameters /home/CMS_pixel/Testing/pxar_fermi/data/mi202/phCalibrationFitErr35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/phCalibrationFitErr35_C15.dat
[11:39:57.224] INFO: readReadbackCal: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/readbackCal_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/readbackCal_C15.dat
[11:40:10.207] INFO: ----------------------------------------------------------------------
[11:40:10.207] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[11:40:10.207] INFO: ----------------------------------------------------------------------
[11:40:11.179] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[11:40:18.788] INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[11:40:53.915] INFO: Resuming triggers.
[11:41:01.525] INFO: run duration 15 seconds, buffer almost full (81%), pausing triggers.
[11:41:36.638] INFO: Resuming triggers.
[11:41:44.252] INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[11:42:19.516] INFO: Resuming triggers.
[11:42:27.134] INFO: run duration 30 seconds, buffer almost full (81%), pausing triggers.
[11:43:02.293] INFO: Resuming triggers.
[11:43:09.911] INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[11:43:44.904] INFO: Resuming triggers.
[11:43:52.526] INFO: run duration 45 seconds, buffer almost full (81%), pausing triggers.
[11:44:27.753] INFO: Resuming triggers.
[11:44:35.376] INFO: run duration 53 seconds, buffer almost full (81%), pausing triggers.
[11:45:10.448] INFO: Resuming triggers.
[11:45:17.213] INFO: data taking finished, elapsed time: 60 seconds.
[11:45:48.506] INFO: PixTest:: pg_setup set to default.
[11:45:48.545] INFO: PixTestXray::doPhRun() done
[11:45:57.400] QUIET: Connection to board 58 closed.
[11:29:30.086] INFO: *** Welcome to pxar ***
[11:29:30.086] INFO: *** Today: 2016/06/06
[11:29:30.108] INFO: *** Version: v1.9.0-805-geb36
[11:29:30.108] INFO: readRocDacs: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/dacParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/dacParameters35_C15.dat
[11:29:30.109] INFO: readTbmDacs: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/tbmParameters_C0a.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/tbmParameters_C0b.dat
[11:29:30.110] INFO: readMaskFile: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/defaultMaskFile.dat
[11:29:30.110] INFO: readTrimFile: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/trimParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/trimParameters35_C15.dat
[11:29:30.260] INFO: clk: 4
[11:29:30.260] INFO: ctr: 4
[11:29:30.260] INFO: sda: 19
[11:29:30.260] INFO: tin: 9
[11:29:30.260] INFO: level: 15
[11:29:30.260] INFO: triggerdelay: 0
[11:29:30.260] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[11:29:30.260] INFO: Log level: INFO
[11:29:30.271] QUIET: Connection to board DTB_WRPRHI opened.
[11:29:30.274] 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:
------------------------------------------------------
[11:29:30.277] INFO: RPC call hashes of host and DTB match: 398089610
[11:29:31.882] INFO: DUT info:
[11:29:31.882] INFO: The DUT currently contains the following objects:
[11:29:31.882] INFO: 2 TBM Cores tbm08c (2 ON)
[11:29:31.882] INFO: TBM Core alpha (0): 7 registers set
[11:29:31.882] INFO: TBM Core beta (1): 7 registers set
[11:29:31.882] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:29:31.882] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:31.882] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:31.882] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:31.882] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:31.882] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:31.882] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:31.882] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:31.882] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:31.882] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:31.882] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:31.882] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:31.882] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:31.883] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:31.883] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:31.883] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:31.883] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:32.475] INFO: PixTestCmd::init()
[11:29:32.484] INFO: readGainPedestalParameters /home/CMS_pixel/Testing/pxar_fermi/data/mi202/phCalibrationFitErr35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/phCalibrationFitErr35_C15.dat
[11:29:32.786] INFO: readReadbackCal: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/readbackCal_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/readbackCal_C15.dat
[11:29:38.426] INFO: ######################################################################
[11:29:38.426] INFO: PixTestAlive::doTest()
[11:29:38.426] INFO: ######################################################################
[11:29:38.429] INFO: ----------------------------------------------------------------------
[11:29:38.429] 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:29:38.429] INFO: ----------------------------------------------------------------------
[11:29:38.807] INFO: Expecting 41600 events.
[11:29:43.063] INFO: 41600 events read in total (3538ms).
[11:29:43.211] INFO: Test took 4779ms.
[11:29:43.220] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:29:43.495] INFO: PixTestAlive::aliveTest() done
[11:29:43.495] INFO: number of dead pixels (per ROC): 2 0 1 1 0 0 0 0 0 1 1 0 0 0 0 0
[11:29:43.518] INFO: ----------------------------------------------------------------------
[11:29:43.518] 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:29:43.518] INFO: ----------------------------------------------------------------------
[11:29:43.894] INFO: Expecting 41600 events.
[11:29:46.951] INFO: 41600 events read in total (2342ms).
[11:29:46.952] INFO: Test took 3432ms.
[11:29:46.952] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:29:46.952] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:29:47.374] INFO: PixTestAlive::maskTest() done
[11:29:47.374] 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:29:47.393] INFO: ----------------------------------------------------------------------
[11:29:47.393] 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:29:47.393] INFO: ----------------------------------------------------------------------
[11:29:47.769] INFO: Expecting 41600 events.
[11:29:52.010] INFO: 41600 events read in total (3525ms).
[11:29:52.011] INFO: Test took 4616ms.
[11:29:52.022] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:29:52.394] INFO: PixTestAlive::addressDecodingTest() done
[11:29:52.394] 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:29:52.394] INFO: PixTestAlive::doTest() done, duration: 13 seconds
[11:29:58.039] INFO: ----------------------------------------------------------------------
[11:29:58.039] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[11:29:58.039] INFO: ----------------------------------------------------------------------
[11:29:58.177] INFO: Expecting 768 events.
[11:29:59.309] INFO: 768 events read in total (417ms).
[11:29:59.310] INFO: Test took 1266ms.
[11:30:00.113] INFO: Expecting 41600 events.
[11:30:03.370] INFO: 41600 events read in total (2730ms).
[11:30:03.374] INFO: Test took 4058ms.
[11:30:03.460] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:04.165] INFO: Expecting 41600 events.
[11:30:07.519] INFO: 41600 events read in total (2827ms).
[11:30:07.523] INFO: Test took 4022ms.
[11:30:07.605] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:08.311] INFO: Expecting 41600 events.
[11:30:11.699] INFO: 41600 events read in total (2861ms).
[11:30:11.702] INFO: Test took 4056ms.
[11:30:11.785] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:12.492] INFO: Expecting 41600 events.
[11:30:15.871] INFO: 41600 events read in total (2853ms).
[11:30:15.875] INFO: Test took 4048ms.
[11:30:15.958] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:16.665] INFO: Expecting 41600 events.
[11:30:20.038] INFO: 41600 events read in total (2847ms).
[11:30:20.042] INFO: Test took 4043ms.
[11:30:20.125] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:20.831] INFO: Expecting 41600 events.
[11:30:24.210] INFO: 41600 events read in total (2852ms).
[11:30:24.214] INFO: Test took 4048ms.
[11:30:24.296] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:25.003] INFO: Expecting 41600 events.
[11:30:28.384] INFO: 41600 events read in total (2855ms).
[11:30:28.388] INFO: Test took 4050ms.
[11:30:28.471] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:29.178] INFO: Expecting 41600 events.
[11:30:32.563] INFO: 41600 events read in total (2859ms).
[11:30:32.567] INFO: Test took 4054ms.
[11:30:32.650] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:33.357] INFO: Expecting 41600 events.
[11:30:36.736] INFO: 41600 events read in total (2853ms).
[11:30:36.740] INFO: Test took 4048ms.
[11:30:36.823] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:37.531] INFO: Expecting 41600 events.
[11:30:40.911] INFO: 41600 events read in total (2853ms).
[11:30:40.915] INFO: Test took 4049ms.
[11:30:40.998] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:41.707] INFO: Expecting 41600 events.
[11:30:45.089] INFO: 41600 events read in total (2855ms).
[11:30:45.093] INFO: Test took 4051ms.
[11:30:45.178] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:45.886] INFO: Expecting 41600 events.
[11:30:49.267] INFO: 41600 events read in total (2854ms).
[11:30:49.270] INFO: Test took 4049ms.
[11:30:49.353] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:50.059] INFO: Expecting 41600 events.
[11:30:53.438] INFO: 41600 events read in total (2852ms).
[11:30:53.441] INFO: Test took 4047ms.
[11:30:53.524] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:54.231] INFO: Expecting 41600 events.
[11:30:57.613] INFO: 41600 events read in total (2856ms).
[11:30:57.617] INFO: Test took 4052ms.
[11:30:57.701] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:58.409] INFO: Expecting 41600 events.
[11:31:01.810] INFO: 41600 events read in total (2874ms).
[11:31:01.814] INFO: Test took 4070ms.
[11:31:01.897] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:31:02.604] INFO: Expecting 41600 events.
[11:31:05.983] INFO: 41600 events read in total (2853ms).
[11:31:05.987] INFO: Test took 4048ms.
[11:31:06.071] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:31:06.779] INFO: Expecting 41600 events.
[11:31:10.161] INFO: 41600 events read in total (2855ms).
[11:31:10.165] INFO: Test took 4051ms.
[11:31:10.247] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:31:10.954] INFO: Expecting 41600 events.
[11:31:14.346] INFO: 41600 events read in total (2865ms).
[11:31:14.350] INFO: Test took 4061ms.
[11:31:14.432] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:31:15.139] INFO: Expecting 41600 events.
[11:31:18.509] INFO: 41600 events read in total (2844ms).
[11:31:18.513] INFO: Test took 4039ms.
[11:31:18.596] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:31:19.303] INFO: Expecting 41600 events.
[11:31:22.556] INFO: 41600 events read in total (2727ms).
[11:31:22.560] INFO: Test took 3922ms.
[11:31:22.643] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:32:27.151] INFO: ----------------------------------------------------------------------
[11:32:27.151] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:32:27.151] INFO: ----------------------------------------------------------------------
[11:32:27.832] INFO: Expecting 208000 events.
[11:32:40.700] INFO: 208000 events read in total (12341ms).
[11:32:40.714] INFO: Test took 13547ms.
[11:32:41.110] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:32:41.490] INFO: number of dead pixels (per ROC): 2 0 1 1 0 0 0 0 0 1 1 0 0 0 0 0
[11:32:41.490] INFO: number of red-efficiency pixels: 102 91 160 271 255 266 264 245 266 337 266 262 232 134 80 103
[11:32:41.490] INFO: number of X-ray hits detected: 77012 65794 107774 158800 167826 166198 169304 161250 179064 179404 175670 157149 162385 103197 62601 69513
[11:32:41.490] 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:32:41.490] INFO: number of Vcal hits detected: 207795 207905 207746 207665 207731 207714 207731 207745 207723 207589 207675 207728 207759 207864 207917 207894
[11:32:41.490] INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.8 99.9 99.9 99.9 99.9 100.0 99.9
[11:32:41.490] INFO: Vcal hit overall efficiency (%): 99.9 100.0 99.9 99.8 99.9 99.9 99.9 99.9 99.9 99.8 99.8 99.9 99.9 99.9 100.0 99.9
[11:32:41.490] INFO: X-ray hit rate [MHz/cm2]: 22.6 19.3 31.6 46.5 49.2 48.7 49.6 47.3 52.5 52.6 51.5 46.1 47.6 30.2 18.3 20.4
[11:32:41.490] INFO: PixTestHighRate::doXPixelAlive() done
[11:32:41.537] INFO: PixTest:: pg_setup set to default.
[11:32:56.233] QUIET: Connection to board 58 closed.
[11:26:38.128] INFO: *** Welcome to pxar ***
[11:26:38.128] INFO: *** Today: 2016/06/06
[11:26:38.151] INFO: *** Version: v1.9.0-805-geb36
[11:26:38.151] INFO: readRocDacs: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/dacParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/dacParameters35_C15.dat
[11:26:38.152] INFO: readTbmDacs: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/tbmParameters_C0a.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/tbmParameters_C0b.dat
[11:26:38.152] INFO: readMaskFile: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/defaultMaskFile.dat
[11:26:38.152] INFO: readTrimFile: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/trimParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/trimParameters35_C15.dat
[11:26:38.301] INFO: clk: 4
[11:26:38.301] INFO: ctr: 4
[11:26:38.301] INFO: sda: 19
[11:26:38.301] INFO: tin: 9
[11:26:38.301] INFO: level: 15
[11:26:38.301] INFO: triggerdelay: 0
[11:26:38.301] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[11:26:38.301] INFO: Log level: INFO
[11:26:38.312] QUIET: Connection to board DTB_WRPRHI opened.
[11:26:38.315] 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:
------------------------------------------------------
[11:26:38.318] INFO: RPC call hashes of host and DTB match: 398089610
[11:26:39.918] INFO: DUT info:
[11:26:39.919] INFO: The DUT currently contains the following objects:
[11:26:39.919] INFO: 2 TBM Cores tbm08c (2 ON)
[11:26:39.919] INFO: TBM Core alpha (0): 7 registers set
[11:26:39.919] INFO: TBM Core beta (1): 7 registers set
[11:26:39.919] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:26:39.919] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:26:39.919] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:26:39.919] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:26:39.919] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:26:39.919] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:26:39.919] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:26:39.919] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:26:39.919] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:26:39.919] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:26:39.919] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:26:39.919] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:26:39.919] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:26:39.919] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:26:39.919] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:26:39.919] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:26:39.919] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:26:40.550] INFO: PixTestCmd::init()
[11:26:40.560] INFO: readGainPedestalParameters /home/CMS_pixel/Testing/pxar_fermi/data/mi202/phCalibrationFitErr35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/phCalibrationFitErr35_C15.dat
[11:26:40.882] INFO: readReadbackCal: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/readbackCal_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/readbackCal_C15.dat
[11:26:56.546] INFO: ######################################################################
[11:26:56.546] INFO: PixTestAlive::doTest()
[11:26:56.546] INFO: ######################################################################
[11:26:56.549] INFO: ----------------------------------------------------------------------
[11:26:56.549] 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:26:56.549] INFO: ----------------------------------------------------------------------
[11:26:56.927] INFO: Expecting 41600 events.
[11:27:01.183] INFO: 41600 events read in total (3538ms).
[11:27:01.330] INFO: Test took 4778ms.
[11:27:01.339] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:27:01.614] INFO: PixTestAlive::aliveTest() done
[11:27:01.614] INFO: number of dead pixels (per ROC): 2 0 1 1 0 0 0 0 0 1 1 0 0 0 0 0
[11:27:01.636] INFO: ----------------------------------------------------------------------
[11:27:01.636] 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:27:01.636] INFO: ----------------------------------------------------------------------
[11:27:02.012] INFO: Expecting 41600 events.
[11:27:05.056] INFO: 41600 events read in total (2329ms).
[11:27:05.056] INFO: Test took 3417ms.
[11:27:05.056] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:27:05.057] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:27:05.479] INFO: PixTestAlive::maskTest() done
[11:27:05.479] 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:27:05.498] INFO: ----------------------------------------------------------------------
[11:27:05.498] 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:27:05.498] INFO: ----------------------------------------------------------------------
[11:27:05.874] INFO: Expecting 41600 events.
[11:27:10.116] INFO: 41600 events read in total (3526ms).
[11:27:10.118] INFO: Test took 4618ms.
[11:27:10.128] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:27:10.500] INFO: PixTestAlive::addressDecodingTest() done
[11:27:10.500] 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:27:10.500] INFO: PixTestAlive::doTest() done, duration: 13 seconds
[11:27:15.415] INFO: ----------------------------------------------------------------------
[11:27:15.415] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[11:27:15.415] INFO: ----------------------------------------------------------------------
[11:27:15.553] INFO: Expecting 768 events.
[11:27:16.685] INFO: 768 events read in total (416ms).
[11:27:16.686] INFO: Test took 1266ms.
[11:27:17.489] INFO: Expecting 41600 events.
[11:27:20.976] INFO: 41600 events read in total (2960ms).
[11:27:20.980] INFO: Test took 4289ms.
[11:27:21.102] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:27:21.819] INFO: Expecting 41600 events.
[11:27:25.401] INFO: 41600 events read in total (3056ms).
[11:27:25.406] INFO: Test took 4252ms.
[11:27:25.523] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:27:26.241] INFO: Expecting 41600 events.
[11:27:29.862] INFO: 41600 events read in total (3094ms).
[11:27:29.866] INFO: Test took 4291ms.
[11:27:29.985] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:27:30.704] INFO: Expecting 41600 events.
[11:27:34.342] INFO: 41600 events read in total (3111ms).
[11:27:34.346] INFO: Test took 4307ms.
[11:27:34.462] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:27:35.181] INFO: Expecting 41600 events.
[11:27:38.808] INFO: 41600 events read in total (3100ms).
[11:27:38.813] INFO: Test took 4297ms.
[11:27:38.931] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:27:39.650] INFO: Expecting 41600 events.
[11:27:43.277] INFO: 41600 events read in total (3101ms).
[11:27:43.282] INFO: Test took 4297ms.
[11:27:43.401] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:27:44.119] INFO: Expecting 41600 events.
[11:27:47.755] INFO: 41600 events read in total (3109ms).
[11:27:47.760] INFO: Test took 4306ms.
[11:27:47.877] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:27:48.596] INFO: Expecting 41600 events.
[11:27:52.236] INFO: 41600 events read in total (3113ms).
[11:27:52.241] INFO: Test took 4309ms.
[11:27:52.360] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:27:53.079] INFO: Expecting 41600 events.
[11:27:56.739] INFO: 41600 events read in total (3134ms).
[11:27:56.743] INFO: Test took 4331ms.
[11:27:56.862] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:27:57.581] INFO: Expecting 41600 events.
[11:28:01.222] INFO: 41600 events read in total (3114ms).
[11:28:01.226] INFO: Test took 4310ms.
[11:28:01.343] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:28:02.062] INFO: Expecting 41600 events.
[11:28:05.704] INFO: 41600 events read in total (3115ms).
[11:28:05.709] INFO: Test took 4311ms.
[11:28:05.826] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:28:06.545] INFO: Expecting 41600 events.
[11:28:10.189] INFO: 41600 events read in total (3117ms).
[11:28:10.194] INFO: Test took 4314ms.
[11:28:10.312] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:28:11.032] INFO: Expecting 41600 events.
[11:28:14.681] INFO: 41600 events read in total (3123ms).
[11:28:14.685] INFO: Test took 4318ms.
[11:28:14.803] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:28:15.523] INFO: Expecting 41600 events.
[11:28:19.152] INFO: 41600 events read in total (3103ms).
[11:28:19.157] INFO: Test took 4300ms.
[11:28:19.274] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:28:19.993] INFO: Expecting 41600 events.
[11:28:23.626] INFO: 41600 events read in total (3106ms).
[11:28:23.630] INFO: Test took 4302ms.
[11:28:23.747] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:28:24.467] INFO: Expecting 41600 events.
[11:28:28.106] INFO: 41600 events read in total (3112ms).
[11:28:28.111] INFO: Test took 4309ms.
[11:28:28.228] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:28:28.948] INFO: Expecting 41600 events.
[11:28:32.596] INFO: 41600 events read in total (3121ms).
[11:28:32.601] INFO: Test took 4317ms.
[11:28:32.720] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:28:33.439] INFO: Expecting 41600 events.
[11:28:37.080] INFO: 41600 events read in total (3114ms).
[11:28:37.084] INFO: Test took 4310ms.
[11:28:37.202] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:28:37.922] INFO: Expecting 41600 events.
[11:28:41.535] INFO: 41600 events read in total (3086ms).
[11:28:41.540] INFO: Test took 4283ms.
[11:28:41.657] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:28:42.376] INFO: Expecting 41600 events.
[11:28:45.887] INFO: 41600 events read in total (2984ms).
[11:28:45.892] INFO: Test took 4181ms.
[11:28:46.006] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:28:49.103] INFO: ----------------------------------------------------------------------
[11:28:49.103] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:28:49.103] INFO: ----------------------------------------------------------------------
[11:28:49.784] INFO: Expecting 208000 events.
[11:29:04.043] INFO: 208000 events read in total (13732ms).
[11:29:04.059] INFO: Test took 14940ms.
[11:29:04.611] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:29:05.053] INFO: number of dead pixels (per ROC): 2 0 1 1 0 0 0 0 0 1 1 0 0 0 0 0
[11:29:05.053] INFO: number of red-efficiency pixels: 151 130 277 428 490 432 451 398 497 538 571 425 465 320 142 130
[11:29:05.053] INFO: number of X-ray hits detected: 111281 96726 155553 230070 242333 241418 244540 233506 259228 261297 255815 229016 234824 149566 91856 101408
[11:29:05.053] 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:29:05.053] INFO: number of Vcal hits detected: 207746 207866 207607 207491 207466 207533 207514 207579 207452 207347 207309 207549 207502 207651 207854 207865
[11:29:05.053] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.7 99.7 99.8 99.8 99.8 99.9 99.9
[11:29:05.053] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.8 99.8 99.7 99.8 99.8 99.8 99.7 99.7 99.7 99.8 99.8 99.8 99.9 99.9
[11:29:05.053] INFO: X-ray hit rate [MHz/cm2]: 32.6 28.4 45.6 67.4 71.0 70.8 71.7 68.4 76.0 76.6 75.0 67.1 68.8 43.8 26.9 29.7
[11:29:05.053] INFO: PixTestHighRate::doXPixelAlive() done
[11:29:05.100] INFO: PixTest:: pg_setup set to default.
[11:29:24.084] QUIET: Connection to board 58 closed.
[11:19:58.320] INFO: *** Welcome to pxar ***
[11:19:58.320] INFO: *** Today: 2016/06/06
[11:19:58.343] INFO: *** Version: v1.9.0-805-geb36
[11:19:58.343] INFO: readRocDacs: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/dacParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/dacParameters35_C15.dat
[11:19:58.344] INFO: readTbmDacs: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/tbmParameters_C0a.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/tbmParameters_C0b.dat
[11:19:58.344] INFO: readMaskFile: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/defaultMaskFile.dat
[11:19:58.344] INFO: readTrimFile: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/trimParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/trimParameters35_C15.dat
[11:19:58.493] INFO: clk: 4
[11:19:58.493] INFO: ctr: 4
[11:19:58.493] INFO: sda: 19
[11:19:58.493] INFO: tin: 9
[11:19:58.493] INFO: level: 15
[11:19:58.493] INFO: triggerdelay: 0
[11:19:58.493] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[11:19:58.493] INFO: Log level: INFO
[11:19:58.505] QUIET: Connection to board DTB_WRPRHI opened.
[11:19:58.509] 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:
------------------------------------------------------
[11:19:58.511] INFO: RPC call hashes of host and DTB match: 398089610
[11:20:00.111] INFO: DUT info:
[11:20:00.111] INFO: The DUT currently contains the following objects:
[11:20:00.111] INFO: 2 TBM Cores tbm08c (2 ON)
[11:20:00.111] INFO: TBM Core alpha (0): 7 registers set
[11:20:00.111] INFO: TBM Core beta (1): 7 registers set
[11:20:00.111] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:20:00.111] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:00.111] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:00.111] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:00.111] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:00.111] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:00.111] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:00.111] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:00.111] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:00.111] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:00.111] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:00.111] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:00.111] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:00.111] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:00.111] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:00.111] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:00.111] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:00.706] INFO: PixTestCmd::init()
[11:20:00.715] INFO: readGainPedestalParameters /home/CMS_pixel/Testing/pxar_fermi/data/mi202/phCalibrationFitErr35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/phCalibrationFitErr35_C15.dat
[11:20:01.015] INFO: readReadbackCal: /home/CMS_pixel/Testing/pxar_fermi/data/mi202/readbackCal_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mi202/readbackCal_C15.dat
[11:20:04.338] INFO: ######################################################################
[11:20:04.338] INFO: PixTestAlive::doTest()
[11:20:04.338] INFO: ######################################################################
[11:20:04.341] INFO: ----------------------------------------------------------------------
[11:20:04.341] 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:20:04.341] INFO: ----------------------------------------------------------------------
[11:20:04.719] INFO: Expecting 41600 events.
[11:20:08.976] INFO: 41600 events read in total (3539ms).
[11:20:09.123] INFO: Test took 4780ms.
[11:20:09.133] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:09.407] INFO: PixTestAlive::aliveTest() done
[11:20:09.407] INFO: number of dead pixels (per ROC): 2 0 1 1 0 0 0 0 0 1 1 0 0 0 0 0
[11:20:09.429] INFO: ----------------------------------------------------------------------
[11:20:09.429] 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:20:09.429] INFO: ----------------------------------------------------------------------
[11:20:09.805] INFO: Expecting 41600 events.
[11:20:12.856] INFO: 41600 events read in total (2336ms).
[11:20:12.856] INFO: Test took 3425ms.
[11:20:12.856] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:12.857] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:20:13.279] INFO: PixTestAlive::maskTest() done
[11:20:13.279] 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:20:13.298] INFO: ----------------------------------------------------------------------
[11:20:13.298] 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:20:13.298] INFO: ----------------------------------------------------------------------
[11:20:13.674] INFO: Expecting 41600 events.
[11:20:17.909] INFO: 41600 events read in total (3519ms).
[11:20:17.911] INFO: Test took 4611ms.
[11:20:17.922] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:18.294] INFO: PixTestAlive::addressDecodingTest() done
[11:20:18.294] 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:20:18.294] INFO: PixTestAlive::doTest() done, duration: 13 seconds
[11:20:19.902] INFO: ----------------------------------------------------------------------
[11:20:19.902] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[11:20:19.903] INFO: ----------------------------------------------------------------------
[11:20:20.042] INFO: Expecting 768 events.
[11:20:21.173] INFO: 768 events read in total (416ms).
[11:20:21.174] INFO: Test took 1266ms.
[11:20:21.977] INFO: Expecting 41600 events.
[11:20:25.711] INFO: 41600 events read in total (3208ms).
[11:20:25.716] INFO: Test took 4537ms.
[11:20:25.875] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:26.606] INFO: Expecting 41600 events.
[11:20:30.428] INFO: 41600 events read in total (3295ms).
[11:20:30.434] INFO: Test took 4493ms.
[11:20:30.585] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:31.320] INFO: Expecting 41600 events.
[11:20:35.184] INFO: 41600 events read in total (3338ms).
[11:20:35.190] INFO: Test took 4536ms.
[11:20:35.340] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:36.075] INFO: Expecting 41600 events.
[11:20:39.935] INFO: 41600 events read in total (3333ms).
[11:20:39.941] INFO: Test took 4531ms.
[11:20:40.090] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:40.825] INFO: Expecting 41600 events.
[11:20:44.678] INFO: 41600 events read in total (3326ms).
[11:20:44.683] INFO: Test took 4523ms.
[11:20:44.834] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:45.568] INFO: Expecting 41600 events.
[11:20:49.419] INFO: 41600 events read in total (3324ms).
[11:20:49.425] INFO: Test took 4522ms.
[11:20:49.577] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:50.313] INFO: Expecting 41600 events.
[11:20:54.188] INFO: 41600 events read in total (3348ms).
[11:20:54.194] INFO: Test took 4546ms.
[11:20:54.349] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:55.082] INFO: Expecting 41600 events.
[11:20:58.967] INFO: 41600 events read in total (3358ms).
[11:20:58.973] INFO: Test took 4556ms.
[11:20:59.124] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:59.858] INFO: Expecting 41600 events.
[11:21:03.739] INFO: 41600 events read in total (3354ms).
[11:21:03.745] INFO: Test took 4552ms.
[11:21:03.895] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:04.630] INFO: Expecting 41600 events.
[11:21:08.504] INFO: 41600 events read in total (3347ms).
[11:21:08.510] INFO: Test took 4545ms.
[11:21:08.661] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:09.397] INFO: Expecting 41600 events.
[11:21:13.277] INFO: 41600 events read in total (3353ms).
[11:21:13.282] INFO: Test took 4550ms.
[11:21:13.434] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:14.170] INFO: Expecting 41600 events.
[11:21:18.064] INFO: 41600 events read in total (3367ms).
[11:21:18.070] INFO: Test took 4565ms.
[11:21:18.220] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:18.957] INFO: Expecting 41600 events.
[11:21:22.838] INFO: 41600 events read in total (3354ms).
[11:21:22.843] INFO: Test took 4552ms.
[11:21:23.046] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:23.781] INFO: Expecting 41600 events.
[11:21:27.647] INFO: 41600 events read in total (3339ms).
[11:21:27.653] INFO: Test took 4536ms.
[11:21:27.803] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:28.539] INFO: Expecting 41600 events.
[11:21:32.421] INFO: 41600 events read in total (3355ms).
[11:21:32.427] INFO: Test took 4553ms.
[11:21:32.577] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:33.313] INFO: Expecting 41600 events.
[11:21:37.208] INFO: 41600 events read in total (3368ms).
[11:21:37.214] INFO: Test took 4566ms.
[11:21:37.368] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:38.102] INFO: Expecting 41600 events.
[11:21:41.988] INFO: 41600 events read in total (3360ms).
[11:21:41.993] INFO: Test took 4556ms.
[11:21:42.150] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:42.883] INFO: Expecting 41600 events.
[11:21:46.775] INFO: 41600 events read in total (3365ms).
[11:21:46.781] INFO: Test took 4562ms.
[11:21:46.936] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:47.669] INFO: Expecting 41600 events.
[11:21:51.557] INFO: 41600 events read in total (3362ms).
[11:21:51.562] INFO: Test took 4558ms.
[11:21:51.718] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:52.452] INFO: Expecting 41600 events.
[11:21:56.196] INFO: 41600 events read in total (3217ms).
[11:21:56.202] INFO: Test took 4415ms.
[11:21:56.352] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:22:05.127] INFO: ----------------------------------------------------------------------
[11:22:05.127] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:22:05.127] INFO: ----------------------------------------------------------------------
[11:22:05.808] INFO: Expecting 208000 events.
[11:22:22.076] INFO: 208000 events read in total (15741ms).
[11:22:22.098] INFO: Test took 16956ms.
[11:22:22.957] INFO: Fetched DAQ statistics. Counters are being reset now.
[11:22:23.475] INFO: number of dead pixels (per ROC): 2 0 1 1 0 0 0 0 0 1 1 0 0 0 0 0
[11:22:23.475] INFO: number of red-efficiency pixels: 273 208 489 748 832 805 883 885 924 1002 879 758 799 390 205 261
[11:22:23.475] INFO: number of X-ray hits detected: 152379 131559 213259 314620 330653 328614 333845 320521 354971 356180 349467 314322 321003 204181 124272 138672
[11:22:23.475] 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:22:23.475] INFO: number of Vcal hits detected: 207615 207780 207337 207080 207025 207059 206968 206994 206955 206733 206889 207115 207085 207539 207783 207728
[11:22:23.475] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.7 99.6 99.6 99.6 99.5 99.5 99.5 99.5 99.5 99.6 99.6 99.8 99.9 99.9
[11:22:23.475] INFO: Vcal hit overall efficiency (%): 99.8 99.9 99.7 99.6 99.5 99.5 99.5 99.5 99.5 99.4 99.5 99.6 99.6 99.8 99.9 99.9
[11:22:23.475] INFO: X-ray hit rate [MHz/cm2]: 44.7 38.6 62.5 92.2 96.9 96.3 97.9 93.9 104.0 104.4 102.4 92.1 94.1 59.8 36.4 40.6
[11:22:23.475] INFO: PixTestHighRate::doXPixelAlive() done
[11:22:23.521] INFO: PixTest:: pg_setup set to default.
[11:22:40.261] QUIET: Connection to board 58 closed.