Build log

The build generated 105,754 lines of output. The output is too long and has been truncated to the last 1,000 lines. Download or view full build log. You can find logs from previous runs here.

16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::initializeToSky[R&D]::MPIServer-1 Computed maps using FTMachine::initMaps. polMap = [0, 0]
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-1 Computing Phase Grad for Field : 1 for spw :0
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-3 Computing Phase Grad for Field : 1 for spw :0
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-2 Computing Phase Grad for Field : 1 for spw :0
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-1 Computing Phase Grad for Field : 0 for spw :1
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-3 Computing Phase Grad for Field : 0 for spw :1
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-2 Computing Phase Grad for Field : 0 for spw :1
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-1 Computing Phase Grad for Field : 1 for spw :1
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-3 Computing Phase Grad for Field : 1 for spw :1
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-2 Computing Phase Grad for Field : 1 for spw :1
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-1 Computing Phase Grad for Field : 0 for spw :2
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-3 Computing Phase Grad for Field : 0 for spw :2
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-2 Computing Phase Grad for Field : 0 for spw :2
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-1 Computing Phase Grad for Field : 1 for spw :2
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-3 Computing Phase Grad for Field : 1 for spw :2
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-2 Computing Phase Grad for Field : 1 for spw :2
16-Jul-2026 02:32:01	2026-07-16 02:32:01 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToVis::MPIServer-1 Time degrid 0.05
16-Jul-2026 02:32:01	2026-07-16 02:32:01 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToVis::MPIServer-1 Time degrid 0.02
16-Jul-2026 02:32:01	2026-07-16 02:32:01 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-1 time to massage data 0.02
16-Jul-2026 02:32:01	2026-07-16 02:32:01 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-1 time gridding 0.02
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-1 Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order)
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-1+ [8830.19]
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-1+ (3.4511,0.0279434) (0,0)
16-Jul-2026 02:32:01	2026-07-16 02:32:01 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToVis::MPIServer-3 Time degrid 0.01
16-Jul-2026 02:32:01	2026-07-16 02:32:01 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToVis::MPIServer-3 Time degrid 0
16-Jul-2026 02:32:01	2026-07-16 02:32:01 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-3 time to massage data 0.04
16-Jul-2026 02:32:01	2026-07-16 02:32:01 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-3 time gridding 0.07
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-3 Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order)
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-3+ [8583.62]
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-3+ (3.59508,0.106853) (0,0)
16-Jul-2026 02:32:01	2026-07-16 02:32:01 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToVis::MPIServer-2 Time degrid 0.06
16-Jul-2026 02:32:01	2026-07-16 02:32:01 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToVis::MPIServer-2 Time degrid 0
16-Jul-2026 02:32:01	2026-07-16 02:32:01 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-2 time to massage data 0.04
16-Jul-2026 02:32:01	2026-07-16 02:32:01 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-2 time gridding 0.02
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-2 Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order)
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-2+ [8838.74]
16-Jul-2026 02:32:01	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-2+ (3.56724,0.306496) (0,0)
16-Jul-2026 02:32:01	2026-07-16 02:32:01 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-3 time to massage data 0.07
16-Jul-2026 02:32:01	2026-07-16 02:32:01 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-3 time gridding 0.03
16-Jul-2026 02:32:01	2026-07-16 02:32:01 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-2 time to massage data 0.06
16-Jul-2026 02:32:01	2026-07-16 02:32:01 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-2 time gridding 0.02
16-Jul-2026 02:32:03	2026-07-16 02:32:01 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-1 time to massage data 0.04
16-Jul-2026 02:32:03	2026-07-16 02:32:01 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-1 time gridding 0.02
16-Jul-2026 02:32:03	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-3 Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order)
16-Jul-2026 02:32:03	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-3+ [-7.52245]
16-Jul-2026 02:32:03	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-3+ (-0.292433,-0.00438546) (0,0)
16-Jul-2026 02:32:03	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-2 Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order)
16-Jul-2026 02:32:03	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-2+ [-9.40991]
16-Jul-2026 02:32:03	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-2+ (0.304552,0.0255159) (0,0)
16-Jul-2026 02:32:03	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-1 Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order)
16-Jul-2026 02:32:03	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-1+ [-8.47029]
16-Jul-2026 02:32:03	2026-07-16 02:32:01 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-1+ (0.293379,-0.0470373) (0,0)
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO tclean::::casa ...done
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst.workdirectory/tst.n1, /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n2, /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n3] onto :tst
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.136884, over full image : 0.136884
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 9, 'cyclethreshold': 0.01715674437582493, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO SDAlgorithmBase::deconvolve [tst] Run mtmfs minor-cycle \| CycleThreshold=0.0171567, CycleNiter=9, Gain=0.1
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO SIImageStoreMultiTerm::calcFractionalBandwidth MFS frequency range : 1.04999 GHz -> 1.94998GHz.Fractional Bandwidth : 60.0001 %.Reference Frequency for Taylor Expansion : 1.49998GHz.
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO MultiTermMatrixCleaner::mtclean() Calculating convolutions of residual images with scales
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO MultiTermMatrixCleaner::mtclean() Peak convolved residual (within mask) : 0.136884
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO MultiTermMatrixCleaner::mtclean() Reached max number of iterations for this minor cycle
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO MultiTermMatrixCleaner::mtclean() Total flux by scale : [0]: 0.910652 (in this run)
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO MultiTermMatrixCleaner::mtclean() Total flux by Taylor coefficient : [0]: 0.910652 [1]: 0.0487354
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO SDAlgorithmBase::deconvolve [tst] iters=0->9 [9], model=0.8268->0.910652, peakres=0.136884->0.0530315, Reached cycleniter.
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 30 iterations.
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : tst to all nodes :[/home/casatest/work/test_task_tclean/tst.workdirectory/tst.n1, /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n2, /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n3]
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst.model.tt0 to /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n1.model.tt0
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst.model.tt1 to /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n1.model.tt1
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst.model.tt0 to /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n2.model.tt0
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst.model.tt1 to /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n2.model.tt1
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst.model.tt0 to /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n3.model.tt0
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst.model.tt1 to /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n3.model.tt1
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ----------------------------
16-Jul-2026 02:32:03	2026-07-16 02:32:02 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 3 -------------------------------------
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 3 -------------------------------------
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 3 -------------------------------------
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::init[R&D]::MPIServer-1 Using CPUResampler visibility resampler (a.k.a. "gridder/degridder")
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-1 Computing Phase Grad for Field : 0 for spw :0
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::init[R&D]::MPIServer-2 Using CPUResampler visibility resampler (a.k.a. "gridder/degridder")
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::init[R&D]::MPIServer-3 Using CPUResampler visibility resampler (a.k.a. "gridder/degridder")
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-2 Computing Phase Grad for Field : 0 for spw :0
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-3 Computing Phase Grad for Field : 0 for spw :0
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::init[R&D]::MPIServer-3 Using CPUResampler visibility resampler (a.k.a. "gridder/degridder")
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::init[R&D]::MPIServer-2 Using CPUResampler visibility resampler (a.k.a. "gridder/degridder")
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::init[R&D]::MPIServer-1 Using CPUResampler visibility resampler (a.k.a. "gridder/degridder")
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::init[R&D]::MPIServer-3 Using CPUResampler visibility resampler (a.k.a. "gridder/degridder")
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::initializeToSky[R&D]::MPIServer-3 Computed maps using FTMachine::initMaps. polMap = [0, 0]
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::init[R&D]::MPIServer-3 Using CPUResampler visibility resampler (a.k.a. "gridder/degridder")
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::initializeToSky[R&D]::MPIServer-3 Computed maps using FTMachine::initMaps. polMap = [0, 0]
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::init[R&D]::MPIServer-2 Using CPUResampler visibility resampler (a.k.a. "gridder/degridder")
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::initializeToSky[R&D]::MPIServer-2 Computed maps using FTMachine::initMaps. polMap = [0, 0]
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::init[R&D]::MPIServer-2 Using CPUResampler visibility resampler (a.k.a. "gridder/degridder")
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::initializeToSky[R&D]::MPIServer-2 Computed maps using FTMachine::initMaps. polMap = [0, 0]
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::init[R&D]::MPIServer-1 Using CPUResampler visibility resampler (a.k.a. "gridder/degridder")
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::initializeToSky[R&D]::MPIServer-1 Computed maps using FTMachine::initMaps. polMap = [0, 0]
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::init[R&D]::MPIServer-1 Using CPUResampler visibility resampler (a.k.a. "gridder/degridder")
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::initializeToSky[R&D]::MPIServer-1 Computed maps using FTMachine::initMaps. polMap = [0, 0]
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-3 Computing Phase Grad for Field : 1 for spw :0
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-2 Computing Phase Grad for Field : 1 for spw :0
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-1 Computing Phase Grad for Field : 1 for spw :0
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-3 Computing Phase Grad for Field : 0 for spw :1
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-2 Computing Phase Grad for Field : 0 for spw :1
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-1 Computing Phase Grad for Field : 0 for spw :1
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-3 Computing Phase Grad for Field : 1 for spw :1
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-2 Computing Phase Grad for Field : 1 for spw :1
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-1 Computing Phase Grad for Field : 1 for spw :1
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-3 Computing Phase Grad for Field : 0 for spw :2
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-2 Computing Phase Grad for Field : 0 for spw :2
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-1 Computing Phase Grad for Field : 0 for spw :2
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-3 Computing Phase Grad for Field : 1 for spw :2
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-2 Computing Phase Grad for Field : 1 for spw :2
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-1 Computing Phase Grad for Field : 1 for spw :2
16-Jul-2026 02:32:03	2026-07-16 02:32:03 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToVis::MPIServer-3 Time degrid 0.05
16-Jul-2026 02:32:03	2026-07-16 02:32:03 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToVis::MPIServer-3 Time degrid 0
16-Jul-2026 02:32:03	2026-07-16 02:32:03 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-3 time to massage data 0.02
16-Jul-2026 02:32:03	2026-07-16 02:32:03 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-3 time gridding 0.01
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-3 Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order)
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-3+ [8583.62]
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-3+ (1.4466,0.0436851) (0,0)
16-Jul-2026 02:32:03	2026-07-16 02:32:03 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToVis::MPIServer-2 Time degrid 0.03
16-Jul-2026 02:32:03	2026-07-16 02:32:03 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToVis::MPIServer-2 Time degrid 0.02
16-Jul-2026 02:32:03	2026-07-16 02:32:03 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-2 time to massage data 0.04
16-Jul-2026 02:32:03	2026-07-16 02:32:03 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-2 time gridding 0.03
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-2 Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order)
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-2+ [8838.74]
16-Jul-2026 02:32:03	2026-07-16 02:32:03 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-2+ (1.39209,0.1612) (0,0)
16-Jul-2026 02:32:03	2026-07-16 02:32:04 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToVis::MPIServer-1 Time degrid 0.06
16-Jul-2026 02:32:03	2026-07-16 02:32:04 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToVis::MPIServer-1 Time degrid 0.01
16-Jul-2026 02:32:03	2026-07-16 02:32:04 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-1 time to massage data 0.03
16-Jul-2026 02:32:03	2026-07-16 02:32:04 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-1 time gridding 0.06
16-Jul-2026 02:32:03	2026-07-16 02:32:04 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-1 Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order)
16-Jul-2026 02:32:03	2026-07-16 02:32:04 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-1+ [8830.19]
16-Jul-2026 02:32:03	2026-07-16 02:32:04 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-1+ (1.40218,-0.00878298) (0,0)
16-Jul-2026 02:32:03	2026-07-16 02:32:04 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-3 time to massage data 0.03
16-Jul-2026 02:32:03	2026-07-16 02:32:04 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-3 time gridding 0
16-Jul-2026 02:32:03	2026-07-16 02:32:04 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-3 Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order)
16-Jul-2026 02:32:03	2026-07-16 02:32:04 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-3+ [-7.52245]
16-Jul-2026 02:32:03	2026-07-16 02:32:04 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-3+ (-0.121316,-0.00236836) (0,0)
16-Jul-2026 02:32:03	2026-07-16 02:32:04 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-2 time to massage data 0.05
16-Jul-2026 02:32:03	2026-07-16 02:32:04 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-2 time gridding 0.03
16-Jul-2026 02:32:26	2026-07-16 02:32:04 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-2 Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order)
16-Jul-2026 02:32:26	2026-07-16 02:32:04 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-2+ [-9.40991]
16-Jul-2026 02:32:26	2026-07-16 02:32:04 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-2+ (0.114296,-0.0141075) (0,0)
16-Jul-2026 02:32:26	2026-07-16 02:32:04 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-1 time to massage data 0.05
16-Jul-2026 02:32:26	2026-07-16 02:32:04 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-1 time gridding 0.02
16-Jul-2026 02:32:26	2026-07-16 02:32:04 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-1 Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order)
16-Jul-2026 02:32:26	2026-07-16 02:32:04 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-1+ [-8.47029]
16-Jul-2026 02:32:26	2026-07-16 02:32:04 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-1+ (0.11933,-0.0197206) (0,0)
16-Jul-2026 02:32:26	2026-07-16 02:32:04 INFO tclean::::casa ...done
16-Jul-2026 02:32:26	2026-07-16 02:32:04 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst.workdirectory/tst.n1, /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n2, /home/casatest/work/test_task_tclean/tst.workdirectory/tst.n3] onto :tst
16-Jul-2026 02:32:26	2026-07-16 02:32:05 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.0555074, over full image : 0.0555074
16-Jul-2026 02:32:26	2026-07-16 02:32:05 INFO tclean::::casa Reached global stopping criterion : iteration limit
16-Jul-2026 02:32:26	2026-07-16 02:32:05 INFO tclean::::casa getSummary call: fullsummary=False
16-Jul-2026 02:32:26	2026-07-16 02:32:05 INFO MultiTermMatrixCleaner::computeprincipalsolution() MTMC :: Computing principal solution on residuals
16-Jul-2026 02:32:26	2026-07-16 02:32:05 INFO SDAlgorithmBase::restore [tst] : Restoring model image.
16-Jul-2026 02:32:26	2026-07-16 02:32:05 INFO SIImageStore::restore Beam for chan : 0 : 139.82 arcsec, 129.968 arcsec, -86.7085 deg
16-Jul-2026 02:32:26	2026-07-16 02:32:05 INFO SIImageStore::restore Beam for chan : 0 : 139.82 arcsec, 129.968 arcsec, -86.7085 deg
16-Jul-2026 02:32:26	2026-07-16 02:32:05 INFO SIImageStoreMultiTerm::calculateAlphaBeta Calculating spectral parameters for Intensity > peakresidual/10 = 0.00555074 Jy/beam
16-Jul-2026 02:32:26	2026-07-16 02:32:05 INFO SIImageStoreMultiTerm::calculateAlphaBeta Written Spectral Index Error Image : /home/casatest/work/test_task_tclean/tst.alpha.error
16-Jul-2026 02:32:26	2026-07-16 02:32:05 INFO SDAlgorithmMSMFS::restore Restored images :
16-Jul-2026 02:32:26	2026-07-16 02:32:05 INFO SDAlgorithmMSMFS::restore /home/casatest/work/test_task_tclean/tst.image.tt0 (model=/home/casatest/work/test_task_tclean/tst.model.tt0)
16-Jul-2026 02:32:26	2026-07-16 02:32:05 INFO SDAlgorithmMSMFS::restore /home/casatest/work/test_task_tclean/tst.image.tt1 (model=/home/casatest/work/test_task_tclean/tst.model.tt1)
16-Jul-2026 02:32:26	2026-07-16 02:32:05 INFO SDAlgorithmMSMFS::restore
16-Jul-2026 02:32:26	2026-07-16 02:32:05 INFO MPICommandServer::command_request_handler_service::VB2CFBMap::~VB2CFMap[R&D]::MPIServer-3 Total extra cost of heterogeneous array pointing correction = 0.13sec. Total VBs processed = 72791. The pointingoffsetsigdev used was = []
16-Jul-2026 02:32:26	2026-07-16 02:32:05 INFO MPICommandServer::command_request_handler_service::VB2CFBMap::~VB2CFMap[R&D]::MPIServer-2 Total extra cost of heterogeneous array pointing correction = 0.09sec. Total VBs processed = 72852. The pointingoffsetsigdev used was = []
16-Jul-2026 02:32:26	2026-07-16 02:32:05 INFO MPICommandServer::command_request_handler_service::VB2CFBMap::~VB2CFMap[R&D]::MPIServer-1 Total extra cost of heterogeneous array pointing correction = 0.16sec. Total VBs processed = 72865. The pointingoffsetsigdev used was = []
16-Jul-2026 02:32:26	2026-07-16 02:32:23 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:32:26	2026-07-16 02:32:23 INFO ::casa::MPIServer-3 node 3 has completed its job
16-Jul-2026 02:32:26	2026-07-16 02:32:23 INFO ::casa::MPIServer-2 node 2 has completed its job
16-Jul-2026 02:32:26	2026-07-16 02:32:23 INFO ::casa::MPIServer-1 node 1 has completed its job
16-Jul-2026 02:32:26	2026-07-16 02:32:24 INFO tclean::::casa ...done
16-Jul-2026 02:32:26	2026-07-16 02:32:24 INFO tclean::::casa Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed.
16-Jul-2026 02:32:26	2026-07-16 02:32:24 INFO tclean::::casa Searching for images with prefix 'tst'... Found these, writing history into them: ['tst.residual.tt0', 'tst.psf.tt0', 'tst.sumwt.tt0', 'tst.psf.tt1', 'tst.sumwt.tt1', 'tst.psf.tt2', 'tst.sumwt.tt2', 'tst.weight.tt0', 'tst.weight.tt1', 'tst.weight.tt2', 'tst.pb.tt0', 'tst.model.tt0', 'tst.model.tt1', 'tst.residual.tt1', 'tst.mask', 'tst.image.tt0', 'tst.image.tt1', 'tst.alpha', 'tst.alpha.error']
16-Jul-2026 02:32:26	2026-07-16 02:32:24 INFO tclean::::casa Task tclean complete. Start time: 2026-07-16 02:30:20.264733 End time: 2026-07-16 02:32:24.499174
16-Jul-2026 02:32:26	2026-07-16 02:32:24 INFO tclean::::casa ##### End Task: tclean #####
16-Jul-2026 02:32:26	2026-07-16 02:32:24 INFO tclean::::casa ##########################################
16-Jul-2026 02:32:26	2026-07-16 02:32:25 INFO name:: No table opened.
16-Jul-2026 02:32:26	2026-07-16 02:32:25 INFO showcache:: The Table Cache is empty.
16-Jul-2026 02:32:26	2026-07-16 02:32:25 INFO tclean::::casa [ checkall ]
16-Jul-2026 02:32:26	2026-07-16 02:32:25 INFO tclean::::casa+ [ check_ims ] Image made : ['tst.image.tt0', 'tst.psf.tt0', 'tst.weight.tt0'] = [True, True, True] ( Pass : should all be True )
16-Jul-2026 02:32:26	2026-07-16 02:32:25 INFO tclean::::casa+ All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords)
16-Jul-2026 02:32:26	2026-07-16 02:32:25 INFO tclean::::casa+ [check_history] All expected history entries found. (Pass)
16-Jul-2026 02:32:26	2026-07-16 02:32:25 INFO tclean::::casa+ [ check_pix_val ] tst.image.tt0 : Value is 0.9574441313743591 at [256, 256, 0, 0] ( Pass : should be 0.96 , Epsilon: 0.05)
16-Jul-2026 02:32:26	2026-07-16 02:32:25 INFO tclean::::casa+ [ check_pix_val ] tst.weight.tt0 : Value is 0.48626992106437683 at [256, 256, 0, 0] ( Pass : should be 0.486 , Epsilon: 0.05)
16-Jul-2026 02:32:26	2026-07-16 02:32:25 INFO tclean::::casa+ [ check_pix_val ] tst.alpha : Value is -0.004446303006261587 at [256, 256, 0, 0] ( Pass : should be 0.0 , Epsilon: 0.05)
16-Jul-2026 02:32:26	.2026-07-16 02:32:25 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 3
16-Jul-2026 02:32:26	2026-07-16 02:32:25 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 2
16-Jul-2026 02:32:26	2026-07-16 02:32:25 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 1
16-Jul-2026 02:32:26	2026-07-16 02:32:26 INFO tclean::::casa setupCluster, Setting up 3 engines.
16-Jul-2026 02:32:26	2026-07-16 02:32:26 INFO tclean::::casa ##########################################
16-Jul-2026 02:32:26	2026-07-16 02:32:26 INFO tclean::::casa ##### Begin Task: tclean #####
16-Jul-2026 02:32:32	2026-07-16 02:32:26 INFO tclean::::casa tclean( vis='vla_wideband_2ptg_w_squint.ms', selectdata=True, field='1', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst.awp2', imsize=1200, cell='1.6arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='awp2', facets=1, psfphasecenter='', wprojplanes=6, vptable='', mosweight=True, aterm=True, psterm=False, wbawp=True, conjbeams=False, cfcache='', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=-0.1, normtype='flatnoise', deconvolver='hogbom', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=True, outlierfile='', weighting='uniform', robust=0.5, noise='1.0Jy', npixels=0, uvtaper=[''], niter=20, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='none', calcres=True, calcpsf=True, psfcutoff=0.35, parallel=True )
16-Jul-2026 02:32:32	2026-07-16 02:32:26 INFO tclean::::casa Verifying Input Parameters
16-Jul-2026 02:32:32	2026-07-16 02:32:28 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 3
16-Jul-2026 02:32:32	2026-07-16 02:32:28 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 2
16-Jul-2026 02:32:32	2026-07-16 02:32:28 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 1
16-Jul-2026 02:32:32	2026-07-16 02:32:29 INFO tclean::::casa setupCluster, Setting up 3 engines.
16-Jul-2026 02:32:32	2026-07-16 02:32:29 INFO SynthesisUtilMethods::continuumDataPartition
16-Jul-2026 02:32:32	2026-07-16 02:32:29 INFO SynthesisUtilMethods::continuumDataPartition + Rows = 4683 7020 [P][M]: 0:2 ROWNUMBER() >= 4683 && ROWNUMBER() <= 7020
16-Jul-2026 02:32:32	2026-07-16 02:32:29 INFO tclean::::casa Partitioned Selection : {'0': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '1', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'vla_wideband_2ptg_w_squint.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 1 && ROWNUMBER() <= 2341', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '1': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '1', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'vla_wideband_2ptg_w_squint.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 2342 && ROWNUMBER() <= 4682', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '2': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '1', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'vla_wideband_2ptg_w_squint.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 4683 && ROWNUMBER() <= 7020', 'timestr': '', 'usescratch': False, 'uvdist': ''}}}
16-Jul-2026 02:32:32	2026-07-16 02:32:29 INFO SynthesisImagerVi2::selectData MS : vla_wideband_2ptg_w_squint.ms \| Selecting on fields : 1 \| [Opened in readonly mode]
16-Jul-2026 02:32:32	2026-07-16 02:32:29 INFO SynthesisImagerVi2::selectData NRows selected : 7020
16-Jul-2026 02:32:32	2026-07-16 02:32:29 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.awp2] :
16-Jul-2026 02:32:32	2026-07-16 02:32:29 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.awp2] :
16-Jul-2026 02:32:32	2026-07-16 02:32:29 INFO SynthesisImagerVi2::defineImage Impars: start
16-Jul-2026 02:32:32	2026-07-16 02:32:29 INFO SynthesisImagerVi2::defineImage Shape: [1200, 1200, 1, 1] Spectral: [1.48111e+09] at [0] with increment [5.99947e+08]
16-Jul-2026 02:32:32	2026-07-16 02:32:29 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst.awp2] with ftmachine : awp2
16-Jul-2026 02:32:32	2026-07-16 02:32:29 INFO SynthesisImager::getVPRecord Using default Voltage Patterns from the VPManager
16-Jul-2026 02:32:32	2026-07-16 02:32:29 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.6798 GB. Available mem.: 395.2 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
16-Jul-2026 02:32:32	2026-07-16 02:32:29 INFO SynthesisImagerVi2::weight() Set imaging weights : Uniform weighting: sidelobes will be suppressed over full image
16-Jul-2026 02:32:32	2026-07-16 02:32:30 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:32:32	2026-07-16 02:32:31 INFO tclean::::casa ...done
16-Jul-2026 02:32:32	2026-07-16 02:32:31 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:32:32	2026-07-16 02:32:31 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 MS : vla_wideband_2ptg_w_squint.ms \| Selecting on fields : 1 \| [Opened in readonly mode]
16-Jul-2026 02:32:32	2026-07-16 02:32:31 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 Selecting via TaQL : ROWNUMBER() >= 2342 && ROWNUMBER() <= 4682 \| NRows selected : 2341
16-Jul-2026 02:32:32	2026-07-16 02:32:31 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 MS : vla_wideband_2ptg_w_squint.ms \| Selecting on fields : 1 \| [Opened in readonly mode]
16-Jul-2026 02:32:32	2026-07-16 02:32:31 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 Selecting via TaQL : ROWNUMBER() >= 1 && ROWNUMBER() <= 2341 \| NRows selected : 2341
16-Jul-2026 02:32:32	2026-07-16 02:32:31 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 MS : vla_wideband_2ptg_w_squint.ms \| Selecting on fields : 1 \| [Opened in readonly mode]
16-Jul-2026 02:32:32	2026-07-16 02:32:31 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 Selecting via TaQL : ROWNUMBER() >= 4683 && ROWNUMBER() <= 7020 \| NRows selected : 2338
16-Jul-2026 02:32:32	2026-07-16 02:32:32 INFO tclean::::casa ...done
16-Jul-2026 02:32:32	2026-07-16 02:32:32 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n1] :
16-Jul-2026 02:32:32	2026-07-16 02:32:32 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n1] :
16-Jul-2026 02:32:32	2026-07-16 02:32:32 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Impars: start
16-Jul-2026 02:32:32	2026-07-16 02:32:32 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Shape: [1200, 1200, 1, 1] Spectral: [1.48111e+09] at [0] with increment [5.99947e+08]
16-Jul-2026 02:32:32	2026-07-16 02:32:32 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Set Gridding options for [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n1] with ftmachine : awp2
16-Jul-2026 02:32:32	2026-07-16 02:32:32 INFO MPICommandServer::command_request_handler_service::SynthesisImager::getVPRecord::MPIServer-1 Using default Voltage Patterns from the VPManager
16-Jul-2026 02:32:32	2026-07-16 02:32:32 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-1 Required memory: 0.6798 GB. Available mem.: 395.2 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
16-Jul-2026 02:32:32	2026-07-16 02:32:32 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n2] :
16-Jul-2026 02:33:47	2026-07-16 02:32:32 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n2] :
16-Jul-2026 02:33:47	2026-07-16 02:32:32 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Impars: start
16-Jul-2026 02:33:47	2026-07-16 02:32:32 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Shape: [1200, 1200, 1, 1] Spectral: [1.48111e+09] at [0] with increment [5.99947e+08]
16-Jul-2026 02:33:47	2026-07-16 02:32:32 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Set Gridding options for [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n2] with ftmachine : awp2
16-Jul-2026 02:33:47	2026-07-16 02:32:32 INFO MPICommandServer::command_request_handler_service::SynthesisImager::getVPRecord::MPIServer-2 Using default Voltage Patterns from the VPManager
16-Jul-2026 02:33:47	2026-07-16 02:32:32 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-2 Required memory: 0.6798 GB. Available mem.: 395.2 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
16-Jul-2026 02:33:47	2026-07-16 02:32:33 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:33:47	2026-07-16 02:32:33 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n3] :
16-Jul-2026 02:33:47	2026-07-16 02:32:33 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n3] :
16-Jul-2026 02:33:47	2026-07-16 02:32:33 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Impars: start
16-Jul-2026 02:33:47	2026-07-16 02:32:33 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Shape: [1200, 1200, 1, 1] Spectral: [1.48111e+09] at [0] with increment [5.99947e+08]
16-Jul-2026 02:33:47	2026-07-16 02:32:33 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Set Gridding options for [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n3] with ftmachine : awp2
16-Jul-2026 02:33:47	2026-07-16 02:32:33 INFO MPICommandServer::command_request_handler_service::SynthesisImager::getVPRecord::MPIServer-3 Using default Voltage Patterns from the VPManager
16-Jul-2026 02:33:47	2026-07-16 02:32:33 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-3 Required memory: 0.6798 GB. Available mem.: 395.2 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
16-Jul-2026 02:33:47	2026-07-16 02:32:34 INFO tclean::::casa ...done
16-Jul-2026 02:33:47	2026-07-16 02:32:36 INFO SynthesisImagerVi2::selectData MS : vla_wideband_2ptg_w_squint.ms \| Selecting on fields : 1 \| [Opened in readonly mode]
16-Jul-2026 02:33:47	2026-07-16 02:32:36 INFO SynthesisImagerVi2::selectData NRows selected : 7020
16-Jul-2026 02:33:47	2026-07-16 02:32:36 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.awp2] :
16-Jul-2026 02:33:47	2026-07-16 02:32:36 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.awp2] :
16-Jul-2026 02:33:47	2026-07-16 02:32:36 INFO SynthesisImagerVi2::defineImage Impars: start
16-Jul-2026 02:33:47	2026-07-16 02:32:36 INFO SynthesisImagerVi2::defineImage Shape: [1200, 1200, 1, 1] Spectral: [1.48111e+09] at [0] with increment [5.99947e+08]
16-Jul-2026 02:33:47	2026-07-16 02:32:36 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst.awp2] with ftmachine : awp2
16-Jul-2026 02:33:47	2026-07-16 02:32:36 INFO SynthesisImager::getVPRecord Using default Voltage Patterns from the VPManager
16-Jul-2026 02:33:47	2026-07-16 02:32:36 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 0.6798 GB. Available mem.: 395.2 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
16-Jul-2026 02:33:47	2026-07-16 02:32:36 INFO SynthesisImagerVi2::weight() Set imaging weights : Uniform weighting: sidelobes will be suppressed over full image
16-Jul-2026 02:33:47	2026-07-16 02:32:36 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:33:47	2026-07-16 02:32:37 INFO tclean::::casa ...done
16-Jul-2026 02:33:47	2026-07-16 02:32:37 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst.awp2] : hogbom
16-Jul-2026 02:33:47	2026-07-16 02:32:37 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:33:47	2026-07-16 02:32:38 INFO tclean::::casa ...done
16-Jul-2026 02:33:47	2026-07-16 02:32:38 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:33:47	2026-07-16 02:32:38 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-3 ----------------------------------------------------------- Make PSF ---------------------------------------------
16-Jul-2026 02:33:47	2026-07-16 02:32:38 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-2 ----------------------------------------------------------- Make PSF ---------------------------------------------
16-Jul-2026 02:33:47	2026-07-16 02:32:38 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-1 ----------------------------------------------------------- Make PSF ---------------------------------------------
16-Jul-2026 02:33:47	2026-07-16 02:33:26 INFO tclean::::casa ...done
16-Jul-2026 02:33:47	2026-07-16 02:33:26 INFO SynthesisNormalizer::gatherImages Gather psf,weight images : [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n1, /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n2, /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n3] onto :tst.awp2
16-Jul-2026 02:33:47	2026-07-16 02:33:27 INFO SIImageStore::calcSensitivity [tst.awp2] Theoretical sensitivity (Jy/bm):0.00282974
16-Jul-2026 02:33:47	2026-07-16 02:33:27 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.0113
16-Jul-2026 02:33:47	2026-07-16 02:33:27 INFO SIImageStore::printBeamSet Beam : 5.34877 arcsec, 4.3664 arcsec, -84.4348 deg
16-Jul-2026 02:33:47	2026-07-16 02:33:27 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:33:47	2026-07-16 02:33:28 INFO tclean::::casa ...done
16-Jul-2026 02:33:47	2026-07-16 02:33:28 INFO SynthesisNormalizer::scatterModel Send the model from : tst.awp2 to all nodes :[/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n1, /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n2, /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n3]
16-Jul-2026 02:33:47	2026-07-16 02:33:28 INFO SIImageStore::setModelImageOne Copying input model tst.awp2.model to /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n1.model
16-Jul-2026 02:33:47	2026-07-16 02:33:28 INFO SIImageStore::setModelImageOne Copying input model tst.awp2.model to /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n2.model
16-Jul-2026 02:33:47	2026-07-16 02:33:28 INFO SIImageStore::setModelImageOne Copying input model tst.awp2.model to /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n3.model
16-Jul-2026 02:33:47	2026-07-16 02:33:28 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ----------------------------
16-Jul-2026 02:33:47	2026-07-16 02:33:28 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:33:47	2026-07-16 02:33:28 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
16-Jul-2026 02:33:47	2026-07-16 02:33:28 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
16-Jul-2026 02:33:47	2026-07-16 02:33:28 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
16-Jul-2026 02:33:47
16-Jul-2026 02:33:47	0%....10....20....30....40....50....60....70....80....90....100%
16-Jul-2026 02:33:47
16-Jul-2026 02:33:47	0%....10....20....30....40....50....60....
16-Jul-2026 02:33:47	0%....10....20....30....40....50....70....80..60....70....90....100%
16-Jul-2026 02:33:47	..80....90....100%
16-Jul-2026 02:33:47	2026-07-16 02:33:47 INFO tclean::::casa ...done
16-Jul-2026 02:34:41	2026-07-16 02:33:47 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n1, /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n2, /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n3] onto :tst.awp2
16-Jul-2026 02:34:41	2026-07-16 02:33:48 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 0.477513
16-Jul-2026 02:34:41	2026-07-16 02:33:48 INFO SynthesisDeconvolver::setupMask [tst.awp2] Initializing new mask to 1.0 for the full image
16-Jul-2026 02:34:41	2026-07-16 02:33:48 INFO SynthesisDeconvolver::setupMask [tst.awp2] Number of pixels in the clean mask : 1.44e+06 out of a total of 1.44e+06 pixels. [ 100 % ]
16-Jul-2026 02:34:41	2026-07-16 02:33:48 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.477513, over full image : 0.477513
16-Jul-2026 02:34:41	2026-07-16 02:33:48 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 20, 'cyclethreshold': 0.02387566864490509, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
16-Jul-2026 02:34:41	2026-07-16 02:33:48 INFO SDAlgorithmBase::deconvolve [tst.awp2] Run Hogbom minor-cycle \| CycleThreshold=0.0238757, CycleNiter=20, Gain=0.1
16-Jul-2026 02:34:41	2026-07-16 02:33:48 INFO SDAlgorithmBase::deconvolve [tst.awp2] iters=0->20 [20], model=0->0.425264, peakres=0.477513->0.052249, Reached cycleniter.
16-Jul-2026 02:34:41	2026-07-16 02:33:48 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 20 iterations.
16-Jul-2026 02:34:41	2026-07-16 02:33:48 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : tst.awp2 to all nodes :[/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n1, /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n2, /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n3]
16-Jul-2026 02:34:41	2026-07-16 02:33:48 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst.awp2.model to /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n1.model
16-Jul-2026 02:34:41	2026-07-16 02:33:48 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst.awp2.model to /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n2.model
16-Jul-2026 02:34:41	2026-07-16 02:33:48 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst.awp2.model to /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n3.model
16-Jul-2026 02:34:41	2026-07-16 02:33:48 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ----------------------------
16-Jul-2026 02:34:41	2026-07-16 02:33:48 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:34:41	2026-07-16 02:33:48 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 2 -------------------------------------
16-Jul-2026 02:34:41	2026-07-16 02:33:48 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 2 -------------------------------------
16-Jul-2026 02:34:41	2026-07-16 02:33:48 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 2 -------------------------------------
16-Jul-2026 02:34:41
16-Jul-2026 02:34:41	0%....10....20....30....40....50....60....70....
16-Jul-2026 02:34:41	0%....10....20....30....80....90..40....50....100%
16-Jul-2026 02:34:41
16-Jul-2026 02:34:41	0%....10....20....30....40....60......50....70....80..60....70....90....100%
16-Jul-2026 02:34:41	..80....90....100%
16-Jul-2026 02:34:41	2026-07-16 02:34:28 INFO tclean::::casa ...done
16-Jul-2026 02:34:41	2026-07-16 02:34:28 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n1, /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n2, /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n3] onto :tst.awp2
16-Jul-2026 02:34:41	2026-07-16 02:34:28 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.0560292, over full image : 0.0560292
16-Jul-2026 02:34:41	2026-07-16 02:34:28 INFO tclean::::casa Reached global stopping criterion : iteration limit
16-Jul-2026 02:34:41	2026-07-16 02:34:28 INFO tclean::::casa getSummary call: fullsummary=False
16-Jul-2026 02:34:41	2026-07-16 02:34:28 INFO SDAlgorithmBase::restore [tst.awp2] : Restoring model image.
16-Jul-2026 02:34:41	2026-07-16 02:34:28 INFO SIImageStore::restore Beam for chan : 0 : 5.34877 arcsec, 4.3664 arcsec, -84.4348 deg
16-Jul-2026 02:34:41	2026-07-16 02:34:28 INFO task_tclean::SDAlgorithmBase::pbcor [tst.awp2] : Applying PB correction
16-Jul-2026 02:34:41	2026-07-16 02:34:37 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:34:41	2026-07-16 02:34:37 INFO ::casa::MPIServer-3 node 3 has completed its job
16-Jul-2026 02:34:41	2026-07-16 02:34:37 INFO ::casa::MPIServer-2 node 2 has completed its job
16-Jul-2026 02:34:41	2026-07-16 02:34:37 INFO ::casa::MPIServer-1 node 1 has completed its job
16-Jul-2026 02:34:41	2026-07-16 02:34:38 INFO tclean::::casa ...done
16-Jul-2026 02:34:41	2026-07-16 02:34:38 INFO tclean::::casa Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed.
16-Jul-2026 02:34:41	2026-07-16 02:34:38 INFO tclean::::casa Searching for images with prefix 'tst.awp2'... Found these, writing history into them: ['tst.awp2.gridwt_moswt', 'tst.awp2.psf', 'tst.awp2.sumwt', 'tst.awp2.weight', 'tst.awp2.pb', 'tst.awp2.model', 'tst.awp2.residual', 'tst.awp2.mask', 'tst.awp2.image', 'tst.awp2.image.pbcor']
16-Jul-2026 02:34:41	2026-07-16 02:34:39 INFO tclean::::casa Task tclean complete. Start time: 2026-07-16 02:32:26.326087 End time: 2026-07-16 02:34:38.507937
16-Jul-2026 02:34:41	2026-07-16 02:34:39 INFO tclean::::casa ##### End Task: tclean #####
16-Jul-2026 02:34:41	2026-07-16 02:34:39 INFO tclean::::casa ##########################################
16-Jul-2026 02:34:41	2026-07-16 02:34:39 INFO name:: No table opened.
16-Jul-2026 02:34:41	2026-07-16 02:34:39 INFO showcache:: The Table Cache is empty.
16-Jul-2026 02:34:41	2026-07-16 02:34:39 INFO tclean::::casa [ checkall ]
16-Jul-2026 02:34:41	2026-07-16 02:34:39 INFO tclean::::casa+ [ check_ims ] Image made : ['tst.awp2.image'] = [True] ( Pass : should all be True )
16-Jul-2026 02:34:41	2026-07-16 02:34:39 INFO tclean::::casa+ All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords)
16-Jul-2026 02:34:41	2026-07-16 02:34:39 INFO tclean::::casa+ [check_history] All expected history entries found. (Pass)
16-Jul-2026 02:34:41	2026-07-16 02:34:39 INFO tclean::::casa+ [ check_pix_val ] tst.awp2.pb : Value is 0.686262309551239 at [323, 858, 0, 0] ( Pass : should be 0.66 , Epsilon: 0.1)
16-Jul-2026 02:34:41	2026-07-16 02:34:39 INFO tclean::::casa+ [ check_pix_val ] tst.awp2.image.pbcor : Value is 0.7013260126113892 at [323, 858, 0, 0] ( Pass : should be 0.75 , Epsilon: 0.1)
16-Jul-2026 02:34:41	.s2026-07-16 02:34:40 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 3
16-Jul-2026 02:34:41	2026-07-16 02:34:40 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 2
16-Jul-2026 02:34:41	2026-07-16 02:34:40 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 1
16-Jul-2026 02:34:41	2026-07-16 02:34:41 INFO tclean::::casa setupCluster, Setting up 3 engines.
16-Jul-2026 02:34:41	2026-07-16 02:34:41 INFO tclean::::casa ##########################################
16-Jul-2026 02:34:41	2026-07-16 02:34:41 INFO tclean::::casa ##### Begin Task: tclean #####
16-Jul-2026 02:34:46	2026-07-16 02:34:41 INFO tclean::::casa tclean( vis='refim_point_wterm_vlad.ms', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst.awp', imsize=2048, cell='10.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='awproject', facets=1, psfphasecenter='', wprojplanes=16, vptable='', mosweight=True, aterm=False, psterm=True, wbawp=False, conjbeams=False, cfcache='tst_use_awp.cf', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=-0.1, normtype='flatnoise', deconvolver='hogbom', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=False, outlierfile='', weighting='uniform', robust=0.5, noise='1.0Jy', npixels=0, uvtaper=[''], niter=0, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='none', calcres=True, calcpsf=True, psfcutoff=0.35, parallel=True )
16-Jul-2026 02:34:46	2026-07-16 02:34:41 INFO tclean::::casa Verifying Input Parameters
16-Jul-2026 02:34:46	2026-07-16 02:34:43 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 3
16-Jul-2026 02:34:46	2026-07-16 02:34:43 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 2
16-Jul-2026 02:34:46	2026-07-16 02:34:43 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 1
16-Jul-2026 02:34:46	2026-07-16 02:34:44 INFO tclean::::casa setupCluster, Setting up 3 engines.
16-Jul-2026 02:34:46	2026-07-16 02:34:44 INFO SynthesisUtilMethods::continuumDataPartition
16-Jul-2026 02:34:46	2026-07-16 02:34:44 INFO SynthesisUtilMethods::continuumDataPartition + Rows = 10065 15093 [P][M]: 0:2 ROWNUMBER() >= 10065 && ROWNUMBER() <= 15093
16-Jul-2026 02:34:46	2026-07-16 02:34:44 INFO tclean::::casa Partitioned Selection : {'0': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point_wterm_vlad.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 1 && ROWNUMBER() <= 5032', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '1': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point_wterm_vlad.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 5033 && ROWNUMBER() <= 10064', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '2': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point_wterm_vlad.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 10065 && ROWNUMBER() <= 15093', 'timestr': '', 'usescratch': False, 'uvdist': ''}}}
16-Jul-2026 02:34:46	2026-07-16 02:34:44 INFO SynthesisImagerVi2::selectData MS : refim_point_wterm_vlad.ms \| [Opened in readonly mode]
16-Jul-2026 02:34:46	2026-07-16 02:34:44 INFO SynthesisImagerVi2::selectData NRows selected : 15093
16-Jul-2026 02:34:46	2026-07-16 02:34:44 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.awp] :
16-Jul-2026 02:34:46	2026-07-16 02:34:44 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.awp] :
16-Jul-2026 02:34:46	2026-07-16 02:34:44 INFO SynthesisImagerVi2::defineImage Impars: start
16-Jul-2026 02:34:46	2026-07-16 02:34:44 INFO SynthesisImagerVi2::defineImage Shape: [2048, 2048, 1, 1] Spectral: [9.99981e+08] at [0] with increment [1.00218e+06]
16-Jul-2026 02:34:46	2026-07-16 02:34:44 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst.awp] with ftmachine : awprojectft
16-Jul-2026 02:34:46	2026-07-16 02:34:44 INFO CFCache2::fillCFSFromDisk No. of CFS* found in tst_use_awp.cf: 0
16-Jul-2026 02:34:46	2026-07-16 02:34:44 INFO CFCache2::fillCFSFromDisk No. of WTCFS* found in tst_use_awp.cf: 0
16-Jul-2026 02:34:46	2026-07-16 02:34:44 INFO AWProjectFT2::setPAIncrement[R&D] Setting PA increment to 360 deg
16-Jul-2026 02:34:46	2026-07-16 02:34:44 INFO SynthesisImagerVi2::createAWPFTMachine Sending frequency selection information Axis Lengths: [1, 4] (NB: Matrix in Row/Column order)
16-Jul-2026 02:34:46	2026-07-16 02:34:44 INFO SynthesisImagerVi2::createAWPFTMachine + [0, 1e+09, 1e+09, 1e+06]
16-Jul-2026 02:34:46	2026-07-16 02:34:44 INFO SynthesisImagerVi2::createAWPFTMachine + to AWP FTM.
16-Jul-2026 02:34:46	2026-07-16 02:34:44 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 1.537 GB. Available mem.: 395.1 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
16-Jul-2026 02:34:46	2026-07-16 02:34:44 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:34:46	2026-07-16 02:34:45 INFO tclean::::casa ...done
16-Jul-2026 02:34:46	2026-07-16 02:34:45 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:34:46	2026-07-16 02:34:45 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 MS : refim_point_wterm_vlad.ms \| [Opened in readonly mode]
16-Jul-2026 02:34:46	2026-07-16 02:34:45 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 Selecting via TaQL : ROWNUMBER() >= 5033 && ROWNUMBER() <= 10064 \| NRows selected : 5032
16-Jul-2026 02:34:46	2026-07-16 02:34:45 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 MS : refim_point_wterm_vlad.ms \| [Opened in readonly mode]
16-Jul-2026 02:34:46	2026-07-16 02:34:45 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 Selecting via TaQL : ROWNUMBER() >= 1 && ROWNUMBER() <= 5032 \| NRows selected : 5032
16-Jul-2026 02:34:46	2026-07-16 02:34:46 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 MS : refim_point_wterm_vlad.ms \| [Opened in readonly mode]
16-Jul-2026 02:34:46	2026-07-16 02:34:46 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 Selecting via TaQL : ROWNUMBER() >= 10065 && ROWNUMBER() <= 15093 \| NRows selected : 5029
16-Jul-2026 02:34:46	2026-07-16 02:34:46 INFO tclean::::casa ...done
16-Jul-2026 02:34:46	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n1] :
16-Jul-2026 02:34:46	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n1] :
16-Jul-2026 02:34:46	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Impars: start
16-Jul-2026 02:34:46	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Shape: [2048, 2048, 1, 1] Spectral: [9.99981e+08] at [0] with increment [1.00218e+06]
16-Jul-2026 02:34:46	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Set Gridding options for [/home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n1] with ftmachine : awprojectft
16-Jul-2026 02:34:46	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFSFromDisk::MPIServer-1 No. of CFS* found in tst_use_awp.cf: 0
16-Jul-2026 02:34:46	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFSFromDisk::MPIServer-1 No. of WTCFS* found in tst_use_awp.cf: 0
16-Jul-2026 02:34:46	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::setPAIncrement[R&D]::MPIServer-1 Setting PA increment to 360 deg
16-Jul-2026 02:34:51	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::createAWPFTMachine::MPIServer-1 Sending frequency selection information Axis Lengths: [1, 4] (NB: Matrix in Row/Column order)
16-Jul-2026 02:34:51	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::createAWPFTMachine::MPIServer-1 + [0, 1e+09, 1e+09, 1e+06]
16-Jul-2026 02:34:51	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::createAWPFTMachine::MPIServer-1 + to AWP FTM.
16-Jul-2026 02:34:51	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-1 Required memory: 1.537 GB. Available mem.: 395.1 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
16-Jul-2026 02:34:51	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n2] :
16-Jul-2026 02:34:51	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n2] :
16-Jul-2026 02:34:51	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Impars: start
16-Jul-2026 02:34:51	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Shape: [2048, 2048, 1, 1] Spectral: [9.99981e+08] at [0] with increment [1.00218e+06]
16-Jul-2026 02:34:51	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Set Gridding options for [/home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n2] with ftmachine : awprojectft
16-Jul-2026 02:34:51	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFSFromDisk::MPIServer-2 No. of CFS* found in tst_use_awp.cf: 0
16-Jul-2026 02:34:51	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFSFromDisk::MPIServer-2 No. of WTCFS* found in tst_use_awp.cf: 0
16-Jul-2026 02:34:51	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::setPAIncrement[R&D]::MPIServer-2 Setting PA increment to 360 deg
16-Jul-2026 02:34:51	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::createAWPFTMachine::MPIServer-2 Sending frequency selection information Axis Lengths: [1, 4] (NB: Matrix in Row/Column order)
16-Jul-2026 02:34:51	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::createAWPFTMachine::MPIServer-2 + [0, 1e+09, 1e+09, 1e+06]
16-Jul-2026 02:34:51	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::createAWPFTMachine::MPIServer-2 + to AWP FTM.
16-Jul-2026 02:34:51	2026-07-16 02:34:47 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-2 Required memory: 1.537 GB. Available mem.: 395.1 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
16-Jul-2026 02:34:51	2026-07-16 02:34:48 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:34:51	2026-07-16 02:34:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n3] :
16-Jul-2026 02:34:51	2026-07-16 02:34:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n3] :
16-Jul-2026 02:34:51	2026-07-16 02:34:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Impars: start
16-Jul-2026 02:34:51	2026-07-16 02:34:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Shape: [2048, 2048, 1, 1] Spectral: [9.99981e+08] at [0] with increment [1.00218e+06]
16-Jul-2026 02:34:51	2026-07-16 02:34:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Set Gridding options for [/home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n3] with ftmachine : awprojectft
16-Jul-2026 02:34:51	2026-07-16 02:34:48 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFSFromDisk::MPIServer-3 No. of CFS* found in tst_use_awp.cf: 0
16-Jul-2026 02:34:51	2026-07-16 02:34:48 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFSFromDisk::MPIServer-3 No. of WTCFS* found in tst_use_awp.cf: 0
16-Jul-2026 02:34:51	2026-07-16 02:34:48 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::setPAIncrement[R&D]::MPIServer-3 Setting PA increment to 360 deg
16-Jul-2026 02:34:51	2026-07-16 02:34:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::createAWPFTMachine::MPIServer-3 Sending frequency selection information Axis Lengths: [1, 4] (NB: Matrix in Row/Column order)
16-Jul-2026 02:34:51	2026-07-16 02:34:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::createAWPFTMachine::MPIServer-3 + [0, 1e+09, 1e+09, 1e+06]
16-Jul-2026 02:34:51	2026-07-16 02:34:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::createAWPFTMachine::MPIServer-3 + to AWP FTM.
16-Jul-2026 02:34:51	2026-07-16 02:34:48 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-3 Required memory: 1.537 GB. Available mem.: 395.1 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
16-Jul-2026 02:34:51	2026-07-16 02:34:49 INFO tclean::::casa ...done
16-Jul-2026 02:34:51	2026-07-16 02:34:49 INFO SynthesisImagerVi2::dryGridding ---------------------------------------------------- Dry Gridding ---------------------------------------------
16-Jul-2026 02:34:51	2026-07-16 02:34:49 INFO AWProjectFT2::init[R&D] Using CPUResampler visibility resampler (a.k.a. "gridder/degridder")
16-Jul-2026 02:34:51	2026-07-16 02:34:49 INFO AWProjectFT2::initializeToSky[R&D] Computed maps using FTMachine::initMaps. polMap = [0, 0]
16-Jul-2026 02:34:51	2026-07-16 02:34:49 WARN SynthesisImagerVi2::dryGridding (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SynthesisImagerVi2.cc, line 3148) Making a "blank" CFCache (without the A-Term)
16-Jul-2026 02:34:51	2026-07-16 02:34:49 INFO VB2CFBMap::makeVBRow2CFBMap[R&D] CFs not cached for -64.1134 deg, dPA = 360 Field ID = 0 Ant1Type, Ant2Type = 0,0
16-Jul-2026 02:34:51	2026-07-16 02:34:49 INFO AWConvFunc2::makeConvFunction[R&D] Making a new convolution function for PA=-64.1134deg for field ID 0
16-Jul-2026 02:34:51	2026-07-16 02:34:49 INFO AWConvFunc2::makeConvFunction[R&D] Using 16 planes for W-projection
16-Jul-2026 02:34:51	2026-07-16 02:34:49 INFO AWConvFunc2::makeConvFunction[R&D] Estimating maximum possible W = 5156.62 (wavelengths)
16-Jul-2026 02:34:51	2026-07-16 02:34:49 INFO AWConvFunc2::makeConvFunction[R&D] Scaling in W (at maximum W) = 22.9183 wavelengths per pixel
16-Jul-2026 02:34:51	2026-07-16 02:34:49 INFO AWConvFunc2::makeConvFunction[R&D] Making 16 w plane(s).
16-Jul-2026 02:34:51	2026-07-16 02:34:49 INFO AWConvFunc2::makeConvFunction[R&D] Making 1 frequency plane(s).
16-Jul-2026 02:34:51	2026-07-16 02:34:49 INFO AWConvFunc2::makeConvFunction[R&D] CFB Freq. axis [N, Min, Max, Incr. (GHz)]: 1 0.999981 0.999981 0.1
16-Jul-2026 02:34:51	2026-07-16 02:34:49 INFO AWConvFunc2::makeConvFunction[R&D] Making empty CFs for baseline type 0
16-Jul-2026 02:34:51	2026-07-16 02:34:49 WARN AWProjectWBFT2::makeSensitivityImage(Complex)[R&D] Setting up for weights accumulation during gridding to compute sensitivity pattern.
16-Jul-2026 02:34:51	2026-07-16 02:34:49 WARN AWProjectWBFT2::makeSensitivityImage(Complex)[R&D]+ Consequently, the first gridding cycle will be slower than the subsequent ones.
16-Jul-2026 02:34:51	2026-07-16 02:34:49 INFO CFStore2::makePersistent(pa)[R&D] Saving CFStore of shape [1, 16, 2] for PA = -64.1134 BaselineType(antType1, antType2) = (0,0)
16-Jul-2026 02:34:51	2026-07-16 02:34:50 INFO CFStore2::makePersistent(pa)[R&D] Saving CFStore of shape [1, 16, 2] for PA = -64.1134 BaselineType(antType1, antType2) = (0,0)
16-Jul-2026 02:34:51	2026-07-16 02:34:51 INFO AWProjectFT2::findConvFunction[R&D] Convolution function memory footprint:0 KB out of a maximum of 515213 MB
16-Jul-2026 02:34:51	2026-07-16 02:34:51 INFO SynthesisImagerVi2::fillCFCache ---------------------------------------------------- fillCFCache ---------------------------------------------
16-Jul-2026 02:37:26	2026-07-16 02:34:51 WARN SynthesisImagerVi2::fillCFCache (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SynthesisImagerVi2.cc, line 3232) Re-loading the "blank" CFCache for filling
16-Jul-2026 02:37:26	2026-07-16 02:34:51 INFO CFCache2::fillCFListFromDisk Loading misc info from CFs
16-Jul-2026 02:37:26	2026-07-16 02:34:51 INFO CFCache2::fillCFListFromDisk Loading misc info from CFs
16-Jul-2026 02:37:26	2026-07-16 02:34:51 WARN crustaceans::makeConvFunction2[R&D] Filling CFs for baseline type 0, PA slot 0
16-Jul-2026 02:37:26	2026-07-16 02:34:51 INFO BeamCalc::setBeamCalcGeometries() Initialisation of geometries for observatory VLA, antenna type STANDARD
16-Jul-2026 02:37:26	2026-07-16 02:34:51 INFO BeamCalc::setBeamCalcGeometries() Will use default geometries for VLA STANDARD.
16-Jul-2026 02:37:26	Processing request for geometries from observatory VLA, antenna type STANDARD
16-Jul-2026 02:37:26	2026-07-16 02:34:56 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:0,C:0.999981,W:0): CF Support: 4 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:35:01 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:0,C:0.999981,W:22.9183): CF Support: 5 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:35:05 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:0,C:0.999981,W:91.6732): CF Support: 5 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:35:10 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:0,C:0.999981,W:206.265): CF Support: 5 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:35:15 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:0,C:0.999981,W:366.693): CF Support: 6 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:35:20 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:0,C:0.999981,W:572.958): CF Support: 7 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:35:24 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:0,C:0.999981,W:825.059): CF Support: 9 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:35:29 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:0,C:0.999981,W:1123): CF Support: 10 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:35:34 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:0,C:0.999981,W:1466.77): CF Support: 12 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:35:39 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:0,C:0.999981,W:1856.38): CF Support: 14 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:35:43 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:0,C:0.999981,W:2291.83): CF Support: 17 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:35:48 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:0,C:0.999981,W:2773.12): CF Support: 19 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:35:53 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:0,C:0.999981,W:3300.24): CF Support: 22 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:35:58 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:0,C:0.999981,W:3873.19): CF Support: 26 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:36:02 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:0,C:0.999981,W:4491.99): CF Support: 29 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:36:07 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:0,C:0.999981,W:5156.62): CF Support: 33 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:36:12 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:15,C:0.999981,W:0): CF Support: 4 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:36:16 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:15,C:0.999981,W:22.9183): CF Support: 5 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:36:21 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:15,C:0.999981,W:91.6732): CF Support: 5 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:36:26 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:15,C:0.999981,W:206.265): CF Support: 5 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:36:31 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:15,C:0.999981,W:366.693): CF Support: 6 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:36:35 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:15,C:0.999981,W:572.958): CF Support: 7 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:36:40 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:15,C:0.999981,W:825.059): CF Support: 9 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:36:45 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:15,C:0.999981,W:1123): CF Support: 10 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:36:50 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:15,C:0.999981,W:1466.77): CF Support: 12 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:36:54 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:15,C:0.999981,W:1856.38): CF Support: 14 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:36:59 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:15,C:0.999981,W:2291.83): CF Support: 17 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:37:04 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:15,C:0.999981,W:2773.12): CF Support: 19 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:37:09 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:15,C:0.999981,W:3300.24): CF Support: 22 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:37:13 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:15,C:0.999981,W:3873.19): CF Support: 26 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:37:18 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:15,C:0.999981,W:4491.99): CF Support: 29 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:37:23 INFO Moluscs::fillConvFuncBuffer2[R&D] CF(M:15,C:0.999981,W:5156.62): CF Support: 33 (6) pixels
16-Jul-2026 02:37:26	2026-07-16 02:37:23 INFO CFStore2.2::makePersistent[R&D] Writing CFStore(0,0) of shape [1, 16, 2]
16-Jul-2026 02:37:26	2026-07-16 02:37:24 INFO CFStore2.2::makePersistent[R&D] Writing CFStore(0,0) of shape [1, 16, 2]
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO tclean::::casa reloadCFCache, CMD = 1 toolsi.reloadcfcache()
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO tclean::::casa reloadCFCache, CMD = 2 toolsi.reloadcfcache()
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO tclean::::casa reloadCFCache, CMD = 3 toolsi.reloadcfcache()
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::reloadCFCache::MPIServer-3 -------------------------------------------- Re-load CFCache ---------------------------------------------
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO MPICommandServer::command_request_handler_service::CFCache::setLazyFill::MPIServer-3 Lazy fill is On
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::reloadCFCache::MPIServer-2 -------------------------------------------- Re-load CFCache ---------------------------------------------
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO MPICommandServer::command_request_handler_service::CFCache::setLazyFill::MPIServer-2 Lazy fill is On
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFSFromDisk::MPIServer-3 No. of CFS* found in tst_use_awp.cf: 32
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFSFromDisk::MPIServer-2 No. of CFS* found in tst_use_awp.cf: 32
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFListFromDisk::MPIServer-3 Loading misc info from CFs
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFListFromDisk::MPIServer-2 Loading misc info from CFs
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::reloadCFCache::MPIServer-1 -------------------------------------------- Re-load CFCache ---------------------------------------------
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO MPICommandServer::command_request_handler_service::CFCache::setLazyFill::MPIServer-1 Lazy fill is On
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFSFromDisk::MPIServer-1 No. of CFS* found in tst_use_awp.cf: 32
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFListFromDisk::MPIServer-1 Loading misc info from CFs
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFSFromDisk::MPIServer-3 No. of WTCFS* found in tst_use_awp.cf: 32
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFSFromDisk::MPIServer-2 No. of WTCFS* found in tst_use_awp.cf: 32
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFListFromDisk::MPIServer-3 Loading misc info from CFs
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFListFromDisk::MPIServer-2 Loading misc info from CFs
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFSFromDisk::MPIServer-1 No. of WTCFS* found in tst_use_awp.cf: 32
16-Jul-2026 02:37:26	2026-07-16 02:37:25 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFListFromDisk::MPIServer-1 Loading misc info from CFs
16-Jul-2026 02:37:26	2026-07-16 02:37:26 INFO tclean::::casa ...done
16-Jul-2026 02:37:26	2026-07-16 02:37:26 INFO tclean::::casa reloadCFCache, CMD = 1 toolsi.reloadcfcache()
16-Jul-2026 02:37:26	2026-07-16 02:37:26 INFO tclean::::casa reloadCFCache, CMD = 2 toolsi.reloadcfcache()
16-Jul-2026 02:37:34	2026-07-16 02:37:26 INFO tclean::::casa reloadCFCache, CMD = 3 toolsi.reloadcfcache()
16-Jul-2026 02:37:34	2026-07-16 02:37:26 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:37:34	2026-07-16 02:37:26 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::reloadCFCache::MPIServer-3 -------------------------------------------- Re-load CFCache ---------------------------------------------
16-Jul-2026 02:37:34	2026-07-16 02:37:26 INFO MPICommandServer::command_request_handler_service::CFCache::setLazyFill::MPIServer-3 Lazy fill is On
16-Jul-2026 02:37:34	2026-07-16 02:37:26 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::reloadCFCache::MPIServer-2 -------------------------------------------- Re-load CFCache ---------------------------------------------
16-Jul-2026 02:37:34	2026-07-16 02:37:26 INFO MPICommandServer::command_request_handler_service::CFCache::setLazyFill::MPIServer-2 Lazy fill is On
16-Jul-2026 02:37:34	2026-07-16 02:37:26 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFSFromDisk::MPIServer-3 No. of CFS* found in tst_use_awp.cf: 32
16-Jul-2026 02:37:34	2026-07-16 02:37:26 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFSFromDisk::MPIServer-2 No. of CFS* found in tst_use_awp.cf: 32
16-Jul-2026 02:37:34	2026-07-16 02:37:26 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFListFromDisk::MPIServer-3 Loading misc info from CFs
16-Jul-2026 02:37:34	2026-07-16 02:37:26 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFListFromDisk::MPIServer-2 Loading misc info from CFs
16-Jul-2026 02:37:34	2026-07-16 02:37:26 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::reloadCFCache::MPIServer-1 -------------------------------------------- Re-load CFCache ---------------------------------------------
16-Jul-2026 02:37:34	2026-07-16 02:37:26 INFO MPICommandServer::command_request_handler_service::CFCache::setLazyFill::MPIServer-1 Lazy fill is On
16-Jul-2026 02:37:34	2026-07-16 02:37:26 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFSFromDisk::MPIServer-1 No. of CFS* found in tst_use_awp.cf: 32
16-Jul-2026 02:37:34	2026-07-16 02:37:26 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFListFromDisk::MPIServer-1 Loading misc info from CFs
16-Jul-2026 02:37:34	2026-07-16 02:37:26 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFSFromDisk::MPIServer-2 No. of WTCFS* found in tst_use_awp.cf: 32
16-Jul-2026 02:37:34	2026-07-16 02:37:26 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFSFromDisk::MPIServer-3 No. of WTCFS* found in tst_use_awp.cf: 32
16-Jul-2026 02:37:34	2026-07-16 02:37:26 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFListFromDisk::MPIServer-2 Loading misc info from CFs
16-Jul-2026 02:37:34	2026-07-16 02:37:26 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFListFromDisk::MPIServer-3 Loading misc info from CFs
16-Jul-2026 02:37:34	2026-07-16 02:37:26 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFSFromDisk::MPIServer-1 No. of WTCFS* found in tst_use_awp.cf: 32
16-Jul-2026 02:37:34	2026-07-16 02:37:26 INFO MPICommandServer::command_request_handler_service::CFCache2::fillCFListFromDisk::MPIServer-1 Loading misc info from CFs
16-Jul-2026 02:37:34	2026-07-16 02:37:27 INFO tclean::::casa ...done
16-Jul-2026 02:37:34	2026-07-16 02:37:27 INFO VB2CFBMap::~VB2CFMap[R&D] Total extra cost of heterogeneous array pointing correction = 0sec. Total VBs processed = 0. The pointingoffsetsigdev used was = []
16-Jul-2026 02:37:34	2026-07-16 02:37:30 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:37:34	2026-07-16 02:37:30 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-1 Set imaging weights : Uniform weighting: sidelobes will be suppressed over full image
16-Jul-2026 02:37:34	2026-07-16 02:37:30 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-2 Set imaging weights : Uniform weighting: sidelobes will be suppressed over full image
16-Jul-2026 02:37:34	2026-07-16 02:37:30 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-3 Set imaging weights : Uniform weighting: sidelobes will be suppressed over full image
16-Jul-2026 02:37:34	2026-07-16 02:37:31 INFO tclean::::casa ...done
16-Jul-2026 02:37:34	2026-07-16 02:37:31 INFO tclean::::casa Gathering/Merging/Scattering Weight Density for PSF generation
16-Jul-2026 02:37:34	2026-07-16 02:37:31 INFO tclean::::casa ******************************************************
16-Jul-2026 02:37:34	2026-07-16 02:37:31 INFO tclean::::casa gather and scatter now
16-Jul-2026 02:37:34	2026-07-16 02:37:31 INFO tclean::::casa ******************************************************
16-Jul-2026 02:37:34	2026-07-16 02:37:31 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:37:34	2026-07-16 02:37:32 INFO tclean::::casa ...done
16-Jul-2026 02:37:34	2026-07-16 02:37:32 INFO SynthesisNormalizer::scatterWeightDensity Send the gridded weight from : tst.awp to all nodes :[/home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n1, /home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n2, /home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n3]
16-Jul-2026 02:37:34	2026-07-16 02:37:32 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:37:34	2026-07-16 02:37:33 INFO tclean::::casa ...done
16-Jul-2026 02:37:34	2026-07-16 02:37:33 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst.awp] : hogbom
16-Jul-2026 02:37:34	2026-07-16 02:37:33 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:37:34	2026-07-16 02:37:34 INFO tclean::::casa ...done
16-Jul-2026 02:37:34	2026-07-16 02:37:34 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:37:34	2026-07-16 02:37:34 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-1 ----------------------------------------------------------- Make PSF ---------------------------------------------
16-Jul-2026 02:37:34	2026-07-16 02:37:34 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-3 ----------------------------------------------------------- Make PSF ---------------------------------------------
16-Jul-2026 02:37:34	2026-07-16 02:37:34 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-2 ----------------------------------------------------------- Make PSF ---------------------------------------------
16-Jul-2026 02:37:34	2026-07-16 02:37:34 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::init[R&D]::MPIServer-1 Using CPUResampler visibility resampler (a.k.a. "gridder/degridder")
16-Jul-2026 02:37:34	2026-07-16 02:37:34 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::init[R&D]::MPIServer-3 Using CPUResampler visibility resampler (a.k.a. "gridder/degridder")
16-Jul-2026 02:37:34	2026-07-16 02:37:34 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::init[R&D]::MPIServer-2 Using CPUResampler visibility resampler (a.k.a. "gridder/degridder")
16-Jul-2026 02:37:34	2026-07-16 02:37:34 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::initializeToSky[R&D]::MPIServer-1 Computed maps using FTMachine::initMaps. polMap = [0, 0]
16-Jul-2026 02:37:34	2026-07-16 02:37:34 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::initializeToSky[R&D]::MPIServer-3 Computed maps using FTMachine::initMaps. polMap = [0, 0]
16-Jul-2026 02:37:34	2026-07-16 02:37:34 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::initializeToSky[R&D]::MPIServer-2 Computed maps using FTMachine::initMaps. polMap = [0, 0]
16-Jul-2026 02:37:34	2026-07-16 02:37:34 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-2 Computing Phase Grad for Field : 0 for spw :0
16-Jul-2026 02:37:34	2026-07-16 02:37:34 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-3 Computing Phase Grad for Field : 0 for spw :0
16-Jul-2026 02:37:34	2026-07-16 02:37:34 WARN MPICommandServer::command_request_handler_service::AWProjectWBFT2::makeSensitivityImage(Complex)[R&D]::MPIServer-3 Setting up for weights accumulation during gridding to compute sensitivity pattern.
16-Jul-2026 02:37:34	2026-07-16 02:37:34 WARN MPICommandServer::command_request_handler_service::AWProjectWBFT2::makeSensitivityImage(Complex)[R&D]::MPIServer-3+ Consequently, the first gridding cycle will be slower than the subsequent ones.
16-Jul-2026 02:37:34	2026-07-16 02:37:34 WARN MPICommandServer::command_request_handler_service::AWProjectWBFT2::makeSensitivityImage(Complex)[R&D]::MPIServer-2 Setting up for weights accumulation during gridding to compute sensitivity pattern.
16-Jul-2026 02:37:39	2026-07-16 02:37:34 WARN MPICommandServer::command_request_handler_service::AWProjectWBFT2::makeSensitivityImage(Complex)[R&D]::MPIServer-2+ Consequently, the first gridding cycle will be slower than the subsequent ones.
16-Jul-2026 02:37:39	2026-07-16 02:37:34 INFO MPICommandServer::command_request_handler_service::PhaseGrad::computeAntennaPointingGrad::MPIServer-1 Computing Phase Grad for Field : 0 for spw :0
16-Jul-2026 02:37:39	2026-07-16 02:37:34 WARN MPICommandServer::command_request_handler_service::AWProjectWBFT2::makeSensitivityImage(Complex)[R&D]::MPIServer-1 Setting up for weights accumulation during gridding to compute sensitivity pattern.
16-Jul-2026 02:37:39	2026-07-16 02:37:34 WARN MPICommandServer::command_request_handler_service::AWProjectWBFT2::makeSensitivityImage(Complex)[R&D]::MPIServer-1+ Consequently, the first gridding cycle will be slower than the subsequent ones.
16-Jul-2026 02:37:39	2026-07-16 02:37:34 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-2 time to massage data 0.11
16-Jul-2026 02:37:39	2026-07-16 02:37:34 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-2 time gridding 0.08
16-Jul-2026 02:37:39	2026-07-16 02:37:34 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-3 time to massage data 0.12
16-Jul-2026 02:37:39	2026-07-16 02:37:34 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-3 time gridding 0.09
16-Jul-2026 02:37:39	2026-07-16 02:37:34 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-1 time to massage data 0.12
16-Jul-2026 02:37:39	2026-07-16 02:37:34 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-1 time gridding 0.1
16-Jul-2026 02:37:39	2026-07-16 02:37:35 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-2 Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order)
16-Jul-2026 02:37:39	2026-07-16 02:37:35 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-2+ [8474.84]
16-Jul-2026 02:37:39	2026-07-16 02:37:35 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-2+ (0.992538,2.94906e-08) (0,0)
16-Jul-2026 02:37:39	2026-07-16 02:37:35 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-3 Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order)
16-Jul-2026 02:37:39	2026-07-16 02:37:35 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-3+ [8234.25]
16-Jul-2026 02:37:39	2026-07-16 02:37:35 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-3+ (1.39154,-6.08118e-08) (0,0)
16-Jul-2026 02:37:39	2026-07-16 02:37:35 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-1 Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order)
16-Jul-2026 02:37:39	2026-07-16 02:37:35 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-1+ [8258.9]
16-Jul-2026 02:37:39	2026-07-16 02:37:35 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-1+ (1.39034,-2.25006e-08) (0,0)
16-Jul-2026 02:37:39	2026-07-16 02:37:37 INFO tclean::::casa ...done
16-Jul-2026 02:37:39	2026-07-16 02:37:37 INFO SynthesisNormalizer::gatherImages Gather psf,weight images : [/home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n1, /home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n2, /home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n3] onto :tst.awp
16-Jul-2026 02:37:39	2026-07-16 02:37:37 INFO SIImageStore::calcSensitivity [tst.awp] Theoretical sensitivity (Jy/bm):0.00632861
16-Jul-2026 02:37:39	2026-07-16 02:37:37 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.033879
16-Jul-2026 02:37:39	2026-07-16 02:37:37 INFO SIImageStore::printBeamSet Beam : 85.3879 arcsec, 71.2449 arcsec, -89.0476 deg
16-Jul-2026 02:37:39	2026-07-16 02:37:37 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:37:39	2026-07-16 02:37:38 INFO tclean::::casa ...done
16-Jul-2026 02:37:39	2026-07-16 02:37:39 INFO SynthesisNormalizer::scatterModel Send the model from : tst.awp to all nodes :[/home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n1, /home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n2, /home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n3]
16-Jul-2026 02:37:39	2026-07-16 02:37:39 INFO SIImageStore::setModelImageOne Copying input model tst.awp.model to /home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n1.model
16-Jul-2026 02:37:39	2026-07-16 02:37:39 INFO SIImageStore::setModelImageOne Copying input model tst.awp.model to /home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n2.model
16-Jul-2026 02:37:39	2026-07-16 02:37:39 INFO SIImageStore::setModelImageOne Copying input model tst.awp.model to /home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n3.model
16-Jul-2026 02:37:39	2026-07-16 02:37:39 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ----------------------------
16-Jul-2026 02:37:39	2026-07-16 02:37:39 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:37:39	2026-07-16 02:37:39 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
16-Jul-2026 02:37:39	2026-07-16 02:37:39 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
16-Jul-2026 02:37:39	2026-07-16 02:37:39 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
16-Jul-2026 02:37:39	2026-07-16 02:37:39 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::init[R&D]::MPIServer-2 Using CPUResampler visibility resampler (a.k.a. "gridder/degridder")
16-Jul-2026 02:37:39	2026-07-16 02:37:39 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::initializeToSky[R&D]::MPIServer-2 Computed maps using FTMachine::initMaps. polMap = [0, 0]
16-Jul-2026 02:37:39	2026-07-16 02:37:39 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::init[R&D]::MPIServer-1 Using CPUResampler visibility resampler (a.k.a. "gridder/degridder")
16-Jul-2026 02:37:39	2026-07-16 02:37:39 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::initializeToSky[R&D]::MPIServer-1 Computed maps using FTMachine::initMaps. polMap = [0, 0]
16-Jul-2026 02:37:39	2026-07-16 02:37:39 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::init[R&D]::MPIServer-3 Using CPUResampler visibility resampler (a.k.a. "gridder/degridder")
16-Jul-2026 02:37:39	2026-07-16 02:37:39 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::initializeToSky[R&D]::MPIServer-3 Computed maps using FTMachine::initMaps. polMap = [0, 0]
16-Jul-2026 02:37:39	2026-07-16 02:37:40 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-2 time to massage data 0.07
16-Jul-2026 02:37:39	2026-07-16 02:37:40 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-2 time gridding 0.03
16-Jul-2026 02:37:39	2026-07-16 02:37:40 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-2 Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order)
16-Jul-2026 02:37:39	2026-07-16 02:37:40 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-2+ [8475.52]
16-Jul-2026 02:37:39	2026-07-16 02:37:40 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-2+ (-0.470794,-1.04899) (0,0)
16-Jul-2026 02:37:39	2026-07-16 02:37:40 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-1 time to massage data 0.04
16-Jul-2026 02:37:39	2026-07-16 02:37:40 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-1 time gridding 0.07
16-Jul-2026 02:37:39	2026-07-16 02:37:40 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-3 time to massage data 0.06
16-Jul-2026 02:37:39	2026-07-16 02:37:40 WARN MPICommandServer::command_request_handler_service::AWProjectFT::finalizeToSky::MPIServer-3 time gridding 0.06
16-Jul-2026 02:37:39	2026-07-16 02:37:40 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-1 Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order)
16-Jul-2026 02:37:59	2026-07-16 02:37:40 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-1+ [8259.7]
16-Jul-2026 02:37:59	2026-07-16 02:37:40 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-1+ (-1.08331,0.295813) (0,0)
16-Jul-2026 02:37:59	2026-07-16 02:37:40 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-3 Sum of weights: Axis Lengths: [1, 1] (NB: Matrix in Row/Column order)
16-Jul-2026 02:37:59	2026-07-16 02:37:40 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-3+ [8235.06]
16-Jul-2026 02:37:59	2026-07-16 02:37:40 INFO MPICommandServer::command_request_handler_service::AWProjectFT2::getImage[R&D]::MPIServer-3+ (-0.996397,0.392977) (0,0)
16-Jul-2026 02:37:59	2026-07-16 02:37:41 INFO tclean::::casa ...done
16-Jul-2026 02:37:59	2026-07-16 02:37:41 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n1, /home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n2, /home/casatest/work/test_task_tclean/tst.awp.workdirectory/tst.awp.n3] onto :tst.awp
16-Jul-2026 02:37:59	2026-07-16 02:37:42 INFO task_tclean::SDAlgorithmBase::restore [tst.awp] : Restoring model image.
16-Jul-2026 02:37:59	2026-07-16 02:37:42 WARN task_tclean::SIImageStore::restore (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SIImageStore.cc, line 2353) Restoring with an empty model image. Only residuals will be processed to form the output restored image.
16-Jul-2026 02:37:59	2026-07-16 02:37:42 INFO task_tclean::SIImageStore::restore Beam for chan : 0 : 85.3879 arcsec, 71.2449 arcsec, -89.0476 deg
16-Jul-2026 02:37:59	2026-07-16 02:37:42 INFO MPICommandServer::command_request_handler_service::VB2CFBMap::~VB2CFMap[R&D]::MPIServer-1 Total extra cost of heterogeneous array pointing correction = 0.01sec. Total VBs processed = 15798. The pointingoffsetsigdev used was = []
16-Jul-2026 02:37:59	2026-07-16 02:37:42 INFO MPICommandServer::command_request_handler_service::VB2CFBMap::~VB2CFMap[R&D]::MPIServer-3 Total extra cost of heterogeneous array pointing correction = 0.03sec. Total VBs processed = 15317. The pointingoffsetsigdev used was = []
16-Jul-2026 02:37:59	2026-07-16 02:37:42 INFO MPICommandServer::command_request_handler_service::VB2CFBMap::~VB2CFMap[R&D]::MPIServer-2 Total extra cost of heterogeneous array pointing correction = 0.01sec. Total VBs processed = 15562. The pointingoffsetsigdev used was = []
16-Jul-2026 02:37:59	2026-07-16 02:37:52 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:37:59	2026-07-16 02:37:52 INFO ::casa::MPIServer-3 node 3 has completed its job
16-Jul-2026 02:37:59	2026-07-16 02:37:52 INFO ::casa::MPIServer-2 node 2 has completed its job
16-Jul-2026 02:37:59	2026-07-16 02:37:52 INFO ::casa::MPIServer-1 node 1 has completed its job
16-Jul-2026 02:37:59	2026-07-16 02:37:53 INFO tclean::::casa ...done
16-Jul-2026 02:37:59	2026-07-16 02:37:53 INFO tclean::::casa Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed.
16-Jul-2026 02:37:59	2026-07-16 02:37:53 INFO tclean::::casa Searching for images with prefix 'tst.awp'... Found these, writing history into them: ['tst.awp.gridwt_temp', 'tst.awp.psf', 'tst.awp.sumwt', 'tst.awp.weight', 'tst.awp.pb', 'tst.awp.model', 'tst.awp.residual', 'tst.awp.image']
16-Jul-2026 02:37:59	2026-07-16 02:37:53 INFO tclean::::casa Task tclean complete. Start time: 2026-07-16 02:34:41.311437 End time: 2026-07-16 02:37:53.377291
16-Jul-2026 02:37:59	2026-07-16 02:37:53 INFO tclean::::casa ##### End Task: tclean #####
16-Jul-2026 02:37:59	2026-07-16 02:37:53 INFO tclean::::casa ##########################################
16-Jul-2026 02:37:59	2026-07-16 02:37:53 INFO name:: No table opened.
16-Jul-2026 02:37:59	2026-07-16 02:37:53 INFO showcache:: The Table Cache is empty.
16-Jul-2026 02:37:59	2026-07-16 02:37:53 INFO tclean::::casa [ checkall ]
16-Jul-2026 02:37:59	2026-07-16 02:37:53 INFO tclean::::casa+ [ check_ims ] Image made : ['tst.awp.image'] = [True] ( Pass : should all be True )
16-Jul-2026 02:37:59	2026-07-16 02:37:53 INFO tclean::::casa+ All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords)
16-Jul-2026 02:37:59	2026-07-16 02:37:53 INFO tclean::::casa+ [check_history] All expected history entries found. (Pass)
16-Jul-2026 02:37:59	2026-07-16 02:37:53 INFO tclean::::casa+ [ check_pix_val ] tst.awp.psf : Value is 1.0 at [1024, 1024, 0, 0] ( Pass : should be 1.0 , Epsilon: 0.05)
16-Jul-2026 02:37:59	2026-07-16 02:37:53 INFO tclean::::casa+ [ check_pix_val ] tst.awp.image : Value is 0.9958503246307373 at [1158, 1384, 0, 0] ( Pass : should be 1.0 , Epsilon: 0.05)
16-Jul-2026 02:37:59	.s2026-07-16 02:37:55 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 3
16-Jul-2026 02:37:59	2026-07-16 02:37:55 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 2
16-Jul-2026 02:37:59	2026-07-16 02:37:55 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 1
16-Jul-2026 02:37:59	2026-07-16 02:37:56 INFO tclean::::casa setupCluster, Setting up 3 engines.
16-Jul-2026 02:37:59	2026-07-16 02:37:56 INFO tclean::::casa ##########################################
16-Jul-2026 02:37:59	2026-07-16 02:37:56 INFO tclean::::casa ##### Begin Task: tclean #####
16-Jul-2026 02:37:59	2026-07-16 02:37:56 INFO tclean::::casa tclean( vis='vla_wideband_2ptg_w_squint.ms', selectdata=True, field='1', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst.awp2', imsize=1200, cell='1.6arcsec', phasecenter='', stokes='IV', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='awp2', facets=1, psfphasecenter='', wprojplanes=2, vptable='', mosweight=True, aterm=True, psterm=False, wbawp=True, conjbeams=False, cfcache='', usepointing=False, computepastep=15.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=-0.1, normtype='flatnoise', deconvolver='hogbom', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=True, outlierfile='', weighting='uniform', robust=0.5, noise='1.0Jy', npixels=0, uvtaper=[''], niter=20, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='none', calcres=True, calcpsf=True, psfcutoff=0.35, parallel=True )
16-Jul-2026 02:37:59	2026-07-16 02:37:56 INFO tclean::::casa Verifying Input Parameters
16-Jul-2026 02:37:59	2026-07-16 02:37:58 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 3
16-Jul-2026 02:37:59	2026-07-16 02:37:58 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 2
16-Jul-2026 02:37:59	2026-07-16 02:37:58 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 1
16-Jul-2026 02:37:59	2026-07-16 02:37:59 INFO tclean::::casa setupCluster, Setting up 3 engines.
16-Jul-2026 02:37:59	2026-07-16 02:37:59 INFO SynthesisUtilMethods::continuumDataPartition
16-Jul-2026 02:37:59	2026-07-16 02:37:59 INFO SynthesisUtilMethods::continuumDataPartition + Rows = 4683 7020 [P][M]: 0:2 ROWNUMBER() >= 4683 && ROWNUMBER() <= 7020
16-Jul-2026 02:38:02	2026-07-16 02:37:59 INFO tclean::::casa Partitioned Selection : {'0': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '1', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'vla_wideband_2ptg_w_squint.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 1 && ROWNUMBER() <= 2341', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '1': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '1', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'vla_wideband_2ptg_w_squint.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 2342 && ROWNUMBER() <= 4682', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '2': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '1', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'vla_wideband_2ptg_w_squint.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 4683 && ROWNUMBER() <= 7020', 'timestr': '', 'usescratch': False, 'uvdist': ''}}}
16-Jul-2026 02:38:02	2026-07-16 02:37:59 INFO SynthesisImagerVi2::selectData MS : vla_wideband_2ptg_w_squint.ms \| Selecting on fields : 1 \| [Opened in readonly mode]
16-Jul-2026 02:38:02	2026-07-16 02:37:59 INFO SynthesisImagerVi2::selectData NRows selected : 7020
16-Jul-2026 02:38:02	2026-07-16 02:37:59 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.awp2] :
16-Jul-2026 02:38:02	2026-07-16 02:37:59 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.awp2] :
16-Jul-2026 02:38:02	2026-07-16 02:37:59 INFO SynthesisImagerVi2::defineImage Impars: start
16-Jul-2026 02:38:02	2026-07-16 02:37:59 INFO SynthesisImagerVi2::defineImage Shape: [1200, 1200, 2, 1] Spectral: [1.48111e+09] at [0] with increment [5.99947e+08]
16-Jul-2026 02:38:02	2026-07-16 02:37:59 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst.awp2] with ftmachine : awp2
16-Jul-2026 02:38:02	2026-07-16 02:37:59 INFO SynthesisImager::getVPRecord Using default Voltage Patterns from the VPManager
16-Jul-2026 02:38:02	2026-07-16 02:37:59 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 1.36 GB. Available mem.: 395.2 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
16-Jul-2026 02:38:02	2026-07-16 02:37:59 INFO SynthesisImagerVi2::weight() Set imaging weights : Uniform weighting: sidelobes will be suppressed over full image
16-Jul-2026 02:38:02	2026-07-16 02:38:00 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:38:02	2026-07-16 02:38:01 INFO tclean::::casa ...done
16-Jul-2026 02:38:02	2026-07-16 02:38:01 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:38:02	2026-07-16 02:38:01 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 MS : vla_wideband_2ptg_w_squint.ms \| Selecting on fields : 1 \| [Opened in readonly mode]
16-Jul-2026 02:38:02	2026-07-16 02:38:01 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 Selecting via TaQL : ROWNUMBER() >= 4683 && ROWNUMBER() <= 7020 \| NRows selected : 2338
16-Jul-2026 02:38:02	2026-07-16 02:38:01 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 MS : vla_wideband_2ptg_w_squint.ms \| Selecting on fields : 1 \| [Opened in readonly mode]
16-Jul-2026 02:38:02	2026-07-16 02:38:01 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 Selecting via TaQL : ROWNUMBER() >= 2342 && ROWNUMBER() <= 4682 \| NRows selected : 2341
16-Jul-2026 02:38:02	2026-07-16 02:38:01 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 MS : vla_wideband_2ptg_w_squint.ms \| Selecting on fields : 1 \| [Opened in readonly mode]
16-Jul-2026 02:38:02	2026-07-16 02:38:01 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 Selecting via TaQL : ROWNUMBER() >= 1 && ROWNUMBER() <= 2341 \| NRows selected : 2341
16-Jul-2026 02:38:02	2026-07-16 02:38:02 INFO tclean::::casa ...done
16-Jul-2026 02:38:02	2026-07-16 02:38:02 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n1] :
16-Jul-2026 02:38:02	2026-07-16 02:38:02 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n1] :
16-Jul-2026 02:38:02	2026-07-16 02:38:02 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Impars: start
16-Jul-2026 02:38:02	2026-07-16 02:38:02 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Shape: [1200, 1200, 2, 1] Spectral: [1.48111e+09] at [0] with increment [5.99947e+08]
16-Jul-2026 02:38:02	2026-07-16 02:38:02 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Set Gridding options for [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n1] with ftmachine : awp2
16-Jul-2026 02:38:02	2026-07-16 02:38:02 INFO MPICommandServer::command_request_handler_service::SynthesisImager::getVPRecord::MPIServer-1 Using default Voltage Patterns from the VPManager
16-Jul-2026 02:38:02	2026-07-16 02:38:02 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-1 Required memory: 1.36 GB. Available mem.: 395.2 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
16-Jul-2026 02:38:02	2026-07-16 02:38:03 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n2] :
16-Jul-2026 02:38:02	2026-07-16 02:38:03 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n2] :
16-Jul-2026 02:38:02	2026-07-16 02:38:03 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Impars: start
16-Jul-2026 02:38:02	2026-07-16 02:38:03 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Shape: [1200, 1200, 2, 1] Spectral: [1.48111e+09] at [0] with increment [5.99947e+08]
16-Jul-2026 02:38:02	2026-07-16 02:38:03 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Set Gridding options for [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n2] with ftmachine : awp2
16-Jul-2026 02:38:02	2026-07-16 02:38:03 INFO MPICommandServer::command_request_handler_service::SynthesisImager::getVPRecord::MPIServer-2 Using default Voltage Patterns from the VPManager
16-Jul-2026 02:38:02	2026-07-16 02:38:03 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-2 Required memory: 1.36 GB. Available mem.: 395.2 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
16-Jul-2026 02:38:02	2026-07-16 02:38:03 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:38:02	2026-07-16 02:38:03 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n3] :
16-Jul-2026 02:38:02	2026-07-16 02:38:03 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n3] :
16-Jul-2026 02:38:02	2026-07-16 02:38:03 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Impars: start
16-Jul-2026 02:38:02	2026-07-16 02:38:03 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Shape: [1200, 1200, 2, 1] Spectral: [1.48111e+09] at [0] with increment [5.99947e+08]
16-Jul-2026 02:38:02	2026-07-16 02:38:03 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Set Gridding options for [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n3] with ftmachine : awp2
16-Jul-2026 02:38:02	2026-07-16 02:38:03 INFO MPICommandServer::command_request_handler_service::SynthesisImager::getVPRecord::MPIServer-3 Using default Voltage Patterns from the VPManager
16-Jul-2026 02:40:00	2026-07-16 02:38:03 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-3 Required memory: 1.36 GB. Available mem.: 395.2 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
16-Jul-2026 02:40:00	2026-07-16 02:38:04 INFO tclean::::casa ...done
16-Jul-2026 02:40:00	2026-07-16 02:38:06 INFO SynthesisImagerVi2::selectData MS : vla_wideband_2ptg_w_squint.ms \| Selecting on fields : 1 \| [Opened in readonly mode]
16-Jul-2026 02:40:00	2026-07-16 02:38:06 INFO SynthesisImagerVi2::selectData NRows selected : 7020
16-Jul-2026 02:40:00	2026-07-16 02:38:06 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.awp2] :
16-Jul-2026 02:40:00	2026-07-16 02:38:06 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.awp2] :
16-Jul-2026 02:40:00	2026-07-16 02:38:06 INFO SynthesisImagerVi2::defineImage Impars: start
16-Jul-2026 02:40:00	2026-07-16 02:38:06 INFO SynthesisImagerVi2::defineImage Shape: [1200, 1200, 2, 1] Spectral: [1.48111e+09] at [0] with increment [5.99947e+08]
16-Jul-2026 02:40:00	2026-07-16 02:38:06 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst.awp2] with ftmachine : awp2
16-Jul-2026 02:40:00	2026-07-16 02:38:06 INFO SynthesisImager::getVPRecord Using default Voltage Patterns from the VPManager
16-Jul-2026 02:40:00	2026-07-16 02:38:06 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 1.36 GB. Available mem.: 395.2 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
16-Jul-2026 02:40:00	2026-07-16 02:38:06 INFO SynthesisImagerVi2::weight() Set imaging weights : Uniform weighting: sidelobes will be suppressed over full image
16-Jul-2026 02:40:00	2026-07-16 02:38:06 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:40:00	2026-07-16 02:38:07 INFO tclean::::casa ...done
16-Jul-2026 02:40:00	2026-07-16 02:38:07 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst.awp2] : hogbom
16-Jul-2026 02:40:00	2026-07-16 02:38:07 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:40:00	2026-07-16 02:38:08 INFO tclean::::casa ...done
16-Jul-2026 02:40:00	2026-07-16 02:38:08 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:40:00	2026-07-16 02:38:08 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-1 ----------------------------------------------------------- Make PSF ---------------------------------------------
16-Jul-2026 02:40:00	2026-07-16 02:38:08 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-3 ----------------------------------------------------------- Make PSF ---------------------------------------------
16-Jul-2026 02:40:00	2026-07-16 02:38:08 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-2 ----------------------------------------------------------- Make PSF ---------------------------------------------
16-Jul-2026 02:40:00	paMax 1.69476 painc 0.261799
16-Jul-2026 02:40:00	paMax 1.89109 painc 0.261799
16-Jul-2026 02:40:00	paMax 3.13298 painc 0.261799
16-Jul-2026 02:40:00
16-Jul-2026 02:40:00	0%....10....20....30....40....50....60....70....80....90....100%
16-Jul-2026 02:40:00	2026-07-16 02:39:50 INFO tclean::::casa ...done
16-Jul-2026 02:40:00	2026-07-16 02:39:50 INFO SynthesisNormalizer::gatherImages Gather psf,weight images : [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n1, /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n2, /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n3] onto :tst.awp2
16-Jul-2026 02:40:00	2026-07-16 02:39:51 INFO SIImageStore::calcSensitivity [tst.awp2] Theoretical sensitivity (Jy/bm):p0:0.00400186 p1:0.00400186
16-Jul-2026 02:40:00	2026-07-16 02:39:51 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.020886
16-Jul-2026 02:40:00	2026-07-16 02:39:51 INFO SIImageStore::printBeamSet Restoring Beams
16-Jul-2026 02:40:00	2026-07-16 02:39:51 INFO SIImageStore::printBeamSet + Chan Freq Vel Pol
16-Jul-2026 02:40:00	2026-07-16 02:39:51 INFO SIImageStore::printBeamSet + 0 1.5e+09 -70230 I 5.3459 arcsec x 4.3663 arcsec pa=-84.5374 deg
16-Jul-2026 02:40:00	2026-07-16 02:39:51 INFO SIImageStore::printBeamSet + 0 1.5e+09 -70230 V 5.3459 arcsec x 4.3663 arcsec pa=-84.5374 deg
16-Jul-2026 02:40:00	2026-07-16 02:39:51 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:40:00	2026-07-16 02:39:52 INFO tclean::::casa ...done
16-Jul-2026 02:40:00	2026-07-16 02:39:52 INFO SynthesisNormalizer::scatterModel Send the model from : tst.awp2 to all nodes :[/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n1, /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n2, /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n3]
16-Jul-2026 02:40:00	2026-07-16 02:39:52 INFO SIImageStore::setModelImageOne Copying input model tst.awp2.model to /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n1.model
16-Jul-2026 02:40:00	2026-07-16 02:39:52 INFO SIImageStore::setModelImageOne Copying input model tst.awp2.model to /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n2.model
16-Jul-2026 02:40:00	2026-07-16 02:39:52 INFO SIImageStore::setModelImageOne Copying input model tst.awp2.model to /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n3.model
16-Jul-2026 02:40:00	2026-07-16 02:39:52 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ----------------------------
16-Jul-2026 02:40:00	2026-07-16 02:39:52 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:40:00	2026-07-16 02:39:53 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
16-Jul-2026 02:40:00	2026-07-16 02:39:53 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
16-Jul-2026 02:40:00	2026-07-16 02:39:53 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
16-Jul-2026 02:40:00	2026-07-16 02:39:59 INFO tclean::::casa ...done
16-Jul-2026 02:40:00	2026-07-16 02:40:00 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n1, /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n2, /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n3] onto :tst.awp2
16-Jul-2026 02:40:00	2026-07-16 02:40:00 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0, over full image : 0.458244
16-Jul-2026 02:40:00	2026-07-16 02:40:00 INFO SynthesisDeconvolver::setupMask [tst.awp2] Initializing new mask to 1.0 for the full image
16-Jul-2026 02:40:00	2026-07-16 02:40:00 INFO SynthesisDeconvolver::setupMask [tst.awp2] Number of pixels in the clean mask : 2.88e+06 out of a total of 2.88e+06 pixels. [ 100 % ]
16-Jul-2026 02:40:00	2026-07-16 02:40:00 INFO SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.458244, over full image : 0.458244
16-Jul-2026 02:40:00	2026-07-16 02:40:00 INFO tclean::::casa Minor Cycle controls : {'cycleniter': 20, 'cyclethreshold': 0.022912221029400826, 'loopgain': 0.10000000149011612, 'nsigma': 0.0, 'thresholdreached': False}
16-Jul-2026 02:40:00	2026-07-16 02:40:00 INFO SDAlgorithmBase::deconvolve [tst.awp2] Run Hogbom minor-cycle on 2 pols \| CycleThreshold=0.0229122, CycleNiter=20, Gain=0.1
16-Jul-2026 02:40:00	2026-07-16 02:40:00 INFO SDAlgorithmBase::deconvolve [tst.awp2:P0] iters=0->20 [20], model=0->0.408104, peakres=0.458244->0.0501406, Reached cycleniter.
16-Jul-2026 02:40:00	2026-07-16 02:40:00 INFO SDAlgorithmBase::deconvolve [tst.awp2:P1] iters=20->20 [0], model=0->0, peakres=0.00489643->0.00489643, Reached cyclethreshold.
16-Jul-2026 02:40:00	2026-07-16 02:40:00 INFO SDAlgorithmBase::deconvolve [tst.awp2] Total model flux (over all planes) : 0.408104 Peak Residual (over all planes) : 0.0501406 in C0:P0
16-Jul-2026 02:40:00	2026-07-16 02:40:00 INFO grpcInteractiveCleanManager::mergeCycleExecutionRecord Completed 20 iterations.
16-Jul-2026 02:40:00	2026-07-16 02:40:00 INFO task_tclean::SynthesisNormalizer::scatterModel Send the model from : tst.awp2 to all nodes :[/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n1, /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n2, /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n3]
16-Jul-2026 02:40:00	2026-07-16 02:40:00 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst.awp2.model to /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n1.model
16-Jul-2026 02:40:30	2026-07-16 02:40:00 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst.awp2.model to /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n2.model
16-Jul-2026 02:40:30	2026-07-16 02:40:00 INFO task_tclean::SIImageStore::setModelImageOne Copying input model tst.awp2.model to /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n3.model
16-Jul-2026 02:40:30	2026-07-16 02:40:00 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ----------------------------
16-Jul-2026 02:40:30	2026-07-16 02:40:00 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:40:30	2026-07-16 02:40:00 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 2 -------------------------------------
16-Jul-2026 02:40:30	2026-07-16 02:40:01 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 2 -------------------------------------
16-Jul-2026 02:40:30	2026-07-16 02:40:01 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 2 -------------------------------------
16-Jul-2026 02:40:30
16-Jul-2026 02:40:30	0%....10....20....30....40....50....60....70....80....90....100%
16-Jul-2026 02:40:30
16-Jul-2026 02:40:30	0%....10....20....30....40....50....60....70....80....90....100%
16-Jul-2026 02:40:30	2026-07-16 02:40:14 INFO tclean::::casa ...done
16-Jul-2026 02:40:30	2026-07-16 02:40:14 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n1, /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n2, /home/casatest/work/test_task_tclean/tst.awp2.workdirectory/tst.awp2.n3] onto :tst.awp2
16-Jul-2026 02:40:30	2026-07-16 02:40:15 INFO task_tclean::SynthesisDeconvolver::initMinorCycle Absolute Peak residual within mask : 0.0626308, over full image : 0.0626308
16-Jul-2026 02:40:30	2026-07-16 02:40:15 INFO tclean::::casa Reached global stopping criterion : iteration limit
16-Jul-2026 02:40:30	2026-07-16 02:40:15 INFO tclean::::casa getSummary call: fullsummary=False
16-Jul-2026 02:40:30	2026-07-16 02:40:15 INFO SDAlgorithmBase::restore [tst.awp2] : Restoring model image.
16-Jul-2026 02:40:30	2026-07-16 02:40:15 INFO SIImageStore::restore Beam for chan : 0 : 5.34588 arcsec, 4.36629 arcsec, -84.5374 deg
16-Jul-2026 02:40:30	2026-07-16 02:40:15 INFO SIImageStore::restore Beam for chan : 0 : 5.34588 arcsec, 4.36629 arcsec, -84.5374 deg
16-Jul-2026 02:40:30	2026-07-16 02:40:15 INFO task_tclean::SDAlgorithmBase::pbcor [tst.awp2] : Applying PB correction
16-Jul-2026 02:40:30	2026-07-16 02:40:24 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:40:30	2026-07-16 02:40:25 INFO ::casa::MPIServer-2 node 2 has completed its job
16-Jul-2026 02:40:30	2026-07-16 02:40:25 INFO ::casa::MPIServer-1 node 1 has completed its job
16-Jul-2026 02:40:30	2026-07-16 02:40:25 INFO ::casa::MPIServer-3 node 3 has completed its job
16-Jul-2026 02:40:30	2026-07-16 02:40:25 INFO tclean::::casa ...done
16-Jul-2026 02:40:30	2026-07-16 02:40:25 INFO tclean::::casa Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed.
16-Jul-2026 02:40:30	2026-07-16 02:40:25 INFO tclean::::casa Searching for images with prefix 'tst.awp2'... Found these, writing history into them: ['tst.awp2.gridwt_moswt', 'tst.awp2.psf', 'tst.awp2.sumwt', 'tst.awp2.weight', 'tst.awp2.pb', 'tst.awp2.model', 'tst.awp2.residual', 'tst.awp2.mask', 'tst.awp2.image', 'tst.awp2.image.pbcor']
16-Jul-2026 02:40:30	2026-07-16 02:40:26 INFO tclean::::casa Task tclean complete. Start time: 2026-07-16 02:37:56.306326 End time: 2026-07-16 02:40:25.682699
16-Jul-2026 02:40:30	2026-07-16 02:40:26 INFO tclean::::casa ##### End Task: tclean #####
16-Jul-2026 02:40:30	2026-07-16 02:40:26 INFO tclean::::casa ##########################################
16-Jul-2026 02:40:30	2026-07-16 02:40:26 INFO name:: No table opened.
16-Jul-2026 02:40:30	2026-07-16 02:40:26 INFO showcache:: The Table Cache is empty.
16-Jul-2026 02:40:30	2026-07-16 02:40:26 INFO tclean::::casa [ checkall ]
16-Jul-2026 02:40:30	2026-07-16 02:40:26 INFO tclean::::casa+ [ check_ims ] Image made : ['tst.awp2.image'] = [True] ( Pass : should all be True )
16-Jul-2026 02:40:30	2026-07-16 02:40:26 INFO tclean::::casa+ All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords)
16-Jul-2026 02:40:30	2026-07-16 02:40:26 INFO tclean::::casa+ [check_history] All expected history entries found. (Pass)
16-Jul-2026 02:40:30	2026-07-16 02:40:26 INFO tclean::::casa+ [ check_pix_val ] tst.awp2.pb : Value is 0.6791477799415588 at [323, 858, 0, 0] ( Pass : should be 0.654 , Epsilon: 0.05)
16-Jul-2026 02:40:30	2026-07-16 02:40:26 INFO tclean::::casa+ [ check_pix_val ] tst.awp2.image.pbcor : Value is 0.6931255459785461 at [323, 858, 0, 0] ( Pass : should be 0.7 , Epsilon: 0.05)
16-Jul-2026 02:40:30	2026-07-16 02:40:26 INFO tclean::::casa+ [ check_pix_val ] tst.awp2.image.pbcor : Value is -0.02026747539639473 at [323, 858, 1, 0] ( Pass : should be -0.01 , Epsilon: 0.05)
16-Jul-2026 02:40:30	[ checkall ]
16-Jul-2026 02:40:30	[ check_ims ] Image made : ['tst.awp2.image'] = [True] ( Pass : should all be True )
16-Jul-2026 02:40:30	All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords)
16-Jul-2026 02:40:30	[check_history] All expected history entries found. (Pass)
16-Jul-2026 02:40:30	[ check_pix_val ] tst.awp2.pb : Value is 0.6791477799415588 at [323, 858, 0, 0] ( Pass : should be 0.654 , Epsilon: 0.05)
16-Jul-2026 02:40:30	[ check_pix_val ] tst.awp2.image.pbcor : Value is 0.6931255459785461 at [323, 858, 0, 0] ( Pass : should be 0.7 , Epsilon: 0.05)
16-Jul-2026 02:40:30	[ check_pix_val ] tst.awp2.image.pbcor : Value is -0.02026747539639473 at [323, 858, 1, 0] ( Pass : should be -0.01 , Epsilon: 0.05)
16-Jul-2026 02:40:30
16-Jul-2026 02:40:30	.2026-07-16 02:40:28 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 3
16-Jul-2026 02:40:30	2026-07-16 02:40:28 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 2
16-Jul-2026 02:40:30	2026-07-16 02:40:28 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 1
16-Jul-2026 02:40:30	2026-07-16 02:40:29 INFO tclean::::casa setupCluster, Setting up 3 engines.
16-Jul-2026 02:40:30	2026-07-16 02:40:29 INFO tclean::::casa ##########################################
16-Jul-2026 02:40:30	2026-07-16 02:40:29 INFO tclean::::casa ##### Begin Task: tclean #####
16-Jul-2026 02:40:30	2026-07-16 02:40:29 INFO tclean::::casa tclean( vis='refim_point_wterm_vlad.ms', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', observation='', intent='', datacolumn='corrected', imagename='tst.wyes', imsize=2048, cell='10.0arcsec', phasecenter='', stokes='I', projection='SIN', startmodel='', specmode='mfs', reffreq='', nchan=-1, start='', width='', outframe='LSRK', veltype='radio', restfreq=[], interpolation='linear', perchanweightdensity=True, gridder='wproject', facets=1, psfphasecenter='', wprojplanes=16, vptable='', mosweight=True, aterm=True, psterm=False, wbawp=True, conjbeams=False, cfcache='', usepointing=False, computepastep=360.0, rotatepastep=360.0, pointingoffsetsigdev=[], pblimit=-0.1, normtype='flatnoise', deconvolver='hogbom', scales=[], nterms=2, smallscalebias=0.0, fusedthreshold=0.0, largestscale=-1, restoration=True, restoringbeam=[], pbcor=False, outlierfile='', weighting='uniform', robust=0.5, noise='1.0Jy', npixels=0, uvtaper=[''], niter=0, gain=0.1, threshold=0.0, nsigma=0.0, cycleniter=-1, cyclefactor=1.0, minpsffraction=0.05, maxpsffraction=0.8, interactive=False, nmajor=-1, fullsummary=False, usemask='user', mask='', pbmask=0.0, sidelobethreshold=3.0, noisethreshold=5.0, lownoisethreshold=1.5, negativethreshold=0.0, smoothfactor=1.0, minbeamfrac=0.3, cutthreshold=0.01, growiterations=75, dogrowprune=True, minpercentchange=-1.0, verbose=False, fastnoise=True, restart=True, savemodel='none', calcres=True, calcpsf=True, psfcutoff=0.35, parallel=True )
16-Jul-2026 02:40:30	2026-07-16 02:40:29 INFO tclean::::casa Verifying Input Parameters
16-Jul-2026 02:40:30	2026-07-16 02:40:31 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 3
16-Jul-2026 02:40:30	2026-07-16 02:40:31 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 2
16-Jul-2026 02:40:39	2026-07-16 02:40:31 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal MPIEnvironment.command_handling_log_level = 'DEBUG' successfully handled by server 1
16-Jul-2026 02:40:39	2026-07-16 02:40:32 INFO tclean::::casa setupCluster, Setting up 3 engines.
16-Jul-2026 02:40:39	2026-07-16 02:40:32 INFO SynthesisUtilMethods::continuumDataPartition
16-Jul-2026 02:40:39	2026-07-16 02:40:32 INFO SynthesisUtilMethods::continuumDataPartition + Rows = 10065 15093 [P][M]: 0:2 ROWNUMBER() >= 10065 && ROWNUMBER() <= 15093
16-Jul-2026 02:40:39	2026-07-16 02:40:32 INFO tclean::::casa Partitioned Selection : {'0': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point_wterm_vlad.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 1 && ROWNUMBER() <= 5032', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '1': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point_wterm_vlad.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 5033 && ROWNUMBER() <= 10064', 'timestr': '', 'usescratch': False, 'uvdist': ''}}, '2': {'ms0': {'antenna': '', 'datacolumn': 'corrected', 'field': '', 'freqbeg': '', 'freqend': '', 'freqframe': 'LSRK', 'incrmodel': False, 'msname': 'refim_point_wterm_vlad.ms', 'obs': '', 'outframe': 'LSRK', 'readonly': True, 'scan': '', 'spw': '', 'state': '', 'taql': 'ROWNUMBER() >= 10065 && ROWNUMBER() <= 15093', 'timestr': '', 'usescratch': False, 'uvdist': ''}}}
16-Jul-2026 02:40:39	2026-07-16 02:40:32 INFO SynthesisImagerVi2::selectData MS : refim_point_wterm_vlad.ms \| [Opened in readonly mode]
16-Jul-2026 02:40:39	2026-07-16 02:40:32 INFO SynthesisImagerVi2::selectData NRows selected : 15093
16-Jul-2026 02:40:39	2026-07-16 02:40:32 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.wyes] :
16-Jul-2026 02:40:39	2026-07-16 02:40:32 INFO SynthesisImagerVi2::defineImage Define image coordinates for [tst.wyes] :
16-Jul-2026 02:40:39	2026-07-16 02:40:32 INFO SynthesisImagerVi2::defineImage Impars: start
16-Jul-2026 02:40:39	2026-07-16 02:40:32 INFO SynthesisImagerVi2::defineImage Shape: [2048, 2048, 1, 1] Spectral: [9.99981e+08] at [0] with increment [1.00218e+06]
16-Jul-2026 02:40:39	2026-07-16 02:40:32 INFO SynthesisImagerVi2::defineImage Set Gridding options for [tst.wyes] with ftmachine : wprojectft
16-Jul-2026 02:40:39	2026-07-16 02:40:32 INFO SynthesisImagerVi2::nSubCubeFitInMemory Required memory: 1.537 GB. Available mem.: 395.1 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
16-Jul-2026 02:40:39	2026-07-16 02:40:32 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:40:39	2026-07-16 02:40:33 INFO tclean::::casa ...done
16-Jul-2026 02:40:39	2026-07-16 02:40:33 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:40:39	2026-07-16 02:40:33 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 MS : refim_point_wterm_vlad.ms \| [Opened in readonly mode]
16-Jul-2026 02:40:39	2026-07-16 02:40:33 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-1 Selecting via TaQL : ROWNUMBER() >= 1 && ROWNUMBER() <= 5032 \| NRows selected : 5032
16-Jul-2026 02:40:39	2026-07-16 02:40:33 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 MS : refim_point_wterm_vlad.ms \| [Opened in readonly mode]
16-Jul-2026 02:40:39	2026-07-16 02:40:33 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-3 Selecting via TaQL : ROWNUMBER() >= 10065 && ROWNUMBER() <= 15093 \| NRows selected : 5029
16-Jul-2026 02:40:39	2026-07-16 02:40:33 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 MS : refim_point_wterm_vlad.ms \| [Opened in readonly mode]
16-Jul-2026 02:40:39	2026-07-16 02:40:33 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::selectData::MPIServer-2 Selecting via TaQL : ROWNUMBER() >= 5033 && ROWNUMBER() <= 10064 \| NRows selected : 5032
16-Jul-2026 02:40:39	2026-07-16 02:40:34 INFO tclean::::casa ...done
16-Jul-2026 02:40:39	2026-07-16 02:40:35 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.wyes.workdirectory/tst.wyes.n1] :
16-Jul-2026 02:40:39	2026-07-16 02:40:35 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.wyes.workdirectory/tst.wyes.n1] :
16-Jul-2026 02:40:39	2026-07-16 02:40:35 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Impars: start
16-Jul-2026 02:40:39	2026-07-16 02:40:35 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Shape: [2048, 2048, 1, 1] Spectral: [9.99981e+08] at [0] with increment [1.00218e+06]
16-Jul-2026 02:40:39	2026-07-16 02:40:35 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-1 Set Gridding options for [/home/casatest/work/test_task_tclean/tst.wyes.workdirectory/tst.wyes.n1] with ftmachine : wprojectft
16-Jul-2026 02:40:39	2026-07-16 02:40:35 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-1 Required memory: 1.537 GB. Available mem.: 395.1 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
16-Jul-2026 02:40:39	2026-07-16 02:40:35 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.wyes.workdirectory/tst.wyes.n2] :
16-Jul-2026 02:40:39	2026-07-16 02:40:35 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.wyes.workdirectory/tst.wyes.n2] :
16-Jul-2026 02:40:39	2026-07-16 02:40:35 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Impars: start
16-Jul-2026 02:40:39	2026-07-16 02:40:35 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Shape: [2048, 2048, 1, 1] Spectral: [9.99981e+08] at [0] with increment [1.00218e+06]
16-Jul-2026 02:40:39	2026-07-16 02:40:35 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-2 Set Gridding options for [/home/casatest/work/test_task_tclean/tst.wyes.workdirectory/tst.wyes.n2] with ftmachine : wprojectft
16-Jul-2026 02:40:39	2026-07-16 02:40:35 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-2 Required memory: 1.537 GB. Available mem.: 395.1 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
16-Jul-2026 02:40:39	2026-07-16 02:40:36 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:40:39	2026-07-16 02:40:36 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.wyes.workdirectory/tst.wyes.n3] :
16-Jul-2026 02:40:39	2026-07-16 02:40:36 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Define image coordinates for [/home/casatest/work/test_task_tclean/tst.wyes.workdirectory/tst.wyes.n3] :
16-Jul-2026 02:40:39	2026-07-16 02:40:36 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Impars: start
16-Jul-2026 02:40:39	2026-07-16 02:40:36 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Shape: [2048, 2048, 1, 1] Spectral: [9.99981e+08] at [0] with increment [1.00218e+06]
16-Jul-2026 02:40:39	2026-07-16 02:40:36 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::defineImage::MPIServer-3 Set Gridding options for [/home/casatest/work/test_task_tclean/tst.wyes.workdirectory/tst.wyes.n3] with ftmachine : wprojectft
16-Jul-2026 02:40:39	2026-07-16 02:40:36 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::nSubCubeFitInMemory::MPIServer-3 Required memory: 1.537 GB. Available mem.: 395.1 GB (rc, mem. fraction: 80%, memory: -) => Subcubes: 1. Processes on node: 4.
16-Jul-2026 02:40:39	2026-07-16 02:40:37 INFO tclean::::casa ...done
16-Jul-2026 02:40:39	2026-07-16 02:40:39 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:40:51	2026-07-16 02:40:39 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-1 Set imaging weights : Uniform weighting: sidelobes will be suppressed over full image
16-Jul-2026 02:40:51	2026-07-16 02:40:39 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-3 Set imaging weights : Uniform weighting: sidelobes will be suppressed over full image
16-Jul-2026 02:40:51	2026-07-16 02:40:39 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::weight()::MPIServer-2 Set imaging weights : Uniform weighting: sidelobes will be suppressed over full image
16-Jul-2026 02:40:51	2026-07-16 02:40:40 INFO tclean::::casa ...done
16-Jul-2026 02:40:51	2026-07-16 02:40:40 INFO tclean::::casa Gathering/Merging/Scattering Weight Density for PSF generation
16-Jul-2026 02:40:51	2026-07-16 02:40:40 INFO tclean::::casa ******************************************************
16-Jul-2026 02:40:51	2026-07-16 02:40:40 INFO tclean::::casa gather and scatter now
16-Jul-2026 02:40:51	2026-07-16 02:40:40 INFO tclean::::casa ******************************************************
16-Jul-2026 02:40:51	2026-07-16 02:40:40 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:40:51	2026-07-16 02:40:41 INFO tclean::::casa ...done
16-Jul-2026 02:40:51	2026-07-16 02:40:41 INFO SynthesisNormalizer::scatterWeightDensity Send the gridded weight from : tst.wyes to all nodes :[/home/casatest/work/test_task_tclean/tst.wyes.workdirectory/tst.wyes.n1, /home/casatest/work/test_task_tclean/tst.wyes.workdirectory/tst.wyes.n2, /home/casatest/work/test_task_tclean/tst.wyes.workdirectory/tst.wyes.n3]
16-Jul-2026 02:40:51	2026-07-16 02:40:41 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:40:51	2026-07-16 02:40:42 INFO tclean::::casa ...done
16-Jul-2026 02:40:51	2026-07-16 02:40:42 INFO task_tclean::SynthesisDeconvolver::setupDeconvolution Set Deconvolution Options for [tst.wyes] : hogbom
16-Jul-2026 02:40:51	2026-07-16 02:40:42 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:40:51	2026-07-16 02:40:43 INFO tclean::::casa ...done
16-Jul-2026 02:40:51	2026-07-16 02:40:43 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:40:51	2026-07-16 02:40:43 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-1 ----------------------------------------------------------- Make PSF ---------------------------------------------
16-Jul-2026 02:40:51	2026-07-16 02:40:43 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-3 ----------------------------------------------------------- Make PSF ---------------------------------------------
16-Jul-2026 02:40:51	2026-07-16 02:40:44 INFO MPICommandServer::command_request_handler_service::SynthesisImager::makePSF::MPIServer-2 ----------------------------------------------------------- Make PSF ---------------------------------------------
16-Jul-2026 02:40:51	2026-07-16 02:40:44 INFO MPICommandServer::command_request_handler_service::WPConvFunc::findConvFunction::MPIServer-3 W projection using 16 planes
16-Jul-2026 02:40:51	2026-07-16 02:40:44 INFO MPICommandServer::command_request_handler_service::WPConvFunc::findConvFunction::MPIServer-3 Using maximum possible W = 5156.62 (wavelengths)
16-Jul-2026 02:40:51	2026-07-16 02:40:44 INFO MPICommandServer::command_request_handler_service::WPConvFunc::findConvFunction::MPIServer-3 Typical wavelength = 0.299798 (m)
16-Jul-2026 02:40:51	2026-07-16 02:40:44 INFO MPICommandServer::command_request_handler_service::WPConvFunc::findConvFunction::MPIServer-3 Scaling in W (at maximum W) = 22.9183 wavelengths per pixel
16-Jul-2026 02:40:51	2026-07-16 02:40:44 INFO MPICommandServer::command_request_handler_service::WPConvFunc::findConvFunction::MPIServer-1 W projection using 16 planes
16-Jul-2026 02:40:51	2026-07-16 02:40:44 INFO MPICommandServer::command_request_handler_service::WPConvFunc::findConvFunction::MPIServer-1 Using maximum possible W = 5156.62 (wavelengths)
16-Jul-2026 02:40:51	2026-07-16 02:40:44 INFO MPICommandServer::command_request_handler_service::WPConvFunc::findConvFunction::MPIServer-1 Typical wavelength = 0.299798 (m)
16-Jul-2026 02:40:51	2026-07-16 02:40:44 INFO MPICommandServer::command_request_handler_service::WPConvFunc::findConvFunction::MPIServer-1 Scaling in W (at maximum W) = 22.9183 wavelengths per pixel
16-Jul-2026 02:40:51	2026-07-16 02:40:44 INFO MPICommandServer::command_request_handler_service::WPConvFunc::findConvFunction::MPIServer-2 W projection using 16 planes
16-Jul-2026 02:40:51	2026-07-16 02:40:44 INFO MPICommandServer::command_request_handler_service::WPConvFunc::findConvFunction::MPIServer-2 Using maximum possible W = 5156.62 (wavelengths)
16-Jul-2026 02:40:51	2026-07-16 02:40:44 INFO MPICommandServer::command_request_handler_service::WPConvFunc::findConvFunction::MPIServer-2 Typical wavelength = 0.299798 (m)
16-Jul-2026 02:40:51	2026-07-16 02:40:44 INFO MPICommandServer::command_request_handler_service::WPConvFunc::findConvFunction::MPIServer-2 Scaling in W (at maximum W) = 22.9183 wavelengths per pixel
16-Jul-2026 02:40:51	2026-07-16 02:40:48 INFO MPICommandServer::command_request_handler_service::WPConvFunc::findConvFunction::MPIServer-3 Convolution support = [16, 16, 20, 20, 24, 32, 36, 44, 52, 64, 72, 84, 96, 112, 124, 140] pixels in Fourier plane
16-Jul-2026 02:40:51	2026-07-16 02:40:48 INFO MPICommandServer::command_request_handler_service::WPConvFunc::findConvFunction::MPIServer-3 Memory used in gridding function = 2 MB from maximum 515213 MB
16-Jul-2026 02:40:51	2026-07-16 02:40:48 INFO MPICommandServer::command_request_handler_service::WPConvFunc::findConvFunction::MPIServer-1 Convolution support = [16, 16, 20, 20, 24, 32, 36, 44, 52, 64, 72, 84, 96, 112, 124, 140] pixels in Fourier plane
16-Jul-2026 02:40:51	2026-07-16 02:40:48 INFO MPICommandServer::command_request_handler_service::WPConvFunc::findConvFunction::MPIServer-1 Memory used in gridding function = 2 MB from maximum 515213 MB
16-Jul-2026 02:40:51	2026-07-16 02:40:48 INFO MPICommandServer::command_request_handler_service::WPConvFunc::findConvFunction::MPIServer-2 Convolution support = [16, 16, 20, 20, 24, 32, 36, 44, 52, 64, 72, 84, 96, 112, 124, 140] pixels in Fourier plane
16-Jul-2026 02:40:51	2026-07-16 02:40:48 INFO MPICommandServer::command_request_handler_service::WPConvFunc::findConvFunction::MPIServer-2 Memory used in gridding function = 2 MB from maximum 515213 MB
16-Jul-2026 02:40:51	2026-07-16 02:40:49 INFO tclean::::casa ...done
16-Jul-2026 02:40:51	2026-07-16 02:40:49 INFO SynthesisNormalizer::gatherImages Gather psf,weight images : [/home/casatest/work/test_task_tclean/tst.wyes.workdirectory/tst.wyes.n1, /home/casatest/work/test_task_tclean/tst.wyes.workdirectory/tst.wyes.n2, /home/casatest/work/test_task_tclean/tst.wyes.workdirectory/tst.wyes.n3] onto :tst.wyes
16-Jul-2026 02:40:51	2026-07-16 02:40:50 INFO SIImageStore::calcSensitivity [tst.wyes] Theoretical sensitivity (Jy/bm):0.00632763
16-Jul-2026 02:40:51	2026-07-16 02:40:50 INFO SIImageStore::getPSFGaussian Time to fit Gaussian to PSF 0.033195
16-Jul-2026 02:40:51	2026-07-16 02:40:50 INFO SIImageStore::printBeamSet Beam : 85.3971 arcsec, 71.2504 arcsec, -89.0441 deg
16-Jul-2026 02:40:51	2026-07-16 02:40:50 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:40:51	2026-07-16 02:40:50 INFO MPICommandServer::command_request_handler_service::SynthesisImagerVi2::makePrimaryBeam::MPIServer-1 vi2 : Evaluating Primary Beam model onto image grid(s)
16-Jul-2026 02:40:51	2026-07-16 02:40:51 INFO tclean::::casa ...done
16-Jul-2026 02:40:51	2026-07-16 02:40:51 INFO SynthesisNormalizer::scatterModel Send the model from : tst.wyes to all nodes :[/home/casatest/work/test_task_tclean/tst.wyes.workdirectory/tst.wyes.n1, /home/casatest/work/test_task_tclean/tst.wyes.workdirectory/tst.wyes.n2, /home/casatest/work/test_task_tclean/tst.wyes.workdirectory/tst.wyes.n3]
16-Jul-2026 02:40:51	2026-07-16 02:40:51 INFO SIImageStore::setModelImageOne Starting model image tst.wyes.model does not exist. No initial prediction will be done
16-Jul-2026 02:40:51	2026-07-16 02:40:51 INFO SIImageStore::setModelImageOne Starting model image tst.wyes.model does not exist. No initial prediction will be done
16-Jul-2026 02:40:51	2026-07-16 02:40:51 INFO SIImageStore::setModelImageOne Starting model image tst.wyes.model does not exist. No initial prediction will be done
16-Jul-2026 02:40:51	2026-07-16 02:40:51 INFO tclean::::casa ----------------------------- Running Parallel Major Cycle ----------------------------
16-Jul-2026 02:40:51	2026-07-16 02:40:51 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:40:51	2026-07-16 02:40:51 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-1 ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
16-Jul-2026 02:41:19	2026-07-16 02:40:51 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-2 ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
16-Jul-2026 02:41:19	2026-07-16 02:40:51 INFO MPICommandServer::command_request_handler_service::SynthesisImager::executeMajorCycle::MPIServer-3 ----------------------------------------------------------- Run Major Cycle 1 -------------------------------------
16-Jul-2026 02:41:19	2026-07-16 02:40:53 INFO tclean::::casa ...done
16-Jul-2026 02:41:19	2026-07-16 02:40:53 INFO SynthesisNormalizer::gatherImages Gather residual images : [/home/casatest/work/test_task_tclean/tst.wyes.workdirectory/tst.wyes.n1, /home/casatest/work/test_task_tclean/tst.wyes.workdirectory/tst.wyes.n2, /home/casatest/work/test_task_tclean/tst.wyes.workdirectory/tst.wyes.n3] onto :tst.wyes
16-Jul-2026 02:41:19	2026-07-16 02:40:53 INFO task_tclean::SDAlgorithmBase::restore [tst.wyes] : Restoring model image.
16-Jul-2026 02:41:19	2026-07-16 02:40:53 WARN task_tclean::SIImageStore::restore (file /source/casa6/casatools/src/code/synthesis/ImagerObjects/SIImageStore.cc, line 2353) Restoring with an empty model image. Only residuals will be processed to form the output restored image.
16-Jul-2026 02:41:19	2026-07-16 02:40:54 INFO task_tclean::SIImageStore::restore Beam for chan : 0 : 85.3971 arcsec, 71.2504 arcsec, -89.0441 deg
16-Jul-2026 02:41:19	2026-07-16 02:41:02 INFO tclean::::casa checkJobs. Blocking for nodes to finish
16-Jul-2026 02:41:19	2026-07-16 02:41:02 INFO ::casa::MPIServer-1 node 1 has completed its job
16-Jul-2026 02:41:19	2026-07-16 02:41:02 INFO ::casa::MPIServer-2 node 2 has completed its job
16-Jul-2026 02:41:19	2026-07-16 02:41:02 INFO ::casa::MPIServer-3 node 3 has completed its job
16-Jul-2026 02:41:19	2026-07-16 02:41:03 INFO tclean::::casa ...done
16-Jul-2026 02:41:19	2026-07-16 02:41:03 INFO tclean::::casa Ending use of cluster, but not closing it. Call clustermanager.stop_cluster() to close it if needed.
16-Jul-2026 02:41:19	2026-07-16 02:41:03 INFO tclean::::casa Searching for images with prefix 'tst.wyes'... Found these, writing history into them: ['tst.wyes.gridwt_temp', 'tst.wyes.psf', 'tst.wyes.sumwt', 'tst.wyes.pb', 'tst.wyes.residual', 'tst.wyes.image', 'tst.wyes.model']
16-Jul-2026 02:41:19	2026-07-16 02:41:03 INFO tclean::::casa Task tclean complete. Start time: 2026-07-16 02:40:29.327169 End time: 2026-07-16 02:41:02.715295
16-Jul-2026 02:41:19	2026-07-16 02:41:03 INFO tclean::::casa ##### End Task: tclean #####
16-Jul-2026 02:41:19	2026-07-16 02:41:03 INFO tclean::::casa ##########################################
16-Jul-2026 02:41:19	2026-07-16 02:41:03 INFO name:: No table opened.
16-Jul-2026 02:41:19	2026-07-16 02:41:03 INFO showcache:: The Table Cache is empty.
16-Jul-2026 02:41:19	[check_tfmask] T/F mask name for tst.wyes.image is : ['T'] (Pass : should be ['T'])
16-Jul-2026 02:41:19
16-Jul-2026 02:41:19	2026-07-16 02:41:03 INFO tclean::::casa [ checkall ]
16-Jul-2026 02:41:19	2026-07-16 02:41:03 INFO tclean::::casa+ [ check_ims ] Image made : ['tst.wyes.image'] = [True] ( Pass : should all be True )
16-Jul-2026 02:41:19	2026-07-16 02:41:03 INFO tclean::::casa+ All expected keywords in imageinfo, miscinfo, and coords found. (check_keywords)
16-Jul-2026 02:41:19	2026-07-16 02:41:03 INFO tclean::::casa+ [check_history] All expected history entries found. (Pass)
16-Jul-2026 02:41:19	2026-07-16 02:41:03 INFO tclean::::casa+ [ check_pix_val ] tst.wyes.psf : Value is 1.0 at [1024, 1024, 0, 0] ( Pass : should be 1.0 , Epsilon: 0.05)
16-Jul-2026 02:41:19	2026-07-16 02:41:03 INFO tclean::::casa+ [ check_pix_val ] tst.wyes.image : Value is 0.9963292479515076 at [1158, 1384, 0, 0] ( Pass : should be 1.0 , Epsilon: 0.05)
16-Jul-2026 02:41:19	2026-07-16 02:41:03 INFO tclean::::casa+ [check_tfmask] T/F mask name for tst.wyes.image is : ['T'] (Pass : should be ['T'])
16-Jul-2026 02:41:19	.s
16-Jul-2026 02:41:19	----------------------------------------------------------------------
16-Jul-2026 02:41:19	Ran 338 tests in 13427.893s
16-Jul-2026 02:41:19
16-Jul-2026 02:41:19	OK (skipped=32)
16-Jul-2026 02:41:19	Marking test as passed.
16-Jul-2026 02:41:19	2026-07-16 02:41:10 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal self.signal_stop_virtual_frame_buffer() successfully handled by server 3
16-Jul-2026 02:41:19	2026-07-16 02:41:10 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal self.signal_stop_virtual_frame_buffer() successfully handled by server 2
16-Jul-2026 02:41:19	2026-07-16 02:41:10 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal self.signal_stop_virtual_frame_buffer() successfully handled by server 1
16-Jul-2026 02:41:19	2026-07-16 02:41:13 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Control signal self.signal_stop_service_request() successfully handled by server 3
16-Jul-2026 02:41:19	2026-07-16 02:41:13 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Control signal self.signal_stop_service_request() successfully handled by server 2
16-Jul-2026 02:41:19	2026-07-16 02:41:13 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Control signal self.signal_stop_service_request() successfully handled by server 1
16-Jul-2026 02:41:19	2026-07-16 02:41:16 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 stop service signal received, stopping services...
16-Jul-2026 02:41:19	2026-07-16 02:41:16 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 stop service signal received, stopping services...
16-Jul-2026 02:41:19	2026-07-16 02:41:16 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 stop service signal received, stopping services...
16-Jul-2026 02:41:19	2026-07-16 02:41:19 INFO MPICommandServer::stop_command_request_handler_service::MPICommandServer::stop_command_request_handler_service::casa::MPIServer-1 MPI command request handler service stopped
16-Jul-2026 02:41:19	2026-07-16 02:41:19 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Going to finalize MPI environment
16-Jul-2026 02:41:19	2026-07-16 02:41:19 INFO MPICommandServer::stop_command_request_handler_service::MPICommandServer::stop_command_request_handler_service::casa::MPIServer-3 MPI command request handler service stopped
16-Jul-2026 02:41:19	2026-07-16 02:41:19 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Going to finalize MPI environment
16-Jul-2026 02:41:19	2026-07-16 02:41:19 INFO MPICommandServer::stop_command_request_handler_service::MPICommandServer::stop_command_request_handler_service::casa::MPIServer-2 MPI command request handler service stopped
16-Jul-2026 02:41:19	2026-07-16 02:41:19 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Going to finalize MPI environment
16-Jul-2026 02:41:19	2026-07-16 02:41:19 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-1 Exiting
16-Jul-2026 02:41:19	2026-07-16 02:41:19 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-2 Exiting
16-Jul-2026 02:41:19	2026-07-16 02:41:19 INFO MPICommandServer::serve::MPICommandServer::serve::casa::MPIServer-3 Exiting
16-Jul-2026 02:41:19	Executor result: 0
16-Jul-2026 02:41:19	Failed tests:[]
16-Jul-2026 02:41:19
16-Jul-2026 02:41:19	Results: [{'testname': 'test_task_tclean', 'runtime': '3:44:08.607519', 'returncode': 0, 'testerr': []}]
16-Jul-2026 02:41:19	Stopping Xvfb.
16-Jul-2026 02:41:19	Stopping framebuffer <Popen: returncode: None args: ['Xvfb', ':133', '-screen', '0', '2048x2048x2...>
16-Jul-2026 02:41:19	Virtual frame buffer deployed at :133 with pid 144 successfully shutdown
16-Jul-2026 02:41:19	Xvfb stopped.
16-Jul-2026 02:41:20	total 1618664
16-Jul-2026 02:41:20	-rw-r--r-- 1 casaci 15001 1657506024 Jul 15 22:55 casa-6.7.6-11-py3.12.el9.tar.xz
16-Jul-2026 02:41:20	-rw-r--r-- 1 casaci casatest 327 Jul 16 02:41 xUnit-suite-mpi-8.xml
16-Jul-2026 02:41:20	Finished task 'MPI Tasks Tests on EL8' with result: Success
16-Jul-2026 02:41:20	Starting task 'Parse test results' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
16-Jul-2026 02:41:20	Parsing test results under /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-MASTERTESTCASALITHPY312-MTTR95DML234...
16-Jul-2026 02:41:20	Finished task 'Parse test results' with result: Success
16-Jul-2026 02:41:20	Substituting variable: ${bamboo.capability.hostname} with cvpost134
16-Jul-2026 02:41:20	Substituting variable: ${bamboo.capability.hostname} with cvpost134
16-Jul-2026 02:41:20	Starting task 'Cleanup' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
16-Jul-2026 02:41:20	Beginning to execute external process for build 'CASASPECS - Master Test Casalith 3.12 - Test MPI Task Tclean Many Linux 2.34 Rocky 9.5 Docker #279 (CASASPECS-MASTERTESTCASALITHPY312-MTTR95DML234-279)' ... running command line: /export/cvpost134-nvme/casa/bamboohome/temp/CASASPECS-MASTERTESTCASALITHPY312-MTTR95DML234-279-ScriptBuildTask-5092408979334336405.sh ... in: /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-MASTERTESTCASALITHPY312-MTTR95DML234 bamboo_planRepository_1_branch=master bamboo_dependency_parent_0=CASASPECS-MASTERBUILDCASALITH-277 bamboo_jira_components= bamboo_repository_136380562_name=casa6 bamboo_dependency_parent_total=1 bamboo_planRepository_1_branchDisplayName=master bamboo_repository_revision_number=350d94ec32491983c2ac6a838a3d80a0a5c85748 bamboo_resultsUrl=https://open-bamboo.nrao.edu/browse/CASASPECS-MASTERTESTCASALITHPY312-MTTR95DML234-279 bamboo_repository_136380562_git_branch=master bamboo_build_working_directory=/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-MASTERTESTCASALITHPY312-MTTR95DML234 bamboo_planRepository_1_name=casa6 bamboo_buildKey=CASASPECS-MASTERTESTCASALITHPY312-MTTR95DML234 bamboo_shortPlanName=Master Test Casalith 3.12 bamboo_capability_hostname=cvpost134 bamboo_planRepository_name=casa6 bamboo_python_version=3.12 bamboo_buildNumber=279 bamboo_simpleBuildTimeStamp=20260715144436 bamboo_shortJobName=Test MPI Task Tclean Many Linux 2.34 Rocky 9.5 Docker bamboo_buildResultsUrl=https://open-bamboo.nrao.edu/browse/CASASPECS-MASTERTESTCASALITHPY312-MTTR95DML234-279 bamboo_repository_136380562_branch_name=master bamboo_planRepository_repositoryUrl=ssh://git@open-bitbucket.nrao.edu:7999/casa/casa6.git bamboo_atlutil_user=casaadm bamboo_ManualBuildTriggerReason_stageName=Default Stage bamboo_agentId=78741505 bamboo_planName=CASASPECS - Master Test Casalith 3.12 bamboo_shortPlanKey=MASTERTESTCASALITHPY312 bamboo_rocky8_docker_image=casa-docker.nrao.edu:5000/casa-test-rocky-8.10:4 bamboo_shortJobKey=MTTR95DML234 bamboo_rocky9_docker_image=casa-docker.nrao.edu:5000/casa-test-rocky-9.5:1 bamboo_planRepository_revision=350d94ec32491983c2ac6a838a3d80a0a5c85748 bamboo_repository_previous_revision_number=29b9e60ff5efac7662bc3995bc056d79878deb05 bamboo_buildTimeStamp=2026-07-15T14:44:36.980-04:00 bamboo_build_commandline_com_atlassian_bamboo_plugins_scripttask_task_builder_script_3=/export/cvpost134-nvme/casa/bamboohome/temp/CASASPECS-MASTERTESTCASALITHPY312-MTTR95DML234-279-ScriptBuildTask-16836864702763898453.sh bamboo_planRepository_previousRevision=29b9e60ff5efac7662bc3995bc056d79878deb05 bamboo_build_commandline_com_atlassian_bamboo_plugins_scripttask_task_builder_script_5=/export/cvpost134-nvme/casa/bamboohome/temp/CASASPECS-MASTERTESTCASALITHPY312-MTTR95DML234-279-ScriptBuildTask-2328642072850266891.sh bamboo_build_commandline_com_atlassian_bamboo_plugins_scripttask_task_builder_script_4=/export/cvpost134-nvme/casa/bamboohome/temp/CASASPECS-MASTERTESTCASALITHPY312-MTTR95DML234-279-ScriptBuildTask-13331675961558741402.sh bamboo_repository_git_branch=master bamboo_buildResultKey=CASASPECS-MASTERTESTCASALITHPY312-MTTR95DML234-279 bamboo_repository_branch_name=master bamboo_buildPlanName=CASASPECS - Master Test Casalith 3.12 - Test MPI Task Tclean Many Linux 2.34 Rocky 9.5 Docker bamboo_planRepository_1_revision=350d94ec32491983c2ac6a838a3d80a0a5c85748 bamboo_repository_136380562_revision_number=350d94ec32491983c2ac6a838a3d80a0a5c85748 bamboo_repository_name=casa6 bamboo_buildFailed=false bamboo_capability_system_docker_executable=/usr/bin/docker bamboo_planRepository_branch=master bamboo_agentWorkingDirectory=/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir bamboo_capability_system_git_executable=/usr/bin/git bamboo_capability_system_jdk_JDK_17=/usr/lib/jvm/java-17-openjdk-17.0.12.0.7-2.el8.x86_64 bamboo_repository_git_username= bamboo_planRepository_1_previousRevision=29b9e60ff5efac7662bc3995bc056d79878deb05 bamboo_planRepository_branchDisplayName=master bamboo_planRepository_1_type=bbserver bamboo_planRepository_branchName=master bamboo_shortPlanBranchName= bamboo_capability_system_jdk_JDK=/usr/lib/jvm/java-17-openjdk-17.0.12.0.7-2.el8.x86_64 bamboo_atlutil_password=******** bamboo_plan_storageTag=plan-130056254 bamboo_planRepository_1_username= bamboo_planRepository_type=bbserver bamboo_git_cache_directory=/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/_git-repositories-cache bamboo_ManualBuildTriggerReason_userName=awells bamboo_repository_git_repositoryUrl=ssh://git@open-bitbucket.nrao.edu:7999/casa/casa6.git bamboo_DependencyTriggerReason_triggeringBuildResultKey=CASASPECS-MASTERBUILDCASALITH-277 bamboo_testlist= bamboo_tmp_directory=/export/cvpost134-nvme/casa/bamboohome/temp bamboo_working_directory=/export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-MASTERTESTCASALITHPY312-MTTR95DML234 bamboo_planKey=CASASPECS-MASTERTESTCASALITHPY312 bamboo_RerunBuildTriggerReason_noOfRetries=1 bamboo_planRepository_1_repositoryUrl=ssh://git@open-bitbucket.nrao.edu:7999/casa/casa6.git bamboo_capability_system_jdk_JDK_17_0_12__JRE_=/usr/lib/jvm/java-17-openjdk-17.0.12.0.7-2.el8.x86_64 bamboo_planRepository_username= bamboo_repository_136380562_git_repositoryUrl=ssh://git@open-bitbucket.nrao.edu:7999/casa/casa6.git bamboo_triggerReason_key=com.atlassian.bamboo.plugin.system.triggerReason:RerunBuildTriggerReason bamboo_repository_136380562_previous_revision_number=29b9e60ff5efac7662bc3995bc056d79878deb05 bamboo_capability_gpu_installed=true bamboo_repository_136380562_git_username= bamboo_ubuntu_docker_image=casa-docker.nrao.edu:5000/casa-test-ubuntu-24.04:2 bamboo_planRepository_1_branchName=master
16-Jul-2026 02:41:20	Starting cleanup
16-Jul-2026 02:41:30	test-container
16-Jul-2026 02:41:35	test-container
16-Jul-2026 02:41:35	Error response from daemon: No such container: test-container-cvpost134
16-Jul-2026 02:41:35	Error response from daemon: No such container: test-container-cvpost134
16-Jul-2026 02:41:35	Cleanup complete
16-Jul-2026 02:41:35	Finished task 'Cleanup' with result: Success
16-Jul-2026 02:41:35	Running post build plugin 'Docker Container Cleanup'
16-Jul-2026 02:41:35	Running post build plugin 'NCover Results Collector'
16-Jul-2026 02:41:35	Running post build plugin 'Build Results Label Collector'
16-Jul-2026 02:41:35	Running post build plugin 'Clover Results Collector'
16-Jul-2026 02:41:35	Running post build plugin 'npm Cache Cleanup'
16-Jul-2026 02:41:35	Running post build plugin 'Artifact Copier'
16-Jul-2026 02:41:35	Finalising the build...
16-Jul-2026 02:41:35	Stopping timer.
16-Jul-2026 02:41:35	Build CASASPECS-MASTERTESTCASALITHPY312-MTTR95DML234-279 completed.
15-Jul-2026 22:41:35	Running on server: post build plugin 'Build Hanging Detection Configuration'
15-Jul-2026 22:41:35	Running on server: post build plugin 'NCover Results Collector'
15-Jul-2026 22:41:35	Running on server: post build plugin 'Build Labeller'
15-Jul-2026 22:41:35	Running on server: post build plugin 'Clover Delta Calculator'
15-Jul-2026 22:41:35	Running on server: post build plugin 'Maven Dependencies Postprocessor'
15-Jul-2026 22:41:35	All post build plugins have finished
15-Jul-2026 22:41:35	Generating build results summary...
15-Jul-2026 22:41:35	Saving build results to disk...
15-Jul-2026 22:41:35	Store variable context...
15-Jul-2026 22:41:35	Finished building CASASPECS-MASTERTESTCASALITHPY312-MTTR95DML234-279.

Older logs

Filename	Actions
plan-130056254-MTTR95DML234-279.log.1	Download or view

Build: #279 failed

Job: Test MPI Task Tclean Many Linux 2.34 Rocky 9.5 Docker was successful

Stages & jobs

Default Stage

Build log

Older logs

Build #279

Build: #279 failed

Job: Test MPI Task Tclean Many Linux 2.34 Rocky 9.5 Docker was successful

Stages & jobs

Default Stage

Build log

Older logs