/opt/ci_workspace/casa/bamboo/agent7/temp/CASASPECS-DEVTESTPY31281-TTOMLPY312-7-ScriptBuildTask-10464644557386335885.sh: line 2: cd: /opt/casa/data/casa-data-req: No such file or directory
Error response from daemon: No such container: wheel-container-test_153550855
Error response from daemon: No such container: wheel-container-test_153550855
2026-03-26 22:34:25        INFO        GJonesSpline::solve()         Accumulating data for:  field= 1445+09900002_0, spw= 0, nchan= 63
2026-03-26 22:34:25        INFO        GJonesSpline::solve()         Accumulating data for:  field= N5921_2, spw= 0, nchan= 63
2026-03-26 22:34:25        INFO        GJonesSpline::solve()         Number of timestamps in data = 60
2026-03-26 22:34:25        INFO        GJonesSpline::getKnots()         Gridded splinetime = 5280 sec.
2026-03-26 22:34:25        INFO        GJonesSpline::solve()         Number of cubic spline control points = 4
2026-03-26 22:34:25        INFO        GJonesSpline::solve()         Number of cubic spline knots = 8
2026-03-26 22:34:25        INFO        GJonesSpline::solve()         Number of cubic spline segments = 1
2026-03-26 22:34:25        INFO        GJonesSpline::solve()         Fitting amplitude spline.
2026-03-26 22:34:25        INFO        GJonesSpline::solve()         Searching for and correcting phase-wraps on each baseline.
2026-03-26 22:34:25        INFO        GJonesSpline::solve()         Fitting phase spline.
2026-03-26 22:34:25        INFO        GJonesSpline::updateCalTable         Storing solutions in table gainspline
2026-03-26 22:34:25        INFO        calibrater::solve        Finished solving.
2026-03-26 22:34:26        WARN        calibrater::setvi(bool,bool)        Forcing use of NEW VisibilityIterator.
2026-03-26 22:34:26        INFO        calibrater::open        ****Using NEW VI2-driven calibrater tool****
2026-03-26 22:34:26        INFO        calibrater::open        Opening MS: gaincaltest2.ms for calibration.
2026-03-26 22:34:26        INFO                Clearing all model records in MS header.
2026-03-26 22:34:26        INFO        VisSetUtil::addScrCols        Adding MODEL_DATA and CORRECTED_DATA column(s).
2026-03-26 22:34:26        INFO        VisSetUtil::initScrCols        Initializing MODEL_DATA to (unity).
2026-03-26 22:34:26        INFO        VisSetUtil::initScrCols        Initialized 328860 rows.
2026-03-26 22:34:26        INFO        Calibrater::        Initializing nominal selection to the whole MS.
2026-03-26 22:34:26        INFO        calibrater::specifycal        Beginning specifycal-----------------------
2026-03-26 22:34:26        INFO                Creating G Jones table from specified parameters.
2026-03-26 22:34:26        INFO                Generating 'G' corrections.
2026-03-26 22:34:26        INFO                Specified parameter(s) (per spw and pol) repeated on all antennas.
2026-03-26 22:34:26        INFO                Specified parameter(s) (per spw and antenna) repeated on all polarizations.
2026-03-26 22:34:26        INFO                spwId=1 antId=<all> polId=<all> parameter= 3   (ip0,ip1 = [0, 0, 0],[1, 0, 9])
2026-03-26 22:34:26        INFO                Writing solutions to table: testcalout.cal
2026-03-26 22:34:26        WARN        calibrater::setvi(bool,bool)        Already using NEW VisibilityIterator.
2026-03-26 22:34:27        WARN        calibrater::setvi(bool,bool)        Forcing use of OLD VisibilityIterator.
2026-03-26 22:34:27        INFO        calibrater::open        ****Using OLD VI-driven calibrater tool****
2026-03-26 22:34:27        INFO        calibrater::open        Opening MS: gaincaltest2.ms for calibration.
2026-03-26 22:34:27        INFO                Clearing all model records in MS header.
2026-03-26 22:34:27        INFO        VisSetUtil::addScrCols        Adding MODEL_DATA and CORRECTED_DATA column(s).
2026-03-26 22:34:27        INFO        VisSetUtil::initScrCols        Initializing MODEL_DATA to (unity).
2026-03-26 22:34:27        INFO        VisSetUtil::initScrCols        Initialized 328860 rows.
2026-03-26 22:34:27        INFO        Calibrater::        Initializing nominal selection to the whole MS.
2026-03-26 22:34:27        INFO        calibrater::setapply        Beginning setapply--(MSSelection version)-------
2026-03-26 22:34:27        INFO        Calibrater::setapply(type, applypar)        Arranging to APPLY:
2026-03-26 22:34:28        INFO        Calibrater::setapply(type, applypar)        .   G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false
2026-03-26 22:34:28        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
2026-03-26 22:34:28        INFO        Calibrater::setsolve        Arranging to SOLVE:
2026-03-26 22:34:28        INFO        Calibrater::setsolve        .   Mf Mueller: table=output.ms append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
2026-03-26 22:34:28        INFO        Calibrater::state        The following calibration terms are arranged for apply:
2026-03-26 22:34:28        INFO        Calibrater::state        .   G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false
2026-03-26 22:34:28        INFO        Calibrater::state        The following calibration term is arranged for solve:
2026-03-26 22:34:28        INFO        Calibrater::state        .   Mf Mueller: table=output.ms append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
2026-03-26 22:34:28        INFO        calibrater::solve        Beginning solve-----------------------------
2026-03-26 22:34:28        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
2026-03-26 22:34:28        INFO        Calibrater::solve        .   G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false
2026-03-26 22:34:28        INFO        Calibrater::solve        The following calibration term is arranged for solve:
2026-03-26 22:34:28        INFO        Calibrater::solve        .   Mf Mueller: table=output.ms append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
2026-03-26 22:34:28        INFO                Solving for Mf Mueller
2026-03-26 22:34:28        INFO                For solint = inf, found 84 solution intervals.
2026-03-26 22:34:28        INFO                  Found good Mf Mueller solutions in 84 intervals.
2026-03-26 22:34:28        INFO                Writing solutions to table: output.ms
2026-03-26 22:34:28        INFO        calibrater::solve        Finished solving.
2026-03-26 22:34:28        WARN        calibrater::setvi(bool,bool)        Forcing use of NEW VisibilityIterator.
2026-03-26 22:34:29        INFO        calibrater::open        ****Using NEW VI2-driven calibrater tool****
2026-03-26 22:34:29        INFO        calibrater::open        Opening MS: gaincaltest2.ms for calibration.
2026-03-26 22:34:29        INFO                Clearing all model records in MS header.
2026-03-26 22:34:29        INFO        VisSetUtil::addScrCols        Adding MODEL_DATA and CORRECTED_DATA column(s).
2026-03-26 22:34:29        INFO        VisSetUtil::initScrCols        Initializing MODEL_DATA to (unity).
2026-03-26 22:34:29        INFO        VisSetUtil::initScrCols        Initialized 328860 rows.
2026-03-26 22:34:29        INFO        Calibrater::        Initializing nominal selection to the whole MS.
2026-03-26 22:34:29        INFO        name::        No table opened.
2026-03-26 22:34:29        INFO        showcache::        The Table Cache has the following 16 entries:
2026-03-26 22:34:29        INFO        showcache::            0: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms"
2026-03-26 22:34:29        INFO        showcache::            1: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/ANTENNA"
2026-03-26 22:34:29        INFO        showcache::            2: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/DATA_DESCRIPTION"
2026-03-26 22:34:29        INFO        showcache::            3: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FEED"
2026-03-26 22:34:29        INFO        showcache::            4: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FIELD"
2026-03-26 22:34:29        INFO        showcache::            5: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FLAG_CMD"
2026-03-26 22:34:29        INFO        showcache::            6: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/HISTORY"
2026-03-26 22:34:29        INFO        showcache::            7: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/OBSERVATION"
2026-03-26 22:34:29        INFO        showcache::            8: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/POINTING"
2026-03-26 22:34:29        INFO        showcache::            9: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/POLARIZATION"
2026-03-26 22:34:29        INFO        showcache::            10: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/PROCESSOR"
2026-03-26 22:34:29        INFO        showcache::            11: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SOURCE"
2026-03-26 22:34:29        INFO        showcache::            12: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SPECTRAL_WINDOW"
2026-03-26 22:34:29        INFO        showcache::            13: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/STATE"
2026-03-26 22:34:29        INFO        showcache::            14: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SYSCAL"
2026-03-26 22:34:29        INFO        showcache::            15: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/WEATHER"
2026-03-26 22:34:29        INFO        name::        No table opened.
2026-03-26 22:34:29        INFO        showcache::        The Table Cache is empty.
2026-03-26 22:34:29        WARN        calibrater::setvi(bool,bool)        Already using NEW VisibilityIterator.
2026-03-26 22:34:29        INFO        calibrater::open        ****Using NEW VI2-driven calibrater tool****
2026-03-26 22:34:29        INFO        calibrater::open        Opening MS: gaincaltest2.ms for calibration.
2026-03-26 22:34:29        INFO                Clearing all model records in MS header.
2026-03-26 22:34:29        INFO        VisSetUtil::addScrCols        Adding MODEL_DATA and CORRECTED_DATA column(s).
2026-03-26 22:34:30        INFO        VisSetUtil::initScrCols        Initializing MODEL_DATA to (unity).
2026-03-26 22:34:30        INFO        VisSetUtil::initScrCols        Initialized 328860 rows.
2026-03-26 22:34:30        INFO        Calibrater::        Initializing nominal selection to the whole MS.
2026-03-26 22:34:30        INFO        calibrater::setapply        Beginning setapply--(MSSelection version)-------
2026-03-26 22:34:30        INFO        Calibrater::setapply(type, applypar)        Arranging to APPLY:
2026-03-26 22:34:30        INFO        Calibrater::setapply(type, applypar)        .   G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false
2026-03-26 22:34:30        INFO        calibrater::correct        Beginning correct---------------------------
2026-03-26 22:34:30        INFO        Calibrater::correct2 (VI2/VB2)        The following calibration terms are arranged for apply:
2026-03-26 22:34:30        INFO        Calibrater::correct2 (VI2/VB2)        .   G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false
2026-03-26 22:34:40        INFO        calibrater::correct        Finished correcting.
2026-03-26 22:34:40        WARN        calibrater::setvi(bool,bool)        Already using NEW VisibilityIterator.
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

[notice] A new release of pip is available: 23.0.1 -> 26.0.1
[notice] To update, run: pip3 install --upgrade pip
Cloning into 'casa-build-utils'...