Build: #1 was successful

Job: Test Casalith Cvpost Many Linux 2.28 was successful

Stages & jobs

  1. Default Stage

Build log

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

24-Apr-2026 02:55:00 2026-04-24 02:55:00        INFO        sdintimaging::::casa        Initializing SDINT Helper instance with tmp file tag 252634
24-Apr-2026 02:55:00 2026-04-24 02:55:00        INFO        sdintimaging::::casa         The center of psf coincides with int psf: (diffRA,diffDec)=( 0.0, 0.0)
24-Apr-2026 02:55:00 2026-04-24 02:55:00        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Apr-2026 02:55:00 2026-04-24 02:55:00        WARN        ImageRegridder::_doImagesOverlap        At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
24-Apr-2026 02:55:00 2026-04-24 02:55:00        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.
24-Apr-2026 02:55:00 2026-04-24 02:55:00        INFO        SubImageFactory::createImage        Creating image 'tst.sp_mfs_sdint.sd.cube.residual' of shape [800, 800, 1, 3]
24-Apr-2026 02:55:00 2026-04-24 02:55:00        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Apr-2026 02:55:00 2026-04-24 02:55:00        WARN        ImageRegridder::_doImagesOverlap        At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
24-Apr-2026 02:55:00 2026-04-24 02:55:00        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.
24-Apr-2026 02:55:00 2026-04-24 02:55:00        INFO        SubImageFactory::createImage        Creating image 'tst.sp_mfs_sdint.sd.cube.image' of shape [800, 800, 1, 3]
24-Apr-2026 02:55:00 2026-04-24 02:55:00        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Apr-2026 02:55:00 2026-04-24 02:55:00        WARN        ImageRegridder::_doImagesOverlap        At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
24-Apr-2026 02:55:00 2026-04-24 02:55:00        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.
24-Apr-2026 02:55:00 2026-04-24 02:55:00        INFO        SubImageFactory::createImage        Creating image 'tst.sp_mfs_sdint.sd.cube.psf' of shape [800, 800, 1, 3]
24-Apr-2026 02:55:00 2026-04-24 02:55:00        INFO        sdintimaging::::casa        Deleting tmp_252634_*plane
24-Apr-2026 02:55:00 2026-04-24 02:55:00        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.
24-Apr-2026 02:55:00 2026-04-24 02:55:00        INFO        sdintimaging::::casa        There are 1 empty channels in the interferometer cube. These channels will be excluded from the feathering step.
24-Apr-2026 02:55:00 2026-04-24 02:55:00        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.]
24-Apr-2026 02:55:00 2026-04-24 02:55:00        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
24-Apr-2026 02:55:00 2026-04-24 02:55:00        INFO        sdintimaging::::casa        Feathering INT and SD residual images...
24-Apr-2026 02:55:00 2026-04-24 02:55:00        INFO        sdintimaging::::casa        Deleting tmp_975190_*plane
24-Apr-2026 02:55:00 2026-04-24 02:55:00        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:55:00 2026-04-24 02:55:00        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:55:00 2026-04-24 02:55:00        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:55:00 2026-04-24 02:55:00        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:55:00 2026-04-24 02:55:00        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)
24-Apr-2026 02:55:00 2026-04-24 02:55:00        INFO        ImageRegion::fromRecord        Creating image 'tmp_975190_sdplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:55:00 2026-04-24 02:55:01        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:55:00 2026-04-24 02:55:01        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:55:00 2026-04-24 02:55:01        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:55:00 2026-04-24 02:55:01        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:55:02 2026-04-24 02:55:01        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)
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        ImageRegion::fromRecord        Creating image 'tmp_975190_intplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        sdintimaging::::casa        start Feathering.....
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        Imager::setvp()         Setting voltage pattern parameters
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        Imager::setvp()         Sky position tolerance is 180 degrees
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        Imager::setvp()         Using system default voltage patterns for each telescope
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        imager::setsdoptions()         Setting single dish processing options
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        imager::feather()        
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        imager::feather()+        Feathering together high and low resolution images...
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        imager::feather()        Each input image has a single restoring beam.
24-Apr-2026 02:55:02 2026-04-24 02:55:01        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.
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        sdintimaging::::casa        Deleting tmp_975190_*plane
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:55:02 2026-04-24 02:55:01        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)
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        ImageRegion::fromRecord        Creating image 'tmp_975190_sdplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:55:02 2026-04-24 02:55:01        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)
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        ImageRegion::fromRecord        Creating image 'tmp_975190_intplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        sdintimaging::::casa        start Feathering.....
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        Imager::setvp()         Setting voltage pattern parameters
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        Imager::setvp()         Sky position tolerance is 180 degrees
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        Imager::setvp()         Using system default voltage patterns for each telescope
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        imager::setsdoptions()         Setting single dish processing options
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        imager::feather()        
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        imager::feather()+        Feathering together high and low resolution images...
24-Apr-2026 02:55:02 2026-04-24 02:55:01        INFO        imager::feather()        Each input image has a single restoring beam.
24-Apr-2026 02:55:02 2026-04-24 02:55:01        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.
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        sdintimaging::::casa        Deleting tmp_975190_*plane
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:55:02 2026-04-24 02:55:02        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)
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        ImageRegion::fromRecord        Creating image 'tmp_975190_sdplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:55:02 2026-04-24 02:55:02        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)
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        ImageRegion::fromRecord        Creating image 'tmp_975190_intplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        sdintimaging::::casa        start Feathering.....
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        Imager::setvp()         Setting voltage pattern parameters
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        Imager::setvp()         Sky position tolerance is 180 degrees
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        Imager::setvp()         Using system default voltage patterns for each telescope
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        imager::setsdoptions()         Setting single dish processing options
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        imager::feather()        
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        imager::feather()+        Feathering together high and low resolution images...
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        imager::feather()        Each input image has a single restoring beam.
24-Apr-2026 02:55:02 2026-04-24 02:55:02        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.
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        sdintimaging::::casa        Deleting tmp_975190_*plane
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:55:02 2026-04-24 02:55:02        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)
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        ImageRegion::fromRecord        Creating image 'tmp_975190_sdplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:55:02 2026-04-24 02:55:02        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)
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        ImageRegion::fromRecord        Creating image 'tmp_975190_intplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        sdintimaging::::casa        start Feathering.....
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        Imager::setvp()         Setting voltage pattern parameters
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        Imager::setvp()         Sky position tolerance is 180 degrees
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        Imager::setvp()         Using system default voltage patterns for each telescope
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        imager::setsdoptions()         Setting single dish processing options
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        imager::feather()        
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        imager::feather()+        Feathering together high and low resolution images...
24-Apr-2026 02:55:02 2026-04-24 02:55:02        INFO        imager::feather()        Each input image has a single restoring beam.
24-Apr-2026 02:55:12 2026-04-24 02:55:02        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.
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        SIImageStore::Open existing Images         SumWt does not exist. Proceeding only with PSF
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        SynthesisUtilMethods::fitPsfBeam        Fitting PSF beam for Imagestore : tst.sp_mfs_sdint.joint.cube
24-Apr-2026 02:55:12 2026-04-24 02:55:03        WARN        SIImageStore::getPSFGaussian (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SIImageStore.cc, line 2143)        PSF is blank for[C2:P0]
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        SIImageStore::getPSFGaussian         Time to fit Gaussian to PSF 0.039933
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        SIImageStore::printBeamSet         Restoring Beams
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        SIImageStore::printBeamSet +        Chan    Freq   Vel Pol
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        SIImageStore::printBeamSet +           0 1.0e+09    33   I   77.5193 arcsec x   76.6073 arcsec pa= 11.1113 deg
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        SIImageStore::printBeamSet +           1 1.5e+09 -149846   I   51.6676 arcsec x   51.0710 arcsec pa= 11.3343 deg
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        SIImageStore::printBeamSet +           2 2.0e+09 -299726   I   77.5193 arcsec x   76.6073 arcsec pa= 11.1113 deg
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        sdintimaging::::casa        Calculate spectral PSFs and Taylor Residuals...
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        SynthesisUtilMethods::fitPsfBeam        Fitting PSF beam for Imagestore : tst.sp_mfs_sdint.joint.multiterm
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        SIImageStore::getPSFGaussian         Time to fit Gaussian to PSF 0.015924
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        SIImageStore::printBeamSet         Beam : 62.8224 arcsec, 62.2044 arcsec, 13.3205 deg
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0, over full image : 1.29169
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        SynthesisDeconvolver::setupMask         [tst.sp_mfs_sdint.joint.multiterm] Setting up a mask from [papersky_standard.true.im.masklist]
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:55:12 2026-04-24 02:55:03        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.
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Apr-2026 02:55:12 2026-04-24 02:55:03        WARN        ImageRegridder::_doImagesOverlap        At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        RegionTextParser::_determineVersion        RegionTextParser::_determineVersion: Found spec version 0
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        AsciiRegionFileParser::_parse        Combined 5 image regions (which excludes any annotation regions)
24-Apr-2026 02:55:12 2026-04-24 02:55:03        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).
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        SynthesisDeconvolver::setupMask         ----------------------------------------------------------------------------------------------------------------------------------------
24-Apr-2026 02:55:12 2026-04-24 02:55:03        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 % ]
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 1.29169, over full image : 1.29169
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        sdintimaging::::casa        Minor Cycle controls : {'cycleniter': 50, 'cyclethreshold': 0.1430157572031021, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        SDAlgorithmBase::deconvolve         [tst.sp_mfs_sdint.joint.multiterm] Run mtmfs minor-cycle | CycleThreshold=0.143016, CycleNiter=50, Gain=0.1
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        MultiTermMatrixCleaner::verifyScaleSizes()         Scale sizes to be used for deconvolution : [0, 12, 20, 40, 60, 80, 100]
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        MultiTermMatrixCleaner::setupScaleFunctions         scale 1 = 0 pixels with bias = 1
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        MultiTermMatrixCleaner::setupScaleFunctions         scale 2 = 12 pixels with bias = 1
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        MultiTermMatrixCleaner::setupScaleFunctions         scale 3 = 20 pixels with bias = 1
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        MultiTermMatrixCleaner::setupScaleFunctions         scale 4 = 40 pixels with bias = 1
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        MultiTermMatrixCleaner::setupScaleFunctions         scale 5 = 60 pixels with bias = 1
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        MultiTermMatrixCleaner::setupScaleFunctions         scale 6 = 80 pixels with bias = 1
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        MultiTermMatrixCleaner::setupScaleFunctions         scale 7 = 100 pixels with bias = 1
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        MultiTermMatrixCleaner::initialise()         Using a PSF patch of 800 pixels on each side for minor-cycle updates.
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 0.990624 at [400, 400]
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        SIImageStoreMultiTerm::calcFractionalBandwidth         MFS frequency range : 0.749917 GHz -> 2.25008GHz.Fractional Bandwidth : 100.011 %.Reference Frequency for Taylor Expansion : 1.5GHz.
24-Apr-2026 02:55:12 2026-04-24 02:55:03        INFO        MultiTermMatrixCleaner::computeHessianPeak         Calculating PSF and Scale convolutions
24-Apr-2026 02:55:12 2026-04-24 02:55:04        INFO        MultiTermMatrixCleaner::computeHessianPeak         The Matrix [H] for 0 pixel scale is : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:55:12 2026-04-24 02:55:04        INFO        MultiTermMatrixCleaner::computeHessianPeak +        [0.990624, -0.165207
24-Apr-2026 02:55:12 2026-04-24 02:55:04        INFO        MultiTermMatrixCleaner::computeHessianPeak +         -0.165207, 0.0550629]
24-Apr-2026 02:55:12 2026-04-24 02:55:04        INFO        MultiTermMatrixCleaner::computeHessianPeak         The Matrix [H] for 12 pixel scale is : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:55:12 2026-04-24 02:55:04        INFO        MultiTermMatrixCleaner::computeHessianPeak +        [0.308491, -0.0629614
24-Apr-2026 02:55:12 2026-04-24 02:55:04        INFO        MultiTermMatrixCleaner::computeHessianPeak +         -0.0629614, 0.0209874]
24-Apr-2026 02:55:12 2026-04-24 02:55:04        INFO        MultiTermMatrixCleaner::computeHessianPeak         The Matrix [H] for 20 pixel scale is : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:55:12 2026-04-24 02:55:04        INFO        MultiTermMatrixCleaner::computeHessianPeak +        [0.166511, -0.0351309
24-Apr-2026 02:55:12 2026-04-24 02:55:04        INFO        MultiTermMatrixCleaner::computeHessianPeak +         -0.0351309, 0.0117106]
24-Apr-2026 02:55:12 2026-04-24 02:55:04        INFO        MultiTermMatrixCleaner::computeHessianPeak         The Matrix [H] for 40 pixel scale is : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:55:12 2026-04-24 02:55:04        INFO        MultiTermMatrixCleaner::computeHessianPeak +        [0.0568644, -0.0130262
24-Apr-2026 02:55:12 2026-04-24 02:55:04        INFO        MultiTermMatrixCleaner::computeHessianPeak +         -0.0130262, 0.00434238]
24-Apr-2026 02:55:12 2026-04-24 02:55:04        INFO        MultiTermMatrixCleaner::computeHessianPeak         The Matrix [H] for 60 pixel scale is : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:55:12 2026-04-24 02:55:04        INFO        MultiTermMatrixCleaner::computeHessianPeak +        [0.0243685, -0.00596235
24-Apr-2026 02:55:12 2026-04-24 02:55:04        INFO        MultiTermMatrixCleaner::computeHessianPeak +         -0.00596235, 0.00198765]
24-Apr-2026 02:55:12 2026-04-24 02:55:04        INFO        MultiTermMatrixCleaner::computeHessianPeak         The Matrix [H] for 80 pixel scale is : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:55:12 2026-04-24 02:55:04        INFO        MultiTermMatrixCleaner::computeHessianPeak +        [0.0117886, -0.00298506
24-Apr-2026 02:55:12 2026-04-24 02:55:04        INFO        MultiTermMatrixCleaner::computeHessianPeak +         -0.00298506, 0.000995135]
24-Apr-2026 02:55:12 2026-04-24 02:55:04        INFO        MultiTermMatrixCleaner::computeHessianPeak         The Matrix [H] for 100 pixel scale is : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:55:12 2026-04-24 02:55:04        INFO        MultiTermMatrixCleaner::computeHessianPeak +        [0.006295, -0.00163772
24-Apr-2026 02:55:12 2026-04-24 02:55:04        INFO        MultiTermMatrixCleaner::computeHessianPeak +         -0.00163772, 0.000545977]
24-Apr-2026 02:55:12 2026-04-24 02:55:05        INFO        MultiTermMatrixCleaner::mtclean()         Calculating convolutions of residual images with scales
24-Apr-2026 02:55:12 2026-04-24 02:55:05        INFO        MultiTermMatrixCleaner::mtclean()         Peak convolved residual (within mask)  : 1.30392
24-Apr-2026 02:55:12 2026-04-24 02:55:09        INFO                [20] Res: 1.22854 Max: 1.68963 Gain: 0.1 Pos: [296, 422] Scale: 100 Coeffs: 18.7747  9.38979 
24-Apr-2026 02:55:26 2026-04-24 02:55:12        INFO                [40] Res: 0.856896 Max: 0.77222 Gain: 0.1 Pos: [267, 383] Scale: 100 Coeffs: 13.6767  10.3534 
24-Apr-2026 02:55:26 2026-04-24 02:55:14        INFO                [50] Res: 0.717276 Max: 0.55649 Gain: 0.1 Pos: [400, 367] Scale: 0 Coeffs: 0.591667  -0.862934 
24-Apr-2026 02:55:26 2026-04-24 02:55:14        INFO        MultiTermMatrixCleaner::mtclean()         Reached max number of iterations for this minor cycle
24-Apr-2026 02:55:26 2026-04-24 02:55:14        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by scale :  [0]: 1.23248  [12]: 0  [20]: 0  [40]: 0  [60]: 0  [80]: 0  [100]: 80.9651 (in this run)
24-Apr-2026 02:55:26 2026-04-24 02:55:14        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by Taylor coefficient :  [0]: 82.1976  [1]: 38.9155
24-Apr-2026 02:55:26 2026-04-24 02:55:14        INFO        SDAlgorithmBase::deconvolve         [tst.sp_mfs_sdint.joint.multiterm] iters=0->50 [50], model=0->82.1937, peakres=1.29169->0.710551, Reached cycleniter.
24-Apr-2026 02:55:26 2026-04-24 02:55:14        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 50 iterations.
24-Apr-2026 02:55:26 2026-04-24 02:55:14        INFO        task_sdintimaging::image::_setrestoringbeam         Will remove any existing beams from image
24-Apr-2026 02:55:26 2026-04-24 02:55:14        INFO        task_sdintimaging::::        Deleted restoring beam(s)
24-Apr-2026 02:55:26 2026-04-24 02:55:14        INFO        task_sdintimaging::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 2 -------------------------------------
24-Apr-2026 02:55:26 2026-04-24 02:55:14        INFO        task_sdintimaging::SynthesisImagerVi2::nSubCubeFitInMemory        Required memory: 0.4079 GB. Available mem.: 389.7 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        sdintimaging::::casa        Deleting tmp_975190_*plane
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:55:26 2026-04-24 02:55:16        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)
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        ImageRegion::fromRecord        Creating image 'tmp_975190_sdplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:55:26 2026-04-24 02:55:16        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)
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        ImageRegion::fromRecord        Creating image 'tmp_975190_intplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        sdintimaging::::casa        start Feathering.....
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        Imager::setvp()         Setting voltage pattern parameters
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        Imager::setvp()         Sky position tolerance is 180 degrees
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        Imager::setvp()         Using system default voltage patterns for each telescope
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        imager::setsdoptions()         Setting single dish processing options
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        imager::feather()        
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        imager::feather()+        Feathering together high and low resolution images...
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        imager::feather()        Each input image has a single restoring beam.
24-Apr-2026 02:55:26 2026-04-24 02:55:16        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.
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        sdintimaging::::casa        Deleting tmp_975190_*plane
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:55:26 2026-04-24 02:55:16        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)
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        ImageRegion::fromRecord        Creating image 'tmp_975190_sdplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:55:26 2026-04-24 02:55:16        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)
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        ImageRegion::fromRecord        Creating image 'tmp_975190_intplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        sdintimaging::::casa        start Feathering.....
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        Imager::setvp()         Setting voltage pattern parameters
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        Imager::setvp()         Sky position tolerance is 180 degrees
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        Imager::setvp()         Using system default voltage patterns for each telescope
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        imager::setsdoptions()         Setting single dish processing options
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        imager::feather()        
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        imager::feather()+        Feathering together high and low resolution images...
24-Apr-2026 02:55:26 2026-04-24 02:55:16        INFO        imager::feather()        Each input image has a single restoring beam.
24-Apr-2026 02:55:26 2026-04-24 02:55:16        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.
24-Apr-2026 02:55:26 2026-04-24 02:55:17        INFO        sdintimaging::::casa        getSummary call: fullsummary=False
24-Apr-2026 02:55:26 2026-04-24 02:55:17        INFO        SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.71052, over full image : 0.71052
24-Apr-2026 02:55:26 2026-04-24 02:55:17        INFO        sdintimaging::::casa        Minor Cycle controls : {'cycleniter': 50, 'cyclethreshold': 0.07866837829351425, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
24-Apr-2026 02:55:26 2026-04-24 02:55:17        INFO        SDAlgorithmBase::deconvolve         [tst.sp_mfs_sdint.joint.multiterm] Run mtmfs minor-cycle | CycleThreshold=0.0786684, CycleNiter=50, Gain=0.1
24-Apr-2026 02:55:26 2026-04-24 02:55:17        INFO        SIImageStoreMultiTerm::calcFractionalBandwidth         MFS frequency range : 0.749917 GHz -> 2.25008GHz.Fractional Bandwidth : 100.011 %.Reference Frequency for Taylor Expansion : 1.5GHz.
24-Apr-2026 02:55:26 2026-04-24 02:55:17        INFO        MultiTermMatrixCleaner::mtclean()         Calculating convolutions of residual images with scales
24-Apr-2026 02:55:26 2026-04-24 02:55:17        INFO        MultiTermMatrixCleaner::mtclean()         Peak convolved residual (within mask)  : 0.717245
24-Apr-2026 02:55:26 2026-04-24 02:55:19        INFO                [60] Res: 0.648191 Max: 0.437314 Gain: 0.1 Pos: [288, 468] Scale: 100 Coeffs: 8.08301  -0.964005 
24-Apr-2026 02:55:26 2026-04-24 02:55:23        INFO                [80] Res: 0.488584 Max: 0.267872 Gain: 0.1 Pos: [345, 412] Scale: 100 Coeffs: 7.55851  4.07243 
24-Apr-2026 02:55:26 2026-04-24 02:55:26        INFO                [100] Res: 0.386002 Max: 0.15873 Gain: 0.1 Pos: [282, 320] Scale: 100 Coeffs: 3.88515  -4.2365 
24-Apr-2026 02:55:26 2026-04-24 02:55:26        INFO        MultiTermMatrixCleaner::mtclean()         Reached max number of iterations for this minor cycle
24-Apr-2026 02:55:26 2026-04-24 02:55:26        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by scale :  [0]: 2.03727  [12]: 0  [20]: 0  [40]: 0  [60]: 0  [80]: 0  [100]: 104.609 (in this run)
24-Apr-2026 02:55:26 2026-04-24 02:55:26        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by Taylor coefficient :  [0]: 106.642  [1]: 40.9103
24-Apr-2026 02:55:26 2026-04-24 02:55:26        INFO        SDAlgorithmBase::deconvolve         [tst.sp_mfs_sdint.joint.multiterm] iters=0->50 [50], model=82.198->106.641, peakres=0.71052->0.382383, Reached cycleniter.
24-Apr-2026 02:55:29 2026-04-24 02:55:26        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 100 iterations.
24-Apr-2026 02:55:29 2026-04-24 02:55:27        INFO        task_sdintimaging::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 3 -------------------------------------
24-Apr-2026 02:55:29 2026-04-24 02:55:27        INFO        task_sdintimaging::SynthesisImagerVi2::nSubCubeFitInMemory        Required memory: 0.4079 GB. Available mem.: 389.7 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
24-Apr-2026 02:55:29 2026-04-24 02:55:28        INFO        sdintimaging::::casa        Deleting tmp_975190_*plane
24-Apr-2026 02:55:29 2026-04-24 02:55:28        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:55:29 2026-04-24 02:55:28        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:55:29 2026-04-24 02:55:28        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:55:29 2026-04-24 02:55:28        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:55:29 2026-04-24 02:55:28        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)
24-Apr-2026 02:55:29 2026-04-24 02:55:28        INFO        ImageRegion::fromRecord        Creating image 'tmp_975190_sdplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:55:29 2026-04-24 02:55:28        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:55:29 2026-04-24 02:55:28        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:55:29 2026-04-24 02:55:28        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:55:29 2026-04-24 02:55:28        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:55:29 2026-04-24 02:55:28        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)
24-Apr-2026 02:55:29 2026-04-24 02:55:28        INFO        ImageRegion::fromRecord        Creating image 'tmp_975190_intplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:55:29 2026-04-24 02:55:28        INFO        sdintimaging::::casa        start Feathering.....
24-Apr-2026 02:55:29 2026-04-24 02:55:28        INFO        Imager::setvp()         Setting voltage pattern parameters
24-Apr-2026 02:55:29 2026-04-24 02:55:28        INFO        Imager::setvp()         Sky position tolerance is 180 degrees
24-Apr-2026 02:55:29 2026-04-24 02:55:28        INFO        Imager::setvp()         Using system default voltage patterns for each telescope
24-Apr-2026 02:55:29 2026-04-24 02:55:28        INFO        imager::setsdoptions()         Setting single dish processing options
24-Apr-2026 02:55:29 2026-04-24 02:55:28        INFO        imager::feather()        
24-Apr-2026 02:55:29 2026-04-24 02:55:28        INFO        imager::feather()+        Feathering together high and low resolution images...
24-Apr-2026 02:55:29 2026-04-24 02:55:28        INFO        imager::feather()        Each input image has a single restoring beam.
24-Apr-2026 02:55:29 2026-04-24 02:55:28        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.
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        sdintimaging::::casa        Deleting tmp_975190_*plane
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:55:29 2026-04-24 02:55:29        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)
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        ImageRegion::fromRecord        Creating image 'tmp_975190_sdplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:55:29 2026-04-24 02:55:29        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)
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        ImageRegion::fromRecord        Creating image 'tmp_975190_intplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        sdintimaging::::casa        start Feathering.....
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        Imager::setvp()         Setting voltage pattern parameters
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        Imager::setvp()         Sky position tolerance is 180 degrees
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        Imager::setvp()         Using system default voltage patterns for each telescope
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        imager::setsdoptions()         Setting single dish processing options
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        imager::feather()        
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        imager::feather()+        Feathering together high and low resolution images...
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        imager::feather()        Each input image has a single restoring beam.
24-Apr-2026 02:55:29 2026-04-24 02:55:29        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.
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        sdintimaging::::casa        getSummary call: fullsummary=False
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.38229, over full image : 0.38229
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        sdintimaging::::casa        Reached global stopping criterion : iteration limit
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        MultiTermMatrixCleaner::computeprincipalsolution()         MTMC :: Computing principal solution on residuals
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        SDAlgorithmBase::restore         [tst.sp_mfs_sdint.joint.multiterm] : Restoring model image.
24-Apr-2026 02:55:29 2026-04-24 02:55:29        INFO        SIImageStore::restore         Beam for chan : 0 : 62.8224 arcsec, 62.2044 arcsec, 13.3205 deg
24-Apr-2026 02:55:29 2026-04-24 02:55:30        INFO        SIImageStore::restore         Beam for chan : 0 : 62.8224 arcsec, 62.2044 arcsec, 13.3205 deg
24-Apr-2026 02:55:29 2026-04-24 02:55:30        INFO        SIImageStoreMultiTerm::calculateAlphaBeta         Calculating spectral parameters for Intensity > peakresidual/10 = 0.0384815 Jy/beam
24-Apr-2026 02:55:29 2026-04-24 02:55:30        INFO        SIImageStoreMultiTerm::calculateAlphaBeta         Written Spectral Index Error Image : /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31233-CCM228/work/test_task_sdintimaging/tst.sp_mfs_sdint.joint.multiterm.alpha.error
24-Apr-2026 02:55:29 2026-04-24 02:55:30        INFO        SDAlgorithmMSMFS::restore         Restored images :
24-Apr-2026 02:55:29 2026-04-24 02:55:30        INFO        SDAlgorithmMSMFS::restore         /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31233-CCM228/work/test_task_sdintimaging/tst.sp_mfs_sdint.joint.multiterm.image.tt0  (model=/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31233-CCM228/work/test_task_sdintimaging/tst.sp_mfs_sdint.joint.multiterm.model.tt0)
24-Apr-2026 02:55:29 2026-04-24 02:55:30        INFO        SDAlgorithmMSMFS::restore         /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31233-CCM228/work/test_task_sdintimaging/tst.sp_mfs_sdint.joint.multiterm.image.tt1  (model=/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31233-CCM228/work/test_task_sdintimaging/tst.sp_mfs_sdint.joint.multiterm.model.tt1)
24-Apr-2026 02:55:29 2026-04-24 02:55:30        INFO        SDAlgorithmMSMFS::restore         
24-Apr-2026 02:55:29 master 1 init 1
24-Apr-2026 02:55:29 2026-04-24 02:55:30        INFO        sdintimaging::::casa        Deleting tmp_975190_*plane
24-Apr-2026 02:55:32 2026-04-24 02:55:30        INFO        sdintimaging::::casa        Searching for images with prefix 'tst.sp_mfs_sdint'... Found these, writing history into them: ['tst.sp_mfs_sdint.int.cube.pb', 'tst.sp_mfs_sdint.int.cube.psf', 'tst.sp_mfs_sdint.int.cube.sumwt', 'tst.sp_mfs_sdint.int.cube.residual', 'tst.sp_mfs_sdint.joint.multiterm.psf.tt0', 'tst.sp_mfs_sdint.joint.multiterm.sumwt.tt0', 'tst.sp_mfs_sdint.joint.multiterm.psf.tt1', 'tst.sp_mfs_sdint.joint.multiterm.sumwt.tt1', 'tst.sp_mfs_sdint.joint.multiterm.psf.tt2', 'tst.sp_mfs_sdint.joint.multiterm.sumwt.tt2', 'tst.sp_mfs_sdint.joint.multiterm.pb.tt0', 'tst.sp_mfs_sdint.joint.multiterm.residual.tt0', 'tst.sp_mfs_sdint.joint.multiterm.residual.tt1', 'tst.sp_mfs_sdint.sd.cube.residual', 'tst.sp_mfs_sdint.sd.cube.image', 'tst.sp_mfs_sdint.sd.cube.psf', 'tst.sp_mfs_sdint.joint.cube.psf', 'tst.sp_mfs_sdint.joint.multiterm.mask', 'tst.sp_mfs_sdint.joint.multiterm.model.tt0', 'tst.sp_mfs_sdint.joint.multiterm.model.tt1', 'tst.sp_mfs_sdint.int.cube.model', 'tst.sp_mfs_sdint.sd.cube.model', 'tst.sp_mfs_sdint.joint.cube.residual', 'tst.sp_mfs_sdint.joint.multiterm.image.tt0', 'tst.sp_mfs_sdint.joint.multiterm.image.tt1', 'tst.sp_mfs_sdint.joint.multiterm.alpha', 'tst.sp_mfs_sdint.joint.multiterm.alpha.error']
24-Apr-2026 02:55:32 2026-04-24 02:55:30        INFO        sdintimaging::::casa        Task sdintimaging complete. Start time: 2026-04-23 22:54:56.834016 End time: 2026-04-23 22:55:30.479549
24-Apr-2026 02:55:32 2026-04-24 02:55:30        INFO        sdintimaging::::casa        ##### End Task: sdintimaging         #####
24-Apr-2026 02:55:32 2026-04-24 02:55:30        INFO        sdintimaging::::casa        ##########################################
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        name::        No table opened.
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        showcache::        The Table Cache is empty.
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        sdintimaging::::casa        [ check_ret_structure ] Return dictionary struture check: type=reduced ( Pass : found all expected keys  )
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        sdintimaging::::casa+        [ check_ims ] Image made : ['tst.sp_mfs_sdint.joint.multiterm.psf.tt0', 'tst.sp_mfs_sdint.joint.multiterm.residual.tt0', 'tst.sp_mfs_sdint.joint.multiterm.image.tt0', 'tst.sp_mfs_sdint.joint.multiterm.image.tt1', 'tst.sp_mfs_sdint.joint.multiterm.alpha'] =  [True, True, True, True, True] ( Pass : should all be True )
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        sdintimaging::::casa+        All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords)
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        sdintimaging::::casa+        [check_history] All expected history entries found. (Pass)
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        sdintimaging::::casa+        [ check_pix_val ] tst.sp_mfs_sdint.joint.multiterm.psf.tt0 : Value is 0.9906240701675415 at [400, 400, 0, 0] ( Pass : should be 0.991 , Epsilon: 0.05)
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        sdintimaging::::casa+        [ check_pix_val ] tst.sp_mfs_sdint.joint.multiterm.image.tt0 : Value is 1.1378769874572754 at [350, 433, 0, 0] ( Pass : should be 1.138 , Epsilon: 0.05)
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        sdintimaging::::casa+        [ check_pix_val ] tst.sp_mfs_sdint.joint.multiterm.image.tt0 : Value is 0.3725101351737976 at [300, 400, 0, 0] ( Pass : should be 0.373 , Epsilon: 0.05)
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        sdintimaging::::casa+        [ check_pix_val ] tst.sp_mfs_sdint.joint.multiterm.alpha : Value is -1.3045321702957153 at [350, 433, 0, 0] ( Pass : should be -1.3 , Epsilon: 0.05)
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        sdintimaging::::casa+        [ check_pix_val ] tst.sp_mfs_sdint.joint.multiterm.alpha : Value is 0.07270953059196472 at [300, 400, 0, 0] ( Pass : should be 0.0727 , Epsilon: 0.05)
24-Apr-2026 02:55:32 .2026-04-24 02:55:31        INFO        sdintimaging::::casa        ##########################################
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        sdintimaging::::casa        ##### Begin Task: sdintimaging       #####
24-Apr-2026 02:55:32 2026-04-24 02:55:31        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_mfs_sdonly', 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 )
24-Apr-2026 02:55:32 2026-04-24 02:55:31        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.
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        sdintimaging::::casa        Initializing SDINT Helper instance with tmp file tag 498880
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        sdintimaging::::casa        INT cube setup ....
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        sdintimaging::::casa        Verifying Input Parameters
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        SynthesisImagerVi2::selectData         MS : papersky_standard.ms | [Opened in readonly mode]
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        SynthesisImagerVi2::selectData           NRows selected : 6318
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [tst.sp_mfs_sdonly.int.cube] :
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [tst.sp_mfs_sdonly.int.cube] :
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        MSTransformRegridder::calcChanFreqs         phaseCenter='Direction: [0.377371, -0.657097, 0.652545]'  Channels equidistant in freq
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        MSTransformRegridder::calcChanFreqs+         Central frequency (in output frame) = 1.49983e+09 Hz
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        MSTransformRegridder::calcChanFreqs+         Width of central channel (in output frame) = 4.99945e+08 Hz
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        MSTransformRegridder::calcChanFreqs+         Number of channels = 3
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        MSTransformRegridder::calcChanFreqs+         Total width of SPW (in output frame) = 1.49983e+09 Hz
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        MSTransformRegridder::calcChanFreqs+         Lower edge = 7.49917e+08 Hz, upper edge = 2.24975e+09 Hz
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        SynthesisImagerVi2::defineImage         Impars: start
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        SynthesisImagerVi2::defineImage         Shape: [800, 800, 1, 3] Spectral: [9.99889e+08] at [0] with increment [4.99945e+08]
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        SynthesisImagerVi2::defineImage         Set Gridding options for [tst.sp_mfs_sdonly.int.cube] with ftmachine : gridft
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        SynthesisImagerVi2::nSubCubeFitInMemory        Required memory: 0.4079 GB. Available mem.: 389.7 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        sdintimaging::::casa        CFCache already exists
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        SynthesisImagerVi2::weight()         Set imaging weights : Natural weighting
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        SynthesisImager::makePSF         ----------------------------------------------------------- Make PSF ---------------------------------------------
24-Apr-2026 02:55:32 2026-04-24 02:55:31        INFO        SynthesisImagerVi2::nSubCubeFitInMemory        Required memory: 0.4079 GB. Available mem.: 389.7 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
24-Apr-2026 02:55:32 2026-04-24 02:55:32        INFO        SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
24-Apr-2026 02:55:32 2026-04-24 02:55:32        INFO        SynthesisImagerVi2::nSubCubeFitInMemory        Required memory: 0.4079 GB. Available mem.: 389.7 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
24-Apr-2026 02:55:32 2026-04-24 02:55:32        INFO        sdintimaging::::casa        Copying restoring beam(s) for 3 channel(s) from tst.sp_mfs_sdonly.int.cube.psf to tst.sp_mfs_sdonly.int.cube.residual
24-Apr-2026 02:55:32 2026-04-24 02:55:32        INFO        image::_setrestoringbeam         Will copy beams from another image to this image
24-Apr-2026 02:55:32 2026-04-24 02:55:32        INFO        BeamManipulator::set        Set image beam set
24-Apr-2026 02:55:32 2026-04-24 02:55:32        INFO        sdintimaging::::casa        Combined image setup ....
24-Apr-2026 02:55:32 2026-04-24 02:55:32        INFO        sdintimaging::::casa        Verifying Input Parameters
24-Apr-2026 02:55:32 2026-04-24 02:55:32        INFO        SynthesisImagerVi2::selectData         MS : papersky_standard.ms | [Opened in readonly mode]
24-Apr-2026 02:55:32 2026-04-24 02:55:32        INFO        SynthesisImagerVi2::selectData           NRows selected : 6318
24-Apr-2026 02:55:34 2026-04-24 02:55:32        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [tst.sp_mfs_sdonly.joint.multiterm] :
24-Apr-2026 02:55:34 2026-04-24 02:55:32        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [tst.sp_mfs_sdonly.joint.multiterm] :
24-Apr-2026 02:55:34 2026-04-24 02:55:32        INFO        SynthesisImagerVi2::defineImage         Impars: start
24-Apr-2026 02:55:34 2026-04-24 02:55:32        INFO        SynthesisImagerVi2::defineImage         Shape: [800, 800, 1, 1] Spectral: [1.5e+09] at [0] with increment [1.50017e+09]
24-Apr-2026 02:55:34 2026-04-24 02:55:32        INFO        SynthesisImagerVi2::defineImage         Set Gridding options for [tst.sp_mfs_sdonly.joint.multiterm] with ftmachine : gridft
24-Apr-2026 02:55:34 2026-04-24 02:55:32        INFO        SynthesisImagerVi2::nSubCubeFitInMemory        Required memory: 0.2266 GB. Available mem.: 389.7 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
24-Apr-2026 02:55:34 2026-04-24 02:55:32        INFO        SynthesisImagerVi2::weight()         Set imaging weights : Natural weighting
24-Apr-2026 02:55:34 2026-04-24 02:55:32        INFO        SynthesisImager::makePSF         ----------------------------------------------------------- Make PSF ---------------------------------------------
24-Apr-2026 02:55:34 2026-04-24 02:55:33        INFO        SIImageStoreMultiTerm::calcSensitivity         Multi-Term Hessian Matrix : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:55:34 2026-04-24 02:55:33        INFO        SIImageStoreMultiTerm::calcSensitivity +        [37908, -4.18539
24-Apr-2026 02:55:34 2026-04-24 02:55:33        INFO        SIImageStoreMultiTerm::calcSensitivity +         -4.18539, 2807.38]
24-Apr-2026 02:55:34 2026-04-24 02:55:33        INFO        SIImageStoreMultiTerm::calcSensitivity         Multi-Term Covariance Matrix : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:55:34 2026-04-24 02:55:33        INFO        SIImageStoreMultiTerm::calcSensitivity +        [2.63797e-05, 3.93281e-08
24-Apr-2026 02:55:34 2026-04-24 02:55:33        INFO        SIImageStoreMultiTerm::calcSensitivity +         3.93281e-08, 0.000356204]
24-Apr-2026 02:55:34 2026-04-24 02:55:33        INFO        SIImageStoreMultiTerm::calcSensitivity         [tst.sp_mfs_sdonly.joint.multiterm][Taylor0] Theoretical sensitivity (Jy/bm):0.00513611
24-Apr-2026 02:55:34 2026-04-24 02:55:33        INFO        SIImageStoreMultiTerm::calcSensitivity         [tst.sp_mfs_sdonly.joint.multiterm][Taylor1] Theoretical sensitivity (Jy/bm):0.0188734
24-Apr-2026 02:55:34 2026-04-24 02:55:33        INFO        SIImageStoreMultiTerm::calcFractionalBandwidth         MFS frequency range : 0.749917 GHz -> 2.25008GHz.Fractional Bandwidth : 100.011 %.Reference Frequency for Taylor Expansion : 1.5GHz.
24-Apr-2026 02:55:34 2026-04-24 02:55:33        INFO        SIImageStore::getPSFGaussian         Time to fit Gaussian to PSF 0.014131
24-Apr-2026 02:55:34 2026-04-24 02:55:33        INFO        SIImageStore::printBeamSet         Beam : 53.662 arcsec, 53.2099 arcsec, 22.4308 deg
24-Apr-2026 02:55:34 2026-04-24 02:55:33        INFO        SynthesisImagerVi2::makePrimaryBeam         vi2 : Evaluating Primary Beam model onto image grid(s)
24-Apr-2026 02:55:34 2026-04-24 02:55:33        INFO        SynthesisDeconvolver::setupDeconvolution         Set Deconvolution Options for [tst.sp_mfs_sdonly.joint.multiterm] : mtmfs
24-Apr-2026 02:55:34 2026-04-24 02:55:33        INFO        SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
24-Apr-2026 02:55:34 2026-04-24 02:55:34        INFO        sdintimaging::::casa        SD cube setup ....
24-Apr-2026 02:55:34 2026-04-24 02:55:34        INFO        sdintimaging::::casa        Initializing SDINT Helper instance with tmp file tag 220129
24-Apr-2026 02:55:34 2026-04-24 02:55:34        INFO        sdintimaging::::casa         The center of psf coincides with int psf: (diffRA,diffDec)=( 0.0, 0.0)
24-Apr-2026 02:55:34 2026-04-24 02:55:34        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Apr-2026 02:55:34 2026-04-24 02:55:34        WARN        ImageRegridder::_doImagesOverlap        At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
24-Apr-2026 02:55:34 2026-04-24 02:55:34        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.
24-Apr-2026 02:55:34 2026-04-24 02:55:34        INFO        SubImageFactory::createImage        Creating image 'tst.sp_mfs_sdonly.sd.cube.residual' of shape [800, 800, 1, 3]
24-Apr-2026 02:55:34 2026-04-24 02:55:34        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Apr-2026 02:55:34 2026-04-24 02:55:34        WARN        ImageRegridder::_doImagesOverlap        At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
24-Apr-2026 02:55:34 2026-04-24 02:55:34        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.
24-Apr-2026 02:55:34 2026-04-24 02:55:34        INFO        SubImageFactory::createImage        Creating image 'tst.sp_mfs_sdonly.sd.cube.image' of shape [800, 800, 1, 3]
24-Apr-2026 02:55:34 2026-04-24 02:55:34        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Apr-2026 02:55:34 2026-04-24 02:55:34        WARN        ImageRegridder::_doImagesOverlap        At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
24-Apr-2026 02:55:34 2026-04-24 02:55:34        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.
24-Apr-2026 02:55:34 2026-04-24 02:55:34        INFO        SubImageFactory::createImage        Creating image 'tst.sp_mfs_sdonly.sd.cube.psf' of shape [800, 800, 1, 3]
24-Apr-2026 02:55:34 2026-04-24 02:55:34        INFO        sdintimaging::::casa        Deleting tmp_220129_*plane
24-Apr-2026 02:55:34 2026-04-24 02:55:34        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.
24-Apr-2026 02:55:34 2026-04-24 02:55:34        INFO        sdintimaging::::casa        Feathering INT and SD residual images...
24-Apr-2026 02:55:34 2026-04-24 02:55:34        INFO        SIImageStore::Open existing Images         SumWt does not exist. Proceeding only with PSF
24-Apr-2026 02:55:34 2026-04-24 02:55:34        INFO        SynthesisUtilMethods::fitPsfBeam        Fitting PSF beam for Imagestore : tst.sp_mfs_sdonly.joint.cube
24-Apr-2026 02:55:34 2026-04-24 02:55:34        INFO        SIImageStore::getPSFGaussian         Time to fit Gaussian to PSF 0.151129
24-Apr-2026 02:55:34 2026-04-24 02:55:34        INFO        SIImageStore::printBeamSet         Restoring Beams
24-Apr-2026 02:55:34 2026-04-24 02:55:34        INFO        SIImageStore::printBeamSet +        Chan    Freq   Vel Pol
24-Apr-2026 02:55:34 2026-04-24 02:55:34        INFO        SIImageStore::printBeamSet +           0 1.0e+09    33   I  664.4244 arcsec x  664.4244 arcsec pa=-24.7813 deg
24-Apr-2026 02:55:34 2026-04-24 02:55:34        INFO        SIImageStore::printBeamSet +           1 1.5e+09 -149846   I  424.2759 arcsec x  424.2759 arcsec pa= 52.6739 deg
24-Apr-2026 02:55:34 2026-04-24 02:55:34        INFO        SIImageStore::printBeamSet +           2 2.0e+09 -299726   I  320.2759 arcsec x  320.2759 arcsec pa= 57.9766 deg
24-Apr-2026 02:55:34 2026-04-24 02:55:34        INFO        sdintimaging::::casa        Calculate spectral PSFs and Taylor Residuals...
24-Apr-2026 02:55:34 2026-04-24 02:55:35        INFO        SynthesisUtilMethods::fitPsfBeam        Fitting PSF beam for Imagestore : tst.sp_mfs_sdonly.joint.multiterm
24-Apr-2026 02:55:34 2026-04-24 02:55:35        INFO        SIImageStore::getPSFGaussian         Time to fit Gaussian to PSF 0.057481
24-Apr-2026 02:55:34 2026-04-24 02:55:35        INFO        SIImageStore::printBeamSet         Beam : 430.287 arcsec, 430.287 arcsec, -27.0128 deg
24-Apr-2026 02:55:34 2026-04-24 02:55:35        INFO        SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0, over full image : 19.665
24-Apr-2026 02:55:34 2026-04-24 02:55:35        INFO        SynthesisDeconvolver::setupMask         [tst.sp_mfs_sdonly.joint.multiterm] Setting up a mask from [papersky_standard.true.im.masklist]
24-Apr-2026 02:55:34 2026-04-24 02:55:35        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:55:34 2026-04-24 02:55:35        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
24-Apr-2026 02:55:34 2026-04-24 02:55:35        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:55:34 2026-04-24 02:55:35        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.
24-Apr-2026 02:55:34 2026-04-24 02:55:35        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Apr-2026 02:55:34 2026-04-24 02:55:35        WARN        ImageRegridder::_doImagesOverlap        At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
24-Apr-2026 02:55:57 2026-04-24 02:55:35        INFO        RegionTextParser::_determineVersion        RegionTextParser::_determineVersion: Found spec version 0
24-Apr-2026 02:55:57 2026-04-24 02:55:35        INFO        AsciiRegionFileParser::_parse        Combined 5 image regions (which excludes any annotation regions)
24-Apr-2026 02:55:57 2026-04-24 02:55:35        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).
24-Apr-2026 02:55:57 2026-04-24 02:55:35        INFO        SynthesisDeconvolver::setupMask         ----------------------------------------------------------------------------------------------------------------------------------------
24-Apr-2026 02:55:57 2026-04-24 02:55:35        INFO        SynthesisDeconvolver::setupMask         [tst.sp_mfs_sdonly.joint.multiterm] Number of pixels in the clean mask : 44220 out of a total of 640000 pixels. [ 6.90937 % ]
24-Apr-2026 02:55:57 2026-04-24 02:55:35        INFO        SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 19.665, over full image : 19.665
24-Apr-2026 02:55:57 2026-04-24 02:55:35        INFO        sdintimaging::::casa        Minor Cycle controls : {'cycleniter': 50, 'cyclethreshold': 0.9832497835159302, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
24-Apr-2026 02:55:57 2026-04-24 02:55:35        INFO        SDAlgorithmBase::deconvolve         [tst.sp_mfs_sdonly.joint.multiterm] Run mtmfs minor-cycle | CycleThreshold=0.98325, CycleNiter=50, Gain=0.1
24-Apr-2026 02:55:57 2026-04-24 02:55:35        INFO        MultiTermMatrixCleaner::verifyScaleSizes()         Scale sizes to be used for deconvolution : [0, 12, 20, 40, 60, 80, 100]
24-Apr-2026 02:55:57 2026-04-24 02:55:35        INFO        MultiTermMatrixCleaner::setupScaleFunctions         scale 1 = 0 pixels with bias = 1
24-Apr-2026 02:55:57 2026-04-24 02:55:35        INFO        MultiTermMatrixCleaner::setupScaleFunctions         scale 2 = 12 pixels with bias = 1
24-Apr-2026 02:55:57 2026-04-24 02:55:35        INFO        MultiTermMatrixCleaner::setupScaleFunctions         scale 3 = 20 pixels with bias = 1
24-Apr-2026 02:55:57 2026-04-24 02:55:35        INFO        MultiTermMatrixCleaner::setupScaleFunctions         scale 4 = 40 pixels with bias = 1
24-Apr-2026 02:55:57 2026-04-24 02:55:35        INFO        MultiTermMatrixCleaner::setupScaleFunctions         scale 5 = 60 pixels with bias = 1
24-Apr-2026 02:55:57 2026-04-24 02:55:35        INFO        MultiTermMatrixCleaner::setupScaleFunctions         scale 6 = 80 pixels with bias = 1
24-Apr-2026 02:55:57 2026-04-24 02:55:35        INFO        MultiTermMatrixCleaner::setupScaleFunctions         scale 7 = 100 pixels with bias = 1
24-Apr-2026 02:55:57 2026-04-24 02:55:35        INFO        MultiTermMatrixCleaner::initialise()         Using a PSF patch of 800 pixels on each side for minor-cycle updates.
24-Apr-2026 02:55:57 2026-04-24 02:55:35        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 1 at [400, 400]
24-Apr-2026 02:55:57 2026-04-24 02:55:35        INFO        SIImageStoreMultiTerm::calcFractionalBandwidth         MFS frequency range : 0.749917 GHz -> 2.25008GHz.Fractional Bandwidth : 100.011 %.Reference Frequency for Taylor Expansion : 1.5GHz.
24-Apr-2026 02:55:57 2026-04-24 02:55:35        INFO        MultiTermMatrixCleaner::computeHessianPeak         Calculating PSF and Scale convolutions
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::computeHessianPeak         The Matrix [H] for 0 pixel scale is : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::computeHessianPeak +        [1, -0.000110958
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::computeHessianPeak +         -0.000110958, 0.0740577]
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::computeHessianPeak         The Matrix [H] for 12 pixel scale is : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::computeHessianPeak +        [0.94427, -0.00762221
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::computeHessianPeak +         -0.00762221, 0.0698511]
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::computeHessianPeak         The Matrix [H] for 20 pixel scale is : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::computeHessianPeak +        [0.859381, -0.0178902
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::computeHessianPeak +         -0.0178902, 0.0635511]
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::computeHessianPeak         The Matrix [H] for 40 pixel scale is : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::computeHessianPeak +        [0.608886, -0.0376936
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::computeHessianPeak +         -0.0376936, 0.0456457]
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::computeHessianPeak         The Matrix [H] for 60 pixel scale is : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::computeHessianPeak +        [0.416334, -0.039146
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::computeHessianPeak +         -0.039146, 0.032104]
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::computeHessianPeak         The Matrix [H] for 80 pixel scale is : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::computeHessianPeak +        [0.291608, -0.0328658
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::computeHessianPeak +         -0.0328658, 0.0229904]
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::computeHessianPeak         The Matrix [H] for 100 pixel scale is : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::computeHessianPeak +        [0.211678, -0.0260793
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::computeHessianPeak +         -0.0260793, 0.0169138]
24-Apr-2026 02:55:57 2026-04-24 02:55:36        INFO        MultiTermMatrixCleaner::mtclean()         Calculating convolutions of residual images with scales
24-Apr-2026 02:55:57 2026-04-24 02:55:37        INFO        MultiTermMatrixCleaner::mtclean()         Peak convolved residual (within mask)  : 19.665
24-Apr-2026 02:55:57 2026-04-24 02:55:40        INFO                [20] Res: 5.10815 Max: 77.3431 Gain: 0.1 Pos: [298, 441] Scale: 100 Coeffs: 18.9288  -1.48036 
24-Apr-2026 02:55:57 2026-04-24 02:55:44        INFO                [40] Res: 2.71228 Max: 16.7033 Gain: 0.1 Pos: [358, 428] Scale: 100 Coeffs: 8.8508  -0.25997 
24-Apr-2026 02:55:57 2026-04-24 02:55:46        INFO                [50] Res: 2.13701 Max: 8.85767 Gain: 0.1 Pos: [359, 434] Scale: 100 Coeffs: 6.47337  0.0373564 
24-Apr-2026 02:55:57 2026-04-24 02:55:46        INFO        MultiTermMatrixCleaner::mtclean()         Reached max number of iterations for this minor cycle
24-Apr-2026 02:55:57 2026-04-24 02:55:46        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by scale :  [0]: 0  [12]: 0  [20]: 0  [40]: 0  [60]: 0  [80]: 0  [100]: 106.822 (in this run)
24-Apr-2026 02:55:57 2026-04-24 02:55:46        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by Taylor coefficient :  [0]: 106.822  [1]: -8.01212
24-Apr-2026 02:55:57 2026-04-24 02:55:46        INFO        SDAlgorithmBase::deconvolve         [tst.sp_mfs_sdonly.joint.multiterm] iters=0->50 [50], model=0->106.818, peakres=19.665->2.13701, Reached cycleniter.
24-Apr-2026 02:55:57 2026-04-24 02:55:46        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 50 iterations.
24-Apr-2026 02:55:57 2026-04-24 02:55:46        INFO        task_sdintimaging::image::_setrestoringbeam         Will remove any existing beams from image
24-Apr-2026 02:55:57 2026-04-24 02:55:46        INFO        task_sdintimaging::::        Deleted restoring beam(s)
24-Apr-2026 02:55:57 2026-04-24 02:55:47        INFO        sdintimaging::::casa        getSummary call: fullsummary=False
24-Apr-2026 02:55:57 2026-04-24 02:55:47        INFO        SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 2.13701, over full image : 2.13701
24-Apr-2026 02:55:57 2026-04-24 02:55:47        INFO        sdintimaging::::casa        Minor Cycle controls : {'cycleniter': 50, 'cyclethreshold': 0.10685043781995773, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
24-Apr-2026 02:55:57 2026-04-24 02:55:47        INFO        SDAlgorithmBase::deconvolve         [tst.sp_mfs_sdonly.joint.multiterm] Run mtmfs minor-cycle | CycleThreshold=0.10685, CycleNiter=50, Gain=0.1
24-Apr-2026 02:55:57 2026-04-24 02:55:48        INFO        SIImageStoreMultiTerm::calcFractionalBandwidth         MFS frequency range : 0.749917 GHz -> 2.25008GHz.Fractional Bandwidth : 100.011 %.Reference Frequency for Taylor Expansion : 1.5GHz.
24-Apr-2026 02:55:57 2026-04-24 02:55:48        INFO        MultiTermMatrixCleaner::mtclean()         Calculating convolutions of residual images with scales
24-Apr-2026 02:55:57 2026-04-24 02:55:48        INFO        MultiTermMatrixCleaner::mtclean()         Peak convolved residual (within mask)  : 2.13701
24-Apr-2026 02:55:57 2026-04-24 02:55:50        INFO                [60] Res: 1.84557 Max: 5.16861 Gain: 0.1 Pos: [382, 364] Scale: 100 Coeffs: 4.88817  -0.422475 
24-Apr-2026 02:55:57 2026-04-24 02:55:54        INFO                [80] Res: 1.31836 Max: 2.08425 Gain: 0.1 Pos: [311, 377] Scale: 0 Coeffs: -1.2825  2.43402 
24-Apr-2026 02:55:57 2026-04-24 02:55:57        INFO                [100] Res: 1.00376 Max: 1.09028 Gain: 0.1 Pos: [356, 431] Scale: 40 Coeffs: 1.32615  -0.179836 
24-Apr-2026 02:55:57 2026-04-24 02:55:57        INFO        MultiTermMatrixCleaner::mtclean()         Reached max number of iterations for this minor cycle
24-Apr-2026 02:56:00 2026-04-24 02:55:57        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by scale :  [0]: -0.550933  [12]: 0  [20]: 0  [40]: 0.453056  [60]: 0.512442  [80]: 0.407626  [100]: 122.214 (in this run)
24-Apr-2026 02:56:00 2026-04-24 02:55:57        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by Taylor coefficient :  [0]: 123.031  [1]: -5.31311
24-Apr-2026 02:56:00 2026-04-24 02:55:58        INFO        SDAlgorithmBase::deconvolve         [tst.sp_mfs_sdonly.joint.multiterm] iters=0->50 [50], model=106.823->123.028, peakres=2.13701->1.00376, Reached cycleniter.
24-Apr-2026 02:56:00 2026-04-24 02:55:58        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 100 iterations.
24-Apr-2026 02:56:00 2026-04-24 02:55:59        INFO        sdintimaging::::casa        getSummary call: fullsummary=False
24-Apr-2026 02:56:00 2026-04-24 02:55:59        INFO        SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 1.00376, over full image : 1.00376
24-Apr-2026 02:56:00 2026-04-24 02:55:59        INFO        sdintimaging::::casa        Reached global stopping criterion : iteration limit
24-Apr-2026 02:56:00 2026-04-24 02:55:59        INFO        MultiTermMatrixCleaner::computeprincipalsolution()         MTMC :: Computing principal solution on residuals
24-Apr-2026 02:56:00 2026-04-24 02:55:59        INFO        SDAlgorithmBase::restore         [tst.sp_mfs_sdonly.joint.multiterm] : Restoring model image.
24-Apr-2026 02:56:00 2026-04-24 02:55:59        INFO        SIImageStore::restore         Beam for chan : 0 : 430.287 arcsec, 430.287 arcsec, -27.0128 deg
24-Apr-2026 02:56:00 2026-04-24 02:55:59        INFO        SIImageStore::restore         Beam for chan : 0 : 430.287 arcsec, 430.287 arcsec, -27.0128 deg
24-Apr-2026 02:56:00 2026-04-24 02:55:59        INFO        SIImageStoreMultiTerm::calculateAlphaBeta         Calculating spectral parameters for Intensity > peakresidual/10 = 0.100376 Jy/beam
24-Apr-2026 02:56:00 2026-04-24 02:55:59        INFO        SIImageStoreMultiTerm::calculateAlphaBeta         Written Spectral Index Error Image : /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31233-CCM228/work/test_task_sdintimaging/tst.sp_mfs_sdonly.joint.multiterm.alpha.error
24-Apr-2026 02:56:00 2026-04-24 02:55:59        INFO        SDAlgorithmMSMFS::restore         Restored images :
24-Apr-2026 02:56:00 2026-04-24 02:55:59        INFO        SDAlgorithmMSMFS::restore         /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31233-CCM228/work/test_task_sdintimaging/tst.sp_mfs_sdonly.joint.multiterm.image.tt0  (model=/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31233-CCM228/work/test_task_sdintimaging/tst.sp_mfs_sdonly.joint.multiterm.model.tt0)
24-Apr-2026 02:56:00 2026-04-24 02:55:59        INFO        SDAlgorithmMSMFS::restore         /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31233-CCM228/work/test_task_sdintimaging/tst.sp_mfs_sdonly.joint.multiterm.image.tt1  (model=/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31233-CCM228/work/test_task_sdintimaging/tst.sp_mfs_sdonly.joint.multiterm.model.tt1)
24-Apr-2026 02:56:00 2026-04-24 02:55:59        INFO        SDAlgorithmMSMFS::restore         
24-Apr-2026 02:56:00 master 1 init 1
24-Apr-2026 02:56:00 2026-04-24 02:55:59        INFO        sdintimaging::::casa        Deleting tmp_498880_*plane
24-Apr-2026 02:56:00 2026-04-24 02:55:59        INFO        sdintimaging::::casa        Searching for images with prefix 'tst.sp_mfs_sdonly'... Found these, writing history into them: ['tst.sp_mfs_sdonly.int.cube.pb', 'tst.sp_mfs_sdonly.int.cube.psf', 'tst.sp_mfs_sdonly.int.cube.sumwt', 'tst.sp_mfs_sdonly.int.cube.residual', 'tst.sp_mfs_sdonly.joint.multiterm.psf.tt0', 'tst.sp_mfs_sdonly.joint.multiterm.sumwt.tt0', 'tst.sp_mfs_sdonly.joint.multiterm.psf.tt1', 'tst.sp_mfs_sdonly.joint.multiterm.sumwt.tt1', 'tst.sp_mfs_sdonly.joint.multiterm.psf.tt2', 'tst.sp_mfs_sdonly.joint.multiterm.sumwt.tt2', 'tst.sp_mfs_sdonly.joint.multiterm.pb.tt0', 'tst.sp_mfs_sdonly.joint.multiterm.residual.tt0', 'tst.sp_mfs_sdonly.joint.multiterm.residual.tt1', 'tst.sp_mfs_sdonly.sd.cube.residual', 'tst.sp_mfs_sdonly.sd.cube.image', 'tst.sp_mfs_sdonly.sd.cube.psf', 'tst.sp_mfs_sdonly.joint.cube.psf', 'tst.sp_mfs_sdonly.joint.multiterm.mask', 'tst.sp_mfs_sdonly.joint.multiterm.model.tt0', 'tst.sp_mfs_sdonly.joint.multiterm.model.tt1', 'tst.sp_mfs_sdonly.int.cube.model', 'tst.sp_mfs_sdonly.sd.cube.model', 'tst.sp_mfs_sdonly.joint.cube.residual', 'tst.sp_mfs_sdonly.joint.multiterm.image.tt0', 'tst.sp_mfs_sdonly.joint.multiterm.image.tt1', 'tst.sp_mfs_sdonly.joint.multiterm.alpha', 'tst.sp_mfs_sdonly.joint.multiterm.alpha.error']
24-Apr-2026 02:56:00 2026-04-24 02:56:00        INFO        sdintimaging::::casa        Task sdintimaging complete. Start time: 2026-04-23 22:55:30.646542 End time: 2026-04-23 22:55:59.981474
24-Apr-2026 02:56:00 2026-04-24 02:56:00        INFO        sdintimaging::::casa        ##### End Task: sdintimaging         #####
24-Apr-2026 02:56:00 2026-04-24 02:56:00        INFO        sdintimaging::::casa        ##########################################
24-Apr-2026 02:56:00 2026-04-24 02:56:00        INFO        name::        No table opened.
24-Apr-2026 02:56:00 2026-04-24 02:56:00        INFO        showcache::        The Table Cache is empty.
24-Apr-2026 02:56:00 2026-04-24 02:56:00        INFO        sdintimaging::::casa        [ check_ret_structure ] Return dictionary struture check: type=reduced ( Pass : found all expected keys  )
24-Apr-2026 02:56:00 2026-04-24 02:56:00        INFO        sdintimaging::::casa+        [ check_ims ] Image made : ['tst.sp_mfs_sdonly.joint.multiterm.psf.tt0', 'tst.sp_mfs_sdonly.joint.multiterm.residual.tt0', 'tst.sp_mfs_sdonly.joint.multiterm.image.tt0', 'tst.sp_mfs_sdonly.joint.multiterm.image.tt1', 'tst.sp_mfs_sdonly.joint.multiterm.alpha'] =  [True, True, True, True, True] ( Pass : should all be True )
24-Apr-2026 02:56:00 2026-04-24 02:56:00        INFO        sdintimaging::::casa+        All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords)
24-Apr-2026 02:56:00 2026-04-24 02:56:00        INFO        sdintimaging::::casa+        [check_history] All expected history entries found. (Pass)
24-Apr-2026 02:56:00 2026-04-24 02:56:00        INFO        sdintimaging::::casa+        [ check_pix_val ] tst.sp_mfs_sdonly.joint.multiterm.psf.tt0 : Value is 1.0 at [400, 400, 0, 0] ( Pass : should be 1.0 , Epsilon: 0.05)
24-Apr-2026 02:56:00 2026-04-24 02:56:00        INFO        sdintimaging::::casa+        [ check_pix_val ] tst.sp_mfs_sdonly.joint.multiterm.image.tt0 : Value is 8.102530479431152 at [350, 433, 0, 0] ( Pass : should be 7.91 , Epsilon: 0.05)
24-Apr-2026 02:56:00 2026-04-24 02:56:00        INFO        sdintimaging::::casa+        [ check_pix_val ] tst.sp_mfs_sdonly.joint.multiterm.image.tt0 : Value is 15.698700904846191 at [300, 400, 0, 0] ( Pass : should be 15.3 , Epsilon: 0.05)
24-Apr-2026 02:56:00 2026-04-24 02:56:00        INFO        sdintimaging::::casa+        [ check_pix_val ] tst.sp_mfs_sdonly.joint.multiterm.alpha : Value is -0.13693596422672272 at [350, 433, 0, 0] ( Pass : should be -0.137 , Epsilon: 0.05)
24-Apr-2026 02:56:00 2026-04-24 02:56:00        INFO        sdintimaging::::casa+        [ check_pix_val ] tst.sp_mfs_sdonly.joint.multiterm.alpha : Value is 0.01598879136145115 at [300, 400, 0, 0] ( Pass : should be 0.018 , Epsilon: 0.05)
24-Apr-2026 02:56:00 .2026-04-24 02:56:00        INFO        sdintimaging::::casa        ##########################################
24-Apr-2026 02:56:00 2026-04-24 02:56:00        INFO        sdintimaging::::casa        ##### Begin Task: sdintimaging       #####
24-Apr-2026 02:56:00 2026-04-24 02:56:00        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=2, 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 )
24-Apr-2026 02:56:00 2026-04-24 02:56:00        INFO        sdintimaging::::casa        Initializing SDINT Helper instance with tmp file tag 447653
24-Apr-2026 02:56:00 2026-04-24 02:56:00        INFO        sdintimaging::::casa        INT cube setup ....
24-Apr-2026 02:56:00 2026-04-24 02:56:00        INFO        sdintimaging::::casa        Verifying Input Parameters
24-Apr-2026 02:56:03 2026-04-24 02:56:00        INFO        SynthesisImagerVi2::selectData         MS : papersky_standard.ms | [Opened in readonly mode]
24-Apr-2026 02:56:03 2026-04-24 02:56:00        INFO        SynthesisImagerVi2::selectData           NRows selected : 6318
24-Apr-2026 02:56:03 2026-04-24 02:56:00        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [tst.sp_mfs_sdint.int.cube] :
24-Apr-2026 02:56:03 2026-04-24 02:56:00        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [tst.sp_mfs_sdint.int.cube] :
24-Apr-2026 02:56:03 2026-04-24 02:56:00        INFO        MSTransformRegridder::calcChanFreqs         phaseCenter='Direction: [0.377371, -0.657097, 0.652545]'  Channels equidistant in freq
24-Apr-2026 02:56:03 2026-04-24 02:56:00        INFO        MSTransformRegridder::calcChanFreqs+         Central frequency (in output frame) = 1.49983e+09 Hz
24-Apr-2026 02:56:03 2026-04-24 02:56:00        INFO        MSTransformRegridder::calcChanFreqs+         Width of central channel (in output frame) = 4.99945e+08 Hz
24-Apr-2026 02:56:03 2026-04-24 02:56:00        INFO        MSTransformRegridder::calcChanFreqs+         Number of channels = 3
24-Apr-2026 02:56:03 2026-04-24 02:56:00        INFO        MSTransformRegridder::calcChanFreqs+         Total width of SPW (in output frame) = 1.49983e+09 Hz
24-Apr-2026 02:56:03 2026-04-24 02:56:00        INFO        MSTransformRegridder::calcChanFreqs+         Lower edge = 7.49917e+08 Hz, upper edge = 2.24975e+09 Hz
24-Apr-2026 02:56:03 2026-04-24 02:56:00        INFO        SynthesisImagerVi2::defineImage         Impars: start
24-Apr-2026 02:56:03 2026-04-24 02:56:00        INFO        SynthesisImagerVi2::defineImage         Shape: [800, 800, 1, 3] Spectral: [9.99889e+08] at [0] with increment [4.99945e+08]
24-Apr-2026 02:56:03 2026-04-24 02:56:00        INFO        SynthesisImagerVi2::defineImage         Set Gridding options for [tst.sp_mfs_sdint.int.cube] with ftmachine : gridft
24-Apr-2026 02:56:03 2026-04-24 02:56:00        INFO        SynthesisImagerVi2::nSubCubeFitInMemory        Required memory: 0.4079 GB. Available mem.: 389.7 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
24-Apr-2026 02:56:03 2026-04-24 02:56:00        INFO        sdintimaging::::casa        CFCache already exists
24-Apr-2026 02:56:03 2026-04-24 02:56:00        INFO        SynthesisImagerVi2::weight()         Set imaging weights : Natural weighting
24-Apr-2026 02:56:03 2026-04-24 02:56:00        INFO        SynthesisImager::makePSF         ----------------------------------------------------------- Make PSF ---------------------------------------------
24-Apr-2026 02:56:03 2026-04-24 02:56:00        INFO        SynthesisImagerVi2::nSubCubeFitInMemory        Required memory: 0.4079 GB. Available mem.: 389.7 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
24-Apr-2026 02:56:03 2026-04-24 02:56:01        INFO        SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
24-Apr-2026 02:56:03 2026-04-24 02:56:01        INFO        SynthesisImagerVi2::nSubCubeFitInMemory        Required memory: 0.4079 GB. Available mem.: 389.7 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
24-Apr-2026 02:56:03 2026-04-24 02:56:02        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
24-Apr-2026 02:56:03 2026-04-24 02:56:02        INFO        image::_setrestoringbeam         Will copy beams from another image to this image
24-Apr-2026 02:56:03 2026-04-24 02:56:02        INFO        BeamManipulator::set        Set image beam set
24-Apr-2026 02:56:03 2026-04-24 02:56:02        INFO        sdintimaging::::casa        Combined image setup ....
24-Apr-2026 02:56:03 2026-04-24 02:56:02        INFO        sdintimaging::::casa        Verifying Input Parameters
24-Apr-2026 02:56:03 2026-04-24 02:56:02        INFO        SynthesisImagerVi2::selectData         MS : papersky_standard.ms | [Opened in readonly mode]
24-Apr-2026 02:56:03 2026-04-24 02:56:02        INFO        SynthesisImagerVi2::selectData           NRows selected : 6318
24-Apr-2026 02:56:03 2026-04-24 02:56:02        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [tst.sp_mfs_sdint.joint.multiterm] :
24-Apr-2026 02:56:03 2026-04-24 02:56:02        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [tst.sp_mfs_sdint.joint.multiterm] :
24-Apr-2026 02:56:03 2026-04-24 02:56:02        INFO        SynthesisImagerVi2::defineImage         Impars: start
24-Apr-2026 02:56:03 2026-04-24 02:56:02        INFO        SynthesisImagerVi2::defineImage         Shape: [800, 800, 1, 1] Spectral: [1.5e+09] at [0] with increment [1.50017e+09]
24-Apr-2026 02:56:03 2026-04-24 02:56:02        INFO        SynthesisImagerVi2::defineImage         Set Gridding options for [tst.sp_mfs_sdint.joint.multiterm] with ftmachine : gridft
24-Apr-2026 02:56:03 2026-04-24 02:56:02        INFO        SynthesisImagerVi2::nSubCubeFitInMemory        Required memory: 0.2266 GB. Available mem.: 389.7 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
24-Apr-2026 02:56:03 2026-04-24 02:56:02        INFO        SynthesisImagerVi2::weight()         Set imaging weights : Natural weighting
24-Apr-2026 02:56:03 2026-04-24 02:56:02        INFO        SynthesisImager::makePSF         ----------------------------------------------------------- Make PSF ---------------------------------------------
24-Apr-2026 02:56:03 2026-04-24 02:56:03        INFO        SIImageStoreMultiTerm::calcSensitivity         Multi-Term Hessian Matrix : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:56:03 2026-04-24 02:56:03        INFO        SIImageStoreMultiTerm::calcSensitivity +        [37908, -4.18539
24-Apr-2026 02:56:03 2026-04-24 02:56:03        INFO        SIImageStoreMultiTerm::calcSensitivity +         -4.18539, 2807.38]
24-Apr-2026 02:56:03 2026-04-24 02:56:03        INFO        SIImageStoreMultiTerm::calcSensitivity         Multi-Term Covariance Matrix : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:56:03 2026-04-24 02:56:03        INFO        SIImageStoreMultiTerm::calcSensitivity +        [2.63797e-05, 3.93281e-08
24-Apr-2026 02:56:03 2026-04-24 02:56:03        INFO        SIImageStoreMultiTerm::calcSensitivity +         3.93281e-08, 0.000356204]
24-Apr-2026 02:56:03 2026-04-24 02:56:03        INFO        SIImageStoreMultiTerm::calcSensitivity         [tst.sp_mfs_sdint.joint.multiterm][Taylor0] Theoretical sensitivity (Jy/bm):0.00513611
24-Apr-2026 02:56:03 2026-04-24 02:56:03        INFO        SIImageStoreMultiTerm::calcSensitivity         [tst.sp_mfs_sdint.joint.multiterm][Taylor1] Theoretical sensitivity (Jy/bm):0.0188734
24-Apr-2026 02:56:03 2026-04-24 02:56:03        INFO        SIImageStoreMultiTerm::calcFractionalBandwidth         MFS frequency range : 0.749917 GHz -> 2.25008GHz.Fractional Bandwidth : 100.011 %.Reference Frequency for Taylor Expansion : 1.5GHz.
24-Apr-2026 02:56:03 2026-04-24 02:56:03        INFO        SIImageStore::getPSFGaussian         Time to fit Gaussian to PSF 0.014274
24-Apr-2026 02:56:03 2026-04-24 02:56:03        INFO        SIImageStore::printBeamSet         Beam : 53.662 arcsec, 53.2099 arcsec, 22.4308 deg
24-Apr-2026 02:56:03 2026-04-24 02:56:03        INFO        SynthesisImagerVi2::makePrimaryBeam         vi2 : Evaluating Primary Beam model onto image grid(s)
24-Apr-2026 02:56:03 2026-04-24 02:56:03        INFO        SynthesisDeconvolver::setupDeconvolution         Set Deconvolution Options for [tst.sp_mfs_sdint.joint.multiterm] : mtmfs
24-Apr-2026 02:56:03 2026-04-24 02:56:03        INFO        SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
24-Apr-2026 02:56:03 2026-04-24 02:56:03        INFO        sdintimaging::::casa        SD cube setup ....
24-Apr-2026 02:56:03 2026-04-24 02:56:03        INFO        sdintimaging::::casa        Initializing SDINT Helper instance with tmp file tag 266165
24-Apr-2026 02:56:03 2026-04-24 02:56:03        INFO        sdintimaging::::casa         The center of psf coincides with int psf: (diffRA,diffDec)=( 0.0, 0.0)
24-Apr-2026 02:56:03 2026-04-24 02:56:03        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Apr-2026 02:56:03 2026-04-24 02:56:03        WARN        ImageRegridder::_doImagesOverlap        At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
24-Apr-2026 02:56:03 2026-04-24 02:56:03        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.
24-Apr-2026 02:56:03 2026-04-24 02:56:03        INFO        SubImageFactory::createImage        Creating image 'tst.sp_mfs_sdint.sd.cube.residual' of shape [800, 800, 1, 3]
24-Apr-2026 02:56:03 2026-04-24 02:56:04        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Apr-2026 02:56:03 2026-04-24 02:56:04        WARN        ImageRegridder::_doImagesOverlap        At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
24-Apr-2026 02:56:03 2026-04-24 02:56:04        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.
24-Apr-2026 02:56:03 2026-04-24 02:56:04        INFO        SubImageFactory::createImage        Creating image 'tst.sp_mfs_sdint.sd.cube.image' of shape [800, 800, 1, 3]
24-Apr-2026 02:56:03 2026-04-24 02:56:04        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Apr-2026 02:56:03 2026-04-24 02:56:04        WARN        ImageRegridder::_doImagesOverlap        At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
24-Apr-2026 02:56:05 2026-04-24 02:56:04        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.
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        SubImageFactory::createImage        Creating image 'tst.sp_mfs_sdint.sd.cube.psf' of shape [800, 800, 1, 3]
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        sdintimaging::::casa        Deleting tmp_266165_*plane
24-Apr-2026 02:56:05 2026-04-24 02:56:04        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.
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        sdintimaging::::casa        Feathering INT and SD residual images...
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        sdintimaging::::casa        Deleting tmp_447653_*plane
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:05 2026-04-24 02:56:04        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)
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_sdplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:05 2026-04-24 02:56:04        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)
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_intplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        sdintimaging::::casa        start Feathering.....
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        Imager::setvp()         Setting voltage pattern parameters
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        Imager::setvp()         Sky position tolerance is 180 degrees
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        Imager::setvp()         Using system default voltage patterns for each telescope
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        imager::setsdoptions()         Setting single dish processing options
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        imager::feather()        
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        imager::feather()+        Feathering together high and low resolution images...
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        imager::feather()        Each input image has a single restoring beam.
24-Apr-2026 02:56:05 2026-04-24 02:56:04        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.
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        sdintimaging::::casa        Deleting tmp_447653_*plane
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:05 2026-04-24 02:56:04        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)
24-Apr-2026 02:56:05 2026-04-24 02:56:04        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_sdplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:05 2026-04-24 02:56:05        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)
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_intplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        sdintimaging::::casa        start Feathering.....
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        Imager::setvp()         Setting voltage pattern parameters
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        Imager::setvp()         Sky position tolerance is 180 degrees
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        Imager::setvp()         Using system default voltage patterns for each telescope
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        imager::setsdoptions()         Setting single dish processing options
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        imager::feather()        
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        imager::feather()+        Feathering together high and low resolution images...
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        imager::feather()        Each input image has a single restoring beam.
24-Apr-2026 02:56:05 2026-04-24 02:56:05        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.
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        sdintimaging::::casa        Deleting tmp_447653_*plane
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:05 2026-04-24 02:56:05        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)
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_sdplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:05 2026-04-24 02:56:05        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)
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_intplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        sdintimaging::::casa        start Feathering.....
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        Imager::setvp()         Setting voltage pattern parameters
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        Imager::setvp()         Sky position tolerance is 180 degrees
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        Imager::setvp()         Using system default voltage patterns for each telescope
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        imager::setsdoptions()         Setting single dish processing options
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        imager::feather()        
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        imager::feather()+        Feathering together high and low resolution images...
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        imager::feather()        Each input image has a single restoring beam.
24-Apr-2026 02:56:05 2026-04-24 02:56:05        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.
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        sdintimaging::::casa        Deleting tmp_447653_*plane
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:05 2026-04-24 02:56:05        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:07 2026-04-24 02:56:05        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)
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_sdplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:07 2026-04-24 02:56:06        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)
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_intplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        sdintimaging::::casa        start Feathering.....
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        Imager::setvp()         Setting voltage pattern parameters
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        Imager::setvp()         Sky position tolerance is 180 degrees
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        Imager::setvp()         Using system default voltage patterns for each telescope
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        imager::setsdoptions()         Setting single dish processing options
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        imager::feather()        
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        imager::feather()+        Feathering together high and low resolution images...
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        imager::feather()        Each input image has a single restoring beam.
24-Apr-2026 02:56:07 2026-04-24 02:56:06        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.
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        sdintimaging::::casa        Deleting tmp_447653_*plane
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:07 2026-04-24 02:56:06        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)
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_sdplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:07 2026-04-24 02:56:06        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)
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_intplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        sdintimaging::::casa        start Feathering.....
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        Imager::setvp()         Setting voltage pattern parameters
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        Imager::setvp()         Sky position tolerance is 180 degrees
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        Imager::setvp()         Using system default voltage patterns for each telescope
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        imager::setsdoptions()         Setting single dish processing options
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        imager::feather()        
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        imager::feather()+        Feathering together high and low resolution images...
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        imager::feather()        Each input image has a single restoring beam.
24-Apr-2026 02:56:07 2026-04-24 02:56:06        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.
24-Apr-2026 02:56:07 2026-04-24 02:56:06        INFO        sdintimaging::::casa        Deleting tmp_447653_*plane
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:07 2026-04-24 02:56:07        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)
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_sdplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:07 2026-04-24 02:56:07        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)
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_intplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        sdintimaging::::casa        start Feathering.....
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        Imager::setvp()         Setting voltage pattern parameters
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        Imager::setvp()         Sky position tolerance is 180 degrees
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        Imager::setvp()         Using system default voltage patterns for each telescope
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        imager::setsdoptions()         Setting single dish processing options
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        imager::feather()        
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        imager::feather()+        Feathering together high and low resolution images...
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        imager::feather()        Each input image has a single restoring beam.
24-Apr-2026 02:56:07 2026-04-24 02:56:07        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.
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        SIImageStore::Open existing Images         SumWt does not exist. Proceeding only with PSF
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        SynthesisUtilMethods::fitPsfBeam        Fitting PSF beam for Imagestore : tst.sp_mfs_sdint.joint.cube
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        SIImageStore::getPSFGaussian         Time to fit Gaussian to PSF 0.03948
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        SIImageStore::printBeamSet         Restoring Beams
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        SIImageStore::printBeamSet +        Chan    Freq   Vel Pol
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        SIImageStore::printBeamSet +           0 1.0e+09    33   I   77.5193 arcsec x   76.6073 arcsec pa= 11.1113 deg
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        SIImageStore::printBeamSet +           1 1.5e+09 -149846   I   51.6676 arcsec x   51.0710 arcsec pa= 11.3343 deg
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        SIImageStore::printBeamSet +           2 2.0e+09 -299726   I   38.7687 arcsec x   38.3203 arcsec pa= 14.0803 deg
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        sdintimaging::::casa        Calculate spectral PSFs and Taylor Residuals...
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        SynthesisUtilMethods::fitPsfBeam        Fitting PSF beam for Imagestore : tst.sp_mfs_sdint.joint.multiterm
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        SIImageStore::getPSFGaussian         Time to fit Gaussian to PSF 0.015987
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        SIImageStore::printBeamSet         Beam : 53.1832 arcsec, 52.7084 arcsec, 20.2963 deg
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0, over full image : 1.1314
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        SynthesisDeconvolver::setupMask         [tst.sp_mfs_sdint.joint.multiterm] Setting up a mask from [papersky_standard.true.im.masklist]
24-Apr-2026 02:56:07 2026-04-24 02:56:07        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:14 2026-04-24 02:56:07        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
24-Apr-2026 02:56:14 2026-04-24 02:56:07        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:14 2026-04-24 02:56:07        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.
24-Apr-2026 02:56:14 2026-04-24 02:56:07        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Apr-2026 02:56:14 2026-04-24 02:56:07        WARN        ImageRegridder::_doImagesOverlap        At least one of the images exceeds one degree on at one side, not checking for direction plane overlap.
24-Apr-2026 02:56:14 2026-04-24 02:56:07        INFO        RegionTextParser::_determineVersion        RegionTextParser::_determineVersion: Found spec version 0
24-Apr-2026 02:56:14 2026-04-24 02:56:07        INFO        AsciiRegionFileParser::_parse        Combined 5 image regions (which excludes any annotation regions)
24-Apr-2026 02:56:14 2026-04-24 02:56:07        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).
24-Apr-2026 02:56:14 2026-04-24 02:56:08        INFO        SynthesisDeconvolver::setupMask         ----------------------------------------------------------------------------------------------------------------------------------------
24-Apr-2026 02:56:14 2026-04-24 02:56:08        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 % ]
24-Apr-2026 02:56:14 2026-04-24 02:56:08        INFO        SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 1.1314, over full image : 1.1314
24-Apr-2026 02:56:14 2026-04-24 02:56:08        INFO        sdintimaging::::casa        Minor Cycle controls : {'cycleniter': 20, 'cyclethreshold': 0.1363893300294876, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
24-Apr-2026 02:56:14 2026-04-24 02:56:08        INFO        SDAlgorithmBase::deconvolve         [tst.sp_mfs_sdint.joint.multiterm] Run mtmfs minor-cycle | CycleThreshold=0.136389, CycleNiter=20, Gain=0.1
24-Apr-2026 02:56:14 2026-04-24 02:56:08        INFO        MultiTermMatrixCleaner::verifyScaleSizes()         Scale sizes to be used for deconvolution : [0, 12, 20, 40, 60, 80, 100]
24-Apr-2026 02:56:14 2026-04-24 02:56:08        INFO        MultiTermMatrixCleaner::setupScaleFunctions         scale 1 = 0 pixels with bias = 1
24-Apr-2026 02:56:14 2026-04-24 02:56:08        INFO        MultiTermMatrixCleaner::setupScaleFunctions         scale 2 = 12 pixels with bias = 1
24-Apr-2026 02:56:14 2026-04-24 02:56:08        INFO        MultiTermMatrixCleaner::setupScaleFunctions         scale 3 = 20 pixels with bias = 1
24-Apr-2026 02:56:14 2026-04-24 02:56:08        INFO        MultiTermMatrixCleaner::setupScaleFunctions         scale 4 = 40 pixels with bias = 1
24-Apr-2026 02:56:14 2026-04-24 02:56:08        INFO        MultiTermMatrixCleaner::setupScaleFunctions         scale 5 = 60 pixels with bias = 1
24-Apr-2026 02:56:14 2026-04-24 02:56:08        INFO        MultiTermMatrixCleaner::setupScaleFunctions         scale 6 = 80 pixels with bias = 1
24-Apr-2026 02:56:14 2026-04-24 02:56:08        INFO        MultiTermMatrixCleaner::setupScaleFunctions         scale 7 = 100 pixels with bias = 1
24-Apr-2026 02:56:14 2026-04-24 02:56:08        INFO        MultiTermMatrixCleaner::initialise()         Using a PSF patch of 800 pixels on each side for minor-cycle updates.
24-Apr-2026 02:56:14 2026-04-24 02:56:08        INFO        MatrixCleaner::validatePsf()         Peak of PSF = 0.990617 at [400, 400]
24-Apr-2026 02:56:14 2026-04-24 02:56:08        INFO        SIImageStoreMultiTerm::calcFractionalBandwidth         MFS frequency range : 0.749917 GHz -> 2.25008GHz.Fractional Bandwidth : 100.011 %.Reference Frequency for Taylor Expansion : 1.5GHz.
24-Apr-2026 02:56:14 2026-04-24 02:56:08        INFO        MultiTermMatrixCleaner::computeHessianPeak         Calculating PSF and Scale convolutions
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::computeHessianPeak         The Matrix [H] for 0 pixel scale is : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::computeHessianPeak +        [0.990617, -0.000119891
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::computeHessianPeak +         -0.000119891, 0.073365]
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::computeHessianPeak         The Matrix [H] for 12 pixel scale is : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::computeHessianPeak +        [0.261247, -0.0234538
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::computeHessianPeak +         -0.0234538, 0.0201623]
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::computeHessianPeak         The Matrix [H] for 20 pixel scale is : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::computeHessianPeak +        [0.137015, -0.0147553
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::computeHessianPeak +         -0.0147553, 0.0106943]
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::computeHessianPeak         The Matrix [H] for 40 pixel scale is : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::computeHessianPeak +        [0.0438432, -0.00670719
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::computeHessianPeak +         -0.00670719, 0.00355362]
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::computeHessianPeak         The Matrix [H] for 60 pixel scale is : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::computeHessianPeak +        [0.0181479, -0.00334112
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::computeHessianPeak +         -0.00334112, 0.00153626]
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::computeHessianPeak         The Matrix [H] for 80 pixel scale is : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::computeHessianPeak +        [0.00861385, -0.00173856
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::computeHessianPeak +         -0.00173856, 0.000747211]
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::computeHessianPeak         The Matrix [H] for 100 pixel scale is : Axis Lengths: [2, 2]  (NB: Matrix in Row/Column order)
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::computeHessianPeak +        [0.00459695, -0.000958446
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::computeHessianPeak +         -0.000958446, 0.00040842]
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::mtclean()         Calculating convolutions of residual images with scales
24-Apr-2026 02:56:14 2026-04-24 02:56:09        INFO        MultiTermMatrixCleaner::mtclean()         Peak convolved residual (within mask)  : 1.14211
24-Apr-2026 02:56:14 2026-04-24 02:56:13        INFO                [20] Res: 1.06781 Max: 1.29809 Gain: 0.1 Pos: [297, 423] Scale: 100 Coeffs: 18.4318  8.24836 
24-Apr-2026 02:56:14 2026-04-24 02:56:13        INFO        MultiTermMatrixCleaner::mtclean()         Reached max number of iterations for this minor cycle
24-Apr-2026 02:56:14 2026-04-24 02:56:13        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)
24-Apr-2026 02:56:14 2026-04-24 02:56:13        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by Taylor coefficient :  [0]: 59.0281  [1]: 30.2788
24-Apr-2026 02:56:14 2026-04-24 02:56:13        INFO        SDAlgorithmBase::deconvolve         [tst.sp_mfs_sdint.joint.multiterm] iters=0->20 [20], model=0->59.0275, peakres=1.1314->1.05779, Reached cycleniter.
24-Apr-2026 02:56:14 2026-04-24 02:56:13        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 20 iterations.
24-Apr-2026 02:56:14 2026-04-24 02:56:13        INFO        task_sdintimaging::image::_setrestoringbeam         Will remove any existing beams from image
24-Apr-2026 02:56:14 2026-04-24 02:56:13        INFO        task_sdintimaging::::        Deleted restoring beam(s)
24-Apr-2026 02:56:14 2026-04-24 02:56:13        INFO        task_sdintimaging::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 2 -------------------------------------
24-Apr-2026 02:56:14 2026-04-24 02:56:13        INFO        task_sdintimaging::SynthesisImagerVi2::nSubCubeFitInMemory        Required memory: 0.4079 GB. Available mem.: 389.7 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
24-Apr-2026 02:56:14 2026-04-24 02:56:15        INFO        sdintimaging::::casa        Deleting tmp_447653_*plane
24-Apr-2026 02:56:14 2026-04-24 02:56:15        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:14 2026-04-24 02:56:15        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:14 2026-04-24 02:56:15        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:14 2026-04-24 02:56:15        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:14 2026-04-24 02:56:15        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)
24-Apr-2026 02:56:14 2026-04-24 02:56:15        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_sdplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:20 2026-04-24 02:56:15        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)
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_intplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        sdintimaging::::casa        start Feathering.....
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        Imager::setvp()         Setting voltage pattern parameters
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        Imager::setvp()         Sky position tolerance is 180 degrees
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        Imager::setvp()         Using system default voltage patterns for each telescope
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        imager::setsdoptions()         Setting single dish processing options
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        imager::feather()        
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        imager::feather()+        Feathering together high and low resolution images...
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        imager::feather()        Each input image has a single restoring beam.
24-Apr-2026 02:56:20 2026-04-24 02:56:15        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.
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        sdintimaging::::casa        Deleting tmp_447653_*plane
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:20 2026-04-24 02:56:15        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)
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_sdplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:20 2026-04-24 02:56:15        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)
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_intplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        sdintimaging::::casa        start Feathering.....
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        Imager::setvp()         Setting voltage pattern parameters
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        Imager::setvp()         Sky position tolerance is 180 degrees
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        Imager::setvp()         Using system default voltage patterns for each telescope
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        imager::setsdoptions()         Setting single dish processing options
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        imager::feather()        
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        imager::feather()+        Feathering together high and low resolution images...
24-Apr-2026 02:56:20 2026-04-24 02:56:15        INFO        imager::feather()        Each input image has a single restoring beam.
24-Apr-2026 02:56:20 2026-04-24 02:56:15        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.
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        sdintimaging::::casa        Deleting tmp_447653_*plane
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:20 2026-04-24 02:56:16        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)
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_sdplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:20 2026-04-24 02:56:16        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)
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_intplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        sdintimaging::::casa        start Feathering.....
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        Imager::setvp()         Setting voltage pattern parameters
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        Imager::setvp()         Sky position tolerance is 180 degrees
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        Imager::setvp()         Using system default voltage patterns for each telescope
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        imager::setsdoptions()         Setting single dish processing options
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        imager::feather()        
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        imager::feather()+        Feathering together high and low resolution images...
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        imager::feather()        Each input image has a single restoring beam.
24-Apr-2026 02:56:20 2026-04-24 02:56:16        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.
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        sdintimaging::::casa        getSummary call: fullsummary=False
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 1.05779, over full image : 1.05779
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        sdintimaging::::casa        Minor Cycle controls : {'cycleniter': 20, 'cyclethreshold': 0.12751585245132446, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
24-Apr-2026 02:56:20 2026-04-24 02:56:16        INFO        SDAlgorithmBase::deconvolve         [tst.sp_mfs_sdint.joint.multiterm] Run mtmfs minor-cycle | CycleThreshold=0.127516, CycleNiter=20, Gain=0.1
24-Apr-2026 02:56:20 2026-04-24 02:56:17        INFO        SIImageStoreMultiTerm::calcFractionalBandwidth         MFS frequency range : 0.749917 GHz -> 2.25008GHz.Fractional Bandwidth : 100.011 %.Reference Frequency for Taylor Expansion : 1.5GHz.
24-Apr-2026 02:56:20 2026-04-24 02:56:17        INFO        MultiTermMatrixCleaner::mtclean()         Calculating convolutions of residual images with scales
24-Apr-2026 02:56:20 2026-04-24 02:56:17        INFO        MultiTermMatrixCleaner::mtclean()         Peak convolved residual (within mask)  : 1.06781
24-Apr-2026 02:56:20 2026-04-24 02:56:20        INFO                [40] Res: 0.739462 Max: 0.633658 Gain: 0.1 Pos: [552, 400] Scale: 0 Coeffs: 0.799742  0.0328288 
24-Apr-2026 02:56:20 2026-04-24 02:56:20        INFO        MultiTermMatrixCleaner::mtclean()         Reached max number of iterations for this minor cycle
24-Apr-2026 02:56:20 2026-04-24 02:56:20        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)
24-Apr-2026 02:56:20 2026-04-24 02:56:20        INFO        MultiTermMatrixCleaner::mtclean()         Total flux by Taylor coefficient :  [0]: 74.333  [1]: 34.0242
24-Apr-2026 02:56:20 2026-04-24 02:56:20        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.
24-Apr-2026 02:56:20 2026-04-24 02:56:20        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 40 iterations.
24-Apr-2026 02:56:24 2026-04-24 02:56:21        INFO        task_sdintimaging::SynthesisImager::executeMajorCycle         ----------------------------------------------------------- Run Major Cycle 3 -------------------------------------
24-Apr-2026 02:56:24 2026-04-24 02:56:21        INFO        task_sdintimaging::SynthesisImagerVi2::nSubCubeFitInMemory        Required memory: 0.4079 GB. Available mem.: 389.7 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 3. Processes on node: 4.
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        sdintimaging::::casa        Deleting tmp_447653_*plane
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:24 2026-04-24 02:56:22        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)
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_sdplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:24 2026-04-24 02:56:22        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)
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_intplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        sdintimaging::::casa        start Feathering.....
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        Imager::setvp()         Setting voltage pattern parameters
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        Imager::setvp()         Sky position tolerance is 180 degrees
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        Imager::setvp()         Using system default voltage patterns for each telescope
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        imager::setsdoptions()         Setting single dish processing options
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        imager::feather()        
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        imager::feather()+        Feathering together high and low resolution images...
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        imager::feather()        Each input image has a single restoring beam.
24-Apr-2026 02:56:24 2026-04-24 02:56:22        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.
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        sdintimaging::::casa        Deleting tmp_447653_*plane
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:24 2026-04-24 02:56:22        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:24 2026-04-24 02:56:22        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)
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_sdplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:24 2026-04-24 02:56:23        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)
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_intplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        sdintimaging::::casa        start Feathering.....
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        Imager::setvp()         Setting voltage pattern parameters
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        Imager::setvp()         Sky position tolerance is 180 degrees
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        Imager::setvp()         Using system default voltage patterns for each telescope
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        imager::setsdoptions()         Setting single dish processing options
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        imager::feather()        
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        imager::feather()+        Feathering together high and low resolution images...
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        imager::feather()        Each input image has a single restoring beam.
24-Apr-2026 02:56:24 2026-04-24 02:56:23        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.
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        sdintimaging::::casa        Deleting tmp_447653_*plane
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:24 2026-04-24 02:56:23        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)
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_sdplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        CasacRegionManager::fromBCS        Using channel range(s)
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Apr-2026 02:56:24 2026-04-24 02:56:23        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)
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        ImageRegion::fromRecord        Creating image 'tmp_447653_intplane' of shape [800, 800, 1, 1]
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        sdintimaging::::casa        start Feathering.....
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        Imager::setvp()         Setting voltage pattern parameters
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        Imager::setvp()         Sky position tolerance is 180 degrees
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        Imager::setvp()         Using system default voltage patterns for each telescope
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        imager::setsdoptions()         Setting single dish processing options
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        imager::feather()        
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        imager::feather()+        Feathering together high and low resolution images...
24-Apr-2026 02:56:24 2026-04-24 02:56:23        INFO        imager::feather()        Each input image has a single restoring beam.
24-Apr-2026 02:56:24 2026-04-24 02:56:23        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.
24-Apr-2026 02:56:24 2026-04-24 02:56:24        INFO        sdintimaging::::casa        getSummary call: fullsummary=False
24-Apr-2026 02:56:24 2026-04-24 02:56:24        INFO        SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.732524, over full image : 0.732524
24-Apr-2026 02:56:24 2026-04-24 02:56:24        INFO        sdintimaging::::casa        Reached global stopping criterion : reached nmajor
24-Apr-2026 02:56:24 2026-04-24 02:56:24        INFO        MultiTermMatrixCleaner::computeprincipalsolution()         MTMC :: Computing principal solution on residuals
24-Apr-2026 02:56:24 2026-04-24 02:56:24        INFO        SDAlgorithmBase::restore         [tst.sp_mfs_sdint.joint.multiterm] : Restoring model image.
24-Apr-2026 02:56:24 2026-04-24 02:56:24        INFO        SIImageStore::restore         Beam for chan : 0 : 53.1832 arcsec, 52.7084 arcsec, 20.2963 deg
24-Apr-2026 02:56:24 2026-04-24 02:56:24        INFO        SIImageStore::restore         Beam for chan : 0 : 53.1832 arcsec, 52.7084 arcsec, 20.2963 deg
24-Apr-2026 02:56:40 2026-04-24 02:56:24        INFO        SIImageStoreMultiTerm::calculateAlphaBeta         Calculating spectral parameters for Intensity > peakresidual/10 = 0.0739367 Jy/beam
24-Apr-2026 02:56:40 2026-04-24 02:56:24        INFO        SIImageStoreMultiTerm::calculateAlphaBeta         Written Spectral Index Error Image : /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31233-CCM228/work/test_task_sdintimaging/tst.sp_mfs_sdint.joint.multiterm.alpha.error
24-Apr-2026 02:56:40 2026-04-24 02:56:24        INFO        SDAlgorithmMSMFS::restore         Restored images :
24-Apr-2026 02:56:40 2026-04-24 02:56:24        INFO        SDAlgorithmMSMFS::restore         /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31233-CCM228/work/test_task_sdintimaging/tst.sp_mfs_sdint.joint.multiterm.image.tt0  (model=/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31233-CCM228/work/test_task_sdintimaging/tst.sp_mfs_sdint.joint.multiterm.model.tt0)
24-Apr-2026 02:56:40 2026-04-24 02:56:24        INFO        SDAlgorithmMSMFS::restore         /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31233-CCM228/work/test_task_sdintimaging/tst.sp_mfs_sdint.joint.multiterm.image.tt1  (model=/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31233-CCM228/work/test_task_sdintimaging/tst.sp_mfs_sdint.joint.multiterm.model.tt1)
24-Apr-2026 02:56:40 2026-04-24 02:56:24        INFO        SDAlgorithmMSMFS::restore         
24-Apr-2026 02:56:40 master 1 init 1
24-Apr-2026 02:56:40 2026-04-24 02:56:24        INFO        sdintimaging::::casa        Deleting tmp_447653_*plane
24-Apr-2026 02:56:40 2026-04-24 02:56:24        INFO        sdintimaging::::casa        Searching for images with prefix 'tst.sp_mfs_sdint'... Found these, writing history into them: ['tst.sp_mfs_sdint.int.cube.pb', 'tst.sp_mfs_sdint.int.cube.psf', 'tst.sp_mfs_sdint.int.cube.sumwt', 'tst.sp_mfs_sdint.int.cube.residual', 'tst.sp_mfs_sdint.joint.multiterm.psf.tt0', 'tst.sp_mfs_sdint.joint.multiterm.sumwt.tt0', 'tst.sp_mfs_sdint.joint.multiterm.psf.tt1', 'tst.sp_mfs_sdint.joint.multiterm.sumwt.tt1', 'tst.sp_mfs_sdint.joint.multiterm.psf.tt2', 'tst.sp_mfs_sdint.joint.multiterm.sumwt.tt2', 'tst.sp_mfs_sdint.joint.multiterm.pb.tt0', 'tst.sp_mfs_sdint.joint.multiterm.residual.tt0', 'tst.sp_mfs_sdint.joint.multiterm.residual.tt1', 'tst.sp_mfs_sdint.sd.cube.residual', 'tst.sp_mfs_sdint.sd.cube.image', 'tst.sp_mfs_sdint.sd.cube.psf', 'tst.sp_mfs_sdint.joint.cube.psf', 'tst.sp_mfs_sdint.joint.multiterm.mask', 'tst.sp_mfs_sdint.joint.multiterm.model.tt0', 'tst.sp_mfs_sdint.joint.multiterm.model.tt1', 'tst.sp_mfs_sdint.int.cube.model', 'tst.sp_mfs_sdint.sd.cube.model', 'tst.sp_mfs_sdint.joint.cube.residual', 'tst.sp_mfs_sdint.joint.multiterm.image.tt0', 'tst.sp_mfs_sdint.joint.multiterm.image.tt1', 'tst.sp_mfs_sdint.joint.multiterm.alpha', 'tst.sp_mfs_sdint.joint.multiterm.alpha.error']
24-Apr-2026 02:56:40 2026-04-24 02:56:25        INFO        sdintimaging::::casa        Task sdintimaging complete. Start time: 2026-04-23 22:56:00.156780 End time: 2026-04-23 22:56:24.983864
24-Apr-2026 02:56:40 2026-04-24 02:56:25        INFO        sdintimaging::::casa        ##### End Task: sdintimaging         #####
24-Apr-2026 02:56:40 2026-04-24 02:56:25        INFO        sdintimaging::::casa        ##########################################
24-Apr-2026 02:56:40 2026-04-24 02:56:25        INFO        name::        No table opened.
24-Apr-2026 02:56:40 2026-04-24 02:56:25        INFO        showcache::        The Table Cache is empty.
24-Apr-2026 02:56:40 2026-04-24 02:56:25        INFO        sdintimaging::::casa        [ check_ret_structure ] Return dictionary struture check: type=reduced ( Pass : found all expected keys  )
24-Apr-2026 02:56:40 2026-04-24 02:56:25        INFO        sdintimaging::::casa+        [ check_val ] iterdone is 40 ( Pass : should be 40, Exact: True )
24-Apr-2026 02:56:40 2026-04-24 02:56:25        INFO        sdintimaging::::casa+        [ check_val ] nmajordone is 3 ( Pass : should be 3, Exact: True )
24-Apr-2026 02:56:40 2026-04-24 02:56:25        INFO        sdintimaging::::casa+        [ check_ims ] Image made : ['tst.sp_mfs_sdint.joint.multiterm.psf.tt0', 'tst.sp_mfs_sdint.joint.multiterm.residual.tt0', 'tst.sp_mfs_sdint.joint.multiterm.image.tt0', 'tst.sp_mfs_sdint.joint.multiterm.image.tt1', 'tst.sp_mfs_sdint.joint.multiterm.alpha'] =  [True, True, True, True, True] ( Pass : should all be True )
24-Apr-2026 02:56:40 2026-04-24 02:56:25        INFO        sdintimaging::::casa+        All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords)
24-Apr-2026 02:56:40 2026-04-24 02:56:25        INFO        sdintimaging::::casa+        [check_history] All expected history entries found. (Pass)
24-Apr-2026 02:56:40 .
24-Apr-2026 02:56:40 ----------------------------------------------------------------------
24-Apr-2026 02:56:40 Ran 21 tests in 1719.291s
24-Apr-2026 02:56:40
24-Apr-2026 02:56:40 OK (skipped=2)
24-Apr-2026 02:56:40 Marking test as passed.
24-Apr-2026 02:56:40 Executor result: 0
24-Apr-2026 02:56:40 Failed tests:[]
24-Apr-2026 02:56:40
24-Apr-2026 02:56:40 Results: [{'testname': 'test_regression_alma_M100_if', 'runtime': '0:19:23.885407', 'returncode': 0, 'testerr': []}, {'testname': 'test_regression_sim_multi_arrays_and_TP', 'runtime': '0:01:00.904561', 'returncode': 0, 'testerr': []}, {'testname': 'test_stk_srdp_restore_mode', 'runtime': '0:39:12.104213', 'returncode': 0, 'testerr': []}, {'testname': 'test_stk_alma_pipeline_imaging', 'runtime': '1:39:07.562148', 'returncode': 0, 'testerr': []}, {'testname': 'test_stk_vlass_pipeline_imaging', 'runtime': '0:41:22.573947', 'returncode': 0, 'testerr': []}, {'testname': 'test_stk_vla_users_continuum_from_SDM', 'runtime': '0:23:41.647006', 'returncode': 0, 'testerr': []}, {'testname': 'test_task_deconvolve', 'runtime': '0:28:43.213807', 'returncode': 0, 'testerr': []}, {'testname': 'test_task_tclean', 'runtime': '3:58:37.850427', 'returncode': 0, 'testerr': []}, {'testname': 'test_task_sdintimaging', 'runtime': '0:28:58.460452', 'returncode': 0, 'testerr': []}]
24-Apr-2026 02:56:40 Stopping Xvfb.
24-Apr-2026 02:56:40 Stopping framebuffer <subprocess.Popen object at 0x7f9501025550>
24-Apr-2026 02:56:40 Virtual frame buffer deployed at :903839 with pid 903881 successfully shutdown
24-Apr-2026 02:56:40 Xvfb stopped.
24-Apr-2026 02:56:41 Finished task 'Test' with result: Success
24-Apr-2026 02:56:41 Starting task 'Parse test results' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
24-Apr-2026 02:56:41 Parsing test results under /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31233-CCM228...
24-Apr-2026 02:56:41 Finished task 'Parse test results' with result: Success
24-Apr-2026 02:56:41 Running post build plugin 'Docker Container Cleanup'
24-Apr-2026 02:56:41 Running post build plugin 'NCover Results Collector'
24-Apr-2026 02:56:41 Running post build plugin 'Build Results Label Collector'
24-Apr-2026 02:56:41 Running post build plugin 'Clover Results Collector'
24-Apr-2026 02:56:41 Running post build plugin 'npm Cache Cleanup'
24-Apr-2026 02:56:41 Running post build plugin 'Artifact Copier'
24-Apr-2026 02:56:41 Finalising the build...
24-Apr-2026 02:56:41 Stopping timer.
24-Apr-2026 02:56:41 Build CASASPECS-DEVVERCASALITHPY31233-CCM228-1 completed.
23-Apr-2026 22:56:41 Running on server: post build plugin 'Build Hanging Detection Configuration'
23-Apr-2026 22:56:41 Running on server: post build plugin 'NCover Results Collector'
23-Apr-2026 22:56:41 Running on server: post build plugin 'Build Labeller'
23-Apr-2026 22:56:41 Running on server: post build plugin 'Clover Delta Calculator'
23-Apr-2026 22:56:41 Running on server: post build plugin 'Maven Dependencies Postprocessor'
23-Apr-2026 22:56:41 All post build plugins have finished
23-Apr-2026 22:56:41 Generating build results summary...
23-Apr-2026 22:56:41 Saving build results to disk...
23-Apr-2026 22:56:41 Store variable context...
23-Apr-2026 22:56:41 Finished building CASASPECS-DEVVERCASALITHPY31233-CCM228-1.