Build: #2 failed

Job: VLA Stakeholder Tests MPI EL8 Docker failed

Build log

The build generated 1,024 lines of output.The output is too long and has been truncated to the last 1,000 lines. Download or view full build log.

17-Sep-2024 18:18:33 Finished task 'Stop and remove running test containers' with result: Success
17-Sep-2024 18:18:33
Substituting variable: ${bamboo.capability.hostname} with cvpost135
17-Sep-2024 18:18:33
Substituting variable: ${bamboo.capability.hostname} with cvpost135
17-Sep-2024 18:18:33
Substituting variable: ${bamboo.build.working.directory} with /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASA-CMTSP3-STCR85D
17-Sep-2024 18:18:33 Starting task 'Start container' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
17-Sep-2024 18:18:33
Beginning to execute external process for build 'CASA - CMake Master Test Stakeholder Python 3.10 - VLA Stakeholder Tests MPI EL8 Docker #2 (CASA-CMTSP3-STCR85D-2)'
... running command line:
/export/cvpost135-nvme/casa/bamboohome/temp/CASA-CMTSP3-STCR85D-2-ScriptBuildTask-2524551332162590352.sh
... in: /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASA-CMTSP3-STCR85D
17-Sep-2024 18:18:47 8d49fe10e18c5de84d12a0a3546ef91ac36b39c264527d1595420a7697815074
17-Sep-2024 18:18:48 Finished task 'Start container' with result: Success
17-Sep-2024 18:18:48 Skipping execution of task 'Mount /opt/casa/data' as it is disabled
17-Sep-2024 18:18:48 Skipping execution of task 'Mount  /export/cvpost134-4tb/casa/casa-data' as it is disabled
17-Sep-2024 18:18:48 Skipping execution of task 'Mount  /export/cvpost135-4tb/casa/casa-data' as it is disabled
17-Sep-2024 18:18:48
Substituting variable: ${bamboo.planRepository.branchName} with master
17-Sep-2024 18:18:48 Starting task 'Script' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
17-Sep-2024 18:18:48
Beginning to execute external process for build 'CASA - CMake Master Test Stakeholder Python 3.10 - VLA Stakeholder Tests MPI EL8 Docker #2 (CASA-CMTSP3-STCR85D-2)'
... running command line:
/export/cvpost135-nvme/casa/bamboohome/temp/CASA-CMTSP3-STCR85D-2-ScriptBuildTask-6766493878521615573.sh
... in: /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASA-CMTSP3-STCR85D
17-Sep-2024 18:18:48 /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASA-CMTSP3-STCR85D
17-Sep-2024 18:18:48   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
17-Sep-2024 18:18:48                                  Dload  Upload   Total   Spent    Left  Speed
17-Sep-2024 18:18:48
17-Sep-2024 18:18:48   0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0
17-Sep-2024 18:18:48 100 6002k  100 6002k    0     0  74.2M      0 --:--:-- --:--:-- --:--:-- 74.2M
17-Sep-2024 18:18:48 Components:
17-Sep-2024 18:18:48 Using container name test-container
17-Sep-2024 18:18:48 datapath=[  "/opt/casa/data/casa-data","/opt/casa/data/casatestdata-large"]
17-Sep-2024 18:18:48 measurespath="opt/casa/data/casa-data"
17-Sep-2024 18:18:48 measures_auto_update=False
17-Sep-2024 18:18:48 data_auto_update=False
17-Sep-2024 18:18:48 total 989856
17-Sep-2024 18:18:48 -rw-r--r-- 1 9285 15001 1013609516 Sep 17 18:18 casa-6.7.0-3-py3.10.el8.tar.xz
17-Sep-2024 18:18:48 config.py:
17-Sep-2024 18:18:48 datapath=[  "/opt/casa/data/casa-data","/opt/casa/data/casatestdata-large"]
17-Sep-2024 18:18:48 measurespath="opt/casa/data/casa-data"
17-Sep-2024 18:18:48 measures_auto_update=False
17-Sep-2024 18:18:48 data_auto_update=False
17-Sep-2024 18:18:48 Cloning into 'casa-build-utils'...
17-Sep-2024 18:18:48 Cloning into 'casa6'...
17-Sep-2024 18:18:58 Updating files:  26% (2497/9315)
17-Sep-2024 18:18:58 Updating files:  27% (2516/9315)
17-Sep-2024 18:18:58 Updating files:  28% (2609/9315)
17-Sep-2024 18:18:58 Updating files:  29% (2702/9315)
17-Sep-2024 18:18:58 Updating files:  30% (2795/9315)
17-Sep-2024 18:18:58 Updating files:  31% (2888/9315)
17-Sep-2024 18:18:58 Updating files:  32% (2981/9315)
17-Sep-2024 18:18:58 Updating files:  33% (3074/9315)
17-Sep-2024 18:18:58 Updating files:  34% (3168/9315)
17-Sep-2024 18:18:58 Updating files:  35% (3261/9315)
17-Sep-2024 18:18:58 Updating files:  36% (3354/9315)
17-Sep-2024 18:18:59 Updating files:  37% (3447/9315)
17-Sep-2024 18:18:59 Updating files:  38% (3540/9315)
17-Sep-2024 18:18:59 Updating files:  39% (3633/9315)
17-Sep-2024 18:18:59 Updating files:  40% (3726/9315)
17-Sep-2024 18:18:59 Updating files:  41% (3820/9315)
17-Sep-2024 18:18:59 Updating files:  42% (3913/9315)
17-Sep-2024 18:18:59 Updating files:  43% (4006/9315)
17-Sep-2024 18:18:59 Updating files:  44% (4099/9315)
17-Sep-2024 18:18:59 Updating files:  45% (4192/9315)
17-Sep-2024 18:18:59 Updating files:  46% (4285/9315)
17-Sep-2024 18:18:59 Updating files:  47% (4379/9315)
17-Sep-2024 18:18:59 Updating files:  47% (4458/9315)
17-Sep-2024 18:18:59 Updating files:  48% (4472/9315)
17-Sep-2024 18:18:59 Updating files:  49% (4565/9315)
17-Sep-2024 18:18:59 Updating files:  50% (4658/9315)
17-Sep-2024 18:18:59 Updating files:  51% (4751/9315)
17-Sep-2024 18:18:59 Updating files:  52% (4844/9315)
17-Sep-2024 18:18:59 Updating files:  53% (4937/9315)
17-Sep-2024 18:18:59 Updating files:  54% (5031/9315)
17-Sep-2024 18:18:59 Updating files:  55% (5124/9315)
17-Sep-2024 18:18:59 Updating files:  56% (5217/9315)
17-Sep-2024 18:19:00 Updating files:  57% (5310/9315)
17-Sep-2024 18:19:00 Updating files:  58% (5403/9315)
17-Sep-2024 18:19:00 Updating files:  59% (5496/9315)
17-Sep-2024 18:19:00 Updating files:  60% (5589/9315)
17-Sep-2024 18:19:00 Updating files:  61% (5683/9315)
17-Sep-2024 18:19:00 Updating files:  62% (5776/9315)
17-Sep-2024 18:19:00 Updating files:  63% (5869/9315)
17-Sep-2024 18:19:00 Updating files:  64% (5962/9315)
17-Sep-2024 18:19:00 Updating files:  65% (6055/9315)
17-Sep-2024 18:19:00 Updating files:  66% (6148/9315)
17-Sep-2024 18:19:00 Updating files:  67% (6242/9315)
17-Sep-2024 18:19:00 Updating files:  68% (6335/9315)
17-Sep-2024 18:19:00 Updating files:  68% (6388/9315)
17-Sep-2024 18:19:00 Updating files:  69% (6428/9315)
17-Sep-2024 18:19:00 Updating files:  70% (6521/9315)
17-Sep-2024 18:19:00 Updating files:  71% (6614/9315)
17-Sep-2024 18:19:00 Updating files:  72% (6707/9315)
17-Sep-2024 18:19:00 Updating files:  73% (6800/9315)
17-Sep-2024 18:19:00 Updating files:  74% (6894/9315)
17-Sep-2024 18:19:00 Updating files:  75% (6987/9315)
17-Sep-2024 18:19:00 Updating files:  76% (7080/9315)
17-Sep-2024 18:19:01 Updating files:  77% (7173/9315)
17-Sep-2024 18:19:01 Updating files:  78% (7266/9315)
17-Sep-2024 18:19:01 Updating files:  79% (7359/9315)
17-Sep-2024 18:19:01 Updating files:  80% (7452/9315)
17-Sep-2024 18:19:01 Updating files:  81% (7546/9315)
17-Sep-2024 18:19:01 Updating files:  82% (7639/9315)
17-Sep-2024 18:19:01 Updating files:  83% (7732/9315)
17-Sep-2024 18:19:01 Updating files:  84% (7825/9315)
17-Sep-2024 18:19:01 Updating files:  85% (7918/9315)
17-Sep-2024 18:19:01 Updating files:  86% (8011/9315)
17-Sep-2024 18:19:01 Updating files:  87% (8105/9315)
17-Sep-2024 18:19:01 Updating files:  87% (8150/9315)
17-Sep-2024 18:19:01 Updating files:  88% (8198/9315)
17-Sep-2024 18:19:01 Updating files:  89% (8291/9315)
17-Sep-2024 18:19:01 Updating files:  90% (8384/9315)
17-Sep-2024 18:19:01 Updating files:  91% (8477/9315)
17-Sep-2024 18:19:01 Updating files:  92% (8570/9315)
17-Sep-2024 18:19:01 Updating files:  93% (8663/9315)
17-Sep-2024 18:19:01 Updating files:  94% (8757/9315)
17-Sep-2024 18:19:02 Updating files:  95% (8850/9315)
17-Sep-2024 18:19:02 Updating files:  96% (8943/9315)
17-Sep-2024 18:19:02 Updating files:  97% (9036/9315)
17-Sep-2024 18:19:02 Updating files:  98% (9129/9315)
17-Sep-2024 18:19:02 Updating files:  99% (9222/9315)
17-Sep-2024 18:19:02 Updating files: 100% (9315/9315)
17-Sep-2024 18:19:02 Updating files: 100% (9315/9315), done.
17-Sep-2024 18:19:02 error: pathspec 'origin/CAS-14357' did not match any file(s) known to git
17-Sep-2024 18:19:02 tarfile casa-6.7.0-3-py3.10.el8.tar.xz
17-Sep-2024 18:19:35   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
17-Sep-2024 18:19:35                                  Dload  Upload   Total   Spent    Left  Speed
17-Sep-2024 18:19:35
17-Sep-2024 18:19:35   0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0
17-Sep-2024 18:19:35 100   669    0   669    0     0  37166      0 --:--:-- --:--:-- --:--:-- 37166
17-Sep-2024 18:19:50 HAVE_PYTEST: False
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 Namespace(list=False, verbose=False, dry_run=False, classes=None, file=None, mapfile=None, branch=None, merge_target=None, pkg='/dockershare/casa-6.7.0-3-py3.10.el8.tar.xz', work_dir='/home/casatest/work', ncores='8', test_paths=None, test_list='test_stk_vla_users_continuum_from_SDM', test_config='/home/casatest/casa6/casatestutils/casatestutils/component_to_test_map.json', test_group=None, pmode='parallel', bamboo=True, cachedir=None, ignore_list=None)
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 Operating system: Linux
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 Arguments Sent Direct To Pytest :  []
17-Sep-2024 18:19:50 Package: /dockershare/casa-6.7.0-3-py3.10.el8.tar.xz
17-Sep-2024 18:19:50 Test configuration file: /home/casatest/casa6/casatestutils/casatestutils/component_to_test_map.json
17-Sep-2024 18:19:50 Number of cores: 8
17-Sep-2024 18:19:50 Workdir: /home/casatest/work
17-Sep-2024 18:19:50 branch: None
17-Sep-2024 18:19:50 ---------------     run_bamboo     ---------------
17-Sep-2024 18:19:50 Test list: ['test_stk_vla_users_continuum_from_SDM']
17-Sep-2024 18:19:50 Test group: None
17-Sep-2024 18:19:50 Unpacking tarball: /dockershare/casa-6.7.0-3-py3.10.el8.tar.xz to /home/casatest/work/pkg
17-Sep-2024 18:19:50 ['tar', '-xf', '/dockershare/casa-6.7.0-3-py3.10.el8.tar.xz', '-C', '/home/casatest/work/pkg']
17-Sep-2024 18:19:50 Executing: ['tar', '-xf', '/dockershare/casa-6.7.0-3-py3.10.el8.tar.xz', '-C', '/home/casatest/work/pkg']
17-Sep-2024 18:19:50 Executor result: 0
17-Sep-2024 18:19:50 Failed tests:[]
17-Sep-2024 18:19:50 Outputdir contents:/home/casatest/work/pkg
17-Sep-2024 18:19:50 casa-6.7.0-3-py3.10.el8
17-Sep-2024 18:19:50 installpath: casa-6.7.0-3-py3.10.el8
17-Sep-2024 18:19:50 Package root: /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8
17-Sep-2024 18:19:50 Executable path: /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/bin
17-Sep-2024 18:19:50 Casatestutils Path: /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatestutils/runtest.py
17-Sep-2024 18:19:50 Starting Xvfb
17-Sep-2024 18:19:50 Xvfb :111 -screen 0 2048x2048x24+32 -auth /tmp/CASA_testrunner_xauthl19vf_3g/tmpvjnni1h8
17-Sep-2024 18:19:50 Deployed virtual frame buffer at port :111 with PID 124
17-Sep-2024 18:19:50 run_bamboo fetch_tests branchmaster
17-Sep-2024 18:19:50 Fetching Repository: casa6
17-Sep-2024 18:19:50         Running:  git clone https://open-bitbucket.nrao.edu/scm/casa/casa6
17-Sep-2024 18:19:50 Executing: ['git', 'clone', 'https://open-bitbucket.nrao.edu/scm/casa/casa6']
17-Sep-2024 18:19:50 Cloning into 'casa6'...
17-Sep-2024 18:19:50 Updating files:  26% (2462/9315)
17-Sep-2024 18:19:50 Updating files:  27% (2516/9315)
17-Sep-2024 18:19:50 Updating files:  28% (2609/9315)
17-Sep-2024 18:19:50 Updating files:  29% (2702/9315)
17-Sep-2024 18:19:50 Updating files:  30% (2795/9315)
17-Sep-2024 18:19:50 Updating files:  31% (2888/9315)
17-Sep-2024 18:19:50 Updating files:  32% (2981/9315)
17-Sep-2024 18:19:50 Updating files:  33% (3074/9315)
17-Sep-2024 18:19:50 Updating files:  34% (3168/9315)
17-Sep-2024 18:19:50 Updating files:  35% (3261/9315)
17-Sep-2024 18:19:50 Updating files:  36% (3354/9315)
17-Sep-2024 18:19:50 Updating files:  37% (3447/9315)
17-Sep-2024 18:19:50 Updating files:  38% (3540/9315)
17-Sep-2024 18:19:50 Updating files:  39% (3633/9315)
17-Sep-2024 18:19:50 Updating files:  40% (3726/9315)
17-Sep-2024 18:19:50 Updating files:  41% (3820/9315)
17-Sep-2024 18:19:50 Updating files:  42% (3913/9315)
17-Sep-2024 18:19:50 Updating files:  43% (4006/9315)
17-Sep-2024 18:19:50 Updating files:  44% (4099/9315)
17-Sep-2024 18:19:50 Updating files:  45% (4192/9315)
17-Sep-2024 18:19:50 Updating files:  46% (4285/9315)
17-Sep-2024 18:19:50 Updating files:  47% (4379/9315)
17-Sep-2024 18:19:50 Updating files:  47% (4395/9315)
17-Sep-2024 18:19:50 Updating files:  48% (4472/9315)
17-Sep-2024 18:19:50 Updating files:  49% (4565/9315)
17-Sep-2024 18:19:50 Updating files:  50% (4658/9315)
17-Sep-2024 18:19:50 Updating files:  51% (4751/9315)
17-Sep-2024 18:19:50 Updating files:  52% (4844/9315)
17-Sep-2024 18:19:50 Updating files:  53% (4937/9315)
17-Sep-2024 18:19:50 Updating files:  54% (5031/9315)
17-Sep-2024 18:19:50 Updating files:  55% (5124/9315)
17-Sep-2024 18:19:50 Updating files:  56% (5217/9315)
17-Sep-2024 18:19:50 Updating files:  57% (5310/9315)
17-Sep-2024 18:19:50 Updating files:  58% (5403/9315)
17-Sep-2024 18:19:50 Updating files:  59% (5496/9315)
17-Sep-2024 18:19:50 Updating files:  60% (5589/9315)
17-Sep-2024 18:19:50 Updating files:  61% (5683/9315)
17-Sep-2024 18:19:50 Updating files:  62% (5776/9315)
17-Sep-2024 18:19:50 Updating files:  63% (5869/9315)
17-Sep-2024 18:19:50 Updating files:  64% (5962/9315)
17-Sep-2024 18:19:50 Updating files:  65% (6055/9315)
17-Sep-2024 18:19:50 Updating files:  66% (6148/9315)
17-Sep-2024 18:19:50 Updating files:  67% (6242/9315)
17-Sep-2024 18:19:50 Updating files:  67% (6287/9315)
17-Sep-2024 18:19:50 Updating files:  68% (6335/9315)
17-Sep-2024 18:19:50 Updating files:  69% (6428/9315)
17-Sep-2024 18:19:50 Updating files:  70% (6521/9315)
17-Sep-2024 18:19:50 Updating files:  71% (6614/9315)
17-Sep-2024 18:19:50 Updating files:  72% (6707/9315)
17-Sep-2024 18:19:50 Updating files:  73% (6800/9315)
17-Sep-2024 18:19:50 Updating files:  74% (6894/9315)
17-Sep-2024 18:19:50 Updating files:  75% (6987/9315)
17-Sep-2024 18:19:50 Updating files:  76% (7080/9315)
17-Sep-2024 18:19:50 Updating files:  77% (7173/9315)
17-Sep-2024 18:19:50 Updating files:  78% (7266/9315)
17-Sep-2024 18:19:50 Updating files:  79% (7359/9315)
17-Sep-2024 18:19:50 Updating files:  80% (7452/9315)
17-Sep-2024 18:19:50 Updating files:  81% (7546/9315)
17-Sep-2024 18:19:50 Updating files:  82% (7639/9315)
17-Sep-2024 18:19:50 Updating files:  83% (7732/9315)
17-Sep-2024 18:19:50 Updating files:  84% (7825/9315)
17-Sep-2024 18:19:50 Updating files:  85% (7918/9315)
17-Sep-2024 18:19:50 Updating files:  86% (8011/9315)
17-Sep-2024 18:19:50 Updating files:  86% (8022/9315)
17-Sep-2024 18:19:50 Updating files:  87% (8105/9315)
17-Sep-2024 18:19:50 Updating files:  88% (8198/9315)
17-Sep-2024 18:19:50 Updating files:  89% (8291/9315)
17-Sep-2024 18:19:50 Updating files:  90% (8384/9315)
17-Sep-2024 18:19:50 Updating files:  91% (8477/9315)
17-Sep-2024 18:19:50 Updating files:  92% (8570/9315)
17-Sep-2024 18:19:50 Updating files:  93% (8663/9315)
17-Sep-2024 18:19:50 Updating files:  94% (8757/9315)
17-Sep-2024 18:19:50 Updating files:  95% (8850/9315)
17-Sep-2024 18:19:50 Updating files:  96% (8943/9315)
17-Sep-2024 18:19:50 Updating files:  97% (9036/9315)
17-Sep-2024 18:19:50 Updating files:  98% (9129/9315)
17-Sep-2024 18:19:50 Updating files:  99% (9222/9315)
17-Sep-2024 18:19:50 Updating files: 100% (9315/9315)
17-Sep-2024 18:19:50 Updating files: 100% (9315/9315), done.
17-Sep-2024 18:19:50 Executor result: 0
17-Sep-2024 18:19:50 Failed tests:[]
17-Sep-2024 18:19:50         Running:  git checkout origin/master
17-Sep-2024 18:19:50 Executing: ['git', 'checkout', 'origin/master']
17-Sep-2024 18:19:50 Note: switching to 'origin/master'.
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 You are in 'detached HEAD' state. You can look around, make experimental
17-Sep-2024 18:19:50 changes and commit them, and you can discard any commits you make in this
17-Sep-2024 18:19:50 state without impacting any branches by switching back to a branch.
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 If you want to create a new branch to retain commits you create, you may
17-Sep-2024 18:19:50 do so (now or later) by using -c with the switch command. Example:
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50   git switch -c <new-branch-name>
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 Or undo this operation with:
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50   git switch -
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 Turn off this advice by setting config variable advice.detachedHead to false
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 HEAD is now at 73c121f99c Pull request #863: CAS-9957
17-Sep-2024 18:19:50 Executor result: 0
17-Sep-2024 18:19:50 Failed tests:[]
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 Fetching Repository: casampi
17-Sep-2024 18:19:50         Running:  git clone https://open-bitbucket.nrao.edu/scm/casa/casampi
17-Sep-2024 18:19:50 Executing: ['git', 'clone', 'https://open-bitbucket.nrao.edu/scm/casa/casampi']
17-Sep-2024 18:19:50 Cloning into 'casampi'...
17-Sep-2024 18:19:50 Executor result: 0
17-Sep-2024 18:19:50 Failed tests:[]
17-Sep-2024 18:19:50         Tag: tags/0.5.5
17-Sep-2024 18:19:50         Running:  git checkout tags/0.5.5
17-Sep-2024 18:19:50 Executing: ['git', 'checkout', 'tags/0.5.5']
17-Sep-2024 18:19:50 Note: switching to 'tags/0.5.5'.
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 You are in 'detached HEAD' state. You can look around, make experimental
17-Sep-2024 18:19:50 changes and commit them, and you can discard any commits you make in this
17-Sep-2024 18:19:50 state without impacting any branches by switching back to a branch.
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 If you want to create a new branch to retain commits you create, you may
17-Sep-2024 18:19:50 do so (now or later) by using -c with the switch command. Example:
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50   git switch -c <new-branch-name>
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 Or undo this operation with:
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50   git switch -
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 Turn off this advice by setting config variable advice.detachedHead to false
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 HEAD is now at aebe7c9 Pull request #14: Change aips2-request@nrao.edu to casa-feedback@nrao.edu
17-Sep-2024 18:19:50 Executor result: 0
17-Sep-2024 18:19:50 Failed tests:[]
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 Fetching Repository: casaplotms
17-Sep-2024 18:19:50         Running:  git clone https://open-bitbucket.nrao.edu/scm/casa/casaplotms
17-Sep-2024 18:19:50 Executing: ['git', 'clone', 'https://open-bitbucket.nrao.edu/scm/casa/casaplotms']
17-Sep-2024 18:19:50 Cloning into 'casaplotms'...
17-Sep-2024 18:19:50 Executor result: 0
17-Sep-2024 18:19:50 Failed tests:[]
17-Sep-2024 18:19:50         Tag: tags/2.5.2
17-Sep-2024 18:19:50         Running:  git checkout tags/2.5.2
17-Sep-2024 18:19:50 Executing: ['git', 'checkout', 'tags/2.5.2']
17-Sep-2024 18:19:50 Note: switching to 'tags/2.5.2'.
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 You are in 'detached HEAD' state. You can look around, make experimental
17-Sep-2024 18:19:50 changes and commit them, and you can discard any commits you make in this
17-Sep-2024 18:19:50 state without impacting any branches by switching back to a branch.
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 If you want to create a new branch to retain commits you create, you may
17-Sep-2024 18:19:50 do so (now or later) by using -c with the switch command. Example:
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50   git switch -c <new-branch-name>
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 Or undo this operation with:
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50   git switch -
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 Turn off this advice by setting config variable advice.detachedHead to false
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 HEAD is now at 94e0f52 Pull request #86: CAS-14309
17-Sep-2024 18:19:50 Executor result: 0
17-Sep-2024 18:19:50 Failed tests:[]
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 Fetching Repository: casaviewer
17-Sep-2024 18:19:50         Running:  git clone https://open-bitbucket.nrao.edu/scm/casa/casaviewer
17-Sep-2024 18:19:50 Executing: ['git', 'clone', 'https://open-bitbucket.nrao.edu/scm/casa/casaviewer']
17-Sep-2024 18:19:50 Cloning into 'casaviewer'...
17-Sep-2024 18:19:50 Executor result: 0
17-Sep-2024 18:19:50 Failed tests:[]
17-Sep-2024 18:19:50         Tag: tags/2.2.3
17-Sep-2024 18:19:50         Running:  git checkout tags/2.2.3
17-Sep-2024 18:19:50 Executing: ['git', 'checkout', 'tags/2.2.3']
17-Sep-2024 18:19:50 Note: switching to 'tags/2.2.3'.
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 You are in 'detached HEAD' state. You can look around, make experimental
17-Sep-2024 18:19:50 changes and commit them, and you can discard any commits you make in this
17-Sep-2024 18:19:50 state without impacting any branches by switching back to a branch.
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 If you want to create a new branch to retain commits you create, you may
17-Sep-2024 18:19:50 do so (now or later) by using -c with the switch command. Example:
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50   git switch -c <new-branch-name>
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50 Or undo this operation with:
17-Sep-2024 18:19:50
17-Sep-2024 18:19:50   git switch -
17-Sep-2024 18:19:50
17-Sep-2024 18:19:53 Turn off this advice by setting config variable advice.detachedHead to false
17-Sep-2024 18:19:53
17-Sep-2024 18:19:53 HEAD is now at 24d91fe Pull request #47: CAS-14309
17-Sep-2024 18:19:53 Executor result: 0
17-Sep-2024 18:19:53 Failed tests:[]
17-Sep-2024 18:19:53 Reading config from: /home/casatest/casa6/casatestutils/casatestutils/component_to_test_map.json
17-Sep-2024 18:19:53 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//casaviewer/tests/tasks']
17-Sep-2024 18:19:53 Test list provided. Filtering tests.
17-Sep-2024 18:19:53 Subset tests:
17-Sep-2024 18:19:53 test_stk_vla_users_continuum_from_SDM
17-Sep-2024 18:19:53 Running test: test_stk_vla_users_continuum_from_SDM in MPI mode
17-Sep-2024 18:19:53 Running cmd ['/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/bin/mpicasa', '-n', '8', '/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/bin/casa', '--nogui', '--nologger', '--log2term', '--agg', '-c', '/home/casatest/work/casasources//casa6/casatests/stakeholder/test_stk_vla_users_continuum_from_SDM.py']in /home/casatest/work/test_stk_vla_users_continuum_from_SDM
17-Sep-2024 18:19:53 Executing: ['/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/bin/mpicasa', '-n', '8', '/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/bin/casa', '--nogui', '--nologger', '--log2term', '--agg', '-c', '/home/casatest/work/casasources//casa6/casatests/stakeholder/test_stk_vla_users_continuum_from_SDM.py']
17-Sep-2024 18:19:53
17-Sep-2024 18:19:53 Using user configuration file /home/casatest/.casa/config.py
17-Sep-2024 18:19:53
17-Sep-2024 18:19:53 Using user configuration file /home/casatest/.casa/config.py
17-Sep-2024 18:19:53
17-Sep-2024 18:19:53 Using user configuration file /home/casatest/.casa/config.py
17-Sep-2024 18:19:53
17-Sep-2024 18:19:53 Using user configuration file /home/casatest/.casa/config.py
17-Sep-2024 18:19:53
17-Sep-2024 18:19:53 Using user configuration file /home/casatest/.casa/config.py
17-Sep-2024 18:19:53
17-Sep-2024 18:19:53 Using user configuration file /home/casatest/.casa/config.py
17-Sep-2024 18:19:53
17-Sep-2024 18:19:53 Using user configuration file /home/casatest/.casa/config.py
17-Sep-2024 18:19:53
17-Sep-2024 18:19:53 Using user configuration file /home/casatest/.casa/config.py
17-Sep-2024 18:19:53
17-Sep-2024 18:19:53
17-Sep-2024 18:19:53
17-Sep-2024 18:19:53
17-Sep-2024 18:19:53
17-Sep-2024 18:19:53
17-Sep-2024 18:19:53
17-Sep-2024 18:19:53
17-Sep-2024 18:19:53 No event loop hook running.
17-Sep-2024 18:19:53 No event loop hook running.
17-Sep-2024 18:19:53 No event loop hook running.
17-Sep-2024 18:19:53 No event loop hook running.
17-Sep-2024 18:19:53 No event loop hook running.
17-Sep-2024 18:19:53 No event loop hook running.
17-Sep-2024 18:19:53 No event loop hook running.
17-Sep-2024 18:19:53 No event loop hook running.
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-7        
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-7        The expected casa data was not found at measurespath. CASA may still work if the data can be found in datapath.
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-7        The expected measures data was not found at measurespath. CASA may still work if the data can be found in datapath.
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-7        visit https://casadocs.readthedocs.io/en/stable/notebooks/external-data.html for more information
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-7        
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa        
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa        The expected casa data was not found at measurespath. CASA may still work if the data can be found in datapath.
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa        The expected measures data was not found at measurespath. CASA may still work if the data can be found in datapath.
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa        visit https://casadocs.readthedocs.io/en/stable/notebooks/external-data.html for more information
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa        
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-2        
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-2        The expected casa data was not found at measurespath. CASA may still work if the data can be found in datapath.
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-2        The expected measures data was not found at measurespath. CASA may still work if the data can be found in datapath.
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-2        visit https://casadocs.readthedocs.io/en/stable/notebooks/external-data.html for more information
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-2        
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-6        
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-6        The expected casa data was not found at measurespath. CASA may still work if the data can be found in datapath.
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-6        The expected measures data was not found at measurespath. CASA may still work if the data can be found in datapath.
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-6        visit https://casadocs.readthedocs.io/en/stable/notebooks/external-data.html for more information
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-6        
17-Sep-2024 18:19:53 Using location of IERSeop2000 table found in datapath for measurespath /opt/casa/data/casa-data
17-Sep-2024 18:19:53 Using location of IERSeop2000 table found in datapath for measurespath /opt/casa/data/casa-data
17-Sep-2024 18:19:53 Using location of IERSeop2000 table found in datapath for measurespath /opt/casa/data/casa-data
17-Sep-2024 18:19:53 Using location of IERSeop2000 table found in datapath for measurespath /opt/casa/data/casa-data
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-5        
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-5        The expected casa data was not found at measurespath. CASA may still work if the data can be found in datapath.
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-5        The expected measures data was not found at measurespath. CASA may still work if the data can be found in datapath.
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-5        visit https://casadocs.readthedocs.io/en/stable/notebooks/external-data.html for more information
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-5        
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-1        
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-1        The expected casa data was not found at measurespath. CASA may still work if the data can be found in datapath.
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-1        The expected measures data was not found at measurespath. CASA may still work if the data can be found in datapath.
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-1        visit https://casadocs.readthedocs.io/en/stable/notebooks/external-data.html for more information
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-1        
17-Sep-2024 18:19:53 Using location of IERSeop2000 table found in datapath for measurespath /opt/casa/data/casa-data
17-Sep-2024 18:19:53 Using location of IERSeop2000 table found in datapath for measurespath /opt/casa/data/casa-data
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-3        
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-3        The expected casa data was not found at measurespath. CASA may still work if the data can be found in datapath.
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-3        The expected measures data was not found at measurespath. CASA may still work if the data can be found in datapath.
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-3        visit https://casadocs.readthedocs.io/en/stable/notebooks/external-data.html for more information
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-3        
17-Sep-2024 18:19:53 Using location of IERSeop2000 table found in datapath for measurespath /opt/casa/data/casa-data
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-4        
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-4        The expected casa data was not found at measurespath. CASA may still work if the data can be found in datapath.
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-4        The expected measures data was not found at measurespath. CASA may still work if the data can be found in datapath.
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-4        visit https://casadocs.readthedocs.io/en/stable/notebooks/external-data.html for more information
17-Sep-2024 18:19:53 2024-09-17 18:19:53        SEVERE        ::casa::MPIServer-4        
17-Sep-2024 18:19:53 Using location of IERSeop2000 table found in datapath for measurespath /opt/casa/data/casa-data
17-Sep-2024 18:19:53 CASA 6.7.0.3 -- Common Astronomy Software Applications [6.7.0.3]
17-Sep-2024 18:19:53 2024-09-17 18:19:54        INFO        ::casa        Using user configuration file /home/casatest/.casa/config.py
17-Sep-2024 18:19:53 2024-09-17 18:19:54        INFO        ::casa        loaded config file : /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casaconfig/config.py
17-Sep-2024 18:19:53 2024-09-17 18:19:54        INFO        ::casa        loaded config file : /home/casatest/.casa/config.py
17-Sep-2024 18:19:53 2024-09-17 18:19:54        INFO        ::casa        
17-Sep-2024 18:19:53 2024-09-17 18:19:54        INFO        ::casa        config values
17-Sep-2024 18:19:53 2024-09-17 18:19:54        INFO        ::casa            agg = True
17-Sep-2024 18:19:53 2024-09-17 18:19:54        INFO        ::casa            cachedir = '/home/casatest/.casa'
17-Sep-2024 18:19:53 2024-09-17 18:19:54        INFO        ::casa            casaconfig_verbose = 1
17-Sep-2024 18:19:53 2024-09-17 18:19:54        INFO        ::casa            colors = 'Neutral'
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa            data_auto_update = False
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa            datapath = ['/opt/casa/data/casa-data', '/opt/casa/data/casatestdata-large']
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa            iplog = False
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa            iplogfile = '/home/casatest/work/test_stk_vla_users_continuum_from_SDM/ipython-20240917-181951.log'
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa            log2term = True
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa            logfile = '/home/casatest/work/test_stk_vla_users_continuum_from_SDM/casa-20240917-181950.log'
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa            measures_auto_update = False
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa            measurespath = '/home/casatest/work/test_stk_vla_users_continuum_from_SDM/opt/casa/data/casa-data'
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa            nogui = True
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa            nologfile = False
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa            nologger = True
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa            pipeline = False
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa            startupfile = '/home/casatest/.casa/startup.py'
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa            user_site = False
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa        
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa        casarundata version is unknown, this is probably a legacy version not installed by casaconfig
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa        measures version is unknown, this is probably a legacy version not installed by casaconfig
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa        
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa        Checking Measures tables in data repository sub-directory /opt/casa/data/casa-data/geodetic
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa          IERSeop2000 (version date, last date in table (UTC)): 2024/03/09/15:00, 2024/02/08/00:00:00
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa          IERSeop97 (version date, last date in table (UTC)): 2024/03/09/15:00, 2024/02/08/00:00:00
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa          IERSpredict (version date, last date in table (UTC)): 2024/03/22/15:00, 2024/06/20/00:00:00
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa          TAI_UTC (version date, last date in table (UTC)): 2024/03/21/15:00, 2017/01/01/00:00:00
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        ::casa        MPI is enabled. Will run in parallel using Multi-MS for calibration and tclean
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        importasdm::::casa        ##########################################
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        importasdm::::casa        ##### Begin Task: importasdm         #####
17-Sep-2024 18:24:49 2024-09-17 18:19:54        INFO        importasdm::::casa        importasdm( asdm='TDEM0001_sb1218006_1.55310.33439732639', vis='TDEM0001_sb1218006_1.55310.33439732639.ms', createmms=True, separationaxis='auto', numsubms='auto', corr_mode='all', srt='all', time_sampling='all', ocorr_mode='co', compression=False, lazy=False, asis='Receiver CalAtmosphere', wvr_corrected_data='no', scans='', ignore_time=False, process_syspower=True, process_caldevice=True, process_pointing=True, process_flags=True, tbuff=0.0, applyflags=False, savecmds=True, outfile='TDEM0001_sb1218006_1.55310.33439732639.flagonline.txt', flagbackup=True, verbose=False, overwrite=False, bdfflags=False, with_pointing_correction=True, convert_ephem2geo=True, polyephem_tabtimestep=0.0 )
17-Sep-2024 18:24:49 2024-09-17 18:19:55        SEVERE        importasdm::MeasTable::dUTC(Double) (file /source/casa6/casatools/casacore/measures/Measures/MeasTable.cc, line 4290)        Leap second table TAI_UTC seems out-of-date.
17-Sep-2024 18:24:49 2024-09-17 18:19:55        SEVERE        importasdm::MeasTable::dUTC(Double) (file /source/casa6/casatools/casacore/measures/Measures/MeasTable.cc, line 4290)+        Until the table is updated (see the CASA documentation or your system admin),
17-Sep-2024 18:24:49 2024-09-17 18:19:55        SEVERE        importasdm::MeasTable::dUTC(Double) (file /source/casa6/casatools/casacore/measures/Measures/MeasTable.cc, line 4290)+        times and coordinates derived from UTC could be wrong by 1s or more.
17-Sep-2024 18:24:49 2024-09-17 18:23:44        INFO        importasdm::::casa        No ephemerides attached.
17-Sep-2024 18:24:49 2024-09-17 18:23:44        INFO        importasdm::::casa        Will create a Multi-MS for: TDEM0001_sb1218006_1.55310.33439732639.ms
17-Sep-2024 18:24:49 2024-09-17 18:23:45        INFO        ParallelDataHelper::::casa        Analyzing MS for partitioning
17-Sep-2024 18:24:49 2024-09-17 18:23:45        INFO        ParallelDataHelper::::casa        Automatically distribute the scan/spw pairs to balance the load along field, spw and scan axes
17-Sep-2024 18:24:49 2024-09-17 18:23:52        INFO        msmetadata_cmpt.cc::open        Performing internal consistency checks on /home/casatest/work/test_stk_vla_users_continuum_from_SDM/TDEM0001_sb1218006_1.55310.33439732639.ms.temp.ms...
17-Sep-2024 18:24:49 2024-09-17 18:24:22        INFO        ParallelDataHelper::::casa        Finalizing MMS structure
17-Sep-2024 18:24:49 2024-09-17 18:24:22        INFO        ms::createmultims        Copying subtables from /home/casatest/work/test_stk_vla_users_continuum_from_SDM/TDEM0001_sb1218006_1.55310.33439732639.ms.data/TDEM0001_sb1218006_1.55310.33439732639.ms.0000.ms to the other MMS members.
17-Sep-2024 18:24:49 2024-09-17 18:24:31        INFO        importasdm::AgentFlagger::open        Table type is Measurement Set
17-Sep-2024 18:24:49 2024-09-17 18:24:31        INFO        importasdm::FlagVersion::saveFlagVersion        Creating new backup flag file called Original
17-Sep-2024 18:24:49 2024-09-17 18:24:43        INFO        importasdm::::casa        Found Flag.xml in SDM
17-Sep-2024 18:24:49 2024-09-17 18:24:43        INFO        importasdm::::casa        Found Antenna.xml in SDM
17-Sep-2024 18:24:49 2024-09-17 18:24:43        INFO        importasdm::::casa        Found SpectralWindow.xml in SDM
17-Sep-2024 18:24:49 2024-09-17 18:24:43        INFO        importasdm::::casa        Found 26 rows in Antenna.xml
17-Sep-2024 18:24:49 2024-09-17 18:24:43        INFO        importasdm::::casa        Found 2 rows in SpectralWindow.xml
17-Sep-2024 18:24:49 2024-09-17 18:24:43        INFO        importasdm::::casa        Will construct spw flags using names
17-Sep-2024 18:24:49 2024-09-17 18:24:43        INFO        importasdm::::casa        Will construct polarization flags using polarizationType
17-Sep-2024 18:24:49 2024-09-17 18:24:43        INFO        importasdm::::casa        No numAntenna entry found, must be an old style SDM
17-Sep-2024 18:24:49 2024-09-17 18:24:43        INFO        importasdm::::casa        Found 1436 flags in Flag.xml
17-Sep-2024 18:24:49 2024-09-17 18:24:43        INFO        importasdm::::casa        Will not apply flags to TDEM0001_sb1218006_1.55310.33439732639.ms (apply_flags=False), use flagcmd to apply
17-Sep-2024 18:24:49 2024-09-17 18:24:43        INFO        importasdm::::casa        There are 0 rows already in FLAG_CMD
17-Sep-2024 18:24:49 2024-09-17 18:24:43        INFO        importasdm::::casa        Saved 1436 rows to FLAG_CMD of TDEM0001_sb1218006_1.55310.33439732639.ms
17-Sep-2024 18:24:49 2024-09-17 18:24:44        INFO        importasdm::::casa        Saved 1436 flag commands to TDEM0001_sb1218006_1.55310.33439732639.flagonline.txt
17-Sep-2024 18:24:49 2024-09-17 18:24:44        INFO        importasdm::::casa        Task importasdm complete. Start time: 2024-09-17 18:19:53.804924 End time: 2024-09-17 18:24:43.577131
17-Sep-2024 18:24:49 2024-09-17 18:24:44        INFO        importasdm::::casa        ##### End Task: importasdm           #####
17-Sep-2024 18:24:49 2024-09-17 18:24:44        INFO        importasdm::::casa        ##########################################
17-Sep-2024 18:24:49 2024-09-17 18:24:44        INFO        flagdata::::casa        ##########################################
17-Sep-2024 18:24:49 2024-09-17 18:24:44        INFO        flagdata::::casa        ##### Begin Task: flagdata           #####
17-Sep-2024 18:24:49 2024-09-17 18:24:44        INFO        flagdata::::casa        flagdata( vis='TDEM0001_sb1218006_1.55310.33439732639.ms', mode='list', autocorr=False, inpfile='TDEM0001_sb1218006_1.55310.33439732639.flagonline.txt', reason='any', tbuff=0.0, spw='', 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=False, savepars=False, cmdreason='', outfile='', overwrite=True, writeflags=True )
17-Sep-2024 18:24:49 2024-09-17 18:24:50        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:24:49 2024-09-17 18:24:50        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:24:49 2024-09-17 18:24:50        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:08 2024-09-17 18:24:50        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:08 2024-09-17 18:24:50        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:08 2024-09-17 18:24:50        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:08 2024-09-17 18:24:50        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:08 2024-09-17 18:24:50        INFO        flagdata::::casa        Task flagdata complete. Start time: 2024-09-17 18:24:43.768243 End time: 2024-09-17 18:24:49.599950
17-Sep-2024 18:26:08 2024-09-17 18:24:50        INFO        flagdata::::casa        ##### End Task: flagdata             #####
17-Sep-2024 18:26:08 2024-09-17 18:24:50        INFO        flagdata::::casa        ##########################################
17-Sep-2024 18:26:08 2024-09-17 18:24:50        INFO        flagdata::::casa        ##########################################
17-Sep-2024 18:26:08 2024-09-17 18:24:50        INFO        flagdata::::casa        ##### Begin Task: flagdata           #####
17-Sep-2024 18:26:08 2024-09-17 18:24:50        INFO        flagdata::::casa        flagdata( vis='TDEM0001_sb1218006_1.55310.33439732639.ms', mode='clip', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='', field='', antenna='', uvrange='', timerange='', correlation='', scan='', intent='', array='', observation='', feed='', clipminmax=[], datacolumn='DATA', clipoutside=True, channelavg=False, chanbin=1, timeavg=False, timebin='0s', clipzeros=True, 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=False, savepars=False, cmdreason='', outfile='', overwrite=True, writeflags=True )
17-Sep-2024 18:26:08 2024-09-17 18:25:31        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:08 2024-09-17 18:25:31        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:08 2024-09-17 18:25:31        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:08 2024-09-17 18:25:31        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:08 2024-09-17 18:25:31        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:08 2024-09-17 18:25:31        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:08 2024-09-17 18:25:31        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:08 2024-09-17 18:25:31        INFO        flagdata::::casa        Task flagdata complete. Start time: 2024-09-17 18:24:49.608218 End time: 2024-09-17 18:25:31.125972
17-Sep-2024 18:26:08 2024-09-17 18:25:31        INFO        flagdata::::casa        ##### End Task: flagdata             #####
17-Sep-2024 18:26:08 2024-09-17 18:25:31        INFO        flagdata::::casa        ##########################################
17-Sep-2024 18:26:08 2024-09-17 18:25:31        INFO        flagdata::::casa        ##########################################
17-Sep-2024 18:26:08 2024-09-17 18:25:31        INFO        flagdata::::casa        ##### Begin Task: flagdata           #####
17-Sep-2024 18:26:08 2024-09-17 18:25:31        INFO        flagdata::::casa        flagdata( vis='TDEM0001_sb1218006_1.55310.33439732639.ms', mode='shadow', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='', 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=False, savepars=False, cmdreason='', outfile='', overwrite=True, writeflags=True )
17-Sep-2024 18:26:08 2024-09-17 18:25:37        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:08 2024-09-17 18:25:37        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:08 2024-09-17 18:25:37        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:08 2024-09-17 18:25:37        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:08 2024-09-17 18:25:37        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:08 2024-09-17 18:25:37        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:08 2024-09-17 18:25:37        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:08 2024-09-17 18:25:37        INFO        flagdata::::casa        Task flagdata complete. Start time: 2024-09-17 18:25:31.133907 End time: 2024-09-17 18:25:36.684857
17-Sep-2024 18:26:08 2024-09-17 18:25:37        INFO        flagdata::::casa        ##### End Task: flagdata             #####
17-Sep-2024 18:26:08 2024-09-17 18:25:37        INFO        flagdata::::casa        ##########################################
17-Sep-2024 18:26:08 2024-09-17 18:25:37        INFO        split::::casa        ##########################################
17-Sep-2024 18:26:08 2024-09-17 18:25:37        INFO        split::::casa        ##### Begin Task: split              #####
17-Sep-2024 18:26:08 2024-09-17 18:25:37        INFO        split::::casa        split( vis='TDEM0001_sb1218006_1.55310.33439732639.ms', outputvis='3c391_ctm_mosaic_10s_spw0.ms', keepmms=True, field='', spw='0', scan='', antenna='', correlation='', timerange='', intent='', array='', uvrange='', observation='', feed='', datacolumn='DATA', keepflags=False, width=1, timebin='10s', combine='' )
17-Sep-2024 18:26:08 2024-09-17 18:25:37        INFO        ParallelDataHelper::::casa        Analyzing MS for partitioning
17-Sep-2024 18:26:08 2024-09-17 18:25:37        INFO        ParallelDataHelper::::casa        Input vis is a Multi-MS
17-Sep-2024 18:26:08 2024-09-17 18:26:03        INFO        ParallelDataHelper::::casa        Finalizing MMS structure
17-Sep-2024 18:26:08 2024-09-17 18:26:03        INFO        ms::createmultims        Copying subtables from /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_mosaic_10s_spw0.ms.data/3c391_ctm_mosaic_10s_spw0.ms.0000.ms to the other MMS members.
17-Sep-2024 18:26:08 2024-09-17 18:26:09        INFO        split::::casa        Task split complete. Start time: 2024-09-17 18:25:36.692655 End time: 2024-09-17 18:26:08.530982
17-Sep-2024 18:26:08 2024-09-17 18:26:09        INFO        split::::casa        ##### End Task: split                #####
17-Sep-2024 18:26:08 2024-09-17 18:26:09        INFO        split::::casa        ##########################################
17-Sep-2024 18:26:08 2024-09-17 18:26:09        INFO        flagdata::::casa        ##########################################
17-Sep-2024 18:26:08 2024-09-17 18:26:09        INFO        flagdata::::casa        ##### Begin Task: flagdata           #####
17-Sep-2024 18:26:09 2024-09-17 18:26:09        INFO        flagdata::::casa        flagdata( vis='3c391_ctm_mosaic_10s_spw0.ms', mode='manual', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='', field='', antenna='', uvrange='', timerange='', correlation='', scan='1', 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 )
17-Sep-2024 18:26:09 2024-09-17 18:26:09        INFO        flagdata::::casa        Backup original flags before applying new flags
17-Sep-2024 18:26:09 2024-09-17 18:26:09        INFO        AgentFlagger::open        Table type is Measurement Set
17-Sep-2024 18:26:09 2024-09-17 18:26:09        INFO        FlagVersion::saveFlagVersion        Creating new backup flag file called flagdata_1
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa        Command request with id 38 failed in server n# 5 with traceback Traceback (most recent call last):
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casampi/private/MPICommandServer.py", line 208, in __command_request_handler_service
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            command_response['ret'] = eval(eval_str)
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "<string>", line 1, in <module>
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/flagdata.py", line 1136, in __call__
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            task_result = _flagdata_t( _pc.document['vis'], _pc.document['mode'], _pc.document['autocorr'], _pc.document['inpfile'], _pc.document['reason'], _pc.document['tbuff'], _pc.document['spw'], _pc.document['field'], _pc.document['antenna'], _pc.document['uvrange'], _pc.document['timerange'], _pc.document['correlation'], _pc.document['scan'], _pc.document['intent'], _pc.document['array'], _pc.document['observation'], _pc.document['feed'], _pc.document['clipminmax'], _pc.document['datacolumn'], _pc.document['clipoutside'], _pc.document['channelavg'], _pc.document['chanbin'], _pc.document['timeavg'], _pc.document['timebin'], _pc.document['clipzeros'], _pc.document['quackinterval'], _pc.document['quackmode'], _pc.document['quackincrement'], _pc.document['tolerance'], _pc.document['addantenna'], _pc.document['lowerlimit'], _pc.document['upperlimit'], _pc.document['ntime'], _pc.document['combinescans'], _pc.document['timecutoff'], _pc.document['freqcutoff'], _pc.document['timefit'], _pc.document['freqfit'], _pc.document['maxnpieces'], _pc.document['flagdimension'], _pc.document['usewindowstats'], _pc.document['halfwin'], _pc.document['extendflags'], _pc.document['winsize'], _pc.document['timedev'], _pc.document['freqdev'], _pc.document['timedevscale'], _pc.document['freqdevscale'], _pc.document['spectralmax'], _pc.document['spectralmin'], _pc.document['antint_ref_antenna'], _pc.document['minchanfrac'], _pc.document['verbose'], _pc.document['extendpols'], _pc.document['growtime'], _pc.document['growfreq'], _pc.document['growaround'], _pc.document['flagneartime'], _pc.document['flagnearfreq'], _pc.document['minrel'], _pc.document['maxrel'], _pc.document['minabs'], _pc.document['maxabs'], _pc.document['spwchan'], _pc.document['spwcorr'], _pc.document['basecnt'], _pc.document['fieldcnt'], _pc.document['name'], _pc.document['action'], _pc.document['display'], _pc.document['flagbackup'], _pc.document['savepars'], _pc.document['cmdreason'], _pc.document['outfile'], _pc.document['overwrite'], _pc.document['writeflags'] )
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/private/task_flagdata.py", line 618, in flagdata
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            aflocal.selectdata(field=field, spw=spw, array=array, feed=feed, scan=scan, \
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/agentflagger.py", line 36, in selectdata
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return self._swigobj.selectdata(config, field, spw, array, feed, scan, antenna, uvrange, timerange, correlation, intent, observation)
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/agentflagger.py", line 197, in selectdata
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return _agentflagger.agentflagger_selectdata(self, *args, **kwargs)
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+        RuntimeError: MSSelectionNullSelection : The selected table has zero rows.
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa        Command request with id 36 failed in server n# 7 with traceback Traceback (most recent call last):
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casampi/private/MPICommandServer.py", line 208, in __command_request_handler_service
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            command_response['ret'] = eval(eval_str)
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "<string>", line 1, in <module>
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/flagdata.py", line 1136, in __call__
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            task_result = _flagdata_t( _pc.document['vis'], _pc.document['mode'], _pc.document['autocorr'], _pc.document['inpfile'], _pc.document['reason'], _pc.document['tbuff'], _pc.document['spw'], _pc.document['field'], _pc.document['antenna'], _pc.document['uvrange'], _pc.document['timerange'], _pc.document['correlation'], _pc.document['scan'], _pc.document['intent'], _pc.document['array'], _pc.document['observation'], _pc.document['feed'], _pc.document['clipminmax'], _pc.document['datacolumn'], _pc.document['clipoutside'], _pc.document['channelavg'], _pc.document['chanbin'], _pc.document['timeavg'], _pc.document['timebin'], _pc.document['clipzeros'], _pc.document['quackinterval'], _pc.document['quackmode'], _pc.document['quackincrement'], _pc.document['tolerance'], _pc.document['addantenna'], _pc.document['lowerlimit'], _pc.document['upperlimit'], _pc.document['ntime'], _pc.document['combinescans'], _pc.document['timecutoff'], _pc.document['freqcutoff'], _pc.document['timefit'], _pc.document['freqfit'], _pc.document['maxnpieces'], _pc.document['flagdimension'], _pc.document['usewindowstats'], _pc.document['halfwin'], _pc.document['extendflags'], _pc.document['winsize'], _pc.document['timedev'], _pc.document['freqdev'], _pc.document['timedevscale'], _pc.document['freqdevscale'], _pc.document['spectralmax'], _pc.document['spectralmin'], _pc.document['antint_ref_antenna'], _pc.document['minchanfrac'], _pc.document['verbose'], _pc.document['extendpols'], _pc.document['growtime'], _pc.document['growfreq'], _pc.document['growaround'], _pc.document['flagneartime'], _pc.document['flagnearfreq'], _pc.document['minrel'], _pc.document['maxrel'], _pc.document['minabs'], _pc.document['maxabs'], _pc.document['spwchan'], _pc.document['spwcorr'], _pc.document['basecnt'], _pc.document['fieldcnt'], _pc.document['name'], _pc.document['action'], _pc.document['display'], _pc.document['flagbackup'], _pc.document['savepars'], _pc.document['cmdreason'], _pc.document['outfile'], _pc.document['overwrite'], _pc.document['writeflags'] )
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/private/task_flagdata.py", line 618, in flagdata
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            aflocal.selectdata(field=field, spw=spw, array=array, feed=feed, scan=scan, \
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/agentflagger.py", line 36, in selectdata
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return self._swigobj.selectdata(config, field, spw, array, feed, scan, antenna, uvrange, timerange, correlation, intent, observation)
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/agentflagger.py", line 197, in selectdata
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return _agentflagger.agentflagger_selectdata(self, *args, **kwargs)
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+        RuntimeError: MSSelectionNullSelection : The selected table has zero rows.
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa        Command request with id 41 failed in server n# 2 with traceback Traceback (most recent call last):
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casampi/private/MPICommandServer.py", line 208, in __command_request_handler_service
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            command_response['ret'] = eval(eval_str)
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "<string>", line 1, in <module>
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/flagdata.py", line 1136, in __call__
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            task_result = _flagdata_t( _pc.document['vis'], _pc.document['mode'], _pc.document['autocorr'], _pc.document['inpfile'], _pc.document['reason'], _pc.document['tbuff'], _pc.document['spw'], _pc.document['field'], _pc.document['antenna'], _pc.document['uvrange'], _pc.document['timerange'], _pc.document['correlation'], _pc.document['scan'], _pc.document['intent'], _pc.document['array'], _pc.document['observation'], _pc.document['feed'], _pc.document['clipminmax'], _pc.document['datacolumn'], _pc.document['clipoutside'], _pc.document['channelavg'], _pc.document['chanbin'], _pc.document['timeavg'], _pc.document['timebin'], _pc.document['clipzeros'], _pc.document['quackinterval'], _pc.document['quackmode'], _pc.document['quackincrement'], _pc.document['tolerance'], _pc.document['addantenna'], _pc.document['lowerlimit'], _pc.document['upperlimit'], _pc.document['ntime'], _pc.document['combinescans'], _pc.document['timecutoff'], _pc.document['freqcutoff'], _pc.document['timefit'], _pc.document['freqfit'], _pc.document['maxnpieces'], _pc.document['flagdimension'], _pc.document['usewindowstats'], _pc.document['halfwin'], _pc.document['extendflags'], _pc.document['winsize'], _pc.document['timedev'], _pc.document['freqdev'], _pc.document['timedevscale'], _pc.document['freqdevscale'], _pc.document['spectralmax'], _pc.document['spectralmin'], _pc.document['antint_ref_antenna'], _pc.document['minchanfrac'], _pc.document['verbose'], _pc.document['extendpols'], _pc.document['growtime'], _pc.document['growfreq'], _pc.document['growaround'], _pc.document['flagneartime'], _pc.document['flagnearfreq'], _pc.document['minrel'], _pc.document['maxrel'], _pc.document['minabs'], _pc.document['maxabs'], _pc.document['spwchan'], _pc.document['spwcorr'], _pc.document['basecnt'], _pc.document['fieldcnt'], _pc.document['name'], _pc.document['action'], _pc.document['display'], _pc.document['flagbackup'], _pc.document['savepars'], _pc.document['cmdreason'], _pc.document['outfile'], _pc.document['overwrite'], _pc.document['writeflags'] )
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/private/task_flagdata.py", line 618, in flagdata
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            aflocal.selectdata(field=field, spw=spw, array=array, feed=feed, scan=scan, \
17-Sep-2024 18:26:09 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/agentflagger.py", line 36, in selectdata
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return self._swigobj.selectdata(config, field, spw, array, feed, scan, antenna, uvrange, timerange, correlation, intent, observation)
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/agentflagger.py", line 197, in selectdata
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return _agentflagger.agentflagger_selectdata(self, *args, **kwargs)
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+        RuntimeError: MSSelectionNullSelection : The selected table has zero rows.
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa        Command request with id 42 failed in server n# 1 with traceback Traceback (most recent call last):
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casampi/private/MPICommandServer.py", line 208, in __command_request_handler_service
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            command_response['ret'] = eval(eval_str)
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "<string>", line 1, in <module>
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/flagdata.py", line 1136, in __call__
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            task_result = _flagdata_t( _pc.document['vis'], _pc.document['mode'], _pc.document['autocorr'], _pc.document['inpfile'], _pc.document['reason'], _pc.document['tbuff'], _pc.document['spw'], _pc.document['field'], _pc.document['antenna'], _pc.document['uvrange'], _pc.document['timerange'], _pc.document['correlation'], _pc.document['scan'], _pc.document['intent'], _pc.document['array'], _pc.document['observation'], _pc.document['feed'], _pc.document['clipminmax'], _pc.document['datacolumn'], _pc.document['clipoutside'], _pc.document['channelavg'], _pc.document['chanbin'], _pc.document['timeavg'], _pc.document['timebin'], _pc.document['clipzeros'], _pc.document['quackinterval'], _pc.document['quackmode'], _pc.document['quackincrement'], _pc.document['tolerance'], _pc.document['addantenna'], _pc.document['lowerlimit'], _pc.document['upperlimit'], _pc.document['ntime'], _pc.document['combinescans'], _pc.document['timecutoff'], _pc.document['freqcutoff'], _pc.document['timefit'], _pc.document['freqfit'], _pc.document['maxnpieces'], _pc.document['flagdimension'], _pc.document['usewindowstats'], _pc.document['halfwin'], _pc.document['extendflags'], _pc.document['winsize'], _pc.document['timedev'], _pc.document['freqdev'], _pc.document['timedevscale'], _pc.document['freqdevscale'], _pc.document['spectralmax'], _pc.document['spectralmin'], _pc.document['antint_ref_antenna'], _pc.document['minchanfrac'], _pc.document['verbose'], _pc.document['extendpols'], _pc.document['growtime'], _pc.document['growfreq'], _pc.document['growaround'], _pc.document['flagneartime'], _pc.document['flagnearfreq'], _pc.document['minrel'], _pc.document['maxrel'], _pc.document['minabs'], _pc.document['maxabs'], _pc.document['spwchan'], _pc.document['spwcorr'], _pc.document['basecnt'], _pc.document['fieldcnt'], _pc.document['name'], _pc.document['action'], _pc.document['display'], _pc.document['flagbackup'], _pc.document['savepars'], _pc.document['cmdreason'], _pc.document['outfile'], _pc.document['overwrite'], _pc.document['writeflags'] )
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/private/task_flagdata.py", line 618, in flagdata
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            aflocal.selectdata(field=field, spw=spw, array=array, feed=feed, scan=scan, \
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/agentflagger.py", line 36, in selectdata
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return self._swigobj.selectdata(config, field, spw, array, feed, scan, antenna, uvrange, timerange, correlation, intent, observation)
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/agentflagger.py", line 197, in selectdata
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return _agentflagger.agentflagger_selectdata(self, *args, **kwargs)
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+        RuntimeError: MSSelectionNullSelection : The selected table has zero rows.
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa        Command request with id 37 failed in server n# 6 with traceback Traceback (most recent call last):
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casampi/private/MPICommandServer.py", line 208, in __command_request_handler_service
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            command_response['ret'] = eval(eval_str)
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "<string>", line 1, in <module>
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/flagdata.py", line 1136, in __call__
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            task_result = _flagdata_t( _pc.document['vis'], _pc.document['mode'], _pc.document['autocorr'], _pc.document['inpfile'], _pc.document['reason'], _pc.document['tbuff'], _pc.document['spw'], _pc.document['field'], _pc.document['antenna'], _pc.document['uvrange'], _pc.document['timerange'], _pc.document['correlation'], _pc.document['scan'], _pc.document['intent'], _pc.document['array'], _pc.document['observation'], _pc.document['feed'], _pc.document['clipminmax'], _pc.document['datacolumn'], _pc.document['clipoutside'], _pc.document['channelavg'], _pc.document['chanbin'], _pc.document['timeavg'], _pc.document['timebin'], _pc.document['clipzeros'], _pc.document['quackinterval'], _pc.document['quackmode'], _pc.document['quackincrement'], _pc.document['tolerance'], _pc.document['addantenna'], _pc.document['lowerlimit'], _pc.document['upperlimit'], _pc.document['ntime'], _pc.document['combinescans'], _pc.document['timecutoff'], _pc.document['freqcutoff'], _pc.document['timefit'], _pc.document['freqfit'], _pc.document['maxnpieces'], _pc.document['flagdimension'], _pc.document['usewindowstats'], _pc.document['halfwin'], _pc.document['extendflags'], _pc.document['winsize'], _pc.document['timedev'], _pc.document['freqdev'], _pc.document['timedevscale'], _pc.document['freqdevscale'], _pc.document['spectralmax'], _pc.document['spectralmin'], _pc.document['antint_ref_antenna'], _pc.document['minchanfrac'], _pc.document['verbose'], _pc.document['extendpols'], _pc.document['growtime'], _pc.document['growfreq'], _pc.document['growaround'], _pc.document['flagneartime'], _pc.document['flagnearfreq'], _pc.document['minrel'], _pc.document['maxrel'], _pc.document['minabs'], _pc.document['maxabs'], _pc.document['spwchan'], _pc.document['spwcorr'], _pc.document['basecnt'], _pc.document['fieldcnt'], _pc.document['name'], _pc.document['action'], _pc.document['display'], _pc.document['flagbackup'], _pc.document['savepars'], _pc.document['cmdreason'], _pc.document['outfile'], _pc.document['overwrite'], _pc.document['writeflags'] )
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/private/task_flagdata.py", line 618, in flagdata
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            aflocal.selectdata(field=field, spw=spw, array=array, feed=feed, scan=scan, \
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/agentflagger.py", line 36, in selectdata
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return self._swigobj.selectdata(config, field, spw, array, feed, scan, antenna, uvrange, timerange, correlation, intent, observation)
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/agentflagger.py", line 197, in selectdata
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return _agentflagger.agentflagger_selectdata(self, *args, **kwargs)
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+        RuntimeError: MSSelectionNullSelection : The selected table has zero rows.
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa        Command request with id 40 failed in server n# 3 with traceback Traceback (most recent call last):
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casampi/private/MPICommandServer.py", line 208, in __command_request_handler_service
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            command_response['ret'] = eval(eval_str)
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "<string>", line 1, in <module>
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/flagdata.py", line 1136, in __call__
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            task_result = _flagdata_t( _pc.document['vis'], _pc.document['mode'], _pc.document['autocorr'], _pc.document['inpfile'], _pc.document['reason'], _pc.document['tbuff'], _pc.document['spw'], _pc.document['field'], _pc.document['antenna'], _pc.document['uvrange'], _pc.document['timerange'], _pc.document['correlation'], _pc.document['scan'], _pc.document['intent'], _pc.document['array'], _pc.document['observation'], _pc.document['feed'], _pc.document['clipminmax'], _pc.document['datacolumn'], _pc.document['clipoutside'], _pc.document['channelavg'], _pc.document['chanbin'], _pc.document['timeavg'], _pc.document['timebin'], _pc.document['clipzeros'], _pc.document['quackinterval'], _pc.document['quackmode'], _pc.document['quackincrement'], _pc.document['tolerance'], _pc.document['addantenna'], _pc.document['lowerlimit'], _pc.document['upperlimit'], _pc.document['ntime'], _pc.document['combinescans'], _pc.document['timecutoff'], _pc.document['freqcutoff'], _pc.document['timefit'], _pc.document['freqfit'], _pc.document['maxnpieces'], _pc.document['flagdimension'], _pc.document['usewindowstats'], _pc.document['halfwin'], _pc.document['extendflags'], _pc.document['winsize'], _pc.document['timedev'], _pc.document['freqdev'], _pc.document['timedevscale'], _pc.document['freqdevscale'], _pc.document['spectralmax'], _pc.document['spectralmin'], _pc.document['antint_ref_antenna'], _pc.document['minchanfrac'], _pc.document['verbose'], _pc.document['extendpols'], _pc.document['growtime'], _pc.document['growfreq'], _pc.document['growaround'], _pc.document['flagneartime'], _pc.document['flagnearfreq'], _pc.document['minrel'], _pc.document['maxrel'], _pc.document['minabs'], _pc.document['maxabs'], _pc.document['spwchan'], _pc.document['spwcorr'], _pc.document['basecnt'], _pc.document['fieldcnt'], _pc.document['name'], _pc.document['action'], _pc.document['display'], _pc.document['flagbackup'], _pc.document['savepars'], _pc.document['cmdreason'], _pc.document['outfile'], _pc.document['overwrite'], _pc.document['writeflags'] )
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/private/task_flagdata.py", line 618, in flagdata
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            aflocal.selectdata(field=field, spw=spw, array=array, feed=feed, scan=scan, \
17-Sep-2024 18:26:10 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/agentflagger.py", line 36, in selectdata
17-Sep-2024 18:26:13 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return self._swigobj.selectdata(config, field, spw, array, feed, scan, antenna, uvrange, timerange, correlation, intent, observation)
17-Sep-2024 18:26:13 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/agentflagger.py", line 197, in selectdata
17-Sep-2024 18:26:13 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return _agentflagger.agentflagger_selectdata(self, *args, **kwargs)
17-Sep-2024 18:26:13 2024-09-17 18:26:10        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+        RuntimeError: MSSelectionNullSelection : The selected table has zero rows.
17-Sep-2024 18:26:13 2024-09-17 18:26:10        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: None
17-Sep-2024 18:26:13 2024-09-17 18:26:10        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: None
17-Sep-2024 18:26:13 2024-09-17 18:26:10        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: None
17-Sep-2024 18:26:13 2024-09-17 18:26:10        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:13 2024-09-17 18:26:10        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: None
17-Sep-2024 18:26:13 2024-09-17 18:26:10        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: None
17-Sep-2024 18:26:13 2024-09-17 18:26:10        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: None
17-Sep-2024 18:26:13 2024-09-17 18:26:10        INFO        flagdata::::casa        Task flagdata complete. Start time: 2024-09-17 18:26:08.557322 End time: 2024-09-17 18:26:10.290485
17-Sep-2024 18:26:13 2024-09-17 18:26:10        INFO        flagdata::::casa        ##### End Task: flagdata             #####
17-Sep-2024 18:26:13 2024-09-17 18:26:10        INFO        flagdata::::casa        ##########################################
17-Sep-2024 18:26:13 2024-09-17 18:26:10        INFO        flagdata::::casa        ##########################################
17-Sep-2024 18:26:13 2024-09-17 18:26:10        INFO        flagdata::::casa        ##### Begin Task: flagdata           #####
17-Sep-2024 18:26:13 2024-09-17 18:26:10        INFO        flagdata::::casa        flagdata( vis='3c391_ctm_mosaic_10s_spw0.ms', mode='manual', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='', field='', antenna='ea13,ea15', 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 )
17-Sep-2024 18:26:13 2024-09-17 18:26:10        INFO        flagdata::::casa        Backup original flags before applying new flags
17-Sep-2024 18:26:13 2024-09-17 18:26:10        INFO        AgentFlagger::open        Table type is Measurement Set
17-Sep-2024 18:26:13 2024-09-17 18:26:10        INFO        FlagVersion::saveFlagVersion        Creating new backup flag file called flagdata_2
17-Sep-2024 18:26:13 2024-09-17 18:26:12        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:13 2024-09-17 18:26:12        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:13 2024-09-17 18:26:12        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:13 2024-09-17 18:26:12        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:13 2024-09-17 18:26:12        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:13 2024-09-17 18:26:12        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:13 2024-09-17 18:26:12        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:13 2024-09-17 18:26:12        INFO        flagdata::::casa        Task flagdata complete. Start time: 2024-09-17 18:26:10.298370 End time: 2024-09-17 18:26:11.563500
17-Sep-2024 18:26:13 2024-09-17 18:26:12        INFO        flagdata::::casa        ##### End Task: flagdata             #####
17-Sep-2024 18:26:13 2024-09-17 18:26:12        INFO        flagdata::::casa        ##########################################
17-Sep-2024 18:26:13 2024-09-17 18:26:12        INFO        flagdata::::casa        ##########################################
17-Sep-2024 18:26:13 2024-09-17 18:26:12        INFO        flagdata::::casa        ##### Begin Task: flagdata           #####
17-Sep-2024 18:26:13 2024-09-17 18:26:12        INFO        flagdata::::casa        flagdata( vis='3c391_ctm_mosaic_10s_spw0.ms', mode='quack', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='', 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=10.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 )
17-Sep-2024 18:26:13 2024-09-17 18:26:12        INFO        flagdata::::casa        Backup original flags before applying new flags
17-Sep-2024 18:26:13 2024-09-17 18:26:12        INFO        AgentFlagger::open        Table type is Measurement Set
17-Sep-2024 18:26:13 2024-09-17 18:26:12        INFO        FlagVersion::saveFlagVersion        Creating new backup flag file called flagdata_3
17-Sep-2024 18:26:13 2024-09-17 18:26:13        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:13 2024-09-17 18:26:13        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:13 2024-09-17 18:26:13        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:13 2024-09-17 18:26:13        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:13 2024-09-17 18:26:13        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:13 2024-09-17 18:26:13        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:13 2024-09-17 18:26:13        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
17-Sep-2024 18:26:13 2024-09-17 18:26:13        INFO        flagdata::::casa        Task flagdata complete. Start time: 2024-09-17 18:26:11.571456 End time: 2024-09-17 18:26:13.028507
17-Sep-2024 18:26:13 2024-09-17 18:26:13        INFO        flagdata::::casa        ##### End Task: flagdata             #####
17-Sep-2024 18:26:13 2024-09-17 18:26:13        INFO        flagdata::::casa        ##########################################
17-Sep-2024 18:26:13 2024-09-17 18:26:13        INFO        flagdata::::casa        ##########################################
17-Sep-2024 18:26:13 2024-09-17 18:26:13        INFO        flagdata::::casa        ##### Begin Task: flagdata           #####
17-Sep-2024 18:26:14 2024-09-17 18:26:13        INFO        flagdata::::casa        flagdata( vis='3c391_ctm_mosaic_10s_spw0.ms', mode='summary', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='', 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 )
17-Sep-2024 18:26:14 2024-09-17 18:26:14        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {'antenna': {'ea01': {'flagged': 341504.0, 'total': 2509568.0}, 'ea02': {'flagged': 274432.0, 'total': 2105600.0}, 'ea03': {'flagged': 341504.0, 'total': 2509568.0}, 'ea04': {'flagged': 341504.0, 'total': 2504192.0}, 'ea05': {'flagged': 341504.0, 'total': 2509568.0}, 'ea07': {'flagged': 341504.0, 'total': 2509312.0}, 'ea08': {'flagged': 287232.0, 'total': 2193152.0}, 'ea09': {'flagged': 330240.0, 'total': 2509312.0}, 'ea11': {'flagged': 342016.0, 'total': 2509568.0}, 'ea12': {'flagged': 341504.0, 'total': 2509568.0}, 'ea13': {'flagged': 2509568.0, 'total': 2509568.0}, 'ea14': {'flagged': 341504.0, 'total': 2509568.0}, 'ea15': {'flagged': 2509568.0, 'total': 2509568.0}, 'ea16': {'flagged': 281088.0, 'total': 2119424.0}, 'ea17': {'flagged': 341504.0, 'total': 2509312.0}, 'ea18': {'flagged': 341504.0, 'total': 2509568.0}, 'ea19': {'flagged': 341504.0, 'total': 2509568.0}, 'ea20': {'flagged': 341504.0, 'total': 2509568.0}, 'ea21': {'flagged': 342016.0, 'total': 2509568.0}, 'ea22': {'flagged': 341504.0, 'total': 2509568.0}, 'ea23': {'flagged': 341504.0, 'total': 2509568.0}, 'ea24': {'flagged': 341504.0, 'total': 2509568.0}, 'ea25': {'flagged': 342016.0, 'total': 2509568.0}, 'ea26': {'flagged': 341504.0, 'total': 2509568.0}, 'ea27': {'flagged': 341504.0, 'total': 2509568.0}, 'ea28': {'flagged': 340480.0, 'total': 2497280.0}}, 'array': {'0': {'flagged': 6511360.0, 'total': 32059904.0}}, 'correlation': {'LL': {'flagged': 1627840.0, 'total': 8014976.0}, 'LR': {'flagged': 1627840.0, 'total': 8014976.0}, 'RL': {'flagged': 1627840.0, 'total': 8014976.0}, 'RR': {'flagged': 1627840.0, 'total': 8014976.0}}, 'field': {'3C391 C1': {'flagged': 1315584.0, 'total': 7308800.0}, '3C391 C2': {'flagged': 424704.0, 'total': 2291200.0}, '3C391 C3': {'flagged': 1016832.0, 'total': 4908800.0}, '3C391 C4': {'flagged': 1896192.0, 'total': 8903680.0}, '3C391 C6': {'flagged': 505088.0, 'total': 2412800.0}, '3C391 C7': {'flagged': 1016832.0, 'total': 4908800.0}, 'J1822-0938': {'flagged': 336128.0, 'total': 1325824.0}}, 'flagged': 6511360.0, 'name': 'Summary', 'observation': {'0': {'flagged': 6511360.0, 'total': 32059904.0}}, 'scan': {'11': {'flagged': 511744.0, 'total': 2496000.0}, '13': {'flagged': 446208.0, 'total': 2483200.0}, '16': {'flagged': 511744.0, 'total': 2496000.0}, '28': {'flagged': 183808.0, 'total': 748800.0}, '31': {'flagged': 517632.0, 'total': 2496000.0}, '42': {'flagged': 505088.0, 'total': 2412800.0}, '52': {'flagged': 505088.0, 'total': 2412800.0}, '65': {'flagged': 499200.0, 'total': 2412800.0}, '71': {'flagged': 434688.0, 'total': 2412800.0}, '8': {'flagged': 452608.0, 'total': 2116608.0}, '85': {'flagged': 505088.0, 'total': 2412800.0}, '86': {'flagged': 152320.0, 'total': 577024.0}, '87': {'flagged': 434688.0, 'total': 2412800.0}, '88': {'flagged': 424704.0, 'total': 2291200.0}, '98': {'flagged': 426752.0, 'total': 1878272.0}}, 'spw': {'0': {'flagged': 6511360.0, 'total': 32059904.0}}, 'total': 32059904.0, 'type': 'summary'}
17-Sep-2024 18:26:14 2024-09-17 18:26:14        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {'antenna': {'ea01': {'flagged': 302336.0, 'total': 2231296.0}, 'ea02': {'flagged': 229632.0, 'total': 1704448.0}, 'ea03': {'flagged': 294400.0, 'total': 2217216.0}, 'ea04': {'flagged': 297984.0, 'total': 2161920.0}, 'ea05': {'flagged': 295168.0, 'total': 2217728.0}, 'ea07': {'flagged': 300800.0, 'total': 2226944.0}, 'ea08': {'flagged': 275200.0, 'total': 2059776.0}, 'ea09': {'flagged': 280320.0, 'total': 2225920.0}, 'ea11': {'flagged': 298752.0, 'total': 2226176.0}, 'ea12': {'flagged': 302592.0, 'total': 2229760.0}, 'ea13': {'flagged': 2226944.0, 'total': 2226944.0}, 'ea14': {'flagged': 300288.0, 'total': 2223104.0}, 'ea15': {'flagged': 2229760.0, 'total': 2229760.0}, 'ea16': {'flagged': 275200.0, 'total': 2059520.0}, 'ea17': {'flagged': 300800.0, 'total': 2226688.0}, 'ea18': {'flagged': 300288.0, 'total': 2223104.0}, 'ea19': {'flagged': 302592.0, 'total': 2230016.0}, 'ea20': {'flagged': 301056.0, 'total': 2229760.0}, 'ea21': {'flagged': 302848.0, 'total': 2231808.0}, 'ea22': {'flagged': 301056.0, 'total': 2229760.0}, 'ea23': {'flagged': 298240.0, 'total': 2198528.0}, 'ea24': {'flagged': 300288.0, 'total': 2223104.0}, 'ea25': {'flagged': 298496.0, 'total': 2225920.0}, 'ea26': {'flagged': 300288.0, 'total': 2223104.0}, 'ea27': {'flagged': 302592.0, 'total': 2229760.0}, 'ea28': {'flagged': 297472.0, 'total': 2224896.0}}, 'array': {'0': {'flagged': 5757696.0, 'total': 28468480.0}}, 'correlation': {'LL': {'flagged': 1439424.0, 'total': 7117120.0}, 'LR': {'flagged': 1439424.0, 'total': 7117120.0}, 'RL': {'flagged': 1439424.0, 'total': 7117120.0}, 'RR': {'flagged': 1439424.0, 'total': 7117120.0}}, 'field': {'3C391 C1': {'flagged': 452352.0, 'total': 2496000.0}, '3C391 C2': {'flagged': 1436928.0, 'total': 7142400.0}, '3C391 C3': {'flagged': 478464.0, 'total': 2227200.0}, '3C391 C4': {'flagged': 499200.0, 'total': 2412800.0}, '3C391 C6': {'flagged': 1022720.0, 'total': 4908800.0}, '3C391 C7': {'flagged': 925952.0, 'total': 4291072.0}, 'J0319+4130': {'flagged': 423936.0, 'total': 2488576.0}, 'J1331+3030': {'flagged': 163328.0, 'total': 1016832.0}, 'J1822-0938': {'flagged': 354816.0, 'total': 1484800.0}}, 'flagged': 5757696.0, 'name': 'Summary', 'observation': {'0': {'flagged': 5757696.0, 'total': 28468480.0}}, 'scan': {'103': {'flagged': 423936.0, 'total': 2488576.0}, '18': {'flagged': 517632.0, 'total': 2496000.0}, '22': {'flagged': 511744.0, 'total': 2496000.0}, '36': {'flagged': 183808.0, 'total': 748800.0}, '37': {'flagged': 163328.0, 'total': 1016832.0}, '39': {'flagged': 452352.0, 'total': 2496000.0}, '53': {'flagged': 499200.0, 'total': 2412800.0}, '58': {'flagged': 499200.0, 'total': 2412800.0}, '64': {'flagged': 420096.0, 'total': 2233600.0}, '70': {'flagged': 171008.0, 'total': 736000.0}, '76': {'flagged': 505088.0, 'total': 2412800.0}, '80': {'flagged': 505088.0, 'total': 2412800.0}, '89': {'flagged': 478464.0, 'total': 2227200.0}, '93': {'flagged': 426752.0, 'total': 1878272.0}}, 'spw': {'0': {'flagged': 5757696.0, 'total': 28468480.0}}, 'total': 28468480.0, 'type': 'summary'}
17-Sep-2024 18:26:14 2024-09-17 18:26:14        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {'antenna': {'ea01': {'flagged': 353024.0, 'total': 2519552.0}, 'ea02': {'flagged': 294912.0, 'total': 2150400.0}, 'ea03': {'flagged': 353024.0, 'total': 2519552.0}, 'ea04': {'flagged': 347904.0, 'total': 2519552.0}, 'ea05': {'flagged': 353536.0, 'total': 2519552.0}, 'ea07': {'flagged': 348416.0, 'total': 2519552.0}, 'ea08': {'flagged': 295424.0, 'total': 2150400.0}, 'ea09': {'flagged': 332288.0, 'total': 2519552.0}, 'ea11': {'flagged': 354048.0, 'total': 2519552.0}, 'ea12': {'flagged': 353024.0, 'total': 2519552.0}, 'ea13': {'flagged': 2519552.0, 'total': 2519552.0}, 'ea14': {'flagged': 353024.0, 'total': 2519552.0}, 'ea15': {'flagged': 2519552.0, 'total': 2519552.0}, 'ea16': {'flagged': 294912.0, 'total': 2150400.0}, 'ea17': {'flagged': 353024.0, 'total': 2519552.0}, 'ea18': {'flagged': 353024.0, 'total': 2519552.0}, 'ea19': {'flagged': 344832.0, 'total': 2482688.0}, 'ea20': {'flagged': 353024.0, 'total': 2519552.0}, 'ea21': {'flagged': 353024.0, 'total': 2519552.0}, 'ea22': {'flagged': 353024.0, 'total': 2519552.0}, 'ea23': {'flagged': 353024.0, 'total': 2519552.0}, 'ea24': {'flagged': 344832.0, 'total': 2482688.0}, 'ea25': {'flagged': 353536.0, 'total': 2519552.0}, 'ea26': {'flagged': 344832.0, 'total': 2482688.0}, 'ea27': {'flagged': 344832.0, 'total': 2482688.0}, 'ea28': {'flagged': 353024.0, 'total': 2519552.0}}, 'array': {'0': {'flagged': 6638336.0, 'total': 32126720.0}}, 'correlation': {'LL': {'flagged': 1659584.0, 'total': 8031680.0}, 'LR': {'flagged': 1659584.0, 'total': 8031680.0}, 'RL': {'flagged': 1659584.0, 'total': 8031680.0}, 'RR': {'flagged': 1659584.0, 'total': 8031680.0}}, 'field': {'3C391 C1': {'flagged': 435200.0, 'total': 2412800.0}, '3C391 C2': {'flagged': 1016832.0, 'total': 4908800.0}, '3C391 C3': {'flagged': 1955584.0, 'total': 9264640.0}, '3C391 C4': {'flagged': 499200.0, 'total': 2412800.0}, '3C391 C5': {'flagged': 421632.0, 'total': 1878272.0}, '3C391 C6': {'flagged': 517632.0, 'total': 2496000.0}, '3C391 C7': {'flagged': 1016832.0, 'total': 4908800.0}, 'J1331+3030': {'flagged': 668160.0, 'total': 3494400.0}, 'J1822-0938': {'flagged': 107264.0, 'total': 350208.0}}, 'flagged': 6638336.0, 'name': 'Summary', 'observation': {'0': {'flagged': 6638336.0, 'total': 32126720.0}}, 'scan': {'102': {'flagged': 107264.0, 'total': 350208.0}, '14': {'flagged': 511744.0, 'total': 2496000.0}, '15': {'flagged': 517632.0, 'total': 2496000.0}, '2': {'flagged': 668160.0, 'total': 3494400.0}, '26': {'flagged': 517632.0, 'total': 2496000.0}, '35': {'flagged': 517632.0, 'total': 2496000.0}, '41': {'flagged': 505088.0, 'total': 2412800.0}, '55': {'flagged': 435200.0, 'total': 2412800.0}, '57': {'flagged': 505088.0, 'total': 2412800.0}, '61': {'flagged': 499200.0, 'total': 2412800.0}, '7': {'flagged': 427776.0, 'total': 1943040.0}, '72': {'flagged': 505088.0, 'total': 2412800.0}, '82': {'flagged': 499200.0, 'total': 2412800.0}, '99': {'flagged': 421632.0, 'total': 1878272.0}}, 'spw': {'0': {'flagged': 6638336.0, 'total': 32126720.0}}, 'total': 32126720.0, 'type': 'summary'}
17-Sep-2024 18:26:14 2024-09-17 18:26:14        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {'antenna': {'ea01': {'flagged': 332032.0, 'total': 2324992.0}, 'ea02': {'flagged': 215040.0, 'total': 1508352.0}, 'ea03': {'flagged': 314624.0, 'total': 2147072.0}, 'ea04': {'flagged': 333312.0, 'total': 2324992.0}, 'ea05': {'flagged': 328960.0, 'total': 2319104.0}, 'ea07': {'flagged': 328448.0, 'total': 2312960.0}, 'ea08': {'flagged': 216320.0, 'total': 1508352.0}, 'ea09': {'flagged': 310784.0, 'total': 2319104.0}, 'ea11': {'flagged': 333312.0, 'total': 2324992.0}, 'ea12': {'flagged': 330752.0, 'total': 2323456.0}, 'ea13': {'flagged': 2323456.0, 'total': 2323456.0}, 'ea14': {'flagged': 327936.0, 'total': 2306816.0}, 'ea15': {'flagged': 2323456.0, 'total': 2323456.0}, 'ea16': {'flagged': 215040.0, 'total': 1508352.0}, 'ea17': {'flagged': 331520.0, 'total': 2319104.0}, 'ea18': {'flagged': 329472.0, 'total': 2323456.0}, 'ea19': {'flagged': 333312.0, 'total': 2323456.0}, 'ea20': {'flagged': 327424.0, 'total': 2323456.0}, 'ea21': {'flagged': 332288.0, 'total': 2324992.0}, 'ea22': {'flagged': 329472.0, 'total': 2323456.0}, 'ea23': {'flagged': 328448.0, 'total': 2313728.0}, 'ea24': {'flagged': 329472.0, 'total': 2323456.0}, 'ea25': {'flagged': 333568.0, 'total': 2324992.0}, 'ea26': {'flagged': 329472.0, 'total': 2323456.0}, 'ea27': {'flagged': 332032.0, 'total': 2323456.0}, 'ea28': {'flagged': 332032.0, 'total': 2323456.0}}, 'array': {'0': {'flagged': 6100992.0, 'total': 28872960.0}}, 'correlation': {'LL': {'flagged': 1525248.0, 'total': 7218240.0}, 'LR': {'flagged': 1525248.0, 'total': 7218240.0}, 'RL': {'flagged': 1525248.0, 'total': 7218240.0}, 'RR': {'flagged': 1525248.0, 'total': 7218240.0}}, 'field': {'3C391 C1': {'flagged': 449792.0, 'total': 2483456.0}, '3C391 C2': {'flagged': 1352192.0, 'total': 6214912.0}, '3C391 C3': {'flagged': 426752.0, 'total': 1878272.0}, '3C391 C5': {'flagged': 1521920.0, 'total': 7321600.0}, '3C391 C6': {'flagged': 926720.0, 'total': 4291072.0}, '3C391 C7': {'flagged': 937728.0, 'total': 4729600.0}, 'J1331+3030': {'flagged': 166400.0, 'total': 166400.0}, 'J1822-0938': {'flagged': 319488.0, 'total': 1787648.0}}, 'flagged': 6100992.0, 'name': 'Summary', 'observation': {'0': {'flagged': 6100992.0, 'total': 28872960.0}}, 'scan': {'1': {'flagged': 166400.0, 'total': 166400.0}, '100': {'flagged': 421632.0, 'total': 1878272.0}, '25': {'flagged': 517632.0, 'total': 2496000.0}, '27': {'flagged': 517632.0, 'total': 2496000.0}, '4': {'flagged': 319488.0, 'total': 1787648.0}, '47': {'flagged': 449792.0, 'total': 2483456.0}, '48': {'flagged': 497664.0, 'total': 2393600.0}, '51': {'flagged': 505088.0, 'total': 2412800.0}, '59': {'flagged': 499200.0, 'total': 2412800.0}, '6': {'flagged': 427776.0, 'total': 1943040.0}, '69': {'flagged': 420096.0, 'total': 2233600.0}, '84': {'flagged': 505088.0, 'total': 2412800.0}, '96': {'flagged': 426752.0, 'total': 1878272.0}, '97': {'flagged': 426752.0, 'total': 1878272.0}}, 'spw': {'0': {'flagged': 6100992.0, 'total': 28872960.0}}, 'total': 28872960.0, 'type': 'summary'}
17-Sep-2024 18:26:14 2024-09-17 18:26:14        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {'antenna': {'ea01': {'flagged': 339968.0, 'total': 2436096.0}, 'ea02': {'flagged': 314112.0, 'total': 2266624.0}, 'ea03': {'flagged': 332800.0, 'total': 2353920.0}, 'ea04': {'flagged': 342272.0, 'total': 2435072.0}, 'ea05': {'flagged': 341760.0, 'total': 2430976.0}, 'ea07': {'flagged': 334080.0, 'total': 2430720.0}, 'ea08': {'flagged': 330240.0, 'total': 2293248.0}, 'ea09': {'flagged': 317440.0, 'total': 2430464.0}, 'ea11': {'flagged': 343040.0, 'total': 2436096.0}, 'ea12': {'flagged': 339968.0, 'total': 2435072.0}, 'ea13': {'flagged': 2380288.0, 'total': 2380288.0}, 'ea14': {'flagged': 339456.0, 'total': 2430976.0}, 'ea15': {'flagged': 2435072.0, 'total': 2435072.0}, 'ea16': {'flagged': 332800.0, 'total': 2356224.0}, 'ea17': {'flagged': 339712.0, 'total': 2429440.0}, 'ea18': {'flagged': 339968.0, 'total': 2435072.0}, 'ea19': {'flagged': 335872.0, 'total': 2372352.0}, 'ea20': {'flagged': 334592.0, 'total': 2435072.0}, 'ea21': {'flagged': 339968.0, 'total': 2435840.0}, 'ea22': {'flagged': 339968.0, 'total': 2435072.0}, 'ea23': {'flagged': 338944.0, 'total': 2425344.0}, 'ea24': {'flagged': 339456.0, 'total': 2430976.0}, 'ea25': {'flagged': 343040.0, 'total': 2436096.0}, 'ea26': {'flagged': 339456.0, 'total': 2430976.0}, 'ea27': {'flagged': 341504.0, 'total': 2435072.0}, 'ea28': {'flagged': 338944.0, 'total': 2422784.0}}, 'array': {'0': {'flagged': 6447360.0, 'total': 31337472.0}}, 'correlation': {'LL': {'flagged': 1611840.0, 'total': 7834368.0}, 'LR': {'flagged': 1611840.0, 'total': 7834368.0}, 'RL': {'flagged': 1611840.0, 'total': 7834368.0}, 'RR': {'flagged': 1611840.0, 'total': 7834368.0}}, 'field': {'3C391 C1': {'flagged': 894464.0, 'total': 4979200.0}, '3C391 C2': {'flagged': 505088.0, 'total': 2412800.0}, '3C391 C4': {'flagged': 505088.0, 'total': 2412800.0}, '3C391 C5': {'flagged': 1975296.0, 'total': 9318912.0}, '3C391 C6': {'flagged': 506112.0, 'total': 2496000.0}, '3C391 C7': {'flagged': 1516032.0, 'total': 7321600.0}, 'J1822-0938': {'flagged': 545280.0, 'total': 2396160.0}}, 'flagged': 6447360.0, 'name': 'Summary', 'observation': {'0': {'flagged': 6447360.0, 'total': 31337472.0}}, 'scan': {'10': {'flagged': 506112.0, 'total': 2496000.0}, '19': {'flagged': 511744.0, 'total': 2496000.0}, '21': {'flagged': 458496.0, 'total': 2566400.0}, '33': {'flagged': 517632.0, 'total': 2496000.0}, '38': {'flagged': 241920.0, 'total': 1051648.0}, '43': {'flagged': 505088.0, 'total': 2412800.0}, '45': {'flagged': 499200.0, 'total': 2412800.0}, '46': {'flagged': 126976.0, 'total': 678912.0}, '56': {'flagged': 505088.0, 'total': 2412800.0}, '62': {'flagged': 176384.0, 'total': 665600.0}, '63': {'flagged': 435968.0, 'total': 2412800.0}, '67': {'flagged': 499200.0, 'total': 2412800.0}, '74': {'flagged': 505088.0, 'total': 2412800.0}, '77': {'flagged': 505088.0, 'total': 2412800.0}, '91': {'flagged': 453376.0, 'total': 1997312.0}}, 'spw': {'0': {'flagged': 6447360.0, 'total': 31337472.0}}, 'total': 31337472.0, 'type': 'summary'}
17-Sep-2024 18:26:14 2024-09-17 18:26:14        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {'antenna': {'ea01': {'flagged': 364800.0, 'total': 2566400.0}, 'ea02': {'flagged': 309504.0, 'total': 2184704.0}, 'ea03': {'flagged': 359680.0, 'total': 2569472.0}, 'ea04': {'flagged': 364288.0, 'total': 2571264.0}, 'ea05': {'flagged': 364032.0, 'total': 2569472.0}, 'ea07': {'flagged': 359424.0, 'total': 2578688.0}, 'ea08': {'flagged': 308992.0, 'total': 2183936.0}, 'ea09': {'flagged': 348160.0, 'total': 2571008.0}, 'ea11': {'flagged': 364288.0, 'total': 2571264.0}, 'ea12': {'flagged': 364288.0, 'total': 2568192.0}, 'ea13': {'flagged': 2567680.0, 'total': 2567680.0}, 'ea14': {'flagged': 365056.0, 'total': 2578688.0}, 'ea15': {'flagged': 2569472.0, 'total': 2569472.0}, 'ea16': {'flagged': 309248.0, 'total': 2184192.0}, 'ea17': {'flagged': 364288.0, 'total': 2571008.0}, 'ea18': {'flagged': 364032.0, 'total': 2566656.0}, 'ea19': {'flagged': 364288.0, 'total': 2571264.0}, 'ea20': {'flagged': 364288.0, 'total': 2568192.0}, 'ea21': {'flagged': 365312.0, 'total': 2571264.0}, 'ea22': {'flagged': 364288.0, 'total': 2571264.0}, 'ea23': {'flagged': 364288.0, 'total': 2571264.0}, 'ea24': {'flagged': 364032.0, 'total': 2568192.0}, 'ea25': {'flagged': 365312.0, 'total': 2571264.0}, 'ea26': {'flagged': 364032.0, 'total': 2568192.0}, 'ea27': {'flagged': 364288.0, 'total': 2566912.0}, 'ea28': {'flagged': 364032.0, 'total': 2568192.0}}, 'array': {'0': {'flagged': 6845696.0, 'total': 32834048.0}}, 'correlation': {'LL': {'flagged': 1711424.0, 'total': 8208512.0}, 'LR': {'flagged': 1711424.0, 'total': 8208512.0}, 'RL': {'flagged': 1711424.0, 'total': 8208512.0}, 'RR': {'flagged': 1711424.0, 'total': 8208512.0}}, 'field': {'3C391 C1': {'flagged': 385536.0, 'total': 1943040.0}, '3C391 C2': {'flagged': 1016832.0, 'total': 4908800.0}, '3C391 C3': {'flagged': 1478144.0, 'total': 7047680.0}, '3C391 C4': {'flagged': 1016832.0, 'total': 4908800.0}, '3C391 C5': {'flagged': 1016832.0, 'total': 4908800.0}, '3C391 C6': {'flagged': 926720.0, 'total': 4291072.0}, 'J1331+3030': {'flagged': 668160.0, 'total': 3494400.0}, 'J1822-0938': {'flagged': 336640.0, 'total': 1331456.0}}, 'flagged': 6845696.0, 'name': 'Summary', 'observation': {'0': {'flagged': 6845696.0, 'total': 32834048.0}}, 'scan': {'12': {'flagged': 183808.0, 'total': 748800.0}, '17': {'flagged': 517632.0, 'total': 2496000.0}, '23': {'flagged': 517632.0, 'total': 2496000.0}, '3': {'flagged': 668160.0, 'total': 3494400.0}, '30': {'flagged': 517632.0, 'total': 2496000.0}, '32': {'flagged': 511744.0, 'total': 2496000.0}, '40': {'flagged': 499200.0, 'total': 2412800.0}, '49': {'flagged': 455424.0, 'total': 2138880.0}, '5': {'flagged': 385536.0, 'total': 1943040.0}, '60': {'flagged': 505088.0, 'total': 2412800.0}, '66': {'flagged': 505088.0, 'total': 2412800.0}, '73': {'flagged': 505088.0, 'total': 2412800.0}, '78': {'flagged': 152832.0, 'total': 582656.0}, '83': {'flagged': 499200.0, 'total': 2412800.0}, '92': {'flagged': 421632.0, 'total': 1878272.0}}, 'spw': {'0': {'flagged': 6845696.0, 'total': 32834048.0}}, 'total': 32834048.0, 'type': 'summary'}
17-Sep-2024 18:26:14 2024-09-17 18:26:14        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {'antenna': {'ea01': {'flagged': 346112.0, 'total': 2529792.0}, 'ea02': {'flagged': 265728.0, 'total': 1978880.0}, 'ea03': {'flagged': 329728.0, 'total': 2400768.0}, 'ea04': {'flagged': 348672.0, 'total': 2529792.0}, 'ea05': {'flagged': 347648.0, 'total': 2529792.0}, 'ea07': {'flagged': 346112.0, 'total': 2529792.0}, 'ea08': {'flagged': 294144.0, 'total': 2157056.0}, 'ea09': {'flagged': 334848.0, 'total': 2529792.0}, 'ea11': {'flagged': 345088.0, 'total': 2526208.0}, 'ea12': {'flagged': 342528.0, 'total': 2526208.0}, 'ea13': {'flagged': 2345472.0, 'total': 2345472.0}, 'ea14': {'flagged': 346112.0, 'total': 2529792.0}, 'ea15': {'flagged': 2526208.0, 'total': 2526208.0}, 'ea16': {'flagged': 273920.0, 'total': 2116608.0}, 'ea17': {'flagged': 346112.0, 'total': 2529792.0}, 'ea18': {'flagged': 342528.0, 'total': 2526208.0}, 'ea19': {'flagged': 334848.0, 'total': 2480128.0}, 'ea20': {'flagged': 346112.0, 'total': 2529792.0}, 'ea21': {'flagged': 342784.0, 'total': 2526208.0}, 'ea22': {'flagged': 342528.0, 'total': 2526208.0}, 'ea23': {'flagged': 342528.0, 'total': 2526208.0}, 'ea24': {'flagged': 342528.0, 'total': 2526208.0}, 'ea25': {'flagged': 345088.0, 'total': 2526208.0}, 'ea26': {'flagged': 336896.0, 'total': 2483712.0}, 'ea27': {'flagged': 347648.0, 'total': 2529792.0}, 'ea28': {'flagged': 345088.0, 'total': 2517504.0}}, 'array': {'0': {'flagged': 6453504.0, 'total': 31992064.0}}, 'correlation': {'LL': {'flagged': 1613376.0, 'total': 7998016.0}, 'LR': {'flagged': 1613376.0, 'total': 7998016.0}, 'RL': {'flagged': 1613376.0, 'total': 7998016.0}, 'RR': {'flagged': 1613376.0, 'total': 7998016.0}}, 'field': {'3C391 C1': {'flagged': 1003776.0, 'total': 6487552.0}, '3C391 C3': {'flagged': 505088.0, 'total': 2412800.0}, '3C391 C4': {'flagged': 1495296.0, 'total': 7136000.0}, '3C391 C5': {'flagged': 1001984.0, 'total': 4870400.0}, '3C391 C6': {'flagged': 1527808.0, 'total': 7321600.0}, '3C391 C7': {'flagged': 426752.0, 'total': 1878272.0}, 'J1822-0938': {'flagged': 492800.0, 'total': 1885440.0}}, 'flagged': 6453504.0, 'name': 'Summary', 'observation': {'0': {'flagged': 6453504.0, 'total': 31992064.0}}, 'scan': {'101': {'flagged': 426752.0, 'total': 1878272.0}, '20': {'flagged': 182784.0, 'total': 736000.0}, '24': {'flagged': 517632.0, 'total': 2496000.0}, '29': {'flagged': 211200.0, 'total': 2330880.0}, '34': {'flagged': 517632.0, 'total': 2496000.0}, '44': {'flagged': 505088.0, 'total': 2412800.0}, '50': {'flagged': 499200.0, 'total': 2412800.0}, '54': {'flagged': 176384.0, 'total': 665600.0}, '68': {'flagged': 505088.0, 'total': 2412800.0}, '75': {'flagged': 499200.0, 'total': 2412800.0}, '79': {'flagged': 419328.0, 'total': 2278400.0}, '81': {'flagged': 505088.0, 'total': 2412800.0}, '9': {'flagged': 502784.0, 'total': 2457600.0}, '90': {'flagged': 478464.0, 'total': 2227200.0}, '94': {'flagged': 133632.0, 'total': 483840.0}, '95': {'flagged': 373248.0, 'total': 1878272.0}}, 'spw': {'0': {'flagged': 6453504.0, 'total': 31992064.0}}, 'total': 31992064.0, 'type': 'summary'}
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        flagdata::::casa        Task flagdata complete. Start time: 2024-09-17 18:26:13.036448 End time: 2024-09-17 18:26:14.083483
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        flagdata::::casa        ##### End Task: flagdata             #####
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        flagdata::::casa        ##########################################
17-Sep-2024 18:26:14 Expected flag percentage of 20.558870499248552, got 20.558870499248552, tolerance 1.0
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::::casa        ##########################################
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::::casa        ##### Begin Task: listobs            #####
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::::casa        listobs( vis='3c391_ctm_mosaic_10s_spw0.ms', selectdata=True, spw='', field='', antenna='', uvrange='', timerange='', correlation='', scan='', intent='', feed='', array='', observation='', verbose=True, listfile='', listunfl=False, cachesize=50.0, overwrite=False )
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary        ================================================================================
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                   MeasurementSet Name:  /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_mosaic_10s_spw0.ms      MS Version 2
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+        ================================================================================
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+           Observer: Dr. James Miller-Jones     Project: uid://evla/pdb/1214864 
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+        Observation: EVLA
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::MSMetaData::_computeScanAndSubScanProperties         Computing scan and subscan properties...
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary        Data records: 850358       Total elapsed time = 28681 seconds
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+           Observed from   24-Apr-2010/08:02:10.0   to   24-Apr-2010/16:00:11.0 (UTC)
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary        
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+           ObservationID = 0         ArrayID = 0
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          Date        Timerange (UTC)          Scan  FldId FieldName             nRows     SpwIds   Average Interval(s)    ScanIntent
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          24-Apr-2010/08:02:10.0 - 08:02:29.0     1      0 J1331+3030                 650  [0]  [8.37] [CALIBRATE_AMPLI#UNSPECIFIED,CALIBRATE_BANDPASS#UNSPECIFIED,UNSPECIFIED#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      08:02:29.0 - 08:09:28.0     2      0 J1331+3030               13650  [0]  [9.98] [CALIBRATE_AMPLI#UNSPECIFIED,CALIBRATE_BANDPASS#UNSPECIFIED,UNSPECIFIED#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      08:09:28.0 - 08:16:27.0     3      0 J1331+3030               13650  [0]  [9.98] [CALIBRATE_AMPLI#UNSPECIFIED,CALIBRATE_BANDPASS#UNSPECIFIED,UNSPECIFIED#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      08:19:37.0 - 08:24:26.0     4      1 J1822-0938                6983  [0]  [9.84] [CALIBRATE_PHASE#UNSPECIFIED,UNSPECIFIED#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      08:24:47.0 - 08:29:45.0     5      2 3C391 C1                  7590  [0]  [9.87] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      08:29:45.0 - 08:34:44.0     6      3 3C391 C2                  7590  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      08:34:44.0 - 08:39:43.0     7      4 3C391 C3                  7590  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      08:39:43.0 - 08:44:42.0     8      5 3C391 C4                  8268  [0]  [9.92] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      08:44:42.0 - 08:49:41.0     9      6 3C391 C5                  9600  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      08:49:41.0 - 08:54:41.0    10      7 3C391 C6                  9750  [0]  [9.98] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      08:54:41.0 - 08:59:40.0    11      8 3C391 C7                  9750  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      09:00:02.0 - 09:01:30.0    12      1 J1822-0938                2925  [0]  [9.48] [CALIBRATE_PHASE#UNSPECIFIED,UNSPECIFIED#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      09:01:51.0 - 09:06:49.0    13      2 3C391 C1                  9700  [0]  [9.85] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      09:06:49.0 - 09:11:48.0    14      3 3C391 C2                  9750  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      09:11:48.0 - 09:16:47.0    15      4 3C391 C3                  9750  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      09:16:47.0 - 09:21:46.0    16      5 3C391 C4                  9750  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      09:21:46.0 - 09:26:45.0    17      6 3C391 C5                  9750  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      09:26:45.0 - 09:31:45.0    18      7 3C391 C6                  9750  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      09:31:45.0 - 09:36:44.0    19      8 3C391 C7                  9750  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      09:37:06.0 - 09:38:33.0    20      1 J1822-0938                2875  [0]  [9.32] [CALIBRATE_PHASE#UNSPECIFIED,UNSPECIFIED#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      09:38:33.0 - 09:43:53.0    21      2 3C391 C1                 10025  [0]  [9.53] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      09:43:53.0 - 09:48:52.0    22      3 3C391 C2                  9750  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      09:48:52.0 - 09:53:51.0    23      4 3C391 C3                  9750  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      09:53:51.0 - 09:58:50.0    24      5 3C391 C4                  9750  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      09:58:50.0 - 10:03:49.0    25      6 3C391 C5                  9750  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      10:03:49.0 - 10:08:48.0    26      7 3C391 C6                  9750  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      10:08:48.0 - 10:13:48.0    27      8 3C391 C7                  9750  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      10:14:11.0 - 10:15:37.0    28      1 J1822-0938                2925  [0]  [9.27] [CALIBRATE_PHASE#UNSPECIFIED,UNSPECIFIED#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      10:15:37.0 - 10:20:56.0    29      2 3C391 C1                  9105  [0]  [9.68] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      10:20:56.0 - 10:25:56.0    30      3 3C391 C2                  9750  [0]  [9.99] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      10:25:56.0 - 10:30:55.0    31      4 3C391 C3                  9750  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      10:30:55.0 - 10:35:54.0    32      5 3C391 C4                  9750  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      10:35:54.0 - 10:40:53.0    33      6 3C391 C5                  9750  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      10:40:53.0 - 10:45:52.0    34      7 3C391 C6                  9750  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      10:45:52.0 - 10:50:52.0    35      8 3C391 C7                  9750  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      10:51:14.0 - 10:52:41.0    36      1 J1822-0938                2925  [0]  [9.38] [CALIBRATE_PHASE#UNSPECIFIED,UNSPECIFIED#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      10:55:13.0 - 10:57:40.0    37      0 J1331+3030                3972  [0]  [9.58] [CALIBRATE_AMPLI#UNSPECIFIED,CALIBRATE_BANDPASS#UNSPECIFIED,UNSPECIFIED#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      10:57:40.0 - 11:02:40.0    38      1 J1822-0938                4108  [0]  [9.01] [CALIBRATE_PHASE#UNSPECIFIED,UNSPECIFIED#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      11:03:02.0 - 11:07:59.0    39      2 3C391 C1                  9750  [0]  [9.85] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      11:07:59.0 - 11:12:48.0    40      3 3C391 C2                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      11:12:48.0 - 11:17:37.0    41      4 3C391 C3                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      11:17:37.0 - 11:22:26.0    42      5 3C391 C4                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      11:22:26.0 - 11:27:16.0    43      6 3C391 C5                  9425  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      11:27:16.0 - 11:32:05.0    44      7 3C391 C6                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      11:32:05.0 - 11:36:54.0    45      8 3C391 C7                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      11:37:20.0 - 11:38:44.0    46      1 J1822-0938                2652  [0]  [9.25] [CALIBRATE_PHASE#UNSPECIFIED,UNSPECIFIED#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      11:39:10.0 - 11:44:03.0    47      2 3C391 C1                  9701  [0]  [9.76] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      11:44:03.0 - 11:48:52.0    48      3 3C391 C2                  9350  [0]  [9.95] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      11:48:52.0 - 11:53:41.0    49      4 3C391 C3                  8355  [0]  [9.66] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      11:53:41.0 - 11:58:30.0    50      5 3C391 C4                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      11:58:30.0 - 12:03:20.0    51      6 3C391 C5                  9425  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      12:03:20.0 - 12:08:09.0    52      7 3C391 C6                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      12:08:09.0 - 12:12:58.0    53      8 3C391 C7                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      12:13:28.0 - 12:14:48.0    54      1 J1822-0938                2600  [0]  [9.76] [CALIBRATE_PHASE#UNSPECIFIED,UNSPECIFIED#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      12:15:17.0 - 12:20:07.0    55      2 3C391 C1                  9425  [0]  [9.92] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      12:20:07.0 - 12:24:56.0    56      3 3C391 C2                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      12:24:56.0 - 12:29:45.0    57      4 3C391 C3                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      12:29:45.0 - 12:34:35.0    58      5 3C391 C4                  9425  [0]  [9.99] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      12:34:35.0 - 12:39:24.0    59      6 3C391 C5                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      12:39:24.0 - 12:44:13.0    60      7 3C391 C6                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      12:44:13.0 - 12:49:02.0    61      8 3C391 C7                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      12:49:34.0 - 12:50:52.0    62      1 J1822-0938                2600  [0]  [9.49] [CALIBRATE_PHASE#UNSPECIFIED,UNSPECIFIED#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      12:51:23.0 - 12:56:11.0    63      2 3C391 C1                  9425  [0]  [9.85] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      12:56:11.0 - 13:01:00.0    64      3 3C391 C2                  8725  [0]  [9.94] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      13:01:00.0 - 13:05:49.0    65      4 3C391 C3                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      13:05:49.0 - 13:10:39.0    66      5 3C391 C4                  9425  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      13:10:39.0 - 13:15:28.0    67      6 3C391 C5                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      13:15:28.0 - 13:20:17.0    68      7 3C391 C6                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      13:20:17.0 - 13:25:06.0    69      8 3C391 C7                  8725  [0]  [9.94] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      13:25:06.0 - 13:26:56.0    70      1 J1822-0938                2875  [0]  [8.54] [CALIBRATE_PHASE#UNSPECIFIED,UNSPECIFIED#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      13:27:27.0 - 13:32:15.0    71      2 3C391 C1                  9425  [0]  [9.83] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      13:32:15.0 - 13:37:04.0    72      3 3C391 C2                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      13:37:04.0 - 13:41:53.0    73      4 3C391 C3                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      13:41:53.0 - 13:46:43.0    74      5 3C391 C4                  9425  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      13:46:43.0 - 13:51:32.0    75      6 3C391 C5                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      13:51:32.0 - 13:56:21.0    76      7 3C391 C6                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      13:56:21.0 - 14:01:10.0    77      8 3C391 C7                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      14:01:10.0 - 14:03:00.0    78      1 J1822-0938                2276  [0]  [8.41] [CALIBRATE_PHASE#UNSPECIFIED,UNSPECIFIED#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      14:03:32.0 - 14:08:19.0    79      2 3C391 C1                  8900  [0]  [9.79] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      14:08:19.0 - 14:13:08.0    80      3 3C391 C2                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      14:13:08.0 - 14:17:58.0    81      4 3C391 C3                  9425  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      14:17:58.0 - 14:22:47.0    82      5 3C391 C4                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      14:22:47.0 - 14:27:36.0    83      6 3C391 C5                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      14:27:36.0 - 14:32:25.0    84      7 3C391 C6                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      14:32:25.0 - 14:37:14.0    85      8 3C391 C7                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      14:37:14.0 - 14:39:04.0    86      1 J1822-0938                2254  [0]  [8.41] [CALIBRATE_PHASE#UNSPECIFIED,UNSPECIFIED#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      14:39:35.0 - 14:44:23.0    87      2 3C391 C1                  9425  [0]  [9.82] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      14:44:23.0 - 14:49:12.0    88      3 3C391 C2                  8950  [0]  [9.93] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      14:49:12.0 - 14:54:02.0    89      4 3C391 C3                  8700  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      14:54:02.0 - 14:58:51.0    90      5 3C391 C4                  8700  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      14:58:51.0 - 15:03:40.0    91      6 3C391 C5                  7802  [0]  [9.92] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      15:03:40.0 - 15:08:29.0    92      7 3C391 C6                  7337  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      15:08:29.0 - 15:13:18.0    93      8 3C391 C7                  7337  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      15:13:18.0 - 15:15:08.0    94      1 J1822-0938                1890  [0]  [8.46] [CALIBRATE_PHASE#UNSPECIFIED,UNSPECIFIED#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      15:15:39.0 - 15:20:27.0    95      2 3C391 C1                  7337  [0]  [9.85] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      15:20:27.0 - 15:25:16.0    96      3 3C391 C2                  7337  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      15:25:16.0 - 15:30:06.0    97      4 3C391 C3                  7337  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      15:30:06.0 - 15:34:55.0    98      5 3C391 C4                  7337  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      15:34:55.0 - 15:39:44.0    99      6 3C391 C5                  7337  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      15:39:44.0 - 15:44:33.0   100      7 3C391 C6                  7337  [0]  [9.95] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      15:44:33.0 - 15:49:23.0   101      8 3C391 C7                  7337  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      15:49:54.0 - 15:51:12.0   102      1 J1822-0938                1368  [0]  [9.44] [CALIBRATE_PHASE#UNSPECIFIED,UNSPECIFIED#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                      15:51:12.0 - 16:00:11.0   103      9 J0319+4130                9721  [0]  [9.66] [CALIBRATE_BANDPASS#UNSPECIFIED,CALIBRATE_PHASE#UNSPECIFIED,UNSPECIFIED#UNSPECIFIED]
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary                   (nRows = Total number of rows per scan)
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary        Fields: 10
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          ID   Code Name                RA               Decl           Epoch   SrcId      nRows
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          0    N    J1331+3030          13:31:08.287984 +30.30.32.95886 J2000   0          31922
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          1    J    J1822-0938          18:22:28.704200 -09.38.56.83501 J2000   1          41256
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          2    NONE 3C391 C1            18:49:24.244000 -00.55.40.58001 J2000   2         109808
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          3    NONE 3C391 C2            18:49:29.149001 -00.57.48.00001 J2000   3         108902
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          4    NONE 3C391 C3            18:49:19.339000 -00.57.48.00001 J2000   4         108357
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          5    NONE 3C391 C4            18:49:14.434001 -00.55.40.58001 J2000   5         110105
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          6    NONE 3C391 C5            18:49:19.339000 -00.53.33.16000 J2000   6         110539
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          7    NONE 3C391 C6            18:49:29.149001 -00.53.33.16000 J2000   7         110224
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          8    NONE 3C391 C7            18:49:34.054000 -00.55.40.58001 J2000   8         109524
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          9    Z    J0319+4130          03:19:48.160102 +41.30.42.10305 J2000   9           9721
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary        Spectral Windows:  (1 unique spectral windows and 1 unique polarization setups)
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          SpwID  Name      #Chans   Frame   Ch0(MHz)  ChanWid(kHz)  TotBW(kHz) CtrFreq(MHz) BBC Num  Corrs         
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          0      Subband:0     64   TOPO    4536.000      2000.000    128000.0   4599.0000        4  RR  RL  LR  LL
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary        Sources: 10
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          ID   Name                SpwId RestFreq(MHz)  SysVel(km/s)
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          0    J1331+3030          0     -              -           
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          1    J1822-0938          0     -              -           
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          2    3C391 C1            0     -              -           
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          3    3C391 C2            0     -              -           
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          4    3C391 C3            0     -              -           
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          5    3C391 C4            0     -              -           
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          6    3C391 C5            0     -              -           
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          7    3C391 C6            0     -              -           
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          8    3C391 C7            0     -              -           
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          9    J0319+4130          0     -              -           
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary        Antennas: 26:
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          ID   Name  Station   Diam.    Long.         Lat.                Offset from array center (m)                ITRF Geocentric coordinates (m)       
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+                                                                             East         North     Elevation               x               y               z
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          0    ea01  W09       25.0 m   -107.37.25.2  +33.53.51.0       -521.9407     -332.7782       -1.1977 -1601710.017000 -5042006.928200  3554602.355600
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          1    ea02  E02       25.0 m   -107.37.04.4  +33.54.01.1          9.8247      -20.4292       -2.7808 -1601150.059500 -5042000.619800  3554860.729400
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          2    ea03  E09       25.0 m   -107.36.45.1  +33.53.53.6        506.0591     -251.8666       -3.5832 -1600715.948000 -5042273.187000  3554668.184500
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          3    ea04  W01       25.0 m   -107.37.05.9  +33.54.00.5        -27.3562      -41.3030       -2.7418 -1601189.030140 -5042000.493300  3554843.425700
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          4    ea05  W08       25.0 m   -107.37.21.6  +33.53.53.0       -432.1158     -272.1493       -1.5032 -1601614.091000 -5042001.655700  3554652.509300
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          5    ea07  N06       25.0 m   -107.37.06.9  +33.54.10.3        -54.0667      263.8720       -4.2292 -1601162.593200 -5041829.000000  3555095.890500
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          6    ea08  N01       25.0 m   -107.37.06.0  +33.54.01.8        -30.8810       -1.4664       -2.8597 -1601185.634945 -5041978.156586  3554876.424700
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          7    ea09  E06       25.0 m   -107.36.55.6  +33.53.57.7        236.9058     -126.3369       -2.4443 -1600951.588000 -5042125.911000  3554773.012300
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          8    ea11  E04       25.0 m   -107.37.00.8  +33.53.59.7        102.8046      -63.7684       -2.6412 -1601068.791200 -5042051.910200  3554824.835300
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          9    ea12  E08       25.0 m   -107.36.48.9  +33.53.55.1        407.8394     -206.0057       -3.2252 -1600801.916000 -5042219.371000  3554706.449900
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          10   ea13  N07       25.0 m   -107.37.07.2  +33.54.12.9        -61.1040      344.2335       -4.6144 -1601155.635800 -5041783.843000  3555162.374100
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          11   ea14  E05       25.0 m   -107.36.58.4  +33.53.58.8        164.9788      -92.8032       -2.5268 -1601014.462000 -5042086.252000  3554800.799800
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          12   ea15  W06       25.0 m   -107.37.15.6  +33.53.56.4       -275.8288     -166.7451       -2.0590 -1601447.198000 -5041992.502500  3554739.687600
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          13   ea16  W02       25.0 m   -107.37.07.5  +33.54.00.9        -67.9687      -26.5614       -2.7175 -1601225.255200 -5041980.383590  3554855.675000
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          14   ea17  W07       25.0 m   -107.37.18.4  +33.53.54.8       -349.9866     -216.7507       -1.7978 -1601526.386100 -5041996.840100  3554698.327400
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          15   ea18  N09       25.0 m   -107.37.07.8  +33.54.19.0        -77.4352      530.6274       -5.5867 -1601139.485500 -5041679.036000  3555316.532800
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          16   ea19  W04       25.0 m   -107.37.10.8  +33.53.59.1       -152.8599      -83.8054       -2.4614 -1601315.893000 -5041985.320170  3554808.304600
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          17   ea20  N05       25.0 m   -107.37.06.7  +33.54.08.0        -47.8454      192.6015       -3.8723 -1601168.786100 -5041869.054000  3555036.936000
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          18   ea21  E01       25.0 m   -107.37.05.7  +33.53.59.2        -23.8638      -81.1510       -2.5851 -1601192.467800 -5042022.856800  3554810.438800
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          19   ea22  N04       25.0 m   -107.37.06.5  +33.54.06.1        -42.5986      132.8623       -3.5431 -1601173.953700 -5041902.660400  3554987.536500
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          20   ea23  E07       25.0 m   -107.36.52.4  +33.53.56.5        318.0523     -164.1848       -2.6960 -1600880.570000 -5042170.388000  3554741.457400
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          21   ea24  W05       25.0 m   -107.37.13.0  +33.53.57.8       -210.0944     -122.3885       -2.2581 -1601377.008000 -5041988.665500  3554776.393400
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          22   ea25  N02       25.0 m   -107.37.06.2  +33.54.03.5        -35.6245       53.1806       -3.1345 -1601180.861480 -5041947.453400  3554921.628700
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          23   ea26  W03       25.0 m   -107.37.08.9  +33.54.00.1       -105.3429      -51.7191       -2.6054 -1601265.151700 -5041982.533050  3554834.856300
17-Sep-2024 18:26:14 2024-09-17 18:26:14        INFO        listobs::ms::summary+          24   ea27  E03       25.0 m   -107.37.02.8  +33.54.00.5         50.6647      -39.4832       -2.7249 -1601114.365500 -5042023.153700  3554844.945600
17-Sep-2024 18:26:22 2024-09-17 18:26:14        INFO        listobs::ms::summary+          25   ea28  N08       25.0 m   -107.37.07.5  +33.54.15.8        -68.9057      433.1889       -5.0602 -1601147.940400 -5041733.837000  3555235.956000
17-Sep-2024 18:26:22 2024-09-17 18:26:14        INFO        listobs::::casa        Task listobs complete. Start time: 2024-09-17 18:26:14.088392 End time: 2024-09-17 18:26:14.418319
17-Sep-2024 18:26:22 2024-09-17 18:26:14        INFO        listobs::::casa        ##### End Task: listobs              #####
17-Sep-2024 18:26:22 2024-09-17 18:26:14        INFO        listobs::::casa        ##########################################
17-Sep-2024 18:26:22 Expected 850358 rows in split MS, got 850358, tolerance exact
17-Sep-2024 18:26:22 2024-09-17 18:26:14        INFO        gencal::::casa        ##########################################
17-Sep-2024 18:26:22 2024-09-17 18:26:14        INFO        gencal::::casa        ##### Begin Task: gencal             #####
17-Sep-2024 18:26:22 2024-09-17 18:26:14        INFO        gencal::::casa        gencal( vis='3c391_ctm_mosaic_10s_spw0.ms', caltable='3c391_ctm_mosaic_10s_spw0.antpos', caltype='antpos', infile='', endpoint='asdm', timeout=180, retry=3, retry_wait_time=5, ant_pos_time_limit=0, spw='', antenna='', pol='', parameter=[], uniform=True )
17-Sep-2024 18:26:22 2024-09-17 18:26:14        INFO        calibrater::open        ****Using NEW VI2-driven calibrater tool****
17-Sep-2024 18:26:22 2024-09-17 18:26:14        INFO        calibrater::open        Opening MS: 3c391_ctm_mosaic_10s_spw0.ms for calibration.
17-Sep-2024 18:26:22 2024-09-17 18:26:14        INFO        Calibrater::        Initializing nominal selection to the whole MS.
17-Sep-2024 18:26:22 2024-09-17 18:26:14        INFO        gencal::::casa         Determine antenna position offsets from the baseline correction database
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO        gencal::::casa        offsets for antenna ea01 :  0.00000   0.00300   0.00000
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO        gencal::::casa        offsets for antenna ea02 : -0.00080   0.00000   0.00000
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO        gencal::::casa        offsets for antenna ea03 : -0.00280   0.00000   0.00000
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO        gencal::::casa        offsets for antenna ea05 :  0.00000   0.00280   0.00000
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO        gencal::::casa        offsets for antenna ea11 :  0.00090   0.00000   0.00000
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO        gencal::::casa        offsets for antenna ea12 : -0.01000   0.00450  -0.00170
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO        gencal::::casa        offsets for antenna ea13 :  0.00000  -0.00080   0.00000
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO        gencal::::casa        offsets for antenna ea17 : -0.00120   0.00000   0.00000
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO        gencal::::casa        offsets for antenna ea18 :  0.00040  -0.00080   0.00040
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO        gencal::::casa        offsets for antenna ea22 : -0.02570   0.00270  -0.01900
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO        gencal::::casa        offsets for antenna ea23 : -0.00140   0.00000   0.00000
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO        gencal::::casa        offsets for antenna ea24 : -0.00150   0.00000   0.00000
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO        gencal::::casa        offsets for antenna ea26 : -0.00190   0.00000   0.00210
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO        gencal::::casa        offsets for antenna ea27 :  0.00000   0.00190  -0.00160
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO        calibrater::specifycal        Beginning specifycal-----------------------
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO                Creating KAntPos Jones table from specified parameters.
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO                Writing solutions to table: 3c391_ctm_mosaic_10s_spw0.antpos
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO        gencal::::casa        Task gencal complete. Start time: 2024-09-17 18:26:14.427994 End time: 2024-09-17 18:26:17.447920
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO        gencal::::casa        ##### End Task: gencal               #####
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO        gencal::::casa        ##########################################
17-Sep-2024 18:26:22 Expected 14 nonzero antenna position corrections, got 14, tolerance exact
17-Sep-2024 18:26:22 Expected minimum antenna position correction of -0.0257, got -0.025699999183416367, tolerance 1e-05
17-Sep-2024 18:26:22 Expected maximum antenna position correction of 0.0045, got 0.0044999998062849045, tolerance 1e-05
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO        setjy::::casa        ##########################################
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO        setjy::::casa        ##### Begin Task: setjy              #####
17-Sep-2024 18:26:22 2024-09-17 18:26:17        INFO        setjy::::casa        setjy( vis='3c391_ctm_mosaic_10s_spw0.ms', field='J1331+3030', spw='', selectdata=False, timerange='', scan='', intent='', observation='', scalebychan=True, standard='Perley-Butler 2017', model='3C286_C.im', listmodels=False, fluxdensity=-1, spix=0.0, reffreq='1GHz', polindex=[], polangle=[], rotmeas=0.0, fluxdict={}, useephemdir=False, interpolation='nearest', usescratch=False, ismms=False )
17-Sep-2024 18:26:22 2024-09-17 18:26:22        INFO        setjy::::casa        {'field': 'J1331+3030'}
17-Sep-2024 18:26:22 2024-09-17 18:26:22        INFO        Imager::open()         Opening MeasurementSet /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_mosaic_10s_spw0.ms
17-Sep-2024 18:26:22 2024-09-17 18:26:23        INFO        setjy::::casa        Using /opt/casa/data/casa-data/nrao/VLA/CalModels/3C286_C.im for model.
17-Sep-2024 18:26:22 2024-09-17 18:26:23        INFO        imager::setjy()        Using channel dependent flux densities
17-Sep-2024 18:26:22 2024-09-17 18:26:23        INFO        imager::data selection        Selected 31922 out of 850358 rows.
17-Sep-2024 18:26:22 2024-09-17 18:26:23        INFO        imager::setjy()          J1331+3030 (fld ind 0) spw 0  [I=7.6686, Q=0, U=0, V=0] Jy @ 4.536e+09Hz, (Perley-Butler 2017)
17-Sep-2024 18:26:22 terminate called after throwing an instance of 'casacore::ArrayShapeError'
17-Sep-2024 18:26:22   what():  ArrayBase::Array(const IPosition&) - Negative shape shape [-2147483647] differs from [-2147483647]
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] *** Process received signal ***
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] Signal: Aborted (6)
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] Signal code:  (-6)
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] [ 0] /lib64/libpthread.so.0(+0x12c20)[0x7f2ab4ac9c20]
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] [ 1] /lib64/libc.so.6(gsignal+0x10f)[0x7f2ab3f9f37f]
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] [ 2] /lib64/libc.so.6(abort+0x127)[0x7f2ab3f89db5]
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] [ 3] /lib64/libstdc++.so.6(+0x9009b)[0x7f2aaf10709b]
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] [ 4] /lib64/libstdc++.so.6(+0x9653c)[0x7f2aaf10d53c]
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] [ 5] /lib64/libstdc++.so.6(+0x96597)[0x7f2aaf10d597]
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] [ 6] /lib64/libstdc++.so.6(+0x967f8)[0x7f2aaf10d7f8]
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] [ 7] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/lib/libcasa_casa.so.7(+0x1386e8)[0x7f2a9be566e8]
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] [ 8] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/lib/libcasa_casa.so.7(_ZN8casacore5ArrayIdEC1ERKNS_9IPositionE+0x12)[0x7f2a9becf412]
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] [ 9] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/lib/libcasa_casa.so.7(_ZN8casacore6VectorIdEC1Em+0x29)[0x7f2a9bf14319]
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] [10] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/lib/libcasacpp_synthesis.so.6(_ZN4casa6Imager13sjy_prepImageERN8casacore5LogIOERNS_12FluxStandardERNS1_6VectorIdEES8_S8_RKNS1_6StringERKNS1_17MSSpWindowColumnsENS6_IiEEbRKNS6_INS6_INS1_10MFrequencyEEEEESB_RKNS1_10MDirectionERKNS1_4UnitERKS7_bSS_RKSG_RKNS1_6MEpochEi+0x885)[0x7f2a9dc85285]
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] [11] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/lib/libcasacpp_synthesis.so.6(_ZN4casa6Imager5setjyERKN8casacore6VectorIiEES5_RKNS1_6StringES8_S8_RKNS2_IdEES8_bSB_RKNS1_10MFrequencyESB_SB_RKdS8_S8_S8_S8_S8_+0x2825)[0x7f2a9dc935d5]
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] [12] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/_imager.cpython-310-x86_64-linux-gnu.so(_ZN5casac6imager5setjyERKNS_7variantES3_RKNSt7__cxx1112basic_stringIcSt11char_traitsIcESaIcEEERKSt6vectorIdSaIdEESB_bSG_S3_SG_SG_dSB_SB_SB_SB_SB_+0x709)[0x7f2a92300749]
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] [13] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/_imager.cpython-310-x86_64-linux-gnu.so(+0x5eb5f)[0x7f2a922eeb5f]
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] [14] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/bin/python3[0x56b2e6]
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] [15] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/bin/python3(PyObject_Call+0xb4)[0x4dc084]
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] [16] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/bin/python3(_PyEval_EvalFrameDefault+0x5d7b)[0x5356ab]
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] [17] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/bin/python3[0x52eb80]
17-Sep-2024 18:26:22 [8d49fe10e18c:00227] [18] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/bin/python3[0x565e2d]
17-Sep-2024 18:26:23 [8d49fe10e18c:00227] [19] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/bin/python3(_PyEval_EvalFrameDefault+0x4e09)[0x534739]
17-Sep-2024 18:26:23 [8d49fe10e18c:00227] [20] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/bin/python3[0x52eb80]
17-Sep-2024 18:26:23 [8d49fe10e18c:00227] [21] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/bin/python3[0x565e2d]
17-Sep-2024 18:26:23 [8d49fe10e18c:00227] [22] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/bin/python3(PyObject_Call+0x229)[0x4dc1f9]
17-Sep-2024 18:26:23 [8d49fe10e18c:00227] [23] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/bin/python3(_PyEval_EvalFrameDefault+0x2cd6)[0x532606]
17-Sep-2024 18:26:23 [8d49fe10e18c:00227] [24] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/bin/python3[0x52eb80]
17-Sep-2024 18:26:23 [8d49fe10e18c:00227] [25] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/bin/python3(_PyEval_EvalFrameDefault+0x338)[0x52fc68]
17-Sep-2024 18:26:23 [8d49fe10e18c:00227] [26] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/bin/python3[0x52eb80]
17-Sep-2024 18:26:23 [8d49fe10e18c:00227] [27] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/bin/python3(_PyEval_EvalFrameDefault+0x338)[0x52fc68]
17-Sep-2024 18:26:23 [8d49fe10e18c:00227] [28] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/bin/python3[0x52eb80]
17-Sep-2024 18:26:23 [8d49fe10e18c:00227] [29] /home/casatest/work/pkg/casa-6.7.0-3-py3.10.el8/lib/py/bin/python3(_PyObject_Call_Prepend+0x199)[0x4db8d9]
17-Sep-2024 18:26:23 [8d49fe10e18c:00227] *** End of error message ***
17-Sep-2024 18:26:23 --------------------------------------------------------------------------
17-Sep-2024 18:26:23 prterun noticed that process rank 0 with PID 227 on node 8d49fe10e18c exited on
17-Sep-2024 18:26:23 signal 6 (Aborted).
17-Sep-2024 18:26:23 --------------------------------------------------------------------------
17-Sep-2024 18:26:23
17-Sep-2024 18:26:23 Executor result: 134
17-Sep-2024 18:26:23 Failed tests:['Executor returned a non-zero exit code']
17-Sep-2024 18:26:23
17-Sep-2024 18:26:23 Results: [{'testname': 'test_stk_vla_users_continuum_from_SDM', 'runtime': '0:06:32.135416', 'returncode': 1, 'testerr': ['Executor returned a non-zero exit code']}]
17-Sep-2024 18:26:23 Stopping Xvfb.
17-Sep-2024 18:26:23 Stopping framebuffer <Popen: returncode: None args: ['Xvfb', ':111', '-screen', '0', '2048x2048x2...>
17-Sep-2024 18:26:23 Virtual frame buffer deployed at :111 with pid 124 successfully shutdown
17-Sep-2024 18:26:23 Xvfb stopped.
17-Sep-2024 18:26:23 cp: cannot stat '/home/casatest/work/test_stk_vla_users_continuum_from_SDM/test_vla_users_continuum_from_sdm_weblog.html': No such file or directory
17-Sep-2024 18:26:23 cp: cannot stat '/home/casatest/work/test_stk_vla_users_continuum_from_SDM/*.png': No such file or directory
17-Sep-2024 18:26:23 total 989860
17-Sep-2024 18:26:23 -rw-r--r-- 1 casaci    15001 1013609516 Sep 17 18:18 casa-6.7.0-3-py3.10.el8.tar.xz
17-Sep-2024 18:26:23 drwxr-xr-x 2 casaci root              6 Sep 17 18:26 html
17-Sep-2024 18:26:23 -rw-r--r-- 1 casaci casatest        413 Sep 17 18:26 xUnit-suite-mpi-8.xml
17-Sep-2024 18:26:23 total 0
17-Sep-2024 18:26:23 Finished task 'Script' with result: Success
17-Sep-2024 18:26:23 Starting task 'Parse test results' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
17-Sep-2024 18:26:23 Parsing test results under /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASA-CMTSP3-STCR85D...
17-Sep-2024 18:26:23 Failing task since 1 failing test cases were found.
17-Sep-2024 18:26:23 Finished task 'Parse test results' with result: Failed
17-Sep-2024 18:26:23
Substituting variable: ${bamboo.capability.hostname} with cvpost135
17-Sep-2024 18:26:23
Substituting variable: ${bamboo.capability.hostname} with cvpost135
17-Sep-2024 18:26:23 Starting task 'Cleanup' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
17-Sep-2024 18:26:23
Beginning to execute external process for build 'CASA - CMake Master Test Stakeholder Python 3.10 - VLA Stakeholder Tests MPI EL8 Docker #2 (CASA-CMTSP3-STCR85D-2)'
... running command line:
/export/cvpost135-nvme/casa/bamboohome/temp/CASA-CMTSP3-STCR85D-2-ScriptBuildTask-8858869361807393088.sh
... in: /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASA-CMTSP3-STCR85D
17-Sep-2024 18:26:23 Starting cleanup
17-Sep-2024 18:26:34 test-container
17-Sep-2024 18:26:42 test-container
17-Sep-2024 18:26:42 Cleanup complete
17-Sep-2024 18:26:42 Finished task 'Cleanup' with result: Success
17-Sep-2024 18:26:42 Running post build plugin 'Docker Container Cleanup'
17-Sep-2024 18:26:42 Running post build plugin 'NCover Results Collector'
17-Sep-2024 18:26:42 Running post build plugin 'Build Results Label Collector'
17-Sep-2024 18:26:42 Running post build plugin 'Clover Results Collector'
17-Sep-2024 18:26:42 Running post build plugin 'npm Cache Cleanup'
17-Sep-2024 18:26:42 Running post build plugin 'Artifact Copier'
17-Sep-2024 18:26:42 Publishing an artifact: VLA Stakeholder MPI
17-Sep-2024 18:26:42 Failing as no matching files has been found and empty artifacts are not allowed.
17-Sep-2024 18:26:42 Unable to publish artifact [VLA Stakeholder MPI]:
17-Sep-2024 18:26:42 The artifact hasn't been successfully published after 40.20 ms
17-Sep-2024 18:26:42 Finalising the build...
17-Sep-2024 18:26:42 Stopping timer.
17-Sep-2024 18:26:42 Build CASA-CMTSP3-STCR85D-2 completed.
17-Sep-2024 14:26:42 Running on server: post build plugin 'Build Hanging Detection Configuration'
17-Sep-2024 14:26:42 Running on server: post build plugin 'NCover Results Collector'
17-Sep-2024 14:26:42 Running on server: post build plugin 'Build Labeller'
17-Sep-2024 14:26:42 Running on server: post build plugin 'Clover Delta Calculator'
17-Sep-2024 14:26:42 Running on server: post build plugin 'Maven Dependencies Postprocessor'
17-Sep-2024 14:26:42 All post build plugins have finished
17-Sep-2024 14:26:42 Generating build results summary...
17-Sep-2024 14:26:42 Saving build results to disk...
17-Sep-2024 14:26:42 Store variable context...
17-Sep-2024 14:26:42 Finished building CASA-CMTSP3-STCR85D-2.