Build: #1 was successful
Job: Test tools OSX1015 was successful
Build log
The build generated 52,520 lines of output.The output is too long and has been truncated to the last 1,000 lines. Download or view full build log.
| 27-Sep-2022 05:10:41 | platform darwin -- Python 3.6.8, pytest-5.4.2, py-1.8.1, pluggy-0.13.1 -- /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6testenv/bin/python |
| 27-Sep-2022 05:10:41 | cachedir: .pytest_cache |
| 27-Sep-2022 05:10:41 | rootdir: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater, inifile: pytest.ini |
| 27-Sep-2022 05:10:42 | collecting ... collected 24 items |
| 27-Sep-2022 05:10:42 | |
| 27-Sep-2022 05:10:42 | |
| 27-Sep-2022 05:10:42 | test_tool_calibrater.py::calibrater_test::test_activityRecord |
| 27-Sep-2022 05:10:42 | Check that using the calibrater to modify the vis shows in the activity record |
| 27-Sep-2022 05:10:50 | 2022-09-27 09:10:51 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 27-Sep-2022 05:10:50 | 2022-09-27 09:10:51 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:10:51 | 2022-09-27 09:10:51 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:10:51 | 2022-09-27 09:10:51 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:10:54 | 2022-09-27 09:10:54 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:10:54 | 2022-09-27 09:10:55 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 27-Sep-2022 05:10:54 | 2022-09-27 09:10:55 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:10:54 | 2022-09-27 09:10:55 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 27-Sep-2022 05:10:54 | 2022-09-27 09:10:55 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 27-Sep-2022 05:10:54 | 2022-09-27 09:10:55 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:10:54 | 2022-09-27 09:10:55 INFO calibrater::corrupt Beginning corrupt--------------------------- |
| 27-Sep-2022 05:10:54 | 2022-09-27 09:10:55 INFO Calibrater::corrupt2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 27-Sep-2022 05:10:54 | 2022-09-27 09:10:55 INFO Calibrater::corrupt2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:10:57 | 2022-09-27 09:10:58 INFO calibrater::corrupt Finished corrupting. |
| 27-Sep-2022 05:10:58 | 2022-09-27 09:10:59 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 27-Sep-2022 05:10:58 | PASSED |
| 27-Sep-2022 05:10:58 | |
| 27-Sep-2022 05:10:58 | test_tool_calibrater.py::calibrater_test::test_corruptCal |
| 27-Sep-2022 05:10:58 | Check that the MS is corrupted using the cal table |
| 27-Sep-2022 05:11:03 | 2022-09-27 09:11:03 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 27-Sep-2022 05:11:03 | 2022-09-27 09:11:03 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:11:03 | 2022-09-27 09:11:03 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:11:03 | 2022-09-27 09:11:03 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:11:08 | 2022-09-27 09:11:09 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:11:08 | 2022-09-27 09:11:09 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 27-Sep-2022 05:11:08 | 2022-09-27 09:11:09 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:11:08 | 2022-09-27 09:11:09 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 27-Sep-2022 05:11:08 | 2022-09-27 09:11:09 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 27-Sep-2022 05:11:08 | 2022-09-27 09:11:09 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:11:08 | 2022-09-27 09:11:09 INFO calibrater::corrupt Beginning corrupt--------------------------- |
| 27-Sep-2022 05:11:08 | 2022-09-27 09:11:09 INFO Calibrater::corrupt2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 27-Sep-2022 05:11:08 | 2022-09-27 09:11:09 INFO Calibrater::corrupt2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:11:11 | 2022-09-27 09:11:12 INFO calibrater::corrupt Finished corrupting. |
| 27-Sep-2022 05:11:14 | 2022-09-27 09:11:15 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 27-Sep-2022 05:11:14 | PASSED |
| 27-Sep-2022 05:11:14 | |
| 27-Sep-2022 05:11:14 | test_tool_calibrater.py::calibrater_test::test_createEmpty |
| 27-Sep-2022 05:11:14 | Check that an empty cal table can be created |
| 27-Sep-2022 05:11:18 | 2022-09-27 09:11:19 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 27-Sep-2022 05:11:18 | 2022-09-27 09:11:19 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:11:18 | 2022-09-27 09:11:19 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:11:18 | 2022-09-27 09:11:19 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:11:22 | 2022-09-27 09:11:22 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:11:22 | 2022-09-27 09:11:22 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 27-Sep-2022 05:11:22 | 2022-09-27 09:11:22 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:11:23 | 2022-09-27 09:11:24 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 27-Sep-2022 05:11:24 | PASSED |
| 27-Sep-2022 05:11:24 | |
| 27-Sep-2022 05:11:24 | test_tool_calibrater.py::calibrater_test::test_done |
| 27-Sep-2022 05:11:24 | Check that done closes the active calibrator tool |
| 27-Sep-2022 05:11:27 | 2022-09-27 09:11:28 INFO name:: No table opened. |
| 27-Sep-2022 05:11:27 | 2022-09-27 09:11:28 INFO showcache:: The Table Cache is empty. |
| 27-Sep-2022 05:11:27 | 2022-09-27 09:11:28 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 27-Sep-2022 05:11:27 | 2022-09-27 09:11:28 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:11:27 | 2022-09-27 09:11:28 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:11:27 | 2022-09-27 09:11:28 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:11:31 | 2022-09-27 09:11:31 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:11:31 | 2022-09-27 09:11:32 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 27-Sep-2022 05:11:31 | 2022-09-27 09:11:32 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:11:31 | 2022-09-27 09:11:32 INFO name:: No table opened. |
| 27-Sep-2022 05:11:31 | 2022-09-27 09:11:32 INFO showcache:: The Table Cache has the following 16 entries: |
| 27-Sep-2022 05:11:31 | 2022-09-27 09:11:32 INFO showcache:: 0: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms" |
| 27-Sep-2022 05:11:31 | 2022-09-27 09:11:32 INFO showcache:: 1: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/ANTENNA" |
| 27-Sep-2022 05:11:31 | 2022-09-27 09:11:32 INFO showcache:: 2: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/DATA_DESCRIPTION" |
| 27-Sep-2022 05:11:31 | 2022-09-27 09:11:32 INFO showcache:: 3: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FEED" |
| 27-Sep-2022 05:11:31 | 2022-09-27 09:11:32 INFO showcache:: 4: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FIELD" |
| 27-Sep-2022 05:11:31 | 2022-09-27 09:11:32 INFO showcache:: 5: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FLAG_CMD" |
| 27-Sep-2022 05:11:31 | 2022-09-27 09:11:32 INFO showcache:: 6: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/HISTORY" |
| 27-Sep-2022 05:11:31 | 2022-09-27 09:11:32 INFO showcache:: 7: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/OBSERVATION" |
| 27-Sep-2022 05:11:31 | 2022-09-27 09:11:32 INFO showcache:: 8: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/POINTING" |
| 27-Sep-2022 05:11:31 | 2022-09-27 09:11:32 INFO showcache:: 9: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/POLARIZATION" |
| 27-Sep-2022 05:11:31 | 2022-09-27 09:11:32 INFO showcache:: 10: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/PROCESSOR" |
| 27-Sep-2022 05:11:31 | 2022-09-27 09:11:32 INFO showcache:: 11: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SOURCE" |
| 27-Sep-2022 05:11:31 | 2022-09-27 09:11:32 INFO showcache:: 12: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SPECTRAL_WINDOW" |
| 27-Sep-2022 05:11:31 | 2022-09-27 09:11:32 INFO showcache:: 13: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/STATE" |
| 27-Sep-2022 05:11:31 | 2022-09-27 09:11:32 INFO showcache:: 14: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SYSCAL" |
| 27-Sep-2022 05:11:31 | 2022-09-27 09:11:32 INFO showcache:: 15: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/WEATHER" |
| 27-Sep-2022 05:11:33 | 2022-09-27 09:11:33 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 27-Sep-2022 05:11:33 | PASSED |
| 27-Sep-2022 05:11:33 | |
| 27-Sep-2022 05:11:33 | test_tool_calibrater.py::calibrater_test::test_reinitModel |
| 27-Sep-2022 05:11:33 | Check that initcalset will reset the CORRECTED_DATA to unity |
| 27-Sep-2022 05:11:38 | 2022-09-27 09:11:39 WARN calibrater::setvi(bool,bool) Forcing use of OLD VisibilityIterator. |
| 27-Sep-2022 05:11:38 | 2022-09-27 09:11:39 INFO calibrater::open ****Using OLD VI-driven calibrater tool**** |
| 27-Sep-2022 05:11:38 | 2022-09-27 09:11:39 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:11:38 | 2022-09-27 09:11:39 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:11:38 | 2022-09-27 09:11:39 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:11:43 | 2022-09-27 09:11:43 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:11:43 | 2022-09-27 09:11:43 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 27-Sep-2022 05:11:43 | 2022-09-27 09:11:43 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:11:43 | 2022-09-27 09:11:43 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 27-Sep-2022 05:11:43 | 2022-09-27 09:11:44 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 27-Sep-2022 05:11:43 | 2022-09-27 09:11:44 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:11:43 | 2022-09-27 09:11:44 INFO calibrater::correct Beginning correct--------------------------- |
| 27-Sep-2022 05:11:43 | 2022-09-27 09:11:44 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 27-Sep-2022 05:11:43 | 2022-09-27 09:11:44 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:11:47 | 2022-09-27 09:11:47 INFO calibrater::correct Finished correcting. |
| 27-Sep-2022 05:11:50 | 2022-09-27 09:11:51 INFO calibrater::open ****Using OLD VI-driven calibrater tool**** |
| 27-Sep-2022 05:11:50 | 2022-09-27 09:11:51 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:11:50 | 2022-09-27 09:11:51 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:11:51 | 2022-09-27 09:11:51 INFO calibrater::initcalset Beginning initcalset------------------------ |
| 27-Sep-2022 05:11:51 | 2022-09-27 09:11:51 INFO VisSet::VisSet Initializing MODEL_DATA (to unity) and CORRECTED_DATA (to DATA) |
| 27-Sep-2022 05:11:54 | 2022-09-27 09:11:54 INFO VisSet::VisSet Initialized 328860 rows. |
| 27-Sep-2022 05:11:55 | 2022-09-27 09:11:56 WARN calibrater::setvi(bool,bool) Forcing use of NEW VisibilityIterator. |
| 27-Sep-2022 05:11:55 | PASSED |
| 27-Sep-2022 05:11:55 | |
| 27-Sep-2022 05:11:55 | test_tool_calibrater.py::calibrater_test::test_resetSolveApply |
| 27-Sep-2022 05:11:55 | Check that the reset function can clear set apply and solves |
| 27-Sep-2022 05:12:00 | 2022-09-27 09:12:01 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 27-Sep-2022 05:12:00 | 2022-09-27 09:12:01 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:12:00 | 2022-09-27 09:12:01 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:12:00 | 2022-09-27 09:12:01 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:12:06 | 2022-09-27 09:12:07 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:12:07 | 2022-09-27 09:12:07 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 27-Sep-2022 05:12:07 | 2022-09-27 09:12:07 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:12:07 | 2022-09-27 09:12:07 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 27-Sep-2022 05:12:07 | 2022-09-27 09:12:07 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 27-Sep-2022 05:12:07 | 2022-09-27 09:12:07 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:12:07 | 2022-09-27 09:12:07 INFO calibrater::setsolve Beginning setsolve--(MSSelection version)------- |
| 27-Sep-2022 05:12:07 | 2022-09-27 09:12:07 INFO Calibrater::setsolve Arranging to SOLVE: |
| 27-Sep-2022 05:12:07 | 2022-09-27 09:12:07 INFO Calibrater::setsolve . Mf Mueller: table=gaincaltest2.ms.G0 append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false |
| 27-Sep-2022 05:12:07 | 2022-09-27 09:12:07 INFO calibrater::reset Reseting solve/apply state |
| 27-Sep-2022 05:12:07 | 2022-09-27 09:12:07 INFO calibrater::solve Beginning solve----------------------------- |
| 27-Sep-2022 05:12:07 | 2022-09-27 09:12:07 SEVERE Calibrater::solve Caught exception: Please run setsolve before attempting to solve. |
| 27-Sep-2022 05:12:07 | 2022-09-27 09:12:07 INFO Calibrater::solve Reseting entire solve/apply state. |
| 27-Sep-2022 05:12:07 | 2022-09-27 09:12:07 SEVERE Exception Reported: Error in Calibrater::solve. |
| 27-Sep-2022 05:12:07 | 2022-09-27 09:12:07 INFO calibrater::correct Beginning correct--------------------------- |
| 27-Sep-2022 05:12:07 | 2022-09-27 09:12:07 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 27-Sep-2022 05:12:07 | 2022-09-27 09:12:07 INFO Calibrater::correct2 (VI2/VB2) . (None) |
| 27-Sep-2022 05:12:07 | 2022-09-27 09:12:07 SEVERE Calibrater::correct2 (VI2/VB2) Caught exception: Nothing to Apply |
| 27-Sep-2022 05:12:07 | 2022-09-27 09:12:07 INFO Calibrater::correct2 (VI2/VB2) Resetting all calibration application settings. |
| 27-Sep-2022 05:12:07 | 2022-09-27 09:12:07 SEVERE Exception Reported: Error in Calibrater::correct. |
| 27-Sep-2022 05:12:10 | 2022-09-27 09:12:10 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 27-Sep-2022 05:12:10 | PASSED |
| 27-Sep-2022 05:12:10 | |
| 27-Sep-2022 05:12:10 | test_tool_calibrater.py::calibrater_test::test_returnDict |
| 27-Sep-2022 05:12:10 | Check that the returndict function gives a dictonary with the expected keys |
| 27-Sep-2022 05:12:16 | 2022-09-27 09:12:16 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 27-Sep-2022 05:12:16 | 2022-09-27 09:12:16 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:12:16 | 2022-09-27 09:12:16 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:12:16 | 2022-09-27 09:12:17 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:12:22 | 2022-09-27 09:12:22 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:12:22 | 2022-09-27 09:12:22 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 27-Sep-2022 05:12:22 | 2022-09-27 09:12:22 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:12:23 | 2022-09-27 09:12:23 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
| 27-Sep-2022 05:12:23 | 2022-09-27 09:12:23 INFO calibrater::reset Reseting solve/apply state |
| 27-Sep-2022 05:12:23 | 2022-09-27 09:12:23 INFO Calibrater::selectvis Performing selection on MeasurementSet |
| 27-Sep-2022 05:12:23 | 2022-09-27 09:12:23 INFO Calibrater::selectvis+ Selecting on spw: '1' |
| 27-Sep-2022 05:12:23 | 2022-09-27 09:12:23 INFO Calibrater::selectvis By selection 328860 rows are reduced to 82215 |
| 27-Sep-2022 05:12:23 | 2022-09-27 09:12:23 INFO Calibrater::selectvis Frequency selection: |
| 27-Sep-2022 05:12:23 | 2022-09-27 09:12:23 INFO Calibrater::selectvis . Spw 1:0~7 (8 channels, step by 1) |
| 27-Sep-2022 05:12:23 | 2022-09-27 09:12:23 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
| 27-Sep-2022 05:12:25 | 2022-09-27 09:12:26 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 27-Sep-2022 05:12:26 | PASSED |
| 27-Sep-2022 05:12:26 | |
| 27-Sep-2022 05:12:26 | test_tool_calibrater.py::calibrater_test::test_selectVisBaseline |
| 27-Sep-2022 05:12:26 | Check that selectvis properly selects baseline/antenna |
| 27-Sep-2022 05:12:30 | 2022-09-27 09:12:30 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 27-Sep-2022 05:12:30 | 2022-09-27 09:12:30 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:12:30 | 2022-09-27 09:12:30 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:12:30 | 2022-09-27 09:12:30 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:12:34 | 2022-09-27 09:12:35 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:12:34 | 2022-09-27 09:12:35 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 27-Sep-2022 05:12:34 | 2022-09-27 09:12:35 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:12:34 | 2022-09-27 09:12:35 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
| 27-Sep-2022 05:12:34 | 2022-09-27 09:12:35 INFO calibrater::reset Reseting solve/apply state |
| 27-Sep-2022 05:12:34 | 2022-09-27 09:12:35 INFO Calibrater::selectvis Performing selection on MeasurementSet |
| 27-Sep-2022 05:12:34 | 2022-09-27 09:12:35 INFO Calibrater::selectvis+ Selecting on antenna/baseline: '0' |
| 27-Sep-2022 05:12:35 | 2022-09-27 09:12:35 INFO Calibrater::selectvis By selection 328860 rows are reduced to 65772 |
| 27-Sep-2022 05:12:35 | 2022-09-27 09:12:35 INFO Calibrater::selectvis Frequency selection: Selecting all channels in all spws. |
| 27-Sep-2022 05:12:35 | 2022-09-27 09:12:35 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
| 27-Sep-2022 05:12:35 | 2022-09-27 09:12:35 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 27-Sep-2022 05:12:35 | 2022-09-27 09:12:35 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 27-Sep-2022 05:12:35 | 2022-09-27 09:12:35 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:12:35 | 2022-09-27 09:12:35 INFO calibrater::correct Beginning correct--------------------------- |
| 27-Sep-2022 05:12:35 | 2022-09-27 09:12:35 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 27-Sep-2022 05:12:35 | 2022-09-27 09:12:35 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:12:37 | 2022-09-27 09:12:37 INFO calibrater::correct Finished correcting. |
| 27-Sep-2022 05:12:40 | 2022-09-27 09:12:41 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 27-Sep-2022 05:12:40 | 65772 65772 |
| 27-Sep-2022 05:12:40 | 263088 263088 |
| 27-Sep-2022 05:12:40 | PASSED |
| 27-Sep-2022 05:12:40 | |
| 27-Sep-2022 05:12:40 | test_tool_calibrater.py::calibrater_test::test_selectVisField |
| 27-Sep-2022 05:12:40 | Check that the field is properly selected by selectvis |
| 27-Sep-2022 05:12:44 | 2022-09-27 09:12:44 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 27-Sep-2022 05:12:44 | 2022-09-27 09:12:44 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:12:44 | 2022-09-27 09:12:44 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:12:44 | 2022-09-27 09:12:44 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:12:47 | 2022-09-27 09:12:48 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:12:47 | 2022-09-27 09:12:48 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 27-Sep-2022 05:12:47 | 2022-09-27 09:12:48 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:12:47 | 2022-09-27 09:12:48 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
| 27-Sep-2022 05:12:47 | 2022-09-27 09:12:48 INFO calibrater::reset Reseting solve/apply state |
| 27-Sep-2022 05:12:47 | 2022-09-27 09:12:48 INFO Calibrater::selectvis Performing selection on MeasurementSet |
| 27-Sep-2022 05:12:47 | 2022-09-27 09:12:48 INFO Calibrater::selectvis+ Selecting on field: '0' |
| 27-Sep-2022 05:12:47 | 2022-09-27 09:12:48 INFO Calibrater::selectvis By selection 328860 rows are reduced to 172260 |
| 27-Sep-2022 05:12:47 | 2022-09-27 09:12:48 INFO Calibrater::selectvis Frequency selection: Selecting all channels in all spws. |
| 27-Sep-2022 05:12:47 | 2022-09-27 09:12:48 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
| 27-Sep-2022 05:12:47 | 2022-09-27 09:12:48 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 27-Sep-2022 05:12:47 | 2022-09-27 09:12:48 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 27-Sep-2022 05:12:47 | 2022-09-27 09:12:48 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:12:47 | 2022-09-27 09:12:48 INFO calibrater::correct Beginning correct--------------------------- |
| 27-Sep-2022 05:12:47 | 2022-09-27 09:12:48 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 27-Sep-2022 05:12:47 | 2022-09-27 09:12:48 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:12:49 | 2022-09-27 09:12:50 INFO calibrater::correct Finished correcting. |
| 27-Sep-2022 05:12:52 | 2022-09-27 09:12:53 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 27-Sep-2022 05:12:52 | PASSED |
| 27-Sep-2022 05:12:52 | |
| 27-Sep-2022 05:12:52 | test_tool_calibrater.py::calibrater_test::test_selectVisIntent |
| 27-Sep-2022 05:12:52 | Check that the intent is properly selected by selectvis |
| 27-Sep-2022 05:12:56 | 2022-09-27 09:12:57 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 27-Sep-2022 05:12:56 | 2022-09-27 09:12:57 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:12:56 | 2022-09-27 09:12:57 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:12:56 | 2022-09-27 09:12:57 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:13:00 | 2022-09-27 09:13:01 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:13:00 | 2022-09-27 09:13:01 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 27-Sep-2022 05:13:00 | 2022-09-27 09:13:01 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:13:00 | 2022-09-27 09:13:01 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
| 27-Sep-2022 05:13:00 | 2022-09-27 09:13:01 INFO calibrater::reset Reseting solve/apply state |
| 27-Sep-2022 05:13:00 | 2022-09-27 09:13:01 INFO Calibrater::selectvis Performing selection on MeasurementSet |
| 27-Sep-2022 05:13:00 | 2022-09-27 09:13:01 INFO Calibrater::selectvis+ Selecting on intent: '*AMPLI*' |
| 27-Sep-2022 05:13:00 | 2022-09-27 09:13:01 INFO Calibrater::selectvis Selection did not drop any rows |
| 27-Sep-2022 05:13:00 | 2022-09-27 09:13:01 INFO Calibrater::selectvis Frequency selection: Selecting all channels in all spws. |
| 27-Sep-2022 05:13:00 | 2022-09-27 09:13:01 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
| 27-Sep-2022 05:13:00 | 2022-09-27 09:13:01 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 27-Sep-2022 05:13:00 | 2022-09-27 09:13:01 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 27-Sep-2022 05:13:00 | 2022-09-27 09:13:01 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:13:00 | 2022-09-27 09:13:01 INFO calibrater::correct Beginning correct--------------------------- |
| 27-Sep-2022 05:13:00 | 2022-09-27 09:13:01 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 27-Sep-2022 05:13:00 | 2022-09-27 09:13:01 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:13:05 | 2022-09-27 09:13:05 INFO calibrater::correct Finished correcting. |
| 27-Sep-2022 05:13:05 | 2022-09-27 09:13:05 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 27-Sep-2022 05:13:05 | PASSED |
| 27-Sep-2022 05:13:05 | |
| 27-Sep-2022 05:13:05 | test_tool_calibrater.py::calibrater_test::test_selectVisObs |
| 27-Sep-2022 05:13:09 | 2022-09-27 09:13:09 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 27-Sep-2022 05:13:09 | 2022-09-27 09:13:09 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:13:09 | 2022-09-27 09:13:09 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:13:09 | 2022-09-27 09:13:09 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:13:13 | 2022-09-27 09:13:13 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:13:13 | 2022-09-27 09:13:13 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 27-Sep-2022 05:13:13 | 2022-09-27 09:13:13 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:13:13 | 2022-09-27 09:13:13 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
| 27-Sep-2022 05:13:13 | 2022-09-27 09:13:13 INFO calibrater::reset Reseting solve/apply state |
| 27-Sep-2022 05:13:13 | 2022-09-27 09:13:13 INFO Calibrater::selectvis Performing selection on MeasurementSet |
| 27-Sep-2022 05:13:13 | 2022-09-27 09:13:13 INFO Calibrater::selectvis+ Selecting by observation IDs: '0' |
| 27-Sep-2022 05:13:13 | 2022-09-27 09:13:13 INFO Calibrater::selectvis By selection 328860 rows are reduced to 318870 |
| 27-Sep-2022 05:13:13 | 2022-09-27 09:13:13 INFO Calibrater::selectvis Frequency selection: Selecting all channels in all spws. |
| 27-Sep-2022 05:13:13 | 2022-09-27 09:13:13 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
| 27-Sep-2022 05:13:13 | 2022-09-27 09:13:13 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 27-Sep-2022 05:13:13 | 2022-09-27 09:13:13 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 27-Sep-2022 05:13:13 | 2022-09-27 09:13:13 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:13:13 | 2022-09-27 09:13:13 INFO calibrater::correct Beginning correct--------------------------- |
| 27-Sep-2022 05:13:13 | 2022-09-27 09:13:13 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 27-Sep-2022 05:13:13 | 2022-09-27 09:13:13 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:13:16 | 2022-09-27 09:13:17 INFO calibrater::correct Finished correcting. |
| 27-Sep-2022 05:13:17 | 2022-09-27 09:13:17 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 27-Sep-2022 05:13:17 | PASSED |
| 27-Sep-2022 05:13:17 | |
| 27-Sep-2022 05:13:17 | test_tool_calibrater.py::calibrater_test::test_selectVisScan |
| 27-Sep-2022 05:13:17 | Check tht the scan is properly selected by selectvis |
| 27-Sep-2022 05:13:22 | 2022-09-27 09:13:22 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 27-Sep-2022 05:13:22 | 2022-09-27 09:13:22 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:13:22 | 2022-09-27 09:13:22 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:13:22 | 2022-09-27 09:13:22 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:13:25 | 2022-09-27 09:13:26 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:13:25 | 2022-09-27 09:13:26 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 27-Sep-2022 05:13:25 | 2022-09-27 09:13:26 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:13:25 | 2022-09-27 09:13:26 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
| 27-Sep-2022 05:13:25 | 2022-09-27 09:13:26 INFO calibrater::reset Reseting solve/apply state |
| 27-Sep-2022 05:13:25 | 2022-09-27 09:13:26 INFO Calibrater::selectvis Performing selection on MeasurementSet |
| 27-Sep-2022 05:13:25 | 2022-09-27 09:13:26 INFO Calibrater::selectvis+ Selecting on scan: '2' |
| 27-Sep-2022 05:13:26 | 2022-09-27 09:13:26 INFO Calibrater::selectvis By selection 328860 rows are reduced to 15660 |
| 27-Sep-2022 05:13:26 | 2022-09-27 09:13:26 INFO Calibrater::selectvis Frequency selection: Selecting all channels in all spws. |
| 27-Sep-2022 05:13:26 | 2022-09-27 09:13:26 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
| 27-Sep-2022 05:13:26 | 2022-09-27 09:13:26 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 27-Sep-2022 05:13:26 | 2022-09-27 09:13:26 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 27-Sep-2022 05:13:26 | 2022-09-27 09:13:26 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:13:26 | 2022-09-27 09:13:26 INFO calibrater::correct Beginning correct--------------------------- |
| 27-Sep-2022 05:13:26 | 2022-09-27 09:13:26 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 27-Sep-2022 05:13:26 | 2022-09-27 09:13:26 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:13:26 | 2022-09-27 09:13:26 INFO calibrater::correct Finished correcting. |
| 27-Sep-2022 05:13:28 | 2022-09-27 09:13:28 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 27-Sep-2022 05:13:28 | PASSED |
| 27-Sep-2022 05:13:28 | |
| 27-Sep-2022 05:13:28 | test_tool_calibrater.py::calibrater_test::test_selectVisSpw |
| 27-Sep-2022 05:13:28 | Check that spw is properly selected by selectvis |
| 27-Sep-2022 05:13:32 | 2022-09-27 09:13:32 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 27-Sep-2022 05:13:32 | 2022-09-27 09:13:32 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:13:32 | 2022-09-27 09:13:32 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:13:32 | 2022-09-27 09:13:32 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:13:35 | 2022-09-27 09:13:35 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:13:35 | 2022-09-27 09:13:36 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 27-Sep-2022 05:13:35 | 2022-09-27 09:13:36 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:13:35 | 2022-09-27 09:13:36 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
| 27-Sep-2022 05:13:35 | 2022-09-27 09:13:36 INFO calibrater::reset Reseting solve/apply state |
| 27-Sep-2022 05:13:35 | 2022-09-27 09:13:36 INFO Calibrater::selectvis Performing selection on MeasurementSet |
| 27-Sep-2022 05:13:35 | 2022-09-27 09:13:36 INFO Calibrater::selectvis+ Selecting on spw: '0' |
| 27-Sep-2022 05:13:35 | 2022-09-27 09:13:36 INFO Calibrater::selectvis By selection 328860 rows are reduced to 82215 |
| 27-Sep-2022 05:13:35 | 2022-09-27 09:13:36 INFO Calibrater::selectvis Frequency selection: |
| 27-Sep-2022 05:13:35 | 2022-09-27 09:13:36 INFO Calibrater::selectvis . Spw 0:0~7 (8 channels, step by 1) |
| 27-Sep-2022 05:13:35 | 2022-09-27 09:13:36 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
| 27-Sep-2022 05:13:35 | 2022-09-27 09:13:36 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 27-Sep-2022 05:13:35 | 2022-09-27 09:13:36 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 27-Sep-2022 05:13:35 | 2022-09-27 09:13:36 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:13:35 | 2022-09-27 09:13:36 INFO calibrater::correct Beginning correct--------------------------- |
| 27-Sep-2022 05:13:35 | 2022-09-27 09:13:36 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 27-Sep-2022 05:13:35 | 2022-09-27 09:13:36 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:13:36 | 2022-09-27 09:13:37 INFO calibrater::correct Finished correcting. |
| 27-Sep-2022 05:13:38 | 2022-09-27 09:13:39 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 27-Sep-2022 05:13:38 | PASSED |
| 27-Sep-2022 05:13:38 | |
| 27-Sep-2022 05:13:38 | test_tool_calibrater.py::calibrater_test::test_selectVisTime |
| 27-Sep-2022 05:13:38 | Check that time is properly selected by selectvis |
| 27-Sep-2022 05:13:43 | 2022-09-27 09:13:43 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 27-Sep-2022 05:13:43 | 2022-09-27 09:13:43 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:13:43 | 2022-09-27 09:13:43 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:13:43 | 2022-09-27 09:13:43 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:13:46 | 2022-09-27 09:13:47 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:13:47 | 2022-09-27 09:13:47 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 27-Sep-2022 05:13:47 | 2022-09-27 09:13:47 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:13:47 | 2022-09-27 09:13:47 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
| 27-Sep-2022 05:13:47 | 2022-09-27 09:13:47 INFO calibrater::reset Reseting solve/apply state |
| 27-Sep-2022 05:13:47 | 2022-09-27 09:13:47 INFO Calibrater::selectvis Performing selection on MeasurementSet |
| 27-Sep-2022 05:13:47 | 2022-09-27 09:13:47 INFO Calibrater::selectvis+ Selecting on time: '>04:38:23' |
| 27-Sep-2022 05:13:47 | 2022-09-27 09:13:47 INFO Calibrater::selectvis By selection 328860 rows are reduced to 313200 |
| 27-Sep-2022 05:13:47 | 2022-09-27 09:13:47 INFO Calibrater::selectvis Frequency selection: Selecting all channels in all spws. |
| 27-Sep-2022 05:13:47 | 2022-09-27 09:13:47 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
| 27-Sep-2022 05:13:47 | 2022-09-27 09:13:47 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 27-Sep-2022 05:13:47 | 2022-09-27 09:13:47 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 27-Sep-2022 05:13:47 | 2022-09-27 09:13:47 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:13:47 | 2022-09-27 09:13:47 INFO calibrater::correct Beginning correct--------------------------- |
| 27-Sep-2022 05:13:47 | 2022-09-27 09:13:47 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 27-Sep-2022 05:13:47 | 2022-09-27 09:13:47 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:13:50 | 2022-09-27 09:13:51 INFO calibrater::correct Finished correcting. |
| 27-Sep-2022 05:13:51 | 2022-09-27 09:13:52 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 27-Sep-2022 05:13:51 | PASSED |
| 27-Sep-2022 05:13:51 | |
| 27-Sep-2022 05:13:51 | test_tool_calibrater.py::calibrater_test::test_selectVisUVrange |
| 27-Sep-2022 05:13:51 | Check that selectvis properly selects for uvrange |
| 27-Sep-2022 05:13:54 | 2022-09-27 09:13:54 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 27-Sep-2022 05:13:54 | 2022-09-27 09:13:54 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:13:54 | 2022-09-27 09:13:54 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:13:54 | 2022-09-27 09:13:54 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:13:57 | 2022-09-27 09:13:57 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:13:57 | 2022-09-27 09:13:57 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 27-Sep-2022 05:13:57 | 2022-09-27 09:13:57 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:13:57 | 2022-09-27 09:13:57 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
| 27-Sep-2022 05:13:57 | 2022-09-27 09:13:57 INFO calibrater::reset Reseting solve/apply state |
| 27-Sep-2022 05:13:57 | 2022-09-27 09:13:57 INFO Calibrater::selectvis Performing selection on MeasurementSet |
| 27-Sep-2022 05:13:57 | 2022-09-27 09:13:57 INFO Calibrater::selectvis+ Selecting on uvrange: '> 500000lambda' |
| 27-Sep-2022 05:13:58 | 2022-09-27 09:13:59 INFO Calibrater::selectvis By selection 328860 rows are reduced to 103321 |
| 27-Sep-2022 05:13:58 | 2022-09-27 09:13:59 INFO Calibrater::selectvis Frequency selection: Selecting all channels in all spws. |
| 27-Sep-2022 05:13:58 | 2022-09-27 09:13:59 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
| 27-Sep-2022 05:13:58 | 2022-09-27 09:13:59 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 27-Sep-2022 05:13:58 | 2022-09-27 09:13:59 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 27-Sep-2022 05:13:58 | 2022-09-27 09:13:59 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:13:58 | 2022-09-27 09:13:59 INFO calibrater::correct Beginning correct--------------------------- |
| 27-Sep-2022 05:13:58 | 2022-09-27 09:13:59 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 27-Sep-2022 05:13:58 | 2022-09-27 09:13:59 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:14:01 | 2022-09-27 09:14:01 INFO calibrater::correct Finished correcting. |
| 27-Sep-2022 05:14:04 | 2022-09-27 09:14:05 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 27-Sep-2022 05:14:05 | PASSED |
| 27-Sep-2022 05:14:05 | |
| 27-Sep-2022 05:14:05 | test_tool_calibrater.py::calibrater_test::test_setCalLib |
| 27-Sep-2022 05:14:05 | Check that a provided cal table can be used to corrupt the MODEL_DATA |
| 27-Sep-2022 05:14:08 | 2022-09-27 09:14:08 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 27-Sep-2022 05:14:08 | 2022-09-27 09:14:08 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:14:08 | 2022-09-27 09:14:08 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:14:08 | 2022-09-27 09:14:09 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:14:12 | 2022-09-27 09:14:12 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:14:12 | 2022-09-27 09:14:13 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 27-Sep-2022 05:14:12 | 2022-09-27 09:14:13 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:14:12 | 2022-09-27 09:14:13 INFO calibrater::parsecallibfile Beginning parsecallibfile-)------- |
| 27-Sep-2022 05:14:12 | 2022-09-27 09:14:13 INFO calibrater::setcallib Beginning setcallib--------- |
| 27-Sep-2022 05:14:12 | 2022-09-27 09:14:13 INFO Calibrater::setcallib2(callib) Arranging to APPLY: |
| 27-Sep-2022 05:14:12 | 2022-09-27 09:14:13 INFO . G Jones: table=gaincaltest2.ms.G0 (by cal library) calWt=true |
| 27-Sep-2022 05:14:12 | 2022-09-27 09:14:13 INFO . 0: |
| 27-Sep-2022 05:14:12 | 2022-09-27 09:14:13 INFO + MS: obs= fld= intent= spw= |
| 27-Sep-2022 05:14:12 | 2022-09-27 09:14:13 INFO + CT: tinterp=linear finterp= |
| 27-Sep-2022 05:14:12 | 2022-09-27 09:14:13 INFO + obsmap=[] fldmap=[] |
| 27-Sep-2022 05:14:12 | 2022-09-27 09:14:13 INFO + spwmap=[] antmap=[] |
| 27-Sep-2022 05:14:13 | 2022-09-27 09:14:13 INFO calibrater::corrupt Beginning corrupt--------------------------- |
| 27-Sep-2022 05:14:13 | 2022-09-27 09:14:13 INFO Calibrater::corrupt2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 27-Sep-2022 05:14:13 | 2022-09-27 09:14:13 INFO Calibrater::corrupt2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 (by cal library) calWt=true |
| 27-Sep-2022 05:14:16 | 2022-09-27 09:14:16 INFO calibrater::corrupt Finished corrupting. |
| 27-Sep-2022 05:14:18 | 2022-09-27 09:14:19 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 27-Sep-2022 05:14:18 | PASSED |
| 27-Sep-2022 05:14:18 | |
| 27-Sep-2022 05:14:18 | test_tool_calibrater.py::calibrater_test::test_setCorrDepFlags |
| 27-Sep-2022 05:14:18 | Check that corrdepflags will be checked |
| 27-Sep-2022 05:14:21 | 2022-09-27 09:14:22 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 27-Sep-2022 05:14:21 | 2022-09-27 09:14:22 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:14:21 | 2022-09-27 09:14:22 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:14:21 | 2022-09-27 09:14:22 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:14:24 | 2022-09-27 09:14:25 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:14:25 | 2022-09-27 09:14:25 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 27-Sep-2022 05:14:25 | 2022-09-27 09:14:25 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:14:25 | 2022-09-27 09:14:25 INFO Calibrater::setCorrDepFlags Setting correlation dependent flags = True |
| 27-Sep-2022 05:14:26 | 2022-09-27 09:14:27 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 27-Sep-2022 05:14:27 | PASSED |
| 27-Sep-2022 05:14:27 | |
| 27-Sep-2022 05:14:27 | test_tool_calibrater.py::calibrater_test::test_smoothedCalTables |
| 27-Sep-2022 05:14:27 | Check that the smooth command creates a smoothed cal table |
| 27-Sep-2022 05:14:34 | 2022-09-27 09:14:35 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 27-Sep-2022 05:14:34 | 2022-09-27 09:14:35 INFO calibrater::open Opening MS: ngc5921.ms for calibration. |
| 27-Sep-2022 05:14:34 | 2022-09-27 09:14:35 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:14:34 | 2022-09-27 09:14:35 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:14:35 | 2022-09-27 09:14:36 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:14:35 | 2022-09-27 09:14:36 INFO VisSetUtil::initScrCols Initialized 22653 rows. |
| 27-Sep-2022 05:14:35 | 2022-09-27 09:14:36 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:14:35 | 2022-09-27 09:14:36 INFO calibrater::smooth Beginning smooth--(MSSelection version)------- |
| 27-Sep-2022 05:14:35 | 2022-09-27 09:14:36 INFO Calibrater::smooth Beginning smoothing/interpolating method. |
| 27-Sep-2022 05:14:35 | 2022-09-27 09:14:36 WARN Found pre-v4.1 caltable (/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/ngc5921.gcal); attempting to update... |
| 27-Sep-2022 05:14:35 | 2022-09-27 09:14:36 WARN + SUCCEEDED: trivial OBSERVATION/OBSERVATION_ID have been added. |
| 27-Sep-2022 05:14:35 | 2022-09-27 09:14:36 INFO Calibrater::smooth Storing result in testcalout.cal |
| 27-Sep-2022 05:14:35 | 2022-09-27 09:14:36 INFO Writing solutions to table: testcalout.cal |
| 27-Sep-2022 05:14:36 | 2022-09-27 09:14:36 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 27-Sep-2022 05:14:36 | PASSED |
| 27-Sep-2022 05:14:36 | |
| 27-Sep-2022 05:14:36 | test_tool_calibrater.py::calibrater_test::test_solveBandpass |
| 27-Sep-2022 05:14:36 | Check that solve band poly creates the output table |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:39 WARN calibrater::setvi(bool,bool) Forcing use of OLD VisibilityIterator. |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:39 INFO calibrater::open ****Using OLD VI-driven calibrater tool**** |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:39 INFO calibrater::open Opening MS: ngc5921.ms for calibration. |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:39 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:39 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO VisSetUtil::initScrCols Initialized 22653 rows. |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO calibrater::setsolvebandpoly Beginning setsolvebandpoly--(MSSelection version)------- |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO Calibrater::setsolvebandpoly Arranging to SOLVE: |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO Calibrater::setsolvebandpoly . BPOLY: table=bpoly append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode= solnorm=true normtype=MEAN |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO calibrater::solve Beginning solve----------------------------- |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO Calibrater::solve The following calibration terms are arranged for apply: |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO Calibrater::solve . (None) |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO Calibrater::solve The following calibration term is arranged for solve: |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO Calibrater::solve . BPOLY: table=bpoly append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode= solnorm=true normtype=MEAN |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO Calibrater::solve Solving for BPOLY |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO For solint = inf, found 7 solution intervals. |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Fitting bandpass amplitude and phase polynomials. |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Polynomial degree for amplitude is 5 |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Polynomial degree for phase is 7 |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Spectral grid for fit will have 63 points spaced by 24.4141 kHz. |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz. |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Total bandwidth: 1538.09 kHz. |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Found data for 351 baselines among 27 antennas. |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.059507/0.0681762/0.0765806 |
| 27-Sep-2022 05:14:39 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 0.33653/0.750193/1.6779 |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0630839/0.0689061/0.0756384 |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 0.279482/0.74979/1.59355 |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Normalizing antenna-based solutions. |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::updateCalTable() Storing calibration in table bpoly |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Fitting bandpass amplitude and phase polynomials. |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Polynomial degree for amplitude is 5 |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Polynomial degree for phase is 7 |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Spectral grid for fit will have 63 points spaced by 24.4141 kHz. |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz. |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Total bandwidth: 1538.09 kHz. |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Found data for 351 baselines among 27 antennas. |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0672607/0.089081/0.111106 |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 2.31075/3.32219/4.29305 |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0652822/0.0889198/0.116912 |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:40 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:41 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 2.44269/3.26616/4.3519 |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:41 INFO BJonesPoly::selfSolveOne() Normalizing antenna-based solutions. |
| 27-Sep-2022 05:14:40 | 2022-09-27 09:14:41 INFO BJonesPoly::updateCalTable() Storing calibration in table bpoly |
| 27-Sep-2022 05:14:41 | 2022-09-27 09:14:41 INFO BJonesPoly::selfSolveOne() THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION |
| 27-Sep-2022 05:14:41 | 2022-09-27 09:14:41 INFO BJonesPoly::selfSolveOne() Fitting bandpass amplitude and phase polynomials. |
| 27-Sep-2022 05:14:41 | 2022-09-27 09:14:41 INFO BJonesPoly::selfSolveOne() Polynomial degree for amplitude is 5 |
| 27-Sep-2022 05:14:41 | 2022-09-27 09:14:41 INFO BJonesPoly::selfSolveOne() Polynomial degree for phase is 7 |
| 27-Sep-2022 05:14:41 | 2022-09-27 09:14:41 INFO BJonesPoly::selfSolveOne() Spectral grid for fit will have 63 points spaced by 24.4141 kHz. |
| 27-Sep-2022 05:14:41 | 2022-09-27 09:14:41 INFO BJonesPoly::selfSolveOne() Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz. |
| 27-Sep-2022 05:14:41 | 2022-09-27 09:14:41 INFO BJonesPoly::selfSolveOne() Total bandwidth: 1538.09 kHz. |
| 27-Sep-2022 05:14:41 | 2022-09-27 09:14:41 INFO BJonesPoly::selfSolveOne() Found data for 351 baselines among 27 antennas. |
| 27-Sep-2022 05:14:41 | 2022-09-27 09:14:41 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 27-Sep-2022 05:14:41 | 2022-09-27 09:14:41 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.350681/0.587724/0.894558 |
| 27-Sep-2022 05:14:41 | 2022-09-27 09:14:41 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 27-Sep-2022 05:14:42 | 2022-09-27 09:14:42 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 21.296/59.0077/111.454 |
| 27-Sep-2022 05:14:42 | 2022-09-27 09:14:42 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 27-Sep-2022 05:14:42 | 2022-09-27 09:14:42 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.354236/0.581733/0.988903 |
| 27-Sep-2022 05:14:42 | 2022-09-27 09:14:42 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 27-Sep-2022 05:14:43 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 17.2419/56.3249/117.264 |
| 27-Sep-2022 05:14:43 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Normalizing antenna-based solutions. |
| 27-Sep-2022 05:14:43 | 2022-09-27 09:14:44 INFO BJonesPoly::updateCalTable() Storing calibration in table bpoly |
| 27-Sep-2022 05:14:43 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION |
| 27-Sep-2022 05:14:43 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Fitting bandpass amplitude and phase polynomials. |
| 27-Sep-2022 05:14:43 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Polynomial degree for amplitude is 5 |
| 27-Sep-2022 05:14:43 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Polynomial degree for phase is 7 |
| 27-Sep-2022 05:14:43 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Spectral grid for fit will have 63 points spaced by 24.4141 kHz. |
| 27-Sep-2022 05:14:43 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz. |
| 27-Sep-2022 05:14:43 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Total bandwidth: 1538.09 kHz. |
| 27-Sep-2022 05:14:43 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Found data for 351 baselines among 27 antennas. |
| 27-Sep-2022 05:14:43 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 27-Sep-2022 05:14:43 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0850169/0.113968/0.15276 |
| 27-Sep-2022 05:14:43 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 27-Sep-2022 05:14:43 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 3.67561/5.33243/8.17296 |
| 27-Sep-2022 05:14:43 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 27-Sep-2022 05:14:43 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0784237/0.114345/0.159908 |
| 27-Sep-2022 05:14:43 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 3.46392/5.27232/7.20673 |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Normalizing antenna-based solutions. |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:44 INFO BJonesPoly::updateCalTable() Storing calibration in table bpoly |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Fitting bandpass amplitude and phase polynomials. |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Polynomial degree for amplitude is 5 |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Polynomial degree for phase is 7 |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Spectral grid for fit will have 63 points spaced by 24.4141 kHz. |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz. |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Total bandwidth: 1538.09 kHz. |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Found data for 351 baselines among 27 antennas. |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0703936/0.102501/0.131676 |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 2.98728/4.47977/5.84264 |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0751114/0.102994/0.138529 |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:44 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:45 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 3.18629/4.47068/5.89411 |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:45 INFO BJonesPoly::selfSolveOne() Normalizing antenna-based solutions. |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:45 INFO BJonesPoly::updateCalTable() Storing calibration in table bpoly |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:45 INFO BJonesPoly::selfSolveOne() THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:45 INFO BJonesPoly::selfSolveOne() Fitting bandpass amplitude and phase polynomials. |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:45 INFO BJonesPoly::selfSolveOne() Polynomial degree for amplitude is 5 |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:45 INFO BJonesPoly::selfSolveOne() Polynomial degree for phase is 7 |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:45 INFO BJonesPoly::selfSolveOne() Spectral grid for fit will have 63 points spaced by 24.4141 kHz. |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:45 INFO BJonesPoly::selfSolveOne() Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz. |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:45 INFO BJonesPoly::selfSolveOne() Total bandwidth: 1538.09 kHz. |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:45 INFO BJonesPoly::selfSolveOne() Found data for 351 baselines among 27 antennas. |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:45 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:45 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.350626/0.604424/0.974388 |
| 27-Sep-2022 05:14:44 | 2022-09-27 09:14:45 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 27-Sep-2022 05:14:46 | 2022-09-27 09:14:46 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 21.2542/59.3511/120.719 |
| 27-Sep-2022 05:14:46 | 2022-09-27 09:14:46 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 27-Sep-2022 05:14:46 | 2022-09-27 09:14:46 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.382806/0.598119/0.941571 |
| 27-Sep-2022 05:14:46 | 2022-09-27 09:14:46 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:47 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 20.0637/57.2112/118.101 |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:47 INFO BJonesPoly::selfSolveOne() Normalizing antenna-based solutions. |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:47 INFO BJonesPoly::updateCalTable() Storing calibration in table bpoly |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:47 INFO BJonesPoly::selfSolveOne() THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:47 INFO BJonesPoly::selfSolveOne() Fitting bandpass amplitude and phase polynomials. |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:47 INFO BJonesPoly::selfSolveOne() Polynomial degree for amplitude is 5 |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:47 INFO BJonesPoly::selfSolveOne() Polynomial degree for phase is 7 |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:47 INFO BJonesPoly::selfSolveOne() Spectral grid for fit will have 63 points spaced by 24.4141 kHz. |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:47 INFO BJonesPoly::selfSolveOne() Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz. |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:47 INFO BJonesPoly::selfSolveOne() Total bandwidth: 1538.09 kHz. |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:47 INFO BJonesPoly::selfSolveOne() Found data for 351 baselines among 27 antennas. |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:47 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:47 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0750931/0.0978998/0.125897 |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:47 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:48 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 2.72933/3.98787/5.33715 |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:48 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:48 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0658572/0.0972125/0.140794 |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:48 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:48 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 2.97943/3.97841/5.72903 |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:48 INFO BJonesPoly::selfSolveOne() Normalizing antenna-based solutions. |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:48 INFO BJonesPoly::updateCalTable() Storing calibration in table bpoly |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:48 INFO Calibrater::solve Found good BPOLY solutions in 7 slots. |
| 27-Sep-2022 05:14:47 | 2022-09-27 09:14:48 INFO calibrater::solve Finished solving. |
| 27-Sep-2022 05:14:48 | 2022-09-27 09:14:48 WARN calibrater::setvi(bool,bool) Forcing use of NEW VisibilityIterator. |
| 27-Sep-2022 05:14:48 | PASSED |
| 27-Sep-2022 05:14:48 | |
| 27-Sep-2022 05:14:48 | test_tool_calibrater.py::calibrater_test::test_solveGainspline |
| 27-Sep-2022 05:14:48 | Check that solve gain spline creates the output table |
| 27-Sep-2022 05:14:51 | 2022-09-27 09:14:52 WARN calibrater::setvi(bool,bool) Forcing use of OLD VisibilityIterator. |
| 27-Sep-2022 05:14:51 | 2022-09-27 09:14:52 INFO calibrater::open ****Using OLD VI-driven calibrater tool**** |
| 27-Sep-2022 05:14:51 | 2022-09-27 09:14:52 INFO calibrater::open Opening MS: ngc5921.ms for calibration. |
| 27-Sep-2022 05:14:51 | 2022-09-27 09:14:52 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:14:51 | 2022-09-27 09:14:52 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:52 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO VisSetUtil::initScrCols Initialized 22653 rows. |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO calibrater::setsolvegainspline Beginning setsolvegainspline--(MSSelection version)------- |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO Calibrater::setsolvegainspline Arranging to SOLVE: |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO Calibrater::setsolvegainspline . GSPLINE: table=gainspline append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AMP solnorm=false |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO calibrater::solve Beginning solve----------------------------- |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO Calibrater::solve The following calibration terms are arranged for apply: |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO Calibrater::solve . (None) |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO Calibrater::solve The following calibration term is arranged for solve: |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO Calibrater::solve . GSPLINE: table=gainspline append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AMP solnorm=false |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO GJonesSpline::solve() Fitting time-dependent cubic splines. |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO GJonesSpline::solve() Solving for phase splines with splinetime= 10800 |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO GJonesSpline::solve() Solving for amplitude splines with splinetime= 10800 |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO GJonesSpline::solve() Accumulating data for: field= 1331+30500002_0, spw= 0, nchan= 63 |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO GJonesSpline::solve() Accumulating data for: field= 1445+09900002_0, spw= 0, nchan= 63 |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO GJonesSpline::solve() Accumulating data for: field= N5921_2, spw= 0, nchan= 63 |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO GJonesSpline::solve() Number of timestamps in data = 60 |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO GJonesSpline::getKnots() Gridded splinetime = 5280 sec. |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO GJonesSpline::solve() Number of cubic spline control points = 4 |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO GJonesSpline::solve() Number of cubic spline knots = 8 |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO GJonesSpline::solve() Number of cubic spline segments = 1 |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO GJonesSpline::solve() Fitting amplitude spline. |
| 27-Sep-2022 05:14:52 | DPBTRF ;problem leading minor 23 |
| 27-Sep-2022 05:14:52 | DPBTRF ;problem leading minor 23 |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO GJonesSpline::solve() Searching for and correcting phase-wraps on each baseline. |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO GJonesSpline::solve() Fitting phase spline. |
| 27-Sep-2022 05:14:52 | DPBTRF ;problem leading minor 22 |
| 27-Sep-2022 05:14:52 | DPBTRF ;problem leading minor 22 |
| 27-Sep-2022 05:14:52 | 2022-09-27 09:14:53 INFO GJonesSpline::updateCalTable Storing solutions in table gainspline |
| 27-Sep-2022 05:14:53 | 2022-09-27 09:14:53 INFO calibrater::solve Finished solving. |
| 27-Sep-2022 05:14:53 | 2022-09-27 09:14:53 WARN calibrater::setvi(bool,bool) Forcing use of NEW VisibilityIterator. |
| 27-Sep-2022 05:14:53 | PASSED |
| 27-Sep-2022 05:14:53 | |
| 27-Sep-2022 05:14:53 | test_tool_calibrater.py::calibrater_test::test_specifyCal |
| 27-Sep-2022 05:14:53 | Check that specifycal can set values for specific spws and antennas |
| 27-Sep-2022 05:14:56 | 2022-09-27 09:14:57 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 27-Sep-2022 05:14:56 | 2022-09-27 09:14:57 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:14:56 | 2022-09-27 09:14:57 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:14:56 | 2022-09-27 09:14:57 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:14:59 | 2022-09-27 09:15:00 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:15:00 | 2022-09-27 09:15:00 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 27-Sep-2022 05:15:00 | 2022-09-27 09:15:00 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:15:00 | 2022-09-27 09:15:00 INFO calibrater::specifycal Beginning specifycal----------------------- |
| 27-Sep-2022 05:15:00 | 2022-09-27 09:15:00 INFO Creating G Jones table from specified parameters. |
| 27-Sep-2022 05:15:00 | 2022-09-27 09:15:00 INFO Generating 'G' corrections. |
| 27-Sep-2022 05:15:00 | 2022-09-27 09:15:00 INFO Specified parameter(s) (per spw and pol) repeated on all antennas. |
| 27-Sep-2022 05:15:00 | 2022-09-27 09:15:00 INFO Specified parameter(s) (per spw and antenna) repeated on all polarizations. |
| 27-Sep-2022 05:15:00 | 2022-09-27 09:15:00 INFO spwId=1 antId=<all> polId=<all> parameter= 3 (ip0,ip1 = [0, 0, 0],[1, 0, 9]) |
| 27-Sep-2022 05:15:00 | 2022-09-27 09:15:00 INFO Writing solutions to table: testcalout.cal |
| 27-Sep-2022 05:15:02 | 2022-09-27 09:15:02 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 27-Sep-2022 05:15:02 | PASSED |
| 27-Sep-2022 05:15:02 | |
| 27-Sep-2022 05:15:02 | test_tool_calibrater.py::calibrater_test::test_standardPath |
| 27-Sep-2022 05:15:02 | open setapply setsolve state solve close |
| 27-Sep-2022 05:15:06 | 2022-09-27 09:15:07 WARN calibrater::setvi(bool,bool) Forcing use of OLD VisibilityIterator. |
| 27-Sep-2022 05:15:06 | 2022-09-27 09:15:07 INFO calibrater::open ****Using OLD VI-driven calibrater tool**** |
| 27-Sep-2022 05:15:06 | 2022-09-27 09:15:07 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:15:06 | 2022-09-27 09:15:07 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:15:06 | 2022-09-27 09:15:07 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:15:09 | 2022-09-27 09:15:10 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:15:10 | 2022-09-27 09:15:10 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 27-Sep-2022 05:15:10 | 2022-09-27 09:15:10 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:15:10 | 2022-09-27 09:15:10 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 27-Sep-2022 05:15:10 | 2022-09-27 09:15:10 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 27-Sep-2022 05:15:10 | 2022-09-27 09:15:10 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:15:10 | 2022-09-27 09:15:10 INFO calibrater::setsolve Beginning setsolve--(MSSelection version)------- |
| 27-Sep-2022 05:15:10 | 2022-09-27 09:15:10 INFO Calibrater::setsolve Arranging to SOLVE: |
| 27-Sep-2022 05:15:10 | 2022-09-27 09:15:10 INFO Calibrater::setsolve . Mf Mueller: table=output.ms append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false |
| 27-Sep-2022 05:15:10 | 2022-09-27 09:15:10 INFO Calibrater::state The following calibration terms are arranged for apply: |
| 27-Sep-2022 05:15:10 | 2022-09-27 09:15:10 INFO Calibrater::state . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:15:10 | 2022-09-27 09:15:10 INFO Calibrater::state The following calibration term is arranged for solve: |
| 27-Sep-2022 05:15:10 | 2022-09-27 09:15:10 INFO Calibrater::state . Mf Mueller: table=output.ms append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false |
| 27-Sep-2022 05:15:10 | 2022-09-27 09:15:10 INFO calibrater::solve Beginning solve----------------------------- |
| 27-Sep-2022 05:15:10 | 2022-09-27 09:15:10 INFO Calibrater::solve The following calibration terms are arranged for apply: |
| 27-Sep-2022 05:15:10 | 2022-09-27 09:15:10 INFO Calibrater::solve . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:15:10 | 2022-09-27 09:15:10 INFO Calibrater::solve The following calibration term is arranged for solve: |
| 27-Sep-2022 05:15:10 | 2022-09-27 09:15:10 INFO Calibrater::solve . Mf Mueller: table=output.ms append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false |
| 27-Sep-2022 05:15:10 | 2022-09-27 09:15:10 INFO Solving for Mf Mueller |
| 27-Sep-2022 05:15:10 | 2022-09-27 09:15:11 INFO For solint = inf, found 84 solution intervals. |
| 27-Sep-2022 05:15:12 | 2022-09-27 09:15:12 INFO Found good Mf Mueller solutions in 84 intervals. |
| 27-Sep-2022 05:15:12 | 2022-09-27 09:15:12 INFO Writing solutions to table: output.ms |
| 27-Sep-2022 05:15:12 | 2022-09-27 09:15:12 INFO calibrater::solve Finished solving. |
| 27-Sep-2022 05:15:13 | 2022-09-27 09:15:14 WARN calibrater::setvi(bool,bool) Forcing use of NEW VisibilityIterator. |
| 27-Sep-2022 05:15:13 | PASSED |
| 27-Sep-2022 05:15:13 | |
| 27-Sep-2022 05:15:13 | test_tool_calibrater.py::calibrater_test::test_takesMs |
| 27-Sep-2022 05:15:13 | Check that the calibrater tool can open and close an MS |
| 27-Sep-2022 05:15:16 | 2022-09-27 09:15:17 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 27-Sep-2022 05:15:16 | 2022-09-27 09:15:17 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:15:16 | 2022-09-27 09:15:17 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:15:16 | 2022-09-27 09:15:17 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:15:19 | 2022-09-27 09:15:20 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:15:19 | 2022-09-27 09:15:20 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 27-Sep-2022 05:15:19 | 2022-09-27 09:15:20 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:15:19 | 2022-09-27 09:15:20 INFO name:: No table opened. |
| 27-Sep-2022 05:15:19 | 2022-09-27 09:15:20 INFO showcache:: The Table Cache has the following 16 entries: |
| 27-Sep-2022 05:15:19 | 2022-09-27 09:15:20 INFO showcache:: 0: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms" |
| 27-Sep-2022 05:15:19 | 2022-09-27 09:15:20 INFO showcache:: 1: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/ANTENNA" |
| 27-Sep-2022 05:15:19 | 2022-09-27 09:15:20 INFO showcache:: 2: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/DATA_DESCRIPTION" |
| 27-Sep-2022 05:15:19 | 2022-09-27 09:15:20 INFO showcache:: 3: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FEED" |
| 27-Sep-2022 05:15:19 | 2022-09-27 09:15:20 INFO showcache:: 4: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FIELD" |
| 27-Sep-2022 05:15:19 | 2022-09-27 09:15:20 INFO showcache:: 5: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FLAG_CMD" |
| 27-Sep-2022 05:15:19 | 2022-09-27 09:15:20 INFO showcache:: 6: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/HISTORY" |
| 27-Sep-2022 05:15:19 | 2022-09-27 09:15:20 INFO showcache:: 7: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/OBSERVATION" |
| 27-Sep-2022 05:15:19 | 2022-09-27 09:15:20 INFO showcache:: 8: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/POINTING" |
| 27-Sep-2022 05:15:19 | 2022-09-27 09:15:20 INFO showcache:: 9: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/POLARIZATION" |
| 27-Sep-2022 05:15:19 | 2022-09-27 09:15:20 INFO showcache:: 10: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/PROCESSOR" |
| 27-Sep-2022 05:15:19 | 2022-09-27 09:15:20 INFO showcache:: 11: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SOURCE" |
| 27-Sep-2022 05:15:19 | 2022-09-27 09:15:20 INFO showcache:: 12: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SPECTRAL_WINDOW" |
| 27-Sep-2022 05:15:19 | 2022-09-27 09:15:20 INFO showcache:: 13: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/STATE" |
| 27-Sep-2022 05:15:19 | 2022-09-27 09:15:20 INFO showcache:: 14: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SYSCAL" |
| 27-Sep-2022 05:15:19 | 2022-09-27 09:15:20 INFO showcache:: 15: "/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/WEATHER" |
| 27-Sep-2022 05:15:21 | 2022-09-27 09:15:22 INFO name:: No table opened. |
| 27-Sep-2022 05:15:21 | 2022-09-27 09:15:22 INFO showcache:: The Table Cache is empty. |
| 27-Sep-2022 05:15:21 | 2022-09-27 09:15:22 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 27-Sep-2022 05:15:21 | PASSED |
| 27-Sep-2022 05:15:21 | |
| 27-Sep-2022 05:15:21 | test_tool_calibrater.py::calibrater_test::test_writeToCorrected |
| 27-Sep-2022 05:15:21 | Check that the tool writes to the CORRECTED_DATA column |
| 27-Sep-2022 05:15:25 | 2022-09-27 09:15:25 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 27-Sep-2022 05:15:25 | 2022-09-27 09:15:25 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
| 27-Sep-2022 05:15:25 | 2022-09-27 09:15:25 INFO Clearing all model records in MS header. |
| 27-Sep-2022 05:15:25 | 2022-09-27 09:15:25 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
| 27-Sep-2022 05:15:29 | 2022-09-27 09:15:29 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
| 27-Sep-2022 05:15:29 | 2022-09-27 09:15:30 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
| 27-Sep-2022 05:15:29 | 2022-09-27 09:15:30 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 27-Sep-2022 05:15:29 | 2022-09-27 09:15:30 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
| 27-Sep-2022 05:15:29 | 2022-09-27 09:15:30 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
| 27-Sep-2022 05:15:29 | 2022-09-27 09:15:30 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:15:29 | 2022-09-27 09:15:30 INFO calibrater::correct Beginning correct--------------------------- |
| 27-Sep-2022 05:15:29 | 2022-09-27 09:15:30 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
| 27-Sep-2022 05:15:29 | 2022-09-27 09:15:30 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
| 27-Sep-2022 05:15:32 | 2022-09-27 09:15:33 INFO calibrater::correct Finished correcting. |
| 27-Sep-2022 05:15:34 | 2022-09-27 09:15:35 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
| 27-Sep-2022 05:15:35 | PASSED |
| 27-Sep-2022 05:15:35 | |
| 27-Sep-2022 05:15:35 | - generated xml file: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/xml/test_tool_calibrater/nose.xml - |
| 27-Sep-2022 05:15:35 | ================== 24 passed, 1 warning in 293.28s (0:04:53) =================== |
| 27-Sep-2022 05:15:35 | ============================= test session starts ============================== |
| 27-Sep-2022 05:15:35 | platform darwin -- Python 3.6.8, pytest-5.4.2, py-1.8.1, pluggy-0.13.1 -- /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6testenv/bin/python |
| 27-Sep-2022 05:15:35 | cachedir: .pytest_cache |
| 27-Sep-2022 05:15:35 | rootdir: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_measures, inifile: pytest.ini |
| 27-Sep-2022 05:15:36 | collecting ... collected 3 items |
| 27-Sep-2022 05:15:36 | |
| 27-Sep-2022 05:15:36 | |
| 27-Sep-2022 05:15:36 | test_tool_measures.py::me_test_cometdist::test_cometdist |
| 27-Sep-2022 05:15:36 | Is the distance to Ganymede just right? |
| 27-Sep-2022 05:15:36 | PASSED |
| 27-Sep-2022 05:15:36 | |
| 27-Sep-2022 05:15:36 | test_tool_measures.py::me_test_cometangdiam::test_cometangdiam |
| 27-Sep-2022 05:15:36 | Is Ganymede's angular diameter correct? |
| 27-Sep-2022 05:15:36 | PASSED |
| 27-Sep-2022 05:15:36 | |
| 27-Sep-2022 05:15:36 | test_tool_measures.py::me_test_shift::test_shift |
| 27-Sep-2022 05:15:36 | Test me.shift |
| 27-Sep-2022 05:15:36 | PASSED |
| 27-Sep-2022 05:15:36 | |
| 27-Sep-2022 05:15:36 | - generated xml file: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/xml/test_tool_measures/nose.xml - |
| 27-Sep-2022 05:15:36 | ========================= 3 passed, 1 warning in 0.91s ========================= |
| 27-Sep-2022 05:15:37 | ============================= test session starts ============================== |
| 27-Sep-2022 05:15:37 | platform darwin -- Python 3.6.8, pytest-5.4.2, py-1.8.1, pluggy-0.13.1 -- /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6testenv/bin/python |
| 27-Sep-2022 05:15:37 | cachedir: .pytest_cache |
| 27-Sep-2022 05:15:37 | rootdir: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_image_fromcomplist, inifile: pytest.ini |
| 27-Sep-2022 05:15:37 | collecting ... collected 0 items |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | - generated xml file: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/xml/test_tool_image_fromcomplist/nose.xml - |
| 27-Sep-2022 05:15:37 | ============================== 1 warning in 0.01s ============================== |
| 27-Sep-2022 05:15:37 | Traceback (most recent call last): |
| 27-Sep-2022 05:15:37 | File "runtest.py", line 613, in run |
| 27-Sep-2022 05:15:37 | shutil.copy2("{}{}.py".format(workdir + "tests/",test), workdir + "{}/".format(test if not test.endswith(".py") else test[:-3])) |
| 27-Sep-2022 05:15:37 | File "/Library/Frameworks/Python.framework/Versions/3.6/lib/python3.6/shutil.py", line 263, in copy2 |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | copyfile(src, dst, follow_symlinks=follow_symlinks) |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | File "/Library/Frameworks/Python.framework/Versions/3.6/lib/python3.6/shutil.py", line 120, in copyfile |
| 27-Sep-2022 05:15:37 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_regionmanager/ |
| 27-Sep-2022 05:15:37 | with open(src, 'rb') as fsrc: |
| 27-Sep-2022 05:15:37 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/tests/ to test_tool_regionmanager /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_regionmanager/ |
| 27-Sep-2022 05:15:37 | FileNotFoundError: [Errno 2] No such file or directory: '/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/tests/test_tool_image_fromcomplist.py' |
| 27-Sep-2022 05:15:37 | Test Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_regionmanager |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Running Command: pytest ['--junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/xml/test_tool_regionmanager/nose.xml', '-s', '--disable-pytest-warnings', '--verbose', '-ra', '--tb=short', '/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_regionmanager/'] |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_image_transpose/ |
| 27-Sep-2022 05:15:37 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/tests/ to test_tool_image_transpose /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_image_transpose/ |
| 27-Sep-2022 05:15:37 | Test Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_image_transpose |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Running Command: pytest ['--junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/xml/test_tool_image_transpose/nose.xml', '-s', '--disable-pytest-warnings', '--verbose', '-ra', '--tb=short', '/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_image_transpose/'] |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_imagepol/ |
| 27-Sep-2022 05:15:37 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/tests/ to test_tool_imagepol /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_imagepol/ |
| 27-Sep-2022 05:15:37 | Test Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_imagepol |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Running Command: pytest ['--junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/xml/test_tool_imagepol/nose.xml', '-s', '--disable-pytest-warnings', '--verbose', '-ra', '--tb=short', '/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_imagepol/'] |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_sdm_toms/ |
| 27-Sep-2022 05:15:37 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/tests/ to test_tool_sdm_toms /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_sdm_toms/ |
| 27-Sep-2022 05:15:37 | Test Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_sdm_toms |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Running Command: pytest ['--junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/xml/test_tool_sdm_toms/nose.xml', '-s', '--disable-pytest-warnings', '--verbose', '-ra', '--tb=short', '/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_sdm_toms/'] |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_image_rebin/ |
| 27-Sep-2022 05:15:37 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/tests/ to test_tool_image_rebin /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_image_rebin/ |
| 27-Sep-2022 05:15:37 | Test Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_image_rebin |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Running Command: pytest ['--junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/xml/test_tool_image_rebin/nose.xml', '-s', '--disable-pytest-warnings', '--verbose', '-ra', '--tb=short', '/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_image_rebin/'] |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_image_pv/ |
| 27-Sep-2022 05:15:37 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/tests/ to test_tool_image_pv /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_image_pv/ |
| 27-Sep-2022 05:15:37 | Test Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_image_pv |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Running Command: pytest ['--junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-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-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_image_pv/'] |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_ms_createmultims/ |
| 27-Sep-2022 05:15:37 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/tests/ to test_tool_ms_createmultims /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_ms_createmultims/ |
| 27-Sep-2022 05:15:37 | Test Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_ms_createmultims |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Running Command: pytest ['--junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-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-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_ms_createmultims/'] |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_image_deviation/ |
| 27-Sep-2022 05:15:37 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/tests/ to test_tool_image_deviation /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_image_deviation/ |
| 27-Sep-2022 05:15:37 | Test Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_image_deviation |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Running Command: pytest ['--junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-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-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_image_deviation/'] |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_table/ |
| 27-Sep-2022 05:15:37 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/tests/ to test_tool_table /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_table/ |
| 27-Sep-2022 05:15:37 | Test Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_table |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Running Command: pytest ['--junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/xml/test_tool_table/nose.xml', '-s', '--disable-pytest-warnings', '--verbose', '-ra', '--tb=short', '/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_table/'] |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calanalysis/ |
| 27-Sep-2022 05:15:37 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/tests/ to test_tool_calanalysis /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calanalysis/ |
| 27-Sep-2022 05:15:37 | Test Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calanalysis |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Running Command: pytest ['--junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/xml/test_tool_calanalysis/nose.xml', '-s', '--disable-pytest-warnings', '--verbose', '-ra', '--tb=short', '/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calanalysis/'] |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_msmetadata/ |
| 27-Sep-2022 05:15:37 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/tests/ to test_tool_msmetadata /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_msmetadata/ |
| 27-Sep-2022 05:15:37 | Test Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_msmetadata |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Running Command: pytest ['--junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/xml/test_tool_msmetadata/nose.xml', '-s', '--disable-pytest-warnings', '--verbose', '-ra', '--tb=short', '/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_msmetadata/'] |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_componentlist/ |
| 27-Sep-2022 05:15:37 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/tests/ to test_tool_componentlist /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_componentlist/ |
| 27-Sep-2022 05:15:37 | Test Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_componentlist |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Running Command: pytest ['--junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-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-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_componentlist/'] |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_ms_statwt/ |
| 27-Sep-2022 05:15:37 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/tests/ to test_tool_ms_statwt /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_ms_statwt/ |
| 27-Sep-2022 05:15:37 | Test Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_ms_statwt |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Running Command: pytest ['--junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/xml/test_tool_ms_statwt/nose.xml', '-s', '--disable-pytest-warnings', '--verbose', '-ra', '--tb=short', '/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_ms_statwt/'] |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/ |
| 27-Sep-2022 05:15:37 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/tests/ to test_tool_calibrater /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/ |
| 27-Sep-2022 05:15:37 | Test Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Running Command: pytest ['--junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-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-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_calibrater/'] |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_measures/ |
| 27-Sep-2022 05:15:37 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/tests/ to test_tool_measures /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_measures/ |
| 27-Sep-2022 05:15:37 | Test Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_measures |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Running Command: pytest ['--junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/xml/test_tool_measures/nose.xml', '-s', '--disable-pytest-warnings', '--verbose', '-ra', '--tb=short', '/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_measures/'] |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Setting Working Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_image_fromcomplist/ |
| 27-Sep-2022 05:15:37 | Copying: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/tests/ to test_tool_image_fromcomplist /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_image_fromcomplist/ |
| 27-Sep-2022 05:15:37 | Test Directory: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_image_fromcomplist |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Running Command: pytest ['--junitxml=/Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-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-C6DTF227-TTO15/casa6/casatestutils/nosedir/test_tool_image_fromcomplist/'] |
| 27-Sep-2022 05:15:37 | |
| 27-Sep-2022 05:15:37 | Finished task 'Test wheel' with result: Success |
| 27-Sep-2022 05:15:37 | Starting task 'Parse tests' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit' |
| 27-Sep-2022 05:15:37 | Parsing test results under /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15... |
| 27-Sep-2022 05:15:42 | Finished task 'Parse tests' with result: Success |
| 27-Sep-2022 05:15:42 | Starting task 'Script' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script' |
| 27-Sep-2022 05:15:42 | Beginning to execute external process for build 'CASA - Casa 6 Dev Test Full - CAS-13930 - Test tools OSX1015 #1 (CASA-C6DTF227-TTO15-1)' ... running command line: /Users/casaci/bamboohome/temp/CASA-C6DTF227-TTO15-1-ScriptBuildTask-8187269793797173308.sh ... in: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15 |
| 27-Sep-2022 05:15:43 | Cloning into 'casa-build-utils'... |
| 27-Sep-2022 05:15:45 | /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15 |
| 27-Sep-2022 05:15:54 | Looking in indexes: https://casa-pip.nrao.edu/repository/pypi-group/simple |
| 27-Sep-2022 05:15:54 | Collecting twine |
| 27-Sep-2022 05:15:55 | Using cached https://casa-pip.nrao.edu/repository/pypi-group/packages/twine/3.1.1/twine-3.1.1-py3-none-any.whl |
| 27-Sep-2022 05:15:55 | Collecting tqdm>=4.14 (from twine) |
| 27-Sep-2022 05:15:55 | Using cached https://casa-pip.nrao.edu/repository/pypi-group/packages/tqdm/4.46.0/tqdm-4.46.0-py2.py3-none-any.whl |
| 27-Sep-2022 05:15:55 | Requirement already satisfied: setuptools>=0.7.0 in ./casa6testenv/lib/python3.6/site-packages (from twine) (40.6.2) |
| 27-Sep-2022 05:15:55 | Collecting requests-toolbelt!=0.9.0,>=0.8.0 (from twine) |
| 27-Sep-2022 05:15:56 | Using cached https://casa-pip.nrao.edu/repository/pypi-group/packages/requests-toolbelt/0.9.1/requests_toolbelt-0.9.1-py2.py3-none-any.whl |
| 27-Sep-2022 05:15:56 | Collecting pkginfo>=1.4.2 (from twine) |
| 27-Sep-2022 05:15:56 | Using cached https://casa-pip.nrao.edu/repository/pypi-group/packages/pkginfo/1.5.0.1/pkginfo-1.5.0.1-py2.py3-none-any.whl |
| 27-Sep-2022 05:15:56 | Collecting importlib-metadata; python_version < "3.8" (from twine) |
| 27-Sep-2022 05:15:56 | Using cached https://casa-pip.nrao.edu/repository/pypi-group/packages/importlib-metadata/1.6.0/importlib_metadata-1.6.0-py2.py3-none-any.whl |
| 27-Sep-2022 05:15:56 | Collecting readme-renderer>=21.0 (from twine) |
| 27-Sep-2022 05:15:57 | Using cached https://casa-pip.nrao.edu/repository/pypi-group/packages/readme-renderer/26.0/readme_renderer-26.0-py2.py3-none-any.whl |
| 27-Sep-2022 05:15:57 | Collecting keyring>=15.1 (from twine) |
| 27-Sep-2022 05:15:58 | Using cached https://casa-pip.nrao.edu/repository/pypi-group/packages/keyring/21.2.1/keyring-21.2.1-py3-none-any.whl |
| 27-Sep-2022 05:15:58 | Collecting requests>=2.20 (from twine) |
| 27-Sep-2022 05:15:58 | Using cached https://casa-pip.nrao.edu/repository/pypi-group/packages/requests/2.23.0/requests-2.23.0-py2.py3-none-any.whl |
| 27-Sep-2022 05:15:58 | Collecting zipp>=0.5 (from importlib-metadata; python_version < "3.8"->twine) |
| 27-Sep-2022 05:15:58 | Using cached https://casa-pip.nrao.edu/repository/pypi-group/packages/zipp/3.1.0/zipp-3.1.0-py3-none-any.whl |
| 27-Sep-2022 05:15:58 | Collecting six (from readme-renderer>=21.0->twine) |
| 27-Sep-2022 05:15:58 | Using cached https://casa-pip.nrao.edu/repository/pypi-group/packages/six/1.15.0/six-1.15.0-py2.py3-none-any.whl |
| 27-Sep-2022 05:15:58 | Collecting docutils>=0.13.1 (from readme-renderer>=21.0->twine) |
| 27-Sep-2022 05:15:59 | Using cached https://casa-pip.nrao.edu/repository/pypi-group/packages/docutils/0.16/docutils-0.16-py2.py3-none-any.whl |
| 27-Sep-2022 05:15:59 | Collecting bleach>=2.1.0 (from readme-renderer>=21.0->twine) |
| 27-Sep-2022 05:16:00 | Using cached https://casa-pip.nrao.edu/repository/pypi-group/packages/bleach/3.1.5/bleach-3.1.5-py2.py3-none-any.whl |
| 27-Sep-2022 05:16:00 | Collecting Pygments>=2.5.1 (from readme-renderer>=21.0->twine) |
| 27-Sep-2022 05:16:00 | Using cached https://casa-pip.nrao.edu/repository/pypi-group/packages/pygments/2.6.1/Pygments-2.6.1-py3-none-any.whl |
| 27-Sep-2022 05:16:01 | Collecting certifi>=2017.4.17 (from requests>=2.20->twine) |
| 27-Sep-2022 05:16:01 | Using cached https://casa-pip.nrao.edu/repository/pypi-group/packages/certifi/2020.12.5/certifi-2020.12.5-py2.py3-none-any.whl |
| 27-Sep-2022 05:16:01 | Collecting chardet<4,>=3.0.2 (from requests>=2.20->twine) |
| 27-Sep-2022 05:16:01 | Using cached https://casa-pip.nrao.edu/repository/pypi-group/packages/chardet/3.0.4/chardet-3.0.4-py2.py3-none-any.whl |
| 27-Sep-2022 05:16:02 | Collecting urllib3!=1.25.0,!=1.25.1,<1.26,>=1.21.1 (from requests>=2.20->twine) |
| 27-Sep-2022 05:16:03 | Using cached https://casa-pip.nrao.edu/repository/pypi-group/packages/urllib3/1.25.9/urllib3-1.25.9-py2.py3-none-any.whl |
| 27-Sep-2022 05:16:03 | Collecting idna<3,>=2.5 (from requests>=2.20->twine) |
| 27-Sep-2022 05:16:03 | Using cached https://casa-pip.nrao.edu/repository/pypi-group/packages/idna/2.9/idna-2.9-py2.py3-none-any.whl |
| 27-Sep-2022 05:16:03 | Collecting webencodings (from bleach>=2.1.0->readme-renderer>=21.0->twine) |
| 27-Sep-2022 05:16:03 | Using cached https://casa-pip.nrao.edu/repository/pypi-group/packages/webencodings/0.5.1/webencodings-0.5.1-py2.py3-none-any.whl |
| 27-Sep-2022 05:16:03 | Collecting packaging (from bleach>=2.1.0->readme-renderer>=21.0->twine) |
| 27-Sep-2022 05:16:04 | Using cached https://casa-pip.nrao.edu/repository/pypi-group/packages/packaging/20.4/packaging-20.4-py2.py3-none-any.whl |
| 27-Sep-2022 05:16:04 | Collecting pyparsing>=2.0.2 (from packaging->bleach>=2.1.0->readme-renderer>=21.0->twine) |
| 27-Sep-2022 05:16:04 | Using cached https://casa-pip.nrao.edu/repository/pypi-group/packages/pyparsing/2.4.7/pyparsing-2.4.7-py2.py3-none-any.whl |
| 27-Sep-2022 05:16:04 | Installing collected packages: tqdm, certifi, chardet, urllib3, idna, requests, requests-toolbelt, pkginfo, zipp, importlib-metadata, six, docutils, webencodings, pyparsing, packaging, bleach, Pygments, readme-renderer, keyring, twine |
| 27-Sep-2022 05:16:11 | Successfully installed Pygments-2.6.1 bleach-3.1.5 certifi-2020.12.5 chardet-3.0.4 docutils-0.16 idna-2.9 importlib-metadata-1.6.0 keyring-21.2.1 packaging-20.4 pkginfo-1.5.0.1 pyparsing-2.4.7 readme-renderer-26.0 requests-2.23.0 requests-toolbelt-0.9.1 six-1.15.0 tqdm-4.46.0 twine-3.1.1 urllib3-1.25.9 webencodings-0.5.1 zipp-3.1.0 |
| 27-Sep-2022 05:16:12 | You are using pip version 18.1, however version 20.1.1 is available. |
| 27-Sep-2022 05:16:12 | You should consider upgrading via the 'pip install --upgrade pip' command. |
| 27-Sep-2022 05:16:14 | Uploading distributions to https://casa-pip.nrao.edu:443/repository/casa-dev-wheel/ |
| 27-Sep-2022 05:16:14 | Uploading casatools-6.5.2.23a13930.dev1-cp36-cp36m-macosx_10_15_x86_64.whl |
| 27-Sep-2022 05:16:14 | |
| 27-Sep-2022 05:16:14 | 0%| | 0.00/107M [00:00<?, ?B/s] |
| 27-Sep-2022 05:16:15 | 0%| | 8.00k/107M [00:00<30:19, 61.9kB/s] |
| 27-Sep-2022 05:16:15 | 6%|6 | 6.61M/107M [00:00<19:56, 88.4kB/s] |
| 27-Sep-2022 05:16:15 | 11%|# | 11.3M/107M [00:00<13:18, 126kB/s] |
| 27-Sep-2022 05:16:15 | 14%|#4 | 15.5M/107M [00:00<08:55, 180kB/s] |
| 27-Sep-2022 05:16:15 | 18%|#8 | 19.6M/107M [00:00<05:58, 257kB/s] |
| 27-Sep-2022 05:16:15 | 22%|##2 | 23.8M/107M [00:00<03:59, 366kB/s] |
| 27-Sep-2022 05:16:15 | 27%|##6 | 28.7M/107M [00:00<02:38, 520kB/s] |
| 27-Sep-2022 05:16:15 | 29%|##8 | 31.1M/107M [00:00<01:48, 736kB/s] |
| 27-Sep-2022 05:16:15 | 33%|###3 | 35.6M/107M [00:00<01:12, 1.04MB/s] |
| 27-Sep-2022 05:16:16 | 36%|###6 | 39.2M/107M [00:01<00:48, 1.47MB/s] |
| 27-Sep-2022 05:16:16 | 40%|###9 | 42.9M/107M [00:01<00:32, 2.07MB/s] |
| 27-Sep-2022 05:16:16 | 43%|####2 | 46.1M/107M [00:01<00:22, 2.86MB/s] |
| 27-Sep-2022 05:16:16 | 46%|####6 | 49.5M/107M [00:01<00:15, 3.95MB/s] |
| 27-Sep-2022 05:16:16 | 48%|####8 | 51.9M/107M [00:01<00:11, 5.21MB/s] |
| 27-Sep-2022 05:16:16 | 51%|##### | 54.8M/107M [00:01<00:07, 6.92MB/s] |
| 27-Sep-2022 05:16:16 | 54%|#####3 | 57.7M/107M [00:01<00:05, 8.82MB/s] |
| 27-Sep-2022 05:16:16 | 57%|#####6 | 60.7M/107M [00:01<00:04, 11.2MB/s] |
| 27-Sep-2022 05:16:16 | 59%|#####8 | 63.3M/107M [00:02<00:03, 13.3MB/s] |
| 27-Sep-2022 05:16:17 | 62%|######1 | 66.6M/107M [00:02<00:02, 16.3MB/s] |
| 27-Sep-2022 05:16:17 | 64%|######4 | 69.0M/107M [00:02<00:02, 17.6MB/s] |
| 27-Sep-2022 05:16:17 | 67%|######7 | 72.1M/107M [00:02<00:01, 20.4MB/s] |
| 27-Sep-2022 05:16:17 | 69%|######9 | 74.6M/107M [00:02<00:01, 20.8MB/s] |
| 27-Sep-2022 05:16:17 | 72%|#######2 | 77.6M/107M [00:02<00:01, 23.3MB/s] |
| 27-Sep-2022 05:16:17 | 75%|#######4 | 80.2M/107M [00:02<00:01, 23.1MB/s] |
| 27-Sep-2022 05:16:17 | 78%|#######7 | 83.5M/107M [00:02<00:00, 25.6MB/s] |
| 27-Sep-2022 05:16:17 | 80%|#######9 | 85.8M/107M [00:02<00:00, 24.0MB/s] |
| 27-Sep-2022 05:16:17 | 83%|########2 | 89.0M/107M [00:02<00:00, 26.3MB/s] |
| 27-Sep-2022 05:16:18 | 85%|########5 | 91.5M/107M [00:03<00:00, 25.0MB/s] |
| 27-Sep-2022 05:16:18 | 88%|########8 | 94.7M/107M [00:03<00:00, 27.1MB/s] |
| 27-Sep-2022 05:16:18 | 90%|######### | 97.1M/107M [00:03<00:00, 25.1MB/s] |
| 27-Sep-2022 05:16:18 | 94%|#########3| 101M/107M [00:03<00:00, 26.1MB/s] |
| 27-Sep-2022 05:16:18 | 97%|#########6| 104M/107M [00:03<00:00, 27.6MB/s] |
| 27-Sep-2022 05:16:18 | 99%|#########9| 106M/107M [00:03<00:00, 26.0MB/s] |
| 27-Sep-2022 05:16:18 | 100%|##########| 107M/107M [00:04<00:00, 27.8MB/s] |
| 27-Sep-2022 05:16:18 | HTTPError: 400 Client Error: Repository does not allow updating assets: casa-dev-wheel for url: https://casa-pip.nrao.edu:443/repository/casa-dev-wheel/ |
| 27-Sep-2022 05:16:18 | NOTE: Try --verbose to see response content. |
| 27-Sep-2022 05:16:18 | /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15 |
| 27-Sep-2022 05:16:18 | Finished task 'Script' with result: Success |
| 27-Sep-2022 05:16:18 | Starting task 'Reset config.py' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script' |
| 27-Sep-2022 05:16:18 | Beginning to execute external process for build 'CASA - Casa 6 Dev Test Full - CAS-13930 - Test tools OSX1015 #1 (CASA-C6DTF227-TTO15-1)' ... running command line: /Users/casaci/bamboohome/temp/CASA-C6DTF227-TTO15-1-ScriptBuildTask-6676660067163093071.sh ... in: /Users/casaci/bamboohome/xml-data/build-dir/CASA-C6DTF227-TTO15 |
| 27-Sep-2022 05:16:19 | % Total % Received % Xferd Average Speed Time Time Time Current |
| 27-Sep-2022 05:16:19 | Dload Upload Total Spent Left Speed |
| 27-Sep-2022 05:16:19 | |
| 27-Sep-2022 05:16:19 | 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 |
| 27-Sep-2022 05:16:19 | 100 70 100 70 0 0 909 0 --:--:-- --:--:-- --:--:-- 909 |
| 27-Sep-2022 05:16:19 | Finished task 'Reset config.py' with result: Success |
| 27-Sep-2022 05:16:19 | Running post build plugin 'Docker Container Cleanup' |
| 27-Sep-2022 05:16:19 | Running post build plugin 'NCover Results Collector' |
| 27-Sep-2022 05:16:19 | Running post build plugin 'Clover Results Collector' |
| 27-Sep-2022 05:16:19 | Running post build plugin 'npm Cache Cleanup' |
| 27-Sep-2022 05:16:19 | Running post build plugin 'Artifact Copier' |
| 27-Sep-2022 05:16:19 | Publishing an artifact: OSX10.15 casatools wheel |
| 27-Sep-2022 05:16:25 | Finished publishing of artifact Required shared artifact: [OSX10.15 casatools wheel], pattern: [casatools*.whl] anchored at: [wheeldirectory/] in 6.587 s |
| 27-Sep-2022 05:16:25 | Finalising the build... |
| 27-Sep-2022 05:16:25 | Stopping timer. |
| 27-Sep-2022 05:16:25 | Build CASA-C6DTF227-TTO15-1 completed. |
| 27-Sep-2022 05:16:26 | Running on server: post build plugin 'NCover Results Collector' |
| 27-Sep-2022 05:16:26 | Running on server: post build plugin 'Build Hanging Detection Configuration' |
| 27-Sep-2022 05:16:26 | Running on server: post build plugin 'Clover Delta Calculator' |
| 27-Sep-2022 05:16:26 | Running on server: post build plugin 'Maven Dependencies Postprocessor' |
| 27-Sep-2022 05:16:26 | All post build plugins have finished |
| 27-Sep-2022 05:16:26 | Generating build results summary... |
| 27-Sep-2022 05:16:27 | Saving build results to disk... |
| 27-Sep-2022 05:16:27 | Store variable context... |
| 27-Sep-2022 05:16:27 | Indexing build results... |
| 27-Sep-2022 05:16:27 | Finished building CASA-C6DTF227-TTO15-1. |