Stakeholder tests for Python 3.10

Build: #7 failed

Job: Test VLA Stakeholder Tests MPI Rocky 8.5 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.

04-Oct-2024 09:40:23 Finished task 'Stop and remove running test containers' with result: Success
04-Oct-2024 09:40:23
Substituting variable: ${bamboo.capability.hostname} with cvpost135
04-Oct-2024 09:40:23
Substituting variable: ${bamboo.capability.hostname} with cvpost135
04-Oct-2024 09:40:23
Substituting variable: ${bamboo.build.working.directory} with /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASA-CMTSP3-STCR85D
04-Oct-2024 09:40:23 Starting task 'Start container' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
04-Oct-2024 09:40:23
Beginning to execute external process for build 'CASA - CMake Master Test Stakeholder Python 3.10 - VLA Stakeholder Tests MPI EL8 Docker #7 (CASA-CMTSP3-STCR85D-7)'
... running command line:
/export/cvpost135-nvme/casa/bamboohome/temp/CASA-CMTSP3-STCR85D-7-ScriptBuildTask-3704488875659946838.sh
... in: /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASA-CMTSP3-STCR85D
04-Oct-2024 09:40:39 2afa582414ff830f5fe8443267a5a7b622d9cc9f28d16f308ef77aebe4255c00
04-Oct-2024 09:40:39 Finished task 'Start container' with result: Success
04-Oct-2024 09:40:39 Skipping execution of task 'Mount /opt/casa/data' as it is disabled
04-Oct-2024 09:40:39 Skipping execution of task 'Mount  /export/cvpost134-4tb/casa/casa-data' as it is disabled
04-Oct-2024 09:40:39 Skipping execution of task 'Mount  /export/cvpost135-4tb/casa/casa-data' as it is disabled
04-Oct-2024 09:40:39
Substituting variable: ${bamboo.planRepository.branchName} with master
04-Oct-2024 09:40:39 Starting task 'Script' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
04-Oct-2024 09:40:39
Beginning to execute external process for build 'CASA - CMake Master Test Stakeholder Python 3.10 - VLA Stakeholder Tests MPI EL8 Docker #7 (CASA-CMTSP3-STCR85D-7)'
... running command line:
/export/cvpost135-nvme/casa/bamboohome/temp/CASA-CMTSP3-STCR85D-7-ScriptBuildTask-1647625405887942074.sh
... in: /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASA-CMTSP3-STCR85D
04-Oct-2024 09:40:39 /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASA-CMTSP3-STCR85D
04-Oct-2024 09:40:39   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
04-Oct-2024 09:40:39                                  Dload  Upload   Total   Spent    Left  Speed
04-Oct-2024 09:40:39
04-Oct-2024 09:40:39   0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0
04-Oct-2024 09:40:39 100 6002k  100 6002k    0     0  75.1M      0 --:--:-- --:--:-- --:--:-- 75.1M
04-Oct-2024 09:40:39 Components:
04-Oct-2024 09:40:39 Using container name test-container
04-Oct-2024 09:40:39 datapath=[  "/opt/casa/data/casa-data","/opt/casa/data/casatestdata-large"]
04-Oct-2024 09:40:39 measurespath="opt/casa/data/casa-data"
04-Oct-2024 09:40:39 measures_auto_update=False
04-Oct-2024 09:40:39 data_auto_update=False
04-Oct-2024 09:40:39 total 990260
04-Oct-2024 09:40:39 -rw-r--r-- 1 9285 15001 1014024892 Oct  4 09:40 casa-6.7.0-7-py3.10.el8.tar.xz
04-Oct-2024 09:40:39 config.py:
04-Oct-2024 09:40:39 datapath=[  "/opt/casa/data/casa-data","/opt/casa/data/casatestdata-large"]
04-Oct-2024 09:40:39 measurespath="opt/casa/data/casa-data"
04-Oct-2024 09:40:39 measures_auto_update=False
04-Oct-2024 09:40:39 data_auto_update=False
04-Oct-2024 09:40:39 Cloning into 'casa-build-utils'...
04-Oct-2024 09:40:40 Cloning into 'casa6'...
04-Oct-2024 09:40:49 Updating files:  26% (2460/9315)
04-Oct-2024 09:40:49 Updating files:  27% (2516/9315)
04-Oct-2024 09:40:49 Updating files:  28% (2609/9315)
04-Oct-2024 09:40:50 Updating files:  29% (2702/9315)
04-Oct-2024 09:40:50 Updating files:  30% (2795/9315)
04-Oct-2024 09:40:50 Updating files:  31% (2888/9315)
04-Oct-2024 09:40:50 Updating files:  32% (2981/9315)
04-Oct-2024 09:40:50 Updating files:  33% (3074/9315)
04-Oct-2024 09:40:50 Updating files:  34% (3168/9315)
04-Oct-2024 09:40:50 Updating files:  35% (3261/9315)
04-Oct-2024 09:40:50 Updating files:  36% (3354/9315)
04-Oct-2024 09:40:50 Updating files:  37% (3447/9315)
04-Oct-2024 09:40:50 Updating files:  38% (3540/9315)
04-Oct-2024 09:40:50 Updating files:  39% (3633/9315)
04-Oct-2024 09:40:50 Updating files:  40% (3726/9315)
04-Oct-2024 09:40:50 Updating files:  41% (3820/9315)
04-Oct-2024 09:40:50 Updating files:  42% (3913/9315)
04-Oct-2024 09:40:50 Updating files:  43% (4006/9315)
04-Oct-2024 09:40:50 Updating files:  44% (4099/9315)
04-Oct-2024 09:40:50 Updating files:  45% (4192/9315)
04-Oct-2024 09:40:50 Updating files:  46% (4285/9315)
04-Oct-2024 09:40:50 Updating files:  47% (4379/9315)
04-Oct-2024 09:40:50 Updating files:  47% (4388/9315)
04-Oct-2024 09:40:50 Updating files:  48% (4472/9315)
04-Oct-2024 09:40:50 Updating files:  49% (4565/9315)
04-Oct-2024 09:40:51 Updating files:  50% (4658/9315)
04-Oct-2024 09:40:51 Updating files:  51% (4751/9315)
04-Oct-2024 09:40:51 Updating files:  52% (4844/9315)
04-Oct-2024 09:40:51 Updating files:  53% (4937/9315)
04-Oct-2024 09:40:51 Updating files:  54% (5031/9315)
04-Oct-2024 09:40:51 Updating files:  55% (5124/9315)
04-Oct-2024 09:40:51 Updating files:  56% (5217/9315)
04-Oct-2024 09:40:51 Updating files:  57% (5310/9315)
04-Oct-2024 09:40:51 Updating files:  58% (5403/9315)
04-Oct-2024 09:40:51 Updating files:  59% (5496/9315)
04-Oct-2024 09:40:51 Updating files:  60% (5589/9315)
04-Oct-2024 09:40:51 Updating files:  61% (5683/9315)
04-Oct-2024 09:40:51 Updating files:  62% (5776/9315)
04-Oct-2024 09:40:51 Updating files:  63% (5869/9315)
04-Oct-2024 09:40:51 Updating files:  64% (5962/9315)
04-Oct-2024 09:40:51 Updating files:  65% (6055/9315)
04-Oct-2024 09:40:51 Updating files:  66% (6148/9315)
04-Oct-2024 09:40:51 Updating files:  67% (6242/9315)
04-Oct-2024 09:40:51 Updating files:  67% (6283/9315)
04-Oct-2024 09:40:51 Updating files:  68% (6335/9315)
04-Oct-2024 09:40:51 Updating files:  69% (6428/9315)
04-Oct-2024 09:40:52 Updating files:  70% (6521/9315)
04-Oct-2024 09:40:52 Updating files:  71% (6614/9315)
04-Oct-2024 09:40:52 Updating files:  72% (6707/9315)
04-Oct-2024 09:40:52 Updating files:  73% (6800/9315)
04-Oct-2024 09:40:52 Updating files:  74% (6894/9315)
04-Oct-2024 09:40:52 Updating files:  75% (6987/9315)
04-Oct-2024 09:40:52 Updating files:  76% (7080/9315)
04-Oct-2024 09:40:52 Updating files:  77% (7173/9315)
04-Oct-2024 09:40:52 Updating files:  78% (7266/9315)
04-Oct-2024 09:40:52 Updating files:  79% (7359/9315)
04-Oct-2024 09:40:52 Updating files:  80% (7452/9315)
04-Oct-2024 09:40:52 Updating files:  81% (7546/9315)
04-Oct-2024 09:40:52 Updating files:  82% (7639/9315)
04-Oct-2024 09:40:52 Updating files:  83% (7732/9315)
04-Oct-2024 09:40:52 Updating files:  84% (7825/9315)
04-Oct-2024 09:40:52 Updating files:  85% (7918/9315)
04-Oct-2024 09:40:52 Updating files:  86% (8011/9315)
04-Oct-2024 09:40:52 Updating files:  86% (8026/9315)
04-Oct-2024 09:40:52 Updating files:  87% (8105/9315)
04-Oct-2024 09:40:52 Updating files:  88% (8198/9315)
04-Oct-2024 09:40:53 Updating files:  89% (8291/9315)
04-Oct-2024 09:40:53 Updating files:  90% (8384/9315)
04-Oct-2024 09:40:53 Updating files:  91% (8477/9315)
04-Oct-2024 09:40:53 Updating files:  92% (8570/9315)
04-Oct-2024 09:40:53 Updating files:  93% (8663/9315)
04-Oct-2024 09:40:53 Updating files:  94% (8757/9315)
04-Oct-2024 09:40:53 Updating files:  95% (8850/9315)
04-Oct-2024 09:40:53 Updating files:  96% (8943/9315)
04-Oct-2024 09:40:53 Updating files:  97% (9036/9315)
04-Oct-2024 09:40:53 Updating files:  98% (9129/9315)
04-Oct-2024 09:40:53 Updating files:  99% (9222/9315)
04-Oct-2024 09:40:53 Updating files: 100% (9315/9315)
04-Oct-2024 09:40:53 Updating files: 100% (9315/9315), done.
04-Oct-2024 09:40:53 error: pathspec 'origin/CAS-14357' did not match any file(s) known to git
04-Oct-2024 09:40:53 tarfile casa-6.7.0-7-py3.10.el8.tar.xz
04-Oct-2024 09:41:27   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
04-Oct-2024 09:41:27                                  Dload  Upload   Total   Spent    Left  Speed
04-Oct-2024 09:41:27
04-Oct-2024 09:41:27   0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0
04-Oct-2024 09:41:27 100   669    0   669    0     0  31857      0 --:--:-- --:--:-- --:--:-- 31857
04-Oct-2024 09:41:42 HAVE_PYTEST: False
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 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-7-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)
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 Operating system: Linux
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 Arguments Sent Direct To Pytest :  []
04-Oct-2024 09:41:42 Package: /dockershare/casa-6.7.0-7-py3.10.el8.tar.xz
04-Oct-2024 09:41:42 Test configuration file: /home/casatest/casa6/casatestutils/casatestutils/component_to_test_map.json
04-Oct-2024 09:41:42 Number of cores: 8
04-Oct-2024 09:41:42 Workdir: /home/casatest/work
04-Oct-2024 09:41:42 branch: None
04-Oct-2024 09:41:42 ---------------     run_bamboo     ---------------
04-Oct-2024 09:41:42 Test list: ['test_stk_vla_users_continuum_from_SDM']
04-Oct-2024 09:41:42 Test group: None
04-Oct-2024 09:41:42 Unpacking tarball: /dockershare/casa-6.7.0-7-py3.10.el8.tar.xz to /home/casatest/work/pkg
04-Oct-2024 09:41:42 ['tar', '-xf', '/dockershare/casa-6.7.0-7-py3.10.el8.tar.xz', '-C', '/home/casatest/work/pkg']
04-Oct-2024 09:41:42 Executing: ['tar', '-xf', '/dockershare/casa-6.7.0-7-py3.10.el8.tar.xz', '-C', '/home/casatest/work/pkg']
04-Oct-2024 09:41:42 Executor result: 0
04-Oct-2024 09:41:42 Failed tests:[]
04-Oct-2024 09:41:42 Outputdir contents:/home/casatest/work/pkg
04-Oct-2024 09:41:42 casa-6.7.0-7-py3.10.el8
04-Oct-2024 09:41:42 installpath: casa-6.7.0-7-py3.10.el8
04-Oct-2024 09:41:42 Package root: /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8
04-Oct-2024 09:41:42 Executable path: /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/bin
04-Oct-2024 09:41:42 Casatestutils Path: /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatestutils/runtest.py
04-Oct-2024 09:41:42 Starting Xvfb
04-Oct-2024 09:41:42 Xvfb :111 -screen 0 2048x2048x24+32 -auth /tmp/CASA_testrunner_xauthye3wcu8r/tmpjeo63goh
04-Oct-2024 09:41:42 Deployed virtual frame buffer at port :111 with PID 124
04-Oct-2024 09:41:42 run_bamboo fetch_tests branchmaster
04-Oct-2024 09:41:42 Fetching Repository: casa6
04-Oct-2024 09:41:42         Running:  git clone https://open-bitbucket.nrao.edu/scm/casa/casa6
04-Oct-2024 09:41:42 Executing: ['git', 'clone', 'https://open-bitbucket.nrao.edu/scm/casa/casa6']
04-Oct-2024 09:41:42 Cloning into 'casa6'...
04-Oct-2024 09:41:42 Updating files:  26% (2467/9315)
04-Oct-2024 09:41:42 Updating files:  27% (2516/9315)
04-Oct-2024 09:41:42 Updating files:  28% (2609/9315)
04-Oct-2024 09:41:42 Updating files:  29% (2702/9315)
04-Oct-2024 09:41:42 Updating files:  30% (2795/9315)
04-Oct-2024 09:41:42 Updating files:  31% (2888/9315)
04-Oct-2024 09:41:42 Updating files:  32% (2981/9315)
04-Oct-2024 09:41:42 Updating files:  33% (3074/9315)
04-Oct-2024 09:41:42 Updating files:  34% (3168/9315)
04-Oct-2024 09:41:42 Updating files:  35% (3261/9315)
04-Oct-2024 09:41:42 Updating files:  36% (3354/9315)
04-Oct-2024 09:41:42 Updating files:  37% (3447/9315)
04-Oct-2024 09:41:42 Updating files:  38% (3540/9315)
04-Oct-2024 09:41:42 Updating files:  39% (3633/9315)
04-Oct-2024 09:41:42 Updating files:  40% (3726/9315)
04-Oct-2024 09:41:42 Updating files:  41% (3820/9315)
04-Oct-2024 09:41:42 Updating files:  42% (3913/9315)
04-Oct-2024 09:41:42 Updating files:  43% (4006/9315)
04-Oct-2024 09:41:42 Updating files:  44% (4099/9315)
04-Oct-2024 09:41:42 Updating files:  45% (4192/9315)
04-Oct-2024 09:41:42 Updating files:  46% (4285/9315)
04-Oct-2024 09:41:42 Updating files:  47% (4379/9315)
04-Oct-2024 09:41:42 Updating files:  47% (4392/9315)
04-Oct-2024 09:41:42 Updating files:  48% (4472/9315)
04-Oct-2024 09:41:42 Updating files:  49% (4565/9315)
04-Oct-2024 09:41:42 Updating files:  50% (4658/9315)
04-Oct-2024 09:41:42 Updating files:  51% (4751/9315)
04-Oct-2024 09:41:42 Updating files:  52% (4844/9315)
04-Oct-2024 09:41:42 Updating files:  53% (4937/9315)
04-Oct-2024 09:41:42 Updating files:  54% (5031/9315)
04-Oct-2024 09:41:42 Updating files:  55% (5124/9315)
04-Oct-2024 09:41:42 Updating files:  56% (5217/9315)
04-Oct-2024 09:41:42 Updating files:  57% (5310/9315)
04-Oct-2024 09:41:42 Updating files:  58% (5403/9315)
04-Oct-2024 09:41:42 Updating files:  59% (5496/9315)
04-Oct-2024 09:41:42 Updating files:  60% (5589/9315)
04-Oct-2024 09:41:42 Updating files:  61% (5683/9315)
04-Oct-2024 09:41:42 Updating files:  62% (5776/9315)
04-Oct-2024 09:41:42 Updating files:  63% (5869/9315)
04-Oct-2024 09:41:42 Updating files:  64% (5962/9315)
04-Oct-2024 09:41:42 Updating files:  65% (6055/9315)
04-Oct-2024 09:41:42 Updating files:  66% (6148/9315)
04-Oct-2024 09:41:42 Updating files:  67% (6242/9315)
04-Oct-2024 09:41:42 Updating files:  67% (6286/9315)
04-Oct-2024 09:41:42 Updating files:  68% (6335/9315)
04-Oct-2024 09:41:42 Updating files:  69% (6428/9315)
04-Oct-2024 09:41:42 Updating files:  70% (6521/9315)
04-Oct-2024 09:41:42 Updating files:  71% (6614/9315)
04-Oct-2024 09:41:42 Updating files:  72% (6707/9315)
04-Oct-2024 09:41:42 Updating files:  73% (6800/9315)
04-Oct-2024 09:41:42 Updating files:  74% (6894/9315)
04-Oct-2024 09:41:42 Updating files:  75% (6987/9315)
04-Oct-2024 09:41:42 Updating files:  76% (7080/9315)
04-Oct-2024 09:41:42 Updating files:  77% (7173/9315)
04-Oct-2024 09:41:42 Updating files:  78% (7266/9315)
04-Oct-2024 09:41:42 Updating files:  79% (7359/9315)
04-Oct-2024 09:41:42 Updating files:  80% (7452/9315)
04-Oct-2024 09:41:42 Updating files:  81% (7546/9315)
04-Oct-2024 09:41:42 Updating files:  82% (7639/9315)
04-Oct-2024 09:41:42 Updating files:  83% (7732/9315)
04-Oct-2024 09:41:42 Updating files:  84% (7825/9315)
04-Oct-2024 09:41:42 Updating files:  85% (7918/9315)
04-Oct-2024 09:41:42 Updating files:  86% (8011/9315)
04-Oct-2024 09:41:42 Updating files:  86% (8035/9315)
04-Oct-2024 09:41:42 Updating files:  87% (8105/9315)
04-Oct-2024 09:41:42 Updating files:  88% (8198/9315)
04-Oct-2024 09:41:42 Updating files:  89% (8291/9315)
04-Oct-2024 09:41:42 Updating files:  90% (8384/9315)
04-Oct-2024 09:41:42 Updating files:  91% (8477/9315)
04-Oct-2024 09:41:42 Updating files:  92% (8570/9315)
04-Oct-2024 09:41:42 Updating files:  93% (8663/9315)
04-Oct-2024 09:41:42 Updating files:  94% (8757/9315)
04-Oct-2024 09:41:42 Updating files:  95% (8850/9315)
04-Oct-2024 09:41:42 Updating files:  96% (8943/9315)
04-Oct-2024 09:41:42 Updating files:  97% (9036/9315)
04-Oct-2024 09:41:42 Updating files:  98% (9129/9315)
04-Oct-2024 09:41:42 Updating files:  99% (9222/9315)
04-Oct-2024 09:41:42 Updating files: 100% (9315/9315)
04-Oct-2024 09:41:42 Updating files: 100% (9315/9315), done.
04-Oct-2024 09:41:42 Executor result: 0
04-Oct-2024 09:41:42 Failed tests:[]
04-Oct-2024 09:41:42         Running:  git checkout origin/master
04-Oct-2024 09:41:42 Executing: ['git', 'checkout', 'origin/master']
04-Oct-2024 09:41:42 Note: switching to 'origin/master'.
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 You are in 'detached HEAD' state. You can look around, make experimental
04-Oct-2024 09:41:42 changes and commit them, and you can discard any commits you make in this
04-Oct-2024 09:41:42 state without impacting any branches by switching back to a branch.
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 If you want to create a new branch to retain commits you create, you may
04-Oct-2024 09:41:42 do so (now or later) by using -c with the switch command. Example:
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42   git switch -c <new-branch-name>
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 Or undo this operation with:
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42   git switch -
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 Turn off this advice by setting config variable advice.detachedHead to false
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 HEAD is now at ac41758859 Pull request #870: Update casacore
04-Oct-2024 09:41:42 Executor result: 0
04-Oct-2024 09:41:42 Failed tests:[]
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 Fetching Repository: casampi
04-Oct-2024 09:41:42         Running:  git clone https://open-bitbucket.nrao.edu/scm/casa/casampi
04-Oct-2024 09:41:42 Executing: ['git', 'clone', 'https://open-bitbucket.nrao.edu/scm/casa/casampi']
04-Oct-2024 09:41:42 Cloning into 'casampi'...
04-Oct-2024 09:41:42 Executor result: 0
04-Oct-2024 09:41:42 Failed tests:[]
04-Oct-2024 09:41:42         Tag: tags/0.5.5
04-Oct-2024 09:41:42         Running:  git checkout tags/0.5.5
04-Oct-2024 09:41:42 Executing: ['git', 'checkout', 'tags/0.5.5']
04-Oct-2024 09:41:42 Note: switching to 'tags/0.5.5'.
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 You are in 'detached HEAD' state. You can look around, make experimental
04-Oct-2024 09:41:42 changes and commit them, and you can discard any commits you make in this
04-Oct-2024 09:41:42 state without impacting any branches by switching back to a branch.
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 If you want to create a new branch to retain commits you create, you may
04-Oct-2024 09:41:42 do so (now or later) by using -c with the switch command. Example:
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42   git switch -c <new-branch-name>
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 Or undo this operation with:
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42   git switch -
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 Turn off this advice by setting config variable advice.detachedHead to false
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 HEAD is now at aebe7c9 Pull request #14: Change aips2-request@nrao.edu to casa-feedback@nrao.edu
04-Oct-2024 09:41:42 Executor result: 0
04-Oct-2024 09:41:42 Failed tests:[]
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 Fetching Repository: casaplotms
04-Oct-2024 09:41:42         Running:  git clone https://open-bitbucket.nrao.edu/scm/casa/casaplotms
04-Oct-2024 09:41:42 Executing: ['git', 'clone', 'https://open-bitbucket.nrao.edu/scm/casa/casaplotms']
04-Oct-2024 09:41:42 Cloning into 'casaplotms'...
04-Oct-2024 09:41:42 Executor result: 0
04-Oct-2024 09:41:42 Failed tests:[]
04-Oct-2024 09:41:42         Tag: tags/2.5.2
04-Oct-2024 09:41:42         Running:  git checkout tags/2.5.2
04-Oct-2024 09:41:42 Executing: ['git', 'checkout', 'tags/2.5.2']
04-Oct-2024 09:41:42 Note: switching to 'tags/2.5.2'.
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 You are in 'detached HEAD' state. You can look around, make experimental
04-Oct-2024 09:41:42 changes and commit them, and you can discard any commits you make in this
04-Oct-2024 09:41:42 state without impacting any branches by switching back to a branch.
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 If you want to create a new branch to retain commits you create, you may
04-Oct-2024 09:41:42 do so (now or later) by using -c with the switch command. Example:
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42   git switch -c <new-branch-name>
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 Or undo this operation with:
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42   git switch -
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 Turn off this advice by setting config variable advice.detachedHead to false
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 HEAD is now at 94e0f52 Pull request #86: CAS-14309
04-Oct-2024 09:41:42 Executor result: 0
04-Oct-2024 09:41:42 Failed tests:[]
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 Fetching Repository: casaviewer
04-Oct-2024 09:41:42         Running:  git clone https://open-bitbucket.nrao.edu/scm/casa/casaviewer
04-Oct-2024 09:41:42 Executing: ['git', 'clone', 'https://open-bitbucket.nrao.edu/scm/casa/casaviewer']
04-Oct-2024 09:41:42 Cloning into 'casaviewer'...
04-Oct-2024 09:41:42 Executor result: 0
04-Oct-2024 09:41:42 Failed tests:[]
04-Oct-2024 09:41:42         Tag: tags/2.2.3
04-Oct-2024 09:41:42         Running:  git checkout tags/2.2.3
04-Oct-2024 09:41:42 Executing: ['git', 'checkout', 'tags/2.2.3']
04-Oct-2024 09:41:42 Note: switching to 'tags/2.2.3'.
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 You are in 'detached HEAD' state. You can look around, make experimental
04-Oct-2024 09:41:42 changes and commit them, and you can discard any commits you make in this
04-Oct-2024 09:41:42 state without impacting any branches by switching back to a branch.
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 If you want to create a new branch to retain commits you create, you may
04-Oct-2024 09:41:42 do so (now or later) by using -c with the switch command. Example:
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42   git switch -c <new-branch-name>
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42 Or undo this operation with:
04-Oct-2024 09:41:42
04-Oct-2024 09:41:42   git switch -
04-Oct-2024 09:41:42
04-Oct-2024 09:41:45 Turn off this advice by setting config variable advice.detachedHead to false
04-Oct-2024 09:41:45
04-Oct-2024 09:41:45 HEAD is now at 24d91fe Pull request #47: CAS-14309
04-Oct-2024 09:41:45 Executor result: 0
04-Oct-2024 09:41:45 Failed tests:[]
04-Oct-2024 09:41:45 Reading config from: /home/casatest/casa6/casatestutils/casatestutils/component_to_test_map.json
04-Oct-2024 09:41:45 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']
04-Oct-2024 09:41:45 Test list provided. Filtering tests.
04-Oct-2024 09:41:45 Subset tests:
04-Oct-2024 09:41:45 test_stk_vla_users_continuum_from_SDM
04-Oct-2024 09:41:45 Running test: test_stk_vla_users_continuum_from_SDM in MPI mode
04-Oct-2024 09:41:45 Running cmd ['/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/bin/mpicasa', '-n', '8', '/home/casatest/work/pkg/casa-6.7.0-7-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
04-Oct-2024 09:41:45 Executing: ['/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/bin/mpicasa', '-n', '8', '/home/casatest/work/pkg/casa-6.7.0-7-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']
04-Oct-2024 09:41:45
04-Oct-2024 09:41:45 Using user configuration file /home/casatest/.casa/config.py
04-Oct-2024 09:41:45
04-Oct-2024 09:41:45 Using user configuration file /home/casatest/.casa/config.py
04-Oct-2024 09:41:45
04-Oct-2024 09:41:45 Using user configuration file /home/casatest/.casa/config.py
04-Oct-2024 09:41:45
04-Oct-2024 09:41:45 Using user configuration file /home/casatest/.casa/config.py
04-Oct-2024 09:41:45
04-Oct-2024 09:41:45 Using user configuration file /home/casatest/.casa/config.py
04-Oct-2024 09:41:45
04-Oct-2024 09:41:45 Using user configuration file /home/casatest/.casa/config.py
04-Oct-2024 09:41:45
04-Oct-2024 09:41:45 Using user configuration file /home/casatest/.casa/config.py
04-Oct-2024 09:41:45
04-Oct-2024 09:41:45 Using user configuration file /home/casatest/.casa/config.py
04-Oct-2024 09:41:45
04-Oct-2024 09:41:45
04-Oct-2024 09:41:45
04-Oct-2024 09:41:45
04-Oct-2024 09:41:45
04-Oct-2024 09:41:45
04-Oct-2024 09:41:45
04-Oct-2024 09:41:45
04-Oct-2024 09:41:45 No event loop hook running.
04-Oct-2024 09:41:45 No event loop hook running.
04-Oct-2024 09:41:45 No event loop hook running.
04-Oct-2024 09:41:45 No event loop hook running.
04-Oct-2024 09:41:45 No event loop hook running.
04-Oct-2024 09:41:45 No event loop hook running.
04-Oct-2024 09:41:45 No event loop hook running.
04-Oct-2024 09:41:45 No event loop hook running.
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa::MPIServer-6        
04-Oct-2024 09:41:45 2024-10-04 09:41:45        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.
04-Oct-2024 09:41:45 2024-10-04 09:41:45        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.
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa::MPIServer-6        visit https://casadocs.readthedocs.io/en/stable/notebooks/external-data.html for more information
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa::MPIServer-6        
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa::MPIServer-5        
04-Oct-2024 09:41:45 2024-10-04 09:41:45        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.
04-Oct-2024 09:41:45 2024-10-04 09:41:45        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.
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa::MPIServer-5        visit https://casadocs.readthedocs.io/en/stable/notebooks/external-data.html for more information
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa::MPIServer-5        
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa        
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa        The expected casa data was not found at measurespath. CASA may still work if the data can be found in datapath.
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa        The expected measures data was not found at measurespath. CASA may still work if the data can be found in datapath.
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa        visit https://casadocs.readthedocs.io/en/stable/notebooks/external-data.html for more information
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa        
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa::MPIServer-7        
04-Oct-2024 09:41:45 2024-10-04 09:41:45        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.
04-Oct-2024 09:41:45 2024-10-04 09:41:45        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.
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa::MPIServer-7        visit https://casadocs.readthedocs.io/en/stable/notebooks/external-data.html for more information
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa::MPIServer-7        
04-Oct-2024 09:41:45 Using location of IERSeop2000 table found in datapath for measurespath /opt/casa/data/casa-data
04-Oct-2024 09:41:45 Using location of IERSeop2000 table found in datapath for measurespath /opt/casa/data/casa-data
04-Oct-2024 09:41:45 Using location of IERSeop2000 table found in datapath for measurespath /opt/casa/data/casa-data
04-Oct-2024 09:41:45 Using location of IERSeop2000 table found in datapath for measurespath /opt/casa/data/casa-data
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa::MPIServer-1        
04-Oct-2024 09:41:45 2024-10-04 09:41:45        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.
04-Oct-2024 09:41:45 2024-10-04 09:41:45        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.
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa::MPIServer-1        visit https://casadocs.readthedocs.io/en/stable/notebooks/external-data.html for more information
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa::MPIServer-1        
04-Oct-2024 09:41:45 Using location of IERSeop2000 table found in datapath for measurespath /opt/casa/data/casa-data
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa::MPIServer-4        
04-Oct-2024 09:41:45 2024-10-04 09:41:45        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.
04-Oct-2024 09:41:45 2024-10-04 09:41:45        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.
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa::MPIServer-4        visit https://casadocs.readthedocs.io/en/stable/notebooks/external-data.html for more information
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa::MPIServer-2        
04-Oct-2024 09:41:45 2024-10-04 09:41:45        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.
04-Oct-2024 09:41:45 2024-10-04 09:41:45        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.
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa::MPIServer-2        visit https://casadocs.readthedocs.io/en/stable/notebooks/external-data.html for more information2024-10-04 09:41:45        SEVERE        ::casa::MPIServer-4        
04-Oct-2024 09:41:45
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa::MPIServer-2        
04-Oct-2024 09:41:45 Using location of IERSeop2000 table found in datapath for measurespath /opt/casa/data/casa-data
04-Oct-2024 09:41:45 Using location of IERSeop2000 table found in datapath for measurespath /opt/casa/data/casa-data
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa::MPIServer-3        
04-Oct-2024 09:41:45 2024-10-04 09:41:45        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.
04-Oct-2024 09:41:45 2024-10-04 09:41:45        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.
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa::MPIServer-3        visit https://casadocs.readthedocs.io/en/stable/notebooks/external-data.html for more information
04-Oct-2024 09:41:45 2024-10-04 09:41:45        SEVERE        ::casa::MPIServer-3        
04-Oct-2024 09:41:45 Using location of IERSeop2000 table found in datapath for measurespath /opt/casa/data/casa-data
04-Oct-2024 09:41:45 CASA 6.7.0.7 -- Common Astronomy Software Applications [6.7.0.7]
04-Oct-2024 09:41:45 2024-10-04 09:41:46        INFO        ::casa        Using user configuration file /home/casatest/.casa/config.py
04-Oct-2024 09:41:45 2024-10-04 09:41:46        INFO        ::casa        loaded config file : /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casaconfig/config.py
04-Oct-2024 09:41:45 2024-10-04 09:41:46        INFO        ::casa        loaded config file : /home/casatest/.casa/config.py
04-Oct-2024 09:41:45 2024-10-04 09:41:46        INFO        ::casa        
04-Oct-2024 09:41:45 2024-10-04 09:41:46        INFO        ::casa        config values
04-Oct-2024 09:41:45 2024-10-04 09:41:46        INFO        ::casa            agg = True
04-Oct-2024 09:41:45 2024-10-04 09:41:46        INFO        ::casa            cachedir = '/home/casatest/.casa'
04-Oct-2024 09:41:45 2024-10-04 09:41:46        INFO        ::casa            casaconfig_verbose = 1
04-Oct-2024 09:41:45 2024-10-04 09:41:46        INFO        ::casa            colors = 'Neutral'
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa            data_auto_update = False
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa            datapath = ['/opt/casa/data/casa-data', '/opt/casa/data/casatestdata-large']
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa            iplog = False
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa            iplogfile = '/home/casatest/work/test_stk_vla_users_continuum_from_SDM/ipython-20241004-094142.log'
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa            log2term = True
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa            logfile = '/home/casatest/work/test_stk_vla_users_continuum_from_SDM/casa-20241004-094142.log'
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa            measures_auto_update = False
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa            measurespath = '/home/casatest/work/test_stk_vla_users_continuum_from_SDM/opt/casa/data/casa-data'
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa            nogui = True
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa            nologfile = False
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa            nologger = True
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa            pipeline = False
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa            startupfile = '/home/casatest/.casa/startup.py'
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa            user_site = False
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa        
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa        casarundata version is unknown, this is probably a legacy version not installed by casaconfig
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa        measures version is unknown, this is probably a legacy version not installed by casaconfig
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa        
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa        Checking Measures tables in data repository sub-directory /opt/casa/data/casa-data/geodetic
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa          IERSeop2000 (version date, last date in table (UTC)): 2024/03/09/15:00, 2024/02/08/00:00:00
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa          IERSeop97 (version date, last date in table (UTC)): 2024/03/09/15:00, 2024/02/08/00:00:00
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa          IERSpredict (version date, last date in table (UTC)): 2024/03/22/15:00, 2024/06/20/00:00:00
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa          TAI_UTC (version date, last date in table (UTC)): 2024/03/21/15:00, 2017/01/01/00:00:00
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        ::casa        MPI is enabled. Will run in parallel using Multi-MS for calibration and tclean
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        importasdm::::casa        ##########################################
04-Oct-2024 09:46:38 2024-10-04 09:41:46        INFO        importasdm::::casa        ##### Begin Task: importasdm         #####
04-Oct-2024 09:46:38 2024-10-04 09:41:46        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 )
04-Oct-2024 09:46:38 2024-10-04 09:41:47        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.
04-Oct-2024 09:46:38 2024-10-04 09:41:47        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),
04-Oct-2024 09:46:38 2024-10-04 09:41:47        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.
04-Oct-2024 09:46:38 2024-10-04 09:45:34        INFO        importasdm::::casa        No ephemerides attached.
04-Oct-2024 09:46:38 2024-10-04 09:45:34        INFO        importasdm::::casa        Will create a Multi-MS for: TDEM0001_sb1218006_1.55310.33439732639.ms
04-Oct-2024 09:46:38 2024-10-04 09:45:35        INFO        ParallelDataHelper::::casa        Analyzing MS for partitioning
04-Oct-2024 09:46:38 2024-10-04 09:45:35        INFO        ParallelDataHelper::::casa        Automatically distribute the scan/spw pairs to balance the load along field, spw and scan axes
04-Oct-2024 09:46:38 2024-10-04 09:45:42        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...
04-Oct-2024 09:46:38 2024-10-04 09:46:13        INFO        ParallelDataHelper::::casa        Finalizing MMS structure
04-Oct-2024 09:46:38 2024-10-04 09:46:13        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.
04-Oct-2024 09:46:38 2024-10-04 09:46:20        INFO        importasdm::AgentFlagger::open        Table type is Measurement Set
04-Oct-2024 09:46:38 2024-10-04 09:46:20        INFO        importasdm::FlagVersion::saveFlagVersion        Creating new backup flag file called Original
04-Oct-2024 09:46:38 2024-10-04 09:46:33        INFO        importasdm::::casa        Found Flag.xml in SDM
04-Oct-2024 09:46:38 2024-10-04 09:46:33        INFO        importasdm::::casa        Found Antenna.xml in SDM
04-Oct-2024 09:46:38 2024-10-04 09:46:33        INFO        importasdm::::casa        Found SpectralWindow.xml in SDM
04-Oct-2024 09:46:38 2024-10-04 09:46:33        INFO        importasdm::::casa        Found 26 rows in Antenna.xml
04-Oct-2024 09:46:38 2024-10-04 09:46:33        INFO        importasdm::::casa        Found 2 rows in SpectralWindow.xml
04-Oct-2024 09:46:38 2024-10-04 09:46:33        INFO        importasdm::::casa        Will construct spw flags using names
04-Oct-2024 09:46:38 2024-10-04 09:46:33        INFO        importasdm::::casa        Will construct polarization flags using polarizationType
04-Oct-2024 09:46:38 2024-10-04 09:46:33        INFO        importasdm::::casa        No numAntenna entry found, must be an old style SDM
04-Oct-2024 09:46:38 2024-10-04 09:46:33        INFO        importasdm::::casa        Found 1436 flags in Flag.xml
04-Oct-2024 09:46:38 2024-10-04 09:46:33        INFO        importasdm::::casa        Will not apply flags to TDEM0001_sb1218006_1.55310.33439732639.ms (apply_flags=False), use flagcmd to apply
04-Oct-2024 09:46:38 2024-10-04 09:46:33        INFO        importasdm::::casa        There are 0 rows already in FLAG_CMD
04-Oct-2024 09:46:38 2024-10-04 09:46:33        INFO        importasdm::::casa        Saved 1436 rows to FLAG_CMD of TDEM0001_sb1218006_1.55310.33439732639.ms
04-Oct-2024 09:46:38 2024-10-04 09:46:33        INFO        importasdm::::casa        Saved 1436 flag commands to TDEM0001_sb1218006_1.55310.33439732639.flagonline.txt
04-Oct-2024 09:46:38 2024-10-04 09:46:33        INFO        importasdm::::casa        Task importasdm complete. Start time: 2024-10-04 09:41:45.687676 End time: 2024-10-04 09:46:32.829739
04-Oct-2024 09:46:38 2024-10-04 09:46:33        INFO        importasdm::::casa        ##### End Task: importasdm           #####
04-Oct-2024 09:46:38 2024-10-04 09:46:33        INFO        importasdm::::casa        ##########################################
04-Oct-2024 09:46:38 2024-10-04 09:46:33        INFO        flagdata::::casa        ##########################################
04-Oct-2024 09:46:38 2024-10-04 09:46:33        INFO        flagdata::::casa        ##### Begin Task: flagdata           #####
04-Oct-2024 09:46:38 2024-10-04 09:46:33        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 )
04-Oct-2024 09:46:38 2024-10-04 09:46:39        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:46:38 2024-10-04 09:46:39        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:46:38 2024-10-04 09:46:39        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:47:55 2024-10-04 09:46:39        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:47:55 2024-10-04 09:46:39        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:47:55 2024-10-04 09:46:39        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:47:55 2024-10-04 09:46:39        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:47:55 2024-10-04 09:46:39        INFO        flagdata::::casa        Task flagdata complete. Start time: 2024-10-04 09:46:33.023660 End time: 2024-10-04 09:46:38.840289
04-Oct-2024 09:47:55 2024-10-04 09:46:39        INFO        flagdata::::casa        ##### End Task: flagdata             #####
04-Oct-2024 09:47:55 2024-10-04 09:46:39        INFO        flagdata::::casa        ##########################################
04-Oct-2024 09:47:55 2024-10-04 09:46:39        INFO        flagdata::::casa        ##########################################
04-Oct-2024 09:47:55 2024-10-04 09:46:39        INFO        flagdata::::casa        ##### Begin Task: flagdata           #####
04-Oct-2024 09:47:55 2024-10-04 09:46:39        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 )
04-Oct-2024 09:47:55 2024-10-04 09:47:20        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:47:55 2024-10-04 09:47:20        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:47:55 2024-10-04 09:47:20        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:47:55 2024-10-04 09:47:20        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:47:55 2024-10-04 09:47:20        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:47:55 2024-10-04 09:47:20        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:47:55 2024-10-04 09:47:20        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:47:55 2024-10-04 09:47:20        INFO        flagdata::::casa        Task flagdata complete. Start time: 2024-10-04 09:46:38.848536 End time: 2024-10-04 09:47:20.162484
04-Oct-2024 09:47:55 2024-10-04 09:47:20        INFO        flagdata::::casa        ##### End Task: flagdata             #####
04-Oct-2024 09:47:55 2024-10-04 09:47:20        INFO        flagdata::::casa        ##########################################
04-Oct-2024 09:47:55 2024-10-04 09:47:20        INFO        flagdata::::casa        ##########################################
04-Oct-2024 09:47:55 2024-10-04 09:47:20        INFO        flagdata::::casa        ##### Begin Task: flagdata           #####
04-Oct-2024 09:47:55 2024-10-04 09:47:20        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 )
04-Oct-2024 09:47:55 2024-10-04 09:47:26        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:47:55 2024-10-04 09:47:26        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:47:55 2024-10-04 09:47:26        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:47:55 2024-10-04 09:47:26        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:47:55 2024-10-04 09:47:26        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:47:55 2024-10-04 09:47:26        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:47:55 2024-10-04 09:47:26        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:47:55 2024-10-04 09:47:26        INFO        flagdata::::casa        Task flagdata complete. Start time: 2024-10-04 09:47:20.170437 End time: 2024-10-04 09:47:25.721631
04-Oct-2024 09:47:55 2024-10-04 09:47:26        INFO        flagdata::::casa        ##### End Task: flagdata             #####
04-Oct-2024 09:47:55 2024-10-04 09:47:26        INFO        flagdata::::casa        ##########################################
04-Oct-2024 09:47:55 2024-10-04 09:47:26        INFO        split::::casa        ##########################################
04-Oct-2024 09:47:55 2024-10-04 09:47:26        INFO        split::::casa        ##### Begin Task: split              #####
04-Oct-2024 09:47:55 2024-10-04 09:47:26        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='' )
04-Oct-2024 09:47:55 2024-10-04 09:47:26        INFO        ParallelDataHelper::::casa        Analyzing MS for partitioning
04-Oct-2024 09:47:55 2024-10-04 09:47:26        INFO        ParallelDataHelper::::casa        Input vis is a Multi-MS
04-Oct-2024 09:47:55 2024-10-04 09:47:51        INFO        ParallelDataHelper::::casa        Finalizing MMS structure
04-Oct-2024 09:47:55 2024-10-04 09:47:51        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.
04-Oct-2024 09:47:55 2024-10-04 09:47:56        INFO        split::::casa        Task split complete. Start time: 2024-10-04 09:47:25.729208 End time: 2024-10-04 09:47:55.779625
04-Oct-2024 09:47:55 2024-10-04 09:47:56        INFO        split::::casa        ##### End Task: split                #####
04-Oct-2024 09:47:55 2024-10-04 09:47:56        INFO        split::::casa        ##########################################
04-Oct-2024 09:47:55 2024-10-04 09:47:56        INFO        flagdata::::casa        ##########################################
04-Oct-2024 09:47:55 2024-10-04 09:47:56        INFO        flagdata::::casa        ##### Begin Task: flagdata           #####
04-Oct-2024 09:47:56 2024-10-04 09:47:56        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 )
04-Oct-2024 09:47:56 2024-10-04 09:47:56        INFO        flagdata::::casa        Backup original flags before applying new flags
04-Oct-2024 09:47:56 2024-10-04 09:47:56        INFO        AgentFlagger::open        Table type is Measurement Set
04-Oct-2024 09:47:56 2024-10-04 09:47:56        INFO        FlagVersion::saveFlagVersion        Creating new backup flag file called flagdata_1
04-Oct-2024 09:47:56 2024-10-04 09:47:57        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):
04-Oct-2024 09:47:56 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casampi/private/MPICommandServer.py", line 208, in __command_request_handler_service
04-Oct-2024 09:47:56 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            command_response['ret'] = eval(eval_str)
04-Oct-2024 09:47:56 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "<string>", line 1, in <module>
04-Oct-2024 09:47:56 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/flagdata.py", line 1136, in __call__
04-Oct-2024 09:47:56 2024-10-04 09:47:57        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'] )
04-Oct-2024 09:47:56 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/private/task_flagdata.py", line 618, in flagdata
04-Oct-2024 09:47:56 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            aflocal.selectdata(field=field, spw=spw, array=array, feed=feed, scan=scan, \
04-Oct-2024 09:47:56 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/agentflagger.py", line 36, in selectdata
04-Oct-2024 09:47:56 2024-10-04 09:47:57        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)
04-Oct-2024 09:47:56 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/agentflagger.py", line 197, in selectdata
04-Oct-2024 09:47:56 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return _agentflagger.agentflagger_selectdata(self, *args, **kwargs)
04-Oct-2024 09:47:56 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+        RuntimeError: MSSelectionNullSelection : The selected table has zero rows.
04-Oct-2024 09:47:56 2024-10-04 09:47:57        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):
04-Oct-2024 09:47:56 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casampi/private/MPICommandServer.py", line 208, in __command_request_handler_service
04-Oct-2024 09:47:56 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            command_response['ret'] = eval(eval_str)
04-Oct-2024 09:47:56 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "<string>", line 1, in <module>
04-Oct-2024 09:47:56 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/flagdata.py", line 1136, in __call__
04-Oct-2024 09:47:57 2024-10-04 09:47:57        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'] )
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/private/task_flagdata.py", line 618, in flagdata
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            aflocal.selectdata(field=field, spw=spw, array=array, feed=feed, scan=scan, \
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/agentflagger.py", line 36, in selectdata
04-Oct-2024 09:47:57 2024-10-04 09:47:57        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)
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/agentflagger.py", line 197, in selectdata
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return _agentflagger.agentflagger_selectdata(self, *args, **kwargs)
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+        RuntimeError: MSSelectionNullSelection : The selected table has zero rows.
04-Oct-2024 09:47:57 2024-10-04 09:47:57        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):
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casampi/private/MPICommandServer.py", line 208, in __command_request_handler_service
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            command_response['ret'] = eval(eval_str)
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "<string>", line 1, in <module>
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/flagdata.py", line 1136, in __call__
04-Oct-2024 09:47:57 2024-10-04 09:47:57        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'] )
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/private/task_flagdata.py", line 618, in flagdata
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            aflocal.selectdata(field=field, spw=spw, array=array, feed=feed, scan=scan, \
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/agentflagger.py", line 36, in selectdata
04-Oct-2024 09:47:57 2024-10-04 09:47:57        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)
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/agentflagger.py", line 197, in selectdata
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return _agentflagger.agentflagger_selectdata(self, *args, **kwargs)
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+        RuntimeError: MSSelectionNullSelection : The selected table has zero rows.
04-Oct-2024 09:47:57 2024-10-04 09:47:57        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):
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casampi/private/MPICommandServer.py", line 208, in __command_request_handler_service
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            command_response['ret'] = eval(eval_str)
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "<string>", line 1, in <module>
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/flagdata.py", line 1136, in __call__
04-Oct-2024 09:47:57 2024-10-04 09:47:57        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'] )
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/private/task_flagdata.py", line 618, in flagdata
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            aflocal.selectdata(field=field, spw=spw, array=array, feed=feed, scan=scan, \
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/agentflagger.py", line 36, in selectdata
04-Oct-2024 09:47:57 2024-10-04 09:47:57        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)
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/agentflagger.py", line 197, in selectdata
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return _agentflagger.agentflagger_selectdata(self, *args, **kwargs)
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+        RuntimeError: MSSelectionNullSelection : The selected table has zero rows.
04-Oct-2024 09:47:57 2024-10-04 09:47:57        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):
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casampi/private/MPICommandServer.py", line 208, in __command_request_handler_service
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            command_response['ret'] = eval(eval_str)
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "<string>", line 1, in <module>
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/flagdata.py", line 1136, in __call__
04-Oct-2024 09:47:57 2024-10-04 09:47:57        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'] )
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/private/task_flagdata.py", line 618, in flagdata
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            aflocal.selectdata(field=field, spw=spw, array=array, feed=feed, scan=scan, \
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/agentflagger.py", line 36, in selectdata
04-Oct-2024 09:47:57 2024-10-04 09:47:57        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)
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/agentflagger.py", line 197, in selectdata
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return _agentflagger.agentflagger_selectdata(self, *args, **kwargs)
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+        RuntimeError: MSSelectionNullSelection : The selected table has zero rows.
04-Oct-2024 09:47:57 2024-10-04 09:47:57        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):
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casampi/private/MPICommandServer.py", line 208, in __command_request_handler_service
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            command_response['ret'] = eval(eval_str)
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "<string>", line 1, in <module>
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/flagdata.py", line 1136, in __call__
04-Oct-2024 09:47:57 2024-10-04 09:47:57        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'] )
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatasks/private/task_flagdata.py", line 618, in flagdata
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            aflocal.selectdata(field=field, spw=spw, array=array, feed=feed, scan=scan, \
04-Oct-2024 09:47:57 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/agentflagger.py", line 36, in selectdata
04-Oct-2024 09:48:00 2024-10-04 09:47:57        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)
04-Oct-2024 09:48:00 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/agentflagger.py", line 197, in selectdata
04-Oct-2024 09:48:00 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return _agentflagger.agentflagger_selectdata(self, *args, **kwargs)
04-Oct-2024 09:48:00 2024-10-04 09:47:57        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+        RuntimeError: MSSelectionNullSelection : The selected table has zero rows.
04-Oct-2024 09:48:00 2024-10-04 09:47:57        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: None
04-Oct-2024 09:48:00 2024-10-04 09:47:57        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: None
04-Oct-2024 09:48:00 2024-10-04 09:47:57        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: None
04-Oct-2024 09:48:00 2024-10-04 09:47:57        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:48:00 2024-10-04 09:47:57        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: None
04-Oct-2024 09:48:00 2024-10-04 09:47:57        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: None
04-Oct-2024 09:48:00 2024-10-04 09:47:57        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: None
04-Oct-2024 09:48:00 2024-10-04 09:47:57        INFO        flagdata::::casa        Task flagdata complete. Start time: 2024-10-04 09:47:55.806306 End time: 2024-10-04 09:47:57.311148
04-Oct-2024 09:48:00 2024-10-04 09:47:57        INFO        flagdata::::casa        ##### End Task: flagdata             #####
04-Oct-2024 09:48:00 2024-10-04 09:47:57        INFO        flagdata::::casa        ##########################################
04-Oct-2024 09:48:00 2024-10-04 09:47:57        INFO        flagdata::::casa        ##########################################
04-Oct-2024 09:48:00 2024-10-04 09:47:57        INFO        flagdata::::casa        ##### Begin Task: flagdata           #####
04-Oct-2024 09:48:00 2024-10-04 09:47:57        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 )
04-Oct-2024 09:48:00 2024-10-04 09:47:57        INFO        flagdata::::casa        Backup original flags before applying new flags
04-Oct-2024 09:48:00 2024-10-04 09:47:57        INFO        AgentFlagger::open        Table type is Measurement Set
04-Oct-2024 09:48:00 2024-10-04 09:47:57        INFO        FlagVersion::saveFlagVersion        Creating new backup flag file called flagdata_2
04-Oct-2024 09:48:00 2024-10-04 09:47:59        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:48:00 2024-10-04 09:47:59        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:48:00 2024-10-04 09:47:59        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:48:00 2024-10-04 09:47:59        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:48:00 2024-10-04 09:47:59        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:48:00 2024-10-04 09:47:59        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:48:00 2024-10-04 09:47:59        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:48:00 2024-10-04 09:47:59        INFO        flagdata::::casa        Task flagdata complete. Start time: 2024-10-04 09:47:57.319061 End time: 2024-10-04 09:47:58.689610
04-Oct-2024 09:48:00 2024-10-04 09:47:59        INFO        flagdata::::casa        ##### End Task: flagdata             #####
04-Oct-2024 09:48:00 2024-10-04 09:47:59        INFO        flagdata::::casa        ##########################################
04-Oct-2024 09:48:00 2024-10-04 09:47:59        INFO        flagdata::::casa        ##########################################
04-Oct-2024 09:48:00 2024-10-04 09:47:59        INFO        flagdata::::casa        ##### Begin Task: flagdata           #####
04-Oct-2024 09:48:00 2024-10-04 09:47:59        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 )
04-Oct-2024 09:48:00 2024-10-04 09:47:59        INFO        flagdata::::casa        Backup original flags before applying new flags
04-Oct-2024 09:48:00 2024-10-04 09:47:59        INFO        AgentFlagger::open        Table type is Measurement Set
04-Oct-2024 09:48:00 2024-10-04 09:47:59        INFO        FlagVersion::saveFlagVersion        Creating new backup flag file called flagdata_3
04-Oct-2024 09:48:00 2024-10-04 09:48:00        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:48:00 2024-10-04 09:48:00        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:48:00 2024-10-04 09:48:00        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:48:00 2024-10-04 09:48:00        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:48:00 2024-10-04 09:48:00        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:48:00 2024-10-04 09:48:00        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:48:00 2024-10-04 09:48:00        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
04-Oct-2024 09:48:00 2024-10-04 09:48:00        INFO        flagdata::::casa        Task flagdata complete. Start time: 2024-10-04 09:47:58.697566 End time: 2024-10-04 09:48:00.152698
04-Oct-2024 09:48:00 2024-10-04 09:48:00        INFO        flagdata::::casa        ##### End Task: flagdata             #####
04-Oct-2024 09:48:00 2024-10-04 09:48:00        INFO        flagdata::::casa        ##########################################
04-Oct-2024 09:48:00 2024-10-04 09:48:00        INFO        flagdata::::casa        ##########################################
04-Oct-2024 09:48:00 2024-10-04 09:48:00        INFO        flagdata::::casa        ##### Begin Task: flagdata           #####
04-Oct-2024 09:48:01 2024-10-04 09:48:00        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 )
04-Oct-2024 09:48:01 2024-10-04 09:48:01        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'}
04-Oct-2024 09:48:01 2024-10-04 09:48:01        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'}
04-Oct-2024 09:48:01 2024-10-04 09:48:01        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'}
04-Oct-2024 09:48:01 2024-10-04 09:48:01        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'}
04-Oct-2024 09:48:01 2024-10-04 09:48:01        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'}
04-Oct-2024 09:48:01 2024-10-04 09:48:01        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'}
04-Oct-2024 09:48:01 2024-10-04 09:48:01        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'}
04-Oct-2024 09:48:01 2024-10-04 09:48:01        INFO        flagdata::::casa        Task flagdata complete. Start time: 2024-10-04 09:48:00.160646 End time: 2024-10-04 09:48:01.204762
04-Oct-2024 09:48:01 2024-10-04 09:48:01        INFO        flagdata::::casa        ##### End Task: flagdata             #####
04-Oct-2024 09:48:01 2024-10-04 09:48:01        INFO        flagdata::::casa        ##########################################
04-Oct-2024 09:48:01 Expected flag percentage of 20.558870499248552, got 20.558870499248552, tolerance 1.0
04-Oct-2024 09:48:01 2024-10-04 09:48:01        INFO        listobs::::casa        ##########################################
04-Oct-2024 09:48:01 2024-10-04 09:48:01        INFO        listobs::::casa        ##### Begin Task: listobs            #####
04-Oct-2024 09:48:01 2024-10-04 09:48:01        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 )
04-Oct-2024 09:48:01 2024-10-04 09:48:01        INFO        listobs::ms::summary        ================================================================================
04-Oct-2024 09:48:01 2024-10-04 09:48:01        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
04-Oct-2024 09:48:01 2024-10-04 09:48:01        INFO        listobs::ms::summary+        ================================================================================
04-Oct-2024 09:48:01 2024-10-04 09:48:01        INFO        listobs::ms::summary+           Observer: Dr. James Miller-Jones     Project: uid://evla/pdb/1214864 
04-Oct-2024 09:48:01 2024-10-04 09:48:01        INFO        listobs::ms::summary+        Observation: EVLA
04-Oct-2024 09:48:01 2024-10-04 09:48:01        INFO        listobs::MSMetaData::_computeScanAndSubScanProperties         Computing scan and subscan properties...
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary        Data records: 850358       Total elapsed time = 28681 seconds
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+           Observed from   24-Apr-2010/08:02:10.0   to   24-Apr-2010/16:00:11.0 (UTC)
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary        
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+           ObservationID = 0         ArrayID = 0
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          Date        Timerange (UTC)          Scan  FldId FieldName             nRows     SpwIds   Average Interval(s)    ScanIntent
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      08:24:47.0 - 08:29:45.0     5      2 3C391 C1                  7590  [0]  [9.87] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      08:29:45.0 - 08:34:44.0     6      3 3C391 C2                  7590  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      08:34:44.0 - 08:39:43.0     7      4 3C391 C3                  7590  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      08:39:43.0 - 08:44:42.0     8      5 3C391 C4                  8268  [0]  [9.92] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      08:44:42.0 - 08:49:41.0     9      6 3C391 C5                  9600  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      08:49:41.0 - 08:54:41.0    10      7 3C391 C6                  9750  [0]  [9.98] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      08:54:41.0 - 08:59:40.0    11      8 3C391 C7                  9750  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      09:01:51.0 - 09:06:49.0    13      2 3C391 C1                  9700  [0]  [9.85] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      09:06:49.0 - 09:11:48.0    14      3 3C391 C2                  9750  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      09:11:48.0 - 09:16:47.0    15      4 3C391 C3                  9750  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      09:16:47.0 - 09:21:46.0    16      5 3C391 C4                  9750  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      09:21:46.0 - 09:26:45.0    17      6 3C391 C5                  9750  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      09:26:45.0 - 09:31:45.0    18      7 3C391 C6                  9750  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      09:31:45.0 - 09:36:44.0    19      8 3C391 C7                  9750  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      09:38:33.0 - 09:43:53.0    21      2 3C391 C1                 10025  [0]  [9.53] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      09:43:53.0 - 09:48:52.0    22      3 3C391 C2                  9750  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      09:48:52.0 - 09:53:51.0    23      4 3C391 C3                  9750  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      09:53:51.0 - 09:58:50.0    24      5 3C391 C4                  9750  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      09:58:50.0 - 10:03:49.0    25      6 3C391 C5                  9750  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      10:03:49.0 - 10:08:48.0    26      7 3C391 C6                  9750  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      10:08:48.0 - 10:13:48.0    27      8 3C391 C7                  9750  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      10:15:37.0 - 10:20:56.0    29      2 3C391 C1                  9105  [0]  [9.68] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      10:20:56.0 - 10:25:56.0    30      3 3C391 C2                  9750  [0]  [9.99] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      10:25:56.0 - 10:30:55.0    31      4 3C391 C3                  9750  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      10:30:55.0 - 10:35:54.0    32      5 3C391 C4                  9750  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      10:35:54.0 - 10:40:53.0    33      6 3C391 C5                  9750  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      10:40:53.0 - 10:45:52.0    34      7 3C391 C6                  9750  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      10:45:52.0 - 10:50:52.0    35      8 3C391 C7                  9750  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      11:03:02.0 - 11:07:59.0    39      2 3C391 C1                  9750  [0]  [9.85] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      11:07:59.0 - 11:12:48.0    40      3 3C391 C2                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      11:12:48.0 - 11:17:37.0    41      4 3C391 C3                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      11:17:37.0 - 11:22:26.0    42      5 3C391 C4                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      11:22:26.0 - 11:27:16.0    43      6 3C391 C5                  9425  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      11:27:16.0 - 11:32:05.0    44      7 3C391 C6                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      11:32:05.0 - 11:36:54.0    45      8 3C391 C7                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      11:39:10.0 - 11:44:03.0    47      2 3C391 C1                  9701  [0]  [9.76] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      11:44:03.0 - 11:48:52.0    48      3 3C391 C2                  9350  [0]  [9.95] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      11:48:52.0 - 11:53:41.0    49      4 3C391 C3                  8355  [0]  [9.66] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      11:53:41.0 - 11:58:30.0    50      5 3C391 C4                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      11:58:30.0 - 12:03:20.0    51      6 3C391 C5                  9425  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      12:03:20.0 - 12:08:09.0    52      7 3C391 C6                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      12:08:09.0 - 12:12:58.0    53      8 3C391 C7                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      12:15:17.0 - 12:20:07.0    55      2 3C391 C1                  9425  [0]  [9.92] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      12:20:07.0 - 12:24:56.0    56      3 3C391 C2                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      12:24:56.0 - 12:29:45.0    57      4 3C391 C3                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      12:29:45.0 - 12:34:35.0    58      5 3C391 C4                  9425  [0]  [9.99] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      12:34:35.0 - 12:39:24.0    59      6 3C391 C5                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      12:39:24.0 - 12:44:13.0    60      7 3C391 C6                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      12:44:13.0 - 12:49:02.0    61      8 3C391 C7                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      12:51:23.0 - 12:56:11.0    63      2 3C391 C1                  9425  [0]  [9.85] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      12:56:11.0 - 13:01:00.0    64      3 3C391 C2                  8725  [0]  [9.94] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      13:01:00.0 - 13:05:49.0    65      4 3C391 C3                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      13:05:49.0 - 13:10:39.0    66      5 3C391 C4                  9425  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      13:10:39.0 - 13:15:28.0    67      6 3C391 C5                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      13:15:28.0 - 13:20:17.0    68      7 3C391 C6                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      13:20:17.0 - 13:25:06.0    69      8 3C391 C7                  8725  [0]  [9.94] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      13:27:27.0 - 13:32:15.0    71      2 3C391 C1                  9425  [0]  [9.83] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      13:32:15.0 - 13:37:04.0    72      3 3C391 C2                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      13:37:04.0 - 13:41:53.0    73      4 3C391 C3                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      13:41:53.0 - 13:46:43.0    74      5 3C391 C4                  9425  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      13:46:43.0 - 13:51:32.0    75      6 3C391 C5                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      13:51:32.0 - 13:56:21.0    76      7 3C391 C6                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      13:56:21.0 - 14:01:10.0    77      8 3C391 C7                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      14:03:32.0 - 14:08:19.0    79      2 3C391 C1                  8900  [0]  [9.79] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      14:08:19.0 - 14:13:08.0    80      3 3C391 C2                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      14:13:08.0 - 14:17:58.0    81      4 3C391 C3                  9425  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      14:17:58.0 - 14:22:47.0    82      5 3C391 C4                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      14:22:47.0 - 14:27:36.0    83      6 3C391 C5                  9425  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      14:27:36.0 - 14:32:25.0    84      7 3C391 C6                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      14:32:25.0 - 14:37:14.0    85      8 3C391 C7                  9425  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      14:39:35.0 - 14:44:23.0    87      2 3C391 C1                  9425  [0]  [9.82] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      14:44:23.0 - 14:49:12.0    88      3 3C391 C2                  8950  [0]  [9.93] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      14:49:12.0 - 14:54:02.0    89      4 3C391 C3                  8700  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      14:54:02.0 - 14:58:51.0    90      5 3C391 C4                  8700  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      14:58:51.0 - 15:03:40.0    91      6 3C391 C5                  7802  [0]  [9.92] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      15:03:40.0 - 15:08:29.0    92      7 3C391 C6                  7337  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      15:08:29.0 - 15:13:18.0    93      8 3C391 C7                  7337  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      15:15:39.0 - 15:20:27.0    95      2 3C391 C1                  7337  [0]  [9.85] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      15:20:27.0 - 15:25:16.0    96      3 3C391 C2                  7337  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      15:25:16.0 - 15:30:06.0    97      4 3C391 C3                  7337  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      15:30:06.0 - 15:34:55.0    98      5 3C391 C4                  7337  [0]  [9.97] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      15:34:55.0 - 15:39:44.0    99      6 3C391 C5                  7337  [0]  [9.96] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      15:39:44.0 - 15:44:33.0   100      7 3C391 C6                  7337  [0]  [9.95] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                      15:44:33.0 - 15:49:23.0   101      8 3C391 C7                  7337  [0]  [10] [OBSERVE_TARGET#UNSPECIFIED]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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]
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary                   (nRows = Total number of rows per scan)
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary        Fields: 10
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          ID   Code Name                RA               Decl           Epoch   SrcId      nRows
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          0    N    J1331+3030          13:31:08.287984 +30.30.32.95886 J2000   0          31922
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          1    J    J1822-0938          18:22:28.704200 -09.38.56.83501 J2000   1          41256
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          2    NONE 3C391 C1            18:49:24.244000 -00.55.40.58001 J2000   2         109808
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          3    NONE 3C391 C2            18:49:29.149001 -00.57.48.00001 J2000   3         108902
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          4    NONE 3C391 C3            18:49:19.339000 -00.57.48.00001 J2000   4         108357
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          5    NONE 3C391 C4            18:49:14.434001 -00.55.40.58001 J2000   5         110105
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          6    NONE 3C391 C5            18:49:19.339000 -00.53.33.16000 J2000   6         110539
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          7    NONE 3C391 C6            18:49:29.149001 -00.53.33.16000 J2000   7         110224
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          8    NONE 3C391 C7            18:49:34.054000 -00.55.40.58001 J2000   8         109524
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          9    Z    J0319+4130          03:19:48.160102 +41.30.42.10305 J2000   9           9721
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary        Spectral Windows:  (1 unique spectral windows and 1 unique polarization setups)
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          SpwID  Name      #Chans   Frame   Ch0(MHz)  ChanWid(kHz)  TotBW(kHz) CtrFreq(MHz) BBC Num  Corrs         
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          0      Subband:0     64   TOPO    4536.000      2000.000    128000.0   4599.0000        4  RR  RL  LR  LL
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary        Sources: 10
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          ID   Name                SpwId RestFreq(MHz)  SysVel(km/s)
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          0    J1331+3030          0     -              -           
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          1    J1822-0938          0     -              -           
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          2    3C391 C1            0     -              -           
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          3    3C391 C2            0     -              -           
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          4    3C391 C3            0     -              -           
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          5    3C391 C4            0     -              -           
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          6    3C391 C5            0     -              -           
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          7    3C391 C6            0     -              -           
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          8    3C391 C7            0     -              -           
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          9    J0319+4130          0     -              -           
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary        Antennas: 26:
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+          ID   Name  Station   Diam.    Long.         Lat.                Offset from array center (m)                ITRF Geocentric coordinates (m)       
04-Oct-2024 09:48:01 2024-10-04 09:48:02        INFO        listobs::ms::summary+                                                                             East         North     Elevation               x               y               z
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:01 2024-10-04 09:48:02        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
04-Oct-2024 09:48:09 2024-10-04 09:48:02        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
04-Oct-2024 09:48:09 2024-10-04 09:48:02        INFO        listobs::::casa        Task listobs complete. Start time: 2024-10-04 09:48:01.209774 End time: 2024-10-04 09:48:01.543492
04-Oct-2024 09:48:09 2024-10-04 09:48:02        INFO        listobs::::casa        ##### End Task: listobs              #####
04-Oct-2024 09:48:09 2024-10-04 09:48:02        INFO        listobs::::casa        ##########################################
04-Oct-2024 09:48:09 Expected 850358 rows in split MS, got 850358, tolerance exact
04-Oct-2024 09:48:09 2024-10-04 09:48:02        INFO        gencal::::casa        ##########################################
04-Oct-2024 09:48:09 2024-10-04 09:48:02        INFO        gencal::::casa        ##### Begin Task: gencal             #####
04-Oct-2024 09:48:09 2024-10-04 09:48:02        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 )
04-Oct-2024 09:48:09 2024-10-04 09:48:02        INFO        calibrater::open        ****Using NEW VI2-driven calibrater tool****
04-Oct-2024 09:48:09 2024-10-04 09:48:02        INFO        calibrater::open        Opening MS: 3c391_ctm_mosaic_10s_spw0.ms for calibration.
04-Oct-2024 09:48:09 2024-10-04 09:48:02        INFO        Calibrater::        Initializing nominal selection to the whole MS.
04-Oct-2024 09:48:09 2024-10-04 09:48:02        INFO        gencal::::casa         Determine antenna position offsets from the baseline correction database
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO        gencal::::casa        offsets for antenna ea01 :  0.00000   0.00300   0.00000
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO        gencal::::casa        offsets for antenna ea02 : -0.00080   0.00000   0.00000
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO        gencal::::casa        offsets for antenna ea03 : -0.00280   0.00000   0.00000
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO        gencal::::casa        offsets for antenna ea05 :  0.00000   0.00280   0.00000
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO        gencal::::casa        offsets for antenna ea11 :  0.00090   0.00000   0.00000
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO        gencal::::casa        offsets for antenna ea12 : -0.01000   0.00450  -0.00170
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO        gencal::::casa        offsets for antenna ea13 :  0.00000  -0.00080   0.00000
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO        gencal::::casa        offsets for antenna ea17 : -0.00120   0.00000   0.00000
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO        gencal::::casa        offsets for antenna ea18 :  0.00040  -0.00080   0.00040
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO        gencal::::casa        offsets for antenna ea22 : -0.02570   0.00270  -0.01900
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO        gencal::::casa        offsets for antenna ea23 : -0.00140   0.00000   0.00000
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO        gencal::::casa        offsets for antenna ea24 : -0.00150   0.00000   0.00000
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO        gencal::::casa        offsets for antenna ea26 : -0.00190   0.00000   0.00210
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO        gencal::::casa        offsets for antenna ea27 :  0.00000   0.00190  -0.00160
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO        calibrater::specifycal        Beginning specifycal-----------------------
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO                Creating KAntPos Jones table from specified parameters.
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO                Writing solutions to table: 3c391_ctm_mosaic_10s_spw0.antpos
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO        gencal::::casa        Task gencal complete. Start time: 2024-10-04 09:48:01.553574 End time: 2024-10-04 09:48:04.424526
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO        gencal::::casa        ##### End Task: gencal               #####
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO        gencal::::casa        ##########################################
04-Oct-2024 09:48:09 Expected 14 nonzero antenna position corrections, got 14, tolerance exact
04-Oct-2024 09:48:09 Expected minimum antenna position correction of -0.0257, got -0.025699999183416367, tolerance 1e-05
04-Oct-2024 09:48:09 Expected maximum antenna position correction of 0.0045, got 0.0044999998062849045, tolerance 1e-05
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO        setjy::::casa        ##########################################
04-Oct-2024 09:48:09 2024-10-04 09:48:04        INFO        setjy::::casa        ##### Begin Task: setjy              #####
04-Oct-2024 09:48:09 2024-10-04 09:48:04        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 )
04-Oct-2024 09:48:09 2024-10-04 09:48:09        INFO        setjy::::casa        {'field': 'J1331+3030'}
04-Oct-2024 09:48:09 2024-10-04 09:48:09        INFO        Imager::open()         Opening MeasurementSet /home/casatest/work/test_stk_vla_users_continuum_from_SDM/3c391_ctm_mosaic_10s_spw0.ms
04-Oct-2024 09:48:09 2024-10-04 09:48:10        INFO        setjy::::casa        Using /opt/casa/data/casa-data/nrao/VLA/CalModels/3C286_C.im for model.
04-Oct-2024 09:48:09 2024-10-04 09:48:10        INFO        imager::setjy()        Using channel dependent flux densities
04-Oct-2024 09:48:09 2024-10-04 09:48:10        INFO        imager::data selection        Selected 31922 out of 850358 rows.
04-Oct-2024 09:48:09 2024-10-04 09:48:10        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)
04-Oct-2024 09:48:09 terminate called after throwing an instance of 'casacore::ArrayShapeError'
04-Oct-2024 09:48:09   what():  ArrayBase::Array(const IPosition&) - Negative shape shape [-2147483647] differs from [-2147483647]
04-Oct-2024 09:48:09 [2afa582414ff:00227] *** Process received signal ***
04-Oct-2024 09:48:09 [2afa582414ff:00227] Signal: Aborted (6)
04-Oct-2024 09:48:09 [2afa582414ff:00227] Signal code:  (-6)
04-Oct-2024 09:48:09 [2afa582414ff:00227] [ 0] /lib64/libpthread.so.0(+0x12c20)[0x7f9e7125cc20]
04-Oct-2024 09:48:09 [2afa582414ff:00227] [ 1] /lib64/libc.so.6(gsignal+0x10f)[0x7f9e7073237f]
04-Oct-2024 09:48:09 [2afa582414ff:00227] [ 2] /lib64/libc.so.6(abort+0x127)[0x7f9e7071cdb5]
04-Oct-2024 09:48:09 [2afa582414ff:00227] [ 3] /lib64/libstdc++.so.6(+0x9009b)[0x7f9e6b89a09b]
04-Oct-2024 09:48:09 [2afa582414ff:00227] [ 4] /lib64/libstdc++.so.6(+0x9653c)[0x7f9e6b8a053c]
04-Oct-2024 09:48:09 [2afa582414ff:00227] [ 5] /lib64/libstdc++.so.6(+0x96597)[0x7f9e6b8a0597]
04-Oct-2024 09:48:09 [2afa582414ff:00227] [ 6] /lib64/libstdc++.so.6(+0x967f8)[0x7f9e6b8a07f8]
04-Oct-2024 09:48:09 [2afa582414ff:00227] [ 7] /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/lib/libcasa_casa.so.8(+0x1386d8)[0x7f9e586246d8]
04-Oct-2024 09:48:09 [2afa582414ff:00227] [ 8] /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/lib/libcasa_casa.so.8(_ZN8casacore5ArrayIdEC1ERKNS_9IPositionE+0x12)[0x7f9e5869d402]
04-Oct-2024 09:48:09 [2afa582414ff:00227] [ 9] /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/lib/libcasa_casa.so.8(_ZN8casacore6VectorIdEC1Em+0x29)[0x7f9e586e2309]
04-Oct-2024 09:48:09 [2afa582414ff:00227] [10] /home/casatest/work/pkg/casa-6.7.0-7-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)[0x7f9e5a453635]
04-Oct-2024 09:48:09 [2afa582414ff:00227] [11] /home/casatest/work/pkg/casa-6.7.0-7-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)[0x7f9e5a461985]
04-Oct-2024 09:48:09 [2afa582414ff:00227] [12] /home/casatest/work/pkg/casa-6.7.0-7-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)[0x7f9e4ea87749]
04-Oct-2024 09:48:09 [2afa582414ff:00227] [13] /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/lib/python3.10/site-packages/casatools/__casac__/_imager.cpython-310-x86_64-linux-gnu.so(+0x5eb5f)[0x7f9e4ea75b5f]
04-Oct-2024 09:48:09 [2afa582414ff:00227] [14] /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/bin/python3[0x56b2e6]
04-Oct-2024 09:48:09 [2afa582414ff:00227] [15] /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/bin/python3(PyObject_Call+0xb4)[0x4dc084]
04-Oct-2024 09:48:09 [2afa582414ff:00227] [16] /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/bin/python3(_PyEval_EvalFrameDefault+0x5d7b)[0x5356ab]
04-Oct-2024 09:48:09 [2afa582414ff:00227] [17] /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/bin/python3[0x52eb80]
04-Oct-2024 09:48:09 [2afa582414ff:00227] [18] /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/bin/python3[0x565e2d]
04-Oct-2024 09:48:10 [2afa582414ff:00227] [19] /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/bin/python3(_PyEval_EvalFrameDefault+0x4e09)[0x534739]
04-Oct-2024 09:48:10 [2afa582414ff:00227] [20] /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/bin/python3[0x52eb80]
04-Oct-2024 09:48:10 [2afa582414ff:00227] [21] /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/bin/python3[0x565e2d]
04-Oct-2024 09:48:10 [2afa582414ff:00227] [22] /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/bin/python3(PyObject_Call+0x229)[0x4dc1f9]
04-Oct-2024 09:48:10 [2afa582414ff:00227] [23] /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/bin/python3(_PyEval_EvalFrameDefault+0x2cd6)[0x532606]
04-Oct-2024 09:48:10 [2afa582414ff:00227] [24] /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/bin/python3[0x52eb80]
04-Oct-2024 09:48:10 [2afa582414ff:00227] [25] /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/bin/python3(_PyEval_EvalFrameDefault+0x338)[0x52fc68]
04-Oct-2024 09:48:10 [2afa582414ff:00227] [26] /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/bin/python3[0x52eb80]
04-Oct-2024 09:48:10 [2afa582414ff:00227] [27] /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/bin/python3(_PyEval_EvalFrameDefault+0x338)[0x52fc68]
04-Oct-2024 09:48:10 [2afa582414ff:00227] [28] /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/bin/python3[0x52eb80]
04-Oct-2024 09:48:10 [2afa582414ff:00227] [29] /home/casatest/work/pkg/casa-6.7.0-7-py3.10.el8/lib/py/bin/python3(_PyObject_Call_Prepend+0x199)[0x4db8d9]
04-Oct-2024 09:48:10 [2afa582414ff:00227] *** End of error message ***
04-Oct-2024 09:48:10 --------------------------------------------------------------------------
04-Oct-2024 09:48:10 prterun noticed that process rank 0 with PID 227 on node 2afa582414ff exited on
04-Oct-2024 09:48:10 signal 6 (Aborted).
04-Oct-2024 09:48:10 --------------------------------------------------------------------------
04-Oct-2024 09:48:10
04-Oct-2024 09:48:10 Executor result: 134
04-Oct-2024 09:48:10 Failed tests:['Executor returned a non-zero exit code']
04-Oct-2024 09:48:10
04-Oct-2024 09:48:10 Results: [{'testname': 'test_stk_vla_users_continuum_from_SDM', 'runtime': '0:06:27.261164', 'returncode': 1, 'testerr': ['Executor returned a non-zero exit code']}]
04-Oct-2024 09:48:10 Stopping Xvfb.
04-Oct-2024 09:48:10 Stopping framebuffer <Popen: returncode: None args: ['Xvfb', ':111', '-screen', '0', '2048x2048x2...>
04-Oct-2024 09:48:10 Virtual frame buffer deployed at :111 with pid 124 successfully shutdown
04-Oct-2024 09:48:10 Xvfb stopped.
04-Oct-2024 09:48:10 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
04-Oct-2024 09:48:10 cp: cannot stat '/home/casatest/work/test_stk_vla_users_continuum_from_SDM/*.png': No such file or directory
04-Oct-2024 09:48:10 total 990264
04-Oct-2024 09:48:10 -rw-r--r-- 1 casaci    15001 1014024892 Oct  4 09:40 casa-6.7.0-7-py3.10.el8.tar.xz
04-Oct-2024 09:48:10 drwxr-xr-x 2 casaci root              6 Oct  4 09:48 html
04-Oct-2024 09:48:10 -rw-r--r-- 1 casaci casatest        413 Oct  4 09:48 xUnit-suite-mpi-8.xml
04-Oct-2024 09:48:10 total 0
04-Oct-2024 09:48:10 Finished task 'Script' with result: Success
04-Oct-2024 09:48:10 Starting task 'Parse test results' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
04-Oct-2024 09:48:10 Parsing test results under /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASA-CMTSP3-STCR85D...
04-Oct-2024 09:48:10 Failing task since 1 failing test cases were found.
04-Oct-2024 09:48:10 Finished task 'Parse test results' with result: Failed
04-Oct-2024 09:48:10
Substituting variable: ${bamboo.capability.hostname} with cvpost135
04-Oct-2024 09:48:10
Substituting variable: ${bamboo.capability.hostname} with cvpost135
04-Oct-2024 09:48:10 Starting task 'Cleanup' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
04-Oct-2024 09:48:10
Beginning to execute external process for build 'CASA - CMake Master Test Stakeholder Python 3.10 - VLA Stakeholder Tests MPI EL8 Docker #7 (CASA-CMTSP3-STCR85D-7)'
... running command line:
/export/cvpost135-nvme/casa/bamboohome/temp/CASA-CMTSP3-STCR85D-7-ScriptBuildTask-777298565808354725.sh
... in: /export/cvpost135-nvme/casa/bamboohome/xml-data/build-dir/CASA-CMTSP3-STCR85D
04-Oct-2024 09:48:10 Starting cleanup
04-Oct-2024 09:48:21 test-container
04-Oct-2024 09:48:29 test-container
04-Oct-2024 09:48:29 Cleanup complete
04-Oct-2024 09:48:29 Finished task 'Cleanup' with result: Success
04-Oct-2024 09:48:29 Running post build plugin 'Docker Container Cleanup'
04-Oct-2024 09:48:29 Running post build plugin 'NCover Results Collector'
04-Oct-2024 09:48:29 Running post build plugin 'Build Results Label Collector'
04-Oct-2024 09:48:29 Running post build plugin 'Clover Results Collector'
04-Oct-2024 09:48:29 Running post build plugin 'npm Cache Cleanup'
04-Oct-2024 09:48:29 Running post build plugin 'Artifact Copier'
04-Oct-2024 09:48:29 Publishing an artifact: VLA Stakeholder MPI
04-Oct-2024 09:48:29 Failing as no matching files has been found and empty artifacts are not allowed.
04-Oct-2024 09:48:29 Unable to publish artifact [VLA Stakeholder MPI]:
04-Oct-2024 09:48:29 The artifact hasn't been successfully published after 53.53 ms
04-Oct-2024 09:48:29 Finalising the build...
04-Oct-2024 09:48:29 Stopping timer.
04-Oct-2024 09:48:29 Build CASA-CMTSP3-STCR85D-7 completed.
04-Oct-2024 05:48:29 Running on server: post build plugin 'Build Hanging Detection Configuration'
04-Oct-2024 05:48:29 Running on server: post build plugin 'NCover Results Collector'
04-Oct-2024 05:48:29 Running on server: post build plugin 'Build Labeller'
04-Oct-2024 05:48:29 Running on server: post build plugin 'Clover Delta Calculator'
04-Oct-2024 05:48:29 Running on server: post build plugin 'Maven Dependencies Postprocessor'
04-Oct-2024 05:48:29 All post build plugins have finished
04-Oct-2024 05:48:29 Generating build results summary...
04-Oct-2024 05:48:29 Saving build results to disk...
04-Oct-2024 05:48:29 Store variable context...
04-Oct-2024 05:48:29 Finished building CASA-CMTSP3-STCR85D-7.