Build: #8 failed
Job: Test Tasks Many Linux 2.28 Remove Casatasks import failed
Build log
The build generated 92,709 lines of output. The output is too long and has been truncated to the last 1,000 lines. Download or view full build log.
| 25-Sep-2026 14:21:08 | 2026-09-25 18:21:08 INFO SDAlgorithmBase::deconvolve [tst.awp2.nosquint] Total model flux (over all planes) : 0.318557 Peak Residual (over all planes) : 0.0539434 in C0:P0 |
| 25-Sep-2026 14:21:08 | 2026-09-25 18:21:08 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 20 iterations. |
| 25-Sep-2026 14:21:10 | 2026-09-25 18:21:11 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 25-Sep-2026 14:21:10 | 2026-09-25 18:21:11 INFO task_tclean::SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 4.721 GB. Available mem.: 10.37 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 1. |
| 25-Sep-2026 14:21:10 | 2026-09-25 18:21:11 INFO task_tclean::SynthesisImagerVi2::selectData MS : vla_wideband_2ptg_w_squint.ms | [Opened in readonly mode] |
| 25-Sep-2026 14:21:10 | 2026-09-25 18:21:11 INFO task_tclean::SynthesisImagerVi2::selectData NRows selected : 14040 |
| 25-Sep-2026 14:21:15 | 2026-09-25 18:21:16 INFO task_tclean::SynthesisImager::getVPRecord Using default Voltage Patterns from the VPManager |
| 25-Sep-2026 14:21:16 | 2026-09-25 18:21:16 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 25-Sep-2026 14:22:48 | |
| 25-Sep-2026 14:23:20 | 0%....10....20....30....40....50....60....70....80....90....100% |
| 25-Sep-2026 14:24:57 | 2026-09-25 18:24:58 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.0535912, over full image : 0.0535912 |
| 25-Sep-2026 14:24:57 | 2026-09-25 18:24:58 INFO tclean::::casa Reached global stopping criterion : iteration limit |
| 25-Sep-2026 14:24:57 | 2026-09-25 18:24:58 INFO tclean::::casa getSummary call: fullsummary=False |
| 25-Sep-2026 14:24:57 | 2026-09-25 18:24:58 INFO MultiTermMatrixCleaner::computeprincipalsolution() MTMC :: Computing principal solution on residuals |
| 25-Sep-2026 14:24:57 | 2026-09-25 18:24:58 INFO SDAlgorithmBase::restore [tst.awp2.nosquint] : Restoring model image. |
| 25-Sep-2026 14:24:57 | 2026-09-25 18:24:58 INFO SIImageStore::restore Beam for chan : 0 : 5.5081 arcsec, 4.62179 arcsec, -84.466 deg |
| 25-Sep-2026 14:24:58 | 2026-09-25 18:24:59 INFO SIImageStore::restore Beam for chan : 0 : 5.5081 arcsec, 4.62179 arcsec, -84.466 deg |
| 25-Sep-2026 14:24:59 | 2026-09-25 18:25:00 INFO SIImageStoreMultiTerm::calculateAlphaBeta Alpha and Beta images will not be computed for images that contain anything other than stokes I in them. |
| 25-Sep-2026 14:24:59 | 2026-09-25 18:25:00 INFO MultiTermMatrixCleaner::computeprincipalsolution() MTMC :: Computing principal solution on residuals |
| 25-Sep-2026 14:24:59 | 2026-09-25 18:25:00 INFO SDAlgorithmBase::restore [tst.awp2.nosquint] : Restoring model image. |
| 25-Sep-2026 14:24:59 | 2026-09-25 18:25:00 WARN SIImageStore::restore (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SIImageStore.cc, line 2353) Restoring with an empty model image. Only residuals will be processed to form the output restored image. |
| 25-Sep-2026 14:24:59 | 2026-09-25 18:25:00 INFO SIImageStore::restore Beam for chan : 0 : 5.5081 arcsec, 4.62179 arcsec, -84.466 deg |
| 25-Sep-2026 14:24:59 | 2026-09-25 18:25:00 WARN SIImageStore::restore (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SIImageStore.cc, line 2353) Restoring with an empty model image. Only residuals will be processed to form the output restored image. |
| 25-Sep-2026 14:24:59 | 2026-09-25 18:25:00 INFO SIImageStore::restore Beam for chan : 0 : 5.5081 arcsec, 4.62179 arcsec, -84.466 deg |
| 25-Sep-2026 14:25:00 | 2026-09-25 18:25:00 INFO SIImageStoreMultiTerm::calculateAlphaBeta Alpha and Beta images will not be computed for images that contain anything other than stokes I in them. |
| 25-Sep-2026 14:25:00 | 2026-09-25 18:25:00 INFO SDAlgorithmMSMFS::restore Restored images : |
| 25-Sep-2026 14:25:00 | 2026-09-25 18:25:00 INFO SDAlgorithmMSMFS::restore /home/casatest/casa6/casatasks/tests/casashell_tests/work/test_task_tclean_casashell/tst.awp2.nosquint.image.tt0 (model=/home/casatest/casa6/casatasks/tests/casashell_tests/work/test_task_tclean_casashell/tst.awp2.nosquint.model.tt0) |
| 25-Sep-2026 14:25:00 | 2026-09-25 18:25:00 INFO SDAlgorithmMSMFS::restore /home/casatest/casa6/casatasks/tests/casashell_tests/work/test_task_tclean_casashell/tst.awp2.nosquint.image.tt1 (model=/home/casatest/casa6/casatasks/tests/casashell_tests/work/test_task_tclean_casashell/tst.awp2.nosquint.model.tt1) |
| 25-Sep-2026 14:25:00 | 2026-09-25 18:25:00 INFO SDAlgorithmMSMFS::restore |
| 25-Sep-2026 14:25:00 | 2026-09-25 18:25:00 INFO task_tclean::SDAlgorithmBase::pbcor [tst.awp2.nosquint] : Applying PB correction |
| 25-Sep-2026 14:25:00 | 2026-09-25 18:25:00 INFO task_tclean::SIImageStoreMultiTerm::pbcorPlane Multi-term PBcor : Dividing all Taylor coefficient images by the tt0 average PB. Please refer to documentation of the 'pbcor' parameter in tclean for information about accurate correction of wideband primary beam effects. |
| 25-Sep-2026 14:25:00 | 2026-09-25 18:25:01 INFO tclean::::casa Searching for images with prefix 'tst.awp2.nosquint'... Found these, writing history into them: ['tst.awp2.nosquint.sumwt', 'tst.awp2.nosquint.gridwt', 'tst.awp2.nosquint.weight', 'tst.awp2.nosquint.psf.tt2', 'tst.awp2.nosquint.sumwt.tt0', 'tst.awp2.nosquint.mask', 'tst.awp2.nosquint.residual.tt1', 'tst.awp2.nosquint.image.tt1.pbcor', 'tst.awp2.nosquint.sumwt.tt2', 'tst.awp2.nosquint.psf.tt1', 'tst.awp2.nosquint.image.tt0', 'tst.awp2.nosquint.image.tt0.pbcor', 'tst.awp2.nosquint.model.tt1', 'tst.awp2.nosquint.pb.tt0', 'tst.awp2.nosquint.residual', 'tst.awp2.nosquint.sumwt.tt1', 'tst.awp2.nosquint.image.tt1', 'tst.awp2.nosquint.psf', 'tst.awp2.nosquint.residual.tt0', 'tst.awp2.nosquint.model', 'tst.awp2.nosquint.psf.tt0', 'tst.awp2.nosquint.pb.tt1', 'tst.awp2.nosquint.pb', 'tst.awp2.nosquint.model.tt0'] |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO tclean::::casa Task tclean complete. Start time: 2026-09-25 18:15:34.680425 End time: 2026-09-25 18:25:01.064688 |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO tclean::::casa ##### End Task: tclean ##### |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO tclean::::casa ########################################## |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO tclean::::casa ########################################## |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO tclean::::casa ##### Begin Task: tclean ##### |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO tclean::::casa tclean( vis='vla_wideband_2ptg_w_squint.ms', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst.awp2', imsize=2000, cell='1.6arcsec', phasecenter='J2000 00h07m0.0 50d0m0.000', stokes='IV', projection='SIN', startmodel='', specmode='mvc', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='awp2', facets=1, psfphasecenter='', wprojplanes=2, vptable='', mosweight=False, aterm=True, psterm=False, wbawp=True, conjbeams=False, cfcache='', usepointing=False, computepastep=15.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=-0.1, normtype='flatnoise', deconvolver='mtmfs', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=True, outlierfile='', weighting='uniform', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.0, uvtaper=[], niter=20, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='none', calcres=True, calcpsf=True, psfcutoff=0.35, parallel=False ) |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO tclean::::casa Verifying Input Parameters |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO tclean::::casa Calculating nchan from the data range to be 5 |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO SynthesisImagerVi2::selectData MS : vla_wideband_2ptg_w_squint.ms | [Opened in readonly mode] |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO SynthesisImagerVi2::selectData NRows selected : 14040 |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.awp2] : |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.awp2] : |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO MSTransformRegridder::calcChanFreqs phaseCenter='Direction: [0.642488, 0.0196298, 0.766044]' *** Requested center of SPW (1.12115e+09 Hz) is smaller than minimum possible value by 5.99949e+07 Hz |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO MSTransformRegridder::calcChanFreqs+ *** Reset to minimum possible value 1.18114e+09 Hz Channels equidistant in freq |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO MSTransformRegridder::calcChanFreqs+ Central frequency (in output frame) = 1.48111e+09 Hz |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO MSTransformRegridder::calcChanFreqs+ Width of central channel (in output frame) = 1.19989e+08 Hz |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO MSTransformRegridder::calcChanFreqs+ Number of channels = 5 |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO MSTransformRegridder::calcChanFreqs+ Total width of SPW (in output frame) = 5.99947e+08 Hz |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO MSTransformRegridder::calcChanFreqs+ Lower edge = 1.18114e+09 Hz, upper edge = 1.78109e+09 Hz |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO SynthesisImagerVi2::defineImage Impars: start 1181140474.1230276Hz |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO SynthesisImagerVi2::defineImage Shape: [2000, 2000, 2, 5] Spectral: [1.24114e+09] at [0] with increment [1.19989e+08] |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst.awp2] with ftmachine : awp2 |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO SynthesisImager::getVPRecord Using default Voltage Patterns from the VPManager |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 4.721 GB. Available mem.: 10.64 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 1. |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO tclean::::casa CFCache already exists |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:01 INFO SynthesisImagerVi2::weight() Set imaging weights : Uniform weighting: sidelobes will be suppressed over full image |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:02 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst.awp2] : mtmfs |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:02 INFO task_tclean::SynthesisImager::makePSF ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 25-Sep-2026 14:25:01 | 2026-09-25 18:25:02 INFO task_tclean::SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 4.721 GB. Available mem.: 10.64 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 1. |
| 25-Sep-2026 14:25:02 | 2026-09-25 18:25:02 INFO task_tclean::SynthesisImagerVi2::selectData MS : vla_wideband_2ptg_w_squint.ms | [Opened in readonly mode] |
| 25-Sep-2026 14:25:02 | 2026-09-25 18:25:02 INFO task_tclean::SynthesisImagerVi2::selectData NRows selected : 14040 |
| 25-Sep-2026 14:25:02 | 2026-09-25 18:25:03 INFO task_tclean::SynthesisImager::getVPRecord Using default Voltage Patterns from the VPManager |
| 25-Sep-2026 14:25:03 | 2026-09-25 18:25:03 INFO task_tclean::SynthesisImager::makePSF ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 25-Sep-2026 14:25:03 | paMax 3.13332 painc 0.261799 |
| 25-Sep-2026 14:27:30 | |
| 25-Sep-2026 14:27:31 | 0%....10....20....30....40....50....60....70....80....90....100% |
| 25-Sep-2026 14:29:05 | 2026-09-25 18:29:06 INFO task_tclean::SIImageStore::calcSensitivity [tst.awp2] Theoretical sensitivity (Jy/bm):c0:p0:0.00743366 c1:p0:0.00726506 c2:p0:0.00613647 c3:p0:0.00695673 c4:p0:0.00684063 c0:p1:0.00743366 c1:p1:0.00726506 c2:p1:0.00613647 c3:p1:0.00695673 c4:p1:0.00684063 |
| 25-Sep-2026 14:29:05 | 2026-09-25 18:29:06 INFO task_tclean::SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.371507 |
| 25-Sep-2026 14:29:05 | 2026-09-25 18:29:06 INFO task_tclean::SIImageStore::printBeamSet Restoring Beams |
| 25-Sep-2026 14:29:05 | 2026-09-25 18:29:06 INFO task_tclean::SIImageStore::printBeamSet + Pol Type Chan Freq Vel |
| 25-Sep-2026 14:29:05 | 2026-09-25 18:29:06 INFO task_tclean::SIImageStore::printBeamSet + I Max 0 1.24e+09 -10277 6.6125 arcsec x 5.4978 arcsec pa=-85.4167 deg |
| 25-Sep-2026 14:29:05 | 2026-09-25 18:29:06 INFO task_tclean::SIImageStore::printBeamSet + I Min 4 1.72e+09 -130183 4.7503 arcsec x 3.9873 arcsec pa=-84.3449 deg |
| 25-Sep-2026 14:29:05 | 2026-09-25 18:29:06 INFO task_tclean::SIImageStore::printBeamSet + I Median 2 1.48e+09 -70230 5.5071 arcsec x 4.6263 arcsec pa=-84.6642 deg |
| 25-Sep-2026 14:29:05 | 2026-09-25 18:29:06 INFO task_tclean::SIImageStore::printBeamSet + V Max 0 1.24e+09 -10277 6.6125 arcsec x 5.4978 arcsec pa=-85.4167 deg |
| 25-Sep-2026 14:29:05 | 2026-09-25 18:29:06 INFO task_tclean::SIImageStore::printBeamSet + V Min 4 1.72e+09 -130183 4.7503 arcsec x 3.9873 arcsec pa=-84.3449 deg |
| 25-Sep-2026 14:29:05 | 2026-09-25 18:29:06 INFO task_tclean::SIImageStore::printBeamSet + V Median 2 1.48e+09 -70230 5.5071 arcsec x 4.6263 arcsec pa=-84.6642 deg |
| 25-Sep-2026 14:29:09 | 2026-09-25 18:29:10 INFO task_tclean::ImageFactory::createImage Created Paged image 'tst.awp2.pb.tt0' of shape [2000, 2000, 2, 1] with float valued pixels. |
| 25-Sep-2026 14:29:10 | 2026-09-25 18:29:11 INFO task_tclean::ImageFactory::createImage Created Paged image 'tst.awp2.psf.tt0' of shape [2000, 2000, 2, 1] with float valued pixels. |
| 25-Sep-2026 14:29:11 | 2026-09-25 18:29:12 INFO task_tclean::ImageFactory::createImage Created Paged image 'tst.awp2.psf.tt1' of shape [2000, 2000, 2, 1] with float valued pixels. |
| 25-Sep-2026 14:29:12 | 2026-09-25 18:29:13 INFO task_tclean::ImageFactory::createImage Created Paged image 'tst.awp2.psf.tt2' of shape [2000, 2000, 2, 1] with float valued pixels. |
| 25-Sep-2026 14:29:12 | 2026-09-25 18:29:13 INFO task_tclean::ImageFactory::createImage Created Paged image 'tst.awp2.sumwt.tt0' of shape [1, 1, 2, 1] with float valued pixels. |
| 25-Sep-2026 14:29:12 | 2026-09-25 18:29:13 INFO task_tclean::ImageFactory::createImage Created Paged image 'tst.awp2.sumwt.tt1' of shape [1, 1, 2, 1] with float valued pixels. |
| 25-Sep-2026 14:29:12 | 2026-09-25 18:29:13 INFO task_tclean::ImageFactory::createImage Created Paged image 'tst.awp2.sumwt.tt2' of shape [1, 1, 2, 1] with float valued pixels. |
| 25-Sep-2026 14:29:15 | 2026-09-25 18:29:16 INFO task_tclean::SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.096824 |
| 25-Sep-2026 14:29:15 | 2026-09-25 18:29:16 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 25-Sep-2026 14:29:15 | 2026-09-25 18:29:16 INFO task_tclean::SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 4.721 GB. Available mem.: 10.64 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 1. |
| 25-Sep-2026 14:29:16 | 2026-09-25 18:29:16 INFO task_tclean::SynthesisImagerVi2::selectData MS : vla_wideband_2ptg_w_squint.ms | [Opened in readonly mode] |
| 25-Sep-2026 14:29:16 | 2026-09-25 18:29:16 INFO task_tclean::SynthesisImagerVi2::selectData NRows selected : 14040 |
| 25-Sep-2026 14:29:16 | 2026-09-25 18:29:17 INFO task_tclean::SynthesisImager::getVPRecord Using default Voltage Patterns from the VPManager |
| 25-Sep-2026 14:29:17 | 2026-09-25 18:29:17 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 25-Sep-2026 14:29:17 | paMax 3.13332 painc 0.261799 |
| 25-Sep-2026 14:31:47 | |
| 25-Sep-2026 14:31:52 | 0%....10....20....30....40....50....60....70....80....90....100% |
| 25-Sep-2026 14:33:28 | 2026-09-25 18:33:29 INFO task_tclean::ImageFactory::createImage Created Paged image 'tst.awp2.residual.tt0' of shape [2000, 2000, 2, 1] with float valued pixels. |
| 25-Sep-2026 14:33:29 | 2026-09-25 18:33:30 INFO task_tclean::ImageFactory::createImage Created Paged image 'tst.awp2.residual.tt1' of shape [2000, 2000, 2, 1] with float valued pixels. |
| 25-Sep-2026 14:33:32 | 2026-09-25 18:33:32 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 0.329921 |
| 25-Sep-2026 14:33:32 | 2026-09-25 18:33:32 INFO SynthesisDeconvolver::setupMask [tst.awp2] Initializing new mask to 1.0 for the full image |
| 25-Sep-2026 14:33:32 | 2026-09-25 18:33:32 INFO SynthesisDeconvolver::setupMask [tst.awp2] Number of pixels in the clean mask : 8e+06 out of a total of 8e+06 pixels. [ 100 % ] |
| 25-Sep-2026 14:33:32 | 2026-09-25 18:33:32 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.329921, over full image : 0.329921 |
| 25-Sep-2026 14:33:32 | 2026-09-25 18:33:32 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 20, 'cyclethreshold': 0.018049009144306183, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 25-Sep-2026 14:33:32 | 2026-09-25 18:33:32 INFO SDAlgorithmBase::deconvolve [tst.awp2] Run mtmfs minor-cycle on 2 pols | CycleThreshold=0.018049, CycleNiter=20, Gain=0.1 |
| 25-Sep-2026 14:33:32 | 2026-09-25 18:33:33 INFO MultiTermMatrixCleaner::verifyScaleSizes() Scale sizes to be used for deconvolution : [0] |
| 25-Sep-2026 14:33:32 | 2026-09-25 18:33:33 INFO MultiTermMatrixCleaner::initialise() Using a PSF patch of 80 pixels on each side for minor-cycle updates. |
| 25-Sep-2026 14:33:32 | 2026-09-25 18:33:33 INFO MatrixCleaner::validatePsf() Peak of PSF = 1 at [1000, 1000] |
| 25-Sep-2026 14:33:33 | 2026-09-25 18:33:33 INFO SIImageStoreMultiTerm::calcFractionalBandwidth MFS frequency range : 1.18114 GHz -> 1.78109GHz.Fractional Bandwidth : 40.5065 %.Reference Frequency for Taylor Expansion : 1.48111GHz. |
| 25-Sep-2026 14:33:33 | 2026-09-25 18:33:33 INFO MultiTermMatrixCleaner::computeHessianPeak Calculating PSF and Scale convolutions |
| 25-Sep-2026 14:33:33 | 2026-09-25 18:33:34 INFO MultiTermMatrixCleaner::computeHessianPeak The Matrix [H] for 0 pixel scale is : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:33:33 | 2026-09-25 18:33:34 INFO MultiTermMatrixCleaner::computeHessianPeak + [1, 0.00633778 |
| 25-Sep-2026 14:33:33 | 2026-09-25 18:33:34 INFO MultiTermMatrixCleaner::computeHessianPeak + 0.00633778, 0.0122695] |
| 25-Sep-2026 14:33:34 | 2026-09-25 18:33:34 INFO MultiTermMatrixCleaner::mtclean() Calculating convolutions of residual images with scales |
| 25-Sep-2026 14:33:35 | 2026-09-25 18:33:35 INFO MultiTermMatrixCleaner::mtclean() Peak convolved residual (within mask) : 0.329921 |
| 25-Sep-2026 14:33:35 | 2026-09-25 18:33:36 INFO [20] Res: 0.053893 Max: 0.003485 Gain: 0.1 Pos: [723, 1446] Scale: 0 Coeffs: 0.0590539 -0.00332696 |
| 25-Sep-2026 14:33:35 | 2026-09-25 18:33:36 INFO MultiTermMatrixCleaner::mtclean() Reached max number of iterations for this minor cycle |
| 25-Sep-2026 14:33:35 | 2026-09-25 18:33:36 INFO MultiTermMatrixCleaner::mtclean() Total flux by scale : [0]: 0.319642 (in this run) |
| 25-Sep-2026 14:33:35 | 2026-09-25 18:33:36 INFO MultiTermMatrixCleaner::mtclean() Total flux by Taylor coefficient : [0]: 0.319642 [1]: -0.148865 |
| 25-Sep-2026 14:33:38 | 2026-09-25 18:33:38 INFO SDAlgorithmBase::deconvolve [tst.awp2:P0] iters=0->20 [20], model=0->0.319642, peakres=0.329921->0.0538929, Reached cycleniter. |
| 25-Sep-2026 14:33:38 | 2026-09-25 18:33:38 INFO SDAlgorithmBase::deconvolve [tst.awp2:P1] iters=20->20 [0], model=0->0, peakres=0.00584457->0.00584457, Reached cyclethreshold. |
| 25-Sep-2026 14:33:38 | 2026-09-25 18:33:38 INFO SDAlgorithmBase::deconvolve [tst.awp2] Total model flux (over all planes) : 0.319642 Peak Residual (over all planes) : 0.0538929 in C0:P0 |
| 25-Sep-2026 14:33:38 | 2026-09-25 18:33:38 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 20 iterations. |
| 25-Sep-2026 14:33:40 | 2026-09-25 18:33:41 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 25-Sep-2026 14:33:40 | 2026-09-25 18:33:41 INFO task_tclean::SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 4.721 GB. Available mem.: 10.38 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 1. |
| 25-Sep-2026 14:33:40 | 2026-09-25 18:33:41 INFO task_tclean::SynthesisImagerVi2::selectData MS : vla_wideband_2ptg_w_squint.ms | [Opened in readonly mode] |
| 25-Sep-2026 14:33:40 | 2026-09-25 18:33:41 INFO task_tclean::SynthesisImagerVi2::selectData NRows selected : 14040 |
| 25-Sep-2026 14:33:45 | 2026-09-25 18:33:46 INFO task_tclean::SynthesisImager::getVPRecord Using default Voltage Patterns from the VPManager |
| 25-Sep-2026 14:33:45 | 2026-09-25 18:33:46 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 25-Sep-2026 14:34:30 | paMax 3.13332 painc 0.261799 |
| 25-Sep-2026 14:37:03 | |
| 25-Sep-2026 14:37:19 | 0%....10....20....30....40....50....60....70....80....90....100% |
| 25-Sep-2026 14:38:57 | 2026-09-25 18:38:58 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.0559102, over full image : 0.0559102 |
| 25-Sep-2026 14:38:57 | 2026-09-25 18:38:58 INFO tclean::::casa Reached global stopping criterion : iteration limit |
| 25-Sep-2026 14:38:57 | 2026-09-25 18:38:58 INFO tclean::::casa getSummary call: fullsummary=False |
| 25-Sep-2026 14:38:57 | 2026-09-25 18:38:58 INFO MultiTermMatrixCleaner::computeprincipalsolution() MTMC :: Computing principal solution on residuals |
| 25-Sep-2026 14:38:57 | 2026-09-25 18:38:58 INFO SDAlgorithmBase::restore [tst.awp2] : Restoring model image. |
| 25-Sep-2026 14:38:58 | 2026-09-25 18:38:58 INFO SIImageStore::restore Beam for chan : 0 : 5.50596 arcsec, 4.62181 arcsec, -84.4295 deg |
| 25-Sep-2026 14:38:59 | 2026-09-25 18:38:59 INFO SIImageStore::restore Beam for chan : 0 : 5.50596 arcsec, 4.62181 arcsec, -84.4295 deg |
| 25-Sep-2026 14:38:59 | 2026-09-25 18:39:00 INFO SIImageStoreMultiTerm::calculateAlphaBeta Alpha and Beta images will not be computed for images that contain anything other than stokes I in them. |
| 25-Sep-2026 14:38:59 | 2026-09-25 18:39:00 INFO MultiTermMatrixCleaner::computeprincipalsolution() MTMC :: Computing principal solution on residuals |
| 25-Sep-2026 14:39:00 | 2026-09-25 18:39:00 INFO SDAlgorithmBase::restore [tst.awp2] : Restoring model image. |
| 25-Sep-2026 14:39:00 | 2026-09-25 18:39:00 WARN SIImageStore::restore (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SIImageStore.cc, line 2353) Restoring with an empty model image. Only residuals will be processed to form the output restored image. |
| 25-Sep-2026 14:39:00 | 2026-09-25 18:39:00 INFO SIImageStore::restore Beam for chan : 0 : 5.50596 arcsec, 4.62181 arcsec, -84.4295 deg |
| 25-Sep-2026 14:39:00 | 2026-09-25 18:39:00 WARN SIImageStore::restore (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SIImageStore.cc, line 2353) Restoring with an empty model image. Only residuals will be processed to form the output restored image. |
| 25-Sep-2026 14:39:00 | 2026-09-25 18:39:00 INFO SIImageStore::restore Beam for chan : 0 : 5.50596 arcsec, 4.62181 arcsec, -84.4295 deg |
| 25-Sep-2026 14:39:00 | 2026-09-25 18:39:00 INFO SIImageStoreMultiTerm::calculateAlphaBeta Alpha and Beta images will not be computed for images that contain anything other than stokes I in them. |
| 25-Sep-2026 14:39:00 | 2026-09-25 18:39:00 INFO SDAlgorithmMSMFS::restore Restored images : |
| 25-Sep-2026 14:39:00 | 2026-09-25 18:39:00 INFO SDAlgorithmMSMFS::restore /home/casatest/casa6/casatasks/tests/casashell_tests/work/test_task_tclean_casashell/tst.awp2.image.tt0 (model=/home/casatest/casa6/casatasks/tests/casashell_tests/work/test_task_tclean_casashell/tst.awp2.model.tt0) |
| 25-Sep-2026 14:39:00 | 2026-09-25 18:39:00 INFO SDAlgorithmMSMFS::restore /home/casatest/casa6/casatasks/tests/casashell_tests/work/test_task_tclean_casashell/tst.awp2.image.tt1 (model=/home/casatest/casa6/casatasks/tests/casashell_tests/work/test_task_tclean_casashell/tst.awp2.model.tt1) |
| 25-Sep-2026 14:39:00 | 2026-09-25 18:39:00 INFO SDAlgorithmMSMFS::restore |
| 25-Sep-2026 14:39:00 | 2026-09-25 18:39:00 INFO task_tclean::SDAlgorithmBase::pbcor [tst.awp2] : Applying PB correction |
| 25-Sep-2026 14:39:00 | 2026-09-25 18:39:00 INFO task_tclean::SIImageStoreMultiTerm::pbcorPlane Multi-term PBcor : Dividing all Taylor coefficient images by the tt0 average PB. Please refer to documentation of the 'pbcor' parameter in tclean for information about accurate correction of wideband primary beam effects. |
| 25-Sep-2026 14:39:00 | 2026-09-25 18:39:01 INFO tclean::::casa Searching for images with prefix 'tst.awp2'... Found these, writing history into them: ['tst.awp2.sumwt', 'tst.awp2.model.tt1', 'tst.awp2.nosquint.sumwt', 'tst.awp2.nosquint.gridwt', 'tst.awp2.nosquint.weight', 'tst.awp2.image.tt1.pbcor', 'tst.awp2.psf', 'tst.awp2.nosquint.psf.tt2', 'tst.awp2.mask', 'tst.awp2.nosquint.sumwt.tt0', 'tst.awp2.nosquint.mask', 'tst.awp2.pb.tt1', 'tst.awp2.nosquint.residual.tt1', 'tst.awp2.pb.tt0', 'tst.awp2.model', 'tst.awp2.model.tt0', 'tst.awp2.psf.tt0', 'tst.awp2.sumwt.tt0', 'tst.awp2.nosquint.image.tt1.pbcor', 'tst.awp2.nosquint.sumwt.tt2', 'tst.awp2.residual', 'tst.awp2.sumwt.tt2', 'tst.awp2.weight', 'tst.awp2.nosquint.psf.tt1', 'tst.awp2.nosquint.image.tt0', 'tst.awp2.nosquint.image.tt0.pbcor', 'tst.awp2.nosquint.model.tt1', 'tst.awp2.nosquint.pb.tt0', 'tst.awp2.psf.tt1', 'tst.awp2.image.tt0', 'tst.awp2.nosquint.residual', 'tst.awp2.image.tt1', 'tst.awp2.nosquint.sumwt.tt1', 'tst.awp2.nosquint.image.tt1', 'tst.awp2.nosquint.psf', 'tst.awp2.psf.tt2', 'tst.awp2.nosquint.residual.tt0', 'tst.awp2.nosquint.model', 'tst.awp2.nosquint.psf.tt0', 'tst.awp2.sumwt.tt1', 'tst.awp2.image.tt0.pbcor', 'tst.awp2.gridwt', 'tst.awp2.residual.tt0', 'tst.awp2.nosquint.pb.tt1', 'tst.awp2.pb', 'tst.awp2.residual.tt1', 'tst.awp2.nosquint.pb', 'tst.awp2.nosquint.model.tt0'] |
| 25-Sep-2026 14:39:01 | 2026-09-25 18:39:02 INFO tclean::::casa Task tclean complete. Start time: 2026-09-25 18:25:01.085092 End time: 2026-09-25 18:39:01.610185 |
| 25-Sep-2026 14:39:01 | 2026-09-25 18:39:02 INFO tclean::::casa ##### End Task: tclean ##### |
| 25-Sep-2026 14:39:01 | 2026-09-25 18:39:02 INFO tclean::::casa ########################################## |
| 25-Sep-2026 14:39:01 | 2026-09-25 18:39:02 INFO name:: No table opened. |
| 25-Sep-2026 14:39:01 | 2026-09-25 18:39:02 INFO showcache:: The Table Cache is empty. |
| 25-Sep-2026 14:39:01 | 2026-09-25 18:39:02 INFO name:: No table opened. |
| 25-Sep-2026 14:39:01 | 2026-09-25 18:39:02 INFO showcache:: The Table Cache is empty. |
| 25-Sep-2026 14:39:01 | 2026-09-25 18:39:02 INFO tclean::::casa [ checkall ] |
| 25-Sep-2026 14:39:01 | 2026-09-25 18:39:02 INFO tclean::::casa+ [ check_ims ] Image made : ['tst.awp2.image.tt0'] = [True] ( Pass : should all be True ) |
| 25-Sep-2026 14:39:01 | 2026-09-25 18:39:02 INFO tclean::::casa+ All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords) |
| 25-Sep-2026 14:39:01 | 2026-09-25 18:39:02 INFO tclean::::casa+ [check_history] All expected history entries found. (Pass) |
| 25-Sep-2026 14:39:01 | 2026-09-25 18:39:02 INFO tclean::::casa+ [ check_pix_val ] tst.awp2.pb.tt0 : Value is 0.5535930395126343 at [723, 1446, 0, 0] ( Pass : should be 0.54 , Epsilon: 0.1) |
| 25-Sep-2026 14:39:01 | 2026-09-25 18:39:02 INFO tclean::::casa+ [ check_pix_val ] tst.awp2.image.tt0.pbcor : Value is 0.5901004672050476 at [723, 1446, 0, 0] ( Fail : should be 0.66 , Epsilon: 0.1) |
| 25-Sep-2026 14:39:02 | [ checkall ] |
| 25-Sep-2026 14:39:02 | [ check_ims ] Image made : ['tst.awp2.image.tt0'] = [True] ( Pass : should all be True ) |
| 25-Sep-2026 14:39:02 | All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords) |
| 25-Sep-2026 14:39:02 | [check_history] All expected history entries found. (Pass) |
| 25-Sep-2026 14:39:02 | [ check_pix_val ] tst.awp2.pb.tt0 : Value is 0.5535930395126343 at [723, 1446, 0, 0] ( Pass : should be 0.54 , Epsilon: 0.1) |
| 25-Sep-2026 14:39:02 | [ check_pix_val ] tst.awp2.image.tt0.pbcor : Value is 0.5901004672050476 at [723, 1446, 0, 0] ( Fail : should be 0.66 , Epsilon: 0.1) |
| 25-Sep-2026 14:39:02 | |
| 25-Sep-2026 14:39:02 | [ checkall ] |
| 25-Sep-2026 14:39:02 | [ check_pix_val ] tst.awp2.image.tt0.pbcor : Value is -0.010899703949689865 at [723, 1446, 1, 0] ( Pass : should be -0.0014 , Epsilon: 0.1) |
| 25-Sep-2026 14:39:02 | [ check_pix_val ] tst.awp2.nosquint.image.tt0.pbcor : Value is -0.010086050257086754 at [723, 1446, 1, 0] ( Pass : should be -0.0099 , Epsilon: 0.1) |
| 25-Sep-2026 14:39:02 | |
| 25-Sep-2026 14:39:02 | F2026-09-25 18:39:02 INFO tclean::::casa ########################################## |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:02 INFO tclean::::casa ##### Begin Task: tclean ##### |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:02 INFO tclean::::casa tclean( vis='refim_mawproject.ms', selectdata=True, field='*', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst', imsize=512, cell='10.0arcsec', phasecenter='J2000 19:59:28.500 +40.44.01.50', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='awproject', facets=1, psfphasecenter='', wprojplanes=1, vptable='', mosweight=False, aterm=True, psterm=False, wbawp=True, conjbeams=True, cfcache='tst.cfcache', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=0.3, normtype='flatnoise', deconvolver='hogbom', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=False, outlierfile='', weighting='natural', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.0, uvtaper=[], niter=30, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='none', calcres=True, calcpsf=True, psfcutoff=0.35, parallel=False ) |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:02 INFO tclean::::casa Verifying Input Parameters |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:02 INFO SynthesisImagerVi2::selectData MS : refim_mawproject.ms | Selecting on fields : * | [Opened in readonly mode] |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:02 INFO SynthesisImagerVi2::selectData NRows selected : 13608 |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst] : |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst] : |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO SynthesisImagerVi2::defineImage Impars: start |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO SynthesisImagerVi2::defineImage Shape: [512, 512, 1, 1] Spectral: [1.49998e+09] at [0] with increment [8.99993e+08] |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst] with ftmachine : awprojectft |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO SynthesisImagerVi2::createAWPFTMachine You are using wprojplanes=1. Doing co-planar imaging (no w-projection needed) |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO SynthesisImagerVi2::createAWPFTMachine Performing WBA-Projection |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO CFCache2::fillCFSFromDisk No. of CFS* found in tst.cfcache: 0 |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO CFCache2::fillCFSFromDisk No. of WTCFS* found in tst.cfcache: 0 |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO AWProjectFT2::setPAIncrement[R&D] Setting PA increment to 360 deg |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO SynthesisImagerVi2::createAWPFTMachine Sending frequency selection information Axis Lengths: [3, 4] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO SynthesisImagerVi2::createAWPFTMachine + [0, 1.2e+09, 1.2e+09, 3e+08 |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO SynthesisImagerVi2::createAWPFTMachine + 1, 1.5e+09, 1.5e+09, 3e+08 |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO SynthesisImagerVi2::createAWPFTMachine + 2, 1.8e+09, 1.8e+09, 3e+08] |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO SynthesisImagerVi2::createAWPFTMachine + to AWP FTM. |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.02518 GB. Available mem.: 10.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 1. |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO SynthesisImagerVi2::weight() Set imaging weights : Natural weighting |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst] : hogbom |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO task_tclean::SynthesisImager::makePSF ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO task_tclean::AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder") |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO task_tclean::AWProjectFT2::initializeToSky[R&D] Computed maps using FTMachine::initMaps. polMap = [0, 0] |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO task_tclean::VB2CFBMap::makeVBRow2CFBMap[R&D] CFs not cached for -86.0481 deg, dPA = 360 Field ID = 0 Ant1Type, Ant2Type = 0,0 |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO task_tclean::AWConvFunc2::makeConvFunction[R&D] Making a new convolution function for PA=-86.0481deg for field ID 0 |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO task_tclean::AWConvFunc2::makeConvFunction[R&D] Using 1 planes for W-projection |
| 25-Sep-2026 14:39:02 | 2026-09-25 18:39:03 INFO task_tclean::AWConvFunc2::makeConvFunction[R&D] Estimating maximum possible W = 5156.62 (wavelengths) |
| 25-Sep-2026 14:39:03 | 2026-09-25 18:39:03 INFO task_tclean::AWConvFunc2::makeConvFunction[R&D] Making 1 w plane(s). |
| 25-Sep-2026 14:39:03 | 2026-09-25 18:39:03 INFO task_tclean::AWConvFunc2::makeConvFunction[R&D] Making 3 frequency plane(s). |
| 25-Sep-2026 14:39:03 | 2026-09-25 18:39:03 INFO task_tclean::AWConvFunc2::makeConvFunction[R&D] CFB Freq. axis [N, Min, Max, Incr. (GHz)]: 3 1.2 1.8 0.1 |
| 25-Sep-2026 14:39:03 | 2026-09-25 18:39:03 INFO task_tclean::AWConvFunc2::makeConvFunction[R&D] Making CFs for baseline type 0 |
| 25-Sep-2026 14:39:03 | Processing request for geometries from observatory EVLA, antenna type STANDARD |
| 25-Sep-2026 14:39:03 | 2026-09-25 18:39:03 INFO task_tclean::BeamCalc::setBeamCalcGeometries() Initialisation of geometries for observatory EVLA, antenna type STANDARD |
| 25-Sep-2026 14:39:03 | 2026-09-25 18:39:03 INFO task_tclean::BeamCalc::setBeamCalcGeometries() Will use default geometries for EVLA STANDARD. |
| 25-Sep-2026 14:39:18 | 2026-09-25 18:39:18 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:0,W:0): |
| 25-Sep-2026 14:39:23 | 2026-09-25 18:39:23 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 4 (6) pixels |
| 25-Sep-2026 14:39:38 | 2026-09-25 18:39:38 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:1,W:0): |
| 25-Sep-2026 14:39:43 | 2026-09-25 18:39:43 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 4 (6) pixels |
| 25-Sep-2026 14:39:43 | |
| 25-Sep-2026 14:39:58 | 0%2026-09-25 18:39:59 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:2,W:0): |
| 25-Sep-2026 14:40:03 | 2026-09-25 18:40:04 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 5 (6) pixels |
| 25-Sep-2026 14:40:19 | ....2026-09-25 18:40:19 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:0,W:0): |
| 25-Sep-2026 14:40:24 | 2026-09-25 18:40:24 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 4 (6) pixels |
| 25-Sep-2026 14:40:39 | 10....2026-09-25 18:40:40 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:1,W:0): |
| 25-Sep-2026 14:40:44 | 2026-09-25 18:40:44 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 4 (6) pixels |
| 25-Sep-2026 14:40:59 | 20...2026-09-25 18:41:00 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:2,W:0): |
| 25-Sep-2026 14:41:06 | 2026-09-25 18:41:06 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 5 (6) pixels |
| 25-Sep-2026 14:41:06 | .30....40....50....60....70....80....90....100% |
| 25-Sep-2026 14:41:06 | |
| 25-Sep-2026 14:41:06 | 0%....10....20....30....40....50....60....70....80....90....100% |
| 25-Sep-2026 14:41:06 | 2026-09-25 18:41:06 WARN task_tclean::AWProjectWBFT2::makeSensitivityImage(Complex)[R&D] Setting up for weights accumulation during gridding to compute sensitivity pattern. |
| 25-Sep-2026 14:41:06 | 2026-09-25 18:41:06 WARN task_tclean::AWProjectWBFT2::makeSensitivityImage(Complex)[R&D]+ Consequently, the first gridding cycle will be slower than the subsequent ones. |
| 25-Sep-2026 14:41:06 | 2026-09-25 18:41:06 INFO task_tclean::CFStore2::makePersistent(pa)[R&D] Saving CFStore of shape [3, 1, 2] for PA = -86.0481 BaselineType(antType1, antType2) = (0,0) |
| 25-Sep-2026 14:41:06 | 2026-09-25 18:41:06 INFO task_tclean::CFStore2::makePersistent(pa)[R&D] Saving CFStore of shape [3, 1, 2] for PA = -86.0481 BaselineType(antType1, antType2) = (0,0) |
| 25-Sep-2026 14:41:06 | 2026-09-25 18:41:07 INFO task_tclean::AWProjectFT2::findConvFunction[R&D] Convolution function memory footprint:2 MB out of a maximum of 15884 MB |
| 25-Sep-2026 14:41:06 | 2026-09-25 18:41:07 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :0 |
| 25-Sep-2026 14:41:06 | 2026-09-25 18:41:07 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :0 |
| 25-Sep-2026 14:41:07 | 2026-09-25 18:41:07 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :1 |
| 25-Sep-2026 14:41:07 | 2026-09-25 18:41:07 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :1 |
| 25-Sep-2026 14:41:07 | 2026-09-25 18:41:08 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :2 |
| 25-Sep-2026 14:41:07 | 2026-09-25 18:41:08 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :2 |
| 25-Sep-2026 14:41:08 | 2026-09-25 18:41:08 WARN task_tclean::AWProjectFT::finalizeToSky time to massage data 124.15 |
| 25-Sep-2026 14:41:08 | 2026-09-25 18:41:08 WARN task_tclean::AWProjectFT::finalizeToSky time gridding 0.44 |
| 25-Sep-2026 14:41:08 | 2026-09-25 18:41:08 INFO task_tclean::AWProjectFT2::getImage[R&D] Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:41:08 | 2026-09-25 18:41:08 INFO task_tclean::AWProjectFT2::getImage[R&D]+ [26963.9] |
| 25-Sep-2026 14:41:08 | 2026-09-25 18:41:08 INFO task_tclean::AWProjectFT2::getImage[R&D]+ (47.5662,1.62243) (0,0) |
| 25-Sep-2026 14:41:08 | 2026-09-25 18:41:08 INFO task_tclean::SIImageStore::calcSensitivity [tst] Theoretical sensitivity (Jy/bm):0.00608988 |
| 25-Sep-2026 14:41:08 | 2026-09-25 18:41:08 INFO task_tclean::SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.026333 |
| 25-Sep-2026 14:41:08 | 2026-09-25 18:41:08 INFO task_tclean::SIImageStore::printBeamSet Beam : 139.82 arcsec, 129.968 arcsec, -86.7085 deg |
| 25-Sep-2026 14:41:08 | 2026-09-25 18:41:08 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 25-Sep-2026 14:41:08 | 2026-09-25 18:41:09 INFO task_tclean::AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder") |
| 25-Sep-2026 14:41:08 | 2026-09-25 18:41:09 INFO task_tclean::AWProjectFT2::initializeToSky[R&D] Computed maps using FTMachine::initMaps. polMap = [0, 0] |
| 25-Sep-2026 14:41:08 | 2026-09-25 18:41:09 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :0 |
| 25-Sep-2026 14:41:08 | 2026-09-25 18:41:09 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :0 |
| 25-Sep-2026 14:41:09 | 2026-09-25 18:41:09 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :1 |
| 25-Sep-2026 14:41:09 | 2026-09-25 18:41:09 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :1 |
| 25-Sep-2026 14:41:09 | 2026-09-25 18:41:09 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :2 |
| 25-Sep-2026 14:41:09 | 2026-09-25 18:41:10 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :2 |
| 25-Sep-2026 14:41:09 | 2026-09-25 18:41:10 WARN task_tclean::AWProjectFT::finalizeToSky time to massage data 0.5 |
| 25-Sep-2026 14:41:09 | 2026-09-25 18:41:10 WARN task_tclean::AWProjectFT::finalizeToSky time gridding 0.09 |
| 25-Sep-2026 14:41:09 | 2026-09-25 18:41:10 INFO task_tclean::AWProjectFT2::getImage[R&D] Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:41:09 | 2026-09-25 18:41:10 INFO task_tclean::AWProjectFT2::getImage[R&D]+ [26252.6] |
| 25-Sep-2026 14:41:09 | 2026-09-25 18:41:10 INFO task_tclean::AWProjectFT2::getImage[R&D]+ (52.8842,0.667782) (0,0) |
| 25-Sep-2026 14:41:09 | 2026-09-25 18:41:10 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 0.93131 |
| 25-Sep-2026 14:41:09 | 2026-09-25 18:41:10 INFO SynthesisDeconvolver::setupMask [tst] Initializing new mask to 1.0 for the full image |
| 25-Sep-2026 14:41:09 | 2026-09-25 18:41:10 INFO SynthesisDeconvolver::setupMask [tst] Number of pixels in the clean mask : 262144 out of a total of 262144 pixels. [ 100 % ] |
| 25-Sep-2026 14:41:09 | 2026-09-25 18:41:10 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.93131, over full image : 0.93131 |
| 25-Sep-2026 14:41:09 | 2026-09-25 18:41:10 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 30, 'cyclethreshold': 0.11672864854335785, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 25-Sep-2026 14:41:09 | 2026-09-25 18:41:10 INFO SDAlgorithmBase::deconvolve [tst] Run Hogbom minor-cycle | CycleThreshold=0.116729, CycleNiter=30, Gain=0.1 |
| 25-Sep-2026 14:41:09 | 2026-09-25 18:41:10 INFO SDAlgorithmBase::deconvolve [tst] iters=0->20 [20], model=0->0.818085, peakres=0.93131->0.113226, Reached cyclethreshold. |
| 25-Sep-2026 14:41:09 | 2026-09-25 18:41:10 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 20 iterations. |
| 25-Sep-2026 14:41:09 | 2026-09-25 18:41:10 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 25-Sep-2026 14:41:09 | 2026-09-25 18:41:10 INFO task_tclean::AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder") |
| 25-Sep-2026 14:41:09 | 2026-09-25 18:41:10 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :0 |
| 25-Sep-2026 14:41:10 | 2026-09-25 18:41:10 INFO task_tclean::AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder") |
| 25-Sep-2026 14:41:10 | 2026-09-25 18:41:10 INFO task_tclean::AWProjectFT2::initializeToSky[R&D] Computed maps using FTMachine::initMaps. polMap = [0, 0] |
| 25-Sep-2026 14:41:10 | 2026-09-25 18:41:10 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :0 |
| 25-Sep-2026 14:41:10 | 2026-09-25 18:41:11 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :1 |
| 25-Sep-2026 14:41:10 | 2026-09-25 18:41:11 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :1 |
| 25-Sep-2026 14:41:11 | 2026-09-25 18:41:11 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :2 |
| 25-Sep-2026 14:41:11 | 2026-09-25 18:41:11 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :2 |
| 25-Sep-2026 14:41:11 | 2026-09-25 18:41:12 WARN task_tclean::AWProjectFT::finalizeToVis Time degrid 0.15 |
| 25-Sep-2026 14:41:11 | 2026-09-25 18:41:12 WARN task_tclean::AWProjectFT::finalizeToSky time to massage data 0.2 |
| 25-Sep-2026 14:41:11 | 2026-09-25 18:41:12 WARN task_tclean::AWProjectFT::finalizeToSky time gridding 0.11 |
| 25-Sep-2026 14:41:11 | 2026-09-25 18:41:12 INFO task_tclean::AWProjectFT2::getImage[R&D] Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:41:11 | 2026-09-25 18:41:12 INFO task_tclean::AWProjectFT2::getImage[R&D]+ [26252.6] |
| 25-Sep-2026 14:41:11 | 2026-09-25 18:41:12 INFO task_tclean::AWProjectFT2::getImage[R&D]+ (7.86427,0.0339481) (0,0) |
| 25-Sep-2026 14:41:11 | 2026-09-25 18:41:12 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.137259, over full image : 0.137259 |
| 25-Sep-2026 14:41:11 | 2026-09-25 18:41:12 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 10, 'cyclethreshold': 0.017203792929649353, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 25-Sep-2026 14:41:11 | 2026-09-25 18:41:12 INFO SDAlgorithmBase::deconvolve [tst] Run Hogbom minor-cycle | CycleThreshold=0.0172038, CycleNiter=10, Gain=0.1 |
| 25-Sep-2026 14:41:11 | 2026-09-25 18:41:12 INFO SDAlgorithmBase::deconvolve [tst] iters=0->10 [10], model=0.818085->0.91227, peakres=0.137259->0.0430733, Reached cycleniter. |
| 25-Sep-2026 14:41:11 | 2026-09-25 18:41:12 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 30 iterations. |
| 25-Sep-2026 14:41:11 | 2026-09-25 18:41:12 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 3 ------------------------------------- |
| 25-Sep-2026 14:41:11 | 2026-09-25 18:41:12 INFO task_tclean::AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder") |
| 25-Sep-2026 14:41:11 | 2026-09-25 18:41:12 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :0 |
| 25-Sep-2026 14:41:11 | 2026-09-25 18:41:12 INFO task_tclean::AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder") |
| 25-Sep-2026 14:41:11 | 2026-09-25 18:41:12 INFO task_tclean::AWProjectFT2::initializeToSky[R&D] Computed maps using FTMachine::initMaps. polMap = [0, 0] |
| 25-Sep-2026 14:41:12 | 2026-09-25 18:41:12 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :0 |
| 25-Sep-2026 14:41:12 | 2026-09-25 18:41:12 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :1 |
| 25-Sep-2026 14:41:12 | 2026-09-25 18:41:13 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :1 |
| 25-Sep-2026 14:41:12 | 2026-09-25 18:41:13 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :2 |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:13 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :2 |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:13 WARN task_tclean::AWProjectFT::finalizeToVis Time degrid 0.11 |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:13 WARN task_tclean::AWProjectFT::finalizeToSky time to massage data 0.22 |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:13 WARN task_tclean::AWProjectFT::finalizeToSky time gridding 0.06 |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:13 INFO task_tclean::AWProjectFT2::getImage[R&D] Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:13 INFO task_tclean::AWProjectFT2::getImage[R&D]+ [26252.6] |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:13 INFO task_tclean::AWProjectFT2::getImage[R&D]+ (2.68114,-0.0390254) (0,0) |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:13 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.0458402, over full image : 0.0458402 |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:13 INFO tclean::::casa Reached global stopping criterion : iteration limit |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:13 INFO tclean::::casa getSummary call: fullsummary=False |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:13 INFO SDAlgorithmBase::restore [tst] : Restoring model image. |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:13 INFO SIImageStore::restore Beam for chan : 0 : 139.82 arcsec, 129.968 arcsec, -86.7085 deg |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:14 INFO task_tclean::VB2CFBMap::~VB2CFMap[R&D] Total extra cost of heterogeneous array pointing correction = 0.5sec. Total VBs processed = 95361. The pointingoffsetsigdev used was = [] |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:14 INFO tclean::::casa Searching for images with prefix 'tst'... Found these, writing history into them: ['tst.sumwt', 'tst.residual', 'tst.pb', 'tst.mask', 'tst.image', 'tst.psf', 'tst.weight', 'tst.model'] |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:14 INFO tclean::::casa Task tclean complete. Start time: 2026-09-25 18:39:02.353247 End time: 2026-09-25 18:41:13.629602 |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:14 INFO tclean::::casa ##### End Task: tclean ##### |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:14 INFO tclean::::casa ########################################## |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:14 INFO name:: No table opened. |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:14 INFO showcache:: The Table Cache is empty. |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:14 INFO tclean::::casa [ checkall ] |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:14 INFO tclean::::casa+ [ check_ims ] Image made : ['tst.image', 'tst.psf', 'tst.weight'] = [True, True, True] ( Pass : should all be True ) |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:14 INFO tclean::::casa+ All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords) |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:14 INFO tclean::::casa+ [check_history] All expected history entries found. (Pass) |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:14 INFO tclean::::casa+ [ check_pix_val ] tst.image : Value is 0.9581106901168823 at [256, 256, 0, 0] ( Pass : should be 1.0 , Epsilon: 0.05) |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:14 INFO tclean::::casa+ [ check_pix_val ] tst.weight : Value is 0.48626992106437683 at [256, 256, 0, 0] ( Pass : should be 0.493 , Epsilon: 0.05) |
| 25-Sep-2026 14:41:13 | .2026-09-25 18:41:14 INFO tclean::::casa ########################################## |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:14 INFO tclean::::casa ##### Begin Task: tclean ##### |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:14 INFO tclean::::casa tclean( vis='refim_mawproject.ms', selectdata=True, field='*', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst', imsize=512, cell='10.0arcsec', phasecenter='J2000 19:59:28.500 +40.44.01.50', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='awproject', facets=1, psfphasecenter='', wprojplanes=1, vptable='', mosweight=False, aterm=True, psterm=False, wbawp=True, conjbeams=True, cfcache='tst.cfcache', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=0.1, normtype='flatnoise', deconvolver='mtmfs', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=False, outlierfile='', weighting='natural', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.0, uvtaper=[], niter=30, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='none', calcres=True, calcpsf=True, psfcutoff=0.35, parallel=False ) |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:14 INFO tclean::::casa Verifying Input Parameters |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:14 INFO SynthesisImagerVi2::selectData MS : refim_mawproject.ms | Selecting on fields : * | [Opened in readonly mode] |
| 25-Sep-2026 14:41:13 | 2026-09-25 18:41:14 INFO SynthesisImagerVi2::selectData NRows selected : 13608 |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst] : |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst] : |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO SynthesisImagerVi2::defineImage Impars: start |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO SynthesisImagerVi2::defineImage Shape: [512, 512, 1, 1] Spectral: [1.49998e+09] at [0] with increment [8.99993e+08] |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst] with ftmachine : awprojectft |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO SynthesisImagerVi2::createAWPFTMachine You are using wprojplanes=1. Doing co-planar imaging (no w-projection needed) |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO SynthesisImagerVi2::createAWPFTMachine Performing WBA-Projection |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO CFCache2::fillCFSFromDisk No. of CFS* found in tst.cfcache: 0 |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO CFCache2::fillCFSFromDisk No. of WTCFS* found in tst.cfcache: 0 |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO AWProjectFT2::setPAIncrement[R&D] Setting PA increment to 360 deg |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO SynthesisImagerVi2::createAWPFTMachine Sending frequency selection information Axis Lengths: [3, 4] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO SynthesisImagerVi2::createAWPFTMachine + [0, 1.2e+09, 1.2e+09, 3e+08 |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO SynthesisImagerVi2::createAWPFTMachine + 1, 1.5e+09, 1.5e+09, 3e+08 |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO SynthesisImagerVi2::createAWPFTMachine + 2, 1.8e+09, 1.8e+09, 3e+08] |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO SynthesisImagerVi2::createAWPFTMachine + to AWP FTM. |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.02518 GB. Available mem.: 10.64 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 1. |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO SynthesisImagerVi2::weight() Set imaging weights : Natural weighting |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst] : mtmfs |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO task_tclean::SynthesisImager::makePSF ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO task_tclean::AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder") |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO task_tclean::AWProjectFT2::initializeToSky[R&D] Computed maps using FTMachine::initMaps. polMap = [0, 0] |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO task_tclean::AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder") |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO task_tclean::AWProjectFT2::initializeToSky[R&D] Computed maps using FTMachine::initMaps. polMap = [0, 0] |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO task_tclean::AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder") |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO task_tclean::AWProjectFT2::initializeToSky[R&D] Computed maps using FTMachine::initMaps. polMap = [0, 0] |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO task_tclean::VB2CFBMap::makeVBRow2CFBMap[R&D] CFs not cached for -86.0481 deg, dPA = 360 Field ID = 0 Ant1Type, Ant2Type = 0,0 |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO task_tclean::AWConvFunc2::makeConvFunction[R&D] Making a new convolution function for PA=-86.0481deg for field ID 0 |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO task_tclean::AWConvFunc2::makeConvFunction[R&D] Using 1 planes for W-projection |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO task_tclean::AWConvFunc2::makeConvFunction[R&D] Estimating maximum possible W = 5156.62 (wavelengths) |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO task_tclean::AWConvFunc2::makeConvFunction[R&D] Making 1 w plane(s). |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO task_tclean::AWConvFunc2::makeConvFunction[R&D] Making 3 frequency plane(s). |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO task_tclean::AWConvFunc2::makeConvFunction[R&D] CFB Freq. axis [N, Min, Max, Incr. (GHz)]: 3 1.2 1.8 0.1 |
| 25-Sep-2026 14:41:14 | 2026-09-25 18:41:14 INFO task_tclean::AWConvFunc2::makeConvFunction[R&D] Making CFs for baseline type 0 |
| 25-Sep-2026 14:41:29 | 2026-09-25 18:41:30 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:0,W:0): |
| 25-Sep-2026 14:41:34 | 2026-09-25 18:41:34 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 4 (6) pixels |
| 25-Sep-2026 14:41:49 | 2026-09-25 18:41:50 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:1,W:0): |
| 25-Sep-2026 14:41:56 | 2026-09-25 18:41:56 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 4 (6) pixels |
| 25-Sep-2026 14:41:56 | |
| 25-Sep-2026 14:42:11 | 0%2026-09-25 18:42:11 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:2,W:0): |
| 25-Sep-2026 14:42:15 | 2026-09-25 18:42:16 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 5 (6) pixels |
| 25-Sep-2026 14:42:31 | ....2026-09-25 18:42:31 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:0,W:0): |
| 25-Sep-2026 14:42:36 | 2026-09-25 18:42:36 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 4 (6) pixels |
| 25-Sep-2026 14:42:51 | 10....2026-09-25 18:42:52 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:1,W:0): |
| 25-Sep-2026 14:42:56 | 2026-09-25 18:42:56 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 4 (6) pixels |
| 25-Sep-2026 14:43:11 | 20...2026-09-25 18:43:12 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:2,W:0): |
| 25-Sep-2026 14:43:16 | 2026-09-25 18:43:17 INFO task_tclean::AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 5 (6) pixels |
| 25-Sep-2026 14:43:16 | .30....40....50....60....70....80....90....100% |
| 25-Sep-2026 14:43:16 | |
| 25-Sep-2026 14:43:16 | 0%....10....20....30....40....50....60....70....80....90....100% |
| 25-Sep-2026 14:43:16 | 2026-09-25 18:43:17 WARN task_tclean::AWProjectWBFT2::makeSensitivityImage(Complex)[R&D] Setting up for weights accumulation for term 0 during gridding to compute sensitivity pattern. |
| 25-Sep-2026 14:43:16 | 2026-09-25 18:43:17 WARN task_tclean::AWProjectWBFT2::makeSensitivityImage(Complex)[R&D]+ Consequently, the first gridding cycle will be slower than the subsequent ones. |
| 25-Sep-2026 14:43:16 | 2026-09-25 18:43:17 INFO task_tclean::CFStore2::makePersistent(pa)[R&D] Saving CFStore of shape [3, 1, 2] for PA = -86.0481 BaselineType(antType1, antType2) = (0,0) |
| 25-Sep-2026 14:43:17 | 2026-09-25 18:43:17 INFO task_tclean::CFStore2::makePersistent(pa)[R&D] Saving CFStore of shape [3, 1, 2] for PA = -86.0481 BaselineType(antType1, antType2) = (0,0) |
| 25-Sep-2026 14:43:17 | 2026-09-25 18:43:17 INFO task_tclean::AWProjectFT2::findConvFunction[R&D] Convolution function memory footprint:2 MB out of a maximum of 15884 MB |
| 25-Sep-2026 14:43:17 | 2026-09-25 18:43:17 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :0 |
| 25-Sep-2026 14:43:17 | 2026-09-25 18:43:17 WARN task_tclean::AWProjectWBFT2::makeSensitivityImage(Complex)[R&D] Setting up for weights accumulation for term 1 during gridding to compute sensitivity pattern. |
| 25-Sep-2026 14:43:17 | 2026-09-25 18:43:17 WARN task_tclean::AWProjectWBFT2::makeSensitivityImage(Complex)[R&D]+ Consequently, the first gridding cycle will be slower than the subsequent ones. |
| 25-Sep-2026 14:43:17 | 2026-09-25 18:43:17 WARN task_tclean::AWProjectWBFT2::makeSensitivityImage(Complex)[R&D] Setting up for weights accumulation for term 2 during gridding to compute sensitivity pattern. |
| 25-Sep-2026 14:43:17 | 2026-09-25 18:43:17 WARN task_tclean::AWProjectWBFT2::makeSensitivityImage(Complex)[R&D]+ Consequently, the first gridding cycle will be slower than the subsequent ones. |
| 25-Sep-2026 14:43:17 | 2026-09-25 18:43:18 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :0 |
| 25-Sep-2026 14:43:18 | 2026-09-25 18:43:18 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :1 |
| 25-Sep-2026 14:43:18 | 2026-09-25 18:43:19 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :1 |
| 25-Sep-2026 14:43:18 | 2026-09-25 18:43:19 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :2 |
| 25-Sep-2026 14:43:19 | 2026-09-25 18:43:19 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :2 |
| 25-Sep-2026 14:43:19 | 2026-09-25 18:43:20 WARN task_tclean::AWProjectFT::finalizeToSky time to massage data 123.3 |
| 25-Sep-2026 14:43:19 | 2026-09-25 18:43:20 WARN task_tclean::AWProjectFT::finalizeToSky time gridding 0.34 |
| 25-Sep-2026 14:43:19 | 2026-09-25 18:43:20 INFO task_tclean::AWProjectFT2::getImage[R&D] Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:43:19 | 2026-09-25 18:43:20 INFO task_tclean::AWProjectFT2::getImage[R&D]+ [26963.9] |
| 25-Sep-2026 14:43:19 | 2026-09-25 18:43:20 INFO task_tclean::AWProjectFT2::getImage[R&D]+ (47.5662,1.62243) (0,0) |
| 25-Sep-2026 14:43:19 | 2026-09-25 18:43:20 WARN task_tclean::AWProjectFT::finalizeToSky time to massage data 0.29 |
| 25-Sep-2026 14:43:19 | 2026-09-25 18:43:20 WARN task_tclean::AWProjectFT::finalizeToSky time gridding 0.34 |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:20 INFO task_tclean::AWProjectFT2::getImage[R&D] Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:20 INFO task_tclean::AWProjectFT2::getImage[R&D]+ [-0.00602939] |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:20 INFO task_tclean::AWProjectFT2::getImage[R&D]+ (-4.40285,0.193823) (0,0) |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:20 WARN task_tclean::AWProjectFT::finalizeToSky time to massage data 0.17 |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:20 WARN task_tclean::AWProjectFT::finalizeToSky time gridding 0.37 |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:20 INFO task_tclean::AWProjectFT2::getImage[R&D] Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:20 INFO task_tclean::AWProjectFT2::getImage[R&D]+ [719.037] |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:20 INFO task_tclean::AWProjectFT2::getImage[R&D]+ (1.20742,0.0389964) (0,0) |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:20 INFO task_tclean::SIImageStoreMultiTerm::calcSensitivity Multi-Term Hessian Matrix : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:20 INFO task_tclean::SIImageStoreMultiTerm::calcSensitivity + [26963.9, -0.00602939 |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:20 INFO task_tclean::SIImageStoreMultiTerm::calcSensitivity + -0.00602939, 719.037] |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:20 INFO task_tclean::SIImageStoreMultiTerm::calcSensitivity Multi-Term Covariance Matrix : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:20 INFO task_tclean::SIImageStoreMultiTerm::calcSensitivity + [3.70866e-05, 3.10985e-10 |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:20 INFO task_tclean::SIImageStoreMultiTerm::calcSensitivity + 3.10985e-10, 0.00139075] |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:20 INFO task_tclean::SIImageStoreMultiTerm::calcSensitivity [tst][Taylor0] Theoretical sensitivity (Jy/bm):0.00608988 |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:20 INFO task_tclean::SIImageStoreMultiTerm::calcSensitivity [tst][Taylor1] Theoretical sensitivity (Jy/bm):0.0372927 |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:20 INFO task_tclean::SIImageStoreMultiTerm::calcFractionalBandwidth MFS frequency range : 1.04999 GHz -> 1.94998GHz.Fractional Bandwidth : 60.0001 %.Reference Frequency for Taylor Expansion : 1.49998GHz. |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:20 INFO task_tclean::SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.01972 |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:20 INFO task_tclean::SIImageStore::printBeamSet Beam : 139.82 arcsec, 129.968 arcsec, -86.7085 deg |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:21 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:21 INFO task_tclean::AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder") |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:21 INFO task_tclean::AWProjectFT2::initializeToSky[R&D] Computed maps using FTMachine::initMaps. polMap = [0, 0] |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:21 INFO task_tclean::AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder") |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:21 INFO task_tclean::AWProjectFT2::initializeToSky[R&D] Computed maps using FTMachine::initMaps. polMap = [0, 0] |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:21 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :0 |
| 25-Sep-2026 14:43:20 | 2026-09-25 18:43:21 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :0 |
| 25-Sep-2026 14:43:21 | 2026-09-25 18:43:21 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :1 |
| 25-Sep-2026 14:43:21 | 2026-09-25 18:43:21 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :1 |
| 25-Sep-2026 14:43:21 | 2026-09-25 18:43:22 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :2 |
| 25-Sep-2026 14:43:21 | 2026-09-25 18:43:22 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :2 |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:22 WARN task_tclean::AWProjectFT::finalizeToSky time to massage data 0.48 |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:22 WARN task_tclean::AWProjectFT::finalizeToSky time gridding 0.12 |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:22 INFO task_tclean::AWProjectFT2::getImage[R&D] Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:22 INFO task_tclean::AWProjectFT2::getImage[R&D]+ [26252.6] |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:22 INFO task_tclean::AWProjectFT2::getImage[R&D]+ (52.8842,0.667782) (0,0) |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:22 WARN task_tclean::AWProjectFT::finalizeToSky time to massage data 0.24 |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:22 WARN task_tclean::AWProjectFT::finalizeToSky time gridding 0.11 |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:22 INFO task_tclean::AWProjectFT2::getImage[R&D] Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:22 INFO task_tclean::AWProjectFT2::getImage[R&D]+ [-25.4027] |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:22 INFO task_tclean::AWProjectFT2::getImage[R&D]+ (-4.59659,0.1706) (0,0) |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:22 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 0.956546 |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:22 INFO SynthesisDeconvolver::setupMask [tst] Initializing new mask to 1.0 for the full image |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:22 INFO SynthesisDeconvolver::setupMask [tst] Number of pixels in the clean mask : 262144 out of a total of 262144 pixels. [ 100 % ] |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:22 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.956546, over full image : 0.956546 |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:22 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 30, 'cyclethreshold': 0.11989162862300873, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:22 INFO SDAlgorithmBase::deconvolve [tst] Run mtmfs minor-cycle | CycleThreshold=0.119892, CycleNiter=30, Gain=0.1 |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:23 INFO MultiTermMatrixCleaner::verifyScaleSizes() Scale sizes to be used for deconvolution : [0] |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:23 INFO MultiTermMatrixCleaner::initialise() Using a PSF patch of 80 pixels on each side for minor-cycle updates. |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:23 INFO MatrixCleaner::validatePsf() Peak of PSF = 1 at [256, 256] |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:23 INFO SIImageStoreMultiTerm::calcFractionalBandwidth MFS frequency range : 1.04999 GHz -> 1.94998GHz.Fractional Bandwidth : 60.0001 %.Reference Frequency for Taylor Expansion : 1.49998GHz. |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:23 INFO MultiTermMatrixCleaner::computeHessianPeak Calculating PSF and Scale convolutions |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:23 INFO MultiTermMatrixCleaner::computeHessianPeak The Matrix [H] for 0 pixel scale is : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:23 INFO MultiTermMatrixCleaner::computeHessianPeak + [1, -1.96684e-07 |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:23 INFO MultiTermMatrixCleaner::computeHessianPeak + -1.96684e-07, 0.0263966] |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:23 INFO MultiTermMatrixCleaner::mtclean() Calculating convolutions of residual images with scales |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:23 INFO MultiTermMatrixCleaner::mtclean() Peak convolved residual (within mask) : 0.956546 |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:23 INFO [20] Res: 0.129215 Max: 0.019763 Gain: 0.1 Pos: [122, 195] Scale: 0 Coeffs: 0.0895175 0.667173 |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:23 INFO MultiTermMatrixCleaner::mtclean() Reached stopping threshold at iteration 21. Peak residual 0.116294 (within mask) |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:23 INFO MultiTermMatrixCleaner::mtclean() Total flux by scale : [0]: 0.849204 (in this run) |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:23 INFO MultiTermMatrixCleaner::mtclean() Total flux by Taylor coefficient : [0]: 0.849204 [1]: 0.036211 |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:23 INFO SDAlgorithmBase::deconvolve [tst] iters=0->21 [21], model=0->0.849204, peakres=0.956546->0.11629, Reached cyclethreshold. |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:23 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 21 iterations. |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:23 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:23 INFO task_tclean::AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder") |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:23 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :0 |
| 25-Sep-2026 14:43:22 | 2026-09-25 18:43:23 INFO task_tclean::CFCache2::loadWtImage Loaded "tst.weight.tt0" |
| 25-Sep-2026 14:43:23 | 2026-09-25 18:43:23 INFO task_tclean::AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder") |
| 25-Sep-2026 14:43:23 | 2026-09-25 18:43:23 INFO task_tclean::CFCache2::loadWtImage Loaded "tst.weight.tt1" |
| 25-Sep-2026 14:43:23 | 2026-09-25 18:43:23 INFO task_tclean::AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder") |
| 25-Sep-2026 14:43:23 | 2026-09-25 18:43:23 INFO task_tclean::AWProjectFT2::initializeToSky[R&D] Computed maps using FTMachine::initMaps. polMap = [0, 0] |
| 25-Sep-2026 14:43:23 | 2026-09-25 18:43:24 INFO task_tclean::AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder") |
| 25-Sep-2026 14:43:23 | 2026-09-25 18:43:24 INFO task_tclean::AWProjectFT2::initializeToSky[R&D] Computed maps using FTMachine::initMaps. polMap = [0, 0] |
| 25-Sep-2026 14:43:23 | 2026-09-25 18:43:24 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :0 |
| 25-Sep-2026 14:43:24 | 2026-09-25 18:43:24 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :1 |
| 25-Sep-2026 14:43:24 | 2026-09-25 18:43:25 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :1 |
| 25-Sep-2026 14:43:24 | 2026-09-25 18:43:25 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :2 |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:25 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :2 |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:26 WARN task_tclean::AWProjectFT::finalizeToVis Time degrid 0.1 |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:26 WARN task_tclean::AWProjectFT::finalizeToVis Time degrid 0.13 |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:26 WARN task_tclean::AWProjectFT::finalizeToSky time to massage data 0.31 |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:26 WARN task_tclean::AWProjectFT::finalizeToSky time gridding 0.11 |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:26 INFO task_tclean::AWProjectFT2::getImage[R&D] Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:26 INFO task_tclean::AWProjectFT2::getImage[R&D]+ [26252.6] |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:26 INFO task_tclean::AWProjectFT2::getImage[R&D]+ (6.43758,0.12326) (0,0) |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:26 WARN task_tclean::AWProjectFT::finalizeToSky time to massage data 0.12 |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:26 WARN task_tclean::AWProjectFT::finalizeToSky time gridding 0.1 |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:26 INFO task_tclean::AWProjectFT2::getImage[R&D] Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:26 INFO task_tclean::AWProjectFT2::getImage[R&D]+ [-25.4027] |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:26 INFO task_tclean::AWProjectFT2::getImage[R&D]+ (-0.524794,0.0132285) (0,0) |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:26 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.118483, over full image : 0.118483 |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:26 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 9, 'cyclethreshold': 0.014850452542304993, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:26 INFO SDAlgorithmBase::deconvolve [tst] Run mtmfs minor-cycle | CycleThreshold=0.0148505, CycleNiter=9, Gain=0.1 |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:26 INFO SIImageStoreMultiTerm::calcFractionalBandwidth MFS frequency range : 1.04999 GHz -> 1.94998GHz.Fractional Bandwidth : 60.0001 %.Reference Frequency for Taylor Expansion : 1.49998GHz. |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:26 INFO MultiTermMatrixCleaner::mtclean() Calculating convolutions of residual images with scales |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:26 INFO MultiTermMatrixCleaner::mtclean() Peak convolved residual (within mask) : 0.118483 |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:26 INFO MultiTermMatrixCleaner::mtclean() Reached max number of iterations for this minor cycle |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:26 INFO MultiTermMatrixCleaner::mtclean() Total flux by scale : [0]: 0.921784 (in this run) |
| 25-Sep-2026 14:43:25 | 2026-09-25 18:43:26 INFO MultiTermMatrixCleaner::mtclean() Total flux by Taylor coefficient : [0]: 0.921784 [1]: 0.0510075 |
| 25-Sep-2026 14:43:26 | 2026-09-25 18:43:26 INFO SDAlgorithmBase::deconvolve [tst] iters=0->9 [9], model=0.849204->0.921784, peakres=0.118483->0.0459027, Reached cycleniter. |
| 25-Sep-2026 14:43:26 | 2026-09-25 18:43:26 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 30 iterations. |
| 25-Sep-2026 14:43:26 | 2026-09-25 18:43:26 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 3 ------------------------------------- |
| 25-Sep-2026 14:43:26 | 2026-09-25 18:43:26 INFO task_tclean::AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder") |
| 25-Sep-2026 14:43:26 | 2026-09-25 18:43:26 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :0 |
| 25-Sep-2026 14:43:26 | 2026-09-25 18:43:26 INFO task_tclean::AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder") |
| 25-Sep-2026 14:43:26 | 2026-09-25 18:43:27 INFO task_tclean::AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder") |
| 25-Sep-2026 14:43:26 | 2026-09-25 18:43:27 INFO task_tclean::AWProjectFT2::initializeToSky[R&D] Computed maps using FTMachine::initMaps. polMap = [0, 0] |
| 25-Sep-2026 14:43:26 | 2026-09-25 18:43:27 INFO task_tclean::AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder") |
| 25-Sep-2026 14:43:26 | 2026-09-25 18:43:27 INFO task_tclean::AWProjectFT2::initializeToSky[R&D] Computed maps using FTMachine::initMaps. polMap = [0, 0] |
| 25-Sep-2026 14:43:27 | 2026-09-25 18:43:27 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :0 |
| 25-Sep-2026 14:43:27 | 2026-09-25 18:43:28 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :1 |
| 25-Sep-2026 14:43:27 | 2026-09-25 18:43:28 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :1 |
| 25-Sep-2026 14:43:28 | 2026-09-25 18:43:28 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :2 |
| 25-Sep-2026 14:43:28 | 2026-09-25 18:43:29 INFO task_tclean::PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 1 for spw :2 |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:29 WARN task_tclean::AWProjectFT::finalizeToVis Time degrid 0.15 |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:29 WARN task_tclean::AWProjectFT::finalizeToVis Time degrid 0.09 |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:29 WARN task_tclean::AWProjectFT::finalizeToSky time to massage data 0.26 |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:29 WARN task_tclean::AWProjectFT::finalizeToSky time gridding 0.09 |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:29 INFO task_tclean::AWProjectFT2::getImage[R&D] Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:29 INFO task_tclean::AWProjectFT2::getImage[R&D]+ [26252.6] |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:29 INFO task_tclean::AWProjectFT2::getImage[R&D]+ (2.43272,0.0729904) (0,0) |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:29 WARN task_tclean::AWProjectFT::finalizeToSky time to massage data 0.23 |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:29 WARN task_tclean::AWProjectFT::finalizeToSky time gridding 0.06 |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:29 INFO task_tclean::AWProjectFT2::getImage[R&D] Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:29 INFO task_tclean::AWProjectFT2::getImage[R&D]+ [-25.4027] |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:29 INFO task_tclean::AWProjectFT2::getImage[R&D]+ (0.204325,-0.0075827) (0,0) |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:29 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.0461401, over full image : 0.0461401 |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:29 INFO tclean::::casa Reached global stopping criterion : iteration limit |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:29 INFO tclean::::casa getSummary call: fullsummary=False |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:29 INFO MultiTermMatrixCleaner::computeprincipalsolution() MTMC :: Computing principal solution on residuals |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:29 INFO SDAlgorithmBase::restore [tst] : Restoring model image. |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:29 INFO SIImageStore::restore Beam for chan : 0 : 139.82 arcsec, 129.968 arcsec, -86.7085 deg |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:30 INFO SIImageStore::restore Beam for chan : 0 : 139.82 arcsec, 129.968 arcsec, -86.7085 deg |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:30 INFO SIImageStoreMultiTerm::calculateAlphaBeta Calculating spectral parameters for Intensity > peakresidual/10 = 0.00461401 Jy/beam |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:30 INFO SIImageStoreMultiTerm::calculateAlphaBeta Written Spectral Index Error Image : /home/casatest/casa6/casatasks/tests/casashell_tests/work/test_task_tclean_casashell/tst.alpha.error |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:30 INFO SDAlgorithmMSMFS::restore Restored images : |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:30 INFO SDAlgorithmMSMFS::restore /home/casatest/casa6/casatasks/tests/casashell_tests/work/test_task_tclean_casashell/tst.image.tt0 (model=/home/casatest/casa6/casatasks/tests/casashell_tests/work/test_task_tclean_casashell/tst.model.tt0) |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:30 INFO SDAlgorithmMSMFS::restore /home/casatest/casa6/casatasks/tests/casashell_tests/work/test_task_tclean_casashell/tst.image.tt1 (model=/home/casatest/casa6/casatasks/tests/casashell_tests/work/test_task_tclean_casashell/tst.model.tt1) |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:30 INFO SDAlgorithmMSMFS::restore |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:30 INFO task_tclean::VB2CFBMap::~VB2CFMap[R&D] Total extra cost of heterogeneous array pointing correction = 0.859999sec. Total VBs processed = 217980. The pointingoffsetsigdev used was = [] |
| 25-Sep-2026 14:43:29 | 2026-09-25 18:43:30 INFO tclean::::casa Searching for images with prefix 'tst'... Found these, writing history into them: ['tst.weight.tt2', 'tst.residual.tt1', 'tst.weight.tt1', 'tst.sumwt.tt0', 'tst.image.tt0', 'tst.psf.tt0', 'tst.model.tt0', 'tst.mask', 'tst.image.tt1', 'tst.weight.tt0', 'tst.psf.tt2', 'tst.alpha', 'tst.alpha.error', 'tst.pb.tt0', 'tst.model.tt1', 'tst.psf.tt1', 'tst.sumwt.tt2', 'tst.sumwt.tt1', 'tst.residual.tt0'] |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO tclean::::casa Task tclean complete. Start time: 2026-09-25 18:41:13.773726 End time: 2026-09-25 18:43:30.033168 |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO tclean::::casa ##### End Task: tclean ##### |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO tclean::::casa ########################################## |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO name:: No table opened. |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO showcache:: The Table Cache is empty. |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO tclean::::casa [ checkall ] |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO tclean::::casa+ [ check_ims ] Image made : ['tst.image.tt0', 'tst.psf.tt0', 'tst.weight.tt0'] = [True, True, True] ( Pass : should all be True ) |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO tclean::::casa+ All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords) |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO tclean::::casa+ [check_history] All expected history entries found. (Pass) |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO tclean::::casa+ [ check_pix_val ] tst.image.tt0 : Value is 0.958972692489624 at [256, 256, 0, 0] ( Pass : should be 0.96 , Epsilon: 0.05) |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO tclean::::casa+ [ check_pix_val ] tst.weight.tt0 : Value is 0.48626992106437683 at [256, 256, 0, 0] ( Pass : should be 0.486 , Epsilon: 0.05) |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO tclean::::casa+ [ check_pix_val ] tst.alpha : Value is -0.0037272940389811993 at [256, 256, 0, 0] ( Pass : should be 0.0 , Epsilon: 0.05) |
| 25-Sep-2026 14:43:30 | .2026-09-25 18:43:30 INFO tclean::::casa ########################################## |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO tclean::::casa ##### Begin Task: tclean ##### |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO tclean::::casa tclean( vis='vla_wideband_2ptg_w_squint.ms', selectdata=True, field='1', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst.awp2', imsize=1200, cell='1.6arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='awp2', facets=1, psfphasecenter='', wprojplanes=6, vptable='', mosweight=False, aterm=True, psterm=False, wbawp=True, conjbeams=False, cfcache='', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=-0.1, normtype='flatnoise', deconvolver='hogbom', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=True, outlierfile='', weighting='uniform', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.0, uvtaper=[], niter=20, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='none', calcres=True, calcpsf=True, psfcutoff=0.35, parallel=False ) |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO tclean::::casa Verifying Input Parameters |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO SynthesisImagerVi2::selectData MS : vla_wideband_2ptg_w_squint.ms | Selecting on fields : 1 | [Opened in readonly mode] |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO SynthesisImagerVi2::selectData NRows selected : 7020 |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.awp2] : |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.awp2] : |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO SynthesisImagerVi2::defineImage Impars: start |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO SynthesisImagerVi2::defineImage Shape: [1200, 1200, 1, 1] Spectral: [1.48111e+09] at [0] with increment [5.99947e+08] |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst.awp2] with ftmachine : awp2 |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO SynthesisImager::getVPRecord Using default Voltage Patterns from the VPManager |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.1699 GB. Available mem.: 10.64 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 1. |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:30 INFO SynthesisImagerVi2::weight() Set imaging weights : Uniform weighting: sidelobes will be suppressed over full image |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:31 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst.awp2] : hogbom |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:31 INFO task_tclean::SynthesisImager::makePSF ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 25-Sep-2026 14:43:30 | Processing request for geometries from observatory VLA, antenna type STANDARD |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:31 INFO task_tclean::BeamCalc::setBeamCalcGeometries() Initialisation of geometries for observatory VLA, antenna type STANDARD |
| 25-Sep-2026 14:43:30 | 2026-09-25 18:43:31 INFO task_tclean::BeamCalc::setBeamCalcGeometries() Will use default geometries for VLA STANDARD. |
| 25-Sep-2026 14:44:40 | |
| 25-Sep-2026 14:44:48 | 0%....10....20....30....40....50....60....70....80....90....100% |
| 25-Sep-2026 14:44:49 | 2026-09-25 18:44:49 INFO task_tclean::SIImageStore::calcSensitivity [tst.awp2] Theoretical sensitivity (Jy/bm):0.00282974 |
| 25-Sep-2026 14:44:49 | 2026-09-25 18:44:49 INFO task_tclean::SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.017998 |
| 25-Sep-2026 14:44:49 | 2026-09-25 18:44:49 INFO task_tclean::SIImageStore::printBeamSet Beam : 5.34694 arcsec, 4.36752 arcsec, -84.5038 deg |
| 25-Sep-2026 14:44:49 | 2026-09-25 18:44:50 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 25-Sep-2026 14:45:00 | |
| 25-Sep-2026 14:45:42 | 0%....10....20....30....40....50....60....70....80....90....100% |
| 25-Sep-2026 14:45:42 | 2026-09-25 18:45:43 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 0.482475 |
| 25-Sep-2026 14:45:42 | 2026-09-25 18:45:43 INFO SynthesisDeconvolver::setupMask [tst.awp2] Initializing new mask to 1.0 for the full image |
| 25-Sep-2026 14:45:42 | 2026-09-25 18:45:43 INFO SynthesisDeconvolver::setupMask [tst.awp2] Number of pixels in the clean mask : 1.44e+06 out of a total of 1.44e+06 pixels. [ 100 % ] |
| 25-Sep-2026 14:45:42 | 2026-09-25 18:45:43 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.482475, over full image : 0.482475 |
| 25-Sep-2026 14:45:42 | 2026-09-25 18:45:43 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 20, 'cyclethreshold': 0.024123763665556908, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 25-Sep-2026 14:45:42 | 2026-09-25 18:45:43 INFO SDAlgorithmBase::deconvolve [tst.awp2] Run Hogbom minor-cycle | CycleThreshold=0.0241238, CycleNiter=20, Gain=0.1 |
| 25-Sep-2026 14:45:42 | 2026-09-25 18:45:43 INFO SDAlgorithmBase::deconvolve [tst.awp2] iters=0->20 [20], model=0->0.429683, peakres=0.482475->0.052792, Reached cycleniter. |
| 25-Sep-2026 14:45:42 | 2026-09-25 18:45:43 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 20 iterations. |
| 25-Sep-2026 14:45:42 | 2026-09-25 18:45:43 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 25-Sep-2026 14:46:01 | |
| 25-Sep-2026 14:47:43 | 0%....10....20....30....40....50....60....70....80....90....100% |
| 25-Sep-2026 14:47:43 | 2026-09-25 18:47:43 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.0525717, over full image : 0.0525717 |
| 25-Sep-2026 14:47:43 | 2026-09-25 18:47:43 INFO tclean::::casa Reached global stopping criterion : iteration limit |
| 25-Sep-2026 14:47:43 | 2026-09-25 18:47:43 INFO tclean::::casa getSummary call: fullsummary=False |
| 25-Sep-2026 14:47:43 | 2026-09-25 18:47:43 INFO SDAlgorithmBase::restore [tst.awp2] : Restoring model image. |
| 25-Sep-2026 14:47:43 | 2026-09-25 18:47:44 INFO SIImageStore::restore Beam for chan : 0 : 5.34694 arcsec, 4.36752 arcsec, -84.5038 deg |
| 25-Sep-2026 14:47:43 | 2026-09-25 18:47:44 INFO task_tclean::SDAlgorithmBase::pbcor [tst.awp2] : Applying PB correction |
| 25-Sep-2026 14:47:44 | 2026-09-25 18:47:44 INFO tclean::::casa Searching for images with prefix 'tst.awp2'... Found these, writing history into them: ['tst.awp2.sumwt', 'tst.awp2.psf', 'tst.awp2.mask', 'tst.awp2.model', 'tst.awp2.residual', 'tst.awp2.weight', 'tst.awp2.image', 'tst.awp2.image.pbcor', 'tst.awp2.pb'] |
| 25-Sep-2026 14:47:44 | 2026-09-25 18:47:45 INFO tclean::::casa Task tclean complete. Start time: 2026-09-25 18:43:30.281658 End time: 2026-09-25 18:47:44.609039 |
| 25-Sep-2026 14:47:44 | 2026-09-25 18:47:45 INFO tclean::::casa ##### End Task: tclean ##### |
| 25-Sep-2026 14:47:44 | 2026-09-25 18:47:45 INFO tclean::::casa ########################################## |
| 25-Sep-2026 14:47:44 | 2026-09-25 18:47:45 INFO name:: No table opened. |
| 25-Sep-2026 14:47:44 | 2026-09-25 18:47:45 INFO showcache:: The Table Cache is empty. |
| 25-Sep-2026 14:47:44 | 2026-09-25 18:47:45 INFO tclean::::casa [ checkall ] |
| 25-Sep-2026 14:47:44 | 2026-09-25 18:47:45 INFO tclean::::casa+ [ check_ims ] Image made : ['tst.awp2.image'] = [True] ( Pass : should all be True ) |
| 25-Sep-2026 14:47:44 | 2026-09-25 18:47:45 INFO tclean::::casa+ All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords) |
| 25-Sep-2026 14:47:44 | 2026-09-25 18:47:45 INFO tclean::::casa+ [check_history] All expected history entries found. (Pass) |
| 25-Sep-2026 14:47:44 | 2026-09-25 18:47:45 INFO tclean::::casa+ [ check_pix_val ] tst.awp2.pb : Value is 0.6532912850379944 at [323, 858, 0, 0] ( Pass : should be 0.66 , Epsilon: 0.1) |
| 25-Sep-2026 14:47:44 | 2026-09-25 18:47:45 INFO tclean::::casa+ [ check_pix_val ] tst.awp2.image.pbcor : Value is 0.7381930947303772 at [323, 858, 0, 0] ( Pass : should be 0.75 , Epsilon: 0.1) |
| 25-Sep-2026 14:47:44 | .s2026-09-25 18:47:45 INFO tclean::::casa ########################################## |
| 25-Sep-2026 14:47:44 | 2026-09-25 18:47:45 INFO tclean::::casa ##### Begin Task: tclean ##### |
| 25-Sep-2026 14:47:44 | 2026-09-25 18:47:45 INFO tclean::::casa tclean( vis='refim_point_wterm_vlad.ms', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst.awp', imsize=2048, cell='10.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='awproject', facets=1, psfphasecenter='', wprojplanes=16, vptable='', mosweight=False, aterm=False, psterm=True, wbawp=False, conjbeams=False, cfcache='tst_use_awp.cf', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=-0.1, normtype='flatnoise', deconvolver='hogbom', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=False, outlierfile='', weighting='uniform', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.0, uvtaper=[], niter=0, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='none', calcres=True, calcpsf=True, psfcutoff=0.35, parallel=False ) |
| 25-Sep-2026 14:47:44 | 2026-09-25 18:47:45 INFO tclean::::casa Verifying Input Parameters |
| 25-Sep-2026 14:47:44 | 2026-09-25 18:47:45 INFO SynthesisImagerVi2::selectData MS : refim_point_wterm_vlad.ms | [Opened in readonly mode] |
| 25-Sep-2026 14:47:44 | 2026-09-25 18:47:45 INFO SynthesisImagerVi2::selectData NRows selected : 15093 |
| 25-Sep-2026 14:47:44 | 2026-09-25 18:47:45 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.awp] : |
| 25-Sep-2026 14:47:44 | 2026-09-25 18:47:45 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.awp] : |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO SynthesisImagerVi2::defineImage Impars: start |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO SynthesisImagerVi2::defineImage Shape: [2048, 2048, 1, 1] Spectral: [9.99981e+08] at [0] with increment [1.00218e+06] |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst.awp] with ftmachine : awprojectft |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO CFCache2::fillCFSFromDisk No. of CFS* found in tst_use_awp.cf: 0 |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO CFCache2::fillCFSFromDisk No. of WTCFS* found in tst_use_awp.cf: 0 |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO AWProjectFT2::setPAIncrement[R&D] Setting PA increment to 360 deg |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO SynthesisImagerVi2::createAWPFTMachine Sending frequency selection information Axis Lengths: [1, 4] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO SynthesisImagerVi2::createAWPFTMachine + [0, 1e+09, 1e+09, 1e+06] |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO SynthesisImagerVi2::createAWPFTMachine + to AWP FTM. |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.3842 GB. Available mem.: 10.64 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 1. |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO SynthesisImagerVi2::weight() Set imaging weights : Uniform weighting: sidelobes will be suppressed over full image |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst.awp] : hogbom |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO SynthesisImager::makePSF ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder") |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO AWProjectFT2::initializeToSky[R&D] Computed maps using FTMachine::initMaps. polMap = [0, 0] |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO VB2CFBMap::makeVBRow2CFBMap[R&D] CFs not cached for -64.1134 deg, dPA = 360 Field ID = 0 Ant1Type, Ant2Type = 0,0 |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO AWConvFunc2::makeConvFunction[R&D] Making a new convolution function for PA=-64.1134deg for field ID 0 |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO AWConvFunc2::makeConvFunction[R&D] Using 16 planes for W-projection |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO AWConvFunc2::makeConvFunction[R&D] Estimating maximum possible W = 5156.62 (wavelengths) |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO AWConvFunc2::makeConvFunction[R&D] Scaling in W (at maximum W) = 22.9183 wavelengths per pixel |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO AWConvFunc2::makeConvFunction[R&D] Making 16 w plane(s). |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO AWConvFunc2::makeConvFunction[R&D] Making 1 frequency plane(s). |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:45 INFO AWConvFunc2::makeConvFunction[R&D] CFB Freq. axis [N, Min, Max, Incr. (GHz)]: 1 0.999981 0.999981 0.1 |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:46 INFO AWConvFunc2::makeConvFunction[R&D] Making CFs for baseline type 0 |
| 25-Sep-2026 14:47:45 | 2026-09-25 18:47:46 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:0,W:0): |
| 25-Sep-2026 14:47:50 | 2026-09-25 18:47:50 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 4 (6) pixels |
| 25-Sep-2026 14:47:50 | 2026-09-25 18:47:51 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:0,W:1): |
| 25-Sep-2026 14:47:57 | 2026-09-25 18:47:57 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 5 (6) pixels |
| 25-Sep-2026 14:47:57 | |
| 25-Sep-2026 14:47:57 | 0%2026-09-25 18:47:57 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:0,W:2): |
| 25-Sep-2026 14:48:02 | 2026-09-25 18:48:03 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 5 (6) pixels |
| 25-Sep-2026 14:48:02 | 2026-09-25 18:48:03 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:0,W:3): |
| 25-Sep-2026 14:48:07 | 2026-09-25 18:48:08 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 5 (6) pixels |
| 25-Sep-2026 14:48:07 | .2026-09-25 18:48:08 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:0,W:4): |
| 25-Sep-2026 14:48:13 | 2026-09-25 18:48:13 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 6 (6) pixels |
| 25-Sep-2026 14:48:13 | .2026-09-25 18:48:13 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:0,W:5): |
| 25-Sep-2026 14:48:18 | 2026-09-25 18:48:18 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 7 (6) pixels |
| 25-Sep-2026 14:48:18 | .2026-09-25 18:48:18 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:0,W:6): |
| 25-Sep-2026 14:48:23 | 2026-09-25 18:48:23 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 9 (6) pixels |
| 25-Sep-2026 14:48:23 | 2026-09-25 18:48:23 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:0,W:7): |
| 25-Sep-2026 14:48:28 | 2026-09-25 18:48:28 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 10 (6) pixels |
| 25-Sep-2026 14:48:28 | .2026-09-25 18:48:29 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:0,W:8): |
| 25-Sep-2026 14:48:33 | 2026-09-25 18:48:33 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 12 (6) pixels |
| 25-Sep-2026 14:48:33 | 102026-09-25 18:48:34 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:0,W:9): |
| 25-Sep-2026 14:48:38 | 2026-09-25 18:48:39 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 14 (6) pixels |
| 25-Sep-2026 14:48:38 | .2026-09-25 18:48:39 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:0,W:10): |
| 25-Sep-2026 14:48:43 | 2026-09-25 18:48:44 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 17 (6) pixels |
| 25-Sep-2026 14:48:43 | .2026-09-25 18:48:44 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:0,W:11): |
| 25-Sep-2026 14:48:48 | 2026-09-25 18:48:49 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 19 (6) pixels |
| 25-Sep-2026 14:48:48 | 2026-09-25 18:48:49 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:0,W:12): |
| 25-Sep-2026 14:48:53 | 2026-09-25 18:48:54 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 22 (6) pixels |
| 25-Sep-2026 14:48:54 | .2026-09-25 18:48:54 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:0,W:13): |
| 25-Sep-2026 14:48:59 | 2026-09-25 18:48:59 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 26 (6) pixels |
| 25-Sep-2026 14:48:59 | .2026-09-25 18:48:59 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:0,W:14): |
| 25-Sep-2026 14:49:04 | 2026-09-25 18:49:04 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 29 (6) pixels |
| 25-Sep-2026 14:49:04 | 202026-09-25 18:49:04 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:0,C:0,W:15): |
| 25-Sep-2026 14:49:09 | 2026-09-25 18:49:09 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 33 (6) pixels |
| 25-Sep-2026 14:49:09 | .2026-09-25 18:49:10 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:0,W:0): |
| 25-Sep-2026 14:49:14 | 2026-09-25 18:49:15 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 4 (6) pixels |
| 25-Sep-2026 14:49:14 | 2026-09-25 18:49:15 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:0,W:1): |
| 25-Sep-2026 14:49:19 | 2026-09-25 18:49:20 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 5 (6) pixels |
| 25-Sep-2026 14:49:19 | .2026-09-25 18:49:20 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:0,W:2): |
| 25-Sep-2026 14:49:25 | 2026-09-25 18:49:25 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 5 (6) pixels |
| 25-Sep-2026 14:49:25 | .2026-09-25 18:49:25 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:0,W:3): |
| 25-Sep-2026 14:49:30 | 2026-09-25 18:49:30 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 5 (6) pixels |
| 25-Sep-2026 14:49:30 | .2026-09-25 18:49:30 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:0,W:4): |
| 25-Sep-2026 14:49:35 | 2026-09-25 18:49:35 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 6 (6) pixels |
| 25-Sep-2026 14:49:35 | 302026-09-25 18:49:36 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:0,W:5): |
| 25-Sep-2026 14:49:40 | 2026-09-25 18:49:41 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 7 (6) pixels |
| 25-Sep-2026 14:49:40 | 2026-09-25 18:49:41 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:0,W:6): |
| 25-Sep-2026 14:49:45 | 2026-09-25 18:49:46 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 9 (6) pixels |
| 25-Sep-2026 14:49:46 | .2026-09-25 18:49:46 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:0,W:7): |
| 25-Sep-2026 14:49:51 | 2026-09-25 18:49:51 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 10 (6) pixels |
| 25-Sep-2026 14:49:51 | .2026-09-25 18:49:51 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:0,W:8): |
| 25-Sep-2026 14:49:56 | 2026-09-25 18:49:57 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 12 (6) pixels |
| 25-Sep-2026 14:49:56 | .2026-09-25 18:49:57 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:0,W:9): |
| 25-Sep-2026 14:50:02 | 2026-09-25 18:50:02 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 14 (6) pixels |
| 25-Sep-2026 14:50:02 | .2026-09-25 18:50:02 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:0,W:10): |
| 25-Sep-2026 14:50:07 | 2026-09-25 18:50:07 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 17 (6) pixels |
| 25-Sep-2026 14:50:07 | 2026-09-25 18:50:08 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:0,W:11): |
| 25-Sep-2026 14:50:12 | 2026-09-25 18:50:12 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 19 (6) pixels |
| 25-Sep-2026 14:50:12 | 402026-09-25 18:50:13 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:0,W:12): |
| 25-Sep-2026 14:50:17 | 2026-09-25 18:50:18 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 22 (6) pixels |
| 25-Sep-2026 14:50:17 | .2026-09-25 18:50:18 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:0,W:13): |
| 25-Sep-2026 14:50:23 | 2026-09-25 18:50:23 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 26 (6) pixels |
| 25-Sep-2026 14:50:23 | .2026-09-25 18:50:23 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:0,W:14): |
| 25-Sep-2026 14:50:28 | 2026-09-25 18:50:28 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 29 (6) pixels |
| 25-Sep-2026 14:50:28 | .2026-09-25 18:50:29 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF(M:15,C:0,W:15): |
| 25-Sep-2026 14:50:33 | 2026-09-25 18:50:34 INFO AWConvFunc2::fillConvFuncBuffer[R&D] CF Support: 33 (6) pixels |
| 25-Sep-2026 14:50:33 | .50....60....70....80....90....100% |
| 25-Sep-2026 14:50:33 | |
| 25-Sep-2026 14:50:33 | 0%....10....20....30....40....50....60....70....80....90....100% |
| 25-Sep-2026 14:50:33 | 2026-09-25 18:50:34 WARN AWProjectWBFT2::makeSensitivityImage(Complex)[R&D] Setting up for weights accumulation during gridding to compute sensitivity pattern. |
| 25-Sep-2026 14:50:33 | 2026-09-25 18:50:34 WARN AWProjectWBFT2::makeSensitivityImage(Complex)[R&D]+ Consequently, the first gridding cycle will be slower than the subsequent ones. |
| 25-Sep-2026 14:50:33 | 2026-09-25 18:50:34 INFO CFStore2::makePersistent(pa)[R&D] Saving CFStore of shape [1, 16, 2] for PA = -64.1134 BaselineType(antType1, antType2) = (0,0) |
| 25-Sep-2026 14:50:34 | 2026-09-25 18:50:34 INFO CFStore2::makePersistent(pa)[R&D] Saving CFStore of shape [1, 16, 2] for PA = -64.1134 BaselineType(antType1, antType2) = (0,0) |
| 25-Sep-2026 14:50:34 | 2026-09-25 18:50:35 INFO AWProjectFT2::findConvFunction[R&D] Convolution function memory footprint:5 MB out of a maximum of 15884 MB |
| 25-Sep-2026 14:50:34 | 2026-09-25 18:50:35 INFO PhaseGrad::computeAntennaPointingGrad Computing Phase Grad for Field : 0 for spw :0 |
| 25-Sep-2026 14:50:35 | 2026-09-25 18:50:35 WARN AWProjectFT::finalizeToSky time to massage data 169.67 |
| 25-Sep-2026 14:50:35 | 2026-09-25 18:50:35 WARN AWProjectFT::finalizeToSky time gridding 0.26 |
| 25-Sep-2026 14:50:36 | 2026-09-25 18:50:37 INFO AWProjectFT2::getImage[R&D] Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:50:36 | 2026-09-25 18:50:37 INFO AWProjectFT2::getImage[R&D]+ [24968] |
| 25-Sep-2026 14:50:36 | 2026-09-25 18:50:37 INFO AWProjectFT2::getImage[R&D]+ (1.79638,1.76118e-09) (0,0) |
| 25-Sep-2026 14:50:38 | 2026-09-25 18:50:38 INFO SIImageStore::calcSensitivity [tst.awp] Theoretical sensitivity (Jy/bm):0.00632861 |
| 25-Sep-2026 14:50:38 | 2026-09-25 18:50:38 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.050523 |
| 25-Sep-2026 14:50:38 | 2026-09-25 18:50:38 INFO SIImageStore::printBeamSet Beam : 85.3879 arcsec, 71.2449 arcsec, -89.0476 deg |
| 25-Sep-2026 14:50:38 | 2026-09-25 18:50:39 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 25-Sep-2026 14:50:38 | 2026-09-25 18:50:39 INFO task_tclean::AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder") |
| 25-Sep-2026 14:50:39 | 2026-09-25 18:50:39 INFO task_tclean::AWProjectFT2::initializeToSky[R&D] Computed maps using FTMachine::initMaps. polMap = [0, 0] |
| 25-Sep-2026 14:50:39 | 2026-09-25 18:50:39 WARN task_tclean::AWProjectFT::finalizeToSky time to massage data 0.25 |
| 25-Sep-2026 14:50:39 | 2026-09-25 18:50:39 WARN task_tclean::AWProjectFT::finalizeToSky time gridding 0.15 |
| 25-Sep-2026 14:50:39 | 2026-09-25 18:50:40 INFO task_tclean::AWProjectFT2::getImage[R&D] Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order) |
| 25-Sep-2026 14:50:39 | 2026-09-25 18:50:40 INFO task_tclean::AWProjectFT2::getImage[R&D]+ [24970.3] |
| 25-Sep-2026 14:50:39 | 2026-09-25 18:50:40 INFO task_tclean::AWProjectFT2::getImage[R&D]+ (0.766387,-1.1916) (0,0) |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:41 INFO task_tclean::SDAlgorithmBase::restore [tst.awp] : Restoring model image. |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:41 WARN task_tclean::SIImageStore::restore (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SIImageStore.cc, line 2353) Restoring with an empty model image. Only residuals will be processed to form the output restored image. |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:41 INFO task_tclean::SIImageStore::restore Beam for chan : 0 : 85.3879 arcsec, 71.2449 arcsec, -89.0476 deg |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:41 INFO task_tclean::VB2CFBMap::~VB2CFMap[R&D] Total extra cost of heterogeneous array pointing correction = 0.19sec. Total VBs processed = 45630. The pointingoffsetsigdev used was = [] |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:41 INFO tclean::::casa Searching for images with prefix 'tst.awp'... Found these, writing history into them: ['tst.awp.psf', 'tst.awp.weight', 'tst.awp.residual', 'tst.awp.pb', 'tst.awp.sumwt', 'tst.awp.image', 'tst.awp.model'] |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:41 INFO tclean::::casa Task tclean complete. Start time: 2026-09-25 18:47:44.843172 End time: 2026-09-25 18:50:41.441308 |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:41 INFO tclean::::casa ##### End Task: tclean ##### |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:41 INFO tclean::::casa ########################################## |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:41 INFO name:: No table opened. |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:41 INFO showcache:: The Table Cache is empty. |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:41 INFO tclean::::casa [ checkall ] |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:41 INFO tclean::::casa+ [ check_ims ] Image made : ['tst.awp.image'] = [True] ( Pass : should all be True ) |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:41 INFO tclean::::casa+ All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords) |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:41 INFO tclean::::casa+ [check_history] All expected history entries found. (Pass) |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:41 INFO tclean::::casa+ [ check_pix_val ] tst.awp.psf : Value is 1.0 at [1024, 1024, 0, 0] ( Pass : should be 1.0 , Epsilon: 0.05) |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:41 INFO tclean::::casa+ [ check_pix_val ] tst.awp.image : Value is 0.9958503246307373 at [1158, 1384, 0, 0] ( Pass : should be 1.0 , Epsilon: 0.05) |
| 25-Sep-2026 14:50:41 | .2026-09-25 18:50:42 INFO tclean::::casa ########################################## |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:42 INFO tclean::::casa ##### Begin Task: tclean ##### |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:42 INFO tclean::::casa tclean( vis='refim_point_wterm_vlad.ms', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst.facet', imsize=2048, cell='10.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='widefield', facets=4, psfphasecenter='', wprojplanes=1, vptable='', mosweight=True, aterm=True, psterm=False, wbawp=True, conjbeams=False, cfcache='', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=-0.1, normtype='flatnoise', deconvolver='hogbom', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=False, outlierfile='', weighting='uniform', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.0, uvtaper=[], niter=0, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='none', calcres=True, calcpsf=True, psfcutoff=0.35, parallel=False ) |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:42 INFO tclean::::casa Verifying Input Parameters |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:42 INFO SynthesisImagerVi2::selectData MS : refim_point_wterm_vlad.ms | [Opened in readonly mode] |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:42 INFO SynthesisImagerVi2::selectData NRows selected : 15093 |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:42 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.facet] : |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:42 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.facet] : |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:42 INFO SynthesisImagerVi2::defineImage Impars: start |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:42 INFO SynthesisImagerVi2::defineImage Shape: [2048, 2048, 1, 1] Spectral: [9.99981e+08] at [0] with increment [1.00218e+06] |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:42 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst.facet] with ftmachine : gridft |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:42 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.2305 GB. Available mem.: 10.64 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 1. |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:42 INFO SynthesisImager::createFacetImageStoreList Creating 16 facets in total |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:42 INFO SynthesisImagerVi2::weight() Set imaging weights : Uniform weighting: sidelobes will be suppressed over full image |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:42 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst.facet] : hogbom |
| 25-Sep-2026 14:50:41 | 2026-09-25 18:50:42 INFO SynthesisImager::makePSF ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 25-Sep-2026 14:50:43 | 2026-09-25 18:50:44 INFO SIImageStore::calcSensitivity [tst.facet] Theoretical sensitivity (Jy/bm):f0:0.00632861 f4:0.00632861 f8:0.00632861 f12:0.00632861 f1:0.00632861 f5:0.00632861 f9:0.00632861 f13:0.00632861 f2:0.00632861 f6:0.00632861 f10:0.00632861 f14:0.00632861 f3:0.00632861 f7:0.00632861 f11:0.00632861 f15:0.00632861 |
| 25-Sep-2026 14:50:43 | 2026-09-25 18:50:44 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.055879 |
| 25-Sep-2026 14:50:43 | 2026-09-25 18:50:44 INFO SIImageStore::printBeamSet Beam : 85.4571 arcsec, 71.4183 arcsec, -88.2589 deg |
| 25-Sep-2026 14:50:43 | 2026-09-25 18:50:44 INFO task_tclean::SynthesisImagerVi2::makePrimaryBeam vi2 : Evaluating Primary Beam model onto image grid(s) |
| 25-Sep-2026 14:50:44 | 2026-09-25 18:50:44 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:46 INFO task_tclean::SDAlgorithmBase::restore [tst.facet] : Restoring model image. |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:46 WARN task_tclean::SIImageStore::restore (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SIImageStore.cc, line 2353) Restoring with an empty model image. Only residuals will be processed to form the output restored image. |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:46 INFO task_tclean::SIImageStore::restore Beam for chan : 0 : 85.4571 arcsec, 71.4183 arcsec, -88.2589 deg |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:46 INFO tclean::::casa Searching for images with prefix 'tst.facet'... Found these, writing history into them: ['tst.facet.psf', 'tst.facet.model', 'tst.facet.residual', 'tst.facet.sumwt', 'tst.facet.image', 'tst.facet.pb'] |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:46 INFO tclean::::casa Task tclean complete. Start time: 2026-09-25 18:50:41.556007 End time: 2026-09-25 18:50:46.447709 |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:46 INFO tclean::::casa ##### End Task: tclean ##### |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:46 INFO tclean::::casa ########################################## |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:46 INFO name:: No table opened. |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:46 INFO showcache:: The Table Cache is empty. |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:46 INFO tclean::::casa [ checkall ] |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:46 INFO tclean::::casa+ [ check_ims ] Image made : ['tst.facet.image'] = [True] ( Pass : should all be True ) |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:46 INFO tclean::::casa+ All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords) |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:46 INFO tclean::::casa+ [check_history] All expected history entries found. (Pass) |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:46 INFO tclean::::casa+ [ check_pix_val ] tst.facet.psf : Value is 1.0 at [1024, 1024, 0, 0] ( Pass : should be 1.0 , Epsilon: 0.05) |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:46 INFO tclean::::casa+ [ check_pix_val ] tst.facet.image : Value is 0.9911644458770752 at [1158, 1384, 0, 0] ( Pass : should be 1.0 , Epsilon: 0.05) |
| 25-Sep-2026 14:50:46 | .2026-09-25 18:50:47 INFO tclean::::casa ########################################## |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:47 INFO tclean::::casa ##### Begin Task: tclean ##### |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:47 INFO tclean::::casa tclean( vis='vla_wideband_2ptg_w_squint.ms', selectdata=True, field='1', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst.awp2', imsize=1200, cell='1.6arcsec', phasecenter='', stokes='IV', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='awp2', facets=1, psfphasecenter='', wprojplanes=2, vptable='', mosweight=False, aterm=True, psterm=False, wbawp=True, conjbeams=False, cfcache='', usepointing=False, computepastep=15.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=-0.1, normtype='flatnoise', deconvolver='hogbom', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=True, outlierfile='', weighting='uniform', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.0, uvtaper=[], niter=20, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='none', calcres=True, calcpsf=True, psfcutoff=0.35, parallel=False ) |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:47 INFO tclean::::casa Verifying Input Parameters |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:47 INFO SynthesisImagerVi2::selectData MS : vla_wideband_2ptg_w_squint.ms | Selecting on fields : 1 | [Opened in readonly mode] |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:47 INFO SynthesisImagerVi2::selectData NRows selected : 7020 |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:47 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.awp2] : |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:47 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.awp2] : |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:47 INFO SynthesisImagerVi2::defineImage Impars: start |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:47 INFO SynthesisImagerVi2::defineImage Shape: [1200, 1200, 2, 1] Spectral: [1.48111e+09] at [0] with increment [5.99947e+08] |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:47 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst.awp2] with ftmachine : awp2 |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:47 INFO SynthesisImager::getVPRecord Using default Voltage Patterns from the VPManager |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:47 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.3399 GB. Available mem.: 10.64 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 1. |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:47 INFO SynthesisImagerVi2::weight() Set imaging weights : Uniform weighting: sidelobes will be suppressed over full image |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:47 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst.awp2] : hogbom |
| 25-Sep-2026 14:50:46 | 2026-09-25 18:50:47 INFO task_tclean::SynthesisImager::makePSF ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 25-Sep-2026 14:50:46 | paMax 3.13298 painc 0.261799 |
| 25-Sep-2026 14:53:30 | |
| 25-Sep-2026 14:53:31 | 0%....10....20....30....40....50....60....70....80....90....100% |
| 25-Sep-2026 14:53:38 | 2026-09-25 18:53:39 INFO task_tclean::SIImageStore::calcSensitivity [tst.awp2] Theoretical sensitivity (Jy/bm):p0:0.00400186 p1:0.00400186 |
| 25-Sep-2026 14:53:38 | 2026-09-25 18:53:39 INFO task_tclean::SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.045791 |
| 25-Sep-2026 14:53:38 | 2026-09-25 18:53:39 INFO task_tclean::SIImageStore::printBeamSet Restoring Beams |
| 25-Sep-2026 14:53:38 | 2026-09-25 18:53:39 INFO task_tclean::SIImageStore::printBeamSet + Chan Freq Vel Pol |
| 25-Sep-2026 14:53:38 | 2026-09-25 18:53:39 INFO task_tclean::SIImageStore::printBeamSet + 0 1.5e+09 -70230 I 5.3454 arcsec x 4.3655 arcsec pa=-84.5682 deg |
| 25-Sep-2026 14:53:38 | 2026-09-25 18:53:39 INFO task_tclean::SIImageStore::printBeamSet + 0 1.5e+09 -70230 V 5.3454 arcsec x 4.3655 arcsec pa=-84.5682 deg |
| 25-Sep-2026 14:53:39 | 2026-09-25 18:53:39 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 25-Sep-2026 14:53:47 | |
| 25-Sep-2026 14:53:53 | 0%....10....20....30....40....50....60....70....80....90....100% |
| 25-Sep-2026 14:53:57 | 2026-09-25 18:53:57 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 0.456313 |
| 25-Sep-2026 14:53:57 | 2026-09-25 18:53:57 INFO SynthesisDeconvolver::setupMask [tst.awp2] Initializing new mask to 1.0 for the full image |
| 25-Sep-2026 14:53:57 | 2026-09-25 18:53:57 INFO SynthesisDeconvolver::setupMask [tst.awp2] Number of pixels in the clean mask : 2.88e+06 out of a total of 2.88e+06 pixels. [ 100 % ] |
| 25-Sep-2026 14:53:57 | 2026-09-25 18:53:57 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.456313, over full image : 0.456313 |
| 25-Sep-2026 14:53:57 | 2026-09-25 18:53:57 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 20, 'cyclethreshold': 0.02281567081809044, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 25-Sep-2026 14:53:57 | 2026-09-25 18:53:57 INFO SDAlgorithmBase::deconvolve [tst.awp2] Run Hogbom minor-cycle on 2 pols | CycleThreshold=0.0228157, CycleNiter=20, Gain=0.1 |
| 25-Sep-2026 14:53:57 | 2026-09-25 18:53:57 INFO SDAlgorithmBase::deconvolve [tst.awp2:P0] iters=0->20 [20], model=0->0.406384, peakres=0.456313->0.0499293, Reached cycleniter. |
| 25-Sep-2026 14:53:57 | 2026-09-25 18:53:57 INFO SDAlgorithmBase::deconvolve [tst.awp2:P1] iters=20->20 [0], model=0->0, peakres=0.00644565->0.00644565, Reached cyclethreshold. |
| 25-Sep-2026 14:53:57 | 2026-09-25 18:53:57 INFO SDAlgorithmBase::deconvolve [tst.awp2] Total model flux (over all planes) : 0.406384 Peak Residual (over all planes) : 0.0499293 in C0:P0 |
| 25-Sep-2026 14:53:57 | 2026-09-25 18:53:57 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 20 iterations. |
| 25-Sep-2026 14:53:57 | 2026-09-25 18:53:57 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 25-Sep-2026 14:54:11 | |
| 25-Sep-2026 14:54:33 | 0%....10....20....30....40....50....60....70....80....90....100% |
| 25-Sep-2026 14:54:37 | 2026-09-25 18:54:37 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.055741, over full image : 0.055741 |
| 25-Sep-2026 14:54:37 | 2026-09-25 18:54:37 INFO tclean::::casa Reached global stopping criterion : iteration limit |
| 25-Sep-2026 14:54:37 | 2026-09-25 18:54:37 INFO tclean::::casa getSummary call: fullsummary=False |
| 25-Sep-2026 14:54:37 | 2026-09-25 18:54:37 INFO SDAlgorithmBase::restore [tst.awp2] : Restoring model image. |
| 25-Sep-2026 14:54:37 | 2026-09-25 18:54:37 INFO SIImageStore::restore Beam for chan : 0 : 5.34537 arcsec, 4.36548 arcsec, -84.5682 deg |
| 25-Sep-2026 14:54:37 | 2026-09-25 18:54:37 INFO SIImageStore::restore Beam for chan : 0 : 5.34537 arcsec, 4.36548 arcsec, -84.5682 deg |
| 25-Sep-2026 14:54:37 | 2026-09-25 18:54:38 INFO task_tclean::SDAlgorithmBase::pbcor [tst.awp2] : Applying PB correction |
| 25-Sep-2026 14:54:38 | 2026-09-25 18:54:39 INFO tclean::::casa Searching for images with prefix 'tst.awp2'... Found these, writing history into them: ['tst.awp2.sumwt', 'tst.awp2.psf', 'tst.awp2.mask', 'tst.awp2.model', 'tst.awp2.residual', 'tst.awp2.weight', 'tst.awp2.image', 'tst.awp2.image.pbcor', 'tst.awp2.pb'] |
| 25-Sep-2026 14:54:38 | 2026-09-25 18:54:39 INFO tclean::::casa Task tclean complete. Start time: 2026-09-25 18:50:46.560436 End time: 2026-09-25 18:54:38.758858 |
| 25-Sep-2026 14:54:38 | 2026-09-25 18:54:39 INFO tclean::::casa ##### End Task: tclean ##### |
| 25-Sep-2026 14:54:38 | 2026-09-25 18:54:39 INFO tclean::::casa ########################################## |
| 25-Sep-2026 14:54:38 | 2026-09-25 18:54:39 INFO name:: No table opened. |
| 25-Sep-2026 14:54:38 | 2026-09-25 18:54:39 INFO showcache:: The Table Cache is empty. |
| 25-Sep-2026 14:54:38 | 2026-09-25 18:54:39 INFO tclean::::casa [ checkall ] |
| 25-Sep-2026 14:54:38 | 2026-09-25 18:54:39 INFO tclean::::casa+ [ check_ims ] Image made : ['tst.awp2.image'] = [True] ( Pass : should all be True ) |
| 25-Sep-2026 14:54:38 | 2026-09-25 18:54:39 INFO tclean::::casa+ All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords) |
| 25-Sep-2026 14:54:38 | 2026-09-25 18:54:39 INFO tclean::::casa+ [check_history] All expected history entries found. (Pass) |
| 25-Sep-2026 14:54:38 | 2026-09-25 18:54:39 INFO tclean::::casa+ [ check_pix_val ] tst.awp2.pb : Value is 0.6809056401252747 at [323, 858, 0, 0] ( Pass : should be 0.654 , Epsilon: 0.05) |
| 25-Sep-2026 14:54:38 | 2026-09-25 18:54:39 INFO tclean::::casa+ [ check_pix_val ] tst.awp2.image.pbcor : Value is 0.6786918044090271 at [323, 858, 0, 0] ( Pass : should be 0.7 , Epsilon: 0.05) |
| 25-Sep-2026 14:54:38 | 2026-09-25 18:54:39 INFO tclean::::casa+ [ check_pix_val ] tst.awp2.image.pbcor : Value is -0.009907497093081474 at [323, 858, 1, 0] ( Pass : should be -0.01 , Epsilon: 0.05) |
| 25-Sep-2026 14:54:38 | [ checkall ] |
| 25-Sep-2026 14:54:38 | [ check_ims ] Image made : ['tst.awp2.image'] = [True] ( Pass : should all be True ) |
| 25-Sep-2026 14:54:38 | All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords) |
| 25-Sep-2026 14:54:38 | [check_history] All expected history entries found. (Pass) |
| 25-Sep-2026 14:54:38 | [ check_pix_val ] tst.awp2.pb : Value is 0.6809056401252747 at [323, 858, 0, 0] ( Pass : should be 0.654 , Epsilon: 0.05) |
| 25-Sep-2026 14:54:38 | [ check_pix_val ] tst.awp2.image.pbcor : Value is 0.6786918044090271 at [323, 858, 0, 0] ( Pass : should be 0.7 , Epsilon: 0.05) |
| 25-Sep-2026 14:54:38 | [ check_pix_val ] tst.awp2.image.pbcor : Value is -0.009907497093081474 at [323, 858, 1, 0] ( Pass : should be -0.01 , Epsilon: 0.05) |
| 25-Sep-2026 14:54:38 | |
| 25-Sep-2026 14:54:39 | .2026-09-25 18:54:39 INFO tclean::::casa ########################################## |
| 25-Sep-2026 14:54:39 | 2026-09-25 18:54:39 INFO tclean::::casa ##### Begin Task: tclean ##### |
| 25-Sep-2026 14:54:39 | 2026-09-25 18:54:39 INFO tclean::::casa tclean( vis='refim_point_wterm_vlad.ms', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst.wyes', imsize=2048, cell='10.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='wproject', facets=1, psfphasecenter='', wprojplanes=16, vptable='', mosweight=True, aterm=True, psterm=False, wbawp=True, conjbeams=False, cfcache='', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=-0.1, normtype='flatnoise', deconvolver='hogbom', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=False, outlierfile='', weighting='uniform', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.0, uvtaper=[], niter=0, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='none', calcres=True, calcpsf=True, psfcutoff=0.35, parallel=False ) |
| 25-Sep-2026 14:54:39 | 2026-09-25 18:54:39 INFO tclean::::casa Verifying Input Parameters |
| 25-Sep-2026 14:54:39 | 2026-09-25 18:54:39 INFO SynthesisImagerVi2::selectData MS : refim_point_wterm_vlad.ms | [Opened in readonly mode] |
| 25-Sep-2026 14:54:39 | 2026-09-25 18:54:39 INFO SynthesisImagerVi2::selectData NRows selected : 15093 |
| 25-Sep-2026 14:54:39 | 2026-09-25 18:54:39 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.wyes] : |
| 25-Sep-2026 14:54:39 | 2026-09-25 18:54:39 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.wyes] : |
| 25-Sep-2026 14:54:39 | 2026-09-25 18:54:39 INFO SynthesisImagerVi2::defineImage Impars: start |
| 25-Sep-2026 14:54:39 | 2026-09-25 18:54:39 INFO SynthesisImagerVi2::defineImage Shape: [2048, 2048, 1, 1] Spectral: [9.99981e+08] at [0] with increment [1.00218e+06] |
| 25-Sep-2026 14:54:39 | 2026-09-25 18:54:39 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst.wyes] with ftmachine : wprojectft |
| 25-Sep-2026 14:54:39 | 2026-09-25 18:54:39 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.3842 GB. Available mem.: 10.89 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 1. |
| 25-Sep-2026 14:54:39 | 2026-09-25 18:54:39 INFO SynthesisImagerVi2::weight() Set imaging weights : Uniform weighting: sidelobes will be suppressed over full image |
| 25-Sep-2026 14:54:39 | 2026-09-25 18:54:39 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst.wyes] : hogbom |
| 25-Sep-2026 14:54:39 | 2026-09-25 18:54:39 INFO SynthesisImager::makePSF ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 25-Sep-2026 14:54:39 | 2026-09-25 18:54:40 INFO WPConvFunc::findConvFunction W projection using 16 planes |
| 25-Sep-2026 14:54:39 | 2026-09-25 18:54:40 INFO WPConvFunc::findConvFunction Using maximum possible W = 5156.62 (wavelengths) |
| 25-Sep-2026 14:54:39 | 2026-09-25 18:54:40 INFO WPConvFunc::findConvFunction Typical wavelength = 0.299798 (m) |
| 25-Sep-2026 14:54:39 | 2026-09-25 18:54:40 INFO WPConvFunc::findConvFunction Scaling in W (at maximum W) = 22.9183 wavelengths per pixel |
| 25-Sep-2026 14:54:45 | 2026-09-25 18:54:45 INFO WPConvFunc::findConvFunction Convolution support = [16, 16, 20, 20, 24, 32, 36, 44, 52, 64, 72, 84, 96, 112, 124, 140] pixels in Fourier plane |
| 25-Sep-2026 14:54:45 | 2026-09-25 18:54:45 INFO WPConvFunc::findConvFunction Memory used in gridding function = 2 MB from maximum 15884 MB |
| 25-Sep-2026 14:54:47 | 2026-09-25 18:54:48 INFO SIImageStore::calcSensitivity [tst.wyes] Theoretical sensitivity (Jy/bm):0.00632763 |
| 25-Sep-2026 14:54:47 | 2026-09-25 18:54:48 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.051383 |
| 25-Sep-2026 14:54:47 | 2026-09-25 18:54:48 INFO SIImageStore::printBeamSet Beam : 85.3971 arcsec, 71.2504 arcsec, -89.0441 deg |
| 25-Sep-2026 14:54:47 | 2026-09-25 18:54:48 INFO task_tclean::SynthesisImagerVi2::makePrimaryBeam vi2 : Evaluating Primary Beam model onto image grid(s) |
| 25-Sep-2026 14:54:48 | 2026-09-25 18:54:48 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO task_tclean::SDAlgorithmBase::restore [tst.wyes] : Restoring model image. |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 WARN task_tclean::SIImageStore::restore (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SIImageStore.cc, line 2353) Restoring with an empty model image. Only residuals will be processed to form the output restored image. |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO task_tclean::SIImageStore::restore Beam for chan : 0 : 85.3971 arcsec, 71.2504 arcsec, -89.0441 deg |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO tclean::::casa Searching for images with prefix 'tst.wyes'... Found these, writing history into them: ['tst.wyes.residual', 'tst.wyes.model', 'tst.wyes.image', 'tst.wyes.psf', 'tst.wyes.sumwt', 'tst.wyes.pb'] |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO tclean::::casa Task tclean complete. Start time: 2026-09-25 18:54:39.071090 End time: 2026-09-25 18:54:50.801888 |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO tclean::::casa ##### End Task: tclean ##### |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO tclean::::casa ########################################## |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO name:: No table opened. |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO showcache:: The Table Cache is empty. |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO tclean::::casa [ checkall ] |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO tclean::::casa+ [ check_ims ] Image made : ['tst.wyes.image'] = [True] ( Pass : should all be True ) |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO tclean::::casa+ All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords) |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO tclean::::casa+ [check_history] All expected history entries found. (Pass) |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO tclean::::casa+ [ check_pix_val ] tst.wyes.psf : Value is 1.0 at [1024, 1024, 0, 0] ( Pass : should be 1.0 , Epsilon: 0.05) |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO tclean::::casa+ [ check_pix_val ] tst.wyes.image : Value is 0.9963290691375732 at [1158, 1384, 0, 0] ( Pass : should be 1.0 , Epsilon: 0.05) |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO tclean::::casa+ [check_tfmask] T/F mask name for tst.wyes.image is : ['T'] (Pass : should be ['T']) |
| 25-Sep-2026 14:54:50 | [check_tfmask] T/F mask name for tst.wyes.image is : ['T'] (Pass : should be ['T']) |
| 25-Sep-2026 14:54:50 | |
| 25-Sep-2026 14:54:50 | .2026-09-25 18:54:51 INFO tclean::::casa ########################################## |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO tclean::::casa ##### Begin Task: tclean ##### |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO tclean::::casa tclean( vis='refim_point_wterm_vlad.ms', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst.wp.facet', imsize=2048, cell='10.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='widefield', facets=4, psfphasecenter='', wprojplanes=4, vptable='', mosweight=True, aterm=True, psterm=False, wbawp=True, conjbeams=False, cfcache='', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=-0.1, normtype='flatnoise', deconvolver='hogbom', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=False, outlierfile='', weighting='uniform', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.0, uvtaper=[], niter=0, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='none', calcres=True, calcpsf=True, psfcutoff=0.35, parallel=False ) |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO tclean::::casa Verifying Input Parameters |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO SynthesisImagerVi2::selectData MS : refim_point_wterm_vlad.ms | [Opened in readonly mode] |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO SynthesisImagerVi2::selectData NRows selected : 15093 |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.wp.facet] : |
| 25-Sep-2026 14:54:50 | 2026-09-25 18:54:51 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.wp.facet] : |
| 25-Sep-2026 14:54:51 | 2026-09-25 18:54:51 INFO SynthesisImagerVi2::defineImage Impars: start |
| 25-Sep-2026 14:54:51 | 2026-09-25 18:54:51 INFO SynthesisImagerVi2::defineImage Shape: [2048, 2048, 1, 1] Spectral: [9.99981e+08] at [0] with increment [1.00218e+06] |
| 25-Sep-2026 14:54:51 | 2026-09-25 18:54:51 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst.wp.facet] with ftmachine : wprojectft |
| 25-Sep-2026 14:54:51 | 2026-09-25 18:54:51 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.3842 GB. Available mem.: 10.89 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 1. |
| 25-Sep-2026 14:54:51 | 2026-09-25 18:54:51 INFO SynthesisImager::createFacetImageStoreList Creating 16 facets in total |
| 25-Sep-2026 14:54:51 | 2026-09-25 18:54:51 INFO SynthesisImagerVi2::weight() Set imaging weights : Uniform weighting: sidelobes will be suppressed over full image |
| 25-Sep-2026 14:54:51 | 2026-09-25 18:54:51 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst.wp.facet] : hogbom |
| 25-Sep-2026 14:54:51 | 2026-09-25 18:54:51 INFO SynthesisImager::makePSF ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 25-Sep-2026 14:54:51 | 2026-09-25 18:54:51 INFO WPConvFunc::findConvFunction W projection using 4 planes |
| 25-Sep-2026 14:54:51 | 2026-09-25 18:54:51 INFO WPConvFunc::findConvFunction Using maximum possible W = 5156.62 (wavelengths) |
| 25-Sep-2026 14:54:51 | 2026-09-25 18:54:51 INFO WPConvFunc::findConvFunction Typical wavelength = 0.299798 (m) |
| 25-Sep-2026 14:54:51 | 2026-09-25 18:54:51 INFO WPConvFunc::findConvFunction Scaling in W (at maximum W) = 572.958 wavelengths per pixel |
| 25-Sep-2026 14:54:51 | 2026-09-25 18:54:51 INFO WPConvFunc::findConvFunction Convolution support = [16, 16, 20, 24] pixels in Fourier plane |
| 25-Sep-2026 14:54:51 | 2026-09-25 18:54:51 INFO WPConvFunc::findConvFunction Memory used in gridding function = 0 MB from maximum 15884 MB |
| 25-Sep-2026 14:54:53 | 2026-09-25 18:54:53 INFO SIImageStore::calcSensitivity [tst.wp.facet] Theoretical sensitivity (Jy/bm):f0:0.00632786 f4:0.00632786 f8:0.00632785 f12:0.00632785 f1:0.00632786 f5:0.00632786 f9:0.00632785 f13:0.00632785 f2:0.00632786 f6:0.00632786 f10:0.00632785 f14:0.00632785 f3:0.00632786 f7:0.00632786 f11:0.00632785 f15:0.00632785 |
| 25-Sep-2026 14:54:53 | 2026-09-25 18:54:53 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.052872 |
| 25-Sep-2026 14:54:53 | 2026-09-25 18:54:53 INFO SIImageStore::printBeamSet Beam : 85.4563 arcsec, 71.4166 arcsec, -88.2567 deg |
| 25-Sep-2026 14:54:53 | 2026-09-25 18:54:53 INFO task_tclean::SynthesisImagerVi2::makePrimaryBeam vi2 : Evaluating Primary Beam model onto image grid(s) |
| 25-Sep-2026 14:54:53 | 2026-09-25 18:54:54 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 25-Sep-2026 14:54:55 | 2026-09-25 18:54:56 INFO task_tclean::SDAlgorithmBase::restore [tst.wp.facet] : Restoring model image. |
| 25-Sep-2026 14:54:55 | 2026-09-25 18:54:56 WARN task_tclean::SIImageStore::restore (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SIImageStore.cc, line 2353) Restoring with an empty model image. Only residuals will be processed to form the output restored image. |
| 25-Sep-2026 14:54:55 | 2026-09-25 18:54:56 INFO task_tclean::SIImageStore::restore Beam for chan : 0 : 85.4563 arcsec, 71.4166 arcsec, -88.2567 deg |
| 25-Sep-2026 14:54:55 | 2026-09-25 18:54:56 INFO tclean::::casa Searching for images with prefix 'tst.wp.facet'... Found these, writing history into them: ['tst.wp.facet.image', 'tst.wp.facet.residual', 'tst.wp.facet.psf', 'tst.wp.facet.sumwt', 'tst.wp.facet.pb', 'tst.wp.facet.model'] |
| 25-Sep-2026 14:54:55 | 2026-09-25 18:54:56 INFO tclean::::casa Task tclean complete. Start time: 2026-09-25 18:54:50.888964 End time: 2026-09-25 18:54:55.933772 |
| 25-Sep-2026 14:54:55 | 2026-09-25 18:54:56 INFO tclean::::casa ##### End Task: tclean ##### |
| 25-Sep-2026 14:54:55 | 2026-09-25 18:54:56 INFO tclean::::casa ########################################## |
| 25-Sep-2026 14:54:55 | 2026-09-25 18:54:56 INFO name:: No table opened. |
| 25-Sep-2026 14:54:55 | 2026-09-25 18:54:56 INFO showcache:: The Table Cache is empty. |
| 25-Sep-2026 14:54:55 | 2026-09-25 18:54:56 INFO tclean::::casa [ checkall ] |
| 25-Sep-2026 14:54:55 | 2026-09-25 18:54:56 INFO tclean::::casa+ [ check_ims ] Image made : ['tst.wp.facet.image'] = [True] ( Pass : should all be True ) |
| 25-Sep-2026 14:54:55 | 2026-09-25 18:54:56 INFO tclean::::casa+ All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords) |
| 25-Sep-2026 14:54:55 | 2026-09-25 18:54:56 INFO tclean::::casa+ [check_history] All expected history entries found. (Pass) |
| 25-Sep-2026 14:54:55 | 2026-09-25 18:54:56 INFO tclean::::casa+ [ check_pix_val ] tst.wp.facet.psf : Value is 1.0 at [1024, 1024, 0, 0] ( Pass : should be 1.0 , Epsilon: 0.05) |
| 25-Sep-2026 14:54:55 | 2026-09-25 18:54:56 INFO tclean::::casa+ [ check_pix_val ] tst.wp.facet.image : Value is 0.9984886050224304 at [1158, 1384, 0, 0] ( Pass : should be 1.0 , Epsilon: 0.05) |
| 25-Sep-2026 14:54:55 | . |
| 25-Sep-2026 14:54:55 | ====================================================================== |
| 25-Sep-2026 14:54:55 | FAIL [1407.676s]: test_widefield_mvc_squint_awp2 (__main__.test_widefield.test_widefield_mvc_squint_awp2) |
| 25-Sep-2026 14:54:55 | [wproject] Test_Widefield_wproj : W-Projection with squint using the AWP2 gridder |
| 25-Sep-2026 14:54:55 | ---------------------------------------------------------------------- |
| 25-Sep-2026 14:54:55 | Traceback (most recent call last): |
| 25-Sep-2026 14:54:55 | File "/home/casatest/casa6/casatasks/tests/casashell_tests/test_task_tclean_casashell.py", line 4339, in test_widefield_mvc_squint_awp2 |
| 25-Sep-2026 14:54:55 | self.assertTrue(self.check_final(report)) |
| 25-Sep-2026 14:54:55 | AssertionError: False is not true |
| 25-Sep-2026 14:54:55 | |
| 25-Sep-2026 14:54:55 | ---------------------------------------------------------------------- |
| 25-Sep-2026 14:54:55 | Ran 341 tests in 8735.723s |
| 25-Sep-2026 14:54:55 | |
| 25-Sep-2026 14:54:55 | FAILED (failures=1, skipped=17) |
| 25-Sep-2026 14:54:55 | |
| 25-Sep-2026 14:54:55 | Generating XML reports... |
| 25-Sep-2026 14:54:58 | CASA exits with a non-zero status : system exit called |
| 25-Sep-2026 14:55:01 | total 779068 |
| 25-Sep-2026 14:55:01 | drwxr-xr-x 5 casaci casaci 4096 Sep 14 02:07 casa-CAS-14882-1-py3.12.el8 |
| 25-Sep-2026 14:55:01 | -rw-r--r-- 1 casaci 15001 797748744 Sep 25 16:25 casa-CAS-14882-1-py3.12.el8.tar.xz |
| 25-Sep-2026 14:55:01 | drwxr-xr-x 2 casaci root 4096 Sep 25 18:55 logs |
| 25-Sep-2026 14:55:01 | drwxr-xr-x 2 casaci root 4096 Sep 25 18:55 xml |
| 25-Sep-2026 14:55:02 | total 7060 |
| 25-Sep-2026 14:55:02 | -rw-r--r-- 1 root root 7228026 Sep 25 18:55 test_task_tclean_casashell_out.log |
| 25-Sep-2026 14:55:02 | total 136 |
| 25-Sep-2026 14:55:02 | -rw-r--r-- 1 root root 136414 Sep 25 18:55 test_task_tclean_casashell.py.xml |
| 25-Sep-2026 14:55:02 | Finished task 'Test wheel as casatest' with result: Success |
| 25-Sep-2026 14:55:02 | Starting task 'Parse tests' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit' |
| 25-Sep-2026 14:55:03 | Parsing test results under /export/home/cbt-el7-1/bamboo-home/xml-data/build-dir/CASA-REDTFX30-TTML2C... |
| 25-Sep-2026 14:55:04 | Failing task since 1 failing test cases were found. |
| 25-Sep-2026 14:55:04 | Finished task 'Parse tests' with result: Failed |
| 25-Sep-2026 14:55:04 | Running post build plugin 'Docker Container Cleanup' |
| 25-Sep-2026 14:55:05 | Beginning to execute external process for build 'CASA - Release Engineering Dev Test Full XML 3.12 - CAS-14882 - Test Tasks Many Linux 2.28 Remove Casatasks import #8 (CASA-REDTFX30-TTML2C-8)' ... running command line: /usr/bin/docker rm -f wheel-container-test ... in: /export/home/cbt-el7-1/bamboo-home/xml-data/build-dir/CASA-REDTFX30-TTML2C |
| 25-Sep-2026 14:55:07 | wheel-container-test |
| 25-Sep-2026 14:55:07 | Running post build plugin 'NCover Results Collector' |
| 25-Sep-2026 14:55:07 | Running post build plugin 'Build Results Label Collector' |
| 25-Sep-2026 14:55:08 | Running post build plugin 'Clover Results Collector' |
| 25-Sep-2026 14:55:08 | Running post build plugin 'npm Cache Cleanup' |
| 25-Sep-2026 14:55:08 | Running post build plugin 'Artifact Copier' |
| 25-Sep-2026 14:55:08 | Publishing an artifact: Log Files |
| 25-Sep-2026 14:55:08 | Finished publishing of artifact Non required job artifact Http Compression On : [Log Files], patterns: [*.log] anchored at: [wheeldirectory/logs/] in 479.7 ms |
| 25-Sep-2026 14:55:08 | Publishing an artifact: XML Files |
| 25-Sep-2026 14:55:08 | Finished publishing of artifact Non required job artifact Http Compression On : [XML Files], patterns: [*.xml] anchored at: [wheeldirectory/xml/] in 53.42 ms |
| 25-Sep-2026 14:55:08 | Publishing an artifact: Workdir |
| 25-Sep-2026 14:55:08 | Failing as no matching files has been found and empty artifacts are not allowed. |
| 25-Sep-2026 14:55:08 | Unable to publish artifact [Workdir]: |
| 25-Sep-2026 14:55:08 | The artifact hasn't been successfully published after 57.48 ms |
| 25-Sep-2026 14:55:08 | Finalising the build... |
| 25-Sep-2026 14:55:08 | Stopping timer. |
| 25-Sep-2026 14:55:08 | Build CASA-REDTFX30-TTML2C-8 completed. |
| 25-Sep-2026 14:55:10 | Running on server: post build plugin 'Build Hanging Detection Configuration' |
| 25-Sep-2026 14:55:10 | Running on server: post build plugin 'NCover Results Collector' |
| 25-Sep-2026 14:55:10 | Running on server: post build plugin 'Build Labeller' |
| 25-Sep-2026 14:55:10 | Running on server: post build plugin 'Clover Delta Calculator' |
| 25-Sep-2026 14:55:10 | Running on server: post build plugin 'Maven Dependencies Postprocessor' |
| 25-Sep-2026 14:55:10 | All post build plugins have finished |
| 25-Sep-2026 14:55:10 | Generating build results summary... |
| 25-Sep-2026 14:55:10 | Saving build results to disk... |
| 25-Sep-2026 14:55:10 | Store variable context... |
| 25-Sep-2026 14:55:10 | Finished building CASA-REDTFX30-TTML2C-8. |