Build: #32 was successful

Job: Test Tools Many Linux 2.28 was successful

Stages & jobs

  1. Tag

  2. Default Stage

  3. Test

Build log

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

25-Oct-2024 15:46:13 2024-10-25 19:46:14        INFO                Specified parameter(s) (per spw and antenna) repeated on all polarizations.
25-Oct-2024 15:46:13 2024-10-25 19:46:14        INFO                spwId=1 antId=<all> polId=<all> parameter= 3   (ip0,ip1 = [0, 0, 0],[1, 0, 9])
25-Oct-2024 15:46:13 2024-10-25 19:46:14        INFO                Writing solutions to table: testcalout.cal
25-Oct-2024 15:46:13 2024-10-25 19:46:14        WARN        calibrater::setvi(bool,bool)        Already using NEW VisibilityIterator.
25-Oct-2024 15:46:13 test_tool_calibrater.py::calibrater_test::test_specifyCal
25-Oct-2024 15:46:13 Check that specifycal can set values for specific spws and antennas
25-Oct-2024 15:46:13 PASSED
25-Oct-2024 15:46:13
25-Oct-2024 15:46:13 2024-10-25 19:46:14        WARN        calibrater::setvi(bool,bool)        Forcing use of OLD VisibilityIterator.
25-Oct-2024 15:46:13 2024-10-25 19:46:14        INFO        calibrater::open        ****Using OLD VI-driven calibrater tool****
25-Oct-2024 15:46:13 2024-10-25 19:46:14        INFO        calibrater::open        Opening MS: gaincaltest2.ms for calibration.
25-Oct-2024 15:46:13 2024-10-25 19:46:14        INFO                Clearing all model records in MS header.
25-Oct-2024 15:46:14 2024-10-25 19:46:14        INFO        VisSetUtil::addScrCols        Adding MODEL_DATA and CORRECTED_DATA column(s).
25-Oct-2024 15:46:15 2024-10-25 19:46:15        INFO        VisSetUtil::initScrCols        Initializing MODEL_DATA to (unity).
25-Oct-2024 15:46:15 2024-10-25 19:46:15        INFO        VisSetUtil::initScrCols        Initialized 328860 rows.
25-Oct-2024 15:46:15 2024-10-25 19:46:15        INFO        Calibrater::        Initializing nominal selection to the whole MS.
25-Oct-2024 15:46:15 2024-10-25 19:46:16        INFO        calibrater::setapply        Beginning setapply--(MSSelection version)-------
25-Oct-2024 15:46:15 2024-10-25 19:46:16        INFO        Calibrater::setapply(type, applypar)        Arranging to APPLY:
25-Oct-2024 15:46:15 2024-10-25 19:46:16        INFO        Calibrater::setapply(type, applypar)        .   G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false
25-Oct-2024 15:46:15 2024-10-25 19:46:16        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
25-Oct-2024 15:46:15 2024-10-25 19:46:16        INFO        Calibrater::setsolve        Arranging to SOLVE:
25-Oct-2024 15:46:15 2024-10-25 19:46:16        INFO        Calibrater::setsolve        .   Mf Mueller: table=output.ms append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
25-Oct-2024 15:46:15 2024-10-25 19:46:16        INFO        Calibrater::state        The following calibration terms are arranged for apply:
25-Oct-2024 15:46:15 2024-10-25 19:46:16        INFO        Calibrater::state        .   G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false
25-Oct-2024 15:46:15 2024-10-25 19:46:16        INFO        Calibrater::state        The following calibration term is arranged for solve:
25-Oct-2024 15:46:15 2024-10-25 19:46:16        INFO        Calibrater::state        .   Mf Mueller: table=output.ms append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
25-Oct-2024 15:46:15 2024-10-25 19:46:16        INFO        calibrater::solve        Beginning solve-----------------------------
25-Oct-2024 15:46:15 2024-10-25 19:46:16        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
25-Oct-2024 15:46:15 2024-10-25 19:46:16        INFO        Calibrater::solve        .   G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false
25-Oct-2024 15:46:15 2024-10-25 19:46:16        INFO        Calibrater::solve        The following calibration term is arranged for solve:
25-Oct-2024 15:46:15 2024-10-25 19:46:16        INFO        Calibrater::solve        .   Mf Mueller: table=output.ms append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
25-Oct-2024 15:46:15 2024-10-25 19:46:16        INFO                Solving for Mf Mueller
25-Oct-2024 15:46:15 2024-10-25 19:46:16        INFO                For solint = inf, found 84 solution intervals.
25-Oct-2024 15:46:17 2024-10-25 19:46:17        INFO                  Found good Mf Mueller solutions in 84 intervals.
25-Oct-2024 15:46:17 2024-10-25 19:46:17        INFO                Writing solutions to table: output.ms
25-Oct-2024 15:46:17 2024-10-25 19:46:17        INFO        calibrater::solve        Finished solving.
25-Oct-2024 15:46:17 2024-10-25 19:46:17        WARN        calibrater::setvi(bool,bool)        Forcing use of NEW VisibilityIterator.
25-Oct-2024 15:46:17 test_tool_calibrater.py::calibrater_test::test_standardPath
25-Oct-2024 15:46:17 open setapply setsolve state solve close 
25-Oct-2024 15:46:17 PASSED
25-Oct-2024 15:46:17
25-Oct-2024 15:46:17 2024-10-25 19:46:18        INFO        calibrater::open        ****Using NEW VI2-driven calibrater tool****
25-Oct-2024 15:46:17 2024-10-25 19:46:18        INFO        calibrater::open        Opening MS: gaincaltest2.ms for calibration.
25-Oct-2024 15:46:17 2024-10-25 19:46:18        INFO                Clearing all model records in MS header.
25-Oct-2024 15:46:17 2024-10-25 19:46:18        INFO        VisSetUtil::addScrCols        Adding MODEL_DATA and CORRECTED_DATA column(s).
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        VisSetUtil::initScrCols        Initializing MODEL_DATA to (unity).
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        VisSetUtil::initScrCols        Initialized 328860 rows.
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        Calibrater::        Initializing nominal selection to the whole MS.
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        name::        No table opened.
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        showcache::        The Table Cache has the following 16 entries:
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        showcache::            0: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms"
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        showcache::            1: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/ANTENNA"
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        showcache::            2: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/DATA_DESCRIPTION"
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        showcache::            3: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FEED"
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        showcache::            4: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FIELD"
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        showcache::            5: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FLAG_CMD"
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        showcache::            6: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/HISTORY"
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        showcache::            7: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/OBSERVATION"
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        showcache::            8: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/POINTING"
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        showcache::            9: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/POLARIZATION"
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        showcache::            10: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/PROCESSOR"
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        showcache::            11: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SOURCE"
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        showcache::            12: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SPECTRAL_WINDOW"
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        showcache::            13: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/STATE"
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        showcache::            14: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SYSCAL"
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        showcache::            15: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/WEATHER"
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        name::        No table opened.
25-Oct-2024 15:46:19 2024-10-25 19:46:19        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:19 2024-10-25 19:46:19        WARN        calibrater::setvi(bool,bool)        Already using NEW VisibilityIterator.
25-Oct-2024 15:46:19 test_tool_calibrater.py::calibrater_test::test_takesMs
25-Oct-2024 15:46:19 Check that the calibrater tool can open and close an MS 
25-Oct-2024 15:46:19 PASSED
25-Oct-2024 15:46:19
25-Oct-2024 15:46:19 2024-10-25 19:46:20        INFO        calibrater::open        ****Using NEW VI2-driven calibrater tool****
25-Oct-2024 15:46:19 2024-10-25 19:46:20        INFO        calibrater::open        Opening MS: gaincaltest2.ms for calibration.
25-Oct-2024 15:46:19 2024-10-25 19:46:20        INFO                Clearing all model records in MS header.
25-Oct-2024 15:46:19 2024-10-25 19:46:20        INFO        VisSetUtil::addScrCols        Adding MODEL_DATA and CORRECTED_DATA column(s).
25-Oct-2024 15:46:20 2024-10-25 19:46:21        INFO        VisSetUtil::initScrCols        Initializing MODEL_DATA to (unity).
25-Oct-2024 15:46:21 2024-10-25 19:46:21        INFO        VisSetUtil::initScrCols        Initialized 328860 rows.
25-Oct-2024 15:46:21 2024-10-25 19:46:21        INFO        Calibrater::        Initializing nominal selection to the whole MS.
25-Oct-2024 15:46:21 2024-10-25 19:46:21        INFO        calibrater::setapply        Beginning setapply--(MSSelection version)-------
25-Oct-2024 15:46:21 2024-10-25 19:46:21        INFO        Calibrater::setapply(type, applypar)        Arranging to APPLY:
25-Oct-2024 15:46:21 2024-10-25 19:46:21        INFO        Calibrater::setapply(type, applypar)        .   G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false
25-Oct-2024 15:46:21 2024-10-25 19:46:21        INFO        calibrater::correct        Beginning correct---------------------------
25-Oct-2024 15:46:21 2024-10-25 19:46:21        INFO        Calibrater::correct2 (VI2/VB2)        The following calibration terms are arranged for apply:
25-Oct-2024 15:46:21 2024-10-25 19:46:21        INFO        Calibrater::correct2 (VI2/VB2)        .   G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false
25-Oct-2024 15:46:23 2024-10-25 19:46:24        INFO        calibrater::correct        Finished correcting.
25-Oct-2024 15:46:24 2024-10-25 19:46:24        WARN        calibrater::setvi(bool,bool)        Already using NEW VisibilityIterator.
25-Oct-2024 15:46:24 test_tool_calibrater.py::calibrater_test::test_writeToCorrected
25-Oct-2024 15:46:24 Check that the tool writes to the CORRECTED_DATA column 
25-Oct-2024 15:46:24 PASSED
25-Oct-2024 15:46:24
25-Oct-2024 15:46:24 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_calibrater/nose.xml -
25-Oct-2024 15:46:24 =================== 24 passed, 1 warning in 98.30s (0:01:38) ===================
25-Oct-2024 15:46:24 ============================= test session starts ==============================
25-Oct-2024 15:46:24 platform linux -- Python 3.8.7, pytest-8.3.3, pluggy-1.5.0 -- /home/casatest/venv/bin/python3.8
25-Oct-2024 15:46:24 cachedir: .pytest_cache
25-Oct-2024 15:46:24 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor
25-Oct-2024 15:46:24 configfile: pytest.ini
25-Oct-2024 15:46:24 collecting ... collected 9 items
25-Oct-2024 15:46:24
25-Oct-2024 15:46:24
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:25 2024-10-25 19:46: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)
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:25 2024-10-25 19:46: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)
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:25 2024-10-25 19:46: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)
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:25 2024-10-25 19:46: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)
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:25 2024-10-25 19:46: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)
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        name::        No table opened.
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:25 test_tool_image_pbcor.py::ia_pbcor_test::test_4d_image_with_2d_pb
25-Oct-2024 15:46:25 ia.pbcor: Test full image divide with cutoff. Primary beam is 2 D, image is 4 D
25-Oct-2024 15:46:25 PASSED
25-Oct-2024 15:46:25
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [5, 5, 1, 1]
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        name::        No table opened.
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:25 test_tool_image_pbcor.py::ia_pbcor_test::test_diff_spectral_coordinate
25-Oct-2024 15:46:25 Verify fix that a different spectral coordinates in target and template don't matter, CAS-5096
25-Oct-2024 15:46:25 PASSED
25-Oct-2024 15:46:25
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        ImageFactory::createImage        Created Paged image 't_in.im' of shape [20, 20, 4, 20] with float valued pixels.
25-Oct-2024 15:46:25 2024-10-25 19:46:25        INFO        ImageFactory::createImage        Created Paged image 't_pb_in.im' of shape [20, 20, 4, 20] with float valued pixels.
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        CasacRegionManager::fromBCS        Using polarizations I
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:25 2024-10-25 19:46:26        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)
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:25 2024-10-25 19:46:26        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)
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        SubImageFactory::createImage        Creating image 't_out.im' of shape [20, 20, 1, 20]
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        name::        No table opened.
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:25 test_tool_image_pbcor.py::ia_pbcor_test::test_empty_region_and_stokes
25-Oct-2024 15:46:25 Test specifying stokes with empty region works (CAS-11708)
25-Oct-2024 15:46:25 PASSED
25-Oct-2024 15:46:25
25-Oct-2024 15:46:25 2024-10-25 19:46:26        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Exception Reported: Exception: File name is empty.
25-Oct-2024 15:46:25 2024-10-25 19:46:26        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
25-Oct-2024 15:46:25 2024-10-25 19:46:26        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Exception Reported: Exception: File totally_bogus does not exist..
25-Oct-2024 15:46:25 2024-10-25 19:46:26        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
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:26        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Exception: The image filename is empty.
25-Oct-2024 15:46:25 2024-10-25 19:46:26        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
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:26        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Exception: File 'totally_bogus2' does not exist.
25-Oct-2024 15:46:25 2024-10-25 19:46:26        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
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:26        SEVERE        ImageInputProcessor::_process        Requested output image /bogusplace/bogusimage cannot be created so will not be written
25-Oct-2024 15:46:25 2024-10-25 19:46:26        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: 2024-10-25 19:46:26        SEVERE        ImageInputProcessor::_process        Requested output image /bogusplace/bogusimage cannot be created so will not be written
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:26        WARN                /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/pbtest1_im.fits is not a valid or readable table
25-Oct-2024 15:46:25 2024-10-25 19:46:26        SEVERE                Cannot read image /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/pbtest1_im.fits to get region bogus_region
25-Oct-2024 15:46:25 2024-10-25 19:46:26        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
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:26        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Unknown mode zz
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:26        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
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        name::        No table opened.
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:25 test_tool_image_pbcor.py::ia_pbcor_test::test_exceptions
25-Oct-2024 15:46:25 ia.pbcor: Test various exception cases
25-Oct-2024 15:46:25 PASSED
25-Oct-2024 15:46:25
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:25 2024-10-25 19:46:26        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)
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:25 2024-10-25 19:46:26        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)
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:25 2024-10-25 19:46:26        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)
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:25 2024-10-25 19:46:26        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)
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        name::        No table opened.
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:25 test_tool_image_pbcor.py::ia_pbcor_test::test_full_image_divide
25-Oct-2024 15:46:25 ia.pbcor: Test full image divide
25-Oct-2024 15:46:25 PASSED
25-Oct-2024 15:46:25
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:25 2024-10-25 19:46:26        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)
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:25 2024-10-25 19:46:26        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)
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:25 2024-10-25 19:46:26        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)
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:25 2024-10-25 19:46:26        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)
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        name::        No table opened.
25-Oct-2024 15:46:25 2024-10-25 19:46:26        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:25 test_tool_image_pbcor.py::ia_pbcor_test::test_full_image_using_cutoff
25-Oct-2024 15:46:25 ia.pbcor: Test full image divide with cutoff
25-Oct-2024 15:46:25 PASSED
25-Oct-2024 15:46:25
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        ImageFactory::createImage        Created Paged image 'zz.im' of shape [20, 20] with float valued pixels.
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        SubImageFactory::createImage        Creating image 'pb_out.im' of shape [20, 20]
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        ::::ImageFactory::createImage        Created Paged image 'zz.im' of shape [20, 20] with float valued pixels.
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        ::::image::fromshape        Ran ia.fromshape
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        ::::image::fromshape        ia.fromshape(outfile="zz.im", shape=[20,20], csys={...}, linear=false, overwrite=false, log=true, type="f")
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        ::::image::pbcor        Ran ia.pbcor
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        ::::image::pbcor        ia.pbcor(pbimage="(...)", outfile="pb_out.im", overwrite=false, box="", region={...}, chans="", stokes="", mask="", mode="divide", cutoff=-1.000000, stretch=false)
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        name::        No table opened.
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:26 test_tool_image_pbcor.py::ia_pbcor_test::test_history
25-Oct-2024 15:46:26 Test history records are written
25-Oct-2024 15:46:26 PASSED
25-Oct-2024 15:46:26
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        ImageFactory::createImage        Created Paged image 'mult_pb.im' of shape [113, 76] with float valued pixels.
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:26 2024-10-25 19:46:26        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)
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:26 2024-10-25 19:46:26        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)
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:26 2024-10-25 19:46:26        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)
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:26 2024-10-25 19:46:26        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)
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:26 2024-10-25 19:46:26        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)
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        name::        No table opened.
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:26 test_tool_image_pbcor.py::ia_pbcor_test::test_multiply
25-Oct-2024 15:46:26 ia.pbcor: Test full image multiply with cutoff. Primary beam is 2 D, image is 4 D
25-Oct-2024 15:46:26 PASSED
25-Oct-2024 15:46:26
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        ImageFactory::createImage        Created Temp image  of shape [113, 76, 1, 1] with float valued pixels.
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        SubImageFactory::createImage        Creating image 'maskim' of shape [113, 76, 1, 1]
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:26 2024-10-25 19:46:26        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
25-Oct-2024 15:46:26 2024-10-25 19:46:26        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        SubImageFactory::createImage        Creating image 'blahblah' of shape [113, 76, 5, 2]
25-Oct-2024 15:46:26 2024-10-25 19:46:26        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
25-Oct-2024 15:46:26 test_tool_image_pbcor.py::ia_pbcor_test::test_stretch
25-Oct-2024 15:46:26 ia.pbcor(): Test stretch parameter
25-Oct-2024 15:46:26 2024-10-25 19:46:27        INFO        name::        No table opened.
25-Oct-2024 15:46:26 2024-10-25 19:46:27        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:26 PASSED
25-Oct-2024 15:46:26
25-Oct-2024 15:46:26 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_pbcor/nose.xml -
25-Oct-2024 15:46:26 ========================= 9 passed, 1 warning in 2.09s =========================
25-Oct-2024 15:46:26 ============================= test session starts ==============================
25-Oct-2024 15:46:26 platform linux -- Python 3.8.7, pytest-8.3.3, pluggy-1.5.0 -- /home/casatest/venv/bin/python3.8
25-Oct-2024 15:46:26 cachedir: .pytest_cache
25-Oct-2024 15:46:26 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv
25-Oct-2024 15:46:26 configfile: pytest.ini
25-Oct-2024 15:46:27 collecting ... collected 7 items
25-Oct-2024 15:46:27
25-Oct-2024 15:46:27
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        ImageFactory::createImage        Created Temp image  of shape [30, 30, 30] with float valued pixels.
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        PVGenerator::setEndpoints         Setting pixel end points [8.5, 15.5], [22.5, 15.5]
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        ImageRegion::fromRecord+            [9, 15, 0] to [22, 15, 29]  (00:00:24.000, +00.00.00.000, 1.41498e+09Hz to 23:59:32.000, +00.00.00.000, 1.41501e+09Hz)
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        PVGenerator::setEndpoints         Setting pixel end points [22.5, 15.5], [8.5, 15.5]
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        PVGenerator::generate         Rotating image by -180 degrees about direction coordinate pixel (15.5, 15.5) to align specified slice with the x axis
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        ImageRegion::fromRecord+            [0, 0, 0] to [29, 29, 29]  (00:01:00.001, -00.15.00.003, 1.41498e+09Hz to 23:59:03.999, +00.14.00.002, 1.41501e+09Hz)
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        ImageRegion::fromRecord+            [9, 15, 0] to [22, 15, 29]  (23:59:32.000, +00.01.00.000, 1.41498e+09Hz to 00:00:24.000, +00.01.00.000, 1.41501e+09Hz)
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        name::        No table opened.
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:27 test_tool_image_pv.py::ia_pv_test::test_CAS10968
25-Oct-2024 15:46:27 Fix for pa=90,270 when segment y pixel falls on half pixel
25-Oct-2024 15:46:27 PASSED
25-Oct-2024 15:46:27
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        PVGenerator::generate         Rotating image by -45 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:27 2024-10-25 19:46:27        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [299, 299, 0, 2]  (09:48:01.492, +13.15.40.658, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [316, 316, 0, 2]  (09:48:01.957, +13.15.33.858, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [1, 157, 0, 0] to [313, 157, 0, 2]  (09:48:00.678, +13.15.52.535, I, 3.63994e+10Hz to 09:47:54.633, +13.17.20.782, I, 3.63991e+10Hz)
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        PVGenerator::generate         Rotating image by 45 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [299, 299, 0, 2]  (09:48:01.492, +13.15.40.658, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [316, 316, 0, 2]  (09:48:01.957, +13.15.33.858, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [1, 157, 0, 0] to [313, 157, 0, 2]  (09:48:00.678, +13.17.20.782, I, 3.63994e+10Hz to 09:47:54.634, +13.15.52.535, I, 3.63991e+10Hz)
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        PVGenerator::generate         Rotating image by -225 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [299, 299, 0, 2]  (09:48:01.492, +13.15.40.658, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [316, 316, 0, 2]  (09:48:01.957, +13.15.33.858, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [1, 157, 0, 0] to [313, 157, 0, 2]  (09:47:54.633, +13.17.20.782, I, 3.63994e+10Hz to 09:48:00.678, +13.15.52.535, I, 3.63991e+10Hz)
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        PVGenerator::generate         Rotating image by -135 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [299, 299, 0, 2]  (09:48:01.492, +13.15.40.658, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [316, 316, 0, 2]  (09:48:01.957, +13.15.33.858, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [1, 157, 0, 0] to [313, 157, 0, 2]  (09:47:54.634, +13.15.52.535, I, 3.63994e+10Hz to 09:48:00.678, +13.17.20.782, I, 3.63991e+10Hz)
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        PVGenerator::generate         Rotating image by -137.67 degrees about direction coordinate pixel (216.468, 187) to align specified slice with the x axis
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [399, 399, 0, 2]  (18:54:07.171, +01.59.37.999, I, 2.369292e+10Hz to 18:53:53.862, +02.02.57.499, I, 2.369285e+10Hz)
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
25-Oct-2024 15:46:27 2024-10-25 19:46:28        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [151, 187, 0, 0] to [284, 187, 0, 2]  (18:53:58.336, +02.00.49.457, I, 2.369292e+10Hz to 18:54:01.616, +02.01.34.238, I, 2.369285e+10Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        PVGenerator::generate         Rotating image by -42.3301 degrees about direction coordinate pixel (215.598, 187.793) to align specified slice with the x axis
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [399, 399, 0, 2]  (18:54:07.171, +01.59.37.999, I, 2.369292e+10Hz to 18:53:53.862, +02.02.57.499, I, 2.369285e+10Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [149, 188, 0, 0] to [282, 188, 0, 2]  (18:54:01.627, +02.00.49.549, I, 2.369292e+10Hz to 18:53:58.347, +02.01.34.331, I, 2.369285e+10Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        PVGenerator::generate         Rotating image by 42.3301 degrees about direction coordinate pixel (216.468, 187) to align specified slice with the x axis
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [399, 399, 0, 2]  (18:54:07.171, +01.59.37.999, I, 2.369292e+10Hz to 18:53:53.862, +02.02.57.499, I, 2.369285e+10Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [149, 187, 0, 0] to [282, 187, 0, 2]  (18:54:01.614, +02.01.34.216, I, 2.369292e+10Hz to 18:53:58.335, +02.00.49.435, I, 2.369285e+10Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        PVGenerator::generate         Rotating image by -222.33 degrees about direction coordinate pixel (215.598, 187.793) to align specified slice with the x axis
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [399, 399, 0, 2]  (18:54:07.171, +01.59.37.999, I, 2.369292e+10Hz to 18:53:53.862, +02.02.57.499, I, 2.369285e+10Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [149, 188, 0, 0] to [282, 188, 0, 2]  (18:53:58.333, +02.01.34.243, I, 2.369292e+10Hz to 18:54:01.612, +02.00.49.462, I, 2.369285e+10Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        name::        No table opened.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:28 test_tool_image_pv.py::ia_pv_test::test_CAS_2996
25-Oct-2024 15:46:28 ia.pv(): Test issues raised in CAS-2996
25-Oct-2024 15:46:28 PASSED
25-Oct-2024 15:46:28
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        PVGenerator::generate         Rotating image by -45 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [299, 299, 0, 2]  (09:48:01.492, +13.15.40.658, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [316, 316, 0, 2]  (09:48:01.957, +13.15.33.858, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [1, 157, 0, 0] to [313, 157, 0, 2]  (09:48:00.678, +13.15.52.535, I, 3.63994e+10Hz to 09:47:54.633, +13.17.20.782, I, 3.63991e+10Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageFitsConverter::ImageHeaderToFITS         Truncating miscinfo field secondary_coordinates to secondar
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageFitsConverter::ImageHeaderToFITS         Not writing miscInfo field 'secondar' - cannot handle type Record
25-Oct-2024 15:46:28 2024-10-25 19:46:28        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageFitsConverter::ImageHeaderToFITS         Truncating miscinfo field secondary_coordinates to secondar
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageFitsConverter::ImageHeaderToFITS         Not writing miscInfo field 'secondar' - cannot handle type Record
25-Oct-2024 15:46:28 2024-10-25 19:46:28        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        name::        No table opened.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:28 test_tool_image_pv.py::ia_pv_test::test_fits
25-Oct-2024 15:46:28 ia.pv(): Test exporting and importing to/from FITS
25-Oct-2024 15:46:28 PASSED
25-Oct-2024 15:46:28
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageFactory::createImage        Created Paged image 'zz.im' of shape [30, 30, 30] with float valued pixels.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        PVGenerator::setEndpoints         Setting pixel end points [10.0503, 19.9497], [19.9497, 10.0503]
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        PVGenerator::generate         Rotating image by 45 degrees about direction coordinate pixel (15, 15) to align specified slice with the x axis
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord+            [0, 0, 0] to [29, 29, 29]  (00:01:00.001, -00.15.00.003, 1.41498e+09Hz to 23:59:03.999, +00.14.00.002, 1.41501e+09Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord+            [8, 15, 0] to [22, 15, 29]  (00:00:19.799, +00.04.56.985, 1.41498e+09Hz to 23:59:40.201, -00.04.56.985, 1.41501e+09Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ::::ImageFactory::createImage        Created Paged image 'zz.im' of shape [30, 30, 30] with float valued pixels.
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ::::image::fromshape        Ran ia.fromshape
25-Oct-2024 15:46:28 2024-10-25 19:46:28        INFO        ::::image::fromshape        ia.fromshape(outfile="zz.im", shape=[30,30,30], csys={...}, linear=false, overwrite=false, log=true, type="f")
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ::::image::pv        Ran ia.pv
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ::::image::pv        ia.pv(outfile="", start=[], end=[], center=[15,15], length="14arcmin", pa="45deg", width=1, unit="arcsec", overwrite=false, region={...}, chans="", stokes="", mask="", stretch=false, wantreturn=true)
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        name::        No table opened.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:28 test_tool_image_pv.py::ia_pv_test::test_history
25-Oct-2024 15:46:28 Verify history is written to created image
25-Oct-2024 15:46:28 PASSED
25-Oct-2024 15:46:28
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageFactory::createImage        Created Paged image 'zxye.im' of shape [10, 10, 10] with float valued pixels.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        name::        No table opened.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        SubImageFactory::createImage        Creating image 'test_pv_0' of shape [6, 10]
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        name::        No table opened.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        SubImageFactory::createImage        Creating image 'test_pv_1' of shape [6, 10]
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        name::        No table opened.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        SubImageFactory::createImage        Creating image 'test_pv_2' of shape [6, 10]
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        name::        No table opened.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        SubImageFactory::createImage        Creating image 'test_pv_3' of shape [6, 10]
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        name::        No table opened.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        SubImageFactory::createImage        Creating image 'test_pv_4' of shape [6, 10]
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        name::        No table opened.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        SubImageFactory::createImage        Creating image 'test_pv_5' of shape [6, 10]
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        name::        No table opened.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        SubImageFactory::createImage        Creating image 'test_pv_6' of shape [6, 10]
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        name::        No table opened.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord+            [2, 4, 0] to [7, 6, 9]  (00:00:12.000, -00.01.00.000, 1.415e+09Hz to 23:59:52.000, +00.01.00.000, 1.415e+09Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_0' of shape [6, 10]
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord+            [2, 4, 0] to [7, 6, 9]  (00:00:12.000, -00.01.00.000, 1.415e+09Hz to 23:59:52.000, +00.01.00.000, 1.415e+09Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_1' of shape [6, 10]
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        PVGenerator::setWidth         Rounding width up to next odd number of pixels (3), or 3arcmin
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord+            [2, 4, 0] to [7, 6, 9]  (00:00:12.000, -00.01.00.000, 1.415e+09Hz to 23:59:52.000, +00.01.00.000, 1.415e+09Hz)
25-Oct-2024 15:46:28 2024-10-25 19:46:29        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_2' of shape [6, 10]
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        PVGenerator::setWidth         Rounding width up to next odd number of pixels (3), or 3arcmin
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord+            [2, 4, 0] to [7, 6, 9]  (00:00:12.000, -00.01.00.000, 1.415e+09Hz to 23:59:52.000, +00.01.00.000, 1.415e+09Hz)
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_3' of shape [6, 10]
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        PVGenerator::setWidth         Rounding width up to next odd number of pixels (3), or 180000marcsec
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord+            [2, 4, 0] to [7, 6, 9]  (00:00:12.000, -00.01.00.000, 1.415e+09Hz to 23:59:52.000, +00.01.00.000, 1.415e+09Hz)
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_4' of shape [6, 10]
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        name::        No table opened.
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:29 test_tool_image_pv.py::ia_pv_test::test_pv
25-Oct-2024 15:46:29 ia.pv(): Test pv()
25-Oct-2024 15:46:29 PASSED
25-Oct-2024 15:46:29
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        ImageFactory::createImage        Created Temp image  of shape [50, 50, 1000] with float valued pixels.
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        PVGenerator::generate         Rotating image by -45 degrees about direction coordinate pixel (7.5, 7.5) to align specified slice with the x axis
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord+            [0, 0, 0] to [49, 49, 999]  (03:01:57.530, -35.32.49.013, 1.4145e+09Hz to 02:57:58.673, -34.43.38.701, 1.4155e+09Hz)
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord+            [4, 7, 0] to [11, 7, 999]  (03:01:31.077, -35.28.09.040, 1.4145e+09Hz to 03:01:06.781, -35.23.12.033, 1.4155e+09Hz)
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        name::        No table opened.
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:29 test_tool_image_pv.py::ia_pv_test::test_refpix_far_outside_image
25-Oct-2024 15:46:29 Test refpix far outside image doesn't lead to malloc error, CAS-5251
25-Oct-2024 15:46:29 PASSED
25-Oct-2024 15:46:29
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        ImageFactory::createImage        Created Paged image 'maskim' of shape [200, 200, 1, 1] with float valued pixels.
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        ImageFactory::createImage        Created Paged image 'kk' of shape [200, 200, 1, 20] with float valued pixels.
25-Oct-2024 15:46:29 2024-10-25 19:46:29        SEVERE        image::pv (file src/tools/image/image_cmpt.cc, line 4856)        Exception Reported: The input image shape ([200, 200, 1, 20]) and mask shape ([200, 200, 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
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord        Selected bounding box :
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        ImageRegion::fromRecord+            [2, 2, 0, 0] to [20, 2, 0, 19]  (00:06:32.213, -01.38.00.797, I, 1.41499e+09Hz to 00:05:20.159, -01.38.00.797, I, 1.41501e+09Hz)
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        name::        No table opened.
25-Oct-2024 15:46:29 2024-10-25 19:46:29        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:29 test_tool_image_pv.py::ia_pv_test::test_stretch
25-Oct-2024 15:46:29 ia.pv(): Test stretch parameter
25-Oct-2024 15:46:29 PASSED
25-Oct-2024 15:46:29
25-Oct-2024 15:46:29 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_pv/nose.xml -
25-Oct-2024 15:46:29 ========================= 7 passed, 1 warning in 2.53s =========================
25-Oct-2024 15:46:29 ============================= test session starts ==============================
25-Oct-2024 15:46:29 platform linux -- Python 3.8.7, pytest-8.3.3, pluggy-1.5.0 -- /home/casatest/venv/bin/python3.8
25-Oct-2024 15:46:29 cachedir: .pytest_cache
25-Oct-2024 15:46:29 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_msuvbinner
25-Oct-2024 15:46:29 configfile: pytest.ini
25-Oct-2024 15:46:30 collecting ... collected 1 item
25-Oct-2024 15:46:30
25-Oct-2024 15:46:30
25-Oct-2024 15:46:31 test_tool_msuvbinner.py::msuvbinnerTest::test_fill_1ms
25-Oct-2024 15:46:31 test uvgridding 1 ms onto an output grid 
25-Oct-2024 15:46:31 PASSED
25-Oct-2024 15:46:31
25-Oct-2024 15:46:31 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_msuvbinner/nose.xml -
25-Oct-2024 15:46:31 ========================= 1 passed, 1 warning in 2.26s =========================
25-Oct-2024 15:46:32 ============================= test session starts ==============================
25-Oct-2024 15:46:32 platform linux -- Python 3.8.7, pytest-8.3.3, pluggy-1.5.0 -- /home/casatest/venv/bin/python3.8
25-Oct-2024 15:46:32 cachedir: .pytest_cache
25-Oct-2024 15:46:32 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_statistics
25-Oct-2024 15:46:32 configfile: pytest.ini
25-Oct-2024 15:46:32 collecting ... collected 11 items
25-Oct-2024 15:46:32
25-Oct-2024 15:46:32
25-Oct-2024 15:46:32 2024-10-25 19:46:33        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
25-Oct-2024 15:46:32 2024-10-25 19:46:33        INFO        name::        No table opened.
25-Oct-2024 15:46:32 2024-10-25 19:46:33        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:32 test_tool_image_statistics.py::ia_statistics_test::test_CAS_2195_image_can_have_linear_rather_than_direction_coordinate
25-Oct-2024 15:46:32 verify fix for CAS-2195, image has linear, not direction, coordinate
25-Oct-2024 15:46:32 PASSED
25-Oct-2024 15:46:32
25-Oct-2024 15:46:39 ....10....20....30....40....50....60....70....80....90....100%
25-Oct-2024 15:46:48 2024-10-25 19:46:49        INFO        name::        No table opened.
25-Oct-2024 15:46:48 2024-10-25 19:46:49        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:48 test_tool_image_statistics.py::ia_statistics_test::test_biweight
25-Oct-2024 15:46:48 Test biweight algorithm CAS-11100
25-Oct-2024 15:46:48 PASSED
25-Oct-2024 15:46:48
25-Oct-2024 15:46:48 2024-10-25 19:46:49        INFO        ImageFactory::createImage        Created Paged image 'chauvtest.im' of shape [107] with float valued pixels.
25-Oct-2024 15:46:48 2024-10-25 19:46:49        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
25-Oct-2024 15:46:48 2024-10-25 19:46:49        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
25-Oct-2024 15:46:48 2024-10-25 19:46:49        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
25-Oct-2024 15:46:48 2024-10-25 19:46:49        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
25-Oct-2024 15:46:48 2024-10-25 19:46:49        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
25-Oct-2024 15:46:48 2024-10-25 19:46:49        INFO        name::        No table opened.
25-Oct-2024 15:46:48 2024-10-25 19:46:49        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:48 test_tool_image_statistics.py::ia_statistics_test::test_chauvenet
25-Oct-2024 15:46:48 Test Chauvenet's criterion algorithm
25-Oct-2024 15:46:48 PASSED
25-Oct-2024 15:46:48
25-Oct-2024 15:46:48 2024-10-25 19:46:49        INFO        ImageFactory::createImage        Created Paged image 'fhtest.im' of shape [100] with float valued pixels.
25-Oct-2024 15:46:48 2024-10-25 19:46:49        INFO        name::        No table opened.
25-Oct-2024 15:46:48 2024-10-25 19:46:49        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:48 test_tool_image_statistics.py::ia_statistics_test::test_fithalf
25-Oct-2024 15:46:48 Test fit to half algorithm
25-Oct-2024 15:46:48 PASSED
25-Oct-2024 15:46:48
25-Oct-2024 15:46:48 2024-10-25 19:46:49        INFO        ImageFactory::createImage        Created Paged image 'hftest.im' of shape [100] with float valued pixels.
25-Oct-2024 15:46:48 2024-10-25 19:46:49        INFO        name::        No table opened.
25-Oct-2024 15:46:48 2024-10-25 19:46:49        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:48 test_tool_image_statistics.py::ia_statistics_test::test_hingesfences
25-Oct-2024 15:46:48 Test hinges-fences algorithm
25-Oct-2024 15:46:48 PASSED
25-Oct-2024 15:46:48
25-Oct-2024 15:46:48 2024-10-25 19:46:49        INFO        ImageFactory::createImage        Created Paged image 'internally_excluded_region.im' of shape [100, 200, 110, 4] with float valued pixels.
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        CasacRegionManager::fromBCS        Using channel range(s)
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        CasacRegionManager::fromBCS        Using polarizations IV
25-Oct-2024 15:46:49 2024-10-25 19:46:50        WARN                Stokes cannot be determined because this region type is not handled yet. But chances are very good this is no need to be alarmed.
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        name::        No table opened.
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:49 test_tool_image_statistics.py::ia_statistics_test::test_internal_region_exclusion
25-Oct-2024 15:46:49 Verify data not returned for internally excluded regions
25-Oct-2024 15:46:49 PASSED
25-Oct-2024 15:46:49
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        name::        No table opened.
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:49 test_tool_image_statistics.py::ia_statistics_test::test_logfile_param
25-Oct-2024 15:46:49 test logfile 
25-Oct-2024 15:46:49 i 1
25-Oct-2024 15:46:49 i 2
25-Oct-2024 15:46:49 PASSED
25-Oct-2024 15:46:49
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary        
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        Image name       : moment_map.im
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        Object name      : G11.92
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        Image type       : PagedImage
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        Image quantity   : Intensity
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        Pixel mask(s)    : mask0
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        Region(s)        : None
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        Image units      : Jy/beam.km/s
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        Restoring Beam   : 3.15627 arcsec, 1.80243 arcsec, 58.3141 deg
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary        
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        Direction reference : J2000
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        Spectral  reference : LSRK
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        Velocity  type      : RADIO
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        Rest frequency      : 2.30538e+11 Hz
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        Pointing center     :  18:13:58.097081  -18.54.16.695951
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        Telescope           : SMA
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        Observer            : SMA
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        Date observation    : 2008/06/23/00:00:00.000000
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        Axis Coord Type      Name             Proj Shape Tile   Coord value at pixel      Coord incr Units
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        --------------------------------------------------------------------------------------------------
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        0    0     Direction Right Ascension   SIN   256  256  18:13:58.097   128.00   -4.000000e-01 arcsec
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        1    0     Direction Declination       SIN   256  256 -18.54.16.696   128.00    4.000000e-01 arcsec
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        2    1     Stokes    Stokes                    1    1             I
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+        3    2     Spectral  Frequency                 1    1   2.30392e+11   -37.00 2.536257562e+06 Hz
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageMetaData::summary+                             Velocity                               189.963   -37.00   -3.298159e+00 km/s
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        name::        No table opened.
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:49 test_tool_image_statistics.py::ia_statistics_test::test_moment_map_flux
25-Oct-2024 15:46:49 Test 1: verify moment maps can have flux densities computed in statistics
25-Oct-2024 15:46:49 PASSED
25-Oct-2024 15:46:49
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageFactory::createImage        Created Paged image 'test011.im' of shape [10, 10, 10] with float valued pixels.
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        CasacRegionManager::fromBCS        Using specified box(es) 0, 0, 2, 2, 4, 4, 6, 6
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        name::        No table opened.
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:49 test_tool_image_statistics.py::ia_statistics_test::test_multiple_region_support
25-Oct-2024 15:46:49 test multiple region support
25-Oct-2024 15:46:49 PASSED
25-Oct-2024 15:46:49
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        name::        No table opened.
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:49 test_tool_image_statistics.py::ia_statistics_test::test_specifying_axes_param
25-Oct-2024 15:46:49 choose axes works
25-Oct-2024 15:46:49 PASSED
25-Oct-2024 15:46:49
25-Oct-2024 15:46:49 2024-10-25 19:46:50        INFO        ImageFactory::createImage        Created Paged image 'maskim' of shape [200, 200, 1, 1] with float valued pixels.
25-Oct-2024 15:46:50 2024-10-25 19:46:50        INFO        ImageFactory::createImage        Created Paged image 'tmp.im' of shape [200, 200, 1, 20] with float valued pixels.
25-Oct-2024 15:46:50 2024-10-25 19:46:50        SEVERE        image::statistics (file src/tools/image/image_cmpt.cc, line 5995)        Exception Reported: The input image shape ([200, 200, 1, 20]) and mask shape ([200, 200, 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
25-Oct-2024 15:46:50 2024-10-25 19:46:50        INFO        name::        No table opened.
25-Oct-2024 15:46:50 2024-10-25 19:46:50        INFO        showcache::        The Table Cache is empty.
25-Oct-2024 15:46:50 test_tool_image_statistics.py::ia_statistics_test::test_stretch
25-Oct-2024 15:46:50 Test stretch parameter
25-Oct-2024 15:46:50 PASSED
25-Oct-2024 15:46:50
25-Oct-2024 15:46:50 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_statistics/nose.xml -
25-Oct-2024 15:46:50 ======================== 11 passed, 1 warning in 17.84s ========================
25-Oct-2024 15:46:50 ============================= test session starts ==============================
25-Oct-2024 15:46:50 platform linux -- Python 3.8.7, pytest-8.3.3, pluggy-1.5.0 -- /home/casatest/venv/bin/python3.8
25-Oct-2024 15:46:50 cachedir: .pytest_cache
25-Oct-2024 15:46:50 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_createmultims
25-Oct-2024 15:46:50 configfile: pytest.ini
25-Oct-2024 15:46:51 collecting ... collected 1 item
25-Oct-2024 15:46:51
25-Oct-2024 15:46:51
25-Oct-2024 15:46:51 2024-10-25 19:46:52        INFO        ms::createmultims        Copying subtables from part1.ms to the other MMS members.
25-Oct-2024 15:46:58 2024-10-25 19:46:59        INFO        name::        No table opened.
25-Oct-2024 15:46:58 2024-10-25 19:46:59        INFO        name::        No table opened.
25-Oct-2024 15:46:58 test_tool_ms_createmultims.py::test_createmultims::test1
25-Oct-2024 15:46:58 Test_createmultims 1: 4 parts, same sources but different spws
25-Oct-2024 15:46:58 Copying part1.ms
25-Oct-2024 15:46:58 Copying part2-mod.ms
25-Oct-2024 15:46:58 Copying part2-mod2.ms
25-Oct-2024 15:46:58 Copying part2.ms
25-Oct-2024 15:46:58 Copying part3.ms
25-Oct-2024 15:46:58 Copying part4.ms
25-Oct-2024 15:46:58 PASSED
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_ms_createmultims/nose.xml -
25-Oct-2024 15:46:58 ========================= 1 passed, 1 warning in 8.15s =========================
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_imagepol/
25-Oct-2024 15:46:58 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_imagepol
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 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/
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_deviation/
25-Oct-2024 15:46:58 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_deviation
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_deviation/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_deviation/
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_sdm/
25-Oct-2024 15:46:58 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_sdm
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_sdm/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_sdm/
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms/
25-Oct-2024 15:46:58 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 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/
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_transpose/
25-Oct-2024 15:46:58 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_transpose
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 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/
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_subimage/
25-Oct-2024 15:46:58 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_subimage
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 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/
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_simulator/
25-Oct-2024 15:46:58 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_simulator
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_simulator/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_simulator/
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_regrid/
25-Oct-2024 15:46:58 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_regrid
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 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/
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_logsink/
25-Oct-2024 15:46:58 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_logsink
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_logsink/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_logsink/
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_coordsys/
25-Oct-2024 15:46:58 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_coordsys
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 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/
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_agentflagger/
25-Oct-2024 15:46:58 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_agentflagger
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 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/
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/
25-Oct-2024 15:46:58 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_calibrater/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/
25-Oct-2024 15:46:58 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 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/
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv/
25-Oct-2024 15:46:58 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 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/
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msuvbinner/
25-Oct-2024 15:46:58 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msuvbinner
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_msuvbinner/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_msuvbinner/
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_statistics/
25-Oct-2024 15:46:58 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_statistics
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 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/
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_createmultims/
25-Oct-2024 15:46:58 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_createmultims
25-Oct-2024 15:46:58
25-Oct-2024 15:46:58 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/
25-Oct-2024 15:46:59 total 175452
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci 15001    129368 Oct 25 19:32 casatestutils-6.6.5.16a14406.dev28+dirty-py3-none-any.whl
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci 15001 179363964 Oct 25 19:32 casatools-6.6.5.16a14406.dev28+dirty-cp38-cp38-manylinux_2_28_x86_64.whl
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root       4320 Oct 25 19:46 test_tool_agentflagger.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root        986 Oct 25 19:46 test_tool_calanalysis.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root       2637 Oct 25 19:46 test_tool_calibrater.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root        667 Oct 25 19:46 test_tool_componentlist.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root       7447 Oct 25 19:46 test_tool_coordsys.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root      12915 Oct 25 19:46 test_tool_image.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root       2200 Oct 25 19:46 test_tool_image_collapse.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root       1028 Oct 25 19:46 test_tool_image_deviation.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root       2555 Oct 25 19:46 test_tool_image_fitprofile.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root       1158 Oct 25 19:46 test_tool_image_pbcor.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root        863 Oct 25 19:46 test_tool_image_pv.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root        986 Oct 25 19:46 test_tool_image_rebin.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root       1316 Oct 25 19:46 test_tool_image_regrid.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root       1513 Oct 25 19:46 test_tool_image_statistics.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root        745 Oct 25 19:46 test_tool_image_subimage.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root        870 Oct 25 19:46 test_tool_image_transpose.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root       1946 Oct 25 19:46 test_tool_imagepol.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root        819 Oct 25 19:46 test_tool_linearmosaic.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root        648 Oct 25 19:46 test_tool_logsink.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root        529 Oct 25 19:46 test_tool_measures.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root       5204 Oct 25 19:46 test_tool_ms.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root        347 Oct 25 19:46 test_tool_ms_createmultims.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root       2075 Oct 25 19:46 test_tool_ms_statwt.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root       8492 Oct 25 19:46 test_tool_msmetadata.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root        339 Oct 25 19:46 test_tool_msuvbinner.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root       1151 Oct 25 19:46 test_tool_quanta.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root       3957 Oct 25 19:46 test_tool_regionmanager.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root       2052 Oct 25 19:46 test_tool_sdm.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root       2076 Oct 25 19:46 test_tool_sdm_toms.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root        428 Oct 25 19:46 test_tool_simulator.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root       1442 Oct 25 19:46 test_tool_table.xml
25-Oct-2024 15:46:59 -rw-r--r-- 1 casaci root       1697 Oct 25 19:46 test_tool_vpmanager.xml
25-Oct-2024 15:46:59 Finished task 'Test wheel' with result: Success
25-Oct-2024 15:46:59 Starting task 'Tar work directory' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
25-Oct-2024 15:46:59
Beginning to execute external process for build 'CASA - CMake CI Build - CAS-14406 - Test Tools Many Linux 2.28 #32 (CASA-CMAKECI217-TTOML228-32)'
... running command line:
/export/home/cbt-el7-1/bamboo-home/temp/CASA-CMAKECI217-TTOML228-32-ScriptBuildTask-1617937073323197018.sh
... in: /export/home/cbt-el7-1/bamboo-home/xml-data/build-dir/CASA-CMAKECI217-TTOML228
25-Oct-2024 15:46:59 Package working directory
25-Oct-2024 15:46:59 tar: work: Cannot stat: No such file or directory
25-Oct-2024 15:47:00 tar: Exiting with failure status due to previous errors
25-Oct-2024 15:47:00 total 175456
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci 15001    129368 Oct 25 19:32 casatestutils-6.6.5.16a14406.dev28+dirty-py3-none-any.whl
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci 15001 179363964 Oct 25 19:32 casatools-6.6.5.16a14406.dev28+dirty-cp38-cp38-manylinux_2_28_x86_64.whl
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root       4320 Oct 25 19:46 test_tool_agentflagger.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root        986 Oct 25 19:46 test_tool_calanalysis.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root       2637 Oct 25 19:46 test_tool_calibrater.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root        667 Oct 25 19:46 test_tool_componentlist.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root       7447 Oct 25 19:46 test_tool_coordsys.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root      12915 Oct 25 19:46 test_tool_image.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root       2200 Oct 25 19:46 test_tool_image_collapse.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root       1028 Oct 25 19:46 test_tool_image_deviation.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root       2555 Oct 25 19:46 test_tool_image_fitprofile.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root       1158 Oct 25 19:46 test_tool_image_pbcor.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root        863 Oct 25 19:46 test_tool_image_pv.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root        986 Oct 25 19:46 test_tool_image_rebin.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root       1316 Oct 25 19:46 test_tool_image_regrid.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root       1513 Oct 25 19:46 test_tool_image_statistics.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root        745 Oct 25 19:46 test_tool_image_subimage.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root        870 Oct 25 19:46 test_tool_image_transpose.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root       1946 Oct 25 19:46 test_tool_imagepol.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root        819 Oct 25 19:46 test_tool_linearmosaic.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root        648 Oct 25 19:46 test_tool_logsink.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root        529 Oct 25 19:46 test_tool_measures.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root       5204 Oct 25 19:46 test_tool_ms.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root        347 Oct 25 19:46 test_tool_ms_createmultims.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root       2075 Oct 25 19:46 test_tool_ms_statwt.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root       8492 Oct 25 19:46 test_tool_msmetadata.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root        339 Oct 25 19:46 test_tool_msuvbinner.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root       1151 Oct 25 19:46 test_tool_quanta.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root       3957 Oct 25 19:46 test_tool_regionmanager.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root       2052 Oct 25 19:46 test_tool_sdm.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root       2076 Oct 25 19:46 test_tool_sdm_toms.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root        428 Oct 25 19:46 test_tool_simulator.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root       1442 Oct 25 19:46 test_tool_table.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root       1697 Oct 25 19:46 test_tool_vpmanager.xml
25-Oct-2024 15:47:00 -rw-r--r-- 1 casaci root         45 Oct 25 19:47 work-el7-3.8.tar.gz
25-Oct-2024 15:47:00 Done packaging working directory
25-Oct-2024 15:47:00 Finished task 'Tar work directory' with result: Success
25-Oct-2024 15:47:00 Starting task 'Parse tests' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
25-Oct-2024 15:47:00 Parsing test results under /export/home/cbt-el7-1/bamboo-home/xml-data/build-dir/CASA-CMAKECI217-TTOML228...
25-Oct-2024 15:47:00 Finished task 'Parse tests' with result: Success
25-Oct-2024 15:47:00 Skipping execution of task 'Upload wheel' as it is disabled
25-Oct-2024 15:47:00 Starting task 'Cleanup' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
25-Oct-2024 15:47:00
Beginning to execute external process for build 'CASA - CMake CI Build - CAS-14406 - Test Tools Many Linux 2.28 #32 (CASA-CMAKECI217-TTOML228-32)'
... running command line:
/export/home/cbt-el7-1/bamboo-home/temp/CASA-CMAKECI217-TTOML228-32-ScriptBuildTask-7836096265578420194.sh
... in: /export/home/cbt-el7-1/bamboo-home/xml-data/build-dir/CASA-CMAKECI217-TTOML228
25-Oct-2024 15:47:00 Starting cleanup
25-Oct-2024 15:47:11 wheel-container-test
25-Oct-2024 15:47:12 wheel-container-test
25-Oct-2024 15:47:12 Cleanup complete
25-Oct-2024 15:47:12 Finished task 'Cleanup' with result: Success
25-Oct-2024 15:47:12 Running post build plugin 'Docker Container Cleanup'
25-Oct-2024 15:47:12
Beginning to execute external process for build 'CASA - CMake CI Build - CAS-14406 - Test Tools Many Linux 2.28 #32 (CASA-CMAKECI217-TTOML228-32)'
... running command line:
/bin/docker rm -f wheel-container-test
... in: /export/home/cbt-el7-1/bamboo-home/xml-data/build-dir/CASA-CMAKECI217-TTOML228
25-Oct-2024 15:47:12 Error response from daemon: No such container: wheel-container-test
25-Oct-2024 15:47:12 Running post build plugin 'NCover Results Collector'
25-Oct-2024 15:47:12 Running post build plugin 'Build Results Label Collector'
25-Oct-2024 15:47:12 Running post build plugin 'Clover Results Collector'
25-Oct-2024 15:47:12 Running post build plugin 'npm Cache Cleanup'
25-Oct-2024 15:47:12 Running post build plugin 'Artifact Copier'
25-Oct-2024 15:47:12 Publishing an artifact: Workdir
25-Oct-2024 15:47:13 Finished publishing of artifact Non required job artifact Http Compression On : [Workdir], patterns: [work*.tar.gz] anchored at: [wheeldirectory/] in 96.00 ms
25-Oct-2024 15:47:13 Publishing an artifact: Tests
25-Oct-2024 15:47:13 Finished publishing of artifact Non required job artifact Http Compression On : [Tests], patterns: [*.xml] anchored at: [wheeldirectory/] in 259.3 ms
25-Oct-2024 15:47:13 Publishing an artifact: xml Directories
25-Oct-2024 15:47:13 Finished publishing of artifact Non required job artifact Http Compression On : [xml Directories], patterns: [**/*.xml] anchored at: [wheeldirectory/] in 252.8 ms
25-Oct-2024 15:47:13 Finalising the build...
25-Oct-2024 15:47:13 Stopping timer.
25-Oct-2024 15:47:13 Build CASA-CMAKECI217-TTOML228-32 completed.
25-Oct-2024 15:47:13 Running on server: post build plugin 'Build Hanging Detection Configuration'
25-Oct-2024 15:47:13 Running on server: post build plugin 'NCover Results Collector'
25-Oct-2024 15:47:13 Running on server: post build plugin 'Build Labeller'
25-Oct-2024 15:47:13 Running on server: post build plugin 'Clover Delta Calculator'
25-Oct-2024 15:47:13 Running on server: post build plugin 'Maven Dependencies Postprocessor'
25-Oct-2024 15:47:13 All post build plugins have finished
25-Oct-2024 15:47:13 Generating build results summary...
25-Oct-2024 15:47:14 Saving build results to disk...
25-Oct-2024 15:47:14 Store variable context...
25-Oct-2024 15:47:14 Finished building CASA-CMAKECI217-TTOML228-32.