The build generated 10,576 lines of output.
The output is too long and has been truncated to the last 1,000 lines.
Download or
view
full build log.
You can find logs from previous runs here.
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:20 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] : |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:20 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] : |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:20 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Impars: start |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:20 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:20 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Set Gridding options for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] with ftmachine : gridft |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:20 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-3 Required memory: 0.002124 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:21 INFO tclean::::casa ...done |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:24 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:24 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-3 Set imaging weights : Natural weighting |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:24 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-1 Set imaging weights : Natural weighting |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:24 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-2 Set imaging weights : Natural weighting |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:25 INFO tclean::::casa ...done |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:25 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [savemod.par] : hogbom |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:25 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:26 INFO tclean::::casa ...done |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:26 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:26 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-3 ----------------------------------------------------------- Make PSF --------------------------------------------- |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:26 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-1 ----------------------------------------------------------- Make PSF --------------------------------------------- |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:26 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-2 ----------------------------------------------------------- Make PSF --------------------------------------------- |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:28 INFO tclean::::casa ...done |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:28 INFO SynthesisNormalizer::gatherImages Gather psf,weight images : [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] onto :savemod.par |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:28 INFO SIImageStore::calcSensitivity [savemod.par] Theoretical sensitivity (Jy/bm):0.000531521 |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:28 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.00502 |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:28 INFO SIImageStore::printBeamSet Beam : 53.0943 arcsec, 49.5719 arcsec, -88.6243 deg |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:28 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:28 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::makePrimaryBeam::MPIServer-1 vi2 : Evaluating Primary Beam model onto image grid(s) |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:29 INFO tclean::::casa ...done |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:29 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : savemod.par to all nodes :[/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] |
|
02-Sep-2026 19:19:28
|
2026-09-02 19:19:29 INFO task_tclean::SIImageStore::setModelImageOne Starting model image savemod.par.model does not exist. No initial prediction will be done |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:29 INFO task_tclean::SIImageStore::setModelImageOne Starting model image savemod.par.model does not exist. No initial prediction will be done |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:29 INFO task_tclean::SIImageStore::setModelImageOne Starting model image savemod.par.model does not exist. No initial prediction will be done |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:29 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:29 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:29 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:29 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:29 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:30 INFO tclean::::casa ...done |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:30 INFO SynthesisNormalizer::gatherImages Gather residual images : [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] onto :savemod.par |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:30 INFO task_tclean::SDAlgorithmBase::restore [savemod.par] : Restoring model image. |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:30 WARN task_tclean::SIImageStore::restore (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SIImageStore.cc, line 2353) Restoring with an empty model image. Only residuals will be processed to form the output restored image. |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:30 INFO task_tclean::SIImageStore::restore Beam for chan : 0 : 53.0943 arcsec, 49.5719 arcsec, -88.6243 deg |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:37 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:37 INFO ::casa::MPIServer-1 node 1 has completed its job |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:37 INFO ::casa::MPIServer-3 node 3 has completed its job |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:37 INFO ::casa::MPIServer-2 node 2 has completed its job |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:38 INFO tclean::::casa ...done |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:38 INFO tclean::::casa Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed. |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:38 INFO tclean::::casa Searching for images with prefix 'savemod.par'... Found these, writing history into them: ['savemod.par.psf', 'savemod.par.sumwt', 'savemod.par.pb', 'savemod.par.residual', 'savemod.par.image', 'savemod.par.model'] |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:38 INFO tclean::::casa Task tclean complete. Start time: 2026-09-02 15:19:13.379607 End time: 2026-09-02 15:19:38.137026 |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:38 INFO tclean::::casa ##### End Task: tclean ##### |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:38 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:38 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:38 INFO tclean::::casa ##### Begin Task: tclean ##### |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:38 INFO tclean::::casa tclean( vis='refim_point.ms', selectdata=True, field='', spw='0:0~5,0:15~19', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='savemod.par', imsize=100, cell='10.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='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='natural', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.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=False, calcpsf=False, psfcutoff=0.35, parallel=False ) |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:38 INFO tclean::::casa Verifying Input Parameters |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:38 INFO SynthesisImagerVi2::selectData MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:38 INFO SynthesisImagerVi2::selectData NRows selected : 168480 |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:38 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:38 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:39 INFO SynthesisImagerVi2::defineImage Impars: start |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:39 INFO SynthesisImagerVi2::defineImage Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:39 INFO SynthesisImagerVi2::defineImage Set Gridding options for [savemod.par] with ftmachine : gridft |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:39 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.002124 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:39 INFO SynthesisImagerVi2::weight() Set imaging weights : Natural weighting |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:39 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [savemod.par] : hogbom |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:39 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 1.10061 |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:39 INFO SynthesisDeconvolver::setupMask [savemod.par] Initializing new mask to 1.0 for the full image |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:39 INFO SynthesisDeconvolver::setupMask [savemod.par] Number of pixels in the clean mask : 10000 out of a total of 10000 pixels. [ 100 % ] |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:39 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 1.10061, over full image : 1.10061 |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:39 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 10, 'cyclethreshold': 0.13606752455234528, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:39 INFO SDAlgorithmBase::deconvolve [savemod.par] Run Hogbom minor-cycle | CycleThreshold=0.136068, CycleNiter=10, Gain=0.1 |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:39 INFO SDAlgorithmBase::deconvolve [savemod.par] iters=0->10 [10], model=0->0.755226, peakres=1.10061->0.345383, Reached cycleniter. |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:39 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 10 iterations. |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:39 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:41 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.345382, over full image : 0.345382 |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:41 INFO tclean::::casa Reached global stopping criterion : iteration limit |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:41 INFO tclean::::casa getSummary call: fullsummary=False |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:41 INFO SDAlgorithmBase::restore [savemod.par] : Restoring model image. |
|
02-Sep-2026 19:19:41
|
2026-09-02 19:19:41 INFO SIImageStore::restore Beam for chan : 0 : 53.0943 arcsec, 49.5719 arcsec, -88.6243 deg |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:41 INFO tclean::::casa Searching for images with prefix 'savemod.par'... Found these, writing history into them: ['savemod.par.psf', 'savemod.par.sumwt', 'savemod.par.pb', 'savemod.par.residual', 'savemod.par.image', 'savemod.par.model', 'savemod.par.mask'] |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:41 INFO tclean::::casa Task tclean complete. Start time: 2026-09-02 15:19:38.144392 End time: 2026-09-02 15:19:41.292548 |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:41 INFO tclean::::casa ##### End Task: tclean ##### |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:41 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:41 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:41 INFO tclean::::casa ##### Begin Task: tclean ##### |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:41 INFO tclean::::casa tclean( vis='refim_point.ms', selectdata=True, field='', spw='0:0~5,0:15~19', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='savemod.ser', imsize=100, cell='10.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel=['savemod.par.model'], 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=False, restoringbeam=[], pbcor=False, outlierfile='', weighting='natural', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.0, uvtaper=[''], niter=0, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='modelcolumn', calcres=False, calcpsf=False, psfcutoff=0.35, parallel=False ) |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:41 INFO tclean::::casa Verifying Input Parameters |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:41 INFO Clearing all model records in MS header. |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:41 INFO SynthesisImagerVi2::selectData MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened with scratch model column] |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:41 INFO SynthesisImagerVi2::selectData NRows selected : 168480 |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:42 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.ser] : |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:42 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.ser] : |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:42 INFO SynthesisImagerVi2::defineImage Impars: start |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:42 INFO SynthesisImagerVi2::defineImage Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:42 INFO SynthesisImagerVi2::defineImage Set Gridding options for [savemod.ser] with ftmachine : gridft |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:42 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.002124 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:42 INFO SIImageStore::setModelImageOne Copying input model savemod.par.model to savemod.ser.model |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:42 INFO SynthesisImagerVi2::weight() Set imaging weights : Natural weighting |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:42 INFO SynthesisImagerVi2::predictModel ---------------------------------------------------- Predict Model --------------------------------------------- |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:42 INFO SynthesisImagerVi2::predictModel Saving model column |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:46 INFO tclean::::casa Searching for images with prefix 'savemod.ser'... Found these, writing history into them: ['savemod.ser.model', 'savemod.ser.psf'] |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:46 INFO tclean::::casa Task tclean complete. Start time: 2026-09-02 15:19:41.299987 End time: 2026-09-02 15:19:46.419471 |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:46 INFO tclean::::casa ##### End Task: tclean ##### |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:46 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:19:48
|
[check_chanvals] Chan 19 is (0.7212174927354114+0j) (Pass : should be <0.9) |
|
02-Sep-2026 19:19:48
|
|
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:47 INFO impbcor::::casa ########################################## |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:47 INFO impbcor::::casa ##### Begin Task: impbcor ##### |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:47 INFO impbcor::::casa impbcor( imagename='savemod.par.image', pbimage='savemod.par.pb', outfile='savemod.par.impbcor', overwrite=True, box='', region='', chans='', stokes='', mask='', mode='divide', cutoff=-1.0, stretch=False ) |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:47 INFO impbcor::CasacRegionManager::fromBCS No directional region specified. Using full positional plane. |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:47 INFO impbcor::CasacRegionManager::fromBCS Using all spectral channels. |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:47 INFO impbcor::CasacRegionManager::fromBCS Using polarizations ALL |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:47 INFO impbcor::ImageRegion::fromRecord Selected bounding box : |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:47 INFO impbcor::ImageRegion::fromRecord+ [0, 0, 0, 0] to [99, 99, 0, 0] (20:00:12.398, +40.35.40.979, I, 1.47499e+09Hz to 19:58:45.301, +40.52.10.998, I, 1.47499e+09Hz) |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:47 INFO impbcor::ImageRegion::fromRecord Selected bounding box : |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:47 INFO impbcor::ImageRegion::fromRecord+ [0, 0, 0, 0] to [99, 99, 0, 0] (20:00:12.398, +40.35.40.979, I, 1.47499e+09Hz to 19:58:45.301, +40.52.10.998, I, 1.47499e+09Hz) |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:47 INFO impbcor::SubImageFactory::createImage Creating image 'savemod.par.impbcor' of shape [100, 100, 1, 1] |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:47 INFO impbcor::::casa Task impbcor complete. Start time: 2026-09-02 15:19:46.740554 End time: 2026-09-02 15:19:46.854242 |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:47 INFO impbcor::::casa ##### End Task: impbcor ##### |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:47 INFO impbcor::::casa ########################################## |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:47 INFO name:: No table opened. |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:47 INFO showcache:: The Table Cache is empty. |
|
02-Sep-2026 19:19:48
|
Run with mfs - mtmfs - usestartmodel = False - imaging in serial |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:47 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:47 INFO tclean::::casa ##### Begin Task: tclean ##### |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:47 INFO tclean::::casa tclean( vis='refim_point.ms', selectdata=True, field='', spw='0:0~5,0:15~19', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='savemod.par', imsize=100, cell='10.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='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='natural', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.0, uvtaper=[''], niter=0, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='none', calcres=True, calcpsf=True, psfcutoff=0.35, parallel=True ) |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:47 INFO tclean::::casa Verifying Input Parameters |
|
02-Sep-2026 19:19:48
|
2026-09-02 19:19:48 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 2 |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:48 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 3 |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:48 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 1 |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:49 INFO tclean::::casa setupCluster, Setting up 3 engines. |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:49 INFO SynthesisUtilMethods::continuumDataPartition |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:49 INFO SynthesisUtilMethods::continuumDataPartition + Rows = 112323 168480 [P][M]: 0:2 ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:49 INFO tclean::::casa Partitioned Selection : {'0': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:0~5,0:15~19', 'state': '', 'taql': 'ROWNUMBER() >= 1 && ROWNUMBER() <= 56161', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '1': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:0~5,0:15~19', 'state': '', 'taql': 'ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '2': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:0~5,0:15~19', 'state': '', 'taql': 'ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480', 'timestr': '', 'usescratch': False, 'uvdist': ''}}} |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:50 INFO SynthesisImagerVi2::selectData MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:50 INFO SynthesisImagerVi2::selectData NRows selected : 168480 |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:50 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:50 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:50 INFO SynthesisImagerVi2::defineImage Impars: start |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:50 INFO SynthesisImagerVi2::defineImage Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:50 INFO SynthesisImagerVi2::defineImage Set Gridding options for [savemod.par] with ftmachine : gridft |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:50 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.003541 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:50 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:51 INFO tclean::::casa ...done |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:51 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:51 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:51 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:51 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 Selecting via TaQL : ROWNUMBER() >= 1 && ROWNUMBER() <= 56161 | NRows selected : 56161 |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:51 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:51 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 Selecting via TaQL : ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 | NRows selected : 56158 |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:51 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 Selecting via TaQL : ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322 | NRows selected : 56161 |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:52 INFO tclean::::casa ...done |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:52 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1] : |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:52 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1] : |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:52 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Impars: start |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:52 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:52 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Set Gridding options for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1] with ftmachine : gridft |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:52 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-1 Required memory: 0.003541 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:53 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2] : |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:53 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2] : |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:53 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Impars: start |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:53 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:53 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Set Gridding options for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2] with ftmachine : gridft |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:53 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-2 Required memory: 0.003541 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:53 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:19:53
|
2026-09-02 19:19:53 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] : |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:19:53 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] : |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:19:53 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Impars: start |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:19:53 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:19:53 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Set Gridding options for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] with ftmachine : gridft |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:19:53 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-3 Required memory: 0.003541 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:19:54 INFO tclean::::casa ...done |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:19:57 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:19:57 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-1 Set imaging weights : Natural weighting |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:19:57 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-3 Set imaging weights : Natural weighting |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:19:57 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-2 Set imaging weights : Natural weighting |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:19:58 INFO tclean::::casa ...done |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:19:58 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [savemod.par] : mtmfs |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:19:58 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:19:59 INFO tclean::::casa ...done |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:19:59 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:19:59 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-1 ----------------------------------------------------------- Make PSF --------------------------------------------- |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:19:59 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-3 ----------------------------------------------------------- Make PSF --------------------------------------------- |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:19:59 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-2 ----------------------------------------------------------- Make PSF --------------------------------------------- |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:02 INFO tclean::::casa ...done |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:02 INFO SynthesisNormalizer::gatherImages Gather psf,weight images : [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] onto :savemod.par |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:02 INFO SIImageStoreMultiTerm::calcSensitivity Multi-Term Hessian Matrix : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order) |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:02 INFO SIImageStoreMultiTerm::calcSensitivity + [3.53965e+06, -49087 |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:02 INFO SIImageStoreMultiTerm::calcSensitivity + -49087, 222874] |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:02 INFO SIImageStoreMultiTerm::calcSensitivity Multi-Term Covariance Matrix : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order) |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:02 INFO SIImageStoreMultiTerm::calcSensitivity + [2.8338e-07, 6.2413e-08 |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:02 INFO SIImageStoreMultiTerm::calcSensitivity + 6.2413e-08, 4.50058e-06] |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:02 INFO SIImageStoreMultiTerm::calcSensitivity [savemod.par][Taylor0] Theoretical sensitivity (Jy/bm):0.000532334 |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:02 INFO SIImageStoreMultiTerm::calcSensitivity [savemod.par][Taylor1] Theoretical sensitivity (Jy/bm):0.00212146 |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:02 INFO SIImageStoreMultiTerm::calcFractionalBandwidth MFS frequency range : 0.974989 GHz -> 1.97498GHz.Fractional Bandwidth : 67.7968 %.Reference Frequency for Taylor Expansion : 1.47499GHz. |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:02 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.005007 |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:02 INFO SIImageStore::printBeamSet Beam : 53.0943 arcsec, 49.5719 arcsec, -88.6243 deg |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:02 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:02 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::makePrimaryBeam::MPIServer-1 vi2 : Evaluating Primary Beam model onto image grid(s) |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:03 INFO tclean::::casa ...done |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:03 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : savemod.par to all nodes :[/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:03 INFO task_tclean::SIImageStore::setModelImageOne Starting model image savemod.par.model.tt0 does not exist. No initial prediction will be done for term0 |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:03 INFO task_tclean::SIImageStore::setModelImageOne Starting model image savemod.par.model.tt1 does not exist. No initial prediction will be done for term1 |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:03 INFO task_tclean::SIImageStore::setModelImageOne Starting model image savemod.par.model.tt0 does not exist. No initial prediction will be done for term0 |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:03 INFO task_tclean::SIImageStore::setModelImageOne Starting model image savemod.par.model.tt1 does not exist. No initial prediction will be done for term1 |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:03 INFO task_tclean::SIImageStore::setModelImageOne Starting model image savemod.par.model.tt0 does not exist. No initial prediction will be done for term0 |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:03 INFO task_tclean::SIImageStore::setModelImageOne Starting model image savemod.par.model.tt1 does not exist. No initial prediction will be done for term1 |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:03 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:03 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:04 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:04 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:04 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 19:20:05
|
2026-09-02 19:20:05 INFO tclean::::casa ...done |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:05 INFO SynthesisNormalizer::gatherImages Gather residual images : [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] onto :savemod.par |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:06 INFO task_tclean::MultiTermMatrixCleaner::verifyScaleSizes() Scale sizes to be used for deconvolution : [0] |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:06 INFO task_tclean::MultiTermMatrixCleaner::initialise() Using a PSF patch of 80 pixels on each side for minor-cycle updates. |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:06 INFO task_tclean::MatrixCleaner::validatePsf() Peak of PSF = 1 at [50, 50] |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:06 INFO task_tclean::MultiTermMatrixCleaner::computeprincipalsolution() MTMC :: Computing principal solution on residuals |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:06 INFO task_tclean::MultiTermMatrixCleaner::computeHessianPeak Calculating PSF and Scale convolutions |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:06 INFO task_tclean::MultiTermMatrixCleaner::computeHessianPeak The Matrix [H] for 0 pixel scale is : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order) |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:06 INFO task_tclean::MultiTermMatrixCleaner::computeHessianPeak + [1, -0.0138678 |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:06 INFO task_tclean::MultiTermMatrixCleaner::computeHessianPeak + -0.0138678, 0.0629652] |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:06 INFO task_tclean::SDAlgorithmBase::restore [savemod.par] : Restoring model image. |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:06 WARN task_tclean::SIImageStore::restore (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SIImageStore.cc, line 2353) Restoring with an empty model image. Only residuals will be processed to form the output restored image. |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:06 INFO task_tclean::SIImageStore::restore Beam for chan : 0 : 53.0943 arcsec, 49.5719 arcsec, -88.6243 deg |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:06 WARN task_tclean::SIImageStore::restore (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SIImageStore.cc, line 2353) Restoring with an empty model image. Only residuals will be processed to form the output restored image. |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:06 INFO task_tclean::SIImageStore::restore Beam for chan : 0 : 53.0943 arcsec, 49.5719 arcsec, -88.6243 deg |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:06 INFO task_tclean::SIImageStoreMultiTerm::calculateAlphaBeta Calculating spectral parameters for Intensity > peakresidual/10 = 0.10855 Jy/beam |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:06 INFO task_tclean::SIImageStoreMultiTerm::calculateAlphaBeta Written Spectral Index Error Image : /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.alpha.error |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:06 INFO task_tclean::SDAlgorithmMSMFS::restore Restored images : |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:06 INFO task_tclean::SDAlgorithmMSMFS::restore /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.image.tt0 (model=/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.model.tt0) |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:06 INFO task_tclean::SDAlgorithmMSMFS::restore /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.image.tt1 (model=/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.model.tt1) |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:06 INFO task_tclean::SDAlgorithmMSMFS::restore |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:19 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:19 INFO ::casa::MPIServer-1 node 1 has completed its job |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:19 INFO ::casa::MPIServer-3 node 3 has completed its job |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:19 INFO ::casa::MPIServer-2 node 2 has completed its job |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:20 INFO tclean::::casa ...done |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:20 INFO tclean::::casa Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed. |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:20 INFO tclean::::casa Searching for images with prefix 'savemod.par'... Found these, writing history into them: ['savemod.par.psf.tt0', 'savemod.par.sumwt.tt0', 'savemod.par.psf.tt1', 'savemod.par.sumwt.tt1', 'savemod.par.psf.tt2', 'savemod.par.sumwt.tt2', 'savemod.par.pb.tt0', 'savemod.par.residual.tt0', 'savemod.par.residual.tt1', 'savemod.par.image.tt0', 'savemod.par.model.tt0', 'savemod.par.image.tt1', 'savemod.par.model.tt1', 'savemod.par.alpha', 'savemod.par.alpha.error'] |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:20 INFO tclean::::casa Task tclean complete. Start time: 2026-09-02 15:19:47.271456 End time: 2026-09-02 15:20:20.278410 |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:20 INFO tclean::::casa ##### End Task: tclean ##### |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:20 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:20 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:20 INFO tclean::::casa ##### Begin Task: tclean ##### |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:20 INFO tclean::::casa tclean( vis='refim_point.ms', selectdata=True, field='', spw='0:0~5,0:15~19', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='savemod.par', imsize=100, cell='10.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='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='natural', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.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=False, calcpsf=False, psfcutoff=0.35, parallel=False ) |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:20 INFO tclean::::casa Verifying Input Parameters |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:20 INFO SynthesisImagerVi2::selectData MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:20 INFO SynthesisImagerVi2::selectData NRows selected : 168480 |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:21 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:21 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:21 INFO SynthesisImagerVi2::defineImage Impars: start |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:21 INFO SynthesisImagerVi2::defineImage Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:21 INFO SynthesisImagerVi2::defineImage Set Gridding options for [savemod.par] with ftmachine : gridft |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:21 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.003541 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:21 INFO SynthesisImagerVi2::weight() Set imaging weights : Natural weighting |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:21 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [savemod.par] : mtmfs |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:21 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 1.10061 |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:21 INFO SynthesisDeconvolver::setupMask [savemod.par] Initializing new mask to 1.0 for the full image |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:21 INFO SynthesisDeconvolver::setupMask [savemod.par] Number of pixels in the clean mask : 10000 out of a total of 10000 pixels. [ 100 % ] |
|
02-Sep-2026 19:20:20
|
2026-09-02 19:20:21 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 1.10061, over full image : 1.10061 |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:21 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 10, 'cyclethreshold': 0.13606752455234528, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:21 INFO SDAlgorithmBase::deconvolve [savemod.par] Run mtmfs minor-cycle | CycleThreshold=0.136068, CycleNiter=10, Gain=0.1 |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:21 INFO MultiTermMatrixCleaner::verifyScaleSizes() Scale sizes to be used for deconvolution : [0] |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:21 INFO MultiTermMatrixCleaner::initialise() Using a PSF patch of 80 pixels on each side for minor-cycle updates. |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:21 INFO MatrixCleaner::validatePsf() Peak of PSF = 1 at [50, 50] |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:21 INFO SIImageStoreMultiTerm::calcFractionalBandwidth MFS frequency range : 0.974989 GHz -> 1.97498GHz.Fractional Bandwidth : 67.7968 %.Reference Frequency for Taylor Expansion : 1.47499GHz. |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:21 INFO MultiTermMatrixCleaner::computeHessianPeak Calculating PSF and Scale convolutions |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:21 INFO MultiTermMatrixCleaner::computeHessianPeak The Matrix [H] for 0 pixel scale is : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order) |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:21 INFO MultiTermMatrixCleaner::computeHessianPeak + [1, -0.0138678 |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:21 INFO MultiTermMatrixCleaner::computeHessianPeak + -0.0138678, 0.0629652] |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:21 INFO MultiTermMatrixCleaner::mtclean() Calculating convolutions of residual images with scales |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:21 INFO MultiTermMatrixCleaner::mtclean() Peak convolved residual (within mask) : 1.10061 |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:21 INFO [10] Res: 0.383759 Max: 0.192997 Gain: 0.1 Pos: [50, 50] Scale: 0 Coeffs: 0.420546 -0.422054 |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:21 INFO MultiTermMatrixCleaner::mtclean() Reached max number of iterations for this minor cycle |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:21 INFO MultiTermMatrixCleaner::mtclean() Total flux by scale : [0]: 0.707011 (in this run) |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:21 INFO MultiTermMatrixCleaner::mtclean() Total flux by Taylor coefficient : [0]: 0.707011 [1]: -0.709546 |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:21 INFO SDAlgorithmBase::deconvolve [savemod.par] iters=0->10 [10], model=0->0.707011, peakres=1.10061->0.383759, Reached cycleniter. |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:21 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 10 iterations. |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:21 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.383758, over full image : 0.383758 |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO tclean::::casa Reached global stopping criterion : iteration limit |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO tclean::::casa getSummary call: fullsummary=False |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO MultiTermMatrixCleaner::computeprincipalsolution() MTMC :: Computing principal solution on residuals |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO SDAlgorithmBase::restore [savemod.par] : Restoring model image. |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO SIImageStore::restore Beam for chan : 0 : 53.0943 arcsec, 49.5719 arcsec, -88.6243 deg |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO SIImageStore::restore Beam for chan : 0 : 53.0943 arcsec, 49.5719 arcsec, -88.6243 deg |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO SIImageStoreMultiTerm::calculateAlphaBeta Calculating spectral parameters for Intensity > peakresidual/10 = 0.037849 Jy/beam |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO SIImageStoreMultiTerm::calculateAlphaBeta Written Spectral Index Error Image : /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.alpha.error |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO SDAlgorithmMSMFS::restore Restored images : |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO SDAlgorithmMSMFS::restore /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.image.tt0 (model=/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.model.tt0) |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO SDAlgorithmMSMFS::restore /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.image.tt1 (model=/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.model.tt1) |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO SDAlgorithmMSMFS::restore |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO tclean::::casa Searching for images with prefix 'savemod.par'... Found these, writing history into them: ['savemod.par.psf.tt0', 'savemod.par.sumwt.tt0', 'savemod.par.psf.tt1', 'savemod.par.sumwt.tt1', 'savemod.par.psf.tt2', 'savemod.par.sumwt.tt2', 'savemod.par.pb.tt0', 'savemod.par.residual.tt0', 'savemod.par.residual.tt1', 'savemod.par.image.tt0', 'savemod.par.model.tt0', 'savemod.par.image.tt1', 'savemod.par.model.tt1', 'savemod.par.alpha', 'savemod.par.alpha.error', 'savemod.par.mask'] |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO tclean::::casa Task tclean complete. Start time: 2026-09-02 15:20:20.285456 End time: 2026-09-02 15:20:25.436108 |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO tclean::::casa ##### End Task: tclean ##### |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO tclean::::casa ##### Begin Task: tclean ##### |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO tclean::::casa tclean( vis='refim_point.ms', selectdata=True, field='', spw='0:0~5,0:15~19', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='savemod.par', imsize=100, cell='10.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel=[], specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='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=False, restoringbeam=[], pbcor=False, outlierfile='', weighting='natural', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.0, uvtaper=[''], niter=0, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='modelcolumn', calcres=False, calcpsf=False, psfcutoff=0.35, parallel=False ) |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO tclean::::casa Verifying Input Parameters |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO Clearing all model records in MS header. |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO SynthesisImagerVi2::selectData MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened with scratch model column] |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:25 INFO SynthesisImagerVi2::selectData NRows selected : 168480 |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:26 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:26 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:26 INFO SynthesisImagerVi2::defineImage Impars: start |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:26 INFO SynthesisImagerVi2::defineImage Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:26 INFO SynthesisImagerVi2::defineImage Set Gridding options for [savemod.par] with ftmachine : gridft |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:26 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.003541 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:20:25
|
2026-09-02 19:20:26 INFO SynthesisImagerVi2::weight() Set imaging weights : Natural weighting |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:26 INFO SynthesisImagerVi2::predictModel ---------------------------------------------------- Predict Model --------------------------------------------- |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:26 INFO SynthesisImagerVi2::predictModel Saving model column |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:31 INFO tclean::::casa Searching for images with prefix 'savemod.par'... Found these, writing history into them: ['savemod.par.psf.tt0', 'savemod.par.sumwt.tt0', 'savemod.par.psf.tt1', 'savemod.par.sumwt.tt1', 'savemod.par.psf.tt2', 'savemod.par.sumwt.tt2', 'savemod.par.pb.tt0', 'savemod.par.residual.tt0', 'savemod.par.residual.tt1', 'savemod.par.image.tt0', 'savemod.par.model.tt0', 'savemod.par.image.tt1', 'savemod.par.model.tt1', 'savemod.par.alpha', 'savemod.par.alpha.error', 'savemod.par.mask'] |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:31 INFO tclean::::casa Task tclean complete. Start time: 2026-09-02 15:20:25.444069 End time: 2026-09-02 15:20:31.415412 |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:31 INFO tclean::::casa ##### End Task: tclean ##### |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:31 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:20:36
|
[check_chanvals] Chan 19 is (0.4569648818094336+0j) (Pass : should be <0.9) |
|
02-Sep-2026 19:20:36
|
|
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:32 INFO impbcor::::casa ########################################## |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:32 INFO impbcor::::casa ##### Begin Task: impbcor ##### |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:32 INFO impbcor::::casa impbcor( imagename='savemod.par.image.tt0', pbimage='savemod.par.pb.tt0', outfile='savemod.par.impbcor.tt0', overwrite=True, box='', region='', chans='', stokes='', mask='', mode='divide', cutoff=-1.0, stretch=False ) |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:32 INFO impbcor::CasacRegionManager::fromBCS No directional region specified. Using full positional plane. |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:32 INFO impbcor::CasacRegionManager::fromBCS Using all spectral channels. |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:32 INFO impbcor::CasacRegionManager::fromBCS Using polarizations ALL |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:32 INFO impbcor::ImageRegion::fromRecord Selected bounding box : |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:32 INFO impbcor::ImageRegion::fromRecord+ [0, 0, 0, 0] to [99, 99, 0, 0] (20:00:12.398, +40.35.40.979, I, 1.47499e+09Hz to 19:58:45.301, +40.52.10.998, I, 1.47499e+09Hz) |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:32 INFO impbcor::ImageRegion::fromRecord Selected bounding box : |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:32 INFO impbcor::ImageRegion::fromRecord+ [0, 0, 0, 0] to [99, 99, 0, 0] (20:00:12.398, +40.35.40.979, I, 1.47499e+09Hz to 19:58:45.301, +40.52.10.998, I, 1.47499e+09Hz) |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:32 INFO impbcor::SubImageFactory::createImage Creating image 'savemod.par.impbcor.tt0' of shape [100, 100, 1, 1] |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:32 INFO impbcor::::casa Task impbcor complete. Start time: 2026-09-02 15:20:31.752978 End time: 2026-09-02 15:20:31.867939 |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:32 INFO impbcor::::casa ##### End Task: impbcor ##### |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:32 INFO impbcor::::casa ########################################## |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:32 INFO name:: No table opened. |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:32 INFO showcache:: The Table Cache is empty. |
|
02-Sep-2026 19:20:36
|
Run with mfs - mtmfs - usestartmodel = True - imaging in serial |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:32 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:32 INFO tclean::::casa ##### Begin Task: tclean ##### |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:32 INFO tclean::::casa tclean( vis='refim_point.ms', selectdata=True, field='', spw='0:0~5,0:15~19', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='savemod.par', imsize=100, cell='10.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='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='natural', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.0, uvtaper=[''], niter=0, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='none', calcres=True, calcpsf=True, psfcutoff=0.35, parallel=True ) |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:32 INFO tclean::::casa Verifying Input Parameters |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:33 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 2 |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:33 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 1 |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:33 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 3 |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:35 INFO tclean::::casa setupCluster, Setting up 3 engines. |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:35 INFO SynthesisUtilMethods::continuumDataPartition |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:35 INFO SynthesisUtilMethods::continuumDataPartition + Rows = 112323 168480 [P][M]: 0:2 ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:35 INFO tclean::::casa Partitioned Selection : {'0': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:0~5,0:15~19', 'state': '', 'taql': 'ROWNUMBER() >= 1 && ROWNUMBER() <= 56161', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '1': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:0~5,0:15~19', 'state': '', 'taql': 'ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '2': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:0~5,0:15~19', 'state': '', 'taql': 'ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480', 'timestr': '', 'usescratch': False, 'uvdist': ''}}} |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:35 INFO SynthesisImagerVi2::selectData MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:35 INFO SynthesisImagerVi2::selectData NRows selected : 168480 |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:35 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:35 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:35 INFO SynthesisImagerVi2::defineImage Impars: start |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:35 INFO SynthesisImagerVi2::defineImage Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:35 INFO SynthesisImagerVi2::defineImage Set Gridding options for [savemod.par] with ftmachine : gridft |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:35 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.003541 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:35 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:36 INFO tclean::::casa ...done |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:36 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:20:36
|
2026-09-02 19:20:36 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:36 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:36 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 Selecting via TaQL : ROWNUMBER() >= 1 && ROWNUMBER() <= 56161 | NRows selected : 56161 |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:36 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 Selecting via TaQL : ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 | NRows selected : 56158 |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:36 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:36 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 Selecting via TaQL : ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322 | NRows selected : 56161 |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:37 INFO tclean::::casa ...done |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:37 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1] : |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:37 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1] : |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:38 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Impars: start |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:38 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:38 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Set Gridding options for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1] with ftmachine : gridft |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:38 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-1 Required memory: 0.003541 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:38 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2] : |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:38 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2] : |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:38 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Impars: start |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:38 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:38 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Set Gridding options for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2] with ftmachine : gridft |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:38 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-2 Required memory: 0.003541 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:38 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:38 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] : |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:38 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] : |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:38 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Impars: start |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:38 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:38 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Set Gridding options for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] with ftmachine : gridft |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:38 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-3 Required memory: 0.003541 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:39 INFO tclean::::casa ...done |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:42 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:42 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-2 Set imaging weights : Natural weighting |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:42 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-1 Set imaging weights : Natural weighting |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:42 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-3 Set imaging weights : Natural weighting |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:43 INFO tclean::::casa ...done |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:43 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [savemod.par] : mtmfs |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:43 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:44 INFO tclean::::casa ...done |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:44 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:44 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-2 ----------------------------------------------------------- Make PSF --------------------------------------------- |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:44 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-1 ----------------------------------------------------------- Make PSF --------------------------------------------- |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:44 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-3 ----------------------------------------------------------- Make PSF --------------------------------------------- |
|
02-Sep-2026 19:20:46
|
2026-09-02 19:20:47 INFO tclean::::casa ...done |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:47 INFO SynthesisNormalizer::gatherImages Gather psf,weight images : [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] onto :savemod.par |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:47 INFO SIImageStoreMultiTerm::calcSensitivity Multi-Term Hessian Matrix : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order) |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:47 INFO SIImageStoreMultiTerm::calcSensitivity + [3.53965e+06, -49087 |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:47 INFO SIImageStoreMultiTerm::calcSensitivity + -49087, 222874] |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:47 INFO SIImageStoreMultiTerm::calcSensitivity Multi-Term Covariance Matrix : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order) |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:47 INFO SIImageStoreMultiTerm::calcSensitivity + [2.8338e-07, 6.2413e-08 |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:47 INFO SIImageStoreMultiTerm::calcSensitivity + 6.2413e-08, 4.50058e-06] |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:47 INFO SIImageStoreMultiTerm::calcSensitivity [savemod.par][Taylor0] Theoretical sensitivity (Jy/bm):0.000532334 |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:47 INFO SIImageStoreMultiTerm::calcSensitivity [savemod.par][Taylor1] Theoretical sensitivity (Jy/bm):0.00212146 |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:47 INFO SIImageStoreMultiTerm::calcFractionalBandwidth MFS frequency range : 0.974989 GHz -> 1.97498GHz.Fractional Bandwidth : 67.7968 %.Reference Frequency for Taylor Expansion : 1.47499GHz. |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:47 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.005001 |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:47 INFO SIImageStore::printBeamSet Beam : 53.0943 arcsec, 49.5719 arcsec, -88.6243 deg |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:47 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::makePrimaryBeam::MPIServer-1 vi2 : Evaluating Primary Beam model onto image grid(s) |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:48 INFO tclean::::casa ...done |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:48 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : savemod.par to all nodes :[/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:48 INFO task_tclean::SIImageStore::setModelImageOne Starting model image savemod.par.model.tt0 does not exist. No initial prediction will be done for term0 |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:48 INFO task_tclean::SIImageStore::setModelImageOne Starting model image savemod.par.model.tt1 does not exist. No initial prediction will be done for term1 |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:48 INFO task_tclean::SIImageStore::setModelImageOne Starting model image savemod.par.model.tt0 does not exist. No initial prediction will be done for term0 |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:48 INFO task_tclean::SIImageStore::setModelImageOne Starting model image savemod.par.model.tt1 does not exist. No initial prediction will be done for term1 |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:48 INFO task_tclean::SIImageStore::setModelImageOne Starting model image savemod.par.model.tt0 does not exist. No initial prediction will be done for term0 |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:48 INFO task_tclean::SIImageStore::setModelImageOne Starting model image savemod.par.model.tt1 does not exist. No initial prediction will be done for term1 |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:48 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:48 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:49 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:49 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:49 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:50 INFO tclean::::casa ...done |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:50 INFO SynthesisNormalizer::gatherImages Gather residual images : [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] onto :savemod.par |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:51 INFO task_tclean::MultiTermMatrixCleaner::verifyScaleSizes() Scale sizes to be used for deconvolution : [0] |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:51 INFO task_tclean::MultiTermMatrixCleaner::initialise() Using a PSF patch of 80 pixels on each side for minor-cycle updates. |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:51 INFO task_tclean::MatrixCleaner::validatePsf() Peak of PSF = 1 at [50, 50] |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:51 INFO task_tclean::MultiTermMatrixCleaner::computeprincipalsolution() MTMC :: Computing principal solution on residuals |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:51 INFO task_tclean::MultiTermMatrixCleaner::computeHessianPeak Calculating PSF and Scale convolutions |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:51 INFO task_tclean::MultiTermMatrixCleaner::computeHessianPeak The Matrix [H] for 0 pixel scale is : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order) |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:51 INFO task_tclean::MultiTermMatrixCleaner::computeHessianPeak + [1, -0.0138678 |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:51 INFO task_tclean::MultiTermMatrixCleaner::computeHessianPeak + -0.0138678, 0.0629652] |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:51 INFO task_tclean::SDAlgorithmBase::restore [savemod.par] : Restoring model image. |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:51 WARN task_tclean::SIImageStore::restore (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SIImageStore.cc, line 2353) Restoring with an empty model image. Only residuals will be processed to form the output restored image. |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:51 INFO task_tclean::SIImageStore::restore Beam for chan : 0 : 53.0943 arcsec, 49.5719 arcsec, -88.6243 deg |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:51 WARN task_tclean::SIImageStore::restore (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SIImageStore.cc, line 2353) Restoring with an empty model image. Only residuals will be processed to form the output restored image. |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:51 INFO task_tclean::SIImageStore::restore Beam for chan : 0 : 53.0943 arcsec, 49.5719 arcsec, -88.6243 deg |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:51 INFO task_tclean::SIImageStoreMultiTerm::calculateAlphaBeta Calculating spectral parameters for Intensity > peakresidual/10 = 0.10855 Jy/beam |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:51 INFO task_tclean::SIImageStoreMultiTerm::calculateAlphaBeta Written Spectral Index Error Image : /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.alpha.error |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:51 INFO task_tclean::SDAlgorithmMSMFS::restore Restored images : |
|
02-Sep-2026 19:20:51
|
2026-09-02 19:20:51 INFO task_tclean::SDAlgorithmMSMFS::restore /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.image.tt0 (model=/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.model.tt0) |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:20:51 INFO task_tclean::SDAlgorithmMSMFS::restore /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.image.tt1 (model=/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.model.tt1) |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:20:51 INFO task_tclean::SDAlgorithmMSMFS::restore |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:04 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:04 INFO ::casa::MPIServer-1 node 1 has completed its job |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:04 INFO ::casa::MPIServer-3 node 3 has completed its job |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:04 INFO ::casa::MPIServer-2 node 2 has completed its job |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:05 INFO tclean::::casa ...done |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:05 INFO tclean::::casa Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed. |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:05 INFO tclean::::casa Searching for images with prefix 'savemod.par'... Found these, writing history into them: ['savemod.par.psf.tt0', 'savemod.par.sumwt.tt0', 'savemod.par.psf.tt1', 'savemod.par.sumwt.tt1', 'savemod.par.psf.tt2', 'savemod.par.sumwt.tt2', 'savemod.par.pb.tt0', 'savemod.par.residual.tt0', 'savemod.par.residual.tt1', 'savemod.par.image.tt0', 'savemod.par.model.tt0', 'savemod.par.image.tt1', 'savemod.par.model.tt1', 'savemod.par.alpha', 'savemod.par.alpha.error'] |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:05 INFO tclean::::casa Task tclean complete. Start time: 2026-09-02 15:20:32.313693 End time: 2026-09-02 15:21:05.293112 |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:05 INFO tclean::::casa ##### End Task: tclean ##### |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:05 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:05 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:05 INFO tclean::::casa ##### Begin Task: tclean ##### |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:05 INFO tclean::::casa tclean( vis='refim_point.ms', selectdata=True, field='', spw='0:0~5,0:15~19', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='savemod.par', imsize=100, cell='10.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='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='natural', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.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=False, calcpsf=False, psfcutoff=0.35, parallel=False ) |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:05 INFO tclean::::casa Verifying Input Parameters |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:05 INFO SynthesisImagerVi2::selectData MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:05 INFO SynthesisImagerVi2::selectData NRows selected : 168480 |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO SynthesisImagerVi2::defineImage Impars: start |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO SynthesisImagerVi2::defineImage Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO SynthesisImagerVi2::defineImage Set Gridding options for [savemod.par] with ftmachine : gridft |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.003541 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO SynthesisImagerVi2::weight() Set imaging weights : Natural weighting |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [savemod.par] : mtmfs |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 1.10061 |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO SynthesisDeconvolver::setupMask [savemod.par] Initializing new mask to 1.0 for the full image |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO SynthesisDeconvolver::setupMask [savemod.par] Number of pixels in the clean mask : 10000 out of a total of 10000 pixels. [ 100 % ] |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 1.10061, over full image : 1.10061 |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 10, 'cyclethreshold': 0.13606752455234528, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO SDAlgorithmBase::deconvolve [savemod.par] Run mtmfs minor-cycle | CycleThreshold=0.136068, CycleNiter=10, Gain=0.1 |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO MultiTermMatrixCleaner::verifyScaleSizes() Scale sizes to be used for deconvolution : [0] |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO MultiTermMatrixCleaner::initialise() Using a PSF patch of 80 pixels on each side for minor-cycle updates. |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO MatrixCleaner::validatePsf() Peak of PSF = 1 at [50, 50] |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO SIImageStoreMultiTerm::calcFractionalBandwidth MFS frequency range : 0.974989 GHz -> 1.97498GHz.Fractional Bandwidth : 67.7968 %.Reference Frequency for Taylor Expansion : 1.47499GHz. |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO MultiTermMatrixCleaner::computeHessianPeak Calculating PSF and Scale convolutions |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO MultiTermMatrixCleaner::computeHessianPeak The Matrix [H] for 0 pixel scale is : Axis Lengths: [2, 2] (NB: Matrix in Row/Column order) |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO MultiTermMatrixCleaner::computeHessianPeak + [1, -0.0138678 |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO MultiTermMatrixCleaner::computeHessianPeak + -0.0138678, 0.0629652] |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO MultiTermMatrixCleaner::mtclean() Calculating convolutions of residual images with scales |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO MultiTermMatrixCleaner::mtclean() Peak convolved residual (within mask) : 1.10061 |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO [10] Res: 0.383759 Max: 0.192997 Gain: 0.1 Pos: [50, 50] Scale: 0 Coeffs: 0.420546 -0.422054 |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO MultiTermMatrixCleaner::mtclean() Reached max number of iterations for this minor cycle |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO MultiTermMatrixCleaner::mtclean() Total flux by scale : [0]: 0.707011 (in this run) |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO MultiTermMatrixCleaner::mtclean() Total flux by Taylor coefficient : [0]: 0.707011 [1]: -0.709546 |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO SDAlgorithmBase::deconvolve [savemod.par] iters=0->10 [10], model=0->0.707011, peakres=1.10061->0.383759, Reached cycleniter. |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 10 iterations. |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:06 INFO task_tclean::SynthesisImager::executeMajorCycle ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:10 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.383758, over full image : 0.383758 |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:10 INFO tclean::::casa Reached global stopping criterion : iteration limit |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:10 INFO tclean::::casa getSummary call: fullsummary=False |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:10 INFO MultiTermMatrixCleaner::computeprincipalsolution() MTMC :: Computing principal solution on residuals |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:10 INFO SDAlgorithmBase::restore [savemod.par] : Restoring model image. |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:10 INFO SIImageStore::restore Beam for chan : 0 : 53.0943 arcsec, 49.5719 arcsec, -88.6243 deg |
|
02-Sep-2026 19:21:09
|
2026-09-02 19:21:10 INFO SIImageStore::restore Beam for chan : 0 : 53.0943 arcsec, 49.5719 arcsec, -88.6243 deg |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:10 INFO SIImageStoreMultiTerm::calculateAlphaBeta Calculating spectral parameters for Intensity > peakresidual/10 = 0.037849 Jy/beam |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:10 INFO SIImageStoreMultiTerm::calculateAlphaBeta Written Spectral Index Error Image : /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.alpha.error |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:10 INFO SDAlgorithmMSMFS::restore Restored images : |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:10 INFO SDAlgorithmMSMFS::restore /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.image.tt0 (model=/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.model.tt0) |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:10 INFO SDAlgorithmMSMFS::restore /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.image.tt1 (model=/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.model.tt1) |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:10 INFO SDAlgorithmMSMFS::restore |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:10 INFO tclean::::casa Searching for images with prefix 'savemod.par'... Found these, writing history into them: ['savemod.par.psf.tt0', 'savemod.par.sumwt.tt0', 'savemod.par.psf.tt1', 'savemod.par.sumwt.tt1', 'savemod.par.psf.tt2', 'savemod.par.sumwt.tt2', 'savemod.par.pb.tt0', 'savemod.par.residual.tt0', 'savemod.par.residual.tt1', 'savemod.par.image.tt0', 'savemod.par.model.tt0', 'savemod.par.image.tt1', 'savemod.par.model.tt1', 'savemod.par.alpha', 'savemod.par.alpha.error', 'savemod.par.mask'] |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:10 INFO tclean::::casa Task tclean complete. Start time: 2026-09-02 15:21:05.300165 End time: 2026-09-02 15:21:10.446031 |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:10 INFO tclean::::casa ##### End Task: tclean ##### |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:10 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:10 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:10 INFO tclean::::casa ##### Begin Task: tclean ##### |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:10 INFO tclean::::casa tclean( vis='refim_point.ms', selectdata=True, field='', spw='0:0~5,0:15~19', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='savemod.ser', imsize=100, cell='10.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel=['savemod.par.model.tt0', 'savemod.par.model.tt1'], 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=False, restoringbeam=[], pbcor=False, outlierfile='', weighting='natural', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.0, uvtaper=[''], niter=0, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='modelcolumn', calcres=False, calcpsf=False, psfcutoff=0.35, parallel=False ) |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:10 INFO tclean::::casa Verifying Input Parameters |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:10 INFO Clearing all model records in MS header. |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:10 INFO SynthesisImagerVi2::selectData MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened with scratch model column] |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:10 INFO SynthesisImagerVi2::selectData NRows selected : 168480 |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:11 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.ser] : |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:11 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.ser] : |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:11 INFO SynthesisImagerVi2::defineImage Impars: start |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:11 INFO SynthesisImagerVi2::defineImage Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:11 INFO SynthesisImagerVi2::defineImage Set Gridding options for [savemod.ser] with ftmachine : gridft |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:11 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.003541 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:11 INFO SIImageStore::setModelImageOne Copying input model savemod.par.model.tt0 to savemod.ser.model.tt0 |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:11 INFO SIImageStore::setModelImageOne Copying input model savemod.par.model.tt1 to savemod.ser.model.tt1 |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:11 INFO SIImageStore::setModelImageOne Copying input model savemod.par.model.tt0 to savemod.ser.model.tt0 |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:11 INFO SIImageStore::setModelImageOne Copying input model savemod.par.model.tt1 to savemod.ser.model.tt1 |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:11 INFO SynthesisImagerVi2::weight() Set imaging weights : Natural weighting |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:11 INFO SynthesisImagerVi2::predictModel ---------------------------------------------------- Predict Model --------------------------------------------- |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:11 INFO SynthesisImagerVi2::predictModel Saving model column |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:16 INFO tclean::::casa Searching for images with prefix 'savemod.ser'... Found these, writing history into them: ['savemod.ser.model.tt0', 'savemod.ser.model.tt1', 'savemod.ser.psf.tt0'] |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:16 INFO tclean::::casa Task tclean complete. Start time: 2026-09-02 15:21:10.453478 End time: 2026-09-02 15:21:16.336533 |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:16 INFO tclean::::casa ##### End Task: tclean ##### |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:16 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:21:16
|
[check_chanvals] Chan 19 is (0.4569648818094336+0j) (Pass : should be <0.9) |
|
02-Sep-2026 19:21:16
|
|
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:17 INFO impbcor::::casa ########################################## |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:17 INFO impbcor::::casa ##### Begin Task: impbcor ##### |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:17 INFO impbcor::::casa impbcor( imagename='savemod.par.image.tt0', pbimage='savemod.par.pb.tt0', outfile='savemod.par.impbcor.tt0', overwrite=True, box='', region='', chans='', stokes='', mask='', mode='divide', cutoff=-1.0, stretch=False ) |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:17 INFO impbcor::CasacRegionManager::fromBCS No directional region specified. Using full positional plane. |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:17 INFO impbcor::CasacRegionManager::fromBCS Using all spectral channels. |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:17 INFO impbcor::CasacRegionManager::fromBCS Using polarizations ALL |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:17 INFO impbcor::ImageRegion::fromRecord Selected bounding box : |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:17 INFO impbcor::ImageRegion::fromRecord+ [0, 0, 0, 0] to [99, 99, 0, 0] (20:00:12.398, +40.35.40.979, I, 1.47499e+09Hz to 19:58:45.301, +40.52.10.998, I, 1.47499e+09Hz) |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:17 INFO impbcor::ImageRegion::fromRecord Selected bounding box : |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:17 INFO impbcor::ImageRegion::fromRecord+ [0, 0, 0, 0] to [99, 99, 0, 0] (20:00:12.398, +40.35.40.979, I, 1.47499e+09Hz to 19:58:45.301, +40.52.10.998, I, 1.47499e+09Hz) |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:17 INFO impbcor::SubImageFactory::createImage Creating image 'savemod.par.impbcor.tt0' of shape [100, 100, 1, 1] |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:17 INFO impbcor::::casa Task impbcor complete. Start time: 2026-09-02 15:21:16.657721 End time: 2026-09-02 15:21:16.771563 |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:17 INFO impbcor::::casa ##### End Task: impbcor ##### |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:17 INFO impbcor::::casa ########################################## |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:17 INFO name:: No table opened. |
|
02-Sep-2026 19:21:16
|
2026-09-02 19:21:17 INFO showcache:: The Table Cache is empty. |
|
02-Sep-2026 19:21:22
|
Run with mfs - hogbom - usestartmodel = False - imaging in parallel |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:17 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:17 INFO tclean::::casa ##### Begin Task: tclean ##### |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:17 INFO tclean::::casa tclean( vis='refim_point.ms', selectdata=True, field='', spw='0:0~5,0:15~19', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='savemod.par', imsize=100, cell='10.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='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='natural', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.0, uvtaper=[''], niter=0, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='none', calcres=True, calcpsf=True, psfcutoff=0.35, parallel=True ) |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:17 INFO tclean::::casa Verifying Input Parameters |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:18 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 1 |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:18 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 2 |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:18 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 3 |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:19 INFO tclean::::casa setupCluster, Setting up 3 engines. |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:19 INFO SynthesisUtilMethods::continuumDataPartition |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:19 INFO SynthesisUtilMethods::continuumDataPartition + Rows = 112323 168480 [P][M]: 0:2 ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:19 INFO tclean::::casa Partitioned Selection : {'0': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:0~5,0:15~19', 'state': '', 'taql': 'ROWNUMBER() >= 1 && ROWNUMBER() <= 56161', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '1': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:0~5,0:15~19', 'state': '', 'taql': 'ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '2': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:0~5,0:15~19', 'state': '', 'taql': 'ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480', 'timestr': '', 'usescratch': False, 'uvdist': ''}}} |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:19 INFO SynthesisImagerVi2::selectData MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:19 INFO SynthesisImagerVi2::selectData NRows selected : 168480 |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:20 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:20 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:20 INFO SynthesisImagerVi2::defineImage Impars: start |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:20 INFO SynthesisImagerVi2::defineImage Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:20 INFO SynthesisImagerVi2::defineImage Set Gridding options for [savemod.par] with ftmachine : gridft |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:20 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.002124 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:20 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:21 INFO tclean::::casa ...done |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:21 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:21 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:21 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 Selecting via TaQL : ROWNUMBER() >= 1 && ROWNUMBER() <= 56161 | NRows selected : 56161 |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:21 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:21 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 Selecting via TaQL : ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 | NRows selected : 56158 |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:21 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:21 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 Selecting via TaQL : ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322 | NRows selected : 56161 |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:22 INFO tclean::::casa ...done |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:22 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1] : |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:22 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1] : |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:22 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Impars: start |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:22 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:22 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Set Gridding options for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1] with ftmachine : gridft |
|
02-Sep-2026 19:21:22
|
2026-09-02 19:21:22 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-1 Required memory: 0.002124 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:23 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2] : |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:23 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2] : |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:23 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Impars: start |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:23 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:23 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Set Gridding options for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2] with ftmachine : gridft |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:23 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-2 Required memory: 0.002124 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:23 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:23 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] : |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:23 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] : |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:23 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Impars: start |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:23 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:23 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Set Gridding options for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] with ftmachine : gridft |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:23 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-3 Required memory: 0.002124 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:24 INFO tclean::::casa ...done |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:26 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:27 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-1 Set imaging weights : Natural weighting |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:27 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-3 Set imaging weights : Natural weighting |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:27 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-2 Set imaging weights : Natural weighting |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:27 INFO tclean::::casa ...done |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:27 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [savemod.par] : hogbom |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:27 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:28 INFO tclean::::casa ...done |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:28 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:29 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-1 ----------------------------------------------------------- Make PSF --------------------------------------------- |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:29 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-3 ----------------------------------------------------------- Make PSF --------------------------------------------- |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:29 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-2 ----------------------------------------------------------- Make PSF --------------------------------------------- |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:30 INFO tclean::::casa ...done |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:31 INFO SynthesisNormalizer::gatherImages Gather psf,weight images : [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] onto :savemod.par |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:31 INFO SIImageStore::calcSensitivity [savemod.par] Theoretical sensitivity (Jy/bm):0.000531521 |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:31 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.005029 |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:31 INFO SIImageStore::printBeamSet Beam : 53.0943 arcsec, 49.5719 arcsec, -88.6243 deg |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:31 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:31 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::makePrimaryBeam::MPIServer-1 vi2 : Evaluating Primary Beam model onto image grid(s) |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:32 INFO tclean::::casa ...done |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:32 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : savemod.par to all nodes :[/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:32 INFO task_tclean::SIImageStore::setModelImageOne Starting model image savemod.par.model does not exist. No initial prediction will be done |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:32 INFO task_tclean::SIImageStore::setModelImageOne Starting model image savemod.par.model does not exist. No initial prediction will be done |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:32 INFO task_tclean::SIImageStore::setModelImageOne Starting model image savemod.par.model does not exist. No initial prediction will be done |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:32 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:32 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:32 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:32 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 19:21:33
|
2026-09-02 19:21:32 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:34 INFO tclean::::casa ...done |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:34 INFO SynthesisNormalizer::gatherImages Gather residual images : [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] onto :savemod.par |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:34 INFO task_tclean::SDAlgorithmBase::restore [savemod.par] : Restoring model image. |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:34 WARN task_tclean::SIImageStore::restore (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SIImageStore.cc, line 2353) Restoring with an empty model image. Only residuals will be processed to form the output restored image. |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:34 INFO task_tclean::SIImageStore::restore Beam for chan : 0 : 53.0943 arcsec, 49.5719 arcsec, -88.6243 deg |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:41 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:41 INFO ::casa::MPIServer-2 node 2 has completed its job |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:41 INFO ::casa::MPIServer-3 node 3 has completed its job |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:41 INFO ::casa::MPIServer-1 node 1 has completed its job |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:42 INFO tclean::::casa ...done |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:42 INFO tclean::::casa Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed. |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:42 INFO tclean::::casa Searching for images with prefix 'savemod.par'... Found these, writing history into them: ['savemod.par.psf', 'savemod.par.sumwt', 'savemod.par.pb', 'savemod.par.residual', 'savemod.par.image', 'savemod.par.model'] |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:42 INFO tclean::::casa Task tclean complete. Start time: 2026-09-02 15:21:17.191638 End time: 2026-09-02 15:21:42.255450 |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:42 INFO tclean::::casa ##### End Task: tclean ##### |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:42 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:42 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:42 INFO tclean::::casa ##### Begin Task: tclean ##### |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:42 INFO tclean::::casa tclean( vis='refim_point.ms', selectdata=True, field='', spw='0:0~5,0:15~19', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='savemod.par', imsize=100, cell='10.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='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='natural', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.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=False, calcpsf=False, psfcutoff=0.35, parallel=True ) |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:42 INFO tclean::::casa Verifying Input Parameters |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:45 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 2 |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:45 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 1 |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:45 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 3 |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:46 INFO tclean::::casa setupCluster, Setting up 3 engines. |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:46 INFO SynthesisUtilMethods::continuumDataPartition |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:46 INFO SynthesisUtilMethods::continuumDataPartition + Rows = 112323 168480 [P][M]: 0:2 ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:46 INFO tclean::::casa Partitioned Selection : {'0': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:0~5,0:15~19', 'state': '', 'taql': 'ROWNUMBER() >= 1 && ROWNUMBER() <= 56161', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '1': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:0~5,0:15~19', 'state': '', 'taql': 'ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '2': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:0~5,0:15~19', 'state': '', 'taql': 'ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480', 'timestr': '', 'usescratch': False, 'uvdist': ''}}} |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:46 INFO SynthesisImagerVi2::selectData MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:47 INFO SynthesisImagerVi2::selectData NRows selected : 168480 |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:47 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:47 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:47 INFO SynthesisImagerVi2::defineImage Impars: start |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:47 INFO SynthesisImagerVi2::defineImage Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:47 INFO SynthesisImagerVi2::defineImage Set Gridding options for [savemod.par] with ftmachine : gridft |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:47 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.002124 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:47 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:48 INFO tclean::::casa ...done |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:48 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 Selecting via TaQL : ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322 | NRows selected : 56161 |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:21:48
|
2026-09-02 19:21:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 Selecting via TaQL : ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 | NRows selected : 56158 |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 Selecting via TaQL : ROWNUMBER() >= 1 && ROWNUMBER() <= 56161 | NRows selected : 56161 |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:49 INFO tclean::::casa ...done |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:50 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1] : |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:50 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1] : |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:50 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Impars: start |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:50 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:50 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Set Gridding options for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1] with ftmachine : gridft |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:50 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-1 Required memory: 0.002124 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:50 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2] : |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:50 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2] : |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:50 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Impars: start |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:50 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:50 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Set Gridding options for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2] with ftmachine : gridft |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:50 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-2 Required memory: 0.002124 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:50 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:50 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] : |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:50 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] : |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:50 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Impars: start |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:50 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:50 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Set Gridding options for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] with ftmachine : gridft |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:50 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-3 Required memory: 0.002124 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:51 INFO tclean::::casa ...done |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:53 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:54 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-3 Set imaging weights : Natural weighting |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:54 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-1 Set imaging weights : Natural weighting |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:54 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-2 Set imaging weights : Natural weighting |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:54 INFO tclean::::casa ...done |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:54 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [savemod.par] : hogbom |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:54 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:55 INFO tclean::::casa ...done |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:55 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 1.10061 |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:56 INFO SynthesisDeconvolver::setupMask [savemod.par] Initializing new mask to 1.0 for the full image |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:56 INFO SynthesisDeconvolver::setupMask [savemod.par] Number of pixels in the clean mask : 10000 out of a total of 10000 pixels. [ 100 % ] |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:56 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 1.10061, over full image : 1.10061 |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:56 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 10, 'cyclethreshold': 0.13606752455234528, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:56 INFO SDAlgorithmBase::deconvolve [savemod.par] Run Hogbom minor-cycle | CycleThreshold=0.136068, CycleNiter=10, Gain=0.1 |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:56 INFO SDAlgorithmBase::deconvolve [savemod.par] iters=0->10 [10], model=0->0.755226, peakres=1.10061->0.345383, Reached cycleniter. |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:56 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 10 iterations. |
|
02-Sep-2026 19:21:55
|
2026-09-02 19:21:56 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : savemod.par to all nodes :[/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:21:56 INFO task_tclean::SIImageStore::setModelImageOne Copying input model savemod.par.model to /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1.model |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:21:56 INFO task_tclean::SIImageStore::setModelImageOne Copying input model savemod.par.model to /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2.model |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:21:56 INFO task_tclean::SIImageStore::setModelImageOne Copying input model savemod.par.model to /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3.model |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:21:56 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:21:56 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:21:56 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:21:56 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:21:56 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:21:58 INFO tclean::::casa ...done |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:21:58 INFO SynthesisNormalizer::gatherImages Gather residual images : [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] onto :savemod.par |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:21:58 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.345382, over full image : 0.345382 |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:21:58 INFO tclean::::casa Reached global stopping criterion : iteration limit |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:21:58 INFO tclean::::casa getSummary call: fullsummary=False |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:21:58 INFO SDAlgorithmBase::restore [savemod.par] : Restoring model image. |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:21:58 INFO SIImageStore::restore Beam for chan : 0 : 53.0943 arcsec, 49.5719 arcsec, -88.6243 deg |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:04 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:05 INFO ::casa::MPIServer-3 node 3 has completed its job |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:05 INFO ::casa::MPIServer-1 node 1 has completed its job |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:05 INFO ::casa::MPIServer-2 node 2 has completed its job |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:05 INFO tclean::::casa ...done |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:05 INFO tclean::::casa Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed. |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:05 INFO tclean::::casa Searching for images with prefix 'savemod.par'... Found these, writing history into them: ['savemod.par.psf', 'savemod.par.sumwt', 'savemod.par.pb', 'savemod.par.residual', 'savemod.par.image', 'savemod.par.model', 'savemod.par.mask'] |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:06 INFO tclean::::casa Task tclean complete. Start time: 2026-09-02 15:21:42.262457 End time: 2026-09-02 15:22:05.558577 |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:06 INFO tclean::::casa ##### End Task: tclean ##### |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:06 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:06 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:06 INFO tclean::::casa ##### Begin Task: tclean ##### |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:06 INFO tclean::::casa tclean( vis='refim_point.ms', selectdata=True, field='', spw='0:0~5,0:15~19', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='savemod.par', imsize=100, cell='10.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel=[], specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='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=False, restoringbeam=[], pbcor=False, outlierfile='', weighting='natural', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.0, uvtaper=[''], niter=0, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='modelcolumn', calcres=False, calcpsf=False, psfcutoff=0.35, parallel=False ) |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:06 INFO tclean::::casa Verifying Input Parameters |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:06 INFO Clearing all model records in MS header. |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:06 INFO SynthesisImagerVi2::selectData MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened with scratch model column] |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:06 INFO SynthesisImagerVi2::selectData NRows selected : 168480 |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:06 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:06 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:06 INFO SynthesisImagerVi2::defineImage Impars: start |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:06 INFO SynthesisImagerVi2::defineImage Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:06 INFO SynthesisImagerVi2::defineImage Set Gridding options for [savemod.par] with ftmachine : gridft |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:06 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.002124 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:06 INFO SynthesisImagerVi2::weight() Set imaging weights : Natural weighting |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:06 INFO SynthesisImagerVi2::predictModel ---------------------------------------------------- Predict Model --------------------------------------------- |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:06 INFO SynthesisImagerVi2::predictModel Saving model column |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:11 INFO tclean::::casa Searching for images with prefix 'savemod.par'... Found these, writing history into them: ['savemod.par.psf', 'savemod.par.sumwt', 'savemod.par.pb', 'savemod.par.residual', 'savemod.par.image', 'savemod.par.model', 'savemod.par.mask'] |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:11 INFO tclean::::casa Task tclean complete. Start time: 2026-09-02 15:22:05.565690 End time: 2026-09-02 15:22:10.696701 |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:11 INFO tclean::::casa ##### End Task: tclean ##### |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:11 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:22:11
|
[check_chanvals] Chan 19 is (0.7212174927354114+0j) (Pass : should be <0.9) |
|
02-Sep-2026 19:22:11
|
|
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:11 INFO impbcor::::casa ########################################## |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:11 INFO impbcor::::casa ##### Begin Task: impbcor ##### |
|
02-Sep-2026 19:22:11
|
2026-09-02 19:22:11 INFO impbcor::::casa impbcor( imagename='savemod.par.image', pbimage='savemod.par.pb', outfile='savemod.par.impbcor', overwrite=True, box='', region='', chans='', stokes='', mask='', mode='divide', cutoff=-1.0, stretch=False ) |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:11 INFO impbcor::CasacRegionManager::fromBCS No directional region specified. Using full positional plane. |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:11 INFO impbcor::CasacRegionManager::fromBCS Using all spectral channels. |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:11 INFO impbcor::CasacRegionManager::fromBCS Using polarizations ALL |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:11 INFO impbcor::ImageRegion::fromRecord Selected bounding box : |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:11 INFO impbcor::ImageRegion::fromRecord+ [0, 0, 0, 0] to [99, 99, 0, 0] (20:00:12.398, +40.35.40.979, I, 1.47499e+09Hz to 19:58:45.301, +40.52.10.998, I, 1.47499e+09Hz) |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:11 INFO impbcor::ImageRegion::fromRecord Selected bounding box : |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:11 INFO impbcor::ImageRegion::fromRecord+ [0, 0, 0, 0] to [99, 99, 0, 0] (20:00:12.398, +40.35.40.979, I, 1.47499e+09Hz to 19:58:45.301, +40.52.10.998, I, 1.47499e+09Hz) |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:11 INFO impbcor::SubImageFactory::createImage Creating image 'savemod.par.impbcor' of shape [100, 100, 1, 1] |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:11 INFO impbcor::::casa Task impbcor complete. Start time: 2026-09-02 15:22:11.017907 End time: 2026-09-02 15:22:11.131070 |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:11 INFO impbcor::::casa ##### End Task: impbcor ##### |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:11 INFO impbcor::::casa ########################################## |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:11 INFO name:: No table opened. |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:11 INFO showcache:: The Table Cache is empty. |
|
02-Sep-2026 19:22:16
|
Run with mfs - hogbom - usestartmodel = True - imaging in parallel |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:12 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:12 INFO tclean::::casa ##### Begin Task: tclean ##### |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:12 INFO tclean::::casa tclean( vis='refim_point.ms', selectdata=True, field='', spw='0:0~5,0:15~19', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='savemod.par', imsize=100, cell='10.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='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='natural', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.0, uvtaper=[''], niter=0, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='none', calcres=True, calcpsf=True, psfcutoff=0.35, parallel=True ) |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:12 INFO tclean::::casa Verifying Input Parameters |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:12 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 2 |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:12 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 3 |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:12 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 1 |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:13 INFO tclean::::casa setupCluster, Setting up 3 engines. |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:13 INFO SynthesisUtilMethods::continuumDataPartition |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:13 INFO SynthesisUtilMethods::continuumDataPartition + Rows = 112323 168480 [P][M]: 0:2 ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:13 INFO tclean::::casa Partitioned Selection : {'0': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:0~5,0:15~19', 'state': '', 'taql': 'ROWNUMBER() >= 1 && ROWNUMBER() <= 56161', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '1': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:0~5,0:15~19', 'state': '', 'taql': 'ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '2': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:0~5,0:15~19', 'state': '', 'taql': 'ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480', 'timestr': '', 'usescratch': False, 'uvdist': ''}}} |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:13 INFO SynthesisImagerVi2::selectData MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:13 INFO SynthesisImagerVi2::selectData NRows selected : 168480 |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:14 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:14 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:14 INFO SynthesisImagerVi2::defineImage Impars: start |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:14 INFO SynthesisImagerVi2::defineImage Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:14 INFO SynthesisImagerVi2::defineImage Set Gridding options for [savemod.par] with ftmachine : gridft |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:14 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.002124 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:14 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:15 INFO tclean::::casa ...done |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:15 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:15 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:15 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:15 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 Selecting via TaQL : ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 | NRows selected : 56158 |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:15 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 Selecting via TaQL : ROWNUMBER() >= 1 && ROWNUMBER() <= 56161 | NRows selected : 56161 |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:15 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:15 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 Selecting via TaQL : ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322 | NRows selected : 56161 |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:16 INFO tclean::::casa ...done |
|
02-Sep-2026 19:22:16
|
2026-09-02 19:22:16 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1] : |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:16 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1] : |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Impars: start |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Set Gridding options for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1] with ftmachine : gridft |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-1 Required memory: 0.002124 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2] : |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2] : |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Impars: start |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Set Gridding options for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2] with ftmachine : gridft |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-2 Required memory: 0.002124 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:17 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] : |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] : |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Impars: start |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Set Gridding options for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] with ftmachine : gridft |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:17 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-3 Required memory: 0.002124 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:18 INFO tclean::::casa ...done |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:21 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:21 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-2 Set imaging weights : Natural weighting |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:21 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-3 Set imaging weights : Natural weighting |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:21 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-1 Set imaging weights : Natural weighting |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:22 INFO tclean::::casa ...done |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:22 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [savemod.par] : hogbom |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:22 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:23 INFO tclean::::casa ...done |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:23 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:23 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-2 ----------------------------------------------------------- Make PSF --------------------------------------------- |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:23 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-3 ----------------------------------------------------------- Make PSF --------------------------------------------- |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:23 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-1 ----------------------------------------------------------- Make PSF --------------------------------------------- |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:25 INFO tclean::::casa ...done |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:25 INFO SynthesisNormalizer::gatherImages Gather psf,weight images : [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] onto :savemod.par |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:25 INFO SIImageStore::calcSensitivity [savemod.par] Theoretical sensitivity (Jy/bm):0.000531521 |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:25 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.004996 |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:25 INFO SIImageStore::printBeamSet Beam : 53.0943 arcsec, 49.5719 arcsec, -88.6243 deg |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:25 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:25 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::makePrimaryBeam::MPIServer-1 vi2 : Evaluating Primary Beam model onto image grid(s) |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:26 INFO tclean::::casa ...done |
|
02-Sep-2026 19:22:25
|
2026-09-02 19:22:26 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : savemod.par to all nodes :[/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:26 INFO task_tclean::SIImageStore::setModelImageOne Starting model image savemod.par.model does not exist. No initial prediction will be done |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:26 INFO task_tclean::SIImageStore::setModelImageOne Starting model image savemod.par.model does not exist. No initial prediction will be done |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:26 INFO task_tclean::SIImageStore::setModelImageOne Starting model image savemod.par.model does not exist. No initial prediction will be done |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:26 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:26 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:26 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:26 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:26 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:27 INFO tclean::::casa ...done |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:27 INFO SynthesisNormalizer::gatherImages Gather residual images : [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] onto :savemod.par |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:27 INFO task_tclean::SDAlgorithmBase::restore [savemod.par] : Restoring model image. |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:27 WARN task_tclean::SIImageStore::restore (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SIImageStore.cc, line 2353) Restoring with an empty model image. Only residuals will be processed to form the output restored image. |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:27 INFO task_tclean::SIImageStore::restore Beam for chan : 0 : 53.0943 arcsec, 49.5719 arcsec, -88.6243 deg |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:34 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:34 INFO ::casa::MPIServer-3 node 3 has completed its job |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:34 INFO ::casa::MPIServer-1 node 1 has completed its job |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:34 INFO ::casa::MPIServer-2 node 2 has completed its job |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:35 INFO tclean::::casa ...done |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:35 INFO tclean::::casa Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed. |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:35 INFO tclean::::casa Searching for images with prefix 'savemod.par'... Found these, writing history into them: ['savemod.par.psf', 'savemod.par.sumwt', 'savemod.par.pb', 'savemod.par.residual', 'savemod.par.image', 'savemod.par.model'] |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:35 INFO tclean::::casa Task tclean complete. Start time: 2026-09-02 15:22:11.552886 End time: 2026-09-02 15:22:35.213818 |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:35 INFO tclean::::casa ##### End Task: tclean ##### |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:35 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:35 INFO tclean::::casa ########################################## |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:35 INFO tclean::::casa ##### Begin Task: tclean ##### |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:35 INFO tclean::::casa tclean( vis='refim_point.ms', selectdata=True, field='', spw='0:0~5,0:15~19', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='savemod.par', imsize=100, cell='10.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='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='natural', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.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=False, calcpsf=False, psfcutoff=0.35, parallel=True ) |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:35 INFO tclean::::casa Verifying Input Parameters |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:36 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 2 |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:36 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 3 |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:36 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 1 |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:37 INFO tclean::::casa setupCluster, Setting up 3 engines. |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:37 INFO SynthesisUtilMethods::continuumDataPartition |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:37 INFO SynthesisUtilMethods::continuumDataPartition + Rows = 112323 168480 [P][M]: 0:2 ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:37 INFO tclean::::casa Partitioned Selection : {'0': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:0~5,0:15~19', 'state': '', 'taql': 'ROWNUMBER() >= 1 && ROWNUMBER() <= 56161', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '1': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:0~5,0:15~19', 'state': '', 'taql': 'ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '2': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:0~5,0:15~19', 'state': '', 'taql': 'ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480', 'timestr': '', 'usescratch': False, 'uvdist': ''}}} |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:37 INFO SynthesisImagerVi2::selectData MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:37 INFO SynthesisImagerVi2::selectData NRows selected : 168480 |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:38 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:38 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.par] : |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:38 INFO SynthesisImagerVi2::defineImage Impars: start |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:38 INFO SynthesisImagerVi2::defineImage Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:22:37
|
2026-09-02 19:22:38 INFO SynthesisImagerVi2::defineImage Set Gridding options for [savemod.par] with ftmachine : gridft |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:38 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.002124 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:38 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:39 INFO tclean::::casa ...done |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:39 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:39 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:39 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:39 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 Selecting via TaQL : ROWNUMBER() >= 112323 && ROWNUMBER() <= 168480 | NRows selected : 56158 |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:39 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 Selecting via TaQL : ROWNUMBER() >= 1 && ROWNUMBER() <= 56161 | NRows selected : 56161 |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:39 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened in readonly mode] |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:39 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 Selecting via TaQL : ROWNUMBER() >= 56162 && ROWNUMBER() <= 112322 | NRows selected : 56161 |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:40 INFO tclean::::casa ...done |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:40 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1] : |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:40 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1] : |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:40 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Impars: start |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:40 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:40 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Set Gridding options for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1] with ftmachine : gridft |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:40 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-1 Required memory: 0.002124 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:41 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2] : |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:41 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2] : |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:41 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Impars: start |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:41 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:41 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Set Gridding options for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2] with ftmachine : gridft |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:41 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-2 Required memory: 0.002124 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:41 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:41 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] : |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:41 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] : |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:41 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Impars: start |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:41 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:41 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Set Gridding options for [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] with ftmachine : gridft |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:41 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-3 Required memory: 0.002124 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:42 INFO tclean::::casa ...done |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:44 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:44 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-3 Set imaging weights : Natural weighting |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:44 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-1 Set imaging weights : Natural weighting |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:45 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-2 Set imaging weights : Natural weighting |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:45 INFO tclean::::casa ...done |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:45 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [savemod.par] : hogbom |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:45 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:46 INFO tclean::::casa ...done |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:46 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 1.10061 |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:46 INFO SynthesisDeconvolver::setupMask [savemod.par] Initializing new mask to 1.0 for the full image |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:46 INFO SynthesisDeconvolver::setupMask [savemod.par] Number of pixels in the clean mask : 10000 out of a total of 10000 pixels. [ 100 % ] |
|
02-Sep-2026 19:22:46
|
2026-09-02 19:22:46 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 1.10061, over full image : 1.10061 |
|
02-Sep-2026 19:22:53
|
Failing task since return code of [/export/cvpost135-nvme/casa/bamboohome/temp/CASASPECS-DEVVERCASALITHPY31257-CCM228-2-ScriptBuildTask-9844747219837349327.sh] was 143 while expected 0 |
|
02-Sep-2026 19:22:53
|
Finished task 'Test' with result: Failed |
|
02-Sep-2026 19:22:53
|
Running post build plugin 'Docker Container Cleanup' |
|
02-Sep-2026 19:22:53
|
Running post build plugin 'NCover Results Collector' |
|
02-Sep-2026 19:22:53
|
Running post build plugin 'Build Results Label Collector' |
|
02-Sep-2026 19:22:53
|
Running post build plugin 'Clover Results Collector' |
|
02-Sep-2026 19:22:53
|
Force Stop build feature is enabled for current plan. Either Bamboo has detected the build has hung or it has been manually stopped. |
|
02-Sep-2026 19:22:53
|
Attempting to generate stack trace and terminate spawned sub-processes of process id: 4550 |
|
02-Sep-2026 19:22:53
|
Running post build plugin 'npm Cache Cleanup' |
|
02-Sep-2026 19:22:53
|
Running post build plugin 'Artifact Copier' |
|
02-Sep-2026 19:22:53
|
Finalising the build... |
|
02-Sep-2026 19:22:53
|
Stopping timer. |
|
02-Sep-2026 19:22:53
|
Build CASASPECS-DEVVERCASALITHPY31257-CCM228-2 completed. |
|
02-Sep-2026 15:22:54
|
Running on server: post build plugin 'Build Hanging Detection Configuration' |
|
02-Sep-2026 15:22:54
|
Running on server: post build plugin 'NCover Results Collector' |
|
02-Sep-2026 15:22:54
|
Running on server: post build plugin 'Build Labeller' |
|
02-Sep-2026 15:22:54
|
Running on server: post build plugin 'Clover Delta Calculator' |
|
02-Sep-2026 15:22:54
|
Running on server: post build plugin 'Maven Dependencies Postprocessor' |
|
02-Sep-2026 15:22:55
|
All post build plugins have finished |
|
02-Sep-2026 15:22:55
|
Generating build results summary... |
|
02-Sep-2026 15:22:55
|
Saving build results to disk... |
|
02-Sep-2026 15:22:55
|
Store variable context... |
|
02-Sep-2026 15:22:55
|
Finished building CASASPECS-DEVVERCASALITHPY31257-CCM228-2. |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:46 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 10, 'cyclethreshold': 0.13606752455234528, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:46 INFO SDAlgorithmBase::deconvolve [savemod.par] Run Hogbom minor-cycle | CycleThreshold=0.136068, CycleNiter=10, Gain=0.1 |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:47 INFO SDAlgorithmBase::deconvolve [savemod.par] iters=0->10 [10], model=0->0.755226, peakres=1.10061->0.345383, Reached cycleniter. |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:47 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 10 iterations. |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:47 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : savemod.par to all nodes :[/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:47 INFO task_tclean::SIImageStore::setModelImageOne Copying input model savemod.par.model to /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1.model |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:47 INFO task_tclean::SIImageStore::setModelImageOne Copying input model savemod.par.model to /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2.model |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:47 INFO task_tclean::SIImageStore::setModelImageOne Copying input model savemod.par.model to /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3.model |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:47 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:47 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:47 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:47 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:47 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 1 ------------------------------------- |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:49 INFO tclean::::casa ...done |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:49 INFO SynthesisNormalizer::gatherImages Gather residual images : [/export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n1, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n2, /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31257-CCM228/work/test_regression_tclean_startmodel_restart_mpi/savemod.par.workdirectory/savemod.par.n3] onto :savemod.par |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:49 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.345382, over full image : 0.345382 |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:49 INFO tclean::::casa Reached global stopping criterion : iteration limit |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:49 INFO tclean::::casa getSummary call: fullsummary=False |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:49 INFO SDAlgorithmBase::restore [savemod.par] : Restoring model image. |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:49 INFO SIImageStore::restore Beam for chan : 0 : 53.0943 arcsec, 49.5719 arcsec, -88.6243 deg |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:55 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:56 INFO ::casa::MPIServer-3 node 3 has completed its job |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:56 INFO ::casa::MPIServer-1 node 1 has completed its job |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:56 INFO ::casa::MPIServer-2 node 2 has completed its job |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:56 INFO tclean::::casa ...done |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:56 INFO tclean::::casa Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed. |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:56 INFO tclean::::casa Searching for images with prefix 'savemod.par'... Found these, writing history into them: ['savemod.par.psf', 'savemod.par.sumwt', 'savemod.par.pb', 'savemod.par.residual', 'savemod.par.image', 'savemod.par.model', 'savemod.par.mask'] |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:57 INFO tclean::::casa Task tclean complete. Start time: 2026-09-02 15:22:35.220932 End time: 2026-09-02 15:22:56.614927 |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:57 INFO tclean::::casa ##### End Task: tclean ##### |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:57 INFO tclean::::casa ########################################## |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:57 INFO tclean::::casa ########################################## |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:57 INFO tclean::::casa ##### Begin Task: tclean ##### |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:57 INFO tclean::::casa tclean( vis='refim_point.ms', selectdata=True, field='', spw='0:0~5,0:15~19', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='savemod.ser', imsize=100, cell='10.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel=['savemod.par.model'], 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=False, restoringbeam=[], pbcor=False, outlierfile='', weighting='natural', robust=0.5, noise='1.0Jy', npixels=0, fracbw=-1.0, uvtaper=[''], niter=0, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='modelcolumn', calcres=False, calcpsf=False, psfcutoff=0.35, parallel=False ) |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:57 INFO tclean::::casa Verifying Input Parameters |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:57 INFO Clearing all model records in MS header. |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:57 INFO SynthesisImagerVi2::selectData MS : refim_point.ms | Selecting on spw :0:0~5,0:15~19 | [Opened with scratch model column] |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:57 INFO SynthesisImagerVi2::selectData NRows selected : 168480 |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:57 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.ser] : |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:57 INFO SynthesisImagerVi2::defineImage Define image coordinates for [savemod.ser] : |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:57 INFO SynthesisImagerVi2::defineImage Impars: start |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:57 INFO SynthesisImagerVi2::defineImage Shape: [100, 100, 1, 1] Spectral: [1.47499e+09] at [0] with increment [9.99992e+08] |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:57 INFO SynthesisImagerVi2::defineImage Set Gridding options for [savemod.ser] with ftmachine : gridft |
|
02-Sep-2026 15:22:57
|
2026-09-02 19:22:57 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.002124 GB. Available mem.: 392.9 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
|
02-Sep-2026 15:22:58
|
Killing: 2378695 |
|
02-Sep-2026 15:22:58
|
Executing kill 2378695 |
|
02-Sep-2026 15:23:03
|
Force Stop build feature is enabled for current plan. Either Bamboo has detected the build has hung or it has been manually stopped. |
|
02-Sep-2026 15:23:03
|
Has finished generating stack trace and terminating spawned sub-processes of process id: 4550 |
