Build: #233 was successful

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

Build log

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

02-Oct-2026 22:00:25 2026-10-02 21:59:48        INFO        applycal::AgentFlagger::open        Table type is Measurement Set
02-Oct-2026 22:00:25 2026-10-02 21:59:48        INFO        FlagVersion::saveFlagVersion        Creating new backup flag file called applycal_2
02-Oct-2026 22:00:25 2026-10-02 21:59:49        INFO        applycal::::casa        Task applycal complete. Start time: 2026-10-02 21:59:47.824699 End time: 2026-10-02 21:59:49.383620
02-Oct-2026 22:00:25 2026-10-02 21:59:49        INFO        applycal::::casa        ##### End Task: applycal             #####
02-Oct-2026 22:00:25 2026-10-02 21:59:49        INFO        applycal::::casa        ##########################################
02-Oct-2026 22:00:25 2026-10-02 21:59:49        INFO        applycal::::casa        ##########################################
02-Oct-2026 22:00:25 2026-10-02 21:59:49        INFO        applycal::::casa        ##### Begin Task: applycal           #####
02-Oct-2026 22:00:25 2026-10-02 21:59:49        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 )
02-Oct-2026 22:00:25 2026-10-02 21:59:49        INFO        applycal::AgentFlagger::open        Table type is Measurement Set
02-Oct-2026 22:00:25 2026-10-02 21:59:49        INFO        FlagVersion::saveFlagVersion        Creating new backup flag file called applycal_3
02-Oct-2026 22:00:25 2026-10-02 21:59:58        INFO        applycal::::casa        Task applycal complete. Start time: 2026-10-02 21:59:49.384765 End time: 2026-10-02 21:59:58.464347
02-Oct-2026 22:00:25 2026-10-02 21:59:58        INFO        applycal::::casa        ##### End Task: applycal             #####
02-Oct-2026 22:00:25 2026-10-02 21:59:58        INFO        applycal::::casa        ##########################################
02-Oct-2026 22:00:25 2026-10-02 21:59:58        INFO        split::::casa        ##########################################
02-Oct-2026 22:00:25 2026-10-02 21:59:58        INFO        split::::casa        ##### Begin Task: split              #####
02-Oct-2026 22:00:25 2026-10-02 21:59:58        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='' )
02-Oct-2026 22:00:25 2026-10-02 21:59:58        INFO        ParallelDataHelper::::casa        Analyzing MS for partitioning
02-Oct-2026 22:00:25 2026-10-02 21:59:59        INFO        ParallelDataHelper::::casa        Input vis is a Multi-MS
02-Oct-2026 22:00:25 2026-10-02 22:00:01        INFO        ParallelDataHelper::::casa        Finalizing MMS structure
02-Oct-2026 22:00:25 2026-10-02 22:00:01        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.
02-Oct-2026 22:00:25 2026-10-02 22:00:02        INFO        split::::casa        Task split complete. Start time: 2026-10-02 21:59:58.467110 End time: 2026-10-02 22:00:01.753906
02-Oct-2026 22:00:25 2026-10-02 22:00:02        INFO        split::::casa        ##### End Task: split                #####
02-Oct-2026 22:00:25 2026-10-02 22:00:02        INFO        split::::casa        ##########################################
02-Oct-2026 22:00:25 2026-10-02 22:00:02        INFO        statwt::::casa        ##########################################
02-Oct-2026 22:00:25 2026-10-02 22:00:02        INFO        statwt::::casa        ##### Begin Task: statwt             #####
02-Oct-2026 22:00:25 2026-10-02 22:00:02        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' )
02-Oct-2026 22:00:25 2026-10-02 22:00:02        INFO        statwt::::casa        Backup original flags before applying new flags
02-Oct-2026 22:00:25 2026-10-02 22:00:02        INFO        AgentFlagger::open        Table type is Measurement Set
02-Oct-2026 22:00:25 2026-10-02 22:00:02        INFO        FlagVersion::saveFlagVersion        Creating new backup flag file called statwt_1
02-Oct-2026 22:00:25 2026-10-02 22:00:02        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.
02-Oct-2026 22:00:25 2026-10-02 22:00:03        INFO        StatWtTVI::StatWtTVI        Using DATA to compute weights
02-Oct-2026 22:00:25 ....10....20....30....40....50....60....70....80....90....100%
02-Oct-2026 22:00:25 2026-10-02 22:00:25        INFO        StatWtTVI::summarizeFlagging        Originally, 35.0215% of the data were flagged. StatWtTVI flagged an additional 0%.
02-Oct-2026 22:00:25 2026-10-02 22:00:25        INFO        StatWtTVI::summarizeFlagging        TOTAL FLAGGED DATA AFTER RUNNING STATWT: 35.0215%
02-Oct-2026 22:00:25 2026-10-02 22:00:25        INFO        StatWtTVI::summarizeFlagging        
02-Oct-2026 22:00:25 2026-10-02 22:00:25        INFO        StatWtTVI::summarizeFlagging        SPECTRAL_WINDOW SAMPLES_WITH_NON-ZERO_VARIANCE SAMPLES_WHERE_REAL_PART_VARIANCE_DIFFERS_BY_>50%_FROM_IMAGINARY_PART
02-Oct-2026 22:00:25 2026-10-02 22:00:25        INFO        StatWtTVI::summarizeFlagging                      0                         997366                                                               260704
02-Oct-2026 22:00:25 2026-10-02 22:00:25        INFO        StatWtTVI::_logUsedChannels        Weights are being computed using SPW 0, channels 0~63
02-Oct-2026 22:00:25 2026-10-02 22:00:25        INFO        StatWtTVI::summarizeStats        The mean of the computed weights is 321.368
02-Oct-2026 22:00:25 2026-10-02 22:00:25        INFO        StatWtTVI::summarizeStats        The variance of the computed weights is 348637
02-Oct-2026 22:00:25 2026-10-02 22:00:25        INFO        StatWtTVI::summarizeStats        Weights which had corresponding flags of True prior to running this application were not used to compute these stats.
02-Oct-2026 22:00:25 2026-10-02 22:00:25        INFO        statwt::::casa        Task statwt complete. Start time: 2026-10-02 22:00:01.796952 End time: 2026-10-02 22:00:25.199098
02-Oct-2026 22:00:25 2026-10-02 22:00:25        INFO        statwt::::casa        ##### End Task: statwt               #####
02-Oct-2026 22:00:25 2026-10-02 22:00:25        INFO        statwt::::casa        ##########################################
02-Oct-2026 22:00:25 2026-10-02 22:00:25        INFO        tclean::::casa        ##########################################
02-Oct-2026 22:00:25 2026-10-02 22:00:25        INFO        tclean::::casa        ##### Begin Task: tclean             #####
02-Oct-2026 22:00:25 2026-10-02 22:00:25        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, fracbw=-1.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 )
02-Oct-2026 22:01:19 2026-10-02 22:00:25        INFO        tclean::::casa        Verifying Input Parameters
02-Oct-2026 22:01:19 2026-10-02 22:00:29        INFO        tclean::::casa        setupCluster, Setting up 7 engines.
02-Oct-2026 22:01:19 2026-10-02 22:00:29        INFO        SynthesisUtilMethods::continuumDataPartition         
02-Oct-2026 22:01:19 2026-10-02 22:00:29        INFO        SynthesisUtilMethods::continuumDataPartition +        Rows = 657829 767459 [P][M]: 0:6 ROWNUMBER() >= 657829 && ROWNUMBER() <= 767459
02-Oct-2026 22:01:19 2026-10-02 22:00:29        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': ''}}}
02-Oct-2026 22:01:19 2026-10-02 22:00:29        INFO        SynthesisImagerVi2::selectData         MS : 3c391_ctm_mosaic_spw0.ms | [Opened in readonly mode]
02-Oct-2026 22:01:19 2026-10-02 22:00:29        INFO        SynthesisImagerVi2::selectData           NRows selected : 767459
02-Oct-2026 22:01:19 2026-10-02 22:00:30        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [3c391_ctm_spw0_multiscale] :
02-Oct-2026 22:01:19 2026-10-02 22:00:30        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [3c391_ctm_spw0_multiscale] :
02-Oct-2026 22:01:19 2026-10-02 22:00:31        INFO        SynthesisImagerVi2::defineImage         Impars: start
02-Oct-2026 22:01:19 2026-10-02 22:00:31        INFO        SynthesisImagerVi2::defineImage         Shape: [480, 480, 1, 1] Spectral: [4.59835e+09] at [0] with increment [1.27992e+08]
02-Oct-2026 22:01:19 2026-10-02 22:00:31        INFO        SynthesisImagerVi2::defineImage         Set Gridding options for [3c391_ctm_spw0_multiscale] with ftmachine : mosaicft
02-Oct-2026 22:01:19 2026-10-02 22:00:32        INFO        SynthesisImager::getVPRecord         Using default Voltage Patterns from the VPManager
02-Oct-2026 22:01:19 2026-10-02 22:00:32        INFO        VPSkyJones::VPSkyJones        PB used EVLA
02-Oct-2026 22:01:19 2026-10-02 22:00:32        INFO        SynthesisImagerVi2::nSubCubeFitInMemory        Required memory: 0.2175 GB. Available mem.: 391.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 8.
02-Oct-2026 22:01:19 2026-10-02 22:00:32        INFO        SynthesisImagerVi2::weight()         Set imaging weights : Briggs weighting: sidelobes will be suppressed over full image
02-Oct-2026 22:01:19 2026-10-02 22:00:40        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
02-Oct-2026 22:01:19 2026-10-02 22:00:40        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
02-Oct-2026 22:01:19 2026-10-02 22:00:40        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
02-Oct-2026 22:01:19 2026-10-02 22:00:40        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
02-Oct-2026 22:01:19 2026-10-02 22:00:40        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
02-Oct-2026 22:01:19 2026-10-02 22:00:40        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
02-Oct-2026 22:01:19 2026-10-02 22:00:40        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
02-Oct-2026 22:01:19 2026-10-02 22:00:41        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
02-Oct-2026 22:01:19 2026-10-02 22:00:42        INFO        tclean::::casa        ...done
02-Oct-2026 22:01:19 2026-10-02 22:00:42        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
02-Oct-2026 22:01:19 2026-10-02 22:00:43        INFO        tclean::::casa        ...done
02-Oct-2026 22:01:19 2026-10-02 22:00:45        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
02-Oct-2026 22:01:19 2026-10-02 22:00:46        INFO        tclean::::casa        ...done
02-Oct-2026 22:01:19 2026-10-02 22:00:52        INFO        SynthesisImagerVi2::selectData         MS : 3c391_ctm_mosaic_spw0.ms | [Opened in readonly mode]
02-Oct-2026 22:01:19 2026-10-02 22:00:52        INFO        SynthesisImagerVi2::selectData           NRows selected : 767459
02-Oct-2026 22:01:19 2026-10-02 22:00:53        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [3c391_ctm_spw0_multiscale] :
02-Oct-2026 22:01:19 2026-10-02 22:00:53        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [3c391_ctm_spw0_multiscale] :
02-Oct-2026 22:01:19 2026-10-02 22:00:54        INFO        SynthesisImagerVi2::defineImage         Impars: start
02-Oct-2026 22:01:19 2026-10-02 22:00:54        INFO        SynthesisImagerVi2::defineImage         Shape: [480, 480, 1, 1] Spectral: [4.59835e+09] at [0] with increment [1.27992e+08]
02-Oct-2026 22:01:19 2026-10-02 22:00:54        INFO        SynthesisImagerVi2::defineImage         Set Gridding options for [3c391_ctm_spw0_multiscale] with ftmachine : mosaicft
02-Oct-2026 22:01:19 2026-10-02 22:00:54        INFO        SynthesisImager::getVPRecord         Using default Voltage Patterns from the VPManager
02-Oct-2026 22:01:19 2026-10-02 22:00:54        INFO        VPSkyJones::VPSkyJones        PB used EVLA
02-Oct-2026 22:01:19 2026-10-02 22:00:54        INFO        SynthesisImagerVi2::nSubCubeFitInMemory        Required memory: 0.2175 GB. Available mem.: 391.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 8.
02-Oct-2026 22:01:19 2026-10-02 22:00:54        INFO        SynthesisImagerVi2::weight()         Set imaging weights : Briggs weighting: sidelobes will be suppressed over full image
02-Oct-2026 22:01:19 2026-10-02 22:01:03        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
02-Oct-2026 22:01:19 2026-10-02 22:01:03        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
02-Oct-2026 22:01:19 2026-10-02 22:01:03        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
02-Oct-2026 22:01:19 2026-10-02 22:01:03        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
02-Oct-2026 22:01:19 2026-10-02 22:01:03        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
02-Oct-2026 22:01:19 2026-10-02 22:01:03        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
02-Oct-2026 22:01:19 2026-10-02 22:01:03        INFO        VisSetUtil::VisImagingWeight()         Normal robustness, robust = 0.5
02-Oct-2026 22:01:19 2026-10-02 22:01:03        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
02-Oct-2026 22:01:19 2026-10-02 22:01:04        INFO        tclean::::casa        ...done
02-Oct-2026 22:01:19 2026-10-02 22:01:04        INFO        task_tclean::SynthesisDeconvolver::setupDeconvolution         Set Deconvolution Options for [3c391_ctm_spw0_multiscale] : multiscale
02-Oct-2026 22:01:19 2026-10-02 22:01:04        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
02-Oct-2026 22:01:19 2026-10-02 22:01:05        INFO        tclean::::casa        ...done
02-Oct-2026 22:01:19 2026-10-02 22:01:05        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
02-Oct-2026 22:01:19
02-Oct-2026 22:01:19 0%....10....20....30....40....50
02-Oct-2026 22:01:19 0%....10....20....30....40....50
02-Oct-2026 22:01:19 0%....10....20....30....
02-Oct-2026 22:01:19 0%....10....20....30....40....50
02-Oct-2026 22:01:19 0%....10....20....30....40....
02-Oct-2026 22:01:19 0%....10....20....30....40.
02-Oct-2026 22:01:19 0%....10....20....30....4050...40.....................50..606060.6050.........50.............60..70..70.7070..60.............60.......70.80..80...80.80...70.........70........80....90.90.90..90...........100%
02-Oct-2026 22:01:19 80..100%
02-Oct-2026 22:01:19 ...100%
02-Oct-2026 22:01:19 .8090....100%
02-Oct-2026 22:01:19 ........100%
02-Oct-2026 22:01:19 ..90..90....100%
02-Oct-2026 22:01:19 ...100%
02-Oct-2026 22:01:19 2026-10-02 22:01:19        INFO        tclean::::casa        ...done
02-Oct-2026 22:01:32 2026-10-02 22:01:19        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
02-Oct-2026 22:01:32 2026-10-02 22:01:20        INFO        SIImageStore::calcSensitivity         [3c391_ctm_spw0_multiscale] Theoretical sensitivity (Jy/bm):1.06835e-05
02-Oct-2026 22:01:32 2026-10-02 22:01:20        INFO        SIImageStore::getPSFGaussian         Time to fit Gaussian to PSF 0.005877
02-Oct-2026 22:01:32 2026-10-02 22:01:20        INFO        SIImageStore::printBeamSet         Beam : 17.0639 arcsec, 14.9556 arcsec, 21.6316 deg
02-Oct-2026 22:01:32 2026-10-02 22:01:20        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
02-Oct-2026 22:01:32 2026-10-02 22:01:21        INFO        tclean::::casa        ...done
02-Oct-2026 22:01:32 2026-10-02 22:01:21        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]
02-Oct-2026 22:01:32 2026-10-02 22:01:21        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
02-Oct-2026 22:01:32 2026-10-02 22:01:21        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
02-Oct-2026 22:01:32 2026-10-02 22:01:21        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
02-Oct-2026 22:01:32 2026-10-02 22:01:21        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
02-Oct-2026 22:01:32 2026-10-02 22:01:21        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
02-Oct-2026 22:01:32 2026-10-02 22:01:21        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
02-Oct-2026 22:01:32 2026-10-02 22:01:21        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
02-Oct-2026 22:01:32 2026-10-02 22:01:21        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
02-Oct-2026 22:01:32 2026-10-02 22:01:21        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
02-Oct-2026 22:01:32
02-Oct-2026 22:01:32 0%....10....20....30....40....50....60
02-Oct-2026 22:01:32 0%....10....20....30....40....50....60....70..
02-Oct-2026 22:01:32 0%....10....20....30....40....50....60....70..
02-Oct-2026 22:01:32 0%....10....20....30....40....50....60....70..
02-Oct-2026 22:01:32 0%....10....20....30....40....50..
02-Oct-2026 22:01:32 0%....10....20....30....40....50....60
02-Oct-2026 22:01:32 0%....10....20....30....40....50....60....70..............80..80.80.80.60......70....70...............9090.9070.90...80.....100%
02-Oct-2026 22:01:32 .....100%
02-Oct-2026 22:01:32 ..100%
02-Oct-2026 22:01:32 ......100%
02-Oct-2026 22:01:32 ..80....8090.......100%
02-Oct-2026 22:01:32 ..90......100%
02-Oct-2026 22:01:32 90....100%
02-Oct-2026 22:01:32 2026-10-02 22:01:32        INFO        tclean::::casa        ...done
02-Oct-2026 22:01:32 2026-10-02 22:01:32        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
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0, over full image : 0.123931
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        SynthesisDeconvolver::setupMask         [3c391_ctm_spw0_multiscale] Setting up a mask from [3c391_clean_mask.crtf]
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
02-Oct-2026 22:01:32 2026-10-02 22:01:33        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.
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        RegionTextParser::_determineVersion        RegionTextParser::_determineVersion: Found spec version 0
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        AsciiRegionFileParser::_parse        Combined 1 image regions (which excludes any annotation regions)
02-Oct-2026 22:01:32 2026-10-02 22:01:33        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).
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        SynthesisDeconvolver::setupMask         ----------------------------------------------------------------------------------------------------------------------------------------
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        SynthesisDeconvolver::setupMask         [3c391_ctm_spw0_multiscale] Number of pixels in the clean mask : 19718 out of a total of 230400 pixels. [ 8.55816 % ]
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.123931, over full image : 0.123931
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 20000, 'cyclethreshold': 0.011826693080365658, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.0118267, CycleNiter=20000, Gain=0.1
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
02-Oct-2026 22:01:32 2026-10-02 22:01:33        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
02-Oct-2026 22:01:52 2026-10-02 22:01:33        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
02-Oct-2026 22:01:52 2026-10-02 22:01:33        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
02-Oct-2026 22:01:52 2026-10-02 22:01:33        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
02-Oct-2026 22:01:52 2026-10-02 22:01:33        INFO        MatrixCleaner::clean()         Cleaning using given mask
02-Oct-2026 22:01:52 2026-10-02 22:01:33        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
02-Oct-2026 22:01:52 2026-10-02 22:01:33        INFO        MatrixCleaner::clean()         Starting iteration
02-Oct-2026 22:01:52 2026-10-02 22:01:33        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.469931 within the mask
02-Oct-2026 22:01:52 2026-10-02 22:01:33        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
02-Oct-2026 22:01:52 2026-10-02 22:01:33        INFO        MatrixCleaner::clean()         200      0.0711923      2.46328
02-Oct-2026 22:01:52 2026-10-02 22:01:33        INFO        MatrixCleaner::clean()         400      0.0143844      3.3664
02-Oct-2026 22:01:52 2026-10-02 22:01:33        INFO        MatrixCleaner::clean()         Reached stopping threshold 0.0118267 at iteration 505
02-Oct-2026 22:01:52 2026-10-02 22:01:33        INFO        MatrixCleaner::clean()         Optimum flux is 0.0117667
02-Oct-2026 22:01:52 2026-10-02 22:01:33        INFO        MatrixCleaner::clean()           0    0.0641231
02-Oct-2026 22:01:52 2026-10-02 22:01:33        INFO        MatrixCleaner::clean()           1    0.170624
02-Oct-2026 22:01:52 2026-10-02 22:01:33        INFO        MatrixCleaner::clean()           2    3.44997
02-Oct-2026 22:01:52 2026-10-02 22:01:33        INFO        MatrixCleaner::clean()           3    0.0269819
02-Oct-2026 22:01:52 2026-10-02 22:01:33        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->506 [506], model=0->3.71053, peakres=0.123931->0.0117667, Reached cyclethreshold.
02-Oct-2026 22:01:52 2026-10-02 22:01:33        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 506 iterations.
02-Oct-2026 22:01:52 2026-10-02 22:01:33        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]
02-Oct-2026 22:01:52 2026-10-02 22:01:34        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
02-Oct-2026 22:01:52 2026-10-02 22:01:34        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
02-Oct-2026 22:01:52 2026-10-02 22:01:34        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
02-Oct-2026 22:01:52 2026-10-02 22:01:34        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
02-Oct-2026 22:01:52 2026-10-02 22:01:34        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
02-Oct-2026 22:01:52 2026-10-02 22:01:34        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
02-Oct-2026 22:01:52 2026-10-02 22:01:34        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
02-Oct-2026 22:01:52 2026-10-02 22:01:34        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
02-Oct-2026 22:01:52 2026-10-02 22:01:34        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
02-Oct-2026 22:01:52
02-Oct-2026 22:01:52 0%....10....
02-Oct-2026 22:01:52 0%....10....20....30.
02-Oct-2026 22:01:52 0%....10....20....30..
02-Oct-2026 22:01:52 0%....10....20....30..
02-Oct-2026 22:01:52 0%....10....
02-Oct-2026 22:01:52 0%....10.....2020.20......40...40.40
02-Oct-2026 22:01:52 0%....10....20....30....40............30.....30......50...5050.50.30............40.40...........60.60.60.40...60..........50..50.........70...70....7070.50........60..60.........80.80...80.80.........60....70.....70.......90.90.9090.........100%
02-Oct-2026 22:01:52 ...100%
02-Oct-2026 22:01:52 70.80...100%
02-Oct-2026 22:01:52 .....100%
02-Oct-2026 22:01:52 .....80....9080......100%
02-Oct-2026 22:01:52 ...90.....100%
02-Oct-2026 22:01:52 .90....100%
02-Oct-2026 22:01:52 2026-10-02 22:01:52        INFO        tclean::::casa        ...done
02-Oct-2026 22:01:52 2026-10-02 22:01:52        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
02-Oct-2026 22:01:52 2026-10-02 22:01:52        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.0139507, over full image : 0.0139507
02-Oct-2026 22:01:52 2026-10-02 22:01:52        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 19494, 'cyclethreshold': 0.0013313069939613342, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
02-Oct-2026 22:01:52 2026-10-02 22:01:52        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.00133131, CycleNiter=19494, Gain=0.1
02-Oct-2026 22:01:52 2026-10-02 22:01:52        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
02-Oct-2026 22:01:52 2026-10-02 22:01:52        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
02-Oct-2026 22:01:52 2026-10-02 22:01:52        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
02-Oct-2026 22:01:52 2026-10-02 22:01:52        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
02-Oct-2026 22:01:52 2026-10-02 22:01:52        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
02-Oct-2026 22:01:52 2026-10-02 22:01:52        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
02-Oct-2026 22:01:52 2026-10-02 22:01:52        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
02-Oct-2026 22:01:52 2026-10-02 22:01:52        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
02-Oct-2026 22:01:52 2026-10-02 22:01:52        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
02-Oct-2026 22:01:52 2026-10-02 22:01:52        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
02-Oct-2026 22:01:52 2026-10-02 22:01:52        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
02-Oct-2026 22:01:52 2026-10-02 22:01:52        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
02-Oct-2026 22:01:52 2026-10-02 22:01:52        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
02-Oct-2026 22:01:52 2026-10-02 22:01:52        INFO        MatrixCleaner::clean()         Cleaning using given mask
02-Oct-2026 22:01:52 2026-10-02 22:01:52        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
02-Oct-2026 22:01:52 2026-10-02 22:01:52        INFO        MatrixCleaner::clean()         Starting iteration
02-Oct-2026 22:01:52 2026-10-02 22:01:52        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.0489674 within the mask
02-Oct-2026 22:02:12 2026-10-02 22:01:52        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
02-Oct-2026 22:02:12 2026-10-02 22:01:52        INFO        MatrixCleaner::clean()         Diverging due to large scale?
02-Oct-2026 22:02:12 2026-10-02 22:01:52        INFO        MatrixCleaner::clean()           0    0.00117514
02-Oct-2026 22:02:12 2026-10-02 22:01:52        INFO        MatrixCleaner::clean()           1    0.0082739
02-Oct-2026 22:02:12 2026-10-02 22:01:52        INFO        MatrixCleaner::clean()           2    0.257526
02-Oct-2026 22:02:12 2026-10-02 22:01:52        INFO        MatrixCleaner::clean()           3    0.0260557
02-Oct-2026 22:02:12 2026-10-02 22:01:52        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
02-Oct-2026 22:02:12 2026-10-02 22:01:52        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->74 [74], model=3.71053->3.97751, peakres=0.0139507->0.0111876, Exited multiscale minor cycle without reaching any stopping criterion.
02-Oct-2026 22:02:12 2026-10-02 22:01:52        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 580 iterations.
02-Oct-2026 22:02:12 2026-10-02 22:01:52        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]
02-Oct-2026 22:02:12 2026-10-02 22:01: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.n1.model
02-Oct-2026 22:02:12 2026-10-02 22:01: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.n2.model
02-Oct-2026 22:02:12 2026-10-02 22:01: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.n3.model
02-Oct-2026 22:02:12 2026-10-02 22:01: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.n4.model
02-Oct-2026 22:02:12 2026-10-02 22:01: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.n5.model
02-Oct-2026 22:02:12 2026-10-02 22:01: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
02-Oct-2026 22:02:12 2026-10-02 22:01: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
02-Oct-2026 22:02:12 2026-10-02 22:01:52        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
02-Oct-2026 22:02:12 2026-10-02 22:01:52        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
02-Oct-2026 22:02:12
02-Oct-2026 22:02:12 0%....10....20
02-Oct-2026 22:02:12 0%....10....20....30...
02-Oct-2026 22:02:12 0%....10....20
02-Oct-2026 22:02:12 0%....10....20
02-Oct-2026 22:02:12 0%....10....20....30...
02-Oct-2026 22:02:12 0%....10....20....30...
02-Oct-2026 22:02:12 0%....10....20....30........40.40...4040............30......30......50..5050..50.30..........40..40...........60.60.60.40...60..........50.50..........70...70....7070.50........6060...........80.80...80.80.........60....70.....70.......90..909090.........100%
02-Oct-2026 22:02:12 ...100%
02-Oct-2026 22:02:12 70.80...100%
02-Oct-2026 22:02:12 ......100%
02-Oct-2026 22:02:12 .....80...9080.....100%
02-Oct-2026 22:02:12 ....90.....100%
02-Oct-2026 22:02:12 .90....100%
02-Oct-2026 22:02:12 2026-10-02 22:02:10        INFO        tclean::::casa        ...done
02-Oct-2026 22:02:12 2026-10-02 22:02:10        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
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.0113207, over full image : 0.0113207
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 19420, 'cyclethreshold': 0.0010803299956023693, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.00108033, CycleNiter=19420, Gain=0.1
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        MatrixCleaner::clean()         Cleaning using given mask
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        MatrixCleaner::clean()         Starting iteration
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.264782 within the mask
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        MatrixCleaner::clean()         200      0.0247378      0.650537
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        MatrixCleaner::clean()         400      0.0193002      1.07716
02-Oct-2026 22:02:12 2026-10-02 22:02:11        INFO        MatrixCleaner::clean()         600      0.01604      1.39109
02-Oct-2026 22:02:12 2026-10-02 22:02:12        INFO        MatrixCleaner::clean()         800      0.0136018      1.6325
02-Oct-2026 22:02:12 2026-10-02 22:02:12        INFO        MatrixCleaner::clean()         1000      0.00400562      1.8299
02-Oct-2026 22:02:12 2026-10-02 22:02:12        INFO        MatrixCleaner::clean()         1200      0.00352989      1.99719
02-Oct-2026 22:02:12 2026-10-02 22:02:12        INFO        MatrixCleaner::clean()         1400      0.00313125      2.14576
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()         1600      0.00822065      2.28115
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()         1800      0.0073705      2.39586
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()         2000      0.00665978      2.491
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()           0    0.133816
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()           1    0.164411
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()           2    1.90829
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()           3    0.284476
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()         Failed to reach stopping threshold
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()         Cleaning using given mask
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()         Starting iteration
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.00226852 within the mask
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()         Diverging due to large scale?
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()           0    0.000226852
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()           1    0
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()           2    0.000666034
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        MatrixCleaner::clean()           3    0
02-Oct-2026 22:02:31 2026-10-02 22:02:13        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
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->2002 [2002], model=3.97751->6.46872, peakres=0.0113207->0.0113212, Possible divergence. Peak residual increased by 10% from minimum.
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 2582 iterations.
02-Oct-2026 22:02:31 2026-10-02 22:02:13        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]
02-Oct-2026 22:02:31 2026-10-02 22:02:13        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
02-Oct-2026 22:02:31 2026-10-02 22:02:13        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
02-Oct-2026 22:02:31 2026-10-02 22:02:13        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
02-Oct-2026 22:02:31 2026-10-02 22:02:13        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
02-Oct-2026 22:02:31 2026-10-02 22:02:13        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
02-Oct-2026 22:02:31 2026-10-02 22:02:13        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
02-Oct-2026 22:02:31 2026-10-02 22:02:13        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
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
02-Oct-2026 22:02:31 2026-10-02 22:02:13        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
02-Oct-2026 22:02:31
02-Oct-2026 22:02:31 0%....10....20
02-Oct-2026 22:02:31 0%....10....20
02-Oct-2026 22:02:31 0%....10....20....30....
02-Oct-2026 22:02:31 0%....10....20....30..
02-Oct-2026 22:02:31 0%....10....20
02-Oct-2026 22:02:31 0%....10....20....30...
02-Oct-2026 22:02:31 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........60.60........80..80....8080...........60..70.....70......90..90.9090........100%
02-Oct-2026 22:02:31 ....100%
02-Oct-2026 22:02:31 .70.80..100%
02-Oct-2026 22:02:31 .....100%
02-Oct-2026 22:02:31 .....80....9080......100%
02-Oct-2026 22:02:31 ..90......100%
02-Oct-2026 22:02:31 .90....100%
02-Oct-2026 22:02:31 2026-10-02 22:02:31        INFO        tclean::::casa        ...done
02-Oct-2026 22:02:31 2026-10-02 22:02: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
02-Oct-2026 22:02:31 2026-10-02 22:02:31        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00330019, over full image : 0.00573342
02-Oct-2026 22:02:31 2026-10-02 22:02:31        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 17418, 'cyclethreshold': 0.0010000000474974513, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': True}
02-Oct-2026 22:02:31 2026-10-02 22:02:31        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.001, CycleNiter=17418, Gain=0.1
02-Oct-2026 22:02:31 2026-10-02 22:02:31        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
02-Oct-2026 22:02:31 2026-10-02 22:02:32        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
02-Oct-2026 22:02:31 2026-10-02 22:02:32        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
02-Oct-2026 22:02:31 2026-10-02 22:02:32        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
02-Oct-2026 22:02:31 2026-10-02 22:02:32        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
02-Oct-2026 22:02:31 2026-10-02 22:02:32        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
02-Oct-2026 22:02:31 2026-10-02 22:02:32        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
02-Oct-2026 22:02:31 2026-10-02 22:02:32        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
02-Oct-2026 22:02:31 2026-10-02 22:02:32        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
02-Oct-2026 22:02:31 2026-10-02 22:02:32        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
02-Oct-2026 22:02:50 2026-10-02 22:02:32        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
02-Oct-2026 22:02:50 2026-10-02 22:02:32        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
02-Oct-2026 22:02:50 2026-10-02 22:02:32        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
02-Oct-2026 22:02:50 2026-10-02 22:02:32        INFO        MatrixCleaner::clean()         Cleaning using given mask
02-Oct-2026 22:02:50 2026-10-02 22:02:32        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
02-Oct-2026 22:02:50 2026-10-02 22:02:32        INFO        MatrixCleaner::clean()         Starting iteration
02-Oct-2026 22:02:50 2026-10-02 22:02:32        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.0127214 within the mask
02-Oct-2026 22:02:50 2026-10-02 22:02:32        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
02-Oct-2026 22:02:50 2026-10-02 22:02:32        INFO        MatrixCleaner::clean()         Diverging due to large scale?
02-Oct-2026 22:02:50 2026-10-02 22:02:32        INFO        MatrixCleaner::clean()           0    0
02-Oct-2026 22:02:50 2026-10-02 22:02:32        INFO        MatrixCleaner::clean()           1    0
02-Oct-2026 22:02:50 2026-10-02 22:02:32        INFO        MatrixCleaner::clean()           2    0.00739823
02-Oct-2026 22:02:50 2026-10-02 22:02:32        INFO        MatrixCleaner::clean()           3    0.00900338
02-Oct-2026 22:02:50 2026-10-02 22:02:32        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
02-Oct-2026 22:02:50 2026-10-02 22:02:32        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->7 [7], model=6.46873->6.47611, peakres=0.00330019->0.00319061, Exited multiscale minor cycle without reaching any stopping criterion.
02-Oct-2026 22:02:50 2026-10-02 22:02:32        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 2589 iterations.
02-Oct-2026 22:02:50 2026-10-02 22:02:32        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]
02-Oct-2026 22:02:50 2026-10-02 22:02:32        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
02-Oct-2026 22:02:50 2026-10-02 22:02:32        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
02-Oct-2026 22:02:50 2026-10-02 22:02:32        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
02-Oct-2026 22:02:50 2026-10-02 22:02:32        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
02-Oct-2026 22:02:50 2026-10-02 22:02:32        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
02-Oct-2026 22:02:50 2026-10-02 22:02:32        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
02-Oct-2026 22:02:50 2026-10-02 22:02:32        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
02-Oct-2026 22:02:50 2026-10-02 22:02:32        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
02-Oct-2026 22:02:50 2026-10-02 22:02:32        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
02-Oct-2026 22:02:50
02-Oct-2026 22:02:50 0%....10....20....30....40
02-Oct-2026 22:02:50 0%....10....20....30....
02-Oct-2026 22:02:50 0%....10....20....30....40
02-Oct-2026 22:02:50 0%....10....20....30....
02-Oct-2026 22:02:50 0%....10....20
02-Oct-2026 22:02:50 0%....10....20.
02-Oct-2026 22:02:50 0%....10....20...40..40...........30......30......5050..50...5030..........40..40...........60.60..60.40....60.......50.50..........70...70.....7070...50....60...60..........80....8080..80.........60..70.....70......90....909090.......100%
02-Oct-2026 22:02:50 ...70...100%
02-Oct-2026 22:02:50 80....100%
02-Oct-2026 22:02:50 .....100%
02-Oct-2026 22:02:50 .....80...90.80....100%
02-Oct-2026 22:02:50 ...90......100%
02-Oct-2026 22:02:50 .90....100%
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        tclean::::casa        ...done
02-Oct-2026 22:02:50 2026-10-02 22:02: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
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00319188, over full image : 0.00573304
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 17411, 'cyclethreshold': 0.0010000000474974513, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': True}
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.001, CycleNiter=17411, Gain=0.1
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        MatrixCleaner::clean()         Cleaning using given mask
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        MatrixCleaner::clean()         Starting iteration
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.0902081 within the mask
02-Oct-2026 22:02:50 2026-10-02 22:02:50        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
02-Oct-2026 22:03:11 2026-10-02 22:02:50        INFO        MatrixCleaner::clean()         200      0.00807465      0.25898
02-Oct-2026 22:03:11 2026-10-02 22:02:51        INFO        MatrixCleaner::clean()         400      0.00683434      0.425356
02-Oct-2026 22:03:11 2026-10-02 22:02:51        INFO        MatrixCleaner::clean()         600      0.00611194      0.55079
02-Oct-2026 22:03:11 2026-10-02 22:02:51        INFO        MatrixCleaner::clean()         800      0.00190047      0.649999
02-Oct-2026 22:03:11 2026-10-02 22:02:51        INFO        MatrixCleaner::clean()         1000      0.00514406      0.736802
02-Oct-2026 22:03:11 2026-10-02 22:02:52        INFO        MatrixCleaner::clean()         1200      0.0021316      0.812211
02-Oct-2026 22:03:11 2026-10-02 22:02:52        INFO        MatrixCleaner::clean()         1400      0.00442275      0.875158
02-Oct-2026 22:03:11 2026-10-02 22:02:52        INFO        MatrixCleaner::clean()         1600      0.00141233      0.933863
02-Oct-2026 22:03:11 2026-10-02 22:02:52        INFO        MatrixCleaner::clean()         1800      0.00132057      0.989256
02-Oct-2026 22:03:11 2026-10-02 22:02:52        INFO        MatrixCleaner::clean()         2000      0.00164392      1.03837
02-Oct-2026 22:03:11 2026-10-02 22:02:52        INFO        MatrixCleaner::clean()           0    0.0904452
02-Oct-2026 22:03:11 2026-10-02 22:02:52        INFO        MatrixCleaner::clean()           1    0.0555198
02-Oct-2026 22:03:11 2026-10-02 22:02:52        INFO        MatrixCleaner::clean()           2    0.67114
02-Oct-2026 22:03:11 2026-10-02 22:02:52        INFO        MatrixCleaner::clean()           3    0.221262
02-Oct-2026 22:03:11 2026-10-02 22:02:52        INFO        MatrixCleaner::clean()         Failed to reach stopping threshold
02-Oct-2026 22:03:11 2026-10-02 22:02:52        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
02-Oct-2026 22:03:11 2026-10-02 22:02:52        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
02-Oct-2026 22:03:11 2026-10-02 22:02:52        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
02-Oct-2026 22:03:11 2026-10-02 22:02:52        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
02-Oct-2026 22:03:11 2026-10-02 22:02:53        INFO        MatrixCleaner::clean()         Cleaning using given mask
02-Oct-2026 22:03:11 2026-10-02 22:02:53        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
02-Oct-2026 22:03:11 2026-10-02 22:02:53        INFO        MatrixCleaner::clean()         Starting iteration
02-Oct-2026 22:03:11 2026-10-02 22:02:53        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.00364809 within the mask
02-Oct-2026 22:03:11 2026-10-02 22:02:53        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
02-Oct-2026 22:03:11 2026-10-02 22:02:53        INFO        MatrixCleaner::clean()         Diverging due to large scale?
02-Oct-2026 22:03:11 2026-10-02 22:02:53        INFO        MatrixCleaner::clean()           0    0.00160586
02-Oct-2026 22:03:11 2026-10-02 22:02:53        INFO        MatrixCleaner::clean()           1    0.000327359
02-Oct-2026 22:03:11 2026-10-02 22:02:53        INFO        MatrixCleaner::clean()           2    0.00617268
02-Oct-2026 22:03:11 2026-10-02 22:02:53        INFO        MatrixCleaner::clean()           3    0.00273267
02-Oct-2026 22:03:11 2026-10-02 22:02:53        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
02-Oct-2026 22:03:11 2026-10-02 22:02:53        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->2039 [2039], model=6.47613->7.52258, peakres=0.00319188->0.00316411, Possible divergence. Peak residual increased by 10% from minimum.
02-Oct-2026 22:03:11 2026-10-02 22:02:53        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 4628 iterations.
02-Oct-2026 22:03:11 2026-10-02 22:02:53        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]
02-Oct-2026 22:03:11 2026-10-02 22:02:53        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
02-Oct-2026 22:03:11 2026-10-02 22:02:53        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
02-Oct-2026 22:03:11 2026-10-02 22:02:53        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
02-Oct-2026 22:03:11 2026-10-02 22:02:53        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
02-Oct-2026 22:03:11 2026-10-02 22:02:53        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
02-Oct-2026 22:03:11 2026-10-02 22:02:53        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
02-Oct-2026 22:03:11 2026-10-02 22:02:53        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
02-Oct-2026 22:03:11 2026-10-02 22:02:53        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
02-Oct-2026 22:03:11 2026-10-02 22:02:53        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
02-Oct-2026 22:03:11
02-Oct-2026 22:03:11 0%....10....20.
02-Oct-2026 22:03:11 0%....10....20....30....
02-Oct-2026 22:03:11 0%....10....20....30....
02-Oct-2026 22:03:11 0%....10....20....30....40
02-Oct-2026 22:03:11 0%....10....20.
02-Oct-2026 22:03:11 0%....10....20....30....40
02-Oct-2026 22:03:11 0%....10....20.40...40...........30.....30.......50.50.50...50.30.........40..40...........60.60.60...40...60.......50..50.........70....70....7070..50......60...60.........80..80..80.80...........60..70...70........90...909090........100%
02-Oct-2026 22:03:11 .....100%
02-Oct-2026 22:03:11 7080....100%
02-Oct-2026 22:03:11 ...100%
02-Oct-2026 22:03:11 ......80....90.80.....100%
02-Oct-2026 22:03:11 ..90......100%
02-Oct-2026 22:03:11 .90....100%
02-Oct-2026 22:03:11 2026-10-02 22:03:11        INFO        tclean::::casa        ...done
02-Oct-2026 22:03:11 2026-10-02 22:03: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
02-Oct-2026 22:03:11 2026-10-02 22:03:11        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00165737, over full image : 0.00416103
02-Oct-2026 22:03:11 2026-10-02 22:03:11        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 15372, 'cyclethreshold': 0.0010000000474974513, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': True}
02-Oct-2026 22:03:11 2026-10-02 22:03:11        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.001, CycleNiter=15372, Gain=0.1
02-Oct-2026 22:03:11 2026-10-02 22:03:11        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
02-Oct-2026 22:03:11 2026-10-02 22:03:11        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        MatrixCleaner::clean()         Cleaning using given mask
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        MatrixCleaner::clean()         Starting iteration
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.00611654 within the mask
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        MatrixCleaner::clean()         Diverging due to large scale?
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        MatrixCleaner::clean()           0    0
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        MatrixCleaner::clean()           1    0
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        MatrixCleaner::clean()           2    0.00119706
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        MatrixCleaner::clean()           3    0.00439182
02-Oct-2026 22:03:29 2026-10-02 22:03:11        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
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->3 [3], model=7.52261->7.52378, peakres=0.00165737->0.00164932, Exited multiscale minor cycle without reaching any stopping criterion.
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 4631 iterations.
02-Oct-2026 22:03:29 2026-10-02 22:03: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]
02-Oct-2026 22:03:29 2026-10-02 22:03: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
02-Oct-2026 22:03:29 2026-10-02 22:03: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
02-Oct-2026 22:03:29 2026-10-02 22:03: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
02-Oct-2026 22:03:29 2026-10-02 22:03: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
02-Oct-2026 22:03:29 2026-10-02 22:03: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.n5.model
02-Oct-2026 22:03:29 2026-10-02 22:03: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.n6.model
02-Oct-2026 22:03:29 2026-10-02 22:03: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.n7.model
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
02-Oct-2026 22:03:29 2026-10-02 22:03:11        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
02-Oct-2026 22:03:29
02-Oct-2026 22:03:29 0%....10....20
02-Oct-2026 22:03:29 0%....10....20....30...
02-Oct-2026 22:03:29 0%....10....20
02-Oct-2026 22:03:29 0%....10....20
02-Oct-2026 22:03:29 0%....10....20....30...
02-Oct-2026 22:03:29 0%....10....20....30...
02-Oct-2026 22:03:29 0%....10....20....30.........4040.40...40............30.......30..50.50...5050....30...........40.40..........6060..60..40..60..........50.50.........70....70...70.70.50..........6060.........8080....80.80...........60..70......70.....90..90.9090.......100%
02-Oct-2026 22:03:29 ......100%
02-Oct-2026 22:03:29 7080...100%
02-Oct-2026 22:03:29 ....100%
02-Oct-2026 22:03:29 .......80...9080.....100%
02-Oct-2026 22:03:29 ....90.....100%
02-Oct-2026 22:03:29 .90....100%
02-Oct-2026 22:03:29 2026-10-02 22:03:29        INFO        tclean::::casa        ...done
02-Oct-2026 22:03:29 2026-10-02 22:03:29        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
02-Oct-2026 22:03:29 2026-10-02 22:03:30        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00164955, over full image : 0.00417018
02-Oct-2026 22:03:29 2026-10-02 22:03:30        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 15369, 'cyclethreshold': 0.0010000000474974513, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': True}
02-Oct-2026 22:03:29 2026-10-02 22:03:30        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.001, CycleNiter=15369, Gain=0.1
02-Oct-2026 22:03:29 2026-10-02 22:03:30        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
02-Oct-2026 22:03:29 2026-10-02 22:03:30        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
02-Oct-2026 22:03:29 2026-10-02 22:03:30        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
02-Oct-2026 22:03:29 2026-10-02 22:03:30        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
02-Oct-2026 22:03:29 2026-10-02 22:03:30        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
02-Oct-2026 22:03:29 2026-10-02 22:03:30        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
02-Oct-2026 22:03:29 2026-10-02 22:03:30        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
02-Oct-2026 22:03:29 2026-10-02 22:03:30        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
02-Oct-2026 22:03:29 2026-10-02 22:03:30        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
02-Oct-2026 22:03:49 2026-10-02 22:03:30        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
02-Oct-2026 22:03:49 2026-10-02 22:03:30        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
02-Oct-2026 22:03:49 2026-10-02 22:03:30        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
02-Oct-2026 22:03:49 2026-10-02 22:03:30        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
02-Oct-2026 22:03:49 2026-10-02 22:03:30        INFO        MatrixCleaner::clean()         Cleaning using given mask
02-Oct-2026 22:03:49 2026-10-02 22:03:30        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
02-Oct-2026 22:03:49 2026-10-02 22:03:30        INFO        MatrixCleaner::clean()         Starting iteration
02-Oct-2026 22:03:49 2026-10-02 22:03:30        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.0439545 within the mask
02-Oct-2026 22:03:49 2026-10-02 22:03:30        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
02-Oct-2026 22:03:49 2026-10-02 22:03:30        INFO        MatrixCleaner::clean()         200      0.00421756      0.137474
02-Oct-2026 22:03:49 2026-10-02 22:03:30        INFO        MatrixCleaner::clean()         400      0.00376598      0.224474
02-Oct-2026 22:03:49 2026-10-02 22:03:30        INFO        MatrixCleaner::clean()         600      0.00347909      0.292141
02-Oct-2026 22:03:49 2026-10-02 22:03:31        INFO        MatrixCleaner::clean()         800      0.00324404      0.347883
02-Oct-2026 22:03:49 2026-10-02 22:03:31        INFO        MatrixCleaner::clean()         1000      0.00103649      0.389349
02-Oct-2026 22:03:49 2026-10-02 22:03:31        INFO        MatrixCleaner::clean()         Reached stopping threshold 0.001 at iteration 1138
02-Oct-2026 22:03:49 2026-10-02 22:03:31        INFO        MatrixCleaner::clean()         Optimum flux is 0.000997873
02-Oct-2026 22:03:49 2026-10-02 22:03:31        INFO        MatrixCleaner::clean()           0    0.0427511
02-Oct-2026 22:03:49 2026-10-02 22:03:31        INFO        MatrixCleaner::clean()           1    0.0178992
02-Oct-2026 22:03:49 2026-10-02 22:03:31        INFO        MatrixCleaner::clean()           2    0.228908
02-Oct-2026 22:03:49 2026-10-02 22:03:31        INFO        MatrixCleaner::clean()           3    0.131411
02-Oct-2026 22:03:49 2026-10-02 22:03:31        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->1139 [1139], model=7.5238->7.94464, peakres=0.00164955->0.000997874, Reached cyclethreshold.
02-Oct-2026 22:03:49 2026-10-02 22:03:31        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 5770 iterations.
02-Oct-2026 22:03:49 2026-10-02 22:03: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]
02-Oct-2026 22:03:49 2026-10-02 22:03: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
02-Oct-2026 22:03:49 2026-10-02 22:03: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
02-Oct-2026 22:03:49 2026-10-02 22:03: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
02-Oct-2026 22:03:49 2026-10-02 22:03: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
02-Oct-2026 22:03:49 2026-10-02 22:03: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
02-Oct-2026 22:03:49 2026-10-02 22:03: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
02-Oct-2026 22:03:49 2026-10-02 22:03: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
02-Oct-2026 22:03:49 2026-10-02 22:03:31        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
02-Oct-2026 22:03:49 2026-10-02 22:03:31        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
02-Oct-2026 22:03:49
02-Oct-2026 22:03:49 0%....10....20....30...
02-Oct-2026 22:03:49 0%....10....20
02-Oct-2026 22:03:49 0%....10....20
02-Oct-2026 22:03:49 0%....10....20
02-Oct-2026 22:03:49 0%....10....20....30...
02-Oct-2026 22:03:49 0%....10....20....30...
02-Oct-2026 22:03:49 0%....10....20....30.........4040.40..40............30.....30........5050.50..5030............40.40...........60.60.6040....60........50....50.........70...70....7070.50........60..60.........80.80...80.80.........60....70....70........90.90.9090.........100%
02-Oct-2026 22:03:49 70....100%
02-Oct-2026 22:03:49 80....100%
02-Oct-2026 22:03:49 ....100%
02-Oct-2026 22:03:49 .....80....9080......100%
02-Oct-2026 22:03:49 ...90.....100%
02-Oct-2026 22:03:49 .90....100%
02-Oct-2026 22:03:49 2026-10-02 22:03:49        INFO        tclean::::casa        ...done
02-Oct-2026 22:03:49 2026-10-02 22:03: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
02-Oct-2026 22:03:49 2026-10-02 22:03:49        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00115385, over full image : 0.00358587
02-Oct-2026 22:03:49 2026-10-02 22:03:49        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 14230, 'cyclethreshold': 0.0010000000474974513, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': True}
02-Oct-2026 22:03:49 2026-10-02 22:03:49        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.001, CycleNiter=14230, Gain=0.1
02-Oct-2026 22:03:49 2026-10-02 22:03:50        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
02-Oct-2026 22:03:49 2026-10-02 22:03:50        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
02-Oct-2026 22:03:49 2026-10-02 22:03:50        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
02-Oct-2026 22:03:49 2026-10-02 22:03:50        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
02-Oct-2026 22:03:49 2026-10-02 22:03:50        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
02-Oct-2026 22:03:49 2026-10-02 22:03:50        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
02-Oct-2026 22:03:49 2026-10-02 22:03:50        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
02-Oct-2026 22:03:49 2026-10-02 22:03:50        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
02-Oct-2026 22:03:49 2026-10-02 22:03:50        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
02-Oct-2026 22:03:49 2026-10-02 22:03:50        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
02-Oct-2026 22:03:49 2026-10-02 22:03:50        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
02-Oct-2026 22:03:49 2026-10-02 22:03:50        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
02-Oct-2026 22:03:49 2026-10-02 22:03:50        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
02-Oct-2026 22:03:49 2026-10-02 22:03:50        INFO        MatrixCleaner::clean()         Cleaning using given mask
02-Oct-2026 22:04:08 2026-10-02 22:03:50        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
02-Oct-2026 22:04:08 2026-10-02 22:03:50        INFO        MatrixCleaner::clean()         Starting iteration
02-Oct-2026 22:04:08 2026-10-02 22:03:50        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.00390444 within the mask
02-Oct-2026 22:04:08 2026-10-02 22:03:50        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
02-Oct-2026 22:04:08 2026-10-02 22:03:50        INFO        MatrixCleaner::clean()         Diverging due to large scale?
02-Oct-2026 22:04:08 2026-10-02 22:03:50        INFO        MatrixCleaner::clean()           0    0
02-Oct-2026 22:04:08 2026-10-02 22:03:50        INFO        MatrixCleaner::clean()           1    0
02-Oct-2026 22:04:08 2026-10-02 22:03:50        INFO        MatrixCleaner::clean()           2    0.00225037
02-Oct-2026 22:04:08 2026-10-02 22:03:50        INFO        MatrixCleaner::clean()           3    0.00278148
02-Oct-2026 22:04:08 2026-10-02 22:03:50        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
02-Oct-2026 22:04:08 2026-10-02 22:03:50        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->7 [7], model=7.94467->7.94688, peakres=0.00115385->0.00113489, Exited multiscale minor cycle without reaching any stopping criterion.
02-Oct-2026 22:04:08 2026-10-02 22:03:50        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 5777 iterations.
02-Oct-2026 22:04:08 2026-10-02 22:03:50        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]
02-Oct-2026 22:04:08 2026-10-02 22:03:50        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
02-Oct-2026 22:04:08 2026-10-02 22:03:50        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
02-Oct-2026 22:04:08 2026-10-02 22:03:50        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
02-Oct-2026 22:04:08 2026-10-02 22:03:50        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
02-Oct-2026 22:04:08 2026-10-02 22:03:50        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
02-Oct-2026 22:04:08 2026-10-02 22:03:50        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
02-Oct-2026 22:04:08 2026-10-02 22:03:50        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
02-Oct-2026 22:04:08 2026-10-02 22:03:50        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
02-Oct-2026 22:04:08 2026-10-02 22:03:50        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
02-Oct-2026 22:04:08
02-Oct-2026 22:04:08 0%....10....20.
02-Oct-2026 22:04:08 0%....10....20.
02-Oct-2026 22:04:08 0%....10....20....30....40
02-Oct-2026 22:04:08 0%....10....20
02-Oct-2026 22:04:08 0%....10....20....30....
02-Oct-2026 22:04:08 0%....10....20....30....40
02-Oct-2026 22:04:08 0%....10....20....30.....40...40...........30.......30......50.505030..50............40..40..........60.60.40.60....60.........50..50........70....70....707050..........60.60........80..80....80.80.......60.....70......70....90...90.9090.....100%
02-Oct-2026 22:04:08 ...70....100%
02-Oct-2026 22:04:08 .80....100%
02-Oct-2026 22:04:08 ....100%
02-Oct-2026 22:04:08 ......80...9080......100%
02-Oct-2026 22:04:08 ...90......100%
02-Oct-2026 22:04:08 90....100%
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        tclean::::casa        ...done
02-Oct-2026 22:04:08 2026-10-02 22:04: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
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00113663, over full image : 0.00359494
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 14223, 'cyclethreshold': 0.0010000000474974513, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': True}
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.001, CycleNiter=14223, Gain=0.1
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        MatrixCleaner::clean()         Cleaning using given mask
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        MatrixCleaner::clean()         Starting iteration
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.0278256 within the mask
02-Oct-2026 22:04:08 2026-10-02 22:04:08        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
02-Oct-2026 22:04:08 2026-10-02 22:04:09        INFO        MatrixCleaner::clean()         200      0.00301924      0.0897329
02-Oct-2026 22:04:08 2026-10-02 22:04:09        INFO        MatrixCleaner::clean()         Reached stopping threshold 0.001 at iteration 273
02-Oct-2026 22:04:08 2026-10-02 22:04:09        INFO        MatrixCleaner::clean()         Optimum flux is 0.000998931
02-Oct-2026 22:04:08 2026-10-02 22:04:09        INFO        MatrixCleaner::clean()           0    0.00602461
02-Oct-2026 22:04:27 2026-10-02 22:04:09        INFO        MatrixCleaner::clean()           1    0.00234237
02-Oct-2026 22:04:27 2026-10-02 22:04:09        INFO        MatrixCleaner::clean()           2    0.0573979
02-Oct-2026 22:04:27 2026-10-02 22:04:09        INFO        MatrixCleaner::clean()           3    0.0485432
02-Oct-2026 22:04:27 2026-10-02 22:04:09        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->274 [274], model=7.94692->8.06104, peakres=0.00113663->0.000998932, Reached cyclethreshold.
02-Oct-2026 22:04:27 2026-10-02 22:04:09        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 6051 iterations.
02-Oct-2026 22:04:27 2026-10-02 22:04:09        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]
02-Oct-2026 22:04:27 2026-10-02 22:04:09        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
02-Oct-2026 22:04:27 2026-10-02 22:04:09        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
02-Oct-2026 22:04:27 2026-10-02 22:04:09        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
02-Oct-2026 22:04:27 2026-10-02 22:04:09        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
02-Oct-2026 22:04:27 2026-10-02 22:04:09        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
02-Oct-2026 22:04:27 2026-10-02 22:04:09        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
02-Oct-2026 22:04:27 2026-10-02 22:04:09        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
02-Oct-2026 22:04:27 2026-10-02 22:04:09        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
02-Oct-2026 22:04:27 2026-10-02 22:04:09        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
02-Oct-2026 22:04:27
02-Oct-2026 22:04:27 0%....10....20....30....40
02-Oct-2026 22:04:27 0%....10....20.
02-Oct-2026 22:04:27 0%....10....20....30....
02-Oct-2026 22:04:27 0%....10....20.
02-Oct-2026 22:04:27 0%....10....20.
02-Oct-2026 22:04:27 0%....10....20....30....
02-Oct-2026 22:04:27 0%....10....20....30....40.40..40...........30......30.......50.5050.30.50............40..40..........60.60.40.60.....60........50..50........70....70....7070.50.........6060.........80..80....8080.........60...70.......70....90....909090......100%
02-Oct-2026 22:04:27 ...70...100%
02-Oct-2026 22:04:27 .80...100%
02-Oct-2026 22:04:27 ......100%
02-Oct-2026 22:04:27 .....80...9080.....100%
02-Oct-2026 22:04:27 ....90......100%
02-Oct-2026 22:04:27 90....100%
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        tclean::::casa        ...done
02-Oct-2026 22:04:27 2026-10-02 22:04:27        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
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00102517, over full image : 0.00342835
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 13949, 'cyclethreshold': 0.0010000000474974513, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': True}
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.001, CycleNiter=13949, Gain=0.1
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::clean()         Cleaning using given mask
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::clean()         Starting iteration
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.00310325 within the mask
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::clean()         Diverging due to large scale?
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::clean()           0    0
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::clean()           1    0
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::clean()           2    0.000926441
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        MatrixCleaner::clean()           3    0.00233484
02-Oct-2026 22:04:27 2026-10-02 22:04:27        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
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->4 [4], model=8.06113->8.06196, peakres=0.00102517->0.00103213, Exited multiscale minor cycle without reaching any stopping criterion.
02-Oct-2026 22:04:27 2026-10-02 22:04:27        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 6055 iterations.
02-Oct-2026 22:04:46 2026-10-02 22:04:27        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]
02-Oct-2026 22:04:46 2026-10-02 22:04:27        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
02-Oct-2026 22:04:46 2026-10-02 22:04:27        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
02-Oct-2026 22:04:46 2026-10-02 22:04:27        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
02-Oct-2026 22:04:46 2026-10-02 22:04:27        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
02-Oct-2026 22:04:46 2026-10-02 22:04:27        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
02-Oct-2026 22:04:46 2026-10-02 22:04:27        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
02-Oct-2026 22:04:46 2026-10-02 22:04:27        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
02-Oct-2026 22:04:46 2026-10-02 22:04:27        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
02-Oct-2026 22:04:46 2026-10-02 22:04:27        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
02-Oct-2026 22:04:46
02-Oct-2026 22:04:46 0%....10....20
02-Oct-2026 22:04:46 0%....10....20
02-Oct-2026 22:04:46 0%....10....20....30...
02-Oct-2026 22:04:46 0%....10....20
02-Oct-2026 22:04:46 0%....10....20....30..
02-Oct-2026 22:04:46 0%....10....20....30...
02-Oct-2026 22:04:46 0%....10....20....30.........40.40..40.40............30.....30......50...5050.50.30............40.40...........60.60.60.40...60..........50..50.........70...70....7070.50........60..60.........80.80...80.80.........60....70.....70......90..90.9090........100%
02-Oct-2026 22:04:46 .70...100%
02-Oct-2026 22:04:46 .80...100%
02-Oct-2026 22:04:46 .....100%
02-Oct-2026 22:04:46 .....80....9080......100%
02-Oct-2026 22:04:46 ...90.....100%
02-Oct-2026 22:04:46 .90....100%
02-Oct-2026 22:04:46 2026-10-02 22:04:45        INFO        tclean::::casa        ...done
02-Oct-2026 22:04:46 2026-10-02 22:04:46        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
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00103202, over full image : 0.00343162
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 13945, 'cyclethreshold': 0.0010000000474974513, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': True}
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] Run multiscale minor-cycle | CycleThreshold=0.001, CycleNiter=13945, Gain=0.1
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [240, 240]
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 0
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 1
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 2
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::makePsfScales()         Calculating convolutions for scale 3
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 0
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 1
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 2
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::makeScaleMasks()         Calculating mask convolution for scale 3
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::clean()         scale 1 = 0 pixels with bias = 1
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::clean()         scale 2 = 5 pixels with bias = 0.9
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::clean()         scale 3 = 15 pixels with bias = 0.7
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::clean()         scale 4 = 45 pixels with bias = 0.1
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::clean()         Cleaning using given mask
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::clean()         Cleaning pixels with mask values above 0.9
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::clean()         Starting iteration
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::clean()         Initial maximum residual is 0.0233413 within the mask
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::clean()         iteration    MaximumResidual   CleanedFlux
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::clean()         Reached stopping threshold 0.001 at iteration 73
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::clean()         Optimum flux is 0.000999513
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::clean()           0    0.0018235
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::clean()           1    0.000401149
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::clean()           2    0.0138873
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        MatrixCleaner::clean()           3    0.0159111
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        SDAlgorithmBase::deconvolve         [3c391_ctm_spw0_multiscale] iters=0->74 [74], model=8.06206->8.09389, peakres=0.00103202->0.000999513, Reached cyclethreshold.
02-Oct-2026 22:04:46 2026-10-02 22:04:46        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 6129 iterations.
02-Oct-2026 22:04:46 2026-10-02 22:04:46        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]
02-Oct-2026 22:04:46 2026-10-02 22:04:46        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
02-Oct-2026 22:04:46 2026-10-02 22:04:46        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
02-Oct-2026 22:05:26 2026-10-02 22:04:46        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
02-Oct-2026 22:05:26 2026-10-02 22:04:46        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
02-Oct-2026 22:05:26 2026-10-02 22:04:46        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
02-Oct-2026 22:05:26 2026-10-02 22:04:46        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
02-Oct-2026 22:05:26 2026-10-02 22:04:46        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
02-Oct-2026 22:05:26 2026-10-02 22:04:46        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
02-Oct-2026 22:05:26 2026-10-02 22:04:46        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
02-Oct-2026 22:05:26
02-Oct-2026 22:05:26 0%....10....20
02-Oct-2026 22:05:26 0%....10....20
02-Oct-2026 22:05:26 0%....10....20....30...
02-Oct-2026 22:05:26 0%....10....20
02-Oct-2026 22:05:26 0%....10....20....30...
02-Oct-2026 22:05:26 0%....10....20....30....
02-Oct-2026 22:05:26 0%....10....20....30.......40.40.40...40...........30......30......50.50.50..5030............40..40..........60.60..60.40..60..........50.50.........70....70....7070.50.........60.60.........80.80...80.80..........60...70......70.....90...909090.......100%
02-Oct-2026 22:05:26 .....100%
02-Oct-2026 22:05:26 .7080...100%
02-Oct-2026 22:05:26 .....100%
02-Oct-2026 22:05:26 ......80...9080.....100%
02-Oct-2026 22:05:26 ....90.....100%
02-Oct-2026 22:05:26 .90....100%
02-Oct-2026 22:05:26 2026-10-02 22:05:04        INFO        tclean::::casa        ...done
02-Oct-2026 22:05:26 2026-10-02 22:05:04        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
02-Oct-2026 22:05:26 2026-10-02 22:05:04        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00100932, over full image : 0.00337241
02-Oct-2026 22:05:26 2026-10-02 22:05:04        INFO        tclean::::casa        Reached global stopping criterion : threshold
02-Oct-2026 22:05:26 2026-10-02 22:05:04        INFO        tclean::::casa        getSummary call: fullsummary=False
02-Oct-2026 22:05:26 2026-10-02 22:05:04        INFO        SDAlgorithmBase::restore         [3c391_ctm_spw0_multiscale] : Restoring model image.
02-Oct-2026 22:05:26 2026-10-02 22:05:04        INFO        SIImageStore::restore         Beam for chan : 0 : 17.0639 arcsec, 14.9556 arcsec, 21.6316 deg
02-Oct-2026 22:05:26 2026-10-02 22:05:25        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        tclean::::casa        ...done
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        tclean::::casa        Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed.
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        tclean::::casa        Searching for images with prefix '3c391_ctm_spw0_multiscale'... Found these, writing history into them: ['3c391_ctm_spw0_multiscale.sumwt', '3c391_ctm_spw0_multiscale.pb', '3c391_ctm_spw0_multiscale.mask', '3c391_ctm_spw0_multiscale.psf', '3c391_ctm_spw0_multiscale.weight', '3c391_ctm_spw0_multiscale.residual', '3c391_ctm_spw0_multiscale.gridwt_moswt', '3c391_ctm_spw0_multiscale.model', '3c391_ctm_spw0_multiscale.image']
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        tclean::::casa        Task tclean complete. Start time: 2026-10-02 22:00:25.232392 End time: 2026-10-02 22:05:26.155836
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        tclean::::casa        ##### End Task: tclean               #####
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        tclean::::casa        ##########################################
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        impbcor::::casa        ##########################################
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        impbcor::::casa        ##### Begin Task: impbcor            #####
02-Oct-2026 22:05:26 2026-10-02 22:05:26        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 )
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        impbcor::CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        impbcor::CasacRegionManager::fromBCS        Using all spectral channels.
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        impbcor::CasacRegionManager::fromBCS        Using polarizations ALL
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        impbcor::ImageRegion::fromRecord        Selected bounding box :
02-Oct-2026 22:05:26 2026-10-02 22:05:26        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)
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        impbcor::ImageRegion::fromRecord        Selected bounding box :
02-Oct-2026 22:05:26 2026-10-02 22:05:26        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)
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        impbcor::SubImageFactory::createImage        Creating image '3c391_ctm_spw0_multiscale.pbcorimage' of shape [480, 480, 1, 1]
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        impbcor::ImageMaskAttacher::makeMask        Created mask `mask0'
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        impbcor::::casa        Task impbcor complete. Start time: 2026-10-02 22:05:26.162188 End time: 2026-10-02 22:05:26.284925
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        impbcor::::casa        ##### End Task: impbcor              #####
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        impbcor::::casa        ##########################################
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::casa        ##########################################
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::casa        ##### Begin Task: imstat             #####
02-Oct-2026 22:05:26 2026-10-02 22:05:26        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 )
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::CasacRegionManager::fromBCS        Using all spectral channels.
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::CasacRegionManager::fromBCS        Using polarizations ALL
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::image::statistics         Determining stats for image 3c391_ctm_spw0_multiscale.pbcorimage
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageRegion::fromRecord        Selected bounding box :
02-Oct-2026 22:05:26 2026-10-02 22:05:26        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)
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::_logStartup        Statistics calculated using Classic algorithm
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::_logStartup        Regions ---
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::_logStartup                 -- bottom-left corner (pixel) [blc]:  [0, 0, 0, 0]
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::_logStartup                 -- top-right corner (pixel) [trc]:    [479, 479, 0, 0]
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::_logStartup                 -- bottom-left corner (world) [blcf]: 18:50:04.251, -01.05.40.567, I, 4.59835e+09Hz
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::_logStartup                 -- top-right corner (world) [trcf]:   18:48:44.407, -00.45.43.065, I, 4.59835e+09Hz
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::        Values ---
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                 -- flux density [flux]:                    9.38568 Jy
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                 -- number of points [npts]:                115808
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                 -- maximum value [max]:                    0.155552 Jy/beam
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                 -- minimum value [min]:                    -0.0064779 Jy/beam
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                 -- position of max value (pixel) [maxpos]: [288, 256, 0, 0]
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                 -- position of min value (pixel) [minpos]: [70, 141, 0, 0]
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                 -- position of max value (world) [maxposf]: 18:49:16.243, -00.55.00.579, I, 4.59835e+09Hz
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                 -- position of min value (world) [minposf]: 18:49:52.582, -00.59.48.073, I, 4.59835e+09Hz
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                 -- Sum of pixel values [sum]:               434.244 Jy/beam
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                 -- Sum of squared pixel values [sumsq]:     17.8609 Jy/beam.Jy/beam
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::        Statistics ---
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                -- Mean of the pixel values [mean]:         0.00374969 Jy/beam
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                -- Variance of the pixel values :           0.00014017 Jy/beam
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                -- Standard deviation of the Mean [sigma]:  0.0118393 Jy/beam
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                -- Root mean square [rms]:                  0.0124189 Jy/beam
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                -- Median of the pixel values [median]:     0.000433106 Jy/beam
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                -- Median of the deviations [medabsdevmed]: 0.00135104 Jy/beam
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                -- IQR [quartile]:                          0.00292432 Jy/beam
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                -- First quartile [q1]:                     -0.000746207 Jy/beam
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                -- Third quartile [q3]:                     0.00217812 Jy/beam
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::statistics        Sum column unit = Jy/beam
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::statistics+        Mean column unit = Jy/beam
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::statistics+        Std_dev column unit = Jy/beam
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::statistics+        Minimum column unit = Jy/beam
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::statistics+        Maximum column unit = Jy/beam
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::statistics        Npts          Sum           Mean          Rms           Std_dev       Minimum       Maximum     
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::statistics         1.158080e+05  4.342437e+02  3.749686e-03  1.241888e-02  1.183933e-02 -6.477905e-03  1.555524e-01
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::casa        Task imstat complete. Start time: 2026-10-02 22:05:26.290249 End time: 2026-10-02 22:05:26.307287
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::casa        ##### End Task: imstat               #####
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::casa        ##########################################
02-Oct-2026 22:05:26 Expected image peak at pixels [288 256], got [288 256], tolerance exact
02-Oct-2026 22:05:26 Expected pbcor image peak of 0.15553903579711914, got 0.15555235743522644, tolerance 4.0%
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::casa        ##########################################
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::casa        ##### Begin Task: imstat             #####
02-Oct-2026 22:05:26 2026-10-02 22:05:26        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 )
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::RegionTextParser::_determineVersion        RegionTextParser::_determineVersion: Found spec version 0
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::AsciiRegionFileParser::_parse        Combined 1 image regions (which excludes any annotation regions)
02-Oct-2026 22:05:26 2026-10-02 22:05:26        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).
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::CasacRegionManager::fromBCS        Region read from CRTF file 3c391_clean_mask.crtf
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::image::statistics         Determining stats for image 3c391_ctm_spw0_multiscale.residual
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageRegion::fromRecord        Selected bounding box :
02-Oct-2026 22:05:26 2026-10-02 22:05:26        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)
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::_logStartup        Statistics calculated using Classic algorithm
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::_logStartup        Regions ---
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::_logStartup                 -- bottom-left corner (pixel) [blc]:  [140, 145, 0, 0]
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::_logStartup                 -- top-right corner (pixel) [trc]:    [316, 315, 0, 0]
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::_logStartup                 -- bottom-left corner (world) [blcf]: 18:49:40.913, -00.59.38.078, I, 4.59835e+09Hz
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::_logStartup                 -- top-right corner (world) [trcf]:   18:49:11.576, -00.52.33.079, I, 4.59835e+09Hz
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::        Values ---
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                 -- number of points [npts]:                19718
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                 -- maximum value [max]:                    0.00100932
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                 -- minimum value [min]:                    -0.000927068
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                 -- position of max value (pixel) [maxpos]: [271, 262, 0, 0]
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                 -- position of min value (pixel) [minpos]: [292, 235, 0, 0]
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                 -- position of max value (world) [maxposf]: 18:49:19.077, -00.54.45.580, I, 4.59835e+09Hz
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                 -- position of min value (world) [minposf]: 18:49:15.576, -00.55.53.079, I, 4.59835e+09Hz
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                 -- Sum of pixel values [sum]:               8.2566
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                 -- Sum of squared pixel values [sumsq]:     0.00574812
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::        Statistics ---
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                -- Mean of the pixel values [mean]:         0.000418734
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                -- Variance of the pixel values :           1.16184e-07
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                -- Standard deviation of the Mean [sigma]:  0.000340858
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                -- Root mean square [rms]:                  0.000539923
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                -- Median of the pixel values [median]:     0.000457813
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                -- Median of the deviations [medabsdevmed]: 0.000227509
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                -- IQR [quartile]:                          0.000456822
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                -- First quartile [q1]:                     0.000222317
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::::                -- Third quartile [q3]:                     0.000679139
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::statistics        Sum column unit =
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::statistics+        Mean column unit =
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::statistics+        Std_dev column unit =
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::statistics+        Minimum column unit =
02-Oct-2026 22:05:26 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::statistics+        Maximum column unit =
02-Oct-2026 22:05:46 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::statistics        Npts          Sum           Mean          Rms           Std_dev       Minimum       Maximum     
02-Oct-2026 22:05:46 2026-10-02 22:05:26        INFO        imstat::ImageStatsCalculator::statistics         1.971800e+04  8.256598e+00  4.187341e-04  5.399227e-04  3.408580e-04 -9.270681e-04  1.009318e-03
02-Oct-2026 22:05:46 2026-10-02 22:05:26        INFO        imstat::::casa        Task imstat complete. Start time: 2026-10-02 22:05:26.309837 End time: 2026-10-02 22:05:26.326235
02-Oct-2026 22:05:46 2026-10-02 22:05:26        INFO        imstat::::casa        ##### End Task: imstat               #####
02-Oct-2026 22:05:46 2026-10-02 22:05:26        INFO        imstat::::casa        ##########################################
02-Oct-2026 22:05:46 Expected peak residual of 0.0010077510960400105, got 0.0010093175806105137, tolerance 10.0%
02-Oct-2026 22:05:46 Expected rms residual of 0.000542584067811474, got 0.0005399226868223044, tolerance 10.0%
02-Oct-2026 22:05:46 2026-10-02 22:05:26        INFO        name::        No table opened.
02-Oct-2026 22:05:46 2026-10-02 22:05:26        INFO        name::        No table opened.
02-Oct-2026 22:05:46 .
02-Oct-2026 22:05:46 ----------------------------------------------------------------------
02-Oct-2026 22:05:46 Ran 1 test in 1002.530s
02-Oct-2026 22:05:46
02-Oct-2026 22:05:46 OK
02-Oct-2026 22:05:46 Executor result: 0
02-Oct-2026 22:05:46 Failed tests:[]
02-Oct-2026 22:05:46
02-Oct-2026 22:05:46 Results: [{'testname': 'test_stk_vla_users_continuum_from_SDM', 'runtime': '0:17:03.588021', 'returncode': 0, 'testerr': []}]
02-Oct-2026 22:05:46 Stopping Xvfb.
02-Oct-2026 22:05:46 Stopping framebuffer <Popen: returncode: None args: ['Xvfb', ':105', '-screen', '0', '2048x2048x2...>
02-Oct-2026 22:05:46 Virtual frame buffer deployed at :105 with pid 118 successfully shutdown
02-Oct-2026 22:05:46 Xvfb stopped.
02-Oct-2026 22:05:47 cp: cannot stat '/home/casatest/work/test_stk_vla_users_continuum_from_SDM/*.png': No such file or directory
02-Oct-2026 22:05:47 total 777304
02-Oct-2026 22:05:47 -rw-r--r-- 1 casaci    15001 795954496 Oct  2 21:47 casa-6.7.7-11-py3.12.el8.tar.xz
02-Oct-2026 22:05:47 drwxr-xr-x 2 casaci root            24 Oct  2 22:05 html
02-Oct-2026 22:05:47 -rw-r--r-- 1 casaci casatest       389 Oct  2 22:05 xUnit-suite-mpi-8.xml
02-Oct-2026 22:05:47 drwxr-xr-x 2 casaci root            58 Oct  2 22:05 xml
02-Oct-2026 22:05:47 total 16
02-Oct-2026 22:05:47 -rw-r--r-- 1 casaci root 12473 Oct  2 22:05 index.html
02-Oct-2026 22:05:47 Finished task 'Script' with result: Success
02-Oct-2026 22:05:47 Starting task 'Parse test results' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
02-Oct-2026 22:05:47 Parsing test results under /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-MASTERTESTSTKPY312-STCR85D...
02-Oct-2026 22:05:47 Finished task 'Parse test results' with result: Success
02-Oct-2026 22:05:47
Substituting variable: ${bamboo.capability.hostname} with cvpost135
02-Oct-2026 22:05:47
Substituting variable: ${bamboo.capability.hostname} with cvpost135
02-Oct-2026 22:05:47 Starting task 'Cleanup' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
02-Oct-2026 22:05:47
Beginning to execute external process for build 'CASASPECS - Master Test Stakeholder Python 3.12 - Test VLA Stakeholder Tests MPI Rocky 8.10 Docker #233 (CASASPECS-MASTERTESTSTKPY312-STCR85D-233)'
... running command line:
/export/cvpost135-nvme/casa/bamboohome/temp/CASASPECS-MASTERTESTSTKPY312-STCR85D-233-ScriptBuildTask-10039292915642412712.sh
... in: /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-MASTERTESTSTKPY312-STCR85D
02-Oct-2026 22:05:47 Starting cleanup
02-Oct-2026 22:05:57 test-container
02-Oct-2026 22:06:02 test-container
02-Oct-2026 22:06:02 Cleanup complete
02-Oct-2026 22:06:02 Finished task 'Cleanup' with result: Success
02-Oct-2026 22:06:02 Running post build plugin 'Docker Container Cleanup'
02-Oct-2026 22:06:02 Running post build plugin 'NCover Results Collector'
02-Oct-2026 22:06:02 Running post build plugin 'Build Results Label Collector'
02-Oct-2026 22:06:02 Running post build plugin 'Clover Results Collector'
02-Oct-2026 22:06:02 Running post build plugin 'npm Cache Cleanup'
02-Oct-2026 22:06:02 Running post build plugin 'Artifact Copier'
02-Oct-2026 22:06:02 Publishing an artifact: VLA Stakeholder MPI
02-Oct-2026 22:06:02 Finished publishing of artifact Non required job artifact Http Compression On : [VLA Stakeholder MPI], patterns: [html/**] anchored at: [dockershare] in 63.85 ms
02-Oct-2026 22:06:02 Finalising the build...
02-Oct-2026 22:06:02 Stopping timer.
02-Oct-2026 22:06:02 Build CASASPECS-MASTERTESTSTKPY312-STCR85D-233 completed.
02-Oct-2026 18:06:02 Running on server: post build plugin 'Build Hanging Detection Configuration'
02-Oct-2026 18:06:02 Running on server: post build plugin 'NCover Results Collector'
02-Oct-2026 18:06:02 Running on server: post build plugin 'Build Labeller'
02-Oct-2026 18:06:02 Running on server: post build plugin 'Clover Delta Calculator'
02-Oct-2026 18:06:02 Running on server: post build plugin 'Maven Dependencies Postprocessor'
02-Oct-2026 18:06:02 All post build plugins have finished
02-Oct-2026 18:06:02 Generating build results summary...
02-Oct-2026 18:06:02 Saving build results to disk...
02-Oct-2026 18:06:02 Store variable context...
02-Oct-2026 18:06:02 Finished building CASASPECS-MASTERTESTSTKPY312-STCR85D-233.