Build: #1 was successful

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

Build log

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

04-Sep-2025 20:57:23
04-Sep-2025 20:57:23 2025-09-05 00:57:24        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [63]
04-Sep-2025 20:57:23 test_tool_ms.py::mstool_test_getdata::test_getweights_channavg
04-Sep-2025 20:57:23 test ms.getdata, weight, channavg
04-Sep-2025 20:57:23 PASSED
04-Sep-2025 20:57:23
04-Sep-2025 20:57:23 2025-09-05 00:57:24        INFO        VisSet::addCalSet        Adding MODEL_DATA and CORRECTED_DATA columns
04-Sep-2025 20:57:23 2025-09-05 00:57:24        INFO        VisSet::VisSet        Initializing MODEL_DATA (to unity) and CORRECTED_DATA (to DATA)
04-Sep-2025 20:57:24 2025-09-05 00:57:24        INFO        VisSet::VisSet        Initialized 22653 rows.
04-Sep-2025 20:57:24 2025-09-05 00:57:24        INFO        MSContinuumSubtractor::setSolutionInterval        Fitting continuum on 0-second (per scan) timescale.
04-Sep-2025 20:57:24 2025-09-05 00:57:24        INFO        MSContinuumSubtractor::subtract2        parameters:
04-Sep-2025 20:57:24 2025-09-05 00:57:24        INFO        MSContinuumSubtractor::subtract2           ddIds=[0], fieldIds=[1], order=0, mode=subtract
04-Sep-2025 20:57:24 2025-09-05 00:57:24        INFO        MSContinuumSubtractor::subtract2        Processing 4 slots for ddId 0
04-Sep-2025 20:57:25 2025-09-05 00:57:26        INFO        SubMS::parseColumnNames()        Using CORRECTED_DATA column.
04-Sep-2025 20:57:25 2025-09-05 00:57:26        INFO        SubMS::makeSelection()        4509 out of 22653 rows are going to be considered due to the selection criteria.
04-Sep-2025 20:57:28 test_tool_ms.py::mstool_test_transform::test_continuum_uv_cont_sub
04-Sep-2025 20:57:28 test ms.continuumsub, uvsub, contsub
04-Sep-2025 20:57:28 PASSED
04-Sep-2025 20:57:28
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        ms::cvel        Input spectral window 0 has 63 channels of width 2.441406e+04 Hz
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        ms::cvel+           First channel center = 1.412665074e+09 Hz, last channel center = 1.414178746e+09 Hz
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        ms::cvel        Starting combination of spectral windows ...
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        SubMS::combineSpws()        Less than two SPWs selected. No combination necessary.
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        ms::cvel        
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        ms::cvel        Testing if spectral frame transformation/regridding is needed ...
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        SubMS::regridSpw()        Using tabulated observatory position for VLA:
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        SubMS::regridSpw()           Position: [-1.60119e+06, -5.04198e+06, 3.55488e+06] (ITRF)
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        SubMS::regridSpw()        Regridded spectral window 0 will be created for field 0 with parameters
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        SubMS::regridSpw()+        input frame = LSRK, output frame = LSRK
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        SubMS::regridSpw()+         Channels equidistant in freq
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        SubMS::regridSpw()+         Central frequency (in output frame) = 1.41341e+09 Hz
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        SubMS::regridSpw()+         Width of central channel (in output frame) = 48828.1 Hz
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        SubMS::regridSpw()+         Number of channels = 31
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        SubMS::regridSpw()+         Total width of SPW (in output frame) = 1.51367e+06 Hz
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        SubMS::regridSpw()+         Lower edge = 1.41265e+09 Hz, upper edge = 1.41417e+09 Hz
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        SubMS::regridSpw()+         Interpolation Method = linear
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        SubMS::regridSpw()        Added 1 new rows to the DATA_DESCRIPTION table and deleted 1 old ones.
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        SubMS::regridSpw()+        Added 1 rows to the SPECTRAL_WINDOW table and deleted 1 old ones.
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        SubMS::regridSpw()+        Added 1 rows to the SOURCE table and deleted 3 old ones.
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        SubMS::regridSpw()        Main table data array columns will be rewritten.
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        SubMS::regridSpw()        The following columns will be Hanning-smoothed before regridding:
04-Sep-2025 20:57:29 2025-09-05 00:57:29        INFO        SubMS::regridSpw()         DATA
04-Sep-2025 20:57:29 test_tool_ms.py::mstool_test_transform::test_cvel regridSpw progress: 20% processed ...
04-Sep-2025 20:57:29 regridSpw progress: 40% processed ...
04-Sep-2025 20:57:29 regridSpw progress: 60% processed ...
04-Sep-2025 20:57:29 regridSpw progress: 80% processed ...
04-Sep-2025 20:57:30 regridSpw progress: 100% processed.
04-Sep-2025 20:57:30 2025-09-05 00:57:30        INFO        ms::cvel        Spectral frame transformation/regridding completed.
04-Sep-2025 20:57:30 2025-09-05 00:57:30        INFO        ms::cvel        Hanning smoothing was applied.
04-Sep-2025 20:57:30 2025-09-05 00:57:30        INFO        ms::cvel        Final spectral window has 31 channels of width 4.882812e+04 Hz
04-Sep-2025 20:57:30 2025-09-05 00:57:30        INFO        ms::cvel+        First channel center = 1.412677281e+09 Hz, last channel center = 1.414142125e+09 Hz
04-Sep-2025 20:57:30
04-Sep-2025 20:57:30 test ms.cvel
04-Sep-2025 20:57:30 PASSED
04-Sep-2025 20:57:30
04-Sep-2025 20:57:30 2025-09-05 00:57:31        INFO        ms::cvelfreqs        Calculating grid ...
04-Sep-2025 20:57:30 2025-09-05 00:57:31        INFO        ms::cvelfreqs        Using observation time from earliest row of the MS given the SPW and FIELD selection:
04-Sep-2025 20:57:30 2025-09-05 00:57:31        INFO        ms::cvelfreqs            1995/04/13/09:19:00 (TAI)
04-Sep-2025 20:57:30 2025-09-05 00:57:31        INFO        ms::cvelfreqs        Using tabulated observatory position for VLA:
04-Sep-2025 20:57:30 2025-09-05 00:57:31        INFO        ms::cvelfreqs           Position: [-1.60119e+06, -5.04198e+06, 3.55488e+06] (ITRF)
04-Sep-2025 20:57:30 2025-09-05 00:57:31        INFO        SubMS::convertGridPars         Channels equidistant in freq
04-Sep-2025 20:57:30 2025-09-05 00:57:31        INFO        SubMS::convertGridPars+         Central frequency (in output frame) = 1.41341e+09 Hz
04-Sep-2025 20:57:30 2025-09-05 00:57:31        INFO        SubMS::convertGridPars+         Width of central channel (in output frame) = 48828.1 Hz
04-Sep-2025 20:57:30 2025-09-05 00:57:31        INFO        SubMS::convertGridPars+         Number of channels = 31
04-Sep-2025 20:57:30 2025-09-05 00:57:31        INFO        SubMS::convertGridPars+         Total width of SPW (in output frame) = 1.51367e+06 Hz
04-Sep-2025 20:57:30 2025-09-05 00:57:31        INFO        SubMS::convertGridPars+         Lower edge = 1.41265e+09 Hz, upper edge = 1.41417e+09 Hz
04-Sep-2025 20:57:30 test_tool_ms.py::mstool_test_transform::test_cvelfreqs
04-Sep-2025 20:57:30 test ms.cvelfreqs
04-Sep-2025 20:57:30 PASSED
04-Sep-2025 20:57:30
04-Sep-2025 20:57:30 2025-09-05 00:57:31        INFO        ms::hanningsmooth        Smoothing MS Main Table column 'data'
04-Sep-2025 20:57:31 test_tool_ms.py::mstool_test_transform::test_hanningsmooth
04-Sep-2025 20:57:31 test ms.hanningsmooth
04-Sep-2025 20:57:31 PASSED
04-Sep-2025 20:57:31
04-Sep-2025 20:57:31 2025-09-05 00:57:31        INFO        ms::regridspw        Starting spectral frame transformation / regridding ...
04-Sep-2025 20:57:31 2025-09-05 00:57:31        INFO        SubMS::regridSpw()        Using tabulated observatory position for VLA:
04-Sep-2025 20:57:31 2025-09-05 00:57:31        INFO        SubMS::regridSpw()           Position: [-1.60119e+06, -5.04198e+06, 3.55488e+06] (ITRF)
04-Sep-2025 20:57:31 2025-09-05 00:57:31        INFO        SubMS::regridSpw()        Regridded spectral window 0 will be created for field 0 with parameters
04-Sep-2025 20:57:31 2025-09-05 00:57:31        INFO        SubMS::regridSpw()+        input frame = LSRK, output frame = LSRK
04-Sep-2025 20:57:31 2025-09-05 00:57:31        INFO        SubMS::regridSpw()+         New channels defined based on original channels
04-Sep-2025 20:57:31 2025-09-05 00:57:31        INFO        SubMS::regridSpw()+         Central channel contains original channel 24
04-Sep-2025 20:57:31 2025-09-05 00:57:31        INFO        SubMS::regridSpw()+         Channel width = 2 original channels
04-Sep-2025 20:57:31 2025-09-05 00:57:31        INFO        SubMS::regridSpw()+         Total width of SPW = 32 original channels == 16 new channels
04-Sep-2025 20:57:31 2025-09-05 00:57:31        INFO        SubMS::regridSpw()+         Total width of SPW (in output frame) = 781250 Hz
04-Sep-2025 20:57:31 2025-09-05 00:57:31        INFO        SubMS::regridSpw()+         Lower edge = 1.41285e+09 Hz, upper edge = 1.41363e+09 Hz
04-Sep-2025 20:57:31 2025-09-05 00:57:31        INFO        SubMS::regridSpw()+         Interpolation Method = linear
04-Sep-2025 20:57:31 2025-09-05 00:57:31        INFO        SubMS::regridSpw()        Added 1 new rows to the DATA_DESCRIPTION table and deleted 1 old ones.
04-Sep-2025 20:57:31 2025-09-05 00:57:31        INFO        SubMS::regridSpw()+        Added 1 rows to the SPECTRAL_WINDOW table and deleted 1 old ones.
04-Sep-2025 20:57:31 2025-09-05 00:57:31        INFO        SubMS::regridSpw()+        Added 3 rows to the SOURCE table and deleted 3 old ones.
04-Sep-2025 20:57:31 2025-09-05 00:57:31        INFO        SubMS::regridSpw()        Main table data array columns will be rewritten.
04-Sep-2025 20:57:31 2025-09-05 00:57:31        INFO        SubMS::regridSpw()        The following columns will be Hanning-smoothed before regridding:
04-Sep-2025 20:57:31 2025-09-05 00:57:31        INFO        SubMS::regridSpw()         DATA
04-Sep-2025 20:57:31 test_tool_ms.py::mstool_test_transform::test_regridspw regridSpw progress: 20% processed ...
04-Sep-2025 20:57:31 regridSpw progress: 40% processed ...
04-Sep-2025 20:57:31 regridSpw progress: 60% processed ...
04-Sep-2025 20:57:32 regridSpw progress: 80% processed ...
04-Sep-2025 20:57:32 regridSpw progress: 100% processed.
04-Sep-2025 20:57:32 2025-09-05 00:57:32        INFO        ms::regridspw        Spectral frame transformation/regridding completed.
04-Sep-2025 20:57:32
04-Sep-2025 20:57:32 test ms.regridspw
04-Sep-2025 20:57:32 PASSED
04-Sep-2025 20:57:32
04-Sep-2025 20:57:32 2025-09-05 00:57:33        INFO        Reweighter::makeSelection()        4509 out of 22653 rows are going to be considered due to the selection criteria.
04-Sep-2025 20:57:32 test_tool_ms.py::mstool_test_transform::test_statwt
04-Sep-2025 20:57:32 test ms.statwt
04-Sep-2025 20:57:32 PASSED
04-Sep-2025 20:57:32
04-Sep-2025 20:57:36 test_tool_ms.py::mstool_test_dataIO::test_getdata_args
04-Sep-2025 20:57:36 test ms.getdata ifraxis, increment, and average
04-Sep-2025 20:57:36 PASSED
04-Sep-2025 20:57:36
04-Sep-2025 20:57:36 test_tool_ms.py::mstool_test_dataIO::test_getdata_average
04-Sep-2025 20:57:36 PASSED
04-Sep-2025 20:57:36
04-Sep-2025 20:57:36 2025-09-05 00:57:37        INFO        calibrater::open        ****Using NEW VI2-driven calibrater tool****
04-Sep-2025 20:57:36 2025-09-05 00:57:37        INFO        calibrater::open        Opening MS: ngc5921_put.ms for calibration.
04-Sep-2025 20:57:36 2025-09-05 00:57:37        INFO                Clearing all model records in MS header.
04-Sep-2025 20:57:37 2025-09-05 00:57:37        INFO        VisSetUtil::addScrCols        Adding MODEL_DATA and CORRECTED_DATA column(s).
04-Sep-2025 20:57:37 2025-09-05 00:57:37        INFO        VisSetUtil::initScrCols        Initializing MODEL_DATA to (unity).
04-Sep-2025 20:57:37 2025-09-05 00:57:37        INFO        VisSetUtil::initScrCols        Initialized 22653 rows.
04-Sep-2025 20:57:37 2025-09-05 00:57:37        INFO        Calibrater::        Initializing nominal selection to the whole MS.
04-Sep-2025 20:57:43 test_tool_ms.py::mstool_test_dataIO::test_getdata_putdata
04-Sep-2025 20:57:43 test ms.getdata, putdata
04-Sep-2025 20:57:43 PASSED
04-Sep-2025 20:57:43
04-Sep-2025 20:57:49 2025-09-05 00:57:50        INFO        ms::sort        Sorted main table of /home/casatest/casa6/casatestutils/nosedir/test_tool_ms/ngc5921.ms by  [ANTENNA1,ANTENNA2]  and stored it in ngc5921_sort.ms .
04-Sep-2025 20:57:49 test_tool_ms.py::mstool_test_sort::test_sort
04-Sep-2025 20:57:49 test ms.sort
04-Sep-2025 20:57:49 PASSED
04-Sep-2025 20:57:49
04-Sep-2025 20:57:50 2025-09-05 00:57:51        INFO        ms::timesort        Sorted main table of /home/casatest/casa6/casatestutils/nosedir/test_tool_ms/ngc5921.ms by TIME and stored it in ngc5921_timesort.ms .
04-Sep-2025 20:57:51 test_tool_ms.py::mstool_test_sort::test_timesort
04-Sep-2025 20:57:51 test ms.timesort
04-Sep-2025 20:57:51 PASSED
04-Sep-2025 20:57:51
04-Sep-2025 20:57:51 2025-09-05 00:57:51        INFO        SubMS::parseColumnNames()        Using DATA column.
04-Sep-2025 20:57:51 2025-09-05 00:57:51        INFO        Partition::makeSelection()        4509 out of 22653 rows are going to be considered due to the selection criteria.
04-Sep-2025 20:57:53 test_tool_ms.py::mstool_test_subms::test_partition
04-Sep-2025 20:57:53 test ms.partition
04-Sep-2025 20:57:53 PASSED
04-Sep-2025 20:57:53
04-Sep-2025 20:57:53 2025-09-05 00:57:54        INFO        SubMS::parseColumnNames()        Using DATA column.
04-Sep-2025 20:57:53 2025-09-05 00:57:54        INFO        SubMS::makeSelection()        4509 out of 22653 rows are going to be considered due to the selection criteria.
04-Sep-2025 20:57:54 2025-09-05 00:57:55        INFO        SubMS::fillDDTables()        The last output channel of spw 0 has only 3 input channels.
04-Sep-2025 20:57:55 2025-09-05 00:57:55        INFO        SubMS::doChannelMods()        Data binned.
04-Sep-2025 20:57:56 test_tool_ms.py::mstool_test_subms::test_split
04-Sep-2025 20:57:56 test ms.split
04-Sep-2025 20:57:56 PASSED
04-Sep-2025 20:57:56
04-Sep-2025 20:57:56 2025-09-05 00:57:56        INFO        SubMS::parseColumnNames()        Using DATA column.
04-Sep-2025 20:57:59 2025-09-05 00:58:00        INFO        SubMS::doTimeAver()        Data binned.
04-Sep-2025 20:58:00 test_tool_ms.py::mstool_test_subms::test_split_averaging
04-Sep-2025 20:58:00 test ms.split time averaging
04-Sep-2025 20:58:00 PASSED
04-Sep-2025 20:58:00
04-Sep-2025 20:58:00 test_tool_ms.py::mstool_test_iter::test_iteration_columns
04-Sep-2025 20:58:00 test ms.iter functions with sort columns
04-Sep-2025 20:58:00 PASSED
04-Sep-2025 20:58:00
04-Sep-2025 20:58:00 test_tool_ms.py::mstool_test_iter::test_iterinit_interval
04-Sep-2025 20:58:00 test ms.iterinit interval parameter
04-Sep-2025 20:58:00 PASSED
04-Sep-2025 20:58:00
04-Sep-2025 20:58:01 test_tool_ms.py::mstool_test_iter::test_iterinit_maxrows
04-Sep-2025 20:58:01 test ms.iterinit maxrows parameter
04-Sep-2025 20:58:01 PASSED
04-Sep-2025 20:58:01
04-Sep-2025 20:58:01 2025-09-05 00:58:01        INFO        MSFitsInput::MSFitsInput        Converting FITS file '/opt/casa/data/casatestdata/unittest/mstool/3c273.fits7' to MeasurementSet 'ngc4826.tutorial.3c273.7.ms'
04-Sep-2025 20:58:01 2025-09-05 00:58:01        INFO        MSFitsInput::setupMeasurementSet        Using tile shape [1, 64, 2048] for HATCREEK with obstype=0
04-Sep-2025 20:58:02 2025-09-05 00:58:03        INFO        MSFitsInput::fillMSMainTableColWise        SOURCE not found in UU VV WW BASELINE DATE
04-Sep-2025 20:58:02 2025-09-05 00:58:03        INFO        MSFitsInput::fillMSMainTableColWise        FREQSEL not found in UU VV WW BASELINE DATE
04-Sep-2025 20:58:02 2025-09-05 00:58:03        INFO        MSFitsInput::fillMSMainTableColWise        Reading and writing 2925 visibility groups
04-Sep-2025 20:58:02 2025-09-05 00:58:03        INFO        MSFitsInput::readRandomGroupUVFits        extname=AIPS AN  nrows=12 ncols=12 rowsize=78 pcount=0 gcount=1
04-Sep-2025 20:58:02 2025-09-05 00:58:03        WARN        MSFitsInput::fillAntennaTable        XYZHAND keyword not found in AN table. Will assume antenna coordinate system is right handed.
04-Sep-2025 20:58:02 2025-09-05 00:58:03        INFO        MSFitsInput::fillExtraTables        Filling SOURCE table (this may take some time).
04-Sep-2025 20:58:02 2025-09-05 00:58:03        WARN        MSFitsInput::fillExtraTable        No systemic velocity for field 0
04-Sep-2025 20:58:02 2025-09-05 00:58:03        WARN        MSFitsInput::fillExtraTable        No rest frequency for field 0
04-Sep-2025 20:58:03 test_tool_ms.py::mstool_test_fits::test_badscan
04-Sep-2025 20:58:03 CAS-10054: Tests intermittent incorrect scan number in last row of single-scan dataset
04-Sep-2025 20:58:03 Last row has scan=1 ; (should be 1).
04-Sep-2025 20:58:03 PASSED
04-Sep-2025 20:58:03
04-Sep-2025 20:58:03 2025-09-05 00:58:03        INFO        MSFitsInput::MSFitsInput        Converting FITS file '/opt/casa/data/casatestdata/unittest/mstool/CTR_CHI_TR2.RWYCP-10rows-ANT-DIAMTER-0' to MeasurementSet 'CAS-5818.ms'
04-Sep-2025 20:58:03 2025-09-05 00:58:03        INFO        MSFitsInput::setupMeasurementSet        Using tile shape [4, 64, 512] for EVLA with obstype=0
04-Sep-2025 20:58:05 2025-09-05 00:58:05        INFO        MSFitsInput::fillMSMainTable        Reading and writing 1 visibility groups
04-Sep-2025 20:58:05 2025-09-05 00:58:05        INFO        MSFitsInput::readRandomGroupUVFits        extname=AIPS FQ  nrows=1 ncols=5 rowsize=204 pcount=0 gcount=1
04-Sep-2025 20:58:05 2025-09-05 00:58:05        INFO        MSFitsInput::readRandomGroupUVFits        extname=AIPS AN  nrows=28 ncols=12 rowsize=62 pcount=0 gcount=1
04-Sep-2025 20:58:05 2025-09-05 00:58:05        WARN        MSFitsInput::fillAntennaTable        XYZHAND keyword not found in AN table. Will assume antenna coordinate system is right handed.
04-Sep-2025 20:58:05 2025-09-05 00:58:05        INFO        MSFitsInput::readRandomGroupUVFits        extname=AIPS SU  nrows=1 ncols=19 rowsize=496 pcount=0 gcount=1
04-Sep-2025 20:58:05 2025-09-05 00:58:05        INFO        MSFitsInput::fillExtraTables        Filling SOURCE table (this may take some time).
04-Sep-2025 20:58:05 2025-09-05 00:58:06        INFO        msmetadata_cmpt.cc::open        Performing internal consistency checks on CAS-5818.ms...
04-Sep-2025 20:58:05 test_tool_ms.py::mstool_test_fits::test_diameters
04-Sep-2025 20:58:05 CAS-5818: Verify bogus dish diameters in AN table are not used but normal algorithm is used instead
04-Sep-2025 20:58:05 PASSED
04-Sep-2025 20:58:05
04-Sep-2025 20:58:05 2025-09-05 00:58:06        INFO        MSFitsOutput::write         nchan=3 startchan=0 stepchan=1 avgchan=1
04-Sep-2025 20:58:05 2025-09-05 00:58:06        INFO        MSFitsOutput::write        Converting MeasurementSet /opt/casa/data/casatestdata/unittest/mstool/uvfits_test.ms to FITS file 'CAS-5492.uvfits'
04-Sep-2025 20:58:05 2025-09-05 00:58:06        INFO        MSFitsOutput::_writeMain        CORRECTED_DATA does not exist, writing DATA
04-Sep-2025 20:58:05 2025-09-05 00:58:06        INFO        MSFitsOutput::_writeMain        Frequency reference frame is LSRK
04-Sep-2025 20:58:05 2025-09-05 00:58:06        INFO        MSFitsOutput::write        Writing AIPS FQ table
04-Sep-2025 20:58:05 2025-09-05 00:58:06        INFO        MSFitsOutput::writeFQ        Found 2 spectral windows
04-Sep-2025 20:58:05 2025-09-05 00:58:06        INFO        MSFitsOutput::write        Writing AIPS AN table
04-Sep-2025 20:58:05 2025-09-05 00:58:06        INFO        MSFitsOutput::writeAN        Using ITRF frame for antenna positions.
04-Sep-2025 20:58:05 2025-09-05 00:58:06        INFO        MSFitsOutput::writeAN        Found 8 antennas in array #1
04-Sep-2025 20:58:05 2025-09-05 00:58:06        INFO        MSFitsOutput::write         nchan=3 startchan=0 stepchan=1 avgchan=1
04-Sep-2025 20:58:05 2025-09-05 00:58:06        SEVERE        ms::tofits        Exception Reported: Exception: Error in output file : File CAS-5492.uvfits exists, and the user does not want to remove it..
04-Sep-2025 20:58:05 2025-09-05 00:58:06        SEVERE        ms::tofits+        ... thrown by void casacore::MSFitsOutput::write() const at File: /source/casa6/casatools/casacore/msfits/MSFits/MSFitsOutput.cc, line: 168
04-Sep-2025 20:58:05 2025-09-05 00:58:06        INFO        MSFitsOutput::write         nchan=3 startchan=0 stepchan=1 avgchan=1
04-Sep-2025 20:58:05 2025-09-05 00:58:06        INFO        MSFitsOutput::write        Removing existing file CAS-5492.uvfits
04-Sep-2025 20:58:05 2025-09-05 00:58:06        INFO        MSFitsOutput::write        Converting MeasurementSet /opt/casa/data/casatestdata/unittest/mstool/uvfits_test.ms to FITS file 'CAS-5492.uvfits'
04-Sep-2025 20:58:05 2025-09-05 00:58:06        INFO        MSFitsOutput::_writeMain        CORRECTED_DATA does not exist, writing DATA
04-Sep-2025 20:58:05 2025-09-05 00:58:06        INFO        MSFitsOutput::_writeMain        Frequency reference frame is LSRK
04-Sep-2025 20:58:05 2025-09-05 00:58:06        INFO        MSFitsOutput::write        Writing AIPS FQ table
04-Sep-2025 20:58:05 2025-09-05 00:58:06        INFO        MSFitsOutput::writeFQ        Found 2 spectral windows
04-Sep-2025 20:58:05 2025-09-05 00:58:06        INFO        MSFitsOutput::write        Writing AIPS AN table
04-Sep-2025 20:58:05 2025-09-05 00:58:06        INFO        MSFitsOutput::writeAN        Using ITRF frame for antenna positions.
04-Sep-2025 20:58:05 2025-09-05 00:58:06        INFO        MSFitsOutput::writeAN        Found 8 antennas in array #1
04-Sep-2025 20:58:06 test_tool_ms.py::mstool_test_fits::test_export_overwrite
04-Sep-2025 20:58:06 CAS-5492: test the overwrite parameter when exporting MSes to uvfits
04-Sep-2025 20:58:06 PASSED
04-Sep-2025 20:58:06
04-Sep-2025 20:58:06 2025-09-05 00:58:06        INFO        MSFitsInput::MSFitsInput        Converting FITS file '/opt/casa/data/casatestdata/unittest/mstool/name10rows+000' to MeasurementSet 'CAS-7696.ms'
04-Sep-2025 20:58:06 2025-09-05 00:58:06        INFO        MSFitsInput::setupMeasurementSet        Using tile shape [4, 64, 512] for EVLA with obstype=0
04-Sep-2025 20:58:07 2025-09-05 00:58:07        INFO        MSFitsInput::fillMSMainTable        Reading and writing 1 visibility groups
04-Sep-2025 20:58:07 2025-09-05 00:58:07        INFO        MSFitsInput::readRandomGroupUVFits        extname=AIPS FQ  nrows=1 ncols=5 rowsize=204 pcount=0 gcount=1
04-Sep-2025 20:58:07 2025-09-05 00:58:07        INFO        MSFitsInput::readRandomGroupUVFits        extname=AIPS AN  nrows=28 ncols=13 rowsize=66 pcount=0 gcount=1
04-Sep-2025 20:58:07 2025-09-05 00:58:07        INFO        MSFitsInput::readRandomGroupUVFits        extname=AIPS SU  nrows=1 ncols=19 rowsize=496 pcount=0 gcount=1
04-Sep-2025 20:58:07 2025-09-05 00:58:07        INFO        MSFitsInput::fillExtraTables        Filling SOURCE table (this may take some time).
04-Sep-2025 20:58:08 test_tool_ms.py::mstool_test_fits::test_filename_extensions
04-Sep-2025 20:58:08 CAS-7696: Verify we turn off fits filename extension support when necessary
04-Sep-2025 20:58:08 PASSED
04-Sep-2025 20:58:08
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::listFits         read fitsfile=ngc5921.fits
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::listFits         Primary Group HDU ------>>>
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU         SIMPLE  =                      T /Standard FITS format
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        BITPIX  =                    -32 /Floating point values
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        NAXIS   =                      7
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        NAXIS1  =                      0 /Random groups, NOT image
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        NAXIS2  =                      3
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        NAXIS3  =                      2
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        NAXIS4  =                     63
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        NAXIS5  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        NAXIS6  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        NAXIS7  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        EXTEND  =                      T /Tables may follow
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        BLOCKED =                      T /File may be blocked
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        GROUPS  =                      T /Random Group UV data
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PCOUNT  =                      9 /Number of random parameters
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        GCOUNT  =                  22653 /Number of groups (rows) in the file
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +               
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        EPOCH   =                   2000
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        BSCALE  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        BZERO   =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        BUNIT   = 'UNCALIB '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CTYPE2  = 'COMPLEX '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CRVAL2  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CDELT2  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CRPIX2  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CROTA2  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CTYPE3  = 'STOKES  '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CRVAL3  =                     -1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CDELT3  =                     -1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CRPIX3  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CROTA3  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CTYPE4  = 'FREQ    '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CRVAL4  =            1.41342e+09
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CDELT4  =                24414.1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CRPIX4  =                     32
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CROTA4  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CTYPE5  = 'IF      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CRVAL5  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CDELT5  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CRPIX5  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CROTA5  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CTYPE6  = 'RA      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CRVAL6  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CDELT6  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CRPIX6  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CROTA6  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CTYPE7  = 'DEC     '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CRVAL7  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CDELT7  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CRPIX7  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        CROTA7  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PTYPE1  = 'UU      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PSCAL1  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PZERO1  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PTYPE2  = 'VV      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PSCAL2  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PZERO2  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PTYPE3  = 'WW      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PSCAL3  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PZERO3  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PTYPE4  = 'DATE    ' /Day number
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PSCAL4  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PZERO4  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PTYPE5  = 'DATE    ' /Day fraction
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PSCAL5  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PZERO5  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PTYPE6  = 'BASELINE'
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PSCAL6  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PZERO6  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PTYPE7  = 'FREQSEL '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PSCAL7  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PZERO7  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PTYPE8  = 'SOURCE  '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PSCAL8  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PZERO8  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PTYPE9  = 'INTTIM  '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PSCAL9  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PZERO9  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        OBJECT  = 'MULTI   '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        DATE-OBS= '1995-04-13T09:18:59.999771'
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TELESCOP= 'VLA     '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        INSTRUME= 'VLA     '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        OBSERVER= 'TEST    '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        SORTORD = 'TB      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        SPECSYS = 'LSRK    '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        RESTFREQ=            1.42041e+09
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        HISTORY AIPS WTSCAL = 1.0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +               
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        ORIGIN  = 'casacore'
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +               
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        END
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showPrimaryGroup         22653 groups total, display first 6 elements of the first 2 groups
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showPrimaryGroup +        Group 0 parms:  0 0 0 2.44982e+06 0.888194 257 1 1 30
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showPrimaryGroup +        Group 0 data:  2.45987 0 6 0.798322 0 6 21.1242 0 6 11.6481 0 6 39.7646 0 6 27.8526 0 6...
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showPrimaryGroup +        Group 1 parms:  -4.61236e-07 1.20458e-06 5.15788e-08 2.44982e+06 0.888194 258 1 1 30
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showPrimaryGroup +        Group 1 data:  0.00824685 -0.0166335 6 0.00102503 -0.00442628 6 -0.0403956 -0.32815 6 -0.179474 0.100313 6 -0.0678851 -0.773201 6 -0.358901 0.429815 6...
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::listFits         <<<------ Primary Group HDU
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::listFits         Binary Table HDU ------>>>
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU         XTENSION= 'BINTABLE' /Binary Table Extension
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        BITPIX  =                      8 /Character Information
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        NAXIS   =                      2 /Two-dimensional table
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        NAXIS1  =                     24 /Number of bytes per row
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        NAXIS2  =                      1 /Number of rows
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PCOUNT  =                      0 /No random parameters
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        GCOUNT  =                      1 /Only one group
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFIELDS =                      5 /Number of columns
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +               
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +               
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        EXTNAME = 'AIPS FQ '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        EXTVER  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        NO_IF   =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +               
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE1  = 'FRQSEL  '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM1  = '1J      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE2  = 'IF FREQ '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM2  = '1D      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT2  = 'HZ      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE3  = 'CH WIDTH'
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM3  = '1E      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT3  = 'HZ      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE4  = 'TOTAL BANDWIDTH'
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM4  = '1E      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT4  = 'HZ      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE5  = 'SIDEBAND'
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM5  = '1J      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +               
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        END
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showBinaryTable         1 rows, 5 cols, 24 bytes total
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showBinaryTable         the first 20 cols of the first 5 rows:
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showBinaryTable         0: | 1 | 0 | 24414.1 | 1.5502e+06 | 1 |
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::listFits         <<<------ Binary Table HDU
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::listFits         Binary Table HDU ------>>>
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU         XTENSION= 'BINTABLE' /Binary Table Extension
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        BITPIX  =                      8 /Character Information
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        NAXIS   =                      2 /Two-dimensional table
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        NAXIS1  =                     66 /Number of bytes per row
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        NAXIS2  =                     28 /Number of rows
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PCOUNT  =                      0 /No random parameters
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        GCOUNT  =                      1 /Only one group
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFIELDS =                     13 /Number of columns
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +               
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +               
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        EXTNAME = 'AIPS AN '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        EXTVER  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        ARRAYX  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        ARRAYY  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        ARRAYZ  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        GSTIA0  =                200.712
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        DEGPDY  =                360.986
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        FREQ    =            1.41342e+09
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        RDATE   = '1995-04-13T09:18:59.999771'
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        POLARX  =                2.12653
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        POLARY  =                17.1957
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        UT1UTC  =               0.123216
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        IATUTC  =                     29
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TIMSYS  = 'TAI     '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        ARRNAM  = 'VLA     '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        NUMORB  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        NOPCAL  =                      0
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        POLTYPE = '        '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        XYZHAND = 'RIGHT   '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        FRAME   = 'ITRF    '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +               
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE1  = 'ANNAME  '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM1  = '8A      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE2  = 'STABXYZ '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM2  = '3D      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT2  = 'METERS  '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE3  = 'ORBPARM '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM3  = '0D      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE4  = 'NOSTA   '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM4  = '1J      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE5  = 'MNTSTA  '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM5  = '1J      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE6  = 'STAXOF  '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM6  = '1E      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT6  = 'METERS  '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE7  = 'POLTYA  '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM7  = '1A      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE8  = 'POLAA   '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM8  = '1E      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT8  = 'DEGREES '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE9  = 'POLCALA '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM9  = '1E      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE10 = 'POLTYB  '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM10 = '1A      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE11 = 'POLAB   '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM11 = '1E      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT11 = 'DEGREES '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE12 = 'POLCALB '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM12 = '1E      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE13 = 'DIAMETER'
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM13 = '1E      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +               
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        END
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showBinaryTable         28 rows, 13 cols, 1848 bytes total
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showBinaryTable         the first 20 cols of the first 5 rows:
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showBinaryTable         0: | VLA:N7 | -1.60116e+06, -5.04178e+06, 3.55516e+06 | | 1 | 0 | 0.00164886 | R | 0 | 0 | L | 0 | 0 | 25 |
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showBinaryTable +        1: | VLA:W1 | -1.60119e+06, -5.042e+06, 3.55484e+06 | | 2 | 0 | 0.000869398 | R | 0 | 0 | L | 0 | 0 | 25 |
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showBinaryTable +        2: | VLA:W2 | -1.60123e+06, -5.04198e+06, 3.55486e+06 | | 3 | 0 | -0.00116919 | R | 0 | 0 | L | 0 | 0 | 25 |
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showBinaryTable +        3: | VLA:E1 | -1.60119e+06, -5.04202e+06, 3.55481e+06 | | 4 | 0 | 0.0093835 | R | 0 | 0 | L | 0 | 0 | 25 |
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showBinaryTable +        4: | VLA:E3 | -1.60111e+06, -5.04202e+06, 3.55484e+06 | | 5 | 0 | 0.000869398 | R | 0 | 0 | L | 0 | 0 | 25 |
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::listFits         <<<------ Binary Table HDU
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::listFits         Binary Table HDU ------>>>
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU         XTENSION= 'BINTABLE' /Binary Table Extension
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        BITPIX  =                      8 /Character Information
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        NAXIS   =                      2 /Two-dimensional table
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        NAXIS1  =                    136 /Number of bytes per row
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        NAXIS2  =                      3 /Number of rows
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        PCOUNT  =                      0 /No random parameters
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        GCOUNT  =                      1 /Only one group
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFIELDS =                     19 /Number of columns
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +               
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +               
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        EXTNAME = 'AIPS SU '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        EXTVER  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        NO_IF   =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        FREQID  =                      1
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +               
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE1  = 'ID. NO. '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM1  = '1J      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE2  = 'SOURCE  '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM2  = '20A     '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE3  = 'QUAL    '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM3  = '1J      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE4  = 'CALCODE '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM4  = '4A      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE5  = 'IFLUX   '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM5  = '1E      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT5  = 'JY      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE6  = 'QFLUX   '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM6  = '1E      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT6  = 'JY      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE7  = 'UFLUX   '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM7  = '1E      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT7  = 'JY      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE8  = 'VFLUX   '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM8  = '1E      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT8  = 'JY      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE9  = 'FREQOFF '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM9  = '1D      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT9  = 'HZ      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE10 = 'BANDWIDTH'
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM10 = '1D      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT10 = 'HZ      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE11 = 'RAEPO   '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM11 = '1D      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT11 = 'DEGREES '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE12 = 'DECEPO  '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM12 = '1D      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT12 = 'DEGREES '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE13 = 'EPOCH   '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM13 = '1D      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT13 = 'YEARS   '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE14 = 'RAAPP   '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM14 = '1D      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT14 = 'DEGREES '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE15 = 'DECAPP  '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM15 = '1D      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT15 = 'DEGREES '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE16 = 'LSRVEL  '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM16 = '1D      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT16 = 'M/SEC   '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE17 = 'RESTFREQ'
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM17 = '1D      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT17 = 'HZ      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE18 = 'PMRA    '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM18 = '1D      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT18 = 'DEG/DAY '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TTYPE19 = 'PMDEC   '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TFORM19 = '1D      '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        TUNIT19 = 'DEG/DAY '
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +               
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showHDU +        END
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showBinaryTable         3 rows, 19 cols, 408 bytes total
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showBinaryTable         the first 20 cols of the first 5 rows:
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showBinaryTable         0: | 1 | 1331+30500002_0      | 0 |      | 0 | 0 | 0 | 0 | 0 | 1.5502e+06 | -157.215 | 30.5092 | 2000 | -157.263 | 30.5314 | 0 | 1.42041e+09 | 0 | 0 |
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showBinaryTable +        1: | 2 | 1445+09900002_0      | 0 |      | 0 | 0 | 0 | 0 | 0 | 1.5502e+06 | -138.681 | 9.97669 | 2000 | -138.732 | 9.99458 | 0 | 1.42041e+09 | 0 | 0 |
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::showBinaryTable +        2: | 3 | N5921_2              | 0 |      | 0 | 0 | 0 | 0 | 0 | 1.5502e+06 | -129.5 | 5.06667 | 2000 | -129.552 | 5.08192 | 0 | 1.42041e+09 | 0 | 0 |
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::listFits         <<<------ Binary Table HDU
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        FITSReader::listFits         finish processing of Header-Data Units.
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        MSFitsInput::MSFitsInput        Converting FITS file 'ngc5921.fits' to MeasurementSet 'fromfits.ms'
04-Sep-2025 20:58:08 2025-09-05 00:58:08        INFO        MSFitsInput::setupMeasurementSet        Using tile shape [2, 63, 1040] for VLA with obstype=0
04-Sep-2025 20:58:10 2025-09-05 00:58:11        INFO        MSFitsInput::fillMSMainTable        Reading and writing 22653 visibility groups
04-Sep-2025 20:58:10 2025-09-05 00:58:11        INFO        MSFitsInput::readRandomGroupUVFits        extname=AIPS FQ  nrows=1 ncols=5 rowsize=24 pcount=0 gcount=1
04-Sep-2025 20:58:10 2025-09-05 00:58:11        INFO        MSFitsInput::readRandomGroupUVFits        extname=AIPS AN  nrows=28 ncols=13 rowsize=66 pcount=0 gcount=1
04-Sep-2025 20:58:10 2025-09-05 00:58:11        INFO        MSFitsInput::readRandomGroupUVFits        extname=AIPS SU  nrows=3 ncols=19 rowsize=136 pcount=0 gcount=1
04-Sep-2025 20:58:10 2025-09-05 00:58:11        INFO        MSFitsInput::fillExtraTables        Filling SOURCE table (this may take some time).
04-Sep-2025 20:58:11 2025-09-05 00:58:12        INFO        ms::tofits        By selection 22653 rows to be converted are reduced to 4509
04-Sep-2025 20:58:11 2025-09-05 00:58:12        INFO        MSFitsOutput::write         nchan=63 startchan=0 stepchan=1 avgchan=1
04-Sep-2025 20:58:11 2025-09-05 00:58:12        INFO        MSFitsOutput::write        Converting MeasurementSet /home/casatest/casa6/casatestutils/nosedir/test_tool_ms/tab1840_1123 to FITS file 'testfile.fits'
04-Sep-2025 20:58:11 2025-09-05 00:58:12        INFO        MSFitsOutput::_writeMain        Writing DATA column
04-Sep-2025 20:58:11 2025-09-05 00:58:12        INFO        MSFitsOutput::_writeMain        Frequency reference frame is LSRK
04-Sep-2025 20:58:11 2025-09-05 00:58:12        INFO        MSFitsOutput::write        Writing AIPS FQ table
04-Sep-2025 20:58:11 2025-09-05 00:58:12        INFO        MSFitsOutput::writeFQ        Found 1 spectral windows
04-Sep-2025 20:58:11 2025-09-05 00:58:12        INFO        MSFitsOutput::write        Writing AIPS AN table
04-Sep-2025 20:58:11 2025-09-05 00:58:12        INFO        MSFitsOutput::writeAN        Using ITRF frame for antenna positions.
04-Sep-2025 20:58:11 2025-09-05 00:58:12        INFO        MSFitsOutput::writeAN        Found 28 antennas in array #1
04-Sep-2025 20:58:11 test_tool_ms.py::mstool_test_fits::test_list_from_tofits
04-Sep-2025 20:58:11 test ms.listfits, fromfits, tofits
04-Sep-2025 20:58:11 PASSED
04-Sep-2025 20:58:11
04-Sep-2025 20:58:12 2025-09-05 00:58:12        INFO        MSFitsOutput::write         nchan=3 startchan=0 stepchan=1 avgchan=1
04-Sep-2025 20:58:12 2025-09-05 00:58:12        INFO        MSFitsOutput::write        Converting MeasurementSet /opt/casa/data/casatestdata/unittest/mstool/uvfits_test.ms to FITS file 'xyz.uvfits'
04-Sep-2025 20:58:12 2025-09-05 00:58:12        INFO        MSFitsOutput::_writeMain        CORRECTED_DATA does not exist, writing DATA
04-Sep-2025 20:58:12 2025-09-05 00:58:12        INFO        MSFitsOutput::_writeMain        Frequency reference frame is LSRK
04-Sep-2025 20:58:12 2025-09-05 00:58:12        INFO        MSFitsOutput::write        Writing AIPS FQ table
04-Sep-2025 20:58:12 2025-09-05 00:58:12        INFO        MSFitsOutput::writeFQ        Found 2 spectral windows
04-Sep-2025 20:58:12 2025-09-05 00:58:12        INFO        MSFitsOutput::write        Writing AIPS AN table
04-Sep-2025 20:58:12 2025-09-05 00:58:12        INFO        MSFitsOutput::writeAN        Using ITRF frame for antenna positions.
04-Sep-2025 20:58:12 2025-09-05 00:58:12        INFO        MSFitsOutput::writeAN        Found 8 antennas in array #1
04-Sep-2025 20:58:12 2025-09-05 00:58:12        INFO        MSFitsInput::MSFitsInput        Converting FITS file 'xyz.uvfits' to MeasurementSet 'ke.ms'
04-Sep-2025 20:58:12 2025-09-05 00:58:12        INFO        MSFitsInput::setupMeasurementSet        Using tile shape [1, 3, 43690] for SMA with obstype=0
04-Sep-2025 20:58:13 2025-09-05 00:58:14        INFO        MSFitsInput::fillMSMainTableColWise        SOURCE not found in UU VV WW DATE DATE BASELINE FREQSEL
04-Sep-2025 20:58:13 2025-09-05 00:58:14        INFO        MSFitsInput::fillMSMainTableColWise        Reading and writing 630 visibility groups
04-Sep-2025 20:58:13 2025-09-05 00:58:14        INFO        MSFitsInput::readRandomGroupUVFits        extname=AIPS FQ  nrows=2 ncols=5 rowsize=24 pcount=0 gcount=1
04-Sep-2025 20:58:13 2025-09-05 00:58:14        INFO        MSFitsInput::readRandomGroupUVFits        extname=AIPS AN  nrows=8 ncols=13 rowsize=66 pcount=0 gcount=1
04-Sep-2025 20:58:13 2025-09-05 00:58:14        INFO        MSFitsInput::fillExtraTables        Filling SOURCE table (this may take some time).
04-Sep-2025 20:58:13 2025-09-05 00:58:14        WARN        MSFitsInput::fillExtraTable        No systemic velocity for field 0
04-Sep-2025 20:58:13 2025-09-05 00:58:14        WARN        MSFitsInput::fillExtraTable        No rest frequency for field 0
04-Sep-2025 20:58:13 2025-09-05 00:58:14        WARN        MSFitsInput::fillExtraTable        No systemic velocity for field 0
04-Sep-2025 20:58:13 2025-09-05 00:58:14        WARN        MSFitsInput::fillExtraTable        No rest frequency for field 0
04-Sep-2025 20:58:15 test_tool_ms.py::mstool_test_fits::test_receptor_angle
04-Sep-2025 20:58:15 CAS-7081: Test receptor angle is preserved
04-Sep-2025 20:58:15 PASSED
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 2025-09-05 00:58:15        INFO        MSFitsInput::MSFitsInput        Converting FITS file '/opt/casa/data/casatestdata/unittest/mstool/1331+305_I.UVFITS' to MeasurementSet 'my.ms'
04-Sep-2025 20:58:15 2025-09-05 00:58:15        SEVERE        ms::fromfits        Stokes I cannot be decomposed into proper correlation types without making assumptions. This functionality is not supported at File: /source/casa6/casatools/casacore/msfits/MSFits/MSFitsInput.cc, line: 744 at File: /source/casa6/casatools/casacore/msfits/MSFits/MSFitsInput.cc, line: 597
04-Sep-2025 20:58:15 test_tool_ms.py::mstool_test_fits::test_stokes
04-Sep-2025 20:58:15 Verify fix to CAS_4283, uvfits files containing actual Stokes parameters will not be imported
04-Sep-2025 20:58:15 PASSED
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_ms/nose.xml -
04-Sep-2025 20:58:15 ================== 53 passed, 4 warnings in 61.93s (0:01:01) ===================
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_agentflagger/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_agentflagger/
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_statistics/
04-Sep-2025 20:58:15 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_statistics
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_statistics/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_statistics/
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager/
04-Sep-2025 20:58:15 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_vpmanager/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager/
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_collapse/
04-Sep-2025 20:58:15 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_collapse
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_collapse/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_collapse/
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_imagepol/
04-Sep-2025 20:58:15 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_imagepol
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_imagepol/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_imagepol/
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_transpose/
04-Sep-2025 20:58:15 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_transpose
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_transpose/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_transpose/
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_rebin/
04-Sep-2025 20:58:15 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_rebin
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_rebin/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_rebin/
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msmetadata/
04-Sep-2025 20:58:15 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msmetadata
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_msmetadata/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_msmetadata/
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_subimage/
04-Sep-2025 20:58:15 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_subimage
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_subimage/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_subimage/
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_table/
04-Sep-2025 20:58:15 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_table
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_table/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_table/
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image/
04-Sep-2025 20:58:15 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image/
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_statwt/
04-Sep-2025 20:58:15 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_statwt
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_ms_statwt/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_statwt/
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_sdm_toms/
04-Sep-2025 20:58:15 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_sdm_toms
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_sdm_toms/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_sdm_toms/
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv/
04-Sep-2025 20:58:15 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_pv/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv/
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_coordsys/
04-Sep-2025 20:58:15 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_coordsys
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_coordsys/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_coordsys/
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calanalysis/
04-Sep-2025 20:58:15 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calanalysis
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_calanalysis/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_calanalysis/
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_regionmanager/
04-Sep-2025 20:58:15 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_regionmanager
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_regionmanager/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_regionmanager/
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_regrid/
04-Sep-2025 20:58:15 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_regrid
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_regrid/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_regrid/
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_measures/
04-Sep-2025 20:58:15 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_measures
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_measures/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_measures/
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms/
04-Sep-2025 20:58:15 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_ms/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_ms/
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_createmultims/
04-Sep-2025 20:58:15 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_createmultims
04-Sep-2025 20:58:15
04-Sep-2025 20:58:15 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_ms_createmultims/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_createmultims/============================= test session starts ==============================
04-Sep-2025 20:58:15 platform linux -- Python 3.12.9, pytest-8.4.2, pluggy-1.6.0 -- /usr/local/bin/python3.12
04-Sep-2025 20:58:15 cachedir: .pytest_cache
04-Sep-2025 20:58:15 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_createmultims
04-Sep-2025 20:58:15 configfile: pytest.ini
04-Sep-2025 20:58:16 collecting ... collected 1 item
04-Sep-2025 20:58:16
04-Sep-2025 20:58:16
04-Sep-2025 20:58:16 2025-09-05 00:58:17        INFO        ms::createmultims        Copying subtables from part1.ms to the other MMS members.
04-Sep-2025 20:58:22 2025-09-05 00:58:22        INFO        name::        No table opened.
04-Sep-2025 20:58:22 2025-09-05 00:58:22        INFO        name::        No table opened.
04-Sep-2025 20:58:22 test_tool_ms_createmultims.py::test_createmultims::test1
04-Sep-2025 20:58:22 Test_createmultims 1: 4 parts, same sources but different spws
04-Sep-2025 20:58:22 Copying part1.ms
04-Sep-2025 20:58:22 Copying part2-mod.ms
04-Sep-2025 20:58:22 Copying part2-mod2.ms
04-Sep-2025 20:58:22 Copying part2.ms
04-Sep-2025 20:58:22 Copying part3.ms
04-Sep-2025 20:58:22 Copying part4.ms
04-Sep-2025 20:58:22 PASSED
04-Sep-2025 20:58:22
04-Sep-2025 20:58:22 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_ms_createmultims/nose.xml -
04-Sep-2025 20:58:22 ======================== 1 passed, 4 warnings in 6.38s =========================
04-Sep-2025 20:58:22 ============================= test session starts ==============================
04-Sep-2025 20:58:22 platform linux -- Python 3.12.9, pytest-8.4.2, pluggy-1.6.0 -- /usr/local/bin/python3.12
04-Sep-2025 20:58:22 cachedir: .pytest_cache
04-Sep-2025 20:58:22 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor
04-Sep-2025 20:58:22 configfile: pytest.ini
04-Sep-2025 20:58:23 collecting ... collected 9 items
04-Sep-2025 20:58:23
04-Sep-2025 20:58:23
04-Sep-2025 20:58:23 2025-09-05 00:58:24        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:23 2025-09-05 00:58:24        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:23 2025-09-05 00:58:24        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
04-Sep-2025 20:58:23 2025-09-05 00:58:24        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
04-Sep-2025 20:58:23 2025-09-05 00:58:24        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
04-Sep-2025 20:58:23 2025-09-05 00:58:24        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Sep-2025 20:58:23 2025-09-05 00:58:24        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
04-Sep-2025 20:58:23 2025-09-05 00:58:24        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Sep-2025 20:58:23 2025-09-05 00:58:24        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
04-Sep-2025 20:58:24 2025-09-05 00:58:24        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
04-Sep-2025 20:58:24 2025-09-05 00:58:24        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
04-Sep-2025 20:58:24 2025-09-05 00:58:25        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Sep-2025 20:58:24 2025-09-05 00:58:25        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 0, 0]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, I)
04-Sep-2025 20:58:24 2025-09-05 00:58:25        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
04-Sep-2025 20:58:24 2025-09-05 00:58:25        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
04-Sep-2025 20:58:24 2025-09-05 00:58:25        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
04-Sep-2025 20:58:24 2025-09-05 00:58:25        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Sep-2025 20:58:24 2025-09-05 00:58:25        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
04-Sep-2025 20:58:24 2025-09-05 00:58:25        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Sep-2025 20:58:24 2025-09-05 00:58:25        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
04-Sep-2025 20:58:25 2025-09-05 00:58:25        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
04-Sep-2025 20:58:25 2025-09-05 00:58:25        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
04-Sep-2025 20:58:25 2025-09-05 00:58:26        INFO        name::        No table opened.
04-Sep-2025 20:58:25 2025-09-05 00:58:26        INFO        showcache::        The Table Cache is empty.
04-Sep-2025 20:58:25 test_tool_image_pbcor.py::ia_pbcor_test::test_4d_image_with_2d_pb
04-Sep-2025 20:58:25 ia.pbcor: Test full image divide with cutoff. Primary beam is 2 D, image is 4 D
04-Sep-2025 20:58:25 PASSED
04-Sep-2025 20:58:25
04-Sep-2025 20:58:26 2025-09-05 00:58:26        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [5, 5, 1, 1]
04-Sep-2025 20:58:26 2025-09-05 00:58:27        INFO        name::        No table opened.
04-Sep-2025 20:58:26 2025-09-05 00:58:27        INFO        showcache::        The Table Cache is empty.
04-Sep-2025 20:58:26 test_tool_image_pbcor.py::ia_pbcor_test::test_diff_spectral_coordinate
04-Sep-2025 20:58:26 Verify fix that a different spectral coordinates in target and template don't matter, CAS-5096
04-Sep-2025 20:58:26 PASSED
04-Sep-2025 20:58:26
04-Sep-2025 20:58:26 2025-09-05 00:58:27        INFO        ImageFactory::createImage        Created Paged image 't_in.im' of shape [20, 20, 4, 20] with float valued pixels.
04-Sep-2025 20:58:27 2025-09-05 00:58:27        INFO        ImageFactory::createImage        Created Paged image 't_pb_in.im' of shape [20, 20, 4, 20] with float valued pixels.
04-Sep-2025 20:58:27 2025-09-05 00:58:27        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
04-Sep-2025 20:58:27 2025-09-05 00:58:27        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
04-Sep-2025 20:58:27 2025-09-05 00:58:27        INFO        CasacRegionManager::fromBCS        Using polarizations I
04-Sep-2025 20:58:27 2025-09-05 00:58:27        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Sep-2025 20:58:27 2025-09-05 00:58:27        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [19, 19, 0, 19]  (00:00:40.000, -00.10.00.001, I, 1.41499e+09Hz to 23:59:24.000, +00.09.00.001, I, 1.41501e+09Hz)
04-Sep-2025 20:58:27 2025-09-05 00:58:27        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Sep-2025 20:58:27 2025-09-05 00:58:27        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [19, 19, 0, 19]  (00:00:40.000, -00.10.00.001, I, 1.41499e+09Hz to 23:59:24.000, +00.09.00.001, I, 1.41501e+09Hz)
04-Sep-2025 20:58:27 2025-09-05 00:58:27        INFO        SubImageFactory::createImage        Creating image 't_out.im' of shape [20, 20, 1, 20]
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        name::        No table opened.
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        showcache::        The Table Cache is empty.
04-Sep-2025 20:58:27 test_tool_image_pbcor.py::ia_pbcor_test::test_empty_region_and_stokes
04-Sep-2025 20:58:27 Test specifying stokes with empty region works (CAS-11708)
04-Sep-2025 20:58:27 PASSED
04-Sep-2025 20:58:27
04-Sep-2025 20:58:27 2025-09-05 00:58:28        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Exception Reported: Exception: File name is empty.
04-Sep-2025 20:58:27 2025-09-05 00:58:28        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)+        ... thrown by static void casa::ImageFactory::_checkInfile(const casacore::String&) at File: /source/casa6/casatools/src/code/imageanalysis/ImageAnalysis/ImageFactory2.cc, line: 371
04-Sep-2025 20:58:27 2025-09-05 00:58:28        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Exception Reported: Exception: File totally_bogus does not exist..
04-Sep-2025 20:58:27 2025-09-05 00:58:28        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)+        ... thrown by static void casa::ImageFactory::_checkInfile(const casacore::String&) at File: /source/casa6/casatools/src/code/imageanalysis/ImageAnalysis/ImageFactory2.cc, line: 375
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:27 2025-09-05 00:58:28        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Exception: The image filename is empty.
04-Sep-2025 20:58:27 2025-09-05 00:58:28        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)+        ... thrown by static void casacore::ImageUtilities::openImage(casacore::ImageInterface<T>*&, const casacore::String&) [with T = float] at File: /source/casainstall/include/casacore/images/Images/ImageUtilities2.tcc, line: 255
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:27 2025-09-05 00:58:28        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Exception: File 'totally_bogus2' does not exist.
04-Sep-2025 20:58:27 2025-09-05 00:58:28        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)+        ... thrown by static void casacore::ImageUtilities::openImage(casacore::ImageInterface<T>*&, const casacore::String&) [with T = float] at File: /source/casainstall/include/casacore/images/Images/ImageUtilities2.tcc, line: 260
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:27 2025-09-05 00:58:28        SEVERE        ImageInputProcessor::_process        Requested output image /bogusplace/bogusimage cannot be created so will not be written
04-Sep-2025 20:58:27 2025-09-05 00:58:28        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: 2025-09-05 00:58:28        SEVERE        ImageInputProcessor::_process        Requested output image /bogusplace/bogusimage cannot be created so will not be written
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:27 2025-09-05 00:58:28        WARN                /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/pbtest1_im.fits is not a valid or readable table
04-Sep-2025 20:58:27 2025-09-05 00:58:28        SEVERE                Cannot read image /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/pbtest1_im.fits to get region bogus_region
04-Sep-2025 20:58:27 2025-09-05 00:58:28        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Unable to open region file or region table description bogus_region in image /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/pbtest1_im.fits at File: /source/casa6/casatools/src/code/imageanalysis/Regions/CasacRegionManager.cc, line: 486
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:27 2025-09-05 00:58:28        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Unknown mode zz
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:27 2025-09-05 00:58:28        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Coordinate systems of image and template are different: The DirectionCoordinates have differing LinearXform components at File: /source/casa6/casatools/src/code/imageanalysis/ImageAnalysis/ImagePrimaryBeamCorrector.cc, line: 141
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        name::        No table opened.
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        showcache::        The Table Cache is empty.
04-Sep-2025 20:58:27 test_tool_image_pbcor.py::ia_pbcor_test::test_exceptions
04-Sep-2025 20:58:27 ia.pbcor: Test various exception cases
04-Sep-2025 20:58:27 PASSED
04-Sep-2025 20:58:27
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
04-Sep-2025 20:58:27 2025-09-05 00:58:28        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
04-Sep-2025 20:58:28 2025-09-05 00:58:28        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:28 2025-09-05 00:58:28        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:28 2025-09-05 00:58:28        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
04-Sep-2025 20:58:28 2025-09-05 00:58:28        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Sep-2025 20:58:28 2025-09-05 00:58:28        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
04-Sep-2025 20:58:28 2025-09-05 00:58:28        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Sep-2025 20:58:28 2025-09-05 00:58:28        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
04-Sep-2025 20:58:28 2025-09-05 00:58:28        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
04-Sep-2025 20:58:28 2025-09-05 00:58:28        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:28 2025-09-05 00:58:28        INFO        name::        No table opened.
04-Sep-2025 20:58:28 2025-09-05 00:58:28        INFO        showcache::        The Table Cache is empty.
04-Sep-2025 20:58:28 test_tool_image_pbcor.py::ia_pbcor_test::test_full_image_divide
04-Sep-2025 20:58:28 ia.pbcor: Test full image divide
04-Sep-2025 20:58:28 PASSED
04-Sep-2025 20:58:28
04-Sep-2025 20:58:28 2025-09-05 00:58:28        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:28 2025-09-05 00:58:28        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:28 2025-09-05 00:58:28        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:28 2025-09-05 00:58:28        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
04-Sep-2025 20:58:28 2025-09-05 00:58:28        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Sep-2025 20:58:28 2025-09-05 00:58:28        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
04-Sep-2025 20:58:28 2025-09-05 00:58:28        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Sep-2025 20:58:28 2025-09-05 00:58:28        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
04-Sep-2025 20:58:28 2025-09-05 00:58:29        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
04-Sep-2025 20:58:28 2025-09-05 00:58:29        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
04-Sep-2025 20:58:29 2025-09-05 00:58:29        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:29 2025-09-05 00:58:29        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
04-Sep-2025 20:58:29 2025-09-05 00:58:29        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Sep-2025 20:58:29 2025-09-05 00:58:29        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
04-Sep-2025 20:58:29 2025-09-05 00:58:29        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Sep-2025 20:58:29 2025-09-05 00:58:29        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
04-Sep-2025 20:58:29 2025-09-05 00:58:29        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
04-Sep-2025 20:58:29 2025-09-05 00:58:29        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
04-Sep-2025 20:58:29 2025-09-05 00:58:30        INFO        name::        No table opened.
04-Sep-2025 20:58:29 2025-09-05 00:58:30        INFO        showcache::        The Table Cache is empty.
04-Sep-2025 20:58:29 test_tool_image_pbcor.py::ia_pbcor_test::test_full_image_using_cutoff
04-Sep-2025 20:58:29 ia.pbcor: Test full image divide with cutoff
04-Sep-2025 20:58:29 PASSED
04-Sep-2025 20:58:29
04-Sep-2025 20:58:30 2025-09-05 00:58:30        INFO        ImageFactory::createImage        Created Paged image 'zz.im' of shape [20, 20] with float valued pixels.
04-Sep-2025 20:58:30 2025-09-05 00:58:31        INFO        SubImageFactory::createImage        Creating image 'pb_out.im' of shape [20, 20]
04-Sep-2025 20:58:31 2025-09-05 00:58:30        INFO        ::::ImageFactory::createImage        Created Paged image 'zz.im' of shape [20, 20] with float valued pixels.
04-Sep-2025 20:58:31 2025-09-05 00:58:30        INFO        ::::image::fromshape        Ran ia.fromshape
04-Sep-2025 20:58:31 2025-09-05 00:58:30        INFO        ::::image::fromshape        ia.fromshape(outfile="zz.im", shape=[20,20], csys={...}, linear=false, overwrite=false, log=true, type="f")
04-Sep-2025 20:58:31 2025-09-05 00:58:31        INFO        ::::image::pbcor        Ran ia.pbcor
04-Sep-2025 20:58:31 2025-09-05 00:58:31        INFO        ::::image::pbcor        ia.pbcor(pbimage="(...)", outfile="pb_out.im", overwrite=false, box="", region={...}, chans="", stokes="", mask="", mode="divide", cutoff=-1.000000, stretch=false)
04-Sep-2025 20:58:31 2025-09-05 00:58:31        INFO        name::        No table opened.
04-Sep-2025 20:58:31 2025-09-05 00:58:31        INFO        showcache::        The Table Cache is empty.
04-Sep-2025 20:58:31 test_tool_image_pbcor.py::ia_pbcor_test::test_history
04-Sep-2025 20:58:31 Test history records are written
04-Sep-2025 20:58:31 PASSED
04-Sep-2025 20:58:31
04-Sep-2025 20:58:31 2025-09-05 00:58:31        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:31 2025-09-05 00:58:31        INFO        ImageFactory::createImage        Created Paged image 'mult_pb.im' of shape [113, 76] with float valued pixels.
04-Sep-2025 20:58:31 2025-09-05 00:58:32        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
04-Sep-2025 20:58:31 2025-09-05 00:58:32        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
04-Sep-2025 20:58:31 2025-09-05 00:58:32        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
04-Sep-2025 20:58:31 2025-09-05 00:58:32        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Sep-2025 20:58:31 2025-09-05 00:58:32        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
04-Sep-2025 20:58:31 2025-09-05 00:58:32        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Sep-2025 20:58:31 2025-09-05 00:58:32        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
04-Sep-2025 20:58:31 2025-09-05 00:58:32        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
04-Sep-2025 20:58:31 2025-09-05 00:58:32        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
04-Sep-2025 20:58:31 2025-09-05 00:58:32        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Sep-2025 20:58:31 2025-09-05 00:58:32        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 0, 0]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, I)
04-Sep-2025 20:58:31 2025-09-05 00:58:32        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
04-Sep-2025 20:58:31 2025-09-05 00:58:32        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
04-Sep-2025 20:58:31 2025-09-05 00:58:32        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
04-Sep-2025 20:58:31 2025-09-05 00:58:32        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Sep-2025 20:58:31 2025-09-05 00:58:32        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
04-Sep-2025 20:58:31 2025-09-05 00:58:32        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Sep-2025 20:58:31 2025-09-05 00:58:32        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
04-Sep-2025 20:58:32 2025-09-05 00:58:32        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
04-Sep-2025 20:58:32 2025-09-05 00:58:32        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
04-Sep-2025 20:58:32 2025-09-05 00:58:32        INFO        name::        No table opened.
04-Sep-2025 20:58:32 2025-09-05 00:58:32        INFO        showcache::        The Table Cache is empty.
04-Sep-2025 20:58:32 test_tool_image_pbcor.py::ia_pbcor_test::test_multiply
04-Sep-2025 20:58:32 ia.pbcor: Test full image multiply with cutoff. Primary beam is 2 D, image is 4 D
04-Sep-2025 20:58:32 PASSED
04-Sep-2025 20:58:32
04-Sep-2025 20:58:32 2025-09-05 00:58:32        INFO        ImageFactory::createImage        Created Temp image  of shape [113, 76, 1, 1] with float valued pixels.
04-Sep-2025 20:58:32 2025-09-05 00:58:33        INFO        SubImageFactory::createImage        Creating image 'maskim' of shape [113, 76, 1, 1]
04-Sep-2025 20:58:32 2025-09-05 00:58:33        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:32 2025-09-05 00:58:33        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: The input image shape ([113, 76, 5, 2]) and mask shape ([113, 76, 1, 1]) are different, and it was specified that the mask should not be extended, so the mask cannot be applied to the (sub)image. Specifying that the mask should be extended may resolve the issue at File: /source/casainstall/include/casacpp/imageanalysis/ImageAnalysis/SubImageFactory.tcc, line: 306
04-Sep-2025 20:58:32 2025-09-05 00:58:33        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
04-Sep-2025 20:58:32 2025-09-05 00:58:33        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Sep-2025 20:58:32 2025-09-05 00:58:33        INFO        SubImageFactory::createImage        Creating image 'blahblah' of shape [113, 76, 5, 2]
04-Sep-2025 20:58:32 2025-09-05 00:58:33        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
04-Sep-2025 20:58:33 2025-09-05 00:58:33        INFO        name::        No table opened.
04-Sep-2025 20:58:33 2025-09-05 00:58:33        INFO        showcache::        The Table Cache is empty.
04-Sep-2025 20:58:33 test_tool_image_pbcor.py::ia_pbcor_test::test_stretch
04-Sep-2025 20:58:33 ia.pbcor(): Test stretch parameter
04-Sep-2025 20:58:33 PASSED
04-Sep-2025 20:58:33
04-Sep-2025 20:58:33 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_pbcor/nose.xml -
04-Sep-2025 20:58:33 ======================== 9 passed, 4 warnings in 10.28s ========================
04-Sep-2025 20:58:33
04-Sep-2025 20:58:33
04-Sep-2025 20:58:33 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/
04-Sep-2025 20:58:33 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor
04-Sep-2025 20:58:33
04-Sep-2025 20:58:33 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_pbcor/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/
04-Sep-2025 20:58:34 total 83104
04-Sep-2025 20:58:34 -rwx------ 1 casaci 15001  6146776 Sep  5 00:31 atlutil
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci 15001   135232 Sep  5 00:30 casatestutils-6.7.2.35+dirty-py3-none-any.whl
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci 15001 78640040 Sep  5 00:30 casatools-6.7.2.35+dirty-cp312-cp312-manylinux_2_28_x86_64.whl
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      4340 Sep  5 00:58 test_tool_agentflagger.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      1006 Sep  5 00:58 test_tool_calanalysis.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      2659 Sep  5 00:58 test_tool_calibrater.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root       687 Sep  5 00:58 test_tool_componentlist.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      7467 Sep  5 00:58 test_tool_coordsys.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root     12937 Sep  5 00:58 test_tool_image.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      2221 Sep  5 00:58 test_tool_image_collapse.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      1048 Sep  5 00:58 test_tool_image_deviation.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      2577 Sep  5 00:58 test_tool_image_fitprofile.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      1179 Sep  5 00:58 test_tool_image_pbcor.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root       883 Sep  5 00:58 test_tool_image_pv.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      1006 Sep  5 00:58 test_tool_image_rebin.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      1336 Sep  5 00:58 test_tool_image_regrid.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      1533 Sep  5 00:58 test_tool_image_statistics.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root       765 Sep  5 00:58 test_tool_image_subimage.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root       890 Sep  5 00:58 test_tool_image_transpose.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      1966 Sep  5 00:58 test_tool_imagepol.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root       839 Sep  5 00:58 test_tool_linearmosaic.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root       668 Sep  5 00:58 test_tool_logsink.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root       549 Sep  5 00:58 test_tool_measures.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      5224 Sep  5 00:58 test_tool_ms.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root       367 Sep  5 00:58 test_tool_ms_createmultims.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      2095 Sep  5 00:58 test_tool_ms_statwt.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      8634 Sep  5 00:58 test_tool_msmetadata.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root       359 Sep  5 00:58 test_tool_msuvbinner.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      1171 Sep  5 00:58 test_tool_quanta.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      3977 Sep  5 00:58 test_tool_regionmanager.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      2073 Sep  5 00:58 test_tool_sdm.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      2102 Sep  5 00:58 test_tool_sdm_toms.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root       670 Sep  5 00:58 test_tool_simulator.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      1717 Sep  5 00:58 test_tool_synthesisutils.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      1462 Sep  5 00:58 test_tool_table.xml
04-Sep-2025 20:58:34 -rw-r--r-- 1 casaci root      1717 Sep  5 00:58 test_tool_vpmanager.xml
04-Sep-2025 20:58:34 Finished task 'Test Wheel' with result: Success
04-Sep-2025 20:58:34 Starting task 'Tar work directory' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
04-Sep-2025 20:58:34
Beginning to execute external process for build 'CASASPECS - Pull Request - CAS-13324 - Test Tools Many Linux 2.28 Python3.12 #1 (CASASPECS-PR121-TTML228-1)'
... running command line:
/export/home/cbt-el7-9/bamboohome/temp/CASASPECS-PR121-TTML228-1-ScriptBuildTask-9764181810931834144.sh
... in: /export/home/cbt-el7-9/bamboohome/xml-data/build-dir/CASASPECS-PR121-TTML228
04-Sep-2025 20:58:34 Package working directory
04-Sep-2025 20:58:35 tar: work: Cannot stat: No such file or directory
04-Sep-2025 20:58:35 tar: Exiting with failure status due to previous errors
04-Sep-2025 20:58:35 total 83108
04-Sep-2025 20:58:35 -rwx------ 1 casaci 15001  6146776 Sep  5 00:31 atlutil
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci 15001   135232 Sep  5 00:30 casatestutils-6.7.2.35+dirty-py3-none-any.whl
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci 15001 78640040 Sep  5 00:30 casatools-6.7.2.35+dirty-cp312-cp312-manylinux_2_28_x86_64.whl
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      4340 Sep  5 00:58 test_tool_agentflagger.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      1006 Sep  5 00:58 test_tool_calanalysis.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      2659 Sep  5 00:58 test_tool_calibrater.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root       687 Sep  5 00:58 test_tool_componentlist.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      7467 Sep  5 00:58 test_tool_coordsys.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root     12937 Sep  5 00:58 test_tool_image.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      2221 Sep  5 00:58 test_tool_image_collapse.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      1048 Sep  5 00:58 test_tool_image_deviation.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      2577 Sep  5 00:58 test_tool_image_fitprofile.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      1179 Sep  5 00:58 test_tool_image_pbcor.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root       883 Sep  5 00:58 test_tool_image_pv.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      1006 Sep  5 00:58 test_tool_image_rebin.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      1336 Sep  5 00:58 test_tool_image_regrid.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      1533 Sep  5 00:58 test_tool_image_statistics.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root       765 Sep  5 00:58 test_tool_image_subimage.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root       890 Sep  5 00:58 test_tool_image_transpose.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      1966 Sep  5 00:58 test_tool_imagepol.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root       839 Sep  5 00:58 test_tool_linearmosaic.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root       668 Sep  5 00:58 test_tool_logsink.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root       549 Sep  5 00:58 test_tool_measures.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      5224 Sep  5 00:58 test_tool_ms.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root       367 Sep  5 00:58 test_tool_ms_createmultims.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      2095 Sep  5 00:58 test_tool_ms_statwt.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      8634 Sep  5 00:58 test_tool_msmetadata.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root       359 Sep  5 00:58 test_tool_msuvbinner.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      1171 Sep  5 00:58 test_tool_quanta.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      3977 Sep  5 00:58 test_tool_regionmanager.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      2073 Sep  5 00:58 test_tool_sdm.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      2102 Sep  5 00:58 test_tool_sdm_toms.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root       670 Sep  5 00:58 test_tool_simulator.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      1717 Sep  5 00:58 test_tool_synthesisutils.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      1462 Sep  5 00:58 test_tool_table.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root      1717 Sep  5 00:58 test_tool_vpmanager.xml
04-Sep-2025 20:58:35 -rw-r--r-- 1 casaci root        45 Sep  5 00:58 work-rocky-manylinux-228.tar.gz
04-Sep-2025 20:58:35 Done packaging working directory
04-Sep-2025 20:58:35 Finished task 'Tar work directory' with result: Success
04-Sep-2025 20:58:35 Starting task 'Parse tests' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
04-Sep-2025 20:58:35 Parsing test results under /export/home/cbt-el7-9/bamboohome/xml-data/build-dir/CASASPECS-PR121-TTML228...
04-Sep-2025 20:58:35 Finished task 'Parse tests' with result: Success
04-Sep-2025 20:58:35 Running post build plugin 'Docker Container Cleanup'
04-Sep-2025 20:58:35
Beginning to execute external process for build 'CASASPECS - Pull Request - CAS-13324 - Test Tools Many Linux 2.28 Python3.12 #1 (CASASPECS-PR121-TTML228-1)'
... running command line:
/bin/docker rm -f wheel-container-test
... in: /export/home/cbt-el7-9/bamboohome/xml-data/build-dir/CASASPECS-PR121-TTML228
04-Sep-2025 20:58:41 wheel-container-test
04-Sep-2025 20:58:41 Running post build plugin 'NCover Results Collector'
04-Sep-2025 20:58:41 Running post build plugin 'Build Results Label Collector'
04-Sep-2025 20:58:41 Running post build plugin 'Clover Results Collector'
04-Sep-2025 20:58:41 Running post build plugin 'npm Cache Cleanup'
04-Sep-2025 20:58:41 Running post build plugin 'Artifact Copier'
04-Sep-2025 20:58:41 Finalising the build...
04-Sep-2025 20:58:41 Stopping timer.
04-Sep-2025 20:58:41 Build CASASPECS-PR121-TTML228-1 completed.
04-Sep-2025 20:58:42 Running on server: post build plugin 'Build Hanging Detection Configuration'
04-Sep-2025 20:58:42 Running on server: post build plugin 'NCover Results Collector'
04-Sep-2025 20:58:42 Running on server: post build plugin 'Build Labeller'
04-Sep-2025 20:58:42 Running on server: post build plugin 'Clover Delta Calculator'
04-Sep-2025 20:58:42 Running on server: post build plugin 'Maven Dependencies Postprocessor'
04-Sep-2025 20:58:42 All post build plugins have finished
04-Sep-2025 20:58:42 Generating build results summary...
04-Sep-2025 20:58:42 Saving build results to disk...
04-Sep-2025 20:58:42 Store variable context...
04-Sep-2025 20:58:42 Finished building CASASPECS-PR121-TTML228-1.