Build: #1 failed
Job: Test tools OSX1015 was successful
Build log
The build generated 52,039 lines of output.The output is too long and has been truncated to the last 1,000 lines. Download or view full build log.
| 03-Oct-2022 16:52:58 | 2022-10-03 20:52:58 INFO ImageMaskAttacher::makeMask Created mask `mask0' |
| 03-Oct-2022 16:52:58 | 2022-10-03 20:52:58 INFO name:: No table opened. |
| 03-Oct-2022 16:52:58 | 2022-10-03 20:52:58 INFO showcache:: The Table Cache is empty. |
| 03-Oct-2022 16:52:58 | 2022-10-03 20:52:58 INFO name:: No table opened. |
| 03-Oct-2022 16:52:58 | 2022-10-03 20:52:58 INFO name:: No table opened. |
| 03-Oct-2022 16:52:58 | test_tool_image_deviation.py::ia_deviation_test::test_mask |
| 03-Oct-2022 16:52:58 | PASSED |
| 03-Oct-2022 16:52:58 | |
| 03-Oct-2022 16:52:58 | 2022-10-03 20:52:58 INFO ImageFactory::createImage Created Temp image of shape [20, 20] with float valued pixels. |
| 03-Oct-2022 16:52:58 | 2022-10-03 20:52:58 INFO StatImageCreator::_computeStat Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 25 grid points in 1 planes. |
| 03-Oct-2022 16:52:58 | 2022-10-03 20:52:58 INFO StatImageCreator::_doInterpolation Interpolate using CUBIC algorithm. |
| 03-Oct-2022 16:52:58 | 2022-10-03 20:52:58 INFO StatImageCreator::useReferencePixelAsAnchor Anchor being set at pixel [10,10], at/near image reference pixel. |
| 03-Oct-2022 16:52:58 | 2022-10-03 20:52:58 INFO StatImageCreator::_computeStat Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 25 grid points in 1 planes. |
| 03-Oct-2022 16:52:58 | 2022-10-03 20:52:58 INFO StatImageCreator::_doInterpolation Interpolate using CUBIC algorithm. |
| 03-Oct-2022 16:52:58 | 2022-10-03 20:52:58 INFO name:: No table opened. |
| 03-Oct-2022 16:52:58 | 2022-10-03 20:52:58 INFO showcache:: The Table Cache is empty. |
| 03-Oct-2022 16:52:58 | 2022-10-03 20:52:58 INFO name:: No table opened. |
| 03-Oct-2022 16:52:58 | 2022-10-03 20:52:58 INFO name:: No table opened. |
| 03-Oct-2022 16:52:58 | test_tool_image_deviation.py::ia_deviation_test::test_refpix |
| 03-Oct-2022 16:52:58 | Test using reference pixel |
| 03-Oct-2022 16:52:58 | PASSED |
| 03-Oct-2022 16:52:58 | |
| 03-Oct-2022 16:52:58 | - generated xml file: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/xml/test_tool_image_deviation/nose.xml - |
| 03-Oct-2022 16:52:58 | ============================== 8 passed in 2.14s =============================== |
| 03-Oct-2022 16:52:58 | ============================= test session starts ============================== |
| 03-Oct-2022 16:52:58 | platform darwin -- Python 3.6.10, pytest-7.0.1, pluggy-1.0.0 -- /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6testenv/bin/python |
| 03-Oct-2022 16:52:58 | cachedir: .pytest_cache |
| 03-Oct-2022 16:52:58 | rootdir: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils |
| 03-Oct-2022 16:52:58 | collecting ... collected 0 items |
| 03-Oct-2022 16:52:58 | |
| 03-Oct-2022 16:52:58 | - generated xml file: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/xml/test_tool_image_fromcomplist/nose.xml - |
| 03-Oct-2022 16:52:58 | ============================ no tests ran in 0.01s ============================= |
| 03-Oct-2022 16:52:58 | ============================= test session starts ============================== |
| 03-Oct-2022 16:52:58 | platform darwin -- Python 3.6.10, pytest-7.0.1, pluggy-1.0.0 -- /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6testenv/bin/python |
| 03-Oct-2022 16:52:58 | cachedir: .pytest_cache |
| 03-Oct-2022 16:52:58 | rootdir: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils |
| 03-Oct-2022 16:52:58 | collecting ... collected 24 items |
| 03-Oct-2022 16:52:58 | |
| 03-Oct-2022 16:52:58 | |
| 03-Oct-2022 16:52:59 | 2022-10-03 20:52:59 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 03-Oct-2022 16:52:59 | 2022-10-03 20:52:59 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:52:59 | 2022-10-03 20:52:59 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:52:59 | 2022-10-03 20:52:59 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:53:00 | 2022-10-03 20:53:01 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:53:01 | 2022-10-03 20:53:01 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 03-Oct-2022 16:53:01 | 2022-10-03 20:53:01 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:53:01 | 2022-10-03 20:53:01 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 03-Oct-2022 16:53:01 | 2022-10-03 20:53:01 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 03-Oct-2022 16:53:01 | 2022-10-03 20:53:01 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:01 | 2022-10-03 20:53:01 INFO calibrater::corrupt Beginning corrupt--------------------------- |
| 03-Oct-2022 16:53:01 | 2022-10-03 20:53:01 INFO Calibrater::corrupt2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 03-Oct-2022 16:53:01 | 2022-10-03 20:53:01 INFO Calibrater::corrupt2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:02 | 2022-10-03 20:53:03 INFO calibrater::corrupt Finished corrupting. |
| 03-Oct-2022 16:53:03 | 2022-10-03 20:53:03 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 03-Oct-2022 16:53:03 | test_tool_calibrater.py::calibrater_test::test_activityRecord |
| 03-Oct-2022 16:53:03 | Check that using the calibrater to modify the vis shows in the activity record |
| 03-Oct-2022 16:53:03 | PASSED |
| 03-Oct-2022 16:53:03 | |
| 03-Oct-2022 16:53:03 | 2022-10-03 20:53:03 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 03-Oct-2022 16:53:03 | 2022-10-03 20:53:03 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:53:03 | 2022-10-03 20:53:03 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:53:03 | 2022-10-03 20:53:03 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:53:05 | 2022-10-03 20:53:05 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:53:05 | 2022-10-03 20:53:05 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 03-Oct-2022 16:53:05 | 2022-10-03 20:53:05 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:53:05 | 2022-10-03 20:53:05 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 03-Oct-2022 16:53:05 | 2022-10-03 20:53:05 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 03-Oct-2022 16:53:05 | 2022-10-03 20:53:05 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:05 | 2022-10-03 20:53:05 INFO calibrater::corrupt Beginning corrupt--------------------------- |
| 03-Oct-2022 16:53:05 | 2022-10-03 20:53:05 INFO Calibrater::corrupt2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 03-Oct-2022 16:53:05 | 2022-10-03 20:53:05 INFO Calibrater::corrupt2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:07 | 2022-10-03 20:53:07 INFO calibrater::corrupt Finished corrupting. |
| 03-Oct-2022 16:53:08 | 2022-10-03 20:53:08 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 03-Oct-2022 16:53:08 | test_tool_calibrater.py::calibrater_test::test_corruptCal |
| 03-Oct-2022 16:53:08 | Check that the MS is corrupted using the cal table |
| 03-Oct-2022 16:53:08 | PASSED |
| 03-Oct-2022 16:53:08 | |
| 03-Oct-2022 16:53:08 | 2022-10-03 20:53:09 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 03-Oct-2022 16:53:08 | 2022-10-03 20:53:09 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:53:08 | 2022-10-03 20:53:09 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:53:08 | 2022-10-03 20:53:09 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:53:10 | 2022-10-03 20:53:10 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:53:10 | 2022-10-03 20:53:10 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 03-Oct-2022 16:53:10 | 2022-10-03 20:53:10 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:53:10 | 2022-10-03 20:53:10 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 03-Oct-2022 16:53:10 | test_tool_calibrater.py::calibrater_test::test_createEmpty |
| 03-Oct-2022 16:53:10 | Check that an empty cal table can be created |
| 03-Oct-2022 16:53:10 | PASSED |
| 03-Oct-2022 16:53:10 | |
| 03-Oct-2022 16:53:10 | 2022-10-03 20:53:11 INFO name:: No table opened. |
| 03-Oct-2022 16:53:10 | 2022-10-03 20:53:11 INFO showcache:: The Table Cache is empty. |
| 03-Oct-2022 16:53:10 | 2022-10-03 20:53:11 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 03-Oct-2022 16:53:10 | 2022-10-03 20:53:11 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:53:10 | 2022-10-03 20:53:11 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:53:10 | 2022-10-03 20:53:11 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 INFO name:: No table opened. |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 INFO showcache:: The Table Cache has the following 16 entries: |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 INFO showcache:: 0: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms" |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 INFO showcache:: 1: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/ANTENNA" |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 INFO showcache:: 2: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/DATA_DESCRIPTION" |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 INFO showcache:: 3: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FEED" |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 INFO showcache:: 4: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FIELD" |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 INFO showcache:: 5: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FLAG_CMD" |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 INFO showcache:: 6: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/HISTORY" |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 INFO showcache:: 7: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/OBSERVATION" |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 INFO showcache:: 8: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/POINTING" |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 INFO showcache:: 9: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/POLARIZATION" |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 INFO showcache:: 10: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/PROCESSOR" |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 INFO showcache:: 11: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SOURCE" |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 INFO showcache:: 12: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SPECTRAL_WINDOW" |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 INFO showcache:: 13: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/STATE" |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 INFO showcache:: 14: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SYSCAL" |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 INFO showcache:: 15: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/WEATHER" |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:12 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 03-Oct-2022 16:53:12 | test_tool_calibrater.py::calibrater_test::test_done |
| 03-Oct-2022 16:53:12 | Check that done closes the active calibrator tool |
| 03-Oct-2022 16:53:12 | PASSED |
| 03-Oct-2022 16:53:12 | |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:13 WARN calibrater::setvi(bool,bool) Forcing use of OLD VisibilityIterator. |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:13 INFO calibrater::open ****Using OLD VI-driven calibrater tool**** |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:13 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:13 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:53:12 | 2022-10-03 20:53:13 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:53:14 | 2022-10-03 20:53:14 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:53:14 | 2022-10-03 20:53:14 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 03-Oct-2022 16:53:14 | 2022-10-03 20:53:14 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:53:14 | 2022-10-03 20:53:14 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 03-Oct-2022 16:53:14 | 2022-10-03 20:53:14 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 03-Oct-2022 16:53:14 | 2022-10-03 20:53:14 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:14 | 2022-10-03 20:53:14 INFO calibrater::correct Beginning correct--------------------------- |
| 03-Oct-2022 16:53:14 | 2022-10-03 20:53:14 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 03-Oct-2022 16:53:14 | 2022-10-03 20:53:14 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:16 | 2022-10-03 20:53:17 INFO calibrater::correct Finished correcting. |
| 03-Oct-2022 16:53:17 | 2022-10-03 20:53:17 INFO calibrater::open ****Using OLD VI-driven calibrater tool**** |
| 03-Oct-2022 16:53:17 | 2022-10-03 20:53:17 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:53:17 | 2022-10-03 20:53:17 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:53:17 | 2022-10-03 20:53:17 INFO calibrater::initcalset Beginning initcalset------------------------ |
| 03-Oct-2022 16:53:17 | 2022-10-03 20:53:17 INFO VisSet::VisSet Initializing MODEL_DATA (to unity) and CORRECTED_DATA (to DATA) |
| 03-Oct-2022 16:53:17 | 2022-10-03 20:53:17 INFO VisSet::VisSet Initialized 328860 rows. |
| 03-Oct-2022 16:53:18 | 2022-10-03 20:53:18 WARN calibrater::setvi(bool,bool) Forcing use of NEW VisibilityIterator. |
| 03-Oct-2022 16:53:20 | test_tool_calibrater.py::calibrater_test::test_reinitModel |
| 03-Oct-2022 16:53:20 | Check that initcalset will reset the CORRECTED_DATA to unity |
| 03-Oct-2022 16:53:20 | PASSED |
| 03-Oct-2022 16:53:20 | |
| 03-Oct-2022 16:53:21 | 2022-10-03 20:53:21 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 03-Oct-2022 16:53:21 | 2022-10-03 20:53:21 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:53:21 | 2022-10-03 20:53:21 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:53:21 | 2022-10-03 20:53:21 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:53:22 | 2022-10-03 20:53:23 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:53:22 | 2022-10-03 20:53:23 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 03-Oct-2022 16:53:22 | 2022-10-03 20:53:23 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:53:22 | 2022-10-03 20:53:23 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 03-Oct-2022 16:53:22 | 2022-10-03 20:53:23 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 03-Oct-2022 16:53:22 | 2022-10-03 20:53:23 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:22 | 2022-10-03 20:53:23 INFO calibrater::setsolve Beginning setsolve--(MSSelection version)------- |
| 03-Oct-2022 16:53:22 | 2022-10-03 20:53:23 INFO Calibrater::setsolve Arranging to SOLVE: |
| 03-Oct-2022 16:53:22 | 2022-10-03 20:53:23 INFO Calibrater::setsolve . Mf Mueller: table=gaincaltest2.ms.G0 append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false |
| 03-Oct-2022 16:53:22 | 2022-10-03 20:53:23 INFO calibrater::reset Reseting solve/apply state |
| 03-Oct-2022 16:53:22 | 2022-10-03 20:53:23 INFO calibrater::solve Beginning solve----------------------------- |
| 03-Oct-2022 16:53:22 | 2022-10-03 20:53:23 SEVERE Calibrater::solve Caught exception: Please run setsolve before attempting to solve. |
| 03-Oct-2022 16:53:22 | 2022-10-03 20:53:23 INFO Calibrater::solve Reseting entire solve/apply state. |
| 03-Oct-2022 16:53:22 | 2022-10-03 20:53:23 SEVERE Exception Reported: Error in Calibrater::solve. |
| 03-Oct-2022 16:53:22 | 2022-10-03 20:53:23 INFO calibrater::correct Beginning correct--------------------------- |
| 03-Oct-2022 16:53:22 | 2022-10-03 20:53:23 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 03-Oct-2022 16:53:22 | 2022-10-03 20:53:23 INFO Calibrater::correct2 (VI2/VB2) . (None) |
| 03-Oct-2022 16:53:22 | 2022-10-03 20:53:23 SEVERE Calibrater::correct2 (VI2/VB2) Caught exception: Nothing to Apply |
| 03-Oct-2022 16:53:22 | 2022-10-03 20:53:23 INFO Calibrater::correct2 (VI2/VB2) Resetting all calibration application settings. |
| 03-Oct-2022 16:53:22 | 2022-10-03 20:53:23 SEVERE Exception Reported: Error in Calibrater::correct. |
| 03-Oct-2022 16:53:22 | 2022-10-03 20:53:23 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 03-Oct-2022 16:53:22 | test_tool_calibrater.py::calibrater_test::test_resetSolveApply |
| 03-Oct-2022 16:53:22 | Check that the reset function can clear set apply and solves |
| 03-Oct-2022 16:53:22 | PASSED |
| 03-Oct-2022 16:53:22 | |
| 03-Oct-2022 16:53:23 | 2022-10-03 20:53:23 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 03-Oct-2022 16:53:23 | 2022-10-03 20:53:23 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:53:23 | 2022-10-03 20:53:23 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:53:23 | 2022-10-03 20:53:23 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:53:24 | 2022-10-03 20:53:25 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:53:24 | 2022-10-03 20:53:25 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 03-Oct-2022 16:53:24 | 2022-10-03 20:53:25 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:53:25 | 2022-10-03 20:53:25 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
| 03-Oct-2022 16:53:25 | 2022-10-03 20:53:25 INFO calibrater::reset Reseting solve/apply state |
| 03-Oct-2022 16:53:25 | 2022-10-03 20:53:25 INFO Calibrater::selectvis Performing selection on MeasurementSet |
| 03-Oct-2022 16:53:25 | 2022-10-03 20:53:25 INFO Calibrater::selectvis+ Selecting on spw: '1' |
| 03-Oct-2022 16:53:25 | 2022-10-03 20:53:25 INFO Calibrater::selectvis By selection 328860 rows are reduced to 82215 |
| 03-Oct-2022 16:53:25 | 2022-10-03 20:53:25 INFO Calibrater::selectvis Frequency selection: |
| 03-Oct-2022 16:53:25 | 2022-10-03 20:53:25 INFO Calibrater::selectvis . Spw 1:0~7 (8 channels, step by 1) |
| 03-Oct-2022 16:53:25 | 2022-10-03 20:53:25 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
| 03-Oct-2022 16:53:25 | 2022-10-03 20:53:26 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 03-Oct-2022 16:53:25 | test_tool_calibrater.py::calibrater_test::test_returnDict |
| 03-Oct-2022 16:53:25 | Check that the returndict function gives a dictonary with the expected keys |
| 03-Oct-2022 16:53:25 | PASSED |
| 03-Oct-2022 16:53:25 | |
| 03-Oct-2022 16:53:26 | 2022-10-03 20:53:26 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 03-Oct-2022 16:53:26 | 2022-10-03 20:53:26 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:53:26 | 2022-10-03 20:53:26 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:53:26 | 2022-10-03 20:53:26 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:53:27 | 2022-10-03 20:53:28 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:53:28 | 2022-10-03 20:53:28 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 03-Oct-2022 16:53:28 | 2022-10-03 20:53:28 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:53:28 | 2022-10-03 20:53:28 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
| 03-Oct-2022 16:53:28 | 2022-10-03 20:53:28 INFO calibrater::reset Reseting solve/apply state |
| 03-Oct-2022 16:53:28 | 2022-10-03 20:53:28 INFO Calibrater::selectvis Performing selection on MeasurementSet |
| 03-Oct-2022 16:53:28 | 2022-10-03 20:53:28 INFO Calibrater::selectvis+ Selecting on antenna/baseline: '0' |
| 03-Oct-2022 16:53:28 | 2022-10-03 20:53:28 INFO Calibrater::selectvis By selection 328860 rows are reduced to 65772 |
| 03-Oct-2022 16:53:28 | 2022-10-03 20:53:28 INFO Calibrater::selectvis Frequency selection: Selecting all channels in all spws. |
| 03-Oct-2022 16:53:28 | 2022-10-03 20:53:28 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
| 03-Oct-2022 16:53:28 | 2022-10-03 20:53:28 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 03-Oct-2022 16:53:28 | 2022-10-03 20:53:28 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 03-Oct-2022 16:53:28 | 2022-10-03 20:53:28 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:28 | 2022-10-03 20:53:28 INFO calibrater::correct Beginning correct--------------------------- |
| 03-Oct-2022 16:53:28 | 2022-10-03 20:53:28 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 03-Oct-2022 16:53:28 | 2022-10-03 20:53:28 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:29 | 2022-10-03 20:53:30 INFO calibrater::correct Finished correcting. |
| 03-Oct-2022 16:53:30 | 2022-10-03 20:53:30 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 03-Oct-2022 16:53:30 | test_tool_calibrater.py::calibrater_test::test_selectVisBaseline |
| 03-Oct-2022 16:53:30 | Check that selectvis properly selects baseline/antenna |
| 03-Oct-2022 16:53:30 | 65772 65772 |
| 03-Oct-2022 16:53:30 | 263088 263088 |
| 03-Oct-2022 16:53:30 | PASSED |
| 03-Oct-2022 16:53:30 | |
| 03-Oct-2022 16:53:30 | 2022-10-03 20:53:31 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 03-Oct-2022 16:53:30 | 2022-10-03 20:53:31 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:53:30 | 2022-10-03 20:53:31 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:53:30 | 2022-10-03 20:53:31 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:53:32 | 2022-10-03 20:53:32 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:53:32 | 2022-10-03 20:53:32 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 03-Oct-2022 16:53:32 | 2022-10-03 20:53:32 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:53:32 | 2022-10-03 20:53:32 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
| 03-Oct-2022 16:53:32 | 2022-10-03 20:53:32 INFO calibrater::reset Reseting solve/apply state |
| 03-Oct-2022 16:53:32 | 2022-10-03 20:53:32 INFO Calibrater::selectvis Performing selection on MeasurementSet |
| 03-Oct-2022 16:53:32 | 2022-10-03 20:53:32 INFO Calibrater::selectvis+ Selecting on field: '0' |
| 03-Oct-2022 16:53:32 | 2022-10-03 20:53:32 INFO Calibrater::selectvis By selection 328860 rows are reduced to 172260 |
| 03-Oct-2022 16:53:32 | 2022-10-03 20:53:32 INFO Calibrater::selectvis Frequency selection: Selecting all channels in all spws. |
| 03-Oct-2022 16:53:32 | 2022-10-03 20:53:32 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
| 03-Oct-2022 16:53:32 | 2022-10-03 20:53:32 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 03-Oct-2022 16:53:32 | 2022-10-03 20:53:32 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 03-Oct-2022 16:53:32 | 2022-10-03 20:53:32 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:32 | 2022-10-03 20:53:32 INFO calibrater::correct Beginning correct--------------------------- |
| 03-Oct-2022 16:53:32 | 2022-10-03 20:53:32 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 03-Oct-2022 16:53:32 | 2022-10-03 20:53:32 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:33 | 2022-10-03 20:53:34 INFO calibrater::correct Finished correcting. |
| 03-Oct-2022 16:53:34 | 2022-10-03 20:53:34 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 03-Oct-2022 16:53:34 | test_tool_calibrater.py::calibrater_test::test_selectVisField |
| 03-Oct-2022 16:53:34 | Check that the field is properly selected by selectvis |
| 03-Oct-2022 16:53:34 | PASSED |
| 03-Oct-2022 16:53:34 | |
| 03-Oct-2022 16:53:34 | 2022-10-03 20:53:35 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 03-Oct-2022 16:53:34 | 2022-10-03 20:53:35 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:53:34 | 2022-10-03 20:53:35 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:53:34 | 2022-10-03 20:53:35 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:53:36 | 2022-10-03 20:53:36 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:53:36 | 2022-10-03 20:53:37 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 03-Oct-2022 16:53:36 | 2022-10-03 20:53:37 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:53:36 | 2022-10-03 20:53:37 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
| 03-Oct-2022 16:53:36 | 2022-10-03 20:53:37 INFO calibrater::reset Reseting solve/apply state |
| 03-Oct-2022 16:53:36 | 2022-10-03 20:53:37 INFO Calibrater::selectvis Performing selection on MeasurementSet |
| 03-Oct-2022 16:53:36 | 2022-10-03 20:53:37 INFO Calibrater::selectvis+ Selecting on intent: '*AMPLI*' |
| 03-Oct-2022 16:53:36 | 2022-10-03 20:53:37 INFO Calibrater::selectvis Selection did not drop any rows |
| 03-Oct-2022 16:53:36 | 2022-10-03 20:53:37 INFO Calibrater::selectvis Frequency selection: Selecting all channels in all spws. |
| 03-Oct-2022 16:53:36 | 2022-10-03 20:53:37 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
| 03-Oct-2022 16:53:36 | 2022-10-03 20:53:37 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 03-Oct-2022 16:53:36 | 2022-10-03 20:53:37 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 03-Oct-2022 16:53:36 | 2022-10-03 20:53:37 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:36 | 2022-10-03 20:53:37 INFO calibrater::correct Beginning correct--------------------------- |
| 03-Oct-2022 16:53:36 | 2022-10-03 20:53:37 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 03-Oct-2022 16:53:36 | 2022-10-03 20:53:37 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:38 | 2022-10-03 20:53:39 INFO calibrater::correct Finished correcting. |
| 03-Oct-2022 16:53:39 | 2022-10-03 20:53:39 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 03-Oct-2022 16:53:39 | test_tool_calibrater.py::calibrater_test::test_selectVisIntent |
| 03-Oct-2022 16:53:39 | Check that the intent is properly selected by selectvis |
| 03-Oct-2022 16:53:39 | PASSED |
| 03-Oct-2022 16:53:39 | |
| 03-Oct-2022 16:53:39 | 2022-10-03 20:53:40 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 03-Oct-2022 16:53:39 | 2022-10-03 20:53:40 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:53:39 | 2022-10-03 20:53:40 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:53:39 | 2022-10-03 20:53:40 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:53:41 | 2022-10-03 20:53:41 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:53:41 | 2022-10-03 20:53:41 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 03-Oct-2022 16:53:41 | 2022-10-03 20:53:41 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:53:41 | 2022-10-03 20:53:41 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
| 03-Oct-2022 16:53:41 | 2022-10-03 20:53:41 INFO calibrater::reset Reseting solve/apply state |
| 03-Oct-2022 16:53:41 | 2022-10-03 20:53:41 INFO Calibrater::selectvis Performing selection on MeasurementSet |
| 03-Oct-2022 16:53:41 | 2022-10-03 20:53:41 INFO Calibrater::selectvis+ Selecting by observation IDs: '0' |
| 03-Oct-2022 16:53:41 | 2022-10-03 20:53:41 INFO Calibrater::selectvis By selection 328860 rows are reduced to 318870 |
| 03-Oct-2022 16:53:41 | 2022-10-03 20:53:41 INFO Calibrater::selectvis Frequency selection: Selecting all channels in all spws. |
| 03-Oct-2022 16:53:41 | 2022-10-03 20:53:41 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
| 03-Oct-2022 16:53:41 | 2022-10-03 20:53:41 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 03-Oct-2022 16:53:41 | 2022-10-03 20:53:41 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 03-Oct-2022 16:53:41 | 2022-10-03 20:53:42 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:41 | 2022-10-03 20:53:42 INFO calibrater::correct Beginning correct--------------------------- |
| 03-Oct-2022 16:53:41 | 2022-10-03 20:53:42 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 03-Oct-2022 16:53:41 | 2022-10-03 20:53:42 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:43 | 2022-10-03 20:53:44 INFO calibrater::correct Finished correcting. |
| 03-Oct-2022 16:53:43 | 2022-10-03 20:53:44 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 03-Oct-2022 16:53:43 | test_tool_calibrater.py::calibrater_test::test_selectVisObs |
| 03-Oct-2022 16:53:43 | PASSED |
| 03-Oct-2022 16:53:43 | |
| 03-Oct-2022 16:53:44 | 2022-10-03 20:53:45 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 03-Oct-2022 16:53:44 | 2022-10-03 20:53:45 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:53:44 | 2022-10-03 20:53:45 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:53:44 | 2022-10-03 20:53:45 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:53:46 | 2022-10-03 20:53:46 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:53:46 | 2022-10-03 20:53:46 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 03-Oct-2022 16:53:46 | 2022-10-03 20:53:46 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:53:46 | 2022-10-03 20:53:46 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
| 03-Oct-2022 16:53:46 | 2022-10-03 20:53:46 INFO calibrater::reset Reseting solve/apply state |
| 03-Oct-2022 16:53:46 | 2022-10-03 20:53:46 INFO Calibrater::selectvis Performing selection on MeasurementSet |
| 03-Oct-2022 16:53:46 | 2022-10-03 20:53:46 INFO Calibrater::selectvis+ Selecting on scan: '2' |
| 03-Oct-2022 16:53:46 | 2022-10-03 20:53:46 INFO Calibrater::selectvis By selection 328860 rows are reduced to 15660 |
| 03-Oct-2022 16:53:46 | 2022-10-03 20:53:46 INFO Calibrater::selectvis Frequency selection: Selecting all channels in all spws. |
| 03-Oct-2022 16:53:46 | 2022-10-03 20:53:46 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
| 03-Oct-2022 16:53:46 | 2022-10-03 20:53:46 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 03-Oct-2022 16:53:46 | 2022-10-03 20:53:46 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 03-Oct-2022 16:53:46 | 2022-10-03 20:53:46 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:46 | 2022-10-03 20:53:46 INFO calibrater::correct Beginning correct--------------------------- |
| 03-Oct-2022 16:53:46 | 2022-10-03 20:53:46 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 03-Oct-2022 16:53:46 | 2022-10-03 20:53:46 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:46 | 2022-10-03 20:53:46 INFO calibrater::correct Finished correcting. |
| 03-Oct-2022 16:53:46 | 2022-10-03 20:53:47 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 03-Oct-2022 16:53:46 | test_tool_calibrater.py::calibrater_test::test_selectVisScan |
| 03-Oct-2022 16:53:46 | Check tht the scan is properly selected by selectvis |
| 03-Oct-2022 16:53:46 | PASSED |
| 03-Oct-2022 16:53:46 | |
| 03-Oct-2022 16:53:47 | 2022-10-03 20:53:48 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 03-Oct-2022 16:53:47 | 2022-10-03 20:53:48 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:53:47 | 2022-10-03 20:53:48 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:53:47 | 2022-10-03 20:53:48 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:53:49 | 2022-10-03 20:53:49 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:53:49 | 2022-10-03 20:53:49 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 03-Oct-2022 16:53:49 | 2022-10-03 20:53:49 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:53:49 | 2022-10-03 20:53:49 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
| 03-Oct-2022 16:53:49 | 2022-10-03 20:53:49 INFO calibrater::reset Reseting solve/apply state |
| 03-Oct-2022 16:53:49 | 2022-10-03 20:53:49 INFO Calibrater::selectvis Performing selection on MeasurementSet |
| 03-Oct-2022 16:53:49 | 2022-10-03 20:53:49 INFO Calibrater::selectvis+ Selecting on spw: '0' |
| 03-Oct-2022 16:53:49 | 2022-10-03 20:53:49 INFO Calibrater::selectvis By selection 328860 rows are reduced to 82215 |
| 03-Oct-2022 16:53:49 | 2022-10-03 20:53:49 INFO Calibrater::selectvis Frequency selection: |
| 03-Oct-2022 16:53:49 | 2022-10-03 20:53:49 INFO Calibrater::selectvis . Spw 0:0~7 (8 channels, step by 1) |
| 03-Oct-2022 16:53:49 | 2022-10-03 20:53:49 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
| 03-Oct-2022 16:53:49 | 2022-10-03 20:53:49 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 03-Oct-2022 16:53:49 | 2022-10-03 20:53:49 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 03-Oct-2022 16:53:49 | 2022-10-03 20:53:49 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:49 | 2022-10-03 20:53:49 INFO calibrater::correct Beginning correct--------------------------- |
| 03-Oct-2022 16:53:49 | 2022-10-03 20:53:49 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 03-Oct-2022 16:53:49 | 2022-10-03 20:53:49 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:49 | 2022-10-03 20:53:50 INFO calibrater::correct Finished correcting. |
| 03-Oct-2022 16:53:50 | 2022-10-03 20:53:50 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 03-Oct-2022 16:53:50 | test_tool_calibrater.py::calibrater_test::test_selectVisSpw |
| 03-Oct-2022 16:53:50 | Check that spw is properly selected by selectvis |
| 03-Oct-2022 16:53:50 | PASSED |
| 03-Oct-2022 16:53:50 | |
| 03-Oct-2022 16:53:51 | 2022-10-03 20:53:51 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 03-Oct-2022 16:53:51 | 2022-10-03 20:53:51 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:53:51 | 2022-10-03 20:53:51 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:53:51 | 2022-10-03 20:53:51 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:53:52 | 2022-10-03 20:53:52 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:53:52 | 2022-10-03 20:53:53 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 03-Oct-2022 16:53:52 | 2022-10-03 20:53:53 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:53:52 | 2022-10-03 20:53:53 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
| 03-Oct-2022 16:53:52 | 2022-10-03 20:53:53 INFO calibrater::reset Reseting solve/apply state |
| 03-Oct-2022 16:53:52 | 2022-10-03 20:53:53 INFO Calibrater::selectvis Performing selection on MeasurementSet |
| 03-Oct-2022 16:53:52 | 2022-10-03 20:53:53 INFO Calibrater::selectvis+ Selecting on time: '>04:38:23' |
| 03-Oct-2022 16:53:52 | 2022-10-03 20:53:53 INFO Calibrater::selectvis By selection 328860 rows are reduced to 313200 |
| 03-Oct-2022 16:53:52 | 2022-10-03 20:53:53 INFO Calibrater::selectvis Frequency selection: Selecting all channels in all spws. |
| 03-Oct-2022 16:53:52 | 2022-10-03 20:53:53 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
| 03-Oct-2022 16:53:52 | 2022-10-03 20:53:53 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 03-Oct-2022 16:53:52 | 2022-10-03 20:53:53 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 03-Oct-2022 16:53:52 | 2022-10-03 20:53:53 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:52 | 2022-10-03 20:53:53 INFO calibrater::correct Beginning correct--------------------------- |
| 03-Oct-2022 16:53:52 | 2022-10-03 20:53:53 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 03-Oct-2022 16:53:52 | 2022-10-03 20:53:53 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:54 | 2022-10-03 20:53:55 INFO calibrater::correct Finished correcting. |
| 03-Oct-2022 16:53:55 | 2022-10-03 20:53:55 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 03-Oct-2022 16:53:55 | test_tool_calibrater.py::calibrater_test::test_selectVisTime |
| 03-Oct-2022 16:53:55 | Check that time is properly selected by selectvis |
| 03-Oct-2022 16:53:55 | PASSED |
| 03-Oct-2022 16:53:55 | |
| 03-Oct-2022 16:53:55 | 2022-10-03 20:53:55 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 03-Oct-2022 16:53:55 | 2022-10-03 20:53:55 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:53:55 | 2022-10-03 20:53:56 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:53:55 | 2022-10-03 20:53:56 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:53:57 | 2022-10-03 20:53:57 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:53:57 | 2022-10-03 20:53:57 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 03-Oct-2022 16:53:57 | 2022-10-03 20:53:57 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:53:57 | 2022-10-03 20:53:57 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
| 03-Oct-2022 16:53:57 | 2022-10-03 20:53:57 INFO calibrater::reset Reseting solve/apply state |
| 03-Oct-2022 16:53:57 | 2022-10-03 20:53:57 INFO Calibrater::selectvis Performing selection on MeasurementSet |
| 03-Oct-2022 16:53:57 | 2022-10-03 20:53:57 INFO Calibrater::selectvis+ Selecting on uvrange: '> 500000lambda' |
| 03-Oct-2022 16:53:57 | 2022-10-03 20:53:58 INFO Calibrater::selectvis By selection 328860 rows are reduced to 103321 |
| 03-Oct-2022 16:53:57 | 2022-10-03 20:53:58 INFO Calibrater::selectvis Frequency selection: Selecting all channels in all spws. |
| 03-Oct-2022 16:53:57 | 2022-10-03 20:53:58 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
| 03-Oct-2022 16:53:57 | 2022-10-03 20:53:58 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 03-Oct-2022 16:53:57 | 2022-10-03 20:53:58 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 03-Oct-2022 16:53:57 | 2022-10-03 20:53:58 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:57 | 2022-10-03 20:53:58 INFO calibrater::correct Beginning correct--------------------------- |
| 03-Oct-2022 16:53:57 | 2022-10-03 20:53:58 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 03-Oct-2022 16:53:57 | 2022-10-03 20:53:58 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:53:59 | 2022-10-03 20:53:59 INFO calibrater::correct Finished correcting. |
| 03-Oct-2022 16:53:59 | 2022-10-03 20:54:00 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 03-Oct-2022 16:53:59 | test_tool_calibrater.py::calibrater_test::test_selectVisUVrange |
| 03-Oct-2022 16:53:59 | Check that selectvis properly selects for uvrange |
| 03-Oct-2022 16:53:59 | PASSED |
| 03-Oct-2022 16:53:59 | |
| 03-Oct-2022 16:54:00 | 2022-10-03 20:54:00 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 03-Oct-2022 16:54:00 | 2022-10-03 20:54:00 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:54:00 | 2022-10-03 20:54:00 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:54:00 | 2022-10-03 20:54:00 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:54:01 | 2022-10-03 20:54:02 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:54:01 | 2022-10-03 20:54:02 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 03-Oct-2022 16:54:01 | 2022-10-03 20:54:02 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:54:01 | 2022-10-03 20:54:02 INFO calibrater::parsecallibfile Beginning parsecallibfile-)------- |
| 03-Oct-2022 16:54:01 | 2022-10-03 20:54:02 INFO calibrater::setcallib Beginning setcallib--------- |
| 03-Oct-2022 16:54:01 | 2022-10-03 20:54:02 INFO Calibrater::setcallib2(callib) Arranging to APPLY: |
| 03-Oct-2022 16:54:01 | 2022-10-03 20:54:02 INFO . G Jones: table=gaincaltest2.ms.G0 (by cal library) calWt=true |
| 03-Oct-2022 16:54:01 | 2022-10-03 20:54:02 INFO . 0: |
| 03-Oct-2022 16:54:01 | 2022-10-03 20:54:02 INFO + MS: obs= fld= intent= spw= |
| 03-Oct-2022 16:54:01 | 2022-10-03 20:54:02 INFO + CT: tinterp=linear finterp= |
| 03-Oct-2022 16:54:01 | 2022-10-03 20:54:02 INFO + obsmap=[] fldmap=[] |
| 03-Oct-2022 16:54:01 | 2022-10-03 20:54:02 INFO + spwmap=[] antmap=[] |
| 03-Oct-2022 16:54:01 | 2022-10-03 20:54:02 INFO calibrater::corrupt Beginning corrupt--------------------------- |
| 03-Oct-2022 16:54:01 | 2022-10-03 20:54:02 INFO Calibrater::corrupt2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 03-Oct-2022 16:54:01 | 2022-10-03 20:54:02 INFO Calibrater::corrupt2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 (by cal library) calWt=true |
| 03-Oct-2022 16:54:03 | 2022-10-03 20:54:04 INFO calibrater::corrupt Finished corrupting. |
| 03-Oct-2022 16:54:04 | 2022-10-03 20:54:04 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 03-Oct-2022 16:54:04 | test_tool_calibrater.py::calibrater_test::test_setCalLib |
| 03-Oct-2022 16:54:04 | Check that a provided cal table can be used to corrupt the MODEL_DATA |
| 03-Oct-2022 16:54:04 | PASSED |
| 03-Oct-2022 16:54:04 | |
| 03-Oct-2022 16:54:04 | 2022-10-03 20:54:04 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 03-Oct-2022 16:54:04 | 2022-10-03 20:54:04 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:54:04 | 2022-10-03 20:54:04 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:54:04 | 2022-10-03 20:54:04 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:54:05 | 2022-10-03 20:54:06 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:54:06 | 2022-10-03 20:54:06 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 03-Oct-2022 16:54:06 | 2022-10-03 20:54:06 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:54:06 | 2022-10-03 20:54:06 INFO Calibrater::setCorrDepFlags Setting correlation dependent flags = True |
| 03-Oct-2022 16:54:06 | 2022-10-03 20:54:06 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 03-Oct-2022 16:54:06 | test_tool_calibrater.py::calibrater_test::test_setCorrDepFlags |
| 03-Oct-2022 16:54:06 | Check that corrdepflags will be checked |
| 03-Oct-2022 16:54:06 | PASSED |
| 03-Oct-2022 16:54:06 | |
| 03-Oct-2022 16:54:06 | 2022-10-03 20:54:06 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 03-Oct-2022 16:54:06 | 2022-10-03 20:54:06 INFO calibrater::open Opening MS: ngc5921.ms for calibration. |
| 03-Oct-2022 16:54:06 | 2022-10-03 20:54:06 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:54:06 | 2022-10-03 20:54:06 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:54:06 | 2022-10-03 20:54:07 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:54:06 | 2022-10-03 20:54:07 INFO VisSetUtil::initScrCols Initialized 22653 rows. |
| 03-Oct-2022 16:54:06 | 2022-10-03 20:54:07 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:54:06 | 2022-10-03 20:54:07 INFO calibrater::smooth Beginning smooth--(MSSelection version)------- |
| 03-Oct-2022 16:54:06 | 2022-10-03 20:54:07 INFO Calibrater::smooth Beginning smoothing/interpolating method. |
| 03-Oct-2022 16:54:06 | 2022-10-03 20:54:07 WARN Found pre-v4.1 caltable (/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/ngc5921.gcal); attempting to update... |
| 03-Oct-2022 16:54:06 | 2022-10-03 20:54:07 WARN + SUCCEEDED: trivial OBSERVATION/OBSERVATION_ID have been added. |
| 03-Oct-2022 16:54:06 | 2022-10-03 20:54:07 INFO Calibrater::smooth Storing result in testcalout.cal |
| 03-Oct-2022 16:54:06 | 2022-10-03 20:54:07 INFO Writing solutions to table: testcalout.cal |
| 03-Oct-2022 16:54:06 | 2022-10-03 20:54:07 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 03-Oct-2022 16:54:06 | test_tool_calibrater.py::calibrater_test::test_smoothedCalTables |
| 03-Oct-2022 16:54:06 | Check that the smooth command creates a smoothed cal table |
| 03-Oct-2022 16:54:06 | PASSED |
| 03-Oct-2022 16:54:06 | |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 WARN calibrater::setvi(bool,bool) Forcing use of OLD VisibilityIterator. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO calibrater::open ****Using OLD VI-driven calibrater tool**** |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO calibrater::open Opening MS: ngc5921.ms for calibration. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO VisSetUtil::initScrCols Initialized 22653 rows. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO calibrater::setsolvebandpoly Beginning setsolvebandpoly--(MSSelection version)------- |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO Calibrater::setsolvebandpoly Arranging to SOLVE: |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO Calibrater::setsolvebandpoly . BPOLY: table=bpoly append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode= solnorm=true normtype=MEAN |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO calibrater::solve Beginning solve----------------------------- |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO Calibrater::solve The following calibration terms are arranged for apply: |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO Calibrater::solve . (None) |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO Calibrater::solve The following calibration term is arranged for solve: |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO Calibrater::solve . BPOLY: table=bpoly append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode= solnorm=true normtype=MEAN |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO Calibrater::solve Solving for BPOLY |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO For solint = inf, found 7 solution intervals. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO BJonesPoly::selfSolveOne() THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO BJonesPoly::selfSolveOne() Fitting bandpass amplitude and phase polynomials. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO BJonesPoly::selfSolveOne() Polynomial degree for amplitude is 5 |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO BJonesPoly::selfSolveOne() Polynomial degree for phase is 7 |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO BJonesPoly::selfSolveOne() Spectral grid for fit will have 63 points spaced by 24.4141 kHz. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO BJonesPoly::selfSolveOne() Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO BJonesPoly::selfSolveOne() Total bandwidth: 1538.09 kHz. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO BJonesPoly::selfSolveOne() Found data for 351 baselines among 27 antennas. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.059507/0.0681762/0.0765806 |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 0.33653/0.750193/1.6779 |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0630839/0.0689061/0.0756384 |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 0.279482/0.74979/1.59355 |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:07 INFO BJonesPoly::selfSolveOne() Normalizing antenna-based solutions. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::updateCalTable() Storing calibration in table bpoly |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Fitting bandpass amplitude and phase polynomials. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Polynomial degree for amplitude is 5 |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Polynomial degree for phase is 7 |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Spectral grid for fit will have 63 points spaced by 24.4141 kHz. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Total bandwidth: 1538.09 kHz. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Found data for 351 baselines among 27 antennas. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0672607/0.089081/0.111106 |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 2.31075/3.32219/4.29305 |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0652822/0.0889198/0.116912 |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 2.44269/3.26616/4.3519 |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Normalizing antenna-based solutions. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::updateCalTable() Storing calibration in table bpoly |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Fitting bandpass amplitude and phase polynomials. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Polynomial degree for amplitude is 5 |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Polynomial degree for phase is 7 |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Spectral grid for fit will have 63 points spaced by 24.4141 kHz. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Total bandwidth: 1538.09 kHz. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Found data for 351 baselines among 27 antennas. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.350681/0.587724/0.894558 |
| 03-Oct-2022 16:54:07 | 2022-10-03 20:54:08 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 03-Oct-2022 16:54:08 | 2022-10-03 20:54:09 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 21.296/59.0077/111.454 |
| 03-Oct-2022 16:54:08 | 2022-10-03 20:54:09 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 03-Oct-2022 16:54:08 | 2022-10-03 20:54:09 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.354236/0.581733/0.988903 |
| 03-Oct-2022 16:54:08 | 2022-10-03 20:54:09 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:09 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 17.2419/56.3249/117.264 |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:09 INFO BJonesPoly::selfSolveOne() Normalizing antenna-based solutions. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:09 INFO BJonesPoly::updateCalTable() Storing calibration in table bpoly |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:09 INFO BJonesPoly::selfSolveOne() THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:09 INFO BJonesPoly::selfSolveOne() Fitting bandpass amplitude and phase polynomials. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:09 INFO BJonesPoly::selfSolveOne() Polynomial degree for amplitude is 5 |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:09 INFO BJonesPoly::selfSolveOne() Polynomial degree for phase is 7 |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:09 INFO BJonesPoly::selfSolveOne() Spectral grid for fit will have 63 points spaced by 24.4141 kHz. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:09 INFO BJonesPoly::selfSolveOne() Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:09 INFO BJonesPoly::selfSolveOne() Total bandwidth: 1538.09 kHz. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:09 INFO BJonesPoly::selfSolveOne() Found data for 351 baselines among 27 antennas. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0850169/0.113968/0.15276 |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 3.67561/5.33243/8.17296 |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0784237/0.114345/0.159908 |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 3.46392/5.27232/7.20673 |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Normalizing antenna-based solutions. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::updateCalTable() Storing calibration in table bpoly |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Fitting bandpass amplitude and phase polynomials. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Polynomial degree for amplitude is 5 |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Polynomial degree for phase is 7 |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Spectral grid for fit will have 63 points spaced by 24.4141 kHz. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Total bandwidth: 1538.09 kHz. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Found data for 351 baselines among 27 antennas. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0703936/0.102501/0.131676 |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 2.98728/4.47977/5.84264 |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0751114/0.102994/0.138529 |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 3.18629/4.47068/5.89411 |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Normalizing antenna-based solutions. |
| 03-Oct-2022 16:54:09 | 2022-10-03 20:54:10 INFO BJonesPoly::updateCalTable() Storing calibration in table bpoly |
| 03-Oct-2022 16:54:10 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION |
| 03-Oct-2022 16:54:10 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Fitting bandpass amplitude and phase polynomials. |
| 03-Oct-2022 16:54:10 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Polynomial degree for amplitude is 5 |
| 03-Oct-2022 16:54:10 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Polynomial degree for phase is 7 |
| 03-Oct-2022 16:54:10 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Spectral grid for fit will have 63 points spaced by 24.4141 kHz. |
| 03-Oct-2022 16:54:10 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz. |
| 03-Oct-2022 16:54:10 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Total bandwidth: 1538.09 kHz. |
| 03-Oct-2022 16:54:10 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Found data for 351 baselines among 27 antennas. |
| 03-Oct-2022 16:54:10 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 03-Oct-2022 16:54:10 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.350626/0.604424/0.974388 |
| 03-Oct-2022 16:54:10 | 2022-10-03 20:54:10 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 03-Oct-2022 16:54:10 | 2022-10-03 20:54:11 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 21.2542/59.3511/120.719 |
| 03-Oct-2022 16:54:10 | 2022-10-03 20:54:11 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 03-Oct-2022 16:54:10 | 2022-10-03 20:54:11 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.382806/0.598119/0.941571 |
| 03-Oct-2022 16:54:10 | 2022-10-03 20:54:11 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 20.0637/57.2112/118.101 |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO BJonesPoly::selfSolveOne() Normalizing antenna-based solutions. |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO BJonesPoly::updateCalTable() Storing calibration in table bpoly |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO BJonesPoly::selfSolveOne() THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO BJonesPoly::selfSolveOne() Fitting bandpass amplitude and phase polynomials. |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO BJonesPoly::selfSolveOne() Polynomial degree for amplitude is 5 |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO BJonesPoly::selfSolveOne() Polynomial degree for phase is 7 |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO BJonesPoly::selfSolveOne() Spectral grid for fit will have 63 points spaced by 24.4141 kHz. |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO BJonesPoly::selfSolveOne() Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz. |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO BJonesPoly::selfSolveOne() Total bandwidth: 1538.09 kHz. |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO BJonesPoly::selfSolveOne() Found data for 351 baselines among 27 antennas. |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0750931/0.0978998/0.125897 |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 2.72933/3.98787/5.33715 |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0658572/0.0972125/0.140794 |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 2.97943/3.97841/5.72903 |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO BJonesPoly::selfSolveOne() Normalizing antenna-based solutions. |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO BJonesPoly::updateCalTable() Storing calibration in table bpoly |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO Calibrater::solve Found good BPOLY solutions in 7 slots. |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 INFO calibrater::solve Finished solving. |
| 03-Oct-2022 16:54:11 | 2022-10-03 20:54:12 WARN calibrater::setvi(bool,bool) Forcing use of NEW VisibilityIterator. |
| 03-Oct-2022 16:54:11 | test_tool_calibrater.py::calibrater_test::test_solveBandpass |
| 03-Oct-2022 16:54:11 | Check that solve band poly creates the output table |
| 03-Oct-2022 16:54:11 | PASSED |
| 03-Oct-2022 16:54:11 | |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:12 WARN calibrater::setvi(bool,bool) Forcing use of OLD VisibilityIterator. |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:12 INFO calibrater::open ****Using OLD VI-driven calibrater tool**** |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:12 INFO calibrater::open Opening MS: ngc5921.ms for calibration. |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:12 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:12 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:12 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:12 INFO VisSetUtil::initScrCols Initialized 22653 rows. |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:12 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:12 INFO calibrater::setsolvegainspline Beginning setsolvegainspline--(MSSelection version)------- |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:12 INFO Calibrater::setsolvegainspline Arranging to SOLVE: |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:12 INFO Calibrater::setsolvegainspline . GSPLINE: table=gainspline append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AMP solnorm=false |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:12 INFO calibrater::solve Beginning solve----------------------------- |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:12 INFO Calibrater::solve The following calibration terms are arranged for apply: |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:12 INFO Calibrater::solve . (None) |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:12 INFO Calibrater::solve The following calibration term is arranged for solve: |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:12 INFO Calibrater::solve . GSPLINE: table=gainspline append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AMP solnorm=false |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:12 INFO GJonesSpline::solve() Fitting time-dependent cubic splines. |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:12 INFO GJonesSpline::solve() Solving for phase splines with splinetime= 10800 |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:12 INFO GJonesSpline::solve() Solving for amplitude splines with splinetime= 10800 |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:12 INFO GJonesSpline::solve() Accumulating data for: field= 1331+30500002_0, spw= 0, nchan= 63 |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:13 INFO GJonesSpline::solve() Accumulating data for: field= 1445+09900002_0, spw= 0, nchan= 63 |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:13 INFO GJonesSpline::solve() Accumulating data for: field= N5921_2, spw= 0, nchan= 63 |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:13 INFO GJonesSpline::solve() Number of timestamps in data = 60 |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:13 INFO GJonesSpline::getKnots() Gridded splinetime = 5280 sec. |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:13 INFO GJonesSpline::solve() Number of cubic spline control points = 4 |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:13 INFO GJonesSpline::solve() Number of cubic spline knots = 8 |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:13 INFO GJonesSpline::solve() Number of cubic spline segments = 1 |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:13 INFO GJonesSpline::solve() Fitting amplitude spline. |
| 03-Oct-2022 16:54:12 | test_tool_calibrater.py::calibrater_test::test_solveGainspline DPBTRF ;problem leading minor 23 |
| 03-Oct-2022 16:54:12 | DPBTRF ;problem leading minor 23 |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:13 INFO GJonesSpline::solve() Searching for and correcting phase-wraps on each baseline. |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:13 INFO GJonesSpline::solve() Fitting phase spline. |
| 03-Oct-2022 16:54:12 | DPBTRF ;problem leading minor 22 |
| 03-Oct-2022 16:54:12 | DPBTRF ;problem leading minor 22 |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:13 INFO GJonesSpline::updateCalTable Storing solutions in table gainspline |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:13 INFO calibrater::solve Finished solving. |
| 03-Oct-2022 16:54:12 | 2022-10-03 20:54:13 WARN calibrater::setvi(bool,bool) Forcing use of NEW VisibilityIterator. |
| 03-Oct-2022 16:54:12 | |
| 03-Oct-2022 16:54:12 | Check that solve gain spline creates the output table |
| 03-Oct-2022 16:54:12 | PASSED |
| 03-Oct-2022 16:54:12 | |
| 03-Oct-2022 16:54:13 | 2022-10-03 20:54:13 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 03-Oct-2022 16:54:13 | 2022-10-03 20:54:13 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:54:13 | 2022-10-03 20:54:13 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:54:13 | 2022-10-03 20:54:13 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:54:14 | 2022-10-03 20:54:15 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:54:14 | 2022-10-03 20:54:15 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 03-Oct-2022 16:54:14 | 2022-10-03 20:54:15 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:54:14 | 2022-10-03 20:54:15 INFO calibrater::specifycal Beginning specifycal----------------------- |
| 03-Oct-2022 16:54:14 | 2022-10-03 20:54:15 INFO Creating G Jones table from specified parameters. |
| 03-Oct-2022 16:54:14 | 2022-10-03 20:54:15 INFO Generating 'G' corrections. |
| 03-Oct-2022 16:54:14 | 2022-10-03 20:54:15 INFO Specified parameter(s) (per spw and pol) repeated on all antennas. |
| 03-Oct-2022 16:54:14 | 2022-10-03 20:54:15 INFO Specified parameter(s) (per spw and antenna) repeated on all polarizations. |
| 03-Oct-2022 16:54:14 | 2022-10-03 20:54:15 INFO spwId=1 antId=<all> polId=<all> parameter= 3 (ip0,ip1 = [0, 0, 0],[1, 0, 9]) |
| 03-Oct-2022 16:54:14 | 2022-10-03 20:54:15 INFO Writing solutions to table: testcalout.cal |
| 03-Oct-2022 16:54:14 | 2022-10-03 20:54:15 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 03-Oct-2022 16:54:14 | test_tool_calibrater.py::calibrater_test::test_specifyCal |
| 03-Oct-2022 16:54:14 | Check that specifycal can set values for specific spws and antennas |
| 03-Oct-2022 16:54:14 | PASSED |
| 03-Oct-2022 16:54:14 | |
| 03-Oct-2022 16:54:15 | 2022-10-03 20:54:15 WARN calibrater::setvi(bool,bool) Forcing use of OLD VisibilityIterator. |
| 03-Oct-2022 16:54:15 | 2022-10-03 20:54:15 INFO calibrater::open ****Using OLD VI-driven calibrater tool**** |
| 03-Oct-2022 16:54:15 | 2022-10-03 20:54:15 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:54:15 | 2022-10-03 20:54:15 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:54:15 | 2022-10-03 20:54:15 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:54:16 | 2022-10-03 20:54:17 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:54:16 | 2022-10-03 20:54:17 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 03-Oct-2022 16:54:16 | 2022-10-03 20:54:17 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:54:16 | 2022-10-03 20:54:17 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 03-Oct-2022 16:54:16 | 2022-10-03 20:54:17 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 03-Oct-2022 16:54:16 | 2022-10-03 20:54:17 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:54:16 | 2022-10-03 20:54:17 INFO calibrater::setsolve Beginning setsolve--(MSSelection version)------- |
| 03-Oct-2022 16:54:16 | 2022-10-03 20:54:17 INFO Calibrater::setsolve Arranging to SOLVE: |
| 03-Oct-2022 16:54:16 | 2022-10-03 20:54:17 INFO Calibrater::setsolve . Mf Mueller: table=output.ms append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false |
| 03-Oct-2022 16:54:16 | 2022-10-03 20:54:17 INFO Calibrater::state The following calibration terms are arranged for apply: |
| 03-Oct-2022 16:54:16 | 2022-10-03 20:54:17 INFO Calibrater::state . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:54:16 | 2022-10-03 20:54:17 INFO Calibrater::state The following calibration term is arranged for solve: |
| 03-Oct-2022 16:54:16 | 2022-10-03 20:54:17 INFO Calibrater::state . Mf Mueller: table=output.ms append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false |
| 03-Oct-2022 16:54:16 | 2022-10-03 20:54:17 INFO calibrater::solve Beginning solve----------------------------- |
| 03-Oct-2022 16:54:16 | 2022-10-03 20:54:17 INFO Calibrater::solve The following calibration terms are arranged for apply: |
| 03-Oct-2022 16:54:16 | 2022-10-03 20:54:17 INFO Calibrater::solve . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:54:16 | 2022-10-03 20:54:17 INFO Calibrater::solve The following calibration term is arranged for solve: |
| 03-Oct-2022 16:54:16 | 2022-10-03 20:54:17 INFO Calibrater::solve . Mf Mueller: table=output.ms append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false |
| 03-Oct-2022 16:54:16 | 2022-10-03 20:54:17 INFO Solving for Mf Mueller |
| 03-Oct-2022 16:54:17 | 2022-10-03 20:54:17 INFO For solint = inf, found 84 solution intervals. |
| 03-Oct-2022 16:54:18 | 2022-10-03 20:54:18 INFO Found good Mf Mueller solutions in 84 intervals. |
| 03-Oct-2022 16:54:18 | 2022-10-03 20:54:18 INFO Writing solutions to table: output.ms |
| 03-Oct-2022 16:54:18 | 2022-10-03 20:54:18 INFO calibrater::solve Finished solving. |
| 03-Oct-2022 16:54:18 | 2022-10-03 20:54:18 WARN calibrater::setvi(bool,bool) Forcing use of NEW VisibilityIterator. |
| 03-Oct-2022 16:54:18 | test_tool_calibrater.py::calibrater_test::test_standardPath |
| 03-Oct-2022 16:54:18 | open setapply setsolve state solve close |
| 03-Oct-2022 16:54:18 | PASSED |
| 03-Oct-2022 16:54:18 | |
| 03-Oct-2022 16:54:18 | 2022-10-03 20:54:19 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 03-Oct-2022 16:54:18 | 2022-10-03 20:54:19 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:54:18 | 2022-10-03 20:54:19 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:54:18 | 2022-10-03 20:54:19 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO name:: No table opened. |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO showcache:: The Table Cache has the following 16 entries: |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO showcache:: 0: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms" |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO showcache:: 1: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/ANTENNA" |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO showcache:: 2: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/DATA_DESCRIPTION" |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO showcache:: 3: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FEED" |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO showcache:: 4: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FIELD" |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO showcache:: 5: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FLAG_CMD" |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO showcache:: 6: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/HISTORY" |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO showcache:: 7: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/OBSERVATION" |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO showcache:: 8: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/POINTING" |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO showcache:: 9: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/POLARIZATION" |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO showcache:: 10: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/PROCESSOR" |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO showcache:: 11: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SOURCE" |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO showcache:: 12: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SPECTRAL_WINDOW" |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO showcache:: 13: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/STATE" |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO showcache:: 14: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SYSCAL" |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO showcache:: 15: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/WEATHER" |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO name:: No table opened. |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 INFO showcache:: The Table Cache is empty. |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:20 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 03-Oct-2022 16:54:20 | test_tool_calibrater.py::calibrater_test::test_takesMs |
| 03-Oct-2022 16:54:20 | Check that the calibrater tool can open and close an MS |
| 03-Oct-2022 16:54:20 | PASSED |
| 03-Oct-2022 16:54:20 | |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:21 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:21 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:21 INFO Clearing all model records in MS header. |
| 03-Oct-2022 16:54:20 | 2022-10-03 20:54:21 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 03-Oct-2022 16:54:22 | 2022-10-03 20:54:22 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 03-Oct-2022 16:54:22 | 2022-10-03 20:54:22 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 03-Oct-2022 16:54:22 | 2022-10-03 20:54:22 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 03-Oct-2022 16:54:22 | 2022-10-03 20:54:22 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 03-Oct-2022 16:54:22 | 2022-10-03 20:54:22 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 03-Oct-2022 16:54:22 | 2022-10-03 20:54:22 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:54:22 | 2022-10-03 20:54:22 INFO calibrater::correct Beginning correct--------------------------- |
| 03-Oct-2022 16:54:22 | 2022-10-03 20:54:22 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 03-Oct-2022 16:54:22 | 2022-10-03 20:54:22 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 03-Oct-2022 16:54:24 | 2022-10-03 20:54:25 INFO calibrater::correct Finished correcting. |
| 03-Oct-2022 16:54:24 | 2022-10-03 20:54:25 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 03-Oct-2022 16:54:24 | test_tool_calibrater.py::calibrater_test::test_writeToCorrected |
| 03-Oct-2022 16:54:24 | Check that the tool writes to the CORRECTED_DATA column |
| 03-Oct-2022 16:54:24 | PASSED |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | - generated xml file: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/xml/test_tool_calibrater/nose.xml - |
| 03-Oct-2022 16:54:24 | ======================== 24 passed in 85.98s (0:01:25) ========================= |
| 03-Oct-2022 16:54:24 | Traceback (most recent call last): |
| 03-Oct-2022 16:54:24 | /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_componentlist/test_tool_componentlist.py |
| 03-Oct-2022 16:54:24 | File "runtest.py", line 593, in run |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | shutil.copy2("{}{}.py".format(workdir + "tests/",test), workdir + "{}/".format(test if not test.endswith(".py") else test[:-3])) |
| 03-Oct-2022 16:54:24 | Test Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_componentlist |
| 03-Oct-2022 16:54:24 | File "/opt/casa/03/Library/Frameworks/Python.framework/Versions/3.6/lib/python3.6/shutil.py", line 263, in copy2 |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | copyfile(src, dst, follow_symlinks=follow_symlinks) |
| 03-Oct-2022 16:54:24 | Running Command: pytest --junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/xml/test_tool_componentlist/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_componentlist/ |
| 03-Oct-2022 16:54:24 | File "/opt/casa/03/Library/Frameworks/Python.framework/Versions/3.6/lib/python3.6/shutil.py", line 120, in copyfile |
| 03-Oct-2022 16:54:24 | with open(src, 'rb') as fsrc: |
| 03-Oct-2022 16:54:24 | FileNotFoundError: [Errno 2] No such file or directory: '/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/tests/test_tool_image_fromcomplist.py' |
| 03-Oct-2022 16:54:24 | test_tool_vpmanager |
| 03-Oct-2022 16:54:24 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_vpmanager/ |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/tests/test_tool_vpmanager.py to /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_vpmanager/test_tool_vpmanager.py |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Test Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_vpmanager |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Running Command: pytest --junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/xml/test_tool_vpmanager/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_vpmanager/ |
| 03-Oct-2022 16:54:24 | test_tool_coordsys |
| 03-Oct-2022 16:54:24 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_coordsys/ |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/tests/test_tool_coordsys.py to /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_coordsys/test_tool_coordsys.py |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Test Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_coordsys |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Running Command: pytest --junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/xml/test_tool_coordsys/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_coordsys/ |
| 03-Oct-2022 16:54:24 | test_tool_agentflagger |
| 03-Oct-2022 16:54:24 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_agentflagger/ |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/tests/test_tool_agentflagger.py to /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_agentflagger/test_tool_agentflagger.py |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Test Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_agentflagger |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Running Command: pytest --junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/xml/test_tool_agentflagger/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_agentflagger/ |
| 03-Oct-2022 16:54:24 | test_tool_image_statistics |
| 03-Oct-2022 16:54:24 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_statistics/ |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/tests/test_tool_image_statistics.py to /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_statistics/test_tool_image_statistics.py |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Test Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_statistics |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Running Command: pytest --junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/xml/test_tool_image_statistics/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_statistics/ |
| 03-Oct-2022 16:54:24 | test_tool_image_fitprofile |
| 03-Oct-2022 16:54:24 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_fitprofile/ |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/tests/test_tool_image_fitprofile.py to /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_fitprofile/test_tool_image_fitprofile.py |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Test Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_fitprofile |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Running Command: pytest --junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/xml/test_tool_image_fitprofile/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_fitprofile/ |
| 03-Oct-2022 16:54:24 | test_tool_linearmosaic |
| 03-Oct-2022 16:54:24 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_linearmosaic/ |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/tests/test_tool_linearmosaic.py to /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_linearmosaic/test_tool_linearmosaic.py |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Test Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_linearmosaic |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Running Command: pytest --junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/xml/test_tool_linearmosaic/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_linearmosaic/ |
| 03-Oct-2022 16:54:24 | test_tool_ms_createmultims |
| 03-Oct-2022 16:54:24 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_ms_createmultims/ |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/tests/test_tool_ms_createmultims.py to /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_ms_createmultims/test_tool_ms_createmultims.py |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Test Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_ms_createmultims |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Running Command: pytest --junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/xml/test_tool_ms_createmultims/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_ms_createmultims/ |
| 03-Oct-2022 16:54:24 | test_tool_image_pv |
| 03-Oct-2022 16:54:24 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_pv/ |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/tests/test_tool_image_pv.py to /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_pv/test_tool_image_pv.py |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Test Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_pv |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Running Command: pytest --junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/xml/test_tool_image_pv/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_pv/ |
| 03-Oct-2022 16:54:24 | test_tool_sdm |
| 03-Oct-2022 16:54:24 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_sdm/ |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/tests/test_tool_sdm.py to /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_sdm/test_tool_sdm.py |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Test Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_sdm |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Running Command: pytest --junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/xml/test_tool_sdm/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_sdm/ |
| 03-Oct-2022 16:54:24 | test_tool_image_regrid |
| 03-Oct-2022 16:54:24 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_regrid/ |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/tests/test_tool_image_regrid.py to /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_regrid/test_tool_image_regrid.py |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Test Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_regrid |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Running Command: pytest --junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/xml/test_tool_image_regrid/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_regrid/ |
| 03-Oct-2022 16:54:24 | test_tool_image_deviation |
| 03-Oct-2022 16:54:24 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_deviation/ |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/tests/test_tool_image_deviation.py to /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_deviation/test_tool_image_deviation.py |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Test Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_deviation |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Running Command: pytest --junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/xml/test_tool_image_deviation/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_deviation/ |
| 03-Oct-2022 16:54:24 | test_tool_image_fromcomplist |
| 03-Oct-2022 16:54:24 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_fromcomplist/ |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/tests/test_tool_image_fromcomplist.py to /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_fromcomplist/test_tool_image_fromcomplist.py |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Test Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_fromcomplist |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Running Command: pytest --junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/xml/test_tool_image_fromcomplist/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_image_fromcomplist/ |
| 03-Oct-2022 16:54:24 | test_tool_calibrater |
| 03-Oct-2022 16:54:24 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/ |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/tests/test_tool_calibrater.py to /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/test_tool_calibrater.py |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Test Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater |
| 03-Oct-2022 16:54:24 | |
| 03-Oct-2022 16:54:24 | Running Command: pytest --junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/xml/test_tool_calibrater/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/ |
| 03-Oct-2022 16:54:24 | Finished task 'Test wheel' with result: Success |
| 03-Oct-2022 16:54:24 | Starting task 'Parse tests' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit' |
| 03-Oct-2022 16:54:24 | Parsing test results under /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15... |
| 03-Oct-2022 16:54:25 | Finished task 'Parse tests' with result: Success |
| 03-Oct-2022 16:54:25 | Starting task 'Script' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script' |
| 03-Oct-2022 16:54:25 | Beginning to execute external process for build 'CASA - Casa 6 Dev Test Full - CAS-13876 - Test tools OSX1015 #1 (CASA-C6DTF231-TTO15-1)' ... running command line: /Users/casaci/bamboohome/temp/CASA-C6DTF231-TTO15-1-ScriptBuildTask-7804242668248572910.sh ... in: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15 |
| 03-Oct-2022 16:54:25 | Cloning into 'casa-build-utils'... |
| 03-Oct-2022 16:54:25 | /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15 |
| 03-Oct-2022 16:54:28 | Collecting twine |
| 03-Oct-2022 16:54:28 | Using cached https://files.pythonhosted.org/packages/5e/74/ea7dfb86223695fd8efa256a24d1520729dde79a4e628ee6879f0f136d40/twine-3.8.0-py3-none-any.whl |
| 03-Oct-2022 16:54:28 | Collecting keyring>=15.1 (from twine) |
| 03-Oct-2022 16:54:28 | Using cached https://files.pythonhosted.org/packages/a4/e9/104ec4bffcf971375c348146c2199d4e241294286cc04a428b12c02e5f81/keyring-23.4.1-py3-none-any.whl |
| 03-Oct-2022 16:54:28 | Collecting rfc3986>=1.4.0 (from twine) |
| 03-Oct-2022 16:54:28 | Using cached https://files.pythonhosted.org/packages/c4/e5/63ca2c4edf4e00657584608bee1001302bbf8c5f569340b78304f2f446cb/rfc3986-1.5.0-py2.py3-none-any.whl |
| 03-Oct-2022 16:54:28 | Collecting requests>=2.20 (from twine) |
| 03-Oct-2022 16:54:28 | Using cached https://files.pythonhosted.org/packages/2d/61/08076519c80041bc0ffa1a8af0cbd3bf3e2b62af10435d269a9d0f40564d/requests-2.27.1-py2.py3-none-any.whl |
| 03-Oct-2022 16:54:28 | Collecting tqdm>=4.14 (from twine) |
| 03-Oct-2022 16:54:28 | Using cached https://files.pythonhosted.org/packages/47/bb/849011636c4da2e44f1253cd927cfb20ada4374d8b3a4e425416e84900cc/tqdm-4.64.1-py2.py3-none-any.whl |
| 03-Oct-2022 16:54:28 | Collecting pkginfo>=1.8.1 (from twine) |
| 03-Oct-2022 16:54:28 | Using cached https://files.pythonhosted.org/packages/f3/28/ded592460bc65d39a48fe51d7678c408ae895ee3694d4cd404a131a73271/pkginfo-1.8.3-py2.py3-none-any.whl |
| 03-Oct-2022 16:54:28 | Collecting readme-renderer>=21.0 (from twine) |
| 03-Oct-2022 16:54:28 | Using cached https://files.pythonhosted.org/packages/40/df/a8d87511e806e4c5311d521140a51c34e5ab13e760cd739fc3b89495012d/readme_renderer-34.0-py3-none-any.whl |
| 03-Oct-2022 16:54:28 | Collecting requests-toolbelt!=0.9.0,>=0.8.0 (from twine) |
| 03-Oct-2022 16:54:28 | Using cached https://files.pythonhosted.org/packages/60/ef/7681134338fc097acef8d9b2f8abe0458e4d87559c689a8c306d0957ece5/requests_toolbelt-0.9.1-py2.py3-none-any.whl |
| 03-Oct-2022 16:54:28 | Collecting importlib-metadata>=3.6 (from twine) |
| 03-Oct-2022 16:54:28 | Using cached https://files.pythonhosted.org/packages/a0/a1/b153a0a4caf7a7e3f15c2cd56c7702e2cf3d89b1b359d1f1c5e59d68f4ce/importlib_metadata-4.8.3-py3-none-any.whl |
| 03-Oct-2022 16:54:28 | Collecting colorama>=0.4.3 (from twine) |
| 03-Oct-2022 16:54:28 | Using cached https://files.pythonhosted.org/packages/77/8b/7550e87b2d308a1b711725dfaddc19c695f8c5fa413c640b2be01662f4e6/colorama-0.4.5-py2.py3-none-any.whl |
| 03-Oct-2022 16:54:28 | Collecting urllib3>=1.26.0 (from twine) |
| 03-Oct-2022 16:54:28 | Using cached https://files.pythonhosted.org/packages/6f/de/5be2e3eed8426f871b170663333a0f627fc2924cc386cd41be065e7ea870/urllib3-1.26.12-py2.py3-none-any.whl |
| 03-Oct-2022 16:54:28 | Collecting idna<4,>=2.5; python_version >= "3" (from requests>=2.20->twine) |
| 03-Oct-2022 16:54:28 | Using cached https://files.pythonhosted.org/packages/fc/34/3030de6f1370931b9dbb4dad48f6ab1015ab1d32447850b9fc94e60097be/idna-3.4-py3-none-any.whl |
| 03-Oct-2022 16:54:28 | Collecting certifi>=2017.4.17 (from requests>=2.20->twine) |
| 03-Oct-2022 16:54:28 | Using cached https://files.pythonhosted.org/packages/1d/38/fa96a426e0c0e68aabc68e896584b83ad1eec779265a028e156ce509630e/certifi-2022.9.24-py3-none-any.whl |
| 03-Oct-2022 16:54:28 | Collecting charset-normalizer~=2.0.0; python_version >= "3" (from requests>=2.20->twine) |
| 03-Oct-2022 16:54:29 | Using cached https://files.pythonhosted.org/packages/06/b3/24afc8868eba069a7f03650ac750a778862dc34941a4bebeb58706715726/charset_normalizer-2.0.12-py3-none-any.whl |
| 03-Oct-2022 16:54:29 | Collecting importlib-resources; python_version < "3.7" (from tqdm>=4.14->twine) |
| 03-Oct-2022 16:54:29 | Using cached https://files.pythonhosted.org/packages/24/1b/33e489669a94da3ef4562938cd306e8fa915e13939d7b8277cb5569cb405/importlib_resources-5.4.0-py3-none-any.whl |
| 03-Oct-2022 16:54:29 | Collecting Pygments>=2.5.1 (from readme-renderer>=21.0->twine) |
| 03-Oct-2022 16:54:29 | Using cached https://files.pythonhosted.org/packages/4f/82/672cd382e5b39ab1cd422a672382f08a1fb3d08d9e0c0f3707f33a52063b/Pygments-2.13.0-py3-none-any.whl |
| 03-Oct-2022 16:54:29 | Collecting bleach>=2.1.0 (from readme-renderer>=21.0->twine) |
| 03-Oct-2022 16:54:29 | Using cached https://files.pythonhosted.org/packages/64/cc/74d634e1e5659742973a23bb441404c53a7bedb6cd3962109ca5efb703e8/bleach-4.1.0-py2.py3-none-any.whl |
| 03-Oct-2022 16:54:29 | Collecting docutils>=0.13.1 (from readme-renderer>=21.0->twine) |
| 03-Oct-2022 16:54:29 | Using cached https://files.pythonhosted.org/packages/8d/14/69b4bad34e3f250afe29a854da03acb6747711f3df06c359fa053fae4e76/docutils-0.18.1-py2.py3-none-any.whl |
| 03-Oct-2022 16:54:29 | Collecting zipp>=0.5 (from importlib-metadata>=3.6->twine) |
| 03-Oct-2022 16:54:29 | Using cached https://files.pythonhosted.org/packages/bd/df/d4a4974a3e3957fd1c1fa3082366d7fff6e428ddb55f074bf64876f8e8ad/zipp-3.6.0-py3-none-any.whl |
| 03-Oct-2022 16:54:29 | Collecting typing-extensions>=3.6.4; python_version < "3.8" (from importlib-metadata>=3.6->twine) |
| 03-Oct-2022 16:54:29 | Using cached https://files.pythonhosted.org/packages/45/6b/44f7f8f1e110027cf88956b59f2fad776cca7e1704396d043f89effd3a0e/typing_extensions-4.1.1-py3-none-any.whl |
| 03-Oct-2022 16:54:29 | Collecting webencodings (from bleach>=2.1.0->readme-renderer>=21.0->twine) |
| 03-Oct-2022 16:54:29 | Using cached https://files.pythonhosted.org/packages/f4/24/2a3e3df732393fed8b3ebf2ec078f05546de641fe1b667ee316ec1dcf3b7/webencodings-0.5.1-py2.py3-none-any.whl |
| 03-Oct-2022 16:54:29 | Collecting six>=1.9.0 (from bleach>=2.1.0->readme-renderer>=21.0->twine) |
| 03-Oct-2022 16:54:29 | Using cached https://files.pythonhosted.org/packages/d9/5a/e7c31adbe875f2abbb91bd84cf2dc52d792b5a01506781dbcf25c91daf11/six-1.16.0-py2.py3-none-any.whl |
| 03-Oct-2022 16:54:29 | Collecting packaging (from bleach>=2.1.0->readme-renderer>=21.0->twine) |
| 03-Oct-2022 16:54:29 | Using cached https://files.pythonhosted.org/packages/05/8e/8de486cbd03baba4deef4142bd643a3e7bbe954a784dc1bb17142572d127/packaging-21.3-py3-none-any.whl |
| 03-Oct-2022 16:54:29 | Collecting pyparsing!=3.0.5,>=2.0.2 (from packaging->bleach>=2.1.0->readme-renderer>=21.0->twine) |
| 03-Oct-2022 16:54:29 | Using cached https://files.pythonhosted.org/packages/6c/10/a7d0fa5baea8fe7b50f448ab742f26f52b80bfca85ac2be9d35cdd9a3246/pyparsing-3.0.9-py3-none-any.whl |
| 03-Oct-2022 16:54:29 | Installing collected packages: zipp, typing-extensions, importlib-metadata, keyring, rfc3986, idna, urllib3, certifi, charset-normalizer, requests, importlib-resources, tqdm, pkginfo, Pygments, webencodings, six, pyparsing, packaging, bleach, docutils, readme-renderer, requests-toolbelt, colorama, twine |
| 03-Oct-2022 16:54:31 | Successfully installed Pygments-2.13.0 bleach-4.1.0 certifi-2022.9.24 charset-normalizer-2.0.12 colorama-0.4.5 docutils-0.18.1 idna-3.4 importlib-metadata-4.8.3 importlib-resources-5.4.0 keyring-23.4.1 packaging-21.3 pkginfo-1.8.3 pyparsing-3.0.9 readme-renderer-34.0 requests-2.27.1 requests-toolbelt-0.9.1 rfc3986-1.5.0 six-1.16.0 tqdm-4.64.1 twine-3.8.0 typing-extensions-4.1.1 urllib3-1.26.12 webencodings-0.5.1 zipp-3.6.0 |
| 03-Oct-2022 16:54:31 | You are using pip version 18.1, however version 21.3.1 is available. |
| 03-Oct-2022 16:54:31 | You should consider upgrading via the 'pip install --upgrade pip' command. |
| 03-Oct-2022 16:54:32 | Uploading distributions to https://casa-pip.nrao.edu:443/repository/casa-dev-wheel/ |
| 03-Oct-2022 16:54:32 | Uploading casatools-6.5.1.19a13876.dev10-cp36-cp36m-macosx_10_15_x86_64.whl |
| 03-Oct-2022 16:54:32 | |
| 03-Oct-2022 16:54:32 | 0%| | 0.00/108M [00:00<?, ?B/s] |
| 03-Oct-2022 16:54:32 | 3%|▎ | 3.20M/108M [00:00<00:03, 33.6MB/s] |
| 03-Oct-2022 16:54:32 | 10%|█ | 11.3M/108M [00:00<00:01, 63.6MB/s] |
| 03-Oct-2022 16:54:32 | 15%|█▌ | 16.6M/108M [00:00<00:01, 59.9MB/s] |
| 03-Oct-2022 16:54:33 | 19%|█▊ | 20.1M/108M [00:00<00:01, 50.9MB/s] |
| 03-Oct-2022 16:54:33 | 22%|██▏ | 23.4M/108M [00:00<00:01, 45.0MB/s] |
| 03-Oct-2022 16:54:33 | 24%|██▍ | 25.7M/108M [00:00<00:02, 37.0MB/s] |
| 03-Oct-2022 16:54:33 | 28%|██▊ | 29.9M/108M [00:00<00:02, 35.2MB/s] |
| 03-Oct-2022 16:54:33 | 32%|███▏ | 34.3M/108M [00:00<00:02, 34.7MB/s] |
| 03-Oct-2022 16:54:33 | 36%|███▌ | 38.6M/108M [00:01<00:02, 33.9MB/s] |
| 03-Oct-2022 16:54:33 | 39%|███▉ | 42.0M/108M [00:01<00:02, 34.3MB/s] |
| 03-Oct-2022 16:54:33 | 42%|████▏ | 45.2M/108M [00:01<00:02, 32.6MB/s] |
| 03-Oct-2022 16:54:34 | 46%|████▌ | 49.3M/108M [00:01<00:01, 32.2MB/s] |
| 03-Oct-2022 16:54:34 | 50%|████▉ | 53.5M/108M [00:01<00:01, 31.8MB/s] |
| 03-Oct-2022 16:54:34 | 54%|█████▎ | 57.7M/108M [00:01<00:01, 32.0MB/s] |
| 03-Oct-2022 16:54:34 | 58%|█████▊ | 62.0M/108M [00:01<00:01, 32.5MB/s] |
| 03-Oct-2022 16:54:34 | 61%|██████▏ | 66.2M/108M [00:01<00:01, 32.6MB/s] |
| 03-Oct-2022 16:54:34 | 64%|██████▍ | 68.9M/108M [00:02<00:01, 31.6MB/s] |
| 03-Oct-2022 16:54:34 | 67%|██████▋ | 72.6M/108M [00:02<00:01, 31.3MB/s] |
| 03-Oct-2022 16:54:34 | 71%|███████▏ | 76.8M/108M [00:02<00:01, 31.4MB/s] |
| 03-Oct-2022 16:54:35 | 75%|███████▌ | 81.0M/108M [00:02<00:00, 32.3MB/s] |
| 03-Oct-2022 16:54:35 | 79%|███████▉ | 85.2M/108M [00:02<00:00, 32.7MB/s] |
| 03-Oct-2022 16:54:35 | 83%|████████▎ | 89.5M/108M [00:02<00:00, 32.4MB/s] |
| 03-Oct-2022 16:54:35 | 87%|████████▋ | 93.6M/108M [00:02<00:00, 33.0MB/s] |
| 03-Oct-2022 16:54:35 | 91%|█████████ | 97.9M/108M [00:02<00:00, 33.1MB/s] |
| 03-Oct-2022 16:54:35 | 95%|█████████▍| 102M/108M [00:03<00:00, 33.2MB/s] |
| 03-Oct-2022 16:54:36 | 99%|█████████▉| 107M/108M [00:03<00:00, 36.9MB/s] |
| 03-Oct-2022 16:54:36 | 100%|██████████| 108M/108M [00:03<00:00, 31.0MB/s] |
| 03-Oct-2022 16:54:36 | Error during upload. Retry with the --verbose option for more details. |
| 03-Oct-2022 16:54:36 | HTTPError: 400 Bad Request from https://casa-pip.nrao.edu:443/repository/casa-dev-wheel/ |
| 03-Oct-2022 16:54:36 | Repository does not allow updating assets: casa-dev-wheel |
| 03-Oct-2022 16:54:36 | /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15 |
| 03-Oct-2022 16:54:36 | Finished task 'Script' with result: Success |
| 03-Oct-2022 16:54:36 | Starting task 'Reset config.py' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script' |
| 03-Oct-2022 16:54:36 | Beginning to execute external process for build 'CASA - Casa 6 Dev Test Full - CAS-13876 - Test tools OSX1015 #1 (CASA-C6DTF231-TTO15-1)' ... running command line: /Users/casaci/bamboohome/temp/CASA-C6DTF231-TTO15-1-ScriptBuildTask-5274311055057483181.sh ... in: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF231-TTO15 |
| 03-Oct-2022 16:54:36 | % Total % Received % Xferd Average Speed Time Time Time Current |
| 03-Oct-2022 16:54:36 | Dload Upload Total Spent Left Speed |
| 03-Oct-2022 16:54:36 | |
| 03-Oct-2022 16:54:36 | 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 |
| 03-Oct-2022 16:54:36 | 100 70 100 70 0 0 2187 0 --:--:-- --:--:-- --:--:-- 2187 |
| 03-Oct-2022 16:54:36 | Finished task 'Reset config.py' with result: Success |
| 03-Oct-2022 16:54:36 | Running post build plugin 'Docker Container Cleanup' |
| 03-Oct-2022 16:54:36 | Running post build plugin 'NCover Results Collector' |
| 03-Oct-2022 16:54:36 | Running post build plugin 'Clover Results Collector' |
| 03-Oct-2022 16:54:36 | Running post build plugin 'npm Cache Cleanup' |
| 03-Oct-2022 16:54:36 | Running post build plugin 'Artifact Copier' |
| 03-Oct-2022 16:54:36 | Publishing an artifact: OSX10.15 casatools wheel |
| 03-Oct-2022 16:54:40 | Finished publishing of artifact Required shared artifact: [OSX10.15 casatools wheel], pattern: [casatools*.whl] anchored at: [wheeldirectory/] in 4.375 s |
| 03-Oct-2022 16:54:40 | Finalising the build... |
| 03-Oct-2022 16:54:40 | Stopping timer. |
| 03-Oct-2022 16:54:40 | Build CASA-C6DTF231-TTO15-1 completed. |
| 03-Oct-2022 16:54:40 | Running on server: post build plugin 'NCover Results Collector' |
| 03-Oct-2022 16:54:40 | Running on server: post build plugin 'Build Hanging Detection Configuration' |
| 03-Oct-2022 16:54:40 | Running on server: post build plugin 'Clover Delta Calculator' |
| 03-Oct-2022 16:54:40 | Running on server: post build plugin 'Maven Dependencies Postprocessor' |
| 03-Oct-2022 16:54:40 | All post build plugins have finished |
| 03-Oct-2022 16:54:40 | Generating build results summary... |
| 03-Oct-2022 16:54:41 | Saving build results to disk... |
| 03-Oct-2022 16:54:41 | Store variable context... |
| 03-Oct-2022 16:54:41 | Indexing build results... |
| 03-Oct-2022 16:54:41 | Finished building CASA-C6DTF231-TTO15-1. |