Build: #4 failed

Job: Test Casalith Cvpost Many Linux 2.28 failed

Stages & jobs

  1. Default Stage

Build log

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

08-Apr-2026 04:21:18 2026-04-08 04:21:05        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:18 2026-04-08 04:21:06        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:18 2026-04-08 04:21:06        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:18 2026-04-08 04:21:07        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:18 2026-04-08 04:21:08        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:18 2026-04-08 04:21:09        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:18 2026-04-08 04:21:11        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:18 2026-04-08 04:21:12        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:18 2026-04-08 04:21:12        INFO        task_tclean::SynthesisDeconvolver::setupDeconvolution         Set Deconvolution Options for [test-X54-Titan] : clark
08-Apr-2026 04:21:18 2026-04-08 04:21:12        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:18 2026-04-08 04:21:13        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:18 2026-04-08 04:21:13        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:18 2026-04-08 04:21:15        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:18 2026-04-08 04:21:15        INFO        SynthesisNormalizer::gatherImages         Gather psf,weight images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3] onto :test-X54-Titan
08-Apr-2026 04:21:18 2026-04-08 04:21:15        INFO        SIImageStore::calcSensitivity         [test-X54-Titan] Theoretical sensitivity (Jy/bm):3.49086e-06
08-Apr-2026 04:21:18 2026-04-08 04:21:15        INFO        SIImageStore::getPSFGaussian         Time to fit Gaussian to PSF 0.002278
08-Apr-2026 04:21:18 2026-04-08 04:21:15        INFO        SIImageStore::printBeamSet         Beam : 3.45213 arcsec, 2.19752 arcsec, 81.2017 deg
08-Apr-2026 04:21:18 2026-04-08 04:21:15        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:18 2026-04-08 04:21:16        WARN        MPICommandServer::command_request_handler_service::SynthesisImagerVi2::makePB::MPIServer-1 (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SynthesisImagerVi2.cc, line 3558)        The MS has multiple antenna diameters ..PB could be wrong
08-Apr-2026 04:21:18 2026-04-08 04:21:16        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:18 2026-04-08 04:21:17        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : test-X54-Titan to all nodes :[/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3]
08-Apr-2026 04:21:18 2026-04-08 04:21:17        INFO        task_tclean::SIImageStore::setModelImageOne         Starting model image test-X54-Titan.model does not exist. No initial prediction will be done
08-Apr-2026 04:21:18 2026-04-08 04:21:17        INFO        task_tclean::SIImageStore::setModelImageOne         Starting model image test-X54-Titan.model does not exist. No initial prediction will be done
08-Apr-2026 04:21:18 2026-04-08 04:21:17        INFO        task_tclean::SIImageStore::setModelImageOne         Starting model image test-X54-Titan.model does not exist. No initial prediction will be done
08-Apr-2026 04:21:18 2026-04-08 04:21:17        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
08-Apr-2026 04:21:18 2026-04-08 04:21:17        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:18 2026-04-08 04:21:18        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:18 2026-04-08 04:21:18        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3] onto :test-X54-Titan
08-Apr-2026 04:21:18 2026-04-08 04:21:18        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0, over full image : 0.21726
08-Apr-2026 04:21:18 2026-04-08 04:21:18        INFO        SynthesisDeconvolver::setupMask         [test-X54-Titan] Setting up a mask from [box [ [ 96pix , 96pix] , [104pix, 104pix ] ]]
08-Apr-2026 04:21:18 2026-04-08 04:21:18        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
08-Apr-2026 04:21:18 2026-04-08 04:21:18        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
08-Apr-2026 04:21:18 2026-04-08 04:21:18        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
08-Apr-2026 04:21:18 2026-04-08 04:21:18        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.
08-Apr-2026 04:21:18 2026-04-08 04:21:18        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
08-Apr-2026 04:21:18 2026-04-08 04:21:18        INFO        AsciiRegionFileParser::_parse        Combined 1 image regions (which excludes any annotation regions)
08-Apr-2026 04:21:18 2026-04-08 04:21:18        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).
08-Apr-2026 04:21:18 2026-04-08 04:21:18        INFO        SynthesisDeconvolver::setupMask         ----------------------------------------------------------------------------------------------------------------------------------------
08-Apr-2026 04:21:18 2026-04-08 04:21:18        INFO        SynthesisDeconvolver::setupMask         [test-X54-Titan] Number of pixels in the clean mask : 81 out of a total of 40000 pixels. [ 0.2025 % ]
08-Apr-2026 04:21:18 2026-04-08 04:21:18        INFO        SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.21726, over full image : 0.21726
08-Apr-2026 04:21:18 2026-04-08 04:21:18        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 100, 'cyclethreshold': 0.08026009052991867, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
08-Apr-2026 04:21:18 2026-04-08 04:21:18        INFO        SDAlgorithmBase::deconvolve         [test-X54-Titan] Run clark minor-cycle | CycleThreshold=0.0802601, CycleNiter=100, Gain=0.1
08-Apr-2026 04:21:18 2026-04-08 04:21:18        INFO        SDAlgorithmClarkClean2::initializeDeconvolver         Choosing a PSF patch size of 22 pixels.
08-Apr-2026 04:21:18 2026-04-08 04:21:18        INFO        ClarkCleanLatModel::solve        Iteration: 1, Maximum residual=0.195534 Flux limit=0.0802601, 34 Active pixels
08-Apr-2026 04:21:18 2026-04-08 04:21:18        INFO        ClarkCleanLatModel::solve        Iteration: 3, Maximum residual=0.158383 Flux limit=0.0802601, 29 Active pixels
08-Apr-2026 04:21:18 2026-04-08 04:21:18        INFO        ClarkCleanLatModel::solve        Iteration: 7, Maximum residual=0.103915 Flux limit=0.0802601, 25 Active pixels
08-Apr-2026 04:21:18 2026-04-08 04:21:18        INFO        ClarkCleanLatModel::solve        Iteration: 10, Maximum residual=0.0757539 Flux limit=0.0802601, 11 Active pixels
08-Apr-2026 04:21:22 2026-04-08 04:21:18        INFO        SDAlgorithmBase::deconvolve         [test-X54-Titan] iters=0->10 [10], model=0->0.141506, peakres=0.21726->0.0757539, Reached cyclethreshold.
08-Apr-2026 04:21:22 2026-04-08 04:21:18        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 10 iterations.
08-Apr-2026 04:21:22 2026-04-08 04:21:18        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : test-X54-Titan to all nodes :[/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3]
08-Apr-2026 04:21:22 2026-04-08 04:21:18        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X54-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1.model
08-Apr-2026 04:21:22 2026-04-08 04:21:18        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X54-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2.model
08-Apr-2026 04:21:22 2026-04-08 04:21:18        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X54-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3.model
08-Apr-2026 04:21:22 2026-04-08 04:21:18        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
08-Apr-2026 04:21:22 2026-04-08 04:21:18        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:22 2026-04-08 04:21:20        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:22 2026-04-08 04:21:20        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3] onto :test-X54-Titan
08-Apr-2026 04:21:22 2026-04-08 04:21:20        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.0757537, over full image : 0.0757537
08-Apr-2026 04:21:22 2026-04-08 04:21:20        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 90, 'cyclethreshold': 0.027984892949461937, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
08-Apr-2026 04:21:22 2026-04-08 04:21:20        INFO        SDAlgorithmBase::deconvolve         [test-X54-Titan] Run clark minor-cycle | CycleThreshold=0.0279849, CycleNiter=90, Gain=0.1
08-Apr-2026 04:21:22 2026-04-08 04:21:20        INFO        SDAlgorithmClarkClean2::initializeDeconvolver         Choosing a PSF patch size of 22 pixels.
08-Apr-2026 04:21:22 2026-04-08 04:21:20        INFO        ClarkCleanLatModel::solve        Iteration: 1, Maximum residual=0.0681783 Flux limit=0.0279849, 35 Active pixels
08-Apr-2026 04:21:22 2026-04-08 04:21:20        INFO        ClarkCleanLatModel::solve        Iteration: 3, Maximum residual=0.0552245 Flux limit=0.0279849, 29 Active pixels
08-Apr-2026 04:21:22 2026-04-08 04:21:20        INFO        ClarkCleanLatModel::solve        Iteration: 7, Maximum residual=0.0362328 Flux limit=0.0279849, 25 Active pixels
08-Apr-2026 04:21:22 2026-04-08 04:21:21        INFO        ClarkCleanLatModel::solve        Iteration: 10, Maximum residual=0.0264137 Flux limit=0.0279849, 11 Active pixels
08-Apr-2026 04:21:22 2026-04-08 04:21:21        INFO        SDAlgorithmBase::deconvolve         [test-X54-Titan] iters=0->10 [10], model=0.141506->0.190846, peakres=0.0757537->0.0264137, Reached cyclethreshold.
08-Apr-2026 04:21:22 2026-04-08 04:21:21        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 20 iterations.
08-Apr-2026 04:21:22 2026-04-08 04:21:21        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : test-X54-Titan to all nodes :[/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3]
08-Apr-2026 04:21:22 2026-04-08 04:21:21        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X54-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1.model
08-Apr-2026 04:21:22 2026-04-08 04:21:21        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X54-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2.model
08-Apr-2026 04:21:22 2026-04-08 04:21:21        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X54-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3.model
08-Apr-2026 04:21:22 2026-04-08 04:21:21        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
08-Apr-2026 04:21:22 2026-04-08 04:21:21        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:22 2026-04-08 04:21:23        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:22 2026-04-08 04:21:23        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3] onto :test-X54-Titan
08-Apr-2026 04:21:22 2026-04-08 04:21:23        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.0264136, over full image : 0.0264136
08-Apr-2026 04:21:22 2026-04-08 04:21:23        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 80, 'cyclethreshold': 0.009757705964148045, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
08-Apr-2026 04:21:22 2026-04-08 04:21:23        INFO        SDAlgorithmBase::deconvolve         [test-X54-Titan] Run clark minor-cycle | CycleThreshold=0.00975771, CycleNiter=80, Gain=0.1
08-Apr-2026 04:21:22 2026-04-08 04:21:23        INFO        SDAlgorithmClarkClean2::initializeDeconvolver         Choosing a PSF patch size of 22 pixels.
08-Apr-2026 04:21:22 2026-04-08 04:21:23        INFO        ClarkCleanLatModel::solve        Iteration: 1, Maximum residual=0.0237723 Flux limit=0.00975771, 35 Active pixels
08-Apr-2026 04:21:22 2026-04-08 04:21:23        INFO        ClarkCleanLatModel::solve        Iteration: 3, Maximum residual=0.0192555 Flux limit=0.00975771, 29 Active pixels
08-Apr-2026 04:21:22 2026-04-08 04:21:23        INFO        ClarkCleanLatModel::solve        Iteration: 7, Maximum residual=0.0126336 Flux limit=0.00975771, 25 Active pixels
08-Apr-2026 04:21:22 2026-04-08 04:21:23        INFO        ClarkCleanLatModel::solve        Iteration: 10, Maximum residual=0.00920986 Flux limit=0.00975771, 11 Active pixels
08-Apr-2026 04:21:22 2026-04-08 04:21:23        INFO        SDAlgorithmBase::deconvolve         [test-X54-Titan] iters=0->10 [10], model=0.190846->0.20805, peakres=0.0264136->0.00920986, Reached cyclethreshold.
08-Apr-2026 04:21:22 2026-04-08 04:21:23        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 30 iterations.
08-Apr-2026 04:21:27 2026-04-08 04:21:23        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : test-X54-Titan to all nodes :[/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3]
08-Apr-2026 04:21:27 2026-04-08 04:21:23        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X54-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1.model
08-Apr-2026 04:21:27 2026-04-08 04:21:23        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X54-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2.model
08-Apr-2026 04:21:27 2026-04-08 04:21:23        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X54-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3.model
08-Apr-2026 04:21:27 2026-04-08 04:21:23        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
08-Apr-2026 04:21:27 2026-04-08 04:21:23        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:27 2026-04-08 04:21:25        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:27 2026-04-08 04:21:25        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3] onto :test-X54-Titan
08-Apr-2026 04:21:27 2026-04-08 04:21:25        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00920983, over full image : 0.00920983
08-Apr-2026 04:21:27 2026-04-08 04:21:25        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 70, 'cyclethreshold': 0.0034022913314402103, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
08-Apr-2026 04:21:27 2026-04-08 04:21:25        INFO        SDAlgorithmBase::deconvolve         [test-X54-Titan] Run clark minor-cycle | CycleThreshold=0.00340229, CycleNiter=70, Gain=0.1
08-Apr-2026 04:21:27 2026-04-08 04:21:25        INFO        SDAlgorithmClarkClean2::initializeDeconvolver         Choosing a PSF patch size of 22 pixels.
08-Apr-2026 04:21:27 2026-04-08 04:21:25        INFO        ClarkCleanLatModel::solve        Iteration: 1, Maximum residual=0.00828885 Flux limit=0.00340229, 37 Active pixels
08-Apr-2026 04:21:27 2026-04-08 04:21:25        INFO        ClarkCleanLatModel::solve        Iteration: 3, Maximum residual=0.00671397 Flux limit=0.00340229, 31 Active pixels
08-Apr-2026 04:21:27 2026-04-08 04:21:25        INFO        ClarkCleanLatModel::solve        Iteration: 7, Maximum residual=0.00440503 Flux limit=0.00340229, 27 Active pixels
08-Apr-2026 04:21:27 2026-04-08 04:21:25        INFO        ClarkCleanLatModel::solve        Iteration: 10, Maximum residual=0.00321127 Flux limit=0.00340229, 11 Active pixels
08-Apr-2026 04:21:27 2026-04-08 04:21:25        INFO        SDAlgorithmBase::deconvolve         [test-X54-Titan] iters=0->10 [10], model=0.20805->0.214049, peakres=0.00920983->0.00321127, Reached cyclethreshold.
08-Apr-2026 04:21:27 2026-04-08 04:21:25        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 40 iterations.
08-Apr-2026 04:21:27 2026-04-08 04:21:25        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : test-X54-Titan to all nodes :[/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3]
08-Apr-2026 04:21:27 2026-04-08 04:21:25        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X54-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1.model
08-Apr-2026 04:21:27 2026-04-08 04:21:25        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X54-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2.model
08-Apr-2026 04:21:27 2026-04-08 04:21:25        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X54-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3.model
08-Apr-2026 04:21:27 2026-04-08 04:21:25        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
08-Apr-2026 04:21:27 2026-04-08 04:21:25        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:27 2026-04-08 04:21:27        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:27 2026-04-08 04:21:27        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3] onto :test-X54-Titan
08-Apr-2026 04:21:27 2026-04-08 04:21:27        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00321126, over full image : 0.00442777
08-Apr-2026 04:21:27 2026-04-08 04:21:27        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 60, 'cyclethreshold': 0.001186302863061428, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
08-Apr-2026 04:21:27 2026-04-08 04:21:27        INFO        SDAlgorithmBase::deconvolve         [test-X54-Titan] Run clark minor-cycle | CycleThreshold=0.0011863, CycleNiter=60, Gain=0.1
08-Apr-2026 04:21:27 2026-04-08 04:21:27        INFO        SDAlgorithmClarkClean2::initializeDeconvolver         Choosing a PSF patch size of 22 pixels.
08-Apr-2026 04:21:27 2026-04-08 04:21:28        INFO        ClarkCleanLatModel::solve        Iteration: 1, Maximum residual=0.00289014 Flux limit=0.0011863, 44 Active pixels
08-Apr-2026 04:21:27 2026-04-08 04:21:28        INFO        ClarkCleanLatModel::solve        Iteration: 3, Maximum residual=0.00234101 Flux limit=0.0011863, 42 Active pixels
08-Apr-2026 04:21:27 2026-04-08 04:21:28        INFO        ClarkCleanLatModel::solve        Iteration: 7, Maximum residual=0.00153594 Flux limit=0.0011863, 35 Active pixels
08-Apr-2026 04:21:27 2026-04-08 04:21:28        INFO        ClarkCleanLatModel::solve        Iteration: 10, Maximum residual=0.00116934 Flux limit=0.0011863, 21 Active pixels
08-Apr-2026 04:21:27 2026-04-08 04:21:28        INFO        SDAlgorithmBase::deconvolve         [test-X54-Titan] iters=0->10 [10], model=0.214049->0.21614, peakres=0.00321126->0.00116934, Reached cyclethreshold.
08-Apr-2026 04:21:27 2026-04-08 04:21:28        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 50 iterations.
08-Apr-2026 04:21:27 2026-04-08 04:21:28        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : test-X54-Titan to all nodes :[/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3]
08-Apr-2026 04:21:27 2026-04-08 04:21:28        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X54-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1.model
08-Apr-2026 04:21:32 2026-04-08 04:21:28        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X54-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2.model
08-Apr-2026 04:21:32 2026-04-08 04:21:28        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X54-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3.model
08-Apr-2026 04:21:32 2026-04-08 04:21:28        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
08-Apr-2026 04:21:32 2026-04-08 04:21:28        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:32 2026-04-08 04:21:30        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:32 2026-04-08 04:21:30        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3] onto :test-X54-Titan
08-Apr-2026 04:21:32 2026-04-08 04:21:30        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00116934, over full image : 0.00424266
08-Apr-2026 04:21:32 2026-04-08 04:21:30        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 50, 'cyclethreshold': 0.0004319767758715898, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
08-Apr-2026 04:21:32 2026-04-08 04:21:30        INFO        SDAlgorithmBase::deconvolve         [test-X54-Titan] Run clark minor-cycle | CycleThreshold=0.000431977, CycleNiter=50, Gain=0.1
08-Apr-2026 04:21:32 2026-04-08 04:21:30        INFO        SDAlgorithmClarkClean2::initializeDeconvolver         Choosing a PSF patch size of 22 pixels.
08-Apr-2026 04:21:32 2026-04-08 04:21:30        INFO        ClarkCleanLatModel::solve        Iteration: 1, Maximum residual=0.00113503 Flux limit=0.000431977, 66 Active pixels
08-Apr-2026 04:21:32 2026-04-08 04:21:30        INFO        ClarkCleanLatModel::solve        Iteration: 4, Maximum residual=0.000961767 Flux limit=0.000431977, 64 Active pixels
08-Apr-2026 04:21:32 2026-04-08 04:21:30        INFO        ClarkCleanLatModel::solve        Iteration: 10, Maximum residual=0.000733085 Flux limit=0.000431977, 60 Active pixels
08-Apr-2026 04:21:32 2026-04-08 04:21:30        INFO        ClarkCleanLatModel::solve        Iteration: 21, Maximum residual=0.000516065 Flux limit=0.000431977, 50 Active pixels
08-Apr-2026 04:21:32 2026-04-08 04:21:30        INFO        ClarkCleanLatModel::solve        Iteration: 27, Maximum residual=0.00042443 Flux limit=0.000431977, 25 Active pixels
08-Apr-2026 04:21:32 2026-04-08 04:21:30        INFO        SDAlgorithmBase::deconvolve         [test-X54-Titan] iters=0->27 [27], model=0.21614->0.218072, peakres=0.00116934->0.00042443, Reached cyclethreshold.
08-Apr-2026 04:21:32 2026-04-08 04:21:30        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 77 iterations.
08-Apr-2026 04:21:32 2026-04-08 04:21:30        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : test-X54-Titan to all nodes :[/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3]
08-Apr-2026 04:21:32 2026-04-08 04:21:30        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X54-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1.model
08-Apr-2026 04:21:32 2026-04-08 04:21:30        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X54-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2.model
08-Apr-2026 04:21:32 2026-04-08 04:21:30        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X54-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3.model
08-Apr-2026 04:21:32 2026-04-08 04:21:30        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
08-Apr-2026 04:21:32 2026-04-08 04:21:30        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:32 2026-04-08 04:21:32        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:32 2026-04-08 04:21:32        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3] onto :test-X54-Titan
08-Apr-2026 04:21:32 2026-04-08 04:21:32        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.000424429, over full image : 0.00439453
08-Apr-2026 04:21:32 2026-04-08 04:21:32        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 23, 'cyclethreshold': 0.00015679227362852544, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
08-Apr-2026 04:21:32 2026-04-08 04:21:32        INFO        SDAlgorithmBase::deconvolve         [test-X54-Titan] Run clark minor-cycle | CycleThreshold=0.000156792, CycleNiter=23, Gain=0.1
08-Apr-2026 04:21:32 2026-04-08 04:21:32        INFO        SDAlgorithmClarkClean2::initializeDeconvolver         Choosing a PSF patch size of 22 pixels.
08-Apr-2026 04:21:32 2026-04-08 04:21:32        INFO        ClarkCleanLatModel::solve        Iteration: 2, Maximum residual=0.000413462 Flux limit=0.000156792, 65 Active pixels
08-Apr-2026 04:21:32 2026-04-08 04:21:32        INFO        ClarkCleanLatModel::solve        Iteration: 6, Maximum residual=0.000375552 Flux limit=0.000156792, 64 Active pixels
08-Apr-2026 04:21:32 2026-04-08 04:21:32        INFO        ClarkCleanLatModel::solve        Iteration: 15, Maximum residual=0.000303282 Flux limit=0.000156792, 61 Active pixels
08-Apr-2026 04:21:32 2026-04-08 04:21:32        INFO        ClarkCleanLatModel::solve        Iteration: 23, Maximum residual=0.000276393 Flux limit=0.000156792, 51 Active pixels
08-Apr-2026 04:21:32 2026-04-08 04:21:32        INFO        SDAlgorithmBase::deconvolve         [test-X54-Titan] iters=0->23 [23], model=0.218072->0.218795, peakres=0.000424429->0.000276393, Reached cycleniter.
08-Apr-2026 04:21:32 2026-04-08 04:21:32        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 100 iterations.
08-Apr-2026 04:21:32 2026-04-08 04:21:32        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : test-X54-Titan to all nodes :[/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3]
08-Apr-2026 04:21:32 2026-04-08 04:21:32        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X54-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1.model
08-Apr-2026 04:21:32 2026-04-08 04:21:32        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X54-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2.model
08-Apr-2026 04:21:56 2026-04-08 04:21:32        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X54-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3.model
08-Apr-2026 04:21:56 2026-04-08 04:21:32        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
08-Apr-2026 04:21:56 2026-04-08 04:21:32        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:56 2026-04-08 04:21:34        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:56 2026-04-08 04:21:34        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X54-Titan.workdirectory/test-X54-Titan.n3] onto :test-X54-Titan
08-Apr-2026 04:21:56 2026-04-08 04:21:34        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.000276392, over full image : 0.00441808
08-Apr-2026 04:21:56 2026-04-08 04:21:34        INFO        tclean::::casa        Reached global stopping criterion : iteration limit
08-Apr-2026 04:21:56 2026-04-08 04:21:34        INFO        tclean::::casa        getSummary call: fullsummary=False
08-Apr-2026 04:21:56 2026-04-08 04:21:34        INFO        SDAlgorithmBase::restore         [test-X54-Titan] : Restoring model image.
08-Apr-2026 04:21:56 2026-04-08 04:21:35        INFO        SIImageStore::restore         Beam for chan : 0 : 3.45213 arcsec, 2.19752 arcsec, 81.2017 deg
08-Apr-2026 04:21:56 2026-04-08 04:21:43        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:56 2026-04-08 04:21:44        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:56 2026-04-08 04:21:44        INFO        tclean::::casa        Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed.
08-Apr-2026 04:21:56 2026-04-08 04:21:44        INFO        tclean::::casa        Searching for images with prefix 'test-X54-Titan'... Found these, writing history into them: ['test-X54-Titan.psf', 'test-X54-Titan.sumwt', 'test-X54-Titan.pb', 'test-X54-Titan.residual', 'test-X54-Titan.mask', 'test-X54-Titan.model', 'test-X54-Titan.image']
08-Apr-2026 04:21:56 2026-04-08 04:21:44        INFO        tclean::::casa        Task tclean complete. Start time: 2026-04-08 00:21:00.395702 End time: 2026-04-08 00:21:43.736781
08-Apr-2026 04:21:56 2026-04-08 04:21:44        INFO        tclean::::casa        ##### End Task: tclean               #####
08-Apr-2026 04:21:56 2026-04-08 04:21:44        INFO        tclean::::casa        ##########################################
08-Apr-2026 04:21:56 2026-04-08 04:21:44        INFO        tclean::::casa        ##########################################
08-Apr-2026 04:21:56 2026-04-08 04:21:44        INFO        tclean::::casa        ##### Begin Task: tclean             #####
08-Apr-2026 04:21:56 2026-04-08 04:21:44        INFO        tclean::::casa        tclean( vis='X220-line-vs.ms', selectdata=True, field='Titan', spw='0~3', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='test-X220-Titan', imsize=200, cell='0.5arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='standard', facets=1, psfphasecenter='', wprojplanes=1, vptable='', mosweight=True, aterm=True, psterm=False, wbawp=True, conjbeams=False, cfcache='', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=0.2, normtype='flatnoise', deconvolver='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=100, 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='box [ [ 96pix , 96pix] , [104pix, 104pix ] ]', 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 )
08-Apr-2026 04:21:56 2026-04-08 04:21:44        INFO        tclean::::casa        Verifying Input Parameters
08-Apr-2026 04:21:56 2026-04-08 04:21:46        INFO        tclean::::casa        setupCluster, Setting up 3 engines.
08-Apr-2026 04:21:56 2026-04-08 04:21:46        INFO        SynthesisUtilMethods::continuumDataPartition         
08-Apr-2026 04:21:56 2026-04-08 04:21:46        INFO        SynthesisUtilMethods::continuumDataPartition +        Rows = 7283 10920 [P][M]: 0:2 ROWNUMBER() >= 7283 && ROWNUMBER() <= 10920
08-Apr-2026 04:21:56 2026-04-08 04:21:46        INFO        tclean::::casa        Partitioned Selection : {'0': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': 'Titan', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'X220-line-vs.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0~3', 'state': '', 'taql': 'ROWNUMBER() >= 1 && ROWNUMBER() <= 3641', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '1': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': 'Titan', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'X220-line-vs.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0~3', 'state': '', 'taql': 'ROWNUMBER() >= 3642 && ROWNUMBER() <= 7282', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '2': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': 'Titan', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'X220-line-vs.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '0~3', 'state': '', 'taql': 'ROWNUMBER() >= 7283 && ROWNUMBER() <= 10920', 'timestr': '', 'usescratch': False, 'uvdist': ''}}}
08-Apr-2026 04:21:56 2026-04-08 04:21:46        INFO        SynthesisImagerVi2::selectData         MS : X220-line-vs.ms | Selecting on fields : Titan | Selecting on spw :0~3 | [Opened in readonly mode]
08-Apr-2026 04:21:56 2026-04-08 04:21:46        INFO        SynthesisImagerVi2::selectData           NRows selected : 10920
08-Apr-2026 04:21:56 2026-04-08 04:21:46        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [test-X220-Titan] :
08-Apr-2026 04:21:56 2026-04-08 04:21:46        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [test-X220-Titan] :
08-Apr-2026 04:21:56 2026-04-08 04:21:47        INFO        SynthesisImagerVi2::defineImage         Impars: start
08-Apr-2026 04:21:56 2026-04-08 04:21:47        INFO        SynthesisImagerVi2::defineImage         Shape: [200, 200, 1, 1] Spectral: [1.07792e+11] at [0] with increment [1.56255e+10]
08-Apr-2026 04:21:56 2026-04-08 04:21:47        INFO        SynthesisImagerVi2::defineImage         Set Gridding options for [test-X220-Titan] with ftmachine : gridft
08-Apr-2026 04:21:56 2026-04-08 04:21:47        INFO        SynthesisImagerVi2::nSubCubeFitInMemory        Required memory: 0.008497 GB. Available mem.: 389.8 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
08-Apr-2026 04:21:56 2026-04-08 04:21:47        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:56 2026-04-08 04:21:48        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:56 2026-04-08 04:21:48        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:56 2026-04-08 04:21:49        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:56 2026-04-08 04:21:50        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:56 2026-04-08 04:21:51        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:56 2026-04-08 04:21:53        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:56 2026-04-08 04:21:54        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:56 2026-04-08 04:21:54        INFO        task_tclean::SynthesisDeconvolver::setupDeconvolution         Set Deconvolution Options for [test-X220-Titan] : clark
08-Apr-2026 04:21:56 2026-04-08 04:21:54        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:56 2026-04-08 04:21:55        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:56 2026-04-08 04:21:55        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:21:56 2026-04-08 04:21:56        INFO        tclean::::casa        ...done
08-Apr-2026 04:21:56 2026-04-08 04:21:56        INFO        SynthesisNormalizer::gatherImages         Gather psf,weight images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n3] onto :test-X220-Titan
08-Apr-2026 04:22:01 2026-04-08 04:21:56        INFO        SIImageStore::calcSensitivity         [test-X220-Titan] Theoretical sensitivity (Jy/bm):3.58671e-06
08-Apr-2026 04:22:01 2026-04-08 04:21:56        INFO        SIImageStore::getPSFGaussian         Time to fit Gaussian to PSF 0.002591
08-Apr-2026 04:22:01 2026-04-08 04:21:56        INFO        SIImageStore::printBeamSet         Beam : 3.77543 arcsec, 2.20411 arcsec, -83.4971 deg
08-Apr-2026 04:22:01 2026-04-08 04:21:56        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:22:01 2026-04-08 04:21:57        WARN        MPICommandServer::command_request_handler_service::SynthesisImagerVi2::makePB::MPIServer-1 (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SynthesisImagerVi2.cc, line 3558)        The MS has multiple antenna diameters ..PB could be wrong
08-Apr-2026 04:22:01 2026-04-08 04:21:57        INFO        tclean::::casa        ...done
08-Apr-2026 04:22:01 2026-04-08 04:21:58        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : test-X220-Titan to all nodes :[/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n3]
08-Apr-2026 04:22:01 2026-04-08 04:21:58        INFO        task_tclean::SIImageStore::setModelImageOne         Starting model image test-X220-Titan.model does not exist. No initial prediction will be done
08-Apr-2026 04:22:01 2026-04-08 04:21:58        INFO        task_tclean::SIImageStore::setModelImageOne         Starting model image test-X220-Titan.model does not exist. No initial prediction will be done
08-Apr-2026 04:22:01 2026-04-08 04:21:58        INFO        task_tclean::SIImageStore::setModelImageOne         Starting model image test-X220-Titan.model does not exist. No initial prediction will be done
08-Apr-2026 04:22:01 2026-04-08 04:21:58        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
08-Apr-2026 04:22:01 2026-04-08 04:21:58        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        tclean::::casa        ...done
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n3] onto :test-X220-Titan
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0, over full image : 0.217132
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        SynthesisDeconvolver::setupMask         [test-X220-Titan] Setting up a mask from [box [ [ 96pix , 96pix] , [104pix, 104pix ] ]]
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
08-Apr-2026 04:22:01 2026-04-08 04:21:59        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.
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        AsciiRegionFileParser::_parse        Combined 1 image regions (which excludes any annotation regions)
08-Apr-2026 04:22:01 2026-04-08 04:21:59        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).
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        SynthesisDeconvolver::setupMask         ----------------------------------------------------------------------------------------------------------------------------------------
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        SynthesisDeconvolver::setupMask         [test-X220-Titan] Number of pixels in the clean mask : 81 out of a total of 40000 pixels. [ 0.2025 % ]
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.217132, over full image : 0.217132
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 100, 'cyclethreshold': 0.0786764994263649, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        SDAlgorithmBase::deconvolve         [test-X220-Titan] Run clark minor-cycle | CycleThreshold=0.0786765, CycleNiter=100, Gain=0.1
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        SDAlgorithmClarkClean2::initializeDeconvolver         Choosing a PSF patch size of 25 pixels.
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        ClarkCleanLatModel::solve        Iteration: 1, Maximum residual=0.195419 Flux limit=0.0786765, 37 Active pixels
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        ClarkCleanLatModel::solve        Iteration: 3, Maximum residual=0.158289 Flux limit=0.0786765, 35 Active pixels
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        ClarkCleanLatModel::solve        Iteration: 7, Maximum residual=0.103854 Flux limit=0.0786765, 29 Active pixels
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        ClarkCleanLatModel::solve        Iteration: 10, Maximum residual=0.0757092 Flux limit=0.0786765, 11 Active pixels
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        SDAlgorithmBase::deconvolve         [test-X220-Titan] iters=0->10 [10], model=0->0.141423, peakres=0.217132->0.0757092, Reached cyclethreshold.
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 10 iterations.
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : test-X220-Titan to all nodes :[/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n3]
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X220-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n1.model
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X220-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n2.model
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X220-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n3.model
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
08-Apr-2026 04:22:01 2026-04-08 04:21:59        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:22:01 2026-04-08 04:22:01        INFO        tclean::::casa        ...done
08-Apr-2026 04:22:01 2026-04-08 04:22:01        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n3] onto :test-X220-Titan
08-Apr-2026 04:22:06 2026-04-08 04:22:01        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.075709, over full image : 0.075709
08-Apr-2026 04:22:06 2026-04-08 04:22:01        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 90, 'cyclethreshold': 0.027432726696133614, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
08-Apr-2026 04:22:06 2026-04-08 04:22:01        INFO        SDAlgorithmBase::deconvolve         [test-X220-Titan] Run clark minor-cycle | CycleThreshold=0.0274327, CycleNiter=90, Gain=0.1
08-Apr-2026 04:22:06 2026-04-08 04:22:01        INFO        SDAlgorithmClarkClean2::initializeDeconvolver         Choosing a PSF patch size of 25 pixels.
08-Apr-2026 04:22:06 2026-04-08 04:22:01        INFO        ClarkCleanLatModel::solve        Iteration: 1, Maximum residual=0.0681381 Flux limit=0.0274327, 37 Active pixels
08-Apr-2026 04:22:06 2026-04-08 04:22:01        INFO        ClarkCleanLatModel::solve        Iteration: 3, Maximum residual=0.0551919 Flux limit=0.0274327, 36 Active pixels
08-Apr-2026 04:22:06 2026-04-08 04:22:01        INFO        ClarkCleanLatModel::solve        Iteration: 7, Maximum residual=0.0362114 Flux limit=0.0274327, 29 Active pixels
08-Apr-2026 04:22:06 2026-04-08 04:22:01        INFO        ClarkCleanLatModel::solve        Iteration: 10, Maximum residual=0.0263981 Flux limit=0.0274327, 11 Active pixels
08-Apr-2026 04:22:06 2026-04-08 04:22:01        INFO        SDAlgorithmBase::deconvolve         [test-X220-Titan] iters=0->10 [10], model=0.141423->0.190734, peakres=0.075709->0.0263981, Reached cyclethreshold.
08-Apr-2026 04:22:06 2026-04-08 04:22:01        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 20 iterations.
08-Apr-2026 04:22:06 2026-04-08 04:22:01        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : test-X220-Titan to all nodes :[/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n3]
08-Apr-2026 04:22:06 2026-04-08 04:22:02        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X220-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n1.model
08-Apr-2026 04:22:06 2026-04-08 04:22:02        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X220-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n2.model
08-Apr-2026 04:22:06 2026-04-08 04:22:02        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X220-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n3.model
08-Apr-2026 04:22:06 2026-04-08 04:22:02        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
08-Apr-2026 04:22:06 2026-04-08 04:22:02        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:22:06 2026-04-08 04:22:04        INFO        tclean::::casa        ...done
08-Apr-2026 04:22:06 2026-04-08 04:22:04        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n3] onto :test-X220-Titan
08-Apr-2026 04:22:06 2026-04-08 04:22:04        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.0263981, over full image : 0.0263981
08-Apr-2026 04:22:06 2026-04-08 04:22:04        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 80, 'cyclethreshold': 0.009565179236233234, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
08-Apr-2026 04:22:06 2026-04-08 04:22:04        INFO        SDAlgorithmBase::deconvolve         [test-X220-Titan] Run clark minor-cycle | CycleThreshold=0.00956518, CycleNiter=80, Gain=0.1
08-Apr-2026 04:22:06 2026-04-08 04:22:04        INFO        SDAlgorithmClarkClean2::initializeDeconvolver         Choosing a PSF patch size of 25 pixels.
08-Apr-2026 04:22:06 2026-04-08 04:22:04        INFO        ClarkCleanLatModel::solve        Iteration: 1, Maximum residual=0.0237582 Flux limit=0.00956518, 37 Active pixels
08-Apr-2026 04:22:06 2026-04-08 04:22:04        INFO        ClarkCleanLatModel::solve        Iteration: 3, Maximum residual=0.0192442 Flux limit=0.00956518, 37 Active pixels
08-Apr-2026 04:22:06 2026-04-08 04:22:04        INFO        ClarkCleanLatModel::solve        Iteration: 7, Maximum residual=0.0126261 Flux limit=0.00956518, 29 Active pixels
08-Apr-2026 04:22:06 2026-04-08 04:22:04        INFO        ClarkCleanLatModel::solve        Iteration: 10, Maximum residual=0.00920443 Flux limit=0.00956518, 12 Active pixels
08-Apr-2026 04:22:06 2026-04-08 04:22:04        INFO        SDAlgorithmBase::deconvolve         [test-X220-Titan] iters=0->10 [10], model=0.190734->0.207927, peakres=0.0263981->0.00920443, Reached cyclethreshold.
08-Apr-2026 04:22:06 2026-04-08 04:22:04        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 30 iterations.
08-Apr-2026 04:22:06 2026-04-08 04:22:04        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : test-X220-Titan to all nodes :[/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n3]
08-Apr-2026 04:22:06 2026-04-08 04:22:04        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X220-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n1.model
08-Apr-2026 04:22:06 2026-04-08 04:22:04        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X220-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n2.model
08-Apr-2026 04:22:06 2026-04-08 04:22:04        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X220-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n3.model
08-Apr-2026 04:22:06 2026-04-08 04:22:04        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
08-Apr-2026 04:22:06 2026-04-08 04:22:04        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:22:06 2026-04-08 04:22:06        INFO        tclean::::casa        ...done
08-Apr-2026 04:22:06 2026-04-08 04:22:06        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n3] onto :test-X220-Titan
08-Apr-2026 04:22:06 2026-04-08 04:22:06        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00920441, over full image : 0.00920441
08-Apr-2026 04:22:06 2026-04-08 04:22:06        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 70, 'cyclethreshold': 0.0033351629972457886, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
08-Apr-2026 04:22:06 2026-04-08 04:22:06        INFO        SDAlgorithmBase::deconvolve         [test-X220-Titan] Run clark minor-cycle | CycleThreshold=0.00333516, CycleNiter=70, Gain=0.1
08-Apr-2026 04:22:10 2026-04-08 04:22:06        INFO        SDAlgorithmClarkClean2::initializeDeconvolver         Choosing a PSF patch size of 25 pixels.
08-Apr-2026 04:22:10 2026-04-08 04:22:06        INFO        ClarkCleanLatModel::solve        Iteration: 1, Maximum residual=0.00828397 Flux limit=0.00333516, 46 Active pixels
08-Apr-2026 04:22:10 2026-04-08 04:22:06        INFO        ClarkCleanLatModel::solve        Iteration: 3, Maximum residual=0.00671001 Flux limit=0.00333516, 44 Active pixels
08-Apr-2026 04:22:10 2026-04-08 04:22:06        INFO        ClarkCleanLatModel::solve        Iteration: 7, Maximum residual=0.00440244 Flux limit=0.00333516, 37 Active pixels
08-Apr-2026 04:22:10 2026-04-08 04:22:06        INFO        ClarkCleanLatModel::solve        Iteration: 10, Maximum residual=0.00320938 Flux limit=0.00333516, 18 Active pixels
08-Apr-2026 04:22:10 2026-04-08 04:22:06        INFO        SDAlgorithmBase::deconvolve         [test-X220-Titan] iters=0->10 [10], model=0.207927->0.213922, peakres=0.00920441->0.00320938, Reached cyclethreshold.
08-Apr-2026 04:22:10 2026-04-08 04:22:06        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 40 iterations.
08-Apr-2026 04:22:10 2026-04-08 04:22:06        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : test-X220-Titan to all nodes :[/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n3]
08-Apr-2026 04:22:10 2026-04-08 04:22:06        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X220-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n1.model
08-Apr-2026 04:22:10 2026-04-08 04:22:06        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X220-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n2.model
08-Apr-2026 04:22:10 2026-04-08 04:22:06        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X220-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n3.model
08-Apr-2026 04:22:10 2026-04-08 04:22:06        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
08-Apr-2026 04:22:10 2026-04-08 04:22:06        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:22:10 2026-04-08 04:22:08        INFO        tclean::::casa        ...done
08-Apr-2026 04:22:10 2026-04-08 04:22:08        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n3] onto :test-X220-Titan
08-Apr-2026 04:22:10 2026-04-08 04:22:08        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00320937, over full image : 0.00521466
08-Apr-2026 04:22:10 2026-04-08 04:22:08        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 60, 'cyclethreshold': 0.001162896165624261, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
08-Apr-2026 04:22:10 2026-04-08 04:22:08        INFO        SDAlgorithmBase::deconvolve         [test-X220-Titan] Run clark minor-cycle | CycleThreshold=0.0011629, CycleNiter=60, Gain=0.1
08-Apr-2026 04:22:10 2026-04-08 04:22:08        INFO        SDAlgorithmClarkClean2::initializeDeconvolver         Choosing a PSF patch size of 25 pixels.
08-Apr-2026 04:22:10 2026-04-08 04:22:08        INFO        ClarkCleanLatModel::solve        Iteration: 1, Maximum residual=0.00291336 Flux limit=0.0011629, 71 Active pixels
08-Apr-2026 04:22:10 2026-04-08 04:22:08        INFO        ClarkCleanLatModel::solve        Iteration: 4, Maximum residual=0.00243614 Flux limit=0.0011629, 70 Active pixels
08-Apr-2026 04:22:10 2026-04-08 04:22:08        INFO        ClarkCleanLatModel::solve        Iteration: 10, Maximum residual=0.00184255 Flux limit=0.0011629, 64 Active pixels
08-Apr-2026 04:22:10 2026-04-08 04:22:08        INFO        ClarkCleanLatModel::solve        Iteration: 20, Maximum residual=0.00119629 Flux limit=0.0011629, 52 Active pixels
08-Apr-2026 04:22:10 2026-04-08 04:22:08        INFO        ClarkCleanLatModel::solve        Iteration: 21, Maximum residual=0.00112493 Flux limit=0.0011629, 5 Active pixels
08-Apr-2026 04:22:10 2026-04-08 04:22:09        INFO        SDAlgorithmBase::deconvolve         [test-X220-Titan] iters=0->21 [21], model=0.213922->0.218005, peakres=0.00320937->0.00112493, Reached cyclethreshold.
08-Apr-2026 04:22:10 2026-04-08 04:22:09        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 61 iterations.
08-Apr-2026 04:22:10 2026-04-08 04:22:09        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : test-X220-Titan to all nodes :[/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n3]
08-Apr-2026 04:22:10 2026-04-08 04:22:09        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X220-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n1.model
08-Apr-2026 04:22:10 2026-04-08 04:22:09        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X220-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n2.model
08-Apr-2026 04:22:10 2026-04-08 04:22:09        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X220-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n3.model
08-Apr-2026 04:22:10 2026-04-08 04:22:09        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
08-Apr-2026 04:22:10 2026-04-08 04:22:09        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:22:10 2026-04-08 04:22:11        INFO        tclean::::casa        ...done
08-Apr-2026 04:22:10 2026-04-08 04:22:11        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n3] onto :test-X220-Titan
08-Apr-2026 04:22:10 2026-04-08 04:22:11        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.00117073, over full image : 0.00515292
08-Apr-2026 04:22:10 2026-04-08 04:22:11        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 39, 'cyclethreshold': 0.000424207333708182, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
08-Apr-2026 04:22:10 2026-04-08 04:22:11        INFO        SDAlgorithmBase::deconvolve         [test-X220-Titan] Run clark minor-cycle | CycleThreshold=0.000424207, CycleNiter=39, Gain=0.1
08-Apr-2026 04:22:10 2026-04-08 04:22:11        INFO        SDAlgorithmClarkClean2::initializeDeconvolver         Choosing a PSF patch size of 25 pixels.
08-Apr-2026 04:22:10 2026-04-08 04:22:11        INFO        ClarkCleanLatModel::solve        Iteration: 1, Maximum residual=0.00109996 Flux limit=0.000424207, 77 Active pixels
08-Apr-2026 04:22:24 2026-04-08 04:22:11        INFO        ClarkCleanLatModel::solve        Iteration: 4, Maximum residual=0.00100057 Flux limit=0.000424207, 75 Active pixels
08-Apr-2026 04:22:24 2026-04-08 04:22:11        INFO        ClarkCleanLatModel::solve        Iteration: 11, Maximum residual=0.000824373 Flux limit=0.000424207, 74 Active pixels
08-Apr-2026 04:22:24 2026-04-08 04:22:11        INFO        ClarkCleanLatModel::solve        Iteration: 24, Maximum residual=0.000607702 Flux limit=0.000424207, 70 Active pixels
08-Apr-2026 04:22:24 2026-04-08 04:22:11        INFO        ClarkCleanLatModel::solve        Iteration: 39, Maximum residual=0.000441009 Flux limit=0.000424207, 54 Active pixels
08-Apr-2026 04:22:24 2026-04-08 04:22:11        INFO        SDAlgorithmBase::deconvolve         [test-X220-Titan] iters=0->39 [39], model=0.218005->0.220838, peakres=0.00117073->0.000441009, Reached cycleniter.
08-Apr-2026 04:22:24 2026-04-08 04:22:11        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 100 iterations.
08-Apr-2026 04:22:24 2026-04-08 04:22:11        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : test-X220-Titan to all nodes :[/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n3]
08-Apr-2026 04:22:24 2026-04-08 04:22:11        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X220-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n1.model
08-Apr-2026 04:22:24 2026-04-08 04:22:11        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X220-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n2.model
08-Apr-2026 04:22:24 2026-04-08 04:22:11        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model test-X220-Titan.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n3.model
08-Apr-2026 04:22:24 2026-04-08 04:22:11        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
08-Apr-2026 04:22:24 2026-04-08 04:22:11        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:22:24 2026-04-08 04:22:13        INFO        tclean::::casa        ...done
08-Apr-2026 04:22:24 2026-04-08 04:22:13        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/test-X220-Titan.workdirectory/test-X220-Titan.n3] onto :test-X220-Titan
08-Apr-2026 04:22:24 2026-04-08 04:22:13        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.000441003, over full image : 0.00519729
08-Apr-2026 04:22:24 2026-04-08 04:22:13        INFO        tclean::::casa        Reached global stopping criterion : iteration limit
08-Apr-2026 04:22:24 2026-04-08 04:22:13        INFO        tclean::::casa        getSummary call: fullsummary=False
08-Apr-2026 04:22:24 2026-04-08 04:22:13        INFO        SDAlgorithmBase::restore         [test-X220-Titan] : Restoring model image.
08-Apr-2026 04:22:24 2026-04-08 04:22:13        INFO        SIImageStore::restore         Beam for chan : 0 : 3.77543 arcsec, 2.20411 arcsec, -83.4971 deg
08-Apr-2026 04:22:24 2026-04-08 04:22:21        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:22:24 2026-04-08 04:22:22        INFO        tclean::::casa        ...done
08-Apr-2026 04:22:24 2026-04-08 04:22:22        INFO        tclean::::casa        Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed.
08-Apr-2026 04:22:24 2026-04-08 04:22:22        INFO        tclean::::casa        Searching for images with prefix 'test-X220-Titan'... Found these, writing history into them: ['test-X220-Titan.psf', 'test-X220-Titan.sumwt', 'test-X220-Titan.pb', 'test-X220-Titan.residual', 'test-X220-Titan.mask', 'test-X220-Titan.model', 'test-X220-Titan.image']
08-Apr-2026 04:22:24 2026-04-08 04:22:22        INFO        tclean::::casa        Task tclean complete. Start time: 2026-04-08 00:21:43.748673 End time: 2026-04-08 00:22:22.341278
08-Apr-2026 04:22:24 2026-04-08 04:22:22        INFO        tclean::::casa        ##### End Task: tclean               #####
08-Apr-2026 04:22:24 2026-04-08 04:22:22        INFO        tclean::::casa        ##########################################
08-Apr-2026 04:22:24
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa        Step 21: Test image of Titan
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa        Time now: 1775622142.3416967
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa        Time used this step: 81.96278214454651
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa        Total time used so far: 875.1873269081116
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa        Step  Time used (s)     Fraction of total time (percent) [description]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          0   101.08941125869751  11.550602728198688 [Data import]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          1   0.6594710350036621  0.0753519863379948 [Generate antenna position cal tables]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          2   11.175009489059448  1.2768705790723527 [Generate tsys cal tables]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          3   5.818705797195435  0.6648526113548668 [Correct the Titan position]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          4   10.12402868270874  1.156784195958963 [Apriori flagging]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          5   33.62792229652405  3.8423685150156137 [Generate WVR cal tables]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          6   37.696974754333496  4.307303544660606 [Generate delay calibration tables]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          7   170.75245428085327  19.510389265357936 [Apply antpos, wvr, tsys, and delay cal tables]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          8   83.92568302154541  9.589453645088831 [Split off non-wvr spws and save flags]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          9   6.8373939990997314  0.7812492010430595 [Flagging]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          10   27.743021249771118  3.1699523515476975 [Rebin to a reduced resolution of approx. 10 km/s]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          11   5.490691423416138  0.6273732782230542 [Fast phase-only gaincal for bandpass]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          12   20.93693733215332  2.392280679625466 [Bandpass]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          13   16.140398263931274  1.8442221188179866 [Setjy]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          14   14.846267938613892  1.696353167162879 [Fast phase-only gaincal]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          15   10.28449010848999  1.175118719420144 [Slow phase-only gaincal]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          16   11.433034181594849  1.3063528035747296 [Slow amp and phase gaincal]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          17   1.5402872562408447  0.17599515085329429 [Fluxscale]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          18   23.161031246185303  2.6464084355527975 [Applycal]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          19   76.53682494163513  8.745193467554742 [Test image of the secondary phase cal]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          20   123.40450620651245  14.100353422904288 [Test image of the primary phase cal]
08-Apr-2026 04:22:24 2026-04-08 04:22:22        WARN        TIMING::::casa          21   81.96278214454651  9.36517013267401 [Test image of Titan]
08-Apr-2026 04:22:24 Step 22: Split off calibrated M100 data
08-Apr-2026 04:22:24 2026-04-08 04:22:22        INFO        split::::casa        ##########################################
08-Apr-2026 04:22:24 2026-04-08 04:22:22        INFO        split::::casa        ##### Begin Task: split              #####
08-Apr-2026 04:22:24 2026-04-08 04:22:22        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='' )
08-Apr-2026 04:22:24 2026-04-08 04:22:22        INFO        ParallelDataHelper::::casa        Analyzing MS for partitioning
08-Apr-2026 04:22:24 2026-04-08 04:22:22        INFO        ParallelDataHelper::::casa        Input vis is a Multi-MS
08-Apr-2026 04:22:28 2026-04-08 04:22:25        INFO        ParallelDataHelper::::casa        Finalizing MMS structure
08-Apr-2026 04:22:28 2026-04-08 04:22:25        INFO        ms::createmultims        Copying subtables from /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/X54-calibrated.ms.data/X54-calibrated.ms.0000.ms to the other MMS members.
08-Apr-2026 04:22:28 2026-04-08 04:22:25        INFO        split::::casa        Task split complete. Start time: 2026-04-08 00:22:22.351015 End time: 2026-04-08 00:22:25.085435
08-Apr-2026 04:22:28 2026-04-08 04:22:25        INFO        split::::casa        ##### End Task: split                #####
08-Apr-2026 04:22:28 2026-04-08 04:22:25        INFO        split::::casa        ##########################################
08-Apr-2026 04:22:28 2026-04-08 04:22:25        INFO        split::::casa        ##########################################
08-Apr-2026 04:22:28 2026-04-08 04:22:25        INFO        split::::casa        ##### Begin Task: split              #####
08-Apr-2026 04:22:28 2026-04-08 04:22:25        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='' )
08-Apr-2026 04:22:28 2026-04-08 04:22:25        INFO        ParallelDataHelper::::casa        Analyzing MS for partitioning
08-Apr-2026 04:22:28 2026-04-08 04:22:25        INFO        ParallelDataHelper::::casa        Input vis is a Multi-MS
08-Apr-2026 04:22:28 2026-04-08 04:22:27        INFO        ParallelDataHelper::::casa        Finalizing MMS structure
08-Apr-2026 04:22:28 2026-04-08 04:22:27        INFO        ms::createmultims        Copying subtables from /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/X220-calibrated.ms.data/X220-calibrated.ms.0000.ms to the other MMS members.
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        split::::casa        Task split complete. Start time: 2026-04-08 00:22:25.092979 End time: 2026-04-08 00:22:27.832011
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        split::::casa        ##### End Task: split                #####
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        split::::casa        ##########################################
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa        Step 22: Split off calibrated M100 data
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa        Time now: 1775622147.832135
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa        Time used this step: 5.490438222885132
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa        Total time used so far: 880.6777651309967
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa        Step  Time used (s)     Fraction of total time (percent) [description]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          0   101.08941125869751  11.478592427465333 [Data import]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          1   0.6594710350036621  0.07488221698268593 [Generate antenna position cal tables]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          2   11.175009489059448  1.2689101430189076 [Generate tsys cal tables]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          3   5.818705797195435  0.6607076989538767 [Correct the Titan position]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          4   10.12402868270874  1.1495724183751634 [Apriori flagging]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          5   33.62792229652405  3.8184139111905533 [Generate WVR cal tables]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          6   37.696974754333496  4.280450381159135 [Generate delay calibration tables]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          7   170.75245428085327  19.38875500682757 [Apply antpos, wvr, tsys, and delay cal tables]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          8   83.92568302154541  9.529669800288628 [Split off non-wvr spws and save flags]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          9   6.8373939990997314  0.7763786335723716 [Flagging]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          10   27.743021249771118  3.150189813824183 [Rebin to a reduced resolution of approx. 10 km/s]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          11   5.490691423416138  0.6234620244556104 [Fast phase-only gaincal for bandpass]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          12   20.93693733215332  2.3773664058657196 [Bandpass]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          13   16.140398263931274  1.8327246244862858 [Setjy]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          14   14.846267938613892  1.6857775370774326 [Fast phase-only gaincal]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          15   10.28449010848999  1.1677926383164925 [Slow phase-only gaincal]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          16   11.433034181594849  1.2982085655238766 [Slow amp and phase gaincal]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          17   1.5402872562408447  0.1748979385225803 [Fluxscale]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          18   23.161031246185303  2.62990984480461 [Applycal]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          19   76.53682494163513  8.690673021618824 [Test image of the secondary phase cal]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          20   123.40450620651245  14.0124471279409 [Test image of the primary phase cal]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          21   81.96278214454651  9.306784545917873 [Test image of Titan]
08-Apr-2026 04:22:28 2026-04-08 04:22:28        WARN        TIMING::::casa          22   5.490438222885132  0.6234332738113871 [Split off calibrated M100 data]
08-Apr-2026 04:22:28
08-Apr-2026 04:22:28 Step 23: Concatenate M100 data
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        virtualconcat::::casa        ##########################################
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        virtualconcat::::casa        ##### Begin Task: virtualconcat      #####
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        virtualconcat::::casa        virtualconcat( vis=['X54-calibrated.ms', 'X220-calibrated.ms'], concatvis='M100all.ms', freqtol='', dirtol='', respectname=True, visweightscale=[], keepcopy=False, copypointing=False )
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        virtualconcat::::casa        Checking MS setup consistency ...
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        virtualconcat::::casa        Checking for unpopulated POINTING table in first MS ...
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        virtualconcat::::casa        Checking for unpopulated optional Main Table columns in first MS ...
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        virtualconcat::::casa        Checking for unpopulated POINTING table ...
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        virtualconcat::::casa        Checking for unpopulated optional Main Table columns ...
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        virtualconcat::::casa        Checking order of MS list ...
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        virtualconcat::::casa        *** The following input measurement sets are multi-MSs
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        virtualconcat::::casa        ***   X54-calibrated.ms
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        virtualconcat::::casa        ***   X220-calibrated.ms
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        virtualconcat::::casa        Concatenating ...
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        virtualconcat::::casa        *** copypointing==False: resulting MMS will have empty POINTING table.
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        virtualconcat::::casa        adding /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/X54-calibrated.ms/SUBMSS/X54-calibrated.ms.0001.ms to multi-MS M100all.ms
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Added 0 rows and matched 94 from the state subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Added 4 rows to the source subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Added 0 rows and matched 4 from the data description subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Added 0 rows and matched 4 from the spectral window subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Removed 4 redundant rows from the source subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Added 0 rows and matched 13 from the antenna subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat +        Added 0 rows to the feed subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat +        Added 0 rows and matched 48 from the field subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::copyObservation        Added 0 rows and matched 1 rows in the observation subtable.
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::copyProcessor        Added 0 rows and matched 3 rows in the processor subtable.
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::copySysCal        No valid syscal tables present. Result won't have one either.
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::copyGainCurve        No valid gain curve tables present. Result won't have one either.
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::copyPhaseCal        No valid gain curve tables present. Result won't have one either.
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Will create auxiliary file concat_aux_1775622148.103905
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Working on appended Main table ...
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Writing to concat_aux_1775622148.103905
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Writing the scalar columns ...
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        virtualconcat::::casa        adding /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/X54-calibrated.ms/SUBMSS/X54-calibrated.ms.0002.ms to multi-MS M100all.ms
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Added 0 rows and matched 94 from the state subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Added 4 rows to the source subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Added 0 rows and matched 4 from the data description subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Added 0 rows and matched 4 from the spectral window subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Removed 4 redundant rows from the source subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Added 0 rows and matched 13 from the antenna subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat +        Added 0 rows to the feed subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat +        Added 0 rows and matched 48 from the field subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::copyObservation        Added 0 rows and matched 1 rows in the observation subtable.
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::copyProcessor        Added 0 rows and matched 3 rows in the processor subtable.
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::copySysCal        No valid syscal tables present. Result won't have one either.
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::copyGainCurve        No valid gain curve tables present. Result won't have one either.
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::copyPhaseCal        No valid gain curve tables present. Result won't have one either.
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Reading from concat_aux_1775622148.103905
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Working on appended Main table ...
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Writing to concat_aux_1775622148.103905
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Writing the scalar columns ...
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        virtualconcat::::casa        adding /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/X220-calibrated.ms/SUBMSS/X220-calibrated.ms.0000.ms to multi-MS M100all.ms
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Added 0 rows and matched 94 from the state subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Added 4 rows to the source subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Added 0 rows and matched 4 from the data description subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Added 0 rows and matched 4 from the spectral window subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Removed 4 redundant rows from the source subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Added 0 rows and matched 13 from the antenna subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat +        Added 0 rows to the feed subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat +        Added 0 rows and matched 48 from the field subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::copyObservation        Added 1 rows and matched 0 rows in the observation subtable.
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::copyProcessor        Added 0 rows and matched 3 rows in the processor subtable.
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::copySysCal        No valid syscal tables present. Result won't have one either.
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::copyGainCurve        No valid gain curve tables present. Result won't have one either.
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::copyPhaseCal        No valid gain curve tables present. Result won't have one either.
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Reading from concat_aux_1775622148.103905
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Working on appended Main table ...
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Will offset scan numbers by 15 for observations with Obs ID 1 in order to make scan numbers unique.
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Writing to concat_aux_1775622148.103905
08-Apr-2026 04:22:28 2026-04-08 04:22:28        INFO        MSConcat::virtualconcat         Writing the scalar columns ...
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        virtualconcat::::casa        adding /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/X220-calibrated.ms/SUBMSS/X220-calibrated.ms.0001.ms to multi-MS M100all.ms
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Added 0 rows and matched 94 from the state subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Added 4 rows to the source subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Added 0 rows and matched 4 from the data description subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Added 0 rows and matched 4 from the spectral window subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Removed 4 redundant rows from the source subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Added 0 rows and matched 13 from the antenna subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat +        Added 0 rows to the feed subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat +        Added 0 rows and matched 48 from the field subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::copyObservation        Added 0 rows and matched 1 rows in the observation subtable.
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::copyProcessor        Added 0 rows and matched 3 rows in the processor subtable.
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::copySysCal        No valid syscal tables present. Result won't have one either.
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::copyGainCurve        No valid gain curve tables present. Result won't have one either.
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::copyPhaseCal        No valid gain curve tables present. Result won't have one either.
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Reading from concat_aux_1775622148.103905
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Working on appended Main table ...
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Will offset scan numbers by 15 for observations with Obs ID 1 in order to make scan numbers unique.
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Writing to concat_aux_1775622148.103905
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Writing the scalar columns ...
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        virtualconcat::::casa        adding /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/X220-calibrated.ms/SUBMSS/X220-calibrated.ms.0002.ms to multi-MS M100all.ms
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Added 0 rows and matched 94 from the state subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Added 4 rows to the source subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Added 0 rows and matched 4 from the data description subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Added 0 rows and matched 4 from the spectral window subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Removed 4 redundant rows from the source subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Added 0 rows and matched 13 from the antenna subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat +        Added 0 rows to the feed subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat +        Added 0 rows and matched 48 from the field subtable
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::copyObservation        Added 0 rows and matched 1 rows in the observation subtable.
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::copyProcessor        Added 0 rows and matched 3 rows in the processor subtable.
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::copySysCal        No valid syscal tables present. Result won't have one either.
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::copyGainCurve        No valid gain curve tables present. Result won't have one either.
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::copyPhaseCal        No valid gain curve tables present. Result won't have one either.
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Reading from concat_aux_1775622148.103905
08-Apr-2026 04:22:28 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Working on appended Main table ...
08-Apr-2026 04:22:35 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Will offset scan numbers by 15 for observations with Obs ID 1 in order to make scan numbers unique.
08-Apr-2026 04:22:35 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Writing to concat_aux_1775622148.103905
08-Apr-2026 04:22:35 2026-04-08 04:22:29        INFO        MSConcat::virtualconcat         Writing the scalar columns ...
08-Apr-2026 04:22:35 2026-04-08 04:22:29        INFO        ms::createmultims        Copying subtables from /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/X54-calibrated.ms/SUBMSS/X54-calibrated.ms.0000.ms to the other MMS members.
08-Apr-2026 04:22:35 2026-04-08 04:22:30        INFO        virtualconcat::::casa        Task virtualconcat complete. Start time: 2026-04-08 00:22:27.840772 End time: 2026-04-08 00:22:29.555348
08-Apr-2026 04:22:35 2026-04-08 04:22:30        INFO        virtualconcat::::casa        ##### End Task: virtualconcat        #####
08-Apr-2026 04:22:35 2026-04-08 04:22:30        INFO        virtualconcat::::casa        ##########################################
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa        Step 23: Concatenate M100 data
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa        Time now: 1775622149.555543
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa        Time used this step: 1.7234079837799072
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa        Total time used so far: 882.4011731147766
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa        Step  Time used (s)     Fraction of total time (percent) [description]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          0   101.08941125869751  11.456173715393339 [Data import]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          1   0.6594710350036621  0.07473596535188226 [Generate antenna position cal tables]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          2   11.175009489059448  1.266431848635573 [Generate tsys cal tables]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          3   5.818705797195435  0.659417278045547 [Correct the Titan position]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          4   10.12402868270874  1.1473272011835682 [Apriori flagging]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          5   33.62792229652405  3.8109562091606564 [Generate WVR cal tables]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          6   37.696974754333496  4.27209028080362 [Generate delay calibration tables]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          7   170.75245428085327  19.350887043601308 [Apply antpos, wvr, tsys, and delay cal tables]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          8   83.92568302154541  9.511057507471032 [Split off non-wvr spws and save flags]
08-Apr-2026 04:22:35
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          9   6.8373939990997314  0.7748622970393956 [Flagging]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          10   27.743021249771118  3.144037212897324 [Rebin to a reduced resolution of approx. 10 km/s]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          11   5.490691423416138  0.6222443476627095 [Fast phase-only gaincal for bandpass]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          12   20.93693733215332  2.3727231977999637 [Bandpass]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          13   16.140398263931274  1.8291451502673652 [Setjy]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          14   14.846267938613892  1.6824850635916815 [Fast phase-only gaincal]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          15   10.28449010848999  1.1655118354145995 [Slow phase-only gaincal]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          16   11.433034181594849  1.2956730487151924 [Slow amp and phase gaincal]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          17   1.5402872562408447  0.17455634729085914 [Fluxscale]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          18   23.161031246185303  2.6247733969379796 [Applycal]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          19   76.53682494163513  8.673699364141683 [Test image of the secondary phase cal]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          20   123.40450620651245  13.985079572243594 [Test image of the primary phase cal]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          21   81.96278214454651  9.28860756782849 [Test image of Titan]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          22   5.490438222885132  0.6222156531710519 [Split off calibrated M100 data]
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        TIMING::::casa          23   1.7234079837799072  0.1953088953515861 [Concatenate M100 data]
08-Apr-2026 04:22:35 Step 24: Average concatenated M100 data in time
08-Apr-2026 04:22:35 2026-04-08 04:22:30        INFO        split::::casa        ##########################################
08-Apr-2026 04:22:35 2026-04-08 04:22:30        INFO        split::::casa        ##### Begin Task: split              #####
08-Apr-2026 04:22:35 2026-04-08 04:22:30        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='' )
08-Apr-2026 04:22:35 2026-04-08 04:22:30        INFO        ParallelDataHelper::::casa        Analyzing MS for partitioning
08-Apr-2026 04:22:35 2026-04-08 04:22:30        INFO        ParallelDataHelper::::casa        Input vis is a Multi-MS
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        MSTransformManager::parseTimeAvgParams::MPIServer-2        Operating with ALMA data, automatically adding state to timespan
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        MSTransformManager::parseTimeAvgParams::MPIServer-2+        In order to remove sub-scan boundaries which limit time average to 30s
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        MSTransformManager::parseTimeAvgParams::MPIServer-3        Operating with ALMA data, automatically adding state to timespan
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        MSTransformManager::parseTimeAvgParams::MPIServer-3+        In order to remove sub-scan boundaries which limit time average to 30s
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        MSTransformManager::parseTimeAvgParams::MPIServer-1        Operating with ALMA data, automatically adding state to timespan
08-Apr-2026 04:22:35 2026-04-08 04:22:30        WARN        MSTransformManager::parseTimeAvgParams::MPIServer-1+        In order to remove sub-scan boundaries which limit time average to 30s
08-Apr-2026 04:22:35 2026-04-08 04:22:33        WARN        MSTransformManager::parseTimeAvgParams::MPIServer-3        Operating with ALMA data, automatically adding state to timespan
08-Apr-2026 04:22:35 2026-04-08 04:22:33        WARN        MSTransformManager::parseTimeAvgParams::MPIServer-3+        In order to remove sub-scan boundaries which limit time average to 30s
08-Apr-2026 04:22:35 2026-04-08 04:22:33        WARN        MSTransformManager::parseTimeAvgParams::MPIServer-1        Operating with ALMA data, automatically adding state to timespan
08-Apr-2026 04:22:35 2026-04-08 04:22:33        WARN        MSTransformManager::parseTimeAvgParams::MPIServer-1+        In order to remove sub-scan boundaries which limit time average to 30s
08-Apr-2026 04:22:35 2026-04-08 04:22:33        WARN        MSTransformManager::parseTimeAvgParams::MPIServer-2        Operating with ALMA data, automatically adding state to timespan
08-Apr-2026 04:22:35 2026-04-08 04:22:33        WARN        MSTransformManager::parseTimeAvgParams::MPIServer-2+        In order to remove sub-scan boundaries which limit time average to 30s
08-Apr-2026 04:22:35 2026-04-08 04:22:35        INFO        ParallelDataHelper::::casa        Finalizing MMS structure
08-Apr-2026 04:22:35 2026-04-08 04:22:35        INFO        ms::createmultims        Copying subtables from /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms.data/M100all_lores.ms.0000.ms to the other MMS members.
08-Apr-2026 04:22:35 2026-04-08 04:22:36        INFO        split::::casa        Task split complete. Start time: 2026-04-08 00:22:29.563461 End time: 2026-04-08 00:22:35.872964
08-Apr-2026 04:22:35 2026-04-08 04:22:36        INFO        split::::casa        ##### End Task: split                #####
08-Apr-2026 04:22:35 2026-04-08 04:22:36        INFO        split::::casa        ##########################################
08-Apr-2026 04:22:35 2026-04-08 04:22:36        WARN        TIMING::::casa        Step 24: Average concatenated M100 data in time
08-Apr-2026 04:22:35 2026-04-08 04:22:36        WARN        TIMING::::casa        Time now: 1775622155.8730948
08-Apr-2026 04:22:35 2026-04-08 04:22:36        WARN        TIMING::::casa        Time used this step: 6.317551851272583
08-Apr-2026 04:22:35 2026-04-08 04:22:36        WARN        TIMING::::casa        Total time used so far: 888.7187249660492
08-Apr-2026 04:22:35 2026-04-08 04:22:36        WARN        TIMING::::casa        Step  Time used (s)     Fraction of total time (percent) [description]
08-Apr-2026 04:22:35 2026-04-08 04:22:36        WARN        TIMING::::casa          0   101.08941125869751  11.374736282568968 [Data import]
08-Apr-2026 04:22:35 2026-04-08 04:22:36        WARN        TIMING::::casa          1   0.6594710350036621  0.07420469677049454 [Generate antenna position cal tables]
08-Apr-2026 04:22:35 2026-04-08 04:22:36        WARN        TIMING::::casa          2   11.175009489059448  1.2574292827560662 [Generate tsys cal tables]
08-Apr-2026 04:22:35 2026-04-08 04:22:36        WARN        TIMING::::casa          3   5.818705797195435  0.6547297399880622 [Correct the Titan position]
08-Apr-2026 04:22:35 2026-04-08 04:22:36        WARN        TIMING::::casa          4   10.12402868270874  1.1391713033947268 [Apriori flagging]
08-Apr-2026 04:22:35 2026-04-08 04:22:36        WARN        TIMING::::casa          5   33.62792229652405  3.7838656204536143 [Generate WVR cal tables]
08-Apr-2026 04:22:35 2026-04-08 04:22:36        WARN        TIMING::::casa          6   37.696974754333496  4.241721671361611 [Generate delay calibration tables]
08-Apr-2026 04:22:54 2026-04-08 04:22:36        WARN        TIMING::::casa          7   170.75245428085327  19.213329198996718 [Apply antpos, wvr, tsys, and delay cal tables]
08-Apr-2026 04:22:54 2026-04-08 04:22:36        WARN        TIMING::::casa          8   83.92568302154541  9.443447140685771 [Split off non-wvr spws and save flags]
08-Apr-2026 04:22:54 2026-04-08 04:22:36        WARN        TIMING::::casa          9   6.8373939990997314  0.769354105750493 [Flagging]
08-Apr-2026 04:22:54 2026-04-08 04:22:36        WARN        TIMING::::casa          10   27.743021249771118  3.121687489011887 [Rebin to a reduced resolution of approx. 10 km/s]
08-Apr-2026 04:22:54 2026-04-08 04:22:36        WARN        TIMING::::casa          11   5.490691423416138  0.6178210573458879 [Fast phase-only gaincal for bandpass]
08-Apr-2026 04:22:54
08-Apr-2026 04:22:54 2026-04-08 04:22:36        WARN        TIMING::::casa          12   20.93693733215332  2.3558564418627674 [Bandpass]
08-Apr-2026 04:22:54 2026-04-08 04:22:36        WARN        TIMING::::casa          13   16.140398263931274  1.8161424768616041 [Setjy]
08-Apr-2026 04:22:54 2026-04-08 04:22:36        WARN        TIMING::::casa          14   14.846267938613892  1.670524939055498 [Fast phase-only gaincal]
08-Apr-2026 04:22:54 2026-04-08 04:22:36        WARN        TIMING::::casa          15   10.28449010848999  1.1572266702136695 [Slow phase-only gaincal]
08-Apr-2026 04:22:54 2026-04-08 04:22:36        WARN        TIMING::::casa          16   11.433034181594849  1.2864626186459178 [Slow amp and phase gaincal]
08-Apr-2026 04:22:54 2026-04-08 04:22:36        WARN        TIMING::::casa          17   1.5402872562408447  0.17331549487715436 [Fluxscale]
08-Apr-2026 04:22:54 2026-04-08 04:22:36        WARN        TIMING::::casa          18   23.161031246185303  2.60611491527537 [Applycal]
08-Apr-2026 04:22:54 2026-04-08 04:22:36        WARN        TIMING::::casa          19   76.53682494163513  8.612041447034773 [Test image of the secondary phase cal]
08-Apr-2026 04:22:54 2026-04-08 04:22:36        WARN        TIMING::::casa          20   123.40450620651245  13.885665142391002 [Test image of the primary phase cal]
08-Apr-2026 04:22:54 2026-04-08 04:22:36        WARN        TIMING::::casa          21   81.96278214454651  9.222578510166718 [Test image of Titan]
08-Apr-2026 04:22:54 2026-04-08 04:22:36        WARN        TIMING::::casa          22   5.490438222885132  0.6177925668320848 [Split off calibrated M100 data]
08-Apr-2026 04:22:54 2026-04-08 04:22:36        WARN        TIMING::::casa          23   1.7234079837799072  0.19392052123642886 [Concatenate M100 data]
08-Apr-2026 04:22:54 2026-04-08 04:22:36        WARN        TIMING::::casa          24   6.317551851272583  0.7108606664627131 [Average concatenated M100 data in time]
08-Apr-2026 04:22:54 Step 25: Continuum image of M100
08-Apr-2026 04:22:54 2026-04-08 04:22:36        INFO        tclean::::casa        ##########################################
08-Apr-2026 04:22:54 2026-04-08 04:22:36        INFO        tclean::::casa        ##### Begin Task: tclean             #####
08-Apr-2026 04:22:54 2026-04-08 04:22:36        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 )
08-Apr-2026 04:22:54 2026-04-08 04:22:36        INFO        tclean::::casa        Verifying Input Parameters
08-Apr-2026 04:22:54 2026-04-08 04:22:37        INFO        tclean::::casa        setupCluster, Setting up 3 engines.
08-Apr-2026 04:22:54 2026-04-08 04:22:37        INFO        SynthesisUtilMethods::continuumDataPartition         
08-Apr-2026 04:22:54 2026-04-08 04:22:37        INFO        SynthesisUtilMethods::continuumDataPartition +        Rows = 27459 41184 [P][M]: 0:2 ROWNUMBER() >= 27459 && ROWNUMBER() <= 41184
08-Apr-2026 04:22:54 2026-04-08 04:22:37        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': ''}}}
08-Apr-2026 04:22:54 2026-04-08 04:22:37        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]
08-Apr-2026 04:22:54 2026-04-08 04:22:37        INFO        SynthesisImagerVi2::selectData           NRows selected : 41184
08-Apr-2026 04:22:54 2026-04-08 04:22:38        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [M100cont] :
08-Apr-2026 04:22:54 2026-04-08 04:22:38        INFO        SynthesisImagerVi2::defineImage         Define image coordinates for [M100cont] :
08-Apr-2026 04:22:54 2026-04-08 04:22:38        INFO        SynthesisImagerVi2::defineImage         Impars: start
08-Apr-2026 04:22:54 2026-04-08 04:22:38        INFO        SynthesisImagerVi2::defineImage         Shape: [200, 200, 1, 1] Spectral: [1.0775e+11] at [0] with increment [1.53986e+10]
08-Apr-2026 04:22:54 2026-04-08 04:22:38        INFO        SynthesisImagerVi2::defineImage         Set Gridding options for [M100cont] with ftmachine : mosaicft
08-Apr-2026 04:22:54 2026-04-08 04:22:38        INFO        SynthesisImager::getVPRecord         Using default Voltage Patterns from the VPManager
08-Apr-2026 04:22:54 2026-04-08 04:22:38        INFO        VPSkyJones::VPSkyJones        PB used ALMA
08-Apr-2026 04:22:54 2026-04-08 04:22:38        INFO        SynthesisImagerVi2::nSubCubeFitInMemory        Required memory: 0.01888 GB. Available mem.: 389.2 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
08-Apr-2026 04:22:54 2026-04-08 04:22:38        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:22:54 2026-04-08 04:22:39        INFO        tclean::::casa        ...done
08-Apr-2026 04:22:54 2026-04-08 04:22:39        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:22:54 2026-04-08 04:22:40        INFO        tclean::::casa        ...done
08-Apr-2026 04:22:54 2026-04-08 04:22:41        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:22:54 2026-04-08 04:22:42        INFO        tclean::::casa        ...done
08-Apr-2026 04:22:54 2026-04-08 04:22:44        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:22:54 2026-04-08 04:22:45        INFO        tclean::::casa        ...done
08-Apr-2026 04:22:54 2026-04-08 04:22:45        INFO        task_tclean::SynthesisDeconvolver::setupDeconvolution         Set Deconvolution Options for [M100cont] : clark
08-Apr-2026 04:22:54 2026-04-08 04:22:45        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:22:54 2026-04-08 04:22:46        INFO        tclean::::casa        ...done
08-Apr-2026 04:22:54 2026-04-08 04:22:46        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:22:54
08-Apr-2026 04:22:54 0%....10....20....30....40....50....60....70....80....90...
08-Apr-2026 04:22:54 0%....10....20....30....40....50....60....70....80....90..100%
08-Apr-2026 04:22:54
08-Apr-2026 04:22:54 0%....10....20....30....40....50....60....70....80....90......100%
08-Apr-2026 04:22:54 .100%
08-Apr-2026 04:22:54 2026-04-08 04:22:54        INFO        tclean::::casa        ...done
08-Apr-2026 04:22:54 2026-04-08 04:22:54        INFO        SynthesisNormalizer::gatherImages         Gather psf,weight images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n3] onto :M100cont
08-Apr-2026 04:23:08 2026-04-08 04:22:55        INFO        SIImageStore::calcSensitivity         [M100cont] Theoretical sensitivity (Jy/bm):1.32309e-06
08-Apr-2026 04:23:08 2026-04-08 04:22:55        INFO        SIImageStore::getPSFGaussian         Time to fit Gaussian to PSF 0.010941
08-Apr-2026 04:23:08 2026-04-08 04:22:55        INFO        SIImageStore::printBeamSet         Beam : 5.16402 arcsec, 2.72039 arcsec, -69.1551 deg
08-Apr-2026 04:23:08 2026-04-08 04:22:55        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:23:08 2026-04-08 04:22:56        INFO        tclean::::casa        ...done
08-Apr-2026 04:23:08 2026-04-08 04:22:56        INFO        SynthesisNormalizer::scatterModel         Send the model from : M100cont to all nodes :[/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n3]
08-Apr-2026 04:23:08 2026-04-08 04:22:56        INFO        SIImageStore::setModelImageOne         Copying input model M100cont.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n1.model
08-Apr-2026 04:23:08 2026-04-08 04:22:56        INFO        SIImageStore::setModelImageOne         Copying input model M100cont.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n2.model
08-Apr-2026 04:23:08 2026-04-08 04:22:56        INFO        SIImageStore::setModelImageOne         Copying input model M100cont.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n3.model
08-Apr-2026 04:23:08 2026-04-08 04:22:56        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
08-Apr-2026 04:23:08 2026-04-08 04:22:56        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:23:08 2026-04-08 04:23:01        INFO        tclean::::casa        ...done
08-Apr-2026 04:23:08 2026-04-08 04:23:01        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n3] onto :M100cont
08-Apr-2026 04:23:08 2026-04-08 04:23:01        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0, over full image : 0.000543286
08-Apr-2026 04:23:08 2026-04-08 04:23:01        INFO        SynthesisDeconvolver::setupMask         [M100cont] Setting up a mask from [M100cont-orig.mask]
08-Apr-2026 04:23:08 2026-04-08 04:23:01        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
08-Apr-2026 04:23:08 2026-04-08 04:23:01        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
08-Apr-2026 04:23:08 2026-04-08 04:23:01        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
08-Apr-2026 04:23:08 2026-04-08 04:23:01        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.
08-Apr-2026 04:23:08 2026-04-08 04:23:01        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
08-Apr-2026 04:23:08 2026-04-08 04:23:01        INFO        SDMaskHandler::fillMask         Copying mask image: M100cont-orig.mask
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
08-Apr-2026 04:23:08 2026-04-08 04:23:02        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.
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        SynthesisDeconvolver::setupMask         ----------------------------------------------------------------------------------------------------------------------------------------
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        SynthesisDeconvolver::setupMask         [M100cont] Number of pixels in the clean mask : 1748 out of a total of 40000 pixels. [ 4.37 % ]
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.000543286, over full image : 0.000543286
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 1000, 'cyclethreshold': 0.0001268737978534773, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        SDAlgorithmBase::deconvolve         [M100cont] Run clark minor-cycle | CycleThreshold=0.000126874, CycleNiter=1000, Gain=0.1
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        SDAlgorithmClarkClean2::initializeDeconvolver         Choosing a PSF patch size of 34 pixels.
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        ClarkCleanLatModel::solve        Iteration: 1, Maximum residual=0.000488957 Flux limit=0.000126874, 902 Active pixels
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        ClarkCleanLatModel::solve        Iteration: 4, Maximum residual=0.000423278 Flux limit=0.000126874, 896 Active pixels
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        ClarkCleanLatModel::solve        Iteration: 10, Maximum residual=0.000348027 Flux limit=0.000126874, 889 Active pixels
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        ClarkCleanLatModel::solve        Iteration: 24, Maximum residual=0.000279456 Flux limit=0.000126874, 868 Active pixels
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        ClarkCleanLatModel::solve        Iteration: 53, Maximum residual=0.000214471 Flux limit=0.000126874, 812 Active pixels
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        ClarkCleanLatModel::solve        Iteration: 111, Maximum residual=0.000156133 Flux limit=0.000126874, 669 Active pixels
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        ClarkCleanLatModel::solve        Iteration: 153, Maximum residual=0.000126376 Flux limit=0.000126874, 288 Active pixels
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        SDAlgorithmBase::deconvolve         [M100cont] iters=0->153 [153], model=0->0.00184152, peakres=0.000543286->0.000126376, Reached cyclethreshold.
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 153 iterations.
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : M100cont to all nodes :[/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n3]
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model M100cont.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n1.model
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model M100cont.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n2.model
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model M100cont.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n3.model
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
08-Apr-2026 04:23:08 2026-04-08 04:23:02        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:23:08 2026-04-08 04:23:09        INFO        tclean::::casa        ...done
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n3] onto :M100cont
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 0.000131666, over full image : 0.000506479
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 847, 'cyclethreshold': 3.074791675317101e-05, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        SDAlgorithmBase::deconvolve         [M100cont] Run clark minor-cycle | CycleThreshold=3.07479e-05, CycleNiter=847, Gain=0.1
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        SDAlgorithmClarkClean2::initializeDeconvolver         Choosing a PSF patch size of 34 pixels.
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        ClarkCleanLatModel::solve        Iteration: 1, Maximum residual=0.000131375 Flux limit=3.07479e-05, 1379 Active pixels
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        ClarkCleanLatModel::solve        Iteration: 4, Maximum residual=0.00012745 Flux limit=3.07479e-05, 1381 Active pixels
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        ClarkCleanLatModel::solve        Iteration: 12, Maximum residual=0.000124416 Flux limit=3.07479e-05, 1382 Active pixels
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        ClarkCleanLatModel::solve        Iteration: 31, Maximum residual=0.000114552 Flux limit=3.07479e-05, 1364 Active pixels
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        ClarkCleanLatModel::solve        Iteration: 75, Maximum residual=0.000100521 Flux limit=3.07479e-05, 1340 Active pixels
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        ClarkCleanLatModel::solve        Iteration: 163, Maximum residual=7.95645e-05 Flux limit=3.07479e-05, 1281 Active pixels
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        ClarkCleanLatModel::solve        Iteration: 322, Maximum residual=5.60986e-05 Flux limit=3.07479e-05, 1170 Active pixels
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        ClarkCleanLatModel::solve        Iteration: 573, Maximum residual=3.98361e-05 Flux limit=3.07479e-05, 829 Active pixels
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        ClarkCleanLatModel::solve        Iteration: 817, Maximum residual=3.06842e-05 Flux limit=3.07479e-05, 437 Active pixels
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        SDAlgorithmBase::deconvolve         [M100cont] iters=0->817 [817], model=0.00184152->0.00251094, peakres=0.000131666->3.06842e-05, Reached cyclethreshold.
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 970 iterations.
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : M100cont to all nodes :[/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n3]
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model M100cont.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n1.model
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model M100cont.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n2.model
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model M100cont.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n3.model
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
08-Apr-2026 04:23:23 2026-04-08 04:23:09        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:23:23 2026-04-08 04:23:16        INFO        tclean::::casa        ...done
08-Apr-2026 04:23:23 2026-04-08 04:23:16        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n3] onto :M100cont
08-Apr-2026 04:23:23 2026-04-08 04:23:16        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 3.98462e-05, over full image : 0.000490799
08-Apr-2026 04:23:23 2026-04-08 04:23:16        INFO        tclean::::casa        Minor Cycle controls : {'cycleniter': 30, 'cyclethreshold': 9.305295861850027e-06, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
08-Apr-2026 04:23:23 2026-04-08 04:23:16        INFO        SDAlgorithmBase::deconvolve         [M100cont] Run clark minor-cycle | CycleThreshold=9.3053e-06, CycleNiter=30, Gain=0.1
08-Apr-2026 04:23:23 2026-04-08 04:23:16        INFO        SDAlgorithmClarkClean2::initializeDeconvolver         Choosing a PSF patch size of 34 pixels.
08-Apr-2026 04:23:23 2026-04-08 04:23:16        INFO        ClarkCleanLatModel::solve        Iteration: 1, Maximum residual=3.95916e-05 Flux limit=9.3053e-06, 1273 Active pixels
08-Apr-2026 04:23:23 2026-04-08 04:23:16        INFO        ClarkCleanLatModel::solve        Iteration: 4, Maximum residual=3.6595e-05 Flux limit=9.3053e-06, 1272 Active pixels
08-Apr-2026 04:23:23 2026-04-08 04:23:16        INFO        ClarkCleanLatModel::solve        Iteration: 12, Maximum residual=3.46897e-05 Flux limit=9.3053e-06, 1257 Active pixels
08-Apr-2026 04:23:23 2026-04-08 04:23:16        INFO        ClarkCleanLatModel::solve        Iteration: 30, Maximum residual=3.30783e-05 Flux limit=9.3053e-06, 1249 Active pixels
08-Apr-2026 04:23:23 2026-04-08 04:23:16        INFO        SDAlgorithmBase::deconvolve         [M100cont] iters=0->30 [30], model=0.00251094->0.00251648, peakres=3.98462e-05->3.30783e-05, Reached cycleniter.
08-Apr-2026 04:23:23 2026-04-08 04:23:16        INFO        grpcInteractiveCleanManager::mergeCycleExecutionRecord         Completed 1000 iterations.
08-Apr-2026 04:23:23 2026-04-08 04:23:16        INFO        task_tclean::SynthesisNormalizer::scatterModel         Send the model from : M100cont to all nodes :[/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n3]
08-Apr-2026 04:23:23 2026-04-08 04:23:16        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model M100cont.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n1.model
08-Apr-2026 04:23:23 2026-04-08 04:23:16        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model M100cont.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n2.model
08-Apr-2026 04:23:23 2026-04-08 04:23:16        INFO        task_tclean::SIImageStore::setModelImageOne         Copying input model M100cont.model to /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n3.model
08-Apr-2026 04:23:23 2026-04-08 04:23:17        INFO        tclean::::casa        -----------------------------  Running Parallel Major Cycle ----------------------------
08-Apr-2026 04:23:23 2026-04-08 04:23:17        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:23:23 2026-04-08 04:23:24        INFO        tclean::::casa        ...done
08-Apr-2026 04:23:44 2026-04-08 04:23:24        INFO        SynthesisNormalizer::gatherImages         Gather residual images : [/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n1, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n2, /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100cont.workdirectory/M100cont.n3] onto :M100cont
08-Apr-2026 04:23:44 2026-04-08 04:23:24        INFO        task_tclean::SynthesisDeconvolver::initMinorCycle          Absolute Peak residual within mask : 3.3542e-05, over full image : 0.000490481
08-Apr-2026 04:23:44 2026-04-08 04:23:24        INFO        tclean::::casa        Reached global stopping criterion : iteration limit
08-Apr-2026 04:23:44 2026-04-08 04:23:24        INFO        tclean::::casa        getSummary call: fullsummary=False
08-Apr-2026 04:23:44 2026-04-08 04:23:24        INFO        SDAlgorithmBase::restore         [M100cont] : Restoring model image.
08-Apr-2026 04:23:44 2026-04-08 04:23:24        INFO        SIImageStore::restore         Beam for chan : 0 : 5.16402 arcsec, 2.72039 arcsec, -69.1551 deg
08-Apr-2026 04:23:44 2026-04-08 04:23:33        INFO        tclean::::casa        checkJobs. Blocking for nodes to finish
08-Apr-2026 04:23:44 2026-04-08 04:23:34        INFO        tclean::::casa        ...done
08-Apr-2026 04:23:44 2026-04-08 04:23:34        INFO        tclean::::casa        Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed.
08-Apr-2026 04:23:44 2026-04-08 04:23:34        INFO        tclean::::casa        Searching for images with prefix 'M100cont'... Found these, writing history into them: ['M100cont.psf', 'M100cont.sumwt', 'M100cont.weight', 'M100cont.pb', 'M100cont.model', 'M100cont.residual', 'M100cont.mask', 'M100cont.image']
08-Apr-2026 04:23:44 2026-04-08 04:23:34        INFO        tclean::::casa        Task tclean complete. Start time: 2026-04-08 00:22:35.884577 End time: 2026-04-08 00:23:34.113827
08-Apr-2026 04:23:44 2026-04-08 04:23:34        INFO        tclean::::casa        ##### End Task: tclean               #####
08-Apr-2026 04:23:44 2026-04-08 04:23:34        INFO        tclean::::casa        ##########################################
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa        Step 25: Continuum image of M100
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa        Time now: 1775622214.1141894
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa        Time used this step: 58.2410945892334
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa        Total time used so far: 946.9598195552826
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa        Step  Time used (s)     Fraction of total time (percent) [description]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          0   101.08941125869751  10.675153176633383 [Data import]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          1   0.6594710350036621  0.06964086768891284 [Generate antenna position cal tables]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          2   11.175009489059448  1.1800933110665168 [Generate tsys cal tables]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          3   5.818705797195435  0.6144617413575217 [Correct the Titan position]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          4   10.12402868270874  1.0691085802841405 [Apriori flagging]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          5   33.62792229652405  3.551145634913698 [Generate WVR cal tables]
08-Apr-2026 04:23:44
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          6   37.696974754333496  3.980842056428222 [Generate delay calibration tables]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          7   170.75245428085327  18.031647252049527 [Apply antpos, wvr, tsys, and delay cal tables]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          8   83.92568302154541  8.862644569329154 [Split off non-wvr spws and save flags]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          9   6.8373939990997314  0.722036337540779 [Flagging]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          10   27.743021249771118  2.9296936022903246 [Rebin to a reduced resolution of approx. 10 km/s]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          11   5.490691423416138  0.579823062185966 [Fast phase-only gaincal for bandpass]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          12   20.93693733215332  2.2109636438413895 [Bandpass]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          13   16.140398263931274  1.7044438349571402 [Setjy]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          14   14.846267938613892  1.5677822471481517 [Fast phase-only gaincal]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          15   10.28449010848999  1.0860534835912954 [Slow phase-only gaincal]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          16   11.433034181594849  1.207341002806656 [Slow amp and phase gaincal]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          17   1.5402872562408447  0.16265603085083424 [Fluxscale]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          18   23.161031246185303  2.4458304109526354 [Applycal]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          19   76.53682494163513  8.082373017429488 [Test image of the secondary phase cal]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          20   123.40450620651245  13.031651782698287 [Test image of the primary phase cal]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          21   81.96278214454651  8.655360074626863 [Test image of Titan]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          22   5.490438222885132  0.5797963239309971 [Split off calibrated M100 data]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          23   1.7234079837799072  0.18199378138232572 [Concatenate M100 data]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          24   6.317551851272583  0.6671404341357876 [Average concatenated M100 data in time]
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        TIMING::::casa          25   58.2410945892334  6.150323739880005 [Continuum image of M100]
08-Apr-2026 04:23:44 Step 26: Determine and subtract continuum
08-Apr-2026 04:23:44 2026-04-08 04:23:34        INFO        uvcontsub_old::::casa        ##########################################
08-Apr-2026 04:23:44 2026-04-08 04:23:34        INFO        uvcontsub_old::::casa        ##### Begin Task: uvcontsub_old      #####
08-Apr-2026 04:23:44 2026-04-08 04:23:34        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 )
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        uvcontsub_old::::casa::MPIServer-2        This task is deprecated and will be removed in an upcoming release.
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        uvcontsub_old::::casa::MPIServer-3        This task is deprecated and will be removed in an upcoming release.
08-Apr-2026 04:23:44 2026-04-08 04:23:34        WARN        uvcontsub_old::::casa::MPIServer-1        This task is deprecated and will be removed in an upcoming release.
08-Apr-2026 04:23:44 2026-04-08 04:23:36        WARN        calibrater::setvi(bool,bool)::MPIServer-2        Forcing use of OLD VisibilityIterator.
08-Apr-2026 04:23:44 2026-04-08 04:23:36        WARN        calibrater::setvi(bool,bool)::MPIServer-1        Forcing use of OLD VisibilityIterator.
08-Apr-2026 04:23:44 2026-04-08 04:23:36        WARN        calibrater::setvi(bool,bool)::MPIServer-3        Forcing use of OLD VisibilityIterator.
08-Apr-2026 04:23:44 2026-04-08 04:23:37        WARN        VBContinuumSubtractor::apply::MPIServer-1        Extrapolating to cover [113.728, 115.599] (GHz).
08-Apr-2026 04:23:44 2026-04-08 04:23:37        WARN        VBContinuumSubtractor::apply::MPIServer-1+        The frequency range used for the continuum fit was [113.767, 115.447] (GHz).
08-Apr-2026 04:23:44 2026-04-08 04:23:37        WARN        VBContinuumSubtractor::apply::MPIServer-3        Extrapolating to cover [113.728, 115.599] (GHz).
08-Apr-2026 04:23:44 2026-04-08 04:23:37        WARN        VBContinuumSubtractor::apply::MPIServer-3+        The frequency range used for the continuum fit was [113.767, 115.447] (GHz).
08-Apr-2026 04:23:44 2026-04-08 04:23:38        WARN        VBContinuumSubtractor::apply::MPIServer-2        Extrapolating to cover [113.728, 115.599] (GHz).
08-Apr-2026 04:23:44 2026-04-08 04:23:38        WARN        VBContinuumSubtractor::apply::MPIServer-2+        The frequency range used for the continuum fit was [113.767, 115.447] (GHz).
08-Apr-2026 04:23:44 2026-04-08 04:23:39        WARN        uvcontsub_old::::casa::MPIServer-1        This task is deprecated and will be removed in an upcoming release.
08-Apr-2026 04:23:44 2026-04-08 04:23:39        WARN        uvcontsub_old::::casa::MPIServer-3        This task is deprecated and will be removed in an upcoming release.
08-Apr-2026 04:23:44 2026-04-08 04:23:40        WARN        uvcontsub_old::::casa::MPIServer-2        This task is deprecated and will be removed in an upcoming release.
08-Apr-2026 04:23:44 2026-04-08 04:23:41        WARN        calibrater::setvi(bool,bool)::MPIServer-1        Already using OLD VisibilityIterator.
08-Apr-2026 04:23:44 2026-04-08 04:23:41        WARN        calibrater::setvi(bool,bool)::MPIServer-3        Already using OLD VisibilityIterator.
08-Apr-2026 04:23:44 2026-04-08 04:23:41        WARN        calibrater::setvi(bool,bool)::MPIServer-2        Already using OLD VisibilityIterator.
08-Apr-2026 04:23:44 2026-04-08 04:23:42        WARN        VBContinuumSubtractor::apply::MPIServer-1        Extrapolating to cover [113.728, 115.599] (GHz).
08-Apr-2026 04:23:44 2026-04-08 04:23:42        WARN        VBContinuumSubtractor::apply::MPIServer-1+        The frequency range used for the continuum fit was [113.767, 115.447] (GHz).
08-Apr-2026 04:23:44 2026-04-08 04:23:43        WARN        VBContinuumSubtractor::apply::MPIServer-2        Extrapolating to cover [113.728, 115.599] (GHz).
08-Apr-2026 04:23:44 2026-04-08 04:23:43        WARN        VBContinuumSubtractor::apply::MPIServer-2+        The frequency range used for the continuum fit was [113.767, 115.447] (GHz).
08-Apr-2026 04:23:44 2026-04-08 04:23:43        WARN        VBContinuumSubtractor::apply::MPIServer-3        Extrapolating to cover [113.728, 115.599] (GHz).
08-Apr-2026 04:23:44 2026-04-08 04:23:43        WARN        VBContinuumSubtractor::apply::MPIServer-3+        The frequency range used for the continuum fit was [113.767, 115.447] (GHz).
08-Apr-2026 04:23:45 2026-04-08 04:23:45        INFO        virtualconcat::::casa        ##########################################
08-Apr-2026 04:23:45 2026-04-08 04:23:45        INFO        virtualconcat::::casa        ##### Begin Task: virtualconcat      #####
08-Apr-2026 04:23:45 2026-04-08 04:23:45        INFO        virtualconcat::::casa        virtualconcat( vis=['/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0000.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0001.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0002.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0003.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0004.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0005.ms.contsub'], concatvis='/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms.contsub', freqtol='', dirtol='', respectname=True, visweightscale=[], keepcopy=False, copypointing=False )
08-Apr-2026 04:23:45 2026-04-08 04:23:45        INFO        virtualconcat::::casa        Checking MS setup consistency ...
08-Apr-2026 04:23:45 2026-04-08 04:23:45        INFO        virtualconcat::::casa        Checking for unpopulated POINTING table in first MS ...
08-Apr-2026 04:23:45 2026-04-08 04:23:45        SEVERE        getvarcol::TIME        Exception Reported: TableProxy::getVarColumn: no such row
08-Apr-2026 04:23:45 2026-04-08 04:23:45        WARN        virtualconcat::::casa        Exception in checking POINTING table of first MS. Assuming it is empty.
08-Apr-2026 04:23:45 2026-04-08 04:23:45        INFO        virtualconcat::::casa        Checking for unpopulated optional Main Table columns in first MS ...
08-Apr-2026 04:23:45 2026-04-08 04:23:45        WARN        virtualconcat::::casa        Column WEIGHT_SPECTRUM in table /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0000.ms.contsub has no data. Accessing it will cause errors.
08-Apr-2026 04:23:45 2026-04-08 04:23:45        INFO        virtualconcat::::casa        Checking for unpopulated POINTING table ...
08-Apr-2026 04:23:45 2026-04-08 04:23:45        SEVERE        getvarcol::TIME        Exception Reported: TableProxy::getVarColumn: no such row
08-Apr-2026 04:23:45 2026-04-08 04:23:45        WARN        virtualconcat::::casa        Exception in checking POINTING table of MS /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0001.ms.contsub. Assuming it is empty.
08-Apr-2026 04:23:45 2026-04-08 04:23:45        INFO        virtualconcat::::casa        Checking for unpopulated optional Main Table columns ...
08-Apr-2026 04:23:45 2026-04-08 04:23:45        WARN        virtualconcat::::casa        Column WEIGHT_SPECTRUM in table /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0001.ms.contsub has no data. Accessing it will cause errors.
08-Apr-2026 04:23:45 2026-04-08 04:23:45        SEVERE        virtualconcat::::casa        Task virtualconcat raised an exception of class RuntimeError with the following message: *** Error 'list index out of range' while checking MS setup consistency
08-Apr-2026 04:23:45 2026-04-08 04:23:45        INFO        virtualconcat::::casa        Task virtualconcat complete. Start time: 2026-04-08 00:23:44.978639 End time: 2026-04-08 00:23:45.027028
08-Apr-2026 04:23:45 2026-04-08 04:23:45        INFO        virtualconcat::::casa        ##### End Task: virtualconcat        #####
08-Apr-2026 04:23:45 2026-04-08 04:23:45        INFO        virtualconcat::::casa        ##########################################
08-Apr-2026 04:23:45 2026-04-08 04:23:45        SEVERE        virtualconcat::::casa        Task uvcontsub_old raised an exception of class RuntimeError with the following message: Error concatenating continuum-subtracted sub-MSs ['/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0000.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0001.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0002.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0003.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0004.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0005.ms.contsub']: *** Error 'list index out of range' while checking MS setup consistency
08-Apr-2026 04:23:45 2026-04-08 04:23:45        INFO        uvcontsub_old::::casa        Task uvcontsub_old complete. Start time: 2026-04-08 00:23:34.121474 End time: 2026-04-08 00:23:45.027167
08-Apr-2026 04:23:45 2026-04-08 04:23:45        INFO        uvcontsub_old::::casa        ##### End Task: uvcontsub_old        #####
08-Apr-2026 04:23:45 2026-04-08 04:23:45        INFO        uvcontsub_old::::casa        ##########################################
08-Apr-2026 04:23:45 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa        Exception running regression: Traceback (most recent call last):
08-Apr-2026 04:23:45 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+          File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/pkg/casa-CAS-14606-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/private/task_virtualconcat.py", line 110, in virtualconcat
08-Apr-2026 04:23:45 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+            mydiff = check_mslist(vislist, ignore_tables=['SORTED_TABLE', 'ASDM*'], testcontent=False)
08-Apr-2026 04:23:45 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+                     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
08-Apr-2026 04:23:45 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+          File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/pkg/casa-CAS-14606-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/private/mslisthelper.py", line 224, in check_mslist
08-Apr-2026 04:23:45 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+            cmpres = comptbdescr(subtbdescs_a[i], subtbdescs_b[ subtbnames_b.index(subtbnames_a[i]) ],
08-Apr-2026 04:23:45 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+                                 ~~~~~~~~~~~~^^^
08-Apr-2026 04:23:45 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+        IndexError: list index out of range
08-Apr-2026 04:23:45 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+        
08-Apr-2026 04:23:45 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+        During handling of the above exception, another exception occurred:
08-Apr-2026 04:23:45 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+        
08-Apr-2026 04:23:45 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+        Traceback (most recent call last):
08-Apr-2026 04:23:45 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+          File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/pkg/casa-CAS-14606-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/private/task_uvcontsub_old.py", line 65, in uvcontsub_old
08-Apr-2026 04:23:45 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+            virtualconcat(concatvis=helper._arg['vis'] + ".contsub",vis=contsub_subMS_list,
08-Apr-2026 04:23:45 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+          File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/pkg/casa-CAS-14606-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/virtualconcat.py", line 130, in __call__
08-Apr-2026 04:23:45 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+            task_result = _virtualconcat_t( _pc.document['vis'], _pc.document['concatvis'], _pc.document['freqtol'], _pc.document['dirtol'], _pc.document['respectname'], _pc.document['visweightscale'], _pc.document['keepcopy'], _pc.document['copypointing'] )
08-Apr-2026 04:23:52 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+                          ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
08-Apr-2026 04:23:52 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+          File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/pkg/casa-CAS-14606-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/private/task_virtualconcat.py", line 112, in virtualconcat
08-Apr-2026 04:23:52 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+            raise RuntimeError("*** Error \'%s\' while checking MS setup consistency" % (instance))
08-Apr-2026 04:23:52 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+        RuntimeError: *** Error 'list index out of range' while checking MS setup consistency
08-Apr-2026 04:23:52 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+        
08-Apr-2026 04:23:52 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+        During handling of the above exception, another exception occurred:
08-Apr-2026 04:23:52 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+        
08-Apr-2026 04:23:52 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+        Traceback (most recent call last):
08-Apr-2026 04:23:52 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+          File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/casasources//casa6/casatests/regression/test_regression_alma_M100_if.py", line 902, in test_regression
08-Apr-2026 04:23:52 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+            uvcontsub_old(vis='M100all_lores.ms', field='', fitspw='0:10~205;260~440',
08-Apr-2026 04:23:52 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+          File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/pkg/casa-CAS-14606-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/uvcontsub_old.py", line 143, in __call__
08-Apr-2026 04:23:52 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+            task_result = _uvcontsub_old_t( _pc.document['vis'], _pc.document['field'], _pc.document['fitspw'], _pc.document['excludechans'], _pc.document['combine'], _pc.document['solint'], _pc.document['fitorder'], _pc.document['spw'], _pc.document['want_cont'] )
08-Apr-2026 04:23:52 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+                          ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
08-Apr-2026 04:23:52 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+          File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/pkg/casa-CAS-14606-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/private/task_uvcontsub_old.py", line 68, in uvcontsub_old
08-Apr-2026 04:23:52 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+            raise RuntimeError("Error concatenating continuum-subtracted sub-MSs %s: %s" %
08-Apr-2026 04:23:52 2026-04-08 04:23:45        WARN        uvcontsub_old::::casa+        RuntimeError: Error concatenating continuum-subtracted sub-MSs ['/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0000.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0001.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0002.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0003.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0004.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0005.ms.contsub']: *** Error 'list index out of range' while checking MS setup consistency
08-Apr-2026 04:23:52 F
08-Apr-2026 04:23:52 ======================================================================
08-Apr-2026 04:23:52 FAIL: test_regression (__main__.regression_alma_m100_test.test_regression)
08-Apr-2026 04:23:52 ----------------------------------------------------------------------
08-Apr-2026 04:23:52 Traceback (most recent call last):
08-Apr-2026 04:23:52   File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/pkg/casa-CAS-14606-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/private/task_virtualconcat.py", line 110, in virtualconcat
08-Apr-2026 04:23:52     mydiff = check_mslist(vislist, ignore_tables=['SORTED_TABLE', 'ASDM*'], testcontent=False)
08-Apr-2026 04:23:52              ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
08-Apr-2026 04:23:52   File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/pkg/casa-CAS-14606-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/private/mslisthelper.py", line 224, in check_mslist
08-Apr-2026 04:23:52     cmpres = comptbdescr(subtbdescs_a[i], subtbdescs_b[ subtbnames_b.index(subtbnames_a[i]) ],
08-Apr-2026 04:23:52                          ~~~~~~~~~~~~^^^
08-Apr-2026 04:23:52 IndexError: list index out of range
08-Apr-2026 04:23:52
08-Apr-2026 04:23:52 During handling of the above exception, another exception occurred:
08-Apr-2026 04:23:52
08-Apr-2026 04:23:52 Traceback (most recent call last):
08-Apr-2026 04:23:52   File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/pkg/casa-CAS-14606-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/private/task_uvcontsub_old.py", line 65, in uvcontsub_old
08-Apr-2026 04:23:52     virtualconcat(concatvis=helper._arg['vis'] + ".contsub",vis=contsub_subMS_list,
08-Apr-2026 04:23:52   File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/pkg/casa-CAS-14606-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/virtualconcat.py", line 130, in __call__
08-Apr-2026 04:23:52     task_result = _virtualconcat_t( _pc.document['vis'], _pc.document['concatvis'], _pc.document['freqtol'], _pc.document['dirtol'], _pc.document['respectname'], _pc.document['visweightscale'], _pc.document['keepcopy'], _pc.document['copypointing'] )
08-Apr-2026 04:23:52                   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
08-Apr-2026 04:23:52   File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/pkg/casa-CAS-14606-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/private/task_virtualconcat.py", line 112, in virtualconcat
08-Apr-2026 04:23:52     raise RuntimeError("*** Error \'%s\' while checking MS setup consistency" % (instance))
08-Apr-2026 04:23:52 RuntimeError: *** Error 'list index out of range' while checking MS setup consistency
08-Apr-2026 04:23:52
08-Apr-2026 04:23:52 During handling of the above exception, another exception occurred:
08-Apr-2026 04:23:52
08-Apr-2026 04:23:52 Traceback (most recent call last):
08-Apr-2026 04:23:52   File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/casasources//casa6/casatests/regression/test_regression_alma_M100_if.py", line 902, in test_regression
08-Apr-2026 04:23:52     uvcontsub_old(vis='M100all_lores.ms', field='', fitspw='0:10~205;260~440',
08-Apr-2026 04:23:52   File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/pkg/casa-CAS-14606-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/uvcontsub_old.py", line 143, in __call__
08-Apr-2026 04:23:52     task_result = _uvcontsub_old_t( _pc.document['vis'], _pc.document['field'], _pc.document['fitspw'], _pc.document['excludechans'], _pc.document['combine'], _pc.document['solint'], _pc.document['fitorder'], _pc.document['spw'], _pc.document['want_cont'] )
08-Apr-2026 04:23:52                   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
08-Apr-2026 04:23:52   File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/pkg/casa-CAS-14606-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/private/task_uvcontsub_old.py", line 68, in uvcontsub_old
08-Apr-2026 04:23:52     raise RuntimeError("Error concatenating continuum-subtracted sub-MSs %s: %s" %
08-Apr-2026 04:24:06 RuntimeError: Error concatenating continuum-subtracted sub-MSs ['/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0000.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0001.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0002.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0003.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0004.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0005.ms.contsub']: *** Error 'list index out of range' while checking MS setup consistency
08-Apr-2026 04:24:06
08-Apr-2026 04:24:06 During handling of the above exception, another exception occurred:
08-Apr-2026 04:24:06
08-Apr-2026 04:24:06 Traceback (most recent call last):
08-Apr-2026 04:24:06   File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/casasources//casa6/casatests/regression/test_regression_alma_M100_if.py", line 1169, in test_regression
08-Apr-2026 04:24:06     self.assertTrue(False, msg="Exception running regression: %s" % str(formatted_traceback))
08-Apr-2026 04:24:06 AssertionError: False is not true : Exception running regression: Traceback (most recent call last):
08-Apr-2026 04:24:06   File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/pkg/casa-CAS-14606-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/private/task_virtualconcat.py", line 110, in virtualconcat
08-Apr-2026 04:24:06     mydiff = check_mslist(vislist, ignore_tables=['SORTED_TABLE', 'ASDM*'], testcontent=False)
08-Apr-2026 04:24:06              ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
08-Apr-2026 04:24:06   File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/pkg/casa-CAS-14606-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/private/mslisthelper.py", line 224, in check_mslist
08-Apr-2026 04:24:06     cmpres = comptbdescr(subtbdescs_a[i], subtbdescs_b[ subtbnames_b.index(subtbnames_a[i]) ],
08-Apr-2026 04:24:06                          ~~~~~~~~~~~~^^^
08-Apr-2026 04:24:06 IndexError: list index out of range
08-Apr-2026 04:24:06
08-Apr-2026 04:24:06 During handling of the above exception, another exception occurred:
08-Apr-2026 04:24:06
08-Apr-2026 04:24:06 Traceback (most recent call last):
08-Apr-2026 04:24:06   File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/pkg/casa-CAS-14606-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/private/task_uvcontsub_old.py", line 65, in uvcontsub_old
08-Apr-2026 04:24:06     virtualconcat(concatvis=helper._arg['vis'] + ".contsub",vis=contsub_subMS_list,
08-Apr-2026 04:24:06   File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/pkg/casa-CAS-14606-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/virtualconcat.py", line 130, in __call__
08-Apr-2026 04:24:06     task_result = _virtualconcat_t( _pc.document['vis'], _pc.document['concatvis'], _pc.document['freqtol'], _pc.document['dirtol'], _pc.document['respectname'], _pc.document['visweightscale'], _pc.document['keepcopy'], _pc.document['copypointing'] )
08-Apr-2026 04:24:06                   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
08-Apr-2026 04:24:06   File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/pkg/casa-CAS-14606-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/private/task_virtualconcat.py", line 112, in virtualconcat
08-Apr-2026 04:24:06     raise RuntimeError("*** Error \'%s\' while checking MS setup consistency" % (instance))
08-Apr-2026 04:24:06 RuntimeError: *** Error 'list index out of range' while checking MS setup consistency
08-Apr-2026 04:24:06
08-Apr-2026 04:24:06 During handling of the above exception, another exception occurred:
08-Apr-2026 04:24:06
08-Apr-2026 04:24:06 Traceback (most recent call last):
08-Apr-2026 04:24:06   File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/casasources//casa6/casatests/regression/test_regression_alma_M100_if.py", line 902, in test_regression
08-Apr-2026 04:24:06     uvcontsub_old(vis='M100all_lores.ms', field='', fitspw='0:10~205;260~440',
08-Apr-2026 04:24:06   File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/pkg/casa-CAS-14606-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/uvcontsub_old.py", line 143, in __call__
08-Apr-2026 04:24:06     task_result = _uvcontsub_old_t( _pc.document['vis'], _pc.document['field'], _pc.document['fitspw'], _pc.document['excludechans'], _pc.document['combine'], _pc.document['solint'], _pc.document['fitorder'], _pc.document['spw'], _pc.document['want_cont'] )
08-Apr-2026 04:24:06                   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
08-Apr-2026 04:24:06   File "/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/pkg/casa-CAS-14606-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/private/task_uvcontsub_old.py", line 68, in uvcontsub_old
08-Apr-2026 04:24:06     raise RuntimeError("Error concatenating continuum-subtracted sub-MSs %s: %s" %
08-Apr-2026 04:24:06 RuntimeError: Error concatenating continuum-subtracted sub-MSs ['/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0000.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0001.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0002.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0003.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0004.ms.contsub', '/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228/work/test_regression_alma_M100_if/M100all_lores.ms/SUBMSS/M100all_lores.ms.0005.ms.contsub']: *** Error 'list index out of range' while checking MS setup consistency
08-Apr-2026 04:24:06
08-Apr-2026 04:24:06
08-Apr-2026 04:24:06 ----------------------------------------------------------------------
08-Apr-2026 04:24:06 Ran 1 test in 964.890s
08-Apr-2026 04:24:06
08-Apr-2026 04:24:06 FAILED (failures=1)
08-Apr-2026 04:24:06 CASA exits with a non-zero status : system exit called
08-Apr-2026 04:24:06 2026-04-08 04:23:52        INFO        uvcontsub_old::::casa        Terminating casaplotms, PID: 1258958
08-Apr-2026 04:24:06 2026-04-08 04:23:52        INFO        uvcontsub_old::::casa        Waiting for casaplotms to terminate. Poll return code: None, PID: 1258958
08-Apr-2026 04:24:06 2026-04-08 04:23:53        INFO        uvcontsub_old::::casa        Finished shutting down casaplotms. Poll return code: -15, PID: 1258958
08-Apr-2026 04:24:06 Executor result: 1
08-Apr-2026 04:24:06 Failed tests:['test_regression', 'Executor returned a non-zero exit code']
08-Apr-2026 04:24:06
08-Apr-2026 04:24:06 Results: [{'testname': 'test_regression_alma_M100_if', 'runtime': '0:16:23.003103', 'returncode': 2, 'testerr': ['test_regression', 'Executor returned a non-zero exit code']}]
08-Apr-2026 04:24:06 Stopping Xvfb.
08-Apr-2026 04:24:06 Stopping framebuffer <subprocess.Popen object at 0x7fbdb3ea9eb8>
08-Apr-2026 04:24:06 Virtual frame buffer deployed at :1258411 with pid 1258463 successfully shutdown
08-Apr-2026 04:24:06 Xvfb stopped.
08-Apr-2026 04:24:06 Finished task 'Test' with result: Success
08-Apr-2026 04:24:06 Starting task 'Parse test results' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
08-Apr-2026 04:24:06 Parsing test results under /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-DEVVERCASALITHPY31228-CCM228...
08-Apr-2026 04:24:06 Failing task since 1 failing test cases were found.
08-Apr-2026 04:24:06 Finished task 'Parse test results' with result: Failed
08-Apr-2026 04:24:06 Running post build plugin 'Docker Container Cleanup'
08-Apr-2026 04:24:06 Running post build plugin 'NCover Results Collector'
08-Apr-2026 04:24:06 Running post build plugin 'Build Results Label Collector'
08-Apr-2026 04:24:06 Running post build plugin 'Clover Results Collector'
08-Apr-2026 04:24:06 Running post build plugin 'npm Cache Cleanup'
08-Apr-2026 04:24:06 Running post build plugin 'Artifact Copier'
08-Apr-2026 04:24:06 Finalising the build...
08-Apr-2026 04:24:06 Stopping timer.
08-Apr-2026 04:24:06 Build CASASPECS-DEVVERCASALITHPY31228-CCM228-4 completed.
08-Apr-2026 00:24:06 Running on server: post build plugin 'Build Hanging Detection Configuration'
08-Apr-2026 00:24:06 Running on server: post build plugin 'NCover Results Collector'
08-Apr-2026 00:24:06 Running on server: post build plugin 'Build Labeller'
08-Apr-2026 00:24:06 Running on server: post build plugin 'Clover Delta Calculator'
08-Apr-2026 00:24:06 Running on server: post build plugin 'Maven Dependencies Postprocessor'
08-Apr-2026 00:24:06 All post build plugins have finished
08-Apr-2026 00:24:06 Generating build results summary...
08-Apr-2026 00:24:06 Saving build results to disk...
08-Apr-2026 00:24:06 Store variable context...
08-Apr-2026 00:24:06 Finished building CASASPECS-DEVVERCASALITHPY31228-CCM228-4.