Build: #3 was successful

Job: Test Tools Many Linux 2.28 was successful

Build log

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

04-Jun-2024 23:31:52 2024-06-05 03:31:52        INFO        BJonesPoly::selfSolveOne()         Spectral grid for fit will have 63 points spaced by 24.4141 kHz.
04-Jun-2024 23:31:52 2024-06-05 03:31:52        INFO        BJonesPoly::selfSolveOne()         Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz.
04-Jun-2024 23:31:52 2024-06-05 03:31:52        INFO        BJonesPoly::selfSolveOne()         Total bandwidth: 1538.09 kHz.
04-Jun-2024 23:31:52 2024-06-05 03:31:52        INFO        BJonesPoly::selfSolveOne()         Found data for 351 baselines among 27 antennas.
04-Jun-2024 23:31:52 2024-06-05 03:31:52        INFO        BJonesPoly::selfSolveOne()         Fitting amplitude polynomial.
04-Jun-2024 23:31:52 2024-06-05 03:31:52        INFO        BJonesPoly::selfSolveOne()         Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.350626/0.604424/0.974388
04-Jun-2024 23:31:52 2024-06-05 03:31:52        INFO        BJonesPoly::selfSolveOne()         Fitting phase polynomial.
04-Jun-2024 23:31:54 2024-06-05 03:31:54        INFO        BJonesPoly::selfSolveOne()         Per baseline RMS phase (deg) statistics: (min/mean/max) = 21.2542/59.3511/120.719
04-Jun-2024 23:31:54 2024-06-05 03:31:54        INFO        BJonesPoly::selfSolveOne()         Fitting amplitude polynomial.
04-Jun-2024 23:31:54 2024-06-05 03:31:54        INFO        BJonesPoly::selfSolveOne()         Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.382806/0.598119/0.941571
04-Jun-2024 23:31:54 2024-06-05 03:31:54        INFO        BJonesPoly::selfSolveOne()         Fitting phase polynomial.
04-Jun-2024 23:31:55 2024-06-05 03:31:56        INFO        BJonesPoly::selfSolveOne()         Per baseline RMS phase (deg) statistics: (min/mean/max) = 20.0637/57.2112/118.101
04-Jun-2024 23:31:55 2024-06-05 03:31:56        INFO        BJonesPoly::selfSolveOne()         Normalizing antenna-based solutions.
04-Jun-2024 23:31:55 2024-06-05 03:31:56        INFO        BJonesPoly::updateCalTable()         Storing calibration in table bpoly
04-Jun-2024 23:31:55 2024-06-05 03:31:56        INFO        BJonesPoly::selfSolveOne()         THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION
04-Jun-2024 23:31:55 2024-06-05 03:31:56        INFO        BJonesPoly::selfSolveOne()         Fitting bandpass amplitude and phase polynomials.
04-Jun-2024 23:31:55 2024-06-05 03:31:56        INFO        BJonesPoly::selfSolveOne()         Polynomial degree for amplitude is 5
04-Jun-2024 23:31:55 2024-06-05 03:31:56        INFO        BJonesPoly::selfSolveOne()         Polynomial degree for phase is 7
04-Jun-2024 23:31:55 2024-06-05 03:31:56        INFO        BJonesPoly::selfSolveOne()         Spectral grid for fit will have 63 points spaced by 24.4141 kHz.
04-Jun-2024 23:31:55 2024-06-05 03:31:56        INFO        BJonesPoly::selfSolveOne()         Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz.
04-Jun-2024 23:31:55 2024-06-05 03:31:56        INFO        BJonesPoly::selfSolveOne()         Total bandwidth: 1538.09 kHz.
04-Jun-2024 23:31:55 2024-06-05 03:31:56        INFO        BJonesPoly::selfSolveOne()         Found data for 351 baselines among 27 antennas.
04-Jun-2024 23:31:55 2024-06-05 03:31:56        INFO        BJonesPoly::selfSolveOne()         Fitting amplitude polynomial.
04-Jun-2024 23:31:55 2024-06-05 03:31:56        INFO        BJonesPoly::selfSolveOne()         Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0750931/0.0978998/0.125897
04-Jun-2024 23:31:55 2024-06-05 03:31:56        INFO        BJonesPoly::selfSolveOne()         Fitting phase polynomial.
04-Jun-2024 23:31:55 2024-06-05 03:31:56        INFO        BJonesPoly::selfSolveOne()         Per baseline RMS phase (deg) statistics: (min/mean/max) = 2.72932/3.98787/5.33715
04-Jun-2024 23:31:55 2024-06-05 03:31:56        INFO        BJonesPoly::selfSolveOne()         Fitting amplitude polynomial.
04-Jun-2024 23:31:55 2024-06-05 03:31:56        INFO        BJonesPoly::selfSolveOne()         Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0658572/0.0972125/0.140794
04-Jun-2024 23:31:55 2024-06-05 03:31:56        INFO        BJonesPoly::selfSolveOne()         Fitting phase polynomial.
04-Jun-2024 23:31:56 2024-06-05 03:31:56        INFO        BJonesPoly::selfSolveOne()         Per baseline RMS phase (deg) statistics: (min/mean/max) = 2.97943/3.97841/5.72903
04-Jun-2024 23:31:56 2024-06-05 03:31:56        INFO        BJonesPoly::selfSolveOne()         Normalizing antenna-based solutions.
04-Jun-2024 23:31:56 2024-06-05 03:31:56        INFO        BJonesPoly::updateCalTable()         Storing calibration in table bpoly
04-Jun-2024 23:31:56 2024-06-05 03:31:56        INFO        Calibrater::solve          Found good BPOLY solutions in 7 slots.
04-Jun-2024 23:31:56 2024-06-05 03:31:56        INFO        calibrater::solve        Finished solving.
04-Jun-2024 23:31:56 2024-06-05 03:31:56        WARN        calibrater::setvi(bool,bool)        Forcing use of NEW VisibilityIterator.
04-Jun-2024 23:31:56 test_tool_calibrater.py::calibrater_test::test_solveBandpass
04-Jun-2024 23:31:56 Check that solve band poly creates the output table
04-Jun-2024 23:31:56 PASSED
04-Jun-2024 23:31:56
04-Jun-2024 23:31:56 2024-06-05 03:31:56        WARN        calibrater::setvi(bool,bool)        Forcing use of OLD VisibilityIterator.
04-Jun-2024 23:31:56 2024-06-05 03:31:56        INFO        calibrater::open        ****Using OLD VI-driven calibrater tool****
04-Jun-2024 23:31:56 2024-06-05 03:31:56        INFO        calibrater::open        Opening MS: ngc5921.ms for calibration.
04-Jun-2024 23:31:56 2024-06-05 03:31:56        INFO                Clearing all model records in MS header.
04-Jun-2024 23:31:56 2024-06-05 03:31:56        INFO        VisSetUtil::addScrCols        Adding MODEL_DATA and CORRECTED_DATA column(s).
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        VisSetUtil::initScrCols        Initializing MODEL_DATA to (unity).
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        VisSetUtil::initScrCols        Initialized 22653 rows.
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        Calibrater::        Initializing nominal selection to the whole MS.
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        calibrater::setsolvegainspline        Beginning setsolvegainspline--(MSSelection version)-------
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        Calibrater::setsolvegainspline        Arranging to SOLVE:
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        Calibrater::setsolvegainspline        .   GSPLINE: table=gainspline append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AMP solnorm=false
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        calibrater::solve        Beginning solve-----------------------------
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        Calibrater::solve        .   (None)
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        Calibrater::solve        The following calibration term is arranged for solve:
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        Calibrater::solve        .   GSPLINE: table=gainspline append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AMP solnorm=false
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        GJonesSpline::solve()         Fitting time-dependent cubic splines.
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        GJonesSpline::solve()         Solving for phase splines with splinetime= 10800
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        GJonesSpline::solve()         Solving for amplitude splines with splinetime= 10800
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        GJonesSpline::solve()         Accumulating data for:  field= 1331+30500002_0, spw= 0, nchan= 63
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        GJonesSpline::solve()         Accumulating data for:  field= 1445+09900002_0, spw= 0, nchan= 63
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        GJonesSpline::solve()         Accumulating data for:  field= N5921_2, spw= 0, nchan= 63
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        GJonesSpline::solve()         Number of timestamps in data = 60
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        GJonesSpline::getKnots()         Gridded splinetime = 5280 sec.
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        GJonesSpline::solve()         Number of cubic spline control points = 4
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        GJonesSpline::solve()         Number of cubic spline knots = 8
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        GJonesSpline::solve()         Number of cubic spline segments = 1
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        GJonesSpline::solve()         Fitting amplitude spline.
04-Jun-2024 23:31:56 test_tool_calibrater.py::calibrater_test::test_solveGainspline  DPBTRF ;problem leading minor           23
04-Jun-2024 23:31:56 DPBTRF ;problem leading minor           23
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        GJonesSpline::solve()         Searching for and correcting phase-wraps on each baseline.
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        GJonesSpline::solve()         Fitting phase spline.
04-Jun-2024 23:31:56 DPBTRF ;problem leading minor           22
04-Jun-2024 23:31:56 DPBTRF ;problem leading minor           22
04-Jun-2024 23:31:56 2024-06-05 03:31:57        INFO        GJonesSpline::updateCalTable         Storing solutions in table gainspline
04-Jun-2024 23:31:57 2024-06-05 03:31:57        INFO        calibrater::solve        Finished solving.
04-Jun-2024 23:31:57 2024-06-05 03:31:57        WARN        calibrater::setvi(bool,bool)        Forcing use of NEW VisibilityIterator.
04-Jun-2024 23:31:57
04-Jun-2024 23:31:57 Check that solve gain spline creates the output table 
04-Jun-2024 23:31:57 PASSED
04-Jun-2024 23:31:57
04-Jun-2024 23:31:57 2024-06-05 03:31:57        INFO        calibrater::open        ****Using NEW VI2-driven calibrater tool****
04-Jun-2024 23:31:57 2024-06-05 03:31:57        INFO        calibrater::open        Opening MS: gaincaltest2.ms for calibration.
04-Jun-2024 23:31:57 2024-06-05 03:31:57        INFO                Clearing all model records in MS header.
04-Jun-2024 23:31:57 2024-06-05 03:31:57        INFO        VisSetUtil::addScrCols        Adding MODEL_DATA and CORRECTED_DATA column(s).
04-Jun-2024 23:31:58 2024-06-05 03:31:59        INFO        VisSetUtil::initScrCols        Initializing MODEL_DATA to (unity).
04-Jun-2024 23:31:58 2024-06-05 03:31:59        INFO        VisSetUtil::initScrCols        Initialized 328860 rows.
04-Jun-2024 23:31:58 2024-06-05 03:31:59        INFO        Calibrater::        Initializing nominal selection to the whole MS.
04-Jun-2024 23:31:58 2024-06-05 03:31:59        INFO        calibrater::specifycal        Beginning specifycal-----------------------
04-Jun-2024 23:31:58 2024-06-05 03:31:59        INFO                Creating G Jones table from specified parameters.
04-Jun-2024 23:31:58 2024-06-05 03:31:59        INFO                Generating 'G' corrections.
04-Jun-2024 23:31:58 2024-06-05 03:31:59        INFO                Specified parameter(s) (per spw and pol) repeated on all antennas.
04-Jun-2024 23:31:58 2024-06-05 03:31:59        INFO                Specified parameter(s) (per spw and antenna) repeated on all polarizations.
04-Jun-2024 23:31:58 2024-06-05 03:31:59        INFO                spwId=1 antId=<all> polId=<all> parameter= 3   (ip0,ip1 = [0, 0, 0],[1, 0, 9])
04-Jun-2024 23:31:58 2024-06-05 03:31:59        INFO                Writing solutions to table: testcalout.cal
04-Jun-2024 23:31:59 2024-06-05 03:31:59        WARN        calibrater::setvi(bool,bool)        Already using NEW VisibilityIterator.
04-Jun-2024 23:31:59 test_tool_calibrater.py::calibrater_test::test_specifyCal
04-Jun-2024 23:31:59 Check that specifycal can set values for specific spws and antennas
04-Jun-2024 23:31:59 PASSED
04-Jun-2024 23:31:59
04-Jun-2024 23:31:59 2024-06-05 03:31:59        WARN        calibrater::setvi(bool,bool)        Forcing use of OLD VisibilityIterator.
04-Jun-2024 23:31:59 2024-06-05 03:31:59        INFO        calibrater::open        ****Using OLD VI-driven calibrater tool****
04-Jun-2024 23:31:59 2024-06-05 03:31:59        INFO        calibrater::open        Opening MS: gaincaltest2.ms for calibration.
04-Jun-2024 23:31:59 2024-06-05 03:31:59        INFO                Clearing all model records in MS header.
04-Jun-2024 23:31:59 2024-06-05 03:32:00        INFO        VisSetUtil::addScrCols        Adding MODEL_DATA and CORRECTED_DATA column(s).
04-Jun-2024 23:32:00 2024-06-05 03:32:01        INFO        VisSetUtil::initScrCols        Initializing MODEL_DATA to (unity).
04-Jun-2024 23:32:01 2024-06-05 03:32:01        INFO        VisSetUtil::initScrCols        Initialized 328860 rows.
04-Jun-2024 23:32:01 2024-06-05 03:32:01        INFO        Calibrater::        Initializing nominal selection to the whole MS.
04-Jun-2024 23:32:01 2024-06-05 03:32:01        INFO        calibrater::setapply        Beginning setapply--(MSSelection version)-------
04-Jun-2024 23:32:01 2024-06-05 03:32:01        INFO        Calibrater::setapply(type, applypar)        Arranging to APPLY:
04-Jun-2024 23:32:01 2024-06-05 03:32:01        INFO        Calibrater::setapply(type, applypar)        .   G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false
04-Jun-2024 23:32:01 2024-06-05 03:32:01        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
04-Jun-2024 23:32:01 2024-06-05 03:32:01        INFO        Calibrater::setsolve        Arranging to SOLVE:
04-Jun-2024 23:32:01 2024-06-05 03:32:01        INFO        Calibrater::setsolve        .   Mf Mueller: table=output.ms append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
04-Jun-2024 23:32:01 2024-06-05 03:32:01        INFO        Calibrater::state        The following calibration terms are arranged for apply:
04-Jun-2024 23:32:01 2024-06-05 03:32:01        INFO        Calibrater::state        .   G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false
04-Jun-2024 23:32:01 2024-06-05 03:32:01        INFO        Calibrater::state        The following calibration term is arranged for solve:
04-Jun-2024 23:32:01 2024-06-05 03:32:01        INFO        Calibrater::state        .   Mf Mueller: table=output.ms append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
04-Jun-2024 23:32:01 2024-06-05 03:32:01        INFO        calibrater::solve        Beginning solve-----------------------------
04-Jun-2024 23:32:01 2024-06-05 03:32:01        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
04-Jun-2024 23:32:01 2024-06-05 03:32:01        INFO        Calibrater::solve        .   G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false
04-Jun-2024 23:32:01 2024-06-05 03:32:01        INFO        Calibrater::solve        The following calibration term is arranged for solve:
04-Jun-2024 23:32:01 2024-06-05 03:32:01        INFO        Calibrater::solve        .   Mf Mueller: table=output.ms append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
04-Jun-2024 23:32:01 2024-06-05 03:32:01        INFO                Solving for Mf Mueller
04-Jun-2024 23:32:01 2024-06-05 03:32:02        INFO                For solint = inf, found 84 solution intervals.
04-Jun-2024 23:32:03 2024-06-05 03:32:03        INFO                  Found good Mf Mueller solutions in 84 intervals.
04-Jun-2024 23:32:03 2024-06-05 03:32:03        INFO                Writing solutions to table: output.ms
04-Jun-2024 23:32:03 2024-06-05 03:32:03        INFO        calibrater::solve        Finished solving.
04-Jun-2024 23:32:03 2024-06-05 03:32:03        WARN        calibrater::setvi(bool,bool)        Forcing use of NEW VisibilityIterator.
04-Jun-2024 23:32:03 test_tool_calibrater.py::calibrater_test::test_standardPath
04-Jun-2024 23:32:03 open setapply setsolve state solve close 
04-Jun-2024 23:32:03 PASSED
04-Jun-2024 23:32:03
04-Jun-2024 23:32:03 2024-06-05 03:32:04        INFO        calibrater::open        ****Using NEW VI2-driven calibrater tool****
04-Jun-2024 23:32:03 2024-06-05 03:32:04        INFO        calibrater::open        Opening MS: gaincaltest2.ms for calibration.
04-Jun-2024 23:32:03 2024-06-05 03:32:04        INFO                Clearing all model records in MS header.
04-Jun-2024 23:32:03 2024-06-05 03:32:04        INFO        VisSetUtil::addScrCols        Adding MODEL_DATA and CORRECTED_DATA column(s).
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        VisSetUtil::initScrCols        Initializing MODEL_DATA to (unity).
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        VisSetUtil::initScrCols        Initialized 328860 rows.
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        Calibrater::        Initializing nominal selection to the whole MS.
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        name::        No table opened.
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        showcache::        The Table Cache has the following 16 entries:
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        showcache::            0: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms"
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        showcache::            1: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/ANTENNA"
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        showcache::            2: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/DATA_DESCRIPTION"
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        showcache::            3: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FEED"
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        showcache::            4: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FIELD"
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        showcache::            5: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FLAG_CMD"
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        showcache::            6: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/HISTORY"
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        showcache::            7: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/OBSERVATION"
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        showcache::            8: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/POINTING"
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        showcache::            9: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/POLARIZATION"
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        showcache::            10: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/PROCESSOR"
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        showcache::            11: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SOURCE"
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        showcache::            12: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SPECTRAL_WINDOW"
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        showcache::            13: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/STATE"
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        showcache::            14: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SYSCAL"
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        showcache::            15: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/WEATHER"
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        name::        No table opened.
04-Jun-2024 23:32:05 2024-06-05 03:32:05        INFO        showcache::        The Table Cache is empty.
04-Jun-2024 23:32:05 2024-06-05 03:32:05        WARN        calibrater::setvi(bool,bool)        Already using NEW VisibilityIterator.
04-Jun-2024 23:32:05 test_tool_calibrater.py::calibrater_test::test_takesMs
04-Jun-2024 23:32:05 Check that the calibrater tool can open and close an MS 
04-Jun-2024 23:32:05 PASSED
04-Jun-2024 23:32:05
04-Jun-2024 23:32:05 2024-06-05 03:32:06        INFO        calibrater::open        ****Using NEW VI2-driven calibrater tool****
04-Jun-2024 23:32:05 2024-06-05 03:32:06        INFO        calibrater::open        Opening MS: gaincaltest2.ms for calibration.
04-Jun-2024 23:32:05 2024-06-05 03:32:06        INFO                Clearing all model records in MS header.
04-Jun-2024 23:32:05 2024-06-05 03:32:06        INFO        VisSetUtil::addScrCols        Adding MODEL_DATA and CORRECTED_DATA column(s).
04-Jun-2024 23:32:06 2024-06-05 03:32:07        INFO        VisSetUtil::initScrCols        Initializing MODEL_DATA to (unity).
04-Jun-2024 23:32:07 2024-06-05 03:32:07        INFO        VisSetUtil::initScrCols        Initialized 328860 rows.
04-Jun-2024 23:32:07 2024-06-05 03:32:07        INFO        Calibrater::        Initializing nominal selection to the whole MS.
04-Jun-2024 23:32:07 2024-06-05 03:32:07        INFO        calibrater::setapply        Beginning setapply--(MSSelection version)-------
04-Jun-2024 23:32:07 2024-06-05 03:32:07        INFO        Calibrater::setapply(type, applypar)        Arranging to APPLY:
04-Jun-2024 23:32:07 2024-06-05 03:32:07        INFO        Calibrater::setapply(type, applypar)        .   G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false
04-Jun-2024 23:32:07 2024-06-05 03:32:07        INFO        calibrater::correct        Beginning correct---------------------------
04-Jun-2024 23:32:07 2024-06-05 03:32:07        INFO        Calibrater::correct2 (VI2/VB2)        The following calibration terms are arranged for apply:
04-Jun-2024 23:32:07 2024-06-05 03:32:07        INFO        Calibrater::correct2 (VI2/VB2)        .   G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false
04-Jun-2024 23:32:10 2024-06-05 03:32:10        INFO        calibrater::correct        Finished correcting.
04-Jun-2024 23:32:10 2024-06-05 03:32:10        WARN        calibrater::setvi(bool,bool)        Already using NEW VisibilityIterator.
04-Jun-2024 23:32:10 test_tool_calibrater.py::calibrater_test::test_writeToCorrected
04-Jun-2024 23:32:10 Check that the tool writes to the CORRECTED_DATA column 
04-Jun-2024 23:32:10 PASSED
04-Jun-2024 23:32:10
04-Jun-2024 23:32:10 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_calibrater/nose.xml -
04-Jun-2024 23:32:10 ================== 24 passed, 1 warning in 101.23s (0:01:41) ===================
04-Jun-2024 23:32:10 ============================= test session starts ==============================
04-Jun-2024 23:32:10 platform linux -- Python 3.8.7, pytest-8.2.2, pluggy-1.5.0 -- /home/casatest/venv/bin/python3.8
04-Jun-2024 23:32:10 cachedir: .pytest_cache
04-Jun-2024 23:32:10 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor
04-Jun-2024 23:32:10 configfile: pytest.ini
04-Jun-2024 23:32:11 collecting ... collected 9 items
04-Jun-2024 23:32:11
04-Jun-2024 23:32:11
04-Jun-2024 23:32:11 2024-06-05 03:32:11        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 0, 0]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, I)
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        name::        No table opened.
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        showcache::        The Table Cache is empty.
04-Jun-2024 23:32:11 test_tool_image_pbcor.py::ia_pbcor_test::test_4d_image_with_2d_pb
04-Jun-2024 23:32:11 ia.pbcor: Test full image divide with cutoff. Primary beam is 2 D, image is 4 D
04-Jun-2024 23:32:11 PASSED
04-Jun-2024 23:32:11
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [5, 5, 1, 1]
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        name::        No table opened.
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        showcache::        The Table Cache is empty.
04-Jun-2024 23:32:11 test_tool_image_pbcor.py::ia_pbcor_test::test_diff_spectral_coordinate
04-Jun-2024 23:32:11 Verify fix that a different spectral coordinates in target and template don't matter, CAS-5096
04-Jun-2024 23:32:11 PASSED
04-Jun-2024 23:32:11
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        ImageFactory::createImage        Created Paged image 't_in.im' of shape [20, 20, 4, 20] with float valued pixels.
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        ImageFactory::createImage        Created Paged image 't_pb_in.im' of shape [20, 20, 4, 20] with float valued pixels.
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        CasacRegionManager::fromBCS        Using polarizations I
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [19, 19, 0, 19]  (00:00:40.000, -00.10.00.001, I, 1.41499e+09Hz to 23:59:24.000, +00.09.00.001, I, 1.41501e+09Hz)
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Jun-2024 23:32:11 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [19, 19, 0, 19]  (00:00:40.000, -00.10.00.001, I, 1.41499e+09Hz to 23:59:24.000, +00.09.00.001, I, 1.41501e+09Hz)
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        SubImageFactory::createImage        Creating image 't_out.im' of shape [20, 20, 1, 20]
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        name::        No table opened.
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        showcache::        The Table Cache is empty.
04-Jun-2024 23:32:12 test_tool_image_pbcor.py::ia_pbcor_test::test_empty_region_and_stokes
04-Jun-2024 23:32:12 Test specifying stokes with empty region works (CAS-11708)
04-Jun-2024 23:32:12 PASSED
04-Jun-2024 23:32:12
04-Jun-2024 23:32:12 2024-06-05 03:32:12        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Exception Reported: Exception: File name is empty.
04-Jun-2024 23:32:12 2024-06-05 03:32:12        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)+        ... thrown by static void casa::ImageFactory::_checkInfile(const casacore::String&) at File: /source/casa6/casatools/src/code/imageanalysis/ImageAnalysis/ImageFactory2.cc, line: 371
04-Jun-2024 23:32:12 2024-06-05 03:32:12        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Exception Reported: Exception: File totally_bogus does not exist..
04-Jun-2024 23:32:12 2024-06-05 03:32:12        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)+        ... thrown by static void casa::ImageFactory::_checkInfile(const casacore::String&) at File: /source/casa6/casatools/src/code/imageanalysis/ImageAnalysis/ImageFactory2.cc, line: 375
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:12        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Exception: The image filename is empty.
04-Jun-2024 23:32:12 2024-06-05 03:32:12        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)+        ... thrown by static void casacore::ImageUtilities::openImage(casacore::ImageInterface<T>*&, const casacore::String&) [with T = float] at File: /source/casainstall/include/casacore/images/Images/ImageUtilities2.tcc, line: 255
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:12        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Exception: File 'totally_bogus2' does not exist.
04-Jun-2024 23:32:12 2024-06-05 03:32:12        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)+        ... thrown by static void casacore::ImageUtilities::openImage(casacore::ImageInterface<T>*&, const casacore::String&) [with T = float] at File: /source/casainstall/include/casacore/images/Images/ImageUtilities2.tcc, line: 260
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:12        SEVERE        ImageInputProcessor::_process        Requested output image /bogusplace/bogusimage cannot be created so will not be written
04-Jun-2024 23:32:12 2024-06-05 03:32:12        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: 2024-06-05 03:32:12        SEVERE        ImageInputProcessor::_process        Requested output image /bogusplace/bogusimage cannot be created so will not be written
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:12        WARN                /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/pbtest1_im.fits is not a valid or readable table
04-Jun-2024 23:32:12 2024-06-05 03:32:12        SEVERE                Cannot read image /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/pbtest1_im.fits to get region bogus_region
04-Jun-2024 23:32:12 2024-06-05 03:32:12        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Unable to open region file or region table description bogus_region in image /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/pbtest1_im.fits at File: /source/casa6/casatools/src/code/imageanalysis/Regions/CasacRegionManager.cc, line: 486
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:12        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Unknown mode zz
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:12        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Coordinate systems of image and template are different: The DirectionCoordinates have differing LinearXform components at File: /source/casa6/casatools/src/code/imageanalysis/ImageAnalysis/ImagePrimaryBeamCorrector.cc, line: 141
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        name::        No table opened.
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        showcache::        The Table Cache is empty.
04-Jun-2024 23:32:12 test_tool_image_pbcor.py::ia_pbcor_test::test_exceptions
04-Jun-2024 23:32:12 ia.pbcor: Test various exception cases
04-Jun-2024 23:32:12 PASSED
04-Jun-2024 23:32:12
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        name::        No table opened.
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        showcache::        The Table Cache is empty.
04-Jun-2024 23:32:12 test_tool_image_pbcor.py::ia_pbcor_test::test_full_image_divide
04-Jun-2024 23:32:12 ia.pbcor: Test full image divide
04-Jun-2024 23:32:12 PASSED
04-Jun-2024 23:32:12
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        name::        No table opened.
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        showcache::        The Table Cache is empty.
04-Jun-2024 23:32:12 test_tool_image_pbcor.py::ia_pbcor_test::test_full_image_using_cutoff
04-Jun-2024 23:32:12 ia.pbcor: Test full image divide with cutoff
04-Jun-2024 23:32:12 PASSED
04-Jun-2024 23:32:12
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ImageFactory::createImage        Created Paged image 'zz.im' of shape [20, 20] with float valued pixels.
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        SubImageFactory::createImage        Creating image 'pb_out.im' of shape [20, 20]
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ::::ImageFactory::createImage        Created Paged image 'zz.im' of shape [20, 20] with float valued pixels.
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ::::image::fromshape        Ran ia.fromshape
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ::::image::fromshape        ia.fromshape(outfile="zz.im", shape=[20,20], csys={...}, linear=false, overwrite=false, log=true, type="f")
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ::::image::pbcor        Ran ia.pbcor
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ::::image::pbcor        ia.pbcor(pbimage="(...)", outfile="pb_out.im", overwrite=false, box="", region={...}, chans="", stokes="", mask="", mode="divide", cutoff=-1.000000, stretch=false)
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        name::        No table opened.
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        showcache::        The Table Cache is empty.
04-Jun-2024 23:32:12 test_tool_image_pbcor.py::ia_pbcor_test::test_history
04-Jun-2024 23:32:12 Test history records are written
04-Jun-2024 23:32:12 PASSED
04-Jun-2024 23:32:12
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:12        INFO        ImageFactory::createImage        Created Paged image 'mult_pb.im' of shape [113, 76] with float valued pixels.
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 0, 0]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, I)
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        ImageRegion::fromRecord        Selected bounding box :
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        name::        No table opened.
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        showcache::        The Table Cache is empty.
04-Jun-2024 23:32:12 test_tool_image_pbcor.py::ia_pbcor_test::test_multiply
04-Jun-2024 23:32:12 ia.pbcor: Test full image multiply with cutoff. Primary beam is 2 D, image is 4 D
04-Jun-2024 23:32:12 PASSED
04-Jun-2024 23:32:12
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        ImageFactory::createImage        Created Temp image  of shape [113, 76, 1, 1] with float valued pixels.
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        SubImageFactory::createImage        Creating image 'maskim' of shape [113, 76, 1, 1]
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:13        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: The input image shape ([113, 76, 5, 2]) and mask shape ([113, 76, 1, 1]) are different, and it was specified that the mask should not be extended, so the mask cannot be applied to the (sub)image. Specifying that the mask should be extended may resolve the issue at File: /source/casainstall/include/casacpp/imageanalysis/ImageAnalysis/SubImageFactory.tcc, line: 306
04-Jun-2024 23:32:12 2024-06-05 03:32:13        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        SubImageFactory::createImage        Creating image 'blahblah' of shape [113, 76, 5, 2]
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        name::        No table opened.
04-Jun-2024 23:32:12 2024-06-05 03:32:13        INFO        showcache::        The Table Cache is empty.
04-Jun-2024 23:32:12 test_tool_image_pbcor.py::ia_pbcor_test::test_stretch
04-Jun-2024 23:32:12 ia.pbcor(): Test stretch parameter
04-Jun-2024 23:32:12 PASSED
04-Jun-2024 23:32:12
04-Jun-2024 23:32:12 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_pbcor/nose.xml -
04-Jun-2024 23:32:12 ========================= 9 passed, 1 warning in 2.13s =========================
04-Jun-2024 23:32:13 ============================= test session starts ==============================
04-Jun-2024 23:32:13 platform linux -- Python 3.8.7, pytest-8.2.2, pluggy-1.5.0 -- /home/casatest/venv/bin/python3.8
04-Jun-2024 23:32:13 cachedir: .pytest_cache
04-Jun-2024 23:32:13 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_linearmosaic
04-Jun-2024 23:32:13 configfile: pytest.ini
04-Jun-2024 23:32:13 collecting ... collected 5 items
04-Jun-2024 23:32:13
04-Jun-2024 23:32:13
04-Jun-2024 23:32:14 2024-06-05 03:32:15        WARN        ImageRegrid::regrid        You are regridding an image whose beam is not well sampled by the pixel size.  Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
04-Jun-2024 23:32:16 2024-06-05 03:32:17        WARN        ImageRegrid::regrid        You are regridding an image whose beam is not well sampled by the pixel size.  Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
04-Jun-2024 23:32:17 test_tool_linearmosaic.py::test_tool_linearmosaic::test_flat_noise
04-Jun-2024 23:32:17 test_flat_noise (flat noise type with flat noise input)
04-Jun-2024 23:32:17 PASSED
04-Jun-2024 23:32:17
04-Jun-2024 23:32:17 2024-06-05 03:32:18        WARN        ImageRegrid::regrid        You are regridding an image whose beam is not well sampled by the pixel size.  Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
04-Jun-2024 23:32:18 test_tool_linearmosaic.py::test_tool_linearmosaic::test_flat_noise_existing_image
04-Jun-2024 23:32:18 test_flat_noise_existing image (flat noise type onto an existing image)
04-Jun-2024 23:32:18 PASSED
04-Jun-2024 23:32:18
04-Jun-2024 23:32:21 test_tool_linearmosaic.py::test_tool_linearmosaic::test_flat_noise_flat_sky_input
04-Jun-2024 23:32:21 test_flat_noise_flat_sky_input (flat noise type with flat sky input)
04-Jun-2024 23:32:21 PASSED
04-Jun-2024 23:32:21
04-Jun-2024 23:32:24 test_tool_linearmosaic.py::test_tool_linearmosaic::test_flat_sky
04-Jun-2024 23:32:24 test_flat_sky (flat sky type with flat noise input
04-Jun-2024 23:32:24 PASSED
04-Jun-2024 23:32:24
04-Jun-2024 23:32:28 test_tool_linearmosaic.py::test_tool_linearmosaic::test_flat_sky_flat_sky_input
04-Jun-2024 23:32:28 test_flat_sky_flat_sky_input (flat sky type with flat sky inputs)
04-Jun-2024 23:32:28 PASSED
04-Jun-2024 23:32:28
04-Jun-2024 23:32:28 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_linearmosaic/nose.xml -
04-Jun-2024 23:32:28 ======================== 5 passed, 1 warning in 15.19s =========================
04-Jun-2024 23:32:28 ============================= test session starts ==============================
04-Jun-2024 23:32:28 platform linux -- Python 3.8.7, pytest-8.2.2, pluggy-1.5.0 -- /home/casatest/venv/bin/python3.8
04-Jun-2024 23:32:28 cachedir: .pytest_cache
04-Jun-2024 23:32:28 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_createmultims
04-Jun-2024 23:32:28 configfile: pytest.ini
04-Jun-2024 23:32:29 collecting ... collected 1 item
04-Jun-2024 23:32:29
04-Jun-2024 23:32:29
04-Jun-2024 23:32:31 2024-06-05 03:32:32        INFO        ms::createmultims        Copying subtables from part1.ms to the other MMS members.
04-Jun-2024 23:32:37 2024-06-05 03:32:38        INFO        name::        No table opened.
04-Jun-2024 23:32:37 2024-06-05 03:32:38        INFO        name::        No table opened.
04-Jun-2024 23:32:38 test_tool_ms_createmultims.py::test_createmultims::test1
04-Jun-2024 23:32:38 Test_createmultims 1: 4 parts, same sources but different spws
04-Jun-2024 23:32:38 Copying part1.ms
04-Jun-2024 23:32:38 Copying part2-mod.ms
04-Jun-2024 23:32:38 Copying part2-mod2.ms
04-Jun-2024 23:32:38 Copying part2.ms
04-Jun-2024 23:32:38 Copying part3.ms
04-Jun-2024 23:32:38 Copying part4.ms
04-Jun-2024 23:32:38 PASSED
04-Jun-2024 23:32:38
04-Jun-2024 23:32:38 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_ms_createmultims/nose.xml -
04-Jun-2024 23:32:38 ========================= 1 passed, 1 warning in 9.29s =========================
04-Jun-2024 23:32:38 ============================= test session starts ==============================
04-Jun-2024 23:32:38 platform linux -- Python 3.8.7, pytest-8.2.2, pluggy-1.5.0 -- /home/casatest/venv/bin/python3.8
04-Jun-2024 23:32:38 cachedir: .pytest_cache
04-Jun-2024 23:32:38 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_simulator
04-Jun-2024 23:32:38 configfile: pytest.ini
04-Jun-2024 23:32:38 collecting ... collected 2 items
04-Jun-2024 23:32:38
04-Jun-2024 23:32:38
04-Jun-2024 23:32:39 2024-06-05 03:32:40        INFO        NewMSSimulator::NewMSSimulator(MeasurementSet& theMS)         Opening MeasurementSet /home/casatest/casa6/casatestutils/nosedir/test_tool_simulator/settrop_split_ant_spw_copy.ms with 15990 rows
04-Jun-2024 23:32:39 2024-06-05 03:32:40        INFO        NewMSSimulator::NewMSSimulator(MeasurementSet& theMS)            last spectral window ID = 1
04-Jun-2024 23:32:39 2024-06-05 03:32:40        INFO        Simulator::create_corrupt()         Creating TF Calibration structure for data corruption.
04-Jun-2024 23:32:39 2024-06-05 03:32:40        INFO        SVC::sizeUpSim()         For simint = 0.1s, found 60 solution intervals.
04-Jun-2024 23:32:39 2024-06-05 03:32:40        INFO        T::createCorruptor()          PWV fluctuations = 0.15 of mean PWV which is 3mm
04-Jun-2024 23:32:39 2024-06-05 03:32:40        INFO        AtmCorr::initAtm         Initializing ATM
04-Jun-2024 23:32:39 2024-06-05 03:32:40        INFO        AtmCorr::initAtm         altitude=5000m, Pground=560mb, Tground=270K, humidity= 20%, water scale height=2000m
04-Jun-2024 23:32:39 2024-06-05 03:32:40        INFO        AtmCorr::initAtm         Spectral window 230(ch 64/128)
04-Jun-2024 23:32:40 2024-06-05 03:32:40        INFO        AtmCorr::initAtm         After setting WH2O to 3
04-Jun-2024 23:32:40 2024-06-05 03:32:40        INFO        AtmCorr::initAtm         Dry and Wet Opacity from RefractiveIndexProfile = 0.0108571, 0.12934 at 230 GHz (ch64)
04-Jun-2024 23:32:40 2024-06-05 03:32:40        INFO        AtmCorr::initAtm         Dry and Wet Opacity from SkyStatus              = 0.0108571, 0.12934
04-Jun-2024 23:32:40 2024-06-05 03:32:40        INFO        AtmCorr::initAtm         Sky plus ground and CMB Brightness Temp across Spw 0, for spill=0.85 Tground=270 pwv=3
04-Jun-2024 23:32:40 2024-06-05 03:32:40        INFO        AtmCorr::initAtm          Zenith Tebb[229,230,230.984]=[73.1745,73.4238,74.3213]
04-Jun-2024 23:32:40 2024-06-05 03:32:40        INFO        AtmCorr::init(Seed,Beta,Scale,AntCols)         creating new fBM of size 245,205 (may take a few minutes) ...
04-Jun-2024 23:32:40 2024-06-05 03:32:40        INFO        SVC[Tf Jones]::setSimulate()         Calculating corruption terms for simulated Tf Jones: output table=settrop_table simint=0.1s t=0.1
04-Jun-2024 23:32:41 2024-06-05 03:32:42        INFO        SVC[Tf Jones]::setSimulate()         Writing calTable = settrop_table (Tf Jones)
04-Jun-2024 23:32:41 2024-06-05 03:32:42        INFO                Writing solutions to table: settrop_table
04-Jun-2024 23:32:41 2024-06-05 03:32:42        INFO        Simulator::corrupt()         Doing visibility corruption.
04-Jun-2024 23:32:41 2024-06-05 03:32:42        INFO        Simulator::corrupt()         simulated Tf Jones: output table=settrop_table simint=0.1s t=0spwok = [1] in corrupt mode.
04-Jun-2024 23:32:42 2024-06-05 03:32:42        INFO        Simulator::reset()         Resetting all visibility corruption components
04-Jun-2024 23:32:42 2024-06-05 03:32:42        INFO        Simulator::reset()         Reset all image-plane corruption components
04-Jun-2024 23:32:42 test_tool_simulator.py::sm_settrop_test::test_smsettrop
04-Jun-2024 23:32:42 PASSED
04-Jun-2024 23:32:42
04-Jun-2024 23:32:42 2024-06-05 03:32:42        INFO        NewMSSimulator::initAnt()         Using global coordinates for the antennas
04-Jun-2024 23:32:42 2024-06-05 03:32:42        INFO        NewMSSimulator::initAnt()         Added rows to ANTENNA table
04-Jun-2024 23:32:42 2024-06-05 03:32:42        INFO        MSsimulator::initFeeds()         Added rows to FEED table
04-Jun-2024 23:32:42 2024-06-05 03:32:42        INFO        MSsimulator::initSpWindows()         Creating new spectral window LBand, ID 1
04-Jun-2024 23:32:42 2024-06-05 03:32:42        INFO        simulator::settimes()        Times
04-Jun-2024 23:32:42 2024-06-05 03:32:42        INFO        simulator::settimes()+             Integration time 2000s
04-Jun-2024 23:32:42 2024-06-05 03:32:42        INFO        simulator::settimes()             Times will be interpreted as hour angles for first source
04-Jun-2024 23:32:42 2024-06-05 03:32:42        INFO        NewMSSimulator::observe()        First source: fake @ 19:53:50.00   +40.06.00.00       J2000
04-Jun-2024 23:32:42 2024-06-05 03:32:42        INFO        NewMSSimulator::observe()+        Full time range: 03-Oct-2019/21:16:01.8 -- 04-Oct-2019/07:16:01.8 TAI with int = 2000
04-Jun-2024 23:32:42 2024-06-05 03:32:42        INFO        NewMSSimulator::observe()        Calculating a total of 18 integrations
04-Jun-2024 23:32:42 2024-06-05 03:32:43        INFO        Simulator::reset()         Resetting all visibility corruption components
04-Jun-2024 23:32:42 2024-06-05 03:32:43        INFO        Simulator::reset()         Reset all image-plane corruption components
04-Jun-2024 23:32:42 2024-06-05 03:32:43        INFO        AgentFlagger::open        Table type is Measurement Set
04-Jun-2024 23:32:42 2024-06-05 03:32:43        INFO        AgentFlagger::initAgents        There are initially 1 agents in the list. Agents: unflag
04-Jun-2024 23:32:42 2024-06-05 03:32:43        INFO        AgentFlagger::initAgents        There are 1 valid agents in the list. Agents: unflag
04-Jun-2024 23:32:42 2024-06-05 03:32:43        INFO        FlagMSHandler::        Chunk = 1 [progress: 100%], Observation = 0, Array = 0, Scan = 1, Field = 0 (fake), Spw = 0, Channels = 5, Corrs = [ RR LL ], Total Rows = 6318
04-Jun-2024 23:32:42 2024-06-05 03:32:43        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (63180/63180)
04-Jun-2024 23:32:42 2024-06-05 03:32:43        INFO        FlagMSHandler::nextChunk         ====================================================================================
04-Jun-2024 23:32:42 2024-06-05 03:32:43        INFO        Unflag::tableSummary        => Percentage of data un-flagged in table selection: 100%
04-Jun-2024 23:32:42 2024-06-05 03:32:43        INFO        AgentFlagger::run        => Writing flags to the MS
04-Jun-2024 23:32:42 2024-06-05 03:32:43        INFO        NewMSSimulator::NewMSSimulator(MeasurementSet& theMS)         Opening MeasurementSet /home/casatest/casa6/casatestutils/nosedir/test_tool_simulator/myms.ms with 6318 rows
04-Jun-2024 23:32:42 2024-06-05 03:32:43        INFO        NewMSSimulator::NewMSSimulator(MeasurementSet& theMS)            last spectral window ID = 1
04-Jun-2024 23:32:42 2024-06-05 03:32:43        INFO        Simulator::predict()         Predicting visibilities using model: [] and componentList: mycomplist.cl
04-Jun-2024 23:32:42 2024-06-05 03:32:43        INFO        Simulator::predict()         The data column will be replaced
04-Jun-2024 23:32:42 2024-06-05 03:32:43        INFO        Simulator::getVPRecord         Using default Voltage Patterns from the VPManager
04-Jun-2024 23:32:42 2024-06-05 03:32:43        INFO        Simulator::getVPRecord         Temporary alert : The state of the vpmanager tool has been modified by loading these primary beam models. If any of your scripts rely on the vpmanager state being preserved throughout your CASA session, please use vp.saveastable() and vp.loadfromtable() as needed.
04-Jun-2024 23:32:42 2024-06-05 03:32:43        INFO        Simulator::createSkyEquation()         Synthesis gridding
04-Jun-2024 23:32:42 2024-06-05 03:32:43        INFO        Simulator::createSkyEquation()         Fourier transforms will use image centers as tangent points
04-Jun-2024 23:32:42 2024-06-05 03:32:43        INFO        Simulator::reset()         Resetting all visibility corruption components
04-Jun-2024 23:32:42 2024-06-05 03:32:43        INFO        Simulator::reset()         Reset all image-plane corruption components
04-Jun-2024 23:32:42 test_tool_simulator.py::sm_predict_test::test_plp
04-Jun-2024 23:32:42 CAS-13439 verify support for plp, spectral curvature model
04-Jun-2024 23:32:42 PASSED
04-Jun-2024 23:32:42
04-Jun-2024 23:32:42 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_simulator/nose.xml -
04-Jun-2024 23:32:42 ========================= 2 passed, 1 warning in 4.36s =========================
04-Jun-2024 23:32:43 ============================= test session starts ==============================
04-Jun-2024 23:32:43 platform linux -- Python 3.8.7, pytest-8.2.2, pluggy-1.5.0 -- /home/casatest/venv/bin/python3.8
04-Jun-2024 23:32:43 cachedir: .pytest_cache
04-Jun-2024 23:32:43 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_statistics
04-Jun-2024 23:32:43 configfile: pytest.ini
04-Jun-2024 23:32:43 collecting ... collected 11 items
04-Jun-2024 23:32:43
04-Jun-2024 23:32:43
04-Jun-2024 23:32:43 2024-06-05 03:32:44        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
04-Jun-2024 23:32:43 2024-06-05 03:32:44        INFO        name::        No table opened.
04-Jun-2024 23:32:43 2024-06-05 03:32:44        INFO        showcache::        The Table Cache is empty.
04-Jun-2024 23:32:43 test_tool_image_statistics.py::ia_statistics_test::test_CAS_2195_image_can_have_linear_rather_than_direction_coordinate
04-Jun-2024 23:32:43 verify fix for CAS-2195, image has linear, not direction, coordinate
04-Jun-2024 23:32:43 PASSED
04-Jun-2024 23:32:43
04-Jun-2024 23:32:50 ....10....20....30....40....50....60....70....80....90....100%
04-Jun-2024 23:32:58 2024-06-05 03:32:59        INFO        name::        No table opened.
04-Jun-2024 23:32:58 2024-06-05 03:32:59        INFO        showcache::        The Table Cache is empty.
04-Jun-2024 23:32:58 test_tool_image_statistics.py::ia_statistics_test::test_biweight
04-Jun-2024 23:32:58 Test biweight algorithm CAS-11100
04-Jun-2024 23:32:58 PASSED
04-Jun-2024 23:32:58
04-Jun-2024 23:32:58 2024-06-05 03:32:59        INFO        ImageFactory::createImage        Created Paged image 'chauvtest.im' of shape [107] with float valued pixels.
04-Jun-2024 23:32:58 2024-06-05 03:32:59        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
04-Jun-2024 23:32:58 2024-06-05 03:32:59        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
04-Jun-2024 23:32:58 2024-06-05 03:32:59        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
04-Jun-2024 23:32:58 2024-06-05 03:32:59        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
04-Jun-2024 23:32:58 2024-06-05 03:32:59        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
04-Jun-2024 23:32:58 2024-06-05 03:32:59        INFO        name::        No table opened.
04-Jun-2024 23:32:58 2024-06-05 03:32:59        INFO        showcache::        The Table Cache is empty.
04-Jun-2024 23:32:58 test_tool_image_statistics.py::ia_statistics_test::test_chauvenet
04-Jun-2024 23:32:58 Test Chauvenet's criterion algorithm
04-Jun-2024 23:32:58 PASSED
04-Jun-2024 23:32:58
04-Jun-2024 23:32:58 2024-06-05 03:32:59        INFO        ImageFactory::createImage        Created Paged image 'fhtest.im' of shape [100] with float valued pixels.
04-Jun-2024 23:32:58 2024-06-05 03:32:59        INFO        name::        No table opened.
04-Jun-2024 23:32:58 2024-06-05 03:32:59        INFO        showcache::        The Table Cache is empty.
04-Jun-2024 23:32:58 test_tool_image_statistics.py::ia_statistics_test::test_fithalf
04-Jun-2024 23:32:58 Test fit to half algorithm
04-Jun-2024 23:32:58 PASSED
04-Jun-2024 23:32:58
04-Jun-2024 23:32:58 2024-06-05 03:32:59        INFO        ImageFactory::createImage        Created Paged image 'hftest.im' of shape [100] with float valued pixels.
04-Jun-2024 23:32:58 2024-06-05 03:32:59        INFO        name::        No table opened.
04-Jun-2024 23:32:58 2024-06-05 03:32:59        INFO        showcache::        The Table Cache is empty.
04-Jun-2024 23:32:58 test_tool_image_statistics.py::ia_statistics_test::test_hingesfences
04-Jun-2024 23:32:58 Test hinges-fences algorithm
04-Jun-2024 23:32:58 PASSED
04-Jun-2024 23:32:58
04-Jun-2024 23:32:58 2024-06-05 03:32:59        INFO        ImageFactory::createImage        Created Paged image 'internally_excluded_region.im' of shape [100, 200, 110, 4] with float valued pixels.
04-Jun-2024 23:32:59 2024-06-05 03:33:00        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
04-Jun-2024 23:32:59 2024-06-05 03:33:00        INFO        CasacRegionManager::fromBCS        Using channel range(s)
04-Jun-2024 23:32:59 2024-06-05 03:33:00        INFO        CasacRegionManager::fromBCS        Using polarizations IV
04-Jun-2024 23:32:59 2024-06-05 03:33:00        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.
04-Jun-2024 23:32:59 2024-06-05 03:33:00        INFO        name::        No table opened.
04-Jun-2024 23:32:59 2024-06-05 03:33:00        INFO        showcache::        The Table Cache is empty.
04-Jun-2024 23:32:59 test_tool_image_statistics.py::ia_statistics_test::test_internal_region_exclusion
04-Jun-2024 23:32:59 Verify data not returned for internally excluded regions
04-Jun-2024 23:32:59 PASSED
04-Jun-2024 23:32:59
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        name::        No table opened.
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        showcache::        The Table Cache is empty.
04-Jun-2024 23:33:00 test_tool_image_statistics.py::ia_statistics_test::test_logfile_param
04-Jun-2024 23:33:00 test logfile 
04-Jun-2024 23:33:00 i 1
04-Jun-2024 23:33:00 i 2
04-Jun-2024 23:33:00 PASSED
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary        
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        Image name       : moment_map.im
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        Object name      : G11.92
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        Image type       : PagedImage
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        Image quantity   : Intensity
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        Pixel mask(s)    : mask0
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        Region(s)        : None
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        Image units      : Jy/beam.km/s
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        Restoring Beam   : 3.15627 arcsec, 1.80243 arcsec, 58.3141 deg
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary        
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        Direction reference : J2000
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        Spectral  reference : LSRK
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        Velocity  type      : RADIO
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        Rest frequency      : 2.30538e+11 Hz
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        Pointing center     :  18:13:58.097081  -18.54.16.695951
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        Telescope           : SMA
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        Observer            : SMA
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        Date observation    : 2008/06/23/00:00:00.000000
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        Axis Coord Type      Name             Proj Shape Tile   Coord value at pixel      Coord incr Units
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        --------------------------------------------------------------------------------------------------
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        0    0     Direction Right Ascension   SIN   256  256  18:13:58.097   128.00   -4.000000e-01 arcsec
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        1    0     Direction Declination       SIN   256  256 -18.54.16.696   128.00    4.000000e-01 arcsec
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        2    1     Stokes    Stokes                    1    1             I
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+        3    2     Spectral  Frequency                 1    1   2.30392e+11   -37.00 2.536257562e+06 Hz
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageMetaData::summary+                             Velocity                               189.963   -37.00   -3.298159e+00 km/s
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        name::        No table opened.
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        showcache::        The Table Cache is empty.
04-Jun-2024 23:33:00 test_tool_image_statistics.py::ia_statistics_test::test_moment_map_flux
04-Jun-2024 23:33:00 Test 1: verify moment maps can have flux densities computed in statistics
04-Jun-2024 23:33:00 PASSED
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageFactory::createImage        Created Paged image 'test011.im' of shape [10, 10, 10] with float valued pixels.
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        CasacRegionManager::fromBCS        Using specified box(es) 0, 0, 2, 2, 4, 4, 6, 6
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        name::        No table opened.
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        showcache::        The Table Cache is empty.
04-Jun-2024 23:33:00 test_tool_image_statistics.py::ia_statistics_test::test_multiple_region_support
04-Jun-2024 23:33:00 test multiple region support
04-Jun-2024 23:33:00 PASSED
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        name::        No table opened.
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        showcache::        The Table Cache is empty.
04-Jun-2024 23:33:00 test_tool_image_statistics.py::ia_statistics_test::test_specifying_axes_param
04-Jun-2024 23:33:00 choose axes works
04-Jun-2024 23:33:00 PASSED
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageFactory::createImage        Created Paged image 'maskim' of shape [200, 200, 1, 1] with float valued pixels.
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        ImageFactory::createImage        Created Paged image 'tmp.im' of shape [200, 200, 1, 20] with float valued pixels.
04-Jun-2024 23:33:00 2024-06-05 03:33:00        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
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        name::        No table opened.
04-Jun-2024 23:33:00 2024-06-05 03:33:00        INFO        showcache::        The Table Cache is empty.
04-Jun-2024 23:33:00 test_tool_image_statistics.py::ia_statistics_test::test_stretch
04-Jun-2024 23:33:00 Test stretch parameter
04-Jun-2024 23:33:00 PASSED
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_statistics/nose.xml -
04-Jun-2024 23:33:00 ======================== 11 passed, 1 warning in 17.32s ========================
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_fitprofile/
04-Jun-2024 23:33:00 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_fitprofile
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_fitprofile/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_fitprofile/
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_collapse/
04-Jun-2024 23:33:00 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_collapse
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_collapse/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_collapse/
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_deviation/
04-Jun-2024 23:33:00 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_deviation
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 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/
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms/
04-Jun-2024 23:33:00 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_ms/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_ms/
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_sdm_toms/
04-Jun-2024 23:33:00 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_sdm_toms
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_sdm_toms/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_sdm_toms/
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msmetadata/
04-Jun-2024 23:33:00 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msmetadata
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_msmetadata/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_msmetadata/
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_measures/
04-Jun-2024 23:33:00 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_measures
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_measures/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_measures/
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_componentlist/
04-Jun-2024 23:33:00 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_componentlist
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_componentlist/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_componentlist/
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_logsink/
04-Jun-2024 23:33:00 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_logsink
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 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/
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_regrid/
04-Jun-2024 23:33:00 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_regrid
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_regrid/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_regrid/
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_quanta/
04-Jun-2024 23:33:00 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_quanta
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_quanta/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_quanta/
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/
04-Jun-2024 23:33:00 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 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/
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/
04-Jun-2024 23:33:00 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_pbcor/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_linearmosaic/
04-Jun-2024 23:33:00 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_linearmosaic
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_linearmosaic/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_linearmosaic/
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_createmultims/
04-Jun-2024 23:33:00 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_createmultims
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 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/
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_simulator/
04-Jun-2024 23:33:00 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_simulator
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 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/
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_statistics/
04-Jun-2024 23:33:00 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_statistics
04-Jun-2024 23:33:00
04-Jun-2024 23:33:00 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_statistics/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_statistics/
04-Jun-2024 23:33:02 total 185716
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci 15001    113351 Jun  5 03:17 casatestutils-6.6.1.14a14360.dev2-py3-none-any.whl
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci 15001 189886736 Jun  5 03:18 casatools-6.6.1.14a14360.dev2-cp38-cp38-manylinux_2_28_x86_64.whl
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root       4314 Jun  5 03:33 test_tool_agentflagger.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root        980 Jun  5 03:33 test_tool_calanalysis.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root       2631 Jun  5 03:33 test_tool_calibrater.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root        545 Jun  5 03:33 test_tool_componentlist.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root       7441 Jun  5 03:33 test_tool_coordsys.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root      12801 Jun  5 03:33 test_tool_image.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root       2194 Jun  5 03:33 test_tool_image_collapse.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root       1022 Jun  5 03:33 test_tool_image_deviation.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root       2549 Jun  5 03:33 test_tool_image_fitprofile.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root       1152 Jun  5 03:33 test_tool_image_pbcor.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root        857 Jun  5 03:33 test_tool_image_pv.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root        980 Jun  5 03:33 test_tool_image_rebin.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root       1310 Jun  5 03:33 test_tool_image_regrid.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root       1507 Jun  5 03:33 test_tool_image_statistics.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root        739 Jun  5 03:33 test_tool_image_subimage.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root        864 Jun  5 03:33 test_tool_image_transpose.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root       1940 Jun  5 03:33 test_tool_imagepol.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root        813 Jun  5 03:33 test_tool_linearmosaic.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root        642 Jun  5 03:33 test_tool_logsink.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root        523 Jun  5 03:33 test_tool_measures.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root       5198 Jun  5 03:33 test_tool_ms.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root        341 Jun  5 03:33 test_tool_ms_createmultims.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root       2069 Jun  5 03:33 test_tool_ms_statwt.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root       8486 Jun  5 03:33 test_tool_msmetadata.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root        333 Jun  5 03:33 test_tool_msuvbinner.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root       1145 Jun  5 03:33 test_tool_quanta.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root       3951 Jun  5 03:33 test_tool_regionmanager.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root       2046 Jun  5 03:33 test_tool_sdm.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root       2070 Jun  5 03:33 test_tool_sdm_toms.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root        422 Jun  5 03:33 test_tool_simulator.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root       1337 Jun  5 03:33 test_tool_table.xml
04-Jun-2024 23:33:02 -rw-r--r-- 1 casaci root       1691 Jun  5 03:33 test_tool_vpmanager.xml
04-Jun-2024 23:33:02 Finished task 'Test wheel' with result: Success
04-Jun-2024 23:33:02 Starting task 'Tar work directory' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
04-Jun-2024 23:33:02
Beginning to execute external process for build 'CASA - CMake Dev Test - CAS-14360 - Test Tools Many Linux 2.28 #3 (CASA-CMDT178-TTOMLPY38-3)'
... running command line:
/export/home/cbt-el7-1/bamboo-home/temp/CASA-CMDT178-TTOMLPY38-3-ScriptBuildTask-5443866852239855732.sh
... in: /export/home/cbt-el7-1/bamboo-home/xml-data/build-dir/CASA-CMDT178-TTOMLPY38
04-Jun-2024 23:33:02 Package working directory
04-Jun-2024 23:33:03 tar: work: Cannot stat: No such file or directory
04-Jun-2024 23:33:03 tar: Exiting with failure status due to previous errors
04-Jun-2024 23:33:03 total 185720
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci 15001    113351 Jun  5 03:17 casatestutils-6.6.1.14a14360.dev2-py3-none-any.whl
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci 15001 189886736 Jun  5 03:18 casatools-6.6.1.14a14360.dev2-cp38-cp38-manylinux_2_28_x86_64.whl
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root       4314 Jun  5 03:33 test_tool_agentflagger.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root        980 Jun  5 03:33 test_tool_calanalysis.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root       2631 Jun  5 03:33 test_tool_calibrater.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root        545 Jun  5 03:33 test_tool_componentlist.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root       7441 Jun  5 03:33 test_tool_coordsys.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root      12801 Jun  5 03:33 test_tool_image.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root       2194 Jun  5 03:33 test_tool_image_collapse.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root       1022 Jun  5 03:33 test_tool_image_deviation.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root       2549 Jun  5 03:33 test_tool_image_fitprofile.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root       1152 Jun  5 03:33 test_tool_image_pbcor.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root        857 Jun  5 03:33 test_tool_image_pv.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root        980 Jun  5 03:33 test_tool_image_rebin.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root       1310 Jun  5 03:33 test_tool_image_regrid.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root       1507 Jun  5 03:33 test_tool_image_statistics.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root        739 Jun  5 03:33 test_tool_image_subimage.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root        864 Jun  5 03:33 test_tool_image_transpose.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root       1940 Jun  5 03:33 test_tool_imagepol.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root        813 Jun  5 03:33 test_tool_linearmosaic.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root        642 Jun  5 03:33 test_tool_logsink.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root        523 Jun  5 03:33 test_tool_measures.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root       5198 Jun  5 03:33 test_tool_ms.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root        341 Jun  5 03:33 test_tool_ms_createmultims.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root       2069 Jun  5 03:33 test_tool_ms_statwt.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root       8486 Jun  5 03:33 test_tool_msmetadata.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root        333 Jun  5 03:33 test_tool_msuvbinner.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root       1145 Jun  5 03:33 test_tool_quanta.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root       3951 Jun  5 03:33 test_tool_regionmanager.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root       2046 Jun  5 03:33 test_tool_sdm.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root       2070 Jun  5 03:33 test_tool_sdm_toms.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root        422 Jun  5 03:33 test_tool_simulator.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root       1337 Jun  5 03:33 test_tool_table.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root       1691 Jun  5 03:33 test_tool_vpmanager.xml
04-Jun-2024 23:33:03 -rw-r--r-- 1 casaci root         45 Jun  5 03:33 work-el7-3.8.tar.gz
04-Jun-2024 23:33:03 Done packaging working directory
04-Jun-2024 23:33:03 Finished task 'Tar work directory' with result: Success
04-Jun-2024 23:33:03 Starting task 'Parse tests' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
04-Jun-2024 23:33:03 Parsing test results under /export/home/cbt-el7-1/bamboo-home/xml-data/build-dir/CASA-CMDT178-TTOMLPY38...
04-Jun-2024 23:33:03 Finished task 'Parse tests' with result: Success
04-Jun-2024 23:33:03
Substituting variable: ${bamboo.repository.branch.name} with CAS-14360
04-Jun-2024 23:33:03 Starting task 'Upload wheel' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
04-Jun-2024 23:33:03
Beginning to execute external process for build 'CASA - CMake Dev Test - CAS-14360 - Test Tools Many Linux 2.28 #3 (CASA-CMDT178-TTOMLPY38-3)'
... running command line:
/export/home/cbt-el7-1/bamboo-home/temp/CASA-CMDT178-TTOMLPY38-3-ScriptBuildTask-1915337274927125901.sh
... in: /export/home/cbt-el7-1/bamboo-home/xml-data/build-dir/CASA-CMDT178-TTOMLPY38
04-Jun-2024 23:33:06 Collecting twine
04-Jun-2024 23:33:06   Downloading twine-5.1.0-py3-none-any.whl (38 kB)
04-Jun-2024 23:33:06 Collecting pkginfo>=1.8.1
04-Jun-2024 23:33:06   Downloading pkginfo-1.11.0-py3-none-any.whl (31 kB)
04-Jun-2024 23:33:06 Collecting keyring>=15.1
04-Jun-2024 23:33:06   Downloading keyring-25.2.1-py3-none-any.whl (38 kB)
04-Jun-2024 23:33:06 Collecting readme-renderer>=35.0
04-Jun-2024 23:33:06   Downloading readme_renderer-43.0-py3-none-any.whl (13 kB)
04-Jun-2024 23:33:06 Collecting requests-toolbelt!=0.9.0,>=0.8.0
04-Jun-2024 23:33:06   Downloading requests_toolbelt-1.0.0-py2.py3-none-any.whl (54 kB)
04-Jun-2024 23:33:06      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 54.5/54.5 KB 10.9 MB/s eta 0:00:00
04-Jun-2024 23:33:06 Collecting rfc3986>=1.4.0
04-Jun-2024 23:33:06   Downloading rfc3986-2.0.0-py2.py3-none-any.whl (31 kB)
04-Jun-2024 23:33:06 Collecting urllib3>=1.26.0
04-Jun-2024 23:33:06   Downloading urllib3-2.2.1-py3-none-any.whl (121 kB)
04-Jun-2024 23:33:06      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 121.1/121.1 KB 17.0 MB/s eta 0:00:00
04-Jun-2024 23:33:06 Collecting requests>=2.20
04-Jun-2024 23:33:06   Downloading requests-2.32.3-py3-none-any.whl (64 kB)
04-Jun-2024 23:33:06      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.9/64.9 KB 12.8 MB/s eta 0:00:00
04-Jun-2024 23:33:06 Collecting rich>=12.0.0
04-Jun-2024 23:33:06   Downloading rich-13.7.1-py3-none-any.whl (240 kB)
04-Jun-2024 23:33:06      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 240.7/240.7 KB 25.7 MB/s eta 0:00:00
04-Jun-2024 23:33:07 Collecting importlib-metadata>=3.6
04-Jun-2024 23:33:07   Downloading importlib_metadata-7.1.0-py3-none-any.whl (24 kB)
04-Jun-2024 23:33:07 Collecting zipp>=0.5
04-Jun-2024 23:33:07   Downloading zipp-3.19.2-py3-none-any.whl (9.0 kB)
04-Jun-2024 23:33:07 Collecting SecretStorage>=3.2
04-Jun-2024 23:33:07   Downloading SecretStorage-3.3.3-py3-none-any.whl (15 kB)
04-Jun-2024 23:33:07 Collecting jeepney>=0.4.2
04-Jun-2024 23:33:07   Downloading jeepney-0.8.0-py3-none-any.whl (48 kB)
04-Jun-2024 23:33:07      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 48.4/48.4 KB 9.6 MB/s eta 0:00:00
04-Jun-2024 23:33:07 Collecting jaraco.context
04-Jun-2024 23:33:07   Downloading jaraco.context-5.3.0-py3-none-any.whl (6.5 kB)
04-Jun-2024 23:33:07 Collecting jaraco.functools
04-Jun-2024 23:33:07   Downloading jaraco.functools-4.0.1-py3-none-any.whl (9.8 kB)
04-Jun-2024 23:33:07 Collecting jaraco.classes
04-Jun-2024 23:33:07   Downloading jaraco.classes-3.4.0-py3-none-any.whl (6.8 kB)
04-Jun-2024 23:33:07 Collecting docutils>=0.13.1
04-Jun-2024 23:33:07   Downloading docutils-0.21.2-py3-none-any.whl (587 kB)
04-Jun-2024 23:33:07      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 587.4/587.4 KB 33.4 MB/s eta 0:00:00
04-Jun-2024 23:33:07 Collecting nh3>=0.2.14
04-Jun-2024 23:33:07   Downloading nh3-0.2.17-cp37-abi3-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (777 kB)
04-Jun-2024 23:33:07      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 777.1/777.1 KB 39.1 MB/s eta 0:00:00
04-Jun-2024 23:33:07 Collecting Pygments>=2.5.1
04-Jun-2024 23:33:07   Downloading pygments-2.18.0-py3-none-any.whl (1.2 MB)
04-Jun-2024 23:33:07      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.2/1.2 MB 33.1 MB/s eta 0:00:00
04-Jun-2024 23:33:07 Collecting certifi>=2017.4.17
04-Jun-2024 23:33:07   Downloading certifi-2024.6.2-py3-none-any.whl (164 kB)
04-Jun-2024 23:33:07      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 164.4/164.4 KB 31.0 MB/s eta 0:00:00
04-Jun-2024 23:33:07 Collecting charset-normalizer<4,>=2
04-Jun-2024 23:33:07   Downloading charset_normalizer-3.3.2-cp310-cp310-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (142 kB)
04-Jun-2024 23:33:08      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 142.1/142.1 KB 28.6 MB/s eta 0:00:00
04-Jun-2024 23:33:08 Collecting idna<4,>=2.5
04-Jun-2024 23:33:08   Downloading idna-3.7-py3-none-any.whl (66 kB)
04-Jun-2024 23:33:08      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.8/66.8 KB 16.7 MB/s eta 0:00:00
04-Jun-2024 23:33:08 Collecting markdown-it-py>=2.2.0
04-Jun-2024 23:33:08   Downloading markdown_it_py-3.0.0-py3-none-any.whl (87 kB)
04-Jun-2024 23:33:08      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 87.5/87.5 KB 20.7 MB/s eta 0:00:00
04-Jun-2024 23:33:08 Collecting mdurl~=0.1
04-Jun-2024 23:33:08   Downloading mdurl-0.1.2-py3-none-any.whl (10.0 kB)
04-Jun-2024 23:33:08 Collecting cryptography>=2.0
04-Jun-2024 23:33:08   Downloading cryptography-42.0.8-cp39-abi3-manylinux_2_28_x86_64.whl (3.9 MB)
04-Jun-2024 23:33:08      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 3.9/3.9 MB 34.5 MB/s eta 0:00:00
04-Jun-2024 23:33:08 Collecting more-itertools
04-Jun-2024 23:33:09   Downloading more_itertools-10.2.0-py3-none-any.whl (57 kB)
04-Jun-2024 23:33:09      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 57.0/57.0 KB 13.5 MB/s eta 0:00:00
04-Jun-2024 23:33:09 Collecting backports.tarfile
04-Jun-2024 23:33:09   Downloading backports.tarfile-1.2.0-py3-none-any.whl (30 kB)
04-Jun-2024 23:33:09 Collecting cffi>=1.12
04-Jun-2024 23:33:09   Downloading cffi-1.16.0-cp310-cp310-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (443 kB)
04-Jun-2024 23:33:09      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 443.9/443.9 KB 31.1 MB/s eta 0:00:00
04-Jun-2024 23:33:09 Collecting pycparser
04-Jun-2024 23:33:09   Downloading pycparser-2.22-py3-none-any.whl (117 kB)
04-Jun-2024 23:33:09      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 117.6/117.6 KB 24.0 MB/s eta 0:00:00
04-Jun-2024 23:33:09 Installing collected packages: nh3, zipp, urllib3, rfc3986, Pygments, pycparser, pkginfo, more-itertools, mdurl, jeepney, idna, docutils, charset-normalizer, certifi, backports.tarfile, requests, readme-renderer, markdown-it-py, jaraco.functools, jaraco.context, jaraco.classes, importlib-metadata, cffi, rich, requests-toolbelt, cryptography, SecretStorage, keyring, twine
04-Jun-2024 23:33:12 Successfully installed Pygments-2.18.0 SecretStorage-3.3.3 backports.tarfile-1.2.0 certifi-2024.6.2 cffi-1.16.0 charset-normalizer-3.3.2 cryptography-42.0.8 docutils-0.21.2 idna-3.7 importlib-metadata-7.1.0 jaraco.classes-3.4.0 jaraco.context-5.3.0 jaraco.functools-4.0.1 jeepney-0.8.0 keyring-25.2.1 markdown-it-py-3.0.0 mdurl-0.1.2 more-itertools-10.2.0 nh3-0.2.17 pkginfo-1.11.0 pycparser-2.22 readme-renderer-43.0 requests-2.32.3 requests-toolbelt-1.0.0 rfc3986-2.0.0 rich-13.7.1 twine-5.1.0 urllib3-2.2.1 zipp-3.19.2
04-Jun-2024 23:33:12 WARNING: Running pip as the 'root' user can result in broken permissions and conflicting behaviour with the system package manager. It is recommended to use a virtual environment instead: https://pip.pypa.io/warnings/venv
04-Jun-2024 23:33:12 WARNING: You are using pip version 22.0.4; however, version 24.0 is available.
04-Jun-2024 23:33:12 You should consider upgrading via the '/usr/local/bin/python3.10 -m pip install --upgrade pip' command.
04-Jun-2024 23:33:12 Cloning into 'casa-build-utils'...
04-Jun-2024 23:33:13 Uploading distributions to
04-Jun-2024 23:33:13 https://casa-pip.nrao.edu:443/repository/casa-dev-wheel/
04-Jun-2024 23:33:15 Uploading casatools-6.6.1.14a14360.dev2-cp38-cp38-manylinux_2_28_x86_64.whl
04-Jun-2024 23:33:15
04-Jun-2024 23:33:15   0% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 0.0/189.9 MB--:--?
04-Jun-2024 23:33:15   4% ━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 8.2/189.9 MB00:02102.3 MB/s
04-Jun-2024 23:33:15   6% ━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 11.6/189.9 MB00:0362.8 MB/s
04-Jun-2024 23:33:15   8% ━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 14.6/189.9 MB00:0450.5 MB/s
04-Jun-2024 23:33:15 10% ━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 18.2/189.9 MB00:0443.1 MB/s
04-Jun-2024 23:33:15 11% ━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 20.9/189.9 MB00:0536.5 MB/s
04-Jun-2024 23:33:15 12% ━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 23.5/189.9 MB00:0631.6 MB/s
04-Jun-2024 23:33:15 14% ━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 26.1/189.9 MB00:0627.9 MB/s
04-Jun-2024 23:33:16 15% ━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 28.8/189.9 MB00:0628.1 MB/s
04-Jun-2024 23:33:16 17% ━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 31.4/189.9 MB00:0628.3 MB/s
04-Jun-2024 23:33:16 18% ━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 33.9/189.9 MB00:0628.0 MB/s
04-Jun-2024 23:33:16 19% ━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 36.7/189.9 MB00:0627.6 MB/s
04-Jun-2024 23:33:16 21% ━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 39.4/189.9 MB00:0627.7 MB/s
04-Jun-2024 23:33:16 22% ━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 42.4/189.9 MB00:0624.9 MB/s
04-Jun-2024 23:33:16 24% ━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 46.4/189.9 MB00:0628.3 MB/s
04-Jun-2024 23:33:16 26% ━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 50.0/189.9 MB00:0528.5 MB/s
04-Jun-2024 23:33:16 28% ━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 52.8/189.9 MB00:0529.4 MB/s
04-Jun-2024 23:33:16 29% ━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 54.9/189.9 MB00:0529.7 MB/s
04-Jun-2024 23:33:17 30% ━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━ 57.6/189.9 MB00:0527.1 MB/s
04-Jun-2024 23:33:17 32% ━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━ 60.0/189.9 MB00:0529.6 MB/s
04-Jun-2024 23:33:17 33% ━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━ 63.3/189.9 MB00:0526.4 MB/s
04-Jun-2024 23:33:17 35% ━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.2/189.9 MB00:0526.3 MB/s
04-Jun-2024 23:33:17 36% ━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━ 68.3/189.9 MB00:0526.2 MB/s
04-Jun-2024 23:33:17 37% ━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━ 70.5/189.9 MB00:0526.2 MB/s
04-Jun-2024 23:33:17 39% ━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━ 74.6/189.9 MB00:0527.1 MB/s
04-Jun-2024 23:33:17 41% ━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━ 77.3/189.9 MB00:0527.4 MB/s
04-Jun-2024 23:33:17 42% ━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━ 80.0/189.9 MB00:0427.7 MB/s
04-Jun-2024 23:33:18 43% ━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━ 82.3/189.9 MB00:0427.6 MB/s
04-Jun-2024 23:33:18 46% ━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━ 86.5/189.9 MB00:0427.8 MB/s
04-Jun-2024 23:33:18 47% ━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━ 88.7/189.9 MB00:0428.0 MB/s
04-Jun-2024 23:33:18 48% ━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━ 90.7/189.9 MB00:0427.6 MB/s
04-Jun-2024 23:33:18 49% ━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━ 92.8/189.9 MB00:0427.4 MB/s
04-Jun-2024 23:33:18 50% ━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━ 95.4/189.9 MB00:0426.5 MB/s
04-Jun-2024 23:33:18 52% ━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━ 99.5/189.9 MB00:0427.6 MB/s
04-Jun-2024 23:33:18 54% ━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━ 102.1/189.9 MB00:0426.9 MB/s
04-Jun-2024 23:33:18 55% ━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━ 104.6/189.9 MB00:0426.9 MB/s
04-Jun-2024 23:33:18 56% ━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━ 107.2/189.9 MB00:0330.1 MB/s
04-Jun-2024 23:33:19 59% ━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━ 111.4/189.9 MB00:0327.9 MB/s
04-Jun-2024 23:33:19 61% ━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━ 115.0/189.9 MB00:0329.9 MB/s
04-Jun-2024 23:33:19 62% ━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━ 117.6/189.9 MB00:0330.3 MB/s
04-Jun-2024 23:33:19 63% ━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━ 120.2/189.9 MB00:0330.5 MB/s
04-Jun-2024 23:33:19 65% ━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━ 122.9/189.9 MB00:0330.7 MB/s
04-Jun-2024 23:33:19 67% ━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━ 126.7/189.9 MB00:0330.7 MB/s
04-Jun-2024 23:33:19 69% ━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━ 130.7/189.9 MB00:0230.8 MB/s
04-Jun-2024 23:33:19 70% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━ 133.3/189.9 MB00:0230.7 MB/s
04-Jun-2024 23:33:19 72% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━ 136.5/189.9 MB00:0229.9 MB/s
04-Jun-2024 23:33:20 73% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━ 139.1/189.9 MB00:0229.6 MB/s
04-Jun-2024 23:33:20 75% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━ 141.8/189.9 MB00:0230.1 MB/s
04-Jun-2024 23:33:20 76% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━ 144.5/189.9 MB00:0229.6 MB/s
04-Jun-2024 23:33:20 78% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━ 148.8/189.9 MB00:0229.7 MB/s
04-Jun-2024 23:33:20 80% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━ 152.3/189.9 MB00:0230.5 MB/s
04-Jun-2024 23:33:20 82% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━ 154.9/189.9 MB00:0230.7 MB/s
04-Jun-2024 23:33:20 83% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━ 157.5/189.9 MB00:0230.7 MB/s
04-Jun-2024 23:33:20 84% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━ 160.1/189.9 MB00:0130.8 MB/s
04-Jun-2024 23:33:20 86% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━ 163.5/189.9 MB00:0130.2 MB/s
04-Jun-2024 23:33:20 88% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━ 167.8/189.9 MB00:0130.2 MB/s
04-Jun-2024 23:33:21 90% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━ 170.6/189.9 MB00:0130.0 MB/s
04-Jun-2024 23:33:21 92% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━ 174.4/189.9 MB00:0132.9 MB/s
04-Jun-2024 23:33:21 93% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━ 176.9/189.9 MB00:0132.8 MB/s
04-Jun-2024 23:33:21 95% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━ 179.7/189.9 MB00:0133.0 MB/s
04-Jun-2024 23:33:21 96% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━ 182.3/189.9 MB00:0132.7 MB/s
04-Jun-2024 23:33:21 98% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺ 185.3/189.9 MB00:0132.8 MB/s
04-Jun-2024 23:33:21 99% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸ 188.7/189.9 MB00:0129.0 MB/s
04-Jun-2024 23:33:21 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 189.9/189.9 MB00:0629.6 MB/s
04-Jun-2024 23:33:21 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 189.9/189.9 MB00:0629.6 MB/s
04-Jun-2024 23:33:22 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 189.9/189.9 MB00:0629.6 MB/s
04-Jun-2024 23:33:22 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 189.9/189.9 MB00:0629.6 MB/s
04-Jun-2024 23:33:22 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 189.9/189.9 MB00:0629.6 MB/s
04-Jun-2024 23:33:22 WARNING Error during upload. Retry with the --verbose option for more details.
04-Jun-2024 23:33:22 ERROR    HTTPError: 400 Bad Request from                                       
04-Jun-2024 23:33:22          https://casa-pip.nrao.edu:443/repository/casa-dev-wheel/               
04-Jun-2024 23:33:22          Repository does not allow updating assets: casa-dev-wheel             
04-Jun-2024 23:33:22 Uploading distributions to
04-Jun-2024 23:33:22 https://casa-pip.nrao.edu:443/repository/casa-dev-wheel/
04-Jun-2024 23:33:22 Uploading casatestutils-6.6.1.14a14360.dev2-py3-none-any.whl
04-Jun-2024 23:33:22
04-Jun-2024 23:33:22   0% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 0.0/125.7 kB--:--?
04-Jun-2024 23:33:22 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 125.7/125.7 kB00:00105.8 MB/s
04-Jun-2024 23:33:22 WARNING Error during upload. Retry with the --verbose option for more details.
04-Jun-2024 23:33:22 ERROR    HTTPError: 400 Bad Request from                                       
04-Jun-2024 23:33:22          https://casa-pip.nrao.edu:443/repository/casa-dev-wheel/               
04-Jun-2024 23:33:22          Repository does not allow updating assets: casa-dev-wheel             
04-Jun-2024 23:33:22 Finished task 'Upload wheel' with result: Success
04-Jun-2024 23:33:22 Starting task 'Cleanup' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
04-Jun-2024 23:33:22
Beginning to execute external process for build 'CASA - CMake Dev Test - CAS-14360 - Test Tools Many Linux 2.28 #3 (CASA-CMDT178-TTOMLPY38-3)'
... running command line:
/export/home/cbt-el7-1/bamboo-home/temp/CASA-CMDT178-TTOMLPY38-3-ScriptBuildTask-541659629581594770.sh
... in: /export/home/cbt-el7-1/bamboo-home/xml-data/build-dir/CASA-CMDT178-TTOMLPY38
04-Jun-2024 23:33:22 Starting cleanup
04-Jun-2024 23:33:33 wheel-container-test
04-Jun-2024 23:33:35 wheel-container-test
04-Jun-2024 23:33:35 Cleanup complete
04-Jun-2024 23:33:35 Finished task 'Cleanup' with result: Success
04-Jun-2024 23:33:35 Running post build plugin 'Docker Container Cleanup'
04-Jun-2024 23:33:35
Beginning to execute external process for build 'CASA - CMake Dev Test - CAS-14360 - Test Tools Many Linux 2.28 #3 (CASA-CMDT178-TTOMLPY38-3)'
... running command line:
/bin/docker rm -f wheel-container-test
... in: /export/home/cbt-el7-1/bamboo-home/xml-data/build-dir/CASA-CMDT178-TTOMLPY38
04-Jun-2024 23:33:35 Error response from daemon: No such container: wheel-container-test
04-Jun-2024 23:33:35 Running post build plugin 'NCover Results Collector'
04-Jun-2024 23:33:35 Running post build plugin 'Build Results Label Collector'
04-Jun-2024 23:33:35 Running post build plugin 'Clover Results Collector'
04-Jun-2024 23:33:35 Running post build plugin 'npm Cache Cleanup'
04-Jun-2024 23:33:35 Running post build plugin 'Artifact Copier'
04-Jun-2024 23:33:35 Publishing an artifact: Workdir
04-Jun-2024 23:33:35 Finished publishing of artifact Non required job artifact Http Compression On : [Workdir], patterns: [work*.tar.gz] anchored at: [wheeldirectory/] in 88.23 ms
04-Jun-2024 23:33:35 Publishing an artifact: Tests
04-Jun-2024 23:33:35 Finished publishing of artifact Non required job artifact Http Compression On : [Tests], patterns: [*.xml] anchored at: [wheeldirectory/] in 432.9 ms
04-Jun-2024 23:33:35 Publishing an artifact: xml Directories
04-Jun-2024 23:33:36 Finished publishing of artifact Non required job artifact Http Compression On : [xml Directories], patterns: [**/*.xml] anchored at: [wheeldirectory/] in 255.5 ms
04-Jun-2024 23:33:36 Finalising the build...
04-Jun-2024 23:33:36 Stopping timer.
04-Jun-2024 23:33:36 Build CASA-CMDT178-TTOMLPY38-3 completed.
04-Jun-2024 23:33:36 Running on server: post build plugin 'Build Hanging Detection Configuration'
04-Jun-2024 23:33:36 Running on server: post build plugin 'NCover Results Collector'
04-Jun-2024 23:33:36 Running on server: post build plugin 'Build Labeller'
04-Jun-2024 23:33:36 Running on server: post build plugin 'Clover Delta Calculator'
04-Jun-2024 23:33:36 Running on server: post build plugin 'Maven Dependencies Postprocessor'
04-Jun-2024 23:33:36 All post build plugins have finished
04-Jun-2024 23:33:36 Generating build results summary...
04-Jun-2024 23:33:36 Saving build results to disk...
04-Jun-2024 23:33:36 Store variable context...
04-Jun-2024 23:33:36 Finished building CASA-CMDT178-TTOMLPY38-3.