Build: #1 did not complete
Job: Test Casalith Many Linux 2014 did not complete
Build log
The build generated 917 lines of output. Download or view full build log.
25-Jul-2023 14:04:13 | Build CASA - Release Engineering Casa 6 Master Test - Test Casalith Many Linux 2014 #1 (CASA-REC6MT-TSGC2014PY38-1) started building on agent cbt-el7-2.cv.nrao.edu, bamboo version: 7.2.10 |
25-Jul-2023 14:04:13 | Remote agent on host cbt-el7-2.cv.nrao.edu |
25-Jul-2023 14:04:13 | Build working directory is /export/home/cbt-el7-2/bamboohome/xml-data/build-dir/CASA-REC6MT-TSGC2014PY38 |
25-Jul-2023 14:04:13 | Executing build CASA - Release Engineering Casa 6 Master Test - Test Casalith Many Linux 2014 #1 (CASA-REC6MT-TSGC2014PY38-1) |
25-Jul-2023 14:04:13 | Starting task 'Clean working directory task' of type 'com.atlassian.bamboo.plugins.bamboo-artifact-downloader-plugin:cleanWorkingDirectoryTask' |
25-Jul-2023 14:04:13 | Cleaning working directory '/export/home/cbt-el7-2/bamboohome/xml-data/build-dir/CASA-REC6MT-TSGC2014PY38' |
25-Jul-2023 14:04:13 | Finished task 'Clean working directory task' with result: Success |
25-Jul-2023 14:04:13 | Running pre-build action: VCS Version Collector |
25-Jul-2023 14:04:13 | Substituting variable: ${bamboo.planRepository.branchName} with master |
25-Jul-2023 14:04:13 | Starting task 'Check if this is a 6.4.1 ticket' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script' |
25-Jul-2023 14:04:13 | Beginning to execute external process for build 'CASA - Release Engineering Casa 6 Master Test - Test Casalith Many Linux 2014 #1 (CASA-REC6MT-TSGC2014PY38-1)' ... running command line: /export/home/cbt-el7-2/bamboohome/temp/CASA-REC6MT-TSGC2014PY38-1-ScriptBuildTask-2215612767604045524.sh ... in: /export/home/cbt-el7-2/bamboohome/xml-data/build-dir/CASA-REC6MT-TSGC2014PY38 |
25-Jul-2023 14:04:13 | % Total % Received % Xferd Average Speed Time Time Time Current |
25-Jul-2023 14:04:13 | Dload Upload Total Spent Left Speed |
25-Jul-2023 14:04:13 | |
25-Jul-2023 14:04:13 | 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 |
25-Jul-2023 14:04:13 | 100 6002k 100 6002k 0 0 19.0M 0 --:--:-- --:--:-- --:--:-- 19.2M |
25-Jul-2023 14:04:14 | [25370] Failed to execute script 'atlutil' due to unhandled exception! |
25-Jul-2023 14:04:14 | Traceback (most recent call last): |
25-Jul-2023 14:04:14 | File "atlutil.py", line 200, in <module> |
25-Jul-2023 14:04:14 | File "atlutil.py", line 165, in has_fix_version |
25-Jul-2023 14:04:14 | KeyError: 'fields' |
25-Jul-2023 14:04:14 | Finished task 'Check if this is a 6.4.1 ticket' with result: Success |
25-Jul-2023 14:04:14 | Starting task 'Inject is_641' of type 'com.atlassian.bamboo.plugins.bamboo-variable-inject-plugin:inject' |
25-Jul-2023 14:04:14 | Injected variable bamboo.inject.is_641=False in LOCAL scope |
25-Jul-2023 14:04:14 | Finished task 'Inject is_641' with result: Success |
25-Jul-2023 14:04:14 | Starting task 'Download casalith' of type 'com.atlassian.bamboo.plugins.bamboo-artifact-downloader-plugin:artifactdownloadertask' |
25-Jul-2023 14:04:14 | Preparing to download plan result CASA-CMBC-22 artifact: Non required shared artifact: [Sys GRPC ManyLinux2014 Python 3.8 Tar 2], pattern: [*.xz] anchored at: [source/wheels] |
25-Jul-2023 14:05:01 | Artifact [Sys GRPC ManyLinux2014 Python 3.8 Tar 2] downloaded successfully in 47.47 s to dockershare/ |
25-Jul-2023 14:05:01 | Finished task 'Download casalith' with result: Success |
25-Jul-2023 14:05:01 | Substituting variable: ${bamboo.working.directory} with /export/home/cbt-el7-2/bamboohome/xml-data/build-dir/CASA-REC6MT-TSGC2014PY38 |
25-Jul-2023 14:05:01 | Starting task 'Docker' of type 'com.atlassian.bamboo.plugins.bamboo-docker-plugin:task.docker.cli' |
25-Jul-2023 14:05:01 | Running image name (casa-docker.nrao.edu:5000/casa-test-casalith:1) |
25-Jul-2023 14:05:01 | Beginning to execute external process for build 'CASA - Release Engineering Casa 6 Master Test - Test Casalith Many Linux 2014 #1 (CASA-REC6MT-TSGC2014PY38-1)' ... running command line: /bin/docker run --volume /opt/casa/data/:/opt/casa/data --volume /export/home/cbt-el7-2/bamboohome/xml-data/build-dir/CASA-REC6MT-TSGC2014PY38/dockershare:/dockershare --detach --privileged --name test-container casa-docker.nrao.edu:5000/casa-test-casalith:1 tail -f /dev/null ... in: /export/home/cbt-el7-2/bamboohome/xml-data/build-dir/CASA-REC6MT-TSGC2014PY38 |
25-Jul-2023 14:05:03 | fe7a047382e7406af3ee0ebc4a2d28211c47ee49dc3d0672a8029f3c38917dd1 |
25-Jul-2023 14:05:03 | Finished task 'Docker' with result: Success |
25-Jul-2023 14:05:03 | Substituting variable: ${bamboo.planRepository.branchName} with master |
25-Jul-2023 14:05:03 | Starting task 'Run plotms, imview, msview, wvrgcal, casampi tests' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script' |
25-Jul-2023 14:05:03 | Beginning to execute external process for build 'CASA - Release Engineering Casa 6 Master Test - Test Casalith Many Linux 2014 #1 (CASA-REC6MT-TSGC2014PY38-1)' ... running command line: /export/home/cbt-el7-2/bamboohome/temp/CASA-REC6MT-TSGC2014PY38-1-ScriptBuildTask-2101132708556825693.sh ... in: /export/home/cbt-el7-2/bamboohome/xml-data/build-dir/CASA-REC6MT-TSGC2014PY38 |
25-Jul-2023 14:05:03 | branch: master |
25-Jul-2023 14:05:03 | /export/home/cbt-el7-2/bamboohome/xml-data/build-dir/CASA-REC6MT-TSGC2014PY38 |
25-Jul-2023 14:05:03 | % Total % Received % Xferd Average Speed Time Time Time Current |
25-Jul-2023 14:05:03 | Dload Upload Total Spent Left Speed |
25-Jul-2023 14:05:03 | |
25-Jul-2023 14:05:03 | 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 |
25-Jul-2023 14:05:03 | 100 6002k 100 6002k 0 0 17.5M 0 --:--:-- --:--:-- --:--:-- 17.8M |
25-Jul-2023 14:05:03 | bamboo_jira_components:'' |
25-Jul-2023 14:05:03 | bamboo_testlist:'' |
25-Jul-2023 14:05:03 | Ticket components: |
25-Jul-2023 14:05:03 | Components: |
25-Jul-2023 14:05:03 | Test list: -l "test_task_wvrgcal,test_casampi,test_task_msview,test_task_imview,test_task_plotms" |
25-Jul-2023 14:05:03 | pmode: both |
25-Jul-2023 14:05:03 | datapath=[ "/opt/casa/data/master","/opt/casa/data/casatestdata"] |
25-Jul-2023 14:05:04 | total 1187712 |
25-Jul-2023 14:05:04 | -rw-r--r-- 1 9285 15001 1216211576 Jul 25 18:05 casa-6.6.0-3-py3.8.el7.tar.xz |
25-Jul-2023 14:05:04 | datapath=[ "/opt/casa/data/master","/opt/casa/data/casatestdata"] |
25-Jul-2023 14:05:04 | Cloning into 'casa6'... |
25-Jul-2023 14:05:19 | Checking out files: 22% (2077/9200) |
25-Jul-2023 14:05:19 | Checking out files: 23% (2116/9200) |
25-Jul-2023 14:05:19 | Checking out files: 24% (2208/9200) |
25-Jul-2023 14:05:19 | Checking out files: 25% (2300/9200) |
25-Jul-2023 14:05:19 | Checking out files: 26% (2392/9200) |
25-Jul-2023 14:05:20 | Checking out files: 27% (2484/9200) |
25-Jul-2023 14:05:20 | Checking out files: 28% (2576/9200) |
25-Jul-2023 14:05:20 | Checking out files: 29% (2668/9200) |
25-Jul-2023 14:05:20 | Checking out files: 30% (2760/9200) |
25-Jul-2023 14:05:20 | Checking out files: 31% (2852/9200) |
25-Jul-2023 14:05:20 | Checking out files: 32% (2944/9200) |
25-Jul-2023 14:05:20 | Checking out files: 33% (3036/9200) |
25-Jul-2023 14:05:20 | Checking out files: 34% (3128/9200) |
25-Jul-2023 14:05:20 | Checking out files: 35% (3220/9200) |
25-Jul-2023 14:05:20 | Checking out files: 36% (3312/9200) |
25-Jul-2023 14:05:20 | Checking out files: 37% (3404/9200) |
25-Jul-2023 14:05:20 | Checking out files: 38% (3496/9200) |
25-Jul-2023 14:05:20 | Checking out files: 39% (3588/9200) |
25-Jul-2023 14:05:20 | Checking out files: 40% (3680/9200) |
25-Jul-2023 14:05:20 | Checking out files: 41% (3772/9200) |
25-Jul-2023 14:05:20 | Checking out files: 42% (3864/9200) |
25-Jul-2023 14:05:20 | Checking out files: 43% (3956/9200) |
25-Jul-2023 14:05:20 | Checking out files: 44% (4048/9200) |
25-Jul-2023 14:05:20 | Checking out files: 44% (4125/9200) |
25-Jul-2023 14:05:20 | Checking out files: 45% (4140/9200) |
25-Jul-2023 14:05:20 | Checking out files: 46% (4232/9200) |
25-Jul-2023 14:05:20 | Checking out files: 47% (4324/9200) |
25-Jul-2023 14:05:21 | Checking out files: 48% (4416/9200) |
25-Jul-2023 14:05:21 | Checking out files: 49% (4508/9200) |
25-Jul-2023 14:05:21 | Checking out files: 50% (4600/9200) |
25-Jul-2023 14:05:21 | Checking out files: 51% (4692/9200) |
25-Jul-2023 14:05:21 | Checking out files: 52% (4784/9200) |
25-Jul-2023 14:05:21 | Checking out files: 53% (4876/9200) |
25-Jul-2023 14:05:21 | Checking out files: 54% (4968/9200) |
25-Jul-2023 14:05:21 | Checking out files: 55% (5060/9200) |
25-Jul-2023 14:05:21 | Checking out files: 56% (5152/9200) |
25-Jul-2023 14:05:21 | Checking out files: 57% (5244/9200) |
25-Jul-2023 14:05:21 | Checking out files: 58% (5336/9200) |
25-Jul-2023 14:05:21 | Checking out files: 59% (5428/9200) |
25-Jul-2023 14:05:21 | Checking out files: 60% (5520/9200) |
25-Jul-2023 14:05:21 | Checking out files: 61% (5612/9200) |
25-Jul-2023 14:05:21 | Checking out files: 62% (5704/9200) |
25-Jul-2023 14:05:21 | Checking out files: 63% (5796/9200) |
25-Jul-2023 14:05:21 | Checking out files: 64% (5888/9200) |
25-Jul-2023 14:05:21 | Checking out files: 65% (5980/9200) |
25-Jul-2023 14:05:21 | Checking out files: 66% (6072/9200) |
25-Jul-2023 14:05:21 | Checking out files: 66% (6089/9200) |
25-Jul-2023 14:05:21 | Checking out files: 67% (6164/9200) |
25-Jul-2023 14:05:21 | Checking out files: 68% (6256/9200) |
25-Jul-2023 14:05:22 | Checking out files: 69% (6348/9200) |
25-Jul-2023 14:05:22 | Checking out files: 70% (6440/9200) |
25-Jul-2023 14:05:22 | Checking out files: 71% (6532/9200) |
25-Jul-2023 14:05:22 | Checking out files: 72% (6624/9200) |
25-Jul-2023 14:05:22 | Checking out files: 73% (6716/9200) |
25-Jul-2023 14:05:22 | Checking out files: 74% (6808/9200) |
25-Jul-2023 14:05:22 | Checking out files: 75% (6900/9200) |
25-Jul-2023 14:05:22 | Checking out files: 76% (6992/9200) |
25-Jul-2023 14:05:22 | Checking out files: 77% (7084/9200) |
25-Jul-2023 14:05:22 | Checking out files: 78% (7176/9200) |
25-Jul-2023 14:05:22 | Checking out files: 79% (7268/9200) |
25-Jul-2023 14:05:22 | Checking out files: 80% (7360/9200) |
25-Jul-2023 14:05:22 | Checking out files: 81% (7452/9200) |
25-Jul-2023 14:05:22 | Checking out files: 82% (7544/9200) |
25-Jul-2023 14:05:22 | Checking out files: 83% (7636/9200) |
25-Jul-2023 14:05:22 | Checking out files: 84% (7728/9200) |
25-Jul-2023 14:05:22 | Checking out files: 85% (7820/9200) |
25-Jul-2023 14:05:22 | Checking out files: 86% (7912/9200) |
25-Jul-2023 14:05:22 | Checking out files: 86% (7936/9200) |
25-Jul-2023 14:05:22 | Checking out files: 87% (8004/9200) |
25-Jul-2023 14:05:22 | Checking out files: 88% (8096/9200) |
25-Jul-2023 14:05:22 | Checking out files: 89% (8188/9200) |
25-Jul-2023 14:05:23 | Checking out files: 90% (8280/9200) |
25-Jul-2023 14:05:23 | Checking out files: 91% (8372/9200) |
25-Jul-2023 14:05:23 | Checking out files: 92% (8464/9200) |
25-Jul-2023 14:05:23 | Checking out files: 93% (8556/9200) |
25-Jul-2023 14:05:23 | Checking out files: 94% (8648/9200) |
25-Jul-2023 14:05:23 | Checking out files: 95% (8740/9200) |
25-Jul-2023 14:05:23 | Checking out files: 96% (8832/9200) |
25-Jul-2023 14:05:23 | Checking out files: 97% (8924/9200) |
25-Jul-2023 14:05:23 | Checking out files: 98% (9016/9200) |
25-Jul-2023 14:05:23 | Checking out files: 99% (9108/9200) |
25-Jul-2023 14:05:23 | Checking out files: 100% (9200/9200) |
25-Jul-2023 14:05:23 | Checking out files: 100% (9200/9200), done. |
25-Jul-2023 14:05:24 | Already on 'master' |
25-Jul-2023 14:07:03 | HAVE_COVTEST: False |
25-Jul-2023 14:07:03 | HAVE_PYTEST: False |
25-Jul-2023 14:07:03 | |
25-Jul-2023 14:07:03 | Namespace(bamboo=True, branch='master', classes=None, dry_run=False, file=None, ignore_list=None, list=False, mapfile=None, ncores='4', pkg='/dockershare/casa-6.6.0-3-py3.8.el7.tar.xz', pmode='both', rcdir=None, test_config='/home/casatest/casa6/casatestutils/casatestutils/component_to_test_map.json', test_group=None, test_list='test_task_wvrgcal,test_casampi,test_task_msview,test_task_imview,test_task_plotms', test_paths=None, verbose=False, work_dir='/home/casatest/work') |
25-Jul-2023 14:07:03 | |
25-Jul-2023 14:07:03 | Operating system: Linux |
25-Jul-2023 14:07:03 | |
25-Jul-2023 14:07:03 | rcdir: |
25-Jul-2023 14:07:03 | Arguments Sent Direct To Pytest : [] |
25-Jul-2023 14:07:03 | Package: /dockershare/casa-6.6.0-3-py3.8.el7.tar.xz |
25-Jul-2023 14:07:03 | Test configuration file: /home/casatest/casa6/casatestutils/casatestutils/component_to_test_map.json |
25-Jul-2023 14:07:03 | Number of cores: 4 |
25-Jul-2023 14:07:03 | Workdir: /home/casatest/work |
25-Jul-2023 14:07:03 | branch: master |
25-Jul-2023 14:07:03 | run_bamboo |
25-Jul-2023 14:07:03 | Test list: ['test_task_wvrgcal', 'test_casampi', 'test_task_msview', 'test_task_imview', 'test_task_plotms'] |
25-Jul-2023 14:07:03 | Test group: None |
25-Jul-2023 14:07:03 | Unpacking tarball: /dockershare/casa-6.6.0-3-py3.8.el7.tar.xz to /home/casatest/work/pkg |
25-Jul-2023 14:07:03 | ['tar', '-xf', '/dockershare/casa-6.6.0-3-py3.8.el7.tar.xz', '-C', '/home/casatest/work/pkg'] |
25-Jul-2023 14:07:03 | Executing: ['tar', '-xf', '/dockershare/casa-6.6.0-3-py3.8.el7.tar.xz', '-C', '/home/casatest/work/pkg'] |
25-Jul-2023 14:07:03 | Executor result: 0 |
25-Jul-2023 14:07:03 | Failed tests:[] |
25-Jul-2023 14:07:03 | outputdir contents:/home/casatest/work/pkg |
25-Jul-2023 14:07:03 | casa-6.6.0-3-py3.8.el7 |
25-Jul-2023 14:07:03 | installpath: casa-6.6.0-3-py3.8.el7 |
25-Jul-2023 14:07:03 | Package root: /home/casatest/work/pkg/casa-6.6.0-3-py3.8.el7 |
25-Jul-2023 14:07:03 | Executable path: /home/casatest/work/pkg/casa-6.6.0-3-py3.8.el7/bin |
25-Jul-2023 14:07:03 | casatestutils path: /home/casatest/work/pkg/casa-6.6.0-3-py3.8.el7/lib/py/lib/python3.8/site-packages/casatestutils/runtest.py |
25-Jul-2023 14:07:03 | Starting Xvfb |
25-Jul-2023 14:07:03 | Xvfb :78 -screen 0 2048x2048x24+32 -auth /tmp/CASA_testrunner_xauth_c4tm62j/tmppwyg1nja |
25-Jul-2023 14:07:03 | Deployed virtual frame buffer at port :78 with PID 86 |
25-Jul-2023 14:07:03 | run_bamboo fetch_tests branchmaster |
25-Jul-2023 14:07:03 | Running: git clone https://open-bitbucket.nrao.edu/scm/casa/casa6 |
25-Jul-2023 14:07:03 | Executing: ['git', 'clone', 'https://open-bitbucket.nrao.edu/scm/casa/casa6'] |
25-Jul-2023 14:07:03 | Cloning into 'casa6'... |
25-Jul-2023 14:07:03 | Checking out files: 22% (2107/9200) |
25-Jul-2023 14:07:03 | Checking out files: 23% (2116/9200) |
25-Jul-2023 14:07:03 | Checking out files: 24% (2208/9200) |
25-Jul-2023 14:07:03 | Checking out files: 25% (2300/9200) |
25-Jul-2023 14:07:03 | Checking out files: 26% (2392/9200) |
25-Jul-2023 14:07:03 | Checking out files: 27% (2484/9200) |
25-Jul-2023 14:07:03 | Checking out files: 28% (2576/9200) |
25-Jul-2023 14:07:03 | Checking out files: 29% (2668/9200) |
25-Jul-2023 14:07:03 | Checking out files: 30% (2760/9200) |
25-Jul-2023 14:07:03 | Checking out files: 31% (2852/9200) |
25-Jul-2023 14:07:03 | Checking out files: 32% (2944/9200) |
25-Jul-2023 14:07:03 | Checking out files: 33% (3036/9200) |
25-Jul-2023 14:07:03 | Checking out files: 34% (3128/9200) |
25-Jul-2023 14:07:03 | Checking out files: 35% (3220/9200) |
25-Jul-2023 14:07:03 | Checking out files: 36% (3312/9200) |
25-Jul-2023 14:07:03 | Checking out files: 37% (3404/9200) |
25-Jul-2023 14:07:03 | Checking out files: 38% (3496/9200) |
25-Jul-2023 14:07:03 | Checking out files: 39% (3588/9200) |
25-Jul-2023 14:07:03 | Checking out files: 40% (3680/9200) |
25-Jul-2023 14:07:03 | Checking out files: 41% (3772/9200) |
25-Jul-2023 14:07:03 | Checking out files: 42% (3864/9200) |
25-Jul-2023 14:07:03 | Checking out files: 42% (3897/9200) |
25-Jul-2023 14:07:03 | Checking out files: 43% (3956/9200) |
25-Jul-2023 14:07:03 | Checking out files: 44% (4048/9200) |
25-Jul-2023 14:07:03 | Checking out files: 45% (4140/9200) |
25-Jul-2023 14:07:03 | Checking out files: 46% (4232/9200) |
25-Jul-2023 14:07:03 | Checking out files: 47% (4324/9200) |
25-Jul-2023 14:07:03 | Checking out files: 48% (4416/9200) |
25-Jul-2023 14:07:03 | Checking out files: 49% (4508/9200) |
25-Jul-2023 14:07:03 | Checking out files: 50% (4600/9200) |
25-Jul-2023 14:07:03 | Checking out files: 51% (4692/9200) |
25-Jul-2023 14:07:03 | Checking out files: 52% (4784/9200) |
25-Jul-2023 14:07:03 | Checking out files: 53% (4876/9200) |
25-Jul-2023 14:07:03 | Checking out files: 54% (4968/9200) |
25-Jul-2023 14:07:03 | Checking out files: 55% (5060/9200) |
25-Jul-2023 14:07:03 | Checking out files: 56% (5152/9200) |
25-Jul-2023 14:07:03 | Checking out files: 57% (5244/9200) |
25-Jul-2023 14:07:03 | Checking out files: 58% (5336/9200) |
25-Jul-2023 14:07:03 | Checking out files: 59% (5428/9200) |
25-Jul-2023 14:07:03 | Checking out files: 60% (5520/9200) |
25-Jul-2023 14:07:03 | Checking out files: 61% (5612/9200) |
25-Jul-2023 14:07:03 | Checking out files: 61% (5618/9200) |
25-Jul-2023 14:07:03 | Checking out files: 62% (5704/9200) |
25-Jul-2023 14:07:03 | Checking out files: 63% (5796/9200) |
25-Jul-2023 14:07:03 | Checking out files: 64% (5888/9200) |
25-Jul-2023 14:07:03 | Checking out files: 65% (5980/9200) |
25-Jul-2023 14:07:03 | Checking out files: 66% (6072/9200) |
25-Jul-2023 14:07:03 | Checking out files: 67% (6164/9200) |
25-Jul-2023 14:07:03 | Checking out files: 68% (6256/9200) |
25-Jul-2023 14:07:03 | Checking out files: 69% (6348/9200) |
25-Jul-2023 14:07:03 | Checking out files: 70% (6440/9200) |
25-Jul-2023 14:07:03 | Checking out files: 71% (6532/9200) |
25-Jul-2023 14:07:03 | Checking out files: 72% (6624/9200) |
25-Jul-2023 14:07:03 | Checking out files: 73% (6716/9200) |
25-Jul-2023 14:07:03 | Checking out files: 74% (6808/9200) |
25-Jul-2023 14:07:03 | Checking out files: 75% (6900/9200) |
25-Jul-2023 14:07:03 | Checking out files: 76% (6992/9200) |
25-Jul-2023 14:07:03 | Checking out files: 77% (7084/9200) |
25-Jul-2023 14:07:03 | Checking out files: 78% (7176/9200) |
25-Jul-2023 14:07:03 | Checking out files: 79% (7268/9200) |
25-Jul-2023 14:07:03 | Checking out files: 80% (7360/9200) |
25-Jul-2023 14:07:03 | Checking out files: 81% (7452/9200) |
25-Jul-2023 14:07:03 | Checking out files: 81% (7467/9200) |
25-Jul-2023 14:07:03 | Checking out files: 82% (7544/9200) |
25-Jul-2023 14:07:03 | Checking out files: 83% (7636/9200) |
25-Jul-2023 14:07:03 | Checking out files: 84% (7728/9200) |
25-Jul-2023 14:07:03 | Checking out files: 85% (7820/9200) |
25-Jul-2023 14:07:03 | Checking out files: 86% (7912/9200) |
25-Jul-2023 14:07:03 | Checking out files: 87% (8004/9200) |
25-Jul-2023 14:07:03 | Checking out files: 88% (8096/9200) |
25-Jul-2023 14:07:03 | Checking out files: 89% (8188/9200) |
25-Jul-2023 14:07:03 | Checking out files: 90% (8280/9200) |
25-Jul-2023 14:07:03 | Checking out files: 91% (8372/9200) |
25-Jul-2023 14:07:03 | Checking out files: 92% (8464/9200) |
25-Jul-2023 14:07:03 | Checking out files: 93% (8556/9200) |
25-Jul-2023 14:07:03 | Checking out files: 94% (8648/9200) |
25-Jul-2023 14:07:03 | Checking out files: 95% (8740/9200) |
25-Jul-2023 14:07:03 | Checking out files: 96% (8832/9200) |
25-Jul-2023 14:07:03 | Checking out files: 96% (8898/9200) |
25-Jul-2023 14:07:03 | Checking out files: 97% (8924/9200) |
25-Jul-2023 14:07:03 | Checking out files: 98% (9016/9200) |
25-Jul-2023 14:07:03 | Checking out files: 99% (9108/9200) |
25-Jul-2023 14:07:03 | Checking out files: 100% (9200/9200) |
25-Jul-2023 14:07:03 | Checking out files: 100% (9200/9200), done. |
25-Jul-2023 14:07:03 | Executor result: 0 |
25-Jul-2023 14:07:03 | Failed tests:[] |
25-Jul-2023 14:07:03 | ['git', 'checkout', 'master'] |
25-Jul-2023 14:07:03 | Executing: ['git', 'checkout', 'master'] |
25-Jul-2023 14:07:03 | Already on 'master' |
25-Jul-2023 14:07:03 | Executor result: 0 |
25-Jul-2023 14:07:03 | Failed tests:[] |
25-Jul-2023 14:07:03 | Running: git clone https://open-bitbucket.nrao.edu/scm/casa/casampi |
25-Jul-2023 14:07:03 | Executing: ['git', 'clone', 'https://open-bitbucket.nrao.edu/scm/casa/casampi'] |
25-Jul-2023 14:07:03 | Cloning into 'casampi'... |
25-Jul-2023 14:07:03 | Executor result: 0 |
25-Jul-2023 14:07:03 | Failed tests:[] |
25-Jul-2023 14:07:03 | ['git', 'checkout', 'tags/0.5.3'] |
25-Jul-2023 14:07:03 | Executing: ['git', 'checkout', 'tags/0.5.3'] |
25-Jul-2023 14:07:03 | Note: checking out 'tags/0.5.3'. |
25-Jul-2023 14:07:03 | |
25-Jul-2023 14:07:03 | You are in 'detached HEAD' state. You can look around, make experimental |
25-Jul-2023 14:07:03 | changes and commit them, and you can discard any commits you make in this |
25-Jul-2023 14:07:03 | state without impacting any branches by performing another checkout. |
25-Jul-2023 14:07:03 | |
25-Jul-2023 14:07:03 | If you want to create a new branch to retain commits you create, you may |
25-Jul-2023 14:07:03 | do so (now or later) by using -b with the checkout command again. Example: |
25-Jul-2023 14:07:03 | |
25-Jul-2023 14:07:03 | git checkout -b new_branch_name |
25-Jul-2023 14:07:03 | |
25-Jul-2023 14:07:03 | HEAD is now at ee2b0e4... Pull request #12: CAS-14034 |
25-Jul-2023 14:07:03 | Executor result: 0 |
25-Jul-2023 14:07:03 | Failed tests:[] |
25-Jul-2023 14:07:03 | Running: git clone https://open-bitbucket.nrao.edu/scm/casa/casaplotms |
25-Jul-2023 14:07:03 | Executing: ['git', 'clone', 'https://open-bitbucket.nrao.edu/scm/casa/casaplotms'] |
25-Jul-2023 14:07:03 | Cloning into 'casaplotms'... |
25-Jul-2023 14:07:03 | Executor result: 0 |
25-Jul-2023 14:07:03 | Failed tests:[] |
25-Jul-2023 14:07:03 | ['git', 'checkout', 'tags/2.2.1'] |
25-Jul-2023 14:07:03 | Executing: ['git', 'checkout', 'tags/2.2.1'] |
25-Jul-2023 14:07:03 | Note: checking out 'tags/2.2.1'. |
25-Jul-2023 14:07:03 | |
25-Jul-2023 14:07:03 | You are in 'detached HEAD' state. You can look around, make experimental |
25-Jul-2023 14:07:03 | changes and commit them, and you can discard any commits you make in this |
25-Jul-2023 14:07:03 | state without impacting any branches by performing another checkout. |
25-Jul-2023 14:07:03 | |
25-Jul-2023 14:07:03 | If you want to create a new branch to retain commits you create, you may |
25-Jul-2023 14:07:03 | do so (now or later) by using -b with the checkout command again. Example: |
25-Jul-2023 14:07:03 | |
25-Jul-2023 14:07:03 | git checkout -b new_branch_name |
25-Jul-2023 14:07:03 | |
25-Jul-2023 14:07:03 | HEAD is now at f1f48de... Pull request #72: CAS-7164 |
25-Jul-2023 14:07:03 | Executor result: 0 |
25-Jul-2023 14:07:03 | Failed tests:[] |
25-Jul-2023 14:07:03 | Running: git clone https://open-bitbucket.nrao.edu/scm/casa/almatasks |
25-Jul-2023 14:07:03 | Executing: ['git', 'clone', 'https://open-bitbucket.nrao.edu/scm/casa/almatasks'] |
25-Jul-2023 14:07:03 | Cloning into 'almatasks'... |
25-Jul-2023 14:07:03 | Executor result: 0 |
25-Jul-2023 14:07:03 | Failed tests:[] |
25-Jul-2023 14:07:03 | ['git', 'checkout', 'tags/1.7.1'] |
25-Jul-2023 14:07:03 | Executing: ['git', 'checkout', 'tags/1.7.1'] |
25-Jul-2023 14:07:03 | Note: checking out 'tags/1.7.1'. |
25-Jul-2023 14:07:03 | |
25-Jul-2023 14:07:03 | You are in 'detached HEAD' state. You can look around, make experimental |
25-Jul-2023 14:07:03 | changes and commit them, and you can discard any commits you make in this |
25-Jul-2023 14:07:03 | state without impacting any branches by performing another checkout. |
25-Jul-2023 14:07:03 | |
25-Jul-2023 14:07:03 | If you want to create a new branch to retain commits you create, you may |
25-Jul-2023 14:07:03 | do so (now or later) by using -b with the checkout command again. Example: |
25-Jul-2023 14:07:03 | |
25-Jul-2023 14:07:03 | git checkout -b new_branch_name |
25-Jul-2023 14:07:03 | |
25-Jul-2023 14:07:03 | HEAD is now at 6c66833... Pull request #12: CAS-14608 |
25-Jul-2023 14:07:03 | Executor result: 0 |
25-Jul-2023 14:07:03 | Failed tests:[] |
25-Jul-2023 14:07:03 | Running: git clone https://open-bitbucket.nrao.edu/scm/casa/casaviewer |
25-Jul-2023 14:07:03 | Executing: ['git', 'clone', 'https://open-bitbucket.nrao.edu/scm/casa/casaviewer'] |
25-Jul-2023 14:07:03 | Cloning into 'casaviewer'... |
25-Jul-2023 14:07:03 | Executor result: 0 |
25-Jul-2023 14:07:03 | Failed tests:[] |
25-Jul-2023 14:07:32 | ['git', 'checkout', 'tags/1.8.2'] |
25-Jul-2023 14:07:32 | Executing: ['git', 'checkout', 'tags/1.8.2'] |
25-Jul-2023 14:07:32 | Note: checking out 'tags/1.8.2'. |
25-Jul-2023 14:07:32 | |
25-Jul-2023 14:07:32 | You are in 'detached HEAD' state. You can look around, make experimental |
25-Jul-2023 14:07:32 | changes and commit them, and you can discard any commits you make in this |
25-Jul-2023 14:07:32 | state without impacting any branches by performing another checkout. |
25-Jul-2023 14:07:32 | |
25-Jul-2023 14:07:32 | If you want to create a new branch to retain commits you create, you may |
25-Jul-2023 14:07:32 | do so (now or later) by using -b with the checkout command again. Example: |
25-Jul-2023 14:07:32 | |
25-Jul-2023 14:07:32 | git checkout -b new_branch_name |
25-Jul-2023 14:07:32 | |
25-Jul-2023 14:07:32 | HEAD is now at c98f40d... Pull request #39: CAS-14106 |
25-Jul-2023 14:07:32 | Executor result: 0 |
25-Jul-2023 14:07:32 | Failed tests:[] |
25-Jul-2023 14:07:32 | Reading config from: /home/casatest/casa6/casatestutils/casatestutils/component_to_test_map.json |
25-Jul-2023 14:07:32 | Test Paths: ['/home/casatest/work/casasources//casa6/casatests/regression/', '/home/casatest/work/casasources//casa6/casatests/stakeholder/', '/home/casatest/work/casasources//casa6/casatasks/tests/', '/home/casatest/work/casasources//casa6/casatools/tests/', '/home/casatest/work/casasources//casampi/src/casampi/tests', '/home/casatest/work/casasources//casaplotms/tests/plotms', '/home/casatest/work/casasources//almatasks/tests/tasks', '/home/casatest/work/casasources//casaviewer/tests/tasks'] |
25-Jul-2023 14:07:32 | Test list provided. Filtering tests. |
25-Jul-2023 14:07:32 | Test test_task_imview configuration not found. Searching for the test... |
25-Jul-2023 14:07:32 | dir: /home/casatest/work/casasources//casaviewer/tests/tasks |
25-Jul-2023 14:07:32 | Found: /home/casatest/work/casasources//casaviewer/tests/tasks/test_task_imview.py |
25-Jul-2023 14:07:32 | No JSON configuration found. Test will be added to execution list without options. |
25-Jul-2023 14:07:32 | Subset tests: |
25-Jul-2023 14:07:32 | test_task_wvrgcal |
25-Jul-2023 14:07:32 | test_casampi |
25-Jul-2023 14:07:32 | test_task_msview |
25-Jul-2023 14:07:32 | test_task_imview |
25-Jul-2023 14:07:32 | test_task_plotms |
25-Jul-2023 14:07:32 | |
25-Jul-2023 14:07:32 | Running test: test_task_wvrgcal in Serial mode |
25-Jul-2023 14:07:32 | Running cmd ['/home/casatest/work/pkg/casa-6.6.0-3-py3.8.el7/bin/casa', '--nogui', '--nologger', '--log2term', '-c', '/home/casatest/work/casasources//almatasks/tests/tasks/test_task_wvrgcal.py']in /home/casatest/work/test_task_wvrgcal |
25-Jul-2023 14:07:32 | Executing: ['/home/casatest/work/pkg/casa-6.6.0-3-py3.8.el7/bin/casa', '--nogui', '--nologger', '--log2term', '-c', '/home/casatest/work/casasources//almatasks/tests/tasks/test_task_wvrgcal.py'] |
25-Jul-2023 14:07:32 | --> CrashReporter initialized. |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:08 INFO ::casa Using configuration file ~/.casa/config.py |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:08 INFO ::casa |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:08 INFO ::casa Checking Measures tables in data repository sub-directory /home/casatest/work/pkg/casa-6.6.0-3-py3.8.el7/lib/py/lib/python3.8/site-packages/casadata/__data__/geodetic |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:08 INFO ::casa IERSeop2000 (version date, last date in table (UTC)): 2023/06/23/15:00, 2023/05/24/00:00:00 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:08 INFO ::casa IERSeop97 (version date, last date in table (UTC)): 2023/06/23/15:00, 2023/05/24/00:00:00 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:08 INFO ::casa IERSpredict (version date, last date in table (UTC)): 2023/07/16/15:00, 2023/10/14/00:00:00 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:08 INFO ::casa TAI_UTC (version date, last date in table (UTC)): 2023/07/09/15:00, 2017/01/01/00:00:00 |
25-Jul-2023 14:07:32 | Telemetry initialized. Telemetry will send anonymized usage statistics to NRAO. |
25-Jul-2023 14:07:32 | You can disable telemetry by adding the following line to the config.py file in your rcdir (e.g. ~/.casa/config.py): |
25-Jul-2023 14:07:32 | telemetry_enabled = False |
25-Jul-2023 14:07:32 | .2023-07-25 18:07:15 INFO wvrgcal::::casa ########################################## |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:15 INFO wvrgcal::::casa ##### Begin Task: wvrgcal ##### |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:15 INFO wvrgcal::::casa wvrgcal( vis='myinput.ms', caltable='mycaltable.wvr', toffset=0.0, segsource=False, sourceflag=[], tie=[], nsol=1, disperse=False, wvrflag=[], statfield='', statsource='0455-462', smooth='', scale=1.0, spw=[], wvrspw=[], reversespw='', cont=False, maxdistm=500.0, minnumants=2, mingoodfrac=0.8, usefieldtab=False, refant=[], offsetstable='' ) |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:15 INFO wvrgcal::::casa Running /home/casatest/work/pkg/casa-6.6.0-3-py3.8.el7/lib/py/lib/python3.8/site-packages/almatasks/__bin__/wvrgcal standalone invoked as: |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:15 INFO wvrgcal::::casa /home/casatest/work/pkg/casa-6.6.0-3-py3.8.el7/lib/py/lib/python3.8/site-packages/almatasks/__bin__/wvrgcal --ms myinput.ms --output mycaltable.wvr --toffset 0.0 --statsource "0455-462" --maxdistm 500.0 --minnumants 2 --mingoodfrac 0.8 |
25-Jul-2023 14:07:32 | Calculating the coefficients now ... |
25-Jul-2023 14:07:32 | done! |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa WVRGCAL -- Version 2.1 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa Developed by B. Nikolic at the University of Cambridge as part of EU FP6 ALMA Enhancement |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa Maintained and extended since 2013 by the European Southern Observatory as part of the ALMA project |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa GPLv2 License -- you have a right to the source code |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa Will use all WVR SPWs: |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa 0 9 10 11 12 13 14 15 16 17 18 19 20 21 22 23 24 25 26 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa Will produce solutions for all SPWs: |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa 0 1 2 3 4 5 6 7 8 9 10 11 12 13 14 15 16 17 18 19 20 21 22 23 24 25 26 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa All WVR data points for antenna 0 are flagged. |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa All WVR data points for antenna 1 are flagged. |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa Choosing (interpolated) antenna 0 == CM01 as reference antenna for dTdL calculations. |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa Retrieved parameters |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa ---------------------------------------------------------------- |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa Evidence PWV PWV Error dT1dL dT2dL dT3dL dT4dL |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa 8.8022e-25 0.27555 0.00535097 29.3112 13.8616 6.20103 3.94196 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa Times used for the statistics calculation (in seconds from first astro datum) |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa ----------------------------------------------------------------------------- |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa (138.24, 146.304) |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa Antenna/WVR information: |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa ----------------------------------------------------------------------- |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa # Name WVR? Flag? RMS (um) Disc (um) |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa 0 CM01 No Yes 0.827 18.4 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa 1 CM02 No Yes 0.901 18.4 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa 2 DA41 Yes No 1.54 16.4 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa 3 DA42 Yes No 3.13 16.1 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa 4 DV02 Yes No 0.102 0 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa 5 DV03 Yes No 2.32 8.67 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa 6 DV04 Yes No 3.1 17.5 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa 7 DV05 Yes No 3.06 16.4 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa 8 DV06 Yes No 3.9 17.2 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa 9 DV08 Yes No 1.37 23.7 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa 10 DV09 Yes No 2.91 9.57 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa 11 DV11 Yes No 3.67 19.2 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa 12 DV12 Yes No 0.808 14.9 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa 13 DV13 Yes No 2.09 15.6 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa 14 DV14 Yes No 1.51 12.6 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa 15 PM02 Yes No 1.79 15.7 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa 16 PM03 Yes No 1.7 14.8 |
25-Jul-2023 14:07:32 | 2023-07-25 18:07:33 INFO wvrgcal::::casa 17 PM04 Yes No 1.25 25.5 |
25-Jul-2023 14:08:56 | 2023-07-25 18:07:33 INFO wvrgcal::::casa Expected performance |
25-Jul-2023 14:08:56 | 2023-07-25 18:07:33 INFO wvrgcal::::casa ------------------------------------------------------------------ |
25-Jul-2023 14:08:56 | 2023-07-25 18:07:33 INFO wvrgcal::::casa * Estimated WVR thermal contribution to path fluctuations (micron per antenna): 2.84137 |
25-Jul-2023 14:08:56 | 2023-07-25 18:07:33 INFO wvrgcal::::casa * Greatest Estimated path fluctuation is (micron on a baseline): 7.18935 |
25-Jul-2023 14:08:56 | 2023-07-25 18:07:33 INFO wvrgcal::::casa * Rough estimate path error due to coefficient error (micron on a baseline): 0.030375 |
25-Jul-2023 14:08:56 | 2023-07-25 18:07:33 INFO wvrgcal::::casa |
25-Jul-2023 14:08:56 | 2023-07-25 18:07:33 INFO wvrgcal::::casa Writing gain table ... |
25-Jul-2023 14:08:56 | 2023-07-25 18:07:33 INFO wvrgcal::::casa Task wvrgcal complete. Start time: 2023-07-25 18:07:14.717481 End time: 2023-07-25 18:07:32.736686 |
25-Jul-2023 14:08:56 | 2023-07-25 18:07:33 INFO wvrgcal::::casa ##### End Task: wvrgcal ##### |
25-Jul-2023 14:08:56 | 2023-07-25 18:07:33 INFO wvrgcal::::casa ########################################## |
25-Jul-2023 14:08:56 | .2023-07-25 18:07:34 INFO wvrgcal::::casa ########################################## |
25-Jul-2023 14:08:56 | 2023-07-25 18:07:34 INFO wvrgcal::::casa ##### Begin Task: wvrgcal ##### |
25-Jul-2023 14:08:56 | 2023-07-25 18:07:34 INFO wvrgcal::::casa wvrgcal( vis='myinput.ms', caltable='mycaltable.wvr', toffset=0.0, segsource=False, sourceflag=[], tie=[], nsol=5, disperse=False, wvrflag=[], statfield='', statsource='', smooth='', scale=1.0, spw=[], wvrspw=[], reversespw='', cont=False, maxdistm=500.0, minnumants=2, mingoodfrac=0.8, usefieldtab=False, refant=[], offsetstable='' ) |
25-Jul-2023 14:08:56 | 2023-07-25 18:07:34 INFO wvrgcal::::casa Running /home/casatest/work/pkg/casa-6.6.0-3-py3.8.el7/lib/py/lib/python3.8/site-packages/almatasks/__bin__/wvrgcal standalone invoked as: |
25-Jul-2023 14:08:56 | 2023-07-25 18:07:34 INFO wvrgcal::::casa /home/casatest/work/pkg/casa-6.6.0-3-py3.8.el7/lib/py/lib/python3.8/site-packages/almatasks/__bin__/wvrgcal --ms myinput.ms --output mycaltable.wvr --toffset 0.0 --nsol 5 --maxdistm 500.0 --minnumants 2 --mingoodfrac 0.8 |
25-Jul-2023 14:08:56 | Calculating the coefficients now ... |
25-Jul-2023 14:08:56 | done! |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa WVRGCAL -- Version 2.1 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa Developed by B. Nikolic at the University of Cambridge as part of EU FP6 ALMA Enhancement |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa Maintained and extended since 2013 by the European Southern Observatory as part of the ALMA project |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa GPLv2 License -- you have a right to the source code |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa Will use all WVR SPWs: |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 0 9 10 11 12 13 14 15 16 17 18 19 20 21 22 23 24 25 26 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa Will produce solutions for all SPWs: |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 0 1 2 3 4 5 6 7 8 9 10 11 12 13 14 15 16 17 18 19 20 21 22 23 24 25 26 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa All WVR data points for antenna 0 are flagged. |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa All WVR data points for antenna 1 are flagged. |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa Choosing (interpolated) antenna 0 == CM01 as reference antenna for dTdL calculations. |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa Retrieved parameters |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa ---------------------------------------------------------------- |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa Evidence PWV PWV Error dT1dL dT2dL dT3dL dT4dL |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 1.11897e-21 0.276816 0.00460199 28.7068 13.879 6.28312 4.00843 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 9.72095e-21 0.273349 0.00551861 31.1751 14.292 6.332 4.0184 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 3.62048e-22 0.276034 0.00646982 31.5963 14.2242 6.23896 3.94681 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 1.86363e-23 0.272148 0.00515628 29.2133 13.8989 6.24173 3.97306 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 5.17486e-23 0.271837 0.00450456 28.8935 13.9358 6.30771 4.02487 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa Times used for the statistics calculation (in seconds from first astro datum) |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa ----------------------------------------------------------------------------- |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa (0, 449.28) |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa Antenna/WVR information: |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa ----------------------------------------------------------------------- |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa # Name WVR? Flag? RMS (um) Disc (um) |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 0 CM01 No Yes 87.5 83.1 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 1 CM02 No Yes 87.6 84.1 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 2 DA41 Yes No 84.7 88.6 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 3 DA42 Yes No 68.9 66.9 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 4 DV02 Yes No 529 120 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 5 DV03 Yes No 92.8 90.8 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 6 DV04 Yes No 90 90.4 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 7 DV05 Yes No 89.2 102 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 8 DV06 Yes No 86.8 84.1 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 9 DV08 Yes No 87.1 86.6 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 10 DV09 Yes No 86.3 111 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 11 DV11 Yes No 90.4 103 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 12 DV12 Yes No 88.4 85.8 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 13 DV13 Yes No 86.1 92.9 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 14 DV14 Yes No 91.2 102 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 15 PM02 Yes No 86 105 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 16 PM03 Yes No 89 97.5 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa 17 PM04 Yes No 87 78.9 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa Expected performance |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa ------------------------------------------------------------------ |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa * Estimated WVR thermal contribution to path fluctuations (micron per antenna): 2.67786 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa * Greatest Estimated path fluctuation is (micron on a baseline): 264.694 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa * Rough estimate path error due to coefficient error (micron on a baseline): 1.10365 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa Writing gain table ... |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa Task wvrgcal complete. Start time: 2023-07-25 18:07:34.006581 End time: 2023-07-25 18:08:54.898631 |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa ##### End Task: wvrgcal ##### |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:55 INFO wvrgcal::::casa ########################################## |
25-Jul-2023 14:08:56 | .2023-07-25 18:08:56 INFO wvrgcal::::casa ########################################## |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:56 INFO wvrgcal::::casa ##### Begin Task: wvrgcal ##### |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:56 INFO wvrgcal::::casa wvrgcal( vis='myinput.ms', caltable='mycaltable.wvr', toffset=-1.0, segsource=True, sourceflag=[], tie=[], nsol=1, disperse=True, wvrflag=[], statfield='', statsource='', smooth='', scale=1.0, spw=[], wvrspw=[], reversespw='', cont=False, maxdistm=500.0, minnumants=2, mingoodfrac=0.8, usefieldtab=False, refant=[], offsetstable='' ) |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:56 INFO wvrgcal::::casa Using dispersion table /opt/casa/data/master/alma/wvrgcal/libair-ddefault.csv |
25-Jul-2023 14:08:56 | 2023-07-25 18:08:56 INFO wvrgcal::::casa Running /home/casatest/work/pkg/casa-6.6.0-3-py3.8.el7/lib/py/lib/python3.8/site-packages/almatasks/__bin__/wvrgcal standalone invoked as: |
25-Jul-2023 14:10:01 | 2023-07-25 18:08:56 INFO wvrgcal::::casa /home/casatest/work/pkg/casa-6.6.0-3-py3.8.el7/lib/py/lib/python3.8/site-packages/almatasks/__bin__/wvrgcal --ms myinput.ms --output mycaltable.wvr --toffset -1.0 --segsource --disperse --maxdistm 500.0 --minnumants 2 --mingoodfrac 0.8 |
25-Jul-2023 14:10:01 | Calculating the coefficients now ... |
25-Jul-2023 14:10:01 | done! |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa WVRGCAL -- Version 2.1 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa Developed by B. Nikolic at the University of Cambridge as part of EU FP6 ALMA Enhancement |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa Maintained and extended since 2013 by the European Southern Observatory as part of the ALMA project |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa GPLv2 License -- you have a right to the source code |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa Will use all WVR SPWs: |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 0 9 10 11 12 13 14 15 16 17 18 19 20 21 22 23 24 25 26 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa Will produce solutions for all SPWs: |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 0 1 2 3 4 5 6 7 8 9 10 11 12 13 14 15 16 17 18 19 20 21 22 23 24 25 26 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa All WVR data points for antenna 0 are flagged. |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa All WVR data points for antenna 1 are flagged. |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa Choosing (interpolated) antenna 0 == CM01 as reference antenna for dTdL calculations. |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa Retrieved parameters |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa ---------------------------------------------------------------- |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa Evidence PWV PWV Error dT1dL dT2dL dT3dL dT4dL |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 1.11897e-21 0.276816 0.00460199 28.7068 13.879 6.28312 4.00843 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 4.0184e-20 0.273237 0.00571632 31.2569 14.2921 6.32313 4.01096 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 2.29389e-21 0.270434 0.00445918 28.8772 13.9561 6.32564 4.03818 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 2.97538e-23 0.272146 0.0068595 32.3114 14.2838 6.21361 3.92165 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa Times used for the statistics calculation (in seconds from first astro datum) |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa ----------------------------------------------------------------------------- |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa (0, 449.28) |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa Antenna/WVR information: |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa ----------------------------------------------------------------------- |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa # Name WVR? Flag? RMS (um) Disc (um) |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 0 CM01 No Yes 67.1 46.2 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 1 CM02 No Yes 67.2 46.1 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 2 DA41 Yes No 66.9 48.5 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 3 DA42 Yes No 66.1 49 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 4 DV02 Yes No 333 171 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 5 DV03 Yes No 65.7 51.3 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 6 DV04 Yes No 70.8 49.8 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 7 DV05 Yes No 65.2 49.3 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 8 DV06 Yes No 67.4 51.6 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 9 DV08 Yes No 66.2 48.1 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 10 DV09 Yes No 65.9 56.1 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 11 DV11 Yes No 66 50.8 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 12 DV12 Yes No 66 42.1 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 13 DV13 Yes No 65.4 56.5 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 14 DV14 Yes No 64.3 57.6 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 15 PM02 Yes No 68.1 50.5 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 16 PM03 Yes No 67.6 50 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa 17 PM04 Yes No 66.8 52.1 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa Expected performance |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa ------------------------------------------------------------------ |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa * Estimated WVR thermal contribution to path fluctuations (micron per antenna): 2.86196 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa * Greatest Estimated path fluctuation is (micron on a baseline): 140.377 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa * Rough estimate path error due to coefficient error (micron on a baseline): 0.279781 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa Writing gain table ... |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa Task wvrgcal complete. Start time: 2023-07-25 18:08:56.056022 End time: 2023-07-25 18:09:59.990009 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa ##### End Task: wvrgcal ##### |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:00 INFO wvrgcal::::casa ########################################## |
25-Jul-2023 14:10:01 | .2023-07-25 18:10:01 INFO flagdata::::casa ########################################## |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:01 INFO flagdata::::casa ##### Begin Task: flagdata ##### |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:01 INFO flagdata::::casa flagdata( vis='myinput.ms', mode='manual', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='0', field='', antenna='', uvrange='', timerange='', correlation='', scan='', intent='', array='', observation='', feed='', clipminmax=[], datacolumn='DATA', clipoutside=True, channelavg=False, chanbin=1, timeavg=False, timebin='0s', clipzeros=False, quackinterval=1.0, quackmode='beg', quackincrement=False, tolerance=0.0, addantenna='', lowerlimit=0.0, upperlimit=90.0, ntime='scan', combinescans=False, timecutoff=4.0, freqcutoff=3.0, timefit='line', freqfit='poly', maxnpieces=7, flagdimension='freqtime', usewindowstats='none', halfwin=1, extendflags=True, winsize=3, timedev='', freqdev='', timedevscale=5.0, freqdevscale=5.0, spectralmax=1000000.0, spectralmin=0.0, antint_ref_antenna='', minchanfrac=0.6, verbose=False, extendpols=True, growtime=50.0, growfreq=50.0, growaround=False, flagneartime=False, flagnearfreq=False, minrel=0.0, maxrel=1.0, minabs=0, maxabs=-1, spwchan=False, spwcorr=False, basecnt=False, fieldcnt=False, name='Summary', action='apply', display='', flagbackup=True, savepars=False, cmdreason='', outfile='', overwrite=True, writeflags=True ) |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:01 INFO flagdata::::casa Backup original flags before applying new flags |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:01 INFO AgentFlagger::open Table type is Measurement Set |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:01 INFO FlagVersion::saveFlagVersion Creating new backup flag file called flagdata_1 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:01 INFO AgentFlagger::open Table type is Measurement Set |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:01 INFO flagdata::::casa Manual mode is active |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:01 INFO FlagMSHandler::selectData Selected spw-channels ids are Axis Lengths: [1, 4] (NB: Matrix in Row/Column order) |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:01 INFO FlagMSHandler::selectData + [0, 0, 3, 1] |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:01 INFO flagdata::::casa Initializing the agents |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:01 INFO AgentFlagger::initAgents There are initially 1 agents in the list. Agents: manual |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:01 INFO Manual::setAgentParameters autocorr is 0 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:01 INFO AgentFlagger::initAgents There are 1 valid agents in the list. Agents: manual |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:01 INFO flagdata::::casa Running the agentflagger tool |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:01 INFO FlagMSHandler:: Chunk = 1 [progress: 26%], Observation = 0, Array = 0, Scan = 1, Field = 0 (0132-169), Spw = 0, Channels = 4, Corrs = [ I ], Total Rows = 162 |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:01 INFO Manual::chunkSummary => Data flagged so far 100% (648/648) |
25-Jul-2023 14:10:01 | 2023-07-25 18:10:01 INFO FlagMSHandler:: Chunk = 2 [progress: 50%], Observation = 0, Array = 0, Scan = 2, Field = 1 (0455-462), Spw = 0, Channels = 4, Corrs = [ I ], Total Rows = 144 |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO Manual::chunkSummary => Data flagged so far 100% (576/576) |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO FlagMSHandler:: Chunk = 3 [progress: 76%], Observation = 0, Array = 0, Scan = 3, Field = 2 (0530+135), Spw = 0, Channels = 4, Corrs = [ I ], Total Rows = 162 |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO Manual::chunkSummary => Data flagged so far 100% (648/648) |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO FlagMSHandler:: Chunk = 4 [progress: 100%], Observation = 0, Array = 0, Scan = 4, Field = 3 (0334-401), Spw = 0, Channels = 4, Corrs = [ I ], Total Rows = 144 |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO Manual::chunkSummary => Data flagged so far 100% (576/576) |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO FlagMSHandler::nextChunk ==================================================================================== |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO Manual::tableSummary => Percentage of data flagged in table selection: 100% |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO AgentFlagger::run => Writing flags to the MS |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO flagdata::::casa Task flagdata complete. Start time: 2023-07-25 18:10:01.142138 End time: 2023-07-25 18:10:01.244990 |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO flagdata::::casa ##### End Task: flagdata ##### |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO flagdata::::casa ########################################## |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO wvrgcal::::casa ########################################## |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO wvrgcal::::casa ##### Begin Task: wvrgcal ##### |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO wvrgcal::::casa wvrgcal( vis='myinput.ms', caltable='mycaltable.wvr', toffset=-1.0, segsource=True, sourceflag=[], tie=[], nsol=1, disperse=True, wvrflag=[], statfield='', statsource='', smooth='', scale=1.0, spw=[], wvrspw=[], reversespw='', cont=False, maxdistm=500.0, minnumants=2, mingoodfrac=0.8, usefieldtab=False, refant=[], offsetstable='' ) |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO wvrgcal::::casa Using dispersion table /opt/casa/data/master/alma/wvrgcal/libair-ddefault.csv |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO wvrgcal::::casa Running /home/casatest/work/pkg/casa-6.6.0-3-py3.8.el7/lib/py/lib/python3.8/site-packages/almatasks/__bin__/wvrgcal standalone invoked as: |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO wvrgcal::::casa /home/casatest/work/pkg/casa-6.6.0-3-py3.8.el7/lib/py/lib/python3.8/site-packages/almatasks/__bin__/wvrgcal --ms myinput.ms --output mycaltable.wvr --toffset -1.0 --segsource --disperse --maxdistm 500.0 --minnumants 2 --mingoodfrac 0.8 |
25-Jul-2023 14:10:02 | terminate called after throwing an instance of 'LibAIR2::MSInputDataError' |
25-Jul-2023 14:10:02 | what(): There is an error in the supplied input data which prevents the calculation of the calibration: Didn't find any WVR data points |
25-Jul-2023 14:10:02 | sh: line 1: 272 Aborted (core dumped) /home/casatest/work/pkg/casa-6.6.0-3-py3.8.el7/lib/py/lib/python3.8/site-packages/almatasks/__bin__/wvrgcal --ms myinput.ms --output mycaltable.wvr --toffset -1.0 --segsource --disperse --maxdistm 500.0 --minnumants 2 --mingoodfrac 0.8 > wvrgcal_tmp_71841985 |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO wvrgcal::::casa |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO wvrgcal::::casa WVRGCAL -- Version 2.1 |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO wvrgcal::::casa |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO wvrgcal::::casa Developed by B. Nikolic at the University of Cambridge as part of EU FP6 ALMA Enhancement |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO wvrgcal::::casa Maintained and extended since 2013 by the European Southern Observatory as part of the ALMA project |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO wvrgcal::::casa GPLv2 License -- you have a right to the source code |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO wvrgcal::::casa |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO wvrgcal::::casa Will use all WVR SPWs: |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO wvrgcal::::casa 0 9 10 11 12 13 14 15 16 17 18 19 20 21 22 23 24 25 26 |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO wvrgcal::::casa Will produce solutions for all SPWs: |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO wvrgcal::::casa 0 1 2 3 4 5 6 7 8 9 10 11 12 13 14 15 16 17 18 19 20 21 22 23 24 25 26 |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 WARN wvrgcal::::casa /home/casatest/work/pkg/casa-6.6.0-3-py3.8.el7/lib/py/lib/python3.8/site-packages/almatasks/__bin__/wvrgcal terminated with exit status 134 |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 SEVERE wvrgcal::::casa No useful input data. |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO wvrgcal::::casa Task wvrgcal complete. Start time: 2023-07-25 18:10:01.247047 End time: 2023-07-25 18:10:01.321871 |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO wvrgcal::::casa ##### End Task: wvrgcal ##### |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:01 INFO wvrgcal::::casa ########################################## |
25-Jul-2023 14:10:02 | .2023-07-25 18:10:02 INFO flagdata::::casa ########################################## |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO flagdata::::casa ##### Begin Task: flagdata ##### |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO flagdata::::casa flagdata( vis='myinput.ms', mode='manual', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='', field='', antenna='DV14&&*', uvrange='', timerange='09:10:11~09:10:15', correlation='', scan='', intent='', array='', observation='', feed='', clipminmax=[], datacolumn='DATA', clipoutside=True, channelavg=False, chanbin=1, timeavg=False, timebin='0s', clipzeros=False, quackinterval=1.0, quackmode='beg', quackincrement=False, tolerance=0.0, addantenna='', lowerlimit=0.0, upperlimit=90.0, ntime='scan', combinescans=False, timecutoff=4.0, freqcutoff=3.0, timefit='line', freqfit='poly', maxnpieces=7, flagdimension='freqtime', usewindowstats='none', halfwin=1, extendflags=True, winsize=3, timedev='', freqdev='', timedevscale=5.0, freqdevscale=5.0, spectralmax=1000000.0, spectralmin=0.0, antint_ref_antenna='', minchanfrac=0.6, verbose=False, extendpols=True, growtime=50.0, growfreq=50.0, growaround=False, flagneartime=False, flagnearfreq=False, minrel=0.0, maxrel=1.0, minabs=0, maxabs=-1, spwchan=False, spwcorr=False, basecnt=False, fieldcnt=False, name='Summary', action='apply', display='', flagbackup=True, savepars=False, cmdreason='', outfile='', overwrite=True, writeflags=True ) |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO flagdata::::casa Backup original flags before applying new flags |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO AgentFlagger::open Table type is Measurement Set |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO FlagVersion::saveFlagVersion Creating new backup flag file called flagdata_1 |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO AgentFlagger::open Table type is Measurement Set |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO flagdata::::casa Manual mode is active |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO flagdata::::casa Initializing the agents |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO AgentFlagger::initAgents There are initially 1 agents in the list. Agents: manual |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO Manual::setAgentParameters autocorr is 0 |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO AgentFlagger::initAgents There are 1 valid agents in the list. Agents: manual |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO flagdata::::casa Running the agentflagger tool |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO FlagMSHandler:: Chunk = 1 [progress: 100%], Observation = 0, Array = 0, Scan = 1, Field = 0 (0132-169), Spw = 0, Channels = 4, Corrs = [ I ], Total Rows = 3 |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO Manual::chunkSummary => Data flagged so far 100% (12/12) |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO FlagMSHandler::nextChunk ==================================================================================== |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO Manual::tableSummary => Percentage of data flagged in table selection: 100% |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO AgentFlagger::run => Writing flags to the MS |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO flagdata::::casa Task flagdata complete. Start time: 2023-07-25 18:10:02.315750 End time: 2023-07-25 18:10:02.439953 |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO flagdata::::casa ##### End Task: flagdata ##### |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO flagdata::::casa ########################################## |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO split::::casa ########################################## |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO split::::casa ##### Begin Task: split ##### |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO split::::casa split( vis='myinput.ms', outputvis='myinput2.ms', keepmms=True, field='', spw='', scan='', antenna='', correlation='', timerange='', intent='', array='', uvrange='', observation='', feed='', datacolumn='data', keepflags=False, width=1, timebin='0s', combine='' ) |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO MSTransformManager::parseMsSpecParams Input file name is myinput.ms |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO MSTransformManager::parseMsSpecParams Data column is DATA |
25-Jul-2023 14:10:02 | 2023-07-25 18:10:02 INFO MSTransformManager::parseMsSpecParams Output file name is myinput2.ms |
25-Jul-2023 14:11:07 | 2023-07-25 18:10:02 INFO MSTransformManager::colCheckInfo Adding DATA column to output MS from input DATA column |
25-Jul-2023 14:11:07 | 2023-07-25 18:10:02 INFO MSTransformManager::open Select data |
25-Jul-2023 14:11:07 | 2023-07-25 18:10:02 INFO MSTransformDataHandler::selectSpw The following a priori selected input spw(s) |
25-Jul-2023 14:11:07 | 2023-07-25 18:10:02 INFO MSTransformDataHandler::selectSpw+ 9 10 11 12 13 14 15 16 17 18 19 20 21 22 23 24 25 26 |
25-Jul-2023 14:11:07 | 2023-07-25 18:10:02 INFO MSTransformDataHandler::selectSpw+ were not found in DATA_DESCRIPTION (i. e. no rows in the main table reference them) and therefore are not included to the output. |
25-Jul-2023 14:11:07 | 2023-07-25 18:10:02 INFO MSTransformManager::createOutputMSStructure Create output MS structure |
25-Jul-2023 14:11:07 | 2023-07-25 18:10:03 INFO MSTransformDataHandler::makeSelection 609 out of 612 rows are going to be considered due to the selection criteria. |
25-Jul-2023 14:11:07 | 2023-07-25 18:10:03 INFO split::::casa Task split complete. Start time: 2023-07-25 18:10:02.460377 End time: 2023-07-25 18:10:03.446019 |
25-Jul-2023 14:11:07 | 2023-07-25 18:10:03 INFO split::::casa ##### End Task: split ##### |
25-Jul-2023 14:11:07 | 2023-07-25 18:10:03 INFO split::::casa ########################################## |
25-Jul-2023 14:11:07 | 2023-07-25 18:10:03 INFO wvrgcal::::casa ########################################## |
25-Jul-2023 14:11:07 | 2023-07-25 18:10:03 INFO wvrgcal::::casa ##### Begin Task: wvrgcal ##### |
25-Jul-2023 14:11:07 | 2023-07-25 18:10:03 INFO wvrgcal::::casa wvrgcal( vis='myinput.ms', caltable='comp.W', toffset=0.0, segsource=True, sourceflag=[], tie=[], nsol=1, disperse=False, wvrflag=[], statfield='', statsource='', smooth='', scale=1.0, spw=[], wvrspw=[], reversespw='', cont=False, maxdistm=500.0, minnumants=2, mingoodfrac=0.8, usefieldtab=False, refant=[], offsetstable='' ) |
25-Jul-2023 14:11:07 | 2023-07-25 18:10:03 INFO wvrgcal::::casa Running /home/casatest/work/pkg/casa-6.6.0-3-py3.8.el7/lib/py/lib/python3.8/site-packages/almatasks/__bin__/wvrgcal standalone invoked as: |
25-Jul-2023 14:11:07 | 2023-07-25 18:10:03 INFO wvrgcal::::casa /home/casatest/work/pkg/casa-6.6.0-3-py3.8.el7/lib/py/lib/python3.8/site-packages/almatasks/__bin__/wvrgcal --ms myinput.ms --output comp.W --toffset 0.0 --segsource --maxdistm 500.0 --minnumants 2 --mingoodfrac 0.8 |
25-Jul-2023 14:11:07 | Calculating the coefficients now ... |
25-Jul-2023 14:11:07 | done! |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa WVRGCAL -- Version 2.1 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa Developed by B. Nikolic at the University of Cambridge as part of EU FP6 ALMA Enhancement |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa Maintained and extended since 2013 by the European Southern Observatory as part of the ALMA project |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa GPLv2 License -- you have a right to the source code |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa Will use all WVR SPWs: |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 0 9 10 11 12 13 14 15 16 17 18 19 20 21 22 23 24 25 26 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa Will produce solutions for all SPWs: |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 0 1 2 3 4 5 6 7 8 9 10 11 12 13 14 15 16 17 18 19 20 21 22 23 24 25 26 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa All WVR data points for antenna 0 are flagged. |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa All WVR data points for antenna 1 are flagged. |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa Choosing (interpolated) antenna 0 == CM01 as reference antenna for dTdL calculations. |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa Retrieved parameters |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa ---------------------------------------------------------------- |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa Evidence PWV PWV Error dT1dL dT2dL dT3dL dT4dL |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 1.36063e-21 0.276254 0.00465181 28.7263 13.8802 6.28209 4.00758 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 4.2929e-22 0.274038 0.00588576 31.3997 14.2692 6.29146 3.98658 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 4.63014e-24 0.272522 0.00491532 29.1304 13.8873 6.24293 3.97518 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 5.88889e-21 0.2683 0.0056288 31.7198 14.3809 6.34222 4.02018 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa Times used for the statistics calculation (in seconds from first astro datum) |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa ----------------------------------------------------------------------------- |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa (0, 449.28) |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa Antenna/WVR information: |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa ----------------------------------------------------------------------- |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa # Name WVR? Flag? RMS (um) Disc (um) |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 0 CM01 No Yes 59.2 42.5 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 1 CM02 No Yes 59.3 43.4 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 2 DA41 Yes No 58.4 53.9 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 3 DA42 Yes No 60 44.3 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 4 DV02 Yes No 338 91.7 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 5 DV03 Yes No 58.2 52.6 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 6 DV04 Yes No 61.9 50.8 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 7 DV05 Yes No 58.5 58 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 8 DV06 Yes No 59.5 41.2 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 9 DV08 Yes No 58.6 46.8 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 10 DV09 Yes No 57.5 72 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 11 DV11 Yes No 57.4 61.2 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 12 DV12 Yes No 58.2 45.1 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 13 DV13 Yes No 57 56.1 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 14 DV14 Yes No 55.6 64.3 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 15 PM02 Yes No 59.3 65 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 16 PM03 Yes No 58.9 54.3 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa 17 PM04 Yes No 58.9 41.6 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa Expected performance |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa ------------------------------------------------------------------ |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa * Estimated WVR thermal contribution to path fluctuations (micron per antenna): 2.85095 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa * Greatest Estimated path fluctuation is (micron on a baseline): 144.449 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa * Rough estimate path error due to coefficient error (micron on a baseline): 0.471086 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa Writing gain table ... |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa Task wvrgcal complete. Start time: 2023-07-25 18:10:03.449865 End time: 2023-07-25 18:11:07.364635 |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa ##### End Task: wvrgcal ##### |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa ########################################## |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa ########################################## |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa ##### Begin Task: wvrgcal ##### |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa wvrgcal( vis='myinput2.ms', caltable='comp2.W', toffset=0.0, segsource=True, sourceflag=[], tie=[], nsol=1, disperse=False, wvrflag=[], statfield='', statsource='', smooth='', scale=1.0, spw=[], wvrspw=[], reversespw='', cont=False, maxdistm=500.0, minnumants=2, mingoodfrac=0.8, usefieldtab=False, refant=[], offsetstable='' ) |
25-Jul-2023 14:11:07 | 2023-07-25 18:11:07 INFO wvrgcal::::casa Running /home/casatest/work/pkg/casa-6.6.0-3-py3.8.el7/lib/py/lib/python3.8/site-packages/almatasks/__bin__/wvrgcal standalone invoked as: |
25-Jul-2023 14:12:57 | Request to stop 'CASA-REC6MT-TSGC2014PY38-1' received from awells |
25-Jul-2023 14:12:58 | Failing task since return code of [/export/home/cbt-el7-2/bamboohome/temp/CASA-REC6MT-TSGC2014PY38-1-ScriptBuildTask-2101132708556825693.sh] was 143 while expected 0 |
25-Jul-2023 14:12:58 | Finished task 'Run plotms, imview, msview, wvrgcal, casampi tests' with result: Failed |
25-Jul-2023 14:12:58 | Starting task 'Cleanup' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script' |
25-Jul-2023 14:12:58 | Beginning to execute external process for build 'CASA - Release Engineering Casa 6 Master Test - Test Casalith Many Linux 2014 #1 (CASA-REC6MT-TSGC2014PY38-1)' ... running command line: /export/home/cbt-el7-2/bamboohome/temp/CASA-REC6MT-TSGC2014PY38-1-ScriptBuildTask-3239986464923710466.sh ... in: /export/home/cbt-el7-2/bamboohome/xml-data/build-dir/CASA-REC6MT-TSGC2014PY38 |
25-Jul-2023 14:12:58 | Force Stop build feature is enabled for current plan. Either Bamboo has detected the build has hung or it has been manually stopped. |
25-Jul-2023 14:12:58 | Attempting to generate stack trace and terminate spawned sub-processes of process id: 1862 |
25-Jul-2023 14:12:58 | Starting cleanup |
25-Jul-2023 14:12:58 | Found related process: pid: 26520 ppid: 1862 pgid: 1825 %cpu: 0.0 %mem: 0.0 cmd: /bin/sh |
25-Jul-2023 14:12:58 | Found related process: pid: 26527 ppid: 26520 pgid: 1825 %cpu: 0.0 %mem: 0.0 cmd: docker |
25-Jul-2023 14:12:58 | Found related process: pid: 25735 ppid: 1 pgid: 1825 %cpu: 0.0 %mem: 0.0 cmd: docker |
25-Jul-2023 14:12:58 | getStackTraceAndKillRelatedProcesses for 3 processes |
25-Jul-2023 14:12:58 | Executing kill -3 25735 |
25-Jul-2023 14:12:58 | Executing kill -3 26527 |
25-Jul-2023 14:12:58 | 2023-07-25 18:11:07 INFO wvrgcal::::casa /home/casatest/work/pkg/casa-6.6.0-3-py3.8.el7/lib/py/lib/python3.8/site-packages/almatasks/__bin__/wvrgcal --ms myinput2.ms --output comp2.W --toffset 0.0 --segsource --maxdistm 500.0 --minnumants 2 --mingoodfrac 0.8 |
25-Jul-2023 14:12:58 | SIGQUIT: quit |
25-Jul-2023 14:12:58 | PC=0x556ced4b30ee m=0 sigcode=0 |
25-Jul-2023 14:12:58 | |
25-Jul-2023 14:12:58 | goroutine 1 [syscall]: |
25-Jul-2023 14:12:58 | syscall.Syscall6(0xc000448a50?, 0x21?, 0x2f6e556ced4c6670?, 0x16?, 0x1?, 0x20?, 0x7f4cb901f188?) |
25-Jul-2023 14:12:58 | /usr/local/go/src/syscall/syscall_linux.go:91 +0x36 fp=0xc00059fb58 sp=0xc00059fad0 pc=0x556ced5339b6 |
25-Jul-2023 14:12:58 | syscall.openat(0x170?, {0xc000448a50?, 0x6ceed3ace0?}, 0x7f4c8eb94138?, 0x0) |
25-Jul-2023 14:12:58 | /usr/local/go/src/syscall/zsyscall_linux_amd64.go:83 +0x94 fp=0xc00059fbd0 sp=0xc00059fb58 pc=0x556ced5304b4 |
25-Jul-2023 14:12:58 | syscall.Open(...) |
25-Jul-2023 14:12:58 | /usr/local/go/src/syscall/syscall_linux.go:272 |
25-Jul-2023 14:12:58 | os.openFileNolog({0xc000448a50, 0x21}, 0x0, 0x0) |
25-Jul-2023 14:12:58 | /usr/local/go/src/os/file_unix.go:245 +0x9b fp=0xc00059fc18 sp=0xc00059fbd0 pc=0x556ced5681fb |
25-Jul-2023 14:12:58 | os.OpenFile({0xc000448a50, 0x21}, 0x0, 0x5?) |
25-Jul-2023 14:12:58 | /usr/local/go/src/os/file.go:326 +0x45 fp=0xc00059fc50 sp=0xc00059fc18 pc=0x556ced565f65 |
25-Jul-2023 14:12:58 | os.Open(...) |
25-Jul-2023 14:12:58 | /usr/local/go/src/os/file.go:306 |
25-Jul-2023 14:12:58 | github.com/docker/cli/cli/config.load({0xc00011a108?, 0x556cedf4d723?}) |
25-Jul-2023 14:12:58 | /go/src/github.com/docker/cli/cli/config/config.go:118 +0x1d3 fp=0xc00059fd40 sp=0xc00059fc50 pc=0x556ced604e33 |
25-Jul-2023 14:12:58 | github.com/docker/cli/cli/config.LoadDefaultConfigFile({0x556cee56cae0, 0xc000014020}) |
25-Jul-2023 14:12:58 | /go/src/github.com/docker/cli/cli/config/config.go:142 +0x51 fp=0xc00059fda8 sp=0xc00059fd40 pc=0x556ced605151 |
25-Jul-2023 14:12:58 | github.com/docker/cli/cli/command.(*DockerCli).Initialize(0xc0003980f0, 0xc0004000c0, {0x0, 0x0, 0xc000004300?}) |
25-Jul-2023 14:12:58 | /go/src/github.com/docker/cli/cli/command/cli.go:231 +0x1a5 fp=0xc00059fdf8 sp=0xc00059fda8 pc=0x556cedabe865 |
25-Jul-2023 14:12:58 | github.com/docker/cli/cli.(*TopLevelCommand).Initialize(0xc00042fec0, {0x0, 0x0, 0x0}) |
25-Jul-2023 14:12:58 | /go/src/github.com/docker/cli/cli/cobra.go:185 +0x5c fp=0xc00059fe30 sp=0xc00059fdf8 pc=0x556cedac937c |
25-Jul-2023 14:12:58 | main.runDocker(0x0?) |
25-Jul-2023 14:12:58 | /go/src/github.com/docker/cli/cmd/docker/docker.go:227 +0x7c fp=0xc00059ff08 sp=0xc00059fe30 pc=0x556cedf46f7c |
25-Jul-2023 14:12:58 | main.main() |
25-Jul-2023 14:12:58 | /go/src/github.com/docker/cli/cmd/docker/docker.go:274 +0x97 fp=0xc00059ff80 sp=0xc00059ff08 pc=0x556cedf474d7 |
25-Jul-2023 14:12:58 | runtime.main() |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/proc.go:250 +0x212 fp=0xc00059ffe0 sp=0xc00059ff80 pc=0x556ced4eafb2 |
25-Jul-2023 14:12:58 | runtime.goexit() |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/asm_amd64.s:1598 +0x1 fp=0xc00059ffe8 sp=0xc00059ffe0 pc=0x556ced51c5c1 |
25-Jul-2023 14:12:58 | Executing kill -3 26520 |
25-Jul-2023 14:12:58 | |
25-Jul-2023 14:12:58 | goroutine 2 [force gc (idle)]: |
25-Jul-2023 14:12:58 | runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/proc.go:381 +0xd6 fp=0xc00006cfb0 sp=0xc00006cf90 pc=0x556ced4eb3f6 |
25-Jul-2023 14:12:58 | runtime.goparkunlock(...) |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/proc.go:387 |
25-Jul-2023 14:12:58 | runtime.forcegchelper() |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/proc.go:305 +0xb0 fp=0xc00006cfe0 sp=0xc00006cfb0 pc=0x556ced4eb230 |
25-Jul-2023 14:12:58 | runtime.goexit() |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/asm_amd64.s:1598 +0x1 fp=0xc00006cfe8 sp=0xc00006cfe0 pc=0x556ced51c5c1 |
25-Jul-2023 14:12:58 | created by runtime.init.6 |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/proc.go:293 +0x25 |
25-Jul-2023 14:12:58 | |
25-Jul-2023 14:12:58 | goroutine 3 [GC sweep wait]: |
25-Jul-2023 14:12:58 | runtime.gopark(0x1?, 0x0?, 0x0?, 0x0?, 0x0?) |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/proc.go:381 +0xd6 fp=0xc00006d780 sp=0xc00006d760 pc=0x556ced4eb3f6 |
25-Jul-2023 14:12:58 | runtime.goparkunlock(...) |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/proc.go:387 |
25-Jul-2023 14:12:58 | runtime.bgsweep(0x0?) |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/mgcsweep.go:319 +0xde fp=0xc00006d7c8 sp=0xc00006d780 pc=0x556ced4d647e |
25-Jul-2023 14:12:58 | runtime.gcenable.func1() |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/mgc.go:178 +0x26 fp=0xc00006d7e0 sp=0xc00006d7c8 pc=0x556ced4cb6e6 |
25-Jul-2023 14:12:58 | runtime.goexit() |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/asm_amd64.s:1598 +0x1 fp=0xc00006d7e8 sp=0xc00006d7e0 pc=0x556ced51c5c1 |
25-Jul-2023 14:12:58 | created by runtime.gcenable |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/mgc.go:178 +0x6b |
25-Jul-2023 14:12:58 | |
25-Jul-2023 14:12:58 | goroutine 4 [GC scavenge wait]: |
25-Jul-2023 14:12:58 | runtime.gopark(0xc00004e4d0?, 0x556cee10ac08?, 0x0?, 0x0?, 0x0?) |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/proc.go:381 +0xd6 fp=0xc00006df70 sp=0xc00006df50 pc=0x556ced4eb3f6 |
25-Jul-2023 14:12:58 | runtime.goparkunlock(...) |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/proc.go:387 |
25-Jul-2023 14:12:58 | runtime.(*scavengerState).park(0x556ceed3a340) |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/mgcscavenge.go:400 +0x53 fp=0xc00006dfa0 sp=0xc00006df70 pc=0x556ced4d4353 |
25-Jul-2023 14:12:58 | runtime.bgscavenge(0x0?) |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/mgcscavenge.go:633 +0x65 fp=0xc00006dfc8 sp=0xc00006dfa0 pc=0x556ced4d4945 |
25-Jul-2023 14:12:58 | runtime.gcenable.func2() |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/mgc.go:179 +0x26 fp=0xc00006dfe0 sp=0xc00006dfc8 pc=0x556ced4cb686 |
25-Jul-2023 14:12:58 | runtime.goexit() |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/asm_amd64.s:1598 +0x1 fp=0xc00006dfe8 sp=0xc00006dfe0 pc=0x556ced51c5c1 |
25-Jul-2023 14:12:58 | created by runtime.gcenable |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/mgc.go:179 +0xaa |
25-Jul-2023 14:12:58 | |
25-Jul-2023 14:12:58 | goroutine 5 [finalizer wait]: |
25-Jul-2023 14:12:58 | runtime.gopark(0x1a0?, 0x556ceed3ace0?, 0x60?, 0x78?, 0xc00006c770?) |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/proc.go:381 +0xd6 fp=0xc00006c628 sp=0xc00006c608 pc=0x556ced4eb3f6 |
25-Jul-2023 14:12:58 | runtime.runfinq() |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/mfinal.go:193 +0x107 fp=0xc00006c7e0 sp=0xc00006c628 pc=0x556ced4ca707 |
25-Jul-2023 14:12:58 | runtime.goexit() |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/asm_amd64.s:1598 +0x1 fp=0xc00006c7e8 sp=0xc00006c7e0 pc=0x556ced51c5c1 |
25-Jul-2023 14:12:58 | created by runtime.createfing |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/mfinal.go:163 +0x45 |
25-Jul-2023 14:12:58 | |
25-Jul-2023 14:12:58 | goroutine 34 [GC worker (idle)]: |
25-Jul-2023 14:12:58 | runtime.gopark(0x556ced9c4395?, 0x556ced4b635d?, 0xc0?, 0xe3?, 0xc00006e7a8?) |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/proc.go:381 +0xd6 fp=0xc00006e750 sp=0xc00006e730 pc=0x556ced4eb3f6 |
25-Jul-2023 14:12:58 | runtime.gcBgMarkWorker() |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/mgc.go:1275 +0xf1 fp=0xc00006e7e0 sp=0xc00006e750 pc=0x556ced4cd451 |
25-Jul-2023 14:12:58 | runtime.goexit() |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/asm_amd64.s:1598 +0x1 fp=0xc00006e7e8 sp=0xc00006e7e0 pc=0x556ced51c5c1 |
25-Jul-2023 14:12:58 | created by runtime.gcBgMarkStartWorkers |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/mgc.go:1199 +0x25 |
25-Jul-2023 14:12:58 | |
25-Jul-2023 14:12:58 | goroutine 35 [GC worker (idle)]: |
25-Jul-2023 14:12:58 | runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/proc.go:381 +0xd6 fp=0xc000068750 sp=0xc000068730 pc=0x556ced4eb3f6 |
25-Jul-2023 14:12:58 | runtime.gcBgMarkWorker() |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/mgc.go:1275 +0xf1 fp=0xc0000687e0 sp=0xc000068750 pc=0x556ced4cd451 |
25-Jul-2023 14:12:58 | runtime.goexit() |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/asm_amd64.s:1598 +0x1 fp=0xc0000687e8 sp=0xc0000687e0 pc=0x556ced51c5c1 |
25-Jul-2023 14:12:58 | created by runtime.gcBgMarkStartWorkers |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/mgc.go:1199 +0x25 |
25-Jul-2023 14:12:58 | |
25-Jul-2023 14:12:58 | goroutine 19 [GC worker (idle)]: |
25-Jul-2023 14:12:58 | runtime.gopark(0x10f6062d0019d6?, 0x0?, 0x0?, 0x0?, 0x0?) |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/proc.go:381 +0xd6 fp=0xc000134750 sp=0xc000134730 pc=0x556ced4eb3f6 |
25-Jul-2023 14:12:58 | runtime.gcBgMarkWorker() |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/mgc.go:1275 +0xf1 fp=0xc0001347e0 sp=0xc000134750 pc=0x556ced4cd451 |
25-Jul-2023 14:12:58 | runtime.goexit() |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/asm_amd64.s:1598 +0x1 fp=0xc0001347e8 sp=0xc0001347e0 pc=0x556ced51c5c1 |
25-Jul-2023 14:12:58 | created by runtime.gcBgMarkStartWorkers |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/mgc.go:1199 +0x25 |
25-Jul-2023 14:12:58 | |
25-Jul-2023 14:12:58 | goroutine 36 [GC worker (idle)]: |
25-Jul-2023 14:12:58 | runtime.gopark(0x10f6062cfcfddf?, 0x0?, 0x0?, 0x0?, 0x0?) |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/proc.go:381 +0xd6 fp=0xc000068f50 sp=0xc000068f30 pc=0x556ced4eb3f6 |
25-Jul-2023 14:12:58 | runtime.gcBgMarkWorker() |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/mgc.go:1275 +0xf1 fp=0xc000068fe0 sp=0xc000068f50 pc=0x556ced4cd451 |
25-Jul-2023 14:12:58 | runtime.goexit() |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/asm_amd64.s:1598 +0x1 fp=0xc000068fe8 sp=0xc000068fe0 pc=0x556ced51c5c1 |
25-Jul-2023 14:12:58 | created by runtime.gcBgMarkStartWorkers |
25-Jul-2023 14:12:58 | /usr/local/go/src/runtime/mgc.go:1199 +0x25 |
25-Jul-2023 14:12:58 | |
25-Jul-2023 14:12:58 | rax 0x3 |
25-Jul-2023 14:12:58 | rbx 0xffffffffffffff9c |
25-Jul-2023 14:12:58 | rcx 0xffffffffffffffff |
25-Jul-2023 14:12:58 | rdx 0x80000 |
25-Jul-2023 14:12:58 | rdi 0xffffffffffffff9c |
25-Jul-2023 14:12:58 | rsi 0xc000448a80 |
25-Jul-2023 14:12:58 | rbp 0xc00059fac0 |
25-Jul-2023 14:12:58 | rsp 0xc00059fa80 |
25-Jul-2023 14:12:58 | r8 0x0 |
25-Jul-2023 14:12:58 | r9 0x0 |
25-Jul-2023 14:12:58 | r10 0x0 |
25-Jul-2023 14:12:58 | r11 0x206 |
25-Jul-2023 14:12:58 | r12 0x0 |
25-Jul-2023 14:12:58 | r13 0x39 |
25-Jul-2023 14:12:58 | r14 0xc0000061a0 |
25-Jul-2023 14:12:58 | r15 0x556ceed3ace0 |
25-Jul-2023 14:12:58 | rip 0x556ced4b30ee |
25-Jul-2023 14:12:58 | rflags 0x206 |
25-Jul-2023 14:12:58 | cs 0x33 |
25-Jul-2023 14:12:58 | fs 0x0 |
25-Jul-2023 14:12:58 | gs 0x0 |
25-Jul-2023 14:12:58 | Error response from daemon: You cannot remove a running container fe7a047382e7406af3ee0ebc4a2d28211c47ee49dc3d0672a8029f3c38917dd1. Stop the container before attempting removal or force remove |
25-Jul-2023 14:12:58 | Cleanup complete |
25-Jul-2023 14:12:58 | Finished task 'Cleanup' with result: Success |
25-Jul-2023 14:12:58 | Running post build plugin 'Docker Container Cleanup' |
25-Jul-2023 14:12:58 | Beginning to execute external process for build 'CASA - Release Engineering Casa 6 Master Test - Test Casalith Many Linux 2014 #1 (CASA-REC6MT-TSGC2014PY38-1)' ... running command line: /bin/docker rm -f test-container ... in: /export/home/cbt-el7-2/bamboohome/xml-data/build-dir/CASA-REC6MT-TSGC2014PY38 |
25-Jul-2023 14:13:01 | test-container |
25-Jul-2023 14:13:01 | Running post build plugin 'NCover Results Collector' |
25-Jul-2023 14:13:01 | Running post build plugin 'Clover Results Collector' |
25-Jul-2023 14:13:01 | Running post build plugin 'npm Cache Cleanup' |
25-Jul-2023 14:13:01 | Running post build plugin 'Artifact Copier' |
25-Jul-2023 14:13:01 | Finalising the build... |
25-Jul-2023 14:13:01 | Stopping timer. |
25-Jul-2023 14:13:01 | Build CASA-REC6MT-TSGC2014PY38-1 completed. |
25-Jul-2023 14:13:01 | Running on server: post build plugin 'NCover Results Collector' |
25-Jul-2023 14:13:01 | Running on server: post build plugin 'Build Hanging Detection Configuration' |
25-Jul-2023 14:13:01 | Running on server: post build plugin 'Clover Delta Calculator' |
25-Jul-2023 14:13:01 | Running on server: post build plugin 'Maven Dependencies Postprocessor' |
25-Jul-2023 14:13:01 | All post build plugins have finished |
25-Jul-2023 14:13:01 | Generating build results summary... |
25-Jul-2023 14:13:01 | Saving build results to disk... |
25-Jul-2023 14:13:01 | Store variable context... |
25-Jul-2023 14:13:01 | Indexing build results... |
25-Jul-2023 14:13:01 | Finished building CASA-REC6MT-TSGC2014PY38-1. |
25-Jul-2023 14:13:03 | Killing: 25735 |
25-Jul-2023 14:13:03 | Executing kill 25735 |
25-Jul-2023 14:13:03 | Killing: 26527 |
25-Jul-2023 14:13:03 | Executing kill 26527 |
25-Jul-2023 14:13:03 | Killing: 26520 |
25-Jul-2023 14:13:03 | Executing kill 26520 |
25-Jul-2023 14:13:08 | Force Stop build feature is enabled for current plan. Either Bamboo has detected the build has hung or it has been manually stopped. |
25-Jul-2023 14:13:08 | Has finished generating stack trace and terminating spawned sub-processes of process id: 1862 |