Build: #72 was successful

Job: Test VLA Stakeholder Tests MPI Rocky 8.10 Docker was successful

Build log

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

15-Oct-2025 08:30:56 2025-10-15 08:30:50        INFO        applycal::::casa        applycal( vis='3c391_ctm_mosaic_10s_spw0.ms', field='J1822-0938', spw='', intent='', selectdata=True, timerange='', uvrange='', antenna='', scan='', observation='', msselect='', docallib=False, callib='', gaintable=['3c391_ctm_mosaic_10s_spw0.antpos', '3c391_ctm_mosaic_10s_spw0.fluxscale1', '3c391_ctm_mosaic_10s_spw0.K0', '3c391_ctm_mosaic_10s_spw0.B0'], gainfield=['', 'J1822-0938', '', ''], interp=['', 'nearest', '', ''], spwmap=[], calwt=[False], parang=False, applymode='', flagbackup=True )
15-Oct-2025 08:30:56 2025-10-15 08:30:50        INFO        applycal::AgentFlagger::open        Table type is Measurement Set
15-Oct-2025 08:30:56 2025-10-15 08:30:50        INFO        FlagVersion::saveFlagVersion        Creating new backup flag file called applycal_2
15-Oct-2025 08:30:56 2025-10-15 08:30:52        INFO        applycal::::casa        Task applycal complete. Start time: 2025-10-15 08:30:50.429972 End time: 2025-10-15 08:30:51.969714
15-Oct-2025 08:30:56 2025-10-15 08:30:52        INFO        applycal::::casa        ##### End Task: applycal             #####
15-Oct-2025 08:30:56 2025-10-15 08:30:52        INFO        applycal::::casa        ##########################################
15-Oct-2025 08:30:56 2025-10-15 08:30:52        INFO        applycal::::casa        ##########################################
15-Oct-2025 08:30:56 2025-10-15 08:30:52        INFO        applycal::::casa        ##### Begin Task: applycal           #####
15-Oct-2025 08:30:56 2025-10-15 08:30:52        INFO        applycal::::casa        applycal( vis='3c391_ctm_mosaic_10s_spw0.ms', field='2~8', spw='', intent='', selectdata=True, timerange='', uvrange='', antenna='', scan='', observation='', msselect='', docallib=False, callib='', gaintable=['3c391_ctm_mosaic_10s_spw0.antpos', '3c391_ctm_mosaic_10s_spw0.fluxscale1', '3c391_ctm_mosaic_10s_spw0.K0', '3c391_ctm_mosaic_10s_spw0.B0'], gainfield=['', 'J1822-0938', '', ''], interp=['', 'linear', '', ''], spwmap=[], calwt=[False], parang=False, applymode='', flagbackup=True )
15-Oct-2025 08:30:56 2025-10-15 08:30:52        INFO        applycal::AgentFlagger::open        Table type is Measurement Set
15-Oct-2025 08:30:56 2025-10-15 08:30:52        INFO        FlagVersion::saveFlagVersion        Creating new backup flag file called applycal_3
15-Oct-2025 08:30:56 2025-10-15 08:30:56        INFO        applycal::::casa        Task applycal complete. Start time: 2025-10-15 08:30:51.970864 End time: 2025-10-15 08:30:56.348285
15-Oct-2025 08:30:56 2025-10-15 08:30:56        INFO        applycal::::casa        ##### End Task: applycal             #####
15-Oct-2025 08:30:56 2025-10-15 08:30:56        INFO        applycal::::casa        ##########################################
15-Oct-2025 08:31:30 2025-10-15 08:30:56        INFO        split::::casa        ##########################################
15-Oct-2025 08:31:30 2025-10-15 08:30:56        INFO        split::::casa        ##### Begin Task: split              #####
15-Oct-2025 08:31:30 2025-10-15 08:30:56        INFO        split::::casa        split( vis='3c391_ctm_mosaic_10s_spw0.ms', outputvis='3c391_ctm_mosaic_spw0.ms', keepmms=True, field='2~8', spw='', scan='', antenna='', correlation='RR,LL', timerange='', intent='', array='', uvrange='', observation='', feed='', datacolumn='corrected', keepflags=True, width=1, timebin='0s', combine='' )
15-Oct-2025 08:31:30 2025-10-15 08:30:56        INFO        ParallelDataHelper::::casa        Analyzing MS for partitioning
15-Oct-2025 08:31:30 2025-10-15 08:30:56        INFO        ParallelDataHelper::::casa        Input vis is a Multi-MS
15-Oct-2025 08:31:30 2025-10-15 08:31:03        INFO        ParallelDataHelper::::casa        Finalizing MMS structure
15-Oct-2025 08:31:30 2025-10-15 08:31:03        INFO        ms::createmultims        Copying subtables from /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_mosaic_spw0.ms.data/3c391_ctm_mosaic_spw0.ms.0000.ms to the other MMS members.
15-Oct-2025 08:31:30 2025-10-15 08:31:04        INFO        split::::casa        Task split complete. Start time: 2025-10-15 08:30:56.351100 End time: 2025-10-15 08:31:03.895236
15-Oct-2025 08:31:30 2025-10-15 08:31:04        INFO        split::::casa        ##### End Task: split                #####
15-Oct-2025 08:31:30 2025-10-15 08:31:04        INFO        split::::casa        ##########################################
15-Oct-2025 08:31:30 2025-10-15 08:31:04        INFO        statwt::::casa        ##########################################
15-Oct-2025 08:31:30 2025-10-15 08:31:04        INFO        statwt::::casa        ##### Begin Task: statwt             #####
15-Oct-2025 08:31:30 2025-10-15 08:31:04        INFO        statwt::::casa        statwt( vis='3c391_ctm_mosaic_spw0.ms', selectdata=True, field='', spw='', intent='', array='', observation='', scan='', combine='', timebin=1, slidetimebin=False, chanbin='spw', minsamp=2, statalg='classic', fence=-1.0, center='mean', lside=True, zscore=-1.0, maxiter=-1, fitspw='', excludechans=False, wtrange=[], flagbackup=True, preview=False, datacolumn='data' )
15-Oct-2025 08:31:30 2025-10-15 08:31:04        INFO        statwt::::casa        Backup original flags before applying new flags
15-Oct-2025 08:31:30 2025-10-15 08:31:04        INFO        AgentFlagger::open        Table type is Measurement Set
15-Oct-2025 08:31:30 2025-10-15 08:31:04        INFO        FlagVersion::saveFlagVersion        Creating new backup flag file called statwt_1
15-Oct-2025 08:31:30 2025-10-15 08:31:04        INFO        StatWtColConfig::_determineFlags        CORRECTED_DATA is not present. Updating the SIGMA/SIGMA_SPECTRUM and WEIGHT/WEIGHT_SPECTRUM values based on calculations using the DATA column.
15-Oct-2025 08:31:30 2025-10-15 08:31:05        INFO        StatWtTVI::StatWtTVI        Using DATA to compute weights
15-Oct-2025 08:31:30 ....10....20....30....40....50....60....70....80....90....100%
15-Oct-2025 08:31:30 2025-10-15 08:31:28        INFO        StatWtTVI::summarizeFlagging        Originally, 35.0215% of the data were flagged. StatWtTVI flagged an additional 0%.
15-Oct-2025 08:31:30 2025-10-15 08:31:28        INFO        StatWtTVI::summarizeFlagging        TOTAL FLAGGED DATA AFTER RUNNING STATWT: 35.0215%
15-Oct-2025 08:31:30 2025-10-15 08:31:28        INFO        StatWtTVI::summarizeFlagging        
15-Oct-2025 08:31:30 2025-10-15 08:31:28        INFO        StatWtTVI::summarizeFlagging        SPECTRAL_WINDOW SAMPLES_WITH_NON-ZERO_VARIANCE SAMPLES_WHERE_REAL_PART_VARIANCE_DIFFERS_BY_>50%_FROM_IMAGINARY_PART
15-Oct-2025 08:31:30 2025-10-15 08:31:28        INFO        StatWtTVI::summarizeFlagging                      0                         997366                                                               260704
15-Oct-2025 08:31:30 2025-10-15 08:31:28        INFO        StatWtTVI::_logUsedChannels        Weights are being computed using SPW 0, channels 0~63
15-Oct-2025 08:31:30 2025-10-15 08:31:28        INFO        StatWtTVI::summarizeStats        The mean of the computed weights is 321.368
15-Oct-2025 08:31:30 2025-10-15 08:31:28        INFO        StatWtTVI::summarizeStats        The variance of the computed weights is 348637
15-Oct-2025 08:31:30 2025-10-15 08:31:28        INFO        StatWtTVI::summarizeStats        Weights which had corresponding flags of True prior to running this application were not used to compute these stats.
15-Oct-2025 08:31:30 2025-10-15 08:31:28        INFO        statwt::::casa        Task statwt complete. Start time: 2025-10-15 08:31:03.924886 End time: 2025-10-15 08:31:28.067246
15-Oct-2025 08:31:30 2025-10-15 08:31:28        INFO        statwt::::casa        ##### End Task: statwt               #####
15-Oct-2025 08:31:30 2025-10-15 08:31:28        INFO        statwt::::casa        ##########################################
15-Oct-2025 08:31:30 2025-10-15 08:31:28        INFO        tclean::::casa        ##########################################
15-Oct-2025 08:31:30 2025-10-15 08:31:28        INFO        tclean::::casa        ##### Begin Task: tclean             #####
15-Oct-2025 08:31:30 2025-10-15 08:31:28        INFO        tclean::::casa        tclean( vis='3c391_ctm_mosaic_spw0.ms', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='3c391_ctm_spw0_multiscale', imsize=[480, 480], cell=['2.5arcsec', '2.5arcsec'], phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='mosaic', 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='multiscale', scales=[0, 5, 15, 45], nterms=2, smallscalebias=0.9, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=False, outlierfile='', weighting='briggs', robust=0.5, noise='1.0Jy', npixels=0, uvtaper=[''], niter=20000, gain=0.1, threshold='1.0mJy', nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='3c391_clean_mask.crtf', 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=True )
15-Oct-2025 08:31:30 2025-10-15 08:31:28        INFO        tclean::::casa        Verifying Input Parameters
15-Oct-2025 08:31:30 2025-10-15 08:31:31        INFO        tclean::::casa        setupCluster, Setting up 7 engines.
15-Oct-2025 08:31:30 2025-10-15 08:31:31        INFO        SynthesisUtilMethods::continuumDataPartition         
15-Oct-2025 08:31:30 2025-10-15 08:31:31        INFO        SynthesisUtilMethods::continuumDataPartition +        Rows = 657829 767459 [P][M]: 0:6 ROWNUMBER() >= 657829 && ROWNUMBER() <= 767459
15-Oct-2025 08:32:19 2025-10-15 08:31:31        INFO        tclean::::casa        Partitioned Selection : {'0': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': '3c391_ctm_mosaic_spw0.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 1 && ROWNUMBER() <= 109638', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '1': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': '3c391_ctm_mosaic_spw0.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 109639 && ROWNUMBER() <= 219276', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '2': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': '3c391_ctm_mosaic_spw0.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 219277 && ROWNUMBER() <= 328914', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '3': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': '3c391_ctm_mosaic_spw0.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 328915 && ROWNUMBER() <= 438552', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '4': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': '3c391_ctm_mosaic_spw0.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 438553 && ROWNUMBER() <= 548190', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '5': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': '3c391_ctm_mosaic_spw0.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 548191 && ROWNUMBER() <= 657828', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '6': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': '3c391_ctm_mosaic_spw0.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 657829 && ROWNUMBER() <= 767459', 'timestr': '', 'usescratch': False, 'uvdist': ''}}}
15-Oct-2025 08:32:19 2025-10-15 08:31:31        INFO        SynthesisImagerVi2::selectData         MS : 3c391_ctm_mosaic_spw0.ms | [Opened in readonly mode]
15-Oct-2025 08:32:19 2025-10-15 08:31:31        INFO        SynthesisImagerVi2::selectData           NRows selected : 767459
15-Oct-2025 08:32:19 2025-10-15 08:31:32        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [3c391_ctm_spw0_multiscale] :
15-Oct-2025 08:32:19 2025-10-15 08:31:32        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [3c391_ctm_spw0_multiscale] :
15-Oct-2025 08:32:19 2025-10-15 08:31:32        INFO        SynthesisImagerVi2::defineImage         Impars: start
15-Oct-2025 08:32:19 2025-10-15 08:31:32        INFO        SynthesisImagerVi2::defineImage         Shape: [480, 480, 1, 1] Spectral: [4.59835e+09] at [0] with increment [1.27992e+08]
15-Oct-2025 08:32:19 2025-10-15 08:31:32        INFO        SynthesisImagerVi2::defineImage         Set Gridding options for [3c391_ctm_spw0_multiscale] with ftmachine : mosaicft
15-Oct-2025 08:32:19 2025-10-15 08:31:32        INFO        SynthesisImager::getVPRecord         Using default Voltage Patterns from the VPManager
15-Oct-2025 08:32:19 2025-10-15 08:31:32        INFO        VPSkyJones::VPSkyJones        PB used EVLA
15-Oct-2025 08:32:19 2025-10-15 08:31:32        INFO        SynthesisImagerVi2::nSubCubeFitInMemory        Required memory: 0.2175 GB. Available mem.: 386.5 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 8.
15-Oct-2025 08:32:19 2025-10-15 08:31:32        INFO        SynthesisImagerVi2::weight()         Set imaging weights : Briggs weighting: sidelobes will be suppressed over full image
15-Oct-2025 08:32:19 2025-10-15 08:31:40        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
15-Oct-2025 08:32:19 2025-10-15 08:31:40        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
15-Oct-2025 08:32:19 2025-10-15 08:31:40        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
15-Oct-2025 08:32:19 2025-10-15 08:31:40        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
15-Oct-2025 08:32:19 2025-10-15 08:31:40        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
15-Oct-2025 08:32:19 2025-10-15 08:31:40        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
15-Oct-2025 08:32:19 2025-10-15 08:31:40        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
15-Oct-2025 08:32:19 2025-10-15 08:31:40        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
15-Oct-2025 08:32:19 2025-10-15 08:31:41        INFO        tclean::::casa        ...done
15-Oct-2025 08:32:19 2025-10-15 08:31:41        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
15-Oct-2025 08:32:19 2025-10-15 08:31:42        INFO        tclean::::casa        ...done
15-Oct-2025 08:32:19 2025-10-15 08:31:45        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
15-Oct-2025 08:32:19 2025-10-15 08:31:46        INFO        tclean::::casa        ...done
15-Oct-2025 08:32:19 2025-10-15 08:31:52        INFO        SynthesisImagerVi2::selectData         MS : 3c391_ctm_mosaic_spw0.ms | [Opened in readonly mode]
15-Oct-2025 08:32:19 2025-10-15 08:31:52        INFO        SynthesisImagerVi2::selectData           NRows selected : 767459
15-Oct-2025 08:32:19 2025-10-15 08:31:53        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [3c391_ctm_spw0_multiscale] :
15-Oct-2025 08:32:19 2025-10-15 08:31:53        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [3c391_ctm_spw0_multiscale] :
15-Oct-2025 08:32:19 2025-10-15 08:31:54        INFO        SynthesisImagerVi2::defineImage         Impars: start
15-Oct-2025 08:32:19 2025-10-15 08:31:54        INFO        SynthesisImagerVi2::defineImage         Shape: [480, 480, 1, 1] Spectral: [4.59835e+09] at [0] with increment [1.27992e+08]
15-Oct-2025 08:32:19 2025-10-15 08:31:54        INFO        SynthesisImagerVi2::defineImage         Set Gridding options for [3c391_ctm_spw0_multiscale] with ftmachine : mosaicft
15-Oct-2025 08:32:19 2025-10-15 08:31:54        INFO        SynthesisImager::getVPRecord         Using default Voltage Patterns from the VPManager
15-Oct-2025 08:32:19 2025-10-15 08:31:54        INFO        VPSkyJones::VPSkyJones        PB used EVLA
15-Oct-2025 08:32:19 2025-10-15 08:31:54        INFO        SynthesisImagerVi2::nSubCubeFitInMemory        Required memory: 0.2175 GB. Available mem.: 386.5 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 8.
15-Oct-2025 08:32:19 2025-10-15 08:31:54        INFO        SynthesisImagerVi2::weight()         Set imaging weights : Briggs weighting: sidelobes will be suppressed over full image
15-Oct-2025 08:32:19 2025-10-15 08:32:02        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
15-Oct-2025 08:32:19 2025-10-15 08:32:02        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
15-Oct-2025 08:32:19 2025-10-15 08:32:02        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
15-Oct-2025 08:32:19 2025-10-15 08:32:02        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
15-Oct-2025 08:32:19 2025-10-15 08:32:02        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
15-Oct-2025 08:32:19 2025-10-15 08:32:02        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
15-Oct-2025 08:32:19 2025-10-15 08:32:02        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
15-Oct-2025 08:32:19 2025-10-15 08:32:02        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
15-Oct-2025 08:32:19 2025-10-15 08:32:03        INFO        tclean::::casa        ...done
15-Oct-2025 08:32:19 2025-10-15 08:32:03        INFO        task_tclean::SynthesisDeconvolver::setupDeconvolution         Set Deconvolution Options for [3c391_ctm_spw0_multiscale] : multiscale
15-Oct-2025 08:32:19 2025-10-15 08:32:03        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
15-Oct-2025 08:32:19 2025-10-15 08:32:04        INFO        tclean::::casa        ...done
15-Oct-2025 08:32:19 2025-10-15 08:32:04        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
15-Oct-2025 08:32:19
15-Oct-2025 08:32:19 0%....10....20....30....40....50..
15-Oct-2025 08:32:19 0%....10....20....30....40..
15-Oct-2025 08:32:19 0%....10....20....30....40....50.
15-Oct-2025 08:32:19 0%....10....20....30....40.
15-Oct-2025 08:32:19 0%....10....20....30....40....50..
15-Oct-2025 08:32:19 0%....10....20....30....40.
15-Oct-2025 08:32:19 0%....10....20....30....40....50.................50.606060.6050.......50................60..70.707070...60............60.........70.80..808080........70......70.......80.......9090.9090.............100%
15-Oct-2025 08:32:19 80...100%
15-Oct-2025 08:32:19 ...100%
15-Oct-2025 08:32:19 80...100%
15-Oct-2025 08:32:19 90........100%
15-Oct-2025 08:32:19 ....9090......100%
15-Oct-2025 08:32:19 ..100%
15-Oct-2025 08:32:19 2025-10-15 08:32:18        INFO        tclean::::casa        ...done
15-Oct-2025 08:32:19 2025-10-15 08:32:18        INFO        SynthesisNormalizer::gatherImages         Gather psf,weight images : [/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7] onto :3c391_ctm_spw0_multiscale
15-Oct-2025 08:32:19 2025-10-15 08:32:18        INFO        SIImageStore::calcSensitivity         [3c391_ctm_spw0_multiscale] Theoretical sensitivity (Jy/bm):1.06835e-05
15-Oct-2025 08:32:19 2025-10-15 08:32:18        INFO        SIImageStore::getPSFGaussian         Time to fit Gaussian to PSF 0.005972
15-Oct-2025 08:32:19 2025-10-15 08:32:18        INFO        SIImageStore::printBeamSet         Beam : 17.0639 arcsec, 14.9556 arcsec, 21.6316 deg
15-Oct-2025 08:32:19 2025-10-15 08:32:18        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
15-Oct-2025 08:32:19 2025-10-15 08:32:19        INFO        tclean::::casa        ...done
15-Oct-2025 08:32:19 2025-10-15 08:32:19        INFO        SynthesisNormalizer::scatterModel         Send the model from : 3c391_ctm_spw0_multiscale to all nodes :[/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7]
15-Oct-2025 08:32:19 2025-10-15 08:32:20        INFO        SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1.model
15-Oct-2025 08:32:19 2025-10-15 08:32:20        INFO        SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2.model
15-Oct-2025 08:32:36 2025-10-15 08:32:20        INFO        SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3.model
15-Oct-2025 08:32:36 2025-10-15 08:32:20        INFO        SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4.model
15-Oct-2025 08:32:36 2025-10-15 08:32:20        INFO        SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5.model
15-Oct-2025 08:32:36 2025-10-15 08:32:20        INFO        SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6.model
15-Oct-2025 08:32:36 2025-10-15 08:32:20        INFO        SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7.model
15-Oct-2025 08:32:36 2025-10-15 08:32:20        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
15-Oct-2025 08:32:36 2025-10-15 08:32:20        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
15-Oct-2025 08:32:36
15-Oct-2025 08:32:36 0%....10....20....30....40....50...
15-Oct-2025 08:32:36 0%....10....20....30....40....50....60.
15-Oct-2025 08:32:36 0%....10....20....30....40....50....60....70...
15-Oct-2025 08:32:36 0%....10....20....30....40....50....60.
15-Oct-2025 08:32:36 0%....10....20....30....40....50....60....70...
15-Oct-2025 08:32:36 0%....10....20....30....40....50....60....70....
15-Oct-2025 08:32:36 0%....10....20....30....40....50....60....70.........8080.8080..60.......70......70............90909070..90....80...100%
15-Oct-2025 08:32:36 ...100%
15-Oct-2025 08:32:36 ......100%
15-Oct-2025 08:32:36 .....100%
15-Oct-2025 08:32:36 ...80...8090.......100%
15-Oct-2025 08:32:36 ..90....90..100%
15-Oct-2025 08:32:36 ....100%
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        tclean::::casa        ...done
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7] onto :3c391_ctm_spw0_multiscale
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0, over full image : 0.123932
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        SynthesisDeconvolver::setupMask         [3c391_ctm_spw0_multiscale] Setting up a mask from [3c391_clean_mask.crtf]
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO                You've specified explicitly that the spectral axis should be regridded. However, the input image has a degenerate spectral axis and so it cannot be regridded. Instead, the resulting single output channel will be replicated 1 times in the output image.
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        RegionTextParser::_determineVersion        RegionTextParser::_determineVersion: Found spec version 0
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        AsciiRegionFileParser::_parse        Combined 1 image regions (which excludes any annotation regions)
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        AsciiRegionFileParser::_parse        The specified region will select all pixels that are included in the region. Full pixels will be included even when they are only partially covered by the region(s).
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        SynthesisDeconvolver::setupMask         ----------------------------------------------------------------------------------------------------------------------------------------
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        SynthesisDeconvolver::setupMask         [3c391_ctm_spw0_multiscale] Number of pixels in the clean mask : 19718 out of a total of 230400 pixels. [ 8.55816 % ]
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.123932, over full image : 0.123932
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 20000, 'cyclethreshold': 0.011826766654849052, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.0118268, CycleNiter=20000, Gain=0.1
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        MatrixCleaner::clean()         Cleaning using given mask
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        MatrixCleaner::clean()         Starting iteration
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.469931 within the mask
15-Oct-2025 08:32:36 2025-10-15 08:32:31        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
15-Oct-2025 08:32:36 2025-10-15 08:32:34        INFO        MatrixCleaner::clean()         200      0.0712141      2.46328
15-Oct-2025 08:32:36 2025-10-15 08:32:36        INFO        MatrixCleaner::clean()         400      0.0422464      3.36933
15-Oct-2025 08:32:36 2025-10-15 08:32:37        INFO        MatrixCleaner::clean()         Reached stopping threshold 0.0118268 at iteration 502
15-Oct-2025 08:32:36 2025-10-15 08:32:37        INFO        MatrixCleaner::clean()         Optimum flux is 0.0116264
15-Oct-2025 08:32:36 2025-10-15 08:32:37        INFO        MatrixCleaner::clean()           0    0.0627742
15-Oct-2025 08:32:36 2025-10-15 08:32:37        INFO        MatrixCleaner::clean()           1    0.172396
15-Oct-2025 08:32:36 2025-10-15 08:32:37        INFO        MatrixCleaner::clean()           2    3.43351
15-Oct-2025 08:32:36 2025-10-15 08:32:37        INFO        MatrixCleaner::clean()           3    0.0570872
15-Oct-2025 08:32:36 2025-10-15 08:32:37        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->503 [503], model=0->3.7246, peakres=0.123932->0.0116264, Reached cyclethreshold.
15-Oct-2025 08:32:36 2025-10-15 08:32:37        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 503 iterations.
15-Oct-2025 08:32:57 2025-10-15 08:32:37        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : 3c391_ctm_spw0_multiscale to all nodes :[/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7]
15-Oct-2025 08:32:57 2025-10-15 08:32:37        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1.model
15-Oct-2025 08:32:57 2025-10-15 08:32:37        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2.model
15-Oct-2025 08:32:57 2025-10-15 08:32:37        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3.model
15-Oct-2025 08:32:57 2025-10-15 08:32:37        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4.model
15-Oct-2025 08:32:57 2025-10-15 08:32:37        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5.model
15-Oct-2025 08:32:57 2025-10-15 08:32:37        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6.model
15-Oct-2025 08:32:57 2025-10-15 08:32:37        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7.model
15-Oct-2025 08:32:57 2025-10-15 08:32:37        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
15-Oct-2025 08:32:57 2025-10-15 08:32:37        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
15-Oct-2025 08:32:57
15-Oct-2025 08:32:57 0%....10....20....30...
15-Oct-2025 08:32:57 0%....10....20
15-Oct-2025 08:32:57 0%....10....20....30....
15-Oct-2025 08:32:57 0%....10....20
15-Oct-2025 08:32:57 0%....10....20....30...
15-Oct-2025 08:32:57 0%....10....20.
15-Oct-2025 08:32:57 0%....10....20....30....40.40....40.40..............30......30..50.50.50..50.....30.........40....40.......60.60..60..40..60...........50..50......70....70...70.70....50........6060.........80.80..80..80............60.70......70.....9090..90.90......100%
15-Oct-2025 08:32:57 ......100%
15-Oct-2025 08:32:57 .70.80..100%
15-Oct-2025 08:32:57 ...100%
15-Oct-2025 08:32:57 ........80...9080.....100%
15-Oct-2025 08:32:57 ....90.....100%
15-Oct-2025 08:32:57 .90....100%
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        tclean::::casa        ...done
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7] onto :3c391_ctm_spw0_multiscale
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.0142191, over full image : 0.0142191
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 19497, 'cyclethreshold': 0.001356918946839869, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.00135692, CycleNiter=19497, Gain=0.1
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        MatrixCleaner::clean()         Cleaning using given mask
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        MatrixCleaner::clean()         Starting iteration
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.0505523 within the mask
15-Oct-2025 08:32:57 2025-10-15 08:32:56        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
15-Oct-2025 08:32:57 2025-10-15 08:32:57        INFO        MatrixCleaner::clean()         Diverging due to large scale?
15-Oct-2025 08:32:57 2025-10-15 08:32:57        INFO        MatrixCleaner::clean()           0    0
15-Oct-2025 08:32:57 2025-10-15 08:32:57        INFO        MatrixCleaner::clean()           1    0.00698189
15-Oct-2025 08:32:57 2025-10-15 08:32:57        INFO        MatrixCleaner::clean()           2    0.175678
15-Oct-2025 08:32:57 2025-10-15 08:32:57        INFO        MatrixCleaner::clean()           3    0.0273352
15-Oct-2025 08:32:57 2025-10-15 08:32:57        WARN        SDAlgorithmMSClean::takeOneStep (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SDAlgorithmMSClean.cc, line 185)        MSClean minor cycle stopped at large scale negative or diverging
15-Oct-2025 08:32:57 2025-10-15 08:32:57        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->49 [49], model=3.72461->3.90727, peakres=0.0142191->0.0117853, Exited multiscale minor cycle without reaching any stopping criterion.
15-Oct-2025 08:32:57 2025-10-15 08:32:57        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 552 iterations.
15-Oct-2025 08:32:57 2025-10-15 08:32:57        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : 3c391_ctm_spw0_multiscale to all nodes :[/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7]
15-Oct-2025 08:32:57 2025-10-15 08:32:57        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1.model
15-Oct-2025 08:32:57 2025-10-15 08:32:57        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2.model
15-Oct-2025 08:33:37 2025-10-15 08:32:57        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3.model
15-Oct-2025 08:33:37 2025-10-15 08:32:57        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4.model
15-Oct-2025 08:33:37 2025-10-15 08:32:57        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5.model
15-Oct-2025 08:33:37 2025-10-15 08:32:57        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6.model
15-Oct-2025 08:33:37 2025-10-15 08:32:57        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7.model
15-Oct-2025 08:33:37 2025-10-15 08:32:57        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
15-Oct-2025 08:33:37 2025-10-15 08:32:57        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
15-Oct-2025 08:33:37
15-Oct-2025 08:33:37 0%....10....20
15-Oct-2025 08:33:37 0%....10....20....30....
15-Oct-2025 08:33:37 0%....10....20
15-Oct-2025 08:33:37 0%....10....20
15-Oct-2025 08:33:37 0%....10....20....30...
15-Oct-2025 08:33:37 0%....10....20....30...
15-Oct-2025 08:33:37 0%....10....20....30.......4040.40...40..............30.....30...50.50..50..50....30..........40...40.......60.60.60....40..60.........50....50.....70...70....7070.......50......6060.........80.80.80...80............60..70.....70....90.90.90.90......100%
15-Oct-2025 08:33:37 ........100%
15-Oct-2025 08:33:37 70.80..100%
15-Oct-2025 08:33:37 ...100%
15-Oct-2025 08:33:37 ........80...9080.....100%
15-Oct-2025 08:33:37 ...90......100%
15-Oct-2025 08:33:37 .90....100%
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        tclean::::casa        ...done
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7] onto :3c391_ctm_spw0_multiscale
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.0119035, over full image : 0.0119035
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 19448, 'cyclethreshold': 0.0011359406635165215, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.00113594, CycleNiter=19448, Gain=0.1
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        MatrixCleaner::clean()         Cleaning using given mask
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        MatrixCleaner::clean()         Starting iteration
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.277388 within the mask
15-Oct-2025 08:33:37 2025-10-15 08:33:16        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
15-Oct-2025 08:33:37 2025-10-15 08:33:19        INFO        MatrixCleaner::clean()         200      0.0256308      0.67816
15-Oct-2025 08:33:37 2025-10-15 08:33:21        INFO        MatrixCleaner::clean()         400      0.00678201      1.10411
15-Oct-2025 08:33:37 2025-10-15 08:33:23        INFO        MatrixCleaner::clean()         600      0.00736689      1.41764
15-Oct-2025 08:33:37 2025-10-15 08:33:25        INFO        MatrixCleaner::clean()         800      0.0139059      1.6712
15-Oct-2025 08:33:37 2025-10-15 08:33:27        INFO        MatrixCleaner::clean()         1000      0.00406681      1.8746
15-Oct-2025 08:33:37 2025-10-15 08:33:29        INFO        MatrixCleaner::clean()         1200      0.0103415      2.04536
15-Oct-2025 08:33:37 2025-10-15 08:33:31        INFO        MatrixCleaner::clean()         1400      0.0031618      2.19537
15-Oct-2025 08:33:37 2025-10-15 08:33:33        INFO        MatrixCleaner::clean()         1600      0.0027961      2.32169
15-Oct-2025 08:33:37 2025-10-15 08:33:36        INFO        MatrixCleaner::clean()         1800      0.00335221      2.43709
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        MatrixCleaner::clean()         2000      0.00671455      2.53881
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        MatrixCleaner::clean()           0    0.134221
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        MatrixCleaner::clean()           1    0.165437
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        MatrixCleaner::clean()           2    1.95941
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        MatrixCleaner::clean()           3    0.279746
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        MatrixCleaner::clean()         Failed to reach stopping threshold
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        MatrixCleaner::clean()         Cleaning using given mask
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        MatrixCleaner::clean()         Starting iteration
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.00301749 within the mask
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        MatrixCleaner::clean()         Diverging due to large scale?
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        MatrixCleaner::clean()           0    0
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        MatrixCleaner::clean()           1    0.000301749
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        MatrixCleaner::clean()           2    0.000671243
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        MatrixCleaner::clean()           3    0
15-Oct-2025 08:33:37 2025-10-15 08:33:38        WARN        SDAlgorithmMSClean::takeOneStep (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SDAlgorithmMSClean.cc, line 185)        MSClean minor cycle stopped at large scale negative or diverging
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->2002 [2002], model=3.90727->6.44637, peakres=0.0119035->0.011904, Possible divergence. Peak residual increased by 10% from minimum.
15-Oct-2025 08:33:37 2025-10-15 08:33:38        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 2554 iterations.
15-Oct-2025 08:33:57 2025-10-15 08:33:38        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : 3c391_ctm_spw0_multiscale to all nodes :[/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7]
15-Oct-2025 08:33:57 2025-10-15 08:33:38        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1.model
15-Oct-2025 08:33:57 2025-10-15 08:33:38        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2.model
15-Oct-2025 08:33:57 2025-10-15 08:33:38        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3.model
15-Oct-2025 08:33:57 2025-10-15 08:33:38        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4.model
15-Oct-2025 08:33:57 2025-10-15 08:33:38        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5.model
15-Oct-2025 08:33:57 2025-10-15 08:33:38        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6.model
15-Oct-2025 08:33:57 2025-10-15 08:33:38        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7.model
15-Oct-2025 08:33:57 2025-10-15 08:33:38        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
15-Oct-2025 08:33:57 2025-10-15 08:33:38        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
15-Oct-2025 08:33:57
15-Oct-2025 08:33:57 0%....10....20
15-Oct-2025 08:33:57 0%....10....20....30....40
15-Oct-2025 08:33:57 0%....10....20....30....
15-Oct-2025 08:33:57 0%....10....20.
15-Oct-2025 08:33:57 0%....10....20....30....
15-Oct-2025 08:33:57 0%....10....20.
15-Oct-2025 08:33:57 0%....10....20....30....40.40...40............30.......30..50..50.50...50...30.........40....40.......60.60..60..40...60.........50.50........70....70....70.70..50.........6060.........80.80..80..80...........60..70......70.....90.90..9090.......100%
15-Oct-2025 08:33:57 ......100%
15-Oct-2025 08:33:57 7080...100%
15-Oct-2025 08:33:57 ...100%
15-Oct-2025 08:33:57 ........80...9080.....100%
15-Oct-2025 08:33:57 ....90.....100%
15-Oct-2025 08:33:57 .90....100%
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        tclean::::casa        ...done
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7] onto :3c391_ctm_spw0_multiscale
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00333072, over full image : 0.00575184
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 17446, 'cyclethreshold': 0.0010000000474974513, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': True}
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.001, CycleNiter=17446, Gain=0.1
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::clean()         Cleaning using given mask
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::clean()         Starting iteration
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.0129891 within the mask
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::clean()         Diverging due to large scale?
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::clean()           0    0
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::clean()           1    0
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::clean()           2    0.0170775
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        MatrixCleaner::clean()           3    0.00871297
15-Oct-2025 08:33:57 2025-10-15 08:33:57        WARN        SDAlgorithmMSClean::takeOneStep (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SDAlgorithmMSClean.cc, line 185)        MSClean minor cycle stopped at large scale negative or diverging
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->15 [15], model=6.44639->6.46344, peakres=0.00333072->0.00316979, Exited multiscale minor cycle without reaching any stopping criterion.
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 2569 iterations.
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : 3c391_ctm_spw0_multiscale to all nodes :[/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7]
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1.model
15-Oct-2025 08:33:57 2025-10-15 08:33:57        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2.model
15-Oct-2025 08:34:38 2025-10-15 08:33:57        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3.model
15-Oct-2025 08:34:38 2025-10-15 08:33:58        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4.model
15-Oct-2025 08:34:38 2025-10-15 08:33:58        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5.model
15-Oct-2025 08:34:38 2025-10-15 08:33:58        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6.model
15-Oct-2025 08:34:38 2025-10-15 08:33:58        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7.model
15-Oct-2025 08:34:38 2025-10-15 08:33:58        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
15-Oct-2025 08:34:38 2025-10-15 08:33:58        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
15-Oct-2025 08:34:38
15-Oct-2025 08:34:38 0%....10....
15-Oct-2025 08:34:38 0%....10....20....30..
15-Oct-2025 08:34:38 0%....10....20....30...
15-Oct-2025 08:34:38 0%....10....20....30..
15-Oct-2025 08:34:38 0%....10....20
15-Oct-2025 08:34:38 0%....10....20
15-Oct-2025 08:34:38 0%....10....20....30....20......4040....40.40...........30........30..50..50.50.50.....30........40...40.........60.60..60..40...60.........50..50.......70....70.....7070..50.........6060........80..80....8080...........60..70......70.....90.90..9090......100%
15-Oct-2025 08:34:38 ......100%
15-Oct-2025 08:34:38 .7080...100%
15-Oct-2025 08:34:38 ....100%
15-Oct-2025 08:34:38 .......80...9080.....100%
15-Oct-2025 08:34:38 ....90.....100%
15-Oct-2025 08:34:38 .90....100%
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        tclean::::casa        ...done
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7] onto :3c391_ctm_spw0_multiscale
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00317446, over full image : 0.00575647
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 17431, 'cyclethreshold': 0.0010000000474974513, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': True}
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.001, CycleNiter=17431, Gain=0.1
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        MatrixCleaner::clean()         Cleaning using given mask
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        MatrixCleaner::clean()         Starting iteration
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.0875261 within the mask
15-Oct-2025 08:34:38 2025-10-15 08:34:17        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
15-Oct-2025 08:34:38 2025-10-15 08:34:19        INFO        MatrixCleaner::clean()         200      0.00808871      0.259701
15-Oct-2025 08:34:38 2025-10-15 08:34:21        INFO        MatrixCleaner::clean()         400      0.00309816      0.42819
15-Oct-2025 08:34:38 2025-10-15 08:34:23        INFO        MatrixCleaner::clean()         600      0.00615639      0.557607
15-Oct-2025 08:34:38 2025-10-15 08:34:25        INFO        MatrixCleaner::clean()         800      0.00559942      0.652203
15-Oct-2025 08:34:38 2025-10-15 08:34:27        INFO        MatrixCleaner::clean()         1000      0.0051514      0.739039
15-Oct-2025 08:34:38 2025-10-15 08:34:30        INFO        MatrixCleaner::clean()         1200      0.00478852      0.810756
15-Oct-2025 08:34:38 2025-10-15 08:34:32        INFO        MatrixCleaner::clean()         1400      0.00444905      0.877789
15-Oct-2025 08:34:38 2025-10-15 08:34:34        INFO        MatrixCleaner::clean()         1600      0.00143532      0.937145
15-Oct-2025 08:34:38 2025-10-15 08:34:36        INFO        MatrixCleaner::clean()         1800      0.00393908      0.993055
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        MatrixCleaner::clean()         2000      0.00369051      1.0394
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        MatrixCleaner::clean()           0    0.0908105
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        MatrixCleaner::clean()           1    0.0528915
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        MatrixCleaner::clean()           2    0.68282
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        MatrixCleaner::clean()           3    0.212872
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        MatrixCleaner::clean()         Failed to reach stopping threshold
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        MatrixCleaner::clean()         Cleaning using given mask
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        MatrixCleaner::clean()         Starting iteration
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.00124928 within the mask
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        MatrixCleaner::clean()         Diverging due to large scale?
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        MatrixCleaner::clean()           0    0.000124928
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        MatrixCleaner::clean()           1    0
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        MatrixCleaner::clean()           2    0.00036736
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        MatrixCleaner::clean()           3    0
15-Oct-2025 08:34:38 2025-10-15 08:34:38        WARN        SDAlgorithmMSClean::takeOneStep (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SDAlgorithmMSClean.cc, line 185)        MSClean minor cycle stopped at large scale negative or diverging
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->2002 [2002], model=6.46347->7.50296, peakres=0.00317446->0.0031741, Possible divergence. Peak residual increased by 10% from minimum.
15-Oct-2025 08:34:38 2025-10-15 08:34:38        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 4571 iterations.
15-Oct-2025 08:34:57 2025-10-15 08:34:38        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : 3c391_ctm_spw0_multiscale to all nodes :[/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7]
15-Oct-2025 08:34:57 2025-10-15 08:34:38        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1.model
15-Oct-2025 08:34:57 2025-10-15 08:34:38        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2.model
15-Oct-2025 08:34:57 2025-10-15 08:34:38        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3.model
15-Oct-2025 08:34:57 2025-10-15 08:34:38        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4.model
15-Oct-2025 08:34:57 2025-10-15 08:34:38        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5.model
15-Oct-2025 08:34:57 2025-10-15 08:34:38        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6.model
15-Oct-2025 08:34:57 2025-10-15 08:34:38        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7.model
15-Oct-2025 08:34:57 2025-10-15 08:34:38        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
15-Oct-2025 08:34:57 2025-10-15 08:34:38        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
15-Oct-2025 08:34:57
15-Oct-2025 08:34:57 0%....10....20
15-Oct-2025 08:34:57 0%....10....20
15-Oct-2025 08:34:57 0%....10....20
15-Oct-2025 08:34:57 0%....10....20....30...
15-Oct-2025 08:34:57 0%....10....20....30...
15-Oct-2025 08:34:57 0%....10....20....30....
15-Oct-2025 08:34:57 0%....10....20....30.......4040...40..40.............30......30..50..50.50.50.....30.........40..40.........60.60..60..40...60.........50..50.......70...70......7070..50.........6060........80..80....8080............60.70......70.....90.90..9090......100%
15-Oct-2025 08:34:57 ......100%
15-Oct-2025 08:34:57 .7080...100%
15-Oct-2025 08:34:57 ....100%
15-Oct-2025 08:34:57 .......80...9080.....100%
15-Oct-2025 08:34:57 ...90......100%
15-Oct-2025 08:34:57 .90....100%
15-Oct-2025 08:34:57 2025-10-15 08:34:57        INFO        tclean::::casa        ...done
15-Oct-2025 08:34:57 2025-10-15 08:34:57        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7] onto :3c391_ctm_spw0_multiscale
15-Oct-2025 08:34:57 2025-10-15 08:34:57        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00166126, over full image : 0.00418057
15-Oct-2025 08:34:57 2025-10-15 08:34:57        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 15429, 'cyclethreshold': 0.0010000000474974513, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': True}
15-Oct-2025 08:34:57 2025-10-15 08:34:57        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.001, CycleNiter=15429, Gain=0.1
15-Oct-2025 08:34:57 2025-10-15 08:34:57        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
15-Oct-2025 08:34:57 2025-10-15 08:34:57        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
15-Oct-2025 08:34:57 2025-10-15 08:34:57        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
15-Oct-2025 08:34:57 2025-10-15 08:34:57        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
15-Oct-2025 08:34:57 2025-10-15 08:34:57        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
15-Oct-2025 08:34:57 2025-10-15 08:34:57        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
15-Oct-2025 08:34:57 2025-10-15 08:34:57        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
15-Oct-2025 08:34:57 2025-10-15 08:34:57        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
15-Oct-2025 08:34:57 2025-10-15 08:34:57        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
15-Oct-2025 08:34:57 2025-10-15 08:34:58        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
15-Oct-2025 08:34:57 2025-10-15 08:34:58        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
15-Oct-2025 08:34:57 2025-10-15 08:34:58        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
15-Oct-2025 08:34:57 2025-10-15 08:34:58        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
15-Oct-2025 08:34:57 2025-10-15 08:34:58        INFO        MatrixCleaner::clean()         Cleaning using given mask
15-Oct-2025 08:34:57 2025-10-15 08:34:58        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
15-Oct-2025 08:34:57 2025-10-15 08:34:58        INFO        MatrixCleaner::clean()         Starting iteration
15-Oct-2025 08:34:57 2025-10-15 08:34:58        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.00625964 within the mask
15-Oct-2025 08:34:57 2025-10-15 08:34:58        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
15-Oct-2025 08:34:57 2025-10-15 08:34:58        INFO        MatrixCleaner::clean()         Diverging due to large scale?
15-Oct-2025 08:34:57 2025-10-15 08:34:58        INFO        MatrixCleaner::clean()           0    0
15-Oct-2025 08:34:57 2025-10-15 08:34:58        INFO        MatrixCleaner::clean()           1    0
15-Oct-2025 08:34:57 2025-10-15 08:34:58        INFO        MatrixCleaner::clean()           2    0.00411141
15-Oct-2025 08:34:57 2025-10-15 08:34:58        INFO        MatrixCleaner::clean()           3    0.00424891
15-Oct-2025 08:34:57 2025-10-15 08:34:58        WARN        SDAlgorithmMSClean::takeOneStep (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SDAlgorithmMSClean.cc, line 185)        MSClean minor cycle stopped at large scale negative or diverging
15-Oct-2025 08:34:57 2025-10-15 08:34:58        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->8 [8], model=7.50299->7.50708, peakres=0.00166126->0.00157375, Exited multiscale minor cycle without reaching any stopping criterion.
15-Oct-2025 08:34:57 2025-10-15 08:34:58        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 4579 iterations.
15-Oct-2025 08:34:57 2025-10-15 08:34:58        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : 3c391_ctm_spw0_multiscale to all nodes :[/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7]
15-Oct-2025 08:34:57 2025-10-15 08:34:58        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1.model
15-Oct-2025 08:34:57 2025-10-15 08:34:58        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2.model
15-Oct-2025 08:35:29 2025-10-15 08:34:58        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3.model
15-Oct-2025 08:35:29 2025-10-15 08:34:58        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4.model
15-Oct-2025 08:35:29 2025-10-15 08:34:58        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5.model
15-Oct-2025 08:35:29 2025-10-15 08:34:58        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6.model
15-Oct-2025 08:35:29 2025-10-15 08:34:58        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7.model
15-Oct-2025 08:35:29 2025-10-15 08:34:58        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
15-Oct-2025 08:35:29 2025-10-15 08:34:58        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
15-Oct-2025 08:35:29
15-Oct-2025 08:35:29 0%....10....20....30....40
15-Oct-2025 08:35:29 0%....10....20.
15-Oct-2025 08:35:29 0%....10....20....30....40
15-Oct-2025 08:35:29 0%....10....20
15-Oct-2025 08:35:29 0%....10....20....30....
15-Oct-2025 08:35:29 0%....10....20....30....
15-Oct-2025 08:35:29 0%....10....20...40..40...........30........30....5050..5050....30.........40....40.........6060...60.40..60...........5050........70.....70....7070..50.........6060.........8080....80.80...........60.70.......70.....90...909090.......100%
15-Oct-2025 08:35:29 .....100%
15-Oct-2025 08:35:29 .7080...100%
15-Oct-2025 08:35:29 .....100%
15-Oct-2025 08:35:29 ......80...9080.....100%
15-Oct-2025 08:35:29 ....90......100%
15-Oct-2025 08:35:29 90....100%
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        tclean::::casa        ...done
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7] onto :3c391_ctm_spw0_multiscale
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00157517, over full image : 0.00419779
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 15421, 'cyclethreshold': 0.0010000000474974513, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': True}
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.001, CycleNiter=15421, Gain=0.1
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        MatrixCleaner::clean()         Cleaning using given mask
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        MatrixCleaner::clean()         Starting iteration
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.0425602 within the mask
15-Oct-2025 08:35:29 2025-10-15 08:35:17        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
15-Oct-2025 08:35:29 2025-10-15 08:35:19        INFO        MatrixCleaner::clean()         200      0.0322572      0.13475
15-Oct-2025 08:35:29 2025-10-15 08:35:21        INFO        MatrixCleaner::clean()         400      0.00129454      0.224776
15-Oct-2025 08:35:29 2025-10-15 08:35:23        INFO        MatrixCleaner::clean()         600      0.00119596      0.293933
15-Oct-2025 08:35:29 2025-10-15 08:35:26        INFO        MatrixCleaner::clean()         800      0.00112261      0.350499
15-Oct-2025 08:35:29 2025-10-15 08:35:28        INFO        MatrixCleaner::clean()         1000      0.00105038      0.392639
15-Oct-2025 08:35:29 2025-10-15 08:35:29        INFO        MatrixCleaner::clean()         Reached stopping threshold 0.001 at iteration 1151
15-Oct-2025 08:35:29 2025-10-15 08:35:29        INFO        MatrixCleaner::clean()         Optimum flux is 0.000999901
15-Oct-2025 08:35:29 2025-10-15 08:35:29        INFO        MatrixCleaner::clean()           0    0.0442363
15-Oct-2025 08:35:29 2025-10-15 08:35:29        INFO        MatrixCleaner::clean()           1    0.0193106
15-Oct-2025 08:35:29 2025-10-15 08:35:29        INFO        MatrixCleaner::clean()           2    0.225709
15-Oct-2025 08:35:29 2025-10-15 08:35:29        INFO        MatrixCleaner::clean()           3    0.137501
15-Oct-2025 08:35:29 2025-10-15 08:35:29        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->1152 [1152], model=7.5071->7.93371, peakres=0.00157517->0.000999901, Reached cyclethreshold.
15-Oct-2025 08:35:29 2025-10-15 08:35:29        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 5731 iterations.
15-Oct-2025 08:35:29 2025-10-15 08:35:29        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : 3c391_ctm_spw0_multiscale to all nodes :[/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7]
15-Oct-2025 08:35:29 2025-10-15 08:35:29        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1.model
15-Oct-2025 08:35:29 2025-10-15 08:35:29        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2.model
15-Oct-2025 08:35:29 2025-10-15 08:35:29        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3.model
15-Oct-2025 08:35:29 2025-10-15 08:35:29        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4.model
15-Oct-2025 08:35:49 2025-10-15 08:35:29        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5.model
15-Oct-2025 08:35:49 2025-10-15 08:35:29        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6.model
15-Oct-2025 08:35:49 2025-10-15 08:35:30        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7.model
15-Oct-2025 08:35:49 2025-10-15 08:35:30        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
15-Oct-2025 08:35:49 2025-10-15 08:35:30        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
15-Oct-2025 08:35:49
15-Oct-2025 08:35:49 0%....10....20
15-Oct-2025 08:35:49 0%....10....20....30..
15-Oct-2025 08:35:49 0%....10....20....30...
15-Oct-2025 08:35:49 0%....10....20....30..
15-Oct-2025 08:35:49 0%....10....
15-Oct-2025 08:35:49 0%....10....20
15-Oct-2025 08:35:49 0%....10....20....30....20......4040...40..40...........30........30...50.50.50.50.....30........40....40........60.60...60.40..60..........50.50........70.....70....7070...50........6060.........8080....80.80...........60..70......70.....90..90.9090.......100%
15-Oct-2025 08:35:49 .....100%
15-Oct-2025 08:35:49 .7080...100%
15-Oct-2025 08:35:49 ....100%
15-Oct-2025 08:35:49 .......80...9080.....100%
15-Oct-2025 08:35:49 ....90.....100%
15-Oct-2025 08:35:49 .90....100%
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        tclean::::casa        ...done
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7] onto :3c391_ctm_spw0_multiscale
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00115585, over full image : 0.00359524
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 14269, 'cyclethreshold': 0.0010000000474974513, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': True}
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.001, CycleNiter=14269, Gain=0.1
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::clean()         Cleaning using given mask
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::clean()         Starting iteration
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.00392886 within the mask
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::clean()         Diverging due to large scale?
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::clean()           0    0
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::clean()           1    0
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::clean()           2    0.00114883
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        MatrixCleaner::clean()           3    0.00281799
15-Oct-2025 08:35:49 2025-10-15 08:35:49        WARN        SDAlgorithmMSClean::takeOneStep (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SDAlgorithmMSClean.cc, line 185)        MSClean minor cycle stopped at large scale negative or diverging
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->4 [4], model=7.93376->7.93486, peakres=0.00115585->0.00115835, Exited multiscale minor cycle without reaching any stopping criterion.
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 5735 iterations.
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : 3c391_ctm_spw0_multiscale to all nodes :[/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7]
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1.model
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2.model
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3.model
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4.model
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5.model
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6.model
15-Oct-2025 08:35:49 2025-10-15 08:35:49        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7.model
15-Oct-2025 08:36:30 2025-10-15 08:35:49        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
15-Oct-2025 08:36:30 2025-10-15 08:35:49        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
15-Oct-2025 08:36:30
15-Oct-2025 08:36:30 0%....10....20
15-Oct-2025 08:36:30 0%....10....20....30....
15-Oct-2025 08:36:30 0%....10....20....30...
15-Oct-2025 08:36:30 0%....10....20....30....
15-Oct-2025 08:36:30 0%....10....20
15-Oct-2025 08:36:30 0%....10....20
15-Oct-2025 08:36:30 0%....10....20....30......4040..40...40............30.......30...50.50.50.50.....30.........40...40........60.60..60..40..60..........50.50........70.....70...70.70...50........6060.........80.80...80.80...........60..70......70.....90.90..9090.......100%
15-Oct-2025 08:36:30 ......100%
15-Oct-2025 08:36:30 7080...100%
15-Oct-2025 08:36:30 ....100%
15-Oct-2025 08:36:30 .......80...9080.....100%
15-Oct-2025 08:36:30 ....90.....100%
15-Oct-2025 08:36:30 .90....100%
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        tclean::::casa        ...done
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7] onto :3c391_ctm_spw0_multiscale
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00115871, over full image : 0.00360053
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 14265, 'cyclethreshold': 0.0010000000474974513, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': True}
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.001, CycleNiter=14265, Gain=0.1
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        MatrixCleaner::clean()         Cleaning using given mask
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        MatrixCleaner::clean()         Starting iteration
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.0281949 within the mask
15-Oct-2025 08:36:30 2025-10-15 08:36:08        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
15-Oct-2025 08:36:30 2025-10-15 08:36:11        INFO        MatrixCleaner::clean()         200      0.00136794      0.0908412
15-Oct-2025 08:36:30 2025-10-15 08:36:11        INFO        MatrixCleaner::clean()         Reached stopping threshold 0.001 at iteration 275
15-Oct-2025 08:36:30 2025-10-15 08:36:11        INFO        MatrixCleaner::clean()         Optimum flux is 0.000999691
15-Oct-2025 08:36:30 2025-10-15 08:36:11        INFO        MatrixCleaner::clean()           0    0.00593259
15-Oct-2025 08:36:30 2025-10-15 08:36:11        INFO        MatrixCleaner::clean()           1    0.00193182
15-Oct-2025 08:36:30 2025-10-15 08:36:11        INFO        MatrixCleaner::clean()           2    0.0604825
15-Oct-2025 08:36:30 2025-10-15 08:36:11        INFO        MatrixCleaner::clean()           3    0.0445607
15-Oct-2025 08:36:30 2025-10-15 08:36:11        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->276 [276], model=7.93491->8.04763, peakres=0.00115871->0.00099969, Reached cyclethreshold.
15-Oct-2025 08:36:30 2025-10-15 08:36:11        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 6011 iterations.
15-Oct-2025 08:36:30 2025-10-15 08:36:11        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : 3c391_ctm_spw0_multiscale to all nodes :[/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7]
15-Oct-2025 08:36:30 2025-10-15 08:36:11        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1.model
15-Oct-2025 08:36:30 2025-10-15 08:36:11        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2.model
15-Oct-2025 08:36:30 2025-10-15 08:36:11        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3.model
15-Oct-2025 08:36:30 2025-10-15 08:36:11        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4.model
15-Oct-2025 08:36:30 2025-10-15 08:36:12        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5.model
15-Oct-2025 08:36:30 2025-10-15 08:36:12        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6.model
15-Oct-2025 08:36:30 2025-10-15 08:36:12        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7.model
15-Oct-2025 08:36:30 2025-10-15 08:36:12        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
15-Oct-2025 08:36:30 2025-10-15 08:36:12        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
15-Oct-2025 08:36:30
15-Oct-2025 08:36:30 0%....10....
15-Oct-2025 08:36:30 0%....10....20....30..
15-Oct-2025 08:36:30 0%....10....20....30...
15-Oct-2025 08:36:30 0%....10....20....30..
15-Oct-2025 08:36:30 0%....10....20
15-Oct-2025 08:36:30 0%....10....20....30.
15-Oct-2025 08:36:30 0%....10....20...20......4040.40....40............30.......30..50.50..50.50.....30.........40..40.........60.60..60..40...60.........50..50.......70...70....70..70.....50......6060.........80.80...80.80............60.70......70.....90.90.90.90......100%
15-Oct-2025 08:36:30 .......100%
15-Oct-2025 08:36:30 7080...100%
15-Oct-2025 08:36:30 ....100%
15-Oct-2025 08:36:30 .......80...9080.....100%
15-Oct-2025 08:36:30 ...90......100%
15-Oct-2025 08:36:30 .90....100%
15-Oct-2025 08:36:30 2025-10-15 08:36:31        INFO        tclean::::casa        ...done
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7] onto :3c391_ctm_spw0_multiscale
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.0010333, over full image : 0.00343648
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 13989, 'cyclethreshold': 0.0010000000474974513, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': True}
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.001, CycleNiter=13989, Gain=0.1
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::clean()         Cleaning using given mask
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::clean()         Starting iteration
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.00314921 within the mask
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::clean()         Diverging due to large scale?
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::clean()           0    0
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::clean()           1    0
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::clean()           2    0.000314921
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        MatrixCleaner::clean()           3    0.00238825
15-Oct-2025 08:36:50 2025-10-15 08:36:31        WARN        SDAlgorithmMSClean::takeOneStep (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SDAlgorithmMSClean.cc, line 185)        MSClean minor cycle stopped at large scale negative or diverging
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->2 [2], model=8.04772->8.04794, peakres=0.0010333->0.00103666, Exited multiscale minor cycle without reaching any stopping criterion.
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 6013 iterations.
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : 3c391_ctm_spw0_multiscale to all nodes :[/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7]
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1.model
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2.model
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3.model
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4.model
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5.model
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6.model
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7.model
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
15-Oct-2025 08:36:50 2025-10-15 08:36:31        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
15-Oct-2025 08:36:50
15-Oct-2025 08:36:50 0%....10....20
15-Oct-2025 08:36:50 0%....10....20
15-Oct-2025 08:36:50 0%....10....20....30...
15-Oct-2025 08:36:50 0%....10....20
15-Oct-2025 08:36:50 0%....10....20....30....
15-Oct-2025 08:36:50 0%....10....20....30....
15-Oct-2025 08:36:50 0%....10....20....30....40...40..40.40............30........30..50..50..50.50...30.........40.....40........6060.60...40..60...........50.50.......70.70........7070...50........6060..........8080..80.80.............6070.......70.....9090...9090........100%
15-Oct-2025 08:36:50 ...100%
15-Oct-2025 08:36:50 ..7080...100%
15-Oct-2025 08:36:50 ....100%
15-Oct-2025 08:36:50 .......80...9080.....100%
15-Oct-2025 08:36:50 ....90......100%
15-Oct-2025 08:36:50 90....100%
15-Oct-2025 08:36:50 2025-10-15 08:36:50        INFO        tclean::::casa        ...done
15-Oct-2025 08:36:50 2025-10-15 08:36:50        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7] onto :3c391_ctm_spw0_multiscale
15-Oct-2025 08:36:50 2025-10-15 08:36:50        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00103682, over full image : 0.00343858
15-Oct-2025 08:36:50 2025-10-15 08:36:50        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 13987, 'cyclethreshold': 0.0010000000474974513, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': True}
15-Oct-2025 08:36:50 2025-10-15 08:36:50        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.001, CycleNiter=13987, Gain=0.1
15-Oct-2025 08:36:50 2025-10-15 08:36:50        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
15-Oct-2025 08:37:32 2025-10-15 08:36:50        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
15-Oct-2025 08:37:32 2025-10-15 08:36:50        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
15-Oct-2025 08:37:32 2025-10-15 08:36:50        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
15-Oct-2025 08:37:32 2025-10-15 08:36:50        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
15-Oct-2025 08:37:32 2025-10-15 08:36:50        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
15-Oct-2025 08:37:32 2025-10-15 08:36:50        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
15-Oct-2025 08:37:32 2025-10-15 08:36:50        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
15-Oct-2025 08:37:32 2025-10-15 08:36:50        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
15-Oct-2025 08:37:32 2025-10-15 08:36:50        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
15-Oct-2025 08:37:32 2025-10-15 08:36:50        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
15-Oct-2025 08:37:32 2025-10-15 08:36:50        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
15-Oct-2025 08:37:32 2025-10-15 08:36:50        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
15-Oct-2025 08:37:32 2025-10-15 08:36:50        INFO        MatrixCleaner::clean()         Cleaning using given mask
15-Oct-2025 08:37:32 2025-10-15 08:36:50        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
15-Oct-2025 08:37:32 2025-10-15 08:36:50        INFO        MatrixCleaner::clean()         Starting iteration
15-Oct-2025 08:37:32 2025-10-15 08:36:50        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.0238888 within the mask
15-Oct-2025 08:37:32 2025-10-15 08:36:50        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
15-Oct-2025 08:37:32 2025-10-15 08:36:51        INFO        MatrixCleaner::clean()         Reached stopping threshold 0.001 at iteration 85
15-Oct-2025 08:37:32 2025-10-15 08:36:51        INFO        MatrixCleaner::clean()         Optimum flux is 0.000999862
15-Oct-2025 08:37:32 2025-10-15 08:36:51        INFO        MatrixCleaner::clean()           0    0.00212589
15-Oct-2025 08:37:32 2025-10-15 08:36:51        INFO        MatrixCleaner::clean()           1    0.0010795
15-Oct-2025 08:37:32 2025-10-15 08:36:51        INFO        MatrixCleaner::clean()           2    0.0151584
15-Oct-2025 08:37:32 2025-10-15 08:36:51        INFO        MatrixCleaner::clean()           3    0.0162163
15-Oct-2025 08:37:32 2025-10-15 08:36:51        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->86 [86], model=8.04803->8.08243, peakres=0.00103682->0.000999861, Reached cyclethreshold.
15-Oct-2025 08:37:32 2025-10-15 08:36:51        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 6099 iterations.
15-Oct-2025 08:37:32 2025-10-15 08:36:51        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : 3c391_ctm_spw0_multiscale to all nodes :[/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7]
15-Oct-2025 08:37:32 2025-10-15 08:36:51        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1.model
15-Oct-2025 08:37:32 2025-10-15 08:36:51        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2.model
15-Oct-2025 08:37:32 2025-10-15 08:36:51        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3.model
15-Oct-2025 08:37:32 2025-10-15 08:36:51        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4.model
15-Oct-2025 08:37:32 2025-10-15 08:36:51        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5.model
15-Oct-2025 08:37:32 2025-10-15 08:36:52        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6.model
15-Oct-2025 08:37:32 2025-10-15 08:36:52        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model 3c391_ctm_spw0_multiscale.model to /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7.model
15-Oct-2025 08:37:32 2025-10-15 08:36:52        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
15-Oct-2025 08:37:32 2025-10-15 08:36:52        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
15-Oct-2025 08:37:32
15-Oct-2025 08:37:32 0%....10....20....30...
15-Oct-2025 08:37:32 0%....10....20
15-Oct-2025 08:37:32 0%....10....20....30.
15-Oct-2025 08:37:32 0%....10....
15-Oct-2025 08:37:32 0%....10....
15-Oct-2025 08:37:32 0%....10....20....30...
15-Oct-2025 08:37:32 0%....10....20....30...20.20....4040......40.40............30........3050...5050...50....30.........40....40.......60.60.60...40...60..........50..50......70..70......70.70...50........6060........80..80....8080............60.70......70...90..90...9090.....100%
15-Oct-2025 08:37:32 ......100%
15-Oct-2025 08:37:32 ..7080...100%
15-Oct-2025 08:37:32 ....100%
15-Oct-2025 08:37:32 .......80...90.80....100%
15-Oct-2025 08:37:32 ....90.....100%
15-Oct-2025 08:37:32 .90....100%
15-Oct-2025 08:37:32 2025-10-15 08:37:11        INFO        tclean::::casa        ...done
15-Oct-2025 08:37:32 2025-10-15 08:37:11        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n1, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n2, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n3, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n4, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n5, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n6, /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_spw0_multiscale.workdirectory/3c391_ctm_spw0_multiscale.n7] onto :3c391_ctm_spw0_multiscale
15-Oct-2025 08:37:32 2025-10-15 08:37:11        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00100629, over full image : 0.00338707
15-Oct-2025 08:37:32 2025-10-15 08:37:11        INFO        tclean::::casa        Reached global stopping criterion : threshold
15-Oct-2025 08:37:32 2025-10-15 08:37:11        INFO        tclean::::casa        getSummary call: fullsummary=False
15-Oct-2025 08:37:32 2025-10-15 08:37:11        INFO        SDAlgorithmBase::restore         [3c391_ctm_spw0_multiscale] : Restoring model image.
15-Oct-2025 08:37:32 2025-10-15 08:37:11        INFO        SIImageStore::restore         Beam for chan : 0 : 17.0639 arcsec, 14.9556 arcsec, 21.6316 deg
15-Oct-2025 08:37:32 2025-10-15 08:37:31        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
15-Oct-2025 08:37:32 2025-10-15 08:37:32        INFO        tclean::::casa        ...done
15-Oct-2025 08:37:32 2025-10-15 08:37:32        INFO        tclean::::casa        Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed.
15-Oct-2025 08:37:32 2025-10-15 08:37:32        INFO        tclean::::casa        Searching for images with prefix '3c391_ctm_spw0_multiscale'... Found these, writing history into them: ['3c391_ctm_spw0_multiscale.model', '3c391_ctm_spw0_multiscale.weight', '3c391_ctm_spw0_multiscale.mask', '3c391_ctm_spw0_multiscale.sumwt', '3c391_ctm_spw0_multiscale.residual', '3c391_ctm_spw0_multiscale.gridwt_moswt', '3c391_ctm_spw0_multiscale.psf', '3c391_ctm_spw0_multiscale.pb', '3c391_ctm_spw0_multiscale.image']
15-Oct-2025 08:37:32 2025-10-15 08:37:32        INFO        tclean::::casa        Task tclean complete. Start time: 2025-10-15 08:31:28.100095 End time: 2025-10-15 08:37:32.428255
15-Oct-2025 08:37:32 2025-10-15 08:37:32        INFO        tclean::::casa        ##### End Task: tclean               #####
15-Oct-2025 08:37:32 2025-10-15 08:37:32        INFO        tclean::::casa        ##########################################
15-Oct-2025 08:37:32 2025-10-15 08:37:32        INFO        impbcor::::casa        ##########################################
15-Oct-2025 08:37:32 2025-10-15 08:37:32        INFO        impbcor::::casa        ##### Begin Task: impbcor            #####
15-Oct-2025 08:37:32 2025-10-15 08:37:32        INFO        impbcor::::casa        impbcor( imagename='3c391_ctm_spw0_multiscale.image', pbimage='3c391_ctm_spw0_multiscale.pb', outfile='3c391_ctm_spw0_multiscale.pbcorimage', overwrite=False, box='', region='', chans='', stokes='', mask='', mode='divide', cutoff=-1.0, stretch=False )
15-Oct-2025 08:37:32 2025-10-15 08:37:32        INFO        impbcor::CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
15-Oct-2025 08:37:32 2025-10-15 08:37:32        INFO        impbcor::CasacRegionManager::fromBCS        Using all spectral channels.
15-Oct-2025 08:37:32 2025-10-15 08:37:32        INFO        impbcor::CasacRegionManager::fromBCS        Using polarizations ALL
15-Oct-2025 08:37:32 2025-10-15 08:37:32        INFO        impbcor::ImageRegion::fromRecord        Selected bounding box :
15-Oct-2025 08:37:32 2025-10-15 08:37:32        INFO        impbcor::ImageRegion::fromRecord+            [0, 0, 0, 0] to [479, 479, 0, 0]  (18:50:04.251, -01.05.40.567, I, 4.59835e+09Hz to 18:48:44.407, -00.45.43.065, I, 4.59835e+09Hz)
15-Oct-2025 08:37:32 2025-10-15 08:37:32        INFO        impbcor::ImageRegion::fromRecord        Selected bounding box :
15-Oct-2025 08:37:32 2025-10-15 08:37:32        INFO        impbcor::ImageRegion::fromRecord+            [0, 0, 0, 0] to [479, 479, 0, 0]  (18:50:04.251, -01.05.40.567, I, 4.59835e+09Hz to 18:48:44.407, -00.45.43.065, I, 4.59835e+09Hz)
15-Oct-2025 08:37:32 2025-10-15 08:37:32        INFO        impbcor::SubImageFactory::createImage        Creating image '3c391_ctm_spw0_multiscale.pbcorimage' of shape [480, 480, 1, 1]
15-Oct-2025 08:37:32 2025-10-15 08:37:32        INFO        impbcor::ImageMaskAttacher::makeMask        Created mask `mask0'
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        impbcor::::casa        Task impbcor complete. Start time: 2025-10-15 08:37:32.434472 End time: 2025-10-15 08:37:32.556359
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        impbcor::::casa        ##### End Task: impbcor              #####
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        impbcor::::casa        ##########################################
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::casa        ##########################################
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::casa        ##### Begin Task: imstat             #####
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::casa        imstat( imagename='3c391_ctm_spw0_multiscale.pbcorimage', 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 )
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::CasacRegionManager::fromBCS        Using all spectral channels.
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::CasacRegionManager::fromBCS        Using polarizations ALL
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::image::statistics         Determining stats for image 3c391_ctm_spw0_multiscale.pbcorimage
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::ImageRegion::fromRecord        Selected bounding box :
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::ImageRegion::fromRecord+            [0, 0, 0, 0] to [479, 479, 0, 0]  (18:50:04.251, -01.05.40.567, I, 4.59835e+09Hz to 18:48:44.407, -00.45.43.065, I, 4.59835e+09Hz)
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::_logStartup        Statistics calculated using Classic algorithm
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::_logStartup        Regions ---
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::_logStartup                 -- bottom-left corner (pixel) [blc]:  [0, 0, 0, 0]
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::_logStartup                 -- top-right corner (pixel) [trc]:    [479, 479, 0, 0]
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::_logStartup                 -- bottom-left corner (world) [blcf]: 18:50:04.251, -01.05.40.567, I, 4.59835e+09Hz
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::_logStartup                 -- top-right corner (world) [trcf]:   18:48:44.407, -00.45.43.065, I, 4.59835e+09Hz
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::        Values ---
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::                 -- flux density [flux]:                    9.37578 Jy
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::                 -- number of points [npts]:                115808
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::                 -- maximum value [max]:                    0.155505 Jy/beam
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::                 -- minimum value [min]:                    -0.00652045 Jy/beam
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::                 -- position of max value (pixel) [maxpos]: [288, 256, 0, 0]
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::                 -- position of min value (pixel) [minpos]: [70, 141, 0, 0]
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::                 -- position of max value (world) [maxposf]: 18:49:16.243, -00.55.00.580, I, 4.59835e+09Hz
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::                 -- position of min value (world) [minposf]: 18:49:52.582, -00.59.48.073, I, 4.59835e+09Hz
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::                 -- Sum of pixel values [sum]:               433.786 Jy/beam
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::                 -- Sum of squared pixel values [sumsq]:     17.843 Jy/beam.Jy/beam
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::        Statistics ---
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::                -- Mean of the pixel values [mean]:         0.00374573 Jy/beam
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::                -- Variance of the pixel values :           0.000140045 Jy/beam
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::                -- Standard deviation of the Mean [sigma]:  0.0118341 Jy/beam
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::                -- Root mean square [rms]:                  0.0124127 Jy/beam
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::                -- Median of the pixel values [median]:     0.000433273 Jy/beam
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::                -- Median of the deviations [medabsdevmed]: 0.00135725 Jy/beam
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::                -- IQR [quartile]:                          0.00293104 Jy/beam
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::                -- First quartile [q1]:                     -0.00075059 Jy/beam
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::                -- Third quartile [q3]:                     0.00218045 Jy/beam
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::statistics        Sum column unit = Jy/beam
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::statistics+        Mean column unit = Jy/beam
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::statistics+        Std_dev column unit = Jy/beam
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::statistics+        Minimum column unit = Jy/beam
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::statistics+        Maximum column unit = Jy/beam
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::statistics        Npts          Sum           Mean          Rms           Std_dev       Minimum       Maximum     
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::statistics         1.158080e+05  4.337857e+02  3.745731e-03  1.241266e-02  1.183406e-02 -6.520449e-03  1.555049e-01
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::casa        Task imstat complete. Start time: 2025-10-15 08:37:32.561376 End time: 2025-10-15 08:37:32.580234
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::casa        ##### End Task: imstat               #####
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::casa        ##########################################
15-Oct-2025 08:37:32 Expected image peak at pixels [288 256], got [288 256], tolerance exact
15-Oct-2025 08:37:32 Expected pbcor image peak of 0.15553903579711914, got 0.15550492703914642, tolerance 4.0%
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::casa        ##########################################
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::casa        ##### Begin Task: imstat             #####
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::::casa        imstat( imagename='3c391_ctm_spw0_multiscale.residual', axes=[], region='3c391_clean_mask.crtf', 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 )
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::RegionTextParser::_determineVersion        RegionTextParser::_determineVersion: Found spec version 0
15-Oct-2025 08:37:32 2025-10-15 08:37:33        INFO        imstat::AsciiRegionFileParser::_parse        Combined 1 image regions (which excludes any annotation regions)
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::AsciiRegionFileParser::_parse        The specified region will select all pixels that are included in the region. Full pixels will be included even when they are only partially covered by the region(s).
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::CasacRegionManager::fromBCS        Region read from CRTF file 3c391_clean_mask.crtf
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::image::statistics         Determining stats for image 3c391_ctm_spw0_multiscale.residual
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::ImageRegion::fromRecord        Selected bounding box :
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::ImageRegion::fromRecord+            [140, 145, 0, 0] to [316, 315, 0, 0]  (18:49:40.913, -00.59.38.078, I, 4.59835e+09Hz to 18:49:11.576, -00.52.33.079, I, 4.59835e+09Hz)
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::_logStartup        Statistics calculated using Classic algorithm
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::_logStartup        Regions ---
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::_logStartup                 -- bottom-left corner (pixel) [blc]:  [140, 145, 0, 0]
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::_logStartup                 -- top-right corner (pixel) [trc]:    [316, 315, 0, 0]
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::_logStartup                 -- bottom-left corner (world) [blcf]: 18:49:40.913, -00.59.38.078, I, 4.59835e+09Hz
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::_logStartup                 -- top-right corner (world) [trcf]:   18:49:11.576, -00.52.33.079, I, 4.59835e+09Hz
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::        Values ---
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::                 -- number of points [npts]:                19718
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::                 -- maximum value [max]:                    0.00100629
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::                 -- minimum value [min]:                    -0.000930621
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::                 -- position of max value (pixel) [maxpos]: [245, 311, 0, 0]
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::                 -- position of min value (pixel) [minpos]: [151, 157, 0, 0]
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::                 -- position of max value (world) [maxposf]: 18:49:23.411, -00.52.43.080, I, 4.59835e+09Hz
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::                 -- position of min value (world) [minposf]: 18:49:39.080, -00.59.08.078, I, 4.59835e+09Hz
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::                 -- Sum of pixel values [sum]:               8.35944
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::                 -- Sum of squared pixel values [sumsq]:     0.00584444
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::        Statistics ---
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::                -- Mean of the pixel values [mean]:         0.00042395
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::                -- Variance of the pixel values :           1.16674e-07
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::                -- Standard deviation of the Mean [sigma]:  0.000341576
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::                -- Root mean square [rms]:                  0.000544427
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::                -- Median of the pixel values [median]:     0.000462975
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::                -- Median of the deviations [medabsdevmed]: 0.000230316
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::                -- IQR [quartile]:                          0.000463206
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::                -- First quartile [q1]:                     0.000223624
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::                -- Third quartile [q3]:                     0.00068683
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::statistics        Sum column unit =
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::statistics+        Mean column unit =
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::statistics+        Std_dev column unit =
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::statistics+        Minimum column unit =
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::statistics+        Maximum column unit =
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::statistics        Npts          Sum           Mean          Rms           Std_dev       Minimum       Maximum     
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::ImageStatsCalculator::statistics         1.971800e+04  8.359437e+00  4.239495e-04  5.444275e-04  3.415757e-04 -9.306206e-04  1.006286e-03
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::casa        Task imstat complete. Start time: 2025-10-15 08:37:32.582615 End time: 2025-10-15 08:37:32.598841
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::casa        ##### End Task: imstat               #####
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        imstat::::casa        ##########################################
15-Oct-2025 08:37:53 Expected peak residual of 0.0010077510960400105, got 0.0010062860092148185, tolerance 10.0%
15-Oct-2025 08:37:53 Expected rms residual of 0.000542584067811474, got 0.000544427461393555, tolerance 10.0%
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        name::        No table opened.
15-Oct-2025 08:37:53 2025-10-15 08:37:33        INFO        name::        No table opened.
15-Oct-2025 08:37:53 .
15-Oct-2025 08:37:53 ----------------------------------------------------------------------
15-Oct-2025 08:37:53 Ran 1 test in 872.592s
15-Oct-2025 08:37:53
15-Oct-2025 08:37:53 OK
15-Oct-2025 08:37:53 Executor result: 0
15-Oct-2025 08:37:53 Failed tests:[]
15-Oct-2025 08:37:53
15-Oct-2025 08:37:53 Results: [{'testname': 'test_stk_vla_users_continuum_from_SDM', 'runtime': '0:14:52.537669', 'returncode': 0, 'testerr': []}]
15-Oct-2025 08:37:53 Stopping Xvfb.
15-Oct-2025 08:37:53 Stopping framebuffer <Popen: returncode: None args: ['Xvfb', ':105', '-screen', '0', '2048x2048x2...>
15-Oct-2025 08:37:53 Virtual frame buffer deployed at :105 with pid 118 successfully shutdown
15-Oct-2025 08:37:53 Xvfb stopped.
15-Oct-2025 08:37:54 cp: cannot stat '/home/casatest/work/test_stk_vla_users_continuum_from_SDM/*.png': No such file or directory
15-Oct-2025 08:37:54 total 1018844
15-Oct-2025 08:37:54 -rw-r--r-- 1 casaci    15001 1043288316 Oct 15 08:20 casa-6.7.1-12-py3.12.el8.tar.xz
15-Oct-2025 08:37:54 drwxr-xr-x 2 casaci root             24 Oct 15 08:37 html
15-Oct-2025 08:37:54 -rw-r--r-- 1 casaci casatest        388 Oct 15 08:37 xUnit-suite-mpi-8.xml
15-Oct-2025 08:37:54 total 16
15-Oct-2025 08:37:54 -rw-r--r-- 1 casaci root 12471 Oct 15 08:37 index.html
15-Oct-2025 08:37:54 Finished task 'Script' with result: Success
15-Oct-2025 08:37:54 Starting task 'Parse test results' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
15-Oct-2025 08:37:54 Parsing test results under /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-RELEASE671TESTSTKPY312-STCR85D...
15-Oct-2025 08:37:54 Finished task 'Parse test results' with result: Success
15-Oct-2025 08:37:54
Substituting variable: ${bamboo.capability.hostname} with cvpost134
15-Oct-2025 08:37:54
Substituting variable: ${bamboo.capability.hostname} with cvpost134
15-Oct-2025 08:37:54 Starting task 'Cleanup' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
15-Oct-2025 08:37:54
Beginning to execute external process for build 'CASASPECS - Release 6.7.1 Test Stakeholder Python 3.12 - Test VLA Stakeholder Tests MPI Rocky 8.10 Docker #72 (CASASPECS-RELEASE671TESTSTKPY312-STCR85D-72)'
... running command line:
/export/cvpost134-nvme/casa/bamboohome/temp/CASASPECS-RELEASE671TESTSTKPY312-STCR85D-72-ScriptBuildTask-2124673066318227545.sh
... in: /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-RELEASE671TESTSTKPY312-STCR85D
15-Oct-2025 08:37:54 Starting cleanup
15-Oct-2025 08:38:04 test-container
15-Oct-2025 08:38:09 test-container
15-Oct-2025 08:38:09 Cleanup complete
15-Oct-2025 08:38:09 Finished task 'Cleanup' with result: Success
15-Oct-2025 08:38:09 Running post build plugin 'Docker Container Cleanup'
15-Oct-2025 08:38:09 Running post build plugin 'NCover Results Collector'
15-Oct-2025 08:38:09 Running post build plugin 'Build Results Label Collector'
15-Oct-2025 08:38:09 Running post build plugin 'Clover Results Collector'
15-Oct-2025 08:38:09 Running post build plugin 'npm Cache Cleanup'
15-Oct-2025 08:38:09 Running post build plugin 'Artifact Copier'
15-Oct-2025 08:38:09 Publishing an artifact: VLA Stakeholder MPI
15-Oct-2025 08:38:09 Finished publishing of artifact Non required job artifact Http Compression On : [VLA Stakeholder MPI], patterns: [html/**] anchored at: [dockershare] in 91.31 ms
15-Oct-2025 08:38:09 Finalising the build...
15-Oct-2025 08:38:09 Stopping timer.
15-Oct-2025 08:38:09 Build CASASPECS-RELEASE671TESTSTKPY312-STCR85D-72 completed.
15-Oct-2025 04:38:09 Running on server: post build plugin 'Build Hanging Detection Configuration'
15-Oct-2025 04:38:09 Running on server: post build plugin 'NCover Results Collector'
15-Oct-2025 04:38:09 Running on server: post build plugin 'Build Labeller'
15-Oct-2025 04:38:09 Running on server: post build plugin 'Clover Delta Calculator'
15-Oct-2025 04:38:09 Running on server: post build plugin 'Maven Dependencies Postprocessor'
15-Oct-2025 04:38:09 All post build plugins have finished
15-Oct-2025 04:38:09 Generating build results summary...
15-Oct-2025 04:38:09 Saving build results to disk...
15-Oct-2025 04:38:09 Store variable context...
15-Oct-2025 04:38:09 Finished building CASASPECS-RELEASE671TESTSTKPY312-STCR85D-72.