Build: #3 did not complete
Job: Test MPI Task Tclean Many Linux 2.28 Rocky 9.5 Docker did not complete
Build log
The build generated 69,500 lines of output. The output is too long and has been truncated to the last 1,000 lines. Download or view full build log.
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:21 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-2 Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:21 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:21 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst0.workdirectory/tst0.n3] : |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:21 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst0.workdirectory/tst0.n3] : |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:21 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Impars: start |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:21 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:21 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Set Gridding options for [/home/casatest/work/test_task_tclean/tst0.workdirectory/tst0.n3] with ftmachine : gridft |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:21 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-3 Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:22 INFO tclean::::casa ...done |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:24 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:24 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-1 Set imaging weights : Natural weighting |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:25 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-2 Set imaging weights : Natural weighting |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:25 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-3 Set imaging weights : Natural weighting |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:25 INFO tclean::::casa ...done |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:25 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst0] : hogbom |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:25 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:26 INFO tclean::::casa ...done |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:26 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:26 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-1 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:27 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-2 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:27 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-3 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:27 INFO tclean::::casa ...done |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:27 INFO SynthesisNormalizer::gatherImages Gather psf,weight images : [/home/casatest/work/test_task_tclean/tst0.workdirectory/tst0.n1, /home/casatest/work/test_task_tclean/tst0.workdirectory/tst0.n2, /home/casatest/work/test_task_tclean/tst0.workdirectory/tst0.n3] onto :tst0 |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:28 INFO SIImageStore::calcSensitivity [tst0] Theoretical sensitivity (Jy/bm):0.00124653 |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:28 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.003536 |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:28 INFO SIImageStore::printBeamSet Beam : 52.9302 arcsec, 49.1475 arcsec, -87.3944 deg |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:28 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:28 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::makePrimaryBeam::MPIServer-1 vi2 : Evaluating Primary Beam model onto image grid(s) |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:29 INFO tclean::::casa ...done |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:29 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : tst0 to all nodes :[/home/casatest/work/test_task_tclean/tst0.workdirectory/tst0.n1, /home/casatest/work/test_task_tclean/tst0.workdirectory/tst0.n2, /home/casatest/work/test_task_tclean/tst0.workdirectory/tst0.n3] |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:29 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst0.model does not exist. No initial prediction will be done |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:29 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst0.model does not exist. No initial prediction will be done |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:29 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst0.model does not exist. No initial prediction will be done |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:29 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:29 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:29 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:29 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:29 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:30 INFO tclean::::casa ...done |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:30 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst0.workdirectory/tst0.n1, /home/casatest/work/test_task_tclean/tst0.workdirectory/tst0.n2, /home/casatest/work/test_task_tclean/tst0.workdirectory/tst0.n3] onto :tst0 |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:30 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 1.12501 |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:30 INFO SynthesisDeconvolver::setupMask [tst0] Initializing new mask to 1.0 for the full image |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:30 INFO SynthesisDeconvolver::setupMask [tst0] Number of pixels in the clean mask : 10000 out of a total of 10000 pixels. [ 100 % ] |
| 20-Apr-2026 17:38:29 | 2026-04-20 17:38:30 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 1.12501, over full image : 1.12501 |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:30 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 10, 'cyclethreshold': 0.1590396612882614, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:30 INFO SDAlgorithmBase::deconvolve [tst0] Run Hogbom minor-cycle | CycleThreshold=0.15904, CycleNiter=10, Gain=0.1 |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:30 INFO SDAlgorithmBase::deconvolve [tst0] iters=0->10 [10], model=0->0.771973, peakres=1.12501->0.353041, Reached cycleniter. |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:30 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 10 iterations. |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:30 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : tst0 to all nodes :[/home/casatest/work/test_task_tclean/tst0.workdirectory/tst0.n1, /home/casatest/work/test_task_tclean/tst0.workdirectory/tst0.n2, /home/casatest/work/test_task_tclean/tst0.workdirectory/tst0.n3] |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:30 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst0.model to /home/casatest/work/test_task_tclean/tst0.workdirectory/tst0.n1.model |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:30 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst0.model to /home/casatest/work/test_task_tclean/tst0.workdirectory/tst0.n2.model |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:30 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst0.model to /home/casatest/work/test_task_tclean/tst0.workdirectory/tst0.n3.model |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:30 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:30 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:30 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:30 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:30 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:31 INFO tclean::::casa ...done |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:31 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst0.workdirectory/tst0.n1, /home/casatest/work/test_task_tclean/tst0.workdirectory/tst0.n2, /home/casatest/work/test_task_tclean/tst0.workdirectory/tst0.n3] onto :tst0 |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:31 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.35304, over full image : 0.35304 |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:31 INFO tclean::::casa Reached global stopping criterion : iteration limit |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:31 INFO tclean::::casa getSummary call: fullsummary=False |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:31 INFO SDAlgorithmBase::restore [tst0] : Restoring model image. |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:31 INFO SIImageStore::restore Beam for chan : 0 : 52.9302 arcsec, 49.1475 arcsec, -87.3944 deg |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:39 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:40 INFO ::casa::MPIServer-1 node 1 has completed its job |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:40 INFO ::casa::MPIServer-3 node 3 has completed its job |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:40 INFO ::casa::MPIServer-2 node 2 has completed its job |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:40 INFO tclean::::casa ...done |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:40 INFO tclean::::casa Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed. |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:40 INFO tclean::::casa Searching for images with prefix 'tst0'... Found these, writing history into them: ['tst0.psf', 'tst0.sumwt', 'tst0.pb', 'tst0.residual', 'tst0.mask', 'tst0.model', 'tst0.image'] |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:41 INFO tclean::::casa Task tclean complete. Start time: 2026-04-20 17:38:14.467401 End time: 2026-04-20 17:38:40.662805 |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:41 INFO tclean::::casa ##### End Task: tclean ##### |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:41 INFO tclean::::casa ########################################## |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:41 INFO tclean::::casa ########################################## |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:41 INFO tclean::::casa ##### Begin Task: tclean ##### |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:41 INFO tclean::::casa tclean( vis='refim_twochan.ms', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst', imsize=100, cell='8.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='standard', facets=1, psfphasecenter='', wprojplanes=1, vptable='', mosweight=True, aterm=True, psterm=False, wbawp=True, conjbeams=False, cfcache='', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=0.2, normtype='flatnoise', deconvolver='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, uvtaper=[''], niter=10, 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=True ) |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:41 INFO tclean::::casa Verifying Input Parameters |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:43 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 2 |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:43 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 3 |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:43 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 1 |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:44 INFO tclean::::casa setupCluster, Setting up 3 engines. |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:44 INFO SynthesisUtilMethods::continuumDataPartition |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:44 INFO SynthesisUtilMethods::continuumDataPartition + Rows = 112323 168480 [P][M]: 0:2 ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:44 INFO tclean::::casa Partitioned Selection : {'0': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_twochan.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 1 && ROWNUMBER() <= 56161', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '1': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_twochan.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '2': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_twochan.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480', 'timestr': '', 'usescratch': False, 'uvdist': ''}}} |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:44 INFO SynthesisImagerVi2::selectData MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:38:44 | 2026-04-20 17:38:44 INFO SynthesisImagerVi2::selectData NRows selected : 168480 |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:45 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst] : |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:45 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst] : |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:45 INFO SynthesisImagerVi2::defineImage Impars: start |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:45 INFO SynthesisImagerVi2::defineImage Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:45 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst] with ftmachine : gridft |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:45 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:45 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:46 INFO tclean::::casa ...done |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:46 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:46 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:46 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:46 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:46 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 Selecting via TaQL : ROWNUMBER() >= 1 && ROWNUMBER() <= 56161 | NRows selected : 56161 |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:46 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 Selecting via TaQL : ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 | NRows selected : 56158 |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:46 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 Selecting via TaQL : ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322 | NRows selected : 56161 |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:47 INFO tclean::::casa ...done |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.workdirectory/tst.n1] : |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.workdirectory/tst.n1] : |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Impars: start |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Set Gridding options for [/home/casatest/work/test_task_tclean/tst.workdirectory/tst.n1] with ftmachine : gridft |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-1 Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.workdirectory/tst.n2] : |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.workdirectory/tst.n2] : |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Impars: start |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Set Gridding options for [/home/casatest/work/test_task_tclean/tst.workdirectory/tst.n2] with ftmachine : gridft |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-2 Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:48 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.workdirectory/tst.n3] : |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.workdirectory/tst.n3] : |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Impars: start |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Set Gridding options for [/home/casatest/work/test_task_tclean/tst.workdirectory/tst.n3] with ftmachine : gridft |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-3 Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:49 INFO tclean::::casa ...done |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:51 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:51 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-1 Set imaging weights : Uniform weighting: sidelobes will be suppressed over full image |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:51 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-3 Set imaging weights : Uniform weighting: sidelobes will be suppressed over full image |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:51 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-2 Set imaging weights : Uniform weighting: sidelobes will be suppressed over full image |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:52 INFO tclean::::casa ...done |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:52 INFO tclean::::casa Gathering/Merging/Scattering Weight Density for PSF generation |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:52 INFO tclean::::casa ****************************************************** |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:52 INFO tclean::::casa gather and scatter now |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:52 INFO tclean::::casa ****************************************************** |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:52 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:53 INFO tclean::::casa ...done |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:54 INFO SynthesisNormalizer::scatterWeightDensity Send the gridded weight from : tst to all nodes :[/home/casatest/work/test_task_tclean/tst.workdirectory/tst.n1, /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n2, /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n3] |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:54 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:55 INFO tclean::::casa ...done |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:55 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst] : hogbom |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:55 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:56 INFO tclean::::casa ...done |
| 20-Apr-2026 17:38:55 | 2026-04-20 17:38:56 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:56 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-1 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:56 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-3 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:56 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-2 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:57 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:57 INFO SynthesisNormalizer::gatherImages Gather psf,weight images : [/home/casatest/work/test_task_tclean/tst.workdirectory/tst.n1, /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n2, /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n3] onto :tst |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:57 INFO SIImageStore::calcSensitivity [tst] Theoretical sensitivity (Jy/bm):0.0210912 |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:57 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.003519 |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:57 INFO SIImageStore::printBeamSet Beam : 20.9721 arcsec, 20.4877 arcsec, -5.90027 deg |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:57 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:57 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::makePrimaryBeam::MPIServer-1 vi2 : Evaluating Primary Beam model onto image grid(s) |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:58 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:58 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : tst to all nodes :[/home/casatest/work/test_task_tclean/tst.workdirectory/tst.n1, /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n2, /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n3] |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:58 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst.model does not exist. No initial prediction will be done |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:58 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst.model does not exist. No initial prediction will be done |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:58 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst.model does not exist. No initial prediction will be done |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:58 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:58 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:58 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:58 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:58 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:59 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:59 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst.workdirectory/tst.n1, /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n2, /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n3] onto :tst |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:59 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 0.837282 |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:59 INFO SynthesisDeconvolver::setupMask [tst] Initializing new mask to 1.0 for the full image |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:59 INFO SynthesisDeconvolver::setupMask [tst] Number of pixels in the clean mask : 10000 out of a total of 10000 pixels. [ 100 % ] |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:59 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.837282, over full image : 0.837282 |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:59 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 10, 'cyclethreshold': 0.10722125321626663, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:59 INFO SDAlgorithmBase::deconvolve [tst] Run Hogbom minor-cycle | CycleThreshold=0.107221, CycleNiter=10, Gain=0.1 |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:59 INFO SDAlgorithmBase::deconvolve [tst] iters=0->10 [10], model=0->0.574534, peakres=0.837282->0.262748, Reached cycleniter. |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:59 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 10 iterations. |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:59 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : tst to all nodes :[/home/casatest/work/test_task_tclean/tst.workdirectory/tst.n1, /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n2, /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n3] |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:59 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst.model to /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n1.model |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:59 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst.model to /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n2.model |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:59 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst.model to /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n3.model |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:59 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:38:59 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:39:00 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:39:00 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:39:00 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:39:00 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:39:00 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst.workdirectory/tst.n1, /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n2, /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n3] onto :tst |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:39:01 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.262747, over full image : 0.262747 |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:39:01 INFO tclean::::casa Reached global stopping criterion : iteration limit |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:39:01 INFO tclean::::casa getSummary call: fullsummary=False |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:39:01 INFO SDAlgorithmBase::restore [tst] : Restoring model image. |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:39:01 INFO SIImageStore::restore Beam for chan : 0 : 20.9721 arcsec, 20.4877 arcsec, -5.90027 deg |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:39:10 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:39:10 INFO ::casa::MPIServer-1 node 1 has completed its job |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:39:10 INFO ::casa::MPIServer-2 node 2 has completed its job |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:39:10 INFO ::casa::MPIServer-3 node 3 has completed its job |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:39:11 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:10 | 2026-04-20 17:39:11 INFO tclean::::casa Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed. |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:11 INFO tclean::::casa Searching for images with prefix 'tst'... Found these, writing history into them: ['tst0.psf', 'tst0.sumwt', 'tst0.pb', 'tst0.residual', 'tst0.mask', 'tst0.model', 'tst0.image', 'tst.gridwt_temp', 'tst.psf', 'tst.sumwt', 'tst.pb', 'tst.residual', 'tst.mask', 'tst.model', 'tst.image'] |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:11 INFO tclean::::casa Task tclean complete. Start time: 2026-04-20 17:38:40.670214 End time: 2026-04-20 17:39:11.072109 |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:11 INFO tclean::::casa ##### End Task: tclean ##### |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:11 INFO tclean::::casa ########################################## |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:11 INFO name:: No table opened. |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:11 INFO showcache:: The Table Cache is empty. |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:11 INFO tclean::::casa ########################################## |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:11 INFO tclean::::casa ##### Begin Task: tclean ##### |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:11 INFO tclean::::casa tclean( vis='refim_twochan.ms', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst2', imsize=100, cell='8.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='standard', facets=1, psfphasecenter='', wprojplanes=1, vptable='', mosweight=True, aterm=True, psterm=False, wbawp=True, conjbeams=False, cfcache='', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=0.2, normtype='flatnoise', deconvolver='hogbom', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=False, outlierfile='', weighting='briggs', robust=-2.0, noise='1.0Jy', npixels=0, uvtaper=[''], niter=10, 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=True ) |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:11 INFO tclean::::casa Verifying Input Parameters |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:13 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 2 |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:13 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 1 |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:13 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 3 |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:14 INFO tclean::::casa setupCluster, Setting up 3 engines. |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:14 INFO SynthesisUtilMethods::continuumDataPartition |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:14 INFO SynthesisUtilMethods::continuumDataPartition + Rows = 112323 168480 [P][M]: 0:2 ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:14 INFO tclean::::casa Partitioned Selection : {'0': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_twochan.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 1 && ROWNUMBER() <= 56161', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '1': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_twochan.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '2': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_twochan.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480', 'timestr': '', 'usescratch': False, 'uvdist': ''}}} |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:14 INFO SynthesisImagerVi2::selectData MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:14 INFO SynthesisImagerVi2::selectData NRows selected : 168480 |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:15 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst2] : |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:15 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst2] : |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:15 INFO SynthesisImagerVi2::defineImage Impars: start |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:15 INFO SynthesisImagerVi2::defineImage Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:15 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst2] with ftmachine : gridft |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:15 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:15 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:16 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:16 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:16 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:16 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 Selecting via TaQL : ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 | NRows selected : 56158 |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:16 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:16 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 Selecting via TaQL : ROWNUMBER() >= 1 && ROWNUMBER() <= 56161 | NRows selected : 56161 |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:16 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:16 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 Selecting via TaQL : ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322 | NRows selected : 56161 |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:17 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n1] : |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n1] : |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Impars: start |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Set Gridding options for [/home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n1] with ftmachine : gridft |
| 20-Apr-2026 17:39:17 | 2026-04-20 17:39:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-1 Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n2] : |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n2] : |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Impars: start |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Set Gridding options for [/home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n2] with ftmachine : gridft |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-2 Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:18 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n3] : |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n3] : |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Impars: start |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Set Gridding options for [/home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n3] with ftmachine : gridft |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-3 Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:19 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:21 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:22 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-2 Set imaging weights : Briggs weighting: sidelobes will be suppressed over full image |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:22 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-3 Set imaging weights : Briggs weighting: sidelobes will be suppressed over full image |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:22 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-1 Set imaging weights : Briggs weighting: sidelobes will be suppressed over full image |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:22 INFO MPICommandServer::command_request_handler_service::VisSetUtil::VisImagingWeight()::MPIServer-3 Normal robustness, robust = -2 |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:22 INFO MPICommandServer::command_request_handler_service::VisSetUtil::VisImagingWeight()::MPIServer-2 Normal robustness, robust = -2 |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:22 INFO MPICommandServer::command_request_handler_service::VisSetUtil::VisImagingWeight()::MPIServer-1 Normal robustness, robust = -2 |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:22 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:22 INFO tclean::::casa Gathering/Merging/Scattering Weight Density for PSF generation |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:22 INFO tclean::::casa ****************************************************** |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:22 INFO tclean::::casa gather and scatter now |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:22 INFO tclean::::casa ****************************************************** |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:22 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:23 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:24 INFO SynthesisNormalizer::scatterWeightDensity Send the gridded weight from : tst2 to all nodes :[/home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n1, /home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n2, /home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n3] |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:24 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:25 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:25 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst2] : hogbom |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:25 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:26 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:26 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:26 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-3 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:26 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-1 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:26 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-2 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:27 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:27 INFO SynthesisNormalizer::gatherImages Gather psf,weight images : [/home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n1, /home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n2, /home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n3] onto :tst2 |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:27 INFO SIImageStore::calcSensitivity [tst2] Theoretical sensitivity (Jy/bm):0.238048 |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:27 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.003276 |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:27 INFO SIImageStore::printBeamSet Beam : 20.9742 arcsec, 20.491 arcsec, -5.93658 deg |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:27 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:27 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::makePrimaryBeam::MPIServer-1 vi2 : Evaluating Primary Beam model onto image grid(s) |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:28 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:28 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : tst2 to all nodes :[/home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n1, /home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n2, /home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n3] |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:28 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst2.model does not exist. No initial prediction will be done |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:28 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst2.model does not exist. No initial prediction will be done |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:28 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst2.model does not exist. No initial prediction will be done |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:28 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:28 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:28 | 2026-04-20 17:39:28 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:28 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:28 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:29 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:29 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n1, /home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n2, /home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n3] onto :tst2 |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:29 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 0.837311 |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:29 INFO SynthesisDeconvolver::setupMask [tst2] Initializing new mask to 1.0 for the full image |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:29 INFO SynthesisDeconvolver::setupMask [tst2] Number of pixels in the clean mask : 10000 out of a total of 10000 pixels. [ 100 % ] |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:29 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.837311, over full image : 0.837311 |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:29 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 10, 'cyclethreshold': 0.10719998925924301, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:29 INFO SDAlgorithmBase::deconvolve [tst2] Run Hogbom minor-cycle | CycleThreshold=0.1072, CycleNiter=10, Gain=0.1 |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:29 INFO SDAlgorithmBase::deconvolve [tst2] iters=0->10 [10], model=0->0.574554, peakres=0.837311->0.262757, Reached cycleniter. |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:29 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 10 iterations. |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:29 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : tst2 to all nodes :[/home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n1, /home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n2, /home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n3] |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:29 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst2.model to /home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n1.model |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:29 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst2.model to /home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n2.model |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:30 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst2.model to /home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n3.model |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:30 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:30 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:30 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:30 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:30 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:31 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:31 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n1, /home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n2, /home/casatest/work/test_task_tclean/tst2.workdirectory/tst2.n3] onto :tst2 |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:31 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.262756, over full image : 0.262756 |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:31 INFO tclean::::casa Reached global stopping criterion : iteration limit |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:31 INFO tclean::::casa getSummary call: fullsummary=False |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:31 INFO SDAlgorithmBase::restore [tst2] : Restoring model image. |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:31 INFO SIImageStore::restore Beam for chan : 0 : 20.9742 arcsec, 20.491 arcsec, -5.93658 deg |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:40 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:40 INFO ::casa::MPIServer-2 node 2 has completed its job |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:40 INFO ::casa::MPIServer-3 node 3 has completed its job |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:40 INFO ::casa::MPIServer-1 node 1 has completed its job |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:41 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:41 INFO tclean::::casa Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed. |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:41 INFO tclean::::casa Searching for images with prefix 'tst2'... Found these, writing history into them: ['tst2.gridwt_temp', 'tst2.psf', 'tst2.sumwt', 'tst2.pb', 'tst2.residual', 'tst2.mask', 'tst2.model', 'tst2.image'] |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:41 INFO tclean::::casa Task tclean complete. Start time: 2026-04-20 17:39:11.100676 End time: 2026-04-20 17:39:41.073567 |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:41 INFO tclean::::casa ##### End Task: tclean ##### |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:41 INFO tclean::::casa ########################################## |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:41 INFO name:: No table opened. |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:41 INFO showcache:: The Table Cache is empty. |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:41 INFO tclean::::casa ########################################## |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:41 INFO tclean::::casa ##### Begin Task: tclean ##### |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:41 INFO tclean::::casa tclean( vis='refim_twochan.ms', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst3', imsize=100, cell='8.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='standard', facets=1, psfphasecenter='', wprojplanes=1, vptable='', mosweight=True, aterm=True, psterm=False, wbawp=True, conjbeams=False, cfcache='', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=0.2, normtype='flatnoise', deconvolver='hogbom', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=False, outlierfile='', weighting='briggs', robust=0.5, noise='1.0Jy', npixels=0, uvtaper=[''], niter=10, 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=True ) |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:41 INFO tclean::::casa Verifying Input Parameters |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:43 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 2 |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:43 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 1 |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:43 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 3 |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:44 INFO tclean::::casa setupCluster, Setting up 3 engines. |
| 20-Apr-2026 17:39:44 | 2026-04-20 17:39:44 INFO SynthesisUtilMethods::continuumDataPartition |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:44 INFO SynthesisUtilMethods::continuumDataPartition + Rows = 112323 168480 [P][M]: 0:2 ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:44 INFO tclean::::casa Partitioned Selection : {'0': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_twochan.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 1 && ROWNUMBER() <= 56161', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '1': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_twochan.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '2': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_twochan.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480', 'timestr': '', 'usescratch': False, 'uvdist': ''}}} |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:44 INFO SynthesisImagerVi2::selectData MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:44 INFO SynthesisImagerVi2::selectData NRows selected : 168480 |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:45 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst3] : |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:45 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst3] : |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:45 INFO SynthesisImagerVi2::defineImage Impars: start |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:45 INFO SynthesisImagerVi2::defineImage Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:45 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst3] with ftmachine : gridft |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:45 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:45 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:46 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:46 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:46 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:46 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:46 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:46 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 Selecting via TaQL : ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322 | NRows selected : 56161 |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:46 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 Selecting via TaQL : ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 | NRows selected : 56158 |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:46 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 Selecting via TaQL : ROWNUMBER() >= 1 && ROWNUMBER() <= 56161 | NRows selected : 56161 |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:47 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n1] : |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n1] : |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Impars: start |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Set Gridding options for [/home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n1] with ftmachine : gridft |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-1 Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n2] : |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n2] : |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Impars: start |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Set Gridding options for [/home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n2] with ftmachine : gridft |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-2 Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:48 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n3] : |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n3] : |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Impars: start |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Set Gridding options for [/home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n3] with ftmachine : gridft |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-3 Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:49 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:51 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:52 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-2 Set imaging weights : Briggs weighting: sidelobes will be suppressed over full image |
| 20-Apr-2026 17:39:51 | 2026-04-20 17:39:52 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-1 Set imaging weights : Briggs weighting: sidelobes will be suppressed over full image |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:52 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-3 Set imaging weights : Briggs weighting: sidelobes will be suppressed over full image |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:52 INFO MPICommandServer::command_request_handler_service::VisSetUtil::VisImagingWeight()::MPIServer-1 Normal robustness, robust = 0.5 |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:52 INFO MPICommandServer::command_request_handler_service::VisSetUtil::VisImagingWeight()::MPIServer-2 Normal robustness, robust = 0.5 |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:52 INFO MPICommandServer::command_request_handler_service::VisSetUtil::VisImagingWeight()::MPIServer-3 Normal robustness, robust = 0.5 |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:52 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:52 INFO tclean::::casa Gathering/Merging/Scattering Weight Density for PSF generation |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:52 INFO tclean::::casa ****************************************************** |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:52 INFO tclean::::casa gather and scatter now |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:52 INFO tclean::::casa ****************************************************** |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:52 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:53 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:54 INFO SynthesisNormalizer::scatterWeightDensity Send the gridded weight from : tst3 to all nodes :[/home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n1, /home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n2, /home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n3] |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:54 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:55 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:55 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst3] : hogbom |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:55 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:56 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:56 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:56 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-1 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:56 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-2 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:56 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-3 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:57 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:57 INFO SynthesisNormalizer::gatherImages Gather psf,weight images : [/home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n1, /home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n2, /home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n3] onto :tst3 |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:57 INFO SIImageStore::calcSensitivity [tst3] Theoretical sensitivity (Jy/bm):0.00186754 |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:57 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.003806 |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:57 INFO SIImageStore::printBeamSet Beam : 35.7188 arcsec, 33.9058 arcsec, -86.6253 deg |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:57 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:57 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::makePrimaryBeam::MPIServer-1 vi2 : Evaluating Primary Beam model onto image grid(s) |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:58 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:58 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : tst3 to all nodes :[/home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n1, /home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n2, /home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n3] |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:58 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst3.model does not exist. No initial prediction will be done |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:58 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst3.model does not exist. No initial prediction will be done |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:58 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst3.model does not exist. No initial prediction will be done |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:58 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:58 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:58 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:58 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:58 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:59 INFO tclean::::casa ...done |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:59 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n1, /home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n2, /home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n3] onto :tst3 |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:59 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 1.02391 |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:59 INFO SynthesisDeconvolver::setupMask [tst3] Initializing new mask to 1.0 for the full image |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:59 INFO SynthesisDeconvolver::setupMask [tst3] Number of pixels in the clean mask : 10000 out of a total of 10000 pixels. [ 100 % ] |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:59 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 1.02391, over full image : 1.02391 |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:59 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 10, 'cyclethreshold': 0.051195528358221054, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:59 INFO SDAlgorithmBase::deconvolve [tst3] Run Hogbom minor-cycle | CycleThreshold=0.0511955, CycleNiter=10, Gain=0.1 |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:59 INFO SDAlgorithmBase::deconvolve [tst3] iters=0->10 [10], model=0->0.702597, peakres=1.02391->0.321314, Reached cycleniter. |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:59 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 10 iterations. |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:59 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : tst3 to all nodes :[/home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n1, /home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n2, /home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n3] |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:59 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst3.model to /home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n1.model |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:59 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst3.model to /home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n2.model |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:39:59 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst3.model to /home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n3.model |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:40:00 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:40:00 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:39:59 | 2026-04-20 17:40:00 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:00 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:00 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:01 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:01 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n1, /home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n2, /home/casatest/work/test_task_tclean/tst3.workdirectory/tst3.n3] onto :tst3 |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:01 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.321313, over full image : 0.321313 |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:01 INFO tclean::::casa Reached global stopping criterion : iteration limit |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:01 INFO tclean::::casa getSummary call: fullsummary=False |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:01 INFO SDAlgorithmBase::restore [tst3] : Restoring model image. |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:01 INFO SIImageStore::restore Beam for chan : 0 : 35.7188 arcsec, 33.9058 arcsec, -86.6253 deg |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:10 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:10 INFO ::casa::MPIServer-2 node 2 has completed its job |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:10 INFO ::casa::MPIServer-3 node 3 has completed its job |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:10 INFO ::casa::MPIServer-1 node 1 has completed its job |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:11 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:11 INFO tclean::::casa Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed. |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:11 INFO tclean::::casa Searching for images with prefix 'tst3'... Found these, writing history into them: ['tst3.gridwt_temp', 'tst3.psf', 'tst3.sumwt', 'tst3.pb', 'tst3.residual', 'tst3.mask', 'tst3.model', 'tst3.image'] |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:11 INFO tclean::::casa Task tclean complete. Start time: 2026-04-20 17:39:41.102378 End time: 2026-04-20 17:40:11.144313 |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:11 INFO tclean::::casa ##### End Task: tclean ##### |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:11 INFO tclean::::casa ########################################## |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:11 INFO name:: No table opened. |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:11 INFO showcache:: The Table Cache is empty. |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:11 INFO tclean::::casa ########################################## |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:11 INFO tclean::::casa ##### Begin Task: tclean ##### |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:11 INFO tclean::::casa tclean( vis='refim_twochan.ms', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst4', imsize=100, cell='8.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='standard', facets=1, psfphasecenter='', wprojplanes=1, vptable='', mosweight=True, aterm=True, psterm=False, wbawp=True, conjbeams=False, cfcache='', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=0.2, normtype='flatnoise', deconvolver='hogbom', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=False, outlierfile='', weighting='briggs', robust=2.0, noise='1.0Jy', npixels=0, uvtaper=[''], niter=10, 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=True ) |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:11 INFO tclean::::casa Verifying Input Parameters |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:13 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 2 |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:13 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 1 |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:13 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 3 |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:14 INFO tclean::::casa setupCluster, Setting up 3 engines. |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:14 INFO SynthesisUtilMethods::continuumDataPartition |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:14 INFO SynthesisUtilMethods::continuumDataPartition + Rows = 112323 168480 [P][M]: 0:2 ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:14 INFO tclean::::casa Partitioned Selection : {'0': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_twochan.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 1 && ROWNUMBER() <= 56161', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '1': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_twochan.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '2': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_twochan.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480', 'timestr': '', 'usescratch': False, 'uvdist': ''}}} |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:14 INFO SynthesisImagerVi2::selectData MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:14 INFO SynthesisImagerVi2::selectData NRows selected : 168480 |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:15 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst4] : |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:15 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst4] : |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:15 INFO SynthesisImagerVi2::defineImage Impars: start |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:15 INFO SynthesisImagerVi2::defineImage Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:15 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst4] with ftmachine : gridft |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:15 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:15 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:16 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:16 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:16 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:16 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 Selecting via TaQL : ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322 | NRows selected : 56161 |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:16 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:40:15 | 2026-04-20 17:40:16 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:16 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 Selecting via TaQL : ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 | NRows selected : 56158 |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:16 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 Selecting via TaQL : ROWNUMBER() >= 1 && ROWNUMBER() <= 56161 | NRows selected : 56161 |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:17 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n1] : |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n1] : |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Impars: start |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Set Gridding options for [/home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n1] with ftmachine : gridft |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-1 Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n2] : |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n2] : |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Impars: start |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Set Gridding options for [/home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n2] with ftmachine : gridft |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-2 Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:18 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n3] : |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n3] : |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Impars: start |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Set Gridding options for [/home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n3] with ftmachine : gridft |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:18 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-3 Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:19 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:21 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:21 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-2 Set imaging weights : Briggs weighting: sidelobes will be suppressed over full image |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:21 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-3 Set imaging weights : Briggs weighting: sidelobes will be suppressed over full image |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:21 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-1 Set imaging weights : Briggs weighting: sidelobes will be suppressed over full image |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:22 INFO MPICommandServer::command_request_handler_service::VisSetUtil::VisImagingWeight()::MPIServer-2 Normal robustness, robust = 2 |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:22 INFO MPICommandServer::command_request_handler_service::VisSetUtil::VisImagingWeight()::MPIServer-1 Normal robustness, robust = 2 |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:22 INFO MPICommandServer::command_request_handler_service::VisSetUtil::VisImagingWeight()::MPIServer-3 Normal robustness, robust = 2 |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:22 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:22 INFO tclean::::casa Gathering/Merging/Scattering Weight Density for PSF generation |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:22 INFO tclean::::casa ****************************************************** |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:22 INFO tclean::::casa gather and scatter now |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:22 INFO tclean::::casa ****************************************************** |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:22 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:23 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:24 INFO SynthesisNormalizer::scatterWeightDensity Send the gridded weight from : tst4 to all nodes :[/home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n1, /home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n2, /home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n3] |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:24 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:25 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:25 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst4] : hogbom |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:25 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:26 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:26 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:26 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-3 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:26 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-1 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:26 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-2 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:27 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:27 INFO SynthesisNormalizer::gatherImages Gather psf,weight images : [/home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n1, /home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n2, /home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n3] onto :tst4 |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:27 INFO SIImageStore::calcSensitivity [tst4] Theoretical sensitivity (Jy/bm):0.00124808 |
| 20-Apr-2026 17:40:26 | 2026-04-20 17:40:27 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.00422 |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:27 INFO SIImageStore::printBeamSet Beam : 52.8212 arcsec, 49.0012 arcsec, -85.6866 deg |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:27 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:27 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::makePrimaryBeam::MPIServer-1 vi2 : Evaluating Primary Beam model onto image grid(s) |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:28 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:28 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : tst4 to all nodes :[/home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n1, /home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n2, /home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n3] |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:28 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst4.model does not exist. No initial prediction will be done |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:28 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst4.model does not exist. No initial prediction will be done |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:28 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst4.model does not exist. No initial prediction will be done |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:28 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:28 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:28 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:28 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:28 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:29 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:29 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n1, /home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n2, /home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n3] onto :tst4 |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:29 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 1.1247 |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:29 INFO SynthesisDeconvolver::setupMask [tst4] Initializing new mask to 1.0 for the full image |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:29 INFO SynthesisDeconvolver::setupMask [tst4] Number of pixels in the clean mask : 10000 out of a total of 10000 pixels. [ 100 % ] |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:29 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 1.1247, over full image : 1.1247 |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:29 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 10, 'cyclethreshold': 0.1588025987148285, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:29 INFO SDAlgorithmBase::deconvolve [tst4] Run Hogbom minor-cycle | CycleThreshold=0.158803, CycleNiter=10, Gain=0.1 |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:29 INFO SDAlgorithmBase::deconvolve [tst4] iters=0->10 [10], model=0->0.771754, peakres=1.1247->0.352941, Reached cycleniter. |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:29 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 10 iterations. |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:29 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : tst4 to all nodes :[/home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n1, /home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n2, /home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n3] |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:29 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst4.model to /home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n1.model |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:29 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst4.model to /home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n2.model |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:29 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst4.model to /home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n3.model |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:29 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:29 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:30 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:30 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:30 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:30 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:30 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n1, /home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n2, /home/casatest/work/test_task_tclean/tst4.workdirectory/tst4.n3] onto :tst4 |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:31 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.35294, over full image : 0.35294 |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:31 INFO tclean::::casa Reached global stopping criterion : iteration limit |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:31 INFO tclean::::casa getSummary call: fullsummary=False |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:31 INFO SDAlgorithmBase::restore [tst4] : Restoring model image. |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:31 INFO SIImageStore::restore Beam for chan : 0 : 52.8212 arcsec, 49.0012 arcsec, -85.6866 deg |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:40 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:40 INFO ::casa::MPIServer-2 node 2 has completed its job |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:40 INFO ::casa::MPIServer-3 node 3 has completed its job |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:40 INFO ::casa::MPIServer-1 node 1 has completed its job |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:41 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:41 INFO tclean::::casa Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed. |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:41 INFO tclean::::casa Searching for images with prefix 'tst4'... Found these, writing history into them: ['tst4.gridwt_temp', 'tst4.psf', 'tst4.sumwt', 'tst4.pb', 'tst4.residual', 'tst4.mask', 'tst4.model', 'tst4.image'] |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:41 INFO tclean::::casa Task tclean complete. Start time: 2026-04-20 17:40:11.173423 End time: 2026-04-20 17:40:40.923009 |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:41 INFO tclean::::casa ##### End Task: tclean ##### |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:41 INFO tclean::::casa ########################################## |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:41 INFO name:: No table opened. |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:41 INFO showcache:: The Table Cache is empty. |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:41 INFO tclean::::casa ########################################## |
| 20-Apr-2026 17:40:40 | 2026-04-20 17:40:41 INFO tclean::::casa ##### Begin Task: tclean ##### |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:41 INFO tclean::::casa tclean( vis='refim_twochan.ms', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst5', imsize=100, cell='8.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='standard', facets=1, psfphasecenter='', wprojplanes=1, vptable='', mosweight=True, aterm=True, psterm=False, wbawp=True, conjbeams=False, cfcache='', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=0.2, normtype='flatnoise', deconvolver='hogbom', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=False, outlierfile='', weighting='radial', robust=0.5, noise='1.0Jy', npixels=0, uvtaper=[''], niter=10, 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=True ) |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:41 INFO tclean::::casa Verifying Input Parameters |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:43 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 2 |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:43 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 1 |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:43 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 3 |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:44 INFO tclean::::casa setupCluster, Setting up 3 engines. |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:44 INFO SynthesisUtilMethods::continuumDataPartition |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:44 INFO SynthesisUtilMethods::continuumDataPartition + Rows = 112323 168480 [P][M]: 0:2 ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:44 INFO tclean::::casa Partitioned Selection : {'0': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_twochan.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 1 && ROWNUMBER() <= 56161', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '1': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_twochan.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '2': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_twochan.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480', 'timestr': '', 'usescratch': False, 'uvdist': ''}}} |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:44 INFO SynthesisImagerVi2::selectData MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:44 INFO SynthesisImagerVi2::selectData NRows selected : 168480 |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:45 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst5] : |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:45 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst5] : |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:45 INFO SynthesisImagerVi2::defineImage Impars: start |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:45 INFO SynthesisImagerVi2::defineImage Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:45 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst5] with ftmachine : gridft |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:45 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:45 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:46 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:46 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:46 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:46 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:46 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:46 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 Selecting via TaQL : ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322 | NRows selected : 56161 |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:46 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 Selecting via TaQL : ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 | NRows selected : 56158 |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:46 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 Selecting via TaQL : ROWNUMBER() >= 1 && ROWNUMBER() <= 56161 | NRows selected : 56161 |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:47 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n1] : |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n1] : |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Impars: start |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Set Gridding options for [/home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n1] with ftmachine : gridft |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-1 Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n2] : |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n2] : |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Impars: start |
| 20-Apr-2026 17:40:47 | 2026-04-20 17:40:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Set Gridding options for [/home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n2] with ftmachine : gridft |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-2 Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:48 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n3] : |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n3] : |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Impars: start |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Set Gridding options for [/home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n3] with ftmachine : gridft |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-3 Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:49 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:51 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:51 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-2 Set imaging weights : Radial weighting |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:51 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-1 Set imaging weights : Radial weighting |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:51 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-3 Set imaging weights : Radial weighting |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:52 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:52 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst5] : hogbom |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:52 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:53 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:53 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:53 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-2 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:53 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-1 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:53 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-3 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:54 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:54 INFO SynthesisNormalizer::gatherImages Gather psf,weight images : [/home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n1, /home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n2, /home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n3] onto :tst5 |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:55 INFO SIImageStore::calcSensitivity [tst5] Theoretical sensitivity (Jy/bm):2.80223e-05 |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:55 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.004177 |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:55 INFO SIImageStore::printBeamSet Beam : 33.3652 arcsec, 31.2431 arcsec, -86.5716 deg |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:55 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:55 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::makePrimaryBeam::MPIServer-1 vi2 : Evaluating Primary Beam model onto image grid(s) |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:56 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:56 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : tst5 to all nodes :[/home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n1, /home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n2, /home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n3] |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:56 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst5.model does not exist. No initial prediction will be done |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:56 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst5.model does not exist. No initial prediction will be done |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:56 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst5.model does not exist. No initial prediction will be done |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:56 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:56 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:56 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:56 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:56 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:57 INFO tclean::::casa ...done |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:57 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n1, /home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n2, /home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n3] onto :tst5 |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:57 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 1.00001 |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:57 INFO SynthesisDeconvolver::setupMask [tst5] Initializing new mask to 1.0 for the full image |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:57 INFO SynthesisDeconvolver::setupMask [tst5] Number of pixels in the clean mask : 10000 out of a total of 10000 pixels. [ 100 % ] |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:57 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 1.00001, over full image : 1.00001 |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:57 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 10, 'cyclethreshold': 0.050000645220279694, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:57 INFO SDAlgorithmBase::deconvolve [tst5] Run Hogbom minor-cycle | CycleThreshold=0.0500006, CycleNiter=10, Gain=0.1 |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:57 INFO SDAlgorithmBase::deconvolve [tst5] iters=0->10 [10], model=0->0.686198, peakres=1.00001->0.313815, Reached cycleniter. |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:57 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 10 iterations. |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:57 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : tst5 to all nodes :[/home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n1, /home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n2, /home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n3] |
| 20-Apr-2026 17:40:57 | 2026-04-20 17:40:57 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst5.model to /home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n1.model |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:40:57 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst5.model to /home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n2.model |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:40:57 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst5.model to /home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n3.model |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:40:57 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:40:57 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:40:57 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:40:57 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:40:57 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:40:58 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:40:58 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n1, /home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n2, /home/casatest/work/test_task_tclean/tst5.workdirectory/tst5.n3] onto :tst5 |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:40:58 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.313814, over full image : 0.313814 |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:40:58 INFO tclean::::casa Reached global stopping criterion : iteration limit |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:40:58 INFO tclean::::casa getSummary call: fullsummary=False |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:40:58 INFO SDAlgorithmBase::restore [tst5] : Restoring model image. |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:40:58 INFO SIImageStore::restore Beam for chan : 0 : 33.3652 arcsec, 31.2431 arcsec, -86.5716 deg |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:06 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:07 INFO ::casa::MPIServer-1 node 1 has completed its job |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:07 INFO ::casa::MPIServer-2 node 2 has completed its job |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:07 INFO ::casa::MPIServer-3 node 3 has completed its job |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:07 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:07 INFO tclean::::casa Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed. |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:07 INFO tclean::::casa Searching for images with prefix 'tst5'... Found these, writing history into them: ['tst5.psf', 'tst5.sumwt', 'tst5.pb', 'tst5.residual', 'tst5.mask', 'tst5.model', 'tst5.image'] |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:08 INFO tclean::::casa Task tclean complete. Start time: 2026-04-20 17:40:40.954086 End time: 2026-04-20 17:41:07.648801 |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:08 INFO tclean::::casa ##### End Task: tclean ##### |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:08 INFO tclean::::casa ########################################## |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:08 INFO name:: No table opened. |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:08 INFO showcache:: The Table Cache is empty. |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:08 INFO tclean::::casa ########################################## |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:08 INFO tclean::::casa ##### Begin Task: tclean ##### |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:08 INFO tclean::::casa tclean( vis='refim_twochan.ms', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst6', imsize=100, cell='8.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='standard', facets=1, psfphasecenter='', wprojplanes=1, vptable='', mosweight=True, aterm=True, psterm=False, wbawp=True, conjbeams=False, cfcache='', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=0.2, normtype='flatnoise', deconvolver='hogbom', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=False, outlierfile='', weighting='superuniform', robust=0.5, noise='1.0Jy', npixels=0, uvtaper=[''], niter=10, 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=True ) |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:08 INFO tclean::::casa Verifying Input Parameters |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:10 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 2 |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:10 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 1 |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:10 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 3 |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:11 INFO tclean::::casa setupCluster, Setting up 3 engines. |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:11 INFO SynthesisUtilMethods::continuumDataPartition |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:11 INFO SynthesisUtilMethods::continuumDataPartition + Rows = 112323 168480 [P][M]: 0:2 ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:11 INFO tclean::::casa Partitioned Selection : {'0': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_twochan.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 1 && ROWNUMBER() <= 56161', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '1': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_twochan.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '2': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_twochan.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480', 'timestr': '', 'usescratch': False, 'uvdist': ''}}} |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:11 INFO SynthesisImagerVi2::selectData MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:11 INFO SynthesisImagerVi2::selectData NRows selected : 168480 |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:12 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst6] : |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:12 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst6] : |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:12 INFO SynthesisImagerVi2::defineImage Impars: start |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:12 INFO SynthesisImagerVi2::defineImage Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:12 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst6] with ftmachine : gridft |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:12 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:12 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:13 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:12 | 2026-04-20 17:41:13 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:13 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:13 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:13 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:13 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 Selecting via TaQL : ROWNUMBER() >= 1 && ROWNUMBER() <= 56161 | NRows selected : 56161 |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:13 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 Selecting via TaQL : ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322 | NRows selected : 56161 |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:13 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 Selecting via TaQL : ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 | NRows selected : 56158 |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:14 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:14 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n1] : |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:14 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n1] : |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:14 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Impars: start |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:14 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:14 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Set Gridding options for [/home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n1] with ftmachine : gridft |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:14 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-1 Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:15 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n2] : |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:15 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n2] : |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:15 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Impars: start |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:15 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:15 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Set Gridding options for [/home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n2] with ftmachine : gridft |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:15 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-2 Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:15 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:15 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n3] : |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:15 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n3] : |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:15 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Impars: start |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:15 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:15 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Set Gridding options for [/home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n3] with ftmachine : gridft |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:15 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-3 Required memory: 0.002124 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:16 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:18 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:19 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-1 Set imaging weights : SuperUniform weighting over a square cell spanning [-3, 3] in the uv plane |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:19 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-2 Set imaging weights : SuperUniform weighting over a square cell spanning [-3, 3] in the uv plane |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:19 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-3 Set imaging weights : SuperUniform weighting over a square cell spanning [-3, 3] in the uv plane |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:19 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:19 INFO tclean::::casa Gathering/Merging/Scattering Weight Density for PSF generation |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:19 INFO tclean::::casa ****************************************************** |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:19 INFO tclean::::casa gather and scatter now |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:19 INFO tclean::::casa ****************************************************** |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:19 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:20 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:21 INFO SynthesisNormalizer::scatterWeightDensity Send the gridded weight from : tst6 to all nodes :[/home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n1, /home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n2, /home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n3] |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:21 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:22 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:22 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst6] : hogbom |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:22 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:23 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:23 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:23 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-1 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:23 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-2 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:23 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-3 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:41:23 | 2026-04-20 17:41:24 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:24 INFO SynthesisNormalizer::gatherImages Gather psf,weight images : [/home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n1, /home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n2, /home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n3] onto :tst6 |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:24 INFO SIImageStore::calcSensitivity [tst6] Theoretical sensitivity (Jy/bm):0.144667 |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:24 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.002956 |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:24 INFO SIImageStore::printBeamSet Beam : 19.7233 arcsec, 19.6343 arcsec, -29.5346 deg |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:24 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:24 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::makePrimaryBeam::MPIServer-1 vi2 : Evaluating Primary Beam model onto image grid(s) |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:25 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:25 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : tst6 to all nodes :[/home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n1, /home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n2, /home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n3] |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:25 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst6.model does not exist. No initial prediction will be done |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:25 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst6.model does not exist. No initial prediction will be done |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:25 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst6.model does not exist. No initial prediction will be done |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:25 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:25 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:25 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:25 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:25 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:26 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:26 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n1, /home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n2, /home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n3] onto :tst6 |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:26 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 0.830827 |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:26 INFO SynthesisDeconvolver::setupMask [tst6] Initializing new mask to 1.0 for the full image |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:26 INFO SynthesisDeconvolver::setupMask [tst6] Number of pixels in the clean mask : 10000 out of a total of 10000 pixels. [ 100 % ] |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:26 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.830827, over full image : 0.830827 |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:26 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 10, 'cyclethreshold': 0.1325298398733139, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:26 INFO SDAlgorithmBase::deconvolve [tst6] Run Hogbom minor-cycle | CycleThreshold=0.13253, CycleNiter=10, Gain=0.1 |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:26 INFO SDAlgorithmBase::deconvolve [tst6] iters=0->10 [10], model=0->0.570104, peakres=0.830827->0.260722, Reached cycleniter. |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:26 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 10 iterations. |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:26 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : tst6 to all nodes :[/home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n1, /home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n2, /home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n3] |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:26 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst6.model to /home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n1.model |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:26 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst6.model to /home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n2.model |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:26 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst6.model to /home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n3.model |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:26 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:26 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:27 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:27 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:27 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:27 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:27 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n1, /home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n2, /home/casatest/work/test_task_tclean/tst6.workdirectory/tst6.n3] onto :tst6 |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:28 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.260721, over full image : 0.260721 |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:28 INFO tclean::::casa Reached global stopping criterion : iteration limit |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:28 INFO tclean::::casa getSummary call: fullsummary=False |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:28 INFO SDAlgorithmBase::restore [tst6] : Restoring model image. |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:28 INFO SIImageStore::restore Beam for chan : 0 : 19.7233 arcsec, 19.6343 arcsec, -29.5346 deg |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:37 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:37 INFO ::casa::MPIServer-1 node 1 has completed its job |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:37 INFO ::casa::MPIServer-3 node 3 has completed its job |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:37 INFO ::casa::MPIServer-2 node 2 has completed its job |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:38 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:38 INFO tclean::::casa Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed. |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:38 INFO tclean::::casa Searching for images with prefix 'tst6'... Found these, writing history into them: ['tst6.gridwt_temp', 'tst6.psf', 'tst6.sumwt', 'tst6.pb', 'tst6.residual', 'tst6.mask', 'tst6.model', 'tst6.image'] |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:38 INFO tclean::::casa Task tclean complete. Start time: 2026-04-20 17:41:07.677929 End time: 2026-04-20 17:41:38.111075 |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:38 INFO tclean::::casa ##### End Task: tclean ##### |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:38 INFO tclean::::casa ########################################## |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:38 INFO name:: No table opened. |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:38 INFO showcache:: The Table Cache is empty. |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:38 INFO tclean::::casa ########################################## |
| 20-Apr-2026 17:41:38 | 2026-04-20 17:41:38 INFO tclean::::casa ##### Begin Task: tclean ##### |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:38 INFO tclean::::casa tclean( vis='refim_twochan.ms', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst7', imsize=100, cell='8.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='standard', facets=1, psfphasecenter='', wprojplanes=1, vptable='', mosweight=True, aterm=True, psterm=False, wbawp=True, conjbeams=False, cfcache='', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=0.2, normtype='flatnoise', deconvolver='mtmfs', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=False, outlierfile='', weighting='briggs', robust=0.5, noise='1.0Jy', npixels=0, uvtaper=[''], niter=10, 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=True ) |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:38 INFO tclean::::casa Verifying Input Parameters |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:40 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 2 |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:40 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 1 |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:40 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 3 |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:41 INFO tclean::::casa setupCluster, Setting up 3 engines. |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:41 INFO SynthesisUtilMethods::continuumDataPartition |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:41 INFO SynthesisUtilMethods::continuumDataPartition + Rows = 112323 168480 [P][M]: 0:2 ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:41 INFO tclean::::casa Partitioned Selection : {'0': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_twochan.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 1 && ROWNUMBER() <= 56161', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '1': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_twochan.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '2': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_twochan.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480', 'timestr': '', 'usescratch': False, 'uvdist': ''}}} |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:41 INFO SynthesisImagerVi2::selectData MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:41 INFO SynthesisImagerVi2::selectData NRows selected : 168480 |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:42 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst7] : |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:42 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst7] : |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:42 INFO SynthesisImagerVi2::defineImage Impars: start |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:42 INFO SynthesisImagerVi2::defineImage Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:42 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst7] with ftmachine : gridft |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:42 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.003541 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:42 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:43 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:43 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:43 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:43 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:43 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 Selecting via TaQL : ROWNUMBER() >= 1 && ROWNUMBER() <= 56161 | NRows selected : 56161 |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:43 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 MS : refim_twochan.ms | [Opened in readonly mode] |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:43 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 Selecting via TaQL : ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 | NRows selected : 56158 |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:43 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 Selecting via TaQL : ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322 | NRows selected : 56161 |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:44 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:44 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n1] : |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:44 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n1] : |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:44 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Impars: start |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:44 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:44 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Set Gridding options for [/home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n1] with ftmachine : gridft |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:44 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-1 Required memory: 0.003541 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:45 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n2] : |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:45 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n2] : |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:45 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Impars: start |
| 20-Apr-2026 17:41:44 | 2026-04-20 17:41:45 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:45 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Set Gridding options for [/home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n2] with ftmachine : gridft |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:45 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-2 Required memory: 0.003541 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:45 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:45 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n3] : |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:45 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n3] : |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:45 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Impars: start |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:45 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Shape: [100, 100, 1, 1] Spectral: [1.49999e+09] at [0] with increment [1.99998e+09] |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:45 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Set Gridding options for [/home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n3] with ftmachine : gridft |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:45 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-3 Required memory: 0.003541 GB. Available mem.: 390.4 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:46 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:48 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-3 Set imaging weights : Briggs weighting: sidelobes will be suppressed over full image |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-2 Set imaging weights : Briggs weighting: sidelobes will be suppressed over full image |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-1 Set imaging weights : Briggs weighting: sidelobes will be suppressed over full image |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:49 INFO MPICommandServer::command_request_handler_service::VisSetUtil::VisImagingWeight()::MPIServer-3 Normal robustness, robust = 0.5 |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:49 INFO MPICommandServer::command_request_handler_service::VisSetUtil::VisImagingWeight()::MPIServer-2 Normal robustness, robust = 0.5 |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:49 INFO MPICommandServer::command_request_handler_service::VisSetUtil::VisImagingWeight()::MPIServer-1 Normal robustness, robust = 0.5 |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:49 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:49 INFO tclean::::casa Gathering/Merging/Scattering Weight Density for PSF generation |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:49 INFO tclean::::casa ****************************************************** |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:49 INFO tclean::::casa gather and scatter now |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:49 INFO tclean::::casa ****************************************************** |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:49 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:50 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:50 INFO SynthesisNormalizer::scatterWeightDensity Send the gridded weight from : tst7 to all nodes :[/home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n1, /home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n2, /home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n3] |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:51 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:52 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:52 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst7] : mtmfs |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:52 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:53 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:53 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:53 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-1 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:53 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-2 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:53 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-3 ----------------------------------------------------------- Make PSF --------------------------------------------- |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:55 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:55 INFO SynthesisNormalizer::gatherImages Gather psf,weight images : [/home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n1, /home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n2, /home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n3] onto :tst7 |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:55 INFO SIImageStoreMultiTerm::calcSensitivity Multi-Term Hessian Matrix : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order) |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:55 INFO SIImageStoreMultiTerm::calcSensitivity + [286722, 25767.2 |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:55 INFO SIImageStoreMultiTerm::calcSensitivity + 25767.2, 31857.9] |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:55 INFO SIImageStoreMultiTerm::calcSensitivity Multi-Term Covariance Matrix : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order) |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:55 INFO SIImageStoreMultiTerm::calcSensitivity + [3.76108e-06, -3.04202e-06 |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:55 INFO SIImageStoreMultiTerm::calcSensitivity + -3.04202e-06, 3.38498e-05] |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:55 INFO SIImageStoreMultiTerm::calcSensitivity [tst7][Taylor0] Theoretical sensitivity (Jy/bm):0.00193935 |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:55 INFO SIImageStoreMultiTerm::calcSensitivity [tst7][Taylor1] Theoretical sensitivity (Jy/bm):0.00581806 |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:55 INFO SIImageStoreMultiTerm::calcFractionalBandwidth MFS frequency range : 0.499994 GHz -> 2.49998GHz.Fractional Bandwidth : 133.333 %.Reference Frequency for Taylor Expansion : 1.49999GHz. |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:55 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.00382 |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:55 INFO SIImageStore::printBeamSet Beam : 35.7188 arcsec, 33.9058 arcsec, -86.6253 deg |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:55 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:55 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::makePrimaryBeam::MPIServer-1 vi2 : Evaluating Primary Beam model onto image grid(s) |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:56 INFO tclean::::casa ...done |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:56 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : tst7 to all nodes :[/home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n1, /home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n2, /home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n3] |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:56 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst7.model.tt0 does not exist. No initial prediction will be done for term0 |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:56 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst7.model.tt1 does not exist. No initial prediction will be done for term1 |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:56 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst7.model.tt0 does not exist. No initial prediction will be done for term0 |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:56 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst7.model.tt1 does not exist. No initial prediction will be done for term1 |
| 20-Apr-2026 17:41:56 | 2026-04-20 17:41:56 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst7.model.tt0 does not exist. No initial prediction will be done for term0 |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:56 INFO task_tclean::SIImageStore::setModelImageOne Starting model image tst7.model.tt1 does not exist. No initial prediction will be done for term1 |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:56 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:56 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:56 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:56 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:56 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:57 INFO tclean::::casa ...done |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:57 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n1, /home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n2, /home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n3] onto :tst7 |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 1.02391 |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO SynthesisDeconvolver::setupMask [tst7] Initializing new mask to 1.0 for the full image |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO SynthesisDeconvolver::setupMask [tst7] Number of pixels in the clean mask : 10000 out of a total of 10000 pixels. [ 100 % ] |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 1.02391, over full image : 1.02391 |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 10, 'cyclethreshold': 0.051195528358221054, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO SDAlgorithmBase::deconvolve [tst7] Run mtmfs minor-cycle | CycleThreshold=0.0511955, CycleNiter=10, Gain=0.1 |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO MultiTermMatrixCleaner::verifyScaleSizes() Scale sizes to be used for deconvolution : [0] |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO MultiTermMatrixCleaner::initialise() Using a PSF patch of 80 pixels on each side for minor-cycle updates. |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO MatrixCleaner::validatePsf() Peak of PSF = 1 at [50, 50] |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO SIImageStoreMultiTerm::calcFractionalBandwidth MFS frequency range : 0.499994 GHz -> 2.49998GHz.Fractional Bandwidth : 133.333 %.Reference Frequency for Taylor Expansion : 1.49999GHz. |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO MultiTermMatrixCleaner::computeHessianPeak Calculating PSF and Scale convolutions |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO MultiTermMatrixCleaner::computeHessianPeak The Matrix [H] for 0 pixel scale is : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order) |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO MultiTermMatrixCleaner::computeHessianPeak + [1, 0.0898682 |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO MultiTermMatrixCleaner::computeHessianPeak + 0.0898682, 0.111111] |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO MultiTermMatrixCleaner::mtclean() Calculating convolutions of residual images with scales |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO MultiTermMatrixCleaner::mtclean() Peak convolved residual (within mask) : 1.02391 |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO [10] Res: 0.357016 Max: 0.176932 Gain: 0.1 Pos: [50, 50] Scale: 0 Coeffs: 0.435853 -0.435854 |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO MultiTermMatrixCleaner::mtclean() Reached max number of iterations for this minor cycle |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO MultiTermMatrixCleaner::mtclean() Total flux by scale : [0]: 0.732746 (in this run) |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO MultiTermMatrixCleaner::mtclean() Total flux by Taylor coefficient : [0]: 0.732746 [1]: -0.732747 |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO SDAlgorithmBase::deconvolve [tst7] iters=0->10 [10], model=0->0.732746, peakres=1.02391->0.357015, Reached cycleniter. |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 10 iterations. |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : tst7 to all nodes :[/home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n1, /home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n2, /home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n3] |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst7.model.tt0 to /home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n1.model.tt0 |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst7.model.tt1 to /home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n1.model.tt1 |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst7.model.tt0 to /home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n2.model.tt0 |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst7.model.tt1 to /home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n2.model.tt1 |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst7.model.tt0 to /home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n3.model.tt0 |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst7.model.tt1 to /home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n3.model.tt1 |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:41:58 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 2 ------------------------------------- |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:42:00 INFO tclean::::casa ...done |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:42:00 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n1, /home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n2, /home/casatest/work/test_task_tclean/tst7.workdirectory/tst7.n3] onto :tst7 |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:42:00 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.357015, over full image : 0.357015 |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:42:00 INFO tclean::::casa Reached global stopping criterion : iteration limit |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:42:00 INFO tclean::::casa getSummary call: fullsummary=False |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:42:00 INFO MultiTermMatrixCleaner::computeprincipalsolution() MTMC :: Computing principal solution on residuals |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:42:00 INFO SDAlgorithmBase::restore [tst7] : Restoring model image. |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:42:00 INFO SIImageStore::restore Beam for chan : 0 : 35.7188 arcsec, 33.9058 arcsec, -86.6253 deg |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:42:01 INFO SIImageStore::restore Beam for chan : 0 : 35.7188 arcsec, 33.9058 arcsec, -86.6253 deg |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:42:01 INFO SIImageStoreMultiTerm::calculateAlphaBeta Calculating spectral parameters for Intensity > peakresidual/10 = 0.0392267 Jy/beam |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:42:01 INFO SIImageStoreMultiTerm::calculateAlphaBeta Written Spectral Index Error Image : /home/casatest/work/test_task_tclean/tst7.alpha.error |
| 20-Apr-2026 17:42:00 | 2026-04-20 17:42:01 INFO SDAlgorithmMSMFS::restore Restored images : |
| 20-Apr-2026 17:42:03 | Failing task since return code of [/export/cvpost134-nvme/casa/bamboohome/temp/CASASPECS-RELEASE675TESTCASALITHPY312-MTTR93D-3-ScriptBuildTask-12836953191376597014.sh] was 143 while expected 0 |
| 20-Apr-2026 17:42:03 | Finished task 'MPI Tasks Tests on EL8' with result: Failed |
| 20-Apr-2026 17:42:03 | Running post build plugin 'Docker Container Cleanup' |
| 20-Apr-2026 17:42:03 | Running post build plugin 'NCover Results Collector' |
| 20-Apr-2026 17:42:03 | Running post build plugin 'Build Results Label Collector' |
| 20-Apr-2026 17:42:03 | Force Stop build feature is enabled for current plan. Either Bamboo has detected the build has hung or it has been manually stopped. |
| 20-Apr-2026 17:42:03 | Attempting to generate stack trace and terminate spawned sub-processes of process id: 6269 |
| 20-Apr-2026 17:42:03 | Running post build plugin 'Clover Results Collector' |
| 20-Apr-2026 17:42:03 | Running post build plugin 'npm Cache Cleanup' |
| 20-Apr-2026 17:42:03 | Running post build plugin 'Artifact Copier' |
| 20-Apr-2026 17:42:03 | Finalising the build... |
| 20-Apr-2026 17:42:03 | Stopping timer. |
| 20-Apr-2026 17:42:03 | Build CASASPECS-RELEASE675TESTCASALITHPY312-MTTR93D-3 completed. |
| 20-Apr-2026 13:42:04 | Running on server: post build plugin 'Build Hanging Detection Configuration' |
| 20-Apr-2026 13:42:04 | Running on server: post build plugin 'NCover Results Collector' |
| 20-Apr-2026 13:42:04 | Running on server: post build plugin 'Build Labeller' |
| 20-Apr-2026 13:42:04 | Running on server: post build plugin 'Clover Delta Calculator' |
| 20-Apr-2026 13:42:04 | Running on server: post build plugin 'Maven Dependencies Postprocessor' |
| 20-Apr-2026 13:42:04 | All post build plugins have finished |
| 20-Apr-2026 13:42:04 | Generating build results summary... |
| 20-Apr-2026 13:42:04 | Saving build results to disk... |
| 20-Apr-2026 13:42:04 | Store variable context... |
| 20-Apr-2026 13:42:04 | Finished building CASASPECS-RELEASE675TESTCASALITHPY312-MTTR93D-3. |
| 20-Apr-2026 13:42:08 | Killing: 327421 |
| 20-Apr-2026 13:42:08 | Executing kill 327421 |
| 20-Apr-2026 13:42:13 | Force Stop build feature is enabled for current plan. Either Bamboo has detected the build has hung or it has been manually stopped. |
| 20-Apr-2026 13:42:13 | Has finished generating stack trace and terminating spawned sub-processes of process id: 6269 |