[12:35:18.786] INFO: *** Welcome to pxar ***
[12:35:18.786] INFO: *** Today: 2016/06/03
[12:35:18.806] INFO: *** Version: v1.9.0-796-gef167-dirty
[12:35:18.806] INFO: readRocDacs: /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//dacParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//dacParameters35_C15.dat
[12:35:18.824] INFO: readTbmDacs: /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//tbmParameters_C0a.dat .. /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//tbmParameters_C0b.dat
[12:35:18.825] INFO: readMaskFile: /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//defaultMaskFile.dat
[12:35:18.839] INFO: MASKED Roc 0 col/row: 1 5
[12:35:18.839] INFO: MASKED Roc 0 col/row: 1 6
[12:35:18.839] INFO: MASKED Roc 0 col/row: 1 7
[12:35:18.839] INFO: MASKED Roc 0 col/row: 1 8
[12:35:18.839] INFO: MASKED Roc 0 col/row: 2 2
[12:35:18.839] INFO: MASKED Roc 0 col/row: 2 3
[12:35:18.839] INFO: MASKED Roc 0 col/row: 2 4
[12:35:18.839] INFO: MASKED Roc 0 col/row: 2 5
[12:35:18.839] INFO: MASKED Roc 0 col/row: 2 6
[12:35:18.839] INFO: MASKED Roc 0 col/row: 2 26
[12:35:18.839] INFO: MASKED Roc 0 col/row: 5 39
[12:35:18.839] INFO: MASKED Roc 0 col/row: 5 43
[12:35:18.839] INFO: MASKED Roc 0 col/row: 12 28
[12:35:18.839] INFO: MASKED Roc 0 col/row: 14 35
[12:35:18.839] INFO: MASKED Roc 0 col/row: 15 36
[12:35:18.839] INFO: MASKED Roc 0 col/row: 15 37
[12:35:18.839] INFO: MASKED Roc 0 col/row: 29 20
[12:35:18.839] INFO: MASKED Roc 0 col/row: 32 20
[12:35:18.839] INFO: MASKED Roc 2 col/row: 34 41
[12:35:18.839] INFO: MASKED Roc 2 col/row: 35 60
[12:35:18.839] INFO: MASKED Roc 2 col/row: 36 62
[12:35:18.839] INFO: MASKED Roc 2 col/row: 38 43
[12:35:18.840] INFO: MASKED Roc 2 col/row: 39 41
[12:35:18.840] INFO: MASKED Roc 2 col/row: 46 43
[12:35:18.840] INFO: MASKED Roc 3 col/row: 2 62
[12:35:18.840] INFO: MASKED Roc 3 col/row: 3 22
[12:35:18.840] INFO: MASKED Roc 3 col/row: 5 62
[12:35:18.840] INFO: MASKED Roc 3 col/row: 9 60
[12:35:18.840] INFO: MASKED Roc 3 col/row: 10 45
[12:35:18.840] INFO: MASKED Roc 3 col/row: 13 50
[12:35:18.840] INFO: MASKED Roc 3 col/row: 16 62
[12:35:18.840] INFO: MASKED Roc 3 col/row: 19 24
[12:35:18.840] INFO: MASKED Roc 3 col/row: 19 62
[12:35:18.840] INFO: MASKED Roc 3 col/row: 26 18
[12:35:18.840] INFO: MASKED Roc 3 col/row: 27 58
[12:35:18.840] INFO: MASKED Roc 3 col/row: 28 25
[12:35:18.840] INFO: MASKED Roc 3 col/row: 29 56
[12:35:18.840] INFO: MASKED Roc 3 col/row: 31 18
[12:35:18.840] INFO: MASKED Roc 3 col/row: 33 15
[12:35:18.840] INFO: MASKED Roc 3 col/row: 40 22
[12:35:18.840] INFO: MASKED Roc 3 col/row: 40 35
[12:35:18.840] INFO: MASKED Roc 3 col/row: 44 33
[12:35:18.840] INFO: MASKED Roc 4 col/row: 4 62
[12:35:18.840] INFO: MASKED Roc 4 col/row: 12 40
[12:35:18.840] INFO: MASKED Roc 4 col/row: 31 17
[12:35:18.840] INFO: MASKED Roc 4 col/row: 41 41
[12:35:18.840] INFO: MASKED Roc 4 col/row: 46 24
[12:35:18.840] INFO: MASKED Roc 4 col/row: 49 24
[12:35:18.840] INFO: MASKED Roc 5 col/row: 9 24
[12:35:18.840] INFO: MASKED Roc 5 col/row: 9 58
[12:35:18.840] INFO: MASKED Roc 5 col/row: 46 54
[12:35:18.840] INFO: MASKED Roc 5 col/row: 49 24
[12:35:18.840] INFO: MASKED Roc 5 col/row: 50 52
[12:35:18.840] INFO: MASKED Roc 6 col/row: 3 58
[12:35:18.840] INFO: MASKED Roc 6 col/row: 9 54
[12:35:18.840] INFO: MASKED Roc 6 col/row: 10 18
[12:35:18.840] INFO: MASKED Roc 6 col/row: 20 58
[12:35:18.840] INFO: MASKED Roc 6 col/row: 23 49
[12:35:18.840] INFO: MASKED Roc 6 col/row: 23 58
[12:35:18.840] INFO: MASKED Roc 6 col/row: 37 49
[12:35:18.840] INFO: MASKED Roc 6 col/row: 44 26
[12:35:18.840] INFO: readTrimFile: /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C15.dat
[12:35:18.840] INFO: masking Roc 0 col/row: 1 5
[12:35:18.840] INFO: masking Roc 0 col/row: 1 6
[12:35:18.840] INFO: masking Roc 0 col/row: 1 7
[12:35:18.840] INFO: masking Roc 0 col/row: 1 8
[12:35:18.840] INFO: masking Roc 0 col/row: 2 2
[12:35:18.840] INFO: masking Roc 0 col/row: 2 3
[12:35:18.840] INFO: masking Roc 0 col/row: 2 4
[12:35:18.840] INFO: masking Roc 0 col/row: 2 5
[12:35:18.840] INFO: masking Roc 0 col/row: 2 6
[12:35:18.840] INFO: masking Roc 0 col/row: 2 26
[12:35:18.840] INFO: masking Roc 0 col/row: 5 39
[12:35:18.840] INFO: masking Roc 0 col/row: 5 43
[12:35:18.840] INFO: masking Roc 0 col/row: 12 28
[12:35:18.841] INFO: masking Roc 0 col/row: 14 35
[12:35:18.841] INFO: masking Roc 0 col/row: 15 36
[12:35:18.841] INFO: masking Roc 0 col/row: 15 37
[12:35:18.841] INFO: masking Roc 0 col/row: 29 20
[12:35:18.841] INFO: masking Roc 0 col/row: 32 20
[12:35:18.867] INFO: masking Roc 2 col/row: 34 41
[12:35:18.867] INFO: masking Roc 2 col/row: 35 60
[12:35:18.867] INFO: masking Roc 2 col/row: 36 62
[12:35:18.867] INFO: masking Roc 2 col/row: 38 43
[12:35:18.867] INFO: masking Roc 2 col/row: 39 41
[12:35:18.867] INFO: masking Roc 2 col/row: 46 43
[12:35:18.880] INFO: masking Roc 3 col/row: 2 62
[12:35:18.880] INFO: masking Roc 3 col/row: 3 22
[12:35:18.880] INFO: masking Roc 3 col/row: 5 62
[12:35:18.880] INFO: masking Roc 3 col/row: 9 60
[12:35:18.880] INFO: masking Roc 3 col/row: 10 45
[12:35:18.880] INFO: masking Roc 3 col/row: 13 50
[12:35:18.880] INFO: masking Roc 3 col/row: 16 62
[12:35:18.880] INFO: masking Roc 3 col/row: 19 24
[12:35:18.880] INFO: masking Roc 3 col/row: 19 62
[12:35:18.880] INFO: masking Roc 3 col/row: 26 18
[12:35:18.880] INFO: masking Roc 3 col/row: 27 58
[12:35:18.880] INFO: masking Roc 3 col/row: 28 25
[12:35:18.880] INFO: masking Roc 3 col/row: 29 56
[12:35:18.880] INFO: masking Roc 3 col/row: 31 18
[12:35:18.880] INFO: masking Roc 3 col/row: 33 15
[12:35:18.880] INFO: masking Roc 3 col/row: 40 22
[12:35:18.880] INFO: masking Roc 3 col/row: 40 35
[12:35:18.880] INFO: masking Roc 3 col/row: 44 33
[12:35:18.889] INFO: masking Roc 4 col/row: 4 62
[12:35:18.889] INFO: masking Roc 4 col/row: 12 40
[12:35:18.889] INFO: masking Roc 4 col/row: 31 17
[12:35:18.889] INFO: masking Roc 4 col/row: 41 41
[12:35:18.889] INFO: masking Roc 4 col/row: 46 24
[12:35:18.889] INFO: masking Roc 4 col/row: 49 24
[12:35:18.894] INFO: masking Roc 5 col/row: 9 24
[12:35:18.894] INFO: masking Roc 5 col/row: 9 58
[12:35:18.894] INFO: masking Roc 5 col/row: 46 54
[12:35:18.894] INFO: masking Roc 5 col/row: 49 24
[12:35:18.894] INFO: masking Roc 5 col/row: 50 52
[12:35:18.907] INFO: masking Roc 6 col/row: 3 58
[12:35:18.907] INFO: masking Roc 6 col/row: 9 54
[12:35:18.907] INFO: masking Roc 6 col/row: 10 18
[12:35:18.907] INFO: masking Roc 6 col/row: 20 58
[12:35:18.907] INFO: masking Roc 6 col/row: 23 49
[12:35:18.907] INFO: masking Roc 6 col/row: 23 58
[12:35:18.907] INFO: masking Roc 6 col/row: 37 49
[12:35:18.907] INFO: masking Roc 6 col/row: 44 26
[12:35:18.989] INFO: clk: 4
[12:35:18.989] INFO: ctr: 4
[12:35:18.989] INFO: sda: 19
[12:35:18.989] INFO: tin: 9
[12:35:18.989] INFO: level: 15
[12:35:18.989] INFO: triggerdelay: 0
[12:35:18.989] QUIET: Instanciating API for pxar v1.9.0+796~gef16747
[12:35:18.989] INFO: Log level: INFO
[12:35:19.008] QUIET: Connection to board DTB_WREK4U opened.
[12:35:19.011] 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:
------------------------------------------------------
[12:35:19.014] INFO: RPC call hashes of host and DTB match: 398089610
[12:35:20.546] INFO: DUT info:
[12:35:20.546] INFO: The DUT currently contains the following objects:
[12:35:20.546] INFO: 2 TBM Cores tbm08c (2 ON)
[12:35:20.546] INFO: TBM Core alpha (0): 7 registers set
[12:35:20.546] INFO: TBM Core beta (1): 7 registers set
[12:35:20.547] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:35:20.547] INFO: ROC 0: 19 DACs set, Pixels: 18 masked, 0 active.
[12:35:20.547] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:35:20.547] INFO: ROC 2: 19 DACs set, Pixels: 6 masked, 0 active.
[12:35:20.547] INFO: ROC 3: 19 DACs set, Pixels: 18 masked, 0 active.
[12:35:20.547] INFO: ROC 4: 19 DACs set, Pixels: 6 masked, 0 active.
[12:35:20.547] INFO: ROC 5: 19 DACs set, Pixels: 5 masked, 0 active.
[12:35:20.547] INFO: ROC 6: 19 DACs set, Pixels: 8 masked, 0 active.
[12:35:20.547] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:35:20.547] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:35:20.547] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:35:20.547] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:35:20.547] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:35:20.547] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:35:20.547] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:35:20.547] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:35:20.547] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:35:20.969] INFO: enter 'restricted' command line mode
[12:35:20.969] INFO: enter test to run
[12:35:26.042] INFO: test: PixelAlive no parameter change
[12:35:26.042] INFO: running: pixelalive
[12:35:26.051] INFO: ----------------------------------------------------------------------
[12:35:26.051] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:35:26.051] INFO: ----------------------------------------------------------------------
[12:35:26.054] INFO: ROC 0 masking pixel 1/5
[12:35:26.054] INFO: ROC 0 masking pixel 1/6
[12:35:26.054] INFO: ROC 0 masking pixel 1/7
[12:35:26.054] INFO: ROC 0 masking pixel 1/8
[12:35:26.054] INFO: ROC 0 masking pixel 2/2
[12:35:26.054] INFO: ROC 0 masking pixel 2/3
[12:35:26.054] INFO: ROC 0 masking pixel 2/4
[12:35:26.054] INFO: ROC 0 masking pixel 2/5
[12:35:26.054] INFO: ROC 0 masking pixel 2/6
[12:35:26.054] INFO: ROC 0 masking pixel 2/26
[12:35:26.054] INFO: ROC 0 masking pixel 5/39
[12:35:26.054] INFO: ROC 0 masking pixel 5/43
[12:35:26.054] INFO: ROC 0 masking pixel 12/28
[12:35:26.054] INFO: ROC 0 masking pixel 14/35
[12:35:26.054] INFO: ROC 0 masking pixel 15/36
[12:35:26.054] INFO: ROC 0 masking pixel 15/37
[12:35:26.054] INFO: ROC 0 masking pixel 29/20
[12:35:26.054] INFO: ROC 0 masking pixel 32/20
[12:35:26.054] INFO: ROC 2 masking pixel 34/41
[12:35:26.054] INFO: ROC 2 masking pixel 35/60
[12:35:26.054] INFO: ROC 2 masking pixel 36/62
[12:35:26.054] INFO: ROC 2 masking pixel 38/43
[12:35:26.054] INFO: ROC 2 masking pixel 39/41
[12:35:26.054] INFO: ROC 2 masking pixel 46/43
[12:35:26.054] INFO: ROC 3 masking pixel 2/62
[12:35:26.054] INFO: ROC 3 masking pixel 3/22
[12:35:26.054] INFO: ROC 3 masking pixel 5/62
[12:35:26.054] INFO: ROC 3 masking pixel 9/60
[12:35:26.054] INFO: ROC 3 masking pixel 10/45
[12:35:26.054] INFO: ROC 3 masking pixel 13/50
[12:35:26.055] INFO: ROC 3 masking pixel 16/62
[12:35:26.055] INFO: ROC 3 masking pixel 19/24
[12:35:26.055] INFO: ROC 3 masking pixel 19/62
[12:35:26.055] INFO: ROC 3 masking pixel 26/18
[12:35:26.055] INFO: ROC 3 masking pixel 27/58
[12:35:26.055] INFO: ROC 3 masking pixel 28/25
[12:35:26.055] INFO: ROC 3 masking pixel 29/56
[12:35:26.055] INFO: ROC 3 masking pixel 31/18
[12:35:26.055] INFO: ROC 3 masking pixel 33/15
[12:35:26.055] INFO: ROC 3 masking pixel 40/22
[12:35:26.055] INFO: ROC 3 masking pixel 40/35
[12:35:26.055] INFO: ROC 3 masking pixel 44/33
[12:35:26.055] INFO: ROC 4 masking pixel 4/62
[12:35:26.055] INFO: ROC 4 masking pixel 12/40
[12:35:26.055] INFO: ROC 4 masking pixel 31/17
[12:35:26.055] INFO: ROC 4 masking pixel 41/41
[12:35:26.055] INFO: ROC 4 masking pixel 46/24
[12:35:26.055] INFO: ROC 4 masking pixel 49/24
[12:35:26.055] INFO: ROC 5 masking pixel 9/24
[12:35:26.055] INFO: ROC 5 masking pixel 9/58
[12:35:26.055] INFO: ROC 5 masking pixel 46/54
[12:35:26.055] INFO: ROC 5 masking pixel 49/24
[12:35:26.055] INFO: ROC 5 masking pixel 50/52
[12:35:26.055] INFO: ROC 6 masking pixel 3/58
[12:35:26.055] INFO: ROC 6 masking pixel 9/54
[12:35:26.055] INFO: ROC 6 masking pixel 10/18
[12:35:26.055] INFO: ROC 6 masking pixel 20/58
[12:35:26.055] INFO: ROC 6 masking pixel 23/49
[12:35:26.055] INFO: ROC 6 masking pixel 23/58
[12:35:26.055] INFO: ROC 6 masking pixel 37/49
[12:35:26.055] INFO: ROC 6 masking pixel 44/26
[12:35:26.367] INFO: Expecting 41600 events.
[12:35:30.707] INFO: 41600 events read in total (3622ms).
[12:35:30.875] INFO: Test took 4820ms.
[12:35:30.886] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:35:31.146] INFO: PixTestAlive::aliveTest() done
[12:35:31.146] INFO: number of dead pixels (per ROC): 18 0 6 18 6 5 8 0 0 0 0 1 0 0 0 0
[12:35:31.146] INFO: ROC 0 masking pixel 1/5
[12:35:31.146] INFO: ROC 0 masking pixel 1/6
[12:35:31.146] INFO: ROC 0 masking pixel 1/7
[12:35:31.146] INFO: ROC 0 masking pixel 1/8
[12:35:31.146] INFO: ROC 0 masking pixel 2/2
[12:35:31.146] INFO: ROC 0 masking pixel 2/3
[12:35:31.146] INFO: ROC 0 masking pixel 2/4
[12:35:31.146] INFO: ROC 0 masking pixel 2/5
[12:35:31.146] INFO: ROC 0 masking pixel 2/6
[12:35:31.146] INFO: ROC 0 masking pixel 2/26
[12:35:31.146] INFO: ROC 0 masking pixel 5/39
[12:35:31.146] INFO: ROC 0 masking pixel 5/43
[12:35:31.146] INFO: ROC 0 masking pixel 12/28
[12:35:31.146] INFO: ROC 0 masking pixel 14/35
[12:35:31.146] INFO: ROC 0 masking pixel 15/36
[12:35:31.146] INFO: ROC 0 masking pixel 15/37
[12:35:31.146] INFO: ROC 0 masking pixel 29/20
[12:35:31.146] INFO: ROC 0 masking pixel 32/20
[12:35:31.146] INFO: ROC 2 masking pixel 34/41
[12:35:31.146] INFO: ROC 2 masking pixel 35/60
[12:35:31.146] INFO: ROC 2 masking pixel 36/62
[12:35:31.146] INFO: ROC 2 masking pixel 38/43
[12:35:31.146] INFO: ROC 2 masking pixel 39/41
[12:35:31.146] INFO: ROC 2 masking pixel 46/43
[12:35:31.146] INFO: ROC 3 masking pixel 2/62
[12:35:31.146] INFO: ROC 3 masking pixel 3/22
[12:35:31.146] INFO: ROC 3 masking pixel 5/62
[12:35:31.146] INFO: ROC 3 masking pixel 9/60
[12:35:31.146] INFO: ROC 3 masking pixel 10/45
[12:35:31.146] INFO: ROC 3 masking pixel 13/50
[12:35:31.146] INFO: ROC 3 masking pixel 16/62
[12:35:31.146] INFO: ROC 3 masking pixel 19/24
[12:35:31.146] INFO: ROC 3 masking pixel 19/62
[12:35:31.146] INFO: ROC 3 masking pixel 26/18
[12:35:31.146] INFO: ROC 3 masking pixel 27/58
[12:35:31.146] INFO: ROC 3 masking pixel 28/25
[12:35:31.146] INFO: ROC 3 masking pixel 29/56
[12:35:31.146] INFO: ROC 3 masking pixel 31/18
[12:35:31.146] INFO: ROC 3 masking pixel 33/15
[12:35:31.146] INFO: ROC 3 masking pixel 40/22
[12:35:31.146] INFO: ROC 3 masking pixel 40/35
[12:35:31.146] INFO: ROC 3 masking pixel 44/33
[12:35:31.146] INFO: ROC 4 masking pixel 4/62
[12:35:31.146] INFO: ROC 4 masking pixel 12/40
[12:35:31.146] INFO: ROC 4 masking pixel 31/17
[12:35:31.146] INFO: ROC 4 masking pixel 41/41
[12:35:31.146] INFO: ROC 4 masking pixel 46/24
[12:35:31.146] INFO: ROC 4 masking pixel 49/24
[12:35:31.146] INFO: ROC 5 masking pixel 9/24
[12:35:31.146] INFO: ROC 5 masking pixel 9/58
[12:35:31.146] INFO: ROC 5 masking pixel 46/54
[12:35:31.146] INFO: ROC 5 masking pixel 49/24
[12:35:31.146] INFO: ROC 5 masking pixel 50/52
[12:35:31.146] INFO: ROC 6 masking pixel 3/58
[12:35:31.146] INFO: ROC 6 masking pixel 9/54
[12:35:31.146] INFO: ROC 6 masking pixel 10/18
[12:35:31.146] INFO: ROC 6 masking pixel 20/58
[12:35:31.146] INFO: ROC 6 masking pixel 23/49
[12:35:31.146] INFO: ROC 6 masking pixel 23/58
[12:35:31.147] INFO: ROC 6 masking pixel 37/49
[12:35:31.147] INFO: ROC 6 masking pixel 44/26
[12:35:31.179] INFO: enter test to run
[12:36:09.450] INFO: test: HighRate setting parameters: ->runsecondshotpixels=5;trimhotpixelthr=200<-
[12:36:09.450] INFO: running: highrate
[12:36:09.450] INFO: readGainPedestalParameters /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//phCalibrationFitErr35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//phCalibrationFitErr35_C15.dat
[12:36:09.675] INFO: ----------------------------------------------------------------------
[12:36:09.675] INFO: PixTest::trimHotPixels() running for 5 seconds with 100 kHz trigger rate
[12:36:09.675] INFO: ----------------------------------------------------------------------
[12:36:09.675] INFO: THR = 200, corresponding to ~ 106.667 MHz/cm2
[12:36:09.675] INFO: edge/corner pixel THR is adjusted
[12:36:09.675] INFO: PixTestHighRate::trimHotPixels: step 0...
[12:36:10.634] INFO: Collecting data for 5 seconds...
[12:36:15.651] INFO: Done with hot pixel readout
[12:36:28.005] INFO: PixTest:: pg_setup set to default.








[12:36:28.006] INFO: 11 hot pixels found in step 0
[12:36:29.027] INFO: Collecting data for 5 seconds...
[12:36:34.044] INFO: Done with hot pixel readout
[12:36:46.380] INFO: PixTest:: pg_setup set to default.










[12:36:46.381] INFO: 15 hot pixels found in step 1
[12:36:47.377] INFO: Collecting data for 5 seconds...
[12:36:52.395] INFO: Done with hot pixel readout
[12:37:04.757] INFO: PixTest:: pg_setup set to default.








[12:37:04.758] INFO: 12 hot pixels found in step 2
[12:37:05.754] INFO: Collecting data for 5 seconds...
[12:37:10.770] INFO: Done with hot pixel readout
[12:37:23.205] INFO: PixTest:: pg_setup set to default.







[12:37:23.206] INFO: 9 hot pixels found in step 3
[12:37:24.202] INFO: Collecting data for 5 seconds...
[12:37:29.219] INFO: Done with hot pixel readout
[12:37:41.552] INFO: PixTest:: pg_setup set to default.









[12:37:41.553] INFO: 14 hot pixels found in step 4
[12:37:42.549] INFO: Collecting data for 5 seconds...
[12:37:47.566] INFO: Done with hot pixel readout
[12:38:00.007] INFO: PixTest:: pg_setup set to default.





[12:38:00.008] INFO: 13 hot pixels found in step 5
[12:38:01.003] INFO: Collecting data for 5 seconds...
[12:38:06.021] INFO: Done with hot pixel readout
[12:38:18.408] INFO: PixTest:: pg_setup set to default.










[12:38:18.409] INFO: 13 hot pixels found in step 6
[12:38:19.406] INFO: Collecting data for 5 seconds...
[12:38:24.423] INFO: Done with hot pixel readout
[12:38:36.774] INFO: PixTest:: pg_setup set to default.









[12:38:36.775] INFO: 16 hot pixels found in step 7
[12:38:37.770] INFO: Collecting data for 5 seconds...
[12:38:42.786] INFO: Done with hot pixel readout
[12:38:55.232] INFO: PixTest:: pg_setup set to default.








[12:38:55.233] INFO: 8 hot pixels found in step 8
[12:38:55.273] INFO: 8 hot pixels could not be trimmed and have been masked.
[12:38:55.276] INFO: PixTest::trimHotPixels() done
[12:38:55.276] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C0.dat
[12:38:55.293] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C1.dat
[12:38:55.305] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C2.dat
[12:38:55.311] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C3.dat
[12:38:55.317] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C4.dat
[12:38:55.323] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C5.dat
[12:38:55.329] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C6.dat
[12:38:55.335] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C7.dat
[12:38:55.340] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C8.dat
[12:38:55.346] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C9.dat
[12:38:55.352] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C10.dat
[12:38:55.358] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C11.dat
[12:38:55.364] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C12.dat
[12:38:55.370] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C13.dat
[12:38:55.375] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C14.dat
[12:38:55.381] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C15.dat
[12:38:55.388] INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//defaultMaskFile.dat
[12:38:55.405] INFO: enter test to run
[12:40:03.688] INFO: test: HighRate setting parameters: ->runsecondshotpixels=1;trimhotpixelthr=200<-
[12:40:03.688] INFO: running: highrate
[12:40:03.692] INFO: ----------------------------------------------------------------------
[12:40:03.692] INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[12:40:03.692] INFO: ----------------------------------------------------------------------
[12:40:03.692] INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[12:40:03.692] INFO: edge/corner pixel THR is adjusted
[12:40:03.692] INFO: PixTestHighRate::trimHotPixels: step 0...
[12:40:04.650] INFO: Collecting data for 1 seconds...
[12:40:05.654] INFO: Done with hot pixel readout
[12:40:10.130] INFO: PixTest:: pg_setup set to default.
[12:40:10.131] INFO: 0 hot pixels found in step 0
[12:40:10.136] INFO: 0 hot pixels could not be trimmed and have been masked.
[12:40:10.209] INFO: PixTest::trimHotPixels() done
[12:40:10.210] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C0.dat
[12:40:10.222] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C1.dat
[12:40:10.228] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C2.dat
[12:40:10.233] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C3.dat
[12:40:10.239] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C4.dat
[12:40:10.244] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C5.dat
[12:40:10.250] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C6.dat
[12:40:10.255] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C7.dat
[12:40:10.261] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C8.dat
[12:40:10.266] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C9.dat
[12:40:10.272] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C10.dat
[12:40:10.277] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C11.dat
[12:40:10.283] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C12.dat
[12:40:10.289] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C13.dat
[12:40:10.294] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C14.dat
[12:40:10.300] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//trimParameters35_C15.dat
[12:40:10.306] INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-Y-A-NF_FPIXTest-17C-FNAL-160421-1341_2016-04-21_13h41m_1461264105/000_FPIXTest_p17//defaultMaskFile.dat
[12:40:10.315] INFO: enter test to run
[12:40:38.143] INFO: test: Xray setting parameters: ->source=DCLowRate<-
[12:40:38.143] INFO: running: xray
[12:40:38.144] INFO: ----------------------------------------------------------------------
[12:40:38.144] INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[12:40:38.144] INFO: ----------------------------------------------------------------------
[12:40:38.148] INFO: ROC 0 masking pixel 1/5
[12:40:38.148] INFO: ROC 0 masking pixel 1/6
[12:40:38.148] INFO: ROC 0 masking pixel 1/7
[12:40:38.148] INFO: ROC 0 masking pixel 1/8
[12:40:38.148] INFO: ROC 0 masking pixel 2/2
[12:40:38.148] INFO: ROC 0 masking pixel 2/3
[12:40:38.148] INFO: ROC 0 masking pixel 2/4
[12:40:38.148] INFO: ROC 0 masking pixel 2/5
[12:40:38.148] INFO: ROC 0 masking pixel 2/6
[12:40:38.148] INFO: ROC 0 masking pixel 2/26
[12:40:38.148] INFO: ROC 0 masking pixel 5/39
[12:40:38.148] INFO: ROC 0 masking pixel 5/43
[12:40:38.148] INFO: ROC 0 masking pixel 12/28
[12:40:38.148] INFO: ROC 0 masking pixel 14/35
[12:40:38.148] INFO: ROC 0 masking pixel 15/36
[12:40:38.148] INFO: ROC 0 masking pixel 15/37
[12:40:38.148] INFO: ROC 0 masking pixel 29/20
[12:40:38.148] INFO: ROC 0 masking pixel 32/20
[12:40:38.148] INFO: ROC 2 masking pixel 34/41
[12:40:38.148] INFO: ROC 2 masking pixel 35/60
[12:40:38.148] INFO: ROC 2 masking pixel 36/62
[12:40:38.148] INFO: ROC 2 masking pixel 38/43
[12:40:38.149] INFO: ROC 2 masking pixel 39/41
[12:40:38.149] INFO: ROC 2 masking pixel 46/43
[12:40:38.149] INFO: ROC 3 masking pixel 2/62
[12:40:38.149] INFO: ROC 3 masking pixel 3/22
[12:40:38.149] INFO: ROC 3 masking pixel 5/62
[12:40:38.149] INFO: ROC 3 masking pixel 9/60
[12:40:38.149] INFO: ROC 3 masking pixel 10/45
[12:40:38.149] INFO: ROC 3 masking pixel 13/50
[12:40:38.149] INFO: ROC 3 masking pixel 16/62
[12:40:38.149] INFO: ROC 3 masking pixel 19/24
[12:40:38.149] INFO: ROC 3 masking pixel 19/62
[12:40:38.149] INFO: ROC 3 masking pixel 26/18
[12:40:38.149] INFO: ROC 3 masking pixel 27/58
[12:40:38.149] INFO: ROC 3 masking pixel 28/25
[12:40:38.149] INFO: ROC 3 masking pixel 29/56
[12:40:38.149] INFO: ROC 3 masking pixel 31/18
[12:40:38.149] INFO: ROC 3 masking pixel 33/15
[12:40:38.149] INFO: ROC 3 masking pixel 40/22
[12:40:38.149] INFO: ROC 3 masking pixel 40/35
[12:40:38.149] INFO: ROC 3 masking pixel 44/33
[12:40:38.149] INFO: ROC 4 masking pixel 4/62
[12:40:38.149] INFO: ROC 4 masking pixel 12/40
[12:40:38.149] INFO: ROC 4 masking pixel 31/17
[12:40:38.149] INFO: ROC 4 masking pixel 41/41
[12:40:38.149] INFO: ROC 4 masking pixel 46/24
[12:40:38.149] INFO: ROC 4 masking pixel 49/24
[12:40:38.149] INFO: ROC 5 masking pixel 9/24
[12:40:38.149] INFO: ROC 5 masking pixel 9/58
[12:40:38.149] INFO: ROC 5 masking pixel 46/54
[12:40:38.149] INFO: ROC 5 masking pixel 49/24
[12:40:38.149] INFO: ROC 5 masking pixel 50/52
[12:40:38.149] INFO: ROC 6 masking pixel 3/58
[12:40:38.149] INFO: ROC 6 masking pixel 9/54
[12:40:38.150] INFO: ROC 6 masking pixel 10/18
[12:40:38.150] INFO: ROC 6 masking pixel 20/58
[12:40:38.150] INFO: ROC 6 masking pixel 23/49
[12:40:38.150] INFO: ROC 6 masking pixel 23/58
[12:40:38.150] INFO: ROC 6 masking pixel 37/49
[12:40:38.150] INFO: ROC 6 masking pixel 44/26
[12:40:39.109] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[12:40:49.782] INFO: run duration 10 seconds, buffer almost full (81%), pausing triggers.
[12:41:19.311] INFO: Resuming triggers.
[12:41:29.981] INFO: run duration 21 seconds, buffer almost full (81%), pausing triggers.
[12:41:59.779] INFO: Resuming triggers.
[12:42:10.449] INFO: run duration 31 seconds, buffer almost full (81%), pausing triggers.
[12:42:40.035] INFO: Resuming triggers.
[12:42:50.707] INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[12:43:20.304] INFO: Resuming triggers.
[12:43:30.973] INFO: run duration 53 seconds, buffer almost full (81%), pausing triggers.
[12:44:00.631] INFO: Resuming triggers.
[12:44:11.303] INFO: run duration 63 seconds, buffer almost full (81%), pausing triggers.
[12:44:40.935] INFO: Resuming triggers.
[12:44:51.601] INFO: run duration 74 seconds, buffer almost full (81%), pausing triggers.
[12:45:21.238] INFO: Resuming triggers.
[12:45:31.905] INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[12:46:01.531] INFO: Resuming triggers.
[12:46:12.204] INFO: run duration 95 seconds, buffer almost full (81%), pausing triggers.
[12:46:41.817] INFO: Resuming triggers.
[12:46:46.116] INFO: data taking finished, elapsed time: 100 seconds.
[12:46:58.239] INFO: PixTest:: pg_setup set to default.
[12:46:58.242] INFO: PixTestXray::doPhRun() done
[12:46:58.380] INFO: enter test to run
[12:47:22.541] INFO: test: Xray setting parameters: ->source=DCHighRate<-
[12:47:22.541] INFO: running: xray
[12:47:22.542] INFO: ----------------------------------------------------------------------
[12:47:22.542] INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[12:47:22.542] INFO: ----------------------------------------------------------------------
[12:47:22.545] INFO: ROC 0 masking pixel 1/5
[12:47:22.545] INFO: ROC 0 masking pixel 1/6
[12:47:22.546] INFO: ROC 0 masking pixel 1/7
[12:47:22.546] INFO: ROC 0 masking pixel 1/8
[12:47:22.546] INFO: ROC 0 masking pixel 2/2
[12:47:22.546] INFO: ROC 0 masking pixel 2/3
[12:47:22.546] INFO: ROC 0 masking pixel 2/4
[12:47:22.546] INFO: ROC 0 masking pixel 2/5
[12:47:22.546] INFO: ROC 0 masking pixel 2/6
[12:47:22.546] INFO: ROC 0 masking pixel 2/26
[12:47:22.546] INFO: ROC 0 masking pixel 5/39
[12:47:22.546] INFO: ROC 0 masking pixel 5/43
[12:47:22.546] INFO: ROC 0 masking pixel 12/28
[12:47:22.546] INFO: ROC 0 masking pixel 14/35
[12:47:22.546] INFO: ROC 0 masking pixel 15/36
[12:47:22.546] INFO: ROC 0 masking pixel 15/37
[12:47:22.546] INFO: ROC 0 masking pixel 29/20
[12:47:22.546] INFO: ROC 0 masking pixel 32/20
[12:47:22.546] INFO: ROC 2 masking pixel 34/41
[12:47:22.546] INFO: ROC 2 masking pixel 35/60
[12:47:22.546] INFO: ROC 2 masking pixel 36/62
[12:47:22.546] INFO: ROC 2 masking pixel 38/43
[12:47:22.546] INFO: ROC 2 masking pixel 39/41
[12:47:22.546] INFO: ROC 2 masking pixel 46/43
[12:47:22.546] INFO: ROC 3 masking pixel 2/62
[12:47:22.546] INFO: ROC 3 masking pixel 3/22
[12:47:22.546] INFO: ROC 3 masking pixel 5/62
[12:47:22.546] INFO: ROC 3 masking pixel 9/60
[12:47:22.546] INFO: ROC 3 masking pixel 10/45
[12:47:22.546] INFO: ROC 3 masking pixel 13/50
[12:47:22.546] INFO: ROC 3 masking pixel 16/62
[12:47:22.546] INFO: ROC 3 masking pixel 19/24
[12:47:22.546] INFO: ROC 3 masking pixel 19/62
[12:47:22.546] INFO: ROC 3 masking pixel 26/18
[12:47:22.546] INFO: ROC 3 masking pixel 27/58
[12:47:22.546] INFO: ROC 3 masking pixel 28/25
[12:47:22.546] INFO: ROC 3 masking pixel 29/56
[12:47:22.546] INFO: ROC 3 masking pixel 31/18
[12:47:22.546] INFO: ROC 3 masking pixel 33/15
[12:47:22.546] INFO: ROC 3 masking pixel 40/22
[12:47:22.546] INFO: ROC 3 masking pixel 40/35
[12:47:22.546] INFO: ROC 3 masking pixel 44/33
[12:47:22.546] INFO: ROC 4 masking pixel 4/62
[12:47:22.546] INFO: ROC 4 masking pixel 12/40
[12:47:22.546] INFO: ROC 4 masking pixel 31/17
[12:47:22.546] INFO: ROC 4 masking pixel 41/41
[12:47:22.546] INFO: ROC 4 masking pixel 46/24
[12:47:22.546] INFO: ROC 4 masking pixel 49/24
[12:47:22.546] INFO: ROC 5 masking pixel 9/24
[12:47:22.546] INFO: ROC 5 masking pixel 9/58
[12:47:22.546] INFO: ROC 5 masking pixel 46/54
[12:47:22.546] INFO: ROC 5 masking pixel 49/24
[12:47:22.546] INFO: ROC 5 masking pixel 50/52
[12:47:22.546] INFO: ROC 6 masking pixel 3/58
[12:47:22.546] INFO: ROC 6 masking pixel 9/54
[12:47:22.546] INFO: ROC 6 masking pixel 10/18
[12:47:22.546] INFO: ROC 6 masking pixel 20/58
[12:47:22.546] INFO: ROC 6 masking pixel 23/49
[12:47:22.547] INFO: ROC 6 masking pixel 23/58
[12:47:22.547] INFO: ROC 6 masking pixel 37/49
[12:47:22.547] INFO: ROC 6 masking pixel 44/26
[12:47:23.514] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[12:47:29.411] INFO: run duration 5 seconds, buffer almost full (81%), pausing triggers.
[12:47:59.663] INFO: Resuming triggers.
[12:48:05.562] INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[12:48:35.816] INFO: Resuming triggers.
[12:48:41.717] INFO: run duration 17 seconds, buffer almost full (81%), pausing triggers.
[12:49:12.053] INFO: Resuming triggers.
[12:49:17.953] INFO: run duration 23 seconds, buffer almost full (81%), pausing triggers.
[12:49:48.478] INFO: Resuming triggers.
[12:49:54.379] INFO: run duration 29 seconds, buffer almost full (81%), pausing triggers.
[12:50:24.625] INFO: Resuming triggers.
[12:50:30.525] INFO: run duration 35 seconds, buffer almost full (81%), pausing triggers.
[12:51:00.744] INFO: Resuming triggers.
[12:51:06.647] INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[12:51:36.809] INFO: Resuming triggers.
[12:51:42.706] INFO: run duration 47 seconds, buffer almost full (81%), pausing triggers.
[12:52:12.919] INFO: Resuming triggers.
[12:52:18.818] INFO: run duration 52 seconds, buffer almost full (81%), pausing triggers.
[12:52:49.067] INFO: Resuming triggers.
[12:52:54.964] INFO: run duration 58 seconds, buffer almost full (81%), pausing triggers.
[12:53:24.757] INFO: Resuming triggers.
[12:53:30.653] INFO: run duration 64 seconds, buffer almost full (81%), pausing triggers.
[12:54:00.937] INFO: Resuming triggers.
[12:54:06.835] INFO: run duration 70 seconds, buffer almost full (81%), pausing triggers.
[12:54:37.054] INFO: Resuming triggers.
[12:54:42.950] INFO: run duration 76 seconds, buffer almost full (81%), pausing triggers.
[12:55:13.253] INFO: Resuming triggers.
[12:55:19.151] INFO: run duration 82 seconds, buffer almost full (81%), pausing triggers.
[12:55:49.389] INFO: Resuming triggers.
[12:55:55.287] INFO: run duration 88 seconds, buffer almost full (81%), pausing triggers.
[12:56:25.472] INFO: Resuming triggers.
[12:56:31.369] INFO: run duration 94 seconds, buffer almost full (81%), pausing triggers.
[12:57:01.576] INFO: Resuming triggers.
[12:57:07.475] INFO: run duration 99 seconds, buffer almost full (81%), pausing triggers.
[12:57:37.672] INFO: Resuming triggers.
[12:57:37.722] INFO: data taking finished, elapsed time: 100 seconds.
[12:57:38.488] INFO: PixTest:: pg_setup set to default.
[12:57:38.491] INFO: PixTestXray::doPhRun() done
[12:57:38.645] INFO: enter test to run
[12:59:07.087] INFO: test: HighRate no parameter change
[12:59:07.087] INFO: running: highrate
[12:59:07.088] INFO: ----------------------------------------------------------------------
[12:59:07.088] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[12:59:07.089] INFO: ----------------------------------------------------------------------
[12:59:07.230] INFO: Expecting 768 events.
[12:59:08.363] INFO: 768 events read in total (418ms).
[12:59:08.363] INFO: Test took 1268ms.
[12:59:08.368] INFO: ROC 0 masking pixel 1/5
[12:59:08.368] INFO: ROC 0 masking pixel 1/6
[12:59:08.368] INFO: ROC 0 masking pixel 1/7
[12:59:08.368] INFO: ROC 0 masking pixel 1/8
[12:59:08.368] INFO: ROC 0 masking pixel 2/2
[12:59:08.368] INFO: ROC 0 masking pixel 2/3
[12:59:08.368] INFO: ROC 0 masking pixel 2/4
[12:59:08.368] INFO: ROC 0 masking pixel 2/5
[12:59:08.368] INFO: ROC 0 masking pixel 2/6
[12:59:08.368] INFO: ROC 0 masking pixel 2/26
[12:59:08.368] INFO: ROC 0 masking pixel 5/39
[12:59:08.368] INFO: ROC 0 masking pixel 5/43
[12:59:08.368] INFO: ROC 0 masking pixel 12/28
[12:59:08.368] INFO: ROC 0 masking pixel 14/35
[12:59:08.368] INFO: ROC 0 masking pixel 15/36
[12:59:08.368] INFO: ROC 0 masking pixel 15/37
[12:59:08.368] INFO: ROC 0 masking pixel 29/20
[12:59:08.368] INFO: ROC 0 masking pixel 32/20
[12:59:08.368] INFO: ROC 2 masking pixel 34/41
[12:59:08.369] INFO: ROC 2 masking pixel 35/60
[12:59:08.369] INFO: ROC 2 masking pixel 36/62
[12:59:08.369] INFO: ROC 2 masking pixel 38/43
[12:59:08.369] INFO: ROC 2 masking pixel 39/41
[12:59:08.369] INFO: ROC 2 masking pixel 46/43
[12:59:08.369] INFO: ROC 3 masking pixel 2/62
[12:59:08.369] INFO: ROC 3 masking pixel 3/22
[12:59:08.369] INFO: ROC 3 masking pixel 5/62
[12:59:08.369] INFO: ROC 3 masking pixel 9/60
[12:59:08.369] INFO: ROC 3 masking pixel 10/45
[12:59:08.369] INFO: ROC 3 masking pixel 13/50
[12:59:08.369] INFO: ROC 3 masking pixel 16/62
[12:59:08.369] INFO: ROC 3 masking pixel 19/24
[12:59:08.369] INFO: ROC 3 masking pixel 19/62
[12:59:08.369] INFO: ROC 3 masking pixel 26/18
[12:59:08.369] INFO: ROC 3 masking pixel 27/58
[12:59:08.369] INFO: ROC 3 masking pixel 28/25
[12:59:08.369] INFO: ROC 3 masking pixel 29/56
[12:59:08.369] INFO: ROC 3 masking pixel 31/18
[12:59:08.369] INFO: ROC 3 masking pixel 33/15
[12:59:08.369] INFO: ROC 3 masking pixel 40/22
[12:59:08.369] INFO: ROC 3 masking pixel 40/35
[12:59:08.369] INFO: ROC 3 masking pixel 44/33
[12:59:08.369] INFO: ROC 4 masking pixel 4/62
[12:59:08.369] INFO: ROC 4 masking pixel 12/40
[12:59:08.369] INFO: ROC 4 masking pixel 31/17
[12:59:08.369] INFO: ROC 4 masking pixel 41/41
[12:59:08.369] INFO: ROC 4 masking pixel 46/24
[12:59:08.369] INFO: ROC 4 masking pixel 49/24
[12:59:08.369] INFO: ROC 5 masking pixel 9/24
[12:59:08.369] INFO: ROC 5 masking pixel 9/58
[12:59:08.369] INFO: ROC 5 masking pixel 46/54
[12:59:08.370] INFO: ROC 5 masking pixel 49/24
[12:59:08.370] INFO: ROC 5 masking pixel 50/52
[12:59:08.370] INFO: ROC 6 masking pixel 3/58
[12:59:08.370] INFO: ROC 6 masking pixel 9/54
[12:59:08.370] INFO: ROC 6 masking pixel 10/18
[12:59:08.370] INFO: ROC 6 masking pixel 20/58
[12:59:08.370] INFO: ROC 6 masking pixel 23/49
[12:59:08.370] INFO: ROC 6 masking pixel 23/58
[12:59:08.370] INFO: ROC 6 masking pixel 37/49
[12:59:08.370] INFO: ROC 6 masking pixel 44/26
[12:59:09.166] INFO: Expecting 41600 events.
[12:59:12.323] INFO: 41600 events read in total (2630ms).
[12:59:12.324] INFO: Test took 3951ms.
[12:59:12.363] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:59:13.083] INFO: Expecting 41600 events.
[12:59:16.320] INFO: 41600 events read in total (2711ms).
[12:59:16.321] INFO: Test took 3936ms.
[12:59:16.361] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:59:17.077] INFO: Expecting 41600 events.
[12:59:20.365] INFO: 41600 events read in total (2761ms).
[12:59:20.366] INFO: Test took 3985ms.
[12:59:20.406] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:59:21.120] INFO: Expecting 41600 events.
[12:59:24.442] INFO: 41600 events read in total (2795ms).
[12:59:24.443] INFO: Test took 4017ms.
[12:59:24.483] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:59:25.192] INFO: Expecting 41600 events.
[12:59:28.502] INFO: 41600 events read in total (2783ms).
[12:59:28.503] INFO: Test took 3999ms.
[12:59:28.543] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:59:29.257] INFO: Expecting 41600 events.
[12:59:32.568] INFO: 41600 events read in total (2784ms).
[12:59:32.569] INFO: Test took 4006ms.
[12:59:32.608] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:59:33.322] INFO: Expecting 41600 events.
[12:59:36.635] INFO: 41600 events read in total (2786ms).
[12:59:36.636] INFO: Test took 4007ms.
[12:59:36.676] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:59:37.388] INFO: Expecting 41600 events.
[12:59:40.695] INFO: 41600 events read in total (2780ms).
[12:59:40.696] INFO: Test took 3999ms.
[12:59:40.736] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:59:41.451] INFO: Expecting 41600 events.
[12:59:44.771] INFO: 41600 events read in total (2793ms).
[12:59:44.772] INFO: Test took 4016ms.
[12:59:44.811] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:59:45.525] INFO: Expecting 41600 events.
[12:59:48.841] INFO: 41600 events read in total (2789ms).
[12:59:48.842] INFO: Test took 4011ms.
[12:59:48.883] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:59:49.593] INFO: Expecting 41600 events.
[12:59:52.901] INFO: 41600 events read in total (2781ms).
[12:59:52.902] INFO: Test took 3998ms.
[12:59:52.943] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:59:53.655] INFO: Expecting 41600 events.
[12:59:56.986] INFO: 41600 events read in total (2804ms).
[12:59:56.987] INFO: Test took 4024ms.
[12:59:57.028] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:59:57.739] INFO: Expecting 41600 events.
[13:00:01.055] INFO: 41600 events read in total (2790ms).
[13:00:01.056] INFO: Test took 4008ms.
[13:00:01.096] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:00:01.806] INFO: Expecting 41600 events.
[13:00:05.115] INFO: 41600 events read in total (2782ms).
[13:00:05.116] INFO: Test took 4000ms.
[13:00:05.156] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:00:05.869] INFO: Expecting 41600 events.
[13:00:09.178] INFO: 41600 events read in total (2782ms).
[13:00:09.179] INFO: Test took 4004ms.
[13:00:09.219] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:00:09.929] INFO: Expecting 41600 events.
[13:00:13.248] INFO: 41600 events read in total (2792ms).
[13:00:13.249] INFO: Test took 4010ms.
[13:00:13.288] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:00:13.001] INFO: Expecting 41600 events.
[13:00:17.315] INFO: 41600 events read in total (2787ms).
[13:00:17.316] INFO: Test took 4008ms.
[13:00:17.356] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:00:18.068] INFO: Expecting 41600 events.
[13:00:21.374] INFO: 41600 events read in total (2779ms).
[13:00:21.375] INFO: Test took 3997ms.
[13:00:21.415] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:00:22.130] INFO: Expecting 41600 events.
[13:00:25.430] INFO: 41600 events read in total (2773ms).
[13:00:25.431] INFO: Test took 3995ms.
[13:00:25.472] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:00:26.186] INFO: Expecting 41600 events.
[13:00:29.327] INFO: 41600 events read in total (2614ms).
[13:00:29.328] INFO: Test took 3837ms.
[13:00:29.367] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:00:29.720] INFO: enter test to run
[13:00:50.607] INFO: test: HighRate no parameter change
[13:00:50.607] INFO: running: highrate
[13:00:50.608] INFO: ----------------------------------------------------------------------
[13:00:50.608] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:00:50.608] INFO: ----------------------------------------------------------------------
[13:00:50.616] INFO: ROC 0 masking pixel 1/5
[13:00:50.616] INFO: ROC 0 masking pixel 1/6
[13:00:50.616] INFO: ROC 0 masking pixel 1/7
[13:00:50.616] INFO: ROC 0 masking pixel 1/8
[13:00:50.616] INFO: ROC 0 masking pixel 2/2
[13:00:50.616] INFO: ROC 0 masking pixel 2/3
[13:00:50.616] INFO: ROC 0 masking pixel 2/4
[13:00:50.616] INFO: ROC 0 masking pixel 2/5
[13:00:50.616] INFO: ROC 0 masking pixel 2/6
[13:00:50.616] INFO: ROC 0 masking pixel 2/26
[13:00:50.617] INFO: ROC 0 masking pixel 5/39
[13:00:50.617] INFO: ROC 0 masking pixel 5/43
[13:00:50.617] INFO: ROC 0 masking pixel 12/28
[13:00:50.617] INFO: ROC 0 masking pixel 14/35
[13:00:50.617] INFO: ROC 0 masking pixel 15/36
[13:00:50.617] INFO: ROC 0 masking pixel 15/37
[13:00:50.617] INFO: ROC 0 masking pixel 29/20
[13:00:50.617] INFO: ROC 0 masking pixel 32/20
[13:00:50.617] INFO: ROC 2 masking pixel 34/41
[13:00:50.617] INFO: ROC 2 masking pixel 35/60
[13:00:50.617] INFO: ROC 2 masking pixel 36/62
[13:00:50.617] INFO: ROC 2 masking pixel 38/43
[13:00:50.617] INFO: ROC 2 masking pixel 39/41
[13:00:50.617] INFO: ROC 2 masking pixel 46/43
[13:00:50.617] INFO: ROC 3 masking pixel 2/62
[13:00:50.617] INFO: ROC 3 masking pixel 3/22
[13:00:50.617] INFO: ROC 3 masking pixel 5/62
[13:00:50.617] INFO: ROC 3 masking pixel 9/60
[13:00:50.617] INFO: ROC 3 masking pixel 10/45
[13:00:50.617] INFO: ROC 3 masking pixel 13/50
[13:00:50.617] INFO: ROC 3 masking pixel 16/62
[13:00:50.617] INFO: ROC 3 masking pixel 19/24
[13:00:50.617] INFO: ROC 3 masking pixel 19/62
[13:00:50.617] INFO: ROC 3 masking pixel 26/18
[13:00:50.617] INFO: ROC 3 masking pixel 27/58
[13:00:50.617] INFO: ROC 3 masking pixel 28/25
[13:00:50.617] INFO: ROC 3 masking pixel 29/56
[13:00:50.617] INFO: ROC 3 masking pixel 31/18
[13:00:50.617] INFO: ROC 3 masking pixel 33/15
[13:00:50.617] INFO: ROC 3 masking pixel 40/22
[13:00:50.617] INFO: ROC 3 masking pixel 40/35
[13:00:50.617] INFO: ROC 3 masking pixel 44/33
[13:00:50.617] INFO: ROC 4 masking pixel 4/62
[13:00:50.617] INFO: ROC 4 masking pixel 12/40
[13:00:50.617] INFO: ROC 4 masking pixel 31/17
[13:00:50.617] INFO: ROC 4 masking pixel 41/41
[13:00:50.617] INFO: ROC 4 masking pixel 46/24
[13:00:50.618] INFO: ROC 4 masking pixel 49/24
[13:00:50.618] INFO: ROC 5 masking pixel 9/24
[13:00:50.618] INFO: ROC 5 masking pixel 9/58
[13:00:50.618] INFO: ROC 5 masking pixel 46/54
[13:00:50.618] INFO: ROC 5 masking pixel 49/24
[13:00:50.618] INFO: ROC 5 masking pixel 50/52
[13:00:50.618] INFO: ROC 6 masking pixel 3/58
[13:00:50.618] INFO: ROC 6 masking pixel 9/54
[13:00:50.618] INFO: ROC 6 masking pixel 10/18
[13:00:50.618] INFO: ROC 6 masking pixel 20/58
[13:00:50.618] INFO: ROC 6 masking pixel 23/49
[13:00:50.618] INFO: ROC 6 masking pixel 23/58
[13:00:50.618] INFO: ROC 6 masking pixel 37/49
[13:00:50.618] INFO: ROC 6 masking pixel 44/26
[13:00:51.222] INFO: Expecting 208000 events.
[13:01:03.464] INFO: 208000 events read in total (11716ms).
[13:01:03.468] INFO: Test took 12850ms.
[13:01:03.648] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:01:03.911] INFO: number of dead pixels (per ROC): 18 0 6 18 6 5 8 0 0 0 0 1 0 0 0 0
[13:01:03.911] INFO: number of red-efficiency pixels: 125 65 127 204 196 181 195 122 146 171 115 105 125 78 28 28
[13:01:03.911] INFO: number of X-ray hits detected: 82846 54565 86319 139590 141685 139729 145402 110686 92728 116199 112555 97650 101962 61583 26760 28651
[13:01:03.911] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:01:03.911] INFO: number of Vcal hits detected: 206993 207935 207575 206907 207505 207569 207405 207877 207853 207825 207882 207844 207873 207921 207972 207972
[13:01:03.911] INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 100.0 99.9 100.0 100.0 100.0
[13:01:03.911] INFO: Vcal hit overall efficiency (%): 99.5 100.0 99.8 99.5 99.8 99.8 99.7 99.9 99.9 99.9 99.9 99.9 99.9 100.0 100.0 100.0
[13:01:03.911] INFO: X-ray hit rate [MHz/cm2]: 24.3 16.0 25.3 40.9 41.5 41.0 42.6 32.4 27.2 34.1 33.0 28.6 29.9 18.1 7.8 8.4
[13:01:03.911] INFO: PixTestHighRate::doXPixelAlive() done
[13:01:03.956] INFO: PixTest:: pg_setup set to default.
[13:01:03.971] INFO: enter test to run
[13:02:26.094] INFO: test: HighRate no parameter change
[13:02:26.094] INFO: running: highrate
[13:02:26.095] INFO: ----------------------------------------------------------------------
[13:02:26.095] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:02:26.095] INFO: ----------------------------------------------------------------------
[13:02:26.103] INFO: ROC 0 masking pixel 1/5
[13:02:26.103] INFO: ROC 0 masking pixel 1/6
[13:02:26.103] INFO: ROC 0 masking pixel 1/7
[13:02:26.103] INFO: ROC 0 masking pixel 1/8
[13:02:26.104] INFO: ROC 0 masking pixel 2/2
[13:02:26.104] INFO: ROC 0 masking pixel 2/3
[13:02:26.104] INFO: ROC 0 masking pixel 2/4
[13:02:26.104] INFO: ROC 0 masking pixel 2/5
[13:02:26.104] INFO: ROC 0 masking pixel 2/6
[13:02:26.104] INFO: ROC 0 masking pixel 2/26
[13:02:26.104] INFO: ROC 0 masking pixel 5/39
[13:02:26.104] INFO: ROC 0 masking pixel 5/43
[13:02:26.104] INFO: ROC 0 masking pixel 12/28
[13:02:26.104] INFO: ROC 0 masking pixel 14/35
[13:02:26.104] INFO: ROC 0 masking pixel 15/36
[13:02:26.104] INFO: ROC 0 masking pixel 15/37
[13:02:26.104] INFO: ROC 0 masking pixel 29/20
[13:02:26.104] INFO: ROC 0 masking pixel 32/20
[13:02:26.104] INFO: ROC 2 masking pixel 34/41
[13:02:26.104] INFO: ROC 2 masking pixel 35/60
[13:02:26.104] INFO: ROC 2 masking pixel 36/62
[13:02:26.104] INFO: ROC 2 masking pixel 38/43
[13:02:26.104] INFO: ROC 2 masking pixel 39/41
[13:02:26.104] INFO: ROC 2 masking pixel 46/43
[13:02:26.104] INFO: ROC 3 masking pixel 2/62
[13:02:26.104] INFO: ROC 3 masking pixel 3/22
[13:02:26.104] INFO: ROC 3 masking pixel 5/62
[13:02:26.104] INFO: ROC 3 masking pixel 9/60
[13:02:26.104] INFO: ROC 3 masking pixel 10/45
[13:02:26.104] INFO: ROC 3 masking pixel 13/50
[13:02:26.104] INFO: ROC 3 masking pixel 16/62
[13:02:26.104] INFO: ROC 3 masking pixel 19/24
[13:02:26.104] INFO: ROC 3 masking pixel 19/62
[13:02:26.104] INFO: ROC 3 masking pixel 26/18
[13:02:26.104] INFO: ROC 3 masking pixel 27/58
[13:02:26.104] INFO: ROC 3 masking pixel 28/25
[13:02:26.104] INFO: ROC 3 masking pixel 29/56
[13:02:26.104] INFO: ROC 3 masking pixel 31/18
[13:02:26.105] INFO: ROC 3 masking pixel 33/15
[13:02:26.105] INFO: ROC 3 masking pixel 40/22
[13:02:26.105] INFO: ROC 3 masking pixel 40/35
[13:02:26.105] INFO: ROC 3 masking pixel 44/33
[13:02:26.105] INFO: ROC 4 masking pixel 4/62
[13:02:26.105] INFO: ROC 4 masking pixel 12/40
[13:02:26.105] INFO: ROC 4 masking pixel 31/17
[13:02:26.105] INFO: ROC 4 masking pixel 41/41
[13:02:26.105] INFO: ROC 4 masking pixel 46/24
[13:02:26.105] INFO: ROC 4 masking pixel 49/24
[13:02:26.105] INFO: ROC 5 masking pixel 9/24
[13:02:26.105] INFO: ROC 5 masking pixel 9/58
[13:02:26.105] INFO: ROC 5 masking pixel 46/54
[13:02:26.105] INFO: ROC 5 masking pixel 49/24
[13:02:26.105] INFO: ROC 5 masking pixel 50/52
[13:02:26.105] INFO: ROC 6 masking pixel 3/58
[13:02:26.105] INFO: ROC 6 masking pixel 9/54
[13:02:26.105] INFO: ROC 6 masking pixel 10/18
[13:02:26.105] INFO: ROC 6 masking pixel 20/58
[13:02:26.105] INFO: ROC 6 masking pixel 23/49
[13:02:26.105] INFO: ROC 6 masking pixel 23/58
[13:02:26.105] INFO: ROC 6 masking pixel 37/49
[13:02:26.105] INFO: ROC 6 masking pixel 44/26
[13:02:26.714] INFO: Expecting 208000 events.
[13:02:41.068] INFO: 208000 events read in total (13827ms).
[13:02:41.075] INFO: Test took 14969ms.
[13:02:41.449] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:02:41.769] INFO: number of dead pixels (per ROC): 18 0 6 18 6 5 8 0 0 0 0 1 0 0 0 0
[13:02:41.769] INFO: number of red-efficiency pixels: 360 177 472 626 631 588 605 443 351 577 386 272 435 285 82 64
[13:02:41.769] INFO: number of X-ray hits detected: 166987 110217 174513 281013 286285 282204 293536 223057 187742 232988 225839 196679 206012 123763 54922 57951
[13:02:41.769] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:02:41.769] INFO: number of Vcal hits detected: 206720 207814 207146 206415 206998 207102 206914 207521 207624 207370 207590 207666 207526 207696 207912 207935
[13:02:41.769] INFO: Vcal hit fiducial efficiency (%): 99.8 99.9 99.8 99.7 99.7 99.7 99.7 99.8 99.8 99.7 99.8 99.9 99.8 99.9 100.0 100.0
[13:02:41.769] INFO: Vcal hit overall efficiency (%): 99.4 99.9 99.6 99.2 99.5 99.6 99.5 99.8 99.8 99.7 99.8 99.8 99.8 99.9 100.0 100.0
[13:02:41.769] INFO: X-ray hit rate [MHz/cm2]: 48.9 32.3 51.2 82.4 83.9 82.7 86.0 65.4 55.0 68.3 66.2 57.6 60.4 36.3 16.1 17.0
[13:02:41.769] INFO: PixTestHighRate::doXPixelAlive() done
[13:02:41.822] INFO: PixTest:: pg_setup set to default.
[13:02:41.835] INFO: enter test to run
[13:03:24.174] INFO: test: HighRate no parameter change
[13:03:24.174] INFO: running: highrate
[13:03:24.175] INFO: ----------------------------------------------------------------------
[13:03:24.175] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:03:24.175] INFO: ----------------------------------------------------------------------
[13:03:24.184] INFO: ROC 0 masking pixel 1/5
[13:03:24.185] INFO: ROC 0 masking pixel 1/6
[13:03:24.185] INFO: ROC 0 masking pixel 1/7
[13:03:24.185] INFO: ROC 0 masking pixel 1/8
[13:03:24.185] INFO: ROC 0 masking pixel 2/2
[13:03:24.185] INFO: ROC 0 masking pixel 2/3
[13:03:24.185] INFO: ROC 0 masking pixel 2/4
[13:03:24.185] INFO: ROC 0 masking pixel 2/5
[13:03:24.185] INFO: ROC 0 masking pixel 2/6
[13:03:24.185] INFO: ROC 0 masking pixel 2/26
[13:03:24.185] INFO: ROC 0 masking pixel 5/39
[13:03:24.185] INFO: ROC 0 masking pixel 5/43
[13:03:24.185] INFO: ROC 0 masking pixel 12/28
[13:03:24.185] INFO: ROC 0 masking pixel 14/35
[13:03:24.185] INFO: ROC 0 masking pixel 15/36
[13:03:24.185] INFO: ROC 0 masking pixel 15/37
[13:03:24.185] INFO: ROC 0 masking pixel 29/20
[13:03:24.185] INFO: ROC 0 masking pixel 32/20
[13:03:24.185] INFO: ROC 2 masking pixel 34/41
[13:03:24.185] INFO: ROC 2 masking pixel 35/60
[13:03:24.185] INFO: ROC 2 masking pixel 36/62
[13:03:24.185] INFO: ROC 2 masking pixel 38/43
[13:03:24.185] INFO: ROC 2 masking pixel 39/41
[13:03:24.185] INFO: ROC 2 masking pixel 46/43
[13:03:24.185] INFO: ROC 3 masking pixel 2/62
[13:03:24.185] INFO: ROC 3 masking pixel 3/22
[13:03:24.185] INFO: ROC 3 masking pixel 5/62
[13:03:24.185] INFO: ROC 3 masking pixel 9/60
[13:03:24.185] INFO: ROC 3 masking pixel 10/45
[13:03:24.185] INFO: ROC 3 masking pixel 13/50
[13:03:24.185] INFO: ROC 3 masking pixel 16/62
[13:03:24.185] INFO: ROC 3 masking pixel 19/24
[13:03:24.185] INFO: ROC 3 masking pixel 19/62
[13:03:24.185] INFO: ROC 3 masking pixel 26/18
[13:03:24.185] INFO: ROC 3 masking pixel 27/58
[13:03:24.185] INFO: ROC 3 masking pixel 28/25
[13:03:24.185] INFO: ROC 3 masking pixel 29/56
[13:03:24.186] INFO: ROC 3 masking pixel 31/18
[13:03:24.186] INFO: ROC 3 masking pixel 33/15
[13:03:24.186] INFO: ROC 3 masking pixel 40/22
[13:03:24.186] INFO: ROC 3 masking pixel 40/35
[13:03:24.186] INFO: ROC 3 masking pixel 44/33
[13:03:24.186] INFO: ROC 4 masking pixel 4/62
[13:03:24.186] INFO: ROC 4 masking pixel 12/40
[13:03:24.186] INFO: ROC 4 masking pixel 31/17
[13:03:24.186] INFO: ROC 4 masking pixel 41/41
[13:03:24.186] INFO: ROC 4 masking pixel 46/24
[13:03:24.186] INFO: ROC 4 masking pixel 49/24
[13:03:24.186] INFO: ROC 5 masking pixel 9/24
[13:03:24.186] INFO: ROC 5 masking pixel 9/58
[13:03:24.186] INFO: ROC 5 masking pixel 46/54
[13:03:24.186] INFO: ROC 5 masking pixel 49/24
[13:03:24.186] INFO: ROC 5 masking pixel 50/52
[13:03:24.186] INFO: ROC 6 masking pixel 3/58
[13:03:24.186] INFO: ROC 6 masking pixel 9/54
[13:03:24.186] INFO: ROC 6 masking pixel 10/18
[13:03:24.186] INFO: ROC 6 masking pixel 20/58
[13:03:24.186] INFO: ROC 6 masking pixel 23/49
[13:03:24.186] INFO: ROC 6 masking pixel 23/58
[13:03:24.186] INFO: ROC 6 masking pixel 37/49
[13:03:24.186] INFO: ROC 6 masking pixel 44/26
[13:03:24.795] INFO: Expecting 208000 events.
[13:03:41.646] INFO: 208000 events read in total (16324ms).
[13:03:41.655] INFO: Test took 17468ms.
[13:03:42.216] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:03:42.595] INFO: number of dead pixels (per ROC): 18 0 6 18 6 5 8 0 0 0 0 1 0 0 0 0
[13:03:42.595] INFO: number of red-efficiency pixels: 835 425 1007 1504 1592 1477 1621 999 861 1388 952 687 1013 584 165 130
[13:03:42.595] INFO: number of X-ray hits detected: 257526 170203 268813 433609 440569 434231 452376 345006 289729 360773 348354 302824 316872 191429 84757 89900
[13:03:42.595] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:03:42.595] INFO: number of Vcal hits detected: 206037 207515 205981 205058 205423 205688 205328 206695 206976 206142 206838 207141 206740 207257 207820 207870
[13:03:42.595] INFO: Vcal hit fiducial efficiency (%): 99.5 99.8 99.3 99.1 99.0 99.1 99.0 99.4 99.5 99.2 99.5 99.7 99.5 99.7 99.9 99.9
[13:03:42.595] INFO: Vcal hit overall efficiency (%): 99.1 99.8 99.0 98.6 98.8 98.9 98.7 99.4 99.5 99.1 99.4 99.6 99.4 99.6 99.9 99.9
[13:03:42.595] INFO: X-ray hit rate [MHz/cm2]: 75.5 49.9 78.8 127.1 129.1 127.3 132.6 101.1 84.9 105.7 102.1 88.8 92.9 56.1 24.8 26.4
[13:03:42.595] INFO: PixTestHighRate::doXPixelAlive() done
[13:03:42.644] INFO: PixTest:: pg_setup set to default.
[13:03:42.661] INFO: enter test to run
[13:04:55.629] INFO: test: exit no parameter change
[13:04:55.956] QUIET: Connection to board 32 closed.
[13:04:55.957] INFO: pXar: this is the end, my friend