Stakeholder tests for Python 3.8

Build: #65 failed

Job: SRDP Restore Mode EL8 was successful

Build log

The build generated 2,790 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 07:29:42 2024-10-02 07:29:42        INFO        Summary::getResult          field HOPS-239 flagged: 1.32048e+06 total: 6.69144e+06 (19.7%)
02-Oct-2024 07:29:42 2024-10-02 07:29:42        INFO        Summary::getResult          field HOPS-050 flagged: 1.31976e+06 total: 6.69144e+06 (19.7%)
02-Oct-2024 07:29:42 2024-10-02 07:29:42        INFO        Summary::getResult          field HOPS-247 flagged: 1.32048e+06 total: 6.69144e+06 (19.7%)
02-Oct-2024 07:29:42 2024-10-02 07:29:42        INFO        Summary::getResult          field HOPS-397 flagged: 1.32024e+06 total: 6.69144e+06 (19.7%)
02-Oct-2024 07:29:42 2024-10-02 07:29:42        INFO        Summary::getResult          field HOPS-240 flagged: 1.32048e+06 total: 6.69144e+06 (19.7%)
02-Oct-2024 07:29:42 2024-10-02 07:29:42        INFO        Summary::getResult          field HOPS-152 flagged: 1.32024e+06 total: 6.69144e+06 (19.7%)
02-Oct-2024 07:29:42 2024-10-02 07:29:42        INFO        Summary::getResult          spw 23 flagged: 71800 total: 370600 (19.4%)
02-Oct-2024 07:29:42 2024-10-02 07:29:42        INFO        Summary::getResult          spw 20 flagged: 2.92918e+07 total: 8.58522e+07 (34.1%)
02-Oct-2024 07:29:42 2024-10-02 07:29:42        INFO        Summary::getResult          spw 18 flagged: 2.91194e+07 total: 8.58522e+07 (33.9%)
02-Oct-2024 07:29:42 2024-10-02 07:29:42        INFO        Summary::getResult          spw 17 flagged: 71800 total: 370600 (19.4%)
02-Oct-2024 07:29:42 2024-10-02 07:29:42        INFO        Summary::getResult          spw 16 flagged: 2.46579e+07 total: 8.58522e+07 (28.7%)
02-Oct-2024 07:29:42 2024-10-02 07:29:42        INFO        Summary::getResult          spw 3 flagged: 604800 total: 604800 (100%)
02-Oct-2024 07:29:42 2024-10-02 07:29:42        INFO        Summary::getResult          spw 13 flagged: 203368 total: 4.3776e+06 (4.65%)
02-Oct-2024 07:29:42 2024-10-02 07:29:42        INFO        Summary::getResult          spw 21 flagged: 71800 total: 370600 (19.4%)
02-Oct-2024 07:29:42 2024-10-02 07:29:42        INFO        Summary::getResult          spw 4 flagged: 3.3792e+06 total: 3.3792e+06 (100%)
02-Oct-2024 07:29:42 2024-10-02 07:29:42        INFO        Summary::getResult          spw 9 flagged: 52800 total: 52800 (100%)
02-Oct-2024 07:29:42 2024-10-02 07:29:42        INFO        Summary::getResult          spw 11 flagged: 52800 total: 52800 (100%)
02-Oct-2024 07:29:42 2024-10-02 07:29:42        INFO        Summary::getResult          spw 0 flagged: 604800 total: 604800 (100%)
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        Summary::getResult          spw 22 flagged: 2.48422e+07 total: 8.58522e+07 (28.9%)
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        Summary::getResult          spw 5 flagged: 52800 total: 52800 (100%)
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        Summary::getResult          spw 8 flagged: 3.3792e+06 total: 3.3792e+06 (100%)
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        Summary::getResult          spw 6 flagged: 3.3792e+06 total: 3.3792e+06 (100%)
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        Summary::getResult          spw 1 flagged: 604800 total: 604800 (100%)
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        Summary::getResult          spw 12 flagged: 203368 total: 4.3776e+06 (4.65%)
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        Summary::getResult          spw 7 flagged: 52800 total: 52800 (100%)
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        Summary::getResult          spw 10 flagged: 3.3792e+06 total: 3.3792e+06 (100%)
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        Summary::getResult          spw 2 flagged: 604800 total: 604800 (100%)
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        Summary::getResult          spw 14 flagged: 203368 total: 4.3776e+06 (4.65%)
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        Summary::getResult          spw 19 flagged: 71800 total: 370600 (19.4%)
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        Summary::getResult          spw 15 flagged: 203368 total: 4.3776e+06 (4.65%)
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        Summary::getResult          correlation YY flagged: 6.25796e+07 total: 1.89274e+08 (33.1%)
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        Summary::getResult          correlation XX flagged: 6.25796e+07 total: 1.89274e+08 (33.1%)
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        Summary::getResult          array 0 flagged: 1.25159e+08 total: 3.78549e+08 (33.1%)
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        Summary::getResult          Total Flagged: 1.25159e+08 Total Counts: 3.78549e+08 (33.1%)
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        flagdata::::casa        Flags are not written to the MS. (action='calculate')
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        flagdata::::casa        Task flagdata complete. Start time: 2024-10-02 03:28:46.902112 End time: 2024-10-02 03:29:42.078482
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        flagdata::::casa        ##### End Task: flagdata             #####
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        flagdata::::casa        ##########################################
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        tclean::::casa        ##########################################
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        tclean::::casa        ##### Begin Task: tclean             #####
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        tclean::::casa        tclean( vis='uid___A002_Xd341ff_X3a2f.ms', selectdata=True, field='J0501-0159', spw='16,18,20,22', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='J0501-0159', imsize=256, cell='0.25arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='standard', facets=1, psfphasecenter='', wprojplanes=1, vptable='', mosweight=True, aterm=True, psterm=False, wbawp=True, conjbeams=False, cfcache='', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=0.2, normtype='flatnoise', deconvolver='hogbom', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=False, outlierfile='', weighting='natural', robust=0.5, noise='1.0Jy', npixels=0, uvtaper=[''], niter=5000, gain=0.1, threshold=0.0, nsigma=3.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='none', calcres=True, calcpsf=True, psfcutoff=0.35, parallel=False )
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        tclean::::casa        Verifying Input Parameters
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        SynthesisImagerVi2::selectData         MS : uid___A002_Xd341ff_X3a2f.ms | Selecting on fields : J0501-0159 | Selecting on spw :16,18,20,22 | [Opened in readonly mode]
02-Oct-2024 07:30:09 2024-10-02 07:29:42        INFO        SynthesisImagerVi2::selectData           NRows selected : 21840
02-Oct-2024 07:30:09 2024-10-02 07:29:43        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [J0501-0159] :
02-Oct-2024 07:30:09 2024-10-02 07:29:43        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [J0501-0159] :
02-Oct-2024 07:30:09 2024-10-02 07:29:43        INFO        SynthesisImagerVi2::defineImage         Impars: start
02-Oct-2024 07:30:09 2024-10-02 07:29:43        INFO        SynthesisImagerVi2::defineImage         Shape: [256, 256, 1, 1] Spectral: [3.38235e+11] at [0] with increment [1.53644e+10]
02-Oct-2024 07:30:09 2024-10-02 07:29:43        INFO        SynthesisImagerVi2::defineImage         Set Gridding options for [J0501-0159] with ftmachine: gridft
02-Oct-2024 07:30:09 2024-10-02 07:29:43        INFO        SynthesisImagerVi2::nSubCubeFitInMemory        Required memory: 0.003433 GB. Available mem.: 385.1 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 1.
02-Oct-2024 07:30:09 2024-10-02 07:29:43        INFO        SynthesisImagerVi2::weight()         Set imaging weights : Natural weighting
02-Oct-2024 07:30:09 2024-10-02 07:29:43        INFO        task_tclean::SynthesisDeconvolver::setupDeconvolution         Set Deconvolution Options for [J0501-0159] : hogbom
02-Oct-2024 07:30:09 2024-10-02 07:29:43        INFO        task_tclean::SynthesisImager::makePSF         ----------------------------------------------------------- Make PSF ---------------------------------------------
02-Oct-2024 07:30:09
02-Oct-2024 07:30:09 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 07:30:09 2024-10-02 07:29:50        INFO        task_tclean::SIImageStore::calcSensitivity         [J0501-0159] Theoretical sensitivity (Jy/bm):0.00055317
02-Oct-2024 07:30:09 2024-10-02 07:29:50        INFO        task_tclean::SIImageStore::getPSFGaussian         Time to fit Gaussian to PSF 0.004777
02-Oct-2024 07:30:09 2024-10-02 07:29:50        INFO        task_tclean::SIImageStore::printBeamSet         Beam : 4.84503 arcsec, 2.89848 arcsec, 78.9539 deg
02-Oct-2024 07:30:09 2024-10-02 07:29:50        INFO        task_tclean::SynthesisImagerVi2::makePrimaryBeam         vi2 : Evaluating Primary Beam model onto image grid(s)
02-Oct-2024 07:30:09 2024-10-02 07:29:51        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
02-Oct-2024 07:30:09
02-Oct-2024 07:30:09 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 07:30:09 2024-10-02 07:29:59        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 0.01s ( user 0.02s, system 0s)
02-Oct-2024 07:30:09 2024-10-02 07:29:59        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.338412
02-Oct-2024 07:30:09 2024-10-02 07:29:59        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 1.55377, over full image : 1.55377
02-Oct-2024 07:30:09 2024-10-02 07:29:59        INFO        SynthesisDeconvolver::setupMask         [J0501-0159] Initializing new mask to 1.0 for the full image
02-Oct-2024 07:30:09 2024-10-02 07:29:59        INFO        SynthesisDeconvolver::setupMask         [J0501-0159] Number of pixels in the clean mask : 65536 out of a total of 65536 pixels. [ 100 % ]
02-Oct-2024 07:30:09 2024-10-02 07:29:59        INFO        SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.338412
02-Oct-2024 07:30:09 2024-10-02 07:29:59        INFO        SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 1.55377, over full image : 1.55377
02-Oct-2024 07:30:09 2024-10-02 07:29:59        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 5000, 'cyclethreshold': 0.7039344310760498, 'loopgain': 0.10000000149011612, 'nsigma': 3.0, 'thresholdreached': False}
02-Oct-2024 07:30:09 2024-10-02 07:29:59        INFO        SDAlgorithmBase::deconvolve         [J0501-0159] Run Hogbom minor-cycle | CycleThreshold=0.703934, CycleNiter=5000, Gain=0.1
02-Oct-2024 07:30:09 2024-10-02 07:29:59        INFO        SDAlgorithmBase::deconvolve         Using cyclethreshold for threshold criterion: (cyclethreshold=0.703934, nsigma threshold=0.338412 )
02-Oct-2024 07:30:09 2024-10-02 07:29:59        INFO        SDAlgorithmBase::deconvolve         [J0501-0159] iters=0->8 [8], model=0->0.884925, peakres=1.55377->0.668848, Reached cyclethreshold.
02-Oct-2024 07:30:09 2024-10-02 07:29:59        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 8 iterations.
02-Oct-2024 07:30:09 2024-10-02 07:29:59        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 2 -------------------------------------
02-Oct-2024 07:30:09
02-Oct-2024 07:30:09 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 07:30:09 2024-10-02 07:30:10        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 0.01s ( user 0.02s, system 0s)
02-Oct-2024 07:30:09 2024-10-02 07:30:10        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.145034
02-Oct-2024 07:31:05 2024-10-02 07:30:10        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.668847, over full image : 0.668847
02-Oct-2024 07:31:05 2024-10-02 07:30:10        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 4992, 'cyclethreshold': 0.3030201196670532, 'loopgain': 0.10000000149011612, 'nsigma': 3.0, 'thresholdreached': False}
02-Oct-2024 07:31:05 2024-10-02 07:30:10        INFO        SDAlgorithmBase::deconvolve         [J0501-0159] Run Hogbom minor-cycle | CycleThreshold=0.30302, CycleNiter=4992, Gain=0.1
02-Oct-2024 07:31:05 2024-10-02 07:30:10        INFO        SDAlgorithmBase::deconvolve         Using cyclethreshold for threshold criterion: (cyclethreshold=0.30302, nsigma threshold=0.145034 )
02-Oct-2024 07:31:05 2024-10-02 07:30:10        INFO        SDAlgorithmBase::deconvolve         [J0501-0159] iters=0->8 [8], model=0.884925->1.26586, peakres=0.668847->0.287917, Reached cyclethreshold.
02-Oct-2024 07:31:05 2024-10-02 07:30:10        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 16 iterations.
02-Oct-2024 07:31:05 2024-10-02 07:30:10        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 3 -------------------------------------
02-Oct-2024 07:31:05
02-Oct-2024 07:31:05 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 07:31:05 2024-10-02 07:30:21        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 0.01s ( user 0.03s, system 0s)
02-Oct-2024 07:31:05 2024-10-02 07:30:21        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.061904
02-Oct-2024 07:31:05 2024-10-02 07:30:21        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.287916, over full image : 0.287916
02-Oct-2024 07:31:05 2024-10-02 07:30:21        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 4984, 'cyclethreshold': 0.13043993711471558, 'loopgain': 0.10000000149011612, 'nsigma': 3.0, 'thresholdreached': False}
02-Oct-2024 07:31:05 2024-10-02 07:30:21        INFO        SDAlgorithmBase::deconvolve         [J0501-0159] Run Hogbom minor-cycle | CycleThreshold=0.13044, CycleNiter=4984, Gain=0.1
02-Oct-2024 07:31:05 2024-10-02 07:30:21        INFO        SDAlgorithmBase::deconvolve         Using cyclethreshold for threshold criterion: (cyclethreshold=0.13044, nsigma threshold=0.061904 )
02-Oct-2024 07:31:05 2024-10-02 07:30:21        INFO        SDAlgorithmBase::deconvolve         [J0501-0159] iters=0->8 [8], model=1.26586->1.42983, peakres=0.287916->0.123938, Reached cyclethreshold.
02-Oct-2024 07:31:05 2024-10-02 07:30:21        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 24 iterations.
02-Oct-2024 07:31:05 2024-10-02 07:30:21        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 4 -------------------------------------
02-Oct-2024 07:31:05
02-Oct-2024 07:31:05 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 07:31:05 2024-10-02 07:30:32        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 0.01s ( user 0.02s, system 0s)
02-Oct-2024 07:31:05 2024-10-02 07:30:32        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.0263049
02-Oct-2024 07:31:05 2024-10-02 07:30:32        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.123938, over full image : 0.123938
02-Oct-2024 07:31:05 2024-10-02 07:30:32        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 4976, 'cyclethreshold': 0.05615009367465973, 'loopgain': 0.10000000149011612, 'nsigma': 3.0, 'thresholdreached': False}
02-Oct-2024 07:31:05 2024-10-02 07:30:32        INFO        SDAlgorithmBase::deconvolve         [J0501-0159] Run Hogbom minor-cycle | CycleThreshold=0.0561501, CycleNiter=4976, Gain=0.1
02-Oct-2024 07:31:05 2024-10-02 07:30:32        INFO        SDAlgorithmBase::deconvolve         Using cyclethreshold for threshold criterion: (cyclethreshold=0.0561501, nsigma threshold=0.0263049 )
02-Oct-2024 07:31:05 2024-10-02 07:30:32        INFO        SDAlgorithmBase::deconvolve         [J0501-0159] iters=0->8 [8], model=1.42983->1.50042, peakres=0.123938->0.0533514, Reached cyclethreshold.
02-Oct-2024 07:31:05 2024-10-02 07:30:32        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 32 iterations.
02-Oct-2024 07:31:05 2024-10-02 07:30:32        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 5 -------------------------------------
02-Oct-2024 07:31:05
02-Oct-2024 07:31:05 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 07:31:05 2024-10-02 07:30:43        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 0.01s ( user 0.02s, system 0s)
02-Oct-2024 07:31:05 2024-10-02 07:30:43        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.0113932
02-Oct-2024 07:31:05 2024-10-02 07:30:43        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.0533514, over full image : 0.0533514
02-Oct-2024 07:31:05 2024-10-02 07:30:43        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 4968, 'cyclethreshold': 0.024170784279704094, 'loopgain': 0.10000000149011612, 'nsigma': 3.0, 'thresholdreached': False}
02-Oct-2024 07:31:05 2024-10-02 07:30:43        INFO        SDAlgorithmBase::deconvolve         [J0501-0159] Run Hogbom minor-cycle | CycleThreshold=0.0241708, CycleNiter=4968, Gain=0.1
02-Oct-2024 07:31:05 2024-10-02 07:30:43        INFO        SDAlgorithmBase::deconvolve         Using cyclethreshold for threshold criterion: (cyclethreshold=0.0241708, nsigma threshold=0.0113932 )
02-Oct-2024 07:31:05 2024-10-02 07:30:43        INFO        SDAlgorithmBase::deconvolve         [J0501-0159] iters=0->8 [8], model=1.50042->1.53082, peakres=0.0533514->0.0230177, Reached cyclethreshold.
02-Oct-2024 07:31:05 2024-10-02 07:30:43        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 40 iterations.
02-Oct-2024 07:31:05 2024-10-02 07:30:43        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 6 -------------------------------------
02-Oct-2024 07:31:05
02-Oct-2024 07:31:05 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 07:31:05 2024-10-02 07:30:54        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 0.01s ( user 0.02s, system 0s)
02-Oct-2024 07:31:05 2024-10-02 07:30:54        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.00562637
02-Oct-2024 07:31:05 2024-10-02 07:30:54        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.0230178, over full image : 0.0230178
02-Oct-2024 07:31:05 2024-10-02 07:30:54        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 4960, 'cyclethreshold': 0.01042815949767828, 'loopgain': 0.10000000149011612, 'nsigma': 3.0, 'thresholdreached': False}
02-Oct-2024 07:31:05 2024-10-02 07:30:54        INFO        SDAlgorithmBase::deconvolve         [J0501-0159] Run Hogbom minor-cycle | CycleThreshold=0.0104282, CycleNiter=4960, Gain=0.1
02-Oct-2024 07:31:05 2024-10-02 07:30:54        INFO        SDAlgorithmBase::deconvolve         Using cyclethreshold for threshold criterion: (cyclethreshold=0.0104282, nsigma threshold=0.00562637 )
02-Oct-2024 07:31:05 2024-10-02 07:30:54        INFO        SDAlgorithmBase::deconvolve         [J0501-0159] iters=0->8 [8], model=1.53082->1.54395, peakres=0.0230178->0.00994298, Reached cyclethreshold.
02-Oct-2024 07:31:05 2024-10-02 07:30:54        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 48 iterations.
02-Oct-2024 07:31:05 2024-10-02 07:30:54        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 7 -------------------------------------
02-Oct-2024 07:31:05
02-Oct-2024 07:31:05 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 07:31:05 2024-10-02 07:31:05        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 0.01s ( user 0.02s, system 0s)
02-Oct-2024 07:31:05 2024-10-02 07:31:05        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.00353201
02-Oct-2024 07:31:05 2024-10-02 07:31:05        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00994292, over full image : 0.00994292
02-Oct-2024 07:31:05 2024-10-02 07:31:05        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 4952, 'cyclethreshold': 0.00450462382286787, 'loopgain': 0.10000000149011612, 'nsigma': 3.0, 'thresholdreached': False}
02-Oct-2024 07:31:05 2024-10-02 07:31:05        INFO        SDAlgorithmBase::deconvolve         [J0501-0159] Run Hogbom minor-cycle | CycleThreshold=0.00450462, CycleNiter=4952, Gain=0.1
02-Oct-2024 07:31:05 2024-10-02 07:31:05        INFO        SDAlgorithmBase::deconvolve         Using cyclethreshold for threshold criterion: (cyclethreshold=0.00450462, nsigma threshold=0.00353201 )
02-Oct-2024 07:31:05 2024-10-02 07:31:05        INFO        SDAlgorithmBase::deconvolve         [J0501-0159] iters=0->14 [14], model=1.54395->1.55291, peakres=0.00994292->0.00436884, Reached cyclethreshold.
02-Oct-2024 07:31:05 2024-10-02 07:31:05        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 62 iterations.
02-Oct-2024 07:31:49 2024-10-02 07:31:05        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 8 -------------------------------------
02-Oct-2024 07:31:49
02-Oct-2024 07:31:49 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 07:31:49 2024-10-02 07:31:17        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 0.01s ( user 0.02s, system 0s)
02-Oct-2024 07:31:49 2024-10-02 07:31:17        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.00254518
02-Oct-2024 07:31:49 2024-10-02 07:31:17        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00414053, over full image : 0.00414053
02-Oct-2024 07:31:49 2024-10-02 07:31:17        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 4938, 'cyclethreshold': 0.0018758582882583141, 'loopgain': 0.10000000149011612, 'nsigma': 3.0, 'thresholdreached': False}
02-Oct-2024 07:31:49 2024-10-02 07:31:17        INFO        SDAlgorithmBase::deconvolve         [J0501-0159] Run Hogbom minor-cycle | CycleThreshold=0.00187586, CycleNiter=4938, Gain=0.1
02-Oct-2024 07:31:49 2024-10-02 07:31:17        INFO        SDAlgorithmBase::deconvolve         Using n-sigma for threshold criterion: (cyclethreshold=0.00187586, nsigma threshold=0.00254518 )
02-Oct-2024 07:31:49 2024-10-02 07:31:17        INFO        SDAlgorithmBase::deconvolve         [J0501-0159] iters=0->26 [26], model=1.55291->1.55957, peakres=0.00414053->0.00254195, Reached n-sigma threshold.
02-Oct-2024 07:31:49 2024-10-02 07:31:17        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 88 iterations.
02-Oct-2024 07:31:49 2024-10-02 07:31:17        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 9 -------------------------------------
02-Oct-2024 07:31:49
02-Oct-2024 07:31:49 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 07:31:49 2024-10-02 07:31:27        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 0.01s ( user 0.02s, system 0.01s)
02-Oct-2024 07:31:49 2024-10-02 07:31:27        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.00237714
02-Oct-2024 07:31:49 2024-10-02 07:31:27        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00265903, over full image : 0.00265903
02-Oct-2024 07:31:49 2024-10-02 07:31:27        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 4912, 'cyclethreshold': 0.0012046705232933164, 'loopgain': 0.10000000149011612, 'nsigma': 3.0, 'thresholdreached': False}
02-Oct-2024 07:31:49 2024-10-02 07:31:27        INFO        SDAlgorithmBase::deconvolve         [J0501-0159] Run Hogbom minor-cycle | CycleThreshold=0.00120467, CycleNiter=4912, Gain=0.1
02-Oct-2024 07:31:49 2024-10-02 07:31:27        INFO        SDAlgorithmBase::deconvolve         Using n-sigma for threshold criterion: (cyclethreshold=0.00120467, nsigma threshold=0.00237714 )
02-Oct-2024 07:31:49 2024-10-02 07:31:27        INFO        SDAlgorithmBase::deconvolve         [J0501-0159] iters=0->7 [7], model=1.55957->1.55976, peakres=0.00265903->0.00236906, Reached n-sigma threshold.
02-Oct-2024 07:31:49 2024-10-02 07:31:27        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 95 iterations.
02-Oct-2024 07:31:49 2024-10-02 07:31:27        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 10 -------------------------------------
02-Oct-2024 07:31:49
02-Oct-2024 07:31:49 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 07:31:49 2024-10-02 07:31:38        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 0.01s ( user 0.02s, system 0s)
02-Oct-2024 07:31:49 2024-10-02 07:31:38        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.00224191
02-Oct-2024 07:31:49 2024-10-02 07:31:38        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00230975, over full image : 0.00230975
02-Oct-2024 07:31:49 2024-10-02 07:31:38        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 4905, 'cyclethreshold': 0.001046430435962975, 'loopgain': 0.10000000149011612, 'nsigma': 3.0, 'thresholdreached': False}
02-Oct-2024 07:31:49 2024-10-02 07:31:38        INFO        SDAlgorithmBase::deconvolve         [J0501-0159] Run Hogbom minor-cycle | CycleThreshold=0.00104643, CycleNiter=4905, Gain=0.1
02-Oct-2024 07:31:49 2024-10-02 07:31:38        INFO        SDAlgorithmBase::deconvolve         Using n-sigma for threshold criterion: (cyclethreshold=0.00104643, nsigma threshold=0.00224191 )
02-Oct-2024 07:31:49 2024-10-02 07:31:38        INFO        SDAlgorithmBase::deconvolve         [J0501-0159] iters=0->4 [4], model=1.55976->1.55976, peakres=0.00230975->0.00223402, Reached n-sigma threshold.
02-Oct-2024 07:31:49 2024-10-02 07:31:38        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 99 iterations.
02-Oct-2024 07:31:49 2024-10-02 07:31:38        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 11 -------------------------------------
02-Oct-2024 07:31:49
02-Oct-2024 07:31:49 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 07:31:49 2024-10-02 07:31:49        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 0.01s ( user 0.03s, system 0s)
02-Oct-2024 07:31:49 2024-10-02 07:31:49        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.00219819
02-Oct-2024 07:31:49 2024-10-02 07:31:49        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00219456, over full image : 0.00219456
02-Oct-2024 07:31:49 2024-10-02 07:31:49        INFO        tclean::::casa        Reached global stopping criterion : any combination of n-sigma and other valid exit criterion
02-Oct-2024 07:31:49 2024-10-02 07:31:49        INFO        tclean::::casa        getSummary call: fullsummary=False
02-Oct-2024 07:31:49 2024-10-02 07:31:49        INFO        SDAlgorithmBase::restore         [J0501-0159] : Restoring model image.
02-Oct-2024 07:31:49 2024-10-02 07:31:49        INFO        SIImageStore::restore         Beam for chan : 0 : 4.84503 arcsec, 2.89848 arcsec, 78.9539 deg
02-Oct-2024 07:31:49 2024-10-02 07:31:49        INFO        tclean::::casa        Searching for images with prefix 'J0501-0159'... Found these, writing history into them: ['J0501-0159.psf', 'J0501-0159.sumwt', 'J0501-0159.pb', 'J0501-0159.residual', 'J0501-0159.mask', 'J0501-0159.model', 'J0501-0159.image']
02-Oct-2024 07:31:49 2024-10-02 07:31:50        INFO        tclean::::casa        Task tclean complete. Start time: 2024-10-02 03:29:42.088297 End time: 2024-10-02 03:31:49.594313
02-Oct-2024 07:31:49 2024-10-02 07:31:50        INFO        tclean::::casa        ##### End Task: tclean               #####
02-Oct-2024 07:31:49 2024-10-02 07:31:50        INFO        tclean::::casa        ##########################################
02-Oct-2024 07:31:49 2024-10-02 07:31:50        INFO        imstat::::casa        ##########################################
02-Oct-2024 07:31:49 2024-10-02 07:31:50        INFO        imstat::::casa        ##### Begin Task: imstat             #####
02-Oct-2024 07:31:49 2024-10-02 07:31:50        INFO        imstat::::casa        imstat( imagename='J0501-0159.image', axes=[], region='', box='', 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 07:31:49 2024-10-02 07:31:50        INFO        imstat::CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
02-Oct-2024 07:31:49 2024-10-02 07:31:50        INFO        imstat::CasacRegionManager::fromBCS        Using all spectral channels.
02-Oct-2024 07:31:49 2024-10-02 07:31:50        INFO        imstat::CasacRegionManager::fromBCS        Using polarizations ALL
02-Oct-2024 07:31:49 2024-10-02 07:31:50        INFO        imstat::image::statistics         Determining stats for image J0501-0159.image
02-Oct-2024 07:31:49 2024-10-02 07:31:50        INFO        imstat::ImageRegion::fromRecord        Selected bounding box :
02-Oct-2024 07:31:49 2024-10-02 07:31:50        INFO        imstat::ImageRegion::fromRecord+            [0, 0, 0, 0] to [255, 255, 0, 0]  (05:01:14.945, -01.59.46.256, I, 3.38235e+11Hz to 05:01:10.692, -01.58.42.506, I, 3.38235e+11Hz)
02-Oct-2024 07:31:49 2024-10-02 07:31:50        INFO        imstat::ImageStatsCalculator::_logStartup        Statistics calculated using Classic algorithm
02-Oct-2024 07:31:49 2024-10-02 07:31:50        INFO        imstat::ImageStatsCalculator::_logStartup        Regions ---
02-Oct-2024 07:31:49 2024-10-02 07:31:50        INFO        imstat::ImageStatsCalculator::_logStartup                 -- bottom-left corner (pixel) [blc]:  [0, 0, 0, 0]
02-Oct-2024 07:31:49 2024-10-02 07:31:50        INFO        imstat::ImageStatsCalculator::_logStartup                 -- top-right corner (pixel) [trc]:    [255, 255, 0, 0]
02-Oct-2024 07:31:49 2024-10-02 07:31:50        INFO        imstat::ImageStatsCalculator::_logStartup                 -- bottom-left corner (world) [blcf]: 05:01:14.945, -01.59.46.256, I, 3.38235e+11Hz
02-Oct-2024 07:31:49 2024-10-02 07:31:50        INFO        imstat::ImageStatsCalculator::_logStartup                 -- top-right corner (world) [trcf]:   05:01:10.692, -01.58.42.506, I, 3.38235e+11Hz
02-Oct-2024 07:31:49 2024-10-02 07:31:50        INFO        imstat::::        Values ---
02-Oct-2024 07:31:49 2024-10-02 07:31:50        INFO        imstat::::                 -- flux density [flux]:                    1.55592 Jy
02-Oct-2024 07:31:49 2024-10-02 07:31:50        INFO        imstat::::                 -- number of points [npts]:                24705
02-Oct-2024 07:31:49 2024-10-02 07:31:50        INFO        imstat::::                 -- maximum value [max]:                    1.55251 Jy/beam
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::::                 -- minimum value [min]:                    -0.00252777 Jy/beam
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::::                 -- position of max value (pixel) [maxpos]: [128, 128, 0, 0]
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::::                 -- position of min value (pixel) [minpos]: [174, 101, 0, 0]
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::::                 -- position of max value (world) [maxposf]: 05:01:12.810, -01.59.14.256, I, 3.38235e+11Hz
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::::                 -- position of min value (world) [minposf]: 05:01:12.043, -01.59.21.006, I, 3.38235e+11Hz
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::::                 -- Sum of pixel values [sum]:               396.13 Jy/beam
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::::                 -- Sum of squared pixel values [sumsq]:     307.848 Jy/beam.Jy/beam
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::::        Statistics ---
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::::                -- Mean of the pixel values [mean]:         0.0160344 Jy/beam
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::::                -- Variance of the pixel values :           0.0122044 Jy/beam
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::::                -- Standard deviation of the Mean [sigma]:  0.110473 Jy/beam
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::::                -- Root mean square [rms]:                  0.111629 Jy/beam
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::::                -- Median of the pixel values [median]:     6.199e-05 Jy/beam
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::::                -- Median of the deviations [medabsdevmed]: 0.000530538 Jy/beam
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::::                -- IQR [quartile]:                          0.00107167 Jy/beam
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::::                -- First quartile [q1]:                     -0.000430468 Jy/beam
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::::                -- Third quartile [q3]:                     0.000641198 Jy/beam
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::ImageStatsCalculator::statistics        Sum column unit = Jy/beam
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::ImageStatsCalculator::statistics+        Mean column unit = Jy/beam
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::ImageStatsCalculator::statistics+        Std_dev column unit = Jy/beam
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::ImageStatsCalculator::statistics+        Minimum column unit = Jy/beam
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::ImageStatsCalculator::statistics+        Maximum column unit = Jy/beam
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::ImageStatsCalculator::statistics        Npts          Sum           Mean          Rms           Std_dev       Minimum       Maximum     
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::ImageStatsCalculator::statistics         2.470500e+04  3.961297e+02  1.603439e-02  1.116287e-01  1.104734e-01 -2.527771e-03  1.552512e+00
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::::casa        Task imstat complete. Start time: 2024-10-02 03:31:49.596625 End time: 2024-10-02 03:31:49.611229
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::::casa        ##### End Task: imstat               #####
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imstat::::casa        ##########################################
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imhead::::casa        ##########################################
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imhead::::casa        ##### Begin Task: imhead             #####
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imhead::::casa        imhead( imagename='J0501-0159.image', mode='summary', hdkey='', hdvalue='', verbose=False )
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary        
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        Image name       : J0501-0159.image
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        Object name      : J0501-0159
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        Image type       : PagedImage
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        Image quantity   : Intensity
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        Pixel mask(s)    : mask0
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        Region(s)        : None
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        Image units      : Jy/beam
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        Restoring Beam   : 4.84503 arcsec, 2.89848 arcsec, 78.9539 deg
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary        
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        Direction reference : ICRS
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        Spectral  reference : LSRK
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        Velocity  type      : RADIO
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        Rest frequency      : 3.30588e+11 Hz
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        Pointing center     :  05:01:12.809885  -01.59.14.256340
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        Telescope           : ALMA
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        Observer            : tmegeath
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        Date observation    : 2018/10/14/07:37:40.319999
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        Telescope position: [2.22514e+06m, -5.44031e+06m, -2.48103e+06m] (ITRF)
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        Axis Coord Type      Name             Proj Shape Tile   Coord value at pixel          Coord incr Units
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        ------------------------------------------------------------------------------------------------------
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        0    0     Direction Right Ascension   SIN   256  256  05:01:12.810   128.00       -2.500000e-01 arcsec
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        1    0     Direction Declination       SIN   256  256 -01.59.14.256   128.00        2.500000e-01 arcsec
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        2    1     Stokes    Stokes                    1    1             I
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+        3    2     Spectral  Frequency                 1    1   3.38235e+11     0.00 1.5364381797413e+10 Hz
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        ImageMetaData::summary+                             Velocity                              -6934.35     0.00       -1.393313e+04 km/s
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imhead::::casa        Task imhead complete. Start time: 2024-10-02 03:31:49.613797 End time: 2024-10-02 03:31:49.617834
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imhead::::casa        ##### End Task: imhead               #####
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imhead::::casa        ##########################################
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imhead::::casa        [ check_val ] total_visibilities is 378548640.0 ( Pass : should be 378548640.0, Exact: True )
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imhead::::casa+        [ check_val ] flags_importasdm is 2160.0 ( Pass : should be 2160.0, Exact: True )
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imhead::::casa+        [ check_val ] flags_restored is 125159272.0 ( Pass : should be 125159272.0, Exact: True )
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imhead::::casa+        [ check_val ] flags_applycal is 125159272.0 ( Pass : should be 125159272.0, Exact: True )
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imhead::::casa+        [ check_val ] flux_max is [1.55251241] ( Pass : should be 1.553, Epsilon: 0.01)
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imhead::::casa+        [ check_val ] beam_major is 4.845033645629883 ( Pass : should be 4.845, Epsilon: 0.01)
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imhead::::casa+        [ check_val ] beam_minor is 2.8984758853912354 ( Pass : should be 2.898, Epsilon: 0.01)
02-Oct-2024 07:33:00 2024-10-02 07:31:50        INFO        imhead::::casa+        [ check_val ] positionangle is 78.95391845703125 ( Pass : should be 78.954, Epsilon: 0.01)
02-Oct-2024 07:33:00 .2024-10-02 07:31:51        INFO        importasdm::::casa        ##########################################
02-Oct-2024 07:33:00 2024-10-02 07:31:51        INFO        importasdm::::casa        ##### Begin Task: importasdm         #####
02-Oct-2024 07:33:00 2024-10-02 07:31:51        INFO        importasdm::::casa        importasdm( asdm='18A-426.sb35644955.eb35676220.58411.96917952546', vis='18A-426.sb35644955.eb35676220.58411.96917952546.ms', createmms=False, separationaxis='auto', numsubms='auto', corr_mode='all', srt='all', time_sampling='all', ocorr_mode='co', compression=False, lazy=False, asis='Receiver CalAtmosphere', wvr_corrected_data='no', scans='', ignore_time=False, process_syspower=True, process_caldevice=True, process_pointing=True, process_flags=True, tbuff=0.0, applyflags=False, savecmds=False, outfile='', flagbackup=True, verbose=False, overwrite=False, bdfflags=False, with_pointing_correction=True, convert_ephem2geo=True, polyephem_tabtimestep=0.0 )
02-Oct-2024 07:33:25 2024-10-02 07:33:00        WARN        importasdm::::sdm (file src/tools/sdm/sdm_cmpt.cc, line 3576)        Main row #7 - The BDF '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASA-CMTS-SRME/work/test_stk_srdp_restore_mode/18A-426.sb35644955.eb35676220.58411.96917952546/ASDMBinary/uid____evla_bdf_1540078994636' contained data not in the time range of scan=8, subscan=1.
02-Oct-2024 07:33:25 2024-10-02 07:33:01        INFO        importasdm::::casa        No ephemerides attached.
02-Oct-2024 07:33:25 2024-10-02 07:33:01        INFO        AgentFlagger::open        Table type is Measurement Set
02-Oct-2024 07:33:25 2024-10-02 07:33:01        INFO        FlagVersion::saveFlagVersion        Creating new backup flag file called Original
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        importasdm::::casa        Found Flag.xml in SDM
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        importasdm::::casa        Found Antenna.xml in SDM
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        importasdm::::casa        Found SpectralWindow.xml in SDM
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        importasdm::::casa        Found 25 rows in Antenna.xml
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        importasdm::::casa        Found 16 rows in SpectralWindow.xml
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        importasdm::::casa        Will construct spw flags using names
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        importasdm::::casa        Will construct polarization flags using polarizationType
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        importasdm::::casa        Found numAntenna=1 must be a new style SDM
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        importasdm::::casa        Found 153 flags in Flag.xml
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        importasdm::::casa        Will not apply flags to 18A-426.sb35644955.eb35676220.58411.96917952546.ms (apply_flags=False), use flagcmd to apply
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        importasdm::::casa        There are 0 rows already in FLAG_CMD
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        importasdm::::casa        Saved 153 rows to FLAG_CMD of 18A-426.sb35644955.eb35676220.58411.96917952546.ms
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        importasdm::::casa        Task importasdm complete. Start time: 2024-10-02 03:31:50.951642 End time: 2024-10-02 03:33:04.374853
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        importasdm::::casa        ##### End Task: importasdm           #####
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        importasdm::::casa        ##########################################
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        flagdata::::casa        ##########################################
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        flagdata::::casa        ##### Begin Task: flagdata           #####
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        flagdata::::casa        flagdata( vis='18A-426.sb35644955.eb35676220.58411.96917952546.ms', mode='summary', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='', field='', antenna='', uvrange='', timerange='', correlation='', scan='', intent='', array='', observation='', feed='', clipminmax=[], datacolumn='DATA', clipoutside=True, channelavg=False, chanbin=1, timeavg=False, timebin='0s', clipzeros=False, quackinterval=1.0, quackmode='beg', quackincrement=False, tolerance=0.0, addantenna='', lowerlimit=0.0, upperlimit=90.0, ntime='scan', combinescans=False, timecutoff=4.0, freqcutoff=3.0, timefit='line', freqfit='poly', maxnpieces=7, flagdimension='freqtime', usewindowstats='none', halfwin=1, extendflags=True, winsize=3, timedev='', freqdev='', timedevscale=5.0, freqdevscale=5.0, spectralmax=1000000.0, spectralmin=0.0, antint_ref_antenna='', minchanfrac=0.6, verbose=False, extendpols=True, growtime=50.0, growfreq=50.0, growaround=False, flagneartime=False, flagnearfreq=False, minrel=0.0, maxrel=1.0, minabs=0, maxabs=-1, spwchan=False, spwcorr=False, basecnt=False, fieldcnt=False, name='after importasdm', action='apply', display='', flagbackup=True, savepars=False, cmdreason='', outfile='', overwrite=True, writeflags=True )
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        AgentFlagger::open        Table type is Measurement Set
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        flagdata::::casa        Summary mode is active
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        flagdata::::casa        Initializing the agents
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        AgentFlagger::initAgents        There are initially 1 agents in the list. Agents: summary
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        Summary::setAgentParameters          display is:
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        AgentFlagger::initAgents        There are 1 valid agents in the list. Agents: summary
02-Oct-2024 07:33:25 2024-10-02 07:33:04        INFO        flagdata::::casa        Running the agentflagger tool
02-Oct-2024 07:33:25 2024-10-02 07:33:07        INFO        FlagMSHandler::        Chunk = 1 [progress: 0%], Observation = 0, Array = 0, Scan = 1, Field = 0 (1331+305=3C286), Spw = 0, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 8100
02-Oct-2024 07:33:25 2024-10-02 07:33:08        INFO        FlagMSHandler::        Chunk = 21 [progress: 10%], Observation = 0, Array = 0, Scan = 2, Field = 0 (1331+305=3C286), Spw = 4, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 80700
02-Oct-2024 07:33:25 2024-10-02 07:33:10        INFO        FlagMSHandler::        Chunk = 28 [progress: 20%], Observation = 0, Array = 0, Scan = 2, Field = 0 (1331+305=3C286), Spw = 11, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 80700
02-Oct-2024 07:33:25 2024-10-02 07:33:12        INFO        FlagMSHandler::        Chunk = 36 [progress: 30%], Observation = 0, Array = 0, Scan = 3, Field = 0 (1331+305=3C286), Spw = 3, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 44400
02-Oct-2024 07:33:25 2024-10-02 07:33:14        INFO        FlagMSHandler::        Chunk = 48 [progress: 40%], Observation = 0, Array = 0, Scan = 3, Field = 0 (1331+305=3C286), Spw = 15, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 44400
02-Oct-2024 07:33:25 2024-10-02 07:33:16        INFO        FlagMSHandler::        Chunk = 61 [progress: 50%], Observation = 0, Array = 0, Scan = 4, Field = 1 (J1820-2528), Spw = 12, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 40200
02-Oct-2024 07:33:25 2024-10-02 07:33:18        INFO        FlagMSHandler::        Chunk = 84 [progress: 60%], Observation = 0, Array = 0, Scan = 6, Field = 2 (HD163296), Spw = 3, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 65400
02-Oct-2024 07:33:25 2024-10-02 07:33:20        INFO        FlagMSHandler::        Chunk = 92 [progress: 70%], Observation = 0, Array = 0, Scan = 6, Field = 2 (HD163296), Spw = 11, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 65400
02-Oct-2024 07:33:25 2024-10-02 07:33:21        INFO        FlagMSHandler::        Chunk = 100 [progress: 80%], Observation = 0, Array = 0, Scan = 7, Field = 2 (HD163296), Spw = 3, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 67800
02-Oct-2024 07:33:25 2024-10-02 07:33:23        INFO        FlagMSHandler::        Chunk = 108 [progress: 91%], Observation = 0, Array = 0, Scan = 7, Field = 2 (HD163296), Spw = 11, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 67800
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        FlagMSHandler::        Chunk = 128 [progress: 100%], Observation = 0, Array = 0, Scan = 8, Field = 1 (J1820-2528), Spw = 15, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 11700
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        FlagMSHandler::nextChunk         ====================================================================================
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          observation 0 flagged: 0 total: 1.33939e+09 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          scan 7 flagged: 0 total: 2.77709e+08 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          scan 2 flagged: 0 total: 3.30547e+08 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          scan 1 flagged: 0 total: 3.31776e+07 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          scan 8 flagged: 0 total: 4.79232e+07 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          scan 5 flagged: 0 total: 3.56352e+07 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          scan 3 flagged: 0 total: 1.81862e+08 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          scan 4 flagged: 0 total: 1.64659e+08 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          scan 6 flagged: 0 total: 2.67878e+08 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea26 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea25 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea24 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea23 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea22 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea03 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea06 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea12 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea01 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea15 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea28 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea16 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea07 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea02 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:33:25 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea09 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea20 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea17 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea10 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea21 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea19 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea04 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea11 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea05 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea14 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          antenna ea18 flagged: 0 total: 1.07151e+08 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          field HD163296 flagged: 0 total: 5.45587e+08 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          field 1331+305=3C286 flagged: 0 total: 5.45587e+08 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          field J1820-2528 flagged: 0 total: 2.48218e+08 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          spw 15 flagged: 0 total: 8.3712e+07 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          spw 14 flagged: 0 total: 8.3712e+07 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          spw 10 flagged: 0 total: 8.3712e+07 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          spw 7 flagged: 0 total: 8.3712e+07 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          spw 12 flagged: 0 total: 8.3712e+07 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          spw 6 flagged: 0 total: 8.3712e+07 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          spw 8 flagged: 0 total: 8.3712e+07 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          spw 5 flagged: 0 total: 8.3712e+07 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          spw 0 flagged: 0 total: 8.3712e+07 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          spw 11 flagged: 0 total: 8.3712e+07 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          spw 9 flagged: 0 total: 8.3712e+07 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          spw 4 flagged: 0 total: 8.3712e+07 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          spw 1 flagged: 0 total: 8.3712e+07 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          spw 2 flagged: 0 total: 8.3712e+07 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          spw 13 flagged: 0 total: 8.3712e+07 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          spw 3 flagged: 0 total: 8.3712e+07 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          correlation LL flagged: 0 total: 3.34848e+08 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          correlation LR flagged: 0 total: 3.34848e+08 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          correlation RR flagged: 0 total: 3.34848e+08 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          correlation RL flagged: 0 total: 3.34848e+08 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          array 0 flagged: 0 total: 1.33939e+09 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        Summary::getResult          Total Flagged: 0 Total Counts: 1.33939e+09 (0%)
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        flagdata::::casa        Flags are not written to the MS. (action='calculate')
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        flagdata::::casa        Task flagdata complete. Start time: 2024-10-02 03:33:04.382462 End time: 2024-10-02 03:33:25.100082
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        flagdata::::casa        ##### End Task: flagdata             #####
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        flagdata::::casa        ##########################################
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        hanningsmooth::::casa        ##########################################
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        hanningsmooth::::casa        ##### Begin Task: hanningsmooth      #####
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        hanningsmooth::::casa        hanningsmooth( vis='18A-426.sb35644955.eb35676220.58411.96917952546.ms', outputvis='temphanning.ms', keepmms=True, field='', spw='', scan='', antenna='', correlation='', timerange='', intent='', array='', uvrange='', observation='', feed='', datacolumn='data' )
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        MSTransformManager::parseMsSpecParams        Input file name is 18A-426.sb35644955.eb35676220.58411.96917952546.ms
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        MSTransformManager::parseMsSpecParams        Data column is DATA
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        MSTransformManager::parseMsSpecParams        Output file name is temphanning.ms
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        MSTransformManager::parseFreqTransParams        Hanning Smooth is activated
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        MSTransformManager::colCheckInfo        Adding DATA column to output MS from input DATA column
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        MSTransformManager::open        Select data
02-Oct-2024 07:35:59 2024-10-02 07:33:25        INFO        MSTransformManager::createOutputMSStructure        Create output MS structure
02-Oct-2024 07:35:59 2024-10-02 07:33:30        INFO        hanningsmooth::::casa        Apply Hanning smoothing on data
02-Oct-2024 07:35:59 2024-10-02 07:35:56        INFO        hanningsmooth::::casa        Task hanningsmooth complete. Start time: 2024-10-02 03:33:25.107277 End time: 2024-10-02 03:35:56.307077
02-Oct-2024 07:35:59 2024-10-02 07:35:56        INFO        hanningsmooth::::casa        ##### End Task: hanningsmooth        #####
02-Oct-2024 07:35:59 2024-10-02 07:35:56        INFO        hanningsmooth::::casa        ##########################################
02-Oct-2024 07:35:59 18A-426.sb35644955.eb35676220.58411.96917952546.ms.flagversions/flags.Pipeline_Final/
02-Oct-2024 07:35:59 18A-426.sb35644955.eb35676220.58411.96917952546.ms.flagversions/flags.Pipeline_Final/table.f1
02-Oct-2024 07:35:59 18A-426.sb35644955.eb35676220.58411.96917952546.ms.flagversions/flags.Pipeline_Final/table.dat
02-Oct-2024 07:35:59 18A-426.sb35644955.eb35676220.58411.96917952546.ms.flagversions/flags.Pipeline_Final/table.f0
02-Oct-2024 07:35:59 18A-426.sb35644955.eb35676220.58411.96917952546.ms.flagversions/flags.Pipeline_Final/table.lock
02-Oct-2024 07:35:59 18A-426.sb35644955.eb35676220.58411.96917952546.ms.flagversions/flags.Pipeline_Final/table.info
02-Oct-2024 07:35:59 18A-426.sb35644955.eb35676220.58411.96917952546.ms.flagversions/flags.Pipeline_Final/table.f0_TSM1
02-Oct-2024 07:35:59 18A-426.sb35644955.eb35676220.58411.96917952546.ms.flagversions/FLAG_VERSION_LIST
02-Oct-2024 07:35:59 2024-10-02 07:35:58        INFO        flagmanager::::casa        ##########################################
02-Oct-2024 07:35:59 2024-10-02 07:35:58        INFO        flagmanager::::casa        ##### Begin Task: flagmanager        #####
02-Oct-2024 07:35:59 2024-10-02 07:35:58        INFO        flagmanager::::casa        flagmanager( vis='18A-426.sb35644955.eb35676220.58411.96917952546.ms', mode='restore', versionname='Pipeline_Final', oldname='', comment='', merge='replace' )
02-Oct-2024 07:35:59 2024-10-02 07:35:58        INFO        flagmanager::AgentFlagger::open        Table type is Measurement Set
02-Oct-2024 07:35:59 2024-10-02 07:35:58        INFO        flagmanager::::casa        Restore flagversions Pipeline_Final
02-Oct-2024 07:35:59 2024-10-02 07:36:00        INFO        flagmanager::::casa        Task flagmanager complete. Start time: 2024-10-02 03:35:57.881027 End time: 2024-10-02 03:35:59.640766
02-Oct-2024 07:35:59 2024-10-02 07:36:00        INFO        flagmanager::::casa        ##### End Task: flagmanager          #####
02-Oct-2024 07:35:59 2024-10-02 07:36:00        INFO        flagmanager::::casa        ##########################################
02-Oct-2024 07:35:59 2024-10-02 07:36:00        INFO        flagdata::::casa        ##########################################
02-Oct-2024 07:35:59 2024-10-02 07:36:00        INFO        flagdata::::casa        ##### Begin Task: flagdata           #####
02-Oct-2024 07:35:59 2024-10-02 07:36:00        INFO        flagdata::::casa        flagdata( vis='18A-426.sb35644955.eb35676220.58411.96917952546.ms', mode='summary', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='', field='', antenna='', uvrange='', timerange='', correlation='', scan='', intent='', array='', observation='', feed='', clipminmax=[], datacolumn='DATA', clipoutside=True, channelavg=False, chanbin=1, timeavg=False, timebin='0s', clipzeros=False, quackinterval=1.0, quackmode='beg', quackincrement=False, tolerance=0.0, addantenna='', lowerlimit=0.0, upperlimit=90.0, ntime='scan', combinescans=False, timecutoff=4.0, freqcutoff=3.0, timefit='line', freqfit='poly', maxnpieces=7, flagdimension='freqtime', usewindowstats='none', halfwin=1, extendflags=True, winsize=3, timedev='', freqdev='', timedevscale=5.0, freqdevscale=5.0, spectralmax=1000000.0, spectralmin=0.0, antint_ref_antenna='', minchanfrac=0.6, verbose=False, extendpols=True, growtime=50.0, growfreq=50.0, growaround=False, flagneartime=False, flagnearfreq=False, minrel=0.0, maxrel=1.0, minabs=0, maxabs=-1, spwchan=False, spwcorr=False, basecnt=False, fieldcnt=False, name='before-applycal', action='apply', display='', flagbackup=True, savepars=False, cmdreason='', outfile='', overwrite=True, writeflags=True )
02-Oct-2024 07:36:22 2024-10-02 07:36:00        INFO        AgentFlagger::open        Table type is Measurement Set
02-Oct-2024 07:36:22 2024-10-02 07:36:00        INFO        flagdata::::casa        Summary mode is active
02-Oct-2024 07:36:22 2024-10-02 07:36:00        INFO        flagdata::::casa        Initializing the agents
02-Oct-2024 07:36:22 2024-10-02 07:36:00        INFO        AgentFlagger::initAgents        There are initially 1 agents in the list. Agents: summary
02-Oct-2024 07:36:22 2024-10-02 07:36:00        INFO        Summary::setAgentParameters          display is:
02-Oct-2024 07:36:22 2024-10-02 07:36:00        INFO        AgentFlagger::initAgents        There are 1 valid agents in the list. Agents: summary
02-Oct-2024 07:36:22 2024-10-02 07:36:00        INFO        flagdata::::casa        Running the agentflagger tool
02-Oct-2024 07:36:22 2024-10-02 07:36:02        INFO        FlagMSHandler::        Chunk = 1 [progress: 0%], Observation = 0, Array = 0, Scan = 1, Field = 0 (1331+305=3C286), Spw = 0, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 8100
02-Oct-2024 07:36:22 2024-10-02 07:36:04        INFO        FlagMSHandler::        Chunk = 21 [progress: 10%], Observation = 0, Array = 0, Scan = 2, Field = 0 (1331+305=3C286), Spw = 4, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 80700
02-Oct-2024 07:36:22 2024-10-02 07:36:06        INFO        FlagMSHandler::        Chunk = 28 [progress: 20%], Observation = 0, Array = 0, Scan = 2, Field = 0 (1331+305=3C286), Spw = 11, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 80700
02-Oct-2024 07:36:22 2024-10-02 07:36:08        INFO        FlagMSHandler::        Chunk = 36 [progress: 30%], Observation = 0, Array = 0, Scan = 3, Field = 0 (1331+305=3C286), Spw = 3, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 44400
02-Oct-2024 07:36:22 2024-10-02 07:36:10        INFO        FlagMSHandler::        Chunk = 48 [progress: 40%], Observation = 0, Array = 0, Scan = 3, Field = 0 (1331+305=3C286), Spw = 15, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 44400
02-Oct-2024 07:36:22 2024-10-02 07:36:12        INFO        FlagMSHandler::        Chunk = 61 [progress: 50%], Observation = 0, Array = 0, Scan = 4, Field = 1 (J1820-2528), Spw = 12, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 40200
02-Oct-2024 07:36:22 2024-10-02 07:36:14        INFO        FlagMSHandler::        Chunk = 84 [progress: 60%], Observation = 0, Array = 0, Scan = 6, Field = 2 (HD163296), Spw = 3, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 65400
02-Oct-2024 07:36:22 2024-10-02 07:36:16        INFO        FlagMSHandler::        Chunk = 92 [progress: 70%], Observation = 0, Array = 0, Scan = 6, Field = 2 (HD163296), Spw = 11, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 65400
02-Oct-2024 07:36:22 2024-10-02 07:36:18        INFO        FlagMSHandler::        Chunk = 100 [progress: 80%], Observation = 0, Array = 0, Scan = 7, Field = 2 (HD163296), Spw = 3, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 67800
02-Oct-2024 07:36:22 2024-10-02 07:36:20        INFO        FlagMSHandler::        Chunk = 108 [progress: 91%], Observation = 0, Array = 0, Scan = 7, Field = 2 (HD163296), Spw = 11, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 67800
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        FlagMSHandler::        Chunk = 128 [progress: 100%], Observation = 0, Array = 0, Scan = 8, Field = 1 (J1820-2528), Spw = 15, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 11700
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        FlagMSHandler::nextChunk         ====================================================================================
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          observation 0 flagged: 6.29265e+08 total: 1.33939e+09 (47%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          scan 7 flagged: 1.14377e+08 total: 2.77709e+08 (41.2%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          scan 2 flagged: 9.08236e+07 total: 3.30547e+08 (27.5%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          scan 1 flagged: 3.31776e+07 total: 3.31776e+07 (100%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          scan 8 flagged: 2.73149e+07 total: 4.79232e+07 (57%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          scan 5 flagged: 1.53338e+07 total: 3.56352e+07 (43%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          scan 3 flagged: 9.27229e+07 total: 1.81862e+08 (51%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          scan 4 flagged: 1.40501e+08 total: 1.64659e+08 (85.3%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          scan 6 flagged: 1.15014e+08 total: 2.67878e+08 (42.9%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea26 flagged: 6.47505e+07 total: 1.07151e+08 (60.4%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea25 flagged: 5.21805e+07 total: 1.07151e+08 (48.7%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea24 flagged: 4.04119e+07 total: 1.07151e+08 (37.7%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea23 flagged: 4.01001e+07 total: 1.07151e+08 (37.4%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea22 flagged: 8.63511e+07 total: 1.07151e+08 (80.6%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea03 flagged: 4.06793e+07 total: 1.07151e+08 (38%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea06 flagged: 4.11481e+07 total: 1.07151e+08 (38.4%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea12 flagged: 4.03226e+07 total: 1.07151e+08 (37.6%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea01 flagged: 4.02048e+07 total: 1.07151e+08 (37.5%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea15 flagged: 7.99907e+07 total: 1.07151e+08 (74.7%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea28 flagged: 4.21666e+07 total: 1.07151e+08 (39.4%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea16 flagged: 6.69877e+07 total: 1.07151e+08 (62.5%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea07 flagged: 4.07694e+07 total: 1.07151e+08 (38%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea02 flagged: 4.08827e+07 total: 1.07151e+08 (38.2%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea09 flagged: 4.43616e+07 total: 1.07151e+08 (41.4%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea20 flagged: 4.14775e+07 total: 1.07151e+08 (38.7%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea17 flagged: 4.30578e+07 total: 1.07151e+08 (40.2%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea10 flagged: 3.97169e+07 total: 1.07151e+08 (37.1%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea21 flagged: 7.92227e+07 total: 1.07151e+08 (73.9%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea19 flagged: 5.20818e+07 total: 1.07151e+08 (48.6%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea04 flagged: 7.98392e+07 total: 1.07151e+08 (74.5%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea11 flagged: 4.08012e+07 total: 1.07151e+08 (38.1%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea05 flagged: 4.10069e+07 total: 1.07151e+08 (38.3%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea14 flagged: 3.91902e+07 total: 1.07151e+08 (36.6%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          antenna ea18 flagged: 4.08291e+07 total: 1.07151e+08 (38.1%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          field HD163296 flagged: 2.29392e+08 total: 5.45587e+08 (42%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          field 1331+305=3C286 flagged: 2.16724e+08 total: 5.45587e+08 (39.7%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          field J1820-2528 flagged: 1.8315e+08 total: 2.48218e+08 (73.8%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          spw 15 flagged: 4.29131e+07 total: 8.3712e+07 (51.3%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          spw 14 flagged: 3.81468e+07 total: 8.3712e+07 (45.6%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          spw 10 flagged: 3.699e+07 total: 8.3712e+07 (44.2%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          spw 7 flagged: 4.27074e+07 total: 8.3712e+07 (51%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          spw 12 flagged: 4.01946e+07 total: 8.3712e+07 (48%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          spw 6 flagged: 3.84568e+07 total: 8.3712e+07 (45.9%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          spw 8 flagged: 4.29436e+07 total: 8.3712e+07 (51.3%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          spw 5 flagged: 3.70833e+07 total: 8.3712e+07 (44.3%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          spw 0 flagged: 4.39489e+07 total: 8.3712e+07 (52.5%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          spw 11 flagged: 3.97964e+07 total: 8.3712e+07 (47.5%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          spw 9 flagged: 3.70475e+07 total: 8.3712e+07 (44.3%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          spw 4 flagged: 3.70835e+07 total: 8.3712e+07 (44.3%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          spw 1 flagged: 3.80499e+07 total: 8.3712e+07 (45.5%)
02-Oct-2024 07:36:22 2024-10-02 07:36:22        INFO        Summary::getResult          spw 2 flagged: 3.77375e+07 total: 8.3712e+07 (45.1%)
02-Oct-2024 07:36:44 2024-10-02 07:36:22        INFO        Summary::getResult          spw 13 flagged: 3.90141e+07 total: 8.3712e+07 (46.6%)
02-Oct-2024 07:36:44 2024-10-02 07:36:22        INFO        Summary::getResult          spw 3 flagged: 3.71521e+07 total: 8.3712e+07 (44.4%)
02-Oct-2024 07:36:44 2024-10-02 07:36:22        INFO        Summary::getResult          correlation LL flagged: 1.57316e+08 total: 3.34848e+08 (47%)
02-Oct-2024 07:36:44 2024-10-02 07:36:22        INFO        Summary::getResult          correlation LR flagged: 1.57316e+08 total: 3.34848e+08 (47%)
02-Oct-2024 07:36:44 2024-10-02 07:36:22        INFO        Summary::getResult          correlation RR flagged: 1.57316e+08 total: 3.34848e+08 (47%)
02-Oct-2024 07:36:44 2024-10-02 07:36:22        INFO        Summary::getResult          correlation RL flagged: 1.57316e+08 total: 3.34848e+08 (47%)
02-Oct-2024 07:36:44 2024-10-02 07:36:22        INFO        Summary::getResult          array 0 flagged: 6.29265e+08 total: 1.33939e+09 (47%)
02-Oct-2024 07:36:44 2024-10-02 07:36:22        INFO        Summary::getResult          Total Flagged: 6.29265e+08 Total Counts: 1.33939e+09 (47%)
02-Oct-2024 07:36:44 2024-10-02 07:36:22        INFO        flagdata::::casa        Flags are not written to the MS. (action='calculate')
02-Oct-2024 07:36:44 2024-10-02 07:36:22        INFO        flagdata::::casa        Task flagdata complete. Start time: 2024-10-02 03:35:59.650267 End time: 2024-10-02 03:36:22.416138
02-Oct-2024 07:36:44 2024-10-02 07:36:22        INFO        flagdata::::casa        ##### End Task: flagdata             #####
02-Oct-2024 07:36:44 2024-10-02 07:36:22        INFO        flagdata::::casa        ##########################################
02-Oct-2024 07:36:44 2024-10-02 07:36:22        INFO        applycal::::casa        ##########################################
02-Oct-2024 07:36:44 2024-10-02 07:36:22        INFO        applycal::::casa        ##### Begin Task: applycal           #####
02-Oct-2024 07:36:44 2024-10-02 07:36:22        INFO        applycal::::casa        applycal( vis='18A-426.sb35644955.eb35676220.58411.96917952546.ms', field='', spw='', intent='', selectdata=True, timerange='', uvrange='', antenna='*&*', scan='', observation='', msselect='', docallib=False, callib='', gaintable=['18A-426.sb35644955.eb35676220.58411.96917952546.ms.hifv_priorcals.s5_3.gc.tbl', '18A-426.sb35644955.eb35676220.58411.96917952546.ms.hifv_priorcals.s5_4.opac.tbl', '18A-426.sb35644955.eb35676220.58411.96917952546.ms.hifv_priorcals.s5_5.rq.tbl', '18A-426.sb35644955.eb35676220.58411.96917952546.ms.finaldelay.k', '18A-426.sb35644955.eb35676220.58411.96917952546.ms.finalBPcal.b', '18A-426.sb35644955.eb35676220.58411.96917952546.ms.averagephasegain.g', '18A-426.sb35644955.eb35676220.58411.96917952546.ms.finalampgaincal.g', '18A-426.sb35644955.eb35676220.58411.96917952546.ms.finalphasegaincal.g'], gainfield=['', '', '', '', '', '', '', ''], interp=['linear', 'linear', 'linear', 'linear', 'linear,nearestflag', 'linear', 'linear', 'linear'], spwmap=[[], [], [], [], [], [], [], []], calwt=[False, False, False, False, False, False, False, False], parang=True, applymode='calflagstrict', flagbackup=False )
02-Oct-2024 07:36:44 2024-10-02 07:36:22        INFO        applycal::calibrater::open        ****Using NEW VI2-driven calibrater tool****
02-Oct-2024 07:36:44 2024-10-02 07:36:22        INFO        applycal::calibrater::open        Opening MS: 18A-426.sb35644955.eb35676220.58411.96917952546.ms for calibration.
02-Oct-2024 07:36:44 2024-10-02 07:36:22        INFO        applycal::VisSetUtil::addScrCols        Adding CORRECTED_DATA column(s).
02-Oct-2024 07:36:44 2024-10-02 07:36:40        INFO        applycal::Calibrater::        Initializing nominal selection to the whole MS.
02-Oct-2024 07:36:44 2024-10-02 07:36:40        INFO        applycal::calibrater::setdata        Beginning selectvis--(MSSelection version)-------
02-Oct-2024 07:36:44 2024-10-02 07:36:40        INFO        applycal::calibrater::reset        Reseting solve/apply state
02-Oct-2024 07:36:44 2024-10-02 07:36:40        INFO        applycal::Calibrater::selectvis        Performing selection on MeasurementSet
02-Oct-2024 07:36:44 2024-10-02 07:36:40        INFO        applycal::Calibrater::selectvis+         Selecting on antenna/baseline: '*&*'
02-Oct-2024 07:36:44 2024-10-02 07:36:40        INFO        applycal::Calibrater::selectvis        Selection did not drop any rows
02-Oct-2024 07:36:44 2024-10-02 07:36:40        INFO        applycal::Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
02-Oct-2024 07:36:44 2024-10-02 07:36:40        INFO        applycal::calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect=''
02-Oct-2024 07:36:44 2024-10-02 07:36:40        INFO        applycal::calibrater::setapply        Beginning setapply--(MSSelection version)-------
02-Oct-2024 07:36:44 2024-10-02 07:36:40        INFO        applycal::Calibrater::setapply(type, applypar)        Arranging to APPLY:
02-Oct-2024 07:36:44 2024-10-02 07:36:41        INFO        applycal::Calibrater::setapply(type, applypar)        .   EGainCurve: table=18A-426.sb35644955.eb35676220.58411.96917952546.ms.hifv_priorcals.s5_3.gc.tbl select= interp=linear spwmap=[] calWt=false
02-Oct-2024 07:36:44 2024-10-02 07:36:41        INFO        applycal::calibrater::setapply        Beginning setapply--(MSSelection version)-------
02-Oct-2024 07:36:44 2024-10-02 07:36:41        INFO        applycal::Calibrater::setapply(type, applypar)        Arranging to APPLY:
02-Oct-2024 07:36:44 2024-10-02 07:36:41        INFO        applycal::Calibrater::setapply(type, applypar)        .   TOpac: table=18A-426.sb35644955.eb35676220.58411.96917952546.ms.hifv_priorcals.s5_4.opac.tbl select= interp=linear spwmap=[] calWt=false
02-Oct-2024 07:36:44 2024-10-02 07:36:41        INFO        applycal::calibrater::setapply        Beginning setapply--(MSSelection version)-------
02-Oct-2024 07:36:44 2024-10-02 07:36:41        INFO        applycal::Calibrater::setapply(type, applypar)        Arranging to APPLY:
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::Calibrater::setapply(type, applypar)        .   G EVLASWPOW: table=18A-426.sb35644955.eb35676220.58411.96917952546.ms.hifv_priorcals.s5_5.rq.tbl select= interp=linear spwmap=[] calWt=false
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::calibrater::setapply        Beginning setapply--(MSSelection version)-------
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::Calibrater::setapply(type, applypar)        Arranging to APPLY:
02-Oct-2024 07:36:44 2024-10-02 07:36:45        WARN        applycal::::         Found pre-5.3.0 CASA delay cal table; using spw REF_FREQUENCY pivot (usually the edge) for phase(freq) calculation.
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::Calibrater::setapply(type, applypar)        .   K Jones: table=18A-426.sb35644955.eb35676220.58411.96917952546.ms.finaldelay.k select= interp=linear spwmap=[] calWt=false
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::calibrater::setapply        Beginning setapply--(MSSelection version)-------
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::Calibrater::setapply(type, applypar)        Arranging to APPLY:
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::Calibrater::setapply(type, applypar)        .   B Jones: table=18A-426.sb35644955.eb35676220.58411.96917952546.ms.finalBPcal.b select= interp=linear,nearestflag spwmap=[] calWt=false
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::calibrater::setapply        Beginning setapply--(MSSelection version)-------
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::Calibrater::setapply(type, applypar)        Arranging to APPLY:
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::Calibrater::setapply(type, applypar)        .   G Jones: table=18A-426.sb35644955.eb35676220.58411.96917952546.ms.averagephasegain.g select= interp=linear spwmap=[] calWt=false
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::calibrater::setapply        Beginning setapply--(MSSelection version)-------
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::Calibrater::setapply(type, applypar)        Arranging to APPLY:
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::Calibrater::setapply(type, applypar)        .   G Jones: table=18A-426.sb35644955.eb35676220.58411.96917952546.ms.finalampgaincal.g select= interp=linear spwmap=[] calWt=false
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::calibrater::setapply        Beginning setapply--(MSSelection version)-------
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::Calibrater::setapply(type, applypar)        Arranging to APPLY:
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::Calibrater::setapply(type, applypar)        .   G Jones: table=18A-426.sb35644955.eb35676220.58411.96917952546.ms.finalphasegaincal.g select= interp=linear spwmap=[] calWt=false
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::calibrater::setapply        Beginning setapply--(MSSelection version)-------
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::Calibrater::setapply(type, applypar)        Arranging to APPLY:
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::Calibrater::setapply(type, applypar)        .   P Jones <pre-computed>
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::calibrater::correct        Beginning correct---------------------------
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::Calibrater::correct2 (VI2/VB2)        The following calibration terms are arranged for apply:
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::Calibrater::correct2 (VI2/VB2)        .   B Jones: table=18A-426.sb35644955.eb35676220.58411.96917952546.ms.finalBPcal.b select= interp=linear,nearestflag spwmap=[] calWt=false
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::Calibrater::correct2 (VI2/VB2)        .   K Jones: table=18A-426.sb35644955.eb35676220.58411.96917952546.ms.finaldelay.k select= interp=linear spwmap=[] calWt=false
02-Oct-2024 07:36:44 2024-10-02 07:36:45        INFO        applycal::Calibrater::correct2 (VI2/VB2)        .   G EVLASWPOW: table=18A-426.sb35644955.eb35676220.58411.96917952546.ms.hifv_priorcals.s5_5.rq.tbl select= interp=linear spwmap=[] calWt=false
02-Oct-2024 07:39:54 2024-10-02 07:36:45        INFO        applycal::Calibrater::correct2 (VI2/VB2)        .   G Jones: table=18A-426.sb35644955.eb35676220.58411.96917952546.ms.averagephasegain.g select= interp=linear spwmap=[] calWt=false
02-Oct-2024 07:39:54 2024-10-02 07:36:45        INFO        applycal::Calibrater::correct2 (VI2/VB2)        .   G Jones: table=18A-426.sb35644955.eb35676220.58411.96917952546.ms.finalampgaincal.g select= interp=linear spwmap=[] calWt=false
02-Oct-2024 07:39:54 2024-10-02 07:36:45        INFO        applycal::Calibrater::correct2 (VI2/VB2)        .   G Jones: table=18A-426.sb35644955.eb35676220.58411.96917952546.ms.finalphasegaincal.g select= interp=linear spwmap=[] calWt=false
02-Oct-2024 07:39:54 2024-10-02 07:36:45        INFO        applycal::Calibrater::correct2 (VI2/VB2)        .   P Jones <pre-computed>
02-Oct-2024 07:39:54 2024-10-02 07:36:45        INFO        applycal::Calibrater::correct2 (VI2/VB2)        .   EGainCurve: table=18A-426.sb35644955.eb35676220.58411.96917952546.ms.hifv_priorcals.s5_3.gc.tbl select= interp=linear spwmap=[] calWt=false
02-Oct-2024 07:39:54 2024-10-02 07:36:45        INFO        applycal::Calibrater::correct2 (VI2/VB2)        .   TOpac: table=18A-426.sb35644955.eb35676220.58411.96917952546.ms.hifv_priorcals.s5_4.opac.tbl select= interp=linear spwmap=[] calWt=false
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        applycal::calibrater::correct        Finished correcting.
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        applycal::::casa        Calibration apply flagging statistics (among calibrateable spws):
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        applycal::::casa          Total visibilities selected for correction (ncorr x nchan x nrow summed over spws) = 1339392000
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        applycal::::casa          Flags:
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        applycal::::casa           B Jones: In: 629265468 / 1339392000   (46.98142649799312%) --> Out: 629265468 / 1339392000   (46.98142649799312%) (18A-426.sb35644955.eb35676220.58411.96917952546.ms.finalBPcal.b)
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        applycal::::casa           K Jones: In: 629265468 / 1339392000   (46.98142649799312%) --> Out: 629265468 / 1339392000   (46.98142649799312%) (18A-426.sb35644955.eb35676220.58411.96917952546.ms.finaldelay.k)
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        applycal::::casa           G EVLASWPOW: In: 629265468 / 1339392000   (46.98142649799312%) --> Out: 629265468 / 1339392000   (46.98142649799312%) (18A-426.sb35644955.eb35676220.58411.96917952546.ms.hifv_priorcals.s5_5.rq.tbl)
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        applycal::::casa           G Jones: In: 629265468 / 1339392000   (46.98142649799312%) --> Out: 629265468 / 1339392000   (46.98142649799312%) (18A-426.sb35644955.eb35676220.58411.96917952546.ms.averagephasegain.g)
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        applycal::::casa           G Jones: In: 629265468 / 1339392000   (46.98142649799312%) --> Out: 629265468 / 1339392000   (46.98142649799312%) (18A-426.sb35644955.eb35676220.58411.96917952546.ms.finalampgaincal.g)
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        applycal::::casa           G Jones: In: 629265468 / 1339392000   (46.98142649799312%) --> Out: 629265468 / 1339392000   (46.98142649799312%) (18A-426.sb35644955.eb35676220.58411.96917952546.ms.finalphasegaincal.g)
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        applycal::::casa           P Jones: In: 629265468 / 1339392000   (46.98142649799312%) --> Out: 629265468 / 1339392000   (46.98142649799312%)
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        applycal::::casa           EGainCurve: In: 629265468 / 1339392000   (46.98142649799312%) --> Out: 629265468 / 1339392000   (46.98142649799312%) (18A-426.sb35644955.eb35676220.58411.96917952546.ms.hifv_priorcals.s5_3.gc.tbl)
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        applycal::::casa           TOpac: In: 629265468 / 1339392000   (46.98142649799312%) --> Out: 629265468 / 1339392000   (46.98142649799312%) (18A-426.sb35644955.eb35676220.58411.96917952546.ms.hifv_priorcals.s5_4.opac.tbl)
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        applycal::::casa        Task applycal complete. Start time: 2024-10-02 03:36:22.418467 End time: 2024-10-02 03:39:31.449648
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        applycal::::casa        ##### End Task: applycal             #####
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        applycal::::casa        ##########################################
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        flagdata::::casa        ##########################################
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        flagdata::::casa        ##### Begin Task: flagdata           #####
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        flagdata::::casa        flagdata( vis='18A-426.sb35644955.eb35676220.58411.96917952546.ms', mode='summary', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='', field='', antenna='', uvrange='', timerange='', correlation='', scan='', intent='', array='', observation='', feed='', clipminmax=[], datacolumn='DATA', clipoutside=True, channelavg=False, chanbin=1, timeavg=False, timebin='0s', clipzeros=False, quackinterval=1.0, quackmode='beg', quackincrement=False, tolerance=0.0, addantenna='', lowerlimit=0.0, upperlimit=90.0, ntime='scan', combinescans=False, timecutoff=4.0, freqcutoff=3.0, timefit='line', freqfit='poly', maxnpieces=7, flagdimension='freqtime', usewindowstats='none', halfwin=1, extendflags=True, winsize=3, timedev='', freqdev='', timedevscale=5.0, freqdevscale=5.0, spectralmax=1000000.0, spectralmin=0.0, antint_ref_antenna='', minchanfrac=0.6, verbose=False, extendpols=True, growtime=50.0, growfreq=50.0, growaround=False, flagneartime=False, flagnearfreq=False, minrel=0.0, maxrel=1.0, minabs=0, maxabs=-1, spwchan=False, spwcorr=False, basecnt=False, fieldcnt=False, name='after applycal', action='apply', display='', flagbackup=True, savepars=False, cmdreason='', outfile='', overwrite=True, writeflags=True )
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        AgentFlagger::open        Table type is Measurement Set
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        flagdata::::casa        Summary mode is active
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        flagdata::::casa        Initializing the agents
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        AgentFlagger::initAgents        There are initially 1 agents in the list. Agents: summary
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        Summary::setAgentParameters          display is:
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        AgentFlagger::initAgents        There are 1 valid agents in the list. Agents: summary
02-Oct-2024 07:39:54 2024-10-02 07:39:31        INFO        flagdata::::casa        Running the agentflagger tool
02-Oct-2024 07:39:54 2024-10-02 07:39:34        INFO        FlagMSHandler::        Chunk = 1 [progress: 0%], Observation = 0, Array = 0, Scan = 1, Field = 0 (1331+305=3C286), Spw = 0, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 8100
02-Oct-2024 07:39:54 2024-10-02 07:39:36        INFO        FlagMSHandler::        Chunk = 21 [progress: 10%], Observation = 0, Array = 0, Scan = 2, Field = 0 (1331+305=3C286), Spw = 4, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 80700
02-Oct-2024 07:39:54 2024-10-02 07:39:38        INFO        FlagMSHandler::        Chunk = 28 [progress: 20%], Observation = 0, Array = 0, Scan = 2, Field = 0 (1331+305=3C286), Spw = 11, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 80700
02-Oct-2024 07:39:54 2024-10-02 07:39:40        INFO        FlagMSHandler::        Chunk = 36 [progress: 30%], Observation = 0, Array = 0, Scan = 3, Field = 0 (1331+305=3C286), Spw = 3, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 44400
02-Oct-2024 07:39:54 2024-10-02 07:39:42        INFO        FlagMSHandler::        Chunk = 48 [progress: 40%], Observation = 0, Array = 0, Scan = 3, Field = 0 (1331+305=3C286), Spw = 15, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 44400
02-Oct-2024 07:39:54 2024-10-02 07:39:44        INFO        FlagMSHandler::        Chunk = 61 [progress: 50%], Observation = 0, Array = 0, Scan = 4, Field = 1 (J1820-2528), Spw = 12, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 40200
02-Oct-2024 07:39:54 2024-10-02 07:39:46        INFO        FlagMSHandler::        Chunk = 84 [progress: 60%], Observation = 0, Array = 0, Scan = 6, Field = 2 (HD163296), Spw = 3, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 65400
02-Oct-2024 07:39:54 2024-10-02 07:39:48        INFO        FlagMSHandler::        Chunk = 92 [progress: 70%], Observation = 0, Array = 0, Scan = 6, Field = 2 (HD163296), Spw = 11, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 65400
02-Oct-2024 07:39:54 2024-10-02 07:39:50        INFO        FlagMSHandler::        Chunk = 100 [progress: 80%], Observation = 0, Array = 0, Scan = 7, Field = 2 (HD163296), Spw = 3, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 67800
02-Oct-2024 07:39:54 2024-10-02 07:39:52        INFO        FlagMSHandler::        Chunk = 108 [progress: 91%], Observation = 0, Array = 0, Scan = 7, Field = 2 (HD163296), Spw = 11, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 67800
02-Oct-2024 07:39:54 2024-10-02 07:39:54        INFO        FlagMSHandler::        Chunk = 128 [progress: 100%], Observation = 0, Array = 0, Scan = 8, Field = 1 (J1820-2528), Spw = 15, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 11700
02-Oct-2024 07:39:54 2024-10-02 07:39:54        INFO        FlagMSHandler::nextChunk         ====================================================================================
02-Oct-2024 07:39:54 2024-10-02 07:39:54        INFO        Summary::getResult          observation 0 flagged: 6.29265e+08 total: 1.33939e+09 (47%)
02-Oct-2024 07:39:54 2024-10-02 07:39:54        INFO        Summary::getResult          scan 7 flagged: 1.14377e+08 total: 2.77709e+08 (41.2%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          scan 2 flagged: 9.08236e+07 total: 3.30547e+08 (27.5%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          scan 1 flagged: 3.31776e+07 total: 3.31776e+07 (100%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          scan 8 flagged: 2.73149e+07 total: 4.79232e+07 (57%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          scan 5 flagged: 1.53338e+07 total: 3.56352e+07 (43%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          scan 3 flagged: 9.27229e+07 total: 1.81862e+08 (51%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          scan 4 flagged: 1.40501e+08 total: 1.64659e+08 (85.3%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          scan 6 flagged: 1.15014e+08 total: 2.67878e+08 (42.9%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea26 flagged: 6.47505e+07 total: 1.07151e+08 (60.4%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea25 flagged: 5.21805e+07 total: 1.07151e+08 (48.7%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea24 flagged: 4.04119e+07 total: 1.07151e+08 (37.7%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea23 flagged: 4.01001e+07 total: 1.07151e+08 (37.4%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea22 flagged: 8.63511e+07 total: 1.07151e+08 (80.6%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea03 flagged: 4.06793e+07 total: 1.07151e+08 (38%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea06 flagged: 4.11481e+07 total: 1.07151e+08 (38.4%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea12 flagged: 4.03226e+07 total: 1.07151e+08 (37.6%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea01 flagged: 4.02048e+07 total: 1.07151e+08 (37.5%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea15 flagged: 7.99907e+07 total: 1.07151e+08 (74.7%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea28 flagged: 4.21666e+07 total: 1.07151e+08 (39.4%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea16 flagged: 6.69877e+07 total: 1.07151e+08 (62.5%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea07 flagged: 4.07694e+07 total: 1.07151e+08 (38%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea02 flagged: 4.08827e+07 total: 1.07151e+08 (38.2%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea09 flagged: 4.43616e+07 total: 1.07151e+08 (41.4%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea20 flagged: 4.14775e+07 total: 1.07151e+08 (38.7%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea17 flagged: 4.30578e+07 total: 1.07151e+08 (40.2%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea10 flagged: 3.97169e+07 total: 1.07151e+08 (37.1%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea21 flagged: 7.92227e+07 total: 1.07151e+08 (73.9%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea19 flagged: 5.20818e+07 total: 1.07151e+08 (48.6%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea04 flagged: 7.98392e+07 total: 1.07151e+08 (74.5%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea11 flagged: 4.08012e+07 total: 1.07151e+08 (38.1%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea05 flagged: 4.10069e+07 total: 1.07151e+08 (38.3%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea14 flagged: 3.91902e+07 total: 1.07151e+08 (36.6%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          antenna ea18 flagged: 4.08291e+07 total: 1.07151e+08 (38.1%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          field HD163296 flagged: 2.29392e+08 total: 5.45587e+08 (42%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          field 1331+305=3C286 flagged: 2.16724e+08 total: 5.45587e+08 (39.7%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          field J1820-2528 flagged: 1.8315e+08 total: 2.48218e+08 (73.8%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          spw 15 flagged: 4.29131e+07 total: 8.3712e+07 (51.3%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          spw 14 flagged: 3.81468e+07 total: 8.3712e+07 (45.6%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          spw 10 flagged: 3.699e+07 total: 8.3712e+07 (44.2%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          spw 7 flagged: 4.27074e+07 total: 8.3712e+07 (51%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          spw 12 flagged: 4.01946e+07 total: 8.3712e+07 (48%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          spw 6 flagged: 3.84568e+07 total: 8.3712e+07 (45.9%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          spw 8 flagged: 4.29436e+07 total: 8.3712e+07 (51.3%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          spw 5 flagged: 3.70833e+07 total: 8.3712e+07 (44.3%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          spw 0 flagged: 4.39489e+07 total: 8.3712e+07 (52.5%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          spw 11 flagged: 3.97964e+07 total: 8.3712e+07 (47.5%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          spw 9 flagged: 3.70475e+07 total: 8.3712e+07 (44.3%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          spw 4 flagged: 3.70835e+07 total: 8.3712e+07 (44.3%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          spw 1 flagged: 3.80499e+07 total: 8.3712e+07 (45.5%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          spw 2 flagged: 3.77375e+07 total: 8.3712e+07 (45.1%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          spw 13 flagged: 3.90141e+07 total: 8.3712e+07 (46.6%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          spw 3 flagged: 3.71521e+07 total: 8.3712e+07 (44.4%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          correlation LL flagged: 1.57316e+08 total: 3.34848e+08 (47%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          correlation LR flagged: 1.57316e+08 total: 3.34848e+08 (47%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          correlation RR flagged: 1.57316e+08 total: 3.34848e+08 (47%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          correlation RL flagged: 1.57316e+08 total: 3.34848e+08 (47%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          array 0 flagged: 6.29265e+08 total: 1.33939e+09 (47%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        Summary::getResult          Total Flagged: 6.29265e+08 Total Counts: 1.33939e+09 (47%)
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        flagdata::::casa        Flags are not written to the MS. (action='calculate')
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        flagdata::::casa        Task flagdata complete. Start time: 2024-10-02 03:39:31.458388 End time: 2024-10-02 03:39:54.369306
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        flagdata::::casa        ##### End Task: flagdata             #####
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        flagdata::::casa        ##########################################
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        statwt::::casa        ##########################################
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        statwt::::casa        ##### Begin Task: statwt             #####
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        statwt::::casa        statwt( vis='18A-426.sb35644955.eb35676220.58411.96917952546.ms', selectdata=True, field='', spw='', intent='', array='', observation='', scan='', combine='', timebin=1, slidetimebin=False, chanbin='spw', minsamp=8, statalg='classic', fence=-1.0, center='mean', lside=True, zscore=-1.0, maxiter=-1, fitspw='', excludechans=False, wtrange=[], flagbackup=True, preview=False, datacolumn='corrected' )
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        statwt::::casa        Backup original flags before applying new flags
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        AgentFlagger::open        Table type is Measurement Set
02-Oct-2024 07:49:29 2024-10-02 07:39:54        INFO        FlagVersion::saveFlagVersion        Creating new backup flag file called statwt_1
02-Oct-2024 07:49:29 2024-10-02 07:39:58        INFO        StatWtColConfig::_determineFlags        Updating the WEIGHT/WEIGHT_SPECTRUM values. SIGMA/SIGMA_SPECTRUM values will not be recalculated as they are related to the values in the DATA column.
02-Oct-2024 07:49:29 2024-10-02 07:40:00        INFO        StatWtTVI::StatWtTVI        Using CORRECTED_DATA to compute weights
02-Oct-2024 07:49:29 ....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 07:49:29 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeFlagging        Originally, 46.9814% of the data were flagged. StatWtTVI flagged an additional 0.00183934%.
02-Oct-2024 07:49:29 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeFlagging        TOTAL FLAGGED DATA AFTER RUNNING STATWT: 46.9833%
02-Oct-2024 07:49:29 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeFlagging        
02-Oct-2024 07:49:29 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeFlagging        SPECTRAL_WINDOW SAMPLES_WITH_NON-ZERO_VARIANCE SAMPLES_WHERE_REAL_PART_VARIANCE_DIFFERS_BY_>50%_FROM_IMAGINARY_PART
02-Oct-2024 07:49:29 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeFlagging                      0                         817728                                                               441318
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeFlagging                      1                         822508                                                               397007
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeFlagging                      2                         818380                                                               402654
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeFlagging                      3                         822844                                                               427771
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeFlagging                      4                         822484                                                               430697
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeFlagging                      5                         822860                                                               398552
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeFlagging                      6                         822588                                                               409967
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeFlagging                      7                         822844                                                               453539
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeFlagging                      8                         822688                                                               446103
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeFlagging                      9                         823024                                                               447472
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeFlagging                     10                         823024                                                               444591
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeFlagging                     11                         822400                                                               435785
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeFlagging                     12                         822760                                                               447646
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeFlagging                     13                         823024                                                               440775
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeFlagging                     14                         822760                                                               431542
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeFlagging                     15                         822720                                                               418915
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        StatWtTVI::_logUsedChannels        Weights are being computed using SPW 0, channels 0~63;SPW 1, channels 0~63;SPW 2, channels 0~63;SPW 3, channels 0~63;SPW 4, channels 0~63;SPW 5, channels 0~63;SPW 6, channels 0~63;SPW 7, channels 0~63;SPW 8, channels 0~63;SPW 9, channels 0~63;SPW 10, channels 0~63;SPW 11, channels 0~63;SPW 12, channels 0~63;SPW 13, channels 0~63;SPW 14, channels 0~63;SPW 15, channels 0~63
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeStats        The mean of the computed weights is 117.472
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeStats        The variance of the computed weights is 7477.42
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        StatWtTVI::summarizeStats        Weights which had corresponding flags of True prior to running this application were not used to compute these stats.
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        statwt::::casa        Task statwt complete. Start time: 2024-10-02 03:39:54.378538 End time: 2024-10-02 03:49:29.855596
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        statwt::::casa        ##### End Task: statwt               #####
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        statwt::::casa        ##########################################
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        flagdata::::casa        ##########################################
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        flagdata::::casa        ##### Begin Task: flagdata           #####
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        flagdata::::casa        flagdata( vis='18A-426.sb35644955.eb35676220.58411.96917952546.ms', mode='summary', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='', field='', antenna='', uvrange='', timerange='', correlation='', scan='', intent='', array='', observation='', feed='', clipminmax=[], datacolumn='DATA', clipoutside=True, channelavg=False, chanbin=1, timeavg=False, timebin='0s', clipzeros=False, quackinterval=1.0, quackmode='beg', quackincrement=False, tolerance=0.0, addantenna='', lowerlimit=0.0, upperlimit=90.0, ntime='scan', combinescans=False, timecutoff=4.0, freqcutoff=3.0, timefit='line', freqfit='poly', maxnpieces=7, flagdimension='freqtime', usewindowstats='none', halfwin=1, extendflags=True, winsize=3, timedev='', freqdev='', timedevscale=5.0, freqdevscale=5.0, spectralmax=1000000.0, spectralmin=0.0, antint_ref_antenna='', minchanfrac=0.6, verbose=False, extendpols=True, growtime=50.0, growfreq=50.0, growaround=False, flagneartime=False, flagnearfreq=False, minrel=0.0, maxrel=1.0, minabs=0, maxabs=-1, spwchan=False, spwcorr=False, basecnt=False, fieldcnt=False, name='after statwt', action='apply', display='', flagbackup=True, savepars=False, cmdreason='', outfile='', overwrite=True, writeflags=True )
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        AgentFlagger::open        Table type is Measurement Set
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        flagdata::::casa        Summary mode is active
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        flagdata::::casa        Initializing the agents
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        AgentFlagger::initAgents        There are initially 1 agents in the list. Agents: summary
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        Summary::setAgentParameters          display is:
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        AgentFlagger::initAgents        There are 1 valid agents in the list. Agents: summary
02-Oct-2024 07:49:52 2024-10-02 07:49:30        INFO        flagdata::::casa        Running the agentflagger tool
02-Oct-2024 07:49:52 2024-10-02 07:49:32        INFO        FlagMSHandler::        Chunk = 1 [progress: 0%], Observation = 0, Array = 0, Scan = 1, Field = 0 (1331+305=3C286), Spw = 0, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 8100
02-Oct-2024 07:49:52 2024-10-02 07:49:34        INFO        FlagMSHandler::        Chunk = 21 [progress: 10%], Observation = 0, Array = 0, Scan = 2, Field = 0 (1331+305=3C286), Spw = 4, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 80700
02-Oct-2024 07:49:52 2024-10-02 07:49:36        INFO        FlagMSHandler::        Chunk = 28 [progress: 20%], Observation = 0, Array = 0, Scan = 2, Field = 0 (1331+305=3C286), Spw = 11, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 80700
02-Oct-2024 07:49:52 2024-10-02 07:49:38        INFO        FlagMSHandler::        Chunk = 36 [progress: 30%], Observation = 0, Array = 0, Scan = 3, Field = 0 (1331+305=3C286), Spw = 3, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 44400
02-Oct-2024 07:49:52 2024-10-02 07:49:40        INFO        FlagMSHandler::        Chunk = 48 [progress: 40%], Observation = 0, Array = 0, Scan = 3, Field = 0 (1331+305=3C286), Spw = 15, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 44400
02-Oct-2024 07:49:52 2024-10-02 07:49:42        INFO        FlagMSHandler::        Chunk = 61 [progress: 50%], Observation = 0, Array = 0, Scan = 4, Field = 1 (J1820-2528), Spw = 12, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 40200
02-Oct-2024 07:49:52 2024-10-02 07:49:44        INFO        FlagMSHandler::        Chunk = 84 [progress: 60%], Observation = 0, Array = 0, Scan = 6, Field = 2 (HD163296), Spw = 3, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 65400
02-Oct-2024 07:49:52 2024-10-02 07:49:46        INFO        FlagMSHandler::        Chunk = 92 [progress: 70%], Observation = 0, Array = 0, Scan = 6, Field = 2 (HD163296), Spw = 11, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 65400
02-Oct-2024 07:49:52 2024-10-02 07:49:48        INFO        FlagMSHandler::        Chunk = 100 [progress: 80%], Observation = 0, Array = 0, Scan = 7, Field = 2 (HD163296), Spw = 3, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 67800
02-Oct-2024 07:49:52 2024-10-02 07:49:50        INFO        FlagMSHandler::        Chunk = 108 [progress: 91%], Observation = 0, Array = 0, Scan = 7, Field = 2 (HD163296), Spw = 11, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 67800
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        FlagMSHandler::        Chunk = 128 [progress: 100%], Observation = 0, Array = 0, Scan = 8, Field = 1 (J1820-2528), Spw = 15, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 11700
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        FlagMSHandler::nextChunk         ====================================================================================
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          observation 0 flagged: 6.2929e+08 total: 1.33939e+09 (47%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          scan 7 flagged: 1.14382e+08 total: 2.77709e+08 (41.2%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          scan 2 flagged: 9.08353e+07 total: 3.30547e+08 (27.5%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          scan 1 flagged: 3.31776e+07 total: 3.31776e+07 (100%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          scan 8 flagged: 2.73149e+07 total: 4.79232e+07 (57%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          scan 5 flagged: 1.53338e+07 total: 3.56352e+07 (43%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          scan 3 flagged: 9.27234e+07 total: 1.81862e+08 (51%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          scan 4 flagged: 1.40501e+08 total: 1.64659e+08 (85.3%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          scan 6 flagged: 1.15023e+08 total: 2.67878e+08 (42.9%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea26 flagged: 6.4752e+07 total: 1.07151e+08 (60.4%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea25 flagged: 5.21831e+07 total: 1.07151e+08 (48.7%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea24 flagged: 4.04124e+07 total: 1.07151e+08 (37.7%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea23 flagged: 4.01016e+07 total: 1.07151e+08 (37.4%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea22 flagged: 8.63512e+07 total: 1.07151e+08 (80.6%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea03 flagged: 4.06798e+07 total: 1.07151e+08 (38%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea06 flagged: 4.11515e+07 total: 1.07151e+08 (38.4%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea12 flagged: 4.0324e+07 total: 1.07151e+08 (37.6%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea01 flagged: 4.02054e+07 total: 1.07151e+08 (37.5%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea15 flagged: 7.99936e+07 total: 1.07151e+08 (74.7%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea28 flagged: 4.21699e+07 total: 1.07151e+08 (39.4%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea16 flagged: 6.69902e+07 total: 1.07151e+08 (62.5%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea07 flagged: 4.07713e+07 total: 1.07151e+08 (38.1%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea02 flagged: 4.0883e+07 total: 1.07151e+08 (38.2%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea09 flagged: 4.43654e+07 total: 1.07151e+08 (41.4%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea20 flagged: 4.14819e+07 total: 1.07151e+08 (38.7%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea17 flagged: 4.30618e+07 total: 1.07151e+08 (40.2%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea10 flagged: 3.97182e+07 total: 1.07151e+08 (37.1%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea21 flagged: 7.92247e+07 total: 1.07151e+08 (73.9%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea19 flagged: 5.20824e+07 total: 1.07151e+08 (48.6%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea04 flagged: 7.98423e+07 total: 1.07151e+08 (74.5%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea11 flagged: 4.08044e+07 total: 1.07151e+08 (38.1%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea05 flagged: 4.10089e+07 total: 1.07151e+08 (38.3%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea14 flagged: 3.91912e+07 total: 1.07151e+08 (36.6%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          antenna ea18 flagged: 4.08299e+07 total: 1.07151e+08 (38.1%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          field HD163296 flagged: 2.29404e+08 total: 5.45587e+08 (42%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          field 1331+305=3C286 flagged: 2.16736e+08 total: 5.45587e+08 (39.7%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          field J1820-2528 flagged: 1.8315e+08 total: 2.48218e+08 (73.8%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          spw 15 flagged: 4.29133e+07 total: 8.3712e+07 (51.3%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          spw 14 flagged: 3.81469e+07 total: 8.3712e+07 (45.6%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          spw 10 flagged: 3.69901e+07 total: 8.3712e+07 (44.2%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          spw 7 flagged: 4.27076e+07 total: 8.3712e+07 (51%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          spw 12 flagged: 4.01946e+07 total: 8.3712e+07 (48%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          spw 6 flagged: 3.84572e+07 total: 8.3712e+07 (45.9%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          spw 8 flagged: 4.29437e+07 total: 8.3712e+07 (51.3%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          spw 5 flagged: 3.70836e+07 total: 8.3712e+07 (44.3%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          spw 0 flagged: 4.3971e+07 total: 8.3712e+07 (52.5%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          spw 11 flagged: 3.97964e+07 total: 8.3712e+07 (47.5%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          spw 9 flagged: 3.70476e+07 total: 8.3712e+07 (44.3%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          spw 4 flagged: 3.70838e+07 total: 8.3712e+07 (44.3%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          spw 1 flagged: 3.805e+07 total: 8.3712e+07 (45.5%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          spw 2 flagged: 3.77377e+07 total: 8.3712e+07 (45.1%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          spw 13 flagged: 3.90141e+07 total: 8.3712e+07 (46.6%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          spw 3 flagged: 3.71523e+07 total: 8.3712e+07 (44.4%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          correlation LL flagged: 1.57323e+08 total: 3.34848e+08 (47%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          correlation LR flagged: 1.57323e+08 total: 3.34848e+08 (47%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          correlation RR flagged: 1.57323e+08 total: 3.34848e+08 (47%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          correlation RL flagged: 1.57323e+08 total: 3.34848e+08 (47%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          array 0 flagged: 6.2929e+08 total: 1.33939e+09 (47%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        Summary::getResult          Total Flagged: 6.2929e+08 Total Counts: 1.33939e+09 (47%)
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        flagdata::::casa        Flags are not written to the MS. (action='calculate')
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        flagdata::::casa        Task flagdata complete. Start time: 2024-10-02 03:49:29.864377 End time: 2024-10-02 03:49:52.487121
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        flagdata::::casa        ##### End Task: flagdata             #####
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        flagdata::::casa        ##########################################
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        tclean::::casa        ##########################################
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        tclean::::casa        ##### Begin Task: tclean             #####
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        tclean::::casa        tclean( vis='18A-426.sb35644955.eb35676220.58411.96917952546.ms', selectdata=True, field='J1820-2528', spw='0~15', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='J1820-2528', imsize=256, cell='1.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='standard', facets=1, psfphasecenter='', wprojplanes=1, vptable='', mosweight=True, aterm=True, psterm=False, wbawp=True, conjbeams=False, cfcache='', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=0.2, normtype='flatnoise', deconvolver='hogbom', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=False, outlierfile='', weighting='natural', robust=0.5, noise='1.0Jy', npixels=0, uvtaper=[''], niter=5000, gain=0.1, threshold=0.0, nsigma=5.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='none', calcres=True, calcpsf=True, psfcutoff=0.35, parallel=False )
02-Oct-2024 07:49:52 2024-10-02 07:49:52        INFO        tclean::::casa        Verifying Input Parameters
02-Oct-2024 07:49:52 2024-10-02 07:49:53        INFO        SynthesisImagerVi2::selectData         MS : 18A-426.sb35644955.eb35676220.58411.96917952546.ms | Selecting on fields : J1820-2528 | Selecting on spw :0~15 | [Opened in readonly mode]
02-Oct-2024 07:50:52 2024-10-02 07:49:53        INFO        SynthesisImagerVi2::selectData           NRows selected : 969600
02-Oct-2024 07:50:52 2024-10-02 07:49:54        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [J1820-2528] :
02-Oct-2024 07:50:52 2024-10-02 07:49:54        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [J1820-2528] :
02-Oct-2024 07:50:52 2024-10-02 07:49:54        INFO        SynthesisImagerVi2::defineImage         Impars: start
02-Oct-2024 07:50:52 2024-10-02 07:49:54        INFO        SynthesisImagerVi2::defineImage         Shape: [256, 256, 1, 1] Spectral: [6.05933e+09] at [0] with increment [3.6242e+09]
02-Oct-2024 07:50:52 2024-10-02 07:49:54        INFO        SynthesisImagerVi2::defineImage         Set Gridding options for [J1820-2528] with ftmachine: gridft
02-Oct-2024 07:50:52 2024-10-02 07:49:54        INFO        SynthesisImagerVi2::nSubCubeFitInMemory        Required memory: 0.003433 GB. Available mem.: 385.1 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 1.
02-Oct-2024 07:50:52 2024-10-02 07:49:54        INFO        SynthesisImagerVi2::weight()         Set imaging weights : Natural weighting
02-Oct-2024 07:50:52 2024-10-02 07:49:54        INFO        task_tclean::SynthesisDeconvolver::setupDeconvolution         Set Deconvolution Options for [J1820-2528] : hogbom
02-Oct-2024 07:50:52 2024-10-02 07:49:54        INFO        task_tclean::SynthesisImager::makePSF         ----------------------------------------------------------- Make PSF ---------------------------------------------
02-Oct-2024 07:50:52
02-Oct-2024 07:50:52 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 07:50:52 2024-10-02 07:50:04        INFO        task_tclean::SIImageStore::calcSensitivity         [J1820-2528] Theoretical sensitivity (Jy/bm):1.33578e-05
02-Oct-2024 07:50:52 2024-10-02 07:50:04        INFO        task_tclean::SIImageStore::getPSFGaussian         Time to fit Gaussian to PSF 0.008008
02-Oct-2024 07:50:52 2024-10-02 07:50:04        INFO        task_tclean::SIImageStore::printBeamSet         Beam : 21.7233 arcsec, 9.35452 arcsec, 1.24805 deg
02-Oct-2024 07:50:52 2024-10-02 07:50:04        INFO        task_tclean::SynthesisImagerVi2::makePrimaryBeam         vi2 : Evaluating Primary Beam model onto image grid(s)
02-Oct-2024 07:50:52 2024-10-02 07:50:05        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
02-Oct-2024 07:50:52
02-Oct-2024 07:50:52 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 07:50:52 2024-10-02 07:50:14        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 0.01s ( user 0.04s, system 0s)
02-Oct-2024 07:50:52 2024-10-02 07:50:14        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.0827195
02-Oct-2024 07:50:52 2024-10-02 07:50:14        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.764641, over full image : 0.764641
02-Oct-2024 07:50:52 2024-10-02 07:50:14        INFO        SynthesisDeconvolver::setupMask         [J1820-2528] Initializing new mask to 1.0 for the full image
02-Oct-2024 07:50:52 2024-10-02 07:50:14        INFO        SynthesisDeconvolver::setupMask         [J1820-2528] Number of pixels in the clean mask : 65536 out of a total of 65536 pixels. [ 100 % ]
02-Oct-2024 07:50:52 2024-10-02 07:50:14        INFO        SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.0827195
02-Oct-2024 07:50:52 2024-10-02 07:50:14        INFO        SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.764641, over full image : 0.764641
02-Oct-2024 07:50:52 2024-10-02 07:50:14        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 5000, 'cyclethreshold': 0.13228942453861237, 'loopgain': 0.10000000149011612, 'nsigma': 5.0, 'thresholdreached': False}
02-Oct-2024 07:50:52 2024-10-02 07:50:14        INFO        SDAlgorithmBase::deconvolve         [J1820-2528] Run Hogbom minor-cycle | CycleThreshold=0.132289, CycleNiter=5000, Gain=0.1
02-Oct-2024 07:50:52 2024-10-02 07:50:14        INFO        SDAlgorithmBase::deconvolve         Using cyclethreshold for threshold criterion: (cyclethreshold=0.132289, nsigma threshold=0.0827195 )
02-Oct-2024 07:50:52 2024-10-02 07:50:14        INFO        SDAlgorithmBase::deconvolve         [J1820-2528] iters=0->17 [17], model=0->0.637153, peakres=0.764641->0.127682, Reached cyclethreshold.
02-Oct-2024 07:50:52 2024-10-02 07:50:14        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 17 iterations.
02-Oct-2024 07:50:52 2024-10-02 07:50:14        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 2 -------------------------------------
02-Oct-2024 07:50:52
02-Oct-2024 07:50:52 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 07:50:52 2024-10-02 07:50:27        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 0.02s ( user 0.19s, system 0s)
02-Oct-2024 07:50:52 2024-10-02 07:50:27        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.0146016
02-Oct-2024 07:50:52 2024-10-02 07:50:27        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.127682, over full image : 0.127682
02-Oct-2024 07:50:52 2024-10-02 07:50:27        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 4983, 'cyclethreshold': 0.0220900047570467, 'loopgain': 0.10000000149011612, 'nsigma': 5.0, 'thresholdreached': False}
02-Oct-2024 07:50:52 2024-10-02 07:50:27        INFO        SDAlgorithmBase::deconvolve         [J1820-2528] Run Hogbom minor-cycle | CycleThreshold=0.02209, CycleNiter=4983, Gain=0.1
02-Oct-2024 07:50:52 2024-10-02 07:50:27        INFO        SDAlgorithmBase::deconvolve         Using cyclethreshold for threshold criterion: (cyclethreshold=0.02209, nsigma threshold=0.0146016 )
02-Oct-2024 07:50:52 2024-10-02 07:50:27        INFO        SDAlgorithmBase::deconvolve         [J1820-2528] iters=0->17 [17], model=0.637153->0.744203, peakres=0.127682->0.0218395, Reached cyclethreshold.
02-Oct-2024 07:50:52 2024-10-02 07:50:27        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 34 iterations.
02-Oct-2024 07:50:52 2024-10-02 07:50:27        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 3 -------------------------------------
02-Oct-2024 07:50:52
02-Oct-2024 07:50:52 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 07:50:52 2024-10-02 07:50:39        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 0.01s ( user 0.04s, system 0s)
02-Oct-2024 07:50:52 2024-10-02 07:50:39        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.0049035
02-Oct-2024 07:50:52 2024-10-02 07:50:39        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.0218392, over full image : 0.0218392
02-Oct-2024 07:50:52 2024-10-02 07:50:39        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 4966, 'cyclethreshold': 0.0037783775478601456, 'loopgain': 0.10000000149011612, 'nsigma': 5.0, 'thresholdreached': False}
02-Oct-2024 07:50:52 2024-10-02 07:50:39        INFO        SDAlgorithmBase::deconvolve         [J1820-2528] Run Hogbom minor-cycle | CycleThreshold=0.00377838, CycleNiter=4966, Gain=0.1
02-Oct-2024 07:50:52 2024-10-02 07:50:39        INFO        SDAlgorithmBase::deconvolve         Using n-sigma for threshold criterion: (cyclethreshold=0.00377838, nsigma threshold=0.0049035 )
02-Oct-2024 07:50:52 2024-10-02 07:50:39        INFO        SDAlgorithmBase::deconvolve         [J1820-2528] iters=0->30 [30], model=0.744203->0.774175, peakres=0.0218392->0.00482478, Reached n-sigma threshold.
02-Oct-2024 07:50:52 2024-10-02 07:50:39        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 64 iterations.
02-Oct-2024 07:50:52 2024-10-02 07:50:39        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 4 -------------------------------------
02-Oct-2024 07:50:52
02-Oct-2024 07:50:52 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 07:50:52 2024-10-02 07:50:53        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 0.01s ( user 0.04s, system 0s)
02-Oct-2024 07:50:52 2024-10-02 07:50:53        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.00322904
02-Oct-2024 07:50:52 2024-10-02 07:50:53        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00477949, over full image : 0.00477949
02-Oct-2024 07:50:52 2024-10-02 07:50:53        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 4936, 'cyclethreshold': 0.0008268924430012703, 'loopgain': 0.10000000149011612, 'nsigma': 5.0, 'thresholdreached': False}
02-Oct-2024 07:50:52 2024-10-02 07:50:53        INFO        SDAlgorithmBase::deconvolve         [J1820-2528] Run Hogbom minor-cycle | CycleThreshold=0.000826892, CycleNiter=4936, Gain=0.1
02-Oct-2024 07:50:52 2024-10-02 07:50:53        INFO        SDAlgorithmBase::deconvolve         Using n-sigma for threshold criterion: (cyclethreshold=0.000826892, nsigma threshold=0.00322904 )
02-Oct-2024 07:50:52 2024-10-02 07:50:53        INFO        SDAlgorithmBase::deconvolve         [J1820-2528] iters=0->28 [28], model=0.774175->0.783625, peakres=0.00477949->0.00321775, Reached n-sigma threshold.
02-Oct-2024 07:50:52 2024-10-02 07:50:53        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 92 iterations.
02-Oct-2024 07:51:17 2024-10-02 07:50:53        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 5 -------------------------------------
02-Oct-2024 07:51:17
02-Oct-2024 07:51:17 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 07:51:17 2024-10-02 07:51:06        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 0.01s ( user 0.04s, system 0s)
02-Oct-2024 07:51:17 2024-10-02 07:51:06        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.00310274
02-Oct-2024 07:51:17 2024-10-02 07:51:06        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00322652, over full image : 0.00322652
02-Oct-2024 07:51:17 2024-10-02 07:51:06        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 4908, 'cyclethreshold': 0.0005582149024121463, 'loopgain': 0.10000000149011612, 'nsigma': 5.0, 'thresholdreached': False}
02-Oct-2024 07:51:17 2024-10-02 07:51:06        INFO        SDAlgorithmBase::deconvolve         [J1820-2528] Run Hogbom minor-cycle | CycleThreshold=0.000558215, CycleNiter=4908, Gain=0.1
02-Oct-2024 07:51:17 2024-10-02 07:51:06        INFO        SDAlgorithmBase::deconvolve         Using n-sigma for threshold criterion: (cyclethreshold=0.000558215, nsigma threshold=0.00310274 )
02-Oct-2024 07:51:17 2024-10-02 07:51:06        INFO        SDAlgorithmBase::deconvolve         [J1820-2528] iters=0->4 [4], model=0.783625->0.784264, peakres=0.00322652->0.00308691, Reached n-sigma threshold.
02-Oct-2024 07:51:17 2024-10-02 07:51:06        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 96 iterations.
02-Oct-2024 07:51:17 2024-10-02 07:51:06        INFO        task_tclean::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 6 -------------------------------------
02-Oct-2024 07:51:17
02-Oct-2024 07:51:17 0%....10....20....30....40....50....60....70....80....90....100%
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         time for calcRobustRMS:  real 0.02s ( user 0.07s, system 0s)
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle         Current nsigma threshold (maximum along spectral channels ) =0.00308985
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00308691, over full image : 0.00308691
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        tclean::::casa        Reached global stopping criterion : any combination of n-sigma and other valid exit criterion
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        tclean::::casa        getSummary call: fullsummary=False
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        SDAlgorithmBase::restore         [J1820-2528] : Restoring model image.
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        SIImageStore::restore         Beam for chan : 0 : 21.7233 arcsec, 9.35452 arcsec, 1.24805 deg
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        tclean::::casa        Searching for images with prefix 'J1820-2528'... Found these, writing history into them: ['J1820-2528.psf', 'J1820-2528.sumwt', 'J1820-2528.pb', 'J1820-2528.residual', 'J1820-2528.mask', 'J1820-2528.model', 'J1820-2528.image']
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        tclean::::casa        Task tclean complete. Start time: 2024-10-02 03:49:52.497128 End time: 2024-10-02 03:51:17.486858
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        tclean::::casa        ##### End Task: tclean               #####
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        tclean::::casa        ##########################################
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        imstat::::casa        ##########################################
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        imstat::::casa        ##### Begin Task: imstat             #####
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        imstat::::casa        imstat( imagename='J1820-2528.image', axes=[], region='', box='', 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 07:51:17 2024-10-02 07:51:17        INFO        imstat::CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        imstat::CasacRegionManager::fromBCS        Using all spectral channels.
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        imstat::CasacRegionManager::fromBCS        Using polarizations ALL
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        imstat::image::statistics         Determining stats for image J1820-2528.image
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        imstat::ImageRegion::fromRecord        Selected bounding box :
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        imstat::ImageRegion::fromRecord+            [0, 0, 0, 0] to [255, 255, 0, 0]  (18:21:07.303, -25.30.20.566, I, 6059326202.54Hz to 18:20:48.473, -25.26.05.566, I, 6059326202.54Hz)
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        imstat::ImageStatsCalculator::_logStartup        Statistics calculated using Classic algorithm
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        imstat::ImageStatsCalculator::_logStartup        Regions ---
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        imstat::ImageStatsCalculator::_logStartup                 -- bottom-left corner (pixel) [blc]:  [0, 0, 0, 0]
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        imstat::ImageStatsCalculator::_logStartup                 -- top-right corner (pixel) [trc]:    [255, 255, 0, 0]
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        imstat::ImageStatsCalculator::_logStartup                 -- bottom-left corner (world) [blcf]: 18:21:07.303, -25.30.20.566, I, 6059326202.54Hz
02-Oct-2024 07:51:17 2024-10-02 07:51:17        INFO        imstat::ImageStatsCalculator::_logStartup                 -- top-right corner (world) [trcf]:   18:20:48.473, -25.26.05.566, I, 6059326202.54Hz
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::        Values ---
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::                 -- flux density [flux]:                    0.773608 Jy
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::                 -- number of points [npts]:                65536
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::                 -- maximum value [max]:                    0.76458 Jy/beam
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::                 -- minimum value [min]:                    -0.00337421 Jy/beam
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::                 -- position of max value (pixel) [maxpos]: [128, 128, 0, 0]
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::                 -- position of min value (pixel) [minpos]: [136, 92, 0, 0]
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::                 -- position of max value (world) [maxposf]: 18:20:57.849, -25.28.12.585, I, 6059326202.54Hz
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::                 -- position of min value (world) [minposf]: 18:20:57.258, -25.28.48.584, I, 6059326202.54Hz
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::                 -- Sum of pixel values [sum]:               178.129 Jy/beam
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::                 -- Sum of squared pixel values [sumsq]:     68.7639 Jy/beam.Jy/beam
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::        Statistics ---
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::                -- Mean of the pixel values [mean]:         0.00271803 Jy/beam
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::                -- Variance of the pixel values :           0.00104188 Jy/beam
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::                -- Standard deviation of the Mean [sigma]:  0.0322782 Jy/beam
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::                -- Root mean square [rms]:                  0.0323922 Jy/beam
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::                -- Median of the pixel values [median]:     -6.92487e-05 Jy/beam
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::                -- Median of the deviations [medabsdevmed]: 0.000426156 Jy/beam
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::                -- IQR [quartile]:                          0.000856674 Jy/beam
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::                -- First quartile [q1]:                     -0.000476596 Jy/beam
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::                -- Third quartile [q3]:                     0.000380078 Jy/beam
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::ImageStatsCalculator::statistics        Sum column unit = Jy/beam
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::ImageStatsCalculator::statistics+        Mean column unit = Jy/beam
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::ImageStatsCalculator::statistics+        Std_dev column unit = Jy/beam
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::ImageStatsCalculator::statistics+        Minimum column unit = Jy/beam
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::ImageStatsCalculator::statistics+        Maximum column unit = Jy/beam
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::ImageStatsCalculator::statistics        Npts          Sum           Mean          Rms           Std_dev       Minimum       Maximum     
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::ImageStatsCalculator::statistics         6.553600e+04  1.781286e+02  2.718026e-03  3.239219e-02  3.227820e-02 -3.374213e-03  7.645795e-01
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::casa        Task imstat complete. Start time: 2024-10-02 03:51:17.489144 End time: 2024-10-02 03:51:17.505707
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::casa        ##### End Task: imstat               #####
02-Oct-2024 07:51:17 2024-10-02 07:51:18        INFO        imstat::::casa        ##########################################
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        imhead::::casa        ##########################################
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        imhead::::casa        ##### Begin Task: imhead             #####
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        imhead::::casa        imhead( imagename='J1820-2528.image', mode='summary', hdkey='', hdvalue='', verbose=False )
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary        
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        Image name       : J1820-2528.image
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        Object name      : J1820-2528
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        Image type       : PagedImage
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        Image quantity   : Intensity
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        Pixel mask(s)    : mask0
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        Region(s)        : None
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        Image units      : Jy/beam
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        Restoring Beam   : 21.7233 arcsec, 9.35452 arcsec, 1.24805 deg
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary        
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        Direction reference : J2000
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        Spectral  reference : LSRK
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        Velocity  type      : RADIO
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        Rest frequency      : 6.05933e+09 Hz
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        Pointing center     :  18:20:57.848685  -25.28.12.584558
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        Telescope           : EVLA
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        Observer            : Mr. Evan Rich
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        Date observation    : 2018/10/20/23:30:32.999999
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        Telescope position: [-1.60116e+06m, -5.04199e+06m, 3.55488e+06m] (ITRF)
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        Axis Coord Type      Name             Proj Shape Tile   Coord value at pixel         Coord incr Units
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        -----------------------------------------------------------------------------------------------------
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        0    0     Direction Right Ascension   SIN   256  256  18:20:57.849   128.00      -1.000000e+00 arcsec
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        1    0     Direction Declination       SIN   256  256 -25.28.12.585   128.00       1.000000e+00 arcsec
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        2    1     Stokes    Stokes                    1    1             I
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+        3    2     Spectral  Frequency                 1    1 6059326202.54     0.00 3.624195659044e+09 Hz
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        ImageMetaData::summary+                             Velocity                                     0     0.00      -1.793114e+05 km/s
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        imhead::::casa        Task imhead complete. Start time: 2024-10-02 03:51:17.508390 End time: 2024-10-02 03:51:17.512467
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        imhead::::casa        ##### End Task: imhead               #####
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        imhead::::casa        ##########################################
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        imhead::::casa        [ check_val ] total_visibilities is 1339392000.0 ( Pass : should be 1339392000.0, Exact: True )
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        imhead::::casa+        [ check_val ] flags_importasdm is 0.0 ( Pass : should be 0.0, Exact: True )
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        imhead::::casa+        [ check_val ] flags_restored is 629265468.0 ( Pass : should be 629265468.0, Exact: True )
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        imhead::::casa+        [ check_val ] flags_applycal is 629265468.0 ( Pass : should be 629265468.0, Exact: True )
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        imhead::::casa+        [ check_val ] statwt_mean is 117.47248275300477 ( Pass : should be 117.4724849592063, Epsilon: 0.01)
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        imhead::::casa+        [ check_val ] statwt_variance is 7477.418834342811 ( Pass : should be 7477.419096555837, Epsilon: 0.01)
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        imhead::::casa+        [ check_val ] flags_statwt is 629290104.0 ( Pass : should be 629290104.0, Epsilon: 0.05)
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        imhead::::casa+        [ check_val ] flux_max is [0.76457953] ( Pass : should be 0.7645, Epsilon: 0.01)
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        imhead::::casa+        [ check_val ] beam_major is 21.723346710205078 ( Pass : should be 21.723, Epsilon: 0.01)
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        imhead::::casa+        [ check_val ] beam_minor is 9.35451602935791 ( Pass : should be 9.354, Epsilon: 0.01)
02-Oct-2024 07:51:20 2024-10-02 07:51:18        INFO        imhead::::casa+        [ check_val ] positionangle is 1.248046875 ( Pass : should be 1.248, Epsilon: 0.01)
02-Oct-2024 07:51:20
02-Oct-2024 07:51:20 Using user configuration file /users/casaci/.casa/config.py
02-Oct-2024 07:51:20
02-Oct-2024 07:51:20 Using matplotlib backend: TkAgg
02-Oct-2024 07:51:20 Using location of IERSeop2000 table found in datapath for measurespath /export/cvpost134-4tb/casa/casa-data/casa-data
02-Oct-2024 07:51:20 CASA 6.7.0.6 -- Common Astronomy Software Applications [6.7.0.6]
02-Oct-2024 07:51:20 .
02-Oct-2024 07:51:20 ----------------------------------------------------------------------
02-Oct-2024 07:51:20 Ran 3 tests in 2375.178s
02-Oct-2024 07:51:20
02-Oct-2024 07:51:20 OK
02-Oct-2024 07:51:20 Executor result: 0
02-Oct-2024 07:51:20 Failed tests:[]
02-Oct-2024 07:51:20
02-Oct-2024 07:51:20 Results: [{'testname': 'test_stk_srdp_restore_mode', 'runtime': '0:39:37.464679', 'returncode': 0, 'testerr': []}]
02-Oct-2024 07:51:20 Stopping Xvfb.
02-Oct-2024 07:51:20 Stopping framebuffer <subprocess.Popen object at 0x7f2b852dfb70>
02-Oct-2024 07:51:20 Virtual frame buffer deployed at :2399479 with pid 2399541 successfully shutdown
02-Oct-2024 07:51:20 Xvfb stopped.
02-Oct-2024 07:51:20 Finished task 'Script' with result: Success
02-Oct-2024 07:51:20 Starting task 'Parse test results' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
02-Oct-2024 07:51:20 Parsing test results under /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASA-CMTS-SRME...
02-Oct-2024 07:51:20 Finished task 'Parse test results' with result: Success
02-Oct-2024 07:51:20 Skipping execution of task 'Cleanup' as it is disabled
02-Oct-2024 07:51:20 Running post build plugin 'Docker Container Cleanup'
02-Oct-2024 07:51:20 Running post build plugin 'NCover Results Collector'
02-Oct-2024 07:51:20 Running post build plugin 'Build Results Label Collector'
02-Oct-2024 07:51:20 Running post build plugin 'Clover Results Collector'
02-Oct-2024 07:51:20 Running post build plugin 'npm Cache Cleanup'
02-Oct-2024 07:51:20 Running post build plugin 'Artifact Copier'
02-Oct-2024 07:51:20 Publishing an artifact: SRDP Restore Mode Stakeholder
02-Oct-2024 07:51:20 Finished publishing of artifact Non required job artifact Http Compression On : [SRDP Restore Mode Stakeholder], patterns: [html/**] anchored at: [work/test_stk_srdp_restore_mode] in 59.02 ms
02-Oct-2024 07:51:20 Finalising the build...
02-Oct-2024 07:51:20 Stopping timer.
02-Oct-2024 07:51:20 Build CASA-CMTS-SRME-65 completed.
02-Oct-2024 03:51:20 Running on server: post build plugin 'Build Hanging Detection Configuration'
02-Oct-2024 03:51:20 Running on server: post build plugin 'NCover Results Collector'
02-Oct-2024 03:51:20 Running on server: post build plugin 'Build Labeller'
02-Oct-2024 03:51:20 Running on server: post build plugin 'Clover Delta Calculator'
02-Oct-2024 03:51:20 Running on server: post build plugin 'Maven Dependencies Postprocessor'
02-Oct-2024 03:51:20 All post build plugins have finished
02-Oct-2024 03:51:20 Generating build results summary...
02-Oct-2024 03:51:20 Saving build results to disk...
02-Oct-2024 03:51:20 Store variable context...
02-Oct-2024 03:51:20 Finished building CASA-CMTS-SRME-65.