2022-10-27 15:39:46        INFO        ImageMetaData::summary+          I    Min    0 1.4149950e+09 1142.00    4.0000 arcsec x    2.0000 arcsec pa= 40.0000 deg
2022-10-27 15:39:46        INFO        ImageMetaData::summary+          I Median    5 1.4150000e+09 1140.94    4.0000 arcsec x    2.0000 arcsec pa= 40.0000 deg
2022-10-27 15:39:46        INFO        ImageMetaData::summary+          Q    Max    0 1.4149950e+09 1142.00    4.0000 arcsec x    2.0000 arcsec pa= 40.0000 deg
2022-10-27 15:39:46        INFO        ImageMetaData::summary+          Q    Min    0 1.4149950e+09 1142.00    4.0000 arcsec x    2.0000 arcsec pa= 40.0000 deg
2022-10-27 15:39:46        INFO        ImageMetaData::summary+          Q Median    5 1.4150000e+09 1140.94    4.0000 arcsec x    2.0000 arcsec pa= 40.0000 deg
2022-10-27 15:39:46        INFO        ImageMetaData::summary+          U    Max    0 1.4149950e+09 1142.00    4.0000 arcsec x    2.0000 arcsec pa= 40.0000 deg
2022-10-27 15:39:46        INFO        ImageMetaData::summary+          U    Min    0 1.4149950e+09 1142.00    4.0000 arcsec x    2.0000 arcsec pa= 40.0000 deg
2022-10-27 15:39:46        INFO        ImageMetaData::summary+          U Median    5 1.4150000e+09 1140.94    4.0000 arcsec x    2.0000 arcsec pa= 40.0000 deg
2022-10-27 15:39:46        INFO        ImageMetaData::summary+          V    Max    6 1.4150010e+09 1140.73    7.0000 arcsec x    5.0000 arcsec pa= 80.0000 deg
2022-10-27 15:39:46        INFO        ImageMetaData::summary+          V    Min    0 1.4149950e+09 1142.00    4.0000 arcsec x    2.0000 arcsec pa= 40.0000 deg
2022-10-27 15:39:46        INFO        ImageMetaData::summary+          V Median    5 1.4150000e+09 1140.94    4.0000 arcsec x    2.0000 arcsec pa= 40.0000 deg
2022-10-27 15:39:46        INFO        ImageMetaData::summary        
2022-10-27 15:39:46        INFO        ImageMetaData::summary+        Direction reference : J2000
2022-10-27 15:39:46        INFO        ImageMetaData::summary+        Spectral  reference : LSRK
2022-10-27 15:39:46        INFO        ImageMetaData::summary+        Velocity  type      : RADIO
2022-10-27 15:39:46        INFO        ImageMetaData::summary+        Rest frequency      : 1.42041e+09 Hz
2022-10-27 15:39:46        INFO        ImageMetaData::summary+        Telescope           : ALMA
2022-10-27 15:39:46        INFO        ImageMetaData::summary+        Observer            : Karl Jansky
2022-10-27 15:39:46        INFO        ImageMetaData::summary+        Date observation    : 2000/01/01/00:00:00.000100
2022-10-27 15:39:46        INFO        ImageMetaData::summary+        Telescope position: [2.22514e+06m, -5.44031e+06m, -2.48103e+06m] (ITRF)
2022-10-27 15:39:46        INFO        ImageMetaData::summary+        
2022-10-27 15:39:46        INFO        ImageMetaData::summary+        Axis Coord Type      Name             Proj Shape Tile   Coord value at pixel    Coord incr Units
2022-10-27 15:39:46        INFO        ImageMetaData::summary+        ------------------------------------------------------------------------------------------------
2022-10-27 15:39:46        INFO        ImageMetaData::summary+        0    0     Direction Right Ascension   SIN    10   10  00:00:00.000     5.00 -6.000000e+01 arcsec
2022-10-27 15:39:46        INFO        ImageMetaData::summary+        1    0     Direction Declination       SIN    10   10 +00.00.00.000     5.00  6.000000e+01 arcsec
2022-10-27 15:39:46        INFO        ImageMetaData::summary+        2    1     Spectral  Frequency                10   10     1.415e+09     5.00  1.000000e+03 Hz
2022-10-27 15:39:46        INFO        ImageMetaData::summary+                             Velocity                               1140.94     5.00 -2.110611e-01 km/s
2022-10-27 15:39:46        INFO        ImageMetaData::summary+        3    2     Stokes    Stokes                    4    4       I Q U V
2022-10-27 15:39:46        INFO        name::        No table opened.
2022-10-27 15:39:46        INFO        name::        No table opened.
2022-10-27 15:39:46        INFO        name::        No table opened.
2022-10-27 15:39:46        INFO        showcache::        The Table Cache is empty.
2022-10-27 15:39:46        INFO        ImageFactory::createImage        Created Paged image 'my.im' of shape [1, 1, 1, 1] with float valued pixels.
2022-10-27 15:39:46        SEVERE        image::tofits (file src/tools/image/image_cmpt.cc, line 6278)        Exception Reported: Exception: fitsfile must be specified.
2022-10-27 15:39:46        SEVERE        image::tofits (file src/tools/image/image_cmpt.cc, line 6278)+        ... thrown by bool casac::image::tofits(const std::__1::string &, bool, bool, long, double, double, const casac::variant &, const casac::variant &, bool, bool, bool, bool, bool, bool, bool, bool, bool) at File: src/tools/image/image_cmpt.cc, line: 6287
2022-10-27 15:39:46        INFO        ImageFactory::createImage        Created Temp image  of shape [10, 10, 10, 4] with float valued pixels.
2022-10-27 15:39:46        INFO        BeamManipulator::set        This image currently has no beams of any kind. Since channel and/or polarization were specified, a set of per plane beams, each equal to the specified beam, will be created.
2022-10-27 15:39:46        INFO        BeamManipulator::set        Beam parameters:  Major          : 10 arcsec
2022-10-27 15:39:46        INFO        BeamManipulator::set+          Minor          : 7 arcsec
2022-10-27 15:39:46        INFO        BeamManipulator::set+          Position Angle : 45 deg
2022-10-27 15:39:46        INFO        BeamManipulator::set        Beam parameters:  Major          : 12 arcsec
2022-10-27 15:39:46        INFO        BeamManipulator::set+          Minor          : 8 arcsec
2022-10-27 15:39:46        INFO        BeamManipulator::set+          Position Angle : 50 deg
2022-10-27 15:39:46        INFO        ImageFITSConverterImpl::FITSToImage         Created (temp)image of shape [10, 10, 10, 4]
2022-10-27 15:39:46        INFO        ImageFITSConverterImpl::FITSToImage         Copy FITS file to 'Temporary_Image' All pixels fit in memory (4000 pixels).
2022-10-27 15:39:46        INFO        ImageFITSConverter::readBeamsTable        Loading multiple beams from BEAMS table
2022-10-27 15:39:46        INFO        ImageFITSConverter::readBeamsTable        Loading multiple beams from BEAMS table
2022-10-27 15:39:46        INFO        ImageFITSConverterImpl::FITSToImage         Created (temp)image of shape [10, 10, 10, 4]
2022-10-27 15:39:46        INFO        ImageFITSConverterImpl::FITSToImage         Copy FITS file to 'Temporary_Image' All pixels fit in memory (4000 pixels).
2022-10-27 15:39:46        INFO        ImageFITSConverter::readBeamsTable        Loading multiple beams from BEAMS table
2022-10-27 15:39:46        INFO        ImageFITSConverter::readBeamsTable        Loading multiple beams from BEAMS table
2022-10-27 15:39:46        INFO        ImageFactory::createImage        Created Paged image 'maskim' of shape [200, 200, 1, 1] with float valued pixels.
2022-10-27 15:39:46        INFO        ImageFactory::createImage        Created Temp image  of shape [200, 200, 1, 20] with float valued pixels.
2022-10-27 15:39:46        SEVERE        image::tofits (file src/tools/image/image_cmpt.cc, line 6278)        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: src/code/imageanalysis/ImageAnalysis/SubImageFactory.tcc, line: 306
2022-10-27 15:39:46        INFO        ImageFactory::createImage        Created Paged image 'zz' of shape [20, 20] with float valued pixels.
2022-10-27 15:39:46        INFO        ImageTwoPtCorr::setUpAxes(...)         Selected Sky axes
2022-10-27 15:39:46        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
2022-10-27 15:39:46        INFO        ImageTwoPtCorr::setUpAxes(...)         Selected first two axes
2022-10-27 15:39:46        INFO        LatticeTwoPtCorr::autoCorrelation(...)         Processing position [0, 0]
2022-10-27 15:39:46        INFO        SubImageFactory::createImage        Creating image 'xyz.im' of shape [39, 39]
2022-10-27 15:39:46        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
2022-10-27 15:39:46        INFO        ::::ImageFactory::createImage        Created Paged image 'zz' of shape [20, 20] with float valued pixels.
2022-10-27 15:39:46        INFO        ::::image::fromshape        Ran ia.fromshape
2022-10-27 15:39:46        INFO        ::::image::fromshape        ia.fromshape(outfile="zz", shape=[20,20], csys={...}, linear=false, overwrite=false, log=true, type="f")
2022-10-27 15:39:46        INFO        ::::image::twopointcorrelation        Ran ia.twopointcorrelation
2022-10-27 15:39:46        INFO        ::::image::twopointcorrelation        ia.twopointcorrelation(outfile="xyz.im", region={...}, mask="", axes=[-1], method="structurefunction", overwrite=false, stretch=false)
2022-10-27 15:39:46        INFO        ImageFactory::createImage        Created Paged image 'maskim' of shape [20, 20, 1, 1] with float valued pixels.
2022-10-27 15:39:46        INFO        ImageFactory::createImage        Created Temp image  of shape [20, 20, 1, 20] with float valued pixels.
2022-10-27 15:39:46        SEVERE        image::twopointcorrelation (file src/tools/image/image_cmpt.cc, line 6525)        Exception Reported: The input image shape ([20, 20, 1, 20]) and mask shape ([20, 20, 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: src/code/imageanalysis/ImageAnalysis/SubImageFactory.tcc, line: 306
2022-10-27 15:39:46        INFO        ImageTwoPtCorr::setUpAxes(...)         Selected Sky axes
2022-10-27 15:39:46        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
2022-10-27 15:39:46        INFO        ImageTwoPtCorr::setUpAxes(...)         Selected first two axes
2022-10-27 15:39:46        INFO        LatticeTwoPtCorr::autoCorrelation(...)         Processing position [0, 0, 0, 0]
2022-10-27 15:39:46        INFO        LatticeTwoPtCorr::autoCorrelation(...)         Processing position [0, 0, 0, 1]
2022-10-27 15:39:46        INFO        LatticeTwoPtCorr::autoCorrelation(...)         Processing position [0, 0, 0, 2]
2022-10-27 15:39:46        INFO        LatticeTwoPtCorr::autoCorrelation(...)         Processing position [0, 0, 0, 3]
2022-10-27 15:39:46        INFO        LatticeTwoPtCorr::autoCorrelation(...)         Processing position [0, 0, 0, 4]
2022-10-27 15:39:46        INFO        LatticeTwoPtCorr::autoCorrelation(...)         Processing position [0, 0, 0, 5]
2022-10-27 15:39:46        INFO        LatticeTwoPtCorr::autoCorrelation(...)         Processing position [0, 0, 0, 6]
2022-10-27 15:39:46        INFO        LatticeTwoPtCorr::autoCorrelation(...)         Processing position [0, 0, 0, 7]
2022-10-27 15:39:46        INFO        LatticeTwoPtCorr::autoCorrelation(...)         Processing position [0, 0, 0, 8]
2022-10-27 15:39:46        INFO        LatticeTwoPtCorr::autoCorrelation(...)         Processing position [0, 0, 0, 9]
2022-10-27 15:39:46        INFO        LatticeTwoPtCorr::autoCorrelation(...)         Processing position [0, 0, 0, 10]
2022-10-27 15:39:46        INFO        LatticeTwoPtCorr::autoCorrelation(...)         Processing position [0, 0, 0, 11]
2022-10-27 15:39:46        INFO        LatticeTwoPtCorr::autoCorrelation(...)         Processing position [0, 0, 0, 12]
2022-10-27 15:39:46        INFO        LatticeTwoPtCorr::autoCorrelation(...)         Processing position [0, 0, 0, 13]
2022-10-27 15:39:46        INFO        LatticeTwoPtCorr::autoCorrelation(...)         Processing position [0, 0, 0, 14]
2022-10-27 15:39:46        INFO        LatticeTwoPtCorr::autoCorrelation(...)         Processing position [0, 0, 0, 15]
2022-10-27 15:39:46        INFO        LatticeTwoPtCorr::autoCorrelation(...)         Processing position [0, 0, 0, 16]
2022-10-27 15:39:46        INFO        LatticeTwoPtCorr::autoCorrelation(...)         Processing position [0, 0, 0, 17]
2022-10-27 15:39:46        INFO        LatticeTwoPtCorr::autoCorrelation(...)         Processing position [0, 0, 0, 18]
2022-10-27 15:39:46        INFO        LatticeTwoPtCorr::autoCorrelation(...)         Processing position [0, 0, 0, 19]
Traceback (most recent call last):
  File "runtest.py", line 613, in run
    shutil.copy2("{}{}.py".format(workdir + "tests/",test), workdir + "{}/".format(test if not test.endswith(".py") else test[:-3]))
  File "/opt/casa/03/Library/Frameworks/Python.framework/Versions/3.6/lib/python3.6/shutil.py", line 263, in copy2
    copyfile(src, dst, follow_symlinks=follow_symlinks)
  File "/opt/casa/03/Library/Frameworks/Python.framework/Versions/3.6/lib/python3.6/shutil.py", line 120, in copyfile
    with open(src, 'rb') as fsrc:
FileNotFoundError: [Errno 2] No such file or directory: '/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF238-TTO15/casa6/casatestutils/nosedir/tests/test_tool_image_fromcomplist.py'
Cloning into 'casa-build-utils'...
You are using pip version 18.1, however version 21.3.1 is available.
You should consider upgrading via the 'pip install --upgrade pip' command.
HTTPError: 400 Bad Request from https://casa-pip.nrao.edu:443/repository/casa-dev-wheel/
Repository does not allow updating assets: casa-dev-wheel
  % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
                                 Dload  Upload   Total   Spent    Left  Speed

  0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0
100    70  100    70    0     0   2187      0 --:--:-- --:--:-- --:--:--  2187