Build: #4 failed
Job: Test Regressions Many Linux 2.28 Rocky 8.10 Docker failed
Build log
The build generated 21,205 lines of output.The output is too long and has been truncated to the last 1,000 lines. Download or view full build log.
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Summary::getResult antenna 5 flagged: 344861 total: 2.51494e+06 (13.7%) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Summary::getResult antenna 30 flagged: 674681 total: 2.51494e+06 (26.8%) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Summary::getResult antenna 8 flagged: 364743 total: 2.51494e+06 (14.5%) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Summary::getResult antenna 25 flagged: 2.51494e+06 total: 2.51494e+06 (100%) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Summary::getResult antenna 12 flagged: 348677 total: 2.51494e+06 (13.9%) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Summary::getResult antenna 1 flagged: 353539 total: 2.51494e+06 (14.1%) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Summary::getResult antenna 7 flagged: 2.51494e+06 total: 2.51494e+06 (100%) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Summary::getResult antenna 10 flagged: 354770 total: 2.51494e+06 (14.1%) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Summary::getResult antenna 2 flagged: 353111 total: 2.51494e+06 (14%) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Summary::getResult antenna 14 flagged: 352540 total: 2.51494e+06 (14%) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Summary::getResult antenna 19 flagged: 2.51494e+06 total: 2.51494e+06 (100%) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Summary::getResult antenna 15 flagged: 511196 total: 2.51494e+06 (20.3%) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Summary::getResult antenna 16 flagged: 507257 total: 2.51494e+06 (20.2%) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Summary::getResult field 3C147 flagged: 9.61534e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Summary::getResult spw 0 flagged: 9.61534e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Summary::getResult correlation LL flagged: 4.81288e+06 total: 1.8862e+07 (25.5%) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Summary::getResult correlation RR flagged: 4.80246e+06 total: 1.8862e+07 (25.5%) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Summary::getResult array 0 flagged: 9.61534e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Summary::getResult Total Flagged: 9.61534e+06 Total Counts: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO flagdata::::casa Flags are not written to the MS. (action='calculate') |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO flagdata::::casa Task flagdata complete. Start time: 2024-10-23 05:40:30.295518 End time: 2024-10-23 05:40:31.202892 |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO flagdata::::casa ##### End Task: flagdata ##### |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO flagdata::::casa ########################################## |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO flagdata::::casa * Flagging 3ctst_copy.ms |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO flagdata::::casa ########################################## |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO flagdata::::casa ##### Begin Task: flagdata ##### |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO flagdata::::casa flagdata( vis='3ctst_copy.ms', mode='rflag', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='0:20~350', field='0', antenna='', uvrange='', timerange='', correlation='', scan='', intent='', array='', observation='', feed='', clipminmax=[], datacolumn='data', clipoutside=True, channelavg=False, chanbin=1, timeavg=True, timebin='3min', clipzeros=False, quackinterval=1.0, quackmode='beg', quackincrement=False, tolerance=0.0, addantenna='', lowerlimit=0.0, upperlimit=90.0, ntime='scan', combinescans=True, timecutoff=4.0, freqcutoff=3.0, timefit='line', freqfit='poly', maxnpieces=7, flagdimension='freqtime', usewindowstats='none', halfwin=1, extendflags=False, winsize=3, timedev='', freqdev='', timedevscale=7.0, freqdevscale=7.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='none', flagbackup=False, savepars=False, cmdreason='', outfile='', overwrite=True, writeflags=True ) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO AgentFlagger::open Table type is Measurement Set |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO flagdata::::casa Rflag mode is active |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO FlagMSHandler::selectData Selected spw-channels ids are Axis Lengths: [1, 4] (NB: Matrix in Row/Column order) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO FlagMSHandler::selectData + [0, 20, 350, 1] |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO flagdata::::casa Parsing the display parameters |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO flagdata::::casa Initializing the agents |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO AgentFlagger::initAgents There are initially 2 agents in the list. Agents: rflag, display |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Rflag::setAgentParameters data column is DATA |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Rflag::setAgentParameters Visibility expression is ABS RR,LL |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Rflag::setAgentParameters Time average bin is 180 |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Rflag::setAgentParameters display is: none |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Rflag::setAgentParameters writeflags is: 1 |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Rflag::setAgentParameters (writeflags OR display)=(1,none), will apply flags on modified flag cube |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Rflag::setAgentParameters winsize is 3 |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Rflag::setAgentParameters spectralmax is 1e+06 |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Rflag::setAgentParameters spectralmin is 0 |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Rflag::setAgentParameters timedevscale is 7 |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Rflag::setAgentParameters freqdevscale is 7 |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Rflag::setAgentParameters No timedev value given. Will Use automatically computed values if applying flags. |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Rflag::setAgentParameters No freqdev value given. Will Use automatically computed values if applying flags. |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Display::setAgentParameters data column is DATA |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Display::setAgentParameters Visibility expression is ABS RR,LL |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Display::setAgentParameters pause is 1 |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Display::setAgentParameters datadisplay is 0 |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Display::setAgentParameters reportdisplay is 0 |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO Display::setAgentParameters format is screen |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO AgentFlagger::initAgents There are 2 valid agents in the list. Agents: rflag, display |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO flagdata::::casa Running the agentflagger tool |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:31 INFO FlagDataHandler::preLoadColumn Setting row blocking to number of rows in selected table: 56985 |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:35 INFO FlagMSHandler:: Chunk = 1 [progress: 100%], Observation = 0, Array = 0, Scan = 1, Field = 0 (3C147), Spw = 0, Channels = 429, Corrs = [ RR LL ], Total Rows = 56985 |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:36 INFO Display::getChunkInfo FlagAgentDisplay::getChunkInfo Field : 0 , 3C147 Spw : 0 Scan : 1 : 11 |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:37 INFO Rflag::chunkSummary => Data flagged so far 0.000156293% (7/4478760) |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:37 INFO FlagMSHandler::nextChunk ==================================================================================== |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:37 INFO Rflag::tableSummary => Percentage of data flagged in table selection: 0.000156293% |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:37 INFO AgentFlagger::run => Writing flags to the MS |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:37 INFO Display::displayReports Report Displays are turned OFF |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:37 INFO flagdata::::casa Task flagdata complete. Start time: 2024-10-23 05:40:31.214756 End time: 2024-10-23 05:40:36.662522 |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:37 INFO flagdata::::casa ##### End Task: flagdata ##### |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:37 INFO flagdata::::casa ########################################## |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:37 INFO flagdata::::casa ########################################## |
| 23-Oct-2024 01:40:36 | 2024-10-23 05:40:37 INFO flagdata::::casa ##### Begin Task: flagdata ##### |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:37 INFO flagdata::::casa flagdata( vis='3ctst_copy.ms', mode='summary', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='0:20~350', 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 ) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:37 INFO AgentFlagger::open Table type is Measurement Set |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:37 INFO flagdata::::casa Summary mode is active |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:37 INFO FlagMSHandler::selectData Selected spw-channels ids are Axis Lengths: [1, 4] (NB: Matrix in Row/Column order) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:37 INFO FlagMSHandler::selectData + [0, 20, 350, 1] |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:37 INFO flagdata::::casa Initializing the agents |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:37 INFO AgentFlagger::initAgents There are initially 1 agents in the list. Agents: summary |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:37 INFO Summary::setAgentParameters display is: |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:37 INFO AgentFlagger::initAgents There are 1 valid agents in the list. Agents: summary |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:37 INFO flagdata::::casa Running the agentflagger tool |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:37 INFO FlagMSHandler:: Chunk = 1 [progress: 53%], Observation = 0, Array = 0, Scan = 1, Field = 0 (3C147), Spw = 0, Channels = 429, Corrs = [ RR LL ], Total Rows = 30450 |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO FlagMSHandler:: Chunk = 2 [progress: 100%], Observation = 0, Array = 0, Scan = 11, Field = 0 (3C147), Spw = 0, Channels = 429, Corrs = [ RR LL ], Total Rows = 26535 |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO FlagMSHandler::nextChunk ==================================================================================== |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult observation 0 flagged: 9.61535e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult scan 11 flagged: 4.4775e+06 total: 1.75662e+07 (25.5%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult scan 1 flagged: 5.13785e+06 total: 2.01579e+07 (25.5%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 29 flagged: 669363 total: 2.51494e+06 (26.6%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 27 flagged: 584615 total: 2.51494e+06 (23.2%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 26 flagged: 584676 total: 2.51494e+06 (23.2%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 28 flagged: 670637 total: 2.51494e+06 (26.7%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 23 flagged: 336755 total: 2.51494e+06 (13.4%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 20 flagged: 350508 total: 2.51494e+06 (13.9%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 18 flagged: 584935 total: 2.51494e+06 (23.3%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 24 flagged: 332031 total: 2.51494e+06 (13.2%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 17 flagged: 609443 total: 2.51494e+06 (24.2%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 6 flagged: 347016 total: 2.51494e+06 (13.8%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 21 flagged: 344996 total: 2.51494e+06 (13.7%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 4 flagged: 370066 total: 2.51494e+06 (14.7%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 9 flagged: 356521 total: 2.51494e+06 (14.2%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 11 flagged: 341940 total: 2.51494e+06 (13.6%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 3 flagged: 348138 total: 2.51494e+06 (13.8%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 13 flagged: 350382 total: 2.51494e+06 (13.9%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 22 flagged: 338485 total: 2.51494e+06 (13.5%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 5 flagged: 344861 total: 2.51494e+06 (13.7%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 30 flagged: 674681 total: 2.51494e+06 (26.8%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 8 flagged: 364743 total: 2.51494e+06 (14.5%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 25 flagged: 2.51494e+06 total: 2.51494e+06 (100%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 12 flagged: 348678 total: 2.51494e+06 (13.9%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 1 flagged: 353539 total: 2.51494e+06 (14.1%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 7 flagged: 2.51494e+06 total: 2.51494e+06 (100%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 10 flagged: 354770 total: 2.51494e+06 (14.1%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 2 flagged: 353113 total: 2.51494e+06 (14%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 14 flagged: 352541 total: 2.51494e+06 (14%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 19 flagged: 2.51494e+06 total: 2.51494e+06 (100%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 15 flagged: 511196 total: 2.51494e+06 (20.3%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult antenna 16 flagged: 507257 total: 2.51494e+06 (20.2%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult field 3C147 flagged: 9.61535e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult spw 0 flagged: 9.61535e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult correlation LL flagged: 4.81288e+06 total: 1.8862e+07 (25.5%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult correlation RR flagged: 4.80247e+06 total: 1.8862e+07 (25.5%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult array 0 flagged: 9.61535e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO Summary::getResult Total Flagged: 9.61535e+06 Total Counts: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO flagdata::::casa Flags are not written to the MS. (action='calculate') |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO flagdata::::casa Task flagdata complete. Start time: 2024-10-23 05:40:36.674779 End time: 2024-10-23 05:40:38.213191 |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO flagdata::::casa ##### End Task: flagdata ##### |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO flagdata::::casa ########################################## |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO flagdata::::casa * Step 5. Total flagged before: 9615343.0 (25.489%), after: 9615350.0 (25.489%). Used timebin: 3min, scale: 7 |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO flagdata::::casa ########################################## |
| 23-Oct-2024 01:40:38 | 2024-10-23 05:40:38 INFO flagdata::::casa ##### Begin Task: flagdata ##### |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:38 INFO flagdata::::casa flagdata( vis='3ctst_copy.ms', mode='summary', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='0:20~350', 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 ) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:38 INFO AgentFlagger::open Table type is Measurement Set |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:38 INFO flagdata::::casa Summary mode is active |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:38 INFO FlagMSHandler::selectData Selected spw-channels ids are Axis Lengths: [1, 4] (NB: Matrix in Row/Column order) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:38 INFO FlagMSHandler::selectData + [0, 20, 350, 1] |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:38 INFO flagdata::::casa Initializing the agents |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:38 INFO AgentFlagger::initAgents There are initially 1 agents in the list. Agents: summary |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:38 INFO Summary::setAgentParameters display is: |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:38 INFO AgentFlagger::initAgents There are 1 valid agents in the list. Agents: summary |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:38 INFO flagdata::::casa Running the agentflagger tool |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:38 INFO FlagMSHandler:: Chunk = 1 [progress: 53%], Observation = 0, Array = 0, Scan = 1, Field = 0 (3C147), Spw = 0, Channels = 429, Corrs = [ RR LL ], Total Rows = 30450 |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO FlagMSHandler:: Chunk = 2 [progress: 100%], Observation = 0, Array = 0, Scan = 11, Field = 0 (3C147), Spw = 0, Channels = 429, Corrs = [ RR LL ], Total Rows = 26535 |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO FlagMSHandler::nextChunk ==================================================================================== |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult observation 0 flagged: 9.61535e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult scan 11 flagged: 4.4775e+06 total: 1.75662e+07 (25.5%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult scan 1 flagged: 5.13785e+06 total: 2.01579e+07 (25.5%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 29 flagged: 669363 total: 2.51494e+06 (26.6%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 27 flagged: 584615 total: 2.51494e+06 (23.2%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 26 flagged: 584676 total: 2.51494e+06 (23.2%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 28 flagged: 670637 total: 2.51494e+06 (26.7%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 23 flagged: 336755 total: 2.51494e+06 (13.4%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 20 flagged: 350508 total: 2.51494e+06 (13.9%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 18 flagged: 584935 total: 2.51494e+06 (23.3%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 24 flagged: 332031 total: 2.51494e+06 (13.2%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 17 flagged: 609443 total: 2.51494e+06 (24.2%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 6 flagged: 347016 total: 2.51494e+06 (13.8%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 21 flagged: 344996 total: 2.51494e+06 (13.7%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 4 flagged: 370066 total: 2.51494e+06 (14.7%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 9 flagged: 356521 total: 2.51494e+06 (14.2%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 11 flagged: 341940 total: 2.51494e+06 (13.6%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 3 flagged: 348138 total: 2.51494e+06 (13.8%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 13 flagged: 350382 total: 2.51494e+06 (13.9%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 22 flagged: 338485 total: 2.51494e+06 (13.5%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 5 flagged: 344861 total: 2.51494e+06 (13.7%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 30 flagged: 674681 total: 2.51494e+06 (26.8%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 8 flagged: 364743 total: 2.51494e+06 (14.5%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 25 flagged: 2.51494e+06 total: 2.51494e+06 (100%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 12 flagged: 348678 total: 2.51494e+06 (13.9%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 1 flagged: 353539 total: 2.51494e+06 (14.1%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 7 flagged: 2.51494e+06 total: 2.51494e+06 (100%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 10 flagged: 354770 total: 2.51494e+06 (14.1%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 2 flagged: 353113 total: 2.51494e+06 (14%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 14 flagged: 352541 total: 2.51494e+06 (14%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 19 flagged: 2.51494e+06 total: 2.51494e+06 (100%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 15 flagged: 511196 total: 2.51494e+06 (20.3%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult antenna 16 flagged: 507257 total: 2.51494e+06 (20.2%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult field 3C147 flagged: 9.61535e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult spw 0 flagged: 9.61535e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult correlation LL flagged: 4.81288e+06 total: 1.8862e+07 (25.5%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult correlation RR flagged: 4.80247e+06 total: 1.8862e+07 (25.5%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult array 0 flagged: 9.61535e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO Summary::getResult Total Flagged: 9.61535e+06 Total Counts: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO flagdata::::casa Flags are not written to the MS. (action='calculate') |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO flagdata::::casa Task flagdata complete. Start time: 2024-10-23 05:40:38.230428 End time: 2024-10-23 05:40:39.147420 |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO flagdata::::casa ##### End Task: flagdata ##### |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO flagdata::::casa ########################################## |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO flagdata::::casa * Flagging 3ctst_copy.ms |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO flagdata::::casa ########################################## |
| 23-Oct-2024 01:40:39 | 2024-10-23 05:40:39 INFO flagdata::::casa ##### Begin Task: flagdata ##### |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO flagdata::::casa flagdata( vis='3ctst_copy.ms', mode='rflag', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='0:20~350', field='0', antenna='', uvrange='', timerange='', correlation='', scan='', intent='', array='', observation='', feed='', clipminmax=[], datacolumn='data', clipoutside=True, channelavg=False, chanbin=1, timeavg=True, timebin='3min', clipzeros=False, quackinterval=1.0, quackmode='beg', quackincrement=False, tolerance=0.0, addantenna='', lowerlimit=0.0, upperlimit=90.0, ntime='scan', combinescans=True, timecutoff=4.0, freqcutoff=3.0, timefit='line', freqfit='poly', maxnpieces=7, flagdimension='freqtime', usewindowstats='none', halfwin=1, extendflags=False, winsize=3, timedev='', freqdev='', timedevscale=7.0, freqdevscale=7.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='none', flagbackup=False, savepars=False, cmdreason='', outfile='', overwrite=True, writeflags=True ) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO AgentFlagger::open Table type is Measurement Set |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO flagdata::::casa Rflag mode is active |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO FlagMSHandler::selectData Selected spw-channels ids are Axis Lengths: [1, 4] (NB: Matrix in Row/Column order) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO FlagMSHandler::selectData + [0, 20, 350, 1] |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO flagdata::::casa Parsing the display parameters |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO flagdata::::casa Initializing the agents |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO AgentFlagger::initAgents There are initially 2 agents in the list. Agents: rflag, display |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO Rflag::setAgentParameters data column is DATA |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO Rflag::setAgentParameters Visibility expression is ABS RR,LL |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO Rflag::setAgentParameters Time average bin is 180 |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO Rflag::setAgentParameters display is: none |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO Rflag::setAgentParameters writeflags is: 1 |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO Rflag::setAgentParameters (writeflags OR display)=(1,none), will apply flags on modified flag cube |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO Rflag::setAgentParameters winsize is 3 |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO Rflag::setAgentParameters spectralmax is 1e+06 |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO Rflag::setAgentParameters spectralmin is 0 |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO Rflag::setAgentParameters timedevscale is 7 |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO Rflag::setAgentParameters freqdevscale is 7 |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO Rflag::setAgentParameters No timedev value given. Will Use automatically computed values if applying flags. |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO Rflag::setAgentParameters No freqdev value given. Will Use automatically computed values if applying flags. |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO Display::setAgentParameters data column is DATA |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO Display::setAgentParameters Visibility expression is ABS RR,LL |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO Display::setAgentParameters pause is 1 |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO Display::setAgentParameters datadisplay is 0 |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO Display::setAgentParameters reportdisplay is 0 |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO Display::setAgentParameters format is screen |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO AgentFlagger::initAgents There are 2 valid agents in the list. Agents: rflag, display |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO flagdata::::casa Running the agentflagger tool |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:39 INFO FlagDataHandler::preLoadColumn Setting row blocking to number of rows in selected table: 56985 |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:42 INFO FlagMSHandler:: Chunk = 1 [progress: 100%], Observation = 0, Array = 0, Scan = 1, Field = 0 (3C147), Spw = 0, Channels = 429, Corrs = [ RR LL ], Total Rows = 56985 |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO Display::getChunkInfo FlagAgentDisplay::getChunkInfo Field : 0 , 3C147 Spw : 0 Scan : 1 : 11 |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO Rflag::chunkSummary => Data flagged so far 8.93104e-05% (4/4478760) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO FlagMSHandler::nextChunk ==================================================================================== |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO Rflag::tableSummary => Percentage of data flagged in table selection: 8.93104e-05% |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO AgentFlagger::run => Writing flags to the MS |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO Display::displayReports Report Displays are turned OFF |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO flagdata::::casa Task flagdata complete. Start time: 2024-10-23 05:40:39.181515 End time: 2024-10-23 05:40:44.326730 |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO flagdata::::casa ##### End Task: flagdata ##### |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO flagdata::::casa ########################################## |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO flagdata::::casa ########################################## |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO flagdata::::casa ##### Begin Task: flagdata ##### |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO flagdata::::casa flagdata( vis='3ctst_copy.ms', mode='summary', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='0:20~350', 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 ) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO AgentFlagger::open Table type is Measurement Set |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO flagdata::::casa Summary mode is active |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO FlagMSHandler::selectData Selected spw-channels ids are Axis Lengths: [1, 4] (NB: Matrix in Row/Column order) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO FlagMSHandler::selectData + [0, 20, 350, 1] |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO flagdata::::casa Initializing the agents |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO AgentFlagger::initAgents There are initially 1 agents in the list. Agents: summary |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO Summary::setAgentParameters display is: |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO AgentFlagger::initAgents There are 1 valid agents in the list. Agents: summary |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO flagdata::::casa Running the agentflagger tool |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:44 INFO FlagMSHandler:: Chunk = 1 [progress: 53%], Observation = 0, Array = 0, Scan = 1, Field = 0 (3C147), Spw = 0, Channels = 429, Corrs = [ RR LL ], Total Rows = 30450 |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO FlagMSHandler:: Chunk = 2 [progress: 100%], Observation = 0, Array = 0, Scan = 11, Field = 0 (3C147), Spw = 0, Channels = 429, Corrs = [ RR LL ], Total Rows = 26535 |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO FlagMSHandler::nextChunk ==================================================================================== |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult observation 0 flagged: 9.61535e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult scan 11 flagged: 4.4775e+06 total: 1.75662e+07 (25.5%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult scan 1 flagged: 5.13785e+06 total: 2.01579e+07 (25.5%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 29 flagged: 669363 total: 2.51494e+06 (26.6%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 27 flagged: 584615 total: 2.51494e+06 (23.2%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 26 flagged: 584676 total: 2.51494e+06 (23.2%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 28 flagged: 670637 total: 2.51494e+06 (26.7%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 23 flagged: 336755 total: 2.51494e+06 (13.4%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 20 flagged: 350508 total: 2.51494e+06 (13.9%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 18 flagged: 584936 total: 2.51494e+06 (23.3%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 24 flagged: 332031 total: 2.51494e+06 (13.2%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 17 flagged: 609445 total: 2.51494e+06 (24.2%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 6 flagged: 347016 total: 2.51494e+06 (13.8%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 21 flagged: 344996 total: 2.51494e+06 (13.7%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 4 flagged: 370067 total: 2.51494e+06 (14.7%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 9 flagged: 356521 total: 2.51494e+06 (14.2%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 11 flagged: 341940 total: 2.51494e+06 (13.6%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 3 flagged: 348138 total: 2.51494e+06 (13.8%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 13 flagged: 350384 total: 2.51494e+06 (13.9%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 22 flagged: 338485 total: 2.51494e+06 (13.5%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 5 flagged: 344861 total: 2.51494e+06 (13.7%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 30 flagged: 674681 total: 2.51494e+06 (26.8%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 8 flagged: 364743 total: 2.51494e+06 (14.5%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 25 flagged: 2.51494e+06 total: 2.51494e+06 (100%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 12 flagged: 348678 total: 2.51494e+06 (13.9%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 1 flagged: 353539 total: 2.51494e+06 (14.1%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 7 flagged: 2.51494e+06 total: 2.51494e+06 (100%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 10 flagged: 354770 total: 2.51494e+06 (14.1%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 2 flagged: 353114 total: 2.51494e+06 (14%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 14 flagged: 352542 total: 2.51494e+06 (14%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 19 flagged: 2.51494e+06 total: 2.51494e+06 (100%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 15 flagged: 511196 total: 2.51494e+06 (20.3%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult antenna 16 flagged: 507257 total: 2.51494e+06 (20.2%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult field 3C147 flagged: 9.61535e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult spw 0 flagged: 9.61535e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult correlation LL flagged: 4.81288e+06 total: 1.8862e+07 (25.5%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult correlation RR flagged: 4.80247e+06 total: 1.8862e+07 (25.5%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult array 0 flagged: 9.61535e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::getResult Total Flagged: 9.61535e+06 Total Counts: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO flagdata::::casa Flags are not written to the MS. (action='calculate') |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO flagdata::::casa Task flagdata complete. Start time: 2024-10-23 05:40:44.338986 End time: 2024-10-23 05:40:45.013060 |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO flagdata::::casa ##### End Task: flagdata ##### |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO flagdata::::casa ########################################## |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO flagdata::::casa * Step 6. Total flagged before: 9615350.0 (25.489%), after: 9615354.0 (25.489%). Used timebin: 3min, scale: 7 |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO flagdata::::casa ########################################## |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO flagdata::::casa ##### Begin Task: flagdata ##### |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO flagdata::::casa flagdata( vis='3ctst_copy.ms', mode='summary', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='0:20~350', 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 ) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO AgentFlagger::open Table type is Measurement Set |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO flagdata::::casa Summary mode is active |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO FlagMSHandler::selectData Selected spw-channels ids are Axis Lengths: [1, 4] (NB: Matrix in Row/Column order) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO FlagMSHandler::selectData + [0, 20, 350, 1] |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO flagdata::::casa Initializing the agents |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO AgentFlagger::initAgents There are initially 1 agents in the list. Agents: summary |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO Summary::setAgentParameters display is: |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO AgentFlagger::initAgents There are 1 valid agents in the list. Agents: summary |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO flagdata::::casa Running the agentflagger tool |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO FlagMSHandler:: Chunk = 1 [progress: 53%], Observation = 0, Array = 0, Scan = 1, Field = 0 (3C147), Spw = 0, Channels = 429, Corrs = [ RR LL ], Total Rows = 30450 |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:45 INFO FlagMSHandler:: Chunk = 2 [progress: 100%], Observation = 0, Array = 0, Scan = 11, Field = 0 (3C147), Spw = 0, Channels = 429, Corrs = [ RR LL ], Total Rows = 26535 |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:46 INFO FlagMSHandler::nextChunk ==================================================================================== |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:46 INFO Summary::getResult observation 0 flagged: 9.61535e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:46 INFO Summary::getResult scan 11 flagged: 4.4775e+06 total: 1.75662e+07 (25.5%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:46 INFO Summary::getResult scan 1 flagged: 5.13785e+06 total: 2.01579e+07 (25.5%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 29 flagged: 669363 total: 2.51494e+06 (26.6%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 27 flagged: 584615 total: 2.51494e+06 (23.2%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 26 flagged: 584676 total: 2.51494e+06 (23.2%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 28 flagged: 670637 total: 2.51494e+06 (26.7%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 23 flagged: 336755 total: 2.51494e+06 (13.4%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 20 flagged: 350508 total: 2.51494e+06 (13.9%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 18 flagged: 584936 total: 2.51494e+06 (23.3%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 24 flagged: 332031 total: 2.51494e+06 (13.2%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 17 flagged: 609445 total: 2.51494e+06 (24.2%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 6 flagged: 347016 total: 2.51494e+06 (13.8%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 21 flagged: 344996 total: 2.51494e+06 (13.7%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 4 flagged: 370067 total: 2.51494e+06 (14.7%) |
| 23-Oct-2024 01:40:45 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 9 flagged: 356521 total: 2.51494e+06 (14.2%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 11 flagged: 341940 total: 2.51494e+06 (13.6%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 3 flagged: 348138 total: 2.51494e+06 (13.8%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 13 flagged: 350384 total: 2.51494e+06 (13.9%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 22 flagged: 338485 total: 2.51494e+06 (13.5%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 5 flagged: 344861 total: 2.51494e+06 (13.7%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 30 flagged: 674681 total: 2.51494e+06 (26.8%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 8 flagged: 364743 total: 2.51494e+06 (14.5%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 25 flagged: 2.51494e+06 total: 2.51494e+06 (100%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 12 flagged: 348678 total: 2.51494e+06 (13.9%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 1 flagged: 353539 total: 2.51494e+06 (14.1%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 7 flagged: 2.51494e+06 total: 2.51494e+06 (100%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 10 flagged: 354770 total: 2.51494e+06 (14.1%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 2 flagged: 353114 total: 2.51494e+06 (14%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 14 flagged: 352542 total: 2.51494e+06 (14%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 19 flagged: 2.51494e+06 total: 2.51494e+06 (100%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 15 flagged: 511196 total: 2.51494e+06 (20.3%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult antenna 16 flagged: 507257 total: 2.51494e+06 (20.2%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult field 3C147 flagged: 9.61535e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult spw 0 flagged: 9.61535e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult correlation LL flagged: 4.81288e+06 total: 1.8862e+07 (25.5%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult correlation RR flagged: 4.80247e+06 total: 1.8862e+07 (25.5%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult array 0 flagged: 9.61535e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Summary::getResult Total Flagged: 9.61535e+06 Total Counts: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO flagdata::::casa Flags are not written to the MS. (action='calculate') |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO flagdata::::casa Task flagdata complete. Start time: 2024-10-23 05:40:45.025491 End time: 2024-10-23 05:40:45.668495 |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO flagdata::::casa ##### End Task: flagdata ##### |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO flagdata::::casa ########################################## |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO flagdata::::casa * Flagging 3ctst_copy.ms |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO flagdata::::casa ########################################## |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO flagdata::::casa ##### Begin Task: flagdata ##### |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO flagdata::::casa flagdata( vis='3ctst_copy.ms', mode='rflag', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='0:20~350', field='0', antenna='', uvrange='', timerange='', correlation='', scan='', intent='', array='', observation='', feed='', clipminmax=[], datacolumn='data', clipoutside=True, channelavg=False, chanbin=1, timeavg=True, timebin='3min', clipzeros=False, quackinterval=1.0, quackmode='beg', quackincrement=False, tolerance=0.0, addantenna='', lowerlimit=0.0, upperlimit=90.0, ntime='scan', combinescans=True, timecutoff=4.0, freqcutoff=3.0, timefit='line', freqfit='poly', maxnpieces=7, flagdimension='freqtime', usewindowstats='none', halfwin=1, extendflags=False, winsize=3, timedev='', freqdev='', timedevscale=7.0, freqdevscale=7.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='none', flagbackup=False, savepars=False, cmdreason='', outfile='', overwrite=True, writeflags=True ) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO AgentFlagger::open Table type is Measurement Set |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO flagdata::::casa Rflag mode is active |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO FlagMSHandler::selectData Selected spw-channels ids are Axis Lengths: [1, 4] (NB: Matrix in Row/Column order) |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO FlagMSHandler::selectData + [0, 20, 350, 1] |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO flagdata::::casa Parsing the display parameters |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO flagdata::::casa Initializing the agents |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO AgentFlagger::initAgents There are initially 2 agents in the list. Agents: rflag, display |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Rflag::setAgentParameters data column is DATA |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Rflag::setAgentParameters Visibility expression is ABS RR,LL |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Rflag::setAgentParameters Time average bin is 180 |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Rflag::setAgentParameters display is: none |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Rflag::setAgentParameters writeflags is: 1 |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Rflag::setAgentParameters (writeflags OR display)=(1,none), will apply flags on modified flag cube |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Rflag::setAgentParameters winsize is 3 |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Rflag::setAgentParameters spectralmax is 1e+06 |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Rflag::setAgentParameters spectralmin is 0 |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Rflag::setAgentParameters timedevscale is 7 |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Rflag::setAgentParameters freqdevscale is 7 |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Rflag::setAgentParameters No timedev value given. Will Use automatically computed values if applying flags. |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Rflag::setAgentParameters No freqdev value given. Will Use automatically computed values if applying flags. |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Display::setAgentParameters data column is DATA |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Display::setAgentParameters Visibility expression is ABS RR,LL |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Display::setAgentParameters pause is 1 |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Display::setAgentParameters datadisplay is 0 |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Display::setAgentParameters reportdisplay is 0 |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO Display::setAgentParameters format is screen |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO AgentFlagger::initAgents There are 2 valid agents in the list. Agents: rflag, display |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO flagdata::::casa Running the agentflagger tool |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:46 INFO FlagDataHandler::preLoadColumn Setting row blocking to number of rows in selected table: 56985 |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:49 INFO FlagMSHandler:: Chunk = 1 [progress: 100%], Observation = 0, Array = 0, Scan = 1, Field = 0 (3C147), Spw = 0, Channels = 429, Corrs = [ RR LL ], Total Rows = 56985 |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:51 INFO Display::getChunkInfo FlagAgentDisplay::getChunkInfo Field : 0 , 3C147 Spw : 0 Scan : 1 : 11 |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:51 INFO FlagMSHandler::nextChunk ==================================================================================== |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:51 INFO AgentFlagger::run => Writing flags to the MS |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:51 INFO Display::displayReports Report Displays are turned OFF |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:51 INFO flagdata::::casa Task flagdata complete. Start time: 2024-10-23 05:40:45.680490 End time: 2024-10-23 05:40:50.835264 |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:51 INFO flagdata::::casa ##### End Task: flagdata ##### |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:51 INFO flagdata::::casa ########################################## |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:51 INFO flagdata::::casa ########################################## |
| 23-Oct-2024 01:40:50 | 2024-10-23 05:40:51 INFO flagdata::::casa ##### Begin Task: flagdata ##### |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:51 INFO flagdata::::casa flagdata( vis='3ctst_copy.ms', mode='summary', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='0:20~350', 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 ) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:51 INFO AgentFlagger::open Table type is Measurement Set |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:51 INFO flagdata::::casa Summary mode is active |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:51 INFO FlagMSHandler::selectData Selected spw-channels ids are Axis Lengths: [1, 4] (NB: Matrix in Row/Column order) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:51 INFO FlagMSHandler::selectData + [0, 20, 350, 1] |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:51 INFO flagdata::::casa Initializing the agents |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:51 INFO AgentFlagger::initAgents There are initially 1 agents in the list. Agents: summary |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:51 INFO Summary::setAgentParameters display is: |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:51 INFO AgentFlagger::initAgents There are 1 valid agents in the list. Agents: summary |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:51 INFO flagdata::::casa Running the agentflagger tool |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:51 INFO FlagMSHandler:: Chunk = 1 [progress: 53%], Observation = 0, Array = 0, Scan = 1, Field = 0 (3C147), Spw = 0, Channels = 429, Corrs = [ RR LL ], Total Rows = 30450 |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:51 INFO FlagMSHandler:: Chunk = 2 [progress: 100%], Observation = 0, Array = 0, Scan = 11, Field = 0 (3C147), Spw = 0, Channels = 429, Corrs = [ RR LL ], Total Rows = 26535 |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO FlagMSHandler::nextChunk ==================================================================================== |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult observation 0 flagged: 9.61535e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult scan 11 flagged: 4.4775e+06 total: 1.75662e+07 (25.5%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult scan 1 flagged: 5.13785e+06 total: 2.01579e+07 (25.5%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 29 flagged: 669363 total: 2.51494e+06 (26.6%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 27 flagged: 584615 total: 2.51494e+06 (23.2%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 26 flagged: 584676 total: 2.51494e+06 (23.2%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 28 flagged: 670637 total: 2.51494e+06 (26.7%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 23 flagged: 336755 total: 2.51494e+06 (13.4%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 20 flagged: 350508 total: 2.51494e+06 (13.9%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 18 flagged: 584936 total: 2.51494e+06 (23.3%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 24 flagged: 332031 total: 2.51494e+06 (13.2%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 17 flagged: 609445 total: 2.51494e+06 (24.2%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 6 flagged: 347016 total: 2.51494e+06 (13.8%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 21 flagged: 344996 total: 2.51494e+06 (13.7%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 4 flagged: 370067 total: 2.51494e+06 (14.7%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 9 flagged: 356521 total: 2.51494e+06 (14.2%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 11 flagged: 341940 total: 2.51494e+06 (13.6%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 3 flagged: 348138 total: 2.51494e+06 (13.8%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 13 flagged: 350384 total: 2.51494e+06 (13.9%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 22 flagged: 338485 total: 2.51494e+06 (13.5%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 5 flagged: 344861 total: 2.51494e+06 (13.7%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 30 flagged: 674681 total: 2.51494e+06 (26.8%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 8 flagged: 364743 total: 2.51494e+06 (14.5%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 25 flagged: 2.51494e+06 total: 2.51494e+06 (100%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 12 flagged: 348678 total: 2.51494e+06 (13.9%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 1 flagged: 353539 total: 2.51494e+06 (14.1%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 7 flagged: 2.51494e+06 total: 2.51494e+06 (100%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 10 flagged: 354770 total: 2.51494e+06 (14.1%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 2 flagged: 353114 total: 2.51494e+06 (14%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 14 flagged: 352542 total: 2.51494e+06 (14%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 19 flagged: 2.51494e+06 total: 2.51494e+06 (100%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 15 flagged: 511196 total: 2.51494e+06 (20.3%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult antenna 16 flagged: 507257 total: 2.51494e+06 (20.2%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult field 3C147 flagged: 9.61535e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult spw 0 flagged: 9.61535e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult correlation LL flagged: 4.81288e+06 total: 1.8862e+07 (25.5%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult correlation RR flagged: 4.80247e+06 total: 1.8862e+07 (25.5%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult array 0 flagged: 9.61535e+06 total: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO Summary::getResult Total Flagged: 9.61535e+06 Total Counts: 3.77241e+07 (25.5%) |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO flagdata::::casa Flags are not written to the MS. (action='calculate') |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO flagdata::::casa Task flagdata complete. Start time: 2024-10-23 05:40:50.847021 End time: 2024-10-23 05:40:51.915205 |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO flagdata::::casa ##### End Task: flagdata ##### |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO flagdata::::casa ########################################## |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 INFO flagdata::::casa * Step 7. Total flagged before: 9615354.0 (25.489%), after: 9615354.0 (25.489%). Used timebin: 3min, scale: 7 |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 WARN TIMING::::casa Step 2 |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 WARN TIMING::::casa Time now: 1729662051.9162683 |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 WARN TIMING::::casa Time used this step: 50.41716122627258 |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 WARN TIMING::::casa Total time used so far: 101.28030896186829 |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 WARN TIMING::::casa Step Time used (s) Fraction of total time (percent) [description] |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 WARN TIMING::::casa 2 40.54216742515564 40.0296640489314 [2] |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 WARN TIMING::::casa 2 10.320980310440063 10.190510293887314 [2] |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 WARN TIMING::::casa 2 50.41716122627258 49.779825657181284 [2] |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 WARN TIMING::::casa Step 3 |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 WARN TIMING::::casa Time now: 1729662051.9171848 |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 WARN TIMING::::casa Time used this step: 0.0009164810180664062 |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 WARN TIMING::::casa Total time used so far: 101.28122544288635 |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 WARN TIMING::::casa Step Time used (s) Fraction of total time (percent) [description] |
| 23-Oct-2024 01:40:51 | 2024-10-23 05:40:52 WARN TIMING::::casa 3 40.54216742515564 40.029301825556836 [3] |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:52 WARN TIMING::::casa 3 10.320980310440063 10.190418081246639 [3] |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:52 WARN TIMING::::casa 3 50.41716122627258 49.77937520582568 [3] |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:52 WARN TIMING::::casa 3 0.0009164810180664062 0.0009048873708417168 [3] |
| 23-Oct-2024 01:41:50 | . |
| 23-Oct-2024 01:41:50 | ---------------------------------------------------------------------- |
| 23-Oct-2024 01:41:50 | Ran 2 tests in 102.430s |
| 23-Oct-2024 01:41:50 | |
| 23-Oct-2024 01:41:50 | OK |
| 23-Oct-2024 01:41:50 | |
| 23-Oct-2024 01:41:50 | Using user configuration file /home/casatest/.casa/config.py |
| 23-Oct-2024 01:41:50 | |
| 23-Oct-2024 01:41:50 | Cannot install event loop hook for "tk" when running with `--simple-prompt`. |
| 23-Oct-2024 01:41:50 | NOTE: Tk is supported natively; use Tk apps and Tk backends with `--simple-prompt`. |
| 23-Oct-2024 01:41:50 | Cannot install event loop hook for "tk" when running with `--simple-prompt`. |
| 23-Oct-2024 01:41:50 | NOTE: Tk is supported natively; use Tk apps and Tk backends with `--simple-prompt`. |
| 23-Oct-2024 01:41:50 | Using matplotlib backend: tkagg |
| 23-Oct-2024 01:41:50 | CASA 6.7.0.11 -- Common Astronomy Software Applications [6.7.0.11] |
| 23-Oct-2024 01:41:50 | Executor result: 0 |
| 23-Oct-2024 01:41:50 | Failed tests:[] |
| 23-Oct-2024 01:41:50 | |
| 23-Oct-2024 01:41:50 | Running test: test_regression_alma_M100_if in MPI mode |
| 23-Oct-2024 01:41:50 | Running cmd ['/home/casatest/work/pkg/casa-6.7.0-11-py3.10.el8/bin/mpicasa', '-n', '4', '/home/casatest/work/pkg/casa-6.7.0-11-py3.10.el8/bin/casa', '--nogui', '--nologger', '--log2term', '--agg', '-c', '/home/casatest/work/casasources//casa6/casatests/regression/test_regression_alma_M100_if.py']in /home/casatest/work/test_regression_alma_M100_if_mpi |
| 23-Oct-2024 01:41:50 | Executing: ['/home/casatest/work/pkg/casa-6.7.0-11-py3.10.el8/bin/mpicasa', '-n', '4', '/home/casatest/work/pkg/casa-6.7.0-11-py3.10.el8/bin/casa', '--nogui', '--nologger', '--log2term', '--agg', '-c', '/home/casatest/work/casasources//casa6/casatests/regression/test_regression_alma_M100_if.py'] |
| 23-Oct-2024 01:41:50 | |
| 23-Oct-2024 01:41:50 | Using user configuration file /home/casatest/.casa/config.py |
| 23-Oct-2024 01:41:50 | |
| 23-Oct-2024 01:41:50 | Using user configuration file /home/casatest/.casa/config.py |
| 23-Oct-2024 01:41:50 | |
| 23-Oct-2024 01:41:50 | Using user configuration file /home/casatest/.casa/config.py |
| 23-Oct-2024 01:41:50 | |
| 23-Oct-2024 01:41:50 | Using user configuration file /home/casatest/.casa/config.py |
| 23-Oct-2024 01:41:50 | |
| 23-Oct-2024 01:41:50 | |
| 23-Oct-2024 01:41:50 | |
| 23-Oct-2024 01:41:50 | |
| 23-Oct-2024 01:41:50 | No event loop hook running. |
| 23-Oct-2024 01:41:50 | No event loop hook running. |
| 23-Oct-2024 01:41:50 | No event loop hook running. |
| 23-Oct-2024 01:41:50 | No event loop hook running. |
| 23-Oct-2024 01:41:50 | CASA 6.7.0.11 -- Common Astronomy Software Applications [6.7.0.11] |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa Using user configuration file /home/casatest/.casa/config.py |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa loaded config file : /home/casatest/work/pkg/casa-6.7.0-11-py3.10.el8/lib/py/lib/python3.10/site-packages/casaconfig/config.py |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa loaded config file : /home/casatest/.casa/config.py |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa config values |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa agg = True |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa cachedir = '/home/casatest/.casa' |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa casaconfig_verbose = 1 |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa colors = 'Neutral' |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa data_auto_update = False |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa datapath = ['/opt/casa/data/casa-data', '/opt/casa/data/master', '/opt/casa/data/casatestdata'] |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa iplog = False |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa iplogfile = '/home/casatest/work/test_regression_alma_M100_if_mpi/ipython-20241023-054054.log' |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa log2term = True |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa logfile = '/home/casatest/work/test_regression_alma_M100_if_mpi/casa-20241023-054053.log' |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa measures_auto_update = False |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa measurespath = '/opt/casa/data/casa-data' |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa nogui = True |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa nologfile = False |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa nologger = True |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa pipeline = False |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa startupfile = '/home/casatest/.casa/startup.py' |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa user_site = False |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa casarundata version is unknown, this is probably a legacy version not installed by casaconfig |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa measures version is unknown, this is probably a legacy version not installed by casaconfig |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa Checking Measures tables in data repository sub-directory /opt/casa/data/casa-data/geodetic |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa IERSeop2000 (version date, last date in table (UTC)): 2024/07/27/15:00, 2024/06/27/00:00:00 |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa IERSeop97 (version date, last date in table (UTC)): 2024/07/27/15:00, 2024/06/27/00:00:00 |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa IERSpredict (version date, last date in table (UTC)): 2024/08/25/15:00, 2024/11/23/00:00:00 |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa TAI_UTC (version date, last date in table (UTC)): 2024/07/27/15:00, 2017/01/01/00:00:00 |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO ::casa MPI environment detected |
| 23-Oct-2024 01:41:50 | Make plots?: True |
| 23-Oct-2024 01:41:50 | Global variable mysteps not set. |
| 23-Oct-2024 01:41:50 | Variable mysteps is empty. Executing all steps: range(0, 31) |
| 23-Oct-2024 01:41:50 | Step 0: Data import |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO importasdm::::casa ########################################## |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO importasdm::::casa ##### Begin Task: importasdm ##### |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:40:57 INFO importasdm::::casa importasdm( asdm='uid___A002_X2a5c2f_X54', vis='X54.ms', createmms=True, separationaxis='auto', numsubms='auto', corr_mode='all', srt='all', time_sampling='all', ocorr_mode='ca', compression=False, lazy=True, asis='Stati* Anten*', 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=False, outfile='', flagbackup=True, verbose=False, overwrite=True, bdfflags=False, with_pointing_correction=False, convert_ephem2geo=True, polyephem_tabtimestep=0.0 ) |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:18 INFO importasdm::::casa No ephemerides attached. |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:18 INFO importasdm::::casa Will create a Multi-MS for: X54.ms |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:19 INFO ParallelDataHelper::::casa Analyzing MS for partitioning |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:19 INFO ParallelDataHelper::::casa Automatically distribute the scan/spw pairs to balance the load along field, spw and scan axes |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:23 INFO msmetadata_cmpt.cc::open Performing internal consistency checks on /home/casatest/work/test_regression_alma_M100_if_mpi/X54.ms.temp.ms... |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:46 INFO ParallelDataHelper::::casa Finalizing MMS structure |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:46 INFO ms::createmultims Copying subtables from /home/casatest/work/test_regression_alma_M100_if_mpi/X54.ms.data/X54.ms.0000.ms to the other MMS members. |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:47 INFO importasdm::AgentFlagger::open Table type is Measurement Set |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:47 INFO importasdm::FlagVersion::saveFlagVersion Creating new backup flag file called Original |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:50 INFO importasdm::::casa Found Flag.xml in SDM |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:50 INFO importasdm::::casa Found Antenna.xml in SDM |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:50 INFO importasdm::::casa Found SpectralWindow.xml in SDM |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:50 INFO importasdm::::casa Found 13 rows in Antenna.xml |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:50 INFO importasdm::::casa Found 30 rows in SpectralWindow.xml |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:50 INFO importasdm::::casa Will construct spw flags using table indices |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:50 INFO importasdm::::casa Will construct polarization flags using polarizationType |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:51 INFO importasdm::::casa Found numAntenna=1 must be a new style SDM |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:51 INFO importasdm::::casa Found 1542 flags in Flag.xml |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:51 INFO importasdm::::casa Will not apply flags to X54.ms (apply_flags=False), use flagcmd to apply |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:51 INFO importasdm::::casa There are 0 rows already in FLAG_CMD |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:51 INFO importasdm::::casa Saved 1542 rows to FLAG_CMD of X54.ms |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:51 INFO importasdm::::casa Task importasdm complete. Start time: 2024-10-23 05:40:56.795879 End time: 2024-10-23 05:41:50.822678 |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:51 INFO importasdm::::casa ##### End Task: importasdm ##### |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:51 INFO importasdm::::casa ########################################## |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:51 INFO importasdm::::casa ########################################## |
| 23-Oct-2024 01:41:50 | 2024-10-23 05:41:51 INFO importasdm::::casa ##### Begin Task: importasdm ##### |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:41:51 INFO importasdm::::casa importasdm( asdm='uid___A002_X2a5c2f_X220', vis='X220.ms', createmms=True, separationaxis='auto', numsubms='auto', corr_mode='all', srt='all', time_sampling='all', ocorr_mode='ca', compression=False, lazy=True, asis='Stati* Anten*', 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=False, outfile='', flagbackup=True, verbose=False, overwrite=True, bdfflags=False, with_pointing_correction=False, convert_ephem2geo=True, polyephem_tabtimestep=0.0 ) |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:42:17 INFO importasdm::::casa No ephemerides attached. |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:42:17 INFO importasdm::::casa Will create a Multi-MS for: X220.ms |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:42:17 INFO ParallelDataHelper::::casa Analyzing MS for partitioning |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:42:17 INFO ParallelDataHelper::::casa Automatically distribute the scan/spw pairs to balance the load along field, spw and scan axes |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:42:21 INFO msmetadata_cmpt.cc::open Performing internal consistency checks on /home/casatest/work/test_regression_alma_M100_if_mpi/X220.ms.temp.ms... |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:09 INFO ParallelDataHelper::::casa Finalizing MMS structure |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:09 INFO ms::createmultims Copying subtables from /home/casatest/work/test_regression_alma_M100_if_mpi/X220.ms.data/X220.ms.0000.ms to the other MMS members. |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:10 INFO importasdm::AgentFlagger::open Table type is Measurement Set |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:10 INFO importasdm::FlagVersion::saveFlagVersion Creating new backup flag file called Original |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:13 INFO importasdm::::casa Found Flag.xml in SDM |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:13 INFO importasdm::::casa Found Antenna.xml in SDM |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:13 INFO importasdm::::casa Found SpectralWindow.xml in SDM |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:13 INFO importasdm::::casa Found 13 rows in Antenna.xml |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:13 INFO importasdm::::casa Found 30 rows in SpectralWindow.xml |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:13 INFO importasdm::::casa Will construct spw flags using table indices |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:13 INFO importasdm::::casa Will construct polarization flags using polarizationType |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:13 INFO importasdm::::casa Found numAntenna=1 must be a new style SDM |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:13 INFO importasdm::::casa Found 1609 flags in Flag.xml |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:13 INFO importasdm::::casa Will not apply flags to X220.ms (apply_flags=False), use flagcmd to apply |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:13 INFO importasdm::::casa There are 0 rows already in FLAG_CMD |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:13 INFO importasdm::::casa Saved 1609 rows to FLAG_CMD of X220.ms |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:13 INFO importasdm::::casa Task importasdm complete. Start time: 2024-10-23 05:41:50.825467 End time: 2024-10-23 05:43:13.373165 |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:13 INFO importasdm::::casa ##### End Task: importasdm ##### |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:13 INFO importasdm::::casa ########################################## |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:13 INFO plotants::::casa ########################################## |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:13 INFO plotants::::casa ##### Begin Task: plotants ##### |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:13 INFO plotants::::casa plotants( vis='X54.ms', figfile='plotants-X54.png', antindex=False, logpos=False, exclude='', checkbaselines=False, title='', showgui=True ) |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:13 INFO msmetadata_cmpt.cc::open Performing internal consistency checks on X54.ms... |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:13 INFO plotants::::casa Number of points being plotted: 13 |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO plotants::::casa Task plotants complete. Start time: 2024-10-23 05:43:13.381823 End time: 2024-10-23 05:43:13.587637 |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO plotants::::casa ##### End Task: plotants ##### |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO plotants::::casa ########################################## |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO plotants::::casa ########################################## |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO plotants::::casa ##### Begin Task: plotants ##### |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO plotants::::casa plotants( vis='X220.ms', figfile='plotants-X220.png', antindex=False, logpos=False, exclude='', checkbaselines=False, title='', showgui=True ) |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO msmetadata_cmpt.cc::open Performing internal consistency checks on X220.ms... |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO plotants::::casa Number of points being plotted: 13 |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO plotants::::casa Task plotants complete. Start time: 2024-10-23 05:43:13.592247 End time: 2024-10-23 05:43:13.787196 |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO plotants::::casa ##### End Task: plotants ##### |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO plotants::::casa ########################################## |
| 23-Oct-2024 01:43:13 | |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 WARN TIMING::::casa Step 0: Data import |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 WARN TIMING::::casa Time now: 1729662193.7874682 |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 WARN TIMING::::casa Time used this step: 137.09276866912842 |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 WARN TIMING::::casa Total time used so far: 137.09276866912842 |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 WARN TIMING::::casa Step Time used (s) Fraction of total time (percent) [description] |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 WARN TIMING::::casa 0 137.09276866912842 100.0 [Data import] |
| 23-Oct-2024 01:43:13 | Step 1: Generate antenna position cal tables |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO gencal::::casa ########################################## |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO gencal::::casa ##### Begin Task: gencal ##### |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO gencal::::casa gencal( vis='X54.ms', caltable='cal-antpos_X54', caltype='antpos', infile='', endpoint='asdm', timeout=180, retry=3, retry_wait_time=5, ant_pos_time_limit=0, spw='', antenna='CM01,PM02,PM04,DV08,DV06,DV13,DV03,DV14', pol='', parameter=[-0.000379055076246, 0.000910912511392, -0.000226045671848, 7.8790821135e-05, 0.000363811850548, -0.000224065035582, -0.000315962965482, 0.000397399838991, -0.000581170175089, -6.35427422822e-05, 0.00129573699087, -0.000625061802566, -0.000167516991496, 0.000174060463905, -0.000417742878199, -0.00010875146836, 0.000319179147482, -0.000588130671531, 0.000142965465784, 0.000455257482827, 0.000168651808053, -0.00150847900659, 0.00357818510383, 0.000811365433037], uniform=True ) |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO calibrater::open Opening MS: X54.ms for calibration. |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO calibrater::specifycal Beginning specifycal----------------------- |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO Creating KAntPos Jones table from specified parameters. |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO Writing solutions to table: cal-antpos_X54 |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO gencal::::casa Task gencal complete. Start time: 2024-10-23 05:43:13.804578 End time: 2024-10-23 05:43:13.891389 |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO gencal::::casa ##### End Task: gencal ##### |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO gencal::::casa ########################################## |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO gencal::::casa ########################################## |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO gencal::::casa ##### Begin Task: gencal ##### |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO gencal::::casa gencal( vis='X220.ms', caltable='cal-antpos_X220', caltype='antpos', infile='', endpoint='asdm', timeout=180, retry=3, retry_wait_time=5, ant_pos_time_limit=0, spw='', antenna='CM01,PM02,PM04,DV08,DV06,DV13,DV03,DV14', pol='', parameter=[-0.000379055076246, 0.000910912511392, -0.000226045671848, 7.8790821135e-05, 0.000363811850548, -0.000224065035582, -0.000315962965482, 0.000397399838991, -0.000581170175089, -6.35427422822e-05, 0.00129573699087, -0.000625061802566, -0.000167516991496, 0.000174060463905, -0.000417742878199, -0.00010875146836, 0.000319179147482, -0.000588130671531, 0.000142965465784, 0.000455257482827, 0.000168651808053, -0.00150847900659, 0.00357818510383, 0.000811365433037], uniform=True ) |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO calibrater::open Opening MS: X220.ms for calibration. |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 23-Oct-2024 01:43:13 | 2024-10-23 05:43:14 INFO calibrater::specifycal Beginning specifycal----------------------- |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO Creating KAntPos Jones table from specified parameters. |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO Writing solutions to table: cal-antpos_X220 |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO gencal::::casa Task gencal complete. Start time: 2024-10-23 05:43:13.892699 End time: 2024-10-23 05:43:13.971979 |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO gencal::::casa ##### End Task: gencal ##### |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO gencal::::casa ########################################## |
| 23-Oct-2024 01:43:15 | |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 WARN TIMING::::casa Step 1: Generate antenna position cal tables |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 WARN TIMING::::casa Time now: 1729662193.9721794 |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 WARN TIMING::::casa Time used this step: 0.18471121788024902 |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 WARN TIMING::::casa Total time used so far: 137.27747988700867 |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 WARN TIMING::::casa Step Time used (s) Fraction of total time (percent) [description] |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 WARN TIMING::::casa 0 137.09276866912842 99.86544681761912 [Data import] |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 WARN TIMING::::casa 1 0.18471121788024902 0.13455318238088465 [Generate antenna position cal tables] |
| 23-Oct-2024 01:43:15 | Step 2: Generate tsys cal tables |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO gencal::::casa ########################################## |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO gencal::::casa ##### Begin Task: gencal ##### |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO gencal::::casa gencal( vis='X54.ms', caltable='cal-tsys_X54.fdm', caltype='tsys', infile='', endpoint='asdm', timeout=180, retry=3, retry_wait_time=5, ant_pos_time_limit=0, spw='', antenna='', pol='', parameter=[], uniform=True ) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO calibrater::open Opening MS: X54.ms for calibration. |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO calibrater::specifycal Beginning specifycal----------------------- |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO Creating B TSYS table from MS SYSCAL subtable. |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO Tsys spectra counts per spw for antenna Ids 0-12 (per pol): |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO Spw 9: [13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13] (=169 spectra; 128 chans per spectra, per pol) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO (Found and flagged 1 spurious negative (or zero) Tsys channels for ant id=8 in spw 9.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO Spw 11: [13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13] (=169 spectra; 128 chans per spectra, per pol) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=1 in spw 11.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=2 in spw 11.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO (Found and flagged 26 spurious negative (or zero) Tsys channels for ant id=3 in spw 11.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO (Found and flagged 26 spurious negative (or zero) Tsys channels for ant id=6 in spw 11.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=7 in spw 11.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO (Found and flagged 26 spurious negative (or zero) Tsys channels for ant id=9 in spw 11.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO (Found and flagged 36 spurious negative (or zero) Tsys channels for ant id=10 in spw 11.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=12 in spw 11.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO Spw 13: [13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13] (=169 spectra; 128 chans per spectra, per pol) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=0 in spw 13.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=1 in spw 13.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO (Found and flagged 27 spurious negative (or zero) Tsys channels for ant id=2 in spw 13.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO (Found and flagged 14 spurious negative (or zero) Tsys channels for ant id=4 in spw 13.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=5 in spw 13.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO (Found and flagged 39 spurious negative (or zero) Tsys channels for ant id=6 in spw 13.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO (Found and flagged 20 spurious negative (or zero) Tsys channels for ant id=7 in spw 13.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=8 in spw 13.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO (Found and flagged 42 spurious negative (or zero) Tsys channels for ant id=9 in spw 13.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO (Found and flagged 26 spurious negative (or zero) Tsys channels for ant id=10 in spw 13.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO (Found and flagged 20 spurious negative (or zero) Tsys channels for ant id=11 in spw 13.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=12 in spw 13.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO Spw 15: [13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13] (=169 spectra; 128 chans per spectra, per pol) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:14 INFO Writing solutions to table: cal-tsys_X54.fdm |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO gencal::::casa Task gencal complete. Start time: 2024-10-23 05:43:13.976833 End time: 2024-10-23 05:43:14.512008 |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO gencal::::casa ##### End Task: gencal ##### |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO gencal::::casa ########################################## |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO gencal::::casa ########################################## |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO gencal::::casa ##### Begin Task: gencal ##### |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO gencal::::casa gencal( vis='X220.ms', caltable='cal-tsys_X220.fdm', caltype='tsys', infile='', endpoint='asdm', timeout=180, retry=3, retry_wait_time=5, ant_pos_time_limit=0, spw='', antenna='', pol='', parameter=[], uniform=True ) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO calibrater::open Opening MS: X220.ms for calibration. |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO calibrater::specifycal Beginning specifycal----------------------- |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO Creating B TSYS table from MS SYSCAL subtable. |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO Tsys spectra counts per spw for antenna Ids 0-12 (per pol): |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO Spw 9: [13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13] (=169 spectra; 128 chans per spectra, per pol) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO Spw 11: [13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13] (=169 spectra; 128 chans per spectra, per pol) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=1 in spw 11.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=2 in spw 11.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO (Found and flagged 26 spurious negative (or zero) Tsys channels for ant id=3 in spw 11.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO (Found and flagged 26 spurious negative (or zero) Tsys channels for ant id=6 in spw 11.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=7 in spw 11.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO (Found and flagged 26 spurious negative (or zero) Tsys channels for ant id=9 in spw 11.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO (Found and flagged 31 spurious negative (or zero) Tsys channels for ant id=10 in spw 11.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=12 in spw 11.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO Spw 13: [13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13] (=169 spectra; 128 chans per spectra, per pol) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=0 in spw 13.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=1 in spw 13.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO (Found and flagged 26 spurious negative (or zero) Tsys channels for ant id=2 in spw 13.) |
| 23-Oct-2024 01:43:15 | 2024-10-23 05:43:15 INFO (Found and flagged 7 spurious negative (or zero) Tsys channels for ant id=4 in spw 13.) |
| 23-Oct-2024 05:41:21 | 2024-10-23 05:43:15 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=5 in spw 13.) |
| 23-Oct-2024 05:41:21 | 2024-10-23 05:43:15 INFO (Found and flagged 39 spurious negative (or zero) Tsys channels for ant id=6 in spw 13.) |
| 23-Oct-2024 05:41:21 | 2024-10-23 05:43:15 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=7 in spw 13.) |
| 23-Oct-2024 05:41:21 | 2024-10-23 05:43:15 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=8 in spw 13.) |
| 23-Oct-2024 05:41:21 | 2024-10-23 05:43:15 INFO (Found and flagged 34 spurious negative (or zero) Tsys channels for ant id=9 in spw 13.) |
| 23-Oct-2024 05:41:21 | 2024-10-23 05:43:15 INFO (Found and flagged 26 spurious negative (or zero) Tsys channels for ant id=10 in spw 13.) |
| 23-Oct-2024 05:41:21 | 2024-10-23 05:43:15 INFO (Found and flagged 16 spurious negative (or zero) Tsys channels for ant id=11 in spw 13.) |
| 23-Oct-2024 05:41:21 | 2024-10-23 05:43:15 INFO (Found and flagged 10 spurious negative (or zero) Tsys channels for ant id=12 in spw 13.) |
| 23-Oct-2024 05:41:21 | 2024-10-23 05:43:15 INFO Spw 15: [13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13] (=169 spectra; 128 chans per spectra, per pol) |
| 23-Oct-2024 05:41:21 | 2024-10-23 05:43:15 INFO Writing solutions to table: cal-tsys_X220.fdm |
| 23-Oct-2024 05:41:21 | 2024-10-23 05:43:15 INFO gencal::::casa Task gencal complete. Start time: 2024-10-23 05:43:14.523937 End time: 2024-10-23 05:43:15.337132 |
| 23-Oct-2024 05:41:21 | 2024-10-23 05:43:15 INFO gencal::::casa ##### End Task: gencal ##### |
| 23-Oct-2024 05:41:21 | 2024-10-23 05:43:15 INFO gencal::::casa ########################################## |
| 23-Oct-2024 05:41:21 | 2024-10-23 05:43:15 INFO plotms::::casa ########################################## |
| 23-Oct-2024 05:41:21 | 2024-10-23 05:43:15 INFO plotms::::casa ##### Begin Task: plotms ##### |
| 23-Oct-2024 05:41:21 | 2024-10-23 05:43:15 INFO plotms::::casa plotms( vis='cal-tsys_X54.fdm', caltable='', gridrows=7, gridcols=2, rowindex=0, colindex=0, plotindex=0, xaxis='freq', xdatacolumn='', xframe='', xinterp='', yaxis='amp', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='9', timerange='', uvrange='', antenna='', scan='', correlation='', polarization='', antpos='', array='', observation='', intent='', feed='', msselect='', averagedata=True, avgchannel='', avgtime='', avgscan=False, avgfield=False, avgbaseline=False, avgantenna=False, avgspw=False, scalar=False, transform=True, freqframe='', restfreq='', veldef='RADIO', phasecenter='', extendflag=False, extcorr=False, extchannel=False, iteraxis='antenna', xselfscale=False, yselfscale=False, xsharedaxis=False, ysharedaxis=False, customsymbol=True, symbolshape='autoscaling', symbolsize=2, symbolcolor='0000ff', symbolfill='fill', symboloutline=False, coloraxis='', customflaggedsymbol=False, flaggedsymbolshape='circle', flaggedsymbolsize=2, flaggedsymbolcolor='ff0000', flaggedsymbolfill='fill', flaggedsymboloutline=False, xconnector='', timeconnector=False, plotrange=[0.0, 0.0, 40.0, 180.0], title='', titlefont=0, xlabel='', xaxisfont=0, ylabel='', yaxisfont=0, showmajorgrid=False, majorwidth=1, majorstyle='', majorcolor='B0B0B0', showminorgrid=False, minorwidth=1, minorstyle='', minorcolor='D0D0D0', showlegend=False, legendposition='', plotfile='cal-tsys_per_spw_9_X54.png', expformat='', verbose=True, exprange='', highres=False, dpi=-1, width=-1, height=-1, overwrite=True, showgui=False, clearplots=True, callib=[], headeritems='', showatm=False, showtsky=False, showimage=False, colorizeoverlay=False ) |
| 23-Oct-2024 05:41:21 | dlopen(): error loading libfuse.so.2 |
| 23-Oct-2024 05:41:21 | |
| 23-Oct-2024 05:41:21 | AppImages require FUSE to run. |
| 23-Oct-2024 05:41:21 | You might still be able to extract the contents of this AppImage |
| 23-Oct-2024 05:41:21 | if you run it with the --appimage-extract option. |
| 23-Oct-2024 05:41:21 | See https://github.com/AppImage/AppImageKit/wiki/FUSE |
| 23-Oct-2024 05:41:21 | for more information |
| 23-Oct-2024 05:41:21 | |
| 23-Oct-2024 05:41:21 | Failed tests:['Caught exception during test execution.'] |
| 23-Oct-2024 05:41:21 | |
| 23-Oct-2024 05:41:21 | Running test: test_regression_alma_M100_if in Serial mode |
| 23-Oct-2024 05:41:21 | Running cmd ['/home/casatest/work/pkg/casa-6.7.0-11-py3.10.el8/bin/casa', '--nogui', '--nologger', '--log2term', '-c', '/home/casatest/work/casasources//casa6/casatests/regression/test_regression_alma_M100_if.py']in /home/casatest/work/test_regression_alma_M100_if |
| 23-Oct-2024 05:41:21 | Executing: ['/home/casatest/work/pkg/casa-6.7.0-11-py3.10.el8/bin/casa', '--nogui', '--nologger', '--log2term', '-c', '/home/casatest/work/casasources//casa6/casatests/regression/test_regression_alma_M100_if.py'] |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa Using user configuration file /home/casatest/.casa/config.py |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa loaded config file : /home/casatest/work/pkg/casa-6.7.0-11-py3.10.el8/lib/py/lib/python3.10/site-packages/casaconfig/config.py |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa loaded config file : /home/casatest/.casa/config.py |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa config values |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa agg = False |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa cachedir = '/home/casatest/.casa' |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa casaconfig_verbose = 1 |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa colors = 'Neutral' |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa data_auto_update = False |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa datapath = ['/opt/casa/data/casa-data', '/opt/casa/data/master', '/opt/casa/data/casatestdata'] |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa iplog = False |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa iplogfile = '/home/casatest/work/test_regression_alma_M100_if/ipython-20241023-094053.log' |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa log2term = True |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa logfile = '/home/casatest/work/test_regression_alma_M100_if/casa-20241023-094053.log' |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa measures_auto_update = False |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa measurespath = '/opt/casa/data/casa-data' |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa nogui = True |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa nologfile = False |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa nologger = True |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa pipeline = False |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa startupfile = '/home/casatest/.casa/startup.py' |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa user_site = False |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa casarundata version is unknown, this is probably a legacy version not installed by casaconfig |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa measures version is unknown, this is probably a legacy version not installed by casaconfig |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa Checking Measures tables in data repository sub-directory /opt/casa/data/casa-data/geodetic |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa IERSeop2000 (version date, last date in table (UTC)): 2024/07/27/15:00, 2024/06/27/00:00:00 |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa IERSeop97 (version date, last date in table (UTC)): 2024/07/27/15:00, 2024/06/27/00:00:00 |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa IERSpredict (version date, last date in table (UTC)): 2024/08/25/15:00, 2024/11/23/00:00:00 |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO ::casa TAI_UTC (version date, last date in table (UTC)): 2024/07/27/15:00, 2017/01/01/00:00:00 |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO importasdm::::casa ########################################## |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO importasdm::::casa ##### Begin Task: importasdm ##### |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:40:57 INFO importasdm::::casa importasdm( asdm='uid___A002_X2a5c2f_X54', vis='X54.ms', createmms=False, separationaxis='auto', numsubms='auto', corr_mode='all', srt='all', time_sampling='all', ocorr_mode='ca', compression=False, lazy=True, asis='Stati* Anten*', 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=False, outfile='', flagbackup=True, verbose=False, overwrite=True, bdfflags=False, with_pointing_correction=False, convert_ephem2geo=True, polyephem_tabtimestep=0.0 ) |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:41:18 INFO importasdm::::casa No ephemerides attached. |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:41:18 INFO AgentFlagger::open Table type is Measurement Set |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:41:18 INFO FlagVersion::saveFlagVersion Creating new backup flag file called Original |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:41:22 INFO importasdm::::casa Found Flag.xml in SDM |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:41:22 INFO importasdm::::casa Found Antenna.xml in SDM |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:41:22 INFO importasdm::::casa Found SpectralWindow.xml in SDM |
| 23-Oct-2024 05:41:21 | 2024-10-23 09:41:22 INFO importasdm::::casa Found 13 rows in Antenna.xml |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:22 INFO importasdm::::casa Found 30 rows in SpectralWindow.xml |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:22 INFO importasdm::::casa Will construct spw flags using table indices |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:22 INFO importasdm::::casa Will construct polarization flags using polarizationType |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:22 INFO importasdm::::casa Found numAntenna=1 must be a new style SDM |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:22 INFO importasdm::::casa Found 1542 flags in Flag.xml |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:22 INFO importasdm::::casa Will not apply flags to X54.ms (apply_flags=False), use flagcmd to apply |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:22 INFO importasdm::::casa There are 0 rows already in FLAG_CMD |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:22 INFO importasdm::::casa Saved 1542 rows to FLAG_CMD of X54.ms |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:22 INFO importasdm::::casa Task importasdm complete. Start time: 2024-10-23 09:40:56.830322 End time: 2024-10-23 09:41:22.074773 |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:22 INFO importasdm::::casa ##### End Task: importasdm ##### |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:22 INFO importasdm::::casa ########################################## |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:22 INFO importasdm::::casa ########################################## |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:22 INFO importasdm::::casa ##### Begin Task: importasdm ##### |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:22 INFO importasdm::::casa importasdm( asdm='uid___A002_X2a5c2f_X220', vis='X220.ms', createmms=False, separationaxis='auto', numsubms='auto', corr_mode='all', srt='all', time_sampling='all', ocorr_mode='ca', compression=False, lazy=True, asis='Stati* Anten*', 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=False, outfile='', flagbackup=True, verbose=False, overwrite=True, bdfflags=False, with_pointing_correction=False, convert_ephem2geo=True, polyephem_tabtimestep=0.0 ) |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:43 INFO importasdm::::casa No ephemerides attached. |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:43 INFO AgentFlagger::open Table type is Measurement Set |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:43 INFO FlagVersion::saveFlagVersion Creating new backup flag file called Original |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:47 INFO importasdm::::casa Found Flag.xml in SDM |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:47 INFO importasdm::::casa Found Antenna.xml in SDM |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:47 INFO importasdm::::casa Found SpectralWindow.xml in SDM |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:47 INFO importasdm::::casa Found 13 rows in Antenna.xml |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:47 INFO importasdm::::casa Found 30 rows in SpectralWindow.xml |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:47 INFO importasdm::::casa Will construct spw flags using table indices |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:47 INFO importasdm::::casa Will construct polarization flags using polarizationType |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:48 INFO importasdm::::casa Found numAntenna=1 must be a new style SDM |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:48 INFO importasdm::::casa Found 1609 flags in Flag.xml |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:48 INFO importasdm::::casa Will not apply flags to X220.ms (apply_flags=False), use flagcmd to apply |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:48 INFO importasdm::::casa There are 0 rows already in FLAG_CMD |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:48 INFO importasdm::::casa Saved 1609 rows to FLAG_CMD of X220.ms |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:48 INFO importasdm::::casa Task importasdm complete. Start time: 2024-10-23 09:41:22.077449 End time: 2024-10-23 09:41:48.427123 |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:48 INFO importasdm::::casa ##### End Task: importasdm ##### |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:48 INFO importasdm::::casa ########################################## |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:48 INFO plotants::::casa ########################################## |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:48 INFO plotants::::casa ##### Begin Task: plotants ##### |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:48 INFO plotants::::casa plotants( vis='X54.ms', figfile='plotants-X54.png', antindex=False, logpos=False, exclude='', checkbaselines=False, title='', showgui=True ) |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO msmetadata_cmpt.cc::open Performing internal consistency checks on X54.ms... |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO plotants::::casa Number of points being plotted: 13 |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO plotants::::casa Task plotants complete. Start time: 2024-10-23 09:41:48.435869 End time: 2024-10-23 09:41:48.761938 |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO plotants::::casa ##### End Task: plotants ##### |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO plotants::::casa ########################################## |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO plotants::::casa ########################################## |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO plotants::::casa ##### Begin Task: plotants ##### |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO plotants::::casa plotants( vis='X220.ms', figfile='plotants-X220.png', antindex=False, logpos=False, exclude='', checkbaselines=False, title='', showgui=True ) |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO msmetadata_cmpt.cc::open Performing internal consistency checks on X220.ms... |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO plotants::::casa Number of points being plotted: 13 |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO plotants::::casa Task plotants complete. Start time: 2024-10-23 09:41:48.766407 End time: 2024-10-23 09:41:48.987064 |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO plotants::::casa ##### End Task: plotants ##### |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO plotants::::casa ########################################## |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 WARN TIMING::::casa Step 0: Data import |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 WARN TIMING::::casa Time now: 1729676508.9872904 |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 WARN TIMING::::casa Time used this step: 52.257646322250366 |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 WARN TIMING::::casa Total time used so far: 52.257646322250366 |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 WARN TIMING::::casa Step Time used (s) Fraction of total time (percent) [description] |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 WARN TIMING::::casa 0 52.257646322250366 100.0 [Data import] |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO gencal::::casa ########################################## |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO gencal::::casa ##### Begin Task: gencal ##### |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO gencal::::casa gencal( vis='X54.ms', caltable='cal-antpos_X54', caltype='antpos', infile='', endpoint='asdm', timeout=180, retry=3, retry_wait_time=5, ant_pos_time_limit=0, spw='', antenna='CM01,PM02,PM04,DV08,DV06,DV13,DV03,DV14', pol='', parameter=[-0.000379055076246, 0.000910912511392, -0.000226045671848, 7.8790821135e-05, 0.000363811850548, -0.000224065035582, -0.000315962965482, 0.000397399838991, -0.000581170175089, -6.35427422822e-05, 0.00129573699087, -0.000625061802566, -0.000167516991496, 0.000174060463905, -0.000417742878199, -0.00010875146836, 0.000319179147482, -0.000588130671531, 0.000142965465784, 0.000455257482827, 0.000168651808053, -0.00150847900659, 0.00357818510383, 0.000811365433037], uniform=True ) |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO calibrater::open Opening MS: X54.ms for calibration. |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO calibrater::specifycal Beginning specifycal----------------------- |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO Creating KAntPos Jones table from specified parameters. |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO Writing solutions to table: cal-antpos_X54 |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO gencal::::casa Task gencal complete. Start time: 2024-10-23 09:41:49.004084 End time: 2024-10-23 09:41:49.102876 |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO gencal::::casa ##### End Task: gencal ##### |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO gencal::::casa ########################################## |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO gencal::::casa ########################################## |
| 23-Oct-2024 05:41:49 | 2024-10-23 09:41:49 INFO gencal::::casa ##### Begin Task: gencal ##### |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 INFO gencal::::casa gencal( vis='X220.ms', caltable='cal-antpos_X220', caltype='antpos', infile='', endpoint='asdm', timeout=180, retry=3, retry_wait_time=5, ant_pos_time_limit=0, spw='', antenna='CM01,PM02,PM04,DV08,DV06,DV13,DV03,DV14', pol='', parameter=[-0.000379055076246, 0.000910912511392, -0.000226045671848, 7.8790821135e-05, 0.000363811850548, -0.000224065035582, -0.000315962965482, 0.000397399838991, -0.000581170175089, -6.35427422822e-05, 0.00129573699087, -0.000625061802566, -0.000167516991496, 0.000174060463905, -0.000417742878199, -0.00010875146836, 0.000319179147482, -0.000588130671531, 0.000142965465784, 0.000455257482827, 0.000168651808053, -0.00150847900659, 0.00357818510383, 0.000811365433037], uniform=True ) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 INFO calibrater::open Opening MS: X220.ms for calibration. |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 INFO calibrater::specifycal Beginning specifycal----------------------- |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 INFO Creating KAntPos Jones table from specified parameters. |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 INFO Writing solutions to table: cal-antpos_X220 |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 INFO gencal::::casa Task gencal complete. Start time: 2024-10-23 09:41:49.104032 End time: 2024-10-23 09:41:49.194755 |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 INFO gencal::::casa ##### End Task: gencal ##### |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 INFO gencal::::casa ########################################## |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 WARN TIMING::::casa Step 1: Generate antenna position cal tables |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 WARN TIMING::::casa Time now: 1729676509.1949558 |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 WARN TIMING::::casa Time used this step: 0.20766544342041016 |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 WARN TIMING::::casa Total time used so far: 52.465311765670776 |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 WARN TIMING::::casa Step Time used (s) Fraction of total time (percent) [description] |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 WARN TIMING::::casa 0 52.257646322250366 99.60418524844012 [Data import] |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 WARN TIMING::::casa 1 0.20766544342041016 0.3958147515598874 [Generate antenna position cal tables] |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 INFO gencal::::casa ########################################## |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 INFO gencal::::casa ##### Begin Task: gencal ##### |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 INFO gencal::::casa gencal( vis='X54.ms', caltable='cal-tsys_X54.fdm', caltype='tsys', infile='', endpoint='asdm', timeout=180, retry=3, retry_wait_time=5, ant_pos_time_limit=0, spw='', antenna='', pol='', parameter=[], uniform=True ) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 INFO calibrater::open Opening MS: X54.ms for calibration. |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 INFO calibrater::specifycal Beginning specifycal----------------------- |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:49 INFO Creating B TSYS table from MS SYSCAL subtable. |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO Tsys spectra counts per spw for antenna Ids 0-12 (per pol): |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO Spw 9: [13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13] (=169 spectra; 128 chans per spectra, per pol) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO (Found and flagged 1 spurious negative (or zero) Tsys channels for ant id=8 in spw 9.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO Spw 11: [13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13] (=169 spectra; 128 chans per spectra, per pol) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=1 in spw 11.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=2 in spw 11.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO (Found and flagged 26 spurious negative (or zero) Tsys channels for ant id=3 in spw 11.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO (Found and flagged 26 spurious negative (or zero) Tsys channels for ant id=6 in spw 11.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=7 in spw 11.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO (Found and flagged 26 spurious negative (or zero) Tsys channels for ant id=9 in spw 11.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO (Found and flagged 36 spurious negative (or zero) Tsys channels for ant id=10 in spw 11.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=12 in spw 11.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO Spw 13: [13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13] (=169 spectra; 128 chans per spectra, per pol) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=0 in spw 13.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=1 in spw 13.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO (Found and flagged 27 spurious negative (or zero) Tsys channels for ant id=2 in spw 13.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO (Found and flagged 14 spurious negative (or zero) Tsys channels for ant id=4 in spw 13.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=5 in spw 13.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO (Found and flagged 39 spurious negative (or zero) Tsys channels for ant id=6 in spw 13.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO (Found and flagged 20 spurious negative (or zero) Tsys channels for ant id=7 in spw 13.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=8 in spw 13.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO (Found and flagged 42 spurious negative (or zero) Tsys channels for ant id=9 in spw 13.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO (Found and flagged 26 spurious negative (or zero) Tsys channels for ant id=10 in spw 13.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO (Found and flagged 20 spurious negative (or zero) Tsys channels for ant id=11 in spw 13.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=12 in spw 13.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO Spw 15: [13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13] (=169 spectra; 128 chans per spectra, per pol) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO Writing solutions to table: cal-tsys_X54.fdm |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO gencal::::casa Task gencal complete. Start time: 2024-10-23 09:41:49.199625 End time: 2024-10-23 09:41:50.114599 |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO gencal::::casa ##### End Task: gencal ##### |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO gencal::::casa ########################################## |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO gencal::::casa ########################################## |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO gencal::::casa ##### Begin Task: gencal ##### |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO gencal::::casa gencal( vis='X220.ms', caltable='cal-tsys_X220.fdm', caltype='tsys', infile='', endpoint='asdm', timeout=180, retry=3, retry_wait_time=5, ant_pos_time_limit=0, spw='', antenna='', pol='', parameter=[], uniform=True ) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO calibrater::open ****Using NEW VI2-driven calibrater tool**** |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO calibrater::open Opening MS: X220.ms for calibration. |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO Calibrater:: Initializing nominal selection to the whole MS. |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO calibrater::specifycal Beginning specifycal----------------------- |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:50 INFO Creating B TSYS table from MS SYSCAL subtable. |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:51 INFO Tsys spectra counts per spw for antenna Ids 0-12 (per pol): |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:51 INFO Spw 9: [13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13] (=169 spectra; 128 chans per spectra, per pol) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:51 INFO Spw 11: [13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13] (=169 spectra; 128 chans per spectra, per pol) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:51 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=1 in spw 11.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:51 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=2 in spw 11.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:51 INFO (Found and flagged 26 spurious negative (or zero) Tsys channels for ant id=3 in spw 11.) |
| 23-Oct-2024 05:41:50 | 2024-10-23 09:41:51 INFO (Found and flagged 26 spurious negative (or zero) Tsys channels for ant id=6 in spw 11.) |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=7 in spw 11.) |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO (Found and flagged 26 spurious negative (or zero) Tsys channels for ant id=9 in spw 11.) |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO (Found and flagged 31 spurious negative (or zero) Tsys channels for ant id=10 in spw 11.) |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=12 in spw 11.) |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO Spw 13: [13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13] (=169 spectra; 128 chans per spectra, per pol) |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=0 in spw 13.) |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=1 in spw 13.) |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO (Found and flagged 26 spurious negative (or zero) Tsys channels for ant id=2 in spw 13.) |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO (Found and flagged 7 spurious negative (or zero) Tsys channels for ant id=4 in spw 13.) |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=5 in spw 13.) |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO (Found and flagged 39 spurious negative (or zero) Tsys channels for ant id=6 in spw 13.) |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=7 in spw 13.) |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO (Found and flagged 13 spurious negative (or zero) Tsys channels for ant id=8 in spw 13.) |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO (Found and flagged 34 spurious negative (or zero) Tsys channels for ant id=9 in spw 13.) |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO (Found and flagged 26 spurious negative (or zero) Tsys channels for ant id=10 in spw 13.) |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO (Found and flagged 16 spurious negative (or zero) Tsys channels for ant id=11 in spw 13.) |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO (Found and flagged 10 spurious negative (or zero) Tsys channels for ant id=12 in spw 13.) |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO Spw 15: [13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13, 13] (=169 spectra; 128 chans per spectra, per pol) |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO Writing solutions to table: cal-tsys_X220.fdm |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO gencal::::casa Task gencal complete. Start time: 2024-10-23 09:41:50.125958 End time: 2024-10-23 09:41:50.990034 |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO gencal::::casa ##### End Task: gencal ##### |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO gencal::::casa ########################################## |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO plotms::::casa ########################################## |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO plotms::::casa ##### Begin Task: plotms ##### |
| 23-Oct-2024 09:40:53 | 2024-10-23 09:41:51 INFO plotms::::casa plotms( vis='cal-tsys_X54.fdm', caltable='', gridrows=7, gridcols=2, rowindex=0, colindex=0, plotindex=0, xaxis='freq', xdatacolumn='', xframe='', xinterp='', yaxis='amp', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='9', timerange='', uvrange='', antenna='', scan='', correlation='', polarization='', antpos='', array='', observation='', intent='', feed='', msselect='', averagedata=True, avgchannel='', avgtime='', avgscan=False, avgfield=False, avgbaseline=False, avgantenna=False, avgspw=False, scalar=False, transform=True, freqframe='', restfreq='', veldef='RADIO', phasecenter='', extendflag=False, extcorr=False, extchannel=False, iteraxis='antenna', xselfscale=False, yselfscale=False, xsharedaxis=False, ysharedaxis=False, customsymbol=True, symbolshape='autoscaling', symbolsize=2, symbolcolor='0000ff', symbolfill='fill', symboloutline=False, coloraxis='', customflaggedsymbol=False, flaggedsymbolshape='circle', flaggedsymbolsize=2, flaggedsymbolcolor='ff0000', flaggedsymbolfill='fill', flaggedsymboloutline=False, xconnector='', timeconnector=False, plotrange=[0.0, 0.0, 40.0, 180.0], title='', titlefont=0, xlabel='', xaxisfont=0, ylabel='', yaxisfont=0, showmajorgrid=False, majorwidth=1, majorstyle='', majorcolor='B0B0B0', showminorgrid=False, minorwidth=1, minorstyle='', minorcolor='D0D0D0', showlegend=False, legendposition='', plotfile='cal-tsys_per_spw_9_X54.png', expformat='', verbose=True, exprange='', highres=False, dpi=-1, width=-1, height=-1, overwrite=True, showgui=False, clearplots=True, callib=[], headeritems='', showatm=False, showtsky=False, showimage=False, colorizeoverlay=False ) |
| 23-Oct-2024 09:40:53 | dlopen(): error loading libfuse.so.2 |
| 23-Oct-2024 09:40:53 | |
| 23-Oct-2024 09:40:53 | AppImages require FUSE to run. |
| 23-Oct-2024 09:40:53 | You might still be able to extract the contents of this AppImage |
| 23-Oct-2024 09:40:53 | if you run it with the --appimage-extract option. |
| 23-Oct-2024 09:40:53 | See https://github.com/AppImage/AppImageKit/wiki/FUSE |
| 23-Oct-2024 09:40:53 | for more information |
| 23-Oct-2024 09:40:53 | |
| 23-Oct-2024 09:40:53 | Failed tests:['Caught exception during test execution.', 'Caught exception during test execution.'] |
| 23-Oct-2024 09:40:53 | |
| 23-Oct-2024 09:40:53 | Results: [{'testname': 'test_regression_alma_sim_componentlist', 'runtime': '0:09:24.869368', 'returncode': 0, 'testerr': []}, {'testname': 'test_regression_sim_cube', 'runtime': '0:00:40.799471', 'returncode': 0, 'testerr': []}, {'testname': 'test_regression_alma_M100_sd', 'runtime': '0:30:00.101205', 'returncode': 1, 'testerr': ['Caught exception during test execution.']}, {'testname': 'test_regression_sim_components', 'runtime': '0:01:43.024295', 'returncode': 0, 'testerr': []}, {'testname': 'test_regression_sim_components_and_skymodel', 'runtime': '0:00:26.353789', 'returncode': 0, 'testerr': []}, {'testname': 'test_regression_simalma_12m_ACA_combination', 'runtime': '0:01:44.730193', 'returncode': 0, 'testerr': []}, {'testname': 'test_regression_sim_multi_arrays_and_TP', 'runtime': '0:02:01.473371', 'returncode': 0, 'testerr': []}, {'testname': 'test_regression_tclean_startmodel_restart', 'runtime': '0:09:07.563831', 'returncode': 0, 'testerr': []}, {'testname': 'test_regression_tclean_startmodel_restart', 'runtime': '0:00:04.171339', 'returncode': 0, 'testerr': []}, {'testname': 'test_regression_sim_TP', 'runtime': '0:01:03.251301', 'returncode': 0, 'testerr': []}, {'testname': 'test_regression_fits_import_export', 'runtime': '0:00:12.901948', 'returncode': 0, 'testerr': []}, {'testname': 'test_regression_timeaverage_and_rflag', 'runtime': '0:01:45.913504', 'returncode': 0, 'testerr': []}, {'testname': 'test_regression_alma_M100_if', 'runtime': '4:00:00.020242', 'returncode': 1, 'testerr': ['Caught exception during test execution.', 'Caught exception during test execution.']}, {'testname': 'test_regression_alma_M100_if', 'runtime': '4:00:00.101123', 'returncode': 2, 'testerr': ['Caught exception during test execution.', 'Caught exception during test execution.']}] |
| 23-Oct-2024 09:40:53 | Stopping Xvfb. |
| 23-Oct-2024 09:40:53 | Stopping framebuffer <Popen: returncode: None args: ['Xvfb', ':146', '-screen', '0', '2048x2048x2...> |
| 23-Oct-2024 09:40:53 | Virtual frame buffer deployed at :146 with pid 157 successfully shutdown |
| 23-Oct-2024 09:40:53 | Xvfb stopped. |
| 23-Oct-2024 09:40:56 | find: './proc/157/task/157/net': Invalid argument |
| 23-Oct-2024 09:40:56 | find: './proc/157/net': Invalid argument |
| 23-Oct-2024 09:40:56 | find: './proc/1219/task/1219/net': Invalid argument |
| 23-Oct-2024 09:40:56 | find: './proc/1219/net': Invalid argument |
| 23-Oct-2024 09:40:56 | find: './proc/6911/task/6911/net': Invalid argument |
| 23-Oct-2024 09:40:56 | find: './proc/6911/net': Invalid argument |
| 23-Oct-2024 09:40:56 | find: './proc/6912/task/6912/net': Invalid argument |
| 23-Oct-2024 09:40:56 | find: './proc/6912/net': Invalid argument |
| 23-Oct-2024 09:40:56 | find: './proc/6913/task/6913/net': Invalid argument |
| 23-Oct-2024 09:40:56 | find: './proc/6913/net': Invalid argument |
| 23-Oct-2024 09:40:56 | find: './proc/9042/task/9042/net': Invalid argument |
| 23-Oct-2024 09:40:56 | find: './proc/9042/net': Invalid argument |
| 23-Oct-2024 09:40:56 | find: './proc/9214/task/9214/net': Invalid argument |
| 23-Oct-2024 09:40:56 | find: './proc/9214/net': Invalid argument |
| 23-Oct-2024 09:40:57 | total 990524 |
| 23-Oct-2024 09:40:57 | -rw-r--r-- 1 casaci 15001 1014291232 Oct 23 04:41 casa-6.7.0-11-py3.10.el8.tar.xz |
| 23-Oct-2024 09:40:57 | drwxr-xr-x 2 casaci casatest 182 Oct 23 04:52 png_list |
| 23-Oct-2024 09:40:57 | -rw-r--r-- 1 casaci casatest 2524 Oct 23 13:40 xUnit-suite-mpi-4.xml |
| 23-Oct-2024 09:40:57 | Finished task 'Run casatests/regression scripts using a casalith' with result: Success |
| 23-Oct-2024 09:40:57 | Starting task 'Parse test results' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit' |
| 23-Oct-2024 09:40:57 | Parsing test results under /export/data_1/bamboohome/xml-data/build-dir/CASASPECS-MASTERTESTCASALITHPY310-CRR89D... |
| 23-Oct-2024 09:40:57 | Failing task since 2 failing test cases were found. |
| 23-Oct-2024 09:40:57 | Finished task 'Parse test results' with result: Failed |
| 23-Oct-2024 09:40:57 | Running post build plugin 'Docker Container Cleanup' |
| 23-Oct-2024 09:40:57 | Running post build plugin 'NCover Results Collector' |
| 23-Oct-2024 09:40:57 | Running post build plugin 'Build Results Label Collector' |
| 23-Oct-2024 09:40:57 | Running post build plugin 'Clover Results Collector' |
| 23-Oct-2024 09:40:57 | Running post build plugin 'npm Cache Cleanup' |
| 23-Oct-2024 09:40:57 | Running post build plugin 'Artifact Copier' |
| 23-Oct-2024 09:40:57 | Publishing an artifact: Regression images |
| 23-Oct-2024 09:40:57 | Finished publishing of artifact Non required job artifact Http Compression On : [Regression images], patterns: [png_list/*.png] anchored at: [dockershare] in 93.37 ms |
| 23-Oct-2024 09:40:57 | Finalising the build... |
| 23-Oct-2024 09:40:57 | Stopping timer. |
| 23-Oct-2024 09:40:57 | Build CASASPECS-MASTERTESTCASALITHPY310-CRR89D-4 completed. |
| 23-Oct-2024 09:40:57 | Running on server: post build plugin 'Build Hanging Detection Configuration' |
| 23-Oct-2024 09:40:57 | Running on server: post build plugin 'NCover Results Collector' |
| 23-Oct-2024 09:40:57 | Running on server: post build plugin 'Build Labeller' |
| 23-Oct-2024 09:40:57 | Running on server: post build plugin 'Clover Delta Calculator' |
| 23-Oct-2024 09:40:57 | Running on server: post build plugin 'Maven Dependencies Postprocessor' |
| 23-Oct-2024 09:40:57 | All post build plugins have finished |
| 23-Oct-2024 09:40:57 | Generating build results summary... |
| 23-Oct-2024 09:40:57 | Saving build results to disk... |
| 23-Oct-2024 09:40:57 | Store variable context... |
| 23-Oct-2024 09:40:57 | Finished building CASASPECS-MASTERTESTCASALITHPY310-CRR89D-4. |