[18:10:51.087] INFO: *** Welcome to pxar ***
[18:10:51.087] INFO: *** Today: 2016/03/23
[18:10:51.091] INFO: *** Version: prod-12-dirty
[18:10:51.091] INFO: readRocDacs: /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//dacParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//dacParameters35_C15.dat
[18:10:51.114] INFO: readTbmDacs: /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//tbmParameters_C0a.dat .. /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//tbmParameters_C0b.dat
[18:10:51.115] INFO: readMaskFile: /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//defaultMaskFile.dat
[18:10:51.115] INFO: readTrimFile: /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C15.dat
[18:10:51.204] INFO: clk: 4
[18:10:51.204] INFO: ctr: 4
[18:10:51.204] INFO: sda: 19
[18:10:51.204] INFO: tin: 9
[18:10:51.204] INFO: level: 15
[18:10:51.204] INFO: triggerdelay: 0
[18:10:51.204] QUIET: Instanciating API for pxar prod-12
[18:10:51.204] INFO: Log level: INFO
[18:10:51.222] QUIET: Connection to board DTB_WREK4U opened.
[18:10:51.226] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 32
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WREK4U
MAC address: 40D855118020
Hostname: pixelDTB032
Comment:
------------------------------------------------------
[18:10:51.229] INFO: RPC call hashes of host and DTB match: 398089610
[18:10:52.755] INFO: DUT info:
[18:10:52.755] INFO: The DUT currently contains the following objects:
[18:10:52.755] INFO: 2 TBM Cores tbm08c (2 ON)
[18:10:52.755] INFO: TBM Core alpha (0): 7 registers set
[18:10:52.755] INFO: TBM Core beta (1): 7 registers set
[18:10:52.755] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[18:10:52.755] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[18:10:52.755] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[18:10:52.755] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[18:10:52.755] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[18:10:52.755] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[18:10:52.755] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[18:10:52.755] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[18:10:52.755] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[18:10:52.755] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[18:10:52.756] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[18:10:52.756] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[18:10:52.756] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[18:10:52.756] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[18:10:52.756] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[18:10:52.756] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[18:10:52.756] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[18:10:53.163] INFO: enter 'restricted' command line mode
[18:10:53.163] INFO: enter test to run
[18:10:59.802] INFO: test: PixelAlive no parameter change
[18:10:59.802] INFO: running: pixelalive
[18:10:59.811] INFO: ----------------------------------------------------------------------
[18:10:59.811] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[18:10:59.811] INFO: ----------------------------------------------------------------------
[18:11:00.128] INFO: Expecting 41600 events.
[18:11:04.456] INFO: 41600 events read in total (3609ms).
[18:11:04.624] INFO: Test took 4810ms.
[18:11:04.635] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:11:04.898] INFO: PixTestAlive::aliveTest() done
[18:11:04.898] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 3 0 0 0
[18:11:04.929] INFO: enter test to run
[18:11:29.474] INFO: test: HighRate setting parameters: ->runsecondshotpixels=5;trimhotpixelthr=100;maskuntrimmable=0<-
[18:11:29.474] INFO: running: highrate
[18:11:29.474] INFO: readGainPedestalParameters /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//phCalibrationFitErr35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//phCalibrationFitErr35_C15.dat
[18:11:29.660] INFO: ----------------------------------------------------------------------
[18:11:29.660] INFO: PixTest::trimHotPixels() running for 5 seconds with 100 kHz trigger rate
[18:11:29.660] INFO: ----------------------------------------------------------------------
[18:11:29.660] INFO: THR = 100, corresponding to ~ 53.3333 MHz/cm2
[18:11:29.660] INFO: edge/corner pixel THR is adjusted
[18:11:29.660] INFO: PixTestHighRate::trimHotPixels: step 0...
[18:11:30.619] INFO: Collecting data for 5 seconds...
[18:11:35.636] INFO: Done with hot pixel readout
[18:11:47.331] INFO: PixTest:: pg_setup set to default.






















































































































































[18:11:47.366] INFO: 4494 hot pixels found in step 0
[18:11:48.357] INFO: Collecting data for 5 seconds...
[18:11:53.373] INFO: Done with hot pixel readout
[18:12:05.076] INFO: PixTest:: pg_setup set to default.











































































































































































































































































[18:12:05.104] INFO: 4369 hot pixels found in step 1
[18:12:06.103] INFO: Collecting data for 5 seconds...
[18:12:11.120] INFO: Done with hot pixel readout
[18:12:22.858] INFO: PixTest:: pg_setup set to default.

















































































































































































































































































































































































































































[18:12:22.923] INFO: 4150 hot pixels found in step 2
[18:12:23.921] INFO: Collecting data for 5 seconds...
[18:12:28.939] INFO: Done with hot pixel readout
[18:12:40.640] INFO: PixTest:: pg_setup set to default.





















































































































































































































































































































































































































































































































































































































































































































[18:12:40.742] INFO: 4051 hot pixels found in step 3
[18:12:41.740] INFO: Collecting data for 5 seconds...
[18:12:46.757] INFO: Done with hot pixel readout
[18:12:58.437] INFO: PixTest:: pg_setup set to default.








































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































[18:12:58.597] INFO: 3802 hot pixels found in step 4
[18:12:59.590] INFO: Collecting data for 5 seconds...
[18:13:04.608] INFO: Done with hot pixel readout
[18:13:16.300] INFO: PixTest:: pg_setup set to default.
































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































[18:13:16.516] INFO: 3710 hot pixels found in step 5
[18:13:17.510] INFO: Collecting data for 5 seconds...
[18:13:22.527] INFO: Done with hot pixel readout
[18:13:34.134] INFO: PixTest:: pg_setup set to default.




















































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































[18:13:34.387] INFO: 3542 hot pixels found in step 6
[18:13:35.383] INFO: Collecting data for 5 seconds...
[18:13:40.400] INFO: Done with hot pixel readout


















































[18:13:51.626] INFO: PixTest:: pg_setup set to default.















































































































































































































































































































































































































































































































































































































































































































































































































































































































































































[18:13:51.783] INFO: 1397 hot pixels found in step 7
[18:13:52.776] INFO: Collecting data for 5 seconds...
[18:13:57.794] INFO: Done with hot pixel readout
[18:14:09.258] INFO: PixTest:: pg_setup set to default.







































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































[18:14:09.568] INFO: 3266 hot pixels found in step 8
[18:14:10.565] INFO: Collecting data for 5 seconds...
[18:14:15.583] INFO: Done with hot pixel readout
[18:14:27.220] INFO: PixTest:: pg_setup set to default.













































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































[18:14:27.558] INFO: 3063 hot pixels found in step 9
[18:14:28.562] INFO: Collecting data for 5 seconds...
[18:14:33.578] INFO: Done with hot pixel readout
[18:14:45.208] INFO: PixTest:: pg_setup set to default.














































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































[18:14:45.550] INFO: 2974 hot pixels found in step 10
[18:14:46.543] INFO: Collecting data for 5 seconds...
[18:14:51.560] INFO: Done with hot pixel readout
[18:15:03.211] INFO: PixTest:: pg_setup set to default.






































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































[18:15:03.555] INFO: 2869 hot pixels found in step 11
[18:15:04.553] INFO: Collecting data for 5 seconds...
[18:15:09.570] INFO: Done with hot pixel readout
[18:15:21.190] INFO: PixTest:: pg_setup set to default.



























































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































[18:15:21.558] INFO: 2833 hot pixels found in step 12
[18:15:22.561] INFO: Collecting data for 5 seconds...
[18:15:27.578] INFO: Done with hot pixel readout
[18:15:39.211] INFO: PixTest:: pg_setup set to default.



























































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































[18:15:39.580] INFO: 2780 hot pixels found in step 13
[18:15:40.577] INFO: Collecting data for 5 seconds...
[18:15:45.594] INFO: Done with hot pixel readout
[18:15:57.224] INFO: PixTest:: pg_setup set to default.






























































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































































[18:15:57.592] INFO: 2708 hot pixels found in step 14
[18:15:57.645] INFO: PixTest::trimHotPixels() done
[18:15:57.654] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C0.dat
[18:15:57.662] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C1.dat
[18:15:57.669] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C2.dat
[18:15:57.677] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C3.dat
[18:15:57.684] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C4.dat
[18:15:57.691] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C5.dat
[18:15:57.699] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C6.dat
[18:15:57.706] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C7.dat
[18:15:57.713] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C8.dat
[18:15:57.720] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C9.dat
[18:15:57.728] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C10.dat
[18:15:57.735] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C11.dat
[18:15:57.742] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C12.dat
[18:15:57.749] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C13.dat
[18:15:57.757] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C14.dat
[18:15:57.764] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C15.dat
[18:15:57.782] INFO: enter test to run
[18:17:41.943] INFO: test: HighRate setting parameters: ->runsecondshotpixels=1;trimhotpixelthr=150;maskuntrimmable=0<-
[18:17:41.943] INFO: running: highrate
[18:17:41.947] INFO: ----------------------------------------------------------------------
[18:17:41.947] INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[18:17:41.947] INFO: ----------------------------------------------------------------------
[18:17:41.948] INFO: THR = 150, corresponding to ~ 400 MHz/cm2
[18:17:41.948] INFO: edge/corner pixel THR is adjusted
[18:17:41.948] INFO: PixTestHighRate::trimHotPixels: step 0...
[18:17:42.905] INFO: Collecting data for 1 seconds...
[18:17:43.909] INFO: Done with hot pixel readout
[18:17:48.190] INFO: PixTest:: pg_setup set to default.
[18:17:48.191] INFO: 0 hot pixels found in step 0
[18:17:48.272] INFO: PixTest::trimHotPixels() done
[18:17:48.272] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C0.dat
[18:17:48.282] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C1.dat
[18:17:48.290] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C2.dat
[18:17:48.297] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C3.dat
[18:17:48.304] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C4.dat
[18:17:48.311] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C5.dat
[18:17:48.318] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C6.dat
[18:17:48.326] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C7.dat
[18:17:48.333] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C8.dat
[18:17:48.340] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C9.dat
[18:17:48.347] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C10.dat
[18:17:48.354] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C11.dat
[18:17:48.362] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C12.dat
[18:17:48.369] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C13.dat
[18:17:48.376] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C14.dat
[18:17:48.383] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//trimParameters35_C15.dat
[18:17:48.400] INFO: enter test to run
[18:18:09.575] INFO: test: Xray setting parameters: ->savemaskfile=1<-
[18:18:09.575] INFO: running: xray
[18:18:09.580] INFO: ----------------------------------------------------------------------
[18:18:09.580] INFO: PixTest::maskHotPixels() running for 10 seconds with 100 kHz trigger rate
[18:18:09.580] INFO: ----------------------------------------------------------------------
[18:18:10.537] INFO: PixTestHighRate::maskHotPixels start TriggerLoop with period 404 and duration 10 seconds and trigger rate 100 kHz
[18:18:19.580] INFO: Done with hot pixel readout
[18:18:33.731] INFO: PixTest:: pg_setup set to default.
[18:18:33.732] INFO: no hot pixel found!
[18:18:33.732] INFO: PixTest::maskHotPixels() done
[18:18:33.736] INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-G-1-49_FPIXTest-17C-FNAL-160125-0956_2016-01-25_09h57m_1453737426/000_FPIXTest_p17//defaultMaskFile.dat
[18:18:33.905] INFO: enter test to run
[18:18:59.774] INFO: test: Xray setting parameters: ->source=DCLowRate<-
[18:18:59.774] INFO: running: xray
[18:18:59.775] INFO: ----------------------------------------------------------------------
[18:18:59.776] INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[18:18:59.776] INFO: ----------------------------------------------------------------------
[18:19:00.740] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[18:19:12.342] INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[18:19:41.547] INFO: Resuming triggers.
[18:19:53.144] INFO: run duration 23 seconds, buffer almost full (81%), pausing triggers.
[18:20:22.494] INFO: Resuming triggers.
[18:20:34.090] INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[18:21:03.337] INFO: Resuming triggers.
[18:21:14.933] INFO: run duration 46 seconds, buffer almost full (81%), pausing triggers.

[18:21:44.571] INFO: Resuming triggers.
[18:21:56.166] INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.



























[18:22:25.409] INFO: Resuming triggers.
[18:22:37.189] INFO: run duration 69 seconds, buffer almost full (81%), pausing triggers.








[18:23:06.349] INFO: Resuming triggers.
[18:23:17.946] INFO: run duration 81 seconds, buffer almost full (81%), pausing triggers.
[18:23:47.185] INFO: Resuming triggers.
[18:23:58.783] INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[18:24:27.955] INFO: Resuming triggers.
[18:24:35.333] INFO: data taking finished, elapsed time: 100 seconds.
[18:24:54.258] INFO: PixTest:: pg_setup set to default.
[18:24:54.261] INFO: PixTestXray::doPhRun() done
[18:24:54.398] INFO: enter test to run
[18:25:17.956] INFO: test: HighRate no parameter change
[18:25:17.956] INFO: running: highrate
[18:25:17.957] INFO: ----------------------------------------------------------------------
[18:25:17.957] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[18:25:17.957] INFO: ----------------------------------------------------------------------
[18:25:18.097] INFO: Expecting 768 events.
[18:25:19.231] INFO: 768 events read in total (419ms).
[18:25:19.231] INFO: Test took 1268ms.
[18:25:20.034] INFO: Expecting 41600 events.
[18:25:23.102] INFO: 41600 events read in total (2541ms).
[18:25:23.103] INFO: Test took 3864ms.
[18:25:23.135] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:25:23.858] INFO: Expecting 41600 events.
[18:25:27.034] INFO: 41600 events read in total (2649ms).
[18:25:27.034] INFO: Test took 3881ms.
[18:25:27.067] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:25:27.794] INFO: Expecting 41600 events.
[18:25:30.994] INFO: 41600 events read in total (2673ms).
[18:25:30.995] INFO: Test took 3910ms.
[18:25:31.028] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:25:31.753] INFO: Expecting 41600 events.
[18:25:34.991] INFO: 41600 events read in total (2711ms).
[18:25:34.992] INFO: Test took 3945ms.
[18:25:35.025] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:25:35.751] INFO: Expecting 41600 events.
[18:25:38.975] INFO: 41600 events read in total (2697ms).
[18:25:38.976] INFO: Test took 3933ms.
[18:25:39.010] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:25:39.733] INFO: Expecting 41600 events.
[18:25:42.958] INFO: 41600 events read in total (2698ms).
[18:25:42.959] INFO: Test took 3932ms.
[18:25:42.993] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:25:43.714] INFO: Expecting 41600 events.
[18:25:46.943] INFO: 41600 events read in total (2702ms).
[18:25:46.944] INFO: Test took 3933ms.
[18:25:46.977] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:25:47.702] INFO: Expecting 41600 events.
[18:25:50.928] INFO: 41600 events read in total (2699ms).
[18:25:50.929] INFO: Test took 3934ms.
[18:25:50.962] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:25:51.689] INFO: Expecting 41600 events.
[18:25:54.933] INFO: 41600 events read in total (2717ms).
[18:25:54.934] INFO: Test took 3954ms.
[18:25:54.967] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:25:55.691] INFO: Expecting 41600 events.
[18:25:58.928] INFO: 41600 events read in total (2711ms).
[18:25:58.929] INFO: Test took 3945ms.
[18:25:58.963] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:25:59.684] INFO: Expecting 41600 events.



[18:26:02.890] INFO: 0 events read in total (2679ms).

[18:26:03.513] INFO: Expecting 41600 events.
















[18:26:06.752] INFO: 41600 events read in total (2712ms).
[18:26:06.753] INFO: Test took 3847ms.
[18:26:06.785] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:26:07.509] INFO: Expecting 41600 events.
[18:26:10.739] INFO: 41600 events read in total (2703ms).
[18:26:10.740] INFO: Test took 3937ms.
[18:26:10.773] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:26:11.499] INFO: Expecting 41600 events.
[18:26:14.736] INFO: 41600 events read in total (2710ms).
[18:26:14.737] INFO: Test took 3946ms.
[18:26:14.770] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:26:15.496] INFO: Expecting 41600 events.
[18:26:18.720] INFO: 41600 events read in total (2697ms).
[18:26:18.721] INFO: Test took 3933ms.
[18:26:18.754] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:26:19.481] INFO: Expecting 41600 events.
[18:26:22.716] INFO: 41600 events read in total (2708ms).
[18:26:22.717] INFO: Test took 3945ms.
[18:26:22.750] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:26:23.475] INFO: Expecting 41600 events.
[18:26:26.731] INFO: 41600 events read in total (2729ms).
[18:26:26.732] INFO: Test took 3963ms.
[18:26:26.765] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:26:27.487] INFO: Expecting 41600 events.
[18:26:30.720] INFO: 41600 events read in total (2706ms).
[18:26:30.721] INFO: Test took 3938ms.
[18:26:30.755] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:26:31.482] INFO: Expecting 41600 events.
[18:26:34.714] INFO: 41600 events read in total (2706ms).
[18:26:34.715] INFO: Test took 3942ms.
[18:26:34.748] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:26:35.474] INFO: Expecting 41600 events.
[18:26:38.677] INFO: 41600 events read in total (2676ms).
[18:26:38.678] INFO: Test took 3913ms.
[18:26:38.711] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:26:39.439] INFO: Expecting 41600 events.
[18:26:42.273] INFO: 41600 events read in total (2307ms).
[18:26:42.274] INFO: Test took 3546ms.
[18:26:42.307] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:26:42.668] INFO: enter test to run
[18:28:34.010] INFO: test: HighRate no parameter change
[18:28:34.011] INFO: running: highrate
[18:28:34.012] INFO: ----------------------------------------------------------------------
[18:28:34.012] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[18:28:34.012] INFO: ----------------------------------------------------------------------
[18:28:34.627] INFO: Expecting 208000 events.
[18:28:46.492] INFO: 208000 events read in total (11338ms).
[18:28:46.495] INFO: Test took 12476ms.
[18:28:46.633] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:28:46.883] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 3 0 0 0
[18:28:46.883] INFO: number of red-efficiency pixels: 61 55 98 124 141 135 167 77 119 119 108 123 103 61 30 31
[18:28:46.883] INFO: number of X-ray hits detected: 56113 45541 69891 100371 104664 112385 109555 73772 76528 92615 92156 82636 84553 51685 24103 28339
[18:28:46.883] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[18:28:46.883] INFO: number of Vcal hits detected: 207938 207943 207900 207873 207855 207863 207829 207921 207880 207880 207890 207872 207748 207937 207970 207969
[18:28:46.883] INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 100.0 99.9 99.9 99.9 99.9 100.0 99.9 99.9 100.0 99.9 100.0 100.0 100.0 100.0
[18:28:46.883] INFO: Vcal hit overall efficiency (%): 100.0 100.0 100.0 99.9 99.9 99.9 99.9 100.0 99.9 99.9 99.9 99.9 99.9 100.0 100.0 100.0
[18:28:46.883] INFO: X-ray hit rate [MHz/cm2]: 16.4 13.3 20.5 29.4 30.7 32.9 32.1 21.6 22.4 27.1 27.0 24.2 24.8 15.1 7.1 8.3
[18:28:46.883] INFO: PixTestHighRate::doXPixelAlive() done
[18:28:46.935] INFO: PixTest:: pg_setup set to default.
[18:28:46.948] INFO: enter test to run
[18:29:06.202] INFO: test: HighRate no parameter change
[18:29:06.202] INFO: running: highrate
[18:29:06.203] INFO: ----------------------------------------------------------------------
[18:29:06.204] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[18:29:06.204] INFO: ----------------------------------------------------------------------
[18:29:06.832] INFO: Expecting 208000 events.
[18:29:20.624] INFO: 208000 events read in total (13265ms).
[18:29:20.629] INFO: Test took 14416ms.
[18:29:20.939] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:29:21.242] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 3 0 0 0
[18:29:21.242] INFO: number of red-efficiency pixels: 205 138 418 447 565 451 632 270 383 484 338 399 344 231 68 77
[18:29:21.242] INFO: number of X-ray hits detected: 123175 100445 154437 221894 229957 246235 241015 163291 169048 204353 202680 183030 187824 114126 53312 63294
[18:29:21.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
[18:29:21.242] INFO: number of Vcal hits detected: 207785 207855 207515 207504 207373 207503 207281 207707 207586 207467 207640 207566 207490 207746 207929 207922
[18:29:21.242] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.8 99.8 99.7 99.8 99.7 99.9 99.8 99.8 99.8 99.8 99.8 99.9 100.0 100.0
[18:29:21.242] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.8 99.8 99.7 99.8 99.7 99.9 99.8 99.7 99.8 99.8 99.8 99.9 100.0 100.0
[18:29:21.242] INFO: X-ray hit rate [MHz/cm2]: 36.1 29.4 45.3 65.0 67.4 72.2 70.6 47.9 49.5 59.9 59.4 53.6 55.1 33.5 15.6 18.6
[18:29:21.242] INFO: PixTestHighRate::doXPixelAlive() done
[18:29:21.291] INFO: PixTest:: pg_setup set to default.
[18:29:21.306] INFO: enter test to run
[18:29:42.618] INFO: test: HighRate no parameter change
[18:29:42.618] INFO: running: highrate
[18:29:42.619] INFO: ----------------------------------------------------------------------
[18:29:42.619] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[18:29:42.619] INFO: ----------------------------------------------------------------------
[18:29:43.234] INFO: Expecting 208000 events.
[18:29:59.673] INFO: 208000 events read in total (15912ms).
[18:29:59.681] INFO: Test took 17053ms.
[18:30:00.172] INFO: Fetched DAQ statistics. Counters are being reset now.
[18:30:00.535] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 3 0 0 0
[18:30:00.535] INFO: number of red-efficiency pixels: 522 362 931 1062 1534 1238 1669 704 896 1284 969 1041 932 587 149 141
[18:30:00.535] INFO: number of X-ray hits detected: 207291 168981 260216 370650 384885 413718 403932 273736 284985 343671 339992 307241 316005 192586 89771 106372
[18:30:00.535] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[18:30:00.535] INFO: number of Vcal hits detected: 207400 207596 206612 206675 205926 206422 205608 207160 206916 206310 206844 206662 206742 207234 207842 207850
[18:30:00.535] INFO: Vcal hit fiducial efficiency (%): 99.7 99.8 99.4 99.4 99.1 99.3 99.0 99.6 99.5 99.3 99.5 99.4 99.5 99.7 99.9 99.9
[18:30:00.535] INFO: Vcal hit overall efficiency (%): 99.7 99.8 99.3 99.4 99.0 99.2 98.9 99.6 99.5 99.2 99.4 99.4 99.4 99.6 99.9 99.9
[18:30:00.535] INFO: X-ray hit rate [MHz/cm2]: 60.8 49.5 76.3 108.6 112.8 121.3 118.4 80.2 83.5 100.7 99.7 90.1 92.6 56.4 26.3 31.2
[18:30:00.535] INFO: PixTestHighRate::doXPixelAlive() done
[18:30:00.583] INFO: PixTest:: pg_setup set to default.
[18:30:00.595] INFO: enter test to run
[18:30:43.906] INFO: test: Xray setting parameters: ->source=DCHighRate<-
[18:30:43.906] INFO: running: xray
[18:30:43.907] INFO: ----------------------------------------------------------------------
[18:30:43.907] INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[18:30:43.907] INFO: ----------------------------------------------------------------------
[18:30:44.884] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[18:30:51.050] INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[18:31:21.142] INFO: Resuming triggers.
[18:31:27.312] INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[18:31:57.402] INFO: Resuming triggers.
[18:32:03.576] INFO: run duration 18 seconds, buffer almost full (81%), pausing triggers.
[18:32:33.539] INFO: Resuming triggers.
[18:32:39.804] INFO: run duration 24 seconds, buffer almost full (81%), pausing triggers.


















[18:33:09.931] INFO: Resuming triggers.
[18:33:16.102] INFO: run duration 30 seconds, buffer almost full (81%), pausing triggers.
[18:33:46.172] INFO: Resuming triggers.
[18:33:52.347] INFO: run duration 36 seconds, buffer almost full (81%), pausing triggers.
[18:34:22.253] INFO: Resuming triggers.
[18:34:28.427] INFO: run duration 43 seconds, buffer almost full (81%), pausing triggers.
[18:34:58.533] INFO: Resuming triggers.
[18:35:04.706] INFO: run duration 49 seconds, buffer almost full (81%), pausing triggers.




































[18:35:34.717] INFO: Resuming triggers.
[18:35:40.889] INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[18:36:10.981] INFO: Resuming triggers.
[18:36:17.155] INFO: run duration 61 seconds, buffer almost full (81%), pausing triggers.
[18:36:47.235] INFO: Resuming triggers.
[18:36:53.405] INFO: run duration 67 seconds, buffer almost full (81%), pausing triggers.


















[18:37:23.473] INFO: Resuming triggers.
[18:37:29.644] INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[18:37:58.407] INFO: Resuming triggers.
[18:38:04.575] INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[18:38:34.627] INFO: Resuming triggers.
[18:38:40.797] INFO: run duration 86 seconds, buffer almost full (81%), pausing triggers.
[18:39:10.895] INFO: Resuming triggers.
[18:39:17.062] INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[18:39:47.157] INFO: Resuming triggers.
[18:39:53.325] INFO: run duration 98 seconds, buffer almost full (81%), pausing triggers.
[18:40:23.400] INFO: Resuming triggers.
[18:40:24.899] INFO: data taking finished, elapsed time: 100 seconds.
[18:40:32.524] INFO: PixTest:: pg_setup set to default.
[18:40:32.527] INFO: PixTestXray::doPhRun() done
[18:40:32.679] INFO: enter test to run
[18:41:06.312] INFO: test: exit no parameter change
[18:41:06.600] QUIET: Connection to board 32 closed.
[18:41:06.611] INFO: pXar: this is the end, my friend