Build: #1 was successful

Job: Test Tasks Many Linux 2.28 Python3.12 was successful

Build log

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

29-Aug-2025 15:45:49
29-Aug-2025 15:45:49 pol0 & pol1 ch 125: diff between 1/SIGMA**2 X 1/(FPARAM[125])**2 and WEIGHT_SPECTRUM[125] 8.146243521878205e-05 0.00020233114491929882
29-Aug-2025 15:45:49 4.334441717664649e-06 % 8.723969173137133e-06 %
29-Aug-2025 15:45:49
29-Aug-2025 15:45:49 pol0 & pol1 ch 126: diff between 1/SIGMA**2 X 1/(FPARAM[126])**2 and WEIGHT_SPECTRUM[126] 8.631705122752464e-05 -0.00016473925961690838
29-Aug-2025 15:45:49 5.48234449028032e-06 % -7.850287451233031e-06 %
29-Aug-2025 15:45:49
29-Aug-2025 15:45:49 pol0 & pol1 ch 127: diff between 1/SIGMA**2 X 1/(FPARAM[127])**2 and WEIGHT_SPECTRUM[127] 4.008430755675363e-05 9.41018111006997e-05
29-Aug-2025 15:45:49 2.789929184392109e-06 % 4.837875533460108e-06 %
29-Aug-2025 15:45:49 PASSED
29-Aug-2025 15:45:49
29-Aug-2025 15:45:50 test_task_sdcal.py::sdcal_test_ps::test_ps00
29-Aug-2025 15:45:50 test_ps00 --- default parameters (raises an error).
29-Aug-2025 15:45:50 PASSED
29-Aug-2025 15:45:50
29-Aug-2025 15:45:50 test_task_sdcal.py::sdcal_test_ps::test_ps01
29-Aug-2025 15:45:50 test_ps01 --- invalid calibration type.
29-Aug-2025 15:45:50 PASSED
29-Aug-2025 15:45:50
29-Aug-2025 15:45:50 test_task_sdcal.py::sdcal_test_ps::test_ps02 2025-08-29 19:45:51        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:45:50 2025-08-29 19:45:51        SEVERE        sdcal::Calibrater::selectvis (file /source/casa6/casatools/src/code/synthesis/MeasurementComponents/Calibrater.cc, line 4222)        Caught exception: Spw Expression: No match found for 99,
29-Aug-2025 15:45:50 2025-08-29 19:45:51        SEVERE        sdcal::::        Exception Reported: Error in data selection specification: Spw Expression: No match found for 99,
29-Aug-2025 15:45:50 2025-08-29 19:45:51        SEVERE        sdcal::::casa        Traceback (most recent call last):
29-Aug-2025 15:45:50 2025-08-29 19:45:51        SEVERE        sdcal::::casa+                     ^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:45:50 2025-08-29 19:45:51        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatasks/private/task_sdcal.py", line 46, in sdcal
29-Aug-2025 15:45:50 2025-08-29 19:45:51        SEVERE        sdcal::::casa+            cb.selectvis(spw=spw, scan=scan, field=field)
29-Aug-2025 15:45:50 2025-08-29 19:45:51        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatools/calibrater.py", line 82, in selectvis
29-Aug-2025 15:45:50 2025-08-29 19:45:51        SEVERE        sdcal::::casa+            return self._swigobj.selectvis(time, spw, scan, field, intent, observation, baseline, uvrange, chanmode, nchan, start, step, mstart, mstep, msselect)
29-Aug-2025 15:45:50 2025-08-29 19:45:51        SEVERE        sdcal::::casa+                   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:45:50 2025-08-29 19:45:51        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatools/__casac__/calibrater.py", line 264, in selectvis
29-Aug-2025 15:45:50 2025-08-29 19:45:51        SEVERE        sdcal::::casa+            return _calibrater.calibrater_selectvis(self, *args, **kwargs)
29-Aug-2025 15:45:50 2025-08-29 19:45:51        SEVERE        sdcal::::casa+                   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:45:50 2025-08-29 19:45:51        SEVERE        sdcal::::casa+        RuntimeError: Error in data selection specification: Spw Expression: No match found for 99,
29-Aug-2025 15:45:50 2025-08-29 19:45:51        SEVERE        sdcal::::casa        Error in data selection specification: Spw Expression: No match found for 99,
29-Aug-2025 15:45:50 2025-08-29 19:45:51        SEVERE        sdcal::::casa        Task sdcal raised an exception of class RuntimeError with the following message: Error in data selection specification: Spw Expression: No match found for 99,
29-Aug-2025 15:45:50
29-Aug-2025 15:45:50 test_ps02 --- invalid selection (invalid spw selection).
29-Aug-2025 15:45:50 PASSED
29-Aug-2025 15:45:50
29-Aug-2025 15:45:51 test_task_sdcal.py::sdcal_test_ps::test_ps03 2025-08-29 19:45:51        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:45:51 2025-08-29 19:45:51        SEVERE        sdcal::::casa        Traceback (most recent call last):
29-Aug-2025 15:45:51 2025-08-29 19:45:51        SEVERE        sdcal::::casa+                     ^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:45:51 2025-08-29 19:45:51        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatasks/private/task_sdcal.py", line 58, in sdcal
29-Aug-2025 15:45:51 2025-08-29 19:45:51        SEVERE        sdcal::::casa+            raise RuntimeError("overwrite is False and output file exists: {}".format(outfile))
29-Aug-2025 15:45:51 2025-08-29 19:45:51        SEVERE        sdcal::::casa+        RuntimeError: overwrite is False and output file exists: uid___A002_X6218fb_X264.ms.sel.sky
29-Aug-2025 15:45:51 2025-08-29 19:45:51        SEVERE        sdcal::::casa        overwrite is False and output file exists: uid___A002_X6218fb_X264.ms.sel.sky
29-Aug-2025 15:45:51 2025-08-29 19:45:51        SEVERE        sdcal::::casa        Task sdcal raised an exception of class RuntimeError with the following message: overwrite is False and output file exists: uid___A002_X6218fb_X264.ms.sel.sky
29-Aug-2025 15:45:51
29-Aug-2025 15:45:51 test_ps03 --- outfile exists (overwrite=False).
29-Aug-2025 15:45:51 PASSED
29-Aug-2025 15:45:51
29-Aug-2025 15:45:51 test_task_sdcal.py::sdcal_test_ps::test_ps04 2025-08-29 19:45:52        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:45:51 2025-08-29 19:45:52        SEVERE        sdcal::::casa        Traceback (most recent call last):
29-Aug-2025 15:45:51 2025-08-29 19:45:52        SEVERE        sdcal::::casa+                     ^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:45:51 2025-08-29 19:45:52        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatasks/private/task_sdcal.py", line 144, in sdcal
29-Aug-2025 15:45:51 2025-08-29 19:45:52        SEVERE        sdcal::::casa+            raise RuntimeError('Output file name must be specified.')
29-Aug-2025 15:45:51 2025-08-29 19:45:52        SEVERE        sdcal::::casa+        RuntimeError: Output file name must be specified.
29-Aug-2025 15:45:51 2025-08-29 19:45:52        SEVERE        sdcal::::casa        Output file name must be specified.
29-Aug-2025 15:45:51 2025-08-29 19:45:52        SEVERE        sdcal::::casa        Task sdcal raised an exception of class RuntimeError with the following message: Output file name must be specified.
29-Aug-2025 15:45:51
29-Aug-2025 15:45:51 test_ps04 --- empty outfile.
29-Aug-2025 15:45:51 PASSED
29-Aug-2025 15:45:51
29-Aug-2025 15:45:51 test_task_sdcal.py::sdcal_test_ps::test_ps05 2025-08-29 19:45:52        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:45:53
29-Aug-2025 15:45:53 test_ps05 --- position switch calibration ('ps').
29-Aug-2025 15:45:53 PASSED
29-Aug-2025 15:45:53
29-Aug-2025 15:45:53 test_task_sdcal.py::sdcal_test_ps::test_ps05M 2025-08-29 19:45:53        WARN        ParallelDataHelper::getPartitionMap::casa        Number of subMSs (8) is greater than available scan,ddi pairs (4), setting nsubms to 4
29-Aug-2025 15:46:13 2025-08-29 19:46:14        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:46:14
29-Aug-2025 15:46:14 test_ps05M --- position switch calibration ('ps') for MMS.
29-Aug-2025 15:46:14 PASSED
29-Aug-2025 15:46:14
29-Aug-2025 15:46:15 test_task_sdcal.py::sdcal_test_ps::test_ps06 2025-08-29 19:46:15        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:46:16
29-Aug-2025 15:46:16 test_ps06 --- position switch calibration ('ps') with data selection.
29-Aug-2025 15:46:16 PASSED
29-Aug-2025 15:46:16
29-Aug-2025 15:46:16 test_task_sdcal.py::sdcal_test_ps::test_ps07 2025-08-29 19:46:17        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:46:17
29-Aug-2025 15:46:17 test_ps07 --- outfile exists (overwrite=True).
29-Aug-2025 15:46:17 PASSED
29-Aug-2025 15:46:17
29-Aug-2025 15:46:18 test_task_sdcal.py::sdcal_test_ps::test_ps08 2025-08-29 19:46:18        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:46:18 2025-08-29 19:46:18        SEVERE        sdcal::Calibrater::solve        Caught exception: Too many edge points (2 out of 1 points)
29-Aug-2025 15:46:18 2025-08-29 19:46:18        SEVERE        sdcal::::        Exception Reported: Error in Calibrater::solve.
29-Aug-2025 15:46:18 2025-08-29 19:46:18        SEVERE        sdcal::::casa        Traceback (most recent call last):
29-Aug-2025 15:46:18 2025-08-29 19:46:18        SEVERE        sdcal::::casa+                     ^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:46:18 2025-08-29 19:46:18        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatasks/private/task_sdcal.py", line 157, in sdcal
29-Aug-2025 15:46:18 2025-08-29 19:46:18        SEVERE        sdcal::::casa+            cb.solve()
29-Aug-2025 15:46:18 2025-08-29 19:46:18        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatools/calibrater.py", line 485, in solve
29-Aug-2025 15:46:18 2025-08-29 19:46:18        SEVERE        sdcal::::casa+            return self._swigobj.solve()
29-Aug-2025 15:46:18 2025-08-29 19:46:18        SEVERE        sdcal::::casa+                   ^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:46:18 2025-08-29 19:46:18        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatools/__casac__/calibrater.py", line 1133, in solve
29-Aug-2025 15:46:18 2025-08-29 19:46:18        SEVERE        sdcal::::casa+            return _calibrater.calibrater_solve(self)
29-Aug-2025 15:46:18 2025-08-29 19:46:18        SEVERE        sdcal::::casa+                   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:46:18 2025-08-29 19:46:18        SEVERE        sdcal::::casa+        RuntimeError: Error in Calibrater::solve.
29-Aug-2025 15:46:18 2025-08-29 19:46:18        SEVERE        sdcal::::casa        Error in Calibrater::solve.
29-Aug-2025 15:46:18 2025-08-29 19:46:18        SEVERE        sdcal::::casa        Task sdcal raised an exception of class RuntimeError with the following message: Error in Calibrater::solve.
29-Aug-2025 15:46:18
29-Aug-2025 15:46:18 test_ps08 --- inappropriate calmode ('otfraster').
29-Aug-2025 15:46:18 PASSED
29-Aug-2025 15:46:18
29-Aug-2025 15:46:18 test_task_sdcal.py::sdcal_test_bug_fix_cas_12712::test_cas_12712_01 2025-08-29 19:46:19        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:46:20
29-Aug-2025 15:46:20 PASSED
29-Aug-2025 15:46:20
29-Aug-2025 15:46:21 test_task_sdcal.py::sdcal_test_otfraster::test_otfraster00 2025-08-29 19:46:22        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:46:21 2025-08-29 19:46:22        SEVERE        sdcal::sdcal::casa        could not convert string to float: 'auto'
29-Aug-2025 15:46:21 2025-08-29 19:46:22        SEVERE        sdcal::::casa        Traceback (most recent call last):
29-Aug-2025 15:46:21 2025-08-29 19:46:22        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatasks/private/task_sdcal.py", line 187, in to_numeric_fraction
29-Aug-2025 15:46:21 2025-08-29 19:46:22        SEVERE        sdcal::::casa+            fraction_numeric = float(fraction)
29-Aug-2025 15:46:21 2025-08-29 19:46:22        SEVERE        sdcal::::casa+                               ^^^^^^^^^^^^^^^
29-Aug-2025 15:46:21 2025-08-29 19:46:22        SEVERE        sdcal::::casa+        ValueError: could not convert string to float: 'auto'
29-Aug-2025 15:46:21 2025-08-29 19:46:22        SEVERE        sdcal::::casa+        
29-Aug-2025 15:46:21 2025-08-29 19:46:22        SEVERE        sdcal::::casa+        During handling of the above exception, another exception occurred:
29-Aug-2025 15:46:21 2025-08-29 19:46:22        SEVERE        sdcal::::casa+        
29-Aug-2025 15:46:21 2025-08-29 19:46:22        SEVERE        sdcal::::casa+        Traceback (most recent call last):
29-Aug-2025 15:46:21 2025-08-29 19:46:22        SEVERE        sdcal::::casa+                     ^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:46:21 2025-08-29 19:46:22        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatasks/private/task_sdcal.py", line 149, in sdcal
29-Aug-2025 15:46:21 2025-08-29 19:46:22        SEVERE        sdcal::::casa+            fraction_numeric = to_numeric_fraction(fraction)
29-Aug-2025 15:46:21 2025-08-29 19:46:22        SEVERE        sdcal::::casa+                               ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:46:21 2025-08-29 19:46:22        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatasks/private/task_sdcal.py", line 192, in to_numeric_fraction
29-Aug-2025 15:46:21 2025-08-29 19:46:22        SEVERE        sdcal::::casa+            raise RuntimeError('Invalid fraction value (original error message: "%s")' % (str(e)))
29-Aug-2025 15:46:21 2025-08-29 19:46:22        SEVERE        sdcal::::casa+        RuntimeError: Invalid fraction value (original error message: "could not convert string to float: 'auto'")
29-Aug-2025 15:46:21 2025-08-29 19:46:22        SEVERE        sdcal::::casa        Invalid fraction value (original error message: "could not convert string to float: 'auto'")
29-Aug-2025 15:46:21 2025-08-29 19:46:22        SEVERE        sdcal::::casa        Task sdcal raised an exception of class RuntimeError with the following message: Invalid fraction value (original error message: "could not convert string to float: 'auto'")
29-Aug-2025 15:46:21
29-Aug-2025 15:46:21 PASSED
29-Aug-2025 15:46:21
29-Aug-2025 15:46:22 test_task_sdcal.py::sdcal_test_otfraster::test_otfraster01 2025-08-29 19:46:22        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:46:22 2025-08-29 19:46:22        SEVERE        sdcal::::casa        Traceback (most recent call last):
29-Aug-2025 15:46:22 2025-08-29 19:46:22        SEVERE        sdcal::::casa+                     ^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:46:22 2025-08-29 19:46:22        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatasks/private/task_sdcal.py", line 151, in sdcal
29-Aug-2025 15:46:22 2025-08-29 19:46:22        SEVERE        sdcal::::casa+            raise ValueError('Too many edge points. fraction must be < 0.5.')
29-Aug-2025 15:46:22 2025-08-29 19:46:22        SEVERE        sdcal::::casa+        ValueError: Too many edge points. fraction must be < 0.5.
29-Aug-2025 15:46:22 2025-08-29 19:46:22        SEVERE        sdcal::::casa        Too many edge points. fraction must be < 0.5.
29-Aug-2025 15:46:22 2025-08-29 19:46:22        SEVERE        sdcal::::casa        Task sdcal raised an exception of class ValueError with the following message: Too many edge points. fraction must be < 0.5.
29-Aug-2025 15:46:22
29-Aug-2025 15:46:22 test_otfraster01 --- too many edge points (fraction 0.5).
29-Aug-2025 15:46:22 PASSED
29-Aug-2025 15:46:22
29-Aug-2025 15:46:22 test_task_sdcal.py::sdcal_test_otfraster::test_otfraster02 2025-08-29 19:46:22        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:46:22 2025-08-29 19:46:22        SEVERE        sdcal::::casa        Traceback (most recent call last):
29-Aug-2025 15:46:22 2025-08-29 19:46:22        SEVERE        sdcal::::casa+                     ^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:46:22 2025-08-29 19:46:22        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatasks/private/task_sdcal.py", line 151, in sdcal
29-Aug-2025 15:46:22 2025-08-29 19:46:22        SEVERE        sdcal::::casa+            raise ValueError('Too many edge points. fraction must be < 0.5.')
29-Aug-2025 15:46:22 2025-08-29 19:46:22        SEVERE        sdcal::::casa+        ValueError: Too many edge points. fraction must be < 0.5.
29-Aug-2025 15:46:22 2025-08-29 19:46:22        SEVERE        sdcal::::casa        Too many edge points. fraction must be < 0.5.
29-Aug-2025 15:46:22 2025-08-29 19:46:22        SEVERE        sdcal::::casa        Task sdcal raised an exception of class ValueError with the following message: Too many edge points. fraction must be < 0.5.
29-Aug-2025 15:46:22
29-Aug-2025 15:46:22 test_otfraster02 --- too many edge points (fraction 50%).
29-Aug-2025 15:46:22 PASSED
29-Aug-2025 15:46:22
29-Aug-2025 15:46:22 test_task_sdcal.py::sdcal_test_otfraster::test_otfraster03 2025-08-29 19:46:23        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::Calibrater::solve        Caught exception: Too many edge points (20000 out of 9 points)
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::        Exception Reported: Error in Calibrater::solve.
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa        Traceback (most recent call last):
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa+                     ^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatasks/private/task_sdcal.py", line 157, in sdcal
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa+            cb.solve()
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatools/calibrater.py", line 485, in solve
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa+            return self._swigobj.solve()
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa+                   ^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatools/__casac__/calibrater.py", line 1133, in solve
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa+            return _calibrater.calibrater_solve(self)
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa+                   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa+        RuntimeError: Error in Calibrater::solve.
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa        Error in Calibrater::solve.
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa        Task sdcal raised an exception of class RuntimeError with the following message: Error in Calibrater::solve.
29-Aug-2025 15:46:22
29-Aug-2025 15:46:22 test_otfraster03 --- too many edge points (noff 100000).
29-Aug-2025 15:46:22 PASSED
29-Aug-2025 15:46:22
29-Aug-2025 15:46:22 test_task_sdcal.py::sdcal_test_otfraster::test_otfraster06 2025-08-29 19:46:23        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::Calibrater::solve        Caught exception: No reference integration found in user-selected data. Please double-check your data selection criteria.
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::        Exception Reported: Error in Calibrater::solve.
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa        Traceback (most recent call last):
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa+                     ^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatasks/private/task_sdcal.py", line 157, in sdcal
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa+            cb.solve()
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatools/calibrater.py", line 485, in solve
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa+            return self._swigobj.solve()
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa+                   ^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatools/__casac__/calibrater.py", line 1133, in solve
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa+            return _calibrater.calibrater_solve(self)
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa+                   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa+        RuntimeError: Error in Calibrater::solve.
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa        Error in Calibrater::solve.
29-Aug-2025 15:46:22 2025-08-29 19:46:23        SEVERE        sdcal::::casa        Task sdcal raised an exception of class RuntimeError with the following message: Error in Calibrater::solve.
29-Aug-2025 15:46:23
29-Aug-2025 15:46:23 test_otfraster06 --- inappropriate calibration mode ('ps').
29-Aug-2025 15:46:23 PASSED
29-Aug-2025 15:46:23
29-Aug-2025 15:46:23 test_task_sdcal.py::sdcal_test_otfraster::test_otfraster07 2025-08-29 19:46:23        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:46:27
29-Aug-2025 15:46:27 test_otfraster07 --- OTF raster calibration ('otfraster') with default setting.
29-Aug-2025 15:46:27 PASSED
29-Aug-2025 15:46:27
29-Aug-2025 15:46:27 test_task_sdcal.py::sdcal_test_otfraster::test_otfraster07M 2025-08-29 19:46:27        WARN        ParallelDataHelper::getPartitionMap::casa        Number of subMSs (8) is greater than available scan,ddi pairs (4), setting nsubms to 4
29-Aug-2025 15:46:45 2025-08-29 19:46:46        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:46:48
29-Aug-2025 15:46:48 test_otfraster07M --- OTF raster calibration ('otfraster') with default setting (MMS).
29-Aug-2025 15:46:48 PASSED
29-Aug-2025 15:46:48
29-Aug-2025 15:46:49 test_task_sdcal.py::sdcal_test_otfraster::test_otfraster08 2025-08-29 19:46:49        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:46:51
29-Aug-2025 15:46:51 test_otfraster08 --- OTF raster calibration ('otfraster') with string fraction (numeric value).
29-Aug-2025 15:46:51 PASSED
29-Aug-2025 15:46:51
29-Aug-2025 15:46:52 test_task_sdcal.py::sdcal_test_otfraster::test_otfraster09 2025-08-29 19:46:52        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:46:54
29-Aug-2025 15:46:54 test_otfraster09 --- OTF raster calibration ('otfraster') with string fraction (percentage).
29-Aug-2025 15:46:54 PASSED
29-Aug-2025 15:46:54
29-Aug-2025 15:46:54 test_task_sdcal.py::sdcal_test_otfraster::test_otfraster10 2025-08-29 19:46:55        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:46:57
29-Aug-2025 15:46:57 test_otfraster10 --- OTF raster calibration ('otfraster') with numeric fraction.
29-Aug-2025 15:46:57 PASSED
29-Aug-2025 15:46:57
29-Aug-2025 15:46:58 test_task_sdcal.py::sdcal_test_otfraster::test_otfraster11 2025-08-29 19:46:58        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:01
29-Aug-2025 15:47:01 test_otfraster11 --- OTF raster calibration ('otfraster') with auto detection.
29-Aug-2025 15:47:01 PASSED
29-Aug-2025 15:47:01
29-Aug-2025 15:47:01 test_task_sdcal.py::sdcal_test_otfraster::test_otfraster12 2025-08-29 19:47:01        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:04
29-Aug-2025 15:47:04 test_otfraster12 --- OTF raster calibration ('otfraster') with custom noff.
29-Aug-2025 15:47:04 PASSED
29-Aug-2025 15:47:04
29-Aug-2025 15:47:04 test_task_sdcal.py::sdcal_test_otfraster::test_otfraster13 2025-08-29 19:47:05        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:07
29-Aug-2025 15:47:07 test_otfraster13 --- check if noff takes priority over fraction.
29-Aug-2025 15:47:07 PASSED
29-Aug-2025 15:47:07
29-Aug-2025 15:47:08 test_task_sdcal.py::sdcal_test_otf::test_otf01 2025-08-29 19:47:08        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:09
29-Aug-2025 15:47:09 test_otf01 --- Compute calibration table. calmode='otf' ms=squares.dec60_cs.ms.
29-Aug-2025 15:47:09 PASSED
29-Aug-2025 15:47:09
29-Aug-2025 15:47:09 test_task_sdcal.py::sdcal_test_otf::test_otf02 2025-08-29 19:47:09        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:10
29-Aug-2025 15:47:10 test_otf02 --- Compute calibration table. calmode='otf' ms=squares.dec60_cs.ms edges_fraction=20%.
29-Aug-2025 15:47:10 PASSED
29-Aug-2025 15:47:10
29-Aug-2025 15:47:11 test_task_sdcal.py::sdcal_test_otf::test_otf03 2025-08-29 19:47:11        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:13
29-Aug-2025 15:47:13 test_otf03 --- Compute calibration table. calmode='otf' ms=lissajous.ms.
29-Aug-2025 15:47:13 PASSED
29-Aug-2025 15:47:13
29-Aug-2025 15:47:13 test_task_sdcal.py::sdcal_test_otf::test_otf03M 2025-08-29 19:47:13        WARN        ParallelDataHelper::getPartitionMap::casa        Number of subMSs (8) is greater than available scan,ddi pairs (4), setting nsubms to 4
29-Aug-2025 15:47:27 2025-08-29 19:47:28        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:28
29-Aug-2025 15:47:28 test_otf03 --- Compute calibration table. calmode='otf' ms=lissajous.ms (MMS).
29-Aug-2025 15:47:28 PASSED
29-Aug-2025 15:47:28
29-Aug-2025 15:47:28 test_task_sdcal.py::sdcal_test_otf::test_otf04 2025-08-29 19:47:29        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:29
29-Aug-2025 15:47:29 test_otf04 --- Compute calibration table. calmode='otf' ms=lissajous.ms edges_fraction=20%.
29-Aug-2025 15:47:29 PASSED
29-Aug-2025 15:47:29
29-Aug-2025 15:47:29 test_task_sdcal.py::sdcal_test_otf::test_otf05 2025-08-29 19:47:30        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:29 The following MS spws have no corresponding cal spws in squares.dec60_cs.edges_fraction_0.1.ms_caltable: 0 1 2 3
29-Aug-2025 15:47:29 2025-08-29 19:47:30        WARN        sdcal::CTPatchedInterp::interpolate        In caltable squares.dec60_cs.edges_fraction_0.1.ms_caltable (SDSKY_OTF):
29-Aug-2025 15:47:29 2025-08-29 19:47:30        WARN        sdcal::CTPatchedInterp::interpolate+         Insufficient solution channel sampling (nchan=1) for frequency-dependent LINEAR interpolation
29-Aug-2025 15:47:29 2025-08-29 19:47:30        WARN        sdcal::CTPatchedInterp::interpolate+         of calibration for MS spw=4; using NEAREST instead.
29-Aug-2025 15:47:30 2025-08-29 19:47:30        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:30 2025-08-29 19:47:31        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:30 The following MS spws have no corresponding cal spws in __sdcal_composite_mode_otf_062.tab: 0 1 2 3
29-Aug-2025 15:47:30 2025-08-29 19:47:31        WARN        sdcal::CTPatchedInterp::interpolate        In caltable __sdcal_composite_mode_otf_062.tab (SDSKY_OTF):
29-Aug-2025 15:47:30 2025-08-29 19:47:31        WARN        sdcal::CTPatchedInterp::interpolate+         Insufficient solution channel sampling (nchan=1) for frequency-dependent LINEAR interpolation
29-Aug-2025 15:47:30 2025-08-29 19:47:31        WARN        sdcal::CTPatchedInterp::interpolate+         of calibration for MS spw=4; using NEAREST instead.
29-Aug-2025 15:47:31
29-Aug-2025 15:47:31 test_otf05 --- Sky calibration. calmode='otf,apply' ms=squares.dec60_cs.ms.
29-Aug-2025 15:47:31 PASSED
29-Aug-2025 15:47:31
29-Aug-2025 15:47:31 test_task_sdcal.py::sdcal_test_otf::test_otf06 2025-08-29 19:47:31        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:31 The following MS spws have no corresponding cal spws in lissajous.edges_new_fraction_0.1.ms_caltable: 0 1 2 3
29-Aug-2025 15:47:31 2025-08-29 19:47:32        WARN        sdcal::CTPatchedInterp::interpolate        In caltable lissajous.edges_new_fraction_0.1.ms_caltable (SDSKY_OTF):
29-Aug-2025 15:47:31 2025-08-29 19:47:32        WARN        sdcal::CTPatchedInterp::interpolate+         Insufficient solution channel sampling (nchan=1) for frequency-dependent LINEAR interpolation
29-Aug-2025 15:47:31 2025-08-29 19:47:32        WARN        sdcal::CTPatchedInterp::interpolate+         of calibration for MS spw=4; using NEAREST instead.
29-Aug-2025 15:47:32
29-Aug-2025 15:47:32 test_otf06 --- Sky calibration reusing caltable pre-computed with calmode='otf'. calmode='apply' ms=lissajous.ms.
29-Aug-2025 15:47:32 PASSED
29-Aug-2025 15:47:32
29-Aug-2025 15:47:32 test_task_sdcal.py::sdcal_test_otf::test_otf07 2025-08-29 19:47:33        WARN        sdcal::::casa        Intent selection for 'otf' or 'otfraster' should be 'OBSERVE_TARGET#ON_SOURCE'.
29-Aug-2025 15:47:32 2025-08-29 19:47:33        WARN        sdcal::::casa+        However, the task is not allowed to set global intent selection since calmode contains 'tsys'.
29-Aug-2025 15:47:32 2025-08-29 19:47:33        WARN        sdcal::::casa+        As a workaround, set intent selection locally when 'otf' or 'otfraster' calibration is performed.
29-Aug-2025 15:47:32 2025-08-29 19:47:33        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:33 2025-08-29 19:47:34        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:35 2025-08-29 19:47:35        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:35 The following MS spws have no corresponding cal spws in __sdcal_composite_mode_otf_062.tab: 0 1 2 3
29-Aug-2025 15:47:35 The following MS spws have no corresponding cal spws in __sdcal_composite_mode_tsys_092.tab: 0 1 2 3
29-Aug-2025 15:47:35 2025-08-29 19:47:35        WARN        sdcal::CTPatchedInterp::interpolate        In caltable __sdcal_composite_mode_otf_062.tab (SDSKY_OTF):
29-Aug-2025 15:47:35 2025-08-29 19:47:35        WARN        sdcal::CTPatchedInterp::interpolate+         Insufficient solution channel sampling (nchan=1) for frequency-dependent LINEAR interpolation
29-Aug-2025 15:47:35 2025-08-29 19:47:35        WARN        sdcal::CTPatchedInterp::interpolate+         of calibration for MS spw=4; using NEAREST instead.
29-Aug-2025 15:47:35 2025-08-29 19:47:35        WARN        sdcal::CTPatchedInterp::interpolate        In caltable __sdcal_composite_mode_tsys_092.tab (B TSYS):
29-Aug-2025 15:47:35 2025-08-29 19:47:35        WARN        sdcal::CTPatchedInterp::interpolate+         Insufficient solution channel sampling (nchan=1) for frequency-dependent LINEAR interpolation
29-Aug-2025 15:47:35 2025-08-29 19:47:35        WARN        sdcal::CTPatchedInterp::interpolate+         of calibration for MS spw=4; using NEAREST instead.
29-Aug-2025 15:47:35
29-Aug-2025 15:47:35 test_otf07 --- Sky calibration + Tsys conversion, composite calmode='otf,tsys,apply'. ms=lissajous.ms.
29-Aug-2025 15:47:35 PASSED
29-Aug-2025 15:47:35
29-Aug-2025 15:47:36 test_task_sdcal.py::sdcal_test_otf_ephem::test_otfephem01 2025-08-29 19:47:36        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:37
29-Aug-2025 15:47:37 test_otfephem01: Sky calibration of 'otf' mode for ephemeris object.
29-Aug-2025 15:47:37 PASSED
29-Aug-2025 15:47:37
29-Aug-2025 15:47:37 test_task_sdcal.py::sdcal_test_otf_ephem::test_otfephem02 2025-08-29 19:47:38        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:39 2025-08-29 19:47:39        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:39 2025-08-29 19:47:39        WARN        sdcal::CTPatchedInterp::interpolate        In caltable __sdcal_composite_mode_otf_028.tab (SDSKY_OTF):
29-Aug-2025 15:47:39 2025-08-29 19:47:39        WARN        sdcal::CTPatchedInterp::interpolate+         Insufficient solution channel sampling (nchan=1) for frequency-dependent LINEAR interpolation
29-Aug-2025 15:47:39 2025-08-29 19:47:39        WARN        sdcal::CTPatchedInterp::interpolate+         of calibration for MS spw=0; using NEAREST instead.
29-Aug-2025 15:47:39 2025-08-29 19:47:39        WARN        sdcal::::        MS obs=0,spw=0,ant=1 is selected for processing, but has no available calibration in __sdcal_composite_mode_otf_028.tab as mapped, and will be flagged.
29-Aug-2025 15:47:39
29-Aug-2025 15:47:39 test_otfephem02: On-the-fly application of 'otf' calibration mode for ephemeris object.
29-Aug-2025 15:47:39 PASSED
29-Aug-2025 15:47:39
29-Aug-2025 15:47:40 test_task_sdcal.py::sdcal_test_apply::test_apply_composite00 2025-08-29 19:47:40        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:41 2025-08-29 19:47:41        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:41 The following MS spws have no corresponding cal spws in __sdcal_composite_mode_ps_085.tab: 0 1 2 3 4 5 6 7 8 10 12 13 14 15 16 17 18 19 20
29-Aug-2025 15:47:41 2025-08-29 19:47:42        WARN        sdcal::::        MS obs=0,spw=9,ant=2 is selected for processing, but has no available calibration in __sdcal_composite_mode_ps_085.tab as mapped, and will be flagged.
29-Aug-2025 15:47:41 2025-08-29 19:47:42        WARN        sdcal::::        MS obs=0,spw=9,ant=3 is selected for processing, but has no available calibration in __sdcal_composite_mode_ps_085.tab as mapped, and will be flagged.
29-Aug-2025 15:47:41 2025-08-29 19:47:42        WARN        sdcal::::        MS obs=0,spw=11,ant=2 is selected for processing, but has no available calibration in __sdcal_composite_mode_ps_085.tab as mapped, and will be flagged.
29-Aug-2025 15:47:41 2025-08-29 19:47:42        WARN        sdcal::::        MS obs=0,spw=11,ant=3 is selected for processing, but has no available calibration in __sdcal_composite_mode_ps_085.tab as mapped, and will be flagged.
29-Aug-2025 15:47:41 2025-08-29 19:47:42        WARN        sdcal::Calibrater::correct2 (VI2/VB2)        Spectral window(s) 1, 3,
29-Aug-2025 15:47:41 2025-08-29 19:47:42        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+          could not be corrected due to missing (pre-)calibration
29-Aug-2025 15:47:41 2025-08-29 19:47:42        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            in one or more of the specified tables.
29-Aug-2025 15:47:41 2025-08-29 19:47:42        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            Please check your results carefully!
29-Aug-2025 15:47:43
29-Aug-2025 15:47:43 test_apply_composite00 --- on-the-fly application of sky table ('ps,apply').
29-Aug-2025 15:47:43 Interpolation option: linear nearestflag
29-Aug-2025 15:47:43 self.finterp: interp_freq_nearestflag
29-Aug-2025 15:47:43 PASSED
29-Aug-2025 15:47:43
29-Aug-2025 15:47:44 test_task_sdcal.py::sdcal_test_apply::test_apply_composite01 2025-08-29 19:47:44        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:46 2025-08-29 19:47:46        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:47 2025-08-29 19:47:47        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:47 The following MS spws have no corresponding cal spws in uid___A002_X6218fb_X264.ms.sel.tsys: 0 2 4 6 8 10 12 13 14 15 16 17 18 19 20
29-Aug-2025 15:47:47 The following MS spws have no corresponding cal spws in __sdcal_composite_mode_ps_057.tab: 0 1 2 3 4 5 6 7 8 10 12 13 14 15 16 17 18 19 20
29-Aug-2025 15:47:47 2025-08-29 19:47:47        WARN        sdcal::::        MS obs=0,spw=9,ant=2 is selected for processing, but has no available calibration in __sdcal_composite_mode_ps_057.tab as mapped, and will be flagged.
29-Aug-2025 15:47:47 2025-08-29 19:47:47        WARN        sdcal::::        MS obs=0,spw=9,ant=3 is selected for processing, but has no available calibration in __sdcal_composite_mode_ps_057.tab as mapped, and will be flagged.
29-Aug-2025 15:47:47 2025-08-29 19:47:47        WARN        sdcal::::        MS obs=0,spw=11,ant=2 is selected for processing, but has no available calibration in __sdcal_composite_mode_ps_057.tab as mapped, and will be flagged.
29-Aug-2025 15:47:47 2025-08-29 19:47:47        WARN        sdcal::::        MS obs=0,spw=11,ant=3 is selected for processing, but has no available calibration in __sdcal_composite_mode_ps_057.tab as mapped, and will be flagged.
29-Aug-2025 15:47:47 2025-08-29 19:47:47        WARN        sdcal::Calibrater::correct2 (VI2/VB2)        Spectral window(s) 1, 3,
29-Aug-2025 15:47:47 2025-08-29 19:47:47        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+          could not be corrected due to missing (pre-)calibration
29-Aug-2025 15:47:47 2025-08-29 19:47:47        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            in one or more of the specified tables.
29-Aug-2025 15:47:47 2025-08-29 19:47:47        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            Please check your results carefully!
29-Aug-2025 15:47:49
29-Aug-2025 15:47:49 test_apply_composite01 --- on-the-fly application of sky table with existing Tsys table.
29-Aug-2025 15:47:49 Interpolation option: linear nearestflag
29-Aug-2025 15:47:49 self.finterp: interp_freq_nearestflag
29-Aug-2025 15:47:49 PASSED
29-Aug-2025 15:47:49
29-Aug-2025 15:47:50 test_task_sdcal.py::sdcal_test_apply::test_apply_composite02 2025-08-29 19:47:50        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:51 2025-08-29 19:47:51        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:52 2025-08-29 19:47:52        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:52 The following MS spws have no corresponding cal spws in __sdcal_composite_mode_ps_024.tab: 0 1 2 3 4 5 6 7 8 10 12 13 14 15 16 17 18 19 20
29-Aug-2025 15:47:52 The following MS spws have no corresponding cal spws in __sdcal_composite_mode_tsys_085.tab: 0 2 4 6 8 10 12 13 14 15 16 17 18 19 20
29-Aug-2025 15:47:52 2025-08-29 19:47:53        WARN        sdcal::::        MS obs=0,spw=9,ant=2 is selected for processing, but has no available calibration in __sdcal_composite_mode_ps_024.tab as mapped, and will be flagged.
29-Aug-2025 15:47:52 2025-08-29 19:47:53        WARN        sdcal::::        MS obs=0,spw=9,ant=3 is selected for processing, but has no available calibration in __sdcal_composite_mode_ps_024.tab as mapped, and will be flagged.
29-Aug-2025 15:47:52 2025-08-29 19:47:53        WARN        sdcal::::        MS obs=0,spw=11,ant=2 is selected for processing, but has no available calibration in __sdcal_composite_mode_ps_024.tab as mapped, and will be flagged.
29-Aug-2025 15:47:52 2025-08-29 19:47:53        WARN        sdcal::::        MS obs=0,spw=11,ant=3 is selected for processing, but has no available calibration in __sdcal_composite_mode_ps_024.tab as mapped, and will be flagged.
29-Aug-2025 15:47:52 2025-08-29 19:47:53        WARN        sdcal::Calibrater::correct2 (VI2/VB2)        Spectral window(s) 1, 3,
29-Aug-2025 15:47:52 2025-08-29 19:47:53        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+          could not be corrected due to missing (pre-)calibration
29-Aug-2025 15:47:52 2025-08-29 19:47:53        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            in one or more of the specified tables.
29-Aug-2025 15:47:52 2025-08-29 19:47:53        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            Please check your results carefully!
29-Aug-2025 15:47:55
29-Aug-2025 15:47:55 test_apply_composite02 --- on-the-fly application of sky and tsys tables ('ps,tsys,apply').
29-Aug-2025 15:47:55 Interpolation option: linear nearestflag
29-Aug-2025 15:47:55 self.finterp: interp_freq_nearestflag
29-Aug-2025 15:47:55 PASSED
29-Aug-2025 15:47:55
29-Aug-2025 15:47:55 test_task_sdcal.py::sdcal_test_apply::test_apply_composite03 2025-08-29 19:47:56        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:56 2025-08-29 19:47:57        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:57 The following MS spws have no corresponding cal spws in uid___A002_X6218fb_X264.ms.sel.sky: 0 1 2 3 4 5 6 7 8 10 12 13 14 15 16 17 18 19 20
29-Aug-2025 15:47:57 The following MS spws have no corresponding cal spws in __sdcal_composite_mode_tsys_100.tab: 0 2 4 6 8 10 12 13 14 15 16 17 18 19 20
29-Aug-2025 15:47:57 2025-08-29 19:47:57        WARN        sdcal::::        MS obs=0,spw=9,ant=2 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:47:57 2025-08-29 19:47:57        WARN        sdcal::::        MS obs=0,spw=9,ant=3 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:47:57 2025-08-29 19:47:57        WARN        sdcal::::        MS obs=0,spw=11,ant=2 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:47:57 2025-08-29 19:47:57        WARN        sdcal::::        MS obs=0,spw=11,ant=3 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:47:57 2025-08-29 19:47:57        WARN        sdcal::Calibrater::correct2 (VI2/VB2)        Spectral window(s) 1, 3,
29-Aug-2025 15:47:57 2025-08-29 19:47:57        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+          could not be corrected due to missing (pre-)calibration
29-Aug-2025 15:47:57 2025-08-29 19:47:57        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            in one or more of the specified tables.
29-Aug-2025 15:47:57 2025-08-29 19:47:57        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            Please check your results carefully!
29-Aug-2025 15:47:59
29-Aug-2025 15:47:59 test_apply_composite03 --- on-the-fly application of sky table ('otfraster,apply').
29-Aug-2025 15:47:59 Interpolation option: linear nearestflag
29-Aug-2025 15:47:59 self.finterp: interp_freq_nearestflag
29-Aug-2025 15:47:59 PASSED
29-Aug-2025 15:47:59
29-Aug-2025 15:47:59 test_task_sdcal.py::sdcal_test_apply::test_apply_sky00 2025-08-29 19:47:59        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:47:59 2025-08-29 19:48:00        SEVERE        sdcal::::casa        Traceback (most recent call last):
29-Aug-2025 15:47:59 2025-08-29 19:48:00        SEVERE        sdcal::::casa+                     ^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:47:59 2025-08-29 19:48:00        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatasks/private/task_sdcal.py", line 78, in sdcal
29-Aug-2025 15:47:59 2025-08-29 19:48:00        SEVERE        sdcal::::casa+            raise Exception('Applytable name must be specified.')
29-Aug-2025 15:47:59 2025-08-29 19:48:00        SEVERE        sdcal::::casa+        Exception: Applytable name must be specified.
29-Aug-2025 15:47:59 2025-08-29 19:48:00        SEVERE        sdcal::::casa        Applytable name must be specified.
29-Aug-2025 15:47:59 2025-08-29 19:48:00        SEVERE        sdcal::::casa        Task sdcal raised an exception of class Exception with the following message: Applytable name must be specified.
29-Aug-2025 15:48:02
29-Aug-2025 15:48:02 test_apply_sky00 --- empty applytable.
29-Aug-2025 15:48:02 PASSED
29-Aug-2025 15:48:02
29-Aug-2025 15:48:02 test_task_sdcal.py::sdcal_test_apply::test_apply_sky01 2025-08-29 19:48:02        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:48:02 2025-08-29 19:48:03        SEVERE        sdcal::::casa        Traceback (most recent call last):
29-Aug-2025 15:48:02 2025-08-29 19:48:03        SEVERE        sdcal::::casa+                     ^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:48:02 2025-08-29 19:48:03        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatasks/private/task_sdcal.py", line 78, in sdcal
29-Aug-2025 15:48:02 2025-08-29 19:48:03        SEVERE        sdcal::::casa+            raise Exception('Applytable name must be specified.')
29-Aug-2025 15:48:02 2025-08-29 19:48:03        SEVERE        sdcal::::casa+        Exception: Applytable name must be specified.
29-Aug-2025 15:48:02 2025-08-29 19:48:03        SEVERE        sdcal::::casa        Applytable name must be specified.
29-Aug-2025 15:48:02 2025-08-29 19:48:03        SEVERE        sdcal::::casa        Task sdcal raised an exception of class Exception with the following message: Applytable name must be specified.
29-Aug-2025 15:48:04
29-Aug-2025 15:48:04 test_apply_sky01 --- empty applytable (list ver.).
29-Aug-2025 15:48:04 PASSED
29-Aug-2025 15:48:04
29-Aug-2025 15:48:04 test_task_sdcal.py::sdcal_test_apply::test_apply_sky02 2025-08-29 19:48:05        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:48:05 2025-08-29 19:48:05        SEVERE        sdcal::::casa        Traceback (most recent call last):
29-Aug-2025 15:48:05 2025-08-29 19:48:05        SEVERE        sdcal::::casa+                     ^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:48:05 2025-08-29 19:48:05        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatasks/private/task_sdcal.py", line 72, in sdcal
29-Aug-2025 15:48:05 2025-08-29 19:48:05        SEVERE        sdcal::::casa+            raise Exception('Applytable name must be specified.')
29-Aug-2025 15:48:05 2025-08-29 19:48:05        SEVERE        sdcal::::casa+        Exception: Applytable name must be specified.
29-Aug-2025 15:48:05 2025-08-29 19:48:05        SEVERE        sdcal::::casa        Applytable name must be specified.
29-Aug-2025 15:48:05 2025-08-29 19:48:05        SEVERE        sdcal::::casa        Task sdcal raised an exception of class Exception with the following message: Applytable name must be specified.
29-Aug-2025 15:48:06
29-Aug-2025 15:48:06 test_apply_sky02 --- empty applytable list.
29-Aug-2025 15:48:06 PASSED
29-Aug-2025 15:48:06
29-Aug-2025 15:48:07 test_task_sdcal.py::sdcal_test_apply::test_apply_sky03 2025-08-29 19:48:07        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:48:07 2025-08-29 19:48:07        SEVERE        sdcal::::casa        Traceback (most recent call last):
29-Aug-2025 15:48:07 2025-08-29 19:48:07        SEVERE        sdcal::::casa+                     ^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:48:07 2025-08-29 19:48:07        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatasks/private/task_sdcal.py", line 81, in sdcal
29-Aug-2025 15:48:07 2025-08-29 19:48:07        SEVERE        sdcal::::casa+            raise Exception("Table doesn't exist: {}".format(_table_name))
29-Aug-2025 15:48:07 2025-08-29 19:48:07        SEVERE        sdcal::::casa+        Exception: Table doesn't exist: notexist.sky
29-Aug-2025 15:48:07 2025-08-29 19:48:07        SEVERE        sdcal::::casa        Table doesn't exist: notexist.sky
29-Aug-2025 15:48:07 2025-08-29 19:48:07        SEVERE        sdcal::::casa        Task sdcal raised an exception of class Exception with the following message: Table doesn't exist: notexist.sky
29-Aug-2025 15:48:09
29-Aug-2025 15:48:09 test_apply_sky03 --- unexisting applytable.
29-Aug-2025 15:48:09 PASSED
29-Aug-2025 15:48:09
29-Aug-2025 15:48:09 test_task_sdcal.py::sdcal_test_apply::test_apply_sky04 2025-08-29 19:48:10        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:48:09 2025-08-29 19:48:10        SEVERE        sdcal::::casa        Traceback (most recent call last):
29-Aug-2025 15:48:09 2025-08-29 19:48:10        SEVERE        sdcal::::casa+                     ^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:48:09 2025-08-29 19:48:10        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatasks/private/task_sdcal.py", line 81, in sdcal
29-Aug-2025 15:48:09 2025-08-29 19:48:10        SEVERE        sdcal::::casa+            raise Exception("Table doesn't exist: {}".format(_table_name))
29-Aug-2025 15:48:09 2025-08-29 19:48:10        SEVERE        sdcal::::casa+        Exception: Table doesn't exist: notexist.sky
29-Aug-2025 15:48:09 2025-08-29 19:48:10        SEVERE        sdcal::::casa        Table doesn't exist: notexist.sky
29-Aug-2025 15:48:09 2025-08-29 19:48:10        SEVERE        sdcal::::casa        Task sdcal raised an exception of class Exception with the following message: Table doesn't exist: notexist.sky
29-Aug-2025 15:48:11
29-Aug-2025 15:48:11 test_apply_sky04 --- unexisting applytable (list ver.).
29-Aug-2025 15:48:11 PASSED
29-Aug-2025 15:48:11
29-Aug-2025 15:48:11 test_task_sdcal.py::sdcal_test_apply::test_apply_sky05 2025-08-29 19:48:12        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:48:12 2025-08-29 19:48:12        SEVERE        sdcal::Calibrater::selectvis (file /source/casa6/casatools/src/code/synthesis/MeasurementComponents/Calibrater.cc, line 4222)        Caught exception: Spw Expression: No match found for 99,
29-Aug-2025 15:48:12 2025-08-29 19:48:12        SEVERE        sdcal::::        Exception Reported: Error in data selection specification: Spw Expression: No match found for 99,
29-Aug-2025 15:48:12 2025-08-29 19:48:12        SEVERE        sdcal::::casa        Traceback (most recent call last):
29-Aug-2025 15:48:12 2025-08-29 19:48:12        SEVERE        sdcal::::casa+                     ^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:48:12 2025-08-29 19:48:12        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatasks/private/task_sdcal.py", line 46, in sdcal
29-Aug-2025 15:48:12 2025-08-29 19:48:12        SEVERE        sdcal::::casa+            cb.selectvis(spw=spw, scan=scan, field=field)
29-Aug-2025 15:48:12 2025-08-29 19:48:12        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatools/calibrater.py", line 82, in selectvis
29-Aug-2025 15:48:12 2025-08-29 19:48:12        SEVERE        sdcal::::casa+            return self._swigobj.selectvis(time, spw, scan, field, intent, observation, baseline, uvrange, chanmode, nchan, start, step, mstart, mstep, msselect)
29-Aug-2025 15:48:12 2025-08-29 19:48:12        SEVERE        sdcal::::casa+                   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:48:12 2025-08-29 19:48:12        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatools/__casac__/calibrater.py", line 264, in selectvis
29-Aug-2025 15:48:12 2025-08-29 19:48:12        SEVERE        sdcal::::casa+            return _calibrater.calibrater_selectvis(self, *args, **kwargs)
29-Aug-2025 15:48:12 2025-08-29 19:48:12        SEVERE        sdcal::::casa+                   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:48:12 2025-08-29 19:48:12        SEVERE        sdcal::::casa+        RuntimeError: Error in data selection specification: Spw Expression: No match found for 99,
29-Aug-2025 15:48:12 2025-08-29 19:48:12        SEVERE        sdcal::::casa        Error in data selection specification: Spw Expression: No match found for 99,
29-Aug-2025 15:48:12 2025-08-29 19:48:12        SEVERE        sdcal::::casa        Task sdcal raised an exception of class RuntimeError with the following message: Error in data selection specification: Spw Expression: No match found for 99,
29-Aug-2025 15:48:14
29-Aug-2025 15:48:14 test_apply_sky05 --- invalid selection (empty selection result).
29-Aug-2025 15:48:14 PASSED
29-Aug-2025 15:48:14
29-Aug-2025 15:48:14 test_task_sdcal.py::sdcal_test_apply::test_apply_sky06 2025-08-29 19:48:14        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:48:14 2025-08-29 19:48:15        SEVERE        sdcal::Calibrater::setapply(type, applypar)        Unknown interp type: 'sinusoid'!! Check inputs and try again.
29-Aug-2025 15:48:14 2025-08-29 19:48:15        SEVERE        sdcal::::        Exception Reported: Error in Calibrater::setapply.
29-Aug-2025 15:48:14 2025-08-29 19:48:15        SEVERE        sdcal::::casa        Traceback (most recent call last):
29-Aug-2025 15:48:14 2025-08-29 19:48:15        SEVERE        sdcal::::casa+                     ^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:48:14 2025-08-29 19:48:15        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatasks/private/task_sdcal.py", line 121, in sdcal
29-Aug-2025 15:48:14 2025-08-29 19:48:15        SEVERE        sdcal::::casa+            cb.setapply(table=_table, interp=interp, calwt=True)
29-Aug-2025 15:48:14 2025-08-29 19:48:15        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatools/calibrater.py", line 212, in setapply
29-Aug-2025 15:48:14 2025-08-29 19:48:15        SEVERE        sdcal::::casa+            return self._swigobj.setapply(type, t, table, field, interp, select, calwt, spwmap, opacity)
29-Aug-2025 15:48:14 2025-08-29 19:48:15        SEVERE        sdcal::::casa+                   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:48:14 2025-08-29 19:48:15        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatools/__casac__/calibrater.py", line 479, in setapply
29-Aug-2025 15:48:14 2025-08-29 19:48:15        SEVERE        sdcal::::casa+            return _calibrater.calibrater_setapply(self, *args, **kwargs)
29-Aug-2025 15:48:14 2025-08-29 19:48:15        SEVERE        sdcal::::casa+                   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:48:14 2025-08-29 19:48:15        SEVERE        sdcal::::casa+        RuntimeError: Error in Calibrater::setapply.
29-Aug-2025 15:48:14 2025-08-29 19:48:15        SEVERE        sdcal::::casa        Error in Calibrater::setapply.
29-Aug-2025 15:48:14 2025-08-29 19:48:15        SEVERE        sdcal::::casa        Task sdcal raised an exception of class RuntimeError with the following message: Error in Calibrater::setapply.
29-Aug-2025 15:48:16
29-Aug-2025 15:48:16 test_apply_sky06 --- invalid interp value.
29-Aug-2025 15:48:16 PASSED
29-Aug-2025 15:48:16
29-Aug-2025 15:48:16 test_task_sdcal.py::sdcal_test_apply::test_apply_sky07 2025-08-29 19:48:17        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:48:16 2025-08-29 19:48:17        SEVERE        sdcal::::casa        Traceback (most recent call last):
29-Aug-2025 15:48:16 2025-08-29 19:48:17        SEVERE        sdcal::::casa+                     ^^^^^^^^^^^^^^^^^^^^^
29-Aug-2025 15:48:16 2025-08-29 19:48:17        SEVERE        sdcal::::casa+          File "/usr/local/lib/python3.12/site-packages/casatasks/private/task_sdcal.py", line 116, in sdcal
29-Aug-2025 15:48:16 2025-08-29 19:48:17        SEVERE        sdcal::::casa+            raise RuntimeError('Applytable \'%s\' is not a caltable format' % (_table))
29-Aug-2025 15:48:16 2025-08-29 19:48:17        SEVERE        sdcal::::casa+        RuntimeError: Applytable 'uid___A002_X6218fb_X264.ms.sel' is not a caltable format
29-Aug-2025 15:48:16 2025-08-29 19:48:17        SEVERE        sdcal::::casa        Applytable 'uid___A002_X6218fb_X264.ms.sel' is not a caltable format
29-Aug-2025 15:48:16 2025-08-29 19:48:17        SEVERE        sdcal::::casa        Task sdcal raised an exception of class RuntimeError with the following message: Applytable 'uid___A002_X6218fb_X264.ms.sel' is not a caltable format
29-Aug-2025 15:48:18
29-Aug-2025 15:48:18 test_apply_sky07 --- invalid applytable (not caltable).
29-Aug-2025 15:48:18 PASSED
29-Aug-2025 15:48:18
29-Aug-2025 15:48:18 test_task_sdcal.py::sdcal_test_apply::test_apply_sky08 2025-08-29 19:48:19        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:48:19 The following MS spws have no corresponding cal spws in uid___A002_X6218fb_X264.ms.sel.sky: 0 1 2 3 4 5 6 7 8 10 12 13 14 15 16 17 18 19 20
29-Aug-2025 15:48:19 2025-08-29 19:48:19        WARN        sdcal::::        MS obs=0,spw=9,ant=2 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:19 2025-08-29 19:48:19        WARN        sdcal::::        MS obs=0,spw=9,ant=3 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:19 2025-08-29 19:48:19        WARN        sdcal::::        MS obs=0,spw=11,ant=2 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:19 2025-08-29 19:48:19        WARN        sdcal::::        MS obs=0,spw=11,ant=3 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:19 2025-08-29 19:48:19        WARN        sdcal::Calibrater::correct2 (VI2/VB2)        Spectral window(s) 1, 3,
29-Aug-2025 15:48:19 2025-08-29 19:48:19        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+          could not be corrected due to missing (pre-)calibration
29-Aug-2025 15:48:19 2025-08-29 19:48:19        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            in one or more of the specified tables.
29-Aug-2025 15:48:19 2025-08-29 19:48:19        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            Please check your results carefully!
29-Aug-2025 15:48:22
29-Aug-2025 15:48:22 test_apply_sky08 --- apply data (linear).
29-Aug-2025 15:48:22 Interpolation option: linear nearestflag
29-Aug-2025 15:48:22 self.finterp: interp_freq_nearestflag
29-Aug-2025 15:48:22 PASSED
29-Aug-2025 15:48:22
29-Aug-2025 15:48:23 test_task_sdcal.py::sdcal_test_apply::test_apply_sky08M
29-Aug-2025 15:48:23 test_apply_sky08M --- apply data (linear) for MMS.
29-Aug-2025 15:48:23 SKIPPED (Skip test_apply_sky08M until calibrator tool supports proce...)
29-Aug-2025 15:48:23
29-Aug-2025 15:48:23 test_task_sdcal.py::sdcal_test_apply::test_apply_sky09 2025-08-29 19:48:23        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:48:23 The following MS spws have no corresponding cal spws in uid___A002_X6218fb_X264.ms.sel.sky: 0 1 2 3 4 5 6 7 8 10 12 13 14 15 16 17 18 19 20
29-Aug-2025 15:48:23 2025-08-29 19:48:24        WARN        sdcal::::        MS obs=0,spw=9,ant=2 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:23 2025-08-29 19:48:24        WARN        sdcal::::        MS obs=0,spw=9,ant=3 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:27
29-Aug-2025 15:48:27 test_apply_sky09 --- apply selected data.
29-Aug-2025 15:48:27 Interpolation option: linear nearestflag
29-Aug-2025 15:48:27 self.finterp: interp_freq_nearestflag
29-Aug-2025 15:48:27 PASSED
29-Aug-2025 15:48:27
29-Aug-2025 15:48:27 test_task_sdcal.py::sdcal_test_apply::test_apply_sky10 2025-08-29 19:48:27        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:48:27 The following MS spws have no corresponding cal spws in uid___A002_X6218fb_X264.ms.sel.sky: 0 1 2 3 4 5 6 7 8 10 12 13 14 15 16 17 18 19 20
29-Aug-2025 15:48:27 2025-08-29 19:48:28        WARN        sdcal::::        MS obs=0,spw=9,ant=2 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:27 2025-08-29 19:48:28        WARN        sdcal::::        MS obs=0,spw=9,ant=3 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:27 2025-08-29 19:48:28        WARN        sdcal::::        MS obs=0,spw=11,ant=2 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:27 2025-08-29 19:48:28        WARN        sdcal::::        MS obs=0,spw=11,ant=3 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:27 2025-08-29 19:48:28        WARN        sdcal::Calibrater::correct2 (VI2/VB2)        Spectral window(s) 1, 3,
29-Aug-2025 15:48:27 2025-08-29 19:48:28        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+          could not be corrected due to missing (pre-)calibration
29-Aug-2025 15:48:27 2025-08-29 19:48:28        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            in one or more of the specified tables.
29-Aug-2025 15:48:27 2025-08-29 19:48:28        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            Please check your results carefully!
29-Aug-2025 15:48:29
29-Aug-2025 15:48:29 test_apply_sky10 --- apply data (nearest).
29-Aug-2025 15:48:29 Interpolation option: nearest nearestflag
29-Aug-2025 15:48:29 self.finterp: interp_freq_nearestflag
29-Aug-2025 15:48:29 PASSED
29-Aug-2025 15:48:29
29-Aug-2025 15:48:30 test_task_sdcal.py::sdcal_test_apply::test_apply_sky11 2025-08-29 19:48:30        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:48:30 The following MS spws have no corresponding cal spws in uid___A002_X6218fb_X264.ms.sel.sky: 0 1 2 3 4 5 6 7 8 10 12 13 14 15 16 17 18 19 20
29-Aug-2025 15:48:30 2025-08-29 19:48:30        WARN        sdcal::::        MS obs=0,spw=9,ant=2 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:30 2025-08-29 19:48:30        WARN        sdcal::::        MS obs=0,spw=9,ant=3 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:30 2025-08-29 19:48:31        WARN        sdcal::::        MS obs=0,spw=11,ant=2 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:30 2025-08-29 19:48:31        WARN        sdcal::::        MS obs=0,spw=11,ant=3 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:30 2025-08-29 19:48:31        WARN        sdcal::Calibrater::correct2 (VI2/VB2)        Spectral window(s) 1, 3,
29-Aug-2025 15:48:30 2025-08-29 19:48:31        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+          could not be corrected due to missing (pre-)calibration
29-Aug-2025 15:48:30 2025-08-29 19:48:31        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            in one or more of the specified tables.
29-Aug-2025 15:48:30 2025-08-29 19:48:31        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            Please check your results carefully!
29-Aug-2025 15:48:32
29-Aug-2025 15:48:32 test_apply_sky11 --- apply data (linearflag for frequency interpolation).
29-Aug-2025 15:48:32 Interpolation option: linear nearestflag
29-Aug-2025 15:48:32 self.finterp: interp_freq_nearestflag
29-Aug-2025 15:48:32 PASSED
29-Aug-2025 15:48:32
29-Aug-2025 15:48:32 test_task_sdcal.py::sdcal_test_apply::test_apply_sky12 2025-08-29 19:48:33        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:48:32 The following MS spws have no corresponding cal spws in uid___A002_X6218fb_X264.ms.sel.sky: 0 1 2 3 4 5 6 7 8 10 12 13 14 15 16 17 18 19 20
29-Aug-2025 15:48:32 2025-08-29 19:48:33        WARN        sdcal::::        MS obs=0,spw=9,ant=2 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:32 2025-08-29 19:48:33        WARN        sdcal::::        MS obs=0,spw=9,ant=3 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:33 2025-08-29 19:48:33        WARN        sdcal::::        MS obs=0,spw=11,ant=2 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:33 2025-08-29 19:48:33        WARN        sdcal::::        MS obs=0,spw=11,ant=3 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:33 2025-08-29 19:48:33        WARN        sdcal::Calibrater::correct2 (VI2/VB2)        Spectral window(s) 1, 3,
29-Aug-2025 15:48:33 2025-08-29 19:48:33        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+          could not be corrected due to missing (pre-)calibration
29-Aug-2025 15:48:33 2025-08-29 19:48:33        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            in one or more of the specified tables.
29-Aug-2025 15:48:33 2025-08-29 19:48:33        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            Please check your results carefully!
29-Aug-2025 15:48:34
29-Aug-2025 15:48:34 test_apply_sky12 --- apply data (nearestflag for frequency interpolation).
29-Aug-2025 15:48:34 Interpolation option: linear nearestflag
29-Aug-2025 15:48:34 self.finterp: interp_freq_nearestflag
29-Aug-2025 15:48:34 PASSED
29-Aug-2025 15:48:34
29-Aug-2025 15:48:35 test_task_sdcal.py::sdcal_test_apply::test_apply_sky13 2025-08-29 19:48:35        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:48:35 The following MS spws have no corresponding cal spws in uid___A002_X6218fb_X264.ms.sel.sky: 0 1 2 3 4 5 6 7 8 10 12 13 14 15 16 17 18 19 20
29-Aug-2025 15:48:35 2025-08-29 19:48:35        WARN        sdcal::::        MS obs=0,spw=9,ant=2 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:35 2025-08-29 19:48:35        WARN        sdcal::::        MS obs=0,spw=9,ant=3 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:35 2025-08-29 19:48:35        WARN        sdcal::::        MS obs=0,spw=11,ant=2 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:35 2025-08-29 19:48:35        WARN        sdcal::::        MS obs=0,spw=11,ant=3 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:35 2025-08-29 19:48:36        WARN        sdcal::Calibrater::correct2 (VI2/VB2)        Spectral window(s) 1, 3,
29-Aug-2025 15:48:35 2025-08-29 19:48:36        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+          could not be corrected due to missing (pre-)calibration
29-Aug-2025 15:48:35 2025-08-29 19:48:36        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            in one or more of the specified tables.
29-Aug-2025 15:48:35 2025-08-29 19:48:36        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            Please check your results carefully!
29-Aug-2025 15:48:38
29-Aug-2025 15:48:38 test_apply_sky13 --- apply data (string applytable input).
29-Aug-2025 15:48:38 Interpolation option: linear nearestflag
29-Aug-2025 15:48:38 self.finterp: interp_freq_nearestflag
29-Aug-2025 15:48:38 PASSED
29-Aug-2025 15:48:38
29-Aug-2025 15:48:38 test_task_sdcal.py::sdcal_test_apply::test_apply_sky14 2025-08-29 19:48:39        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:48:38 The following MS spws have no corresponding cal spws in uid___A002_X6218fb_X264.ms.sel.sky: 0 1 2 3 4 5 6 7 8 10 12 13 14 15 16 17 18 19 20
29-Aug-2025 15:48:38 2025-08-29 19:48:39        WARN        sdcal::::        MS obs=0,spw=9,ant=2 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:38 2025-08-29 19:48:39        WARN        sdcal::::        MS obs=0,spw=9,ant=3 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:39 2025-08-29 19:48:39        WARN        sdcal::::        MS obs=0,spw=11,ant=2 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:39 2025-08-29 19:48:39        WARN        sdcal::::        MS obs=0,spw=11,ant=3 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:39 2025-08-29 19:48:39        WARN        sdcal::Calibrater::correct2 (VI2/VB2)        Spectral window(s) 1, 3,
29-Aug-2025 15:48:39 2025-08-29 19:48:39        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+          could not be corrected due to missing (pre-)calibration
29-Aug-2025 15:48:39 2025-08-29 19:48:39        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            in one or more of the specified tables.
29-Aug-2025 15:48:39 2025-08-29 19:48:39        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            Please check your results carefully!
29-Aug-2025 15:48:41
29-Aug-2025 15:48:41 test_apply_sky14 --- apply data (interp='').
29-Aug-2025 15:48:41 Interpolation option: linear nearestflag
29-Aug-2025 15:48:41 self.finterp: interp_freq_nearestflag
29-Aug-2025 15:48:41 PASSED
29-Aug-2025 15:48:41
29-Aug-2025 15:48:41 test_task_sdcal.py::sdcal_test_apply::test_apply_sky15 2025-08-29 19:48:42        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:48:41 The following MS spws have no corresponding cal spws in uid___A002_X6218fb_X264.ms.sel.sky: 0 1 2 3 4 5 6 7 8 10 12 13 14 15 16 17 18 19 20
29-Aug-2025 15:48:42 2025-08-29 19:48:42        WARN        sdcal::::        MS obs=0,spw=9,ant=2 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:42 2025-08-29 19:48:42        WARN        sdcal::::        MS obs=0,spw=9,ant=3 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:42 2025-08-29 19:48:42        WARN        sdcal::::        MS obs=0,spw=11,ant=2 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:42 2025-08-29 19:48:42        WARN        sdcal::::        MS obs=0,spw=11,ant=3 is selected for processing, but has no available calibration in uid___A002_X6218fb_X264.ms.sel.sky as mapped, and will be flagged.
29-Aug-2025 15:48:42 2025-08-29 19:48:42        WARN        sdcal::Calibrater::correct2 (VI2/VB2)        Spectral window(s) 1, 3,
29-Aug-2025 15:48:42 2025-08-29 19:48:42        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+          could not be corrected due to missing (pre-)calibration
29-Aug-2025 15:48:42 2025-08-29 19:48:42        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            in one or more of the specified tables.
29-Aug-2025 15:48:42 2025-08-29 19:48:42        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            Please check your results carefully!
29-Aug-2025 15:48:45
29-Aug-2025 15:48:45 test_apply_sky15 --- check if WEIGHT_SPECTRUM is updated properly when it exists.
29-Aug-2025 15:48:45 Interpolation option: linear nearestflag
29-Aug-2025 15:48:45 self.finterp: interp_freq_nearestflag
29-Aug-2025 15:48:45 PASSED
29-Aug-2025 15:48:45
29-Aug-2025 15:48:46 test_task_sdcal.py::sdcal_test_single_polarization::test_single_pol_apply 2025-08-29 19:48:47        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:48:48 2025-08-29 19:48:49        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:48:48 The following MS spws have no corresponding cal spws in uid___A002_X6218fb_X264.ms.sel.sky: 0
29-Aug-2025 15:48:48 2025-08-29 19:48:49        WARN        sdcal::Calibrater::correct2 (VI2/VB2)        Spectral window(s) 0,
29-Aug-2025 15:48:48 2025-08-29 19:48:49        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+          could not be corrected due to missing (pre-)calibration
29-Aug-2025 15:48:48 2025-08-29 19:48:49        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            in one or more of the specified tables.
29-Aug-2025 15:48:48 2025-08-29 19:48:49        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            Please check your results carefully!
29-Aug-2025 15:48:48
29-Aug-2025 15:48:48 test_single_pol_apply --- apply caltable to single-polarization data.
29-Aug-2025 15:48:48 PASSED
29-Aug-2025 15:48:48
29-Aug-2025 15:48:48 test_task_sdcal.py::sdcal_test_single_polarization::test_single_pol_apply_composite 2025-08-29 19:48:49        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:48:50 2025-08-29 19:48:50        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:48:50 The following MS spws have no corresponding cal spws in __sdcal_composite_mode_ps_031.tab: 0
29-Aug-2025 15:48:50 2025-08-29 19:48:50        WARN        sdcal::Calibrater::correct2 (VI2/VB2)        Spectral window(s) 0,
29-Aug-2025 15:48:50 2025-08-29 19:48:50        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+          could not be corrected due to missing (pre-)calibration
29-Aug-2025 15:48:50 2025-08-29 19:48:50        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            in one or more of the specified tables.
29-Aug-2025 15:48:50 2025-08-29 19:48:50        WARN        sdcal::Calibrater::correct2 (VI2/VB2)+            Please check your results carefully!
29-Aug-2025 15:48:50
29-Aug-2025 15:48:50 test_single_pol_apply_composite --- on-the-fly calibration/application on single-polarization data.
29-Aug-2025 15:48:50 PASSED
29-Aug-2025 15:48:50
29-Aug-2025 15:48:50 test_task_sdcal.py::sdcal_test_single_polarization::test_single_pol_ps 2025-08-29 19:48:51        WARN        sdcal::calibrater::setvi(bool,bool)        Already using OLD VisibilityIterator.
29-Aug-2025 15:48:51
29-Aug-2025 15:48:51 test_single_pol_ps --- generate caltable for single-polarization data.
29-Aug-2025 15:48:51 PASSED
29-Aug-2025 15:48:51
29-Aug-2025 15:48:51 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_task_sdcal/nose.xml -
29-Aug-2025 15:48:51 =========================== short test summary info ============================
29-Aug-2025 15:48:51 SKIPPED [1] test_task_sdcal.py:1979: Skip test_apply_sky08M until calibrator tool supports processing MMS on serial casa
29-Aug-2025 15:48:51 ============ 65 passed, 1 skipped, 16 warnings in 237.78s (0:03:57) ============
29-Aug-2025 15:48:52
29-Aug-2025 15:48:52
29-Aug-2025 15:48:52 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_task_appendantab/
29-Aug-2025 15:48:52 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_task_appendantab
29-Aug-2025 15:48:52
29-Aug-2025 15:48:52 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_task_appendantab/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_task_appendantab/
29-Aug-2025 15:48:52
29-Aug-2025 15:48:52 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_task_tsdimaging/
29-Aug-2025 15:48:52 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_task_tsdimaging
29-Aug-2025 15:48:52
29-Aug-2025 15:48:52 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_task_tsdimaging/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_task_tsdimaging/
29-Aug-2025 15:48:52
29-Aug-2025 15:48:52 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_task_listfits/
29-Aug-2025 15:48:52 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_task_listfits
29-Aug-2025 15:48:52
29-Aug-2025 15:48:52 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_task_listfits/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_task_listfits/
29-Aug-2025 15:48:52
29-Aug-2025 15:48:52 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_task_asdmsummary/
29-Aug-2025 15:48:52 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_task_asdmsummary
29-Aug-2025 15:48:52
29-Aug-2025 15:48:52 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_task_asdmsummary/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_task_asdmsummary/
29-Aug-2025 15:48:52
29-Aug-2025 15:48:52 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_task_sdimaging/
29-Aug-2025 15:48:52 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_task_sdimaging
29-Aug-2025 15:48:52
29-Aug-2025 15:48:52 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_task_sdimaging/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_task_sdimaging/
29-Aug-2025 15:48:52
29-Aug-2025 15:48:52 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_task_listvis/
29-Aug-2025 15:48:52 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_task_listvis
29-Aug-2025 15:48:52
29-Aug-2025 15:48:52 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_task_listvis/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_task_listvis/
29-Aug-2025 15:48:52
29-Aug-2025 15:48:52 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_task_exportfits/
29-Aug-2025 15:48:52 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_task_exportfits
29-Aug-2025 15:48:52
29-Aug-2025 15:48:52 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_task_exportfits/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_task_exportfits/
29-Aug-2025 15:48:52
29-Aug-2025 15:48:52 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_task_deconvolve/
29-Aug-2025 15:48:52 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_task_deconvolve
29-Aug-2025 15:48:52
29-Aug-2025 15:48:52 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_task_deconvolve/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_task_deconvolve/
29-Aug-2025 15:48:52
29-Aug-2025 15:48:52 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_task_sdcal/
29-Aug-2025 15:48:52 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_task_sdcal
29-Aug-2025 15:48:52
29-Aug-2025 15:48:52 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_task_sdcal/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_task_sdcal/
29-Aug-2025 15:48:57 total 84064
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci 15001  1860239 Aug 29 08:32 casatasks-6.7.2.34+dirty-py3-none-any.whl
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root   4649941 Aug 29 19:48 casatasks_test.log
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci 15001   135205 Aug 29 08:32 casatestutils-6.7.2.34+dirty-py3-none-any.whl
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci 15001 78639099 Aug 29 08:32 casatools-6.7.2.34+dirty-cp312-cp312-manylinux_2_28_x86_64.whl
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      2534 Aug 29 19:48 test_casaxmlutil.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      2343 Aug 29 19:48 test_flaghelper.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1892 Aug 29 19:48 test_imagerhelpers_gclean.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      2684 Aug 29 19:48 test_jyperk.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1822 Aug 29 19:48 test_task_accor.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       907 Aug 29 19:48 test_task_appendantab.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      3182 Aug 29 19:48 test_task_applycal.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       655 Aug 29 19:48 test_task_asdmsummary.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       832 Aug 29 19:48 test_task_bandpass.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1757 Aug 29 19:48 test_task_blcal.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       880 Aug 29 19:48 test_task_calstat.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       999 Aug 29 19:48 test_task_clearcal.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       689 Aug 29 19:48 test_task_clearstat.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1859 Aug 29 19:48 test_task_concat.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1369 Aug 29 19:48 test_task_conjugatevis.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      7428 Aug 29 19:48 test_task_cvel.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      5065 Aug 29 19:48 test_task_cvel2.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root     15787 Aug 29 19:48 test_task_deconvolve.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       944 Aug 29 19:48 test_task_defintent.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       612 Aug 29 19:48 test_task_delmod.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1799 Aug 29 19:48 test_task_exportasdm.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       359 Aug 29 19:48 test_task_exportfits.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1869 Aug 29 19:48 test_task_exportuvfits.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1088 Aug 29 19:48 test_task_feather.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1977 Aug 29 19:48 test_task_fixplanets.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1471 Aug 29 19:48 test_task_fixvis.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      4627 Aug 29 19:48 test_task_flagcmd.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root     28032 Aug 29 19:48 test_task_flagdata.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       967 Aug 29 19:48 test_task_flagmanager.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      2359 Aug 29 19:48 test_task_fluxscale.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1467 Aug 29 19:48 test_task_fringefit.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      3260 Aug 29 19:48 test_task_gaincal.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      3176 Aug 29 19:48 test_task_gencal.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       477 Aug 29 19:48 test_task_getantposalma.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       686 Aug 29 19:48 test_task_getcalmodvla.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1041 Aug 29 19:48 test_task_getephemtable.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      2610 Aug 29 19:48 test_task_hanningsmooth.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root     29298 Aug 29 19:48 test_task_imbaseline.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      2221 Aug 29 19:48 test_task_imcollapse.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1223 Aug 29 19:48 test_task_imcontsub.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1768 Aug 29 19:48 test_task_imdev.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      3192 Aug 29 19:48 test_task_imfit.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      2135 Aug 29 19:48 test_task_imhead.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1175 Aug 29 19:48 test_task_imhistory.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      3055 Aug 29 19:48 test_task_immath.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1668 Aug 29 19:48 test_task_immoments.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1130 Aug 29 19:48 test_task_impbcor.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       753 Aug 29 19:48 test_task_importasap.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      3719 Aug 29 19:48 test_task_importasdm.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       352 Aug 29 19:48 test_task_importatca.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1399 Aug 29 19:48 test_task_importfitsidi.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       358 Aug 29 19:48 test_task_importmiriad.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       640 Aug 29 19:48 test_task_importnro.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1819 Aug 29 19:48 test_task_importuvfits.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       836 Aug 29 19:48 test_task_importvla.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1839 Aug 29 19:48 test_task_impv.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      2116 Aug 29 19:48 test_task_imrebin.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       831 Aug 29 19:48 test_task_imreframe.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      2345 Aug 29 19:48 test_task_imregrid.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1462 Aug 29 19:48 test_task_imsmooth.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1440 Aug 29 19:48 test_task_imstat.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       735 Aug 29 19:48 test_task_imsubimage.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       804 Aug 29 19:48 test_task_imtrans.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      3129 Aug 29 19:48 test_task_imval.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      3796 Aug 29 19:48 test_task_initweights.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1484 Aug 29 19:48 test_task_listcal.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       512 Aug 29 19:48 test_task_listfits.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       752 Aug 29 19:48 test_task_listhistory.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      8581 Aug 29 19:48 test_task_listobs.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1520 Aug 29 19:48 test_task_listpartition.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       525 Aug 29 19:48 test_task_listsdm.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       754 Aug 29 19:48 test_task_listvis.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      2663 Aug 29 19:48 test_task_makemask.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root     34560 Aug 29 19:48 test_task_mstransform.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      5873 Aug 29 19:48 test_task_mstransform_mms.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       786 Aug 29 19:48 test_task_nrobeamaverage.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      3486 Aug 29 19:48 test_task_partition.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      3243 Aug 29 19:48 test_task_phaseshift.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1095 Aug 29 19:48 test_task_plotants.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root     25975 Aug 29 19:48 test_task_plotbandpass.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1796 Aug 29 19:48 test_task_plotprofilemap.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1820 Aug 29 19:48 test_task_plotweather.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      3088 Aug 29 19:48 test_task_polcal.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       358 Aug 29 19:48 test_task_polfromgain.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1217 Aug 29 19:48 test_task_predictcomp.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       974 Aug 29 19:48 test_task_rerefant.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1208 Aug 29 19:48 test_task_rmfit.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       810 Aug 29 19:48 test_task_rmtables.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      5042 Aug 29 19:48 test_task_sdatmcor.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root     18317 Aug 29 19:48 test_task_sdbaseline.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      6651 Aug 29 19:48 test_task_sdcal.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      4178 Aug 29 19:48 test_task_sdfit.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1862 Aug 29 19:48 test_task_sdfixscan.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1589 Aug 29 19:48 test_task_sdgaincal.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root     23486 Aug 29 19:48 test_task_sdimaging.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      2722 Aug 29 19:48 test_task_sdintimaging.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       586 Aug 29 19:48 test_task_sdpolaverage.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      2454 Aug 29 19:48 test_task_sdsidebandsplit.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      3952 Aug 29 19:48 test_task_sdsmooth.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      4400 Aug 29 19:48 test_task_sdtimeaverage.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      3454 Aug 29 19:48 test_task_setjy.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1721 Aug 29 19:48 test_task_simanalyze.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root     12729 Aug 29 19:48 test_task_simobserve.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1512 Aug 29 19:48 test_task_slsearch.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1389 Aug 29 19:48 test_task_smoothcal.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1951 Aug 29 19:48 test_task_specfit.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       716 Aug 29 19:48 test_task_specflux.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       453 Aug 29 19:48 test_task_specsmooth.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       468 Aug 29 19:48 test_task_splattotable.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root     17908 Aug 29 19:48 test_task_split.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       708 Aug 29 19:48 test_task_spxfit.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      2409 Aug 29 19:48 test_task_statwt.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root     39350 Aug 29 19:48 test_task_tclean.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       701 Aug 29 19:48 test_task_testconcat.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root     24646 Aug 29 19:48 test_task_tsdimaging.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root       844 Aug 29 19:48 test_task_uvcontsub_old.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1523 Aug 29 19:48 test_task_uvmodelfit.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1485 Aug 29 19:48 test_task_virtualconcat.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1097 Aug 29 19:48 test_task_vishead.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      3291 Aug 29 19:48 test_task_visstat.xml
29-Aug-2025 15:48:57 -rw-r--r-- 1 casaci root      1988 Aug 29 19:48 test_task_wvrgcal.xml
29-Aug-2025 15:48:57 Finished task 'Test wheel' with result: Success
29-Aug-2025 15:48:57 Starting task 'Package working directory' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
29-Aug-2025 15:48:57
Beginning to execute external process for build 'CASASPECS - Pull Request - CAS-14640 - Test Tasks Many Linux 2.28 Python3.12 #1 (CASASPECS-PR120-TTAML228-1)'
... running command line:
/export/home/cbt-el7-11/bamboohome/temp/CASASPECS-PR120-TTAML228-1-ScriptBuildTask-7679386221650989073.sh
... in: /export/home/cbt-el7-11/bamboohome/xml-data/build-dir/CASASPECS-PR120-TTAML228
29-Aug-2025 15:48:57 Package working directory
29-Aug-2025 15:48:57 tar: work: Cannot stat: No such file or directory
29-Aug-2025 15:48:57 tar: Exiting with failure status due to previous errors
29-Aug-2025 15:48:58 total 84068
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci 15001  1860239 Aug 29 08:32 casatasks-6.7.2.34+dirty-py3-none-any.whl
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root   4649941 Aug 29 19:48 casatasks_test.log
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci 15001   135205 Aug 29 08:32 casatestutils-6.7.2.34+dirty-py3-none-any.whl
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci 15001 78639099 Aug 29 08:32 casatools-6.7.2.34+dirty-cp312-cp312-manylinux_2_28_x86_64.whl
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      2534 Aug 29 19:48 test_casaxmlutil.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      2343 Aug 29 19:48 test_flaghelper.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1892 Aug 29 19:48 test_imagerhelpers_gclean.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      2684 Aug 29 19:48 test_jyperk.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1822 Aug 29 19:48 test_task_accor.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       907 Aug 29 19:48 test_task_appendantab.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      3182 Aug 29 19:48 test_task_applycal.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       655 Aug 29 19:48 test_task_asdmsummary.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       832 Aug 29 19:48 test_task_bandpass.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1757 Aug 29 19:48 test_task_blcal.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       880 Aug 29 19:48 test_task_calstat.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       999 Aug 29 19:48 test_task_clearcal.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       689 Aug 29 19:48 test_task_clearstat.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1859 Aug 29 19:48 test_task_concat.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1369 Aug 29 19:48 test_task_conjugatevis.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      7428 Aug 29 19:48 test_task_cvel.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      5065 Aug 29 19:48 test_task_cvel2.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root     15787 Aug 29 19:48 test_task_deconvolve.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       944 Aug 29 19:48 test_task_defintent.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       612 Aug 29 19:48 test_task_delmod.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1799 Aug 29 19:48 test_task_exportasdm.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       359 Aug 29 19:48 test_task_exportfits.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1869 Aug 29 19:48 test_task_exportuvfits.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1088 Aug 29 19:48 test_task_feather.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1977 Aug 29 19:48 test_task_fixplanets.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1471 Aug 29 19:48 test_task_fixvis.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      4627 Aug 29 19:48 test_task_flagcmd.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root     28032 Aug 29 19:48 test_task_flagdata.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       967 Aug 29 19:48 test_task_flagmanager.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      2359 Aug 29 19:48 test_task_fluxscale.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1467 Aug 29 19:48 test_task_fringefit.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      3260 Aug 29 19:48 test_task_gaincal.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      3176 Aug 29 19:48 test_task_gencal.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       477 Aug 29 19:48 test_task_getantposalma.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       686 Aug 29 19:48 test_task_getcalmodvla.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1041 Aug 29 19:48 test_task_getephemtable.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      2610 Aug 29 19:48 test_task_hanningsmooth.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root     29298 Aug 29 19:48 test_task_imbaseline.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      2221 Aug 29 19:48 test_task_imcollapse.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1223 Aug 29 19:48 test_task_imcontsub.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1768 Aug 29 19:48 test_task_imdev.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      3192 Aug 29 19:48 test_task_imfit.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      2135 Aug 29 19:48 test_task_imhead.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1175 Aug 29 19:48 test_task_imhistory.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      3055 Aug 29 19:48 test_task_immath.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1668 Aug 29 19:48 test_task_immoments.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1130 Aug 29 19:48 test_task_impbcor.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       753 Aug 29 19:48 test_task_importasap.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      3719 Aug 29 19:48 test_task_importasdm.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       352 Aug 29 19:48 test_task_importatca.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1399 Aug 29 19:48 test_task_importfitsidi.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       358 Aug 29 19:48 test_task_importmiriad.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       640 Aug 29 19:48 test_task_importnro.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1819 Aug 29 19:48 test_task_importuvfits.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       836 Aug 29 19:48 test_task_importvla.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1839 Aug 29 19:48 test_task_impv.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      2116 Aug 29 19:48 test_task_imrebin.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       831 Aug 29 19:48 test_task_imreframe.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      2345 Aug 29 19:48 test_task_imregrid.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1462 Aug 29 19:48 test_task_imsmooth.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1440 Aug 29 19:48 test_task_imstat.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       735 Aug 29 19:48 test_task_imsubimage.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       804 Aug 29 19:48 test_task_imtrans.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      3129 Aug 29 19:48 test_task_imval.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      3796 Aug 29 19:48 test_task_initweights.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1484 Aug 29 19:48 test_task_listcal.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       512 Aug 29 19:48 test_task_listfits.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       752 Aug 29 19:48 test_task_listhistory.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      8581 Aug 29 19:48 test_task_listobs.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1520 Aug 29 19:48 test_task_listpartition.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       525 Aug 29 19:48 test_task_listsdm.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       754 Aug 29 19:48 test_task_listvis.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      2663 Aug 29 19:48 test_task_makemask.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root     34560 Aug 29 19:48 test_task_mstransform.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      5873 Aug 29 19:48 test_task_mstransform_mms.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       786 Aug 29 19:48 test_task_nrobeamaverage.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      3486 Aug 29 19:48 test_task_partition.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      3243 Aug 29 19:48 test_task_phaseshift.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1095 Aug 29 19:48 test_task_plotants.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root     25975 Aug 29 19:48 test_task_plotbandpass.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1796 Aug 29 19:48 test_task_plotprofilemap.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1820 Aug 29 19:48 test_task_plotweather.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      3088 Aug 29 19:48 test_task_polcal.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       358 Aug 29 19:48 test_task_polfromgain.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1217 Aug 29 19:48 test_task_predictcomp.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       974 Aug 29 19:48 test_task_rerefant.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1208 Aug 29 19:48 test_task_rmfit.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       810 Aug 29 19:48 test_task_rmtables.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      5042 Aug 29 19:48 test_task_sdatmcor.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root     18317 Aug 29 19:48 test_task_sdbaseline.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      6651 Aug 29 19:48 test_task_sdcal.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      4178 Aug 29 19:48 test_task_sdfit.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1862 Aug 29 19:48 test_task_sdfixscan.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1589 Aug 29 19:48 test_task_sdgaincal.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root     23486 Aug 29 19:48 test_task_sdimaging.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      2722 Aug 29 19:48 test_task_sdintimaging.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       586 Aug 29 19:48 test_task_sdpolaverage.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      2454 Aug 29 19:48 test_task_sdsidebandsplit.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      3952 Aug 29 19:48 test_task_sdsmooth.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      4400 Aug 29 19:48 test_task_sdtimeaverage.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      3454 Aug 29 19:48 test_task_setjy.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1721 Aug 29 19:48 test_task_simanalyze.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root     12729 Aug 29 19:48 test_task_simobserve.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1512 Aug 29 19:48 test_task_slsearch.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1389 Aug 29 19:48 test_task_smoothcal.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1951 Aug 29 19:48 test_task_specfit.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       716 Aug 29 19:48 test_task_specflux.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       453 Aug 29 19:48 test_task_specsmooth.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       468 Aug 29 19:48 test_task_splattotable.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root     17908 Aug 29 19:48 test_task_split.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       708 Aug 29 19:48 test_task_spxfit.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      2409 Aug 29 19:48 test_task_statwt.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root     39350 Aug 29 19:48 test_task_tclean.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       701 Aug 29 19:48 test_task_testconcat.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root     24646 Aug 29 19:48 test_task_tsdimaging.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root       844 Aug 29 19:48 test_task_uvcontsub_old.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1523 Aug 29 19:48 test_task_uvmodelfit.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1485 Aug 29 19:48 test_task_virtualconcat.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1097 Aug 29 19:48 test_task_vishead.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      3291 Aug 29 19:48 test_task_visstat.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root      1988 Aug 29 19:48 test_task_wvrgcal.xml
29-Aug-2025 15:48:58 -rw-r--r-- 1 casaci root        45 Aug 29 19:48 work-el7.tar.gz
29-Aug-2025 15:48:58 Done packaging working directory
29-Aug-2025 15:48:58 Finished task 'Package working directory' with result: Success
29-Aug-2025 15:48:58 Starting task 'Parse tests' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
29-Aug-2025 15:48:58 Parsing test results under /export/home/cbt-el7-11/bamboohome/xml-data/build-dir/CASASPECS-PR120-TTAML228...
29-Aug-2025 15:48:58 Finished task 'Parse tests' with result: Success
29-Aug-2025 15:48:58 Running post build plugin 'Docker Container Cleanup'
29-Aug-2025 15:48:58
Beginning to execute external process for build 'CASASPECS - Pull Request - CAS-14640 - Test Tasks Many Linux 2.28 Python3.12 #1 (CASASPECS-PR120-TTAML228-1)'
... running command line:
/bin/docker rm -f wheel-container-test
... in: /export/home/cbt-el7-11/bamboohome/xml-data/build-dir/CASASPECS-PR120-TTAML228
29-Aug-2025 15:49:12 wheel-container-test
29-Aug-2025 15:49:12 Running post build plugin 'NCover Results Collector'
29-Aug-2025 15:49:12 Running post build plugin 'Build Results Label Collector'
29-Aug-2025 15:49:12 Running post build plugin 'Clover Results Collector'
29-Aug-2025 15:49:12 Running post build plugin 'npm Cache Cleanup'
29-Aug-2025 15:49:12 Running post build plugin 'Artifact Copier'
29-Aug-2025 15:49:12 Publishing an artifact: Workdir
29-Aug-2025 15:49:12 Finished publishing of artifact Non required job artifact Http Compression On : [Workdir], patterns: [work*.tar.gz] anchored at: [wheeldirectory/] in 154.2 ms
29-Aug-2025 15:49:12 Publishing an artifact: Tests
29-Aug-2025 15:49:13 Finished publishing of artifact Non required job artifact Http Compression On : [Tests], patterns: [*.xml] anchored at: [wheeldirectory/] in 746.9 ms
29-Aug-2025 15:49:13 Publishing an artifact: xml Directories
29-Aug-2025 15:49:13 Finished publishing of artifact Non required job artifact Http Compression On : [xml Directories], patterns: [**/*.xml] anchored at: [wheeldirectory/] in 501.3 ms
29-Aug-2025 15:49:13 Publishing an artifact: Casatasks Test Log
29-Aug-2025 15:49:14 Finished publishing of artifact Non required job artifact Http Compression On : [Casatasks Test Log], patterns: [casatasks_test.log] anchored at: [wheeldirectory/] in 170.2 ms
29-Aug-2025 15:49:14 Finalising the build...
29-Aug-2025 15:49:14 Stopping timer.
29-Aug-2025 15:49:14 Build CASASPECS-PR120-TTAML228-1 completed.
29-Aug-2025 15:49:14 Running on server: post build plugin 'Build Hanging Detection Configuration'
29-Aug-2025 15:49:14 Running on server: post build plugin 'NCover Results Collector'
29-Aug-2025 15:49:14 Running on server: post build plugin 'Build Labeller'
29-Aug-2025 15:49:14 Running on server: post build plugin 'Clover Delta Calculator'
29-Aug-2025 15:49:14 Running on server: post build plugin 'Maven Dependencies Postprocessor'
29-Aug-2025 15:49:14 All post build plugins have finished
29-Aug-2025 15:49:14 Generating build results summary...
29-Aug-2025 15:49:15 Saving build results to disk...
29-Aug-2025 15:49:15 Store variable context...
29-Aug-2025 15:49:15 Finished building CASASPECS-PR120-TTAML228-1.