Build: #62 failed
Job: Test Regressions Many Linux 2.28 Rocky 9.4 Docker was successful
Build log
The build generated 9,837 lines of output.The output is too long and has been truncated to the last 1,000 lines. Download or view full build log.
| 13-Nov-2024 17:35:25 | 2024-11-13 22:35:20 INFO tclean::::casa ...done |
| 13-Nov-2024 17:35:25 | 2024-11-13 22:35:20 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:35:25 | 2024-11-13 22:35:22 INFO tclean::::casa ...done |
| 13-Nov-2024 17:35:25 | 2024-11-13 22:35:22 INFO SynthesisNormalizer::gatherImages Gather psf,weight images : [/home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n3] onto :test-X220-Titan |
| 13-Nov-2024 17:35:25 | 2024-11-13 22:35:22 INFO SIImageStore::calcSensitivity [test-X220-Titan] Theoretical sensitivity (Jy/bm):3.58671e-06 |
| 13-Nov-2024 17:35:25 | 2024-11-13 22:35:22 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.009297 |
| 13-Nov-2024 17:35:25 | 2024-11-13 22:35:22 INFO SIImageStore::printBeamSet Beam : 3.77543 arcsec, 2.20411 arcsec, -83.4971 deg |
| 13-Nov-2024 17:35:25 | 2024-11-13 22:35:22 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:35:25 | 2024-11-13 22:35:22 WARN MPICommandServer::command_request_handler_service::SynthesisImagerVi2::makePB::MPIServer-1 (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SynthesisImagerVi2.cc, line 3447) The MS has multiple antenna diameters ..PB could be wrong |
| 13-Nov-2024 17:35:25 | 2024-11-13 22:35:23 INFO tclean::::casa ...done |
| 13-Nov-2024 17:35:25 | 2024-11-13 22:35:23 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : test-X220-Titan to all nodes :[/home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n3] |
| 13-Nov-2024 17:35:25 | 2024-11-13 22:35:23 INFO task_tclean::SIImageStore::setModelImageOne Starting model image test-X220-Titan.model does not exist. No initial prediction will be done |
| 13-Nov-2024 17:35:25 | 2024-11-13 22:35:23 INFO task_tclean::SIImageStore::setModelImageOne Starting model image test-X220-Titan.model does not exist. No initial prediction will be done |
| 13-Nov-2024 17:35:25 | 2024-11-13 22:35:23 INFO task_tclean::SIImageStore::setModelImageOne Starting model image test-X220-Titan.model does not exist. No initial prediction will be done |
| 13-Nov-2024 17:35:25 | 2024-11-13 22:35:23 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 13-Nov-2024 17:35:25 | 2024-11-13 22:35:23 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:35:25 | 2024-11-13 22:35:25 INFO tclean::::casa ...done |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n3] onto :test-X220-Titan |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.217132, over full image : 0.217132 |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO SynthesisDeconvolver::setupMask [test-X220-Titan] Setting up a mask from [box [ [ 96pix , 96pix] , [104pix, 104pix ] ]] |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane. |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO CasacRegionManager::fromBCS Using all spectral channels. |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO CasacRegionManager::fromBCS Using polarizations ALL |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO You've specified explicitly that the spectral axis should be regridded. However, the input image has a degenerate spectral axis and so it cannot be regridded. Instead, the resulting single output channel will be replicated 1 times in the output image. |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO ImageMaskAttacher::makeMask Created and initialized mask `mask0' |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO AsciiRegionFileParser::_parse Combined 1 image regions (which excludes any annotation regions) |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO AsciiRegionFileParser::_parse The specified region will select all pixels that are included in the region. Full pixels will be included even when they are only partially covered by the region(s). |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO SynthesisDeconvolver::setupMask ---------------------------------------------------------------------------------------------------------------------------------------- |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO SynthesisDeconvolver::setupMask [test-X220-Titan] Number of pixels in the clean mask : 81 out of a total of 40000 pixels. [ 0.2025 % ] |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.217132, over full image : 0.217132 |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 100, 'cyclethreshold': 0.07867652177810669, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO SDAlgorithmBase::deconvolve [test-X220-Titan] Run clark minor-cycle | CycleThreshold=0.0786765, CycleNiter=100, Gain=0.1 |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO SDAlgorithmClarkClean2::initializeDeconvolver Choosing a PSF patch size of 25 pixels. |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO ClarkCleanLatModel::solve Iteration: 1, Maximum residual=0.195419 Flux limit=0.0786765, 37 Active pixels |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO ClarkCleanLatModel::solve Iteration: 3, Maximum residual=0.158289 Flux limit=0.0786765, 35 Active pixels |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO ClarkCleanLatModel::solve Iteration: 7, Maximum residual=0.103854 Flux limit=0.0786765, 29 Active pixels |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO ClarkCleanLatModel::solve Iteration: 10, Maximum residual=0.0757093 Flux limit=0.0786765, 11 Active pixels |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO SDAlgorithmBase::deconvolve [test-X220-Titan] iters=0->10 [10], model=0->0.141423, peakres=0.217132->0.0757093, Reached cyclethreshold. |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 10 iterations. |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : test-X220-Titan to all nodes :[/home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n3] |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-X220-Titan.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n1.model |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-X220-Titan.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n2.model |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-X220-Titan.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n3.model |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:26 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:29 INFO tclean::::casa ...done |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:29 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n3] onto :test-X220-Titan |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:29 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.0757091, over full image : 0.0757091 |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:29 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 90, 'cyclethreshold': 0.02743273228406906, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:30 INFO SDAlgorithmBase::deconvolve [test-X220-Titan] Run clark minor-cycle | CycleThreshold=0.0274327, CycleNiter=90, Gain=0.1 |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:30 INFO SDAlgorithmClarkClean2::initializeDeconvolver Choosing a PSF patch size of 25 pixels. |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:30 INFO ClarkCleanLatModel::solve Iteration: 1, Maximum residual=0.0681381 Flux limit=0.0274327, 37 Active pixels |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:30 INFO ClarkCleanLatModel::solve Iteration: 3, Maximum residual=0.0551919 Flux limit=0.0274327, 36 Active pixels |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:30 INFO ClarkCleanLatModel::solve Iteration: 7, Maximum residual=0.0362114 Flux limit=0.0274327, 29 Active pixels |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:30 INFO ClarkCleanLatModel::solve Iteration: 10, Maximum residual=0.0263981 Flux limit=0.0274327, 11 Active pixels |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:30 INFO SDAlgorithmBase::deconvolve [test-X220-Titan] iters=0->10 [10], model=0.141423->0.190734, peakres=0.0757091->0.0263981, Reached cyclethreshold. |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:30 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 20 iterations. |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:30 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : test-X220-Titan to all nodes :[/home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n3] |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:30 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-X220-Titan.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n1.model |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:30 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-X220-Titan.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n2.model |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:30 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-X220-Titan.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n3.model |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:30 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:30 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:35:32 | 2024-11-13 22:35:33 INFO tclean::::casa ...done |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:33 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n3] onto :test-X220-Titan |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:33 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.0263981, over full image : 0.0263981 |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:33 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 80, 'cyclethreshold': 0.009565179236233234, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:33 INFO SDAlgorithmBase::deconvolve [test-X220-Titan] Run clark minor-cycle | CycleThreshold=0.00956518, CycleNiter=80, Gain=0.1 |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:33 INFO SDAlgorithmClarkClean2::initializeDeconvolver Choosing a PSF patch size of 25 pixels. |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:33 INFO ClarkCleanLatModel::solve Iteration: 1, Maximum residual=0.0237582 Flux limit=0.00956518, 37 Active pixels |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:33 INFO ClarkCleanLatModel::solve Iteration: 3, Maximum residual=0.0192442 Flux limit=0.00956518, 37 Active pixels |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:33 INFO ClarkCleanLatModel::solve Iteration: 7, Maximum residual=0.0126261 Flux limit=0.00956518, 29 Active pixels |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:33 INFO ClarkCleanLatModel::solve Iteration: 10, Maximum residual=0.00920443 Flux limit=0.00956518, 12 Active pixels |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:33 INFO SDAlgorithmBase::deconvolve [test-X220-Titan] iters=0->10 [10], model=0.190734->0.207927, peakres=0.0263981->0.00920443, Reached cyclethreshold. |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:33 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 30 iterations. |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:33 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : test-X220-Titan to all nodes :[/home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n3] |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:33 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-X220-Titan.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n1.model |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:33 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-X220-Titan.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n2.model |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:33 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-X220-Titan.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n3.model |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:33 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:33 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:36 INFO tclean::::casa ...done |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:37 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n3] onto :test-X220-Titan |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:37 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.00920441, over full image : 0.00920441 |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:37 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 70, 'cyclethreshold': 0.003335162764415145, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:37 INFO SDAlgorithmBase::deconvolve [test-X220-Titan] Run clark minor-cycle | CycleThreshold=0.00333516, CycleNiter=70, Gain=0.1 |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:37 INFO SDAlgorithmClarkClean2::initializeDeconvolver Choosing a PSF patch size of 25 pixels. |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:37 INFO ClarkCleanLatModel::solve Iteration: 1, Maximum residual=0.00828397 Flux limit=0.00333516, 46 Active pixels |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:37 INFO ClarkCleanLatModel::solve Iteration: 3, Maximum residual=0.00671001 Flux limit=0.00333516, 44 Active pixels |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:37 INFO ClarkCleanLatModel::solve Iteration: 7, Maximum residual=0.00440244 Flux limit=0.00333516, 37 Active pixels |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:37 INFO ClarkCleanLatModel::solve Iteration: 10, Maximum residual=0.00320938 Flux limit=0.00333516, 18 Active pixels |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:37 INFO SDAlgorithmBase::deconvolve [test-X220-Titan] iters=0->10 [10], model=0.207927->0.213922, peakres=0.00920441->0.00320938, Reached cyclethreshold. |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:37 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 40 iterations. |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:37 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : test-X220-Titan to all nodes :[/home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n3] |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:37 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-X220-Titan.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n1.model |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:37 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-X220-Titan.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n2.model |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:37 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-X220-Titan.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n3.model |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:37 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:37 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:40 INFO tclean::::casa ...done |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:40 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n3] onto :test-X220-Titan |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:40 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.00320937, over full image : 0.00521469 |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:40 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 60, 'cyclethreshold': 0.0011628955835476518, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:40 INFO SDAlgorithmBase::deconvolve [test-X220-Titan] Run clark minor-cycle | CycleThreshold=0.0011629, CycleNiter=60, Gain=0.1 |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:40 INFO SDAlgorithmClarkClean2::initializeDeconvolver Choosing a PSF patch size of 25 pixels. |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:40 INFO ClarkCleanLatModel::solve Iteration: 1, Maximum residual=0.00291336 Flux limit=0.0011629, 71 Active pixels |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:40 INFO ClarkCleanLatModel::solve Iteration: 4, Maximum residual=0.00243613 Flux limit=0.0011629, 70 Active pixels |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:40 INFO ClarkCleanLatModel::solve Iteration: 10, Maximum residual=0.00184254 Flux limit=0.0011629, 64 Active pixels |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:40 INFO ClarkCleanLatModel::solve Iteration: 20, Maximum residual=0.00119628 Flux limit=0.0011629, 52 Active pixels |
| 13-Nov-2024 17:35:40 | 2024-11-13 22:35:41 INFO ClarkCleanLatModel::solve Iteration: 21, Maximum residual=0.00112492 Flux limit=0.0011629, 5 Active pixels |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:41 INFO SDAlgorithmBase::deconvolve [test-X220-Titan] iters=0->21 [21], model=0.213922->0.218005, peakres=0.00320937->0.00112492, Reached cyclethreshold. |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:41 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 61 iterations. |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:41 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : test-X220-Titan to all nodes :[/home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n3] |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:41 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-X220-Titan.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n1.model |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:41 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-X220-Titan.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n2.model |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:41 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-X220-Titan.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n3.model |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:41 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:41 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:44 INFO tclean::::casa ...done |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:44 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n3] onto :test-X220-Titan |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:44 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.00117073, over full image : 0.00515295 |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:44 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 39, 'cyclethreshold': 0.00042420762474648654, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:44 INFO SDAlgorithmBase::deconvolve [test-X220-Titan] Run clark minor-cycle | CycleThreshold=0.000424208, CycleNiter=39, Gain=0.1 |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:44 INFO SDAlgorithmClarkClean2::initializeDeconvolver Choosing a PSF patch size of 25 pixels. |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:44 INFO ClarkCleanLatModel::solve Iteration: 1, Maximum residual=0.00109996 Flux limit=0.000424208, 77 Active pixels |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:44 INFO ClarkCleanLatModel::solve Iteration: 4, Maximum residual=0.00100057 Flux limit=0.000424208, 75 Active pixels |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:44 INFO ClarkCleanLatModel::solve Iteration: 11, Maximum residual=0.000824373 Flux limit=0.000424208, 74 Active pixels |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:44 INFO ClarkCleanLatModel::solve Iteration: 24, Maximum residual=0.000607702 Flux limit=0.000424208, 70 Active pixels |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:44 INFO ClarkCleanLatModel::solve Iteration: 39, Maximum residual=0.000441008 Flux limit=0.000424208, 54 Active pixels |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:44 INFO SDAlgorithmBase::deconvolve [test-X220-Titan] iters=0->39 [39], model=0.218005->0.220838, peakres=0.00117073->0.000441008, Reached cycleniter. |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:44 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 100 iterations. |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:44 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : test-X220-Titan to all nodes :[/home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n3] |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:44 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-X220-Titan.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n1.model |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:44 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-X220-Titan.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n2.model |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:44 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-X220-Titan.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n3.model |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:44 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:44 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:47 INFO tclean::::casa ...done |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:47 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-X220-Titan.workdirectory/test-X220-Titan.n3] onto :test-X220-Titan |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:47 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.000441003, over full image : 0.00519732 |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:47 INFO tclean::::casa Reached global stopping criterion : iteration limit |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:47 INFO tclean::::casa getSummary call: fullsummary=False |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:47 INFO SDAlgorithmBase::restore [test-X220-Titan] : Restoring model image. |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:48 INFO SIImageStore::restore Beam for chan : 0 : 3.77543 arcsec, 2.20411 arcsec, -83.4971 deg |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:58 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:59 INFO tclean::::casa ...done |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:59 INFO tclean::::casa Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed. |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:59 INFO tclean::::casa Searching for images with prefix 'test-X220-Titan'... Found these, writing history into them: ['test-X220-Titan.mask', 'test-X220-Titan.psf', 'test-X220-Titan.sumwt', 'test-X220-Titan.image', 'test-X220-Titan.model', 'test-X220-Titan.pb', 'test-X220-Titan.residual'] |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:59 INFO tclean::::casa Task tclean complete. Start time: 2024-11-13 22:35:05.359162 End time: 2024-11-13 22:35:58.784835 |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:59 INFO tclean::::casa ##### End Task: tclean ##### |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:59 INFO tclean::::casa ########################################## |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:59 WARN TIMING::::casa Step 21: Test image of Titan |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:59 WARN TIMING::::casa Time now: 1731537358.7861104 |
| 13-Nov-2024 17:35:58 | |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:59 WARN TIMING::::casa Time used this step: 109.22903299331665 |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:59 WARN TIMING::::casa Total time used so far: 1194.4856746196747 |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:59 WARN TIMING::::casa Step Time used (s) Fraction of total time (percent) [description] |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:59 WARN TIMING::::casa 0 137.75823426246643 11.532849425450731 [Data import] |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:59 WARN TIMING::::casa 1 0.18251419067382812 0.015279730393747987 [Generate antenna position cal tables] |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:59 WARN TIMING::::casa 2 20.73629069328308 1.7360016226134762 [Generate tsys cal tables] |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:59 WARN TIMING::::casa 3 13.971266984939575 1.1696470942933694 [Correct the Titan position] |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:59 WARN TIMING::::casa 4 19.33445382118225 1.6186425866796903 [Apriori flagging] |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:59 WARN TIMING::::casa 5 48.85220289230347 4.089810696797017 [Generate WVR cal tables] |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:59 WARN TIMING::::casa 6 51.44748520851135 4.3070826466706915 [Generate delay calibration tables] |
| 13-Nov-2024 17:35:58 | 2024-11-13 22:35:59 WARN TIMING::::casa 7 225.6134648323059 18.887917170219847 [Apply antpos, wvr, tsys, and delay cal tables] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:35:59 WARN TIMING::::casa 8 37.99801731109619 3.18111954948265 [Split off non-wvr spws and save flags] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:35:59 WARN TIMING::::casa 9 14.350266933441162 1.2013762273047184 [Flagging] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:35:59 WARN TIMING::::casa 10 65.62566232681274 5.494051851874072 [Rebin to a reduced resolution of approx. 10 km/s] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:35:59 WARN TIMING::::casa 11 15.56342625617981 1.3029395485329047 [Fast phase-only gaincal for bandpass] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:35:59 WARN TIMING::::casa 12 43.588441610336304 3.6491389169832362 [Bandpass] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:35:59 WARN TIMING::::casa 13 21.51599144935608 1.801276642033132 [Setjy] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:35:59 WARN TIMING::::casa 14 24.474223375320435 2.048934022010189 [Fast phase-only gaincal] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:35:59 WARN TIMING::::casa 15 19.779827117919922 1.655928366342094 [Slow phase-only gaincal] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:35:59 WARN TIMING::::casa 16 18.84950876235962 1.5780439366392 [Slow amp and phase gaincal] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:35:59 WARN TIMING::::casa 17 2.2262027263641357 0.1863733298495154 [Fluxscale] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:35:59 WARN TIMING::::casa 18 34.86222863197327 2.9185974660661738 [Applycal] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:35:59 WARN TIMING::::casa 19 104.92482042312622 8.784100358217723 [Test image of the secondary phase cal] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:35:59 WARN TIMING::::casa 20 163.60211181640625 13.696448211360702 [Test image of the primary phase cal] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:35:59 WARN TIMING::::casa 21 109.22903299331665 9.144440600185119 [Test image of Titan] |
| 13-Nov-2024 17:36:08 | Step 22: Split off calibrated M100 data |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:35:59 INFO split::::casa ########################################## |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:35:59 INFO split::::casa ##### Begin Task: split ##### |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:35:59 INFO split::::casa split( vis='X54-line-vs.ms', outputvis='X54-calibrated.ms', keepmms=True, field='M100', spw='', scan='', antenna='', correlation='', timerange='', intent='', array='', uvrange='', observation='', feed='', datacolumn='corrected', keepflags=False, width=1, timebin='0s', combine='' ) |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:35:59 INFO ParallelDataHelper::::casa Analyzing MS for partitioning |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:35:59 INFO ParallelDataHelper::::casa Input vis is a Multi-MS |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:03 INFO ParallelDataHelper::::casa Finalizing MMS structure |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:03 INFO ms::createmultims Copying subtables from /home/casatest/work/test_regression_alma_M100_if_mpi/X54-calibrated.ms.data/X54-calibrated.ms.0000.ms to the other MMS members. |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:03 INFO split::::casa Task split complete. Start time: 2024-11-13 22:35:58.807181 End time: 2024-11-13 22:36:03.401648 |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:03 INFO split::::casa ##### End Task: split ##### |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:03 INFO split::::casa ########################################## |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:03 INFO split::::casa ########################################## |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:03 INFO split::::casa ##### Begin Task: split ##### |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:03 INFO split::::casa split( vis='X220-line-vs.ms', outputvis='X220-calibrated.ms', keepmms=True, field='M100', spw='', scan='', antenna='', correlation='', timerange='', intent='', array='', uvrange='', observation='', feed='', datacolumn='corrected', keepflags=False, width=1, timebin='0s', combine='' ) |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:04 INFO ParallelDataHelper::::casa Analyzing MS for partitioning |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:04 INFO ParallelDataHelper::::casa Input vis is a Multi-MS |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:07 INFO ParallelDataHelper::::casa Finalizing MMS structure |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:07 INFO ms::createmultims Copying subtables from /home/casatest/work/test_regression_alma_M100_if_mpi/X220-calibrated.ms.data/X220-calibrated.ms.0000.ms to the other MMS members. |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 INFO split::::casa Task split complete. Start time: 2024-11-13 22:36:03.419739 End time: 2024-11-13 22:36:08.009616 |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 INFO split::::casa ##### End Task: split ##### |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 INFO split::::casa ########################################## |
| 13-Nov-2024 17:36:08 | |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa Step 22: Split off calibrated M100 data |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa Time now: 1731537368.0102057 |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa Time used this step: 9.224095344543457 |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa Total time used so far: 1203.7097699642181 |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa Step Time used (s) Fraction of total time (percent) [description] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 0 137.75823426246643 11.444472554755576 [Data import] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 1 0.18251419067382812 0.015162640964462189 [Generate antenna position cal tables] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 2 20.73629069328308 1.7226985450071983 [Generate tsys cal tables] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 3 13.971266984939575 1.1606840231391402 [Correct the Titan position] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 4 19.33445382118225 1.606238837934911 [Apriori flagging] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 5 48.85220289230347 4.058470248501486 [Generate WVR cal tables] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 6 51.44748520851135 4.274077231261543 [Generate delay calibration tables] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 7 225.6134648323059 18.74317800369873 [Apply antpos, wvr, tsys, and delay cal tables] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 8 37.99801731109619 3.1567424523127143 [Split off non-wvr spws and save flags] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 9 14.350266933441162 1.1921700140281941 [Flagging] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 10 65.62566232681274 5.451950625005191 [Rebin to a reduced resolution of approx. 10 km/s] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 11 15.56342625617981 1.292955049840831 [Fast phase-only gaincal for bandpass] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 12 43.588441610336304 3.6211753612028943 [Bandpass] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 13 21.51599144935608 1.7874733582992908 [Setjy] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 14 24.474223375320435 2.0332329259110327 [Fast phase-only gaincal] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 15 19.779827117919922 1.6432388945807015 [Slow phase-only gaincal] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 16 18.84950876235962 1.5659512976221788 [Slow amp and phase gaincal] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 17 2.2262027263641357 0.18494514059068512 [Fluxscale] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 18 34.86222863197327 2.8962320903160563 [Applycal] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 19 104.92482042312622 8.716787305485212 [Test image of the secondary phase cal] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 20 163.60211181640625 13.591491562062302 [Test image of the primary phase cal] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 21 109.22903299331665 9.074366240008471 [Test image of Titan] |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 WARN TIMING::::casa 22 9.224095344543457 0.7663055974711958 [Split off calibrated M100 data] |
| 13-Nov-2024 17:36:08 | Step 23: Concatenate M100 data |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 INFO virtualconcat::::casa ########################################## |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 INFO virtualconcat::::casa ##### Begin Task: virtualconcat ##### |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 INFO virtualconcat::::casa virtualconcat( vis=['X54-calibrated.ms', 'X220-calibrated.ms'], concatvis='M100all.ms', freqtol='', dirtol='', respectname=True, visweightscale=[], keepcopy=False, copypointing=False ) |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 INFO virtualconcat::::casa Checking MS setup consistency ... |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 INFO virtualconcat::::casa Checking for unpopulated POINTING table in first MS ... |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 INFO virtualconcat::::casa Checking for unpopulated optional Main Table columns in first MS ... |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 INFO virtualconcat::::casa Checking for unpopulated POINTING table ... |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 INFO virtualconcat::::casa Checking for unpopulated optional Main Table columns ... |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 INFO virtualconcat::::casa Checking order of MS list ... |
| 13-Nov-2024 17:36:08 | 2024-11-13 22:36:08 INFO virtualconcat::::casa *** The following input measurement sets are multi-MSs |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:08 INFO virtualconcat::::casa *** X54-calibrated.ms |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:08 INFO virtualconcat::::casa *** X220-calibrated.ms |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:08 INFO virtualconcat::::casa Concatenating ... |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:08 INFO virtualconcat::::casa *** copypointing==False: resulting MMS will have empty POINTING table. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO virtualconcat::::casa adding /home/casatest/work/test_regression_alma_M100_if_mpi/X54-calibrated.ms/SUBMSS/X54-calibrated.ms.0001.ms to multi-MS M100all.ms |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Added 0 rows and matched 94 from the state subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Added 4 rows to the source subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Added 0 rows and matched 4 from the data description subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Added 0 rows and matched 4 from the spectral window subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Removed 4 redundant rows from the source subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Added 0 rows and matched 13 from the antenna subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat + Added 0 rows to the feed subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat + Added 0 rows and matched 48 from the field subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::copyObservation Added 0 rows and matched 1 rows in the observation subtable. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::copyProcessor Added 0 rows and matched 3 rows in the processor subtable. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::copySysCal No valid syscal tables present. Result won't have one either. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::copyGainCurve No valid gain curve tables present. Result won't have one either. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::copyPhaseCal No valid gain curve tables present. Result won't have one either. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Will create auxiliary file concat_aux_1731537368.6584196 |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Working on appended Main table ... |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Writing to concat_aux_1731537368.6584196 |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Writing the scalar columns ... |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO virtualconcat::::casa adding /home/casatest/work/test_regression_alma_M100_if_mpi/X54-calibrated.ms/SUBMSS/X54-calibrated.ms.0002.ms to multi-MS M100all.ms |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Added 0 rows and matched 94 from the state subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Added 4 rows to the source subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Added 0 rows and matched 4 from the data description subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Added 0 rows and matched 4 from the spectral window subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Removed 4 redundant rows from the source subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Added 0 rows and matched 13 from the antenna subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat + Added 0 rows to the feed subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat + Added 0 rows and matched 48 from the field subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::copyObservation Added 0 rows and matched 1 rows in the observation subtable. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::copyProcessor Added 0 rows and matched 3 rows in the processor subtable. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::copySysCal No valid syscal tables present. Result won't have one either. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::copyGainCurve No valid gain curve tables present. Result won't have one either. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::copyPhaseCal No valid gain curve tables present. Result won't have one either. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Reading from concat_aux_1731537368.6584196 |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Working on appended Main table ... |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Writing to concat_aux_1731537368.6584196 |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Writing the scalar columns ... |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO virtualconcat::::casa adding /home/casatest/work/test_regression_alma_M100_if_mpi/X220-calibrated.ms/SUBMSS/X220-calibrated.ms.0000.ms to multi-MS M100all.ms |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Added 0 rows and matched 94 from the state subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Added 4 rows to the source subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Added 0 rows and matched 4 from the data description subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Added 0 rows and matched 4 from the spectral window subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:09 INFO MSConcat::virtualconcat Removed 4 redundant rows from the source subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Added 0 rows and matched 13 from the antenna subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat + Added 0 rows to the feed subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat + Added 0 rows and matched 48 from the field subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::copyObservation Added 1 rows and matched 0 rows in the observation subtable. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::copyProcessor Added 0 rows and matched 3 rows in the processor subtable. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::copySysCal No valid syscal tables present. Result won't have one either. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::copyGainCurve No valid gain curve tables present. Result won't have one either. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::copyPhaseCal No valid gain curve tables present. Result won't have one either. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Reading from concat_aux_1731537368.6584196 |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Working on appended Main table ... |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Will offset scan numbers by 15 for observations with Obs ID 1 in order to make scan numbers unique. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Writing to concat_aux_1731537368.6584196 |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Writing the scalar columns ... |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO virtualconcat::::casa adding /home/casatest/work/test_regression_alma_M100_if_mpi/X220-calibrated.ms/SUBMSS/X220-calibrated.ms.0001.ms to multi-MS M100all.ms |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Added 0 rows and matched 94 from the state subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Added 4 rows to the source subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Added 0 rows and matched 4 from the data description subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Added 0 rows and matched 4 from the spectral window subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Removed 4 redundant rows from the source subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Added 0 rows and matched 13 from the antenna subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat + Added 0 rows to the feed subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat + Added 0 rows and matched 48 from the field subtable |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::copyObservation Added 0 rows and matched 1 rows in the observation subtable. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::copyProcessor Added 0 rows and matched 3 rows in the processor subtable. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::copySysCal No valid syscal tables present. Result won't have one either. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::copyGainCurve No valid gain curve tables present. Result won't have one either. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::copyPhaseCal No valid gain curve tables present. Result won't have one either. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Reading from concat_aux_1731537368.6584196 |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Working on appended Main table ... |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Will offset scan numbers by 15 for observations with Obs ID 1 in order to make scan numbers unique. |
| 13-Nov-2024 17:36:09 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Writing to concat_aux_1731537368.6584196 |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Writing the scalar columns ... |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:10 INFO virtualconcat::::casa adding /home/casatest/work/test_regression_alma_M100_if_mpi/X220-calibrated.ms/SUBMSS/X220-calibrated.ms.0002.ms to multi-MS M100all.ms |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Added 0 rows and matched 94 from the state subtable |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Added 4 rows to the source subtable |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Added 0 rows and matched 4 from the data description subtable |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Added 0 rows and matched 4 from the spectral window subtable |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Removed 4 redundant rows from the source subtable |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Added 0 rows and matched 13 from the antenna subtable |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat + Added 0 rows to the feed subtable |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat + Added 0 rows and matched 48 from the field subtable |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:10 INFO MSConcat::copyObservation Added 0 rows and matched 1 rows in the observation subtable. |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:10 INFO MSConcat::copyProcessor Added 0 rows and matched 3 rows in the processor subtable. |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:10 INFO MSConcat::copySysCal No valid syscal tables present. Result won't have one either. |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:10 INFO MSConcat::copyGainCurve No valid gain curve tables present. Result won't have one either. |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:10 INFO MSConcat::copyPhaseCal No valid gain curve tables present. Result won't have one either. |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Reading from concat_aux_1731537368.6584196 |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Working on appended Main table ... |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Will offset scan numbers by 15 for observations with Obs ID 1 in order to make scan numbers unique. |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Writing to concat_aux_1731537368.6584196 |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:10 INFO MSConcat::virtualconcat Writing the scalar columns ... |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:10 INFO ms::createmultims Copying subtables from /home/casatest/work/test_regression_alma_M100_if_mpi/X54-calibrated.ms/SUBMSS/X54-calibrated.ms.0000.ms to the other MMS members. |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 INFO virtualconcat::::casa Task virtualconcat complete. Start time: 2024-11-13 22:36:08.038907 End time: 2024-11-13 22:36:11.324394 |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 INFO virtualconcat::::casa ##### End Task: virtualconcat ##### |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 INFO virtualconcat::::casa ########################################## |
| 13-Nov-2024 17:36:16 | |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa Step 23: Concatenate M100 data |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa Time now: 1731537371.3250968 |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa Time used this step: 3.3148910999298096 |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa Total time used so far: 1207.024661064148 |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa Step Time used (s) Fraction of total time (percent) [description] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 0 137.75823426246643 11.413042227406917 [Data import] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 1 0.18251419067382812 0.015120999310231021 [Generate antenna position cal tables] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 2 20.73629069328308 1.7179674419411917 [Generate tsys cal tables] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 3 13.971266984939575 1.15749639884094 [Correct the Titan position] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 4 19.33445382118225 1.6018275719517143 [Apriori flagging] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 5 48.85220289230347 4.047324339606612 [Generate WVR cal tables] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 6 51.44748520851135 4.262339193894659 [Generate delay calibration tables] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 7 225.6134648323059 18.691703004095917 [Apply antpos, wvr, tsys, and delay cal tables] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 8 37.99801731109619 3.1480729878042455 [Split off non-wvr spws and save flags] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 9 14.350266933441162 1.1888959187287484 [Flagging] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 10 65.62566232681274 5.436977755612322 [Rebin to a reduced resolution of approx. 10 km/s] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 11 15.56342625617981 1.2894041653182662 [Fast phase-only gaincal for bandpass] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 12 43.588441610336304 3.611230409485376 [Bandpass] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 13 21.51599144935608 1.7825643620559464 [Setjy] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 14 24.474223375320435 2.0276489921708185 [Fast phase-only gaincal] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 15 19.779827117919922 1.6387260141380584 [Slow phase-only gaincal] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 16 18.84950876235962 1.5616506746217882 [Slow amp and phase gaincal] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 17 2.2262027263641357 0.18443721973347676 [Fluxscale] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 18 34.86222863197327 2.8882780738910268 [Applycal] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 19 104.92482042312622 8.69284810888797 [Test image of the secondary phase cal] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 20 163.60211181640625 13.554164806555807 [Test image of the primary phase cal] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 21 109.22903299331665 9.049445012748718 [Test image of Titan] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 22 9.224095344543457 0.7642010674753925 [Split off calibrated M100 data] |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 WARN TIMING::::casa 23 3.3148910999298096 0.2746332537238556 [Concatenate M100 data] |
| 13-Nov-2024 17:36:16 | Step 24: Average concatenated M100 data in time |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 INFO split::::casa ########################################## |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 INFO split::::casa ##### Begin Task: split ##### |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 INFO split::::casa split( vis='M100all.ms', outputvis='M100all_lores.ms', keepmms=True, field='', spw='', scan='', antenna='', correlation='', timerange='', intent='', array='', uvrange='', observation='', feed='', datacolumn='data', keepflags=True, width=1, timebin='60s', combine='' ) |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 INFO ParallelDataHelper::::casa Analyzing MS for partitioning |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:11 INFO ParallelDataHelper::::casa Input vis is a Multi-MS |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:12 WARN MSTransformManager::parseTimeAvgParams::MPIServer-1 Operating with ALMA data, automatically adding state to timespan |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:12 WARN MSTransformManager::parseTimeAvgParams::MPIServer-1+ In order to remove sub-scan boundaries which limit time average to 30s |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:12 WARN MSTransformManager::parseTimeAvgParams::MPIServer-2 Operating with ALMA data, automatically adding state to timespan |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:12 WARN MSTransformManager::parseTimeAvgParams::MPIServer-2+ In order to remove sub-scan boundaries which limit time average to 30s |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:12 WARN MSTransformManager::parseTimeAvgParams::MPIServer-3 Operating with ALMA data, automatically adding state to timespan |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:12 WARN MSTransformManager::parseTimeAvgParams::MPIServer-3+ In order to remove sub-scan boundaries which limit time average to 30s |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:16 WARN MSTransformManager::parseTimeAvgParams::MPIServer-1 Operating with ALMA data, automatically adding state to timespan |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:16 WARN MSTransformManager::parseTimeAvgParams::MPIServer-1+ In order to remove sub-scan boundaries which limit time average to 30s |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:16 WARN MSTransformManager::parseTimeAvgParams::MPIServer-3 Operating with ALMA data, automatically adding state to timespan |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:16 WARN MSTransformManager::parseTimeAvgParams::MPIServer-3+ In order to remove sub-scan boundaries which limit time average to 30s |
| 13-Nov-2024 17:36:16 | 2024-11-13 22:36:16 WARN MSTransformManager::parseTimeAvgParams::MPIServer-2 Operating with ALMA data, automatically adding state to timespan |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:16 WARN MSTransformManager::parseTimeAvgParams::MPIServer-2+ In order to remove sub-scan boundaries which limit time average to 30s |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:20 INFO ParallelDataHelper::::casa Finalizing MMS structure |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:20 INFO ms::createmultims Copying subtables from /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms.data/M100all_lores.ms.0000.ms to the other MMS members. |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 INFO split::::casa Task split complete. Start time: 2024-11-13 22:36:11.345482 End time: 2024-11-13 22:36:21.272620 |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 INFO split::::casa ##### End Task: split ##### |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 INFO split::::casa ########################################## |
| 13-Nov-2024 17:36:25 | |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa Step 24: Average concatenated M100 data in time |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa Time now: 1731537381.273157 |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa Time used this step: 9.948060035705566 |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa Total time used so far: 1216.9727210998535 |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa Step Time used (s) Fraction of total time (percent) [description] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 0 137.75823426246643 11.319747096546733 [Data import] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 1 0.18251419067382812 0.0149973937385284 [Generate antenna position cal tables] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 2 20.73629069328308 1.703924034923512 [Generate tsys cal tables] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 3 13.971266984939575 1.1480345239220215 [Correct the Titan position] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 4 19.33445382118225 1.5887335423351567 [Apriori flagging] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 5 48.85220289230347 4.014239764401022 [Generate WVR cal tables] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 6 51.44748520851135 4.227496994510696 [Generate delay calibration tables] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 7 225.6134648323059 18.538908959964616 [Apply antpos, wvr, tsys, and delay cal tables] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 8 37.99801731109619 3.1223392810937485 [Split off non-wvr spws and save flags] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 9 14.350266933441162 1.1791773705882198 [Flagging] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 10 65.62566232681274 5.392533553874796 [Rebin to a reduced resolution of approx. 10 km/s] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 11 15.56342625617981 1.2788640194099157 [Fast phase-only gaincal for bandpass] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 12 43.588441610336304 3.5817106541996053 [Bandpass] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 13 21.51599144935608 1.7679929119455322 [Setjy] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 14 24.474223375320435 2.011074114562039 [Fast phase-only gaincal] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 15 19.779827117919922 1.6253303607367362 [Slow phase-only gaincal] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 16 18.84950876235962 1.5488850682966955 [Slow amp and phase gaincal] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 17 2.2262027263641357 0.1829295503314305 [Fluxscale] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 18 34.86222863197327 2.864668042884816 [Applycal] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 19 104.92482042312622 8.62178901826979 [Test image of the secondary phase cal] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 20 163.60211181640625 13.443367216033314 [Test image of the primary phase cal] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 21 109.22903299331665 8.975470945199135 [Test image of Titan] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 22 9.224095344543457 0.7579541582663473 [Split off calibrated M100 data] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 23 3.3148910999298096 0.2723882830285577 [Concatenate M100 data] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 WARN TIMING::::casa 24 9.948060035705566 0.8174431409370366 [Average concatenated M100 data in time] |
| 13-Nov-2024 17:36:25 | Step 25: Continuum image of M100 |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 INFO tclean::::casa ########################################## |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 INFO tclean::::casa ##### Begin Task: tclean ##### |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 INFO tclean::::casa tclean( vis='M100all_lores.ms', selectdata=True, field='2~47', spw='0:10~210;256~440,1~3:10~460', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='M100cont', imsize=200, cell='0.5arcsec', phasecenter='J2000 12h22m54.9 +15d49m15', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='mosaic', 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='clark', 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, uvtaper=[''], niter=1000, 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='M100cont-orig.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 ) |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:21 INFO tclean::::casa Verifying Input Parameters |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:25 INFO tclean::::casa setupCluster, Setting up 3 engines. |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:25 INFO SynthesisUtilMethods::continuumDataPartition |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:25 INFO SynthesisUtilMethods::continuumDataPartition + Rows = 27459 41184 [P][M]: 0:2 ROWNUMBER() >= 27459 && ROWNUMBER() <= 41184 |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:25 INFO tclean::::casa Partitioned Selection : {'0': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '2~47', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'M100all_lores.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:10~210;256~440,1~3:10~460', 'state': '', 'taql': 'ROWNUMBER() >= 1 && ROWNUMBER() <= 13729', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '1': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '2~47', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'M100all_lores.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:10~210;256~440,1~3:10~460', 'state': '', 'taql': 'ROWNUMBER() >= 13730 && ROWNUMBER() <= 27458', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '2': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '2~47', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'M100all_lores.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:10~210;256~440,1~3:10~460', 'state': '', 'taql': 'ROWNUMBER() >= 27459 && ROWNUMBER() <= 41184', 'timestr': '', 'usescratch': False, 'uvdist': ''}}} |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:25 INFO SynthesisImagerVi2::selectData MS : M100all_lores.ms | Selecting on fields : 2~47 | Selecting on spw :0:10~210;256~440,1~3:10~460 | [Opened in readonly mode] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:25 INFO SynthesisImagerVi2::selectData NRows selected : 41184 |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:26 INFO SynthesisImagerVi2::defineImage Define image coordinates for [M100cont] : |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:26 INFO SynthesisImagerVi2::defineImage Define image coordinates for [M100cont] : |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:26 INFO SynthesisImagerVi2::defineImage Impars: start |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:26 INFO SynthesisImagerVi2::defineImage Shape: [200, 200, 1, 1] Spectral: [1.0775e+11] at [0] with increment [1.53986e+10] |
| 13-Nov-2024 17:36:25 | 2024-11-13 22:36:26 INFO SynthesisImagerVi2::defineImage Set Gridding options for [M100cont] with ftmachine: mosaicft |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:26 INFO SynthesisImager::getVPRecord Using default Voltage Patterns from the VPManager |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:26 INFO VPSkyJones::VPSkyJones PB used ALMA |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:26 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.01717 GB. Available mem.: 191 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:26 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:27 INFO tclean::::casa ...done |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:27 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:28 INFO tclean::::casa ...done |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:29 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:30 INFO tclean::::casa ...done |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:34 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:35 INFO tclean::::casa ...done |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:35 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [M100cont] : clark |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:35 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:36 INFO tclean::::casa ...done |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:36 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:36:57 | |
| 13-Nov-2024 17:36:57 | 0%....10....20....30....40... |
| 13-Nov-2024 17:36:57 | 0%....10....20....30....40 |
| 13-Nov-2024 17:36:57 | 0%....10....20....30....40....50.....50...50.....60......6060........7070......70....80.....80....80.....90.....100% |
| 13-Nov-2024 17:36:57 | .90....100% |
| 13-Nov-2024 17:36:57 | 90....100% |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:50 INFO tclean::::casa ...done |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:50 INFO SynthesisNormalizer::gatherImages Gather psf,weight images : [/home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n3] onto :M100cont |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:50 INFO SIImageStore::calcSensitivity [M100cont] Theoretical sensitivity (Jy/bm):1.32309e-06 |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:50 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.040046 |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:50 INFO SIImageStore::printBeamSet Beam : 5.16402 arcsec, 2.72039 arcsec, -69.1551 deg |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:50 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:51 INFO tclean::::casa ...done |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:51 INFO SynthesisNormalizer::scatterModel Send the model from : M100cont to all nodes :[/home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n3] |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:51 INFO SIImageStore::setModelImageOne Copying input model M100cont.model to /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n1.model |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:51 INFO SIImageStore::setModelImageOne Copying input model M100cont.model to /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n2.model |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:51 INFO SIImageStore::setModelImageOne Copying input model M100cont.model to /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n3.model |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:51 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:51 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:56 INFO tclean::::casa ...done |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:56 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n3] onto :M100cont |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.000543285, over full image : 0.000543285 |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO SynthesisDeconvolver::setupMask [M100cont] Setting up a mask from [M100cont-orig.mask] |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane. |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO CasacRegionManager::fromBCS Using all spectral channels. |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO CasacRegionManager::fromBCS Using polarizations ALL |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO You've specified explicitly that the spectral axis should be regridded. However, the input image has a degenerate spectral axis and so it cannot be regridded. Instead, the resulting single output channel will be replicated 1 times in the output image. |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO ImageMaskAttacher::makeMask Created and initialized mask `mask0' |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO SDMaskHandler::fillMask Copying mask image: M100cont-orig.mask |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane. |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO CasacRegionManager::fromBCS Using all spectral channels. |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO CasacRegionManager::fromBCS Using polarizations ALL |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO You've specified explicitly that the spectral axis should be regridded. However, the input image has a degenerate spectral axis and so it cannot be regridded. Instead, the resulting single output channel will be replicated 1 times in the output image. |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO ImageMaskAttacher::makeMask Created and initialized mask `mask0' |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO SynthesisDeconvolver::setupMask ---------------------------------------------------------------------------------------------------------------------------------------- |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO SynthesisDeconvolver::setupMask [M100cont] Number of pixels in the clean mask : 1748 out of a total of 40000 pixels. [ 4.37 % ] |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.000543285, over full image : 0.000543285 |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 1000, 'cyclethreshold': 0.00012687371054198593, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO SDAlgorithmBase::deconvolve [M100cont] Run clark minor-cycle | CycleThreshold=0.000126874, CycleNiter=1000, Gain=0.1 |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO SDAlgorithmClarkClean2::initializeDeconvolver Choosing a PSF patch size of 34 pixels. |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO ClarkCleanLatModel::solve Iteration: 1, Maximum residual=0.000488957 Flux limit=0.000126874, 902 Active pixels |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO ClarkCleanLatModel::solve Iteration: 4, Maximum residual=0.000423278 Flux limit=0.000126874, 896 Active pixels |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO ClarkCleanLatModel::solve Iteration: 10, Maximum residual=0.000348027 Flux limit=0.000126874, 889 Active pixels |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO ClarkCleanLatModel::solve Iteration: 24, Maximum residual=0.000279455 Flux limit=0.000126874, 868 Active pixels |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO ClarkCleanLatModel::solve Iteration: 53, Maximum residual=0.000214471 Flux limit=0.000126874, 812 Active pixels |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO ClarkCleanLatModel::solve Iteration: 111, Maximum residual=0.000156133 Flux limit=0.000126874, 669 Active pixels |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO ClarkCleanLatModel::solve Iteration: 153, Maximum residual=0.000126376 Flux limit=0.000126874, 288 Active pixels |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO SDAlgorithmBase::deconvolve [M100cont] iters=0->153 [153], model=0->0.00184152, peakres=0.000543285->0.000126376, Reached cyclethreshold. |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 153 iterations. |
| 13-Nov-2024 17:36:57 | 2024-11-13 22:36:57 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : M100cont to all nodes :[/home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n3] |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:36:57 INFO task_tclean::SIImageStore::setModelImageOne Copying input model M100cont.model to /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n1.model |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:36:57 INFO task_tclean::SIImageStore::setModelImageOne Copying input model M100cont.model to /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n2.model |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:36:57 INFO task_tclean::SIImageStore::setModelImageOne Copying input model M100cont.model to /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n3.model |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:36:57 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:36:57 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:37:22 | |
| 13-Nov-2024 17:37:22 | 0%....10....20....30....40....50....60....70....80... |
| 13-Nov-2024 17:37:22 | 0%....10....20....30....40....50....60....70....80.... |
| 13-Nov-2024 17:37:22 | 0%....10....20....30....40....50....60....70....80....90....90..100% |
| 13-Nov-2024 17:37:22 | ...100% |
| 13-Nov-2024 17:37:22 | 90....100% |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:05 INFO tclean::::casa ...done |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:05 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n3] onto :M100cont |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:06 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.000131666, over full image : 0.000506478 |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:06 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 847, 'cyclethreshold': 3.074792766710743e-05, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:06 INFO SDAlgorithmBase::deconvolve [M100cont] Run clark minor-cycle | CycleThreshold=3.07479e-05, CycleNiter=847, Gain=0.1 |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:06 INFO SDAlgorithmClarkClean2::initializeDeconvolver Choosing a PSF patch size of 34 pixels. |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:06 INFO ClarkCleanLatModel::solve Iteration: 1, Maximum residual=0.000131374 Flux limit=3.07479e-05, 1379 Active pixels |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:06 INFO ClarkCleanLatModel::solve Iteration: 4, Maximum residual=0.00012745 Flux limit=3.07479e-05, 1381 Active pixels |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:06 INFO ClarkCleanLatModel::solve Iteration: 12, Maximum residual=0.000124416 Flux limit=3.07479e-05, 1382 Active pixels |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:06 INFO ClarkCleanLatModel::solve Iteration: 31, Maximum residual=0.000114552 Flux limit=3.07479e-05, 1364 Active pixels |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:06 INFO ClarkCleanLatModel::solve Iteration: 75, Maximum residual=0.00010052 Flux limit=3.07479e-05, 1340 Active pixels |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:06 INFO ClarkCleanLatModel::solve Iteration: 163, Maximum residual=7.9564e-05 Flux limit=3.07479e-05, 1281 Active pixels |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:06 INFO ClarkCleanLatModel::solve Iteration: 322, Maximum residual=5.60987e-05 Flux limit=3.07479e-05, 1170 Active pixels |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:06 INFO ClarkCleanLatModel::solve Iteration: 573, Maximum residual=3.98358e-05 Flux limit=3.07479e-05, 829 Active pixels |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:06 INFO ClarkCleanLatModel::solve Iteration: 817, Maximum residual=3.06841e-05 Flux limit=3.07479e-05, 437 Active pixels |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:06 INFO SDAlgorithmBase::deconvolve [M100cont] iters=0->817 [817], model=0.00184152->0.00251093, peakres=0.000131666->3.06841e-05, Reached cyclethreshold. |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:06 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 970 iterations. |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:06 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : M100cont to all nodes :[/home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n3] |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:06 INFO task_tclean::SIImageStore::setModelImageOne Copying input model M100cont.model to /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n1.model |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:06 INFO task_tclean::SIImageStore::setModelImageOne Copying input model M100cont.model to /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n2.model |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:06 INFO task_tclean::SIImageStore::setModelImageOne Copying input model M100cont.model to /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n3.model |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:06 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:06 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:37:22 | |
| 13-Nov-2024 17:37:22 | 0%....10....20....30....40....50....60....70....80....90 |
| 13-Nov-2024 17:37:22 | 0%....10....20....30....40....50....60....70....80... |
| 13-Nov-2024 17:37:22 | 0%....10....20....30....40....50....60....70....80.........100% |
| 13-Nov-2024 17:37:22 | 90....100% |
| 13-Nov-2024 17:37:22 | 90....100% |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:14 INFO tclean::::casa ...done |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:14 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n3] onto :M100cont |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:14 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 3.9846e-05, over full image : 0.000490798 |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:14 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 30, 'cyclethreshold': 9.305247658630833e-06, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:14 INFO SDAlgorithmBase::deconvolve [M100cont] Run clark minor-cycle | CycleThreshold=9.30525e-06, CycleNiter=30, Gain=0.1 |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:14 INFO SDAlgorithmClarkClean2::initializeDeconvolver Choosing a PSF patch size of 34 pixels. |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:14 INFO ClarkCleanLatModel::solve Iteration: 1, Maximum residual=3.95914e-05 Flux limit=9.30525e-06, 1273 Active pixels |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:14 INFO ClarkCleanLatModel::solve Iteration: 4, Maximum residual=3.6595e-05 Flux limit=9.30525e-06, 1272 Active pixels |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:14 INFO ClarkCleanLatModel::solve Iteration: 12, Maximum residual=3.46896e-05 Flux limit=9.30525e-06, 1257 Active pixels |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:14 INFO ClarkCleanLatModel::solve Iteration: 30, Maximum residual=3.30784e-05 Flux limit=9.30525e-06, 1249 Active pixels |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:14 INFO SDAlgorithmBase::deconvolve [M100cont] iters=0->30 [30], model=0.00251093->0.00251647, peakres=3.9846e-05->3.30784e-05, Reached cycleniter. |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:14 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 1000 iterations. |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:15 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : M100cont to all nodes :[/home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n3] |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:15 INFO task_tclean::SIImageStore::setModelImageOne Copying input model M100cont.model to /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n1.model |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:15 INFO task_tclean::SIImageStore::setModelImageOne Copying input model M100cont.model to /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n2.model |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:15 INFO task_tclean::SIImageStore::setModelImageOne Copying input model M100cont.model to /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n3.model |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:15 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 13-Nov-2024 17:37:22 | 2024-11-13 22:37:15 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:37:22 | |
| 13-Nov-2024 17:37:22 | 0%....10....20....30....40....50....60....70....80. |
| 13-Nov-2024 17:37:22 | 0%....10....20....30....40....50....60....70....80..... |
| 13-Nov-2024 17:37:22 | 0%....10....20....30....40....50....60....70....80....90......90100% |
| 13-Nov-2024 17:37:22 | ....100% |
| 13-Nov-2024 17:37:45 | 90....100% |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:23 INFO tclean::::casa ...done |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:23 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/M100cont.workdirectory/M100cont.n3] onto :M100cont |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:23 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 3.35419e-05, over full image : 0.000490481 |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:23 INFO tclean::::casa Reached global stopping criterion : iteration limit |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:23 INFO tclean::::casa getSummary call: fullsummary=False |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:23 INFO SDAlgorithmBase::restore [M100cont] : Restoring model image. |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:23 INFO SIImageStore::restore Beam for chan : 0 : 5.16402 arcsec, 2.72039 arcsec, -69.1551 deg |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:34 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:35 INFO tclean::::casa ...done |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 INFO tclean::::casa Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed. |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 INFO tclean::::casa Searching for images with prefix 'M100cont'... Found these, writing history into them: ['M100cont.psf', 'M100cont.pb', 'M100cont.residual', 'M100cont.model', 'M100cont.weight', 'M100cont.mask', 'M100cont.image', 'M100cont.sumwt'] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 INFO tclean::::casa Task tclean complete. Start time: 2024-11-13 22:36:21.312023 End time: 2024-11-13 22:37:35.673908 |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 INFO tclean::::casa ##### End Task: tclean ##### |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 INFO tclean::::casa ########################################## |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa Step 25: Continuum image of M100 |
| 13-Nov-2024 17:37:45 | |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa Time now: 1731537455.6751025 |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa Time used this step: 74.4019455909729 |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa Total time used so far: 1291.3746666908264 |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa Step Time used (s) Fraction of total time (percent) [description] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 0 137.75823426246643 10.667565178080709 [Data import] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 1 0.18251419067382812 0.014133325934101248 [Generate antenna position cal tables] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 2 20.73629069328308 1.6057532510235968 [Generate tsys cal tables] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 3 13.971266984939575 1.081891053410644 [Correct the Titan position] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 4 19.33445382118225 1.4971994046257062 [Apriori flagging] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 5 48.85220289230347 3.7829612235996715 [Generate WVR cal tables] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 6 51.44748520851135 3.9839317384432333 [Generate delay calibration tables] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 7 225.6134648323059 17.4707984175069 [Apply antpos, wvr, tsys, and delay cal tables] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 8 37.99801731109619 2.9424471682154705 [Split off non-wvr spws and save flags] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 9 14.350266933441162 1.1112396195764014 [Flagging] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 10 65.62566232681274 5.081845263000228 [Rebin to a reduced resolution of approx. 10 km/s] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 11 15.56342625617981 1.2051828688928365 [Fast phase-only gaincal for bandpass] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 12 43.588441610336304 3.3753520751675086 [Bandpass] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 13 21.51599144935608 1.6661308297530135 [Setjy] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 14 24.474223375320435 1.8952070229189277 [Fast phase-only gaincal] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 15 19.779827117919922 1.5316877145039656 [Slow phase-only gaincal] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 16 18.84950876235962 1.4596467817246148 [Slow amp and phase gaincal] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 17 2.2262027263641357 0.17239015010793304 [Fluxscale] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 18 34.86222863197327 2.699621537513077 [Applycal] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 19 104.92482042312622 8.12504868877428 [Test image of the secondary phase cal] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 20 163.60211181640625 12.668833920649842 [Test image of the primary phase cal] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 21 109.22903299331665 8.458353397408533 [Test image of Titan] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 22 9.224095344543457 0.7142849850214568 [Split off calibrated M100 data] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 23 3.3148910999298096 0.2566947598890324 [Concatenate M100 data] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 24 9.948060035705566 0.7703465378640012 [Average concatenated M100 data in time] |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN TIMING::::casa 25 74.4019455909729 5.761453086394313 [Continuum image of M100] |
| 13-Nov-2024 17:37:45 | Step 26: Determine and subtract continuum |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 INFO uvcontsub_old::::casa ########################################## |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 INFO uvcontsub_old::::casa ##### Begin Task: uvcontsub_old ##### |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 INFO uvcontsub_old::::casa uvcontsub_old( vis='M100all_lores.ms', field='', fitspw='0:10~205;260~440', excludechans=False, combine='', solint='inf', fitorder=1, spw='0', want_cont=False ) |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN uvcontsub_old::::casa::MPIServer-3 This task is deprecated and will be removed in an upcoming release. |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN uvcontsub_old::::casa::MPIServer-2 This task is deprecated and will be removed in an upcoming release. |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:36 WARN uvcontsub_old::::casa::MPIServer-1 This task is deprecated and will be removed in an upcoming release. |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:38 WARN calibrater::setvi(bool,bool)::MPIServer-1 Forcing use of OLD VisibilityIterator. |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:38 WARN calibrater::setvi(bool,bool)::MPIServer-3 Forcing use of OLD VisibilityIterator. |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:38 WARN calibrater::setvi(bool,bool)::MPIServer-2 Forcing use of OLD VisibilityIterator. |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:40 WARN VBContinuumSubtractor::apply::MPIServer-1 Extrapolating to cover [113.728, 115.599] (GHz). |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:40 WARN VBContinuumSubtractor::apply::MPIServer-1+ The frequency range used for the continuum fit was [113.767, 115.447] (GHz). |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:40 WARN VBContinuumSubtractor::apply::MPIServer-3 Extrapolating to cover [113.728, 115.599] (GHz). |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:40 WARN VBContinuumSubtractor::apply::MPIServer-3+ The frequency range used for the continuum fit was [113.767, 115.447] (GHz). |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:41 WARN VBContinuumSubtractor::apply::MPIServer-2 Extrapolating to cover [113.728, 115.599] (GHz). |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:41 WARN VBContinuumSubtractor::apply::MPIServer-2+ The frequency range used for the continuum fit was [113.767, 115.447] (GHz). |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:41 WARN uvcontsub_old::::casa::MPIServer-1 This task is deprecated and will be removed in an upcoming release. |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:42 WARN uvcontsub_old::::casa::MPIServer-3 This task is deprecated and will be removed in an upcoming release. |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:43 WARN calibrater::setvi(bool,bool)::MPIServer-1 Already using OLD VisibilityIterator. |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:43 WARN uvcontsub_old::::casa::MPIServer-2 This task is deprecated and will be removed in an upcoming release. |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:43 WARN calibrater::setvi(bool,bool)::MPIServer-3 Already using OLD VisibilityIterator. |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:44 WARN calibrater::setvi(bool,bool)::MPIServer-2 Already using OLD VisibilityIterator. |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:45 WARN VBContinuumSubtractor::apply::MPIServer-1 Extrapolating to cover [113.728, 115.599] (GHz). |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:45 WARN VBContinuumSubtractor::apply::MPIServer-1+ The frequency range used for the continuum fit was [113.767, 115.447] (GHz). |
| 13-Nov-2024 17:37:45 | 2024-11-13 22:37:45 WARN VBContinuumSubtractor::apply::MPIServer-2 Extrapolating to cover [113.728, 115.599] (GHz). |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:45 WARN VBContinuumSubtractor::apply::MPIServer-2+ The frequency range used for the continuum fit was [113.767, 115.447] (GHz). |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:45 WARN VBContinuumSubtractor::apply::MPIServer-3 Extrapolating to cover [113.728, 115.599] (GHz). |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:45 WARN VBContinuumSubtractor::apply::MPIServer-3+ The frequency range used for the continuum fit was [113.767, 115.447] (GHz). |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:47 INFO virtualconcat::::casa ########################################## |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:47 INFO virtualconcat::::casa ##### Begin Task: virtualconcat ##### |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:47 INFO virtualconcat::::casa virtualconcat( vis=['/home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0000.ms.contsub', '/home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0001.ms.contsub', '/home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0002.ms.contsub', '/home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0003.ms.contsub', '/home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0004.ms.contsub', '/home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0005.ms.contsub'], concatvis='/home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms.contsub', freqtol='', dirtol='', respectname=True, visweightscale=[], keepcopy=False, copypointing=False ) |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:47 INFO virtualconcat::::casa Checking MS setup consistency ... |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:47 INFO virtualconcat::::casa Checking for unpopulated POINTING table in first MS ... |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:47 SEVERE getcell::TIME Exception Reported: TableProxy::getCell: no such row |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:47 INFO virtualconcat::::casa Checking for unpopulated optional Main Table columns in first MS ... |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:47 SEVERE getcell::WEIGHT_SPECTRUM Exception Reported: Table DataManager error: Invalid operation: TSM: no array in row 0 of column WEIGHT_SPECTRUM in /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0000.ms.contsub/table.f19 |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:47 WARN virtualconcat::::casa Column WEIGHT_SPECTRUM in table /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0000.ms.contsub has no data. Accessing it will cause errors. |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:47 INFO virtualconcat::::casa Checking for unpopulated POINTING table ... |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:47 SEVERE getcell::TIME Exception Reported: TableProxy::getCell: no such row |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 INFO virtualconcat::::casa Checking for unpopulated optional Main Table columns ... |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 SEVERE getcell::WEIGHT_SPECTRUM Exception Reported: Table DataManager error: Invalid operation: TSM: no array in row 0 of column WEIGHT_SPECTRUM in /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0001.ms.contsub/table.f19 |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 WARN virtualconcat::::casa Column WEIGHT_SPECTRUM in table /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0001.ms.contsub has no data. Accessing it will cause errors. |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 INFO virtualconcat::::casa Checking for unpopulated POINTING table ... |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 SEVERE getcell::TIME Exception Reported: TableProxy::getCell: no such row |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 INFO virtualconcat::::casa Checking for unpopulated optional Main Table columns ... |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 SEVERE getcell::WEIGHT_SPECTRUM Exception Reported: Table DataManager error: Invalid operation: TSM: no array in row 0 of column WEIGHT_SPECTRUM in /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0002.ms.contsub/table.f19 |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 WARN virtualconcat::::casa Column WEIGHT_SPECTRUM in table /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0002.ms.contsub has no data. Accessing it will cause errors. |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 INFO virtualconcat::::casa Checking for unpopulated POINTING table ... |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 SEVERE getcell::TIME Exception Reported: TableProxy::getCell: no such row |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 INFO virtualconcat::::casa Checking for unpopulated optional Main Table columns ... |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 SEVERE getcell::WEIGHT_SPECTRUM Exception Reported: Table DataManager error: Invalid operation: TSM: no array in row 0 of column WEIGHT_SPECTRUM in /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0003.ms.contsub/table.f19 |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 WARN virtualconcat::::casa Column WEIGHT_SPECTRUM in table /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0003.ms.contsub has no data. Accessing it will cause errors. |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 INFO virtualconcat::::casa Checking for unpopulated POINTING table ... |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 SEVERE getcell::TIME Exception Reported: TableProxy::getCell: no such row |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 INFO virtualconcat::::casa Checking for unpopulated optional Main Table columns ... |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 SEVERE getcell::WEIGHT_SPECTRUM Exception Reported: Table DataManager error: Invalid operation: TSM: no array in row 0 of column WEIGHT_SPECTRUM in /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0004.ms.contsub/table.f19 |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 WARN virtualconcat::::casa Column WEIGHT_SPECTRUM in table /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0004.ms.contsub has no data. Accessing it will cause errors. |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 INFO virtualconcat::::casa Checking for unpopulated POINTING table ... |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 SEVERE getcell::TIME Exception Reported: TableProxy::getCell: no such row |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 INFO virtualconcat::::casa Checking for unpopulated optional Main Table columns ... |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 SEVERE getcell::WEIGHT_SPECTRUM Exception Reported: Table DataManager error: Invalid operation: TSM: no array in row 0 of column WEIGHT_SPECTRUM in /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0005.ms.contsub/table.f19 |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 WARN virtualconcat::::casa Column WEIGHT_SPECTRUM in table /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0005.ms.contsub has no data. Accessing it will cause errors. |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 INFO virtualconcat::::casa Checking order of MS list ... |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 INFO virtualconcat::::casa The list of input MSs is not in chronological order and needed to be sorted. |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 INFO virtualconcat::::casa The chronological order in which the concatenation will take place is: |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 INFO virtualconcat::::casa MJD 55814.770121666654: /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0002.ms.contsub |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 INFO virtualconcat::::casa MJD 55814.78225: /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0000.ms.contsub |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 INFO virtualconcat::::casa MJD 55814.79798499999: /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0001.ms.contsub |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 INFO virtualconcat::::casa MJD 55814.835257222236: /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0005.ms.contsub |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 INFO virtualconcat::::casa MJD 55814.847396111116: /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0003.ms.contsub |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 INFO virtualconcat::::casa MJD 55814.86312833334: /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0004.ms.contsub |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 INFO virtualconcat::::casa Concatenating ... |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 INFO virtualconcat::::casa *** copypointing==False: resulting MMS will have empty POINTING table. |
| 13-Nov-2024 17:37:48 | 2024-11-13 22:37:48 INFO virtualconcat::::casa *** Input POINTING table was already empty. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:48 INFO virtualconcat::::casa adding /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0000.ms.contsub to multi-MS /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms.contsub |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:48 INFO MSConcat::virtualconcat Added 4 rows and matched 20 from the state subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:48 INFO MSConcat::virtualconcat Added 1 rows to the source subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:48 INFO MSConcat::virtualconcat Added 0 rows and matched 1 from the data description subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:48 INFO MSConcat::virtualconcat Added 0 rows and matched 1 from the spectral window subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:48 INFO MSConcat::virtualconcat Removed 1 redundant rows from the source subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:48 INFO MSConcat::virtualconcat Added 0 rows and matched 13 from the antenna subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:48 INFO MSConcat::virtualconcat + Added 0 rows to the feed subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:48 INFO MSConcat::virtualconcat + Added 0 rows and matched 48 from the field subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:48 INFO MSConcat::copyObservation Added 0 rows and matched 2 rows in the observation subtable. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:48 INFO MSConcat::copyProcessor Added 0 rows and matched 3 rows in the processor subtable. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:48 INFO MSConcat::copySysCal No valid syscal tables present. Result won't have one either. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::copyGainCurve No valid gain curve tables present. Result won't have one either. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::copyPhaseCal No valid gain curve tables present. Result won't have one either. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::virtualconcat Will create auxiliary file concat_aux_1731537468.0415123 |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::virtualconcat Working on appended Main table ... |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::virtualconcat Writing to concat_aux_1731537468.0415123 |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::virtualconcat Writing the scalar columns ... |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO virtualconcat::::casa adding /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0001.ms.contsub to multi-MS /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms.contsub |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::virtualconcat Added 0 rows and matched 20 from the state subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::virtualconcat Added 1 rows to the source subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::virtualconcat Added 0 rows and matched 1 from the data description subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::virtualconcat Added 0 rows and matched 1 from the spectral window subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::virtualconcat Removed 1 redundant rows from the source subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::virtualconcat Added 0 rows and matched 13 from the antenna subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::virtualconcat + Added 0 rows to the feed subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::virtualconcat + Added 0 rows and matched 48 from the field subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::copyObservation Added 0 rows and matched 2 rows in the observation subtable. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::copyProcessor Added 0 rows and matched 3 rows in the processor subtable. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::copySysCal No valid syscal tables present. Result won't have one either. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::copyGainCurve No valid gain curve tables present. Result won't have one either. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::copyPhaseCal No valid gain curve tables present. Result won't have one either. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::virtualconcat Reading from concat_aux_1731537468.0415123 |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::virtualconcat Working on appended Main table ... |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::virtualconcat Writing to concat_aux_1731537468.0415123 |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::virtualconcat Writing the scalar columns ... |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO virtualconcat::::casa adding /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0005.ms.contsub to multi-MS /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms.contsub |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::virtualconcat Added 0 rows and matched 20 from the state subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::virtualconcat Added 1 rows to the source subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::virtualconcat Added 0 rows and matched 1 from the data description subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::virtualconcat Added 0 rows and matched 1 from the spectral window subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:49 INFO MSConcat::virtualconcat Removed 1 redundant rows from the source subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat Added 0 rows and matched 13 from the antenna subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat + Added 0 rows to the feed subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat + Added 0 rows and matched 48 from the field subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::copyObservation Added 0 rows and matched 2 rows in the observation subtable. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::copyProcessor Added 0 rows and matched 3 rows in the processor subtable. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::copySysCal No valid syscal tables present. Result won't have one either. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::copyGainCurve No valid gain curve tables present. Result won't have one either. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::copyPhaseCal No valid gain curve tables present. Result won't have one either. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat Reading from concat_aux_1731537468.0415123 |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat Working on appended Main table ... |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat Writing to concat_aux_1731537468.0415123 |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat Writing the scalar columns ... |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO virtualconcat::::casa adding /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0003.ms.contsub to multi-MS /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms.contsub |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat Added 0 rows and matched 24 from the state subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat Added 1 rows to the source subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat Added 0 rows and matched 1 from the data description subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat Added 0 rows and matched 1 from the spectral window subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat Removed 1 redundant rows from the source subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat Added 0 rows and matched 13 from the antenna subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat + Added 0 rows to the feed subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat + Added 0 rows and matched 48 from the field subtable |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::copyObservation Added 0 rows and matched 2 rows in the observation subtable. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::copyProcessor Added 0 rows and matched 3 rows in the processor subtable. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::copySysCal No valid syscal tables present. Result won't have one either. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::copyGainCurve No valid gain curve tables present. Result won't have one either. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::copyPhaseCal No valid gain curve tables present. Result won't have one either. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat Reading from concat_aux_1731537468.0415123 |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 WARN MSConcat::virtualconcat (file /source/casa6/casatools/casacore/ms/MSOper/MSConcat.cc, line 149) Zero or negative scan numbers in MS. May lead to duplicate scan numbers in concatenated MS. |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat Working on appended Main table ... |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat Writing to concat_aux_1731537468.0415123 |
| 13-Nov-2024 17:37:50 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat Writing the scalar columns ... |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:50 INFO virtualconcat::::casa adding /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0004.ms.contsub to multi-MS /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms.contsub |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat Added 0 rows and matched 20 from the state subtable |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat Added 1 rows to the source subtable |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat Added 0 rows and matched 1 from the data description subtable |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat Added 0 rows and matched 1 from the spectral window subtable |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:50 INFO MSConcat::virtualconcat Removed 1 redundant rows from the source subtable |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:51 INFO MSConcat::virtualconcat Added 0 rows and matched 13 from the antenna subtable |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:51 INFO MSConcat::virtualconcat + Added 0 rows to the feed subtable |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:51 INFO MSConcat::virtualconcat + Added 0 rows and matched 48 from the field subtable |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:51 INFO MSConcat::copyObservation Added 0 rows and matched 2 rows in the observation subtable. |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:51 INFO MSConcat::copyProcessor Added 0 rows and matched 3 rows in the processor subtable. |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:51 INFO MSConcat::copySysCal No valid syscal tables present. Result won't have one either. |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:51 INFO MSConcat::copyGainCurve No valid gain curve tables present. Result won't have one either. |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:51 INFO MSConcat::copyPhaseCal No valid gain curve tables present. Result won't have one either. |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:51 INFO MSConcat::virtualconcat Reading from concat_aux_1731537468.0415123 |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:51 WARN MSConcat::virtualconcat (file /source/casa6/casatools/casacore/ms/MSOper/MSConcat.cc, line 149) Zero or negative scan numbers in MS. May lead to duplicate scan numbers in concatenated MS. |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:51 INFO MSConcat::virtualconcat Working on appended Main table ... |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:51 INFO MSConcat::virtualconcat Writing to concat_aux_1731537468.0415123 |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:51 INFO MSConcat::virtualconcat Writing the scalar columns ... |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:51 INFO ms::createmultims Copying subtables from /home/casatest/work/test_regression_alma_M100_if_mpi/M100all_lores.ms/SUBMSS/M100all_lores.ms.0002.ms.contsub to the other MMS members. |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 INFO virtualconcat::::casa Task virtualconcat complete. Start time: 2024-11-13 22:37:47.399064 End time: 2024-11-13 22:37:51.740433 |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 INFO virtualconcat::::casa ##### End Task: virtualconcat ##### |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 INFO virtualconcat::::casa ########################################## |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 INFO uvcontsub_old::::casa Task uvcontsub_old complete. Start time: 2024-11-13 22:37:35.695668 End time: 2024-11-13 22:37:51.783854 |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 INFO uvcontsub_old::::casa ##### End Task: uvcontsub_old ##### |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 INFO uvcontsub_old::::casa ########################################## |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa Step 26: Determine and subtract continuum |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa Time now: 1731537471.784323 |
| 13-Nov-2024 17:37:51 | |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa Time used this step: 16.109220504760742 |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa Total time used so far: 1307.4838871955872 |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa Step Time used (s) Fraction of total time (percent) [description] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 0 137.75823426246643 10.536132461100005 [Data import] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 1 0.18251419067382812 0.013959192343494306 [Generate antenna position cal tables] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 2 20.73629069328308 1.5859691194940997 [Generate tsys cal tables] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 3 13.971266984939575 1.0685613124385378 [Correct the Titan position] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 4 19.33445382118225 1.4787527410875083 [Apriori flagging] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 5 48.85220289230347 3.7363521929961374 [Generate WVR cal tables] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 6 51.44748520851135 3.9348465944663147 [Generate delay calibration tables] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 7 225.6134648323059 17.255544564776443 [Apply antpos, wvr, tsys, and delay cal tables] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 8 37.99801731109619 2.9061939258462193 [Split off non-wvr spws and save flags] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 9 14.350266933441162 1.0975482813957231 [Flagging] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 10 65.62566232681274 5.019232968719237 [Rebin to a reduced resolution of approx. 10 km/s] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 11 15.56342625617981 1.1903340766639725 [Fast phase-only gaincal for bandpass] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 12 43.588441610336304 3.3337651069512484 [Bandpass] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 13 21.51599144935608 1.64560279939706 [Setjy] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 14 24.474223375320435 1.871856595327918 [Fast phase-only gaincal] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 15 19.779827117919922 1.5128161281088925 [Slow phase-only gaincal] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 16 18.84950876235962 1.4416627957679689 [Slow amp and phase gaincal] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 17 2.2262027263641357 0.17026616910278736 [Fluxscale] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 18 34.86222863197327 2.6663600961652394 [Applycal] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 19 104.92482042312622 8.02494175650445 [Test image of the secondary phase cal] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 20 163.60211181640625 12.51274401303065 [Test image of the primary phase cal] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 21 109.22903299331665 8.354139891360438 [Test image of Titan] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 22 9.224095344543457 0.7054844373132699 [Split off calibrated M100 data] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 23 3.3148910999298096 0.2535320803868486 [Concatenate M100 data] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 24 9.948060035705566 0.7608552681320677 [Average concatenated M100 data in time] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 25 74.4019455909729 5.690467494062745 [Continuum image of M100] |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 WARN TIMING::::casa 26 16.109220504760742 1.232077937060723 [Determine and subtract continuum] |
| 13-Nov-2024 17:37:51 | Step 27: Test image of central field |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 INFO tclean::::casa ########################################## |
| 13-Nov-2024 17:37:51 | 2024-11-13 22:37:52 INFO tclean::::casa ##### Begin Task: tclean ##### |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:37:52 INFO tclean::::casa tclean( vis='M100all_lores.ms.contsub', selectdata=True, field='26', spw='0:231~248', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='test-M100line', imsize=200, cell='0.5arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='', 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='clark', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=False, outlierfile='', weighting='briggs', robust=0.5, noise='1.0Jy', npixels=0, uvtaper=[''], niter=500, gain=0.1, threshold='0.0mJy', nsigma=0.0, cycleniter=100, cyclefactor=1.5, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='test-M100line-orig.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 ) |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:37:52 INFO tclean::::casa Verifying Input Parameters |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:37:55 INFO tclean::::casa setupCluster, Setting up 3 engines. |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:37:55 INFO SynthesisUtilMethods::continuumDataPartition |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:37:55 INFO SynthesisUtilMethods::continuumDataPartition + Rows = 179 264 [P][M]: 0:2 ROWNUMBER() >= 179 && ROWNUMBER() <= 264 |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:37:55 INFO tclean::::casa Partitioned Selection : {'0': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '26', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'M100all_lores.ms.contsub', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:231~248', 'state': '', 'taql': 'ROWNUMBER() >= 1 && ROWNUMBER() <= 89', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '1': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '26', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'M100all_lores.ms.contsub', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:231~248', 'state': '', 'taql': 'ROWNUMBER() >= 90 && ROWNUMBER() <= 178', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '2': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '26', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'M100all_lores.ms.contsub', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0:231~248', 'state': '', 'taql': 'ROWNUMBER() >= 179 && ROWNUMBER() <= 264', 'timestr': '', 'usescratch': False, 'uvdist': ''}}} |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:37:55 INFO SynthesisImagerVi2::selectData MS : M100all_lores.ms.contsub | Selecting on fields : 26 | Selecting on spw :0:231~248 | [Opened in readonly mode] |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:37:55 INFO SynthesisImagerVi2::selectData NRows selected : 264 |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:37:55 INFO SynthesisImagerVi2::defineImage Define image coordinates for [test-M100line] : |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:37:55 INFO SynthesisImagerVi2::defineImage Define image coordinates for [test-M100line] : |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:37:55 INFO SynthesisImagerVi2::defineImage Impars: start |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:37:55 INFO SynthesisImagerVi2::defineImage Shape: [200, 200, 1, 1] Spectral: [1.14664e+11] at [0] with increment [7.03712e+07] |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:37:55 INFO SynthesisImagerVi2::defineImage Set Gridding options for [test-M100line] with ftmachine: gridft |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:37:55 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.007725 GB. Available mem.: 191 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4. |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:37:55 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:37:56 INFO tclean::::casa ...done |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:37:56 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:37:57 INFO tclean::::casa ...done |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:37:59 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:00 INFO tclean::::casa ...done |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:03 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:04 INFO tclean::::casa ...done |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:04 INFO tclean::::casa Gathering/Merging/Scattering Weight Density for PSF generation |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:04 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:05 INFO tclean::::casa ...done |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:05 INFO tclean::::casa ****************************************************** |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:05 INFO tclean::::casa gather and scatter now |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:05 INFO tclean::::casa ****************************************************** |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:05 INFO SynthesisNormalizer::gatherImages Gather images : [/home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n3] onto :test-M100line |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:05 INFO SynthesisNormalizer::scatterWeightDensity Send the gridded weight from : test-M100line to all nodes :[/home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n3] |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:05 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:06 INFO tclean::::casa ...done |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:06 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [test-M100line] : clark |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:06 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:07 INFO tclean::::casa ...done |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:07 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:08 INFO tclean::::casa ...done |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:08 INFO SynthesisNormalizer::gatherImages Gather psf,weight images : [/home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n3] onto :test-M100line |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:08 INFO SIImageStore::calcSensitivity [test-M100line] Theoretical sensitivity (Jy/bm):0.000152061 |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:08 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.023071 |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:08 INFO SIImageStore::printBeamSet Beam : 4.15597 arcsec, 2.37523 arcsec, -67.8129 deg |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:08 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:09 WARN MPICommandServer::command_request_handler_service::SynthesisImagerVi2::makePB::MPIServer-1 (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SynthesisImagerVi2.cc, line 3447) The MS has multiple antenna diameters ..PB could be wrong |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:09 INFO tclean::::casa ...done |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:10 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : test-M100line to all nodes :[/home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n3] |
| 13-Nov-2024 17:38:09 | 2024-11-13 22:38:10 INFO task_tclean::SIImageStore::setModelImageOne Starting model image test-M100line.model does not exist. No initial prediction will be done |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:10 INFO task_tclean::SIImageStore::setModelImageOne Starting model image test-M100line.model does not exist. No initial prediction will be done |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:10 INFO task_tclean::SIImageStore::setModelImageOne Starting model image test-M100line.model does not exist. No initial prediction will be done |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:10 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:10 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO tclean::::casa ...done |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n3] onto :test-M100line |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.17435, over full image : 0.17435 |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO SynthesisDeconvolver::setupMask [test-M100line] Setting up a mask from [test-M100line-orig.mask] |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane. |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO CasacRegionManager::fromBCS Using all spectral channels. |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO CasacRegionManager::fromBCS Using polarizations ALL |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO You've specified explicitly that the spectral axis should be regridded. However, the input image has a degenerate spectral axis and so it cannot be regridded. Instead, the resulting single output channel will be replicated 1 times in the output image. |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO ImageMaskAttacher::makeMask Created and initialized mask `mask0' |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO SDMaskHandler::fillMask Copying mask image: test-M100line-orig.mask |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO CasacRegionManager::fromBCS No directional region specified. Using full positional plane. |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO CasacRegionManager::fromBCS Using all spectral channels. |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO CasacRegionManager::fromBCS Using polarizations ALL |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO You've specified explicitly that the spectral axis should be regridded. However, the input image has a degenerate spectral axis and so it cannot be regridded. Instead, the resulting single output channel will be replicated 1 times in the output image. |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO ImageMaskAttacher::makeMask Created and initialized mask `mask0' |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO SynthesisDeconvolver::setupMask ---------------------------------------------------------------------------------------------------------------------------------------- |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO SynthesisDeconvolver::setupMask [test-M100line] Number of pixels in the clean mask : 3977 out of a total of 40000 pixels. [ 9.9425 % ] |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.17435, over full image : 0.17435 |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 100, 'cyclethreshold': 0.06333525478839874, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO SDAlgorithmBase::deconvolve [test-M100line] Run clark minor-cycle | CycleThreshold=0.0633353, CycleNiter=100, Gain=0.1 |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO SDAlgorithmClarkClean2::initializeDeconvolver Choosing a PSF patch size of 28 pixels. |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO ClarkCleanLatModel::solve Iteration: 1, Maximum residual=0.156915 Flux limit=0.0633353, 217 Active pixels |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO ClarkCleanLatModel::solve Iteration: 3, Maximum residual=0.127101 Flux limit=0.0633353, 208 Active pixels |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO ClarkCleanLatModel::solve Iteration: 7, Maximum residual=0.0919475 Flux limit=0.0633353, 197 Active pixels |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO ClarkCleanLatModel::solve Iteration: 17, Maximum residual=0.0723614 Flux limit=0.0633353, 183 Active pixels |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO ClarkCleanLatModel::solve Iteration: 30, Maximum residual=0.0608416 Flux limit=0.0633353, 106 Active pixels |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO SDAlgorithmBase::deconvolve [test-M100line] iters=0->30 [30], model=0->0.261364, peakres=0.17435->0.0608416, Reached cyclethreshold. |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 30 iterations. |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : test-M100line to all nodes :[/home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n3] |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-M100line.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n1.model |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:11 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-M100line.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n2.model |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:12 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-M100line.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n3.model |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:12 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:12 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:13 INFO tclean::::casa ...done |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:13 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n3] onto :test-M100line |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:13 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.0619061, over full image : 0.0619061 |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:13 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 100, 'cyclethreshold': 0.02248828485608101, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:13 INFO SDAlgorithmBase::deconvolve [test-M100line] Run clark minor-cycle | CycleThreshold=0.0224883, CycleNiter=100, Gain=0.1 |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:13 INFO SDAlgorithmClarkClean2::initializeDeconvolver Choosing a PSF patch size of 28 pixels. |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:13 INFO ClarkCleanLatModel::solve Iteration: 1, Maximum residual=0.0614522 Flux limit=0.0224883, 1441 Active pixels |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:13 INFO ClarkCleanLatModel::solve Iteration: 4, Maximum residual=0.0608601 Flux limit=0.0224883, 1434 Active pixels |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:13 INFO ClarkCleanLatModel::solve Iteration: 11, Maximum residual=0.0561393 Flux limit=0.0224883, 1421 Active pixels |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:13 INFO ClarkCleanLatModel::solve Iteration: 27, Maximum residual=0.0486052 Flux limit=0.0224883, 1383 Active pixels |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:13 INFO ClarkCleanLatModel::solve Iteration: 61, Maximum residual=0.038754 Flux limit=0.0224883, 1319 Active pixels |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:13 INFO ClarkCleanLatModel::solve Iteration: 100, Maximum residual=0.0324783 Flux limit=0.0224883, 1191 Active pixels |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:13 INFO SDAlgorithmBase::deconvolve [test-M100line] iters=0->100 [100], model=0.261364->0.653171, peakres=0.0619061->0.0324783, Reached cycleniter. |
| 13-Nov-2024 17:38:13 | 2024-11-13 22:38:13 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 130 iterations. |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:13 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : test-M100line to all nodes :[/home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n3] |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:13 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-M100line.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n1.model |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:13 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-M100line.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n2.model |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:13 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-M100line.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n3.model |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:13 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:13 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:14 INFO tclean::::casa ...done |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:14 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n3] onto :test-M100line |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:14 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.0344598, over full image : 0.0423191 |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:14 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 100, 'cyclethreshold': 0.012518009170889854, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:14 INFO SDAlgorithmBase::deconvolve [test-M100line] Run clark minor-cycle | CycleThreshold=0.012518, CycleNiter=100, Gain=0.1 |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:14 INFO SDAlgorithmClarkClean2::initializeDeconvolver Choosing a PSF patch size of 28 pixels. |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:15 INFO ClarkCleanLatModel::solve Iteration: 1, Maximum residual=0.0332757 Flux limit=0.012518, 2015 Active pixels |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:15 INFO ClarkCleanLatModel::solve Iteration: 4, Maximum residual=0.0324047 Flux limit=0.012518, 2013 Active pixels |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:15 INFO ClarkCleanLatModel::solve Iteration: 12, Maximum residual=0.031068 Flux limit=0.012518, 2008 Active pixels |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:15 INFO ClarkCleanLatModel::solve Iteration: 31, Maximum residual=0.0289234 Flux limit=0.012518, 1988 Active pixels |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:15 INFO ClarkCleanLatModel::solve Iteration: 72, Maximum residual=0.02501 Flux limit=0.012518, 1899 Active pixels |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:15 INFO ClarkCleanLatModel::solve Iteration: 100, Maximum residual=0.0229023 Flux limit=0.012518, 1806 Active pixels |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:15 INFO SDAlgorithmBase::deconvolve [test-M100line] iters=0->100 [100], model=0.653171->0.858008, peakres=0.0344598->0.0229023, Reached cycleniter. |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:15 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 230 iterations. |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:15 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : test-M100line to all nodes :[/home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n3] |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:15 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-M100line.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n1.model |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:15 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-M100line.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n2.model |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:15 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-M100line.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n3.model |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:15 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:15 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:16 INFO tclean::::casa ...done |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:16 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n3] onto :test-M100line |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:16 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.0231555, over full image : 0.0349685 |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:16 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 100, 'cyclethreshold': 0.00841156393289566, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:16 INFO SDAlgorithmBase::deconvolve [test-M100line] Run clark minor-cycle | CycleThreshold=0.00841156, CycleNiter=100, Gain=0.1 |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:16 INFO SDAlgorithmClarkClean2::initializeDeconvolver Choosing a PSF patch size of 28 pixels. |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:16 INFO ClarkCleanLatModel::solve Iteration: 1, Maximum residual=0.0231291 Flux limit=0.00841156, 2373 Active pixels |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:16 INFO ClarkCleanLatModel::solve Iteration: 4, Maximum residual=0.0231253 Flux limit=0.00841156, 2375 Active pixels |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:16 INFO ClarkCleanLatModel::solve Iteration: 12, Maximum residual=0.0221917 Flux limit=0.00841156, 2366 Active pixels |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:16 INFO ClarkCleanLatModel::solve Iteration: 32, Maximum residual=0.0211998 Flux limit=0.00841156, 2353 Active pixels |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:16 INFO ClarkCleanLatModel::solve Iteration: 76, Maximum residual=0.0187746 Flux limit=0.00841156, 2289 Active pixels |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:16 INFO ClarkCleanLatModel::solve Iteration: 100, Maximum residual=0.017858 Flux limit=0.00841156, 2168 Active pixels |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:16 INFO SDAlgorithmBase::deconvolve [test-M100line] iters=0->100 [100], model=0.858008->1.00189, peakres=0.0231555->0.017858, Reached cycleniter. |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:16 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 330 iterations. |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:16 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : test-M100line to all nodes :[/home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n3] |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:16 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-M100line.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n1.model |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:16 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-M100line.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n2.model |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:17 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-M100line.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n3.model |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:17 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:17 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:38:17 | 2024-11-13 22:38:18 INFO tclean::::casa ...done |
| 13-Nov-2024 17:38:33 | 2024-11-13 22:38:18 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n3] onto :test-M100line |
| 13-Nov-2024 17:38:33 | 2024-11-13 22:38:18 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.0183927, over full image : 0.0297444 |
| 13-Nov-2024 17:38:33 | 2024-11-13 22:38:18 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 100, 'cyclethreshold': 0.006681409198790789, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False} |
| 13-Nov-2024 17:38:33 | 2024-11-13 22:38:18 INFO SDAlgorithmBase::deconvolve [test-M100line] Run clark minor-cycle | CycleThreshold=0.00668141, CycleNiter=100, Gain=0.1 |
| 13-Nov-2024 17:38:33 | 2024-11-13 22:38:18 INFO SDAlgorithmClarkClean2::initializeDeconvolver Choosing a PSF patch size of 28 pixels. |
| 13-Nov-2024 17:38:33 | 2024-11-13 22:38:18 INFO ClarkCleanLatModel::solve Iteration: 1, Maximum residual=0.0183544 Flux limit=0.00668141, 2487 Active pixels |
| 13-Nov-2024 17:38:33 | 2024-11-13 22:38:18 INFO ClarkCleanLatModel::solve Iteration: 4, Maximum residual=0.0180976 Flux limit=0.00668141, 2481 Active pixels |
| 13-Nov-2024 17:38:33 | 2024-11-13 22:38:18 INFO ClarkCleanLatModel::solve Iteration: 12, Maximum residual=0.0172782 Flux limit=0.00668141, 2474 Active pixels |
| 13-Nov-2024 17:38:33 | 2024-11-13 22:38:18 INFO ClarkCleanLatModel::solve Iteration: 32, Maximum residual=0.0165748 Flux limit=0.00668141, 2458 Active pixels |
| 13-Nov-2024 17:38:33 | 2024-11-13 22:38:18 INFO ClarkCleanLatModel::solve Iteration: 79, Maximum residual=0.0147744 Flux limit=0.00668141, 2425 Active pixels |
| 13-Nov-2024 17:38:33 | 2024-11-13 22:38:18 INFO ClarkCleanLatModel::solve Iteration: 100, Maximum residual=0.0143979 Flux limit=0.00668141, 2339 Active pixels |
| 13-Nov-2024 17:38:33 | 2024-11-13 22:38:18 INFO SDAlgorithmBase::deconvolve [test-M100line] iters=0->100 [100], model=1.00189->1.10516, peakres=0.0183927->0.0143979, Reached cycleniter. |
| 13-Nov-2024 17:38:33 | 2024-11-13 22:38:18 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 430 iterations. |
| 13-Nov-2024 17:38:33 | 2024-11-13 22:38:18 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : test-M100line to all nodes :[/home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n1, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n2, /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n3] |
| 13-Nov-2024 17:38:33 | 2024-11-13 22:38:18 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-M100line.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n1.model |
| 13-Nov-2024 17:38:33 | 2024-11-13 22:38:18 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-M100line.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n2.model |
| 13-Nov-2024 17:38:33 | 2024-11-13 22:38:18 INFO task_tclean::SIImageStore::setModelImageOne Copying input model test-M100line.model to /home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n3.model |
| 13-Nov-2024 17:38:33 | 2024-11-13 22:38:18 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ---------------------------- |
| 13-Nov-2024 17:38:33 | 2024-11-13 22:38:18 INFO tclean::::casa checkJobs. Blocking for nodes to finish |
| 13-Nov-2024 17:38:33 | 2024-11-13 22:38:19 INFO tclean::::casa ...done |
| 13-Nov-2024 17:38:33 | 2024-11-13 22:38:19 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_regression_alma_M100_if_mpi/test-M100line.workdirectory/test-M100line.n1, /home/casatest/work/test_regression_alma_M100_ifsimple 14-Nov-2024 14:27:56 Running on server: post build plugin 'Build Hanging Detection Configuration' |
| 14-Nov-2024 14:27:56 | Running on server: post build plugin 'NCover Results Collector' |
| 14-Nov-2024 14:27:56 | Running on server: post build plugin 'Build Labeller' |
| 14-Nov-2024 14:27:56 | Running on server: post build plugin 'Clover Delta Calculator' |
| 14-Nov-2024 14:27:56 | Running on server: post build plugin 'Maven Dependencies Postprocessor' |
| 14-Nov-2024 14:27:56 | All post build plugins have finished |
| 14-Nov-2024 14:27:56 | Generating build results summary... |
| 14-Nov-2024 14:27:56 | Saving build results to disk... |
| 14-Nov-2024 14:27:56 | Store variable context... |
| 14-Nov-2024 14:27:56 | Finished building CASASPECS-MASTERTESTCASALITHPY312-CRR93D-62. |