[10:43:46.747] INFO: *** Welcome to pxar ***
[10:43:46.747] INFO: *** Today: 2016/06/06
[10:43:46.770] INFO: *** Version: v1.9.0-805-geb36
[10:43:46.770] INFO: readRocDacs: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/dacParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/dacParameters35_C15.dat
[10:43:46.771] INFO: readTbmDacs: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/tbmParameters_C0a.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/tbmParameters_C0b.dat
[10:43:46.771] INFO: readMaskFile: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/defaultMaskFile.dat
[10:43:46.771] INFO: readTrimFile: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/trimParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/trimParameters35_C15.dat
[10:43:46.919] INFO: clk: 4
[10:43:46.919] INFO: ctr: 4
[10:43:46.919] INFO: sda: 19
[10:43:46.919] INFO: tin: 9
[10:43:46.919] INFO: level: 15
[10:43:46.919] INFO: triggerdelay: 0
[10:43:46.919] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[10:43:46.919] INFO: Log level: INFO
[10:43:46.930] QUIET: Connection to board DTB_WRPRHI opened.
[10:43:46.933] 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:
------------------------------------------------------
[10:43:46.936] INFO: RPC call hashes of host and DTB match: 398089610
[10:43:48.535] INFO: DUT info:
[10:43:48.536] INFO: The DUT currently contains the following objects:
[10:43:48.536] INFO: 2 TBM Cores tbm08c (2 ON)
[10:43:48.536] INFO: TBM Core alpha (0): 7 registers set
[10:43:48.536] INFO: TBM Core beta (1): 7 registers set
[10:43:48.536] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:43:48.536] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:48.536] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:48.536] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:48.536] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:48.536] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:48.536] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:48.536] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:48.536] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:48.536] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:48.536] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:48.536] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:48.536] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:48.536] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:48.536] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:48.536] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:48.536] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:43:49.130] INFO: PixTestCmd::init()
[10:43:49.139] INFO: readGainPedestalParameters /home/CMS_pixel/Testing/pxar_fermi/data/mj134/phCalibrationFitErr35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/phCalibrationFitErr35_C15.dat
[10:43:49.440] INFO: readReadbackCal: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/readbackCal_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/readbackCal_C15.dat
[10:44:00.046] INFO: ----------------------------------------------------------------------
[10:44:00.046] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[10:44:00.046] INFO: ----------------------------------------------------------------------
[10:44:01.019] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[10:44:12.907] INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[10:44:44.074] INFO: Resuming triggers.
[10:44:55.957] INFO: run duration 23 seconds, buffer almost full (81%), pausing triggers.
[10:45:27.166] INFO: Resuming triggers.
[10:45:39.045] INFO: run duration 35 seconds, buffer almost full (81%), pausing triggers.
[10:46:10.108] INFO: Resuming triggers.
[10:46:21.991] INFO: run duration 47 seconds, buffer almost full (81%), pausing triggers.
[10:46:53.374] INFO: Resuming triggers.
[10:47:05.258] INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[10:47:36.332] INFO: Resuming triggers.
[10:47:36.993] INFO: data taking finished, elapsed time: 60 seconds.
[10:47:39.100] INFO: PixTest:: pg_setup set to default.
[10:47:39.141] INFO: PixTestXray::doPhRun() done
[10:47:53.273] QUIET: Connection to board 58 closed.
[10:47:59.579] INFO: *** Welcome to pxar ***
[10:47:59.579] INFO: *** Today: 2016/06/06
[10:47:59.603] INFO: *** Version: v1.9.0-805-geb36
[10:47:59.603] INFO: readRocDacs: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/dacParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/dacParameters35_C15.dat
[10:47:59.604] INFO: readTbmDacs: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/tbmParameters_C0a.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/tbmParameters_C0b.dat
[10:47:59.604] INFO: readMaskFile: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/defaultMaskFile.dat
[10:47:59.604] INFO: readTrimFile: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/trimParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/trimParameters35_C15.dat
[10:47:59.754] INFO: clk: 4
[10:47:59.754] INFO: ctr: 4
[10:47:59.754] INFO: sda: 19
[10:47:59.754] INFO: tin: 9
[10:47:59.754] INFO: level: 15
[10:47:59.754] INFO: triggerdelay: 0
[10:47:59.754] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[10:47:59.754] INFO: Log level: INFO
[10:47:59.765] QUIET: Connection to board DTB_WRPRHI opened.
[10:47:59.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:
------------------------------------------------------
[10:47:59.771] INFO: RPC call hashes of host and DTB match: 398089610
[10:48:01.370] INFO: DUT info:
[10:48:01.370] INFO: The DUT currently contains the following objects:
[10:48:01.370] INFO: 2 TBM Cores tbm08c (2 ON)
[10:48:01.370] INFO: TBM Core alpha (0): 7 registers set
[10:48:01.370] INFO: TBM Core beta (1): 7 registers set
[10:48:01.370] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:48:01.370] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:48:01.370] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:48:01.370] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:48:01.370] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:48:01.370] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:48:01.370] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:48:01.370] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:48:01.370] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:48:01.370] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:48:01.370] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:48:01.371] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:48:01.371] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:48:01.371] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:48:01.371] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:48:01.371] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:48:01.371] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:48:01.970] INFO: PixTestCmd::init()
[10:48:01.975] INFO: readGainPedestalParameters /home/CMS_pixel/Testing/pxar_fermi/data/mj134/phCalibrationFitErr35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/phCalibrationFitErr35_C15.dat
[10:48:02.276] INFO: readReadbackCal: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/readbackCal_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/readbackCal_C15.dat
[10:48:16.222] INFO: ----------------------------------------------------------------------
[10:48:16.222] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[10:48:16.222] INFO: ----------------------------------------------------------------------
[10:48:17.194] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[10:48:24.666] INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[10:48:59.852] INFO: Resuming triggers.
[10:49:07.327] INFO: run duration 14 seconds, buffer almost full (81%), pausing triggers.
[10:49:42.403] INFO: Resuming triggers.
[10:49:49.876] INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[10:50:25.061] INFO: Resuming triggers.
[10:50:32.535] INFO: run duration 29 seconds, buffer almost full (81%), pausing triggers.
[10:51:07.567] INFO: Resuming triggers.
[10:51:15.046] INFO: run duration 37 seconds, buffer almost full (81%), pausing triggers.
[10:51:49.948] INFO: Resuming triggers.
[10:51:57.424] INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[10:52:32.564] INFO: Resuming triggers.
[10:52:40.043] INFO: run duration 52 seconds, buffer almost full (81%), pausing triggers.
[10:53:15.128] INFO: Resuming triggers.
[10:53:22.611] INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[10:53:57.814] INFO: Resuming triggers.
[10:53:58.090] INFO: data taking finished, elapsed time: 60 seconds.
[10:53:59.786] INFO: PixTest:: pg_setup set to default.
[10:53:59.827] INFO: PixTestXray::doPhRun() done
[10:54:26.271] QUIET: Connection to board 58 closed.
[10:38:29.107] INFO: *** Welcome to pxar ***
[10:38:29.107] INFO: *** Today: 2016/06/06
[10:38:29.130] INFO: *** Version: v1.9.0-805-geb36
[10:38:29.130] INFO: readRocDacs: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/dacParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/dacParameters35_C15.dat
[10:38:29.131] INFO: readTbmDacs: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/tbmParameters_C0a.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/tbmParameters_C0b.dat
[10:38:29.131] INFO: readMaskFile: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/defaultMaskFile.dat
[10:38:29.131] INFO: readTrimFile: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/trimParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/trimParameters35_C15.dat
[10:38:29.280] INFO: clk: 4
[10:38:29.280] INFO: ctr: 4
[10:38:29.280] INFO: sda: 19
[10:38:29.280] INFO: tin: 9
[10:38:29.280] INFO: level: 15
[10:38:29.280] INFO: triggerdelay: 0
[10:38:29.280] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[10:38:29.280] INFO: Log level: INFO
[10:38:29.293] QUIET: Connection to board DTB_WRPRHI opened.
[10:38:29.296] 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:
------------------------------------------------------
[10:38:29.299] INFO: RPC call hashes of host and DTB match: 398089610
[10:38:30.898] INFO: DUT info:
[10:38:30.898] INFO: The DUT currently contains the following objects:
[10:38:30.898] INFO: 2 TBM Cores tbm08c (2 ON)
[10:38:30.898] INFO: TBM Core alpha (0): 7 registers set
[10:38:30.898] INFO: TBM Core beta (1): 7 registers set
[10:38:30.898] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:38:30.898] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:30.898] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:30.898] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:30.898] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:30.898] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:30.898] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:30.898] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:30.898] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:30.898] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:30.898] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:30.898] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:30.898] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:30.898] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:30.898] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:30.898] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:30.898] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:31.505] INFO: PixTestCmd::init()
[10:38:31.509] INFO: readGainPedestalParameters /home/CMS_pixel/Testing/pxar_fermi/data/mj134/phCalibrationFitErr35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/phCalibrationFitErr35_C15.dat
[10:38:31.808] INFO: readReadbackCal: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/readbackCal_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/readbackCal_C15.dat
[10:38:36.977] INFO: ######################################################################
[10:38:36.977] INFO: PixTestAlive::doTest()
[10:38:36.977] INFO: ######################################################################
[10:38:36.980] INFO: ----------------------------------------------------------------------
[10:38:36.981] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:38:36.981] INFO: ----------------------------------------------------------------------
[10:38:37.358] INFO: Expecting 41600 events.
[10:38:41.618] INFO: 41600 events read in total (3541ms).
[10:38:41.767] INFO: Test took 4784ms.
[10:38:41.778] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:38:42.048] INFO: PixTestAlive::aliveTest() done
[10:38:42.048] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 1 0 0 0 0 0 0 0 0
[10:38:42.073] INFO: ----------------------------------------------------------------------
[10:38:42.073] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:38:42.073] INFO: ----------------------------------------------------------------------
[10:38:42.449] INFO: Expecting 41600 events.
[10:38:45.502] INFO: 41600 events read in total (2338ms).
[10:38:45.502] INFO: Test took 3427ms.
[10:38:45.502] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:38:45.502] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[10:38:45.925] INFO: PixTestAlive::maskTest() done
[10:38:45.925] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:38:45.943] INFO: ----------------------------------------------------------------------
[10:38:45.943] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:38:45.943] INFO: ----------------------------------------------------------------------
[10:38:46.320] INFO: Expecting 41600 events.
[10:38:50.584] INFO: 41600 events read in total (3549ms).
[10:38:50.585] INFO: Test took 4639ms.
[10:38:50.597] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:38:50.968] INFO: PixTestAlive::addressDecodingTest() done
[10:38:50.968] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:38:50.968] INFO: PixTestAlive::doTest() done, duration: 13 seconds
[10:38:53.622] INFO: ----------------------------------------------------------------------
[10:38:53.622] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[10:38:53.622] INFO: ----------------------------------------------------------------------
[10:38:53.761] INFO: Expecting 768 events.
[10:38:54.893] INFO: 768 events read in total (417ms).
[10:38:54.893] INFO: Test took 1265ms.
[10:38:55.697] INFO: Expecting 41600 events.
[10:38:58.913] INFO: 41600 events read in total (2689ms).
[10:38:58.917] INFO: Test took 4018ms.
[10:38:59.012] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:38:59.719] INFO: Expecting 41600 events.
[10:39:03.069] INFO: 41600 events read in total (2823ms).
[10:39:03.075] INFO: Test took 4020ms.
[10:39:03.169] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:03.877] INFO: Expecting 41600 events.
[10:39:07.272] INFO: 41600 events read in total (2868ms).
[10:39:07.278] INFO: Test took 4066ms.
[10:39:07.372] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:08.082] INFO: Expecting 41600 events.
[10:39:11.495] INFO: 41600 events read in total (2887ms).
[10:39:11.501] INFO: Test took 4085ms.
[10:39:11.596] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:12.305] INFO: Expecting 41600 events.
[10:39:15.735] INFO: 41600 events read in total (2904ms).
[10:39:15.739] INFO: Test took 4099ms.
[10:39:15.832] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:16.541] INFO: Expecting 41600 events.
[10:39:19.980] INFO: 41600 events read in total (2912ms).
[10:39:19.984] INFO: Test took 4108ms.
[10:39:20.076] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:20.785] INFO: Expecting 41600 events.
[10:39:24.235] INFO: 41600 events read in total (2923ms).
[10:39:24.239] INFO: Test took 4119ms.
[10:39:24.332] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:25.041] INFO: Expecting 41600 events.
[10:39:28.487] INFO: 41600 events read in total (2920ms).
[10:39:28.491] INFO: Test took 4115ms.
[10:39:28.583] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:29.292] INFO: Expecting 41600 events.
[10:39:32.741] INFO: 41600 events read in total (2922ms).
[10:39:32.745] INFO: Test took 4118ms.
[10:39:32.837] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:33.546] INFO: Expecting 41600 events.
[10:39:36.995] INFO: 41600 events read in total (2923ms).
[10:39:36.999] INFO: Test took 4118ms.
[10:39:37.092] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:37.801] INFO: Expecting 41600 events.
[10:39:41.249] INFO: 41600 events read in total (2921ms).
[10:39:41.253] INFO: Test took 4117ms.
[10:39:41.345] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:42.054] INFO: Expecting 41600 events.
[10:39:45.493] INFO: 41600 events read in total (2913ms).
[10:39:45.497] INFO: Test took 4108ms.
[10:39:45.590] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:46.299] INFO: Expecting 41600 events.
[10:39:49.748] INFO: 41600 events read in total (2923ms).
[10:39:49.752] INFO: Test took 4118ms.
[10:39:49.844] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:50.553] INFO: Expecting 41600 events.
[10:39:53.993] INFO: 41600 events read in total (2913ms).
[10:39:53.997] INFO: Test took 4109ms.
[10:39:54.090] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:54.799] INFO: Expecting 41600 events.
[10:39:58.246] INFO: 41600 events read in total (2920ms).
[10:39:58.250] INFO: Test took 4116ms.
[10:39:58.342] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:59.051] INFO: Expecting 41600 events.
[10:40:02.494] INFO: 41600 events read in total (2916ms).
[10:40:02.498] INFO: Test took 4112ms.
[10:40:02.591] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:40:03.301] INFO: Expecting 41600 events.
[10:40:06.739] INFO: 41600 events read in total (2912ms).
[10:40:06.743] INFO: Test took 4107ms.
[10:40:06.836] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:40:07.546] INFO: Expecting 41600 events.
[10:40:10.990] INFO: 41600 events read in total (2918ms).
[10:40:10.994] INFO: Test took 4113ms.
[10:40:11.086] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:40:11.796] INFO: Expecting 41600 events.
[10:40:15.224] INFO: 41600 events read in total (2902ms).
[10:40:15.228] INFO: Test took 4097ms.
[10:40:15.320] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:40:16.030] INFO: Expecting 41600 events.
[10:40:19.366] INFO: 41600 events read in total (2809ms).
[10:40:19.370] INFO: Test took 4005ms.
[10:40:19.460] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:40:35.158] INFO: ----------------------------------------------------------------------
[10:40:35.158] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[10:40:35.158] INFO: ----------------------------------------------------------------------
[10:40:35.839] INFO: Expecting 208000 events.
[10:40:48.950] INFO: 208000 events read in total (12584ms).
[10:40:48.964] INFO: Test took 13790ms.
[10:40:49.537] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:40:49.926] INFO: number of dead pixels (per ROC): 0 0 1 0 0 0 0 1 0 0 0 0 0 0 0 0
[10:40:49.926] INFO: number of red-efficiency pixels: 104 82 206 253 343 297 268 276 288 316 286 268 275 161 68 106
[10:40:49.927] INFO: number of X-ray hits detected: 80940 67249 112956 172289 182608 181643 185094 174635 193406 194603 186087 173248 175225 117529 68863 82978
[10:40:49.927] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[10:40:49.927] INFO: number of Vcal hits detected: 207894 207918 207736 207740 207626 207689 207718 207636 207704 207668 207702 207719 207717 207834 207930 207890
[10:40:49.927] INFO: Vcal hit fiducial efficiency (%): 99.9 100.0 99.9 99.9 99.8 99.9 99.9 99.9 99.9 99.8 99.9 99.9 99.9 99.9 100.0 99.9
[10:40:49.927] INFO: Vcal hit overall efficiency (%): 99.9 100.0 99.9 99.9 99.8 99.9 99.9 99.8 99.9 99.8 99.9 99.9 99.9 99.9 100.0 99.9
[10:40:49.927] INFO: X-ray hit rate [MHz/cm2]: 23.7 19.7 33.1 50.5 53.5 53.2 54.3 51.2 56.7 57.0 54.5 50.8 51.4 34.4 20.2 24.3
[10:40:49.927] INFO: PixTestHighRate::doXPixelAlive() done
[10:40:49.971] INFO: PixTest:: pg_setup set to default.
[10:40:57.217] QUIET: Connection to board 58 closed.
[10:35:18.498] INFO: *** Welcome to pxar ***
[10:35:18.498] INFO: *** Today: 2016/06/06
[10:35:18.521] INFO: *** Version: v1.9.0-805-geb36
[10:35:18.521] INFO: readRocDacs: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/dacParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/dacParameters35_C15.dat
[10:35:18.522] INFO: readTbmDacs: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/tbmParameters_C0a.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/tbmParameters_C0b.dat
[10:35:18.522] INFO: readMaskFile: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/defaultMaskFile.dat
[10:35:18.522] INFO: readTrimFile: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/trimParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/trimParameters35_C15.dat
[10:35:18.673] INFO: clk: 4
[10:35:18.673] INFO: ctr: 4
[10:35:18.673] INFO: sda: 19
[10:35:18.673] INFO: tin: 9
[10:35:18.673] INFO: level: 15
[10:35:18.673] INFO: triggerdelay: 0
[10:35:18.673] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[10:35:18.673] INFO: Log level: INFO
[10:35:18.684] QUIET: Connection to board DTB_WRPRHI opened.
[10:35:18.687] 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:
------------------------------------------------------
[10:35:18.690] INFO: RPC call hashes of host and DTB match: 398089610
[10:35:20.289] INFO: DUT info:
[10:35:20.290] INFO: The DUT currently contains the following objects:
[10:35:20.290] INFO: 2 TBM Cores tbm08c (2 ON)
[10:35:20.290] INFO: TBM Core alpha (0): 7 registers set
[10:35:20.290] INFO: TBM Core beta (1): 7 registers set
[10:35:20.290] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:35:20.290] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:20.290] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:20.290] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:20.290] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:20.290] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:20.290] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:20.290] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:20.290] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:20.290] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:20.290] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:20.290] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:20.290] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:20.290] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:20.290] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:20.290] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:20.290] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:35:20.887] INFO: PixTestCmd::init()
[10:35:20.896] INFO: readGainPedestalParameters /home/CMS_pixel/Testing/pxar_fermi/data/mj134/phCalibrationFitErr35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/phCalibrationFitErr35_C15.dat
[10:35:21.195] INFO: readReadbackCal: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/readbackCal_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/readbackCal_C15.dat
[10:35:28.705] INFO: ######################################################################
[10:35:28.705] INFO: PixTestAlive::doTest()
[10:35:28.705] INFO: ######################################################################
[10:35:28.708] INFO: ----------------------------------------------------------------------
[10:35:28.708] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:35:28.708] INFO: ----------------------------------------------------------------------
[10:35:29.086] INFO: Expecting 41600 events.
[10:35:33.355] INFO: 41600 events read in total (3551ms).
[10:35:33.503] INFO: Test took 4792ms.
[10:35:33.513] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:35:33.786] INFO: PixTestAlive::aliveTest() done
[10:35:33.786] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 1 0 0 0 0 0 0 0 0
[10:35:33.809] INFO: ----------------------------------------------------------------------
[10:35:33.809] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:35:33.809] INFO: ----------------------------------------------------------------------
[10:35:34.185] INFO: Expecting 41600 events.
[10:35:37.241] INFO: 41600 events read in total (2341ms).
[10:35:37.242] INFO: Test took 3431ms.
[10:35:37.242] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:35:37.242] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[10:35:37.665] INFO: PixTestAlive::maskTest() done
[10:35:37.665] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:35:37.683] INFO: ----------------------------------------------------------------------
[10:35:37.683] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:35:37.683] INFO: ----------------------------------------------------------------------
[10:35:38.059] INFO: Expecting 41600 events.
[10:35:42.315] INFO: 41600 events read in total (3541ms).
[10:35:42.316] INFO: Test took 4631ms.
[10:35:42.327] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:35:42.699] INFO: PixTestAlive::addressDecodingTest() done
[10:35:42.699] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:35:42.699] INFO: PixTestAlive::doTest() done, duration: 13 seconds
[10:35:46.894] INFO: ----------------------------------------------------------------------
[10:35:46.894] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[10:35:46.894] INFO: ----------------------------------------------------------------------
[10:35:47.033] INFO: Expecting 768 events.
[10:35:48.167] INFO: 768 events read in total (419ms).
[10:35:48.167] INFO: Test took 1268ms.
[10:35:48.971] INFO: Expecting 41600 events.
[10:35:52.475] INFO: 41600 events read in total (2978ms).
[10:35:52.479] INFO: Test took 4306ms.
[10:35:52.608] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:35:53.329] INFO: Expecting 41600 events.
[10:35:56.927] INFO: 41600 events read in total (3071ms).
[10:35:56.932] INFO: Test took 4268ms.
[10:35:57.056] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:35:57.778] INFO: Expecting 41600 events.
[10:36:01.422] INFO: 41600 events read in total (3117ms).
[10:36:01.426] INFO: Test took 4312ms.
[10:36:01.552] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:02.274] INFO: Expecting 41600 events.
[10:36:05.929] INFO: 41600 events read in total (3128ms).
[10:36:05.934] INFO: Test took 4325ms.
[10:36:06.060] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:06.783] INFO: Expecting 41600 events.
[10:36:10.442] INFO: 41600 events read in total (3132ms).
[10:36:10.447] INFO: Test took 4329ms.
[10:36:10.573] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:11.295] INFO: Expecting 41600 events.
[10:36:14.960] INFO: 41600 events read in total (3138ms).
[10:36:14.965] INFO: Test took 4335ms.
[10:36:15.091] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:15.814] INFO: Expecting 41600 events.
[10:36:19.484] INFO: 41600 events read in total (3143ms).
[10:36:19.489] INFO: Test took 4340ms.
[10:36:19.613] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:20.336] INFO: Expecting 41600 events.
[10:36:24.019] INFO: 41600 events read in total (3156ms).
[10:36:24.024] INFO: Test took 4352ms.
[10:36:24.152] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:24.874] INFO: Expecting 41600 events.
[10:36:28.577] INFO: 41600 events read in total (3176ms).
[10:36:28.582] INFO: Test took 4373ms.
[10:36:28.708] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:29.431] INFO: Expecting 41600 events.
[10:36:33.112] INFO: 41600 events read in total (3154ms).
[10:36:33.117] INFO: Test took 4351ms.
[10:36:33.243] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:33.966] INFO: Expecting 41600 events.
[10:36:37.650] INFO: 41600 events read in total (3158ms).
[10:36:37.655] INFO: Test took 4354ms.
[10:36:37.779] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:38.501] INFO: Expecting 41600 events.
[10:36:42.183] INFO: 41600 events read in total (3155ms).
[10:36:42.188] INFO: Test took 4351ms.
[10:36:42.312] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:43.035] INFO: Expecting 41600 events.
[10:36:46.716] INFO: 41600 events read in total (3155ms).
[10:36:46.721] INFO: Test took 4351ms.
[10:36:46.846] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:47.569] INFO: Expecting 41600 events.
[10:36:51.246] INFO: 41600 events read in total (3150ms).
[10:36:51.251] INFO: Test took 4347ms.
[10:36:51.374] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:52.098] INFO: Expecting 41600 events.
[10:36:55.770] INFO: 41600 events read in total (3145ms).
[10:36:55.775] INFO: Test took 4342ms.
[10:36:55.902] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:56.625] INFO: Expecting 41600 events.
[10:37:00.306] INFO: 41600 events read in total (3154ms).
[10:37:00.311] INFO: Test took 4350ms.
[10:37:00.436] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:37:01.159] INFO: Expecting 41600 events.
[10:37:04.841] INFO: 41600 events read in total (3155ms).
[10:37:04.846] INFO: Test took 4352ms.
[10:37:04.970] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:37:05.694] INFO: Expecting 41600 events.
[10:37:09.384] INFO: 41600 events read in total (3163ms).
[10:37:09.389] INFO: Test took 4360ms.
[10:37:09.515] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:37:10.239] INFO: Expecting 41600 events.
[10:37:13.906] INFO: 41600 events read in total (3140ms).
[10:37:13.910] INFO: Test took 4336ms.
[10:37:14.035] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:37:14.759] INFO: Expecting 41600 events.
[10:37:18.307] INFO: 41600 events read in total (3022ms).
[10:37:18.312] INFO: Test took 4218ms.
[10:37:18.434] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:37:41.510] INFO: ----------------------------------------------------------------------
[10:37:41.510] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[10:37:41.510] INFO: ----------------------------------------------------------------------
[10:37:42.191] INFO: Expecting 208000 events.
[10:37:57.071] INFO: 208000 events read in total (14353ms).
[10:37:57.090] INFO: Test took 15564ms.
[10:37:57.778] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:37:58.243] INFO: number of dead pixels (per ROC): 0 0 1 0 0 0 0 1 0 0 0 0 0 0 0 0
[10:37:58.243] INFO: number of red-efficiency pixels: 154 140 295 467 509 498 519 627 577 584 607 513 559 301 121 219
[10:37:58.243] INFO: number of X-ray hits detected: 116785 97594 163979 249549 264624 262898 269086 253186 279201 282496 269452 251175 253756 169181 99679 120019
[10:37:58.243] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[10:37:58.243] INFO: number of Vcal hits detected: 207843 207858 207631 207501 207451 207448 207429 207263 207364 207347 207307 207414 207390 207675 207872 207767
[10:37:58.243] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.7 99.7 99.7 99.7 99.8 99.7 99.9 99.9 99.9
[10:37:58.243] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.8 99.8 99.7 99.7 99.7 99.6 99.7 99.7 99.7 99.7 99.7 99.8 99.9 99.9
[10:37:58.243] INFO: X-ray hit rate [MHz/cm2]: 34.2 28.6 48.1 73.1 77.6 77.1 78.9 74.2 81.8 82.8 79.0 73.6 74.4 49.6 29.2 35.2
[10:37:58.243] INFO: PixTestHighRate::doXPixelAlive() done
[10:37:58.287] INFO: PixTest:: pg_setup set to default.
[10:38:22.001] QUIET: Connection to board 58 closed.
[10:32:39.929] INFO: *** Welcome to pxar ***
[10:32:39.929] INFO: *** Today: 2016/06/06
[10:32:39.951] INFO: *** Version: v1.9.0-805-geb36
[10:32:39.951] INFO: readRocDacs: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/dacParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/dacParameters35_C15.dat
[10:32:39.952] INFO: readTbmDacs: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/tbmParameters_C0a.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/tbmParameters_C0b.dat
[10:32:39.952] INFO: readMaskFile: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/defaultMaskFile.dat
[10:32:39.952] INFO: readTrimFile: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/trimParameters35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/trimParameters35_C15.dat
[10:32:40.103] INFO: clk: 4
[10:32:40.103] INFO: ctr: 4
[10:32:40.103] INFO: sda: 19
[10:32:40.103] INFO: tin: 9
[10:32:40.103] INFO: level: 15
[10:32:40.103] INFO: triggerdelay: 0
[10:32:40.103] QUIET: Instanciating API for pxar v1.9.0+803~gf2ecfa7
[10:32:40.103] INFO: Log level: INFO
[10:32:40.115] QUIET: Connection to board DTB_WRPRHI opened.
[10:32:40.118] 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:
------------------------------------------------------
[10:32:40.121] INFO: RPC call hashes of host and DTB match: 398089610
[10:32:41.721] INFO: DUT info:
[10:32:41.721] INFO: The DUT currently contains the following objects:
[10:32:41.721] INFO: 2 TBM Cores tbm08c (2 ON)
[10:32:41.721] INFO: TBM Core alpha (0): 7 registers set
[10:32:41.721] INFO: TBM Core beta (1): 7 registers set
[10:32:41.721] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:32:41.721] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:32:41.721] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:32:41.721] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:32:41.721] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:32:41.721] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:32:41.721] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:32:41.721] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:32:41.721] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:32:41.721] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:32:41.721] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:32:41.721] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:32:41.721] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:32:41.721] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:32:41.721] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:32:41.721] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:32:41.721] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:32:42.321] INFO: PixTestCmd::init()
[10:32:42.325] INFO: readGainPedestalParameters /home/CMS_pixel/Testing/pxar_fermi/data/mj134/phCalibrationFitErr35_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/phCalibrationFitErr35_C15.dat
[10:32:42.632] INFO: readReadbackCal: /home/CMS_pixel/Testing/pxar_fermi/data/mj134/readbackCal_C0.dat .. /home/CMS_pixel/Testing/pxar_fermi/data/mj134/readbackCal_C15.dat
[10:32:46.857] INFO: ######################################################################
[10:32:46.857] INFO: PixTestAlive::doTest()
[10:32:46.857] INFO: ######################################################################
[10:32:46.860] INFO: ----------------------------------------------------------------------
[10:32:46.860] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:32:46.860] INFO: ----------------------------------------------------------------------
[10:32:47.238] INFO: Expecting 41600 events.
[10:32:51.485] INFO: 41600 events read in total (3529ms).
[10:32:51.634] INFO: Test took 4771ms.
[10:32:51.645] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:32:51.915] INFO: PixTestAlive::aliveTest() done
[10:32:51.915] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 1 0 0 0 0 0 0 0 0
[10:32:51.937] INFO: ----------------------------------------------------------------------
[10:32:51.937] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:32:51.937] INFO: ----------------------------------------------------------------------
[10:32:52.313] INFO: Expecting 41600 events.
[10:32:55.362] INFO: 41600 events read in total (2333ms).
[10:32:55.362] INFO: Test took 3422ms.
[10:32:55.362] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:32:55.363] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[10:32:55.785] INFO: PixTestAlive::maskTest() done
[10:32:55.785] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:32:55.804] INFO: ----------------------------------------------------------------------
[10:32:55.804] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:32:55.804] INFO: ----------------------------------------------------------------------
[10:32:56.180] INFO: Expecting 41600 events.
[10:33:00.421] INFO: 41600 events read in total (3525ms).
[10:33:00.422] INFO: Test took 4615ms.
[10:33:00.434] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:33:00.804] INFO: PixTestAlive::addressDecodingTest() done
[10:33:00.804] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:33:00.804] INFO: PixTestAlive::doTest() done, duration: 13 seconds
[10:33:04.518] INFO: ----------------------------------------------------------------------
[10:33:04.518] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[10:33:04.518] INFO: ----------------------------------------------------------------------
[10:33:04.657] INFO: Expecting 768 events.
[10:33:05.790] INFO: 768 events read in total (418ms).
[10:33:05.791] INFO: Test took 1268ms.
[10:33:06.594] INFO: Expecting 41600 events.
[10:33:10.301] INFO: 41600 events read in total (3180ms).
[10:33:10.307] INFO: Test took 4511ms.
[10:33:10.469] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:33:11.204] INFO: Expecting 41600 events.
[10:33:15.018] INFO: 41600 events read in total (3288ms).
[10:33:15.024] INFO: Test took 4485ms.
[10:33:15.178] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:33:15.914] INFO: Expecting 41600 events.
[10:33:19.781] INFO: 41600 events read in total (3340ms).
[10:33:19.786] INFO: Test took 4536ms.
[10:33:19.946] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:33:20.682] INFO: Expecting 41600 events.
[10:33:24.540] INFO: 41600 events read in total (3332ms).
[10:33:24.546] INFO: Test took 4529ms.
[10:33:24.706] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:33:25.441] INFO: Expecting 41600 events.
[10:33:29.301] INFO: 41600 events read in total (3333ms).
[10:33:29.306] INFO: Test took 4530ms.
[10:33:29.464] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:33:30.199] INFO: Expecting 41600 events.
[10:33:34.079] INFO: 41600 events read in total (3354ms).
[10:33:34.084] INFO: Test took 4550ms.
[10:33:34.242] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:33:34.977] INFO: Expecting 41600 events.
[10:33:38.897] INFO: 41600 events read in total (3393ms).
[10:33:38.902] INFO: Test took 4590ms.
[10:33:39.062] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:33:39.796] INFO: Expecting 41600 events.
[10:33:43.705] INFO: 41600 events read in total (3382ms).
[10:33:43.711] INFO: Test took 4580ms.
[10:33:43.869] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:33:44.604] INFO: Expecting 41600 events.
[10:33:48.540] INFO: 41600 events read in total (3409ms).
[10:33:48.546] INFO: Test took 4607ms.
[10:33:48.705] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:33:49.440] INFO: Expecting 41600 events.
[10:33:53.335] INFO: 41600 events read in total (3368ms).
[10:33:53.341] INFO: Test took 4566ms.
[10:33:53.498] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:33:54.232] INFO: Expecting 41600 events.
[10:33:58.179] INFO: 41600 events read in total (3392ms).
[10:33:58.185] INFO: Test took 4618ms.
[10:33:58.346] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:33:59.081] INFO: Expecting 41600 events.
[10:34:02.983] INFO: 41600 events read in total (3375ms).
[10:34:02.989] INFO: Test took 4573ms.
[10:34:03.148] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:34:03.883] INFO: Expecting 41600 events.
[10:34:07.794] INFO: 41600 events read in total (3384ms).
[10:34:07.800] INFO: Test took 4582ms.
[10:34:07.958] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:34:08.692] INFO: Expecting 41600 events.
[10:34:12.598] INFO: 41600 events read in total (3379ms).
[10:34:12.603] INFO: Test took 4576ms.
[10:34:12.762] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:34:13.496] INFO: Expecting 41600 events.
[10:34:17.405] INFO: 41600 events read in total (3382ms).
[10:34:17.411] INFO: Test took 4580ms.
[10:34:17.568] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:34:18.302] INFO: Expecting 41600 events.
[10:34:22.213] INFO: 41600 events read in total (3384ms).
[10:34:22.218] INFO: Test took 4580ms.
[10:34:22.376] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:34:23.111] INFO: Expecting 41600 events.
[10:34:27.028] INFO: 41600 events read in total (3390ms).
[10:34:27.033] INFO: Test took 4587ms.
[10:34:27.190] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:34:27.925] INFO: Expecting 41600 events.
[10:34:31.833] INFO: 41600 events read in total (3382ms).
[10:34:31.839] INFO: Test took 4579ms.
[10:34:31.998] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:34:32.732] INFO: Expecting 41600 events.
[10:34:36.629] INFO: 41600 events read in total (3370ms).
[10:34:36.634] INFO: Test took 4566ms.
[10:34:36.793] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:34:37.528] INFO: Expecting 41600 events.
[10:34:41.296] INFO: 41600 events read in total (3241ms).
[10:34:41.302] INFO: Test took 4439ms.
[10:34:41.456] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:34:45.718] INFO: ----------------------------------------------------------------------
[10:34:45.718] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[10:34:45.718] INFO: ----------------------------------------------------------------------
[10:34:46.399] INFO: Expecting 208000 events.
[10:35:03.030] INFO: 208000 events read in total (16105ms).
[10:35:03.053] INFO: Test took 17319ms.
[10:35:03.893] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:35:04.417] INFO: number of dead pixels (per ROC): 0 0 1 0 0 0 0 1 0 0 0 0 0 0 0 0
[10:35:04.417] INFO: number of red-efficiency pixels: 223 176 474 803 842 863 812 878 928 998 925 857 848 515 195 227
[10:35:04.417] INFO: number of X-ray hits detected: 151194 126263 212826 323137 342692 338888 347899 327416 362520 363663 348917 325314 328638 219462 129304 154239
[10:35:04.417] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[10:35:04.418] INFO: number of Vcal hits detected: 207764 207820 207403 207070 207007 206985 207026 206945 206935 206806 206808 206984 207022 207405 207789 207762
[10:35:04.418] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.8 99.6 99.6 99.6 99.6 99.5 99.5 99.5 99.5 99.6 99.6 99.7 99.9 99.9
[10:35:04.418] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.7 99.6 99.5 99.5 99.5 99.5 99.5 99.4 99.4 99.5 99.5 99.7 99.9 99.9
[10:35:04.418] INFO: X-ray hit rate [MHz/cm2]: 44.3 37.0 62.4 94.7 100.4 99.3 102.0 96.0 106.3 106.6 102.3 95.4 96.3 64.3 37.9 45.2
[10:35:04.418] INFO: PixTestHighRate::doXPixelAlive() done
[10:35:04.464] INFO: PixTest:: pg_setup set to default.
[10:35:11.619] QUIET: Connection to board 58 closed.