[09:51:50.280] INFO: *** Welcome to pxar ***
[09:51:50.280] INFO: *** Today: 2016/06/06
[09:51:50.303] INFO: *** Version: v1.9.0-805-geb36
[09:51:50.303] INFO: readRocDacs: /home/CMS_pixel/Testing/pxar_fermi/data/myang/dacParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/dacParameters35_C15.dat
[09:51:50.304] INFO: readTbmDacs: /home/CMS_pixel/Testing/pxar_fermi/data/myang/tbmParameters_C0a.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/tbmParameters_C0b.dat
[09:51:50.304] INFO: readMaskFile: /home/CMS_pixel/Testing/pxar_fermi/data/myang/defaultMaskFile.dat
[09:51:50.304] INFO: readTrimFile: /home/CMS_pixel/Testing/pxar_fermi/data/myang/trimParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/trimParameters35_C15.dat
[09:51:50.454] INFO: clk: 4
[09:51:50.454] INFO: ctr: 4
[09:51:50.454] INFO: sda: 19
[09:51:50.454] INFO: tin: 9
[09:51:50.454] INFO: level: 15
[09:51:50.454] INFO: triggerdelay: 0
[09:51:50.454] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[09:51:50.454] INFO: Log level: INFO
[09:51:50.465] QUIET: Connection to board DTB_WRPRHI opened.
[09:51:50.468] 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:
------------------------------------------------------
[09:51:50.471] INFO: RPC call hashes of host and DTB match: 398089610
[09:51:52.070] INFO: DUT info:
[09:51:52.070] INFO: The DUT currently contains the following objects:
[09:51:52.070] INFO: 2 TBM Cores tbm08c (2 ON)
[09:51:52.070] INFO: TBM Core alpha (0): 7 registers set
[09:51:52.070] INFO: TBM Core beta (1): 7 registers set
[09:51:52.070] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:51:52.070] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:52.070] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:52.070] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:52.070] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:52.070] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:52.070] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:52.070] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:52.070] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:52.070] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:52.070] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:52.070] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:52.070] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:52.070] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:52.071] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:52.071] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:52.071] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:52.659] INFO: PixTestCmd::init()
[09:51:52.677] INFO: readGainPedestalParameters /home/CMS_pixel/Testing/pxar_fermi/data/myang/phCalibrationFitErr35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/phCalibrationFitErr35_C15.dat
[09:51:52.980] INFO: readReadbackCal: /home/CMS_pixel/Testing/pxar_fermi/data/myang/readbackCal_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/readbackCal_C15.dat
[09:52:03.021] INFO: ######################################################################
[09:52:03.021] INFO: PixTestXray::doTest()
[09:52:03.021] INFO: ######################################################################
[09:52:03.021] INFO: ----------------------------------------------------------------------
[09:52:03.021] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[09:52:03.021] INFO: ----------------------------------------------------------------------
[09:52:03.994] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[09:52:15.468] INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[09:52:46.969] INFO: Resuming triggers.
[09:52:58.446] INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[09:53:29.888] INFO: Resuming triggers.
[09:53:41.365] INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[09:54:12.989] INFO: Resuming triggers.
[09:54:24.465] INFO: run duration 45 seconds, buffer almost full (81%), pausing triggers.
[09:54:56.094] INFO: Resuming triggers.
[09:55:07.575] INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.
[09:55:39.293] INFO: Resuming triggers.
[09:55:41.990] INFO: data taking finished, elapsed time: 60 seconds.
[09:55:49.705] INFO: PixTest:: pg_setup set to default.
[09:55:49.743] INFO: PixTestXray::doPhRun() done
[09:55:49.743] INFO: PixTestXray::doTest() done
[09:57:07.098] QUIET: Connection to board 58 closed.
[09:57:11.932] INFO: *** Welcome to pxar ***
[09:57:11.932] INFO: *** Today: 2016/06/06
[09:57:11.955] INFO: *** Version: v1.9.0-805-geb36
[09:57:11.955] INFO: readRocDacs: /home/CMS_pixel/Testing/pxar_fermi/data/myang/dacParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/dacParameters35_C15.dat
[09:57:11.956] INFO: readTbmDacs: /home/CMS_pixel/Testing/pxar_fermi/data/myang/tbmParameters_C0a.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/tbmParameters_C0b.dat
[09:57:11.956] INFO: readMaskFile: /home/CMS_pixel/Testing/pxar_fermi/data/myang/defaultMaskFile.dat
[09:57:11.956] INFO: readTrimFile: /home/CMS_pixel/Testing/pxar_fermi/data/myang/trimParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/trimParameters35_C15.dat
[09:57:12.104] INFO: clk: 4
[09:57:12.104] INFO: ctr: 4
[09:57:12.104] INFO: sda: 19
[09:57:12.104] INFO: tin: 9
[09:57:12.104] INFO: level: 15
[09:57:12.104] INFO: triggerdelay: 0
[09:57:12.104] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[09:57:12.105] INFO: Log level: INFO
[09:57:12.115] QUIET: Connection to board DTB_WRPRHI opened.
[09:57:12.119] 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:
------------------------------------------------------
[09:57:12.121] INFO: RPC call hashes of host and DTB match: 398089610
[09:57:13.720] INFO: DUT info:
[09:57:13.720] INFO: The DUT currently contains the following objects:
[09:57:13.720] INFO: 2 TBM Cores tbm08c (2 ON)
[09:57:13.720] INFO: TBM Core alpha (0): 7 registers set
[09:57:13.720] INFO: TBM Core beta (1): 7 registers set
[09:57:13.720] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:57:13.720] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:13.720] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:13.720] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:13.720] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:13.721] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:13.721] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:13.721] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:13.721] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:13.721] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:13.721] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:13.721] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:13.721] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:13.721] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:13.721] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:13.721] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:13.721] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:14.324] INFO: PixTestCmd::init()
[09:57:14.328] INFO: readGainPedestalParameters /home/CMS_pixel/Testing/pxar_fermi/data/myang/phCalibrationFitErr35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/phCalibrationFitErr35_C15.dat
[09:57:14.630] INFO: readReadbackCal: /home/CMS_pixel/Testing/pxar_fermi/data/myang/readbackCal_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/readbackCal_C15.dat
[09:57:29.413] INFO: ----------------------------------------------------------------------
[09:57:29.413] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[09:57:29.413] INFO: ----------------------------------------------------------------------
[09:57:30.386] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[09:57:37.428] INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[09:58:12.743] INFO: Resuming triggers.
[09:58:19.792] INFO: run duration 14 seconds, buffer almost full (81%), pausing triggers.
[09:58:55.002] INFO: Resuming triggers.
[09:59:02.058] INFO: run duration 21 seconds, buffer almost full (81%), pausing triggers.
[09:59:37.658] INFO: Resuming triggers.
[09:59:44.709] INFO: run duration 28 seconds, buffer almost full (81%), pausing triggers.
[10:00:20.019] INFO: Resuming triggers.
[10:00:27.077] INFO: run duration 35 seconds, buffer almost full (81%), pausing triggers.
[10:01:02.574] INFO: Resuming triggers.
[10:01:09.632] INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[10:01:44.425] INFO: Resuming triggers.
[10:01:51.488] INFO: run duration 49 seconds, buffer almost full (81%), pausing triggers.
[10:02:26.390] INFO: Resuming triggers.
[10:02:33.454] INFO: run duration 56 seconds, buffer almost full (81%), pausing triggers.
[10:03:08.272] INFO: Resuming triggers.
[10:03:11.907] INFO: data taking finished, elapsed time: 60 seconds.
[10:03:30.131] INFO: PixTest:: pg_setup set to default.
[10:03:30.171] INFO: PixTestXray::doPhRun() done
[10:04:05.155] QUIET: Connection to board 58 closed.
[09:46:19.347] INFO: *** Welcome to pxar ***
[09:46:19.347] INFO: *** Today: 2016/06/06
[09:46:19.369] INFO: *** Version: v1.9.0-805-geb36
[09:46:19.369] INFO: readRocDacs: /home/CMS_pixel/Testing/pxar_fermi/data/myang/dacParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/dacParameters35_C15.dat
[09:46:19.370] INFO: readTbmDacs: /home/CMS_pixel/Testing/pxar_fermi/data/myang/tbmParameters_C0a.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/tbmParameters_C0b.dat
[09:46:19.371] INFO: readMaskFile: /home/CMS_pixel/Testing/pxar_fermi/data/myang/defaultMaskFile.dat
[09:46:19.371] INFO: readTrimFile: /home/CMS_pixel/Testing/pxar_fermi/data/myang/trimParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/trimParameters35_C15.dat
[09:46:19.519] INFO: clk: 4
[09:46:19.519] INFO: ctr: 4
[09:46:19.519] INFO: sda: 19
[09:46:19.519] INFO: tin: 9
[09:46:19.519] INFO: level: 15
[09:46:19.519] INFO: triggerdelay: 0
[09:46:19.519] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[09:46:19.519] INFO: Log level: INFO
[09:46:19.530] QUIET: Connection to board DTB_WRPRHI opened.
[09:46:19.533] 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:
------------------------------------------------------
[09:46:19.536] INFO: RPC call hashes of host and DTB match: 398089610
[09:46:21.135] INFO: DUT info:
[09:46:21.135] INFO: The DUT currently contains the following objects:
[09:46:21.135] INFO: 2 TBM Cores tbm08c (2 ON)
[09:46:21.135] INFO: TBM Core alpha (0): 7 registers set
[09:46:21.135] INFO: TBM Core beta (1): 7 registers set
[09:46:21.135] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:46:21.135] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:21.135] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:21.135] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:21.135] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:21.135] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:21.135] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:21.135] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:21.135] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:21.135] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:21.135] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:21.135] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:21.135] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:21.135] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:21.135] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:21.135] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:21.135] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:46:21.732] INFO: PixTestCmd::init()
[09:46:21.739] INFO: readGainPedestalParameters /home/CMS_pixel/Testing/pxar_fermi/data/myang/phCalibrationFitErr35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/phCalibrationFitErr35_C15.dat
[09:46:22.037] INFO: readReadbackCal: /home/CMS_pixel/Testing/pxar_fermi/data/myang/readbackCal_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/readbackCal_C15.dat
[09:46:27.664] INFO: ######################################################################
[09:46:27.664] INFO: PixTestAlive::doTest()
[09:46:27.664] INFO: ######################################################################
[09:46:27.668] INFO: ----------------------------------------------------------------------
[09:46:27.668] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:46:27.668] INFO: ----------------------------------------------------------------------
[09:46:28.045] INFO: Expecting 41600 events.
[09:46:32.302] INFO: 41600 events read in total (3539ms).
[09:46:32.452] INFO: Test took 4782ms.
[09:46:32.462] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:46:32.732] INFO: PixTestAlive::aliveTest() done
[09:46:32.732] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 3 0 0 0 0 0 0 0
[09:46:32.755] INFO: ----------------------------------------------------------------------
[09:46:32.755] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:46:32.755] INFO: ----------------------------------------------------------------------
[09:46:33.132] INFO: Expecting 41600 events.
[09:46:36.181] INFO: 41600 events read in total (2334ms).
[09:46:36.181] INFO: Test took 3423ms.
[09:46:36.182] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:46:36.182] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[09:46:36.606] INFO: PixTestAlive::maskTest() done
[09:46:36.606] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:46:36.624] INFO: ----------------------------------------------------------------------
[09:46:36.624] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:46:36.624] INFO: ----------------------------------------------------------------------
[09:46:37.001] INFO: Expecting 41600 events.
[09:46:41.260] INFO: 41600 events read in total (3544ms).
[09:46:41.262] INFO: Test took 4635ms.
[09:46:41.273] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:46:41.643] INFO: PixTestAlive::addressDecodingTest() done
[09:46:41.643] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:46:41.644] INFO: PixTestAlive::doTest() done, duration: 13 seconds
[09:46:44.925] INFO: ----------------------------------------------------------------------
[09:46:44.925] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[09:46:44.925] INFO: ----------------------------------------------------------------------
[09:46:45.064] INFO: Expecting 768 events.
[09:46:46.197] INFO: 768 events read in total (417ms).
[09:46:46.197] INFO: Test took 1266ms.
[09:46:47.001] INFO: Expecting 41600 events.
[09:46:50.374] INFO: 41600 events read in total (2846ms).
[09:46:50.379] INFO: Test took 4176ms.
[09:46:50.482] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:46:51.192] INFO: Expecting 41600 events.
[09:46:54.626] INFO: 41600 events read in total (2907ms).
[09:46:54.630] INFO: Test took 4103ms.
[09:46:54.732] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:46:55.445] INFO: Expecting 41600 events.
[09:46:58.911] INFO: 41600 events read in total (2939ms).
[09:46:58.915] INFO: Test took 4135ms.
[09:46:59.019] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:46:59.733] INFO: Expecting 41600 events.
[09:47:03.188] INFO: 41600 events read in total (2928ms).
[09:47:03.193] INFO: Test took 4125ms.
[09:47:03.296] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:47:04.009] INFO: Expecting 41600 events.
[09:47:07.474] INFO: 41600 events read in total (2938ms).
[09:47:07.478] INFO: Test took 4134ms.
[09:47:07.577] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:47:08.288] INFO: Expecting 41600 events.
[09:47:11.760] INFO: 41600 events read in total (2945ms).
[09:47:11.764] INFO: Test took 4141ms.
[09:47:11.866] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:47:12.579] INFO: Expecting 41600 events.
[09:47:16.051] INFO: 41600 events read in total (2945ms).
[09:47:16.055] INFO: Test took 4141ms.
[09:47:16.157] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:47:16.870] INFO: Expecting 41600 events.
[09:47:20.345] INFO: 41600 events read in total (2948ms).
[09:47:20.350] INFO: Test took 4144ms.
[09:47:20.450] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:47:21.163] INFO: Expecting 41600 events.
[09:47:24.643] INFO: 41600 events read in total (2953ms).
[09:47:24.647] INFO: Test took 4149ms.
[09:47:24.746] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:47:25.458] INFO: Expecting 41600 events.
[09:47:28.938] INFO: 41600 events read in total (2953ms).
[09:47:28.942] INFO: Test took 4148ms.
[09:47:29.044] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:47:29.756] INFO: Expecting 41600 events.
[09:47:33.230] INFO: 41600 events read in total (2947ms).
[09:47:33.234] INFO: Test took 4143ms.
[09:47:33.335] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:47:34.047] INFO: Expecting 41600 events.
[09:47:37.537] INFO: 41600 events read in total (2963ms).
[09:47:37.541] INFO: Test took 4158ms.
[09:47:37.645] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:47:38.359] INFO: Expecting 41600 events.
[09:47:41.838] INFO: 41600 events read in total (2952ms).
[09:47:41.842] INFO: Test took 4148ms.
[09:47:41.941] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:47:42.654] INFO: Expecting 41600 events.
[09:47:46.130] INFO: 41600 events read in total (2949ms).
[09:47:46.134] INFO: Test took 4145ms.
[09:47:46.234] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:47:46.947] INFO: Expecting 41600 events.
[09:47:50.420] INFO: 41600 events read in total (2947ms).
[09:47:50.424] INFO: Test took 4142ms.
[09:47:50.526] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:47:51.238] INFO: Expecting 41600 events.
[09:47:54.711] INFO: 41600 events read in total (2946ms).
[09:47:54.715] INFO: Test took 4142ms.
[09:47:54.817] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:47:55.531] INFO: Expecting 41600 events.
[09:47:59.006] INFO: 41600 events read in total (2948ms).
[09:47:59.010] INFO: Test took 4144ms.
[09:47:59.112] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:47:59.826] INFO: Expecting 41600 events.
[09:48:03.293] INFO: 41600 events read in total (2940ms).
[09:48:03.297] INFO: Test took 4136ms.
[09:48:03.397] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:48:04.109] INFO: Expecting 41600 events.
[09:48:07.517] INFO: 41600 events read in total (2881ms).
[09:48:07.521] INFO: Test took 4076ms.
[09:48:07.621] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:48:08.336] INFO: Expecting 41600 events.
[09:48:11.560] INFO: 41600 events read in total (2697ms).
[09:48:11.564] INFO: Test took 3893ms.
[09:48:11.662] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:48:21.149] INFO: ----------------------------------------------------------------------
[09:48:21.149] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[09:48:21.149] INFO: ----------------------------------------------------------------------
[09:48:21.830] INFO: Expecting 208000 events.
[09:48:35.302] INFO: 208000 events read in total (12945ms).
[09:48:35.317] INFO: Test took 14152ms.
[09:48:35.835] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:48:36.242] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 3 0 0 0 0 0 0 0
[09:48:36.242] INFO: number of red-efficiency pixels: 143 107 242 318 360 395 350 327 426 432 438 453 342 205 93 104
[09:48:36.242] INFO: number of X-ray hits detected: 89878 79299 124391 190732 202051 202149 203015 184650 207001 213206 209034 201462 199833 130913 74820 81947
[09:48:36.242] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[09:48:36.242] INFO: number of Vcal hits detected: 207857 207890 207745 207660 207621 207577 207625 207664 207393 207528 207526 207513 207637 207785 207905 207894
[09:48:36.242] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.9 100.0 100.0
[09:48:36.242] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.7 99.8 99.8 99.8 99.8 99.9 100.0 99.9
[09:48:36.242] INFO: X-ray hit rate [MHz/cm2]: 26.3 23.2 36.5 55.9 59.2 59.3 59.5 54.1 60.7 62.5 61.3 59.0 58.6 38.4 21.9 24.0
[09:48:36.242] INFO: PixTestHighRate::doXPixelAlive() done
[09:48:36.288] INFO: PixTest:: pg_setup set to default.
[09:48:48.096] QUIET: Connection to board 58 closed.
[09:43:19.014] INFO: *** Welcome to pxar ***
[09:43:19.015] INFO: *** Today: 2016/06/06
[09:43:19.037] INFO: *** Version: v1.9.0-805-geb36
[09:43:19.037] INFO: readRocDacs: /home/CMS_pixel/Testing/pxar_fermi/data/myang/dacParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/dacParameters35_C15.dat
[09:43:19.038] INFO: readTbmDacs: /home/CMS_pixel/Testing/pxar_fermi/data/myang/tbmParameters_C0a.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/tbmParameters_C0b.dat
[09:43:19.039] INFO: readMaskFile: /home/CMS_pixel/Testing/pxar_fermi/data/myang/defaultMaskFile.dat
[09:43:19.039] INFO: readTrimFile: /home/CMS_pixel/Testing/pxar_fermi/data/myang/trimParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/trimParameters35_C15.dat
[09:43:19.187] INFO: clk: 4
[09:43:19.187] INFO: ctr: 4
[09:43:19.187] INFO: sda: 19
[09:43:19.187] INFO: tin: 9
[09:43:19.187] INFO: level: 15
[09:43:19.187] INFO: triggerdelay: 0
[09:43:19.187] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[09:43:19.187] INFO: Log level: INFO
[09:43:19.198] QUIET: Connection to board DTB_WRPRHI opened.
[09:43:19.201] 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:
------------------------------------------------------
[09:43:19.204] INFO: RPC call hashes of host and DTB match: 398089610
[09:43:20.803] INFO: DUT info:
[09:43:20.803] INFO: The DUT currently contains the following objects:
[09:43:20.803] INFO: 2 TBM Cores tbm08c (2 ON)
[09:43:20.803] INFO: TBM Core alpha (0): 7 registers set
[09:43:20.803] INFO: TBM Core beta (1): 7 registers set
[09:43:20.803] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:43:20.803] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:20.803] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:20.803] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:20.803] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:20.803] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:20.803] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:20.803] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:20.803] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:20.803] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:20.803] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:20.803] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:20.803] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:20.803] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:20.803] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:20.803] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:20.804] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:43:21.393] INFO: PixTestCmd::init()
[09:43:21.404] INFO: readGainPedestalParameters /home/CMS_pixel/Testing/pxar_fermi/data/myang/phCalibrationFitErr35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/phCalibrationFitErr35_C15.dat
[09:43:21.705] INFO: readReadbackCal: /home/CMS_pixel/Testing/pxar_fermi/data/myang/readbackCal_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/readbackCal_C15.dat
[09:43:27.552] INFO: ######################################################################
[09:43:27.552] INFO: PixTestAlive::doTest()
[09:43:27.552] INFO: ######################################################################
[09:43:27.556] INFO: ----------------------------------------------------------------------
[09:43:27.556] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:43:27.556] INFO: ----------------------------------------------------------------------
[09:43:27.933] INFO: Expecting 41600 events.
[09:43:32.189] INFO: 41600 events read in total (3538ms).
[09:43:32.336] INFO: Test took 4778ms.
[09:43:32.345] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:43:32.616] INFO: PixTestAlive::aliveTest() done
[09:43:32.616] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 3 0 0 0 0 0 0 0
[09:43:32.640] INFO: ----------------------------------------------------------------------
[09:43:32.640] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:43:32.640] INFO: ----------------------------------------------------------------------
[09:43:33.016] INFO: Expecting 41600 events.
[09:43:36.068] INFO: 41600 events read in total (2337ms).
[09:43:36.068] INFO: Test took 3426ms.
[09:43:36.068] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:43:36.069] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[09:43:36.491] INFO: PixTestAlive::maskTest() done
[09:43:36.491] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:43:36.509] INFO: ----------------------------------------------------------------------
[09:43:36.509] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:43:36.509] INFO: ----------------------------------------------------------------------
[09:43:36.887] INFO: Expecting 41600 events.
[09:43:41.157] INFO: 41600 events read in total (3555ms).
[09:43:41.158] INFO: Test took 4647ms.
[09:43:41.168] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:43:41.540] INFO: PixTestAlive::addressDecodingTest() done
[09:43:41.540] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:43:41.540] INFO: PixTestAlive::doTest() done, duration: 13 seconds
[09:43:45.589] INFO: ----------------------------------------------------------------------
[09:43:45.589] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[09:43:45.589] INFO: ----------------------------------------------------------------------
[09:43:45.728] INFO: Expecting 768 events.
[09:43:46.860] INFO: 768 events read in total (417ms).
[09:43:46.861] INFO: Test took 1266ms.
[09:43:47.664] INFO: Expecting 41600 events.
[09:43:51.321] INFO: 41600 events read in total (3131ms).
[09:43:51.326] INFO: Test took 4460ms.
[09:43:51.473] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:43:52.199] INFO: Expecting 41600 events.
[09:43:55.911] INFO: 41600 events read in total (3185ms).
[09:43:55.916] INFO: Test took 4382ms.
[09:43:56.055] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:43:56.784] INFO: Expecting 41600 events.
[09:44:00.535] INFO: 41600 events read in total (3224ms).
[09:44:00.541] INFO: Test took 4421ms.
[09:44:00.677] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:01.407] INFO: Expecting 41600 events.
[09:44:05.169] INFO: 41600 events read in total (3235ms).
[09:44:05.174] INFO: Test took 4432ms.
[09:44:05.313] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:06.043] INFO: Expecting 41600 events.
[09:44:09.806] INFO: 41600 events read in total (3236ms).
[09:44:09.811] INFO: Test took 4433ms.
[09:44:09.949] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:10.680] INFO: Expecting 41600 events.
[09:44:14.462] INFO: 41600 events read in total (3256ms).
[09:44:14.467] INFO: Test took 4453ms.
[09:44:14.606] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:15.336] INFO: Expecting 41600 events.
[09:44:19.129] INFO: 41600 events read in total (3266ms).
[09:44:19.134] INFO: Test took 4463ms.
[09:44:19.276] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:20.006] INFO: Expecting 41600 events.
[09:44:23.804] INFO: 41600 events read in total (3271ms).
[09:44:23.809] INFO: Test took 4468ms.
[09:44:23.948] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:24.679] INFO: Expecting 41600 events.
[09:44:28.473] INFO: 41600 events read in total (3268ms).
[09:44:28.478] INFO: Test took 4464ms.
[09:44:28.621] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:29.350] INFO: Expecting 41600 events.
[09:44:33.138] INFO: 41600 events read in total (3261ms).
[09:44:33.144] INFO: Test took 4459ms.
[09:44:33.282] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:34.013] INFO: Expecting 41600 events.
[09:44:37.790] INFO: 41600 events read in total (3250ms).
[09:44:37.795] INFO: Test took 4447ms.
[09:44:37.934] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:38.665] INFO: Expecting 41600 events.
[09:44:42.427] INFO: 41600 events read in total (3236ms).
[09:44:42.433] INFO: Test took 4433ms.
[09:44:42.573] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:43.303] INFO: Expecting 41600 events.
[09:44:47.072] INFO: 41600 events read in total (3242ms).
[09:44:47.077] INFO: Test took 4439ms.
[09:44:47.217] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:47.948] INFO: Expecting 41600 events.
[09:44:51.721] INFO: 41600 events read in total (3247ms).
[09:44:51.726] INFO: Test took 4444ms.
[09:44:51.867] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:52.599] INFO: Expecting 41600 events.
[09:44:56.371] INFO: 41600 events read in total (3246ms).
[09:44:56.376] INFO: Test took 4442ms.
[09:44:56.515] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:44:57.246] INFO: Expecting 41600 events.
[09:45:01.011] INFO: 41600 events read in total (3238ms).
[09:45:01.017] INFO: Test took 4436ms.
[09:45:01.155] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:45:01.885] INFO: Expecting 41600 events.
[09:45:05.666] INFO: 41600 events read in total (3254ms).
[09:45:05.671] INFO: Test took 4450ms.
[09:45:05.813] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:45:06.544] INFO: Expecting 41600 events.
[09:45:10.315] INFO: 41600 events read in total (3244ms).
[09:45:10.320] INFO: Test took 4441ms.
[09:45:10.460] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:45:11.191] INFO: Expecting 41600 events.
[09:45:14.881] INFO: 41600 events read in total (3163ms).
[09:45:14.886] INFO: Test took 4360ms.
[09:45:15.025] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:45:15.755] INFO: Expecting 41600 events.
[09:45:19.243] INFO: 41600 events read in total (2961ms).
[09:45:19.248] INFO: Test took 4158ms.
[09:45:19.385] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:45:28.349] INFO: ----------------------------------------------------------------------
[09:45:28.349] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[09:45:28.349] INFO: ----------------------------------------------------------------------
[09:45:29.031] INFO: Expecting 208000 events.
[09:45:44.655] INFO: 208000 events read in total (15097ms).
[09:45:44.675] INFO: Test took 16310ms.
[09:45:45.438] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:45:45.928] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 3 0 0 0 0 0 0 0
[09:45:45.928] INFO: number of red-efficiency pixels: 185 196 392 706 765 705 673 651 786 823 813 747 717 417 168 196
[09:45:45.928] INFO: number of X-ray hits detected: 134952 118316 186363 287949 304349 303585 304108 277503 310251 319763 313862 301778 299880 197800 112366 123783
[09:45:45.928] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[09:45:45.928] INFO: number of Vcal hits detected: 207810 207796 207556 207212 207126 207182 207246 207244 206945 207047 207078 207115 207178 207524 207826 207799
[09:45:45.928] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.8 99.6 99.6 99.6 99.7 99.7 99.6 99.6 99.6 99.6 99.6 99.8 99.9 99.9
[09:45:45.928] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.8 99.6 99.6 99.6 99.6 99.6 99.5 99.5 99.6 99.6 99.6 99.8 99.9 99.9
[09:45:45.928] INFO: X-ray hit rate [MHz/cm2]: 39.6 34.7 54.6 84.4 89.2 89.0 89.1 81.3 90.9 93.7 92.0 88.5 87.9 58.0 32.9 36.3
[09:45:45.928] INFO: PixTestHighRate::doXPixelAlive() done
[09:45:45.975] INFO: PixTest:: pg_setup set to default.
[09:46:13.433] QUIET: Connection to board 58 closed.
[09:39:55.575] INFO: *** Welcome to pxar ***
[09:39:55.575] INFO: *** Today: 2016/06/06
[09:39:55.598] INFO: *** Version: v1.9.0-805-geb36
[09:39:55.598] INFO: readRocDacs: /home/CMS_pixel/Testing/pxar_fermi/data/myang/dacParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/dacParameters35_C15.dat
[09:39:55.599] INFO: readTbmDacs: /home/CMS_pixel/Testing/pxar_fermi/data/myang/tbmParameters_C0a.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/tbmParameters_C0b.dat
[09:39:55.599] INFO: readMaskFile: /home/CMS_pixel/Testing/pxar_fermi/data/myang/defaultMaskFile.dat
[09:39:55.600] INFO: readTrimFile: /home/CMS_pixel/Testing/pxar_fermi/data/myang/trimParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/trimParameters35_C15.dat
[09:39:55.747] INFO: clk: 4
[09:39:55.748] INFO: ctr: 4
[09:39:55.748] INFO: sda: 19
[09:39:55.748] INFO: tin: 9
[09:39:55.748] INFO: level: 15
[09:39:55.748] INFO: triggerdelay: 0
[09:39:55.748] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[09:39:55.748] INFO: Log level: INFO
[09:39:55.758] QUIET: Connection to board DTB_WRPRHI opened.
[09:39:55.761] 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:
------------------------------------------------------
[09:39:55.764] INFO: RPC call hashes of host and DTB match: 398089610
[09:39:57.364] INFO: DUT info:
[09:39:57.364] INFO: The DUT currently contains the following objects:
[09:39:57.364] INFO: 2 TBM Cores tbm08c (2 ON)
[09:39:57.364] INFO: TBM Core alpha (0): 7 registers set
[09:39:57.364] INFO: TBM Core beta (1): 7 registers set
[09:39:57.364] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:39:57.364] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:57.364] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:57.364] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:57.364] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:57.364] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:57.364] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:57.364] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:57.364] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:57.364] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:57.364] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:57.364] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:57.364] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:57.364] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:57.364] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:57.364] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:57.364] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:39:57.954] INFO: PixTestCmd::init()
[09:39:57.967] INFO: readGainPedestalParameters /home/CMS_pixel/Testing/pxar_fermi/data/myang/phCalibrationFitErr35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/phCalibrationFitErr35_C15.dat
[09:39:58.266] INFO: readReadbackCal: /home/CMS_pixel/Testing/pxar_fermi/data/myang/readbackCal_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/myang/readbackCal_C15.dat
[09:40:03.656] INFO: ######################################################################
[09:40:03.656] INFO: PixTestAlive::doTest()
[09:40:03.656] INFO: ######################################################################
[09:40:03.659] INFO: ----------------------------------------------------------------------
[09:40:03.659] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:40:03.659] INFO: ----------------------------------------------------------------------
[09:40:04.037] INFO: Expecting 41600 events.
[09:40:08.294] INFO: 41600 events read in total (3538ms).
[09:40:08.441] INFO: Test took 4779ms.
[09:40:08.450] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:40:08.719] INFO: PixTestAlive::aliveTest() done
[09:40:08.719] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 3 0 0 0 0 0 0 0
[09:40:08.742] INFO: ----------------------------------------------------------------------
[09:40:08.742] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:40:08.742] INFO: ----------------------------------------------------------------------
[09:40:09.118] INFO: Expecting 41600 events.
[09:40:12.175] INFO: 41600 events read in total (2341ms).
[09:40:12.175] INFO: Test took 3431ms.
[09:40:12.175] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:40:12.176] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[09:40:12.599] INFO: PixTestAlive::maskTest() done
[09:40:12.599] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:40:12.618] INFO: ----------------------------------------------------------------------
[09:40:12.618] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:40:12.618] INFO: ----------------------------------------------------------------------
[09:40:12.995] INFO: Expecting 41600 events.
[09:40:17.244] INFO: 41600 events read in total (3534ms).
[09:40:17.246] INFO: Test took 4626ms.
[09:40:17.257] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:40:17.628] INFO: PixTestAlive::addressDecodingTest() done
[09:40:17.628] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:40:17.628] INFO: PixTestAlive::doTest() done, duration: 13 seconds
[09:40:29.197] INFO: ----------------------------------------------------------------------
[09:40:29.197] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[09:40:29.197] INFO: ----------------------------------------------------------------------
[09:40:29.336] INFO: Expecting 768 events.
[09:40:30.469] INFO: 768 events read in total (418ms).
[09:40:30.469] INFO: Test took 1266ms.
[09:40:31.273] INFO: Expecting 41600 events.
[09:40:35.210] INFO: 41600 events read in total (3410ms).
[09:40:35.216] INFO: Test took 4741ms.
[09:40:35.401] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:40:36.147] INFO: Expecting 41600 events.
[09:40:40.161] INFO: 41600 events read in total (3488ms).
[09:40:40.167] INFO: Test took 4688ms.
[09:40:40.348] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:40:41.094] INFO: Expecting 41600 events.
[09:40:45.135] INFO: 41600 events read in total (3514ms).
[09:40:45.141] INFO: Test took 4712ms.
[09:40:45.326] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:40:46.070] INFO: Expecting 41600 events.
[09:40:50.102] INFO: 41600 events read in total (3505ms).
[09:40:50.108] INFO: Test took 4702ms.
[09:40:50.290] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:40:51.037] INFO: Expecting 41600 events.
[09:40:55.068] INFO: 41600 events read in total (3504ms).
[09:40:55.074] INFO: Test took 4702ms.
[09:40:55.254] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:40:56.000] INFO: Expecting 41600 events.
[09:41:00.038] INFO: 41600 events read in total (3511ms).
[09:41:00.045] INFO: Test took 4710ms.
[09:41:00.224] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:41:00.970] INFO: Expecting 41600 events.
[09:41:05.013] INFO: 41600 events read in total (3517ms).
[09:41:05.019] INFO: Test took 4714ms.
[09:41:05.202] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:41:05.950] INFO: Expecting 41600 events.
[09:41:10.014] INFO: 41600 events read in total (3537ms).
[09:41:10.020] INFO: Test took 4735ms.
[09:41:10.202] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:41:10.948] INFO: Expecting 41600 events.
[09:41:14.998] INFO: 41600 events read in total (3523ms).
[09:41:15.004] INFO: Test took 4721ms.
[09:41:15.191] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:41:15.938] INFO: Expecting 41600 events.
[09:41:19.997] INFO: 41600 events read in total (3532ms).
[09:41:20.003] INFO: Test took 4730ms.
[09:41:20.186] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:41:20.934] INFO: Expecting 41600 events.
[09:41:24.984] INFO: 41600 events read in total (3524ms).
[09:41:24.990] INFO: Test took 4721ms.
[09:41:25.172] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:41:25.920] INFO: Expecting 41600 events.
[09:41:29.971] INFO: 41600 events read in total (3525ms).
[09:41:29.977] INFO: Test took 4722ms.
[09:41:30.160] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:41:30.905] INFO: Expecting 41600 events.
[09:41:34.972] INFO: 41600 events read in total (3540ms).
[09:41:34.978] INFO: Test took 4738ms.
[09:41:35.159] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:41:35.906] INFO: Expecting 41600 events.
[09:41:39.997] INFO: 41600 events read in total (3565ms).
[09:41:40.003] INFO: Test took 4762ms.
[09:41:40.182] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:41:40.928] INFO: Expecting 41600 events.
[09:41:45.008] INFO: 41600 events read in total (3554ms).
[09:41:45.014] INFO: Test took 4751ms.
[09:41:45.194] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:41:45.940] INFO: Expecting 41600 events.
[09:41:50.006] INFO: 41600 events read in total (3539ms).
[09:41:50.013] INFO: Test took 4739ms.
[09:41:50.194] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:41:50.939] INFO: Expecting 41600 events.
[09:41:55.021] INFO: 41600 events read in total (3556ms).
[09:41:55.027] INFO: Test took 4753ms.
[09:41:55.210] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:41:55.956] INFO: Expecting 41600 events.
[09:42:00.019] INFO: 41600 events read in total (3537ms).
[09:42:00.025] INFO: Test took 4734ms.
[09:42:00.206] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:42:00.952] INFO: Expecting 41600 events.
[09:42:04.932] INFO: 41600 events read in total (3453ms).
[09:42:04.939] INFO: Test took 4652ms.
[09:42:05.121] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:42:05.868] INFO: Expecting 41600 events.
[09:42:09.639] INFO: 41600 events read in total (3245ms).
[09:42:09.645] INFO: Test took 4442ms.
[09:42:09.821] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:42:37.133] INFO: ----------------------------------------------------------------------
[09:42:37.133] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[09:42:37.133] INFO: ----------------------------------------------------------------------
[09:42:37.814] INFO: Expecting 208000 events.
[09:42:55.752] INFO: 208000 events read in total (17411ms).
[09:42:55.777] INFO: Test took 18628ms.
[09:42:56.808] INFO: Fetched DAQ statistics. Counters are being reset now.
[09:42:57.367] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 3 0 0 0 0 0 0 0
[09:42:57.367] INFO: number of red-efficiency pixels: 302 263 610 1077 1408 1240 1207 1035 1403 1412 1348 1291 1241 726 299 259
[09:42:57.367] INFO: number of X-ray hits detected: 175344 153113 241814 371972 394393 394432 394557 358898 403722 414154 405379 391603 389736 256570 145468 159375
[09:42:57.367] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[09:42:57.367] INFO: number of Vcal hits detected: 207680 207717 207227 206690 206125 206395 206458 206746 205951 206068 206245 206316 206416 207056 207675 207728
[09:42:57.367] INFO: Vcal hit fiducial efficiency (%): 99.8 99.9 99.7 99.4 99.2 99.3 99.3 99.4 99.1 99.2 99.2 99.3 99.3 99.6 99.9 99.9
[09:42:57.367] INFO: Vcal hit overall efficiency (%): 99.8 99.9 99.6 99.4 99.1 99.2 99.3 99.4 99.0 99.1 99.2 99.2 99.2 99.5 99.8 99.9
[09:42:57.367] INFO: X-ray hit rate [MHz/cm2]: 51.4 44.9 70.9 109.0 115.6 115.6 115.6 105.2 118.3 121.4 118.8 114.8 114.2 75.2 42.6 46.7
[09:42:57.367] INFO: PixTestHighRate::doXPixelAlive() done
[09:42:57.412] INFO: PixTest:: pg_setup set to default.
[09:43:08.456] INFO: Canvas printed to HighRate-1.pdf
[09:43:15.044] QUIET: Connection to board 58 closed.