Build log

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

20-Apr-2026 13:40:38	2026-04-20 17:40:37 INFO imager::feather() Each input image has a single restoring beam.
20-Apr-2026 13:40:38	2026-04-20 17:40:37 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:40:38	2026-04-20 17:40:37 INFO sdintimaging::::casa getSummary call: fullsummary=False
20-Apr-2026 13:40:38	2026-04-20 17:40:37 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.836058, over full image : 0.836058
20-Apr-2026 13:40:38	2026-04-20 17:40:37 INFO sdintimaging::::casa Reached global stopping criterion : iteration limit
20-Apr-2026 13:40:38	2026-04-20 17:40:37 INFO SDAlgorithmBase::restore [tst.sp_cube_sdint.joint.cube] : Restoring model image.
20-Apr-2026 13:40:38	2026-04-20 17:40:37 INFO SIImageStore::restore Beam for chan : 0 : 77.5193 arcsec, 76.6073 arcsec, 11.1113 deg
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO SIImageStore::restore Beam for chan : 1 : 51.6676 arcsec, 51.071 arcsec, 11.3343 deg
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO SIImageStore::restore Beam for chan : 2 : 38.7687 arcsec, 38.3203 arcsec, 14.0803 deg
20-Apr-2026 13:40:38	master 1 init 1
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO sdintimaging::::casa Deleting tmp_461049_*plane
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO sdintimaging::::casa Searching for images with prefix 'tst.sp_cube_sdint'... Found these, writing history into them: ['tst.sp_cube_sdint.joint.cube.sumwt', 'tst.sp_cube_sdint.int.cube.pb', 'tst.sp_cube_sdint.sd.cube.model', 'tst.sp_cube_sdint.sd.cube.psf', 'tst.sp_cube_sdint.joint.cube.image', 'tst.sp_cube_sdint.sd.cube.image', 'tst.sp_cube_sdint.int.cube.sumwt', 'tst.sp_cube_sdint.joint.cube.mask', 'tst.sp_cube_sdint.joint.cube.pb', 'tst.sp_cube_sdint.joint.cube.model', 'tst.sp_cube_sdint.joint.cube.residual', 'tst.sp_cube_sdint.int.cube.residual', 'tst.sp_cube_sdint.int.cube.psf', 'tst.sp_cube_sdint.int.cube.model', 'tst.sp_cube_sdint.sd.cube.residual', 'tst.sp_cube_sdint.joint.cube.psf']
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO sdintimaging::::casa Task sdintimaging complete. Start time: 2026-04-20 17:40:22.408408 End time: 2026-04-20 17:40:37.861631
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO sdintimaging::::casa ##### End Task: sdintimaging #####
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO sdintimaging::::casa ##########################################
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO name:: No table opened.
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO showcache:: The Table Cache is empty.
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO sdintimaging::::casa [ check_ret_structure ] Return dictionary struture check: type=reduced ( Pass : found all expected keys )
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO sdintimaging::::casa+ [ check_ims ] Image made : ['tst.sp_cube_sdint.joint.cube.psf', 'tst.sp_cube_sdint.joint.cube.residual', 'tst.sp_cube_sdint.joint.cube.image'] = [True, True, True] ( Pass : should all be True )
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO sdintimaging::::casa+ All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords)
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO sdintimaging::::casa+ [check_history] All expected history entries found. (Pass)
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_cube_sdint.joint.cube.psf : Value is 0.9906921982765198 at [400, 400, 0, 0] ( Pass : should be 0.99 , Epsilon: 0.05)
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_cube_sdint.joint.cube.psf : Value is 0.9905558824539185 at [400, 400, 0, 1] ( Pass : should be 0.99 , Epsilon: 0.05)
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_cube_sdint.joint.cube.image : Value is 1.6687167882919312 at [350, 433, 0, 0] ( Pass : should be 1.67 , Epsilon: 0.05)
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_cube_sdint.joint.cube.image : Value is 0.4621974229812622 at [300, 400, 0, 0] ( Pass : should be 0.462 , Epsilon: 0.05)
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_cube_sdint.joint.cube.image : Value is 1.0839482545852661 at [350, 433, 0, 1] ( Pass : should be 1.084 , Epsilon: 0.05)
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_cube_sdint.joint.cube.image : Value is 0.2299831211566925 at [300, 400, 0, 1] ( Pass : should be 0.23 , Epsilon: 0.05)
20-Apr-2026 13:40:38	.2026-04-20 17:40:38 INFO flagdata::::casa ##########################################
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO flagdata::::casa ##### Begin Task: flagdata #####
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO flagdata::::casa flagdata( vis='papersky_standard.ms', mode='manual', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='0:2', field='', antenna='', uvrange='', timerange='', correlation='', scan='', intent='', array='', observation='', feed='', clipminmax=[], datacolumn='DATA', clipoutside=True, channelavg=False, chanbin=1, timeavg=False, timebin='0s', clipzeros=False, quackinterval=1.0, quackmode='beg', quackincrement=False, tolerance=0.0, addantenna='', lowerlimit=0.0, upperlimit=90.0, ntime='scan', combinescans=False, timecutoff=4.0, freqcutoff=3.0, timefit='line', freqfit='poly', maxnpieces=7, flagdimension='freqtime', usewindowstats='none', halfwin=1, extendflags=True, winsize=3, timedev='', freqdev='', timedevscale=5.0, freqdevscale=5.0, spectralmax=1000000.0, spectralmin=0.0, antint_ref_antenna='', minchanfrac=0.6, verbose=False, extendpols=True, growtime=50.0, growfreq=50.0, growaround=False, flagneartime=False, flagnearfreq=False, minrel=0.0, maxrel=1.0, minabs=0, maxabs=-1, spwchan=False, spwcorr=False, basecnt=False, fieldcnt=False, name='Summary', action='apply', display='', flagbackup=True, savepars=False, cmdreason='', outfile='', overwrite=True, writeflags=True )
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO flagdata::::casa Backup original flags before applying new flags
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO AgentFlagger::open Table type is Measurement Set
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO FlagVersion::saveFlagVersion Creating new backup flag file called flagdata_1
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO AgentFlagger::open Table type is Measurement Set
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO flagdata::::casa Manual mode is active
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO FlagMSHandler::selectData Selected spw-channels ids are Axis Lengths: [1, 4] (NB: Matrix in Row/Column order)
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO FlagMSHandler::selectData + [0, 2, 2, 1]
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO flagdata::::casa Initializing the agents
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO AgentFlagger::initAgents There are initially 1 agents in the list. Agents: manual
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO Manual::setAgentParameters autocorr is 0
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO AgentFlagger::initAgents There are 1 valid agents in the list. Agents: manual
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO flagdata::::casa Running the agentflagger tool
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO FlagMSHandler:: Chunk = 1 [progress: 100%], Observation = 0, Array = 0, Scan = 1, Field = 0 (fake0), Spw = 0, Channels = 3, Corrs = [ RR LL ], Total Rows = 6318
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO Manual::chunkSummary => Data flagged so far 33.3333% (12636/37908)
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO FlagMSHandler::nextChunk ====================================================================================
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO Manual::tableSummary => Percentage of data flagged in table selection: 33.3333%
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO AgentFlagger::run => Writing flags to the MS
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO flagdata::::casa Task flagdata complete. Start time: 2026-04-20 17:40:38.023419 End time: 2026-04-20 17:40:38.110592
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO flagdata::::casa ##### End Task: flagdata #####
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO flagdata::::casa ##########################################
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO sdintimaging::::casa ##########################################
20-Apr-2026 13:40:38	2026-04-20 17:40:38 INFO sdintimaging::::casa ##### Begin Task: sdintimaging #####
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO sdintimaging::::casa sdintimaging( usedata='sdint', sdimage='papersky_standard.sdimage', sdpsf='papersky_standard.sdpsf', sdgain=1.0, dishdia=100.0, vis='papersky_standard.ms', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst.sp_cube_sdint', imsize=800, cell='9.0arcsec', phasecenter='J2000 19:59:28.500 +40.44.01.50', stokes='I', projection='SIN', startmodel='', specmode='cube', reffreq='1.5GHz', nchan=3, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='nearest', perchanweightdensity=True, gridder='standard', facets=1, psfphasecenter='', wprojplanes=1, vptable='', mosweight=True, aterm=True, psterm=False, wbawp=True, cfcache='', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=-0.1, deconvolver='multiscale', scales=[0, 12, 20, 40, 60, 80, 100], nterms=2, smallscalebias=0.0, restoration=True, restoringbeam=[], pbcor=False, weighting='natural', robust=0.5, noise='1.0Jy', npixels=0, uvtaper=[''], niter=100, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=50, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, fullsummary=False, nmajor=-1, usemask='user', mask='papersky_standard.true.im.masklist', 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, calcres=True, calcpsf=True )
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO sdintimaging::::casa Initializing SDINT Helper instance with tmp file tag 239566
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO sdintimaging::::casa INT cube setup ....
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO sdintimaging::::casa Verifying Input Parameters
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO SynthesisImagerVi2::selectData MS : papersky_standard.ms \| [Opened in readonly mode]
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO SynthesisImagerVi2::selectData NRows selected : 6318
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.sp_cube_sdint.int.cube] :
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.sp_cube_sdint.int.cube] :
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO MSTransformRegridder::calcChanFreqs phaseCenter='Direction: [0.377371, -0.657097, 0.652545]' Channels equidistant in freq
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO MSTransformRegridder::calcChanFreqs+ Central frequency (in output frame) = 1.49983e+09 Hz
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO MSTransformRegridder::calcChanFreqs+ Width of central channel (in output frame) = 4.99945e+08 Hz
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO MSTransformRegridder::calcChanFreqs+ Number of channels = 3
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO MSTransformRegridder::calcChanFreqs+ Total width of SPW (in output frame) = 1.49983e+09 Hz
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO MSTransformRegridder::calcChanFreqs+ Lower edge = 7.49917e+08 Hz, upper edge = 2.24975e+09 Hz
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO SynthesisImagerVi2::defineImage Impars: start
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO SynthesisImagerVi2::defineImage Shape: [800, 800, 1, 3] Spectral: [9.99889e+08] at [0] with increment [4.99945e+08]
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst.sp_cube_sdint.int.cube] with ftmachine : gridft
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO sdintimaging::::casa CFCache already exists
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO SynthesisImagerVi2::weight() Set imaging weights : Natural weighting
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO SynthesisImager::makePSF ----------------------------------------------------------- Make PSF ---------------------------------------------
20-Apr-2026 13:40:42	2026-04-20 17:40:38 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:40:42	2026-04-20 17:40:39 WARN MPICommandServer::command_request_handler_service::SIImageStore::getPSFGaussian::MPIServer-3 (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SIImageStore.cc, line 2143) PSF is blank for[C0:P0]
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO sdintimaging::::casa Copying restoring beam(s) for 3 channel(s) from tst.sp_cube_sdint.int.cube.psf to tst.sp_cube_sdint.int.cube.residual
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO image::_setrestoringbeam Will copy beams from another image to this image
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO BeamManipulator::set Set image beam set
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO sdintimaging::::casa Combined image setup ....
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO sdintimaging::::casa Verifying Input Parameters
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO SynthesisImagerVi2::selectData MS : papersky_standard.ms \| [Opened in readonly mode]
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO SynthesisImagerVi2::selectData NRows selected : 6318
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.sp_cube_sdint.joint.cube] :
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.sp_cube_sdint.joint.cube] :
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO MSTransformRegridder::calcChanFreqs phaseCenter='Direction: [0.377371, -0.657097, 0.652545]' Channels equidistant in freq
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO MSTransformRegridder::calcChanFreqs+ Central frequency (in output frame) = 1.49983e+09 Hz
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO MSTransformRegridder::calcChanFreqs+ Width of central channel (in output frame) = 4.99945e+08 Hz
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO MSTransformRegridder::calcChanFreqs+ Number of channels = 3
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO MSTransformRegridder::calcChanFreqs+ Total width of SPW (in output frame) = 1.49983e+09 Hz
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO MSTransformRegridder::calcChanFreqs+ Lower edge = 7.49917e+08 Hz, upper edge = 2.24975e+09 Hz
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO SynthesisImagerVi2::defineImage Impars: start
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO SynthesisImagerVi2::defineImage Shape: [800, 800, 1, 3] Spectral: [9.99889e+08] at [0] with increment [4.99945e+08]
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst.sp_cube_sdint.joint.cube] with ftmachine : gridft
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO sdintimaging::::casa CFCache already exists
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO SynthesisImagerVi2::weight() Set imaging weights : Natural weighting
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO SynthesisImager::makePSF ----------------------------------------------------------- Make PSF ---------------------------------------------
20-Apr-2026 13:40:42	2026-04-20 17:40:40 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:40:42	2026-04-20 17:40:41 WARN MPICommandServer::command_request_handler_service::SIImageStore::getPSFGaussian::MPIServer-3 (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SIImageStore.cc, line 2143) PSF is blank for[C0:P0]
20-Apr-2026 13:40:42	2026-04-20 17:40:42 INFO SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst.sp_cube_sdint.joint.cube] : multiscale
20-Apr-2026 13:40:42	2026-04-20 17:40:42 INFO SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
20-Apr-2026 13:40:42	2026-04-20 17:40:42 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:40:42	2026-04-20 17:40:42 INFO sdintimaging::::casa SD cube setup ....
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO sdintimaging::::casa Initializing SDINT Helper instance with tmp file tag 620028
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO sdintimaging::::casa The center of psf coincides with int psf: (diffRA,diffDec)=( 0.0, 0.0)
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO ImageMaskAttacher::makeMask Created and initialized mask `mask0'
20-Apr-2026 13:40:43	2026-04-20 17:40:42 WARN ImageRegridder::_doImagesOverlap At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
20-Apr-2026 13:40:43	2026-04-20 17:40:42 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO SubImageFactory::createImage Creating image 'tst.sp_cube_sdint.sd.cube.residual' of shape [800, 800, 1, 3]
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO ImageMaskAttacher::makeMask Created and initialized mask `mask0'
20-Apr-2026 13:40:43	2026-04-20 17:40:42 WARN ImageRegridder::_doImagesOverlap At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
20-Apr-2026 13:40:43	2026-04-20 17:40:42 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO SubImageFactory::createImage Creating image 'tst.sp_cube_sdint.sd.cube.image' of shape [800, 800, 1, 3]
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO ImageMaskAttacher::makeMask Created and initialized mask `mask0'
20-Apr-2026 13:40:43	2026-04-20 17:40:42 WARN ImageRegridder::_doImagesOverlap At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
20-Apr-2026 13:40:43	2026-04-20 17:40:42 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO SubImageFactory::createImage Creating image 'tst.sp_cube_sdint.sd.cube.psf' of shape [800, 800, 1, 3]
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO sdintimaging::::casa Deleting tmp_620028_*plane
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO sdintimaging::::casa There are 1 empty channels in the interferometer cube. These channels will be excluded from the feathering step.
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO sdintimaging::::casa The following channel weights/flags will be used in the feather step and minor cycle. Zero indicates channels that are empty in either the INT or SD input cubes and which will be excluded from the joint reconstruction. : [1. 1. 0.]
20-Apr-2026 13:40:43	2026-04-20 17:40:42 WARN sdintimaging::::casa There are channels that are filled with zeros either in the INT cube or the SD cube or both, and they will be ignored from the joint reconstruction. Please search the log file for the string "channel weights/flags" to find a listing of channels that are being used
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO sdintimaging::::casa Feathering INT and SD residual images...
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO sdintimaging::::casa Deleting tmp_239566_*plane
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO ImageRegion::fromRecord+ [0, 0, 0, 0] to [799, 799, 0, 0] (20:04:40.577, +39.43.34.655, I, 999889040.02Hz to 19:54:07.715, +41.43.25.344, I, 999889040.02Hz)
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO ImageRegion::fromRecord Creating image 'tmp_239566_sdplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO ImageRegion::fromRecord+ [0, 0, 0, 0] to [799, 799, 0, 0] (20:04:40.577, +39.43.34.655, I, 999889040.02Hz to 19:54:07.715, +41.43.25.344, I, 999889040.02Hz)
20-Apr-2026 13:40:43	2026-04-20 17:40:42 INFO ImageRegion::fromRecord Creating image 'tmp_239566_intplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO sdintimaging::::casa start Feathering.....
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO Imager::setvp() Setting voltage pattern parameters
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO Imager::setvp() Sky position tolerance is 180 degrees
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO Imager::setvp() Using system default voltage patterns for each telescope
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO imager::setsdoptions() Setting single dish processing options
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO imager::feather()
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO imager::feather()+ Feathering together high and low resolution images...
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO imager::feather() Each input image has a single restoring beam.
20-Apr-2026 13:40:43	2026-04-20 17:40:43 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO sdintimaging::::casa Deleting tmp_239566_*plane
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO ImageRegion::fromRecord+ [0, 0, 0, 1] to [799, 799, 0, 1] (20:04:40.577, +39.43.34.655, I, 1.49983e+09Hz to 19:54:07.715, +41.43.25.344, I, 1.49983e+09Hz)
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO ImageRegion::fromRecord Creating image 'tmp_239566_sdplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO ImageRegion::fromRecord+ [0, 0, 0, 1] to [799, 799, 0, 1] (20:04:40.577, +39.43.34.655, I, 1.49983e+09Hz to 19:54:07.715, +41.43.25.344, I, 1.49983e+09Hz)
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO ImageRegion::fromRecord Creating image 'tmp_239566_intplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO sdintimaging::::casa start Feathering.....
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO Imager::setvp() Setting voltage pattern parameters
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO Imager::setvp() Sky position tolerance is 180 degrees
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO Imager::setvp() Using system default voltage patterns for each telescope
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO imager::setsdoptions() Setting single dish processing options
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO imager::feather()
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO imager::feather()+ Feathering together high and low resolution images...
20-Apr-2026 13:40:43	2026-04-20 17:40:43 INFO imager::feather() Each input image has a single restoring beam.
20-Apr-2026 13:40:43	2026-04-20 17:40:43 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:40:50	2026-04-20 17:40:43 INFO sdintimaging::::casa Deleting tmp_239566_*plane
20-Apr-2026 13:40:50	2026-04-20 17:40:43 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:40:50	2026-04-20 17:40:43 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:40:50	2026-04-20 17:40:43 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:40:50	2026-04-20 17:40:43 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:40:50	2026-04-20 17:40:43 INFO ImageRegion::fromRecord+ [0, 0, 0, 0] to [799, 799, 0, 0] (20:04:40.577, +39.43.34.655, I, 999889040.02Hz to 19:54:07.715, +41.43.25.344, I, 999889040.02Hz)
20-Apr-2026 13:40:50	2026-04-20 17:40:43 INFO ImageRegion::fromRecord Creating image 'tmp_239566_sdplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:40:50	2026-04-20 17:40:43 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:40:50	2026-04-20 17:40:43 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:40:50	2026-04-20 17:40:43 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:40:50	2026-04-20 17:40:43 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:40:50	2026-04-20 17:40:43 INFO ImageRegion::fromRecord+ [0, 0, 0, 0] to [799, 799, 0, 0] (20:04:40.577, +39.43.34.655, I, 999889040.02Hz to 19:54:07.715, +41.43.25.344, I, 999889040.02Hz)
20-Apr-2026 13:40:50	2026-04-20 17:40:43 INFO ImageRegion::fromRecord Creating image 'tmp_239566_intplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:40:50	2026-04-20 17:40:43 INFO sdintimaging::::casa start Feathering.....
20-Apr-2026 13:40:50	2026-04-20 17:40:43 INFO Imager::setvp() Setting voltage pattern parameters
20-Apr-2026 13:40:50	2026-04-20 17:40:43 INFO Imager::setvp() Sky position tolerance is 180 degrees
20-Apr-2026 13:40:50	2026-04-20 17:40:43 INFO Imager::setvp() Using system default voltage patterns for each telescope
20-Apr-2026 13:40:50	2026-04-20 17:40:43 INFO imager::setsdoptions() Setting single dish processing options
20-Apr-2026 13:40:50	2026-04-20 17:40:43 INFO imager::feather()
20-Apr-2026 13:40:50	2026-04-20 17:40:43 INFO imager::feather()+ Feathering together high and low resolution images...
20-Apr-2026 13:40:50	2026-04-20 17:40:43 INFO imager::feather() Each input image has a single restoring beam.
20-Apr-2026 13:40:50	2026-04-20 17:40:43 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO sdintimaging::::casa Deleting tmp_239566_*plane
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO ImageRegion::fromRecord+ [0, 0, 0, 1] to [799, 799, 0, 1] (20:04:40.577, +39.43.34.655, I, 1.49983e+09Hz to 19:54:07.715, +41.43.25.344, I, 1.49983e+09Hz)
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO ImageRegion::fromRecord Creating image 'tmp_239566_sdplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO ImageRegion::fromRecord+ [0, 0, 0, 1] to [799, 799, 0, 1] (20:04:40.577, +39.43.34.655, I, 1.49983e+09Hz to 19:54:07.715, +41.43.25.344, I, 1.49983e+09Hz)
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO ImageRegion::fromRecord Creating image 'tmp_239566_intplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO sdintimaging::::casa start Feathering.....
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO Imager::setvp() Setting voltage pattern parameters
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO Imager::setvp() Sky position tolerance is 180 degrees
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO Imager::setvp() Using system default voltage patterns for each telescope
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO imager::setsdoptions() Setting single dish processing options
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO imager::feather()
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO imager::feather()+ Feathering together high and low resolution images...
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO imager::feather() Each input image has a single restoring beam.
20-Apr-2026 13:40:50	2026-04-20 17:40:44 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO SynthesisUtilMethods::fitPsfBeam Fitting PSF beam for Imagestore : tst.sp_cube_sdint.joint.cube
20-Apr-2026 13:40:50	2026-04-20 17:40:44 WARN SIImageStore::getPSFGaussian (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SIImageStore.cc, line 2143) PSF is blank for[C2:P0]
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.044928
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO SIImageStore::printBeamSet Restoring Beams
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO SIImageStore::printBeamSet + Chan Freq Vel Pol
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO SIImageStore::printBeamSet + 0 1.0e+09 33 I 77.5193 arcsec x 76.6073 arcsec pa= 11.1113 deg
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO SIImageStore::printBeamSet + 1 1.5e+09 -149846 I 51.6676 arcsec x 51.0710 arcsec pa= 11.3343 deg
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO SIImageStore::printBeamSet + 2 2.0e+09 -299726 I 77.5193 arcsec x 76.6073 arcsec pa= 11.1113 deg
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 1.51885
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO SynthesisDeconvolver::setupMask [tst.sp_cube_sdint.joint.cube] Setting up a mask from [papersky_standard.true.im.masklist]
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO CasacRegionManager::fromBCS Using all spectral channels.
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO ImageMaskAttacher::makeMask Created and initialized mask `mask0'
20-Apr-2026 13:40:50	2026-04-20 17:40:44 WARN ImageRegridder::_doImagesOverlap At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO RegionTextParser::_determineVersion RegionTextParser::_determineVersion: Found spec version 0
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO AsciiRegionFileParser::_parse Combined 5 image regions (which excludes any annotation regions)
20-Apr-2026 13:40:50	2026-04-20 17:40:44 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).
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO SynthesisDeconvolver::setupMask ----------------------------------------------------------------------------------------------------------------------------------------
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO SynthesisDeconvolver::setupMask [tst.sp_cube_sdint.joint.cube] Number of pixels in the clean mask : 132660 out of a total of 1.92e+06 pixels. [ 6.90937 % ]
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 1.51885, over full image : 1.51885
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO sdintimaging::::casa Minor Cycle controls : {'cycleniter': 50, 'cyclethreshold': 0.1825110912322998, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
20-Apr-2026 13:40:50	2026-04-20 17:40:44 INFO SynthesisDeconvolver::executeCubeMinorCycle ---------------------------------------------------- Run Minor Cycle Iterations ---------------------------------------------
20-Apr-2026 13:40:50	2026-04-20 17:40:51 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 100 iterations.
20-Apr-2026 13:40:50	2026-04-20 17:40:51 INFO task_sdintimaging::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 2 -------------------------------------
20-Apr-2026 13:40:54	2026-04-20 17:40:51 INFO task_sdintimaging::SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO sdintimaging::::casa Deleting tmp_239566_*plane
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO ImageRegion::fromRecord+ [0, 0, 0, 0] to [799, 799, 0, 0] (20:04:40.577, +39.43.34.655, I, 999889040.02Hz to 19:54:07.715, +41.43.25.344, I, 999889040.02Hz)
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO ImageRegion::fromRecord Creating image 'tmp_239566_sdplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO ImageRegion::fromRecord+ [0, 0, 0, 0] to [799, 799, 0, 0] (20:04:40.577, +39.43.34.655, I, 999889040.02Hz to 19:54:07.715, +41.43.25.344, I, 999889040.02Hz)
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO ImageRegion::fromRecord Creating image 'tmp_239566_intplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO sdintimaging::::casa start Feathering.....
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO Imager::setvp() Setting voltage pattern parameters
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO Imager::setvp() Sky position tolerance is 180 degrees
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO Imager::setvp() Using system default voltage patterns for each telescope
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO imager::setsdoptions() Setting single dish processing options
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO imager::feather()
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO imager::feather()+ Feathering together high and low resolution images...
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO imager::feather() Each input image has a single restoring beam.
20-Apr-2026 13:40:54	2026-04-20 17:40:53 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO sdintimaging::::casa Deleting tmp_239566_*plane
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO ImageRegion::fromRecord+ [0, 0, 0, 1] to [799, 799, 0, 1] (20:04:40.577, +39.43.34.655, I, 1.49983e+09Hz to 19:54:07.715, +41.43.25.344, I, 1.49983e+09Hz)
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO ImageRegion::fromRecord Creating image 'tmp_239566_sdplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:40:54	2026-04-20 17:40:53 INFO ImageRegion::fromRecord+ [0, 0, 0, 1] to [799, 799, 0, 1] (20:04:40.577, +39.43.34.655, I, 1.49983e+09Hz to 19:54:07.715, +41.43.25.344, I, 1.49983e+09Hz)
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO ImageRegion::fromRecord Creating image 'tmp_239566_intplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO sdintimaging::::casa start Feathering.....
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO Imager::setvp() Setting voltage pattern parameters
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO Imager::setvp() Sky position tolerance is 180 degrees
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO Imager::setvp() Using system default voltage patterns for each telescope
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO imager::setsdoptions() Setting single dish processing options
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO imager::feather()
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO imager::feather()+ Feathering together high and low resolution images...
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO imager::feather() Each input image has a single restoring beam.
20-Apr-2026 13:40:54	2026-04-20 17:40:54 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO sdintimaging::::casa getSummary call: fullsummary=False
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.836058, over full image : 0.836058
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO sdintimaging::::casa Reached global stopping criterion : iteration limit
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO SDAlgorithmBase::restore [tst.sp_cube_sdint.joint.cube] : Restoring model image.
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO SIImageStore::restore Beam for chan : 0 : 77.5193 arcsec, 76.6073 arcsec, 11.1113 deg
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO SIImageStore::restore Beam for chan : 1 : 51.6676 arcsec, 51.071 arcsec, 11.3343 deg
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO SIImageStore::restore Beam for chan : 2 : 77.5193 arcsec, 76.6073 arcsec, 11.1113 deg
20-Apr-2026 13:40:54	master 1 init 1
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO sdintimaging::::casa Deleting tmp_239566_*plane
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO sdintimaging::::casa Searching for images with prefix 'tst.sp_cube_sdint'... Found these, writing history into them: ['tst.sp_cube_sdint.joint.cube.sumwt', 'tst.sp_cube_sdint.int.cube.pb', 'tst.sp_cube_sdint.sd.cube.model', 'tst.sp_cube_sdint.sd.cube.psf', 'tst.sp_cube_sdint.joint.cube.image', 'tst.sp_cube_sdint.sd.cube.image', 'tst.sp_cube_sdint.int.cube.sumwt', 'tst.sp_cube_sdint.joint.cube.mask', 'tst.sp_cube_sdint.joint.cube.pb', 'tst.sp_cube_sdint.joint.cube.model', 'tst.sp_cube_sdint.joint.cube.residual', 'tst.sp_cube_sdint.int.cube.residual', 'tst.sp_cube_sdint.int.cube.psf', 'tst.sp_cube_sdint.int.cube.model', 'tst.sp_cube_sdint.sd.cube.residual', 'tst.sp_cube_sdint.joint.cube.psf']
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO sdintimaging::::casa Task sdintimaging complete. Start time: 2026-04-20 17:40:38.139892 End time: 2026-04-20 17:40:54.299320
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO sdintimaging::::casa ##### End Task: sdintimaging #####
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO sdintimaging::::casa ##########################################
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO name:: No table opened.
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO showcache:: The Table Cache is empty.
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO sdintimaging::::casa [ check_ret_structure ] Return dictionary struture check: type=reduced ( Pass : found all expected keys )
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO sdintimaging::::casa+ [ check_ims ] Image made : ['tst.sp_cube_sdint.joint.cube.psf', 'tst.sp_cube_sdint.joint.cube.residual', 'tst.sp_cube_sdint.joint.cube.image'] = [True, True, True] ( Pass : should all be True )
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO sdintimaging::::casa+ All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords)
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO sdintimaging::::casa+ [check_history] All expected history entries found. (Pass)
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_cube_sdint.joint.cube.psf : Value is 0.9906921982765198 at [400, 400, 0, 0] ( Pass : should be 0.99 , Epsilon: 0.05)
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_cube_sdint.joint.cube.psf : Value is 0.0 at [400, 400, 0, 2] ( Pass : should be 0 , Epsilon: 0.05)
20-Apr-2026 13:40:54	2026-04-20 17:40:54 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_cube_sdint.joint.cube.image : Value is 1.6687167882919312 at [350, 433, 0, 0] ( Pass : should be 1.66 , Epsilon: 0.05)
20-Apr-2026 13:40:56	2026-04-20 17:40:54 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_cube_sdint.joint.cube.image : Value is 0.4621974229812622 at [300, 400, 0, 0] ( Pass : should be 0.459 , Epsilon: 0.05)
20-Apr-2026 13:40:56	2026-04-20 17:40:54 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_cube_sdint.joint.cube.image : Value is 0.0 at [350, 433, 0, 2] ( Pass : should be 0 , Epsilon: 0.05)
20-Apr-2026 13:40:56	2026-04-20 17:40:54 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_cube_sdint.joint.cube.image : Value is 0.0 at [300, 400, 0, 2] ( Pass : should be 0 , Epsilon: 0.05)
20-Apr-2026 13:40:56	.2026-04-20 17:40:54 INFO sdintimaging::::casa ##########################################
20-Apr-2026 13:40:56	2026-04-20 17:40:54 INFO sdintimaging::::casa ##### Begin Task: sdintimaging #####
20-Apr-2026 13:40:56	2026-04-20 17:40:54 INFO sdintimaging::::casa sdintimaging( usedata='sd', sdimage='papersky_standard.sdimage', sdpsf='papersky_standard.sdpsf', sdgain=1.0, dishdia=100.0, vis='papersky_standard.ms', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst.sp_cube_sdonly', imsize=800, cell='9.0arcsec', phasecenter='J2000 19:59:28.500 +40.44.01.50', stokes='I', projection='SIN', startmodel='', specmode='cube', reffreq='1.5GHz', nchan=3, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='nearest', perchanweightdensity=True, gridder='standard', facets=1, psfphasecenter='', wprojplanes=1, vptable='', mosweight=True, aterm=True, psterm=False, wbawp=True, cfcache='', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=-0.1, deconvolver='multiscale', scales=[0, 12, 20, 40, 60, 80, 100], nterms=2, smallscalebias=0.0, restoration=True, restoringbeam=[], pbcor=False, weighting='natural', robust=0.5, noise='1.0Jy', npixels=0, uvtaper=[''], niter=100, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=50, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, fullsummary=False, nmajor=-1, usemask='user', mask='papersky_standard.true.im.masklist', 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, calcres=True, calcpsf=True )
20-Apr-2026 13:40:56	2026-04-20 17:40:54 WARN sdintimaging::task_sdintimaging::casa The Single-Dish-Only mode of sdintimaging is better supported via the deconvolve task which supports spectral cube, mfs and multi-term mfs deconvolution in the image domain alone. The deconvolve task is the more appropriate version to use for stand-alone image-domain deconvolution, and will not have the bookkeeping overheads currently present in the sdintimaging task's sd-only mode. Please note that the 'sd' option of the sdintimaging task will be removed in a subsequent release. Please refer to the task deconvolve documentation for instructions on how to prepare image and psf cubes for the deconvolve task for all these modes.
20-Apr-2026 13:40:56	2026-04-20 17:40:54 INFO sdintimaging::::casa Initializing SDINT Helper instance with tmp file tag 110858
20-Apr-2026 13:40:56	2026-04-20 17:40:54 INFO sdintimaging::::casa INT cube setup ....
20-Apr-2026 13:40:56	2026-04-20 17:40:54 INFO sdintimaging::::casa Verifying Input Parameters
20-Apr-2026 13:40:56	2026-04-20 17:40:54 INFO SynthesisImagerVi2::selectData MS : papersky_standard.ms \| [Opened in readonly mode]
20-Apr-2026 13:40:56	2026-04-20 17:40:54 INFO SynthesisImagerVi2::selectData NRows selected : 6318
20-Apr-2026 13:40:56	2026-04-20 17:40:55 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.sp_cube_sdonly.int.cube] :
20-Apr-2026 13:40:56	2026-04-20 17:40:55 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.sp_cube_sdonly.int.cube] :
20-Apr-2026 13:40:56	2026-04-20 17:40:55 INFO MSTransformRegridder::calcChanFreqs phaseCenter='Direction: [0.377371, -0.657097, 0.652545]' Channels equidistant in freq
20-Apr-2026 13:40:56	2026-04-20 17:40:55 INFO MSTransformRegridder::calcChanFreqs+ Central frequency (in output frame) = 1.49983e+09 Hz
20-Apr-2026 13:40:56	2026-04-20 17:40:55 INFO MSTransformRegridder::calcChanFreqs+ Width of central channel (in output frame) = 4.99945e+08 Hz
20-Apr-2026 13:40:56	2026-04-20 17:40:55 INFO MSTransformRegridder::calcChanFreqs+ Number of channels = 3
20-Apr-2026 13:40:56	2026-04-20 17:40:55 INFO MSTransformRegridder::calcChanFreqs+ Total width of SPW (in output frame) = 1.49983e+09 Hz
20-Apr-2026 13:40:56	2026-04-20 17:40:55 INFO MSTransformRegridder::calcChanFreqs+ Lower edge = 7.49917e+08 Hz, upper edge = 2.24975e+09 Hz
20-Apr-2026 13:40:56	2026-04-20 17:40:55 INFO SynthesisImagerVi2::defineImage Impars: start
20-Apr-2026 13:40:56	2026-04-20 17:40:55 INFO SynthesisImagerVi2::defineImage Shape: [800, 800, 1, 3] Spectral: [9.99889e+08] at [0] with increment [4.99945e+08]
20-Apr-2026 13:40:56	2026-04-20 17:40:55 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst.sp_cube_sdonly.int.cube] with ftmachine : gridft
20-Apr-2026 13:40:56	2026-04-20 17:40:55 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:40:56	2026-04-20 17:40:55 INFO sdintimaging::::casa CFCache already exists
20-Apr-2026 13:40:56	2026-04-20 17:40:55 INFO SynthesisImagerVi2::weight() Set imaging weights : Natural weighting
20-Apr-2026 13:40:56	2026-04-20 17:40:55 INFO SynthesisImager::makePSF ----------------------------------------------------------- Make PSF ---------------------------------------------
20-Apr-2026 13:40:56	2026-04-20 17:40:55 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO sdintimaging::::casa Copying restoring beam(s) for 3 channel(s) from tst.sp_cube_sdonly.int.cube.psf to tst.sp_cube_sdonly.int.cube.residual
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO image::_setrestoringbeam Will copy beams from another image to this image
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO BeamManipulator::set Set image beam set
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO sdintimaging::::casa Combined image setup ....
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO sdintimaging::::casa Verifying Input Parameters
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO SynthesisImagerVi2::selectData MS : papersky_standard.ms \| [Opened in readonly mode]
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO SynthesisImagerVi2::selectData NRows selected : 6318
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.sp_cube_sdonly.joint.cube] :
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.sp_cube_sdonly.joint.cube] :
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO MSTransformRegridder::calcChanFreqs phaseCenter='Direction: [0.377371, -0.657097, 0.652545]' Channels equidistant in freq
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO MSTransformRegridder::calcChanFreqs+ Central frequency (in output frame) = 1.49983e+09 Hz
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO MSTransformRegridder::calcChanFreqs+ Width of central channel (in output frame) = 4.99945e+08 Hz
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO MSTransformRegridder::calcChanFreqs+ Number of channels = 3
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO MSTransformRegridder::calcChanFreqs+ Total width of SPW (in output frame) = 1.49983e+09 Hz
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO MSTransformRegridder::calcChanFreqs+ Lower edge = 7.49917e+08 Hz, upper edge = 2.24975e+09 Hz
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO SynthesisImagerVi2::defineImage Impars: start
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO SynthesisImagerVi2::defineImage Shape: [800, 800, 1, 3] Spectral: [9.99889e+08] at [0] with increment [4.99945e+08]
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst.sp_cube_sdonly.joint.cube] with ftmachine : gridft
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:40:56	2026-04-20 17:40:56 INFO sdintimaging::::casa CFCache already exists
20-Apr-2026 13:41:05	2026-04-20 17:40:56 INFO SynthesisImagerVi2::weight() Set imaging weights : Natural weighting
20-Apr-2026 13:41:05	2026-04-20 17:40:56 INFO SynthesisImager::makePSF ----------------------------------------------------------- Make PSF ---------------------------------------------
20-Apr-2026 13:41:05	2026-04-20 17:40:56 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:41:05	2026-04-20 17:40:57 INFO SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst.sp_cube_sdonly.joint.cube] : multiscale
20-Apr-2026 13:41:05	2026-04-20 17:40:57 INFO SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
20-Apr-2026 13:41:05	2026-04-20 17:40:57 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:41:05	2026-04-20 17:40:57 INFO sdintimaging::::casa SD cube setup ....
20-Apr-2026 13:41:05	2026-04-20 17:40:57 INFO sdintimaging::::casa Initializing SDINT Helper instance with tmp file tag 557336
20-Apr-2026 13:41:05	2026-04-20 17:40:57 INFO sdintimaging::::casa The center of psf coincides with int psf: (diffRA,diffDec)=( 0.0, 0.0)
20-Apr-2026 13:41:05	2026-04-20 17:40:57 INFO ImageMaskAttacher::makeMask Created and initialized mask `mask0'
20-Apr-2026 13:41:05	2026-04-20 17:40:57 WARN ImageRegridder::_doImagesOverlap At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
20-Apr-2026 13:41:05	2026-04-20 17:40:57 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:41:05	2026-04-20 17:40:57 INFO SubImageFactory::createImage Creating image 'tst.sp_cube_sdonly.sd.cube.residual' of shape [800, 800, 1, 3]
20-Apr-2026 13:41:05	2026-04-20 17:40:57 INFO ImageMaskAttacher::makeMask Created and initialized mask `mask0'
20-Apr-2026 13:41:05	2026-04-20 17:40:57 WARN ImageRegridder::_doImagesOverlap At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
20-Apr-2026 13:41:05	2026-04-20 17:40:57 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:41:05	2026-04-20 17:40:57 INFO SubImageFactory::createImage Creating image 'tst.sp_cube_sdonly.sd.cube.image' of shape [800, 800, 1, 3]
20-Apr-2026 13:41:05	2026-04-20 17:40:57 INFO ImageMaskAttacher::makeMask Created and initialized mask `mask0'
20-Apr-2026 13:41:05	2026-04-20 17:40:57 WARN ImageRegridder::_doImagesOverlap At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
20-Apr-2026 13:41:05	2026-04-20 17:40:57 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:41:05	2026-04-20 17:40:57 INFO SubImageFactory::createImage Creating image 'tst.sp_cube_sdonly.sd.cube.psf' of shape [800, 800, 1, 3]
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO sdintimaging::::casa Deleting tmp_557336_*plane
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO sdintimaging::::casa Feathering INT and SD residual images...
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO SynthesisUtilMethods::fitPsfBeam Fitting PSF beam for Imagestore : tst.sp_cube_sdonly.joint.cube
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.199888
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO SIImageStore::printBeamSet Restoring Beams
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO SIImageStore::printBeamSet + Chan Freq Vel Pol
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO SIImageStore::printBeamSet + 0 1.0e+09 33 I 664.4244 arcsec x 664.4244 arcsec pa=-77.8797 deg
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO SIImageStore::printBeamSet + 1 1.5e+09 -149846 I 424.2759 arcsec x 424.2759 arcsec pa= 18.1714 deg
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO SIImageStore::printBeamSet + 2 2.0e+09 -299726 I 320.2759 arcsec x 320.2759 arcsec pa=-31.9648 deg
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 32.8423
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO SynthesisDeconvolver::setupMask [tst.sp_cube_sdonly.joint.cube] Setting up a mask from [papersky_standard.true.im.masklist]
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO CasacRegionManager::fromBCS Using all spectral channels.
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO ImageMaskAttacher::makeMask Created and initialized mask `mask0'
20-Apr-2026 13:41:05	2026-04-20 17:40:58 WARN ImageRegridder::_doImagesOverlap At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO RegionTextParser::_determineVersion RegionTextParser::_determineVersion: Found spec version 0
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO AsciiRegionFileParser::_parse Combined 5 image regions (which excludes any annotation regions)
20-Apr-2026 13:41:05	2026-04-20 17:40:58 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).
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO SynthesisDeconvolver::setupMask ----------------------------------------------------------------------------------------------------------------------------------------
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO SynthesisDeconvolver::setupMask [tst.sp_cube_sdonly.joint.cube] Number of pixels in the clean mask : 132660 out of a total of 1.92e+06 pixels. [ 6.90937 % ]
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 32.8423, over full image : 32.8423
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO sdintimaging::::casa Minor Cycle controls : {'cycleniter': 50, 'cyclethreshold': 1.6421152353286743, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
20-Apr-2026 13:41:05	2026-04-20 17:40:58 INFO SynthesisDeconvolver::executeCubeMinorCycle ---------------------------------------------------- Run Minor Cycle Iterations ---------------------------------------------
20-Apr-2026 13:41:05	2026-04-20 17:41:04 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 150 iterations.
20-Apr-2026 13:41:05	2026-04-20 17:41:05 INFO sdintimaging::::casa getSummary call: fullsummary=False
20-Apr-2026 13:41:05	2026-04-20 17:41:05 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 3.27485, over full image : 3.27485
20-Apr-2026 13:41:05	2026-04-20 17:41:05 INFO sdintimaging::::casa Reached global stopping criterion : iteration limit
20-Apr-2026 13:41:05	2026-04-20 17:41:05 INFO SDAlgorithmBase::restore [tst.sp_cube_sdonly.joint.cube] : Restoring model image.
20-Apr-2026 13:41:05	2026-04-20 17:41:05 INFO SIImageStore::restore Beam for chan : 0 : 664.424 arcsec, 664.424 arcsec, -77.8797 deg
20-Apr-2026 13:41:05	2026-04-20 17:41:05 INFO SIImageStore::restore Beam for chan : 1 : 424.276 arcsec, 424.276 arcsec, 18.1714 deg
20-Apr-2026 13:41:05	2026-04-20 17:41:05 INFO SIImageStore::restore Beam for chan : 2 : 320.276 arcsec, 320.276 arcsec, -31.9648 deg
20-Apr-2026 13:41:05	master 1 init 1
20-Apr-2026 13:41:05	2026-04-20 17:41:06 INFO sdintimaging::::casa Deleting tmp_110858_*plane
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO sdintimaging::::casa Searching for images with prefix 'tst.sp_cube_sdonly'... Found these, writing history into them: ['tst.sp_cube_sdonly.joint.cube.model', 'tst.sp_cube_sdonly.sd.cube.residual', 'tst.sp_cube_sdonly.sd.cube.image', 'tst.sp_cube_sdonly.joint.cube.pb', 'tst.sp_cube_sdonly.sd.cube.model', 'tst.sp_cube_sdonly.int.cube.model', 'tst.sp_cube_sdonly.joint.cube.mask', 'tst.sp_cube_sdonly.joint.cube.image', 'tst.sp_cube_sdonly.int.cube.psf', 'tst.sp_cube_sdonly.int.cube.pb', 'tst.sp_cube_sdonly.joint.cube.sumwt', 'tst.sp_cube_sdonly.int.cube.sumwt', 'tst.sp_cube_sdonly.int.cube.residual', 'tst.sp_cube_sdonly.joint.cube.residual', 'tst.sp_cube_sdonly.joint.cube.psf', 'tst.sp_cube_sdonly.sd.cube.psf']
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO sdintimaging::::casa Task sdintimaging complete. Start time: 2026-04-20 17:40:54.431772 End time: 2026-04-20 17:41:05.702471
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO sdintimaging::::casa ##### End Task: sdintimaging #####
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO sdintimaging::::casa ##########################################
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO name:: No table opened.
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO showcache:: The Table Cache is empty.
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO sdintimaging::::casa [ check_ret_structure ] Return dictionary struture check: type=reduced ( Pass : found all expected keys )
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO sdintimaging::::casa+ [ check_ims ] Image made : ['tst.sp_cube_sdonly.joint.cube.psf', 'tst.sp_cube_sdonly.joint.cube.residual', 'tst.sp_cube_sdonly.joint.cube.image'] = [True, True, True] ( Pass : should all be True )
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO sdintimaging::::casa+ All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords)
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO sdintimaging::::casa+ [check_history] All expected history entries found. (Pass)
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_cube_sdonly.joint.cube.psf : Value is 1.0 at [400, 400, 0, 0] ( Pass : should be 1.0 , Epsilon: 0.05)
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_cube_sdonly.joint.cube.psf : Value is 1.0 at [400, 400, 0, 1] ( Pass : should be 1.0 , Epsilon: 0.05)
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_cube_sdonly.joint.cube.image : Value is 18.234392166137695 at [350, 433, 0, 0] ( Pass : should be 18.65 , Epsilon: 0.05)
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_cube_sdonly.joint.cube.image : Value is 32.519012451171875 at [300, 400, 0, 0] ( Pass : should be 33.15 , Epsilon: 0.05)
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_cube_sdonly.joint.cube.image : Value is 7.91010046005249 at [350, 433, 0, 1] ( Pass : should be 8.234 , Epsilon: 0.05)
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_cube_sdonly.joint.cube.image : Value is 15.430900573730469 at [300, 400, 0, 1] ( Pass : should be 16.149 , Epsilon: 0.05)
20-Apr-2026 13:41:07	.2026-04-20 17:41:06 INFO sdintimaging::::casa ##########################################
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO sdintimaging::::casa ##### Begin Task: sdintimaging #####
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO sdintimaging::::casa sdintimaging( usedata='int', sdimage='', sdpsf='', sdgain=1.0, dishdia=100.0, vis='papersky_standard.ms', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst.sp_mfs_intonly', imsize=800, cell='9.0arcsec', phasecenter='J2000 19:59:28.500 +40.44.01.50', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='1.5GHz', nchan=3, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='nearest', perchanweightdensity=True, gridder='standard', facets=1, psfphasecenter='', wprojplanes=1, vptable='', mosweight=True, aterm=True, psterm=False, wbawp=True, cfcache='', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=-0.1, deconvolver='mtmfs', scales=[0, 12, 20, 40, 60, 80, 100], nterms=2, smallscalebias=0.0, restoration=True, restoringbeam=[], pbcor=False, weighting='natural', robust=0.5, noise='1.0Jy', npixels=0, uvtaper=[''], niter=100, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=50, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, fullsummary=False, nmajor=-1, usemask='user', mask='papersky_standard.true.im.masklist', 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, calcres=True, calcpsf=True )
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO sdintimaging::::casa Initializing SDINT Helper instance with tmp file tag 365448
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO sdintimaging::::casa INT cube setup ....
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO sdintimaging::::casa Verifying Input Parameters
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO SynthesisImagerVi2::selectData MS : papersky_standard.ms \| [Opened in readonly mode]
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO SynthesisImagerVi2::selectData NRows selected : 6318
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.sp_mfs_intonly.int.cube] :
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.sp_mfs_intonly.int.cube] :
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO MSTransformRegridder::calcChanFreqs phaseCenter='Direction: [0.377371, -0.657097, 0.652545]' Channels equidistant in freq
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO MSTransformRegridder::calcChanFreqs+ Central frequency (in output frame) = 1.49983e+09 Hz
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO MSTransformRegridder::calcChanFreqs+ Width of central channel (in output frame) = 4.99945e+08 Hz
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO MSTransformRegridder::calcChanFreqs+ Number of channels = 3
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO MSTransformRegridder::calcChanFreqs+ Total width of SPW (in output frame) = 1.49983e+09 Hz
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO MSTransformRegridder::calcChanFreqs+ Lower edge = 7.49917e+08 Hz, upper edge = 2.24975e+09 Hz
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO SynthesisImagerVi2::defineImage Impars: start
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO SynthesisImagerVi2::defineImage Shape: [800, 800, 1, 3] Spectral: [9.99889e+08] at [0] with increment [4.99945e+08]
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst.sp_mfs_intonly.int.cube] with ftmachine : gridft
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO sdintimaging::::casa CFCache already exists
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO SynthesisImagerVi2::weight() Set imaging weights : Natural weighting
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO SynthesisImager::makePSF ----------------------------------------------------------- Make PSF ---------------------------------------------
20-Apr-2026 13:41:07	2026-04-20 17:41:06 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:41:07	2026-04-20 17:41:07 INFO SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
20-Apr-2026 13:41:07	2026-04-20 17:41:07 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:41:07	2026-04-20 17:41:08 INFO sdintimaging::::casa Copying restoring beam(s) for 3 channel(s) from tst.sp_mfs_intonly.int.cube.psf to tst.sp_mfs_intonly.int.cube.residual
20-Apr-2026 13:41:07	2026-04-20 17:41:08 INFO image::_setrestoringbeam Will copy beams from another image to this image
20-Apr-2026 13:41:07	2026-04-20 17:41:08 INFO BeamManipulator::set Set image beam set
20-Apr-2026 13:41:07	2026-04-20 17:41:08 INFO sdintimaging::::casa Combined image setup ....
20-Apr-2026 13:41:07	2026-04-20 17:41:08 INFO sdintimaging::::casa Verifying Input Parameters
20-Apr-2026 13:41:07	2026-04-20 17:41:08 INFO SynthesisImagerVi2::selectData MS : papersky_standard.ms \| [Opened in readonly mode]
20-Apr-2026 13:41:07	2026-04-20 17:41:08 INFO SynthesisImagerVi2::selectData NRows selected : 6318
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.sp_mfs_intonly.joint.multiterm] :
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.sp_mfs_intonly.joint.multiterm] :
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SynthesisImagerVi2::defineImage Impars: start
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SynthesisImagerVi2::defineImage Shape: [800, 800, 1, 1] Spectral: [1.5e+09] at [0] with increment [1.50017e+09]
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst.sp_mfs_intonly.joint.multiterm] with ftmachine : gridft
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.2266 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SynthesisImagerVi2::weight() Set imaging weights : Natural weighting
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SynthesisImager::makePSF ----------------------------------------------------------- Make PSF ---------------------------------------------
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SIImageStoreMultiTerm::calcSensitivity Multi-Term Hessian Matrix : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order)
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SIImageStoreMultiTerm::calcSensitivity + [37908, -4.18539
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SIImageStoreMultiTerm::calcSensitivity + -4.18539, 2807.38]
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SIImageStoreMultiTerm::calcSensitivity Multi-Term Covariance Matrix : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order)
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SIImageStoreMultiTerm::calcSensitivity + [2.63797e-05, 3.93281e-08
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SIImageStoreMultiTerm::calcSensitivity + 3.93281e-08, 0.000356204]
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SIImageStoreMultiTerm::calcSensitivity [tst.sp_mfs_intonly.joint.multiterm][Taylor0] Theoretical sensitivity (Jy/bm):0.00513611
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SIImageStoreMultiTerm::calcSensitivity [tst.sp_mfs_intonly.joint.multiterm][Taylor1] Theoretical sensitivity (Jy/bm):0.0188734
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SIImageStoreMultiTerm::calcFractionalBandwidth MFS frequency range : 0.749917 GHz -> 2.25008GHz.Fractional Bandwidth : 100.011 %.Reference Frequency for Taylor Expansion : 1.5GHz.
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.019571
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SIImageStore::printBeamSet Beam : 53.662 arcsec, 53.2099 arcsec, 22.4308 deg
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SynthesisImagerVi2::makePrimaryBeam vi2 : Evaluating Primary Beam model onto image grid(s)
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst.sp_mfs_intonly.joint.multiterm] : mtmfs
20-Apr-2026 13:41:11	2026-04-20 17:41:08 INFO SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO sdintimaging::::casa Feathering INT and SD residual images...
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO SIImageStore::Open existing Images SumWt does not exist. Proceeding only with PSF
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO SynthesisUtilMethods::fitPsfBeam Fitting PSF beam for Imagestore : tst.sp_mfs_intonly.joint.cube
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.054662
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO SIImageStore::printBeamSet Restoring Beams
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO SIImageStore::printBeamSet + Chan Freq Vel Pol
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO SIImageStore::printBeamSet + 0 1.0e+09 33 I 78.1052 arcsec x 77.1472 arcsec pa= 15.4584 deg
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO SIImageStore::printBeamSet + 1 1.5e+09 -149846 I 52.0684 arcsec x 51.4678 arcsec pa= 14.3366 deg
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO SIImageStore::printBeamSet + 2 2.0e+09 -299726 I 39.0829 arcsec x 38.6031 arcsec pa= 10.7035 deg
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO sdintimaging::::casa Calculate spectral PSFs and Taylor Residuals...
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO SynthesisUtilMethods::fitPsfBeam Fitting PSF beam for Imagestore : tst.sp_mfs_intonly.joint.multiterm
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.021872
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO SIImageStore::printBeamSet Beam : 53.662 arcsec, 53.2099 arcsec, 22.4308 deg
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 1.02677
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO SynthesisDeconvolver::setupMask [tst.sp_mfs_intonly.joint.multiterm] Setting up a mask from [papersky_standard.true.im.masklist]
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO CasacRegionManager::fromBCS Using all spectral channels.
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:41:11	2026-04-20 17:41:09 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.
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO ImageMaskAttacher::makeMask Created and initialized mask `mask0'
20-Apr-2026 13:41:11	2026-04-20 17:41:09 WARN ImageRegridder::_doImagesOverlap At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO RegionTextParser::_determineVersion RegionTextParser::_determineVersion: Found spec version 0
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO AsciiRegionFileParser::_parse Combined 5 image regions (which excludes any annotation regions)
20-Apr-2026 13:41:11	2026-04-20 17:41:09 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).
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO SynthesisDeconvolver::setupMask ----------------------------------------------------------------------------------------------------------------------------------------
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO SynthesisDeconvolver::setupMask [tst.sp_mfs_intonly.joint.multiterm] Number of pixels in the clean mask : 44220 out of a total of 640000 pixels. [ 6.90937 % ]
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 1.02677, over full image : 1.02677
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO sdintimaging::::casa Minor Cycle controls : {'cycleniter': 50, 'cyclethreshold': 0.13124234974384308, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO SDAlgorithmBase::deconvolve [tst.sp_mfs_intonly.joint.multiterm] Run mtmfs minor-cycle \| CycleThreshold=0.131242, CycleNiter=50, Gain=0.1
20-Apr-2026 13:41:11	2026-04-20 17:41:09 INFO MultiTermMatrixCleaner::verifyScaleSizes() Scale sizes to be used for deconvolution : [0, 12, 20, 40, 60, 80, 100]
20-Apr-2026 13:41:11	2026-04-20 17:41:10 INFO MultiTermMatrixCleaner::setupScaleFunctions scale 1 = 0 pixels with bias = 1
20-Apr-2026 13:41:11	2026-04-20 17:41:10 INFO MultiTermMatrixCleaner::setupScaleFunctions scale 2 = 12 pixels with bias = 1
20-Apr-2026 13:41:11	2026-04-20 17:41:10 INFO MultiTermMatrixCleaner::setupScaleFunctions scale 3 = 20 pixels with bias = 1
20-Apr-2026 13:41:11	2026-04-20 17:41:10 INFO MultiTermMatrixCleaner::setupScaleFunctions scale 4 = 40 pixels with bias = 1
20-Apr-2026 13:41:11	2026-04-20 17:41:10 INFO MultiTermMatrixCleaner::setupScaleFunctions scale 5 = 60 pixels with bias = 1
20-Apr-2026 13:41:11	2026-04-20 17:41:10 INFO MultiTermMatrixCleaner::setupScaleFunctions scale 6 = 80 pixels with bias = 1
20-Apr-2026 13:41:11	2026-04-20 17:41:10 INFO MultiTermMatrixCleaner::setupScaleFunctions scale 7 = 100 pixels with bias = 1
20-Apr-2026 13:41:11	2026-04-20 17:41:10 INFO MultiTermMatrixCleaner::initialise() Using a PSF patch of 800 pixels on each side for minor-cycle updates.
20-Apr-2026 13:41:11	2026-04-20 17:41:10 INFO MatrixCleaner::validatePsf() Peak of PSF = 1 at [400, 400]
20-Apr-2026 13:41:11	2026-04-20 17:41:10 INFO SIImageStoreMultiTerm::calcFractionalBandwidth MFS frequency range : 0.749917 GHz -> 2.25008GHz.Fractional Bandwidth : 100.011 %.Reference Frequency for Taylor Expansion : 1.5GHz.
20-Apr-2026 13:41:11	2026-04-20 17:41:10 INFO MultiTermMatrixCleaner::computeHessianPeak Calculating PSF and Scale convolutions
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::computeHessianPeak The Matrix [H] for 0 pixel scale is : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order)
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::computeHessianPeak + [1, -0.00011096
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::computeHessianPeak + -0.00011096, 0.0740577]
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::computeHessianPeak The Matrix [H] for 12 pixel scale is : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order)
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::computeHessianPeak + [0.269944, -0.0235358
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::computeHessianPeak + -0.0235358, 0.0208027]
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::computeHessianPeak The Matrix [H] for 20 pixel scale is : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order)
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::computeHessianPeak + [0.144656, -0.0149637
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::computeHessianPeak + -0.0149637, 0.0112554]
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::computeHessianPeak The Matrix [H] for 40 pixel scale is : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order)
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::computeHessianPeak + [0.0482287, -0.00718351
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::computeHessianPeak + -0.00718351, 0.00387903]
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::computeHessianPeak The Matrix [H] for 60 pixel scale is : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order)
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::computeHessianPeak + [0.0199174, -0.0038471
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::computeHessianPeak + -0.0038471, 0.00167948]
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::computeHessianPeak The Matrix [H] for 80 pixel scale is : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order)
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::computeHessianPeak + [0.00884728, -0.00210331
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::computeHessianPeak + -0.00210331, 0.000784706]
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::computeHessianPeak The Matrix [H] for 100 pixel scale is : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order)
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::computeHessianPeak + [0.00409699, -0.00114236
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::computeHessianPeak + -0.00114236, 0.000391136]
20-Apr-2026 13:41:38	2026-04-20 17:41:11 INFO MultiTermMatrixCleaner::mtclean() Calculating convolutions of residual images with scales
20-Apr-2026 13:41:38	2026-04-20 17:41:12 INFO MultiTermMatrixCleaner::mtclean() Peak convolved residual (within mask) : 1.02677
20-Apr-2026 13:41:38	2026-04-20 17:41:16 INFO [20] Res: 0.779394 Max: 0.659354 Gain: 0.1 Pos: [299, 418] Scale: 100 Coeffs: 9.02184 -12.7335
20-Apr-2026 13:41:38	2026-04-20 17:41:21 INFO [40] Res: 0.574774 Max: 0.34656 Gain: 0.1 Pos: [350, 433] Scale: 0 Coeffs: 0.568653 -0.558771
20-Apr-2026 13:41:38	2026-04-20 17:41:24 INFO [50] Res: 0.469229 Max: 0.257043 Gain: 0.1 Pos: [317, 337] Scale: 100 Coeffs: 8.42532 1.82269
20-Apr-2026 13:41:38	2026-04-20 17:41:24 INFO MultiTermMatrixCleaner::mtclean() Reached max number of iterations for this minor cycle
20-Apr-2026 13:41:38	2026-04-20 17:41:24 INFO MultiTermMatrixCleaner::mtclean() Total flux by scale : [0]: 1.67817 [12]: 0 [20]: 0 [40]: 0 [60]: 0 [80]: 1.32963 [100]: 24.5833 (in this run)
20-Apr-2026 13:41:38	2026-04-20 17:41:24 INFO MultiTermMatrixCleaner::mtclean() Total flux by Taylor coefficient : [0]: 27.5911 [1]: -21.799
20-Apr-2026 13:41:38	2026-04-20 17:41:24 INFO SDAlgorithmBase::deconvolve [tst.sp_mfs_intonly.joint.multiterm] iters=0->50 [50], model=0->27.592, peakres=1.02677->0.469229, Reached cycleniter.
20-Apr-2026 13:41:38	2026-04-20 17:41:24 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 50 iterations.
20-Apr-2026 13:41:38	2026-04-20 17:41:24 INFO task_sdintimaging::image::_setrestoringbeam Will remove any existing beams from image
20-Apr-2026 13:41:38	2026-04-20 17:41:24 INFO task_sdintimaging:::: Deleted restoring beam(s)
20-Apr-2026 13:41:38	2026-04-20 17:41:24 INFO task_sdintimaging::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 2 -------------------------------------
20-Apr-2026 13:41:38	2026-04-20 17:41:24 INFO task_sdintimaging::SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:41:38	2026-04-20 17:41:25 INFO sdintimaging::::casa getSummary call: fullsummary=False
20-Apr-2026 13:41:38	2026-04-20 17:41:25 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.469255, over full image : 0.469255
20-Apr-2026 13:41:38	2026-04-20 17:41:25 INFO sdintimaging::::casa Minor Cycle controls : {'cycleniter': 50, 'cyclethreshold': 0.05998029187321663, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
20-Apr-2026 13:41:38	2026-04-20 17:41:25 INFO SDAlgorithmBase::deconvolve [tst.sp_mfs_intonly.joint.multiterm] Run mtmfs minor-cycle \| CycleThreshold=0.0599803, CycleNiter=50, Gain=0.1
20-Apr-2026 13:41:38	2026-04-20 17:41:25 INFO SIImageStoreMultiTerm::calcFractionalBandwidth MFS frequency range : 0.749917 GHz -> 2.25008GHz.Fractional Bandwidth : 100.011 %.Reference Frequency for Taylor Expansion : 1.5GHz.
20-Apr-2026 13:41:38	2026-04-20 17:41:25 INFO MultiTermMatrixCleaner::mtclean() Calculating convolutions of residual images with scales
20-Apr-2026 13:41:38	2026-04-20 17:41:25 INFO MultiTermMatrixCleaner::mtclean() Peak convolved residual (within mask) : 0.469255
20-Apr-2026 13:41:38	2026-04-20 17:41:28 INFO [60] Res: 0.426851 Max: 0.18522 Gain: 0.1 Pos: [297, 420] Scale: 100 Coeffs: 4.98596 -6.05836
20-Apr-2026 13:41:38	2026-04-20 17:41:32 INFO [80] Res: 0.283337 Max: 0.0991173 Gain: 0.1 Pos: [552, 400] Scale: 0 Coeffs: 0.314818 -0.00907864
20-Apr-2026 13:41:38	2026-04-20 17:41:37 INFO [100] Res: 0.209905 Max: 0.0544574 Gain: 0.1 Pos: [552, 400] Scale: 0 Coeffs: 0.233225 -0.0289525
20-Apr-2026 13:41:38	2026-04-20 17:41:37 INFO MultiTermMatrixCleaner::mtclean() Reached max number of iterations for this minor cycle
20-Apr-2026 13:41:38	2026-04-20 17:41:37 INFO MultiTermMatrixCleaner::mtclean() Total flux by scale : [0]: 2.48026 [12]: 0 [20]: 0 [40]: 0 [60]: 0.169947 [80]: 2.3891 [100]: 31.695 (in this run)
20-Apr-2026 13:41:38	2026-04-20 17:41:37 INFO MultiTermMatrixCleaner::mtclean() Total flux by Taylor coefficient : [0]: 36.7352 [1]: -23.2581
20-Apr-2026 13:41:38	2026-04-20 17:41:37 INFO SDAlgorithmBase::deconvolve [tst.sp_mfs_intonly.joint.multiterm] iters=0->50 [50], model=27.5913->36.7344, peakres=0.469255->0.209905, Reached cycleniter.
20-Apr-2026 13:41:38	2026-04-20 17:41:37 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 100 iterations.
20-Apr-2026 13:41:38	2026-04-20 17:41:38 INFO task_sdintimaging::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 3 -------------------------------------
20-Apr-2026 13:41:38	2026-04-20 17:41:38 INFO task_sdintimaging::SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:41:38	2026-04-20 17:41:38 INFO sdintimaging::::casa getSummary call: fullsummary=False
20-Apr-2026 13:41:38	2026-04-20 17:41:38 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.209898, over full image : 0.209898
20-Apr-2026 13:41:38	2026-04-20 17:41:38 INFO sdintimaging::::casa Reached global stopping criterion : iteration limit
20-Apr-2026 13:41:38	2026-04-20 17:41:38 INFO MultiTermMatrixCleaner::computeprincipalsolution() MTMC :: Computing principal solution on residuals
20-Apr-2026 13:41:38	2026-04-20 17:41:38 INFO SDAlgorithmBase::restore [tst.sp_mfs_intonly.joint.multiterm] : Restoring model image.
20-Apr-2026 13:41:38	2026-04-20 17:41:38 INFO SIImageStore::restore Beam for chan : 0 : 53.662 arcsec, 53.2099 arcsec, 22.4308 deg
20-Apr-2026 13:41:38	2026-04-20 17:41:39 INFO SIImageStore::restore Beam for chan : 0 : 53.662 arcsec, 53.2099 arcsec, 22.4308 deg
20-Apr-2026 13:41:38	2026-04-20 17:41:39 INFO SIImageStoreMultiTerm::calculateAlphaBeta Calculating spectral parameters for Intensity > peakresidual/10 = 0.0209895 Jy/beam
20-Apr-2026 13:41:38	2026-04-20 17:41:39 INFO SIImageStoreMultiTerm::calculateAlphaBeta Written Spectral Index Error Image : /home/casatest/work/test_task_sdintimaging/tst.sp_mfs_intonly.joint.multiterm.alpha.error
20-Apr-2026 13:41:38	2026-04-20 17:41:39 INFO SDAlgorithmMSMFS::restore Restored images :
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO SDAlgorithmMSMFS::restore /home/casatest/work/test_task_sdintimaging/tst.sp_mfs_intonly.joint.multiterm.image.tt0 (model=/home/casatest/work/test_task_sdintimaging/tst.sp_mfs_intonly.joint.multiterm.model.tt0)
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO SDAlgorithmMSMFS::restore /home/casatest/work/test_task_sdintimaging/tst.sp_mfs_intonly.joint.multiterm.image.tt1 (model=/home/casatest/work/test_task_sdintimaging/tst.sp_mfs_intonly.joint.multiterm.model.tt1)
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO SDAlgorithmMSMFS::restore
20-Apr-2026 13:41:39	master 1 init 1
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO sdintimaging::::casa Deleting tmp_365448_*plane
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO sdintimaging::::casa Searching for images with prefix 'tst.sp_mfs_intonly'... Found these, writing history into them: ['tst.sp_mfs_intonly.joint.multiterm.image.tt1', 'tst.sp_mfs_intonly.joint.multiterm.image.tt0', 'tst.sp_mfs_intonly.joint.multiterm.alpha', 'tst.sp_mfs_intonly.joint.multiterm.psf.tt0', 'tst.sp_mfs_intonly.joint.multiterm.pb.tt0', 'tst.sp_mfs_intonly.int.cube.pb', 'tst.sp_mfs_intonly.joint.multiterm.psf.tt2', 'tst.sp_mfs_intonly.joint.cube.psf', 'tst.sp_mfs_intonly.joint.multiterm.residual.tt1', 'tst.sp_mfs_intonly.joint.multiterm.residual.tt0', 'tst.sp_mfs_intonly.int.cube.sumwt', 'tst.sp_mfs_intonly.joint.multiterm.sumwt.tt1', 'tst.sp_mfs_intonly.joint.cube.residual', 'tst.sp_mfs_intonly.joint.multiterm.sumwt.tt2', 'tst.sp_mfs_intonly.joint.multiterm.model.tt1', 'tst.sp_mfs_intonly.joint.multiterm.alpha.error', 'tst.sp_mfs_intonly.joint.multiterm.sumwt.tt0', 'tst.sp_mfs_intonly.int.cube.residual', 'tst.sp_mfs_intonly.joint.multiterm.psf.tt1', 'tst.sp_mfs_intonly.joint.multiterm.model.tt0', 'tst.sp_mfs_intonly.joint.multiterm.mask', 'tst.sp_mfs_intonly.int.cube.psf', 'tst.sp_mfs_intonly.int.cube.model']
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO sdintimaging::::casa Task sdintimaging complete. Start time: 2026-04-20 17:41:05.834587 End time: 2026-04-20 17:41:38.956395
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO sdintimaging::::casa ##### End Task: sdintimaging #####
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO sdintimaging::::casa ##########################################
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO name:: No table opened.
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO showcache:: The Table Cache is empty.
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO sdintimaging::::casa [ check_ret_structure ] Return dictionary struture check: type=reduced ( Pass : found all expected keys )
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO sdintimaging::::casa+ [ check_ims ] Image made : ['tst.sp_mfs_intonly.joint.multiterm.psf.tt0', 'tst.sp_mfs_intonly.joint.multiterm.residual.tt0', 'tst.sp_mfs_intonly.joint.multiterm.image.tt0', 'tst.sp_mfs_intonly.joint.multiterm.image.tt1', 'tst.sp_mfs_intonly.joint.multiterm.alpha'] = [True, True, True, True, True] ( Pass : should all be True )
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO sdintimaging::::casa+ All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords)
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO sdintimaging::::casa+ [check_history] All expected history entries found. (Pass)
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_mfs_intonly.joint.multiterm.psf.tt0 : Value is 1.0 at [400, 400, 0, 0] ( Pass : should be 1.0 , Epsilon: 0.05)
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_mfs_intonly.joint.multiterm.image.tt0 : Value is 1.0936431884765625 at [350, 433, 0, 0] ( Pass : should be 1.09 , Epsilon: 0.05)
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_mfs_intonly.joint.multiterm.image.tt0 : Value is 0.10115920007228851 at [300, 400, 0, 0] ( Pass : should be 0.1 , Epsilon: 0.05)
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_mfs_intonly.joint.multiterm.alpha : Value is -0.9958438873291016 at [350, 433, 0, 0] ( Pass : should be -0.996 , Epsilon: 0.05)
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO sdintimaging::::casa+ [ check_pix_val ] tst.sp_mfs_intonly.joint.multiterm.alpha : Value is -2.353593587875366 at [300, 400, 0, 0] ( Pass : should be -2.35 , Epsilon: 0.05)
20-Apr-2026 13:41:39	.2026-04-20 17:41:39 INFO sdintimaging::::casa ##########################################
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO sdintimaging::::casa ##### Begin Task: sdintimaging #####
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO sdintimaging::::casa sdintimaging( usedata='sdint', sdimage='papersky_standard.sdimage', sdpsf='papersky_standard.sdpsf', sdgain=1.0, dishdia=100.0, vis='papersky_standard.ms', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst.sp_mfs_sdint', imsize=800, cell='9.0arcsec', phasecenter='J2000 19:59:28.500 +40.44.01.50', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='1.5GHz', nchan=3, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='nearest', perchanweightdensity=True, gridder='standard', facets=1, psfphasecenter='', wprojplanes=1, vptable='', mosweight=True, aterm=True, psterm=False, wbawp=True, cfcache='', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=-0.1, deconvolver='mtmfs', scales=[0, 12, 20, 40, 60, 80, 100], nterms=2, smallscalebias=0.0, restoration=True, restoringbeam=[], pbcor=False, weighting='natural', robust=0.5, noise='1.0Jy', npixels=0, uvtaper=[''], niter=100, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=20, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, fullsummary=False, nmajor=-1, usemask='user', mask='papersky_standard.true.im.masklist', 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, calcres=True, calcpsf=True )
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO sdintimaging::::casa Initializing SDINT Helper instance with tmp file tag 145333
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO sdintimaging::::casa INT cube setup ....
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO sdintimaging::::casa Verifying Input Parameters
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO SynthesisImagerVi2::selectData MS : papersky_standard.ms \| [Opened in readonly mode]
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO SynthesisImagerVi2::selectData NRows selected : 6318
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.sp_mfs_sdint.int.cube] :
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.sp_mfs_sdint.int.cube] :
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO MSTransformRegridder::calcChanFreqs phaseCenter='Direction: [0.377371, -0.657097, 0.652545]' Channels equidistant in freq
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO MSTransformRegridder::calcChanFreqs+ Central frequency (in output frame) = 1.49983e+09 Hz
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO MSTransformRegridder::calcChanFreqs+ Width of central channel (in output frame) = 4.99945e+08 Hz
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO MSTransformRegridder::calcChanFreqs+ Number of channels = 3
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO MSTransformRegridder::calcChanFreqs+ Total width of SPW (in output frame) = 1.49983e+09 Hz
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO MSTransformRegridder::calcChanFreqs+ Lower edge = 7.49917e+08 Hz, upper edge = 2.24975e+09 Hz
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO SynthesisImagerVi2::defineImage Impars: start
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO SynthesisImagerVi2::defineImage Shape: [800, 800, 1, 3] Spectral: [9.99889e+08] at [0] with increment [4.99945e+08]
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst.sp_mfs_sdint.int.cube] with ftmachine : gridft
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO sdintimaging::::casa CFCache already exists
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO SynthesisImagerVi2::weight() Set imaging weights : Natural weighting
20-Apr-2026 13:41:39	2026-04-20 17:41:39 INFO SynthesisImager::makePSF ----------------------------------------------------------- Make PSF ---------------------------------------------
20-Apr-2026 13:41:42	2026-04-20 17:41:39 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:41:42	2026-04-20 17:41:41 INFO SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
20-Apr-2026 13:41:42	2026-04-20 17:41:41 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:41:42	2026-04-20 17:41:41 INFO sdintimaging::::casa Copying restoring beam(s) for 3 channel(s) from tst.sp_mfs_sdint.int.cube.psf to tst.sp_mfs_sdint.int.cube.residual
20-Apr-2026 13:41:42	2026-04-20 17:41:41 INFO image::_setrestoringbeam Will copy beams from another image to this image
20-Apr-2026 13:41:42	2026-04-20 17:41:41 INFO BeamManipulator::set Set image beam set
20-Apr-2026 13:41:42	2026-04-20 17:41:41 INFO sdintimaging::::casa Combined image setup ....
20-Apr-2026 13:41:42	2026-04-20 17:41:41 INFO sdintimaging::::casa Verifying Input Parameters
20-Apr-2026 13:41:42	2026-04-20 17:41:41 INFO SynthesisImagerVi2::selectData MS : papersky_standard.ms \| [Opened in readonly mode]
20-Apr-2026 13:41:42	2026-04-20 17:41:41 INFO SynthesisImagerVi2::selectData NRows selected : 6318
20-Apr-2026 13:41:42	2026-04-20 17:41:41 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.sp_mfs_sdint.joint.multiterm] :
20-Apr-2026 13:41:42	2026-04-20 17:41:41 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.sp_mfs_sdint.joint.multiterm] :
20-Apr-2026 13:41:42	2026-04-20 17:41:41 INFO SynthesisImagerVi2::defineImage Impars: start
20-Apr-2026 13:41:42	2026-04-20 17:41:41 INFO SynthesisImagerVi2::defineImage Shape: [800, 800, 1, 1] Spectral: [1.5e+09] at [0] with increment [1.50017e+09]
20-Apr-2026 13:41:42	2026-04-20 17:41:41 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst.sp_mfs_sdint.joint.multiterm] with ftmachine : gridft
20-Apr-2026 13:41:42	2026-04-20 17:41:41 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.2266 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
20-Apr-2026 13:41:42	2026-04-20 17:41:41 INFO SynthesisImagerVi2::weight() Set imaging weights : Natural weighting
20-Apr-2026 13:41:42	2026-04-20 17:41:41 INFO SynthesisImager::makePSF ----------------------------------------------------------- Make PSF ---------------------------------------------
20-Apr-2026 13:41:42	2026-04-20 17:41:42 INFO SIImageStoreMultiTerm::calcSensitivity Multi-Term Hessian Matrix : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order)
20-Apr-2026 13:41:42	2026-04-20 17:41:42 INFO SIImageStoreMultiTerm::calcSensitivity + [37908, -4.18539
20-Apr-2026 13:41:42	2026-04-20 17:41:42 INFO SIImageStoreMultiTerm::calcSensitivity + -4.18539, 2807.38]
20-Apr-2026 13:41:42	2026-04-20 17:41:42 INFO SIImageStoreMultiTerm::calcSensitivity Multi-Term Covariance Matrix : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order)
20-Apr-2026 13:41:42	2026-04-20 17:41:42 INFO SIImageStoreMultiTerm::calcSensitivity + [2.63797e-05, 3.93281e-08
20-Apr-2026 13:41:42	2026-04-20 17:41:42 INFO SIImageStoreMultiTerm::calcSensitivity + 3.93281e-08, 0.000356204]
20-Apr-2026 13:41:42	2026-04-20 17:41:42 INFO SIImageStoreMultiTerm::calcSensitivity [tst.sp_mfs_sdint.joint.multiterm][Taylor0] Theoretical sensitivity (Jy/bm):0.00513611
20-Apr-2026 13:41:42	2026-04-20 17:41:42 INFO SIImageStoreMultiTerm::calcSensitivity [tst.sp_mfs_sdint.joint.multiterm][Taylor1] Theoretical sensitivity (Jy/bm):0.0188734
20-Apr-2026 13:41:42	2026-04-20 17:41:42 INFO SIImageStoreMultiTerm::calcFractionalBandwidth MFS frequency range : 0.749917 GHz -> 2.25008GHz.Fractional Bandwidth : 100.011 %.Reference Frequency for Taylor Expansion : 1.5GHz.
20-Apr-2026 13:41:42	2026-04-20 17:41:42 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.018617
20-Apr-2026 13:41:42	2026-04-20 17:41:42 INFO SIImageStore::printBeamSet Beam : 53.662 arcsec, 53.2099 arcsec, 22.4308 deg
20-Apr-2026 13:41:42	2026-04-20 17:41:42 INFO SynthesisImagerVi2::makePrimaryBeam vi2 : Evaluating Primary Beam model onto image grid(s)
20-Apr-2026 13:41:42	2026-04-20 17:41:42 INFO SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst.sp_mfs_sdint.joint.multiterm] : mtmfs
20-Apr-2026 13:41:42	2026-04-20 17:41:42 INFO SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
20-Apr-2026 13:41:42	2026-04-20 17:41:42 INFO sdintimaging::::casa SD cube setup ....
20-Apr-2026 13:41:42	2026-04-20 17:41:42 INFO sdintimaging::::casa Initializing SDINT Helper instance with tmp file tag 436723
20-Apr-2026 13:41:42	2026-04-20 17:41:42 INFO sdintimaging::::casa The center of psf coincides with int psf: (diffRA,diffDec)=( 0.0, 0.0)
20-Apr-2026 13:41:42	2026-04-20 17:41:42 INFO ImageMaskAttacher::makeMask Created and initialized mask `mask0'
20-Apr-2026 13:41:42	2026-04-20 17:41:42 WARN ImageRegridder::_doImagesOverlap At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
20-Apr-2026 13:41:42	2026-04-20 17:41:42 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:41:42	2026-04-20 17:41:42 INFO SubImageFactory::createImage Creating image 'tst.sp_mfs_sdint.sd.cube.residual' of shape [800, 800, 1, 3]
20-Apr-2026 13:41:42	2026-04-20 17:41:42 INFO ImageMaskAttacher::makeMask Created and initialized mask `mask0'
20-Apr-2026 13:41:42	2026-04-20 17:41:42 WARN ImageRegridder::_doImagesOverlap At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
20-Apr-2026 13:41:42	2026-04-20 17:41:42 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:41:42	2026-04-20 17:41:42 INFO SubImageFactory::createImage Creating image 'tst.sp_mfs_sdint.sd.cube.image' of shape [800, 800, 1, 3]
20-Apr-2026 13:41:42	2026-04-20 17:41:43 INFO ImageMaskAttacher::makeMask Created and initialized mask `mask0'
20-Apr-2026 13:41:42	2026-04-20 17:41:43 WARN ImageRegridder::_doImagesOverlap At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
20-Apr-2026 13:41:42	2026-04-20 17:41:43 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:41:42	2026-04-20 17:41:43 INFO SubImageFactory::createImage Creating image 'tst.sp_mfs_sdint.sd.cube.psf' of shape [800, 800, 1, 3]
20-Apr-2026 13:41:42	2026-04-20 17:41:43 INFO sdintimaging::::casa Deleting tmp_436723_*plane
20-Apr-2026 13:41:42	2026-04-20 17:41:43 WARN sdintimaging::task_sdintimaging::casa The cube for the major cycle has only 3 channels. A minimum of nterms = 2 channels is required for an accurate polynomial fit, but where possible at least 5 to 10 channels that span the frequency range are prefered in order to properly encode frequency dependent intensity and weights.
20-Apr-2026 13:41:42	2026-04-20 17:41:43 INFO sdintimaging::::casa Feathering INT and SD residual images...
20-Apr-2026 13:41:42	2026-04-20 17:41:43 INFO sdintimaging::::casa Deleting tmp_145333_*plane
20-Apr-2026 13:41:42	2026-04-20 17:41:43 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:41:42	2026-04-20 17:41:43 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:41:42	2026-04-20 17:41:43 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:41:42	2026-04-20 17:41:43 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:41:42	2026-04-20 17:41:43 INFO ImageRegion::fromRecord+ [0, 0, 0, 0] to [799, 799, 0, 0] (20:04:40.577, +39.43.34.655, I, 999889040.02Hz to 19:54:07.715, +41.43.25.344, I, 999889040.02Hz)
20-Apr-2026 13:41:42	2026-04-20 17:41:43 INFO ImageRegion::fromRecord Creating image 'tmp_145333_sdplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:41:42	2026-04-20 17:41:43 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:41:42	2026-04-20 17:41:43 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:41:42	2026-04-20 17:41:43 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO ImageRegion::fromRecord+ [0, 0, 0, 0] to [799, 799, 0, 0] (20:04:40.577, +39.43.34.655, I, 999889040.02Hz to 19:54:07.715, +41.43.25.344, I, 999889040.02Hz)
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO ImageRegion::fromRecord Creating image 'tmp_145333_intplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO sdintimaging::::casa start Feathering.....
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO Imager::setvp() Setting voltage pattern parameters
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO Imager::setvp() Sky position tolerance is 180 degrees
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO Imager::setvp() Using system default voltage patterns for each telescope
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO imager::setsdoptions() Setting single dish processing options
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO imager::feather()
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO imager::feather()+ Feathering together high and low resolution images...
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO imager::feather() Each input image has a single restoring beam.
20-Apr-2026 13:41:44	2026-04-20 17:41:43 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO sdintimaging::::casa Deleting tmp_145333_*plane
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO ImageRegion::fromRecord+ [0, 0, 0, 1] to [799, 799, 0, 1] (20:04:40.577, +39.43.34.655, I, 1.49983e+09Hz to 19:54:07.715, +41.43.25.344, I, 1.49983e+09Hz)
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO ImageRegion::fromRecord Creating image 'tmp_145333_sdplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO ImageRegion::fromRecord+ [0, 0, 0, 1] to [799, 799, 0, 1] (20:04:40.577, +39.43.34.655, I, 1.49983e+09Hz to 19:54:07.715, +41.43.25.344, I, 1.49983e+09Hz)
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO ImageRegion::fromRecord Creating image 'tmp_145333_intplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO sdintimaging::::casa start Feathering.....
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO Imager::setvp() Setting voltage pattern parameters
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO Imager::setvp() Sky position tolerance is 180 degrees
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO Imager::setvp() Using system default voltage patterns for each telescope
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO imager::setsdoptions() Setting single dish processing options
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO imager::feather()
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO imager::feather()+ Feathering together high and low resolution images...
20-Apr-2026 13:41:44	2026-04-20 17:41:43 INFO imager::feather() Each input image has a single restoring beam.
20-Apr-2026 13:41:44	2026-04-20 17:41:43 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO sdintimaging::::casa Deleting tmp_145333_*plane
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO ImageRegion::fromRecord+ [0, 0, 0, 2] to [799, 799, 0, 2] (20:04:40.577, +39.43.34.655, I, 1.99978e+09Hz to 19:54:07.715, +41.43.25.344, I, 1.99978e+09Hz)
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO ImageRegion::fromRecord Creating image 'tmp_145333_sdplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO ImageRegion::fromRecord+ [0, 0, 0, 2] to [799, 799, 0, 2] (20:04:40.577, +39.43.34.655, I, 1.99978e+09Hz to 19:54:07.715, +41.43.25.344, I, 1.99978e+09Hz)
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO ImageRegion::fromRecord Creating image 'tmp_145333_intplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO sdintimaging::::casa start Feathering.....
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO Imager::setvp() Setting voltage pattern parameters
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO Imager::setvp() Sky position tolerance is 180 degrees
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO Imager::setvp() Using system default voltage patterns for each telescope
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO imager::setsdoptions() Setting single dish processing options
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO imager::feather()
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO imager::feather()+ Feathering together high and low resolution images...
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO imager::feather() Each input image has a single restoring beam.
20-Apr-2026 13:41:44	2026-04-20 17:41:44 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO sdintimaging::::casa Deleting tmp_145333_*plane
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO ImageRegion::fromRecord+ [0, 0, 0, 0] to [799, 799, 0, 0] (20:04:40.577, +39.43.34.655, I, 999889040.02Hz to 19:54:07.715, +41.43.25.344, I, 999889040.02Hz)
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO ImageRegion::fromRecord Creating image 'tmp_145333_sdplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO ImageRegion::fromRecord+ [0, 0, 0, 0] to [799, 799, 0, 0] (20:04:40.577, +39.43.34.655, I, 999889040.02Hz to 19:54:07.715, +41.43.25.344, I, 999889040.02Hz)
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO ImageRegion::fromRecord Creating image 'tmp_145333_intplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO sdintimaging::::casa start Feathering.....
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO Imager::setvp() Setting voltage pattern parameters
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO Imager::setvp() Sky position tolerance is 180 degrees
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO Imager::setvp() Using system default voltage patterns for each telescope
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO imager::setsdoptions() Setting single dish processing options
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO imager::feather()
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO imager::feather()+ Feathering together high and low resolution images...
20-Apr-2026 13:41:44	2026-04-20 17:41:44 INFO imager::feather() Each input image has a single restoring beam.
20-Apr-2026 13:41:45	2026-04-20 17:41:44 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:41:45	2026-04-20 17:41:44 INFO sdintimaging::::casa Deleting tmp_145333_*plane
20-Apr-2026 13:41:45	2026-04-20 17:41:44 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:41:45	2026-04-20 17:41:44 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:41:45	2026-04-20 17:41:44 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:41:45	2026-04-20 17:41:44 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:41:45	2026-04-20 17:41:44 INFO ImageRegion::fromRecord+ [0, 0, 0, 1] to [799, 799, 0, 1] (20:04:40.577, +39.43.34.655, I, 1.49983e+09Hz to 19:54:07.715, +41.43.25.344, I, 1.49983e+09Hz)
20-Apr-2026 13:41:45	2026-04-20 17:41:44 INFO ImageRegion::fromRecord Creating image 'tmp_145333_sdplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:41:45	2026-04-20 17:41:44 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:41:45	2026-04-20 17:41:44 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:41:45	2026-04-20 17:41:44 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:41:45	2026-04-20 17:41:44 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:41:45	2026-04-20 17:41:44 INFO ImageRegion::fromRecord+ [0, 0, 0, 1] to [799, 799, 0, 1] (20:04:40.577, +39.43.34.655, I, 1.49983e+09Hz to 19:54:07.715, +41.43.25.344, I, 1.49983e+09Hz)
20-Apr-2026 13:41:45	2026-04-20 17:41:44 INFO ImageRegion::fromRecord Creating image 'tmp_145333_intplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:41:45	2026-04-20 17:41:44 INFO sdintimaging::::casa start Feathering.....
20-Apr-2026 13:41:45	2026-04-20 17:41:44 INFO Imager::setvp() Setting voltage pattern parameters
20-Apr-2026 13:41:45	2026-04-20 17:41:44 INFO Imager::setvp() Sky position tolerance is 180 degrees
20-Apr-2026 13:41:45	2026-04-20 17:41:44 INFO Imager::setvp() Using system default voltage patterns for each telescope
20-Apr-2026 13:41:45	2026-04-20 17:41:44 INFO imager::setsdoptions() Setting single dish processing options
20-Apr-2026 13:41:45	2026-04-20 17:41:44 INFO imager::feather()
20-Apr-2026 13:41:45	2026-04-20 17:41:44 INFO imager::feather()+ Feathering together high and low resolution images...
20-Apr-2026 13:41:45	2026-04-20 17:41:44 INFO imager::feather() Each input image has a single restoring beam.
20-Apr-2026 13:41:45	2026-04-20 17:41:44 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO sdintimaging::::casa Deleting tmp_145333_*plane
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO ImageRegion::fromRecord+ [0, 0, 0, 2] to [799, 799, 0, 2] (20:04:40.577, +39.43.34.655, I, 1.99978e+09Hz to 19:54:07.715, +41.43.25.344, I, 1.99978e+09Hz)
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO ImageRegion::fromRecord Creating image 'tmp_145333_sdplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO ImageRegion::fromRecord+ [0, 0, 0, 2] to [799, 799, 0, 2] (20:04:40.577, +39.43.34.655, I, 1.99978e+09Hz to 19:54:07.715, +41.43.25.344, I, 1.99978e+09Hz)
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO ImageRegion::fromRecord Creating image 'tmp_145333_intplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO sdintimaging::::casa start Feathering.....
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO Imager::setvp() Setting voltage pattern parameters
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO Imager::setvp() Sky position tolerance is 180 degrees
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO Imager::setvp() Using system default voltage patterns for each telescope
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO imager::setsdoptions() Setting single dish processing options
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO imager::feather()
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO imager::feather()+ Feathering together high and low resolution images...
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO imager::feather() Each input image has a single restoring beam.
20-Apr-2026 13:41:45	2026-04-20 17:41:45 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO SIImageStore::Open existing Images SumWt does not exist. Proceeding only with PSF
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO SynthesisUtilMethods::fitPsfBeam Fitting PSF beam for Imagestore : tst.sp_mfs_sdint.joint.cube
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.054647
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO SIImageStore::printBeamSet Restoring Beams
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO SIImageStore::printBeamSet + Chan Freq Vel Pol
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO SIImageStore::printBeamSet + 0 1.0e+09 33 I 77.5193 arcsec x 76.6073 arcsec pa= 11.1113 deg
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO SIImageStore::printBeamSet + 1 1.5e+09 -149846 I 51.6676 arcsec x 51.0710 arcsec pa= 11.3343 deg
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO SIImageStore::printBeamSet + 2 2.0e+09 -299726 I 38.7687 arcsec x 38.3203 arcsec pa= 14.0803 deg
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO sdintimaging::::casa Calculate spectral PSFs and Taylor Residuals...
20-Apr-2026 13:41:45	2026-04-20 17:41:45 INFO SynthesisUtilMethods::fitPsfBeam Fitting PSF beam for Imagestore : tst.sp_mfs_sdint.joint.multiterm
20-Apr-2026 13:41:45	2026-04-20 17:41:46 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.021786
20-Apr-2026 13:41:45	2026-04-20 17:41:46 INFO SIImageStore::printBeamSet Beam : 53.1832 arcsec, 52.7084 arcsec, 20.2963 deg
20-Apr-2026 13:41:45	2026-04-20 17:41:46 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 1.1314
20-Apr-2026 13:41:45	2026-04-20 17:41:46 INFO SynthesisDeconvolver::setupMask [tst.sp_mfs_sdint.joint.multiterm] Setting up a mask from [papersky_standard.true.im.masklist]
20-Apr-2026 13:41:45	2026-04-20 17:41:46 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:41:45	2026-04-20 17:41:46 INFO CasacRegionManager::fromBCS Using all spectral channels.
20-Apr-2026 13:41:45	2026-04-20 17:41:46 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:41:45	2026-04-20 17:41:46 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.
20-Apr-2026 13:41:45	2026-04-20 17:41:46 INFO ImageMaskAttacher::makeMask Created and initialized mask `mask0'
20-Apr-2026 13:41:45	2026-04-20 17:41:46 WARN ImageRegridder::_doImagesOverlap At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
20-Apr-2026 13:41:45	2026-04-20 17:41:46 INFO RegionTextParser::_determineVersion RegionTextParser::_determineVersion: Found spec version 0
20-Apr-2026 13:41:45	2026-04-20 17:41:46 INFO AsciiRegionFileParser::_parse Combined 5 image regions (which excludes any annotation regions)
20-Apr-2026 13:41:45	2026-04-20 17:41:46 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).
20-Apr-2026 13:41:45	2026-04-20 17:41:46 INFO SynthesisDeconvolver::setupMask ----------------------------------------------------------------------------------------------------------------------------------------
20-Apr-2026 13:41:55	2026-04-20 17:41:46 INFO SynthesisDeconvolver::setupMask [tst.sp_mfs_sdint.joint.multiterm] Number of pixels in the clean mask : 44220 out of a total of 640000 pixels. [ 6.90937 % ]
20-Apr-2026 13:41:55	2026-04-20 17:41:46 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 1.1314, over full image : 1.1314
20-Apr-2026 13:41:55	2026-04-20 17:41:46 INFO sdintimaging::::casa Minor Cycle controls : {'cycleniter': 20, 'cyclethreshold': 0.1363893300294876, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
20-Apr-2026 13:41:55	2026-04-20 17:41:46 INFO SDAlgorithmBase::deconvolve [tst.sp_mfs_sdint.joint.multiterm] Run mtmfs minor-cycle \| CycleThreshold=0.136389, CycleNiter=20, Gain=0.1
20-Apr-2026 13:41:55	2026-04-20 17:41:46 INFO MultiTermMatrixCleaner::verifyScaleSizes() Scale sizes to be used for deconvolution : [0, 12, 20, 40, 60, 80, 100]
20-Apr-2026 13:41:55	2026-04-20 17:41:46 INFO MultiTermMatrixCleaner::setupScaleFunctions scale 1 = 0 pixels with bias = 1
20-Apr-2026 13:41:55	2026-04-20 17:41:46 INFO MultiTermMatrixCleaner::setupScaleFunctions scale 2 = 12 pixels with bias = 1
20-Apr-2026 13:41:55	2026-04-20 17:41:46 INFO MultiTermMatrixCleaner::setupScaleFunctions scale 3 = 20 pixels with bias = 1
20-Apr-2026 13:41:55	2026-04-20 17:41:46 INFO MultiTermMatrixCleaner::setupScaleFunctions scale 4 = 40 pixels with bias = 1
20-Apr-2026 13:41:55	2026-04-20 17:41:46 INFO MultiTermMatrixCleaner::setupScaleFunctions scale 5 = 60 pixels with bias = 1
20-Apr-2026 13:41:55	2026-04-20 17:41:46 INFO MultiTermMatrixCleaner::setupScaleFunctions scale 6 = 80 pixels with bias = 1
20-Apr-2026 13:41:55	2026-04-20 17:41:46 INFO MultiTermMatrixCleaner::setupScaleFunctions scale 7 = 100 pixels with bias = 1
20-Apr-2026 13:41:55	2026-04-20 17:41:46 INFO MultiTermMatrixCleaner::initialise() Using a PSF patch of 800 pixels on each side for minor-cycle updates.
20-Apr-2026 13:41:55	2026-04-20 17:41:46 INFO MatrixCleaner::validatePsf() Peak of PSF = 0.990617 at [400, 400]
20-Apr-2026 13:41:55	2026-04-20 17:41:46 INFO SIImageStoreMultiTerm::calcFractionalBandwidth MFS frequency range : 0.749917 GHz -> 2.25008GHz.Fractional Bandwidth : 100.011 %.Reference Frequency for Taylor Expansion : 1.5GHz.
20-Apr-2026 13:41:55	2026-04-20 17:41:46 INFO MultiTermMatrixCleaner::computeHessianPeak Calculating PSF and Scale convolutions
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::computeHessianPeak The Matrix [H] for 0 pixel scale is : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order)
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::computeHessianPeak + [0.990617, -0.000119891
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::computeHessianPeak + -0.000119891, 0.073365]
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::computeHessianPeak The Matrix [H] for 12 pixel scale is : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order)
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::computeHessianPeak + [0.261247, -0.0234538
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::computeHessianPeak + -0.0234538, 0.0201623]
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::computeHessianPeak The Matrix [H] for 20 pixel scale is : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order)
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::computeHessianPeak + [0.137015, -0.0147553
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::computeHessianPeak + -0.0147553, 0.0106943]
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::computeHessianPeak The Matrix [H] for 40 pixel scale is : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order)
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::computeHessianPeak + [0.0438432, -0.00670719
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::computeHessianPeak + -0.00670719, 0.00355362]
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::computeHessianPeak The Matrix [H] for 60 pixel scale is : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order)
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::computeHessianPeak + [0.0181479, -0.00334112
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::computeHessianPeak + -0.00334112, 0.00153626]
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::computeHessianPeak The Matrix [H] for 80 pixel scale is : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order)
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::computeHessianPeak + [0.00861385, -0.00173856
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::computeHessianPeak + -0.00173856, 0.000747211]
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::computeHessianPeak The Matrix [H] for 100 pixel scale is : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order)
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::computeHessianPeak + [0.00459695, -0.000958446
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::computeHessianPeak + -0.000958446, 0.00040842]
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::mtclean() Calculating convolutions of residual images with scales
20-Apr-2026 13:41:55	2026-04-20 17:41:48 INFO MultiTermMatrixCleaner::mtclean() Peak convolved residual (within mask) : 1.14211
20-Apr-2026 13:41:55	2026-04-20 17:41:53 INFO [20] Res: 1.06781 Max: 1.29809 Gain: 0.1 Pos: [297, 423] Scale: 100 Coeffs: 18.4318 8.24836
20-Apr-2026 13:41:55	2026-04-20 17:41:53 INFO MultiTermMatrixCleaner::mtclean() Reached max number of iterations for this minor cycle
20-Apr-2026 13:41:55	2026-04-20 17:41:53 INFO MultiTermMatrixCleaner::mtclean() Total flux by scale : [0]: 0.114076 [12]: 0 [20]: 0 [40]: 0 [60]: 0 [80]: 0 [100]: 58.914 (in this run)
20-Apr-2026 13:41:55	2026-04-20 17:41:53 INFO MultiTermMatrixCleaner::mtclean() Total flux by Taylor coefficient : [0]: 59.0281 [1]: 30.2788
20-Apr-2026 13:41:55	2026-04-20 17:41:53 INFO SDAlgorithmBase::deconvolve [tst.sp_mfs_sdint.joint.multiterm] iters=0->20 [20], model=0->59.0275, peakres=1.1314->1.05779, Reached cycleniter.
20-Apr-2026 13:41:55	2026-04-20 17:41:53 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 20 iterations.
20-Apr-2026 13:41:55	2026-04-20 17:41:53 INFO task_sdintimaging::image::_setrestoringbeam Will remove any existing beams from image
20-Apr-2026 13:41:55	2026-04-20 17:41:53 INFO task_sdintimaging:::: Deleted restoring beam(s)
20-Apr-2026 13:41:55	2026-04-20 17:41:54 INFO task_sdintimaging::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 2 -------------------------------------
20-Apr-2026 13:41:55	2026-04-20 17:41:54 INFO task_sdintimaging::SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:41:55	2026-04-20 17:41:55 INFO sdintimaging::::casa Deleting tmp_145333_*plane
20-Apr-2026 13:41:55	2026-04-20 17:41:55 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:41:55	2026-04-20 17:41:55 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:41:55	2026-04-20 17:41:55 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:41:55	2026-04-20 17:41:55 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:41:55	2026-04-20 17:41:55 INFO ImageRegion::fromRecord+ [0, 0, 0, 0] to [799, 799, 0, 0] (20:04:40.577, +39.43.34.655, I, 999889040.02Hz to 19:54:07.715, +41.43.25.344, I, 999889040.02Hz)
20-Apr-2026 13:41:55	2026-04-20 17:41:55 INFO ImageRegion::fromRecord Creating image 'tmp_145333_sdplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:41:55	2026-04-20 17:41:55 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:41:55	2026-04-20 17:41:55 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:41:55	2026-04-20 17:41:55 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:41:55	2026-04-20 17:41:55 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:41:55	2026-04-20 17:41:55 INFO ImageRegion::fromRecord+ [0, 0, 0, 0] to [799, 799, 0, 0] (20:04:40.577, +39.43.34.655, I, 999889040.02Hz to 19:54:07.715, +41.43.25.344, I, 999889040.02Hz)
20-Apr-2026 13:41:55	2026-04-20 17:41:55 INFO ImageRegion::fromRecord Creating image 'tmp_145333_intplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:41:55	2026-04-20 17:41:55 INFO sdintimaging::::casa start Feathering.....
20-Apr-2026 13:41:55	2026-04-20 17:41:55 INFO Imager::setvp() Setting voltage pattern parameters
20-Apr-2026 13:41:55	2026-04-20 17:41:55 INFO Imager::setvp() Sky position tolerance is 180 degrees
20-Apr-2026 13:41:55	2026-04-20 17:41:55 INFO Imager::setvp() Using system default voltage patterns for each telescope
20-Apr-2026 13:41:55	2026-04-20 17:41:55 INFO imager::setsdoptions() Setting single dish processing options
20-Apr-2026 13:41:55	2026-04-20 17:41:55 INFO imager::feather()
20-Apr-2026 13:41:55	2026-04-20 17:41:55 INFO imager::feather()+ Feathering together high and low resolution images...
20-Apr-2026 13:41:55	2026-04-20 17:41:55 INFO imager::feather() Each input image has a single restoring beam.
20-Apr-2026 13:42:03	2026-04-20 17:41:55 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:42:03	2026-04-20 17:41:55 INFO sdintimaging::::casa Deleting tmp_145333_*plane
20-Apr-2026 13:42:03	2026-04-20 17:41:55 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:42:03	2026-04-20 17:41:55 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:42:03	2026-04-20 17:41:55 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:42:03	2026-04-20 17:41:55 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:42:03	2026-04-20 17:41:55 INFO ImageRegion::fromRecord+ [0, 0, 0, 1] to [799, 799, 0, 1] (20:04:40.577, +39.43.34.655, I, 1.49983e+09Hz to 19:54:07.715, +41.43.25.344, I, 1.49983e+09Hz)
20-Apr-2026 13:42:03	2026-04-20 17:41:55 INFO ImageRegion::fromRecord Creating image 'tmp_145333_sdplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO ImageRegion::fromRecord+ [0, 0, 0, 1] to [799, 799, 0, 1] (20:04:40.577, +39.43.34.655, I, 1.49983e+09Hz to 19:54:07.715, +41.43.25.344, I, 1.49983e+09Hz)
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO ImageRegion::fromRecord Creating image 'tmp_145333_intplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO sdintimaging::::casa start Feathering.....
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO Imager::setvp() Setting voltage pattern parameters
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO Imager::setvp() Sky position tolerance is 180 degrees
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO Imager::setvp() Using system default voltage patterns for each telescope
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO imager::setsdoptions() Setting single dish processing options
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO imager::feather()
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO imager::feather()+ Feathering together high and low resolution images...
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO imager::feather() Each input image has a single restoring beam.
20-Apr-2026 13:42:03	2026-04-20 17:41:56 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO sdintimaging::::casa Deleting tmp_145333_*plane
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO ImageRegion::fromRecord+ [0, 0, 0, 2] to [799, 799, 0, 2] (20:04:40.577, +39.43.34.655, I, 1.99978e+09Hz to 19:54:07.715, +41.43.25.344, I, 1.99978e+09Hz)
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO ImageRegion::fromRecord Creating image 'tmp_145333_sdplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO ImageRegion::fromRecord+ [0, 0, 0, 2] to [799, 799, 0, 2] (20:04:40.577, +39.43.34.655, I, 1.99978e+09Hz to 19:54:07.715, +41.43.25.344, I, 1.99978e+09Hz)
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO ImageRegion::fromRecord Creating image 'tmp_145333_intplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO sdintimaging::::casa start Feathering.....
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO Imager::setvp() Setting voltage pattern parameters
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO Imager::setvp() Sky position tolerance is 180 degrees
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO Imager::setvp() Using system default voltage patterns for each telescope
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO imager::setsdoptions() Setting single dish processing options
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO imager::feather()
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO imager::feather()+ Feathering together high and low resolution images...
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO imager::feather() Each input image has a single restoring beam.
20-Apr-2026 13:42:03	2026-04-20 17:41:56 WARN ImageRegrid::regrid You are regridding an image whose beam is not well sampled by the pixel size. Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO sdintimaging::::casa getSummary call: fullsummary=False
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 1.05779, over full image : 1.05779
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO sdintimaging::::casa Minor Cycle controls : {'cycleniter': 20, 'cyclethreshold': 0.12751585245132446, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO SDAlgorithmBase::deconvolve [tst.sp_mfs_sdint.joint.multiterm] Run mtmfs minor-cycle \| CycleThreshold=0.127516, CycleNiter=20, Gain=0.1
20-Apr-2026 13:42:03	2026-04-20 17:41:56 INFO SIImageStoreMultiTerm::calcFractionalBandwidth MFS frequency range : 0.749917 GHz -> 2.25008GHz.Fractional Bandwidth : 100.011 %.Reference Frequency for Taylor Expansion : 1.5GHz.
20-Apr-2026 13:42:03	2026-04-20 17:41:57 INFO MultiTermMatrixCleaner::mtclean() Calculating convolutions of residual images with scales
20-Apr-2026 13:42:03	2026-04-20 17:41:57 INFO MultiTermMatrixCleaner::mtclean() Peak convolved residual (within mask) : 1.06781
20-Apr-2026 13:42:03	2026-04-20 17:42:01 INFO [40] Res: 0.739462 Max: 0.633658 Gain: 0.1 Pos: [552, 400] Scale: 0 Coeffs: 0.799742 0.0328288
20-Apr-2026 13:42:03	2026-04-20 17:42:01 INFO MultiTermMatrixCleaner::mtclean() Reached max number of iterations for this minor cycle
20-Apr-2026 13:42:03	2026-04-20 17:42:01 INFO MultiTermMatrixCleaner::mtclean() Total flux by scale : [0]: 1.02602 [12]: 0 [20]: 0 [40]: 0 [60]: 0 [80]: 0 [100]: 73.3076 (in this run)
20-Apr-2026 13:42:03	2026-04-20 17:42:01 INFO MultiTermMatrixCleaner::mtclean() Total flux by Taylor coefficient : [0]: 74.333 [1]: 34.0242
20-Apr-2026 13:42:03	2026-04-20 17:42:02 INFO SDAlgorithmBase::deconvolve [tst.sp_mfs_sdint.joint.multiterm] iters=0->20 [20], model=59.0284->74.3311, peakres=1.05779->0.732523, Reached cycleniter.
20-Apr-2026 13:42:03	2026-04-20 17:42:02 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 40 iterations.
20-Apr-2026 13:42:03	2026-04-20 17:42:02 INFO task_sdintimaging::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 3 -------------------------------------
20-Apr-2026 13:42:03	2026-04-20 17:42:02 INFO task_sdintimaging::SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.4079 GB. Available mem.: 192.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
20-Apr-2026 13:42:03	2026-04-20 17:42:03 INFO sdintimaging::::casa Deleting tmp_145333_*plane
20-Apr-2026 13:42:03	2026-04-20 17:42:03 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:42:03	2026-04-20 17:42:03 INFO CasacRegionManager::fromBCS Using channel range(s)
20-Apr-2026 13:42:03	2026-04-20 17:42:03 INFO CasacRegionManager::fromBCS Using polarizations ALL
20-Apr-2026 13:42:03	2026-04-20 17:42:03 INFO ImageRegion::fromRecord Selected bounding box :
20-Apr-2026 13:42:03	2026-04-20 17:42:03 INFO ImageRegion::fromRecord+ [0, 0, 0, 0] to [799, 799, 0, 0] (20:04:40.577, +39.43.34.655, I, 999889040.02Hz to 19:54:07.715, +41.43.25.344, I, 999889040.02Hz)
20-Apr-2026 13:42:03	2026-04-20 17:42:03 INFO ImageRegion::fromRecord Creating image 'tmp_145333_sdplane' of shape [800, 800, 1, 1]
20-Apr-2026 13:42:03	2026-04-20 17:42:03 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane.
20-Apr-2026 13:42:03	Failing task since return code of [/export/data_1/bamboohome/temp/CASASPECS-RELEASE675TESTCASALITHPY312-MTR93-3-ScriptBuildTask-6415883054575860727.sh] was 143 while expected 0
20-Apr-2026 13:42:03	Finished task 'MPI Tasks Tests on EL8' with result: Failed
20-Apr-2026 13:42:03	Running post build plugin 'Docker Container Cleanup'
20-Apr-2026 13:42:03	Running post build plugin 'NCover Results Collector'
20-Apr-2026 13:42:03	Force Stop build feature is enabled for current plan. Either Bamboo has detected the build has hung or it has been manually stopped.
20-Apr-2026 13:42:03	Attempting to generate stack trace and terminate spawned sub-processes of process id: 14902
20-Apr-2026 13:42:03	Running post build plugin 'Build Results Label Collector'
20-Apr-2026 13:42:03	Running post build plugin 'Clover Results Collector'
20-Apr-2026 13:42:03	Found related process: pid: 1045169 ppid: 1 pgid: 14876 %cpu: 0.0 %mem: 0.0 cmd: docker
20-Apr-2026 13:42:03	getStackTraceAndKillRelatedProcesses for 1 processes
20-Apr-2026 13:42:03	Executing kill -3 1045169
20-Apr-2026 13:42:03	Running post build plugin 'npm Cache Cleanup'
20-Apr-2026 13:42:03	Running post build plugin 'Artifact Copier'
20-Apr-2026 13:42:03	Finalising the build...
20-Apr-2026 13:42:03	Stopping timer.
20-Apr-2026 13:42:03	Build CASASPECS-RELEASE675TESTCASALITHPY312-MTR93-3 completed.
20-Apr-2026 13:42:04	Running on server: post build plugin 'Build Hanging Detection Configuration'
20-Apr-2026 13:42:04	Running on server: post build plugin 'NCover Results Collector'
20-Apr-2026 13:42:04	Running on server: post build plugin 'Build Labeller'
20-Apr-2026 13:42:04	Running on server: post build plugin 'Clover Delta Calculator'
20-Apr-2026 13:42:04	Running on server: post build plugin 'Maven Dependencies Postprocessor'
20-Apr-2026 13:42:04	All post build plugins have finished
20-Apr-2026 13:42:04	Generating build results summary...
20-Apr-2026 13:42:04	Saving build results to disk...
20-Apr-2026 13:42:04	Store variable context...
20-Apr-2026 13:42:04	Finished building CASASPECS-RELEASE675TESTCASALITHPY312-MTR93-3.
20-Apr-2026 13:42:08	Killing: 1045169
20-Apr-2026 13:42:08	Executing kill 1045169
20-Apr-2026 13:42:13	Force Stop build feature is enabled for current plan. Either Bamboo has detected the build has hung or it has been manually stopped.
20-Apr-2026 13:42:13	Has finished generating stack trace and terminating spawned sub-processes of process id: 14902

Build: #3 did not complete

Job: Test MPI Task Tests Many Linux 2.28 Rocky 9.5 Docker did not complete

Stages & jobs

Default Stage

Build log

Build #3

Build: #3 did not complete

Job: Test MPI Task Tests Many Linux 2.28 Rocky 9.5 Docker did not complete

Stages & jobs

Default Stage

Build log