Stakeholder tests for Python 3.10

Build: #6 failed

Job: Test VLASS 1.2 Stakeholder Tests cvpost EL8 was successful

Build log

The build generated 25,115 lines of output.The output is too long and has been truncated to the last 1,000 lines. Download or view full build log.

02-Oct-2024 04:42:09 2024-10-02 04:42:07        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] iters=0->30 [30], model=0.854986->0.926635, peakres=0.0741437->0.0218074, Reached cyclethreshold.
02-Oct-2024 04:42:09 2024-10-02 04:42:07        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 58 iterations.
02-Oct-2024 04:46:40 2024-10-02 04:42:10        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 3 -------------------------------------
02-Oct-2024 04:46:40
02-Oct-2024 04:46:40 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 04:46:40 2024-10-02 04:42:55        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 1.31s ( user 1.97s, system 0.42s)
02-Oct-2024 04:46:40 2024-10-02 04:42:55        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.000806466
02-Oct-2024 04:46:40 2024-10-02 04:42:55        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.0239313, over full image : 0.0239313
02-Oct-2024 04:46:40 2024-10-02 04:42:55        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 500, 'cyclethreshold': 0.0070470948703587055, 'loopgain': 0.10000000149011612, 'nsigma': 4.5, 'thresholdreached': False}
02-Oct-2024 04:46:40 2024-10-02 04:42:55        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] Run mtmfs minor-cycle | CycleThreshold=0.00704709, CycleNiter=500, Gain=0.1
02-Oct-2024 04:46:40 2024-10-02 04:42:57        INFO        SIImageStoreMultiTerm::calcFractionalBandwidth         MFS frequency range : 1.96387 GHz -> 4.03613GHz.Fractional Bandwidth : 69.0755 %.Reference Frequency for Taylor Expansion : 3GHz.
02-Oct-2024 04:46:40 2024-10-02 04:42:57        INFO        SDAlgorithmBase::deconvolve         Using cyclethreshold for threshold criterion: (cyclethreshold=0.00704709, nsigma threshold=0.000806466 )
02-Oct-2024 04:46:40 2024-10-02 04:42:58        INFO        MultiTermMatrixCleaner::mtclean()         Calculating convolutions of residual images with scales
02-Oct-2024 04:46:40 2024-10-02 04:43:00        INFO        MultiTermMatrixCleaner::mtclean()         Peak convolved residual (within mask)  : 0.0239313
02-Oct-2024 04:46:40 2024-10-02 04:43:02        INFO                [60] Res: 0.0220154 Max: 0.000604278 Gain: 0.1 Pos: [3645, 3644] Scale: 0 Coeffs: 0.0227763  0.0476486 
02-Oct-2024 04:46:40 2024-10-02 04:43:07        INFO                [80] Res: 0.0152443 Max: 0.000267204 Gain: 0.1 Pos: [3645, 3646] Scale: 0 Coeffs: -0.0160666  -0.0147966 
02-Oct-2024 04:46:40 2024-10-02 04:43:12        INFO                [100] Res: 0.0124798 Max: 0.000167926 Gain: 0.1 Pos: [3645, 3645] Scale: 0 Coeffs: 0.0103061  0.0412562 
02-Oct-2024 04:46:40 2024-10-02 04:43:18        INFO                [120] Res: 0.0106515 Max: 0.000114259 Gain: 0.1 Pos: [3645, 3645] Scale: 0 Coeffs: 0.00829378  0.0354628 
02-Oct-2024 04:46:40 2024-10-02 04:43:23        INFO                [140] Res: 0.00893975 Max: 9.03916e-05 Gain: 0.1 Pos: [3645, 3644] Scale: 0 Coeffs: 0.00935329  0.00835745 
02-Oct-2024 04:46:40 2024-10-02 04:43:28        INFO                [160] Res: 0.00803246 Max: 6.86447e-05 Gain: 0.1 Pos: [3645, 3645] Scale: 0 Coeffs: 0.0068475  0.0244331 
02-Oct-2024 04:46:40 2024-10-02 04:43:33        INFO                [180] Res: 0.00719884 Max: 5.52618e-05 Gain: 0.1 Pos: [3646, 3645] Scale: 0 Coeffs: -0.00736919  -0.00463526 
02-Oct-2024 04:46:40 2024-10-02 04:43:36        INFO        MultiTermMatrixCleaner::mtclean()         Reached stopping threshold at iteration 189. Peak residual 0.00675958 (within mask)
02-Oct-2024 04:46:40 2024-10-02 04:43:36        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by scale :  [0]: 0.923363 (in this run)
02-Oct-2024 04:46:40 2024-10-02 04:43:36        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by Taylor coefficient :  [0]: 0.923363  [1]: 0.355127
02-Oct-2024 04:46:40 2024-10-02 04:43:42        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] iters=0->131 [131], model=0.926635->0.923363, peakres=0.0239313->0.00677737, Reached cyclethreshold.
02-Oct-2024 04:46:40 2024-10-02 04:43:42        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 189 iterations.
02-Oct-2024 04:46:40 2024-10-02 04:43:45        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 4 -------------------------------------
02-Oct-2024 04:46:40
02-Oct-2024 04:46:40 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 04:46:40 2024-10-02 04:44:30        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 1.29s ( user 2.05s, system 0.32s)
02-Oct-2024 04:46:40 2024-10-02 04:44:30        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.000730612
02-Oct-2024 04:46:40 2024-10-02 04:44:30        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00756375, over full image : 0.00756375
02-Oct-2024 04:46:40 2024-10-02 04:44:30        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 500, 'cyclethreshold': 0.0022273105569183826, 'loopgain': 0.10000000149011612, 'nsigma': 4.5, 'thresholdreached': False}
02-Oct-2024 04:46:40 2024-10-02 04:44:30        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] Run mtmfs minor-cycle | CycleThreshold=0.00222731, CycleNiter=500, Gain=0.1
02-Oct-2024 04:46:40 2024-10-02 04:44:33        INFO        SIImageStoreMultiTerm::calcFractionalBandwidth         MFS frequency range : 1.96387 GHz -> 4.03613GHz.Fractional Bandwidth : 69.0755 %.Reference Frequency for Taylor Expansion : 3GHz.
02-Oct-2024 04:46:40 2024-10-02 04:44:33        INFO        SDAlgorithmBase::deconvolve         Using cyclethreshold for threshold criterion: (cyclethreshold=0.00222731, nsigma threshold=0.000730612 )
02-Oct-2024 04:46:40 2024-10-02 04:44:34        INFO        MultiTermMatrixCleaner::mtclean()         Calculating convolutions of residual images with scales
02-Oct-2024 04:46:40 2024-10-02 04:44:35        INFO        MultiTermMatrixCleaner::mtclean()         Peak convolved residual (within mask)  : 0.00756375
02-Oct-2024 04:46:40 2024-10-02 04:44:39        INFO                [200] Res: 0.00692556 Max: 5.4078e-05 Gain: 0.1 Pos: [3646, 3645] Scale: 0 Coeffs: -0.0070509  -0.010601 
02-Oct-2024 04:46:40 2024-10-02 04:44:45        INFO                [220] Res: 0.00652957 Max: 4.24249e-05 Gain: 0.1 Pos: [3645, 3646] Scale: 0 Coeffs: -0.0060759  -0.0120678 
02-Oct-2024 04:46:40 2024-10-02 04:44:50        INFO                [240] Res: 0.00574906 Max: 3.57248e-05 Gain: 0.1 Pos: [3644, 3645] Scale: 0 Coeffs: 0.00597682  6.24523e-05 
02-Oct-2024 04:46:40 2024-10-02 04:44:55        INFO                [260] Res: 0.00533181 Max: 3.18528e-05 Gain: 0.1 Pos: [3647, 3645] Scale: 0 Coeffs: 0.00553254  0.00551381 
02-Oct-2024 04:46:40 2024-10-02 04:45:01        INFO                [280] Res: 0.0048892 Max: 2.49949e-05 Gain: 0.1 Pos: [3647, 3645] Scale: 0 Coeffs: 0.00486537  0.00575594 
02-Oct-2024 04:46:40 2024-10-02 04:45:06        INFO                [300] Res: 0.00478579 Max: 2.32921e-05 Gain: 0.1 Pos: [3644, 3645] Scale: 0 Coeffs: 0.00480268  -0.00301658 
02-Oct-2024 04:46:40 2024-10-02 04:45:11        INFO                [320] Res: 0.00433953 Max: 1.923e-05 Gain: 0.1 Pos: [3646, 3643] Scale: 0 Coeffs: 0.00252171  0.0190326 
02-Oct-2024 04:46:40 2024-10-02 04:45:16        INFO                [340] Res: 0.00399654 Max: 1.87541e-05 Gain: 0.1 Pos: [3646, 3647] Scale: 0 Coeffs: 0.00427473  0.0033608 
02-Oct-2024 04:46:40 2024-10-02 04:45:22        INFO                [360] Res: 0.00394524 Max: 1.5786e-05 Gain: 0.1 Pos: [3646, 3646] Scale: 0 Coeffs: -0.00387051  -0.00448378 
02-Oct-2024 04:46:40 2024-10-02 04:45:27        INFO                [380] Res: 0.00360442 Max: 1.41925e-05 Gain: 0.1 Pos: [3645, 3644] Scale: 0 Coeffs: 0.0037448  0.00189837 
02-Oct-2024 04:46:40 2024-10-02 04:45:32        INFO                [400] Res: 0.00342874 Max: 1.26256e-05 Gain: 0.1 Pos: [3646, 3648] Scale: 0 Coeffs: 0.000524976  -0.0189087 
02-Oct-2024 04:46:40 2024-10-02 04:45:37        INFO                [420] Res: 0.00331619 Max: 1.14498e-05 Gain: 0.1 Pos: [3646, 3643] Scale: 0 Coeffs: 0.00250686  0.0119774 
02-Oct-2024 04:46:40 2024-10-02 04:45:43        INFO                [440] Res: 0.00321676 Max: 1.07963e-05 Gain: 0.1 Pos: [3645, 3647] Scale: 0 Coeffs: 0.00201457  0.0137539 
02-Oct-2024 04:46:40 2024-10-02 04:45:48        INFO                [460] Res: 0.00315336 Max: 9.68227e-06 Gain: 0.1 Pos: [3645, 3644] Scale: 0 Coeffs: 0.00310364  0.000951694 
02-Oct-2024 04:46:40 2024-10-02 04:45:53        INFO                [480] Res: 0.00287609 Max: 8.66917e-06 Gain: 0.1 Pos: [3643, 3646] Scale: 0 Coeffs: 0.0027823  0.00492878 
02-Oct-2024 04:46:40 2024-10-02 04:45:59        INFO                [500] Res: 0.00275242 Max: 7.80452e-06 Gain: 0.1 Pos: [3643, 3645] Scale: 0 Coeffs: -0.00276952  -0.00173554 
02-Oct-2024 04:46:40 2024-10-02 04:46:04        INFO                [520] Res: 0.00267763 Max: 7.58953e-06 Gain: 0.1 Pos: [3641, 3645] Scale: 0 Coeffs: -0.0011119  -0.0134299 
02-Oct-2024 04:46:40 2024-10-02 04:46:09        INFO                [540] Res: 0.00256747 Max: 7.05097e-06 Gain: 0.1 Pos: [3646, 3645] Scale: 0 Coeffs: -0.00265551  5.09457e-05 
02-Oct-2024 04:46:40 2024-10-02 04:46:14        INFO                [560] Res: 0.00249001 Max: 6.59472e-06 Gain: 0.1 Pos: [3648, 3645] Scale: 0 Coeffs: -0.00155154  -0.010846 
02-Oct-2024 04:46:40 2024-10-02 04:46:20        INFO                [580] Res: 0.00239636 Max: 6.20993e-06 Gain: 0.1 Pos: [3643, 3645] Scale: 0 Coeffs: -0.00246959  -0.00158245 
02-Oct-2024 04:46:40 2024-10-02 04:46:25        INFO                [600] Res: 0.0023504 Max: 5.67445e-06 Gain: 0.1 Pos: [3646, 3643] Scale: 0 Coeffs: 0.00206812  0.00616324 
02-Oct-2024 04:46:40 2024-10-02 04:46:30        INFO                [620] Res: 0.00226521 Max: 5.30332e-06 Gain: 0.1 Pos: [3644, 3642] Scale: 0 Coeffs: 0.00106234  0.0108724 
02-Oct-2024 04:46:40 2024-10-02 04:46:34        INFO        MultiTermMatrixCleaner::mtclean()         Reached stopping threshold at iteration 636. Peak residual 0.00222714 (within mask)
02-Oct-2024 04:46:40 2024-10-02 04:46:34        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by scale :  [0]: 0.936178 (in this run)
02-Oct-2024 04:46:40 2024-10-02 04:46:34        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by Taylor coefficient :  [0]: 0.936178  [1]: 0.345159
02-Oct-2024 04:51:14 2024-10-02 04:46:41        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] iters=0->447 [447], model=0.923363->0.936178, peakres=0.00756375->0.00225911, Exited mtmfs minor cycle without reaching any stopping criterion.
02-Oct-2024 04:51:14 2024-10-02 04:46:41        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 636 iterations.
02-Oct-2024 04:51:14 2024-10-02 04:46:43        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 5 -------------------------------------
02-Oct-2024 04:51:14
02-Oct-2024 04:51:14 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 04:51:14 2024-10-02 04:47:28        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 1.3s ( user 1.98s, system 0.41s)
02-Oct-2024 04:51:14 2024-10-02 04:47:28        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.000694118
02-Oct-2024 04:51:14 2024-10-02 04:47:28        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00248784, over full image : 0.00248784
02-Oct-2024 04:51:14 2024-10-02 04:47:28        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 500, 'cyclethreshold': 0.000732598768081516, 'loopgain': 0.10000000149011612, 'nsigma': 4.5, 'thresholdreached': False}
02-Oct-2024 04:51:14 2024-10-02 04:47:28        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] Run mtmfs minor-cycle | CycleThreshold=0.000732599, CycleNiter=500, Gain=0.1
02-Oct-2024 04:51:14 2024-10-02 04:47:31        INFO        SIImageStoreMultiTerm::calcFractionalBandwidth         MFS frequency range : 1.96387 GHz -> 4.03613GHz.Fractional Bandwidth : 69.0755 %.Reference Frequency for Taylor Expansion : 3GHz.
02-Oct-2024 04:51:14 2024-10-02 04:47:31        INFO        SDAlgorithmBase::deconvolve         Using cyclethreshold for threshold criterion: (cyclethreshold=0.000732599, nsigma threshold=0.000694118 )
02-Oct-2024 04:51:14 2024-10-02 04:47:32        INFO        MultiTermMatrixCleaner::mtclean()         Calculating convolutions of residual images with scales
02-Oct-2024 04:51:14 2024-10-02 04:47:34        INFO        MultiTermMatrixCleaner::mtclean()         Peak convolved residual (within mask)  : 0.00248784
02-Oct-2024 04:51:14 2024-10-02 04:47:36        INFO                [640] Res: 0.0024555 Max: 7.01648e-06 Gain: 0.1 Pos: [3645, 3645] Scale: 0 Coeffs: 0.00215205  0.00809992 
02-Oct-2024 04:51:14 2024-10-02 04:47:41        INFO                [660] Res: 0.00229099 Max: 5.61294e-06 Gain: 0.1 Pos: [3645, 3645] Scale: 0 Coeffs: 0.00197282  0.00686764 
02-Oct-2024 04:51:14 2024-10-02 04:47:47        INFO                [680] Res: 0.00216237 Max: 5.15143e-06 Gain: 0.1 Pos: [3647, 3643] Scale: 0 Coeffs: -0.00225535  -0.00118025 
02-Oct-2024 04:51:14 2024-10-02 04:47:52        INFO                [700] Res: 0.00215165 Max: 4.75729e-06 Gain: 0.1 Pos: [3641, 3644] Scale: 0 Coeffs: -0.00068161  -0.0110599 
02-Oct-2024 04:51:14 2024-10-02 04:47:57        INFO                [720] Res: 0.00211176 Max: 4.52758e-06 Gain: 0.1 Pos: [3139, 3811] Scale: 0 Coeffs: 0.00205206  0.00284307 
02-Oct-2024 04:51:14 2024-10-02 04:48:03        INFO                [740] Res: 0.00206688 Max: 4.33836e-06 Gain: 0.1 Pos: [3646, 3646] Scale: 0 Coeffs: -0.00199477  -0.00304434 
02-Oct-2024 04:51:14 2024-10-02 04:48:08        INFO                [760] Res: 0.00200203 Max: 4.0823e-06 Gain: 0.1 Pos: [3643, 3643] Scale: 0 Coeffs: -0.00185792  -0.00409955 
02-Oct-2024 04:51:14 2024-10-02 04:48:13        INFO                [780] Res: 0.00198381 Max: 4.09171e-06 Gain: 0.1 Pos: [3643, 3645] Scale: 0 Coeffs: -0.00200715  -0.00118104 
02-Oct-2024 04:51:14 2024-10-02 04:48:18        INFO                [800] Res: 0.00192876 Max: 3.78799e-06 Gain: 0.1 Pos: [2985, 3862] Scale: 0 Coeffs: 0.00190915  0.00186778 
02-Oct-2024 04:51:14 2024-10-02 04:48:24        INFO                [820] Res: 0.00189311 Max: 3.67895e-06 Gain: 0.1 Pos: [3644, 3642] Scale: 0 Coeffs: 0.00107064  0.00844694 
02-Oct-2024 04:51:14 2024-10-02 04:48:29        INFO                [840] Res: 0.00186704 Max: 3.54953e-06 Gain: 0.1 Pos: [3116, 3819] Scale: 0 Coeffs: 0.00184367  0.00192403 
02-Oct-2024 04:51:14 2024-10-02 04:48:34        INFO                [860] Res: 0.00184658 Max: 3.45051e-06 Gain: 0.1 Pos: [3648, 3643] Scale: 0 Coeffs: 0.00158042  0.0051003 
02-Oct-2024 04:51:14 2024-10-02 04:48:39        INFO                [880] Res: 0.00180498 Max: 3.34079e-06 Gain: 0.1 Pos: [3114, 3820] Scale: 0 Coeffs: 0.00164821  0.00409628 
02-Oct-2024 04:51:14 2024-10-02 04:48:45        INFO                [900] Res: 0.00179523 Max: 3.35141e-06 Gain: 0.1 Pos: [3645, 3645] Scale: 0 Coeffs: 0.00153873  0.00518821 
02-Oct-2024 04:51:14 2024-10-02 04:48:50        INFO                [920] Res: 0.00174645 Max: 3.21425e-06 Gain: 0.1 Pos: [3647, 3645] Scale: 0 Coeffs: 0.00177081  0.00135423 
02-Oct-2024 04:51:14 2024-10-02 04:48:55        INFO                [940] Res: 0.00172683 Max: 3.02576e-06 Gain: 0.1 Pos: [2964, 3869] Scale: 0 Coeffs: 0.0017281  0.000923278 
02-Oct-2024 04:51:14 2024-10-02 04:49:00        INFO                [960] Res: 0.00170722 Max: 2.9636e-06 Gain: 0.1 Pos: [3134, 3813] Scale: 0 Coeffs: 0.00160392  0.00321658 
02-Oct-2024 04:51:14 2024-10-02 04:49:06        INFO                [980] Res: 0.00169121 Max: 2.96365e-06 Gain: 0.1 Pos: [3646, 3643] Scale: 0 Coeffs: 0.00158544  0.00346226 
02-Oct-2024 04:51:14 2024-10-02 04:49:11        INFO                [1000] Res: 0.00166279 Max: 2.81967e-06 Gain: 0.1 Pos: [3645, 3650] Scale: 0 Coeffs: -0.00124349  -0.00594705 
02-Oct-2024 04:51:14 2024-10-02 04:49:16        INFO                [1020] Res: 0.00163882 Max: 2.71885e-06 Gain: 0.1 Pos: [3641, 3647] Scale: 0 Coeffs: 0.000546702  0.00830096 
02-Oct-2024 04:51:14 2024-10-02 04:49:22        INFO                [1040] Res: 0.00161734 Max: 2.66593e-06 Gain: 0.1 Pos: [3046, 3842] Scale: 0 Coeffs: 0.0015515  0.00259581 
02-Oct-2024 04:51:14 2024-10-02 04:49:27        INFO                [1060] Res: 0.00160508 Max: 2.58195e-06 Gain: 0.1 Pos: [3150, 3808] Scale: 0 Coeffs: 0.00138827  0.0042209 
02-Oct-2024 04:51:14 2024-10-02 04:49:32        INFO                [1080] Res: 0.00157816 Max: 2.51986e-06 Gain: 0.1 Pos: [3039, 3844] Scale: 0 Coeffs: 0.00155998  0.00144428 
02-Oct-2024 04:51:14 2024-10-02 04:49:37        INFO                [1100] Res: 0.0015668 Max: 2.46207e-06 Gain: 0.1 Pos: [3012, 3853] Scale: 0 Coeffs: 0.00146689  0.00286217 
02-Oct-2024 04:51:14 2024-10-02 04:49:43        INFO                [1120] Res: 0.00153989 Max: 2.38478e-06 Gain: 0.1 Pos: [3170, 3801] Scale: 0 Coeffs: 0.00142328  0.003092 
02-Oct-2024 04:51:14 2024-10-02 04:49:47        INFO        MultiTermMatrixCleaner::mtclean()         Reached max number of iterations for this minor cycle
02-Oct-2024 04:51:14 2024-10-02 04:49:47        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by scale :  [0]: 0.962391 (in this run)
02-Oct-2024 04:51:14 2024-10-02 04:49:47        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by Taylor coefficient :  [0]: 0.96239  [1]: 0.368981
02-Oct-2024 04:51:14 2024-10-02 04:49:53        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] iters=0->500 [500], model=0.936178->0.96239, peakres=0.00248784->0.0017683, Reached cycleniter.
02-Oct-2024 04:51:14 2024-10-02 04:49:53        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 1136 iterations.
02-Oct-2024 04:51:14 2024-10-02 04:49:56        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 6 -------------------------------------
02-Oct-2024 04:51:14
02-Oct-2024 04:51:14 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 04:51:14 2024-10-02 04:50:41        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 1.28s ( user 1.93s, system 0.44s)
02-Oct-2024 04:51:14 2024-10-02 04:50:41        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.000687529
02-Oct-2024 04:51:14 2024-10-02 04:50:41        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00228588, over full image : 0.00228588
02-Oct-2024 04:51:14 2024-10-02 04:50:41        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 500, 'cyclethreshold': 0.0006731270696036518, 'loopgain': 0.10000000149011612, 'nsigma': 4.5, 'thresholdreached': False}
02-Oct-2024 04:51:14 2024-10-02 04:50:41        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] Run mtmfs minor-cycle | CycleThreshold=0.000673127, CycleNiter=500, Gain=0.1
02-Oct-2024 04:51:14 2024-10-02 04:50:44        INFO        SIImageStoreMultiTerm::calcFractionalBandwidth         MFS frequency range : 1.96387 GHz -> 4.03613GHz.Fractional Bandwidth : 69.0755 %.Reference Frequency for Taylor Expansion : 3GHz.
02-Oct-2024 04:51:14 2024-10-02 04:50:44        INFO        SDAlgorithmBase::deconvolve         Using n-sigma for threshold criterion: (cyclethreshold=0.000673127, nsigma threshold=0.000687529 )
02-Oct-2024 04:51:14 2024-10-02 04:50:45        INFO        MultiTermMatrixCleaner::mtclean()         Calculating convolutions of residual images with scales
02-Oct-2024 04:51:14 2024-10-02 04:50:46        INFO        MultiTermMatrixCleaner::mtclean()         Peak convolved residual (within mask)  : 0.00228588
02-Oct-2024 04:51:14 2024-10-02 04:50:49        INFO                [1140] Res: 0.00184605 Max: 3.954e-06 Gain: 0.1 Pos: [3647, 3643] Scale: 0 Coeffs: -0.00196434  -0.00149193 
02-Oct-2024 04:51:14 2024-10-02 04:50:54        INFO                [1160] Res: 0.00158321 Max: 2.54311e-06 Gain: 0.1 Pos: [3646, 3647] Scale: 0 Coeffs: 0.00155876  0.00167382 
02-Oct-2024 04:51:14 2024-10-02 04:50:59        INFO                [1180] Res: 0.00153619 Max: 2.41057e-06 Gain: 0.1 Pos: [3646, 3648] Scale: 0 Coeffs: -0.000748635  -0.00723419 
02-Oct-2024 04:51:14 2024-10-02 04:51:04        INFO                [1200] Res: 0.00146755 Max: 2.27377e-06 Gain: 0.1 Pos: [3646, 3644] Scale: 0 Coeffs: -0.00142512  -0.00252096 
02-Oct-2024 04:51:14 2024-10-02 04:51:10        INFO                [1220] Res: 0.0014684 Max: 2.15574e-06 Gain: 0.1 Pos: [3642, 3645] Scale: 0 Coeffs: 0.000731534  0.0067679 
02-Oct-2024 04:56:09 2024-10-02 04:51:15        INFO                [1240] Res: 0.00149907 Max: 2.09039e-06 Gain: 0.1 Pos: [3643, 3646] Scale: 0 Coeffs: 0.00143855  0.000659739 
02-Oct-2024 04:56:09 2024-10-02 04:51:20        INFO                [1260] Res: 0.00140091 Max: 1.99171e-06 Gain: 0.1 Pos: [3581, 3666] Scale: 0 Coeffs: -0.00112081  0.00470387 
02-Oct-2024 04:56:09 2024-10-02 04:51:25        INFO                [1280] Res: 0.00136917 Max: 1.94736e-06 Gain: 0.1 Pos: [3606, 3656] Scale: 0 Coeffs: -0.00137498  -0.00116251 
02-Oct-2024 04:56:09 2024-10-02 04:51:31        INFO                [1300] Res: 0.00135269 Max: 1.99752e-06 Gain: 0.1 Pos: [3645, 3645] Scale: 0 Coeffs: 0.00127202  0.00319506 
02-Oct-2024 04:56:09 2024-10-02 04:51:36        INFO                [1320] Res: 0.00134443 Max: 1.83269e-06 Gain: 0.1 Pos: [2813, 3921] Scale: 0 Coeffs: -0.001342  0.00108275 
02-Oct-2024 04:56:09 2024-10-02 04:51:41        INFO                [1340] Res: 0.00133444 Max: 1.80815e-06 Gain: 0.1 Pos: [3649, 3643] Scale: 0 Coeffs: -0.000773881  -0.00583374 
02-Oct-2024 04:56:09 2024-10-02 04:51:47        INFO                [1360] Res: 0.00130629 Max: 1.74999e-06 Gain: 0.1 Pos: [3387, 3728] Scale: 0 Coeffs: -0.00129688  -0.00128987 
02-Oct-2024 04:56:09 2024-10-02 04:51:52        INFO                [1380] Res: 0.00130069 Max: 1.70388e-06 Gain: 0.1 Pos: [3754, 3608] Scale: 0 Coeffs: -0.00104266  -0.00412333 
02-Oct-2024 04:56:09 2024-10-02 04:51:57        INFO                [1400] Res: 0.00126184 Max: 1.66775e-06 Gain: 0.1 Pos: [2723, 3951] Scale: 0 Coeffs: -0.00120349  0.00262317 
02-Oct-2024 04:56:09 2024-10-02 04:52:02        INFO                [1420] Res: 0.00130779 Max: 1.64795e-06 Gain: 0.1 Pos: [3643, 3646] Scale: 0 Coeffs: 0.00128176  0.000284115 
02-Oct-2024 04:56:09 2024-10-02 04:52:08        INFO                [1440] Res: 0.00124906 Max: 1.56912e-06 Gain: 0.1 Pos: [3748, 3610] Scale: 0 Coeffs: -0.00122914  -0.00119149 
02-Oct-2024 04:56:09 2024-10-02 04:52:13        INFO                [1460] Res: 0.00124342 Max: 1.55617e-06 Gain: 0.1 Pos: [3751, 3742] Scale: 0 Coeffs: -0.000363508  -0.00637266 
02-Oct-2024 04:56:09 2024-10-02 04:52:18        INFO                [1480] Res: 0.00121945 Max: 1.52844e-06 Gain: 0.1 Pos: [4325, 3413] Scale: 0 Coeffs: 0.00123587  9.62367e-05 
02-Oct-2024 04:56:09 2024-10-02 04:52:23        INFO                [1500] Res: 0.00121853 Max: 1.49365e-06 Gain: 0.1 Pos: [4552, 3349] Scale: 0 Coeffs: -0.00102681  0.00365002 
02-Oct-2024 04:56:09 2024-10-02 04:52:29        INFO                [1520] Res: 0.00120327 Max: 1.46435e-06 Gain: 0.1 Pos: [2920, 3886] Scale: 0 Coeffs: -0.0012102  3.84271e-05 
02-Oct-2024 04:56:09 2024-10-02 04:52:34        INFO                [1540] Res: 0.00119065 Max: 1.45592e-06 Gain: 0.1 Pos: [2852, 3908] Scale: 0 Coeffs: -0.00119471  0.0010199 
02-Oct-2024 04:56:09 2024-10-02 04:52:39        INFO                [1560] Res: 0.00118272 Max: 1.42118e-06 Gain: 0.1 Pos: [3617, 3423] Scale: 0 Coeffs: 0.00115939  0.00138973 
02-Oct-2024 04:56:09 2024-10-02 04:52:45        INFO                [1580] Res: 0.00117975 Max: 1.4013e-06 Gain: 0.1 Pos: [4510, 3362] Scale: 0 Coeffs: -0.00105746  0.00295133 
02-Oct-2024 04:56:09 2024-10-02 04:52:50        INFO                [1600] Res: 0.00116792 Max: 1.37865e-06 Gain: 0.1 Pos: [4567, 3340] Scale: 0 Coeffs: 0.000943057  -0.00383926 
02-Oct-2024 04:56:09 2024-10-02 04:52:55        INFO                [1620] Res: 0.00116097 Max: 1.388e-06 Gain: 0.1 Pos: [3647, 3645] Scale: 0 Coeffs: 0.00117391  0.000440887 
02-Oct-2024 04:56:09 2024-10-02 04:52:59        INFO        MultiTermMatrixCleaner::mtclean()         Reached max number of iterations for this minor cycle
02-Oct-2024 04:56:09 2024-10-02 04:52:59        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by scale :  [0]: 0.950111 (in this run)
02-Oct-2024 04:56:09 2024-10-02 04:52:59        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by Taylor coefficient :  [0]: 0.950111  [1]: 0.370431
02-Oct-2024 04:56:09 2024-10-02 04:53:06        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] iters=0->500 [500], model=0.96239->0.950111, peakres=0.00228588->0.00138227, Reached cycleniter.
02-Oct-2024 04:56:09 2024-10-02 04:53:06        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 1636 iterations.
02-Oct-2024 04:56:09 2024-10-02 04:53:08        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 7 -------------------------------------
02-Oct-2024 04:56:09
02-Oct-2024 04:56:09 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 04:56:09 2024-10-02 04:53:55        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 1.44s ( user 2.08s, system 0.46s)
02-Oct-2024 04:56:09 2024-10-02 04:53:55        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.000682427
02-Oct-2024 04:56:09 2024-10-02 04:53:55        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00142183, over full image : 0.00142183
02-Oct-2024 04:56:09 2024-10-02 04:53:55        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 500, 'cyclethreshold': 0.00041868758853524923, 'loopgain': 0.10000000149011612, 'nsigma': 4.5, 'thresholdreached': False}
02-Oct-2024 04:56:09 2024-10-02 04:53:55        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] Run mtmfs minor-cycle | CycleThreshold=0.000418688, CycleNiter=500, Gain=0.1
02-Oct-2024 04:56:09 2024-10-02 04:53:58        INFO        SIImageStoreMultiTerm::calcFractionalBandwidth         MFS frequency range : 1.96387 GHz -> 4.03613GHz.Fractional Bandwidth : 69.0755 %.Reference Frequency for Taylor Expansion : 3GHz.
02-Oct-2024 04:56:09 2024-10-02 04:53:58        INFO        SDAlgorithmBase::deconvolve         Using n-sigma for threshold criterion: (cyclethreshold=0.000418688, nsigma threshold=0.000682427 )
02-Oct-2024 04:56:09 2024-10-02 04:53:59        INFO        MultiTermMatrixCleaner::mtclean()         Calculating convolutions of residual images with scales
02-Oct-2024 04:56:09 2024-10-02 04:54:00        INFO        MultiTermMatrixCleaner::mtclean()         Peak convolved residual (within mask)  : 0.00142183
02-Oct-2024 04:56:09 2024-10-02 04:54:03        INFO                [1640] Res: 0.00130564 Max: 1.79492e-06 Gain: 0.1 Pos: [3648, 3643] Scale: 0 Coeffs: 0.00124422  0.00255822 
02-Oct-2024 04:56:09 2024-10-02 04:54:08        INFO                [1660] Res: 0.00118461 Max: 1.49987e-06 Gain: 0.1 Pos: [3645, 3651] Scale: 0 Coeffs: 0.000252781  0.00640925 
02-Oct-2024 04:56:09 2024-10-02 04:54:13        INFO                [1680] Res: 0.00116472 Max: 1.32942e-06 Gain: 0.1 Pos: [3645, 3643] Scale: 0 Coeffs: -0.0010804  -0.00206723 
02-Oct-2024 04:56:09 2024-10-02 04:54:18        INFO                [1700] Res: 0.00111967 Max: 1.28707e-06 Gain: 0.1 Pos: [3645, 3644] Scale: 0 Coeffs: 0.00113456  -2.46909e-05 
02-Oct-2024 04:56:09 2024-10-02 04:54:24        INFO                [1720] Res: 0.00111731 Max: 1.25586e-06 Gain: 0.1 Pos: [4327, 3420] Scale: 0 Coeffs: 0.00112045  -0.000252005 
02-Oct-2024 04:56:09 2024-10-02 04:54:29        INFO                [1740] Res: 0.00109283 Max: 1.21229e-06 Gain: 0.1 Pos: [4020, 3105] Scale: 0 Coeffs: 0.00100842  0.0022844 
02-Oct-2024 04:56:09 2024-10-02 04:54:34        INFO                [1760] Res: 0.00109689 Max: 1.18942e-06 Gain: 0.1 Pos: [3644, 3647] Scale: 0 Coeffs: -0.00099894  -0.00226181 
02-Oct-2024 04:56:09 2024-10-02 04:54:40        INFO                [1780] Res: 0.00106863 Max: 1.17188e-06 Gain: 0.1 Pos: [3650, 3643] Scale: 0 Coeffs: 9.16353e-05  0.00578126 
02-Oct-2024 04:56:09 2024-10-02 04:54:45        INFO                [1800] Res: 0.00106582 Max: 1.15528e-06 Gain: 0.1 Pos: [3643, 3643] Scale: 0 Coeffs: -0.00103813  -0.00140528 
02-Oct-2024 04:56:09 2024-10-02 04:54:50        INFO                [1820] Res: 0.00105003 Max: 1.12202e-06 Gain: 0.1 Pos: [4336, 3410] Scale: 0 Coeffs: 0.00105841  -0.000339839 
02-Oct-2024 04:56:09 2024-10-02 04:54:55        INFO                [1840] Res: 0.00103998 Max: 1.10363e-06 Gain: 0.1 Pos: [3646, 3613] Scale: 0 Coeffs: 0.000489723  0.00494499 
02-Oct-2024 04:56:09 2024-10-02 04:55:01        INFO                [1860] Res: 0.00103069 Max: 1.08385e-06 Gain: 0.1 Pos: [4171, 2888] Scale: 0 Coeffs: 0.00103517  -0.000693608 
02-Oct-2024 04:56:09 2024-10-02 04:55:06        INFO                [1880] Res: 0.00102714 Max: 1.1434e-06 Gain: 0.1 Pos: [3646, 3649] Scale: 0 Coeffs: 0.000390878  0.00530735 
02-Oct-2024 04:56:09 2024-10-02 04:55:11        INFO                [1900] Res: 0.00101868 Max: 1.07497e-06 Gain: 0.1 Pos: [3640, 3644] Scale: 0 Coeffs: 0.000390369  0.00512072 
02-Oct-2024 04:56:09 2024-10-02 04:55:16        INFO                [1920] Res: 0.00100374 Max: 1.02999e-06 Gain: 0.1 Pos: [4432, 3385] Scale: 0 Coeffs: 0.00101472  -0.000223927 
02-Oct-2024 04:56:09 2024-10-02 04:55:22        INFO                [1940] Res: 0.00100657 Max: 1.01797e-06 Gain: 0.1 Pos: [4589, 3333] Scale: 0 Coeffs: 0.000880928  -0.00271958 
02-Oct-2024 04:56:09 2024-10-02 04:55:27        INFO                [1960] Res: 0.00100374 Max: 1.02004e-06 Gain: 0.1 Pos: [3604, 3658] Scale: 0 Coeffs: 0.000148524  0.00534864 
02-Oct-2024 04:56:09 2024-10-02 04:55:32        INFO                [1980] Res: 0.000994489 Max: 9.95063e-07 Gain: 0.1 Pos: [4132, 2944] Scale: 0 Coeffs: 0.000994053  -0.000543689 
02-Oct-2024 04:56:09 2024-10-02 04:55:38        INFO                [2000] Res: 0.000986885 Max: 1.00823e-06 Gain: 0.1 Pos: [3647, 3645] Scale: 0 Coeffs: 0.00100422  -4.86099e-05 
02-Oct-2024 04:56:09 2024-10-02 04:55:43        INFO                [2020] Res: 0.000985961 Max: 9.76035e-07 Gain: 0.1 Pos: [4248, 3440] Scale: 0 Coeffs: 0.00088873  0.00223825 
02-Oct-2024 04:56:09 2024-10-02 04:55:48        INFO                [2040] Res: 0.000969247 Max: 9.60845e-07 Gain: 0.1 Pos: [4322, 3414] Scale: 0 Coeffs: 0.000925983  0.00164545 
02-Oct-2024 04:56:09 2024-10-02 04:55:53        INFO                [2060] Res: 0.00097451 Max: 9.48877e-07 Gain: 0.1 Pos: [3650, 3643] Scale: 0 Coeffs: 0.000112236  0.00518348 
02-Oct-2024 04:56:09 2024-10-02 04:55:59        INFO                [2080] Res: 0.00101113 Max: 9.39761e-07 Gain: 0.1 Pos: [3643, 3645] Scale: 0 Coeffs: -0.000892461  0.00211257 
02-Oct-2024 04:56:09 2024-10-02 04:56:04        INFO                [2100] Res: 0.000961579 Max: 9.43274e-07 Gain: 0.1 Pos: [3644, 3642] Scale: 0 Coeffs: 0.000520619  0.00435452 
02-Oct-2024 05:00:33 2024-10-02 04:56:09        INFO                [2120] Res: 0.000951168 Max: 9.19315e-07 Gain: 0.1 Pos: [3758, 4162] Scale: 0 Coeffs: -0.000692918  0.00361912 
02-Oct-2024 05:00:33 2024-10-02 04:56:13        INFO        MultiTermMatrixCleaner::mtclean()         Reached max number of iterations for this minor cycle
02-Oct-2024 05:00:33 2024-10-02 04:56:13        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by scale :  [0]: 0.969349 (in this run)
02-Oct-2024 05:00:33 2024-10-02 04:56:13        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by Taylor coefficient :  [0]: 0.969349  [1]: 0.355644
02-Oct-2024 05:00:33 2024-10-02 04:56:20        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] iters=0->500 [500], model=0.950111->0.969349, peakres=0.00142183->0.00101329, Reached cycleniter.
02-Oct-2024 05:00:33 2024-10-02 04:56:20        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 2136 iterations.
02-Oct-2024 05:00:33 2024-10-02 04:56:23        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 8 -------------------------------------
02-Oct-2024 05:00:33
02-Oct-2024 05:00:33 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 05:00:33 2024-10-02 04:57:08        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 1.29s ( user 2.04s, system 0.35s)
02-Oct-2024 05:00:33 2024-10-02 04:57:08        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.000678062
02-Oct-2024 05:00:33 2024-10-02 04:57:08        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.0010947, over full image : 0.0010947
02-Oct-2024 05:00:33 2024-10-02 04:57:08        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 500, 'cyclethreshold': 0.00032235897378996015, 'loopgain': 0.10000000149011612, 'nsigma': 4.5, 'thresholdreached': False}
02-Oct-2024 05:00:33 2024-10-02 04:57:08        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] Run mtmfs minor-cycle | CycleThreshold=0.000322359, CycleNiter=500, Gain=0.1
02-Oct-2024 05:00:33 2024-10-02 04:57:11        INFO        SIImageStoreMultiTerm::calcFractionalBandwidth         MFS frequency range : 1.96387 GHz -> 4.03613GHz.Fractional Bandwidth : 69.0755 %.Reference Frequency for Taylor Expansion : 3GHz.
02-Oct-2024 05:00:33 2024-10-02 04:57:11        INFO        SDAlgorithmBase::deconvolve         Using n-sigma for threshold criterion: (cyclethreshold=0.000322359, nsigma threshold=0.000678062 )
02-Oct-2024 05:00:33 2024-10-02 04:57:12        INFO        MultiTermMatrixCleaner::mtclean()         Calculating convolutions of residual images with scales
02-Oct-2024 05:00:33 2024-10-02 04:57:14        INFO        MultiTermMatrixCleaner::mtclean()         Peak convolved residual (within mask)  : 0.0010947
02-Oct-2024 05:00:33 2024-10-02 04:57:16        INFO                [2140] Res: 0.00106381 Max: 1.1424e-06 Gain: 0.1 Pos: [4328, 3422] Scale: 0 Coeffs: -0.0010183  0.00183597 
02-Oct-2024 05:00:33 2024-10-02 04:57:21        INFO                [2160] Res: 0.000989175 Max: 9.93839e-07 Gain: 0.1 Pos: [3649, 3643] Scale: 0 Coeffs: -0.000636838  -0.00406037 
02-Oct-2024 05:00:33 2024-10-02 04:57:27        INFO                [2180] Res: 0.000968273 Max: 9.48881e-07 Gain: 0.1 Pos: [3744, 3611] Scale: 0 Coeffs: -0.000973422  -0.000127491 
02-Oct-2024 05:00:33 2024-10-02 04:57:32        INFO                [2200] Res: 0.000959513 Max: 9.69159e-07 Gain: 0.1 Pos: [3646, 3649] Scale: 0 Coeffs: 0.000287581  0.00502786 
02-Oct-2024 05:00:33 2024-10-02 04:57:37        INFO                [2220] Res: 0.000946139 Max: 9.08683e-07 Gain: 0.1 Pos: [3643, 3648] Scale: 0 Coeffs: 5.80098e-05  0.00510171 
02-Oct-2024 05:00:33 2024-10-02 04:57:42        INFO                [2240] Res: 0.000937895 Max: 8.83548e-07 Gain: 0.1 Pos: [3477, 3698] Scale: 0 Coeffs: -0.000912442  -0.00113359 
02-Oct-2024 05:00:33 2024-10-02 04:57:48        INFO                [2260] Res: 0.000928875 Max: 8.95887e-07 Gain: 0.1 Pos: [3642, 3644] Scale: 0 Coeffs: 0.000945715  0.00014078 
02-Oct-2024 05:00:33 2024-10-02 04:57:53        INFO                [2280] Res: 0.000921149 Max: 8.73218e-07 Gain: 0.1 Pos: [3645, 3651] Scale: 0 Coeffs: 0.000191419  0.00489215 
02-Oct-2024 05:00:33 2024-10-02 04:57:58        INFO                [2300] Res: 0.000916746 Max: 8.42746e-07 Gain: 0.1 Pos: [3645, 3645] Scale: 0 Coeffs: 0.000854201  0.00173052 
02-Oct-2024 05:00:33 2024-10-02 04:58:04        INFO                [2320] Res: 0.000905462 Max: 8.28652e-07 Gain: 0.1 Pos: [3857, 3839] Scale: 0 Coeffs: -0.000738836  -0.00278913 
02-Oct-2024 05:00:33 2024-10-02 04:58:09        INFO                [2340] Res: 0.00089769 Max: 8.17976e-07 Gain: 0.1 Pos: [3629, 3648] Scale: 0 Coeffs: -0.000868971  -0.00127061 
02-Oct-2024 05:00:33 2024-10-02 04:58:14        INFO                [2360] Res: 0.000925781 Max: 8.3977e-07 Gain: 0.1 Pos: [3646, 3645] Scale: 0 Coeffs: -0.000906476  0.000806693 
02-Oct-2024 05:00:33 2024-10-02 04:58:19        INFO                [2380] Res: 0.000889168 Max: 8.04106e-07 Gain: 0.1 Pos: [3645, 3643] Scale: 0 Coeffs: -0.000884772  -0.000708259 
02-Oct-2024 05:00:33 2024-10-02 04:58:25        INFO                [2400] Res: 0.000885602 Max: 8.05425e-07 Gain: 0.1 Pos: [3647, 3645] Scale: 0 Coeffs: 0.000897444  -0.000163137 
02-Oct-2024 05:00:33 2024-10-02 04:58:30        INFO                [2420] Res: 0.00088274 Max: 7.84113e-07 Gain: 0.1 Pos: [3388, 4006] Scale: 0 Coeffs: 0.000882155  0.00034167 
02-Oct-2024 05:00:33 2024-10-02 04:58:35        INFO                [2440] Res: 0.000875385 Max: 7.78229e-07 Gain: 0.1 Pos: [4242, 2784] Scale: 0 Coeffs: -0.000658132  0.00321208 
02-Oct-2024 05:00:33 2024-10-02 04:58:40        INFO                [2460] Res: 0.000875385 Max: 7.67708e-07 Gain: 0.1 Pos: [3917, 3551] Scale: 0 Coeffs: 0.000477295  0.0039015 
02-Oct-2024 05:00:33 2024-10-02 04:58:46        INFO                [2480] Res: 0.00086971 Max: 7.59449e-07 Gain: 0.1 Pos: [3276, 4164] Scale: 0 Coeffs: 0.000869043  0.000279548 
02-Oct-2024 05:00:33 2024-10-02 04:58:51        INFO                [2500] Res: 0.000869741 Max: 7.64797e-07 Gain: 0.1 Pos: [3662, 3639] Scale: 0 Coeffs: -0.000566767  -0.00352459 
02-Oct-2024 05:00:33 2024-10-02 04:58:56        INFO                [2520] Res: 0.00086583 Max: 7.54147e-07 Gain: 0.1 Pos: [3643, 3648] Scale: 0 Coeffs: 4.2655e-05  0.00465161 
02-Oct-2024 05:00:33 2024-10-02 04:59:01        INFO                [2540] Res: 0.000860693 Max: 7.49014e-07 Gain: 0.1 Pos: [3642, 3644] Scale: 0 Coeffs: 0.00086557  -9.23961e-05 
02-Oct-2024 05:00:33 2024-10-02 04:59:07        INFO                [2560] Res: 0.000857426 Max: 7.40457e-07 Gain: 0.1 Pos: [4625, 3987] Scale: 0 Coeffs: -0.000548316  0.00360859 
02-Oct-2024 05:00:33 2024-10-02 04:59:12        INFO                [2580] Res: 0.000854841 Max: 7.32804e-07 Gain: 0.1 Pos: [4236, 4186] Scale: 0 Coeffs: -0.000505035  0.00375502 
02-Oct-2024 05:00:33 2024-10-02 04:59:17        INFO                [2600] Res: 0.00085061 Max: 7.31543e-07 Gain: 0.1 Pos: [3641, 3644] Scale: 0 Coeffs: -0.000578192  -0.00333175 
02-Oct-2024 05:00:33 2024-10-02 04:59:23        INFO                [2620] Res: 0.000846265 Max: 7.20266e-07 Gain: 0.1 Pos: [3639, 3723] Scale: 0 Coeffs: -0.000759723  0.002099 
02-Oct-2024 05:00:33 2024-10-02 04:59:27        INFO        MultiTermMatrixCleaner::mtclean()         Reached max number of iterations for this minor cycle
02-Oct-2024 05:00:33 2024-10-02 04:59:27        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by scale :  [0]: 0.958323 (in this run)
02-Oct-2024 05:00:33 2024-10-02 04:59:27        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by Taylor coefficient :  [0]: 0.958323  [1]: 0.357166
02-Oct-2024 05:00:33 2024-10-02 04:59:33        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] iters=0->500 [500], model=0.969349->0.958323, peakres=0.0010947->0.00101696, Reached cycleniter.
02-Oct-2024 05:00:33 2024-10-02 04:59:33        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 2636 iterations.
02-Oct-2024 05:00:33 2024-10-02 04:59:36        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 9 -------------------------------------
02-Oct-2024 05:00:33
02-Oct-2024 05:00:33 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 05:00:33 2024-10-02 05:00:21        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 1.32s ( user 1.99s, system 0.41s)
02-Oct-2024 05:00:33 2024-10-02 05:00:21        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.000674329
02-Oct-2024 05:00:33 2024-10-02 05:00:21        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00103585, over full image : 0.00103585
02-Oct-2024 05:00:33 2024-10-02 05:00:21        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 500, 'cyclethreshold': 0.00030502883601002395, 'loopgain': 0.10000000149011612, 'nsigma': 4.5, 'thresholdreached': False}
02-Oct-2024 05:00:33 2024-10-02 05:00:21        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] Run mtmfs minor-cycle | CycleThreshold=0.000305029, CycleNiter=500, Gain=0.1
02-Oct-2024 05:00:33 2024-10-02 05:00:23        INFO        SIImageStoreMultiTerm::calcFractionalBandwidth         MFS frequency range : 1.96387 GHz -> 4.03613GHz.Fractional Bandwidth : 69.0755 %.Reference Frequency for Taylor Expansion : 3GHz.
02-Oct-2024 05:00:33 2024-10-02 05:00:23        INFO        SDAlgorithmBase::deconvolve         Using n-sigma for threshold criterion: (cyclethreshold=0.000305029, nsigma threshold=0.000674329 )
02-Oct-2024 05:00:33 2024-10-02 05:00:24        INFO        MultiTermMatrixCleaner::mtclean()         Calculating convolutions of residual images with scales
02-Oct-2024 05:00:33 2024-10-02 05:00:26        INFO        MultiTermMatrixCleaner::mtclean()         Peak convolved residual (within mask)  : 0.00103585
02-Oct-2024 05:00:33 2024-10-02 05:00:28        INFO                [2640] Res: 0.00094108 Max: 9.37632e-07 Gain: 0.1 Pos: [3464, 3705] Scale: 0 Coeffs: 0.000967663  0.000123018 
02-Oct-2024 05:05:21 2024-10-02 05:00:34        INFO                [2660] Res: 0.000892709 Max: 8.08574e-07 Gain: 0.1 Pos: [3645, 3647] Scale: 0 Coeffs: 0.000715741  0.00285854 
02-Oct-2024 05:05:21 2024-10-02 05:00:39        INFO                [2680] Res: 0.000866776 Max: 7.66578e-07 Gain: 0.1 Pos: [4126, 3483] Scale: 0 Coeffs: -0.000389798  -0.00417333 
02-Oct-2024 05:05:21 2024-10-02 05:00:44        INFO                [2700] Res: 0.000853488 Max: 7.35089e-07 Gain: 0.1 Pos: [4059, 3508] Scale: 0 Coeffs: 0.000719829  0.00243664 
02-Oct-2024 05:05:21 2024-10-02 05:00:50        INFO                [2720] Res: 0.000843269 Max: 7.21213e-07 Gain: 0.1 Pos: [3595, 3662] Scale: 0 Coeffs: 0.000774601  0.00180093 
02-Oct-2024 05:05:21 2024-10-02 05:00:55        INFO                [2740] Res: 0.00084038 Max: 7.07032e-07 Gain: 0.1 Pos: [3817, 2900] Scale: 0 Coeffs: -0.000670301  0.0027851 
02-Oct-2024 05:05:21 2024-10-02 05:01:00        INFO                [2760] Res: 0.000833188 Max: 6.99802e-07 Gain: 0.1 Pos: [3719, 3622] Scale: 0 Coeffs: 0.000836543  -3.5936e-07 
02-Oct-2024 05:05:21 2024-10-02 05:01:05        INFO                [2780] Res: 0.000829796 Max: 6.90289e-07 Gain: 0.1 Pos: [3709, 3883] Scale: 0 Coeffs: -0.00037539  -0.00394494 
02-Oct-2024 05:05:21 2024-10-02 05:01:11        INFO                [2800] Res: 0.000825153 Max: 6.85381e-07 Gain: 0.1 Pos: [4665, 3301] Scale: 0 Coeffs: -0.000727259  0.00218883 
02-Oct-2024 05:05:21 2024-10-02 05:01:16        INFO                [2820] Res: 0.000819625 Max: 6.7778e-07 Gain: 0.1 Pos: [4107, 4209] Scale: 0 Coeffs: 0.000499299  -0.00355804 
02-Oct-2024 05:05:21 2024-10-02 05:01:21        INFO                [2840] Res: 0.000812555 Max: 6.71309e-07 Gain: 0.1 Pos: [2904, 3895] Scale: 0 Coeffs: 0.000729236  -0.00207078 
02-Oct-2024 05:05:21 2024-10-02 05:01:26        INFO                [2860] Res: 0.000812555 Max: 6.82868e-07 Gain: 0.1 Pos: [3648, 3646] Scale: 0 Coeffs: -0.000820146  -0.000474716 
02-Oct-2024 05:05:21 2024-10-02 05:01:32        INFO                [2880] Res: 0.000808596 Max: 6.59224e-07 Gain: 0.1 Pos: [4197, 2851] Scale: 0 Coeffs: 0.000787775  -0.00112742 
02-Oct-2024 05:05:21 2024-10-02 05:01:37        INFO                [2900] Res: 0.000804007 Max: 6.54754e-07 Gain: 0.1 Pos: [4592, 4046] Scale: 0 Coeffs: 0.0003163  -0.00402572 
02-Oct-2024 05:05:21 2024-10-02 05:01:42        INFO                [2920] Res: 0.000804007 Max: 6.53392e-07 Gain: 0.1 Pos: [3648, 3643] Scale: 0 Coeffs: 0.000765002  0.00133488 
02-Oct-2024 05:05:21 2024-10-02 05:01:48        INFO                [2940] Res: 0.000803147 Max: 6.462e-07 Gain: 0.1 Pos: [3646, 3613] Scale: 0 Coeffs: 0.000326247  0.00391433 
02-Oct-2024 05:05:21 2024-10-02 05:01:53        INFO                [2960] Res: 0.000794131 Max: 6.42278e-07 Gain: 0.1 Pos: [3649, 3643] Scale: 0 Coeffs: -0.000445989  -0.0035344 
02-Oct-2024 05:05:21 2024-10-02 05:01:58        INFO                [2980] Res: 0.00079157 Max: 6.38034e-07 Gain: 0.1 Pos: [4155, 3476] Scale: 0 Coeffs: 0.000792706  0.000461449 
02-Oct-2024 05:05:21 2024-10-02 05:02:03        INFO                [3000] Res: 0.000791501 Max: 6.32894e-07 Gain: 0.1 Pos: [3423, 3955] Scale: 0 Coeffs: -0.000720485  -0.0017476 
02-Oct-2024 05:05:21 2024-10-02 05:02:09        INFO                [3020] Res: 0.000791501 Max: 6.27975e-07 Gain: 0.1 Pos: [3577, 3731] Scale: 0 Coeffs: 0.000678151  0.00214097 
02-Oct-2024 05:05:21 2024-10-02 05:02:14        INFO                [3040] Res: 0.000788652 Max: 6.25723e-07 Gain: 0.1 Pos: [4378, 4090] Scale: 0 Coeffs: -0.000620373  0.00268991 
02-Oct-2024 05:05:21 2024-10-02 05:02:19        INFO                [3060] Res: 0.000786344 Max: 6.20269e-07 Gain: 0.1 Pos: [4219, 3455] Scale: 0 Coeffs: 0.000764215  0.000956065 
02-Oct-2024 05:05:21 2024-10-02 05:02:24        INFO                [3080] Res: 0.000784483 Max: 6.16857e-07 Gain: 0.1 Pos: [3633, 3763] Scale: 0 Coeffs: 0.00062307  -0.00262248 
02-Oct-2024 05:05:21 2024-10-02 05:02:30        INFO                [3100] Res: 0.000792609 Max: 6.14712e-07 Gain: 0.1 Pos: [3646, 3645] Scale: 0 Coeffs: -0.000763045  0.00103751 
02-Oct-2024 05:05:21 2024-10-02 05:02:35        INFO                [3120] Res: 0.00078648 Max: 6.42714e-07 Gain: 0.1 Pos: [3645, 3647] Scale: 0 Coeffs: 0.000586457  0.00288208 
02-Oct-2024 05:05:21 2024-10-02 05:02:39        INFO        MultiTermMatrixCleaner::mtclean()         Reached max number of iterations for this minor cycle
02-Oct-2024 05:05:21 2024-10-02 05:02:39        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by scale :  [0]: 0.970228 (in this run)
02-Oct-2024 05:05:21 2024-10-02 05:02:39        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by Taylor coefficient :  [0]: 0.970227  [1]: 0.344624
02-Oct-2024 05:05:21 2024-10-02 05:02:46        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] iters=0->500 [500], model=0.958323->0.970228, peakres=0.00103585->0.00100172, Reached cycleniter.
02-Oct-2024 05:05:21 2024-10-02 05:02:46        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 3136 iterations.
02-Oct-2024 05:05:21 2024-10-02 05:02:48        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 10 -------------------------------------
02-Oct-2024 05:05:21
02-Oct-2024 05:05:21 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 05:05:21 2024-10-02 05:03:34        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 1.32s ( user 1.99s, system 0.41s)
02-Oct-2024 05:05:21 2024-10-02 05:03:34        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.000670591
02-Oct-2024 05:05:21 2024-10-02 05:03:34        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.000988065, over full image : 0.000988065
02-Oct-2024 05:05:21 2024-10-02 05:03:34        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 500, 'cyclethreshold': 0.0002909569884650409, 'loopgain': 0.10000000149011612, 'nsigma': 4.5, 'thresholdreached': False}
02-Oct-2024 05:05:21 2024-10-02 05:03:34        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] Run mtmfs minor-cycle | CycleThreshold=0.000290957, CycleNiter=500, Gain=0.1
02-Oct-2024 05:05:21 2024-10-02 05:03:36        INFO        SIImageStoreMultiTerm::calcFractionalBandwidth         MFS frequency range : 1.96387 GHz -> 4.03613GHz.Fractional Bandwidth : 69.0755 %.Reference Frequency for Taylor Expansion : 3GHz.
02-Oct-2024 05:05:21 2024-10-02 05:03:36        INFO        SDAlgorithmBase::deconvolve         Using n-sigma for threshold criterion: (cyclethreshold=0.000290957, nsigma threshold=0.000670591 )
02-Oct-2024 05:05:21 2024-10-02 05:03:37        INFO        MultiTermMatrixCleaner::mtclean()         Calculating convolutions of residual images with scales
02-Oct-2024 05:05:21 2024-10-02 05:03:39        INFO        MultiTermMatrixCleaner::mtclean()         Peak convolved residual (within mask)  : 0.000988065
02-Oct-2024 05:05:21 2024-10-02 05:03:41        INFO                [3140] Res: 0.000870523 Max: 7.78309e-07 Gain: 0.1 Pos: [3675, 3634] Scale: 0 Coeffs: -0.000864107  0.00103452 
02-Oct-2024 05:05:21 2024-10-02 05:03:47        INFO                [3160] Res: 0.000822222 Max: 6.77535e-07 Gain: 0.1 Pos: [2742, 3945] Scale: 0 Coeffs: -0.000822268  -0.000141259 
02-Oct-2024 05:05:21 2024-10-02 05:03:52        INFO                [3180] Res: 0.000800453 Max: 6.5489e-07 Gain: 0.1 Pos: [3644, 3647] Scale: 0 Coeffs: -0.000769518  -0.00127757 
02-Oct-2024 05:05:21 2024-10-02 05:03:57        INFO                [3200] Res: 0.000790468 Max: 6.30836e-07 Gain: 0.1 Pos: [4068, 3507] Scale: 0 Coeffs: -0.000794229  0.000148329 
02-Oct-2024 05:05:21 2024-10-02 05:04:02        INFO                [3220] Res: 0.000783258 Max: 6.16313e-07 Gain: 0.1 Pos: [3724, 3618] Scale: 0 Coeffs: -0.000784199  0.000278614 
02-Oct-2024 05:05:21 2024-10-02 05:04:08        INFO                [3240] Res: 0.000775616 Max: 6.07925e-07 Gain: 0.1 Pos: [3059, 3840] Scale: 0 Coeffs: -0.000729918  -0.00140779 
02-Oct-2024 05:05:21 2024-10-02 05:04:13        INFO                [3260] Res: 0.000772807 Max: 6.08045e-07 Gain: 0.1 Pos: [3646, 3648] Scale: 0 Coeffs: -0.000622978  -0.00246232 
02-Oct-2024 05:05:21 2024-10-02 05:04:18        INFO                [3280] Res: 0.000770962 Max: 5.96784e-07 Gain: 0.1 Pos: [2789, 3929] Scale: 0 Coeffs: -0.000763601  0.000699759 
02-Oct-2024 05:05:21 2024-10-02 05:04:24        INFO                [3300] Res: 0.000768628 Max: 5.91813e-07 Gain: 0.1 Pos: [3015, 2788] Scale: 0 Coeffs: 0.000574998  -0.00279468 
02-Oct-2024 05:05:21 2024-10-02 05:04:29        INFO                [3320] Res: 0.000765785 Max: 5.8761e-07 Gain: 0.1 Pos: [4040, 3510] Scale: 0 Coeffs: 0.000539973  0.00287265 
02-Oct-2024 05:05:21 2024-10-02 05:04:34        INFO                [3340] Res: 0.000763289 Max: 5.84127e-07 Gain: 0.1 Pos: [2586, 3464] Scale: 0 Coeffs: -0.000510017  0.00310087 
02-Oct-2024 05:05:21 2024-10-02 05:04:39        INFO                [3360] Res: 0.000756757 Max: 5.82432e-07 Gain: 0.1 Pos: [3646, 3649] Scale: 0 Coeffs: 0.000187969  0.00395328 
02-Oct-2024 05:05:21 2024-10-02 05:04:45        INFO                [3380] Res: 0.000758146 Max: 5.76849e-07 Gain: 0.1 Pos: [3990, 3150] Scale: 0 Coeffs: -0.000505987  -0.00299541 
02-Oct-2024 05:05:21 2024-10-02 05:04:50        INFO                [3400] Res: 0.000756757 Max: 5.74372e-07 Gain: 0.1 Pos: [3144, 3812] Scale: 0 Coeffs: -0.000545774  -0.00277415 
02-Oct-2024 05:05:21 2024-10-02 05:04:55        INFO                [3420] Res: 0.000754127 Max: 5.70923e-07 Gain: 0.1 Pos: [3642, 3692] Scale: 0 Coeffs: -0.000137963  0.0039996 
02-Oct-2024 05:05:21 2024-10-02 05:05:00        INFO                [3440] Res: 0.000753162 Max: 5.76904e-07 Gain: 0.1 Pos: [3647, 3647] Scale: 0 Coeffs: 0.0007326  0.00101294 
02-Oct-2024 05:05:21 2024-10-02 05:05:06        INFO                [3460] Res: 0.000751268 Max: 5.65448e-07 Gain: 0.1 Pos: [3729, 3761] Scale: 0 Coeffs: -0.000141333  -0.0039515 
02-Oct-2024 05:05:21 2024-10-02 05:05:11        INFO                [3480] Res: 0.000747383 Max: 5.63217e-07 Gain: 0.1 Pos: [4068, 3036] Scale: 0 Coeffs: 0.000698742  0.00140879 
02-Oct-2024 05:05:21 2024-10-02 05:05:16        INFO                [3500] Res: 0.000747383 Max: 5.70285e-07 Gain: 0.1 Pos: [3645, 3638] Scale: 0 Coeffs: 2.29756e-05  0.0040493 
02-Oct-2024 05:10:02 2024-10-02 05:05:22        INFO                [3520] Res: 0.000742584 Max: 5.57792e-07 Gain: 0.1 Pos: [3754, 3609] Scale: 0 Coeffs: -0.000493344  -0.00296594 
02-Oct-2024 05:10:02 2024-10-02 05:05:27        INFO                [3540] Res: 0.000742584 Max: 5.5505e-07 Gain: 0.1 Pos: [3649, 3643] Scale: 0 Coeffs: -0.000468949  -0.00306572 
02-Oct-2024 05:10:02 2024-10-02 05:05:32        INFO                [3560] Res: 0.000742584 Max: 5.53449e-07 Gain: 0.1 Pos: [3783, 3669] Scale: 0 Coeffs: 0.000535743  -0.00281849 
02-Oct-2024 05:10:02 2024-10-02 05:05:37        INFO                [3580] Res: 0.000738928 Max: 5.50641e-07 Gain: 0.1 Pos: [3672, 3330] Scale: 0 Coeffs: -0.000515995  -0.00281672 
02-Oct-2024 05:10:02 2024-10-02 05:05:43        INFO                [3600] Res: 0.000737285 Max: 5.48118e-07 Gain: 0.1 Pos: [3675, 3839] Scale: 0 Coeffs: -0.000640317  -0.00193849 
02-Oct-2024 05:10:02 2024-10-02 05:05:48        INFO                [3620] Res: 0.000735618 Max: 5.45612e-07 Gain: 0.1 Pos: [4519, 3348] Scale: 0 Coeffs: 0.000734083  0.000379909 
02-Oct-2024 05:10:02 2024-10-02 05:05:52        INFO        MultiTermMatrixCleaner::mtclean()         Reached max number of iterations for this minor cycle
02-Oct-2024 05:10:02 2024-10-02 05:05:52        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by scale :  [0]: 0.961456 (in this run)
02-Oct-2024 05:10:02 2024-10-02 05:05:52        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by Taylor coefficient :  [0]: 0.961456  [1]: 0.341244
02-Oct-2024 05:10:02 2024-10-02 05:05:59        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] iters=0->500 [500], model=0.970227->0.961456, peakres=0.000988065->0.000841648, Reached cycleniter.
02-Oct-2024 05:10:02 2024-10-02 05:05:59        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 3636 iterations.
02-Oct-2024 05:10:02 2024-10-02 05:06:01        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 11 -------------------------------------
02-Oct-2024 05:10:02
02-Oct-2024 05:10:02 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 05:10:02 2024-10-02 05:06:47        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 1.31s ( user 1.98s, system 0.41s)
02-Oct-2024 05:10:02 2024-10-02 05:06:47        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.00066738
02-Oct-2024 05:10:02 2024-10-02 05:06:47        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.000890469, over full image : 0.000890469
02-Oct-2024 05:10:02 2024-10-02 05:06:47        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 500, 'cyclethreshold': 0.000262217887211591, 'loopgain': 0.10000000149011612, 'nsigma': 4.5, 'thresholdreached': False}
02-Oct-2024 05:10:02 2024-10-02 05:06:47        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] Run mtmfs minor-cycle | CycleThreshold=0.000262218, CycleNiter=500, Gain=0.1
02-Oct-2024 05:10:02 2024-10-02 05:06:50        INFO        SIImageStoreMultiTerm::calcFractionalBandwidth         MFS frequency range : 1.96387 GHz -> 4.03613GHz.Fractional Bandwidth : 69.0755 %.Reference Frequency for Taylor Expansion : 3GHz.
02-Oct-2024 05:10:02 2024-10-02 05:06:50        INFO        SDAlgorithmBase::deconvolve         Using n-sigma for threshold criterion: (cyclethreshold=0.000262218, nsigma threshold=0.00066738 )
02-Oct-2024 05:10:02 2024-10-02 05:06:51        INFO        MultiTermMatrixCleaner::mtclean()         Calculating convolutions of residual images with scales
02-Oct-2024 05:10:02 2024-10-02 05:06:52        INFO        MultiTermMatrixCleaner::mtclean()         Peak convolved residual (within mask)  : 0.000890469
02-Oct-2024 05:10:02 2024-10-02 05:06:55        INFO                [3640] Res: 0.00083448 Max: 7.29929e-07 Gain: 0.1 Pos: [3516, 3688] Scale: 0 Coeffs: 0.000685184  0.00267887 
02-Oct-2024 05:10:02 2024-10-02 05:07:00        INFO                [3660] Res: 0.000784469 Max: 6.33014e-07 Gain: 0.1 Pos: [3715, 3623] Scale: 0 Coeffs: 0.00078401  -0.00080002 
02-Oct-2024 05:10:02 2024-10-02 05:07:05        INFO                [3680] Res: 0.000762142 Max: 5.82973e-07 Gain: 0.1 Pos: [3440, 3713] Scale: 0 Coeffs: 0.000597073  0.00250168 
02-Oct-2024 05:10:02 2024-10-02 05:07:10        INFO                [3700] Res: 0.000746028 Max: 5.614e-07 Gain: 0.1 Pos: [3750, 3612] Scale: 0 Coeffs: 0.000748979  6.31107e-05 
02-Oct-2024 05:10:02 2024-10-02 05:07:16        INFO                [3720] Res: 0.000738392 Max: 5.51755e-07 Gain: 0.1 Pos: [4625, 3317] Scale: 0 Coeffs: -0.000498055  0.00300248 
02-Oct-2024 05:10:02 2024-10-02 05:07:21        INFO                [3740] Res: 0.000737101 Max: 5.48909e-07 Gain: 0.1 Pos: [3662, 3639] Scale: 0 Coeffs: -0.00039616  -0.00332523 
02-Oct-2024 05:10:02 2024-10-02 05:07:26        INFO                [3760] Res: 0.000733366 Max: 5.38833e-07 Gain: 0.1 Pos: [3077, 3600] Scale: 0 Coeffs: 0.000259561  0.00366231 
02-Oct-2024 05:10:02 2024-10-02 05:07:31        INFO                [3780] Res: 0.000731066 Max: 5.35725e-07 Gain: 0.1 Pos: [3652, 3645] Scale: 0 Coeffs: -0.00040437  -0.00323873 
02-Oct-2024 05:10:02 2024-10-02 05:07:37        INFO                [3800] Res: 0.000727639 Max: 5.32424e-07 Gain: 0.1 Pos: [3470, 3807] Scale: 0 Coeffs: -3.53649e-05  -0.00390861 
02-Oct-2024 05:10:02 2024-10-02 05:07:42        INFO                [3820] Res: 0.000724797 Max: 5.29047e-07 Gain: 0.1 Pos: [3748, 3740] Scale: 0 Coeffs: -0.000323688  -0.00346735 
02-Oct-2024 05:10:02 2024-10-02 05:07:47        INFO                [3840] Res: 0.000722866 Max: 5.24804e-07 Gain: 0.1 Pos: [4461, 3376] Scale: 0 Coeffs: 0.000691855  0.00109299 
02-Oct-2024 05:10:02 2024-10-02 05:07:53        INFO                [3860] Res: 0.000721568 Max: 5.2184e-07 Gain: 0.1 Pos: [2769, 4009] Scale: 0 Coeffs: 0.000582899  -0.00234265 
02-Oct-2024 05:10:02 2024-10-02 05:07:58        INFO                [3880] Res: 0.000736379 Max: 5.25996e-07 Gain: 0.1 Pos: [3646, 3643] Scale: 0 Coeffs: 0.000662245  0.00152917 
02-Oct-2024 05:10:02 2024-10-02 05:08:03        INFO                [3900] Res: 0.000718354 Max: 5.18617e-07 Gain: 0.1 Pos: [2906, 3864] Scale: 0 Coeffs: 0.000720041  -0.000157127 
02-Oct-2024 05:10:02 2024-10-02 05:08:08        INFO                [3920] Res: 0.000716885 Max: 5.16138e-07 Gain: 0.1 Pos: [4020, 3105] Scale: 0 Coeffs: 0.000616737  0.00192358 
02-Oct-2024 05:10:02 2024-10-02 05:08:14        INFO                [3940] Res: 0.000713052 Max: 5.12422e-07 Gain: 0.1 Pos: [4665, 3301] Scale: 0 Coeffs: -0.000637168  0.0018087 
02-Oct-2024 05:10:02 2024-10-02 05:08:19        INFO                [3960] Res: 0.00071952 Max: 5.1218e-07 Gain: 0.1 Pos: [3648, 3648] Scale: 0 Coeffs: 0.000438142  -0.00307643 
02-Oct-2024 05:10:02 2024-10-02 05:08:24        INFO                [3980] Res: 0.000713052 Max: 5.15444e-07 Gain: 0.1 Pos: [4640, 3932] Scale: 0 Coeffs: -0.000481928  0.00289943 
02-Oct-2024 05:10:02 2024-10-02 05:08:29        INFO                [4000] Res: 0.000712401 Max: 5.0789e-07 Gain: 0.1 Pos: [4184, 2869] Scale: 0 Coeffs: 0.000682092  -0.00117068 
02-Oct-2024 05:10:02 2024-10-02 05:08:35        INFO                [4020] Res: 0.000711291 Max: 5.065e-07 Gain: 0.1 Pos: [4391, 3705] Scale: 0 Coeffs: -0.000650612  0.00160718 
02-Oct-2024 05:10:02 2024-10-02 05:08:40        INFO                [4040] Res: 0.00070773 Max: 5.04882e-07 Gain: 0.1 Pos: [4418, 3868] Scale: 0 Coeffs: -0.000648044  0.00162281 
02-Oct-2024 05:10:02 2024-10-02 05:08:45        INFO                [4060] Res: 0.000708055 Max: 5.03839e-07 Gain: 0.1 Pos: [4237, 2793] Scale: 0 Coeffs: 0.000652331  -0.00156108 
02-Oct-2024 05:10:02 2024-10-02 05:08:51        INFO                [4080] Res: 0.000707253 Max: 5.01712e-07 Gain: 0.1 Pos: [3116, 3824] Scale: 0 Coeffs: 0.000664883  -0.00137129 
02-Oct-2024 05:10:02 2024-10-02 05:08:56        INFO                [4100] Res: 0.000705325 Max: 4.99359e-07 Gain: 0.1 Pos: [4601, 3921] Scale: 0 Coeffs: -0.000589104  0.0021478 
02-Oct-2024 05:10:02 2024-10-02 05:09:01        INFO                [4120] Res: 0.000705216 Max: 4.97763e-07 Gain: 0.1 Pos: [3695, 4042] Scale: 0 Coeffs: -0.000497699  0.0027286 
02-Oct-2024 05:10:02 2024-10-02 05:09:05        INFO        MultiTermMatrixCleaner::mtclean()         Reached max number of iterations for this minor cycle
02-Oct-2024 05:10:02 2024-10-02 05:09:05        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by scale :  [0]: 0.967786 (in this run)
02-Oct-2024 05:10:02 2024-10-02 05:09:05        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by Taylor coefficient :  [0]: 0.967786  [1]: 0.34563
02-Oct-2024 05:10:02 2024-10-02 05:09:12        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] iters=0->500 [500], model=0.961456->0.967787, peakres=0.000890469->0.000841445, Reached cycleniter.
02-Oct-2024 05:10:02 2024-10-02 05:09:12        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 4136 iterations.
02-Oct-2024 05:10:02 2024-10-02 05:09:14        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 12 -------------------------------------
02-Oct-2024 05:10:02
02-Oct-2024 05:10:02 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 05:10:02 2024-10-02 05:10:00        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 1.3s ( user 2.29s, system 0.34s)
02-Oct-2024 05:10:02 2024-10-02 05:10:00        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.000663691
02-Oct-2024 05:10:02 2024-10-02 05:10:00        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.000856548, over full image : 0.000856548
02-Oct-2024 05:10:02 2024-10-02 05:10:00        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 500, 'cyclethreshold': 0.00025222901604138315, 'loopgain': 0.10000000149011612, 'nsigma': 4.5, 'thresholdreached': False}
02-Oct-2024 05:10:02 2024-10-02 05:10:00        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] Run mtmfs minor-cycle | CycleThreshold=0.000252229, CycleNiter=500, Gain=0.1
02-Oct-2024 05:14:33 2024-10-02 05:10:02        INFO        SIImageStoreMultiTerm::calcFractionalBandwidth         MFS frequency range : 1.96387 GHz -> 4.03613GHz.Fractional Bandwidth : 69.0755 %.Reference Frequency for Taylor Expansion : 3GHz.
02-Oct-2024 05:14:33 2024-10-02 05:10:02        INFO        SDAlgorithmBase::deconvolve         Using n-sigma for threshold criterion: (cyclethreshold=0.000252229, nsigma threshold=0.000663691 )
02-Oct-2024 05:14:33 2024-10-02 05:10:03        INFO        MultiTermMatrixCleaner::mtclean()         Calculating convolutions of residual images with scales
02-Oct-2024 05:14:33 2024-10-02 05:10:05        INFO        MultiTermMatrixCleaner::mtclean()         Peak convolved residual (within mask)  : 0.000856548
02-Oct-2024 05:14:33 2024-10-02 05:10:07        INFO                [4140] Res: 0.000782588 Max: 6.54312e-07 Gain: 0.1 Pos: [3648, 3645] Scale: 0 Coeffs: -0.000673899  -0.00234213 
02-Oct-2024 05:14:33 2024-10-02 05:10:13        INFO                [4160] Res: 0.000727704 Max: 5.38705e-07 Gain: 0.1 Pos: [3644, 3642] Scale: 0 Coeffs: 0.000486116  0.00290855 
02-Oct-2024 05:14:33 2024-10-02 05:10:18        INFO                [4180] Res: 0.000708478 Max: 5.13231e-07 Gain: 0.1 Pos: [4242, 2784] Scale: 0 Coeffs: -0.000546161  0.00253742 
02-Oct-2024 05:14:33 2024-10-02 05:10:23        INFO                [4200] Res: 0.000702863 Max: 5.04194e-07 Gain: 0.1 Pos: [3617, 3648] Scale: 0 Coeffs: -0.000124617  -0.00374089 
02-Oct-2024 05:14:33 2024-10-02 05:10:28        INFO                [4220] Res: 0.000702201 Max: 4.98061e-07 Gain: 0.1 Pos: [3648, 3645] Scale: 0 Coeffs: -0.000588975  -0.00203507 
02-Oct-2024 05:14:33 2024-10-02 05:10:34        INFO                [4240] Res: 0.000700809 Max: 4.98173e-07 Gain: 0.1 Pos: [3645, 3653] Scale: 0 Coeffs: 0.000703611  0.000242945 
02-Oct-2024 05:14:33 2024-10-02 05:10:39        INFO                [4260] Res: 0.000696409 Max: 4.90359e-07 Gain: 0.1 Pos: [3890, 2759] Scale: 0 Coeffs: -0.000421044  0.00304089 
02-Oct-2024 05:14:33 2024-10-02 05:10:44        INFO                [4280] Res: 0.000696084 Max: 4.89359e-07 Gain: 0.1 Pos: [3676, 3673] Scale: 0 Coeffs: -0.000106349  -0.00370154 
02-Oct-2024 05:14:33 2024-10-02 05:10:49        INFO                [4300] Res: 0.000696084 Max: 4.86166e-07 Gain: 0.1 Pos: [3706, 2940] Scale: 0 Coeffs: -0.000602856  0.00193473 
02-Oct-2024 05:14:33 2024-10-02 05:10:55        INFO                [4320] Res: 0.000688057 Max: 4.83404e-07 Gain: 0.1 Pos: [3249, 3710] Scale: 0 Coeffs: -0.000645312  -0.0013328 
02-Oct-2024 05:14:33 2024-10-02 05:11:00        INFO                [4340] Res: 0.000688057 Max: 4.80981e-07 Gain: 0.1 Pos: [4146, 4139] Scale: 0 Coeffs: -0.000646521  0.00140584 
02-Oct-2024 05:14:33 2024-10-02 05:11:05        INFO                [4360] Res: 0.000688924 Max: 4.78482e-07 Gain: 0.1 Pos: [3468, 3699] Scale: 0 Coeffs: 0.000554078  0.00217383 
02-Oct-2024 05:14:33 2024-10-02 05:11:11        INFO                [4380] Res: 0.0006877 Max: 4.75877e-07 Gain: 0.1 Pos: [4183, 4322] Scale: 0 Coeffs: 0.000398987  -0.00305614 
02-Oct-2024 05:14:33 2024-10-02 05:11:16        INFO                [4400] Res: 0.000687664 Max: 4.74143e-07 Gain: 0.1 Pos: [4594, 3952] Scale: 0 Coeffs: -0.000525112  0.00243789 
02-Oct-2024 05:14:33 2024-10-02 05:11:21        INFO                [4420] Res: 0.000686552 Max: 4.73572e-07 Gain: 0.1 Pos: [4187, 4312] Scale: 0 Coeffs: 0.000233921  -0.00349452 
02-Oct-2024 05:14:33 2024-10-02 05:11:26        INFO                [4440] Res: 0.000686552 Max: 4.7153e-07 Gain: 0.1 Pos: [2668, 3726] Scale: 0 Coeffs: -0.000425341  0.00293152 
02-Oct-2024 05:14:33 2024-10-02 05:11:32        INFO                [4460] Res: 0.000684708 Max: 4.70054e-07 Gain: 0.1 Pos: [2940, 4180] Scale: 0 Coeffs: 0.000330555  -0.00325343 
02-Oct-2024 05:14:33 2024-10-02 05:11:37        INFO                [4480] Res: 0.000681917 Max: 4.68849e-07 Gain: 0.1 Pos: [3804, 3124] Scale: 0 Coeffs: 0.000684767  -0.000106415 
02-Oct-2024 05:14:33 2024-10-02 05:11:42        INFO                [4500] Res: 0.000681917 Max: 4.67601e-07 Gain: 0.1 Pos: [3238, 4217] Scale: 0 Coeffs: 0.000667388  0.000742424 
02-Oct-2024 05:14:33 2024-10-02 05:11:47        INFO                [4520] Res: 0.000681917 Max: 4.66568e-07 Gain: 0.1 Pos: [2595, 3419] Scale: 0 Coeffs: 0.000511749  -0.00247421 
02-Oct-2024 05:14:33 2024-10-02 05:11:53        INFO                [4540] Res: 0.000681917 Max: 4.67155e-07 Gain: 0.1 Pos: [4213, 2828] Scale: 0 Coeffs: 0.000652367  -0.00115394 
02-Oct-2024 05:14:33 2024-10-02 05:11:58        INFO                [4560] Res: 0.000680753 Max: 4.64165e-07 Gain: 0.1 Pos: [3320, 2854] Scale: 0 Coeffs: 0.000535823  -0.00230665 
02-Oct-2024 05:14:33 2024-10-02 05:12:03        INFO                [4580] Res: 0.000679018 Max: 4.62796e-07 Gain: 0.1 Pos: [3977, 3121] Scale: 0 Coeffs: -0.000652355  0.00109527 
02-Oct-2024 05:14:33 2024-10-02 05:12:09        INFO                [4600] Res: 0.000679018 Max: 4.62493e-07 Gain: 0.1 Pos: [3092, 3150] Scale: 0 Coeffs: 0.000574487  -0.0020052 
02-Oct-2024 05:14:33 2024-10-02 05:12:14        INFO                [4620] Res: 0.000676235 Max: 4.60998e-07 Gain: 0.1 Pos: [4065, 3053] Scale: 0 Coeffs: 0.000499951  -0.00251061 
02-Oct-2024 05:14:33 2024-10-02 05:12:18        INFO        MultiTermMatrixCleaner::mtclean()         Reached max number of iterations for this minor cycle
02-Oct-2024 05:14:33 2024-10-02 05:12:18        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by scale :  [0]: 0.963763 (in this run)
02-Oct-2024 05:14:33 2024-10-02 05:12:18        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by Taylor coefficient :  [0]: 0.963763  [1]: 0.343209
02-Oct-2024 05:14:33 2024-10-02 05:12:24        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] iters=0->500 [500], model=0.967786->0.963763, peakres=0.000856548->0.000717626, Reached cycleniter.
02-Oct-2024 05:14:33 2024-10-02 05:12:24        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 4636 iterations.
02-Oct-2024 05:14:33 2024-10-02 05:12:27        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 13 -------------------------------------
02-Oct-2024 05:14:33
02-Oct-2024 05:14:33 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 05:14:33 2024-10-02 05:13:12        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 1.31s ( user 2s, system 0.41s)
02-Oct-2024 05:14:33 2024-10-02 05:13:12        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.000660237
02-Oct-2024 05:14:33 2024-10-02 05:13:12        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.000774736, over full image : 0.000774736
02-Oct-2024 05:14:33 2024-10-02 05:13:12        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 500, 'cyclethreshold': 0.0002281376364408061, 'loopgain': 0.10000000149011612, 'nsigma': 4.5, 'thresholdreached': False}
02-Oct-2024 05:14:33 2024-10-02 05:13:12        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] Run mtmfs minor-cycle | CycleThreshold=0.000228138, CycleNiter=500, Gain=0.1
02-Oct-2024 05:14:33 2024-10-02 05:13:15        INFO        SIImageStoreMultiTerm::calcFractionalBandwidth         MFS frequency range : 1.96387 GHz -> 4.03613GHz.Fractional Bandwidth : 69.0755 %.Reference Frequency for Taylor Expansion : 3GHz.
02-Oct-2024 05:14:33 2024-10-02 05:13:15        INFO        SDAlgorithmBase::deconvolve         Using n-sigma for threshold criterion: (cyclethreshold=0.000228138, nsigma threshold=0.000660237 )
02-Oct-2024 05:14:33 2024-10-02 05:13:16        INFO        MultiTermMatrixCleaner::mtclean()         Calculating convolutions of residual images with scales
02-Oct-2024 05:14:33 2024-10-02 05:13:18        INFO        MultiTermMatrixCleaner::mtclean()         Peak convolved residual (within mask)  : 0.000774736
02-Oct-2024 05:14:33 2024-10-02 05:13:20        INFO                [4640] Res: 0.000707712 Max: 5.29274e-07 Gain: 0.1 Pos: [3647, 3647] Scale: 0 Coeffs: 0.000702093  0.000962579 
02-Oct-2024 05:14:33 2024-10-02 05:13:25        INFO                [4660] Res: 0.000682849 Max: 4.752e-07 Gain: 0.1 Pos: [4232, 3451] Scale: 0 Coeffs: 0.0006717  0.000774201 
02-Oct-2024 05:14:33 2024-10-02 05:13:30        INFO                [4680] Res: 0.000678336 Max: 4.65599e-07 Gain: 0.1 Pos: [4553, 3487] Scale: 0 Coeffs: 0.000406902  -0.00297636 
02-Oct-2024 05:14:33 2024-10-02 05:13:36        INFO                [4700] Res: 0.000675561 Max: 4.58838e-07 Gain: 0.1 Pos: [2829, 3759] Scale: 0 Coeffs: -0.000533946  0.00228521 
02-Oct-2024 05:14:33 2024-10-02 05:13:41        INFO                [4720] Res: 0.000673544 Max: 4.5613e-07 Gain: 0.1 Pos: [3180, 3805] Scale: 0 Coeffs: -0.000665825  0.000669561 
02-Oct-2024 05:14:33 2024-10-02 05:13:46        INFO                [4740] Res: 0.000671633 Max: 4.5369e-07 Gain: 0.1 Pos: [2903, 3867] Scale: 0 Coeffs: -0.000636141  -0.00113301 
02-Oct-2024 05:14:33 2024-10-02 05:13:52        INFO                [4760] Res: 0.000671271 Max: 4.52554e-07 Gain: 0.1 Pos: [3891, 3521] Scale: 0 Coeffs: -0.000625644  -0.00127245 
02-Oct-2024 05:14:33 2024-10-02 05:13:57        INFO                [4780] Res: 0.000669517 Max: 4.50406e-07 Gain: 0.1 Pos: [3609, 3645] Scale: 0 Coeffs: 0.000394749  0.00287818 
02-Oct-2024 05:14:33 2024-10-02 05:14:02        INFO                [4800] Res: 0.00066888 Max: 4.48929e-07 Gain: 0.1 Pos: [3427, 4018] Scale: 0 Coeffs: 0.000315628  0.00314422 
02-Oct-2024 05:14:33 2024-10-02 05:14:07        INFO                [4820] Res: 0.000666554 Max: 4.47699e-07 Gain: 0.1 Pos: [2565, 3416] Scale: 0 Coeffs: 0.000461585  -0.00264128 
02-Oct-2024 05:14:33 2024-10-02 05:14:13        INFO                [4840] Res: 0.000666554 Max: 4.46559e-07 Gain: 0.1 Pos: [4194, 4278] Scale: 0 Coeffs: -0.000361363  0.00304937 
02-Oct-2024 05:14:33 2024-10-02 05:14:18        INFO                [4860] Res: 0.000666554 Max: 4.45076e-07 Gain: 0.1 Pos: [4023, 2774] Scale: 0 Coeffs: -0.000562315  0.00197752 
02-Oct-2024 05:14:33 2024-10-02 05:14:23        INFO                [4880] Res: 0.000664029 Max: 4.43945e-07 Gain: 0.1 Pos: [3984, 3505] Scale: 0 Coeffs: 0.000322886  0.0030996 
02-Oct-2024 05:14:33 2024-10-02 05:14:28        INFO                [4900] Res: 0.000663084 Max: 4.42799e-07 Gain: 0.1 Pos: [3418, 2878] Scale: 0 Coeffs: -0.000405788  0.00286696 
02-Oct-2024 05:17:14 2024-10-02 05:14:34        INFO                [4920] Res: 0.000662729 Max: 4.43004e-07 Gain: 0.1 Pos: [3645, 3653] Scale: 0 Coeffs: 0.000656237  0.000541101 
02-Oct-2024 05:17:14 2024-10-02 05:14:39        INFO                [4940] Res: 0.000662729 Max: 4.40463e-07 Gain: 0.1 Pos: [4508, 2991] Scale: 0 Coeffs: -0.000492912  0.00242954 
02-Oct-2024 05:17:14 2024-10-02 05:14:44        INFO                [4960] Res: 0.000661249 Max: 4.39378e-07 Gain: 0.1 Pos: [3814, 3697] Scale: 0 Coeffs: 0.000662514  6.95606e-05 
02-Oct-2024 05:17:14 2024-10-02 05:14:50        INFO                [4980] Res: 0.000661277 Max: 4.38211e-07 Gain: 0.1 Pos: [3542, 2959] Scale: 0 Coeffs: 0.000274683  -0.00325722 
02-Oct-2024 05:17:14 2024-10-02 05:14:55        INFO        MultiTermMatrixCleaner::mtclean()         Reached stopping threshold at iteration 4999. Peak residual 0.000659778 (within mask)
02-Oct-2024 05:17:14 2024-10-02 05:14:55        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by scale :  [0]: 0.966558 (in this run)
02-Oct-2024 05:17:14 2024-10-02 05:14:55        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by Taylor coefficient :  [0]: 0.966558  [1]: 0.347981
02-Oct-2024 05:17:14 2024-10-02 05:15:01        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] iters=0->363 [363], model=0.963762->0.966558, peakres=0.000774736->0.000704325, Exited mtmfs minor cycle without reaching any stopping criterion.
02-Oct-2024 05:17:14 2024-10-02 05:15:01        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 4999 iterations.
02-Oct-2024 05:17:14 2024-10-02 05:15:04        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 14 -------------------------------------
02-Oct-2024 05:17:14
02-Oct-2024 05:17:14 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 05:17:14 2024-10-02 05:15:48        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 1.29s ( user 1.95s, system 0.43s)
02-Oct-2024 05:17:14 2024-10-02 05:15:48        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.000658003
02-Oct-2024 05:17:14 2024-10-02 05:15:48        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.000721497, over full image : 0.000721497
02-Oct-2024 05:17:14 2024-10-02 05:15:48        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 500, 'cyclethreshold': 0.00021246027608867735, 'loopgain': 0.10000000149011612, 'nsigma': 4.5, 'thresholdreached': False}
02-Oct-2024 05:17:14 2024-10-02 05:15:48        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] Run mtmfs minor-cycle | CycleThreshold=0.00021246, CycleNiter=500, Gain=0.1
02-Oct-2024 05:17:14 2024-10-02 05:15:51        INFO        SIImageStoreMultiTerm::calcFractionalBandwidth         MFS frequency range : 1.96387 GHz -> 4.03613GHz.Fractional Bandwidth : 69.0755 %.Reference Frequency for Taylor Expansion : 3GHz.
02-Oct-2024 05:17:14 2024-10-02 05:15:51        INFO        SDAlgorithmBase::deconvolve         Using n-sigma for threshold criterion: (cyclethreshold=0.00021246, nsigma threshold=0.000658003 )
02-Oct-2024 05:17:14 2024-10-02 05:15:52        INFO        MultiTermMatrixCleaner::mtclean()         Calculating convolutions of residual images with scales
02-Oct-2024 05:17:14 2024-10-02 05:15:54        INFO        MultiTermMatrixCleaner::mtclean()         Peak convolved residual (within mask)  : 0.000721497
02-Oct-2024 05:17:14 2024-10-02 05:15:55        INFO                [5000] Res: 0.00070205 Max: 5.20947e-07 Gain: 0.1 Pos: [3646, 3644] Scale: 0 Coeffs: -0.00072117  -0.000105917 
02-Oct-2024 05:17:14 2024-10-02 05:16:01        INFO                [5020] Res: 0.000664435 Max: 4.46682e-07 Gain: 0.1 Pos: [3659, 3647] Scale: 0 Coeffs: -0.000347702  -0.00303273 
02-Oct-2024 05:17:14 2024-10-02 05:16:06        INFO        MultiTermMatrixCleaner::mtclean()         Reached stopping threshold at iteration 5039. Peak residual 0.000657954 (within mask)
02-Oct-2024 05:17:14 2024-10-02 05:16:06        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by scale :  [0]: 0.96559 (in this run)
02-Oct-2024 05:17:14 2024-10-02 05:16:06        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by Taylor coefficient :  [0]: 0.96559  [1]: 0.347874
02-Oct-2024 05:17:14 2024-10-02 05:16:12        INFO        SDAlgorithmBase::deconvolve         [J1927_ql_iter1] iters=0->40 [40], model=0.966558->0.96559, peakres=0.000721497->0.000657994, Reached n-sigma threshold.
02-Oct-2024 05:17:14 2024-10-02 05:16:12        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 5039 iterations.
02-Oct-2024 05:17:14 2024-10-02 05:16:15        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 15 -------------------------------------
02-Oct-2024 05:17:14
02-Oct-2024 05:17:14 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 05:17:14 2024-10-02 05:17:00        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 1.31s ( user 1.98s, system 0.42s)
02-Oct-2024 05:17:14 2024-10-02 05:17:00        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.000657805
02-Oct-2024 05:17:14 2024-10-02 05:17:00        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.000657891, over full image : 0.000657891
02-Oct-2024 05:17:14 2024-10-02 05:17:00        INFO        tclean::::casa        Reached global stopping criterion : any combination of n-sigma and other valid exit criterion
02-Oct-2024 05:17:14 2024-10-02 05:17:00        INFO        tclean::::casa        getSummary call: fullsummary=False
02-Oct-2024 05:17:14 2024-10-02 05:17:01        INFO        MultiTermMatrixCleaner::computeprincipalsolution()         MTMC :: Computing principal solution on residuals
02-Oct-2024 05:17:14 2024-10-02 05:17:02        INFO        SDAlgorithmBase::restore         [J1927_ql_iter1] : Restoring model image.
02-Oct-2024 05:17:14 2024-10-02 05:17:02        INFO        SIImageStore::restore         Getting common beam
02-Oct-2024 05:17:14 2024-10-02 05:17:02        INFO        SIImageStore::restore         Common Beam : 2.45211 arcsec, 2.07917 arcsec, -18.882 deg
02-Oct-2024 05:17:14 2024-10-02 05:17:05        INFO        SIImageStore::restore         Common Beam : 2.45211 arcsec, 2.07917 arcsec, -18.882 deg
02-Oct-2024 05:17:14 2024-10-02 05:17:09        INFO        SIImageStoreMultiTerm::calculateAlphaBeta         Calculating spectral parameters for Intensity > peakresidual/10 = 6.58855e-05 Jy/beam
02-Oct-2024 05:17:14 2024-10-02 05:17:14        INFO        SIImageStoreMultiTerm::calculateAlphaBeta         Written Spectral Index Error Image : /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASA-CMTSP3-V1STE/work/test_stk_vlass_pipeline_imaging_1v2/J1927_ql_iter1.alpha.error
02-Oct-2024 05:17:14 2024-10-02 05:17:14        INFO        SDAlgorithmMSMFS::restore         Restored images :
02-Oct-2024 05:17:14 2024-10-02 05:17:14        INFO        SDAlgorithmMSMFS::restore         /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASA-CMTSP3-V1STE/work/test_stk_vlass_pipeline_imaging_1v2/J1927_ql_iter1.image.tt0  (model=/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASA-CMTSP3-V1STE/work/test_stk_vlass_pipeline_imaging_1v2/J1927_ql_iter1.model.tt0)
02-Oct-2024 05:17:14 2024-10-02 05:17:14        INFO        SDAlgorithmMSMFS::restore         /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASA-CMTSP3-V1STE/work/test_stk_vlass_pipeline_imaging_1v2/J1927_ql_iter1.image.tt1  (model=/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASA-CMTSP3-V1STE/work/test_stk_vlass_pipeline_imaging_1v2/J1927_ql_iter1.model.tt1)
02-Oct-2024 05:17:14 2024-10-02 05:17:14        INFO        SDAlgorithmMSMFS::restore         
02-Oct-2024 05:17:14 2024-10-02 05:17:15        INFO        tclean::::casa        Searching for images with prefix 'J1927_ql_iter1'... Found these, writing history into them: ['J1927_ql_iter1.weight.tt2', 'J1927_ql_iter1.residual.tt1', 'J1927_ql_iter1.image.tt0', 'J1927_ql_iter1.weight.tt0', 'J1927_ql_iter1.psf.tt2', 'J1927_ql_iter1.image.tt1', 'J1927_ql_iter1.alpha', 'J1927_ql_iter1.psf.tt0', 'J1927_ql_iter1.sumwt.tt1', 'J1927_ql_iter1.pb.tt0', 'J1927_ql_iter1.alpha.error', 'J1927_ql_iter1.mask', 'J1927_ql_iter1.weight.tt1', 'J1927_ql_iter1.model.tt1', 'J1927_ql_iter1.sumwt.tt2', 'J1927_ql_iter1.sumwt.tt0', 'J1927_ql_iter1.residual.tt0', 'J1927_ql_iter1.model.tt0', 'J1927_ql_iter1.psf.tt1']
02-Oct-2024 05:17:14 2024-10-02 05:17:15        INFO        tclean::::casa        Task tclean complete. Start time: 2024-10-02 00:38:12.461852 End time: 2024-10-02 01:17:14.968724
02-Oct-2024 05:17:14 2024-10-02 05:17:15        INFO        tclean::::casa        ##### End Task: tclean               #####
02-Oct-2024 05:17:14 2024-10-02 05:17:15        INFO        tclean::::casa        ##########################################
02-Oct-2024 05:17:14 2024-10-02 05:17:15        INFO        impbcor::::casa        ##########################################
02-Oct-2024 05:17:14 2024-10-02 05:17:15        INFO        impbcor::::casa        ##### Begin Task: impbcor            #####
02-Oct-2024 05:17:14 2024-10-02 05:17:15        INFO        impbcor::::casa        impbcor( imagename='J1927_ql_iter1.image.tt0', pbimage='J1927_ql_iter1.pb.tt0', outfile='J1927_ql_iter1.image.pbcor.tt0', overwrite=False, box='', region='', chans='', stokes='', mask='', mode='divide', cutoff=-1.0, stretch=False )
02-Oct-2024 05:17:14 2024-10-02 05:17:15        INFO        impbcor::CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
02-Oct-2024 05:17:14 2024-10-02 05:17:15        INFO        impbcor::CasacRegionManager::fromBCS        Using all spectral channels.
02-Oct-2024 05:17:14 2024-10-02 05:17:15        INFO        impbcor::CasacRegionManager::fromBCS        Using polarizations ALL
02-Oct-2024 05:17:14 2024-10-02 05:17:15        INFO        impbcor::ImageRegion::fromRecord        Selected bounding box :
02-Oct-2024 05:17:26 2024-10-02 05:17:15        INFO        impbcor::ImageRegion::fromRecord+            [0, 0, 0, 0] to [7289, 7289, 0, 0]  (19:35:40.463, +60.15.50.731, I, 3e+09Hz to 19:18:47.913, +62.17.16.346, I, 3e+09Hz)
02-Oct-2024 05:17:26 2024-10-02 05:17:15        INFO        impbcor::ImageRegion::fromRecord        Selected bounding box :
02-Oct-2024 05:17:26 2024-10-02 05:17:15        INFO        impbcor::ImageRegion::fromRecord+            [0, 0, 0, 0] to [7289, 7289, 0, 0]  (19:35:40.463, +60.15.50.731, I, 3e+09Hz to 19:18:47.913, +62.17.16.346, I, 3e+09Hz)
02-Oct-2024 05:17:26 2024-10-02 05:17:15        INFO        impbcor::SubImageFactory::createImage        Creating image 'J1927_ql_iter1.image.pbcor.tt0' of shape [7290, 7290, 1, 1]
02-Oct-2024 05:17:26 2024-10-02 05:17:15        INFO        impbcor::ImageMaskAttacher::makeMask        Created mask `mask0'
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        impbcor::::casa        Task impbcor complete. Start time: 2024-10-02 01:17:14.970839 End time: 2024-10-02 01:17:15.585588
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        impbcor::::casa        ##### End Task: impbcor              #####
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        impbcor::::casa        ##########################################
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        impbcor::::casa        ##########################################
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        impbcor::::casa        ##### Begin Task: impbcor            #####
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        impbcor::::casa        impbcor( imagename='J1927_ql_iter1.residual.tt0', pbimage='J1927_ql_iter1.pb.tt0', outfile='J1927_ql_iter1.image.residual.pbcor.tt0', overwrite=False, box='', region='', chans='', stokes='', mask='', mode='divide', cutoff=-1.0, stretch=False )
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        impbcor::CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        impbcor::CasacRegionManager::fromBCS        Using all spectral channels.
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        impbcor::CasacRegionManager::fromBCS        Using polarizations ALL
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        impbcor::ImageRegion::fromRecord        Selected bounding box :
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        impbcor::ImageRegion::fromRecord+            [0, 0, 0, 0] to [7289, 7289, 0, 0]  (19:35:40.463, +60.15.50.731, I, 3e+09Hz to 19:18:47.913, +62.17.16.346, I, 3e+09Hz)
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        impbcor::ImageRegion::fromRecord        Selected bounding box :
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        impbcor::ImageRegion::fromRecord+            [0, 0, 0, 0] to [7289, 7289, 0, 0]  (19:35:40.463, +60.15.50.731, I, 3e+09Hz to 19:18:47.913, +62.17.16.346, I, 3e+09Hz)
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        impbcor::SubImageFactory::createImage        Creating image 'J1927_ql_iter1.image.residual.pbcor.tt0' of shape [7290, 7290, 1, 1]
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        impbcor::ImageMaskAttacher::makeMask        Created mask `mask0'
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        impbcor::::casa        Task impbcor complete. Start time: 2024-10-02 01:17:15.586490 End time: 2024-10-02 01:17:16.193305
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        impbcor::::casa        ##### End Task: impbcor              #####
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        impbcor::::casa        ##########################################
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        imdev::::casa        ##########################################
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        imdev::::casa        ##### Begin Task: imdev              #####
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        imdev::::casa        imdev( imagename='J1927_ql_iter1.image.pbcor.tt0', outfile='J1927_ql_iter1.image.pbcor.tt0.rms', region='', box='', chans='', stokes='', mask='', overwrite=True, stretch=False, grid=[10, 10], anchor='ref', xlength='60arcsec', ylength='60arcsec', interp='cubic', stattype='xmadm', statalg='chauvenet', zscore=-1.0, maxiter=-1 )
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        imdev::CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        imdev::CasacRegionManager::fromBCS        Using all spectral channels.
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        imdev::CasacRegionManager::fromBCS        Using polarizations ALL
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        imdev::StatImageCreator::useReferencePixelAsAnchor        Anchor being set at pixel [3645,3645], at/near image reference pixel.
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        imdev::ImageRegion::fromRecord        Selected bounding box :
02-Oct-2024 05:17:26 2024-10-02 05:17:16        INFO        imdev::ImageRegion::fromRecord+            [0, 0, 0, 0] to [7289, 7289, 0, 0]  (19:35:40.463, +60.15.50.731, I, 3e+09Hz to 19:18:47.913, +62.17.16.346, I, 3e+09Hz)
02-Oct-2024 05:17:26 2024-10-02 05:17:17        INFO        imdev::StatImageCreator::_computeStat        Using rectangular region of specified dimensions 60 arcsec x 60 arcsec (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 61 pix x 61 pix) to choose pixels for computing MEDIAN OF THE ABSOLUTE DEVATION FROM THE MEDIAN using the Chauvenet criterion/z-score algorithm around each of 531441 grid points in 1 planes.
02-Oct-2024 05:17:26 ....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 05:17:26 2024-10-02 05:17:25        INFO        imdev::StatImageCreator::_doInterpolation        Interpolate using CUBIC algorithm.
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        imdev::SubImageFactory::createImage        Creating image 'J1927_ql_iter1.image.pbcor.tt0.rms' of shape [7290, 7290, 1, 1]
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        imdev::ImageMaskAttacher::makeMask        Created mask `mask0'
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        imdev::::casa        Task imdev complete. Start time: 2024-10-02 01:17:16.194794 End time: 2024-10-02 01:17:26.438517
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        imdev::::casa        ##### End Task: imdev                #####
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        imdev::::casa        ##########################################
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        imhead::::casa        ##########################################
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        imhead::::casa        ##### Begin Task: imhead             #####
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        imhead::::casa        imhead( imagename='J1927_ql_iter1.image.tt0', mode='summary', hdkey='', hdvalue='', verbose=False )
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary        
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        Image name       : J1927_ql_iter1.image.tt0
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        Object name      : 1928422+611911
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        Image type       : PagedImage
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        Image quantity   : Intensity
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        Pixel mask(s)    : mask0
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        Region(s)        : None
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        Image units      : Jy/beam
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        Restoring Beam   : 2.45211 arcsec, 2.07917 arcsec, -18.882 deg
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary        
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        Direction reference : J2000
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        Spectral  reference : LSRK
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        Velocity  type      : RADIO
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        Rest frequency      : 2.9878e+09 Hz
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        Pointing center     :  19:27:30.443000  +61.17.32.898000
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        Telescope           : EVLA
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        Observer            : Dr. Vlass Scientist
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        Date observation    : 2019/04/12/14:37:40.125000
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        Telescope position: [-1.60116e+06m, -5.04199e+06m, 3.55488e+06m] (ITRF)
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        Axis Coord Type      Name             Proj Shape Tile   Coord value at pixel         Coord incr Units
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        -----------------------------------------------------------------------------------------------------
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        0    0     Direction Right Ascension   SIN  7290  162  19:27:30.443  3645.00      -1.000000e+00 arcsec
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        1    0     Direction Declination       SIN  7290  162 +61.17.32.898  3645.00       1.000000e+00 arcsec
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        2    1     Stokes    Stokes                    1    1             I
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+        3    2     Spectral  Frequency                 1    1         3e+09     0.00 2.072263846574e+09 Hz
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        ImageMetaData::summary+                             Velocity                              -1224.13     0.00      -2.079286e+05 km/s
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        imhead::::casa        Task imhead complete. Start time: 2024-10-02 01:17:26.439571 End time: 2024-10-02 01:17:26.443762
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        imhead::::casa        ##### End Task: imhead               #####
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        imhead::::casa        ##########################################
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        imsubimage::::casa        ##########################################
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        imsubimage::::casa        ##### Begin Task: imsubimage         #####
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        imsubimage::::casa        imsubimage( imagename='J1927_ql_iter1.image.tt0', outfile='J1927_ql_iter1.image.tt0.subim', box='1785,1785,5506,5506', region='', chans='', stokes='', mask='', dropdeg=False, overwrite=False, verbose=True, stretch=False, keepaxes=[] )
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        imsubimage::CasacRegionManager::fromBCS        Using specified box(es) 1785,1785,5506,5506
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        imsubimage::ImageRegion::fromRecord        Selected bounding box :
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        imsubimage::ImageRegion::fromRecord+            [1785, 1785, 0, 0] to [5506, 5506, 0, 0]  (19:31:44.404, +60.46.17.807, I, 3e+09Hz to 19:23:07.837, +61.48.18.336, I, 3e+09Hz)
02-Oct-2024 05:17:26 2024-10-02 05:17:26        INFO        imsubimage::ImageRegion::fromRecord        Creating image 'J1927_ql_iter1.image.tt0.subim' of shape [3722, 3722, 1, 1]
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imsubimage::ImageMaskAttacher::makeMask        Created mask `mask0'
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imsubimage::::casa        Task imsubimage complete. Start time: 2024-10-02 01:17:26.445457 End time: 2024-10-02 01:17:26.633620
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imsubimage::::casa        ##### End Task: imsubimage           #####
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imsubimage::::casa        ##########################################
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imhead::::casa        ##########################################
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imhead::::casa        ##### Begin Task: imhead             #####
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imhead::::casa        imhead( imagename='J1927_ql_iter1.residual.tt0', mode='summary', hdkey='', hdvalue='', verbose=False )
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary        
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Image name       : J1927_ql_iter1.residual.tt0
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Object name      : 1928422+611911
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Image type       : PagedImage
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Image quantity   : Intensity
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Pixel mask(s)    : mask0
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Region(s)        : None
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary        
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Direction reference : J2000
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Spectral  reference : LSRK
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Velocity  type      : RADIO
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Rest frequency      : 2.9878e+09 Hz
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Pointing center     :  19:27:30.443000  +61.17.32.898000
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Telescope           : EVLA
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Observer            : Dr. Vlass Scientist
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Date observation    : 2019/04/12/14:37:40.125000
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Telescope position: [-1.60116e+06m, -5.04199e+06m, 3.55488e+06m] (ITRF)
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Axis Coord Type      Name             Proj Shape Tile   Coord value at pixel         Coord incr Units
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        -----------------------------------------------------------------------------------------------------
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        0    0     Direction Right Ascension   SIN  7290  162  19:27:30.443  3645.00      -1.000000e+00 arcsec
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        1    0     Direction Declination       SIN  7290  162 +61.17.32.898  3645.00       1.000000e+00 arcsec
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        2    1     Stokes    Stokes                    1    1             I
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        3    2     Spectral  Frequency                 1    1         3e+09     0.00 2.072263846574e+09 Hz
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+                             Velocity                              -1224.13     0.00      -2.079286e+05 km/s
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imhead::::casa        Task imhead complete. Start time: 2024-10-02 01:17:26.634254 End time: 2024-10-02 01:17:26.638172
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imhead::::casa        ##### End Task: imhead               #####
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imhead::::casa        ##########################################
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imsubimage::::casa        ##########################################
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imsubimage::::casa        ##### Begin Task: imsubimage         #####
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imsubimage::::casa        imsubimage( imagename='J1927_ql_iter1.residual.tt0', outfile='J1927_ql_iter1.residual.tt0.subim', box='1785,1785,5506,5506', region='', chans='', stokes='', mask='', dropdeg=False, overwrite=False, verbose=True, stretch=False, keepaxes=[] )
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imsubimage::CasacRegionManager::fromBCS        Using specified box(es) 1785,1785,5506,5506
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imsubimage::ImageRegion::fromRecord        Selected bounding box :
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imsubimage::ImageRegion::fromRecord+            [1785, 1785, 0, 0] to [5506, 5506, 0, 0]  (19:31:44.404, +60.46.17.807, I, 3e+09Hz to 19:23:07.837, +61.48.18.336, I, 3e+09Hz)
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imsubimage::ImageRegion::fromRecord        Creating image 'J1927_ql_iter1.residual.tt0.subim' of shape [3722, 3722, 1, 1]
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imsubimage::ImageMaskAttacher::makeMask        Created mask `mask0'
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imsubimage::::casa        Task imsubimage complete. Start time: 2024-10-02 01:17:26.639465 End time: 2024-10-02 01:17:26.822682
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imsubimage::::casa        ##### End Task: imsubimage           #####
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imsubimage::::casa        ##########################################
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imhead::::casa        ##########################################
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imhead::::casa        ##### Begin Task: imhead             #####
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        imhead::::casa        imhead( imagename='J1927_ql_iter1.image.pbcor.tt0', mode='summary', hdkey='', hdvalue='', verbose=False )
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary        
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Image name       : J1927_ql_iter1.image.pbcor.tt0
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Object name      : 1928422+611911
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Image type       : PagedImage
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Image quantity   : Intensity
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Pixel mask(s)    : mask0
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Region(s)        : None
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Image units      : Jy/beam
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Restoring Beam   : 2.45211 arcsec, 2.07917 arcsec, -18.882 deg
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary        
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Direction reference : J2000
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Spectral  reference : LSRK
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Velocity  type      : RADIO
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Rest frequency      : 2.9878e+09 Hz
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Pointing center     :  19:27:30.443000  +61.17.32.898000
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Telescope           : EVLA
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Observer            : Dr. Vlass Scientist
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Date observation    : 2019/04/12/14:37:40.125000
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Telescope position: [-1.60116e+06m, -5.04199e+06m, 3.55488e+06m] (ITRF)
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Axis Coord Type      Name             Proj Shape Tile   Coord value at pixel         Coord incr Units
02-Oct-2024 05:17:26 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        -----------------------------------------------------------------------------------------------------
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        0    0     Direction Right Ascension   SIN  7290  162  19:27:30.443  3645.00      -1.000000e+00 arcsec
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        1    0     Direction Declination       SIN  7290  162 +61.17.32.898  3645.00       1.000000e+00 arcsec
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        2    1     Stokes    Stokes                    1    1             I
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        3    2     Spectral  Frequency                 1    1         3e+09     0.00 2.072263846574e+09 Hz
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+                             Velocity                              -1224.13     0.00      -2.079286e+05 km/s
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imhead::::casa        Task imhead complete. Start time: 2024-10-02 01:17:26.823309 End time: 2024-10-02 01:17:26.827351
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imhead::::casa        ##### End Task: imhead               #####
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imhead::::casa        ##########################################
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::::casa        ##########################################
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::::casa        ##### Begin Task: imsubimage         #####
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::::casa        imsubimage( imagename='J1927_ql_iter1.image.pbcor.tt0', outfile='J1927_ql_iter1.image.pbcor.tt0.subim', box='1785,1785,5506,5506', region='', chans='', stokes='', mask='', dropdeg=False, overwrite=False, verbose=True, stretch=False, keepaxes=[] )
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::CasacRegionManager::fromBCS        Using specified box(es) 1785,1785,5506,5506
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::ImageRegion::fromRecord        Selected bounding box :
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::ImageRegion::fromRecord+            [1785, 1785, 0, 0] to [5506, 5506, 0, 0]  (19:31:44.404, +60.46.17.807, I, 3e+09Hz to 19:23:07.837, +61.48.18.336, I, 3e+09Hz)
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::ImageRegion::fromRecord        Creating image 'J1927_ql_iter1.image.pbcor.tt0.subim' of shape [3722, 3722, 1, 1]
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::ImageMaskAttacher::makeMask        Created mask `mask0'
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::::casa        Task imsubimage complete. Start time: 2024-10-02 01:17:26.828727 End time: 2024-10-02 01:17:27.013771
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::::casa        ##### End Task: imsubimage           #####
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::::casa        ##########################################
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imhead::::casa        ##########################################
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imhead::::casa        ##### Begin Task: imhead             #####
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imhead::::casa        imhead( imagename='J1927_ql_iter1.image.pbcor.tt0.rms', mode='summary', hdkey='', hdvalue='', verbose=False )
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary        
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Image name       : J1927_ql_iter1.image.pbcor.tt0.rms
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Object name      : 1928422+611911
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Image type       : PagedImage
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Image quantity   : Intensity
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Pixel mask(s)    : mask0
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Region(s)        : None
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Image units      : Jy/beam
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Restoring Beam   : 2.45211 arcsec, 2.07917 arcsec, -18.882 deg
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary        
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Direction reference : J2000
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Spectral  reference : LSRK
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Velocity  type      : RADIO
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Rest frequency      : 2.9878e+09 Hz
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Pointing center     :  19:27:30.443000  +61.17.32.898000
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Telescope           : EVLA
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Observer            : Dr. Vlass Scientist
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Date observation    : 2019/04/12/14:37:40.125000
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Telescope position: [-1.60116e+06m, -5.04199e+06m, 3.55488e+06m] (ITRF)
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Axis Coord Type      Name             Proj Shape Tile   Coord value at pixel         Coord incr Units
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        -----------------------------------------------------------------------------------------------------
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        0    0     Direction Right Ascension   SIN  7290  162  19:27:30.443  3645.00      -1.000000e+00 arcsec
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        1    0     Direction Declination       SIN  7290  162 +61.17.32.898  3645.00       1.000000e+00 arcsec
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        2    1     Stokes    Stokes                    1    1             I
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        3    2     Spectral  Frequency                 1    1         3e+09     0.00 2.072263846574e+09 Hz
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+                             Velocity                              -1224.13     0.00      -2.079286e+05 km/s
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imhead::::casa        Task imhead complete. Start time: 2024-10-02 01:17:27.014481 End time: 2024-10-02 01:17:27.018617
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imhead::::casa        ##### End Task: imhead               #####
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imhead::::casa        ##########################################
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::::casa        ##########################################
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::::casa        ##### Begin Task: imsubimage         #####
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::::casa        imsubimage( imagename='J1927_ql_iter1.image.pbcor.tt0.rms', outfile='J1927_ql_iter1.image.pbcor.tt0.rms.subim', box='1785,1785,5506,5506', region='', chans='', stokes='', mask='', dropdeg=False, overwrite=False, verbose=True, stretch=False, keepaxes=[] )
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::CasacRegionManager::fromBCS        Using specified box(es) 1785,1785,5506,5506
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::ImageRegion::fromRecord        Selected bounding box :
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::ImageRegion::fromRecord+            [1785, 1785, 0, 0] to [5506, 5506, 0, 0]  (19:31:44.404, +60.46.17.807, I, 3e+09Hz to 19:23:07.837, +61.48.18.336, I, 3e+09Hz)
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::ImageRegion::fromRecord        Creating image 'J1927_ql_iter1.image.pbcor.tt0.rms.subim' of shape [3722, 3722, 1, 1]
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::ImageMaskAttacher::makeMask        Created mask `mask0'
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::::casa        Task imsubimage complete. Start time: 2024-10-02 01:17:27.019999 End time: 2024-10-02 01:17:27.203188
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::::casa        ##### End Task: imsubimage           #####
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::::casa        ##########################################
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imhead::::casa        ##########################################
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imhead::::casa        ##### Begin Task: imhead             #####
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imhead::::casa        imhead( imagename='J1927_ql_iter1.psf.tt0', mode='summary', hdkey='', hdvalue='', verbose=False )
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary        
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Image name       : J1927_ql_iter1.psf.tt0
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Object name      : 1928422+611911
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Image type       : PagedImage
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Image quantity   : Intensity
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Pixel mask(s)    : None
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Region(s)        : None
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Restoring Beam   : 2.45211 arcsec, 2.07917 arcsec, -18.882 deg
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary        
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Direction reference : J2000
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Spectral  reference : LSRK
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Velocity  type      : RADIO
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Rest frequency      : 2.9878e+09 Hz
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Pointing center     :  19:27:30.443000  +61.17.32.898000
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Telescope           : EVLA
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Observer            : Dr. Vlass Scientist
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Date observation    : 2019/04/12/14:37:40.125000
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Telescope position: [-1.60116e+06m, -5.04199e+06m, 3.55488e+06m] (ITRF)
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Axis Coord Type      Name             Proj Shape Tile   Coord value at pixel         Coord incr Units
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        -----------------------------------------------------------------------------------------------------
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        0    0     Direction Right Ascension   SIN  7290  162  19:27:30.443  3645.00      -1.000000e+00 arcsec
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        1    0     Direction Declination       SIN  7290  162 +61.17.32.898  3645.00       1.000000e+00 arcsec
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        2    1     Stokes    Stokes                    1    1             I
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        3    2     Spectral  Frequency                 1    1         3e+09     0.00 2.072263846574e+09 Hz
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+                             Velocity                              -1224.13     0.00      -2.079286e+05 km/s
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imhead::::casa        Task imhead complete. Start time: 2024-10-02 01:17:27.203820 End time: 2024-10-02 01:17:27.207031
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imhead::::casa        ##### End Task: imhead               #####
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imhead::::casa        ##########################################
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::::casa        ##########################################
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::::casa        ##### Begin Task: imsubimage         #####
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::::casa        imsubimage( imagename='J1927_ql_iter1.psf.tt0', outfile='J1927_ql_iter1.psf.tt0.subim', box='1785,1785,5506,5506', region='', chans='', stokes='', mask='', dropdeg=False, overwrite=False, verbose=True, stretch=False, keepaxes=[] )
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::CasacRegionManager::fromBCS        Using specified box(es) 1785,1785,5506,5506
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::ImageRegion::fromRecord        Selected bounding box :
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::ImageRegion::fromRecord+            [1785, 1785, 0, 0] to [5506, 5506, 0, 0]  (19:31:44.404, +60.46.17.807, I, 3e+09Hz to 19:23:07.837, +61.48.18.336, I, 3e+09Hz)
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::ImageRegion::fromRecord        Creating image 'J1927_ql_iter1.psf.tt0.subim' of shape [3722, 3722, 1, 1]
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::::casa        Task imsubimage complete. Start time: 2024-10-02 01:17:27.208408 End time: 2024-10-02 01:17:27.347902
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::::casa        ##### End Task: imsubimage           #####
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::::casa        ##########################################
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imhead::::casa        ##########################################
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imhead::::casa        ##### Begin Task: imhead             #####
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imhead::::casa        imhead( imagename='J1927_ql_iter1.image.residual.pbcor.tt0', mode='summary', hdkey='', hdvalue='', verbose=False )
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary        
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Image name       : J1927_ql_iter1.image.residual.pbcor.tt0
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Object name      : 1928422+611911
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Image type       : PagedImage
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Image quantity   : Intensity
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Pixel mask(s)    : mask0
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Region(s)        : None
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary        
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Direction reference : J2000
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Spectral  reference : LSRK
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Velocity  type      : RADIO
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Rest frequency      : 2.9878e+09 Hz
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Pointing center     :  19:27:30.443000  +61.17.32.898000
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Telescope           : EVLA
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Observer            : Dr. Vlass Scientist
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Date observation    : 2019/04/12/14:37:40.125000
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Telescope position: [-1.60116e+06m, -5.04199e+06m, 3.55488e+06m] (ITRF)
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        Axis Coord Type      Name             Proj Shape Tile   Coord value at pixel         Coord incr Units
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        -----------------------------------------------------------------------------------------------------
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        0    0     Direction Right Ascension   SIN  7290  162  19:27:30.443  3645.00      -1.000000e+00 arcsec
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        1    0     Direction Declination       SIN  7290  162 +61.17.32.898  3645.00       1.000000e+00 arcsec
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        2    1     Stokes    Stokes                    1    1             I
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+        3    2     Spectral  Frequency                 1    1         3e+09     0.00 2.072263846574e+09 Hz
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        ImageMetaData::summary+                             Velocity                              -1224.13     0.00      -2.079286e+05 km/s
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imhead::::casa        Task imhead complete. Start time: 2024-10-02 01:17:27.348601 End time: 2024-10-02 01:17:27.352522
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imhead::::casa        ##### End Task: imhead               #####
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imhead::::casa        ##########################################
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::::casa        ##########################################
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::::casa        ##### Begin Task: imsubimage         #####
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::::casa        imsubimage( imagename='J1927_ql_iter1.image.residual.pbcor.tt0', outfile='J1927_ql_iter1.image.residual.pbcor.tt0.subim', box='1785,1785,5506,5506', region='', chans='', stokes='', mask='', dropdeg=False, overwrite=False, verbose=True, stretch=False, keepaxes=[] )
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::CasacRegionManager::fromBCS        Using specified box(es) 1785,1785,5506,5506
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::ImageRegion::fromRecord        Selected bounding box :
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::ImageRegion::fromRecord+            [1785, 1785, 0, 0] to [5506, 5506, 0, 0]  (19:31:44.404, +60.46.17.807, I, 3e+09Hz to 19:23:07.837, +61.48.18.336, I, 3e+09Hz)
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::ImageRegion::fromRecord        Creating image 'J1927_ql_iter1.image.residual.pbcor.tt0.subim' of shape [3722, 3722, 1, 1]
02-Oct-2024 05:17:27 2024-10-02 05:17:27        INFO        imsubimage::ImageMaskAttacher::makeMask        Created mask `mask0'
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imsubimage::::casa        Task imsubimage complete. Start time: 2024-10-02 01:17:27.354275 End time: 2024-10-02 01:17:27.537842
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imsubimage::::casa        ##### End Task: imsubimage           #####
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imsubimage::::casa        ##########################################
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imhead::::casa        ##########################################
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imhead::::casa        ##### Begin Task: imhead             #####
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imhead::::casa        imhead( imagename='J1927_ql_iter1.pb.tt0', mode='summary', hdkey='', hdvalue='', verbose=False )
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary        
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Image name       : J1927_ql_iter1.pb.tt0
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Object name      : 1928422+611911
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Image type       : PagedImage
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Image quantity   : Intensity
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Pixel mask(s)    : mask0
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Region(s)        : None
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary        
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Direction reference : J2000
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Spectral  reference : LSRK
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Velocity  type      : RADIO
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Rest frequency      : 2.9878e+09 Hz
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Pointing center     :  19:27:30.443000  +61.17.32.898000
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Telescope           : EVLA
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Observer            : Dr. Vlass Scientist
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Date observation    : 2019/04/12/14:37:40.125000
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Telescope position: [-1.60116e+06m, -5.04199e+06m, 3.55488e+06m] (ITRF)
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Axis Coord Type      Name             Proj Shape Tile   Coord value at pixel         Coord incr Units
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        -----------------------------------------------------------------------------------------------------
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        0    0     Direction Right Ascension   SIN  7290  162  19:27:30.443  3645.00      -1.000000e+00 arcsec
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        1    0     Direction Declination       SIN  7290  162 +61.17.32.898  3645.00       1.000000e+00 arcsec
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        2    1     Stokes    Stokes                    1    1             I
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        3    2     Spectral  Frequency                 1    1         3e+09     0.00 2.072263846574e+09 Hz
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        ImageMetaData::summary+                             Velocity                              -1224.13     0.00      -2.079286e+05 km/s
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imhead::::casa        Task imhead complete. Start time: 2024-10-02 01:17:27.538498 End time: 2024-10-02 01:17:27.542464
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imhead::::casa        ##### End Task: imhead               #####
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imhead::::casa        ##########################################
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imsubimage::::casa        ##########################################
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imsubimage::::casa        ##### Begin Task: imsubimage         #####
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imsubimage::::casa        imsubimage( imagename='J1927_ql_iter1.pb.tt0', outfile='J1927_ql_iter1.pb.tt0.subim', box='1785,1785,5506,5506', region='', chans='', stokes='', mask='', dropdeg=False, overwrite=False, verbose=True, stretch=False, keepaxes=[] )
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imsubimage::CasacRegionManager::fromBCS        Using specified box(es) 1785,1785,5506,5506
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imsubimage::ImageRegion::fromRecord        Selected bounding box :
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imsubimage::ImageRegion::fromRecord+            [1785, 1785, 0, 0] to [5506, 5506, 0, 0]  (19:31:44.404, +60.46.17.807, I, 3e+09Hz to 19:23:07.837, +61.48.18.336, I, 3e+09Hz)
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imsubimage::ImageRegion::fromRecord        Creating image 'J1927_ql_iter1.pb.tt0.subim' of shape [3722, 3722, 1, 1]
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imsubimage::ImageMaskAttacher::makeMask        Created mask `mask0'
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imsubimage::::casa        Task imsubimage complete. Start time: 2024-10-02 01:17:27.543827 End time: 2024-10-02 01:17:27.727283
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imsubimage::::casa        ##### End Task: imsubimage           #####
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imsubimage::::casa        ##########################################
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::casa        ##########################################
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::casa        ##### Begin Task: imstat             #####
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::casa        imstat( imagename='J1927_ql_iter1.image.pbcor.tt0.subim', axes=[], region='', box='1860,1860,1860,1860', chans='', stokes='', listit=True, verbose=True, mask='', stretch=False, logfile='', append=True, algorithm='classic', fence=-1.0, center='mean', lside=True, zscore=-1.0, maxiter=-1, clmethod='auto', niter=3 )
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::CasacRegionManager::fromBCS        Using specified box(es) 1860,1860,1860,1860
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::image::statistics         Determining stats for image J1927_ql_iter1.image.pbcor.tt0.subim
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::ImageRegion::fromRecord        Selected bounding box :
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::ImageRegion::fromRecord+            [1860, 1860, 0, 0] to [1860, 1860, 0, 0]  (19:27:30.443, +61.17.32.898, I, 3e+09Hz to 19:27:30.443, +61.17.32.898, I, 3e+09Hz)
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::ImageStatsCalculator::_logStartup        Statistics calculated using Classic algorithm
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::ImageStatsCalculator::_logStartup        Regions ---
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::ImageStatsCalculator::_logStartup                 -- bottom-left corner (pixel) [blc]:  [1860, 1860, 0, 0]
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::ImageStatsCalculator::_logStartup                 -- top-right corner (pixel) [trc]:    [1860, 1860, 0, 0]
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::ImageStatsCalculator::_logStartup                 -- bottom-left corner (world) [blcf]: 19:27:30.443, +61.17.32.898, I, 3e+09Hz
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::ImageStatsCalculator::_logStartup                 -- top-right corner (world) [trcf]:   19:27:30.443, +61.17.32.898, I, 3e+09Hz
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::ImageStatsCalculator::statistics        Computing quantiles...
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::        Values ---
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::                 -- flux density [flux]:                    0.156681 Jy
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::                 -- number of points [npts]:                1
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::                 -- maximum value [max]:                    0.905131 Jy/beam
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::                 -- minimum value [min]:                    0.905131 Jy/beam
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::                 -- position of max value (pixel) [maxpos]: [1860, 1860, 0, 0]
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::                 -- position of min value (pixel) [minpos]: [1860, 1860, 0, 0]
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::                 -- position of max value (world) [maxposf]: 19:27:30.443, +61.17.32.898, I, 3e+09Hz
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::                 -- position of min value (world) [minposf]: 19:27:30.443, +61.17.32.898, I, 3e+09Hz
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::                 -- Sum of pixel values [sum]:               0.905131 Jy/beam
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::                 -- Sum of squared pixel values [sumsq]:     0.819261 Jy/beam.Jy/beam
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::        Statistics ---
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::                -- Mean of the pixel values [mean]:         0.905131 Jy/beam
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::                -- Variance of the pixel values :           0 Jy/beam
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::                -- Standard deviation of the Mean [sigma]:  0 Jy/beam
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::                -- Root mean square [rms]:                  0.905131 Jy/beam
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::                -- Median of the pixel values [median]:     0.905131 Jy/beam
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::                -- Median of the deviations [medabsdevmed]: 0 Jy/beam
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::                -- IQR [quartile]:                          0 Jy/beam
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::                -- First quartile [q1]:                     0.905131 Jy/beam
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::::                -- Third quartile [q3]:                     0.905131 Jy/beam
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::ImageStatsCalculator::statistics        Sum column unit = Jy/beam
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::ImageStatsCalculator::statistics+        Mean column unit = Jy/beam
02-Oct-2024 05:17:27 2024-10-02 05:17:28        INFO        imstat::ImageStatsCalculator::statistics+        Std_dev column unit = Jy/beam
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        imstat::ImageStatsCalculator::statistics+        Minimum column unit = Jy/beam
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        imstat::ImageStatsCalculator::statistics+        Maximum column unit = Jy/beam
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        imstat::ImageStatsCalculator::statistics        Npts          Sum           Mean          Rms           Std_dev       Minimum       Maximum     
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        imstat::ImageStatsCalculator::statistics         1.000000e+00  9.051305e-01  9.051305e-01  9.051305e-01  0.000000e+00  9.051305e-01  9.051305e-01
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        imstat::::casa        Task imstat complete. Start time: 2024-10-02 01:17:27.728503 End time: 2024-10-02 01:17:27.740875
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        imstat::::casa        ##### End Task: imstat               #####
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        imstat::::casa        ##########################################
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        imstat::::casa        diff=[0.04813282]
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        imstat::::casa        val=0.0481328156884755
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        imstat::::casa        diff=[[3.95754796e-05]]
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        imstat::::casa        val=[3.95754796e-05]
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        imhead::::casa        ##########################################
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        imhead::::casa        ##### Begin Task: imhead             #####
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        imhead::::casa        imhead( imagename='J1927_ql_iter1.image.pbcor.tt0.subim', mode='summary', hdkey='', hdvalue='', verbose=False )
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary        
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Image name       : J1927_ql_iter1.image.pbcor.tt0.subim
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Object name      : 1928422+611911
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Image type       : PagedImage
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Image quantity   : Intensity
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Pixel mask(s)    : mask0
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Region(s)        : None
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Image units      : Jy/beam
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Restoring Beam   : 2.45211 arcsec, 2.07917 arcsec, -18.882 deg
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary        
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Direction reference : J2000
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Spectral  reference : LSRK
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Velocity  type      : RADIO
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Rest frequency      : 2.9878e+09 Hz
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Pointing center     :  19:27:30.443000  +61.17.32.898000
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Telescope           : EVLA
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Observer            : Dr. Vlass Scientist
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Date observation    : 2019/04/12/14:37:40.125000
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Telescope position: [-1.60116e+06m, -5.04199e+06m, 3.55488e+06m] (ITRF)
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        Axis Coord Type      Name             Proj Shape Tile   Coord value at pixel         Coord incr Units
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        -----------------------------------------------------------------------------------------------------
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        0    0     Direction Right Ascension   SIN  3722  178  19:27:30.443  1860.00      -1.000000e+00 arcsec
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        1    0     Direction Declination       SIN  3722  178 +61.17.32.898  1860.00       1.000000e+00 arcsec
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        2    1     Stokes    Stokes                    1    1             I
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+        3    2     Spectral  Frequency                 1    1         3e+09     0.00 2.072263846574e+09 Hz
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        ImageMetaData::summary+                             Velocity                              -1224.13     0.00      -2.079286e+05 km/s
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        imhead::::casa        Task imhead complete. Start time: 2024-10-02 01:17:27.743095 End time: 2024-10-02 01:17:27.746663
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        imhead::::casa        ##### End Task: imhead               #####
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        imhead::::casa        ##########################################
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        imhead::::casa        diff=[4.18051167e-06 6.42350176e-06 1.61624449e-05]
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        imhead::::casa        val=1.6162444857662526e-05
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        immoments::::casa        ##########################################
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        immoments::::casa        ##### Begin Task: immoments          #####
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        immoments::::casa        immoments( imagename='J1927_ql_iter1.image.pbcor.tt0.subim', moments=[8], axis='spectral', region='', box='', chans='', stokes='', mask='', includepix=-1, excludepix=-1, outfile='J1927_ql_iter1.image.pbcor.tt0.subim.moment8', stretch=False )
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        immoments::CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        immoments::CasacRegionManager::fromBCS        Using all spectral channels.
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        immoments::CasacRegionManager::fromBCS        Using polarizations ALL
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        immoments::ImageRegion::fromRecord        Selected bounding box :
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        immoments::ImageRegion::fromRecord+            [0, 0, 0, 0] to [3721, 3721, 0, 0]  (19:31:44.404, +60.46.17.807, I, 3e+09Hz to 19:23:07.837, +61.48.18.336, I, 3e+09Hz)
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        immoments::ImageMoments::createMoments        
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        immoments::ImageMoments::createMoments+        Moment axis type is Frequency
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        immoments::ImageMoments::createMoments        
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        immoments::ImageMoments::createMoments+        
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        immoments::ImageMoments::createMoments+        ***********************************************************************
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        immoments::ImageMoments::createMoments+        You have selected the following methods
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        immoments::ImageMoments::createMoments+        The basic method
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        immoments::ImageMoments::createMoments        Created J1927_ql_iter1.image.pbcor.tt0.subim.moment8
02-Oct-2024 05:17:37 2024-10-02 05:17:28        INFO        immoments::ImageMoments::createMoments        Begin computation of moments
02-Oct-2024 05:17:37 2024-10-02 05:17:33        INFO        immoments::::casa        Task immoments complete. Start time: 2024-10-02 01:17:27.748641 End time: 2024-10-02 01:17:33.204724
02-Oct-2024 05:17:37 2024-10-02 05:17:33        INFO        immoments::::casa        ##### End Task: immoments            #####
02-Oct-2024 05:17:37 2024-10-02 05:17:33        INFO        immoments::::casa        ##########################################
02-Oct-2024 05:17:37 2024-10-02 05:17:33        INFO        imview::::casa        ##########################################
02-Oct-2024 05:17:37 2024-10-02 05:17:33        INFO        imview::::casa        ##### Begin Task: imview             #####
02-Oct-2024 05:17:37 2024-10-02 05:17:33        INFO        imview::::casa        imview( raster={'file': 'J1927_ql_iter1.image.pbcor.tt0.subim.moment8', 'range': [-0.1, 0.9], 'scaling': 0.0}, contour={}, zoom=1, axes={}, out={'file': 'j1927_ql.png'} )
02-Oct-2024 05:17:37 2024-10-02 05:17:37        INFO        imview::::casa        Task imview complete. Start time: 2024-10-02 01:17:33.205354 End time: 2024-10-02 01:17:37.092511
02-Oct-2024 05:17:37 2024-10-02 05:17:37        INFO        imview::::casa        ##### End Task: imview               #####
02-Oct-2024 05:17:37 2024-10-02 05:17:37        INFO        imview::::casa        ##########################################
02-Oct-2024 05:17:37 2024-10-02 05:17:37        INFO        imview::::casa        [ test_j1927_ql ] image_exists('J1927_ql_iter1.image.pbcor.tt0') is True ( Pass : should be True, Exact: True )
02-Oct-2024 05:17:37 2024-10-02 05:17:37        INFO        imview::::casa+        [ test_j1927_ql ] image_exists('J1927_ql_iter1.image.residual.pbcor.tt0') is True ( Pass : should be True, Exact: True )
02-Oct-2024 05:17:37 2024-10-02 05:17:37        INFO        imview::::casa+        [ test_j1927_ql ] image_exists('J1927_ql_iter1.image.pbcor.tt0.rms') is True ( Pass : should be True, Exact: True )
02-Oct-2024 05:17:37 2024-10-02 05:17:37        INFO        imview::::casa+        [ test_j1927_ql ] image_exists('J1927_ql_iter1.image.tt0.subim') is True ( Pass : should be True, Exact: True )
02-Oct-2024 05:17:37 2024-10-02 05:17:37        INFO        imview::::casa+        [ test_j1927_ql ] image_exists('J1927_ql_iter1.residual.tt0.subim') is True ( Pass : should be True, Exact: True )
02-Oct-2024 05:17:40 2024-10-02 05:17:37        INFO        imview::::casa+        [ test_j1927_ql ] image_exists('J1927_ql_iter1.image.pbcor.tt0.subim') is True ( Pass : should be True, Exact: True )
02-Oct-2024 05:17:40 2024-10-02 05:17:37        INFO        imview::::casa+        [ test_j1927_ql ] image_exists('J1927_ql_iter1.image.pbcor.tt0.rms.subim') is True ( Pass : should be True, Exact: True )
02-Oct-2024 05:17:40 2024-10-02 05:17:37        INFO        imview::::casa+        [ test_j1927_ql ] image_exists('J1927_ql_iter1.psf.tt0.subim') is True ( Pass : should be True, Exact: True )
02-Oct-2024 05:17:40 2024-10-02 05:17:37        INFO        imview::::casa+        [ test_j1927_ql ] image_exists('J1927_ql_iter1.image.residual.pbcor.tt0.subim') is True ( Pass : should be True, Exact: True )
02-Oct-2024 05:17:40 2024-10-02 05:17:37        INFO        imview::::casa+        [ test_j1927_ql ] image_exists('J1927_ql_iter1.pb.tt0.subim') is True ( Pass : should be True, Exact: True )
02-Oct-2024 05:17:40 2024-10-02 05:17:37        INFO        imview::::casa+        [ test_j1927_ql ] Frac Diff F_nu vs. on-axis is [np.float64(0.0481328156884755)] ( Pass : should be < [0.1]) (raw actual/expected values: 0.9051305055618286/[np.float64(0.9509)])
02-Oct-2024 05:17:40 2024-10-02 05:17:37        INFO        imview::::casa+        [ test_j1927_ql ] Frac Diff F_nu vs. 6.2.1 image is [[np.float64(3.9575479559659906e-05)]] ( Pass : should be < [[0.1]]) (raw actual/expected values: 0.9051305055618286/[[np.float64(0.9051663279533386)]])
02-Oct-2024 05:17:40 2024-10-02 05:17:37        INFO        imview::::casa+        [ test_j1927_ql ] Frac Diff Maj, Min, PA vs 6.2.1 is [np.float64(4.1805116728073546e-06), np.float64(6.423501762312727e-06), np.float64(1.6162444857662526e-05)] ( Pass : should be < 0.1) (raw actual/expected values: [np.float64(2.4521117210388184), np.float64(2.0791704654693604), np.float64(-18.881975173950195)]/[np.float64(2.45210147), np.float64(2.07915711), np.float64(-18.88167)])
02-Oct-2024 05:17:40 .
02-Oct-2024 05:17:40 ----------------------------------------------------------------------
02-Oct-2024 05:17:40 Ran 7 tests in 51438.049s
02-Oct-2024 05:17:40
02-Oct-2024 05:17:40 OK
02-Oct-2024 05:17:40
02-Oct-2024 05:17:40 Using user configuration file /users/casaci/.casa/config.py
02-Oct-2024 05:17:40
02-Oct-2024 05:17:40 Cannot install event loop hook for "tk" when running with `--simple-prompt`.
02-Oct-2024 05:17:40 NOTE: Tk is supported natively; use Tk apps and Tk backends with `--simple-prompt`.
02-Oct-2024 05:17:40 Cannot install event loop hook for "tk" when running with `--simple-prompt`.
02-Oct-2024 05:17:40 NOTE: Tk is supported natively; use Tk apps and Tk backends with `--simple-prompt`.
02-Oct-2024 05:17:40 Using matplotlib backend: tkagg
02-Oct-2024 05:17:40 Using location of IERSeop2000 table found in datapath for measurespath /export/cvpost134-4tb/casa/casa-data/casa-data
02-Oct-2024 05:17:40 CASA 6.7.0.6 -- Common Astronomy Software Applications [6.7.0.6]
02-Oct-2024 05:17:40 (0) waiting for viewer process...
02-Oct-2024 05:17:40 (1) waiting for viewer process...
02-Oct-2024 05:17:40         ...{'id': 'casaviewer:122f', 'priority': 0, 'types': array(['shutdown', 'image-view', 'interactive-clean'], dtype='<U17'), 'uri': '0.0.0.0:44159'}
02-Oct-2024 05:17:40 Executor result: 0
02-Oct-2024 05:17:40 Failed tests:[]
02-Oct-2024 05:17:40
02-Oct-2024 05:17:40 Results: [{'testname': 'test_stk_vlass_pipeline_imaging_1v2', 'runtime': '14:17:21.922888', 'returncode': 0, 'testerr': []}]
02-Oct-2024 05:17:40 Stopping Xvfb.
02-Oct-2024 05:17:40 Stopping framebuffer <subprocess.Popen object at 0x7fd655f548d0>
02-Oct-2024 05:17:40 Virtual frame buffer deployed at :2221891 with pid 2221970 successfully shutdown
02-Oct-2024 05:17:40 Xvfb stopped.
02-Oct-2024 05:17:40 Finished task 'Script' with result: Success
02-Oct-2024 05:17:40 Starting task 'Parse test results' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
02-Oct-2024 05:17:40 Parsing test results under /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASA-CMTSP3-V1STE...
02-Oct-2024 05:17:40 Finished task 'Parse test results' with result: Success
02-Oct-2024 05:17:40 Skipping execution of task 'Cleanup' as it is disabled
02-Oct-2024 05:17:40 Running post build plugin 'Docker Container Cleanup'
02-Oct-2024 05:17:40 Running post build plugin 'NCover Results Collector'
02-Oct-2024 05:17:40 Running post build plugin 'Build Results Label Collector'
02-Oct-2024 05:17:40 Running post build plugin 'Clover Results Collector'
02-Oct-2024 05:17:40 Running post build plugin 'npm Cache Cleanup'
02-Oct-2024 05:17:40 Running post build plugin 'Artifact Copier'
02-Oct-2024 05:17:40 Publishing an artifact: VLASS 1.2 Stakeholder
02-Oct-2024 05:17:40 Finished publishing of artifact Non required job artifact Http Compression On : [VLASS 1.2 Stakeholder], patterns: [html/**] anchored at: [work/test_stk_vlass_pipeline_imaging_1v2] in 152.5 ms
02-Oct-2024 05:17:40 Finalising the build...
02-Oct-2024 05:17:40 Stopping timer.
02-Oct-2024 05:17:40 Build CASA-CMTSP3-V1STE-6 completed.
02-Oct-2024 01:17:40 Running on server: post build plugin 'Build Hanging Detection Configuration'
02-Oct-2024 01:17:40 Running on server: post build plugin 'NCover Results Collector'
02-Oct-2024 01:17:40 Running on server: post build plugin 'Build Labeller'
02-Oct-2024 01:17:40 Running on server: post build plugin 'Clover Delta Calculator'
02-Oct-2024 01:17:40 Running on server: post build plugin 'Maven Dependencies Postprocessor'
02-Oct-2024 01:17:40 All post build plugins have finished
02-Oct-2024 01:17:40 Generating build results summary...
02-Oct-2024 01:17:40 Saving build results to disk...
02-Oct-2024 01:17:40 Store variable context...
02-Oct-2024 01:17:40 Finished building CASA-CMTSP3-V1STE-6.