Build log
The build generated 53,018 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-Oct-2024 22:40:41 | PASSED |
27-Oct-2024 22:40:41 | |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO showcache:: The Table Cache is empty. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | test_tool_coordsys.py::coordsys_test::test_toPixelMany |
27-Oct-2024 22:40:41 | Test topixelmany parameter |
27-Oct-2024 22:40:41 | PASSED |
27-Oct-2024 22:40:41 | |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO showcache:: The Table Cache is empty. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | test_tool_coordsys.py::coordsys_test::test_toRecord |
27-Oct-2024 22:40:41 | Test that the coordsys can be converted to a record |
27-Oct-2024 22:40:41 | PASSED |
27-Oct-2024 22:40:41 | |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO showcache:: The Table Cache is empty. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | test_tool_coordsys.py::coordsys_test::test_toWorld |
27-Oct-2024 22:40:41 | Test the toworld conversion |
27-Oct-2024 22:40:41 | PASSED |
27-Oct-2024 22:40:41 | |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO showcache:: The Table Cache is empty. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | test_tool_coordsys.py::coordsys_test::test_toWorldMany |
27-Oct-2024 22:40:41 | Test the toworldmany parameter |
27-Oct-2024 22:40:41 | PASSED |
27-Oct-2024 22:40:41 | |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO ImageFactory::createImage Created Temp image of shape [4, 4, 4, 4] with float valued pixels. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO showcache:: The Table Cache is empty. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | test_tool_coordsys.py::coordsys_test::test_transpose |
27-Oct-2024 22:40:41 | Test the transpose() method |
27-Oct-2024 22:40:41 | PASSED |
27-Oct-2024 22:40:41 | |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO showcache:: The Table Cache is empty. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | test_tool_coordsys.py::coordsys_test::test_units |
27-Oct-2024 22:40:41 | Test that you can set and get unit names |
27-Oct-2024 22:40:41 | PASSED |
27-Oct-2024 22:40:41 | |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO showcache:: The Table Cache is empty. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | test_tool_coordsys.py::coordsys_test::test_velocityToFrequency |
27-Oct-2024 22:40:41 | Test velocity To frequency conversion |
27-Oct-2024 22:40:41 | PASSED |
27-Oct-2024 22:40:41 | |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO showcache:: The Table Cache is empty. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | 2024-10-28 02:40:41 INFO name:: No table opened. |
27-Oct-2024 22:40:41 | test_tool_coordsys.py::coordsys_test::test_velocityToFrequencyDiff |
27-Oct-2024 22:40:41 | Test the drequency diff |
27-Oct-2024 22:40:41 | PASSED |
27-Oct-2024 22:40:41 | |
27-Oct-2024 22:40:41 | - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_coordsys/nose.xml - |
27-Oct-2024 22:40:41 | ======================== 74 passed, 1 warning in 0.76s ========================= |
27-Oct-2024 22:40:41 | ============================= test session starts ============================== |
27-Oct-2024 22:40:41 | platform linux -- Python 3.8.7, pytest-8.3.3, pluggy-1.5.0 -- /home/casatest/venv/bin/python3.8 |
27-Oct-2024 22:40:41 | cachedir: .pytest_cache |
27-Oct-2024 22:40:41 | rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater |
27-Oct-2024 22:40:41 | configfile: pytest.ini |
27-Oct-2024 22:40:42 | collecting ... collected 24 items |
27-Oct-2024 22:40:42 | |
27-Oct-2024 22:40:42 | |
27-Oct-2024 22:40:42 | 2024-10-28 02:40:43 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
27-Oct-2024 22:40:42 | 2024-10-28 02:40:43 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:40:42 | 2024-10-28 02:40:43 INFO Clearing all model records in MS header. |
27-Oct-2024 22:40:42 | 2024-10-28 02:40:43 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:40:44 | 2024-10-28 02:40:44 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:40:44 | 2024-10-28 02:40:44 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
27-Oct-2024 22:40:44 | 2024-10-28 02:40:44 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:40:44 | 2024-10-28 02:40:44 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
27-Oct-2024 22:40:44 | 2024-10-28 02:40:44 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
27-Oct-2024 22:40:44 | 2024-10-28 02:40:45 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:40:44 | 2024-10-28 02:40:45 INFO calibrater::corrupt Beginning corrupt--------------------------- |
27-Oct-2024 22:40:44 | 2024-10-28 02:40:45 INFO Calibrater::corrupt2 (VI2/VB2) The following calibration terms are arranged for apply: |
27-Oct-2024 22:40:44 | 2024-10-28 02:40:45 INFO Calibrater::corrupt2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:40:46 | 2024-10-28 02:40:46 INFO calibrater::corrupt Finished corrupting. |
27-Oct-2024 22:40:46 | 2024-10-28 02:40:46 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
27-Oct-2024 22:40:46 | test_tool_calibrater.py::calibrater_test::test_activityRecord |
27-Oct-2024 22:40:46 | Check that using the calibrater to modify the vis shows in the activity record |
27-Oct-2024 22:40:46 | PASSED |
27-Oct-2024 22:40:46 | |
27-Oct-2024 22:40:46 | 2024-10-28 02:40:47 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
27-Oct-2024 22:40:46 | 2024-10-28 02:40:47 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:40:46 | 2024-10-28 02:40:47 INFO Clearing all model records in MS header. |
27-Oct-2024 22:40:46 | 2024-10-28 02:40:47 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:40:48 | 2024-10-28 02:40:48 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:40:48 | 2024-10-28 02:40:49 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
27-Oct-2024 22:40:48 | 2024-10-28 02:40:49 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:40:48 | 2024-10-28 02:40:49 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
27-Oct-2024 22:40:48 | 2024-10-28 02:40:49 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
27-Oct-2024 22:40:48 | 2024-10-28 02:40:49 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:40:48 | 2024-10-28 02:40:49 INFO calibrater::corrupt Beginning corrupt--------------------------- |
27-Oct-2024 22:40:48 | 2024-10-28 02:40:49 INFO Calibrater::corrupt2 (VI2/VB2) The following calibration terms are arranged for apply: |
27-Oct-2024 22:40:48 | 2024-10-28 02:40:49 INFO Calibrater::corrupt2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:40:50 | 2024-10-28 02:40:50 INFO calibrater::corrupt Finished corrupting. |
27-Oct-2024 22:40:52 | 2024-10-28 02:40:52 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
27-Oct-2024 22:40:52 | test_tool_calibrater.py::calibrater_test::test_corruptCal |
27-Oct-2024 22:40:52 | Check that the MS is corrupted using the cal table |
27-Oct-2024 22:40:52 | PASSED |
27-Oct-2024 22:40:52 | |
27-Oct-2024 22:40:52 | 2024-10-28 02:40:52 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
27-Oct-2024 22:40:52 | 2024-10-28 02:40:52 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:40:52 | 2024-10-28 02:40:52 INFO Clearing all model records in MS header. |
27-Oct-2024 22:40:52 | 2024-10-28 02:40:53 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:40:53 | 2024-10-28 02:40:54 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:40:53 | 2024-10-28 02:40:54 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
27-Oct-2024 22:40:53 | 2024-10-28 02:40:54 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:40:55 | 2024-10-28 02:40:56 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
27-Oct-2024 22:40:55 | test_tool_calibrater.py::calibrater_test::test_createEmpty |
27-Oct-2024 22:40:55 | Check that an empty cal table can be created |
27-Oct-2024 22:40:55 | PASSED |
27-Oct-2024 22:40:55 | |
27-Oct-2024 22:40:55 | 2024-10-28 02:40:56 INFO name:: No table opened. |
27-Oct-2024 22:40:55 | 2024-10-28 02:40:56 INFO showcache:: The Table Cache is empty. |
27-Oct-2024 22:40:55 | 2024-10-28 02:40:56 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
27-Oct-2024 22:40:55 | 2024-10-28 02:40:56 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:40:55 | 2024-10-28 02:40:56 INFO Clearing all model records in MS header. |
27-Oct-2024 22:40:56 | 2024-10-28 02:40:56 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 INFO name:: No table opened. |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 INFO showcache:: The Table Cache has the following 16 entries: |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 INFO showcache:: 0: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms" |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 INFO showcache:: 1: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/ANTENNA" |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 INFO showcache:: 2: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/DATA_DESCRIPTION" |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 INFO showcache:: 3: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FEED" |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 INFO showcache:: 4: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FIELD" |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 INFO showcache:: 5: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FLAG_CMD" |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 INFO showcache:: 6: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/HISTORY" |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 INFO showcache:: 7: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/OBSERVATION" |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 INFO showcache:: 8: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/POINTING" |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 INFO showcache:: 9: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/POLARIZATION" |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 INFO showcache:: 10: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/PROCESSOR" |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 INFO showcache:: 11: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SOURCE" |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 INFO showcache:: 12: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SPECTRAL_WINDOW" |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 INFO showcache:: 13: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/STATE" |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 INFO showcache:: 14: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SYSCAL" |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 INFO showcache:: 15: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/WEATHER" |
27-Oct-2024 22:40:57 | 2024-10-28 02:40:58 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
27-Oct-2024 22:40:58 | test_tool_calibrater.py::calibrater_test::test_done |
27-Oct-2024 22:40:58 | Check that done closes the active calibrator tool |
27-Oct-2024 22:40:58 | PASSED |
27-Oct-2024 22:40:58 | |
27-Oct-2024 22:40:58 | 2024-10-28 02:40:58 WARN calibrater::setvi(bool,bool) Forcing use of OLD VisibilityIterator. |
27-Oct-2024 22:40:58 | 2024-10-28 02:40:58 INFO calibrater::open ****Using OLD VI-driven calibrater tool**** |
27-Oct-2024 22:40:58 | 2024-10-28 02:40:58 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:40:58 | 2024-10-28 02:40:58 INFO Clearing all model records in MS header. |
27-Oct-2024 22:40:58 | 2024-10-28 02:40:58 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:40:59 | 2024-10-28 02:41:00 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:40:59 | 2024-10-28 02:41:00 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
27-Oct-2024 22:40:59 | 2024-10-28 02:41:00 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:40:59 | 2024-10-28 02:41:00 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
27-Oct-2024 22:40:59 | 2024-10-28 02:41:00 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
27-Oct-2024 22:41:00 | 2024-10-28 02:41:00 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:41:00 | 2024-10-28 02:41:00 INFO calibrater::correct Beginning correct--------------------------- |
27-Oct-2024 22:41:00 | 2024-10-28 02:41:00 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
27-Oct-2024 22:41:00 | 2024-10-28 02:41:00 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:41:02 | 2024-10-28 02:41:02 INFO calibrater::correct Finished correcting. |
27-Oct-2024 22:41:03 | 2024-10-28 02:41:03 INFO calibrater::open ****Using OLD VI-driven calibrater tool**** |
27-Oct-2024 22:41:03 | 2024-10-28 02:41:03 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:41:03 | 2024-10-28 02:41:03 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:41:03 | 2024-10-28 02:41:03 INFO calibrater::initcalset Beginning initcalset------------------------ |
27-Oct-2024 22:41:03 | 2024-10-28 02:41:03 INFO VisSet::VisSet Initializing MODEL_DATA (to unity) and CORRECTED_DATA (to DATA) |
27-Oct-2024 22:41:03 | 2024-10-28 02:41:04 INFO VisSet::VisSet Initialized 328860 rows. |
27-Oct-2024 22:41:05 | 2024-10-28 02:41:05 WARN calibrater::setvi(bool,bool) Forcing use of NEW VisibilityIterator. |
27-Oct-2024 22:41:05 | test_tool_calibrater.py::calibrater_test::test_reinitModel |
27-Oct-2024 22:41:05 | Check that initcalset will reset the CORRECTED_DATA to unity |
27-Oct-2024 22:41:05 | PASSED |
27-Oct-2024 22:41:05 | |
27-Oct-2024 22:41:05 | 2024-10-28 02:41:05 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
27-Oct-2024 22:41:05 | 2024-10-28 02:41:05 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:41:05 | 2024-10-28 02:41:05 INFO Clearing all model records in MS header. |
27-Oct-2024 22:41:05 | 2024-10-28 02:41:06 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:41:06 | 2024-10-28 02:41:07 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:07 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:07 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:07 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:07 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:07 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:07 INFO calibrater::setsolve Beginning setsolve--(MSSelection version)------- |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:07 INFO Calibrater::setsolve Arranging to SOLVE: |
27-Oct-2024 22:41:07 | 2024-10-28 02:41: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-Oct-2024 22:41:07 | 2024-10-28 02:41:07 INFO calibrater::reset Reseting solve/apply state |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:07 INFO calibrater::solve Beginning solve----------------------------- |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:07 SEVERE Calibrater::solve Caught exception: Please run setsolve before attempting to solve. |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:07 INFO Calibrater::solve Reseting entire solve/apply state. |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:07 SEVERE Exception Reported: Error in Calibrater::solve. |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:07 INFO calibrater::correct Beginning correct--------------------------- |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:07 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:07 INFO Calibrater::correct2 (VI2/VB2) . (None) |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:08 SEVERE Calibrater::correct2 (VI2/VB2) Caught exception: Nothing to Apply |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:08 INFO Calibrater::correct2 (VI2/VB2) Resetting all calibration application settings. |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:08 SEVERE Exception Reported: Error in Calibrater::correct. |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:08 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
27-Oct-2024 22:41:07 | test_tool_calibrater.py::calibrater_test::test_resetSolveApply |
27-Oct-2024 22:41:07 | Check that the reset function can clear set apply and solves |
27-Oct-2024 22:41:07 | PASSED |
27-Oct-2024 22:41:07 | |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:08 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:08 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:08 INFO Clearing all model records in MS header. |
27-Oct-2024 22:41:07 | 2024-10-28 02:41:08 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:41:09 | 2024-10-28 02:41:09 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:41:09 | 2024-10-28 02:41:10 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
27-Oct-2024 22:41:09 | 2024-10-28 02:41:10 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:41:10 | 2024-10-28 02:41:10 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
27-Oct-2024 22:41:10 | 2024-10-28 02:41:10 INFO calibrater::reset Reseting solve/apply state |
27-Oct-2024 22:41:10 | 2024-10-28 02:41:10 INFO Calibrater::selectvis Performing selection on MeasurementSet |
27-Oct-2024 22:41:10 | 2024-10-28 02:41:10 INFO Calibrater::selectvis+ Selecting on spw: '1' |
27-Oct-2024 22:41:10 | 2024-10-28 02:41:10 INFO Calibrater::selectvis By selection 328860 rows are reduced to 82215 |
27-Oct-2024 22:41:10 | 2024-10-28 02:41:10 INFO Calibrater::selectvis Frequency selection: |
27-Oct-2024 22:41:10 | 2024-10-28 02:41:10 INFO Calibrater::selectvis . Spw 1:0~7 (8 channels, step by 1) |
27-Oct-2024 22:41:10 | 2024-10-28 02:41:10 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
27-Oct-2024 22:41:10 | 2024-10-28 02:41:10 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
27-Oct-2024 22:41:10 | test_tool_calibrater.py::calibrater_test::test_returnDict |
27-Oct-2024 22:41:10 | Check that the returndict function gives a dictonary with the expected keys |
27-Oct-2024 22:41:10 | PASSED |
27-Oct-2024 22:41:10 | |
27-Oct-2024 22:41:11 | 2024-10-28 02:41:11 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
27-Oct-2024 22:41:11 | 2024-10-28 02:41:11 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:41:11 | 2024-10-28 02:41:11 INFO Clearing all model records in MS header. |
27-Oct-2024 22:41:11 | 2024-10-28 02:41:11 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:41:12 | 2024-10-28 02:41:13 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:41:12 | 2024-10-28 02:41:13 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
27-Oct-2024 22:41:12 | 2024-10-28 02:41:13 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:41:12 | 2024-10-28 02:41:13 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
27-Oct-2024 22:41:12 | 2024-10-28 02:41:13 INFO calibrater::reset Reseting solve/apply state |
27-Oct-2024 22:41:12 | 2024-10-28 02:41:13 INFO Calibrater::selectvis Performing selection on MeasurementSet |
27-Oct-2024 22:41:12 | 2024-10-28 02:41:13 INFO Calibrater::selectvis+ Selecting on antenna/baseline: '0' |
27-Oct-2024 22:41:13 | 2024-10-28 02:41:13 INFO Calibrater::selectvis By selection 328860 rows are reduced to 65772 |
27-Oct-2024 22:41:13 | 2024-10-28 02:41:13 INFO Calibrater::selectvis Frequency selection: Selecting all channels in all spws. |
27-Oct-2024 22:41:13 | 2024-10-28 02:41:13 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
27-Oct-2024 22:41:13 | 2024-10-28 02:41:13 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
27-Oct-2024 22:41:13 | 2024-10-28 02:41:13 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
27-Oct-2024 22:41:13 | 2024-10-28 02:41:13 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:41:13 | 2024-10-28 02:41:13 INFO calibrater::correct Beginning correct--------------------------- |
27-Oct-2024 22:41:13 | 2024-10-28 02:41:13 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
27-Oct-2024 22:41:13 | 2024-10-28 02:41:13 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:41:14 | 2024-10-28 02:41:14 INFO calibrater::correct Finished correcting. |
27-Oct-2024 22:41:15 | 2024-10-28 02:41:15 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
27-Oct-2024 22:41:15 | test_tool_calibrater.py::calibrater_test::test_selectVisBaseline |
27-Oct-2024 22:41:15 | Check that selectvis properly selects baseline/antenna |
27-Oct-2024 22:41:15 | 65772 65772 |
27-Oct-2024 22:41:15 | 263088 263088 |
27-Oct-2024 22:41:15 | PASSED |
27-Oct-2024 22:41:15 | |
27-Oct-2024 22:41:15 | 2024-10-28 02:41:16 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
27-Oct-2024 22:41:15 | 2024-10-28 02:41:16 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:41:15 | 2024-10-28 02:41:16 INFO Clearing all model records in MS header. |
27-Oct-2024 22:41:16 | 2024-10-28 02:41:16 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:41:17 | 2024-10-28 02:41:17 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:41:17 | 2024-10-28 02:41:18 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
27-Oct-2024 22:41:17 | 2024-10-28 02:41:18 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:41:17 | 2024-10-28 02:41:18 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
27-Oct-2024 22:41:17 | 2024-10-28 02:41:18 INFO calibrater::reset Reseting solve/apply state |
27-Oct-2024 22:41:17 | 2024-10-28 02:41:18 INFO Calibrater::selectvis Performing selection on MeasurementSet |
27-Oct-2024 22:41:17 | 2024-10-28 02:41:18 INFO Calibrater::selectvis+ Selecting on field: '0' |
27-Oct-2024 22:41:17 | 2024-10-28 02:41:18 INFO Calibrater::selectvis By selection 328860 rows are reduced to 172260 |
27-Oct-2024 22:41:17 | 2024-10-28 02:41:18 INFO Calibrater::selectvis Frequency selection: Selecting all channels in all spws. |
27-Oct-2024 22:41:17 | 2024-10-28 02:41:18 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
27-Oct-2024 22:41:17 | 2024-10-28 02:41:18 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
27-Oct-2024 22:41:17 | 2024-10-28 02:41:18 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
27-Oct-2024 22:41:17 | 2024-10-28 02:41:18 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:41:17 | 2024-10-28 02:41:18 INFO calibrater::correct Beginning correct--------------------------- |
27-Oct-2024 22:41:17 | 2024-10-28 02:41:18 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
27-Oct-2024 22:41:17 | 2024-10-28 02:41:18 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:41:18 | 2024-10-28 02:41:19 INFO calibrater::correct Finished correcting. |
27-Oct-2024 22:41:19 | 2024-10-28 02:41:20 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
27-Oct-2024 22:41:19 | test_tool_calibrater.py::calibrater_test::test_selectVisField |
27-Oct-2024 22:41:19 | Check that the field is properly selected by selectvis |
27-Oct-2024 22:41:19 | PASSED |
27-Oct-2024 22:41:19 | |
27-Oct-2024 22:41:20 | 2024-10-28 02:41:20 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
27-Oct-2024 22:41:20 | 2024-10-28 02:41:20 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:41:20 | 2024-10-28 02:41:20 INFO Clearing all model records in MS header. |
27-Oct-2024 22:41:20 | 2024-10-28 02:41:21 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:41:21 | 2024-10-28 02:41:22 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:41:22 | 2024-10-28 02:41:22 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
27-Oct-2024 22:41:22 | 2024-10-28 02:41:22 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:41:22 | 2024-10-28 02:41:22 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
27-Oct-2024 22:41:22 | 2024-10-28 02:41:22 INFO calibrater::reset Reseting solve/apply state |
27-Oct-2024 22:41:22 | 2024-10-28 02:41:22 INFO Calibrater::selectvis Performing selection on MeasurementSet |
27-Oct-2024 22:41:22 | 2024-10-28 02:41:22 INFO Calibrater::selectvis+ Selecting on intent: '*AMPLI*' |
27-Oct-2024 22:41:22 | 2024-10-28 02:41:22 INFO Calibrater::selectvis Selection did not drop any rows |
27-Oct-2024 22:41:22 | 2024-10-28 02:41:22 INFO Calibrater::selectvis Frequency selection: Selecting all channels in all spws. |
27-Oct-2024 22:41:22 | 2024-10-28 02:41:22 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
27-Oct-2024 22:41:22 | 2024-10-28 02:41:22 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
27-Oct-2024 22:41:22 | 2024-10-28 02:41:22 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
27-Oct-2024 22:41:22 | 2024-10-28 02:41:22 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:41:22 | 2024-10-28 02:41:22 INFO calibrater::correct Beginning correct--------------------------- |
27-Oct-2024 22:41:22 | 2024-10-28 02:41:22 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
27-Oct-2024 22:41:22 | 2024-10-28 02:41:22 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:41:24 | 2024-10-28 02:41:25 INFO calibrater::correct Finished correcting. |
27-Oct-2024 22:41:24 | 2024-10-28 02:41:25 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
27-Oct-2024 22:41:24 | test_tool_calibrater.py::calibrater_test::test_selectVisIntent |
27-Oct-2024 22:41:24 | Check that the intent is properly selected by selectvis |
27-Oct-2024 22:41:24 | PASSED |
27-Oct-2024 22:41:24 | |
27-Oct-2024 22:41:25 | 2024-10-28 02:41:26 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
27-Oct-2024 22:41:25 | 2024-10-28 02:41:26 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:41:25 | 2024-10-28 02:41:26 INFO Clearing all model records in MS header. |
27-Oct-2024 22:41:25 | 2024-10-28 02:41:26 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:41:27 | 2024-10-28 02:41:27 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:41:27 | 2024-10-28 02:41:27 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
27-Oct-2024 22:41:27 | 2024-10-28 02:41:27 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:41:27 | 2024-10-28 02:41:27 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
27-Oct-2024 22:41:27 | 2024-10-28 02:41:27 INFO calibrater::reset Reseting solve/apply state |
27-Oct-2024 22:41:27 | 2024-10-28 02:41:27 INFO Calibrater::selectvis Performing selection on MeasurementSet |
27-Oct-2024 22:41:27 | 2024-10-28 02:41:27 INFO Calibrater::selectvis+ Selecting by observation IDs: '0' |
27-Oct-2024 22:41:27 | 2024-10-28 02:41:28 INFO Calibrater::selectvis By selection 328860 rows are reduced to 318870 |
27-Oct-2024 22:41:27 | 2024-10-28 02:41:28 INFO Calibrater::selectvis Frequency selection: Selecting all channels in all spws. |
27-Oct-2024 22:41:27 | 2024-10-28 02:41:28 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
27-Oct-2024 22:41:27 | 2024-10-28 02:41:28 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
27-Oct-2024 22:41:27 | 2024-10-28 02:41:28 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
27-Oct-2024 22:41:27 | 2024-10-28 02:41:28 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:41:27 | 2024-10-28 02:41:28 INFO calibrater::correct Beginning correct--------------------------- |
27-Oct-2024 22:41:27 | 2024-10-28 02:41:28 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
27-Oct-2024 22:41:27 | 2024-10-28 02:41:28 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:41:29 | 2024-10-28 02:41:30 INFO calibrater::correct Finished correcting. |
27-Oct-2024 22:41:29 | 2024-10-28 02:41:30 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
27-Oct-2024 22:41:29 | test_tool_calibrater.py::calibrater_test::test_selectVisObs |
27-Oct-2024 22:41:29 | PASSED |
27-Oct-2024 22:41:29 | |
27-Oct-2024 22:41:30 | 2024-10-28 02:41:31 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
27-Oct-2024 22:41:30 | 2024-10-28 02:41:31 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:41:30 | 2024-10-28 02:41:31 INFO Clearing all model records in MS header. |
27-Oct-2024 22:41:30 | 2024-10-28 02:41:31 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:41:32 | 2024-10-28 02:41:32 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:41:32 | 2024-10-28 02:41:32 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
27-Oct-2024 22:41:32 | 2024-10-28 02:41:32 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:41:32 | 2024-10-28 02:41:32 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
27-Oct-2024 22:41:32 | 2024-10-28 02:41:32 INFO calibrater::reset Reseting solve/apply state |
27-Oct-2024 22:41:32 | 2024-10-28 02:41:32 INFO Calibrater::selectvis Performing selection on MeasurementSet |
27-Oct-2024 22:41:32 | 2024-10-28 02:41:32 INFO Calibrater::selectvis+ Selecting on scan: '2' |
27-Oct-2024 22:41:32 | 2024-10-28 02:41:32 INFO Calibrater::selectvis By selection 328860 rows are reduced to 15660 |
27-Oct-2024 22:41:32 | 2024-10-28 02:41:32 INFO Calibrater::selectvis Frequency selection: Selecting all channels in all spws. |
27-Oct-2024 22:41:32 | 2024-10-28 02:41:32 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
27-Oct-2024 22:41:32 | 2024-10-28 02:41:32 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
27-Oct-2024 22:41:32 | 2024-10-28 02:41:32 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
27-Oct-2024 22:41:32 | 2024-10-28 02:41:32 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:41:32 | 2024-10-28 02:41:32 INFO calibrater::correct Beginning correct--------------------------- |
27-Oct-2024 22:41:32 | 2024-10-28 02:41:32 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
27-Oct-2024 22:41:32 | 2024-10-28 02:41:32 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:41:32 | 2024-10-28 02:41:32 INFO calibrater::correct Finished correcting. |
27-Oct-2024 22:41:33 | 2024-10-28 02:41:33 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
27-Oct-2024 22:41:33 | test_tool_calibrater.py::calibrater_test::test_selectVisScan |
27-Oct-2024 22:41:33 | Check tht the scan is properly selected by selectvis |
27-Oct-2024 22:41:33 | PASSED |
27-Oct-2024 22:41:33 | |
27-Oct-2024 22:41:34 | 2024-10-28 02:41:34 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
27-Oct-2024 22:41:34 | 2024-10-28 02:41:34 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:41:34 | 2024-10-28 02:41:34 INFO Clearing all model records in MS header. |
27-Oct-2024 22:41:34 | 2024-10-28 02:41:34 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:41:35 | 2024-10-28 02:41:36 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:41:35 | 2024-10-28 02:41:36 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
27-Oct-2024 22:41:35 | 2024-10-28 02:41:36 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:41:35 | 2024-10-28 02:41:36 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
27-Oct-2024 22:41:35 | 2024-10-28 02:41:36 INFO calibrater::reset Reseting solve/apply state |
27-Oct-2024 22:41:35 | 2024-10-28 02:41:36 INFO Calibrater::selectvis Performing selection on MeasurementSet |
27-Oct-2024 22:41:35 | 2024-10-28 02:41:36 INFO Calibrater::selectvis+ Selecting on spw: '0' |
27-Oct-2024 22:41:35 | 2024-10-28 02:41:36 INFO Calibrater::selectvis By selection 328860 rows are reduced to 82215 |
27-Oct-2024 22:41:35 | 2024-10-28 02:41:36 INFO Calibrater::selectvis Frequency selection: |
27-Oct-2024 22:41:35 | 2024-10-28 02:41:36 INFO Calibrater::selectvis . Spw 0:0~7 (8 channels, step by 1) |
27-Oct-2024 22:41:35 | 2024-10-28 02:41:36 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
27-Oct-2024 22:41:35 | 2024-10-28 02:41:36 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
27-Oct-2024 22:41:35 | 2024-10-28 02:41:36 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
27-Oct-2024 22:41:36 | 2024-10-28 02:41:36 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:41:36 | 2024-10-28 02:41:36 INFO calibrater::correct Beginning correct--------------------------- |
27-Oct-2024 22:41:36 | 2024-10-28 02:41:36 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
27-Oct-2024 22:41:36 | 2024-10-28 02:41:36 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:41:36 | 2024-10-28 02:41:37 INFO calibrater::correct Finished correcting. |
27-Oct-2024 22:41:37 | 2024-10-28 02:41:37 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
27-Oct-2024 22:41:37 | test_tool_calibrater.py::calibrater_test::test_selectVisSpw |
27-Oct-2024 22:41:37 | Check that spw is properly selected by selectvis |
27-Oct-2024 22:41:37 | PASSED |
27-Oct-2024 22:41:37 | |
27-Oct-2024 22:41:38 | 2024-10-28 02:41:38 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
27-Oct-2024 22:41:38 | 2024-10-28 02:41:38 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:41:38 | 2024-10-28 02:41:38 INFO Clearing all model records in MS header. |
27-Oct-2024 22:41:38 | 2024-10-28 02:41:38 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:41:39 | 2024-10-28 02:41:40 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:41:40 | 2024-10-28 02:41:40 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
27-Oct-2024 22:41:40 | 2024-10-28 02:41:40 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:41:40 | 2024-10-28 02:41:40 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
27-Oct-2024 22:41:40 | 2024-10-28 02:41:40 INFO calibrater::reset Reseting solve/apply state |
27-Oct-2024 22:41:40 | 2024-10-28 02:41:40 INFO Calibrater::selectvis Performing selection on MeasurementSet |
27-Oct-2024 22:41:40 | 2024-10-28 02:41:40 INFO Calibrater::selectvis+ Selecting on time: '>04:38:23' |
27-Oct-2024 22:41:40 | 2024-10-28 02:41:40 INFO Calibrater::selectvis By selection 328860 rows are reduced to 313200 |
27-Oct-2024 22:41:40 | 2024-10-28 02:41:40 INFO Calibrater::selectvis Frequency selection: Selecting all channels in all spws. |
27-Oct-2024 22:41:40 | 2024-10-28 02:41:40 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
27-Oct-2024 22:41:40 | 2024-10-28 02:41:40 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
27-Oct-2024 22:41:40 | 2024-10-28 02:41:40 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
27-Oct-2024 22:41:40 | 2024-10-28 02:41:40 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:41:40 | 2024-10-28 02:41:40 INFO calibrater::correct Beginning correct--------------------------- |
27-Oct-2024 22:41:40 | 2024-10-28 02:41:40 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
27-Oct-2024 22:41:40 | 2024-10-28 02:41:40 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:41:42 | 2024-10-28 02:41:42 INFO calibrater::correct Finished correcting. |
27-Oct-2024 22:41:43 | 2024-10-28 02:41:43 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
27-Oct-2024 22:41:43 | test_tool_calibrater.py::calibrater_test::test_selectVisTime |
27-Oct-2024 22:41:43 | Check that time is properly selected by selectvis |
27-Oct-2024 22:41:43 | PASSED |
27-Oct-2024 22:41:43 | |
27-Oct-2024 22:41:43 | 2024-10-28 02:41:43 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
27-Oct-2024 22:41:43 | 2024-10-28 02:41:43 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:41:43 | 2024-10-28 02:41:43 INFO Clearing all model records in MS header. |
27-Oct-2024 22:41:43 | 2024-10-28 02:41:44 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:41:47 | 2024-10-28 02:41:48 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:41:47 | 2024-10-28 02:41:48 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
27-Oct-2024 22:41:47 | 2024-10-28 02:41:48 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:41:47 | 2024-10-28 02:41:48 INFO calibrater::setdata Beginning selectvis--(MSSelection version)------- |
27-Oct-2024 22:41:47 | 2024-10-28 02:41:48 INFO calibrater::reset Reseting solve/apply state |
27-Oct-2024 22:41:47 | 2024-10-28 02:41:48 INFO Calibrater::selectvis Performing selection on MeasurementSet |
27-Oct-2024 22:41:47 | 2024-10-28 02:41:48 INFO Calibrater::selectvis+ Selecting on uvrange: '> 500000lambda' |
27-Oct-2024 22:41:48 | 2024-10-28 02:41:49 INFO Calibrater::selectvis By selection 328860 rows are reduced to 103321 |
27-Oct-2024 22:41:48 | 2024-10-28 02:41:49 INFO Calibrater::selectvis Frequency selection: Selecting all channels in all spws. |
27-Oct-2024 22:41:48 | 2024-10-28 02:41:49 INFO calibrater::setdata chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='' |
27-Oct-2024 22:41:48 | 2024-10-28 02:41:49 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
27-Oct-2024 22:41:48 | 2024-10-28 02:41:49 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
27-Oct-2024 22:41:48 | 2024-10-28 02:41:49 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:41:48 | 2024-10-28 02:41:49 INFO calibrater::correct Beginning correct--------------------------- |
27-Oct-2024 22:41:48 | 2024-10-28 02:41:49 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
27-Oct-2024 22:41:48 | 2024-10-28 02:41:49 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:41:50 | 2024-10-28 02:41:50 INFO calibrater::correct Finished correcting. |
27-Oct-2024 22:42:00 | 2024-10-28 02:42:01 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
27-Oct-2024 22:42:00 | test_tool_calibrater.py::calibrater_test::test_selectVisUVrange |
27-Oct-2024 22:42:00 | Check that selectvis properly selects for uvrange |
27-Oct-2024 22:42:00 | PASSED |
27-Oct-2024 22:42:00 | |
27-Oct-2024 22:42:00 | 2024-10-28 02:42:01 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
27-Oct-2024 22:42:00 | 2024-10-28 02:42:01 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:42:00 | 2024-10-28 02:42:01 INFO Clearing all model records in MS header. |
27-Oct-2024 22:42:00 | 2024-10-28 02:42:01 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:42:02 | 2024-10-28 02:42:02 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:42:02 | 2024-10-28 02:42:02 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
27-Oct-2024 22:42:02 | 2024-10-28 02:42:02 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:42:02 | 2024-10-28 02:42:02 INFO calibrater::parsecallibfile Beginning parsecallibfile-)------- |
27-Oct-2024 22:42:02 | 2024-10-28 02:42:02 INFO calibrater::setcallib Beginning setcallib--------- |
27-Oct-2024 22:42:02 | 2024-10-28 02:42:02 INFO Calibrater::setcallib2(callib) Arranging to APPLY: |
27-Oct-2024 22:42:02 | 2024-10-28 02:42:02 INFO . G Jones: table=gaincaltest2.ms.G0 (by cal library) calWt=true |
27-Oct-2024 22:42:02 | 2024-10-28 02:42:02 INFO . 0: |
27-Oct-2024 22:42:02 | 2024-10-28 02:42:02 INFO + MS: obs= scan= fld= intent= spw= |
27-Oct-2024 22:42:02 | 2024-10-28 02:42:02 INFO + CT: tinterp=linear finterp= |
27-Oct-2024 22:42:02 | 2024-10-28 02:42:02 INFO + obsmap=[] scanmap=[] fldmap=[] |
27-Oct-2024 22:42:02 | 2024-10-28 02:42:02 INFO + spwmap=[] antmap=[] |
27-Oct-2024 22:42:02 | 2024-10-28 02:42:03 INFO calibrater::corrupt Beginning corrupt--------------------------- |
27-Oct-2024 22:42:02 | 2024-10-28 02:42:03 INFO Calibrater::corrupt2 (VI2/VB2) The following calibration terms are arranged for apply: |
27-Oct-2024 22:42:02 | 2024-10-28 02:42:03 INFO Calibrater::corrupt2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 (by cal library) calWt=true |
27-Oct-2024 22:42:04 | 2024-10-28 02:42:04 INFO calibrater::corrupt Finished corrupting. |
27-Oct-2024 22:42:04 | 2024-10-28 02:42:05 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
27-Oct-2024 22:42:04 | test_tool_calibrater.py::calibrater_test::test_setCalLib |
27-Oct-2024 22:42:04 | Check that a provided cal table can be used to corrupt the MODEL_DATA |
27-Oct-2024 22:42:04 | PASSED |
27-Oct-2024 22:42:04 | |
27-Oct-2024 22:42:05 | 2024-10-28 02:42:05 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
27-Oct-2024 22:42:05 | 2024-10-28 02:42:05 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:42:05 | 2024-10-28 02:42:05 INFO Clearing all model records in MS header. |
27-Oct-2024 22:42:05 | 2024-10-28 02:42:05 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:42:06 | 2024-10-28 02:42:07 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:42:06 | 2024-10-28 02:42:07 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
27-Oct-2024 22:42:06 | 2024-10-28 02:42:07 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:42:06 | 2024-10-28 02:42:07 INFO Calibrater::setCorrDepFlags Setting correlation dependent flags = True |
27-Oct-2024 22:42:06 | 2024-10-28 02:42:07 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
27-Oct-2024 22:42:07 | test_tool_calibrater.py::calibrater_test::test_setCorrDepFlags |
27-Oct-2024 22:42:07 | Check that corrdepflags will be checked |
27-Oct-2024 22:42:07 | PASSED |
27-Oct-2024 22:42:07 | |
27-Oct-2024 22:42:07 | 2024-10-28 02:42:07 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
27-Oct-2024 22:42:07 | 2024-10-28 02:42:07 INFO calibrater::open Opening MS: ngc5921.ms for calibration. |
27-Oct-2024 22:42:07 | 2024-10-28 02:42:07 INFO Clearing all model records in MS header. |
27-Oct-2024 22:42:07 | 2024-10-28 02:42:07 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:42:07 | 2024-10-28 02:42:08 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:42:07 | 2024-10-28 02:42:08 INFO VisSetUtil::initScrCols Initialized 22653 rows. |
27-Oct-2024 22:42:07 | 2024-10-28 02:42:08 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:42:07 | 2024-10-28 02:42:08 INFO calibrater::smooth Beginning smooth--(MSSelection version)------- |
27-Oct-2024 22:42:07 | 2024-10-28 02:42:08 INFO Calibrater::smooth Beginning smoothing/interpolating method. |
27-Oct-2024 22:42:07 | 2024-10-28 02:42:08 WARN Found pre-v4.1 caltable (/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/ngc5921.gcal); attempting to update... |
27-Oct-2024 22:42:07 | 2024-10-28 02:42:08 WARN + SUCCEEDED: trivial OBSERVATION/OBSERVATION_ID have been added. |
27-Oct-2024 22:42:08 | 2024-10-28 02:42:08 INFO Calibrater::smooth Storing result in testcalout.cal |
27-Oct-2024 22:42:08 | 2024-10-28 02:42:08 INFO Writing solutions to table: testcalout.cal |
27-Oct-2024 22:42:09 | 2024-10-28 02:42:09 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
27-Oct-2024 22:42:09 | test_tool_calibrater.py::calibrater_test::test_smoothedCalTables |
27-Oct-2024 22:42:09 | Check that the smooth command creates a smoothed cal table |
27-Oct-2024 22:42:09 | PASSED |
27-Oct-2024 22:42:09 | |
27-Oct-2024 22:42:09 | 2024-10-28 02:42:10 WARN calibrater::setvi(bool,bool) Forcing use of OLD VisibilityIterator. |
27-Oct-2024 22:42:09 | 2024-10-28 02:42:10 INFO calibrater::open ****Using OLD VI-driven calibrater tool**** |
27-Oct-2024 22:42:09 | 2024-10-28 02:42:10 INFO calibrater::open Opening MS: ngc5921.ms for calibration. |
27-Oct-2024 22:42:09 | 2024-10-28 02:42:10 INFO Clearing all model records in MS header. |
27-Oct-2024 22:42:09 | 2024-10-28 02:42:10 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO VisSetUtil::initScrCols Initialized 22653 rows. |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO calibrater::setsolvebandpoly Beginning setsolvebandpoly--(MSSelection version)------- |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO Calibrater::setsolvebandpoly Arranging to SOLVE: |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO Calibrater::setsolvebandpoly . BPOLY: table=bpoly append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode= solnorm=true normtype=MEAN |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO calibrater::solve Beginning solve----------------------------- |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO Calibrater::solve The following calibration terms are arranged for apply: |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO Calibrater::solve . (None) |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO Calibrater::solve The following calibration term is arranged for solve: |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO Calibrater::solve . BPOLY: table=bpoly append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode= solnorm=true normtype=MEAN |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO Calibrater::solve Solving for BPOLY |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO For solint = inf, found 7 solution intervals. |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO BJonesPoly::selfSolveOne() THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO BJonesPoly::selfSolveOne() Fitting bandpass amplitude and phase polynomials. |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO BJonesPoly::selfSolveOne() Polynomial degree for amplitude is 5 |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO BJonesPoly::selfSolveOne() Polynomial degree for phase is 7 |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO BJonesPoly::selfSolveOne() Spectral grid for fit will have 63 points spaced by 24.4141 kHz. |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO BJonesPoly::selfSolveOne() Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz. |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO BJonesPoly::selfSolveOne() Total bandwidth: 1538.09 kHz. |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO BJonesPoly::selfSolveOne() Found data for 351 baselines among 27 antennas. |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.059507/0.0681762/0.0765806 |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:10 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:11 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 0.336529/0.750193/1.6779 |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:11 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:11 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0630839/0.0689061/0.0756384 |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:11 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:11 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 0.279482/0.74979/1.59355 |
27-Oct-2024 22:42:10 | 2024-10-28 02:42:11 INFO BJonesPoly::selfSolveOne() Normalizing antenna-based solutions. |
27-Oct-2024 22:42:11 | 2024-10-28 02:42:11 INFO BJonesPoly::updateCalTable() Storing calibration in table bpoly |
27-Oct-2024 22:42:11 | 2024-10-28 02:42:11 INFO BJonesPoly::selfSolveOne() THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION |
27-Oct-2024 22:42:11 | 2024-10-28 02:42:11 INFO BJonesPoly::selfSolveOne() Fitting bandpass amplitude and phase polynomials. |
27-Oct-2024 22:42:11 | 2024-10-28 02:42:11 INFO BJonesPoly::selfSolveOne() Polynomial degree for amplitude is 5 |
27-Oct-2024 22:42:11 | 2024-10-28 02:42:11 INFO BJonesPoly::selfSolveOne() Polynomial degree for phase is 7 |
27-Oct-2024 22:42:11 | 2024-10-28 02:42:11 INFO BJonesPoly::selfSolveOne() Spectral grid for fit will have 63 points spaced by 24.4141 kHz. |
27-Oct-2024 22:42:11 | 2024-10-28 02:42:11 INFO BJonesPoly::selfSolveOne() Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz. |
27-Oct-2024 22:42:11 | 2024-10-28 02:42:11 INFO BJonesPoly::selfSolveOne() Total bandwidth: 1538.09 kHz. |
27-Oct-2024 22:42:11 | 2024-10-28 02:42:11 INFO BJonesPoly::selfSolveOne() Found data for 351 baselines among 27 antennas. |
27-Oct-2024 22:42:11 | 2024-10-28 02:42:11 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
27-Oct-2024 22:42:11 | 2024-10-28 02:42:11 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0672607/0.089081/0.111106 |
27-Oct-2024 22:42:11 | 2024-10-28 02:42:11 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
27-Oct-2024 22:42:11 | 2024-10-28 02:42:12 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 2.31075/3.32219/4.29305 |
27-Oct-2024 22:42:11 | 2024-10-28 02:42:12 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
27-Oct-2024 22:42:11 | 2024-10-28 02:42:12 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0652822/0.0889198/0.116912 |
27-Oct-2024 22:42:11 | 2024-10-28 02:42:12 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
27-Oct-2024 22:42:11 | 2024-10-28 02:42:12 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 2.44269/3.26616/4.3519 |
27-Oct-2024 22:42:11 | 2024-10-28 02:42:12 INFO BJonesPoly::selfSolveOne() Normalizing antenna-based solutions. |
27-Oct-2024 22:42:11 | 2024-10-28 02:42:12 INFO BJonesPoly::updateCalTable() Storing calibration in table bpoly |
27-Oct-2024 22:42:12 | 2024-10-28 02:42:12 INFO BJonesPoly::selfSolveOne() THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION |
27-Oct-2024 22:42:12 | 2024-10-28 02:42:12 INFO BJonesPoly::selfSolveOne() Fitting bandpass amplitude and phase polynomials. |
27-Oct-2024 22:42:12 | 2024-10-28 02:42:12 INFO BJonesPoly::selfSolveOne() Polynomial degree for amplitude is 5 |
27-Oct-2024 22:42:12 | 2024-10-28 02:42:12 INFO BJonesPoly::selfSolveOne() Polynomial degree for phase is 7 |
27-Oct-2024 22:42:12 | 2024-10-28 02:42:12 INFO BJonesPoly::selfSolveOne() Spectral grid for fit will have 63 points spaced by 24.4141 kHz. |
27-Oct-2024 22:42:12 | 2024-10-28 02:42:12 INFO BJonesPoly::selfSolveOne() Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz. |
27-Oct-2024 22:42:12 | 2024-10-28 02:42:12 INFO BJonesPoly::selfSolveOne() Total bandwidth: 1538.09 kHz. |
27-Oct-2024 22:42:12 | 2024-10-28 02:42:12 INFO BJonesPoly::selfSolveOne() Found data for 351 baselines among 27 antennas. |
27-Oct-2024 22:42:12 | 2024-10-28 02:42:12 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
27-Oct-2024 22:42:12 | 2024-10-28 02:42:12 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.350681/0.587724/0.894558 |
27-Oct-2024 22:42:12 | 2024-10-28 02:42:12 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
27-Oct-2024 22:42:14 | 2024-10-28 02:42:14 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 21.296/59.0077/111.454 |
27-Oct-2024 22:42:14 | 2024-10-28 02:42:14 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
27-Oct-2024 22:42:14 | 2024-10-28 02:42:14 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.354236/0.581733/0.988903 |
27-Oct-2024 22:42:14 | 2024-10-28 02:42:14 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
27-Oct-2024 22:42:16 | 2024-10-28 02:42:17 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 17.2419/56.3249/117.264 |
27-Oct-2024 22:42:16 | 2024-10-28 02:42:17 INFO BJonesPoly::selfSolveOne() Normalizing antenna-based solutions. |
27-Oct-2024 22:42:16 | 2024-10-28 02:42:17 INFO BJonesPoly::updateCalTable() Storing calibration in table bpoly |
27-Oct-2024 22:42:16 | 2024-10-28 02:42:17 INFO BJonesPoly::selfSolveOne() THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION |
27-Oct-2024 22:42:16 | 2024-10-28 02:42:17 INFO BJonesPoly::selfSolveOne() Fitting bandpass amplitude and phase polynomials. |
27-Oct-2024 22:42:16 | 2024-10-28 02:42:17 INFO BJonesPoly::selfSolveOne() Polynomial degree for amplitude is 5 |
27-Oct-2024 22:42:16 | 2024-10-28 02:42:17 INFO BJonesPoly::selfSolveOne() Polynomial degree for phase is 7 |
27-Oct-2024 22:42:16 | 2024-10-28 02:42:17 INFO BJonesPoly::selfSolveOne() Spectral grid for fit will have 63 points spaced by 24.4141 kHz. |
27-Oct-2024 22:42:16 | 2024-10-28 02:42:17 INFO BJonesPoly::selfSolveOne() Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz. |
27-Oct-2024 22:42:16 | 2024-10-28 02:42:17 INFO BJonesPoly::selfSolveOne() Total bandwidth: 1538.09 kHz. |
27-Oct-2024 22:42:16 | 2024-10-28 02:42:17 INFO BJonesPoly::selfSolveOne() Found data for 351 baselines among 27 antennas. |
27-Oct-2024 22:42:16 | 2024-10-28 02:42:17 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
27-Oct-2024 22:42:16 | 2024-10-28 02:42:17 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0850169/0.113968/0.15276 |
27-Oct-2024 22:42:16 | 2024-10-28 02:42:17 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:17 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 3.67561/5.33243/8.17296 |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:17 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:17 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0784236/0.114345/0.159908 |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:17 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:17 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 3.46392/5.27232/7.20673 |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:17 INFO BJonesPoly::selfSolveOne() Normalizing antenna-based solutions. |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:17 INFO BJonesPoly::updateCalTable() Storing calibration in table bpoly |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Fitting bandpass amplitude and phase polynomials. |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Polynomial degree for amplitude is 5 |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Polynomial degree for phase is 7 |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Spectral grid for fit will have 63 points spaced by 24.4141 kHz. |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz. |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Total bandwidth: 1538.09 kHz. |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Found data for 351 baselines among 27 antennas. |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0703936/0.102501/0.131676 |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 2.98728/4.47977/5.84264 |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0751114/0.102994/0.138529 |
27-Oct-2024 22:42:17 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
27-Oct-2024 22:42:18 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 3.18629/4.47068/5.8941 |
27-Oct-2024 22:42:18 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Normalizing antenna-based solutions. |
27-Oct-2024 22:42:18 | 2024-10-28 02:42:18 INFO BJonesPoly::updateCalTable() Storing calibration in table bpoly |
27-Oct-2024 22:42:18 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION |
27-Oct-2024 22:42:18 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Fitting bandpass amplitude and phase polynomials. |
27-Oct-2024 22:42:18 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Polynomial degree for amplitude is 5 |
27-Oct-2024 22:42:18 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Polynomial degree for phase is 7 |
27-Oct-2024 22:42:18 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Spectral grid for fit will have 63 points spaced by 24.4141 kHz. |
27-Oct-2024 22:42:18 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz. |
27-Oct-2024 22:42:18 | 2024-10-28 02:42:18 INFO BJonesPoly::selfSolveOne() Total bandwidth: 1538.09 kHz. |
27-Oct-2024 22:42:18 | 2024-10-28 02:42:19 INFO BJonesPoly::selfSolveOne() Found data for 351 baselines among 27 antennas. |
27-Oct-2024 22:42:18 | 2024-10-28 02:42:19 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
27-Oct-2024 22:42:18 | 2024-10-28 02:42:19 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.350626/0.604424/0.974388 |
27-Oct-2024 22:42:18 | 2024-10-28 02:42:19 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
27-Oct-2024 22:42:20 | 2024-10-28 02:42:21 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 21.2542/59.3511/120.719 |
27-Oct-2024 22:42:20 | 2024-10-28 02:42:21 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
27-Oct-2024 22:42:20 | 2024-10-28 02:42:21 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.382806/0.598119/0.941571 |
27-Oct-2024 22:42:20 | 2024-10-28 02:42:21 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
27-Oct-2024 22:42:22 | 2024-10-28 02:42:23 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 20.0637/57.2112/118.101 |
27-Oct-2024 22:42:22 | 2024-10-28 02:42:23 INFO BJonesPoly::selfSolveOne() Normalizing antenna-based solutions. |
27-Oct-2024 22:42:22 | 2024-10-28 02:42:23 INFO BJonesPoly::updateCalTable() Storing calibration in table bpoly |
27-Oct-2024 22:42:23 | 2024-10-28 02:42:23 INFO BJonesPoly::selfSolveOne() THIS IS THE NEW MULTI-SPW-FLEXIBLE VERSION |
27-Oct-2024 22:42:23 | 2024-10-28 02:42:23 INFO BJonesPoly::selfSolveOne() Fitting bandpass amplitude and phase polynomials. |
27-Oct-2024 22:42:23 | 2024-10-28 02:42:23 INFO BJonesPoly::selfSolveOne() Polynomial degree for amplitude is 5 |
27-Oct-2024 22:42:23 | 2024-10-28 02:42:23 INFO BJonesPoly::selfSolveOne() Polynomial degree for phase is 7 |
27-Oct-2024 22:42:23 | 2024-10-28 02:42:23 INFO BJonesPoly::selfSolveOne() Spectral grid for fit will have 63 points spaced by 24.4141 kHz. |
27-Oct-2024 22:42:23 | 2024-10-28 02:42:23 INFO BJonesPoly::selfSolveOne() Polynomial solution will be valid over frequency range: 1.41267e+09-1.41418e+09 Hz. |
27-Oct-2024 22:42:23 | 2024-10-28 02:42:23 INFO BJonesPoly::selfSolveOne() Total bandwidth: 1538.09 kHz. |
27-Oct-2024 22:42:23 | 2024-10-28 02:42:23 INFO BJonesPoly::selfSolveOne() Found data for 351 baselines among 27 antennas. |
27-Oct-2024 22:42:23 | 2024-10-28 02:42:23 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
27-Oct-2024 22:42:23 | 2024-10-28 02:42:23 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0750931/0.0978998/0.125897 |
27-Oct-2024 22:42:23 | 2024-10-28 02:42:23 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
27-Oct-2024 22:42:23 | 2024-10-28 02:42:23 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 2.72932/3.98787/5.33715 |
27-Oct-2024 22:42:23 | 2024-10-28 02:42:23 INFO BJonesPoly::selfSolveOne() Fitting amplitude polynomial. |
27-Oct-2024 22:42:23 | 2024-10-28 02:42:23 INFO BJonesPoly::selfSolveOne() Per-baseline RMS log(Amp) statistics: (min/mean/max) = 0.0658572/0.0972125/0.140794 |
27-Oct-2024 22:42:23 | 2024-10-28 02:42:23 INFO BJonesPoly::selfSolveOne() Fitting phase polynomial. |
27-Oct-2024 22:42:23 | 2024-10-28 02:42:24 INFO BJonesPoly::selfSolveOne() Per baseline RMS phase (deg) statistics: (min/mean/max) = 2.97943/3.97841/5.72903 |
27-Oct-2024 22:42:23 | 2024-10-28 02:42:24 INFO BJonesPoly::selfSolveOne() Normalizing antenna-based solutions. |
27-Oct-2024 22:42:23 | 2024-10-28 02:42:24 INFO BJonesPoly::updateCalTable() Storing calibration in table bpoly |
27-Oct-2024 22:42:23 | 2024-10-28 02:42:24 INFO Calibrater::solve Found good BPOLY solutions in 7 slots. |
27-Oct-2024 22:42:23 | 2024-10-28 02:42:24 INFO calibrater::solve Finished solving. |
27-Oct-2024 22:42:23 | 2024-10-28 02:42:24 WARN calibrater::setvi(bool,bool) Forcing use of NEW VisibilityIterator. |
27-Oct-2024 22:42:23 | test_tool_calibrater.py::calibrater_test::test_solveBandpass |
27-Oct-2024 22:42:23 | Check that solve band poly creates the output table |
27-Oct-2024 22:42:23 | PASSED |
27-Oct-2024 22:42:23 | |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:24 WARN calibrater::setvi(bool,bool) Forcing use of OLD VisibilityIterator. |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:24 INFO calibrater::open ****Using OLD VI-driven calibrater tool**** |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:24 INFO calibrater::open Opening MS: ngc5921.ms for calibration. |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:24 INFO Clearing all model records in MS header. |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:24 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:24 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO VisSetUtil::initScrCols Initialized 22653 rows. |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO calibrater::setsolvegainspline Beginning setsolvegainspline--(MSSelection version)------- |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO Calibrater::setsolvegainspline Arranging to SOLVE: |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO Calibrater::setsolvegainspline . GSPLINE: table=gainspline append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AMP solnorm=false |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO calibrater::solve Beginning solve----------------------------- |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO Calibrater::solve The following calibration terms are arranged for apply: |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO Calibrater::solve . (None) |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO Calibrater::solve The following calibration term is arranged for solve: |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO Calibrater::solve . GSPLINE: table=gainspline append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AMP solnorm=false |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO GJonesSpline::solve() Fitting time-dependent cubic splines. |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO GJonesSpline::solve() Solving for phase splines with splinetime= 10800 |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO GJonesSpline::solve() Solving for amplitude splines with splinetime= 10800 |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO GJonesSpline::solve() Accumulating data for: field= 1331+30500002_0, spw= 0, nchan= 63 |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO GJonesSpline::solve() Accumulating data for: field= 1445+09900002_0, spw= 0, nchan= 63 |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO GJonesSpline::solve() Accumulating data for: field= N5921_2, spw= 0, nchan= 63 |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO GJonesSpline::solve() Number of timestamps in data = 60 |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO GJonesSpline::getKnots() Gridded splinetime = 5280 sec. |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO GJonesSpline::solve() Number of cubic spline control points = 4 |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO GJonesSpline::solve() Number of cubic spline knots = 8 |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO GJonesSpline::solve() Number of cubic spline segments = 1 |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO GJonesSpline::solve() Fitting amplitude spline. |
27-Oct-2024 22:42:24 | test_tool_calibrater.py::calibrater_test::test_solveGainspline DPBTRF ;problem leading minor 23 |
27-Oct-2024 22:42:24 | DPBTRF ;problem leading minor 23 |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO GJonesSpline::solve() Searching for and correcting phase-wraps on each baseline. |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO GJonesSpline::solve() Fitting phase spline. |
27-Oct-2024 22:42:24 | DPBTRF ;problem leading minor 22 |
27-Oct-2024 22:42:24 | DPBTRF ;problem leading minor 22 |
27-Oct-2024 22:42:24 | 2024-10-28 02:42:25 INFO GJonesSpline::updateCalTable Storing solutions in table gainspline |
27-Oct-2024 22:42:25 | 2024-10-28 02:42:25 INFO calibrater::solve Finished solving. |
27-Oct-2024 22:42:25 | 2024-10-28 02:42:25 WARN calibrater::setvi(bool,bool) Forcing use of NEW VisibilityIterator. |
27-Oct-2024 22:42:25 | |
27-Oct-2024 22:42:25 | Check that solve gain spline creates the output table |
27-Oct-2024 22:42:25 | PASSED |
27-Oct-2024 22:42:25 | |
27-Oct-2024 22:42:25 | 2024-10-28 02:42:25 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
27-Oct-2024 22:42:25 | 2024-10-28 02:42:25 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:42:25 | 2024-10-28 02:42:25 INFO Clearing all model records in MS header. |
27-Oct-2024 22:42:25 | 2024-10-28 02:42:26 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:42:27 | 2024-10-28 02:42:27 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:42:27 | 2024-10-28 02:42:27 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
27-Oct-2024 22:42:27 | 2024-10-28 02:42:27 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:42:27 | 2024-10-28 02:42:27 INFO calibrater::specifycal Beginning specifycal----------------------- |
27-Oct-2024 22:42:27 | 2024-10-28 02:42:27 INFO Creating G Jones table from specified parameters. |
27-Oct-2024 22:42:27 | 2024-10-28 02:42:27 INFO Generating 'G' corrections. |
27-Oct-2024 22:42:27 | 2024-10-28 02:42:27 INFO Specified parameter(s) (per spw and pol) repeated on all antennas. |
27-Oct-2024 22:42:27 | 2024-10-28 02:42:27 INFO Specified parameter(s) (per spw and antenna) repeated on all polarizations. |
27-Oct-2024 22:42:27 | 2024-10-28 02:42:27 INFO spwId=1 antId=<all> polId=<all> parameter= 3 (ip0,ip1 = [0, 0, 0],[1, 0, 9]) |
27-Oct-2024 22:42:27 | 2024-10-28 02:42:27 INFO Writing solutions to table: testcalout.cal |
27-Oct-2024 22:42:28 | 2024-10-28 02:42:28 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
27-Oct-2024 22:42:28 | test_tool_calibrater.py::calibrater_test::test_specifyCal |
27-Oct-2024 22:42:28 | Check that specifycal can set values for specific spws and antennas |
27-Oct-2024 22:42:28 | PASSED |
27-Oct-2024 22:42:28 | |
27-Oct-2024 22:42:28 | 2024-10-28 02:42:29 WARN calibrater::setvi(bool,bool) Forcing use of OLD VisibilityIterator. |
27-Oct-2024 22:42:28 | 2024-10-28 02:42:29 INFO calibrater::open ****Using OLD VI-driven calibrater tool**** |
27-Oct-2024 22:42:28 | 2024-10-28 02:42:29 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:42:28 | 2024-10-28 02:42:29 INFO Clearing all model records in MS header. |
27-Oct-2024 22:42:28 | 2024-10-28 02:42:29 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:42:29 | 2024-10-28 02:42:30 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:42:30 | 2024-10-28 02:42:30 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
27-Oct-2024 22:42:30 | 2024-10-28 02:42:30 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:42:30 | 2024-10-28 02:42:30 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
27-Oct-2024 22:42:30 | 2024-10-28 02:42:30 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
27-Oct-2024 22:42:30 | 2024-10-28 02:42:31 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:42:30 | 2024-10-28 02:42:31 INFO calibrater::setsolve Beginning setsolve--(MSSelection version)------- |
27-Oct-2024 22:42:30 | 2024-10-28 02:42:31 INFO Calibrater::setsolve Arranging to SOLVE: |
27-Oct-2024 22:42:30 | 2024-10-28 02:42:31 INFO Calibrater::setsolve . Mf Mueller: table=output.ms append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false |
27-Oct-2024 22:42:30 | 2024-10-28 02:42:31 INFO Calibrater::state The following calibration terms are arranged for apply: |
27-Oct-2024 22:42:30 | 2024-10-28 02:42:31 INFO Calibrater::state . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:42:30 | 2024-10-28 02:42:31 INFO Calibrater::state The following calibration term is arranged for solve: |
27-Oct-2024 22:42:30 | 2024-10-28 02:42:31 INFO Calibrater::state . Mf Mueller: table=output.ms append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false |
27-Oct-2024 22:42:30 | 2024-10-28 02:42:31 INFO calibrater::solve Beginning solve----------------------------- |
27-Oct-2024 22:42:30 | 2024-10-28 02:42:31 INFO Calibrater::solve The following calibration terms are arranged for apply: |
27-Oct-2024 22:42:30 | 2024-10-28 02:42:31 INFO Calibrater::solve . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:42:30 | 2024-10-28 02:42:31 INFO Calibrater::solve The following calibration term is arranged for solve: |
27-Oct-2024 22:42:30 | 2024-10-28 02:42:31 INFO Calibrater::solve . Mf Mueller: table=output.ms append=false solint=inf,none refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false |
27-Oct-2024 22:42:30 | 2024-10-28 02:42:31 INFO Solving for Mf Mueller |
27-Oct-2024 22:42:30 | 2024-10-28 02:42:31 INFO For solint = inf, found 84 solution intervals. |
27-Oct-2024 22:42:32 | 2024-10-28 02:42:32 INFO Found good Mf Mueller solutions in 84 intervals. |
27-Oct-2024 22:42:32 | 2024-10-28 02:42:32 INFO Writing solutions to table: output.ms |
27-Oct-2024 22:42:33 | 2024-10-28 02:42:33 INFO calibrater::solve Finished solving. |
27-Oct-2024 22:42:33 | 2024-10-28 02:42:33 WARN calibrater::setvi(bool,bool) Forcing use of NEW VisibilityIterator. |
27-Oct-2024 22:42:33 | test_tool_calibrater.py::calibrater_test::test_standardPath |
27-Oct-2024 22:42:33 | open setapply setsolve state solve close |
27-Oct-2024 22:42:33 | PASSED |
27-Oct-2024 22:42:33 | |
27-Oct-2024 22:42:33 | 2024-10-28 02:42:34 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
27-Oct-2024 22:42:33 | 2024-10-28 02:42:34 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:42:33 | 2024-10-28 02:42:34 INFO Clearing all model records in MS header. |
27-Oct-2024 22:42:33 | 2024-10-28 02:42:34 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO name:: No table opened. |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO showcache:: The Table Cache has the following 16 entries: |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO showcache:: 0: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms" |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO showcache:: 1: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/ANTENNA" |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO showcache:: 2: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/DATA_DESCRIPTION" |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO showcache:: 3: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FEED" |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO showcache:: 4: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FIELD" |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO showcache:: 5: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/FLAG_CMD" |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO showcache:: 6: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/HISTORY" |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO showcache:: 7: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/OBSERVATION" |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO showcache:: 8: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/POINTING" |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO showcache:: 9: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/POLARIZATION" |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO showcache:: 10: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/PROCESSOR" |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO showcache:: 11: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SOURCE" |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO showcache:: 12: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SPECTRAL_WINDOW" |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO showcache:: 13: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/STATE" |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO showcache:: 14: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/SYSCAL" |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO showcache:: 15: "/home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/gaincaltest2.ms/WEATHER" |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO name:: No table opened. |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 INFO showcache:: The Table Cache is empty. |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:35 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
27-Oct-2024 22:42:35 | test_tool_calibrater.py::calibrater_test::test_takesMs |
27-Oct-2024 22:42:35 | Check that the calibrater tool can open and close an MS |
27-Oct-2024 22:42:35 | PASSED |
27-Oct-2024 22:42:35 | |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:36 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:36 INFO calibrater::open Opening MS: gaincaltest2.ms for calibration. |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:36 INFO Clearing all model records in MS header. |
27-Oct-2024 22:42:35 | 2024-10-28 02:42:36 INFO VisSetUtil::addScrCols Adding MODEL_DATA and CORRECTED_DATA column(s). |
27-Oct-2024 22:42:37 | 2024-10-28 02:42:37 INFO VisSetUtil::initScrCols Initializing MODEL_DATA to (unity). |
27-Oct-2024 22:42:37 | 2024-10-28 02:42:37 INFO VisSetUtil::initScrCols Initialized 328860 rows. |
27-Oct-2024 22:42:37 | 2024-10-28 02:42:37 INFO Calibrater:: Initializing nominal selection to the whole MS. |
27-Oct-2024 22:42:37 | 2024-10-28 02:42:37 INFO calibrater::setapply Beginning setapply--(MSSelection version)------- |
27-Oct-2024 22:42:37 | 2024-10-28 02:42:37 INFO Calibrater::setapply(type, applypar) Arranging to APPLY: |
27-Oct-2024 22:42:37 | 2024-10-28 02:42:37 INFO Calibrater::setapply(type, applypar) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:42:37 | 2024-10-28 02:42:37 INFO calibrater::correct Beginning correct--------------------------- |
27-Oct-2024 22:42:37 | 2024-10-28 02:42:37 INFO Calibrater::correct2 (VI2/VB2) The following calibration terms are arranged for apply: |
27-Oct-2024 22:42:37 | 2024-10-28 02:42:37 INFO Calibrater::correct2 (VI2/VB2) . G Jones: table=gaincaltest2.ms.G0 select= interp=linear spwmap=[-1] calWt=false |
27-Oct-2024 22:42:39 | 2024-10-28 02:42:40 INFO calibrater::correct Finished correcting. |
27-Oct-2024 22:42:39 | 2024-10-28 02:42:40 WARN calibrater::setvi(bool,bool) Already using NEW VisibilityIterator. |
27-Oct-2024 22:42:39 | test_tool_calibrater.py::calibrater_test::test_writeToCorrected |
27-Oct-2024 22:42:39 | Check that the tool writes to the CORRECTED_DATA column |
27-Oct-2024 22:42:39 | PASSED |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_calibrater/nose.xml - |
27-Oct-2024 22:42:39 | ================== 24 passed, 1 warning in 117.83s (0:01:57) =================== |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv/ |
27-Oct-2024 22:42:39 | Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_pv/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv/ |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_rebin/ |
27-Oct-2024 22:42:39 | Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_rebin |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_rebin/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_rebin/ |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_measures/ |
27-Oct-2024 22:42:39 | Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_measures |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_measures/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_measures/ |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_simulator/ |
27-Oct-2024 22:42:39 | Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_simulator |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_simulator/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_simulator/ |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calanalysis/ |
27-Oct-2024 22:42:39 | Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calanalysis |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_calanalysis/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_calanalysis/ |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_statistics/ |
27-Oct-2024 22:42:39 | Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_statistics |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_statistics/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_statistics/ |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_quanta/ |
27-Oct-2024 22:42:39 | Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_quanta |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_quanta/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_quanta/ |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_subimage/ |
27-Oct-2024 22:42:39 | Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_subimage |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_subimage/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_subimage/ |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager/ |
27-Oct-2024 22:42:39 | Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_vpmanager/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager/ |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_imagepol/ |
27-Oct-2024 22:42:39 | Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_imagepol |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_imagepol/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_imagepol/ |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msmetadata/ |
27-Oct-2024 22:42:39 | Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msmetadata |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_msmetadata/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_msmetadata/ |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msuvbinner/ |
27-Oct-2024 22:42:39 | Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msuvbinner |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_msuvbinner/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_msuvbinner/ |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_logsink/ |
27-Oct-2024 22:42:39 | Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_logsink |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_logsink/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_logsink/ |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms/ |
27-Oct-2024 22:42:39 | Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_ms/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_ms/ |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_regionmanager/ |
27-Oct-2024 22:42:39 | Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_regionmanager |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_regionmanager/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_regionmanager/ |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_coordsys/ |
27-Oct-2024 22:42:39 | Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_coordsys |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_coordsys/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_coordsys/ |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/ |
27-Oct-2024 22:42:39 | Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater |
27-Oct-2024 22:42:39 | |
27-Oct-2024 22:42:39 | Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_calibrater/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/ |
27-Oct-2024 22:42:41 | total 177324 |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci 15001 129287 Oct 28 02:17 casatestutils-6.7.0.0a100.dev0+dirty-py3-none-any.whl |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci 15001 181277126 Oct 28 02:17 casatools-6.7.0.0a100.dev0+dirty-cp38-cp38-manylinux_2_28_x86_64.whl |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 4320 Oct 28 02:42 test_tool_agentflagger.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 986 Oct 28 02:42 test_tool_calanalysis.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 2639 Oct 28 02:42 test_tool_calibrater.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 667 Oct 28 02:42 test_tool_componentlist.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 7447 Oct 28 02:42 test_tool_coordsys.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 12916 Oct 28 02:42 test_tool_image.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 2200 Oct 28 02:42 test_tool_image_collapse.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 1028 Oct 28 02:42 test_tool_image_deviation.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 2556 Oct 28 02:42 test_tool_image_fitprofile.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 1159 Oct 28 02:42 test_tool_image_pbcor.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 863 Oct 28 02:42 test_tool_image_pv.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 986 Oct 28 02:42 test_tool_image_rebin.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 1316 Oct 28 02:42 test_tool_image_regrid.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 1513 Oct 28 02:42 test_tool_image_statistics.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 745 Oct 28 02:42 test_tool_image_subimage.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 870 Oct 28 02:42 test_tool_image_transpose.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 1946 Oct 28 02:42 test_tool_imagepol.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 819 Oct 28 02:42 test_tool_linearmosaic.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 648 Oct 28 02:42 test_tool_logsink.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 529 Oct 28 02:42 test_tool_measures.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 5204 Oct 28 02:42 test_tool_ms.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 347 Oct 28 02:42 test_tool_ms_createmultims.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 2075 Oct 28 02:42 test_tool_ms_statwt.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 8492 Oct 28 02:42 test_tool_msmetadata.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 339 Oct 28 02:42 test_tool_msuvbinner.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 1151 Oct 28 02:42 test_tool_quanta.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 3957 Oct 28 02:42 test_tool_regionmanager.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 2053 Oct 28 02:42 test_tool_sdm.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 2080 Oct 28 02:42 test_tool_sdm_toms.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 428 Oct 28 02:42 test_tool_simulator.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 1442 Oct 28 02:42 test_tool_table.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 1697 Oct 28 02:42 test_tool_vpmanager.xml |
27-Oct-2024 22:42:41 | Finished task 'Test wheel' with result: Success |
27-Oct-2024 22:42:41 | Starting task 'Tar work directory' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script' |
27-Oct-2024 22:42:41 | Beginning to execute external process for build 'CASA - CMake CI Build - CAS-13671 - Test Tools Many Linux 2.28 #10 (CASA-CMAKECI197-TTOML228-10)' ... running command line: /export/home/cbt-el7-11/bamboohome/temp/CASA-CMAKECI197-TTOML228-10-ScriptBuildTask-2819442401320308891.sh ... in: /export/home/cbt-el7-11/bamboohome/xml-data/build-dir/CASA-CMAKECI197-TTOML228 |
27-Oct-2024 22:42:41 | Package working directory |
27-Oct-2024 22:42:41 | tar: work: Cannot stat: No such file or directory |
27-Oct-2024 22:42:41 | tar: Exiting with failure status due to previous errors |
27-Oct-2024 22:42:41 | total 177328 |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci 15001 129287 Oct 28 02:17 casatestutils-6.7.0.0a100.dev0+dirty-py3-none-any.whl |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci 15001 181277126 Oct 28 02:17 casatools-6.7.0.0a100.dev0+dirty-cp38-cp38-manylinux_2_28_x86_64.whl |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 4320 Oct 28 02:42 test_tool_agentflagger.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 986 Oct 28 02:42 test_tool_calanalysis.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 2639 Oct 28 02:42 test_tool_calibrater.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 667 Oct 28 02:42 test_tool_componentlist.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 7447 Oct 28 02:42 test_tool_coordsys.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 12916 Oct 28 02:42 test_tool_image.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 2200 Oct 28 02:42 test_tool_image_collapse.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 1028 Oct 28 02:42 test_tool_image_deviation.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 2556 Oct 28 02:42 test_tool_image_fitprofile.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 1159 Oct 28 02:42 test_tool_image_pbcor.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 863 Oct 28 02:42 test_tool_image_pv.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 986 Oct 28 02:42 test_tool_image_rebin.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 1316 Oct 28 02:42 test_tool_image_regrid.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 1513 Oct 28 02:42 test_tool_image_statistics.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 745 Oct 28 02:42 test_tool_image_subimage.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 870 Oct 28 02:42 test_tool_image_transpose.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 1946 Oct 28 02:42 test_tool_imagepol.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 819 Oct 28 02:42 test_tool_linearmosaic.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 648 Oct 28 02:42 test_tool_logsink.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 529 Oct 28 02:42 test_tool_measures.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 5204 Oct 28 02:42 test_tool_ms.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 347 Oct 28 02:42 test_tool_ms_createmultims.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 2075 Oct 28 02:42 test_tool_ms_statwt.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 8492 Oct 28 02:42 test_tool_msmetadata.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 339 Oct 28 02:42 test_tool_msuvbinner.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 1151 Oct 28 02:42 test_tool_quanta.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 3957 Oct 28 02:42 test_tool_regionmanager.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 2053 Oct 28 02:42 test_tool_sdm.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 2080 Oct 28 02:42 test_tool_sdm_toms.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 428 Oct 28 02:42 test_tool_simulator.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 1442 Oct 28 02:42 test_tool_table.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 1697 Oct 28 02:42 test_tool_vpmanager.xml |
27-Oct-2024 22:42:41 | -rw-r--r-- 1 casaci root 45 Oct 28 02:42 work-el7-3.8.tar.gz |
27-Oct-2024 22:42:41 | Done packaging working directory |
27-Oct-2024 22:42:41 | Finished task 'Tar work directory' with result: Success |
27-Oct-2024 22:42:41 | Starting task 'Parse tests' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit' |
27-Oct-2024 22:42:41 | Parsing test results under /export/home/cbt-el7-11/bamboohome/xml-data/build-dir/CASA-CMAKECI197-TTOML228... |
27-Oct-2024 22:42:41 | Finished task 'Parse tests' with result: Success |
27-Oct-2024 22:42:41 | Skipping execution of task 'Upload wheel' as it is disabled |
27-Oct-2024 22:42:41 | Starting task 'Cleanup' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script' |
27-Oct-2024 22:42:41 | Beginning to execute external process for build 'CASA - CMake CI Build - CAS-13671 - Test Tools Many Linux 2.28 #10 (CASA-CMAKECI197-TTOML228-10)' ... running command line: /export/home/cbt-el7-11/bamboohome/temp/CASA-CMAKECI197-TTOML228-10-ScriptBuildTask-2152576336159466653.sh ... in: /export/home/cbt-el7-11/bamboohome/xml-data/build-dir/CASA-CMAKECI197-TTOML228 |
27-Oct-2024 22:42:41 | Starting cleanup |
27-Oct-2024 22:42:54 | wheel-container-test |
27-Oct-2024 22:42:56 | wheel-container-test |
27-Oct-2024 22:42:56 | Cleanup complete |
27-Oct-2024 22:42:56 | Finished task 'Cleanup' with result: Success |
27-Oct-2024 22:42:56 | Running post build plugin 'Docker Container Cleanup' |
27-Oct-2024 22:42:56 | Beginning to execute external process for build 'CASA - CMake CI Build - CAS-13671 - Test Tools Many Linux 2.28 #10 (CASA-CMAKECI197-TTOML228-10)' ... running command line: /bin/docker rm -f wheel-container-test ... in: /export/home/cbt-el7-11/bamboohome/xml-data/build-dir/CASA-CMAKECI197-TTOML228 |
27-Oct-2024 22:42:56 | Error response from daemon: No such container: wheel-container-test |
27-Oct-2024 22:42:56 | Running post build plugin 'NCover Results Collector' |
27-Oct-2024 22:42:56 | Running post build plugin 'Build Results Label Collector' |
27-Oct-2024 22:42:56 | Running post build plugin 'Clover Results Collector' |
27-Oct-2024 22:42:56 | Running post build plugin 'npm Cache Cleanup' |
27-Oct-2024 22:42:56 | Running post build plugin 'Artifact Copier' |
27-Oct-2024 22:42:56 | Publishing an artifact: Workdir |
27-Oct-2024 22:42:56 | Finished publishing of artifact Non required job artifact Http Compression On : [Workdir], patterns: [work*.tar.gz] anchored at: [wheeldirectory/] in 84.34 ms |
27-Oct-2024 22:42:56 | Publishing an artifact: Tests |
27-Oct-2024 22:42:56 | Finished publishing of artifact Non required job artifact Http Compression On : [Tests], patterns: [*.xml] anchored at: [wheeldirectory/] in 224.3 ms |
27-Oct-2024 22:42:56 | Publishing an artifact: xml Directories |
27-Oct-2024 22:42:56 | Finished publishing of artifact Non required job artifact Http Compression On : [xml Directories], patterns: [**/*.xml] anchored at: [wheeldirectory/] in 214.1 ms |
27-Oct-2024 22:42:56 | Finalising the build... |
27-Oct-2024 22:42:56 | Stopping timer. |
27-Oct-2024 22:42:56 | Build CASA-CMAKECI197-TTOML228-10 completed. |
27-Oct-2024 22:42:57 | Running on server: post build plugin 'Build Hanging Detection Configuration' |
27-Oct-2024 22:42:57 | Running on server: post build plugin 'NCover Results Collector' |
27-Oct-2024 22:42:57 | Running on server: post build plugin 'Build Labeller' |
27-Oct-2024 22:42:57 | Running on server: post build plugin 'Clover Delta Calculator' |
27-Oct-2024 22:42:57 | Running on server: post build plugin 'Maven Dependencies Postprocessor' |
27-Oct-2024 22:42:57 | All post build plugins have finished |
27-Oct-2024 22:42:57 | Generating build results summary... |
27-Oct-2024 22:42:57 | Saving build results to disk... |
27-Oct-2024 22:42:57 | Store variable context... |
27-Oct-2024 22:42:57 | Finished building CASA-CMAKECI197-TTOML228-10. |