Build: #294 failed

Job: Test Regressions Many Linux 2.28 Rocky 8.10 Docker failed

Build log

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

18-Sep-2026 05:57:02 2026-09-18 05:56:35        INFO        ParallelDataHelper::::casa        Analyzing MS for partitioning
18-Sep-2026 05:57:02 2026-09-18 05:56:35        INFO        ParallelDataHelper::::casa        Input vis is a Multi-MS
18-Sep-2026 05:57:02 2026-09-18 05:56:48        INFO        ParallelDataHelper::::casa        Finalizing MMS structure
18-Sep-2026 05:57:02 2026-09-18 05:56:48        INFO        ms::createmultims        Copying subtables from /home/casatest/work/test_regression_alma_M100_if_mpi/X54-line-vs.ms.data/X54-line-vs.ms.0000.ms to the other MMS members.
18-Sep-2026 05:57:02 2026-09-18 05:56:48        INFO        split::::casa        Task split complete. Start time: 2026-09-18 05:56:34.937785 End time: 2026-09-18 05:56:48.148988
18-Sep-2026 05:57:02 2026-09-18 05:56:48        INFO        split::::casa        ##### End Task: split                #####
18-Sep-2026 05:57:02 2026-09-18 05:56:48        INFO        split::::casa        ##########################################
18-Sep-2026 05:57:02 2026-09-18 05:56:48        INFO        flagmanager::::casa        ##########################################
18-Sep-2026 05:57:02 2026-09-18 05:56:48        INFO        flagmanager::::casa        ##### Begin Task: flagmanager        #####
18-Sep-2026 05:57:02 2026-09-18 05:56:48        INFO        flagmanager::::casa        flagmanager( vis='X54-line-vs.ms', mode='save', versionname='apriori', oldname='', comment='', merge='replace' )
18-Sep-2026 05:57:02 2026-09-18 05:56:48        INFO        flagmanager::AgentFlagger::open        Table type is Measurement Set
18-Sep-2026 05:57:02 2026-09-18 05:56:48        INFO        flagmanager::::casa        Save current flagversions to apriori
18-Sep-2026 05:57:02 2026-09-18 05:56:48        INFO        FlagVersion::saveFlagVersion        Creating new backup flag file called apriori
18-Sep-2026 05:57:02 2026-09-18 05:56:49        INFO        flagmanager::::casa        Task flagmanager complete. Start time: 2026-09-18 05:56:48.149413 End time: 2026-09-18 05:56:48.528657
18-Sep-2026 05:57:02 2026-09-18 05:56:49        INFO        flagmanager::::casa        ##### End Task: flagmanager          #####
18-Sep-2026 05:57:02 2026-09-18 05:56:49        INFO        flagmanager::::casa        ##########################################
18-Sep-2026 05:57:02 2026-09-18 05:56:49        INFO        split::::casa        ##########################################
18-Sep-2026 05:57:02 2026-09-18 05:56:49        INFO        split::::casa        ##### Begin Task: split              #####
18-Sep-2026 05:57:02 2026-09-18 05:56:49        INFO        split::::casa        split( vis='X220-line.ms', outputvis='X220-line-vs.ms', keepmms=True, field='', spw='', scan='', antenna='', correlation='', timerange='', intent='', array='', uvrange='', observation='', feed='', datacolumn='data', keepflags=True, width='8', timebin='0s', combine='' )
18-Sep-2026 05:57:02 2026-09-18 05:56:49        INFO        ParallelDataHelper::::casa        Analyzing MS for partitioning
18-Sep-2026 05:57:02 2026-09-18 05:56:49        INFO        ParallelDataHelper::::casa        Input vis is a Multi-MS
18-Sep-2026 05:57:02 2026-09-18 05:57:02        INFO        ParallelDataHelper::::casa        Finalizing MMS structure
18-Sep-2026 05:57:02 2026-09-18 05:57:02        INFO        ms::createmultims        Copying subtables from /home/casatest/work/test_regression_alma_M100_if_mpi/X220-line-vs.ms.data/X220-line-vs.ms.0000.ms to the other MMS members.
18-Sep-2026 05:57:02 2026-09-18 05:57:02        INFO        split::::casa        Task split complete. Start time: 2026-09-18 05:56:48.534465 End time: 2026-09-18 05:57:02.160228
18-Sep-2026 05:57:02 2026-09-18 05:57:02        INFO        split::::casa        ##### End Task: split                #####
18-Sep-2026 05:57:02 2026-09-18 05:57:02        INFO        split::::casa        ##########################################
18-Sep-2026 05:57:02 2026-09-18 05:57:02        INFO        flagmanager::::casa        ##########################################
18-Sep-2026 05:57:02 2026-09-18 05:57:02        INFO        flagmanager::::casa        ##### Begin Task: flagmanager        #####
18-Sep-2026 05:57:02 2026-09-18 05:57:02        INFO        flagmanager::::casa        flagmanager( vis='X220-line-vs.ms', mode='save', versionname='apriori', oldname='', comment='', merge='replace' )
18-Sep-2026 05:57:02 2026-09-18 05:57:02        INFO        flagmanager::AgentFlagger::open        Table type is Measurement Set
18-Sep-2026 05:57:02 2026-09-18 05:57:02        INFO        flagmanager::::casa        Save current flagversions to apriori
18-Sep-2026 05:57:02 2026-09-18 05:57:02        INFO        FlagVersion::saveFlagVersion        Creating new backup flag file called apriori
18-Sep-2026 05:57:02 2026-09-18 05:57:03        INFO        flagmanager::::casa        Task flagmanager complete. Start time: 2026-09-18 05:57:02.160661 End time: 2026-09-18 05:57:02.531770
18-Sep-2026 05:57:02 2026-09-18 05:57:03        INFO        flagmanager::::casa        ##### End Task: flagmanager          #####
18-Sep-2026 05:57:02 2026-09-18 05:57:03        INFO        flagmanager::::casa        ##########################################
18-Sep-2026 05:57:02 2026-09-18 05:57:03        WARN        TIMING::::casa        Step 10: Rebin to a reduced resolution of approx. 10 km/s
18-Sep-2026 05:57:02 2026-09-18 05:57:03        WARN        TIMING::::casa        Time now: 1789711022.5320885
18-Sep-2026 05:57:02 2026-09-18 05:57:03        WARN        TIMING::::casa        Time used this step: 27.59984254837036
18-Sep-2026 05:57:02 2026-09-18 05:57:03        WARN        TIMING::::casa        Total time used so far: 480.27406644821167
18-Sep-2026 05:57:02 2026-09-18 05:57:03        WARN        TIMING::::casa        Step  Time used (s)     Fraction of total time (percent) [description]
18-Sep-2026 05:57:02 2026-09-18 05:57:03        WARN        TIMING::::casa          0   123.43224310874939  25.7003764582944 [Data import]
18-Sep-2026 05:57:02 2026-09-18 05:57:03        WARN        TIMING::::casa          1   0.598240852355957  0.1245623892999573 [Generate antenna position cal tables]
18-Sep-2026 05:57:02 2026-09-18 05:57:03        WARN        TIMING::::casa          2   10.415772676467896  2.1687143662567583 [Generate tsys cal tables]
18-Sep-2026 05:57:02 2026-09-18 05:57:03        WARN        TIMING::::casa          3   5.63817834854126  1.1739501968610309 [Correct the Titan position]
18-Sep-2026 05:57:02 2026-09-18 05:57:03        WARN        TIMING::::casa          4   9.69564938545227  2.01877429217756 [Apriori flagging]
18-Sep-2026 05:57:02 2026-09-18 05:57:03        WARN        TIMING::::casa          5   33.62544226646423  7.001302925876406 [Generate WVR cal tables]
18-Sep-2026 05:57:02 2026-09-18 05:57:03        WARN        TIMING::::casa          6   37.3748140335083  7.781976301553742 [Generate delay calibration tables]
18-Sep-2026 05:57:02 2026-09-18 05:57:03        WARN        TIMING::::casa          7   178.60818934440613  37.1888056886506 [Apply antpos, wvr, tsys, and delay cal tables]
18-Sep-2026 05:57:02 2026-09-18 05:57:03        WARN        TIMING::::casa          8   47.118454694747925  9.810743070764731 [Split off non-wvr spws and save flags]
18-Sep-2026 05:57:02 2026-09-18 05:57:03        WARN        TIMING::::casa          9   6.167239189147949  1.2841083081492943 [Flagging]
18-Sep-2026 05:57:02 2026-09-18 05:57:03        WARN        TIMING::::casa          10   27.59984254837036  5.746686002115518 [Rebin to a reduced resolution of approx. 10 km/s]
18-Sep-2026 05:57:02
18-Sep-2026 05:57:02 Step 11: Fast phase-only gaincal for bandpass
18-Sep-2026 05:57:02 2026-09-18 05:57:03        INFO        gaincal::::casa        ##########################################
18-Sep-2026 05:57:02 2026-09-18 05:57:03        INFO        gaincal::::casa        ##### Begin Task: gaincal            #####
18-Sep-2026 05:57:02 2026-09-18 05:57:03        INFO        gaincal::::casa        gaincal( vis='X54-line-vs.ms', caltable='cal-X54-BPint.Gp', field='*Bandpass*', spw='*:190~310', intent='', selectdata=False, timerange='', uvrange='', antenna='', scan='', observation='', msselect='', solint='int', combine='', preavg=-1.0, refant='DV01', refantmode='flex', minblperant=4, minsnr=3.0, solnorm=False, normtype='mean', gaintype='G', smodel=[], calmode='p', solmode='', rmsthresh=[], corrdepflags=False, append=False, splinetime=3600.0, npointaver=3, phasewrap=180.0, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[], parang=False )
18-Sep-2026 05:57:02 2026-09-18 05:57:03        INFO        gaincal::calibrater::open        ****Using NEW VI2-driven calibrater tool****
18-Sep-2026 05:57:02 2026-09-18 05:57:03        INFO        gaincal::calibrater::open        Opening MS: X54-line-vs.ms for calibration.
18-Sep-2026 05:57:02 2026-09-18 05:57:03        INFO        gaincal::Calibrater::        Initializing nominal selection to the whole MS.
18-Sep-2026 05:57:02 2026-09-18 05:57:03        INFO        gaincal::::casa        NB: gaincal automatically excludes auto-correlations.
18-Sep-2026 05:57:02 2026-09-18 05:57:03        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
18-Sep-2026 05:57:02 2026-09-18 05:57:03        INFO        calibrater::reset        Reseting solve/apply state
18-Sep-2026 05:57:02 2026-09-18 05:57:03        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
18-Sep-2026 05:57:02 2026-09-18 05:57:03        INFO        Calibrater::selectvis+         Selecting on spw: '*:190~310'
18-Sep-2026 05:57:02 2026-09-18 05:57:03        INFO        Calibrater::selectvis+         Selecting on field: '*Bandpass*'
18-Sep-2026 05:57:02 2026-09-18 05:57:03        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1!=ANTENNA2'
18-Sep-2026 05:57:02 2026-09-18 05:57:03        INFO        Calibrater::selectvis        By selection 200200 rows are reduced to 9360
18-Sep-2026 05:57:02 2026-09-18 05:57:03        INFO        Calibrater::selectvis        Frequency selection:
18-Sep-2026 05:57:02 2026-09-18 05:57:03        INFO        Calibrater::selectvis        .  Spw 0:190~310 (121 channels, step by 1)
18-Sep-2026 05:57:02 2026-09-18 05:57:03        INFO        Calibrater::selectvis+        .  Spw 1:190~310 (121 channels, step by 1)
18-Sep-2026 05:57:02 2026-09-18 05:57:03        INFO        Calibrater::selectvis+        .  Spw 2:190~310 (121 channels, step by 1)
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        Calibrater::selectvis+        .  Spw 3:190~310 (121 channels, step by 1)
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1!=ANTENNA2'
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        Calibrater::setsolve        Arranging to SOLVE:
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        Calibrater::setsolve        .   G Jones: table=cal-X54-BPint.Gp append=false solint=int refantmode='flex' refant='DV01' minsnr=3 apmode=P solnorm=false
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        calibrater::solve        Beginning solve-----------------------------
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        Calibrater::solve        .   (None)
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        Calibrater::solve        The following calibration term is arranged for solve:
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        Calibrater::solve        .   G Jones: table=cal-X54-BPint.Gp append=false solint=int refantmode='flex' refant='DV01' minsnr=3 apmode=P solnorm=false
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1, -1, -1]
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 114704690625
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 112829690625
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        FreqMetaData::calcFreqMeta         Selected spw=2 (nchan=1) has centroid freq = 102685159375
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        FreqMetaData::calcFreqMeta         Selected spw=3 (nchan=1) has centroid freq = 100872659375
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        Calibrater::solve        For solint = int, found 120 solution intervals.
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        Calibrater::solve        Beginning solution interval 12/120 (~10% complete)
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        Calibrater::solve        Beginning solution interval 24/120 (~20% complete)
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        Calibrater::solve        Beginning solution interval 36/120 (~30% complete)
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        Calibrater::solve        Beginning solution interval 48/120 (~40% complete)
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        Calibrater::solve        Beginning solution interval 60/120 (~50% complete)
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        Calibrater::solve        Beginning solution interval 72/120 (~60% complete)
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        Calibrater::solve        Beginning solution interval 84/120 (~70% complete)
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        Calibrater::solve        Beginning solution interval 96/120 (~80% complete)
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        Calibrater::solve        Beginning solution interval 108/120 (~90% complete)
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO        Calibrater::solve          Found good G Jones solutions in 120 solution intervals.
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO                Applying refant: DV01 refantmode = flex (hold alternate refants' phase constant) when refant flagged
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO                Enforcing apmode on solutions.
18-Sep-2026 05:57:04 2026-09-18 05:57:03        INFO                Writing solutions to table: cal-X54-BPint.Gp
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9    ANT: 10    ANT: 11    ANT: 12   
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        Calibrater::solve        SPW: 0 [0, 0]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        Calibrater::solve        SPW: 1 [0, 0]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        Calibrater::solve        SPW: 2 [0, 0]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        Calibrater::solve        SPW: 3 [0, 0]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]  [30, 30]
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        Calibrater::solve        ----- PER SPW INFO -----
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        Calibrater::solve        SPW: 0 [30, 30]  [30, 30]        [30, 30]            [30, 30]
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        Calibrater::solve        SPW: 1 [30, 30]  [30, 30]        [30, 30]            [30, 30]
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        Calibrater::solve        SPW: 2 [30, 30]  [30, 30]        [30, 30]            [30, 30]
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        Calibrater::solve        SPW: 3 [30, 30]  [30, 30]        [30, 30]            [30, 30]
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        Calibrater::solve        ----- GLOBAL INFO -----
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        Calibrater::solve        [120, 120]  [120, 120]        [120, 120]            [120, 120]
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        calibrater::solve        Finished solving.
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        gaincal::::casa        Calibration solve statistics per spw:  (expected/attempted/succeeded):
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        gaincal::::casa          Spw 0: 30/30/30
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        gaincal::::casa          Spw 1: 30/30/30
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        gaincal::::casa          Spw 2: 30/30/30
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        gaincal::::casa          Spw 3: 30/30/30
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        gaincal::::casa        Task gaincal complete. Start time: 2026-09-18 05:57:02.536790 End time: 2026-09-18 05:57:03.605923
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        gaincal::::casa        ##### End Task: gaincal              #####
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        gaincal::::casa        ##########################################
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        plotms::::casa        ##### Begin Task: plotms             #####
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        plotms::::casa        plotms( vis='cal-X54-BPint.Gp', caltable='', gridrows=2, gridcols=2, rowindex=0, colindex=0, plotindex=0, xaxis='time', xdatacolumn='', xframe='', xinterp='', yaxis='phase', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', correlation='X', 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='spw', xselfscale=False, yselfscale=False, xsharedaxis=False, ysharedaxis=False, customsymbol=True, symbolshape='circle', 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, -180.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-X54-phase_vs_time_XX.BPint.Gp.png', expformat='', verbose=True, exprange='', highres=False, dpi=-1, width=-1, height=-1, overwrite=False, showgui=False, clearplots=True, callib=[], headeritems='', showatm=False, showtsky=False, showimage=False, colorizeoverlay=False )
18-Sep-2026 05:57:04
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        plotms::::casa        Exporting the plot to /home/casatest/work/test_regression_alma_M100_if_mpi/cal-X54-phase_vs_time_XX.BPint.Gp.png
18-Sep-2026 05:57:04 NOTICE: Exporting to images in screen resolution is currently not working.  Switching to high resolution (which is slower, but works).
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        plotms::::casa        Task plotms complete. Start time: 2026-09-18 05:57:03.615954 End time: 2026-09-18 05:57:04.416166
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        plotms::::casa        ##### End Task: plotms               #####
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:04 2026-09-18 05:57:04        INFO        plotms::::casa        ##### Begin Task: plotms             #####
18-Sep-2026 05:57:06 2026-09-18 05:57:04        INFO        plotms::::casa        plotms( vis='cal-X54-BPint.Gp', caltable='', gridrows=2, gridcols=2, rowindex=0, colindex=0, plotindex=0, xaxis='time', xdatacolumn='', xframe='', xinterp='', yaxis='phase', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', correlation='Y', 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='spw', xselfscale=False, yselfscale=False, xsharedaxis=False, ysharedaxis=False, customsymbol=True, symbolshape='circle', 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, -180.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-X54-phase_vs_time_YY.BPint.Gp.png', expformat='', verbose=True, exprange='', highres=False, dpi=-1, width=-1, height=-1, overwrite=False, showgui=False, clearplots=True, callib=[], headeritems='', showatm=False, showtsky=False, showimage=False, colorizeoverlay=False )
18-Sep-2026 05:57:06
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        plotms::::casa        Exporting the plot to /home/casatest/work/test_regression_alma_M100_if_mpi/cal-X54-phase_vs_time_YY.BPint.Gp.png
18-Sep-2026 05:57:06 NOTICE: Exporting to images in screen resolution is currently not working.  Switching to high resolution (which is slower, but works).
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        plotms::::casa        Task plotms complete. Start time: 2026-09-18 05:57:04.419187 End time: 2026-09-18 05:57:05.211784
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        plotms::::casa        ##### End Task: plotms               #####
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        gaincal::::casa        ##########################################
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        gaincal::::casa        ##### Begin Task: gaincal            #####
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        gaincal::::casa        gaincal( vis='X220-line-vs.ms', caltable='cal-X220-BPint.Gp', field='*Bandpass*', spw='*:190~310', intent='', selectdata=False, timerange='', uvrange='', antenna='', scan='', observation='', msselect='', solint='int', combine='', preavg=-1.0, refant='DV01', refantmode='flex', minblperant=4, minsnr=3.0, solnorm=False, normtype='mean', gaintype='G', smodel=[], calmode='p', solmode='', rmsthresh=[], corrdepflags=False, append=False, splinetime=3600.0, npointaver=3, phasewrap=180.0, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[], parang=False )
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        gaincal::calibrater::open        ****Using NEW VI2-driven calibrater tool****
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        gaincal::calibrater::open        Opening MS: X220-line-vs.ms for calibration.
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        gaincal::Calibrater::        Initializing nominal selection to the whole MS.
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        gaincal::::casa        NB: gaincal automatically excludes auto-correlations.
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        calibrater::reset        Reseting solve/apply state
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::selectvis+         Selecting on spw: '*:190~310'
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::selectvis+         Selecting on field: '*Bandpass*'
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1!=ANTENNA2'
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::selectvis        By selection 194740 rows are reduced to 9360
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::selectvis        Frequency selection:
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::selectvis        .  Spw 0:190~310 (121 channels, step by 1)
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::selectvis+        .  Spw 1:190~310 (121 channels, step by 1)
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::selectvis+        .  Spw 2:190~310 (121 channels, step by 1)
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::selectvis+        .  Spw 3:190~310 (121 channels, step by 1)
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1!=ANTENNA2'
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::setsolve        Arranging to SOLVE:
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::setsolve        .   G Jones: table=cal-X220-BPint.Gp append=false solint=int refantmode='flex' refant='DV01' minsnr=3 apmode=P solnorm=false
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        calibrater::solve        Beginning solve-----------------------------
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::solve        .   (None)
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::solve        The following calibration term is arranged for solve:
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::solve        .   G Jones: table=cal-X220-BPint.Gp append=false solint=int refantmode='flex' refant='DV01' minsnr=3 apmode=P solnorm=false
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1, -1, -1]
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 114704690625
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 112829690625
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        FreqMetaData::calcFreqMeta         Selected spw=2 (nchan=1) has centroid freq = 102685159375
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        FreqMetaData::calcFreqMeta         Selected spw=3 (nchan=1) has centroid freq = 100872659375
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::solve        For solint = int, found 120 solution intervals.
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::solve        Beginning solution interval 12/120 (~10% complete)
18-Sep-2026 05:57:06 Found no unflagged data at:   (time=2011/09/10/19:52:57.3 field=2 spw=0 chan=0)
18-Sep-2026 05:57:06 Found no unflagged data at:   (time=2011/09/10/19:53:03.4 field=2 spw=0 chan=0)
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::solve        Beginning solution interval 24/120 (~20% complete)
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::solve        Beginning solution interval 36/120 (~30% complete)
18-Sep-2026 05:57:06 Found no unflagged data at:   (time=2011/09/10/19:52:57.3 field=2 spw=1 chan=0)
18-Sep-2026 05:57:06 Found no unflagged data at:   (time=2011/09/10/19:53:03.4 field=2 spw=1 chan=0)
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::solve        Beginning solution interval 48/120 (~40% complete)
18-Sep-2026 05:57:06 2026-09-18 05:57:05        INFO        Calibrater::solve        Beginning solution interval 60/120 (~50% complete)
18-Sep-2026 05:57:06 2026-09-18 05:57:06        INFO        Calibrater::solve        Beginning solution interval 72/120 (~60% complete)
18-Sep-2026 05:57:06 Found no unflagged data at:   (time=2011/09/10/19:52:57.3 field=2 spw=2 chan=0)
18-Sep-2026 05:57:06 Found no unflagged data at:   (time=2011/09/10/19:53:03.4 field=2 spw=2 chan=0)
18-Sep-2026 05:57:06 2026-09-18 05:57:06        INFO        Calibrater::solve        Beginning solution interval 84/120 (~70% complete)
18-Sep-2026 05:57:06 2026-09-18 05:57:06        INFO        Calibrater::solve        Beginning solution interval 96/120 (~80% complete)
18-Sep-2026 05:57:06 Found no unflagged data at:   (time=2011/09/10/19:52:57.3 field=2 spw=3 chan=0)
18-Sep-2026 05:57:06 Found no unflagged data at:   (time=2011/09/10/19:53:03.4 field=2 spw=3 chan=0)
18-Sep-2026 05:57:06 2026-09-18 05:57:06        INFO        Calibrater::solve        Beginning solution interval 108/120 (~90% complete)
18-Sep-2026 05:57:06 2026-09-18 05:57:06        INFO        Calibrater::solve          Found good G Jones solutions in 112 solution intervals.
18-Sep-2026 05:57:06 2026-09-18 05:57:06        INFO                Applying refant: DV01 refantmode = flex (hold alternate refants' phase constant) when refant flagged
18-Sep-2026 05:57:06 2026-09-18 05:57:06        INFO                Enforcing apmode on solutions.
18-Sep-2026 05:57:06 2026-09-18 05:57:06        INFO                Writing solutions to table: cal-X220-BPint.Gp
18-Sep-2026 05:57:06 2026-09-18 05:57:06        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9    ANT: 10    ANT: 11    ANT: 12   
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        Calibrater::solve        SPW: 0 [0, 0]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        Calibrater::solve        SPW: 1 [0, 0]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        Calibrater::solve        SPW: 2 [0, 0]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        Calibrater::solve        SPW: 3 [0, 0]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]  [28, 28]
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        Calibrater::solve        ----- PER SPW INFO -----
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        Calibrater::solve        SPW: 0 [30, 30]  [28, 28]        [28, 28]            [28, 28]
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        Calibrater::solve        SPW: 1 [30, 30]  [28, 28]        [28, 28]            [28, 28]
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        Calibrater::solve        SPW: 2 [30, 30]  [28, 28]        [28, 28]            [28, 28]
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        Calibrater::solve        SPW: 3 [30, 30]  [28, 28]        [28, 28]            [28, 28]
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        Calibrater::solve        ----- GLOBAL INFO -----
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        Calibrater::solve        [120, 120]  [112, 112]        [112, 112]            [112, 112]
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        calibrater::solve        Finished solving.
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        gaincal::::casa        Calibration solve statistics per spw:  (expected/attempted/succeeded):
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        gaincal::::casa          Spw 0: 30/28/28
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        gaincal::::casa          Spw 1: 30/28/28
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        gaincal::::casa          Spw 2: 30/28/28
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        gaincal::::casa          Spw 3: 30/28/28
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        gaincal::::casa        Task gaincal complete. Start time: 2026-09-18 05:57:05.222960 End time: 2026-09-18 05:57:06.246546
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        gaincal::::casa        ##### End Task: gaincal              #####
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        gaincal::::casa        ##########################################
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        plotms::::casa        ##### Begin Task: plotms             #####
18-Sep-2026 05:57:07 2026-09-18 05:57:06        INFO        plotms::::casa        plotms( vis='cal-X220-BPint.Gp', caltable='', gridrows=2, gridcols=2, rowindex=0, colindex=0, plotindex=0, xaxis='time', xdatacolumn='', xframe='', xinterp='', yaxis='phase', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', correlation='X', 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='spw', xselfscale=False, yselfscale=False, xsharedaxis=False, ysharedaxis=False, customsymbol=True, symbolshape='circle', 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, -180.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-X220-phase_vs_time_XX.BPint.Gp.png', expformat='', verbose=True, exprange='', highres=False, dpi=-1, width=-1, height=-1, overwrite=False, showgui=False, clearplots=True, callib=[], headeritems='', showatm=False, showtsky=False, showimage=False, colorizeoverlay=False )
18-Sep-2026 05:57:07
18-Sep-2026 05:57:07 2026-09-18 05:57:07        INFO        plotms::::casa        Exporting the plot to /home/casatest/work/test_regression_alma_M100_if_mpi/cal-X220-phase_vs_time_XX.BPint.Gp.png
18-Sep-2026 05:57:07 NOTICE: Exporting to images in screen resolution is currently not working.  Switching to high resolution (which is slower, but works).
18-Sep-2026 05:57:07 2026-09-18 05:57:07        INFO        plotms::::casa        Task plotms complete. Start time: 2026-09-18 05:57:06.256086 End time: 2026-09-18 05:57:07.039153
18-Sep-2026 05:57:07 2026-09-18 05:57:07        INFO        plotms::::casa        ##### End Task: plotms               #####
18-Sep-2026 05:57:07 2026-09-18 05:57:07        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:07 2026-09-18 05:57:07        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:07 2026-09-18 05:57:07        INFO        plotms::::casa        ##### Begin Task: plotms             #####
18-Sep-2026 05:57:07 2026-09-18 05:57:07        INFO        plotms::::casa        plotms( vis='cal-X220-BPint.Gp', caltable='', gridrows=2, gridcols=2, rowindex=0, colindex=0, plotindex=0, xaxis='time', xdatacolumn='', xframe='', xinterp='', yaxis='phase', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='', timerange='', uvrange='', antenna='', scan='', correlation='Y', 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='spw', xselfscale=False, yselfscale=False, xsharedaxis=False, ysharedaxis=False, customsymbol=True, symbolshape='circle', 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, -180.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-X220-phase_vs_time_YY.BPint.Gp.png', expformat='', verbose=True, exprange='', highres=False, dpi=-1, width=-1, height=-1, overwrite=False, showgui=False, clearplots=True, callib=[], headeritems='', showatm=False, showtsky=False, showimage=False, colorizeoverlay=False )
18-Sep-2026 05:57:07
18-Sep-2026 05:57:07 2026-09-18 05:57:08        INFO        plotms::::casa        Exporting the plot to /home/casatest/work/test_regression_alma_M100_if_mpi/cal-X220-phase_vs_time_YY.BPint.Gp.png
18-Sep-2026 05:57:07 NOTICE: Exporting to images in screen resolution is currently not working.  Switching to high resolution (which is slower, but works).
18-Sep-2026 05:57:07 2026-09-18 05:57:08        INFO        plotms::::casa        Task plotms complete. Start time: 2026-09-18 05:57:07.042359 End time: 2026-09-18 05:57:07.825158
18-Sep-2026 05:57:07 2026-09-18 05:57:08        INFO        plotms::::casa        ##### End Task: plotms               #####
18-Sep-2026 05:57:07 2026-09-18 05:57:08        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:07 2026-09-18 05:57:08        WARN        TIMING::::casa        Step 11: Fast phase-only gaincal for bandpass
18-Sep-2026 05:57:07
18-Sep-2026 05:57:07 2026-09-18 05:57:08        WARN        TIMING::::casa        Time used this step: 5.293205738067627
18-Sep-2026 05:57:07 2026-09-18 05:57:08        WARN        TIMING::::casa        Total time used so far: 485.5672721862793
18-Sep-2026 05:57:07 2026-09-18 05:57:08        WARN        TIMING::::casa        Step  Time used (s)     Fraction of total time (percent) [description]
18-Sep-2026 05:57:07 2026-09-18 05:57:08        WARN        TIMING::::casa          0   123.43224310874939  25.42021470124881 [Data import]
18-Sep-2026 05:57:07 2026-09-18 05:57:08        WARN        TIMING::::casa          1   0.598240852355957  0.12320452522723824 [Generate antenna position cal tables]
18-Sep-2026 05:57:07 2026-09-18 05:57:08        WARN        TIMING::::casa          2   10.415772676467896  2.1450730461240948 [Generate tsys cal tables]
18-Sep-2026 05:57:09 2026-09-18 05:57:08        WARN        TIMING::::casa          3   5.63817834854126  1.1611528765427732 [Correct the Titan position]
18-Sep-2026 05:57:09 2026-09-18 05:57:08        WARN        TIMING::::casa          4   9.69564938545227  1.996767480188143 [Apriori flagging]
18-Sep-2026 05:57:09 2026-09-18 05:57:08        WARN        TIMING::::casa          5   33.62544226646423  6.924981190570115 [Generate WVR cal tables]
18-Sep-2026 05:57:09 2026-09-18 05:57:08        WARN        TIMING::::casa          6   37.3748140335083  7.697144386446646 [Generate delay calibration tables]
18-Sep-2026 05:57:09 2026-09-18 05:57:08        WARN        TIMING::::casa          7   178.60818934440613  36.78340769142412 [Apply antpos, wvr, tsys, and delay cal tables]
18-Sep-2026 05:57:09 2026-09-18 05:57:08        WARN        TIMING::::casa          8   47.118454694747925  9.70379541491663 [Split off non-wvr spws and save flags]
18-Sep-2026 05:57:09 2026-09-18 05:57:08        WARN        TIMING::::casa          9   6.167239189147949  1.2701101458876736 [Flagging]
18-Sep-2026 05:57:09 2026-09-18 05:57:08        WARN        TIMING::::casa          10   27.59984254837036  5.684040941248234 [Rebin to a reduced resolution of approx. 10 km/s]
18-Sep-2026 05:57:09 2026-09-18 05:57:08        WARN        TIMING::::casa        Time now: 1789711027.8252943
18-Sep-2026 05:57:09 Step 12: Bandpass
18-Sep-2026 05:57:09 2026-09-18 05:57:08        WARN        TIMING::::casa          11   5.293205738067627  1.0901076001755288 [Fast phase-only gaincal for bandpass]
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        bandpass::::casa        ##########################################
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        bandpass::::casa        ##### Begin Task: bandpass           #####
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        bandpass::::casa        bandpass( vis='X54-line-vs.ms', caltable='cal-X54.B1', field='*Bandpass*', spw='', intent='', selectdata=False, timerange='', uvrange='', antenna='', scan='', observation='', msselect='', solint='inf', combine='', refant='DV01', minblperant=4, minsnr=3.0, solnorm=True, bandtype='B', smodel=[], corrdepflags=False, append=False, fillgaps=10, degamp=3, degphase=3, visnorm=False, maskcenter=0, maskedge=5, docallib=False, callib='', gaintable=['cal-X54-BPint.Gp'], gainfield=[], interp=[], spwmap=[], parang=False )
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        bandpass::calibrater::open        ****Using NEW VI2-driven calibrater tool****
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        bandpass::calibrater::open        Opening MS: X54-line-vs.ms for calibration.
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        bandpass::Calibrater::        Initializing nominal selection to the whole MS.
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        bandpass::calibrater::reset        Reseting solve/apply state
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        bandpass::::casa        NB: bandpass automatically excludes auto-correlations.
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        calibrater::reset        Reseting solve/apply state
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        Calibrater::selectvis+         Selecting on field: '*Bandpass*'
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1!=ANTENNA2'
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        Calibrater::selectvis        By selection 200200 rows are reduced to 9360
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1!=ANTENNA2'
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        calibrater::setapply        Beginning setapply--(MSSelection version)-------
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        Calibrater::setapply(type, applypar)        Arranging to APPLY:
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        Calibrater::setapply(type, applypar)        .   G Jones: table=cal-X54-BPint.Gp select= interp=linear spwmap=[-1] calWt=true
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        Calibrater::setsolve        Arranging to SOLVE:
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        Calibrater::setsolve        .   B Jones: table=cal-X54.B1 append=false solint=inf,none refantmode='flex' refant='DV01' minsnr=3 apmode=AP solnorm=true normtype=MEAN
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        calibrater::solve        Beginning solve-----------------------------
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        Calibrater::solve        .   G Jones: table=cal-X54-BPint.Gp select= interp=linear spwmap=[-1] calWt=true
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        Calibrater::solve        The following calibration term is arranged for solve:
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        Calibrater::solve        .   B Jones: table=cal-X54.B1 append=false solint=inf,none refantmode='flex' refant='DV01' minsnr=3 apmode=AP solnorm=true normtype=MEAN
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=480) has centroid freq = 114663675000
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=480) has centroid freq = 112788675000
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        FreqMetaData::calcFreqMeta         Selected spw=2 (nchan=480) has centroid freq = 102726175000
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        FreqMetaData::calcFreqMeta         Selected spw=3 (nchan=480) has centroid freq = 100913675000
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        Calibrater::solve        For solint = inf, found 4 solution intervals.
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=0 chan=479)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=0 chan=478)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=0 chan=477)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=0 chan=476)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=0 chan=475)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=0 chan=0)
18-Sep-2026 05:57:09 2026-09-18 05:57:08        INFO        Calibrater::solve        Beginning solution interval 1/4 (~25% complete)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=1 chan=479)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=1 chan=478)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=1 chan=477)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=1 chan=476)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=1 chan=475)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=1 chan=0)
18-Sep-2026 05:57:09 2026-09-18 05:57:09        INFO        Calibrater::solve        Beginning solution interval 2/4 (~50% complete)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=2 chan=479)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=2 chan=478)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=2 chan=477)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=2 chan=476)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=2 chan=475)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=2 chan=0)
18-Sep-2026 05:57:09 2026-09-18 05:57:09        INFO        Calibrater::solve        Beginning solution interval 3/4 (~75% complete)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=3 chan=479)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=3 chan=478)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=3 chan=477)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=3 chan=476)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=3 chan=475)
18-Sep-2026 05:57:09 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:09    (time=2011/09/10/18:19:01.8 field=2 spw=3 chan=0)
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO        Calibrater::solve          Found good B Jones solutions in 4 solution intervals.
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                Applying refant: DV01 refantmode = flex (hold alternate refants' phase constant) when refant flagged
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                Normalizing solutions per spw, time, ant, pol with MEAN in amplitude (and center channel in phase).
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=1 pol 0 = 0.462676, 1.12179e-08deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=1 pol 1 = 0.449881, 1.76969e-08deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=2 pol 0 = 0.472005, -7.08207deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=2 pol 1 = 0.461353, -11.1595deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=3 pol 0 = 0.461505, -4.78973deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=3 pol 1 = 0.453974, -6.25333deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=4 pol 0 = 0.449318, -3.48167deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=4 pol 1 = 0.454203, -7.28883deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=5 pol 0 = 0.473875, -6.73554deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=5 pol 1 = 0.462034, -11.0224deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=6 pol 0 = 0.437216, -4.32525deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=6 pol 1 = 0.424196, -10.6695deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=7 pol 0 = 0.465322, -5.70353deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=7 pol 1 = 0.459157, -11.3079deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=8 pol 0 = 0.469527, -10.715deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=8 pol 1 = 0.444899, -10.7292deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=9 pol 0 = 0.46667, -5.85651deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=9 pol 1 = 0.460904, -10.2602deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=10 pol 0 = 0.471934, -4.13302deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=10 pol 1 = 0.459609, -8.14449deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=11 pol 0 = 0.45441, -1.94844deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=11 pol 1 = 0.439552, -7.01711deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=12 pol 0 = 0.466654, -9.91557deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/18:19:01.8 ant=12 pol 1 = 0.454872, -9.9288deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=1 pol 0 = 0.460347, -2.03413e-08deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=1 pol 1 = 0.452743, 2.2901e-09deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=2 pol 0 = 0.471308, -5.06485deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=2 pol 1 = 0.464749, 2.28366deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=3 pol 0 = 0.45782, -3.52545deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=3 pol 1 = 0.452431, -1.29608deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=4 pol 0 = 0.447344, -1.80879deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=4 pol 1 = 0.450647, 0.499984deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=5 pol 0 = 0.469693, -1.48705deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=5 pol 1 = 0.459313, 0.721397deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=6 pol 0 = 0.437818, -4.47005deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=6 pol 1 = 0.423961, 0.86955deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=7 pol 0 = 0.462067, -1.70452deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=7 pol 1 = 0.460985, 1.58129deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=8 pol 0 = 0.470569, -5.133deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=8 pol 1 = 0.446047, 1.71142deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=9 pol 0 = 0.462185, -1.70246deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=9 pol 1 = 0.454599, 2.33652deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=10 pol 0 = 0.469063, 0.758808deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=10 pol 1 = 0.45829, 6.18013deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=11 pol 0 = 0.451792, -2.04534deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=11 pol 1 = 0.436961, 1.06218deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=12 pol 0 = 0.464869, -5.48989deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/18:19:01.8 ant=12 pol 1 = 0.456553, -2.57163deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=1 pol 0 = 0.476036, 2.38346e-09deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=1 pol 1 = 0.463465, 6.21891e-09deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=2 pol 0 = 0.487868, 4.52463deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=2 pol 1 = 0.476472, 0.496187deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=3 pol 0 = 0.475845, 2.70247deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=3 pol 1 = 0.46794, 2.65611deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=4 pol 0 = 0.47882, 1.38136deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=4 pol 1 = 0.462485, 3.7489deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=5 pol 0 = 0.483708, 0.912826deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=5 pol 1 = 0.470118, 3.35956deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=6 pol 0 = 0.448551, 1.31831deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=6 pol 1 = 0.438491, 1.28179deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=7 pol 0 = 0.48049, -0.604465deg
18-Sep-2026 05:57:09 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=7 pol 1 = 0.468037, 2.28098deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=8 pol 0 = 0.477424, 4.07299deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=8 pol 1 = 0.468225, 3.10411deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=9 pol 0 = 0.483085, -0.730684deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=9 pol 1 = 0.467247, -2.17579deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=10 pol 0 = 0.478695, -3.17252deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=10 pol 1 = 0.46906, -0.0416039deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=11 pol 0 = 0.464991, 2.55711deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=11 pol 1 = 0.449998, 4.13547deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=12 pol 0 = 0.486821, 4.93635deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/18:19:01.8 ant=12 pol 1 = 0.473327, 1.69798deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=1 pol 0 = 0.482476, 5.07804e-09deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=1 pol 1 = 0.474304, 5.43079e-09deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=2 pol 0 = 0.488679, 3.04888deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=2 pol 1 = 0.476859, 2.77163deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=3 pol 0 = 0.479391, 0.850254deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=3 pol 1 = 0.469015, 1.45987deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=4 pol 0 = 0.462271, 1.15169deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=4 pol 1 = 0.459884, 3.61304deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=5 pol 0 = 0.490979, 3.3812deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=5 pol 1 = 0.472956, 3.62355deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=6 pol 0 = 0.456212, -0.0843687deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=6 pol 1 = 0.442379, 7.16721deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=7 pol 0 = 0.48504, 0.765114deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=7 pol 1 = 0.463584, 2.75298deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=8 pol 0 = 0.484127, 2.22036deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=8 pol 1 = 0.474568, 5.00849deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=9 pol 0 = 0.487759, 4.02877deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=9 pol 1 = 0.476217, 5.20481deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=10 pol 0 = 0.483377, 6.36781deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=10 pol 1 = 0.475516, 3.70175deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=11 pol 0 = 0.474143, -0.850221deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=11 pol 1 = 0.461365, 1.07609deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=12 pol 0 = 0.485655, 1.97241deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/18:19:01.8 ant=12 pol 1 = 0.475867, 3.66864deg
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                Filling in flagged solution channels by interpolation.
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                Normalizing solutions per spw, pol, ant, time.
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO                Writing solutions to table: cal-X54.B1
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9    ANT: 10    ANT: 11    ANT: 12   
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO        Calibrater::solve        SPW: 0 [0, 0]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO        Calibrater::solve        SPW: 1 [0, 0]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO        Calibrater::solve        SPW: 2 [0, 0]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO        Calibrater::solve        SPW: 3 [0, 0]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO        Calibrater::solve        ----- PER SPW INFO -----
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO        Calibrater::solve        SPW: 0 [1, 1]  [1, 1]        [1, 1]            [1, 1]
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO        Calibrater::solve        SPW: 1 [1, 1]  [1, 1]        [1, 1]            [1, 1]
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO        Calibrater::solve        SPW: 2 [1, 1]  [1, 1]        [1, 1]            [1, 1]
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO        Calibrater::solve        SPW: 3 [1, 1]  [1, 1]        [1, 1]            [1, 1]
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO        Calibrater::solve        ----- GLOBAL INFO -----
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO        Calibrater::solve        [4, 4]  [4, 4]        [4, 4]            [4, 4]
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO        calibrater::solve        Finished solving.
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO        bandpass::::casa        Task bandpass complete. Start time: 2026-09-18 05:57:07.842089 End time: 2026-09-18 05:57:10.106074
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO        bandpass::::casa        ##### End Task: bandpass             #####
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO        bandpass::::casa        ##########################################
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:10 2026-09-18 05:57:10        INFO        plotms::::casa        ##### Begin Task: plotms             #####
18-Sep-2026 05:57:13 2026-09-18 05:57:10        INFO        plotms::::casa        plotms( vis='cal-X54.B1', caltable='', gridrows=4, gridcols=3, rowindex=0, colindex=0, plotindex=0, xaxis='freq', xdatacolumn='', xframe='', xinterp='', yaxis='phase', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='0', 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, -70.0, 70.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-X54-phase.spw0.B1.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 )
18-Sep-2026 05:57:13
18-Sep-2026 05:57:13 2026-09-18 05:57:11        INFO        plotms::::casa        Exporting the plot to /home/casatest/work/test_regression_alma_M100_if_mpi/cal-X54-phase.spw0.B1.png
18-Sep-2026 05:57:13 NOTICE: Exporting to images in screen resolution is currently not working.  Switching to high resolution (which is slower, but works).
18-Sep-2026 05:57:13 2026-09-18 05:57:11        INFO        plotms::::casa        Task plotms complete. Start time: 2026-09-18 05:57:10.116419 End time: 2026-09-18 05:57:11.174697
18-Sep-2026 05:57:13 2026-09-18 05:57:11        INFO        plotms::::casa        ##### End Task: plotms               #####
18-Sep-2026 05:57:13 2026-09-18 05:57:11        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:13 2026-09-18 05:57:11        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:13 2026-09-18 05:57:11        INFO        plotms::::casa        ##### Begin Task: plotms             #####
18-Sep-2026 05:57:13 2026-09-18 05:57:11        INFO        plotms::::casa        plotms( vis='cal-X54.B1', caltable='', gridrows=4, gridcols=3, rowindex=0, colindex=0, plotindex=0, xaxis='freq', xdatacolumn='', xframe='', xinterp='', yaxis='amp', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='0', 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=[], 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-X54-amplitude.spw0.B1.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 )
18-Sep-2026 05:57:13
18-Sep-2026 05:57:13 2026-09-18 05:57:12        INFO        plotms::::casa        Exporting the plot to /home/casatest/work/test_regression_alma_M100_if_mpi/cal-X54-amplitude.spw0.B1.png
18-Sep-2026 05:57:13 NOTICE: Exporting to images in screen resolution is currently not working.  Switching to high resolution (which is slower, but works).
18-Sep-2026 05:57:13 2026-09-18 05:57:12        INFO        plotms::::casa        Task plotms complete. Start time: 2026-09-18 05:57:11.177774 End time: 2026-09-18 05:57:12.128531
18-Sep-2026 05:57:13 2026-09-18 05:57:12        INFO        plotms::::casa        ##### End Task: plotms               #####
18-Sep-2026 05:57:13 2026-09-18 05:57:12        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:13 2026-09-18 05:57:12        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:13 2026-09-18 05:57:12        INFO        plotms::::casa        ##### Begin Task: plotms             #####
18-Sep-2026 05:57:13 2026-09-18 05:57:12        INFO        plotms::::casa        plotms( vis='cal-X54.B1', caltable='', gridrows=4, gridcols=3, rowindex=0, colindex=0, plotindex=0, xaxis='freq', xdatacolumn='', xframe='', xinterp='', yaxis='phase', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='1', 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, -70.0, 70.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-X54-phase.spw1.B1.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 )
18-Sep-2026 05:57:13
18-Sep-2026 05:57:13 2026-09-18 05:57:13        INFO        plotms::::casa        Exporting the plot to /home/casatest/work/test_regression_alma_M100_if_mpi/cal-X54-phase.spw1.B1.png
18-Sep-2026 05:57:13 NOTICE: Exporting to images in screen resolution is currently not working.  Switching to high resolution (which is slower, but works).
18-Sep-2026 05:57:13 2026-09-18 05:57:13        INFO        plotms::::casa        Task plotms complete. Start time: 2026-09-18 05:57:12.131518 End time: 2026-09-18 05:57:13.192217
18-Sep-2026 05:57:13 2026-09-18 05:57:13        INFO        plotms::::casa        ##### End Task: plotms               #####
18-Sep-2026 05:57:13 2026-09-18 05:57:13        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:13 2026-09-18 05:57:13        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:13 2026-09-18 05:57:13        INFO        plotms::::casa        ##### Begin Task: plotms             #####
18-Sep-2026 05:57:16 2026-09-18 05:57:13        INFO        plotms::::casa        plotms( vis='cal-X54.B1', caltable='', gridrows=4, gridcols=3, rowindex=0, colindex=0, plotindex=0, xaxis='freq', xdatacolumn='', xframe='', xinterp='', yaxis='amp', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='1', 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=[], 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-X54-amplitude.spw1.B1.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 )
18-Sep-2026 05:57:16
18-Sep-2026 05:57:16 2026-09-18 05:57:14        INFO        plotms::::casa        Exporting the plot to /home/casatest/work/test_regression_alma_M100_if_mpi/cal-X54-amplitude.spw1.B1.png
18-Sep-2026 05:57:16 NOTICE: Exporting to images in screen resolution is currently not working.  Switching to high resolution (which is slower, but works).
18-Sep-2026 05:57:16 2026-09-18 05:57:14        INFO        plotms::::casa        Task plotms complete. Start time: 2026-09-18 05:57:13.195231 End time: 2026-09-18 05:57:14.137656
18-Sep-2026 05:57:16 2026-09-18 05:57:14        INFO        plotms::::casa        ##### End Task: plotms               #####
18-Sep-2026 05:57:16 2026-09-18 05:57:14        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:16 2026-09-18 05:57:14        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:16 2026-09-18 05:57:14        INFO        plotms::::casa        ##### Begin Task: plotms             #####
18-Sep-2026 05:57:16 2026-09-18 05:57:14        INFO        plotms::::casa        plotms( vis='cal-X54.B1', caltable='', gridrows=4, gridcols=3, rowindex=0, colindex=0, plotindex=0, xaxis='freq', xdatacolumn='', xframe='', xinterp='', yaxis='phase', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='2', 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, -70.0, 70.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-X54-phase.spw2.B1.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 )
18-Sep-2026 05:57:16
18-Sep-2026 05:57:16 2026-09-18 05:57:15        INFO        plotms::::casa        Exporting the plot to /home/casatest/work/test_regression_alma_M100_if_mpi/cal-X54-phase.spw2.B1.png
18-Sep-2026 05:57:16 NOTICE: Exporting to images in screen resolution is currently not working.  Switching to high resolution (which is slower, but works).
18-Sep-2026 05:57:16 2026-09-18 05:57:15        INFO        plotms::::casa        Task plotms complete. Start time: 2026-09-18 05:57:14.140655 End time: 2026-09-18 05:57:15.204777
18-Sep-2026 05:57:16 2026-09-18 05:57:15        INFO        plotms::::casa        ##### End Task: plotms               #####
18-Sep-2026 05:57:16 2026-09-18 05:57:15        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:16 2026-09-18 05:57:15        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:16 2026-09-18 05:57:15        INFO        plotms::::casa        ##### Begin Task: plotms             #####
18-Sep-2026 05:57:16 2026-09-18 05:57:15        INFO        plotms::::casa        plotms( vis='cal-X54.B1', caltable='', gridrows=4, gridcols=3, rowindex=0, colindex=0, plotindex=0, xaxis='freq', xdatacolumn='', xframe='', xinterp='', yaxis='amp', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='2', 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=[], 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-X54-amplitude.spw2.B1.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 )
18-Sep-2026 05:57:16
18-Sep-2026 05:57:16 2026-09-18 05:57:16        INFO        plotms::::casa        Exporting the plot to /home/casatest/work/test_regression_alma_M100_if_mpi/cal-X54-amplitude.spw2.B1.png
18-Sep-2026 05:57:16 NOTICE: Exporting to images in screen resolution is currently not working.  Switching to high resolution (which is slower, but works).
18-Sep-2026 05:57:16 2026-09-18 05:57:16        INFO        plotms::::casa        Task plotms complete. Start time: 2026-09-18 05:57:15.207792 End time: 2026-09-18 05:57:16.155401
18-Sep-2026 05:57:16 2026-09-18 05:57:16        INFO        plotms::::casa        ##### End Task: plotms               #####
18-Sep-2026 05:57:16 2026-09-18 05:57:16        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:16 2026-09-18 05:57:16        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:16 2026-09-18 05:57:16        INFO        plotms::::casa        ##### Begin Task: plotms             #####
18-Sep-2026 05:57:18 2026-09-18 05:57:16        INFO        plotms::::casa        plotms( vis='cal-X54.B1', caltable='', gridrows=4, gridcols=3, rowindex=0, colindex=0, plotindex=0, xaxis='freq', xdatacolumn='', xframe='', xinterp='', yaxis='phase', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='3', 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, -70.0, 70.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-X54-phase.spw3.B1.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 )
18-Sep-2026 05:57:18
18-Sep-2026 05:57:18 2026-09-18 05:57:17        INFO        plotms::::casa        Exporting the plot to /home/casatest/work/test_regression_alma_M100_if_mpi/cal-X54-phase.spw3.B1.png
18-Sep-2026 05:57:18 NOTICE: Exporting to images in screen resolution is currently not working.  Switching to high resolution (which is slower, but works).
18-Sep-2026 05:57:18 2026-09-18 05:57:17        INFO        plotms::::casa        Task plotms complete. Start time: 2026-09-18 05:57:16.158510 End time: 2026-09-18 05:57:17.222945
18-Sep-2026 05:57:18 2026-09-18 05:57:17        INFO        plotms::::casa        ##### End Task: plotms               #####
18-Sep-2026 05:57:18 2026-09-18 05:57:17        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:18 2026-09-18 05:57:17        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:18 2026-09-18 05:57:17        INFO        plotms::::casa        ##### Begin Task: plotms             #####
18-Sep-2026 05:57:18 2026-09-18 05:57:17        INFO        plotms::::casa        plotms( vis='cal-X54.B1', caltable='', gridrows=4, gridcols=3, rowindex=0, colindex=0, plotindex=0, xaxis='freq', xdatacolumn='', xframe='', xinterp='', yaxis='amp', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='3', 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=[], 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-X54-amplitude.spw3.B1.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 )
18-Sep-2026 05:57:18
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        plotms::::casa        Exporting the plot to /home/casatest/work/test_regression_alma_M100_if_mpi/cal-X54-amplitude.spw3.B1.png
18-Sep-2026 05:57:18 NOTICE: Exporting to images in screen resolution is currently not working.  Switching to high resolution (which is slower, but works).
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        plotms::::casa        Task plotms complete. Start time: 2026-09-18 05:57:17.225962 End time: 2026-09-18 05:57:18.173708
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        plotms::::casa        ##### End Task: plotms               #####
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        bandpass::::casa        ##########################################
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        bandpass::::casa        ##### Begin Task: bandpass           #####
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        bandpass::::casa        bandpass( vis='X220-line-vs.ms', caltable='cal-X220.B1', field='*Bandpass*', spw='', intent='', selectdata=False, timerange='', uvrange='', antenna='', scan='', observation='', msselect='', solint='inf', combine='', refant='DV01', minblperant=4, minsnr=3.0, solnorm=True, bandtype='B', smodel=[], corrdepflags=False, append=False, fillgaps=10, degamp=3, degphase=3, visnorm=False, maskcenter=0, maskedge=5, docallib=False, callib='', gaintable=['cal-X220-BPint.Gp'], gainfield=[], interp=[], spwmap=[], parang=False )
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        bandpass::calibrater::open        ****Using NEW VI2-driven calibrater tool****
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        bandpass::calibrater::open        Opening MS: X220-line-vs.ms for calibration.
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        bandpass::Calibrater::        Initializing nominal selection to the whole MS.
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        bandpass::calibrater::reset        Reseting solve/apply state
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        bandpass::::casa        NB: bandpass automatically excludes auto-correlations.
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        calibrater::reset        Reseting solve/apply state
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        Calibrater::selectvis+         Selecting on field: '*Bandpass*'
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1!=ANTENNA2'
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        Calibrater::selectvis        By selection 194740 rows are reduced to 9360
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1!=ANTENNA2'
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        calibrater::setapply        Beginning setapply--(MSSelection version)-------
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        Calibrater::setapply(type, applypar)        Arranging to APPLY:
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        Calibrater::setapply(type, applypar)        .   G Jones: table=cal-X220-BPint.Gp select= interp=linear spwmap=[-1] calWt=true
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        Calibrater::setsolve        Arranging to SOLVE:
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        Calibrater::setsolve        .   B Jones: table=cal-X220.B1 append=false solint=inf,none refantmode='flex' refant='DV01' minsnr=3 apmode=AP solnorm=true normtype=MEAN
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        calibrater::solve        Beginning solve-----------------------------
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        Calibrater::solve        .   G Jones: table=cal-X220-BPint.Gp select= interp=linear spwmap=[-1] calWt=true
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        Calibrater::solve        The following calibration term is arranged for solve:
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        Calibrater::solve        .   B Jones: table=cal-X220.B1 append=false solint=inf,none refantmode='flex' refant='DV01' minsnr=3 apmode=AP solnorm=true normtype=MEAN
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
18-Sep-2026 05:57:18 2026-09-18 05:57:18        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=480) has centroid freq = 114663675000
18-Sep-2026 05:57:20 2026-09-18 05:57:18        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=480) has centroid freq = 112788675000
18-Sep-2026 05:57:20 2026-09-18 05:57:18        INFO        FreqMetaData::calcFreqMeta         Selected spw=2 (nchan=480) has centroid freq = 102726175000
18-Sep-2026 05:57:20 2026-09-18 05:57:18        INFO        FreqMetaData::calcFreqMeta         Selected spw=3 (nchan=480) has centroid freq = 100913675000
18-Sep-2026 05:57:20 2026-09-18 05:57:18        INFO        Calibrater::solve        For solint = inf, found 4 solution intervals.
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=0 chan=479)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=0 chan=478)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=0 chan=477)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=0 chan=476)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=0 chan=475)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=0 chan=0)
18-Sep-2026 05:57:20 2026-09-18 05:57:19        INFO        Calibrater::solve        Beginning solution interval 1/4 (~25% complete)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=1 chan=479)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=1 chan=478)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=1 chan=477)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=1 chan=476)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=1 chan=475)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=1 chan=0)
18-Sep-2026 05:57:20 2026-09-18 05:57:19        INFO        Calibrater::solve        Beginning solution interval 2/4 (~50% complete)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=2 chan=479)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=2 chan=478)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=2 chan=477)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=2 chan=476)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=2 chan=475)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=2 chan=0)
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO        Calibrater::solve        Beginning solution interval 3/4 (~75% complete)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=3 chan=479)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=3 chan=478)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=3 chan=477)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=3 chan=476)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=3 chan=475)
18-Sep-2026 05:57:20 Insufficient unflagged antennas to proceed with this solve.
18-Sep-2026 05:57:20    (time=2011/09/10/19:52:50.1 field=2 spw=3 chan=0)
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO        Calibrater::solve          Found good B Jones solutions in 4 solution intervals.
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                Applying refant: DV01 refantmode = flex (hold alternate refants' phase constant) when refant flagged
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                Normalizing solutions per spw, time, ant, pol with MEAN in amplitude (and center channel in phase).
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=1 pol 0 = 0.458879, -7.59334e-09deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=1 pol 1 = 0.446874, -1.63753e-08deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=2 pol 0 = 0.472091, -7.07252deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=2 pol 1 = 0.465778, -11.2709deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=3 pol 0 = 0.464365, -5.00186deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=3 pol 1 = 0.456828, -6.61909deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=4 pol 0 = 0.448378, -3.73834deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=4 pol 1 = 0.468178, -7.47914deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=5 pol 0 = 0.469532, -6.34317deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=5 pol 1 = 0.459149, -11.294deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=6 pol 0 = 0.437244, -4.16527deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=6 pol 1 = 0.424333, -11.0203deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=7 pol 0 = 0.462797, -5.7366deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=7 pol 1 = 0.461357, -11.4665deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=8 pol 0 = 0.4668, -10.7247deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=8 pol 1 = 0.446526, -11.1303deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=9 pol 0 = 0.464022, -5.75401deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=9 pol 1 = 0.463875, -10.4768deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=10 pol 0 = 0.467441, -4.10679deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=10 pol 1 = 0.456876, -8.31366deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=11 pol 0 = 0.447925, -1.88316deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=11 pol 1 = 0.435315, -7.48728deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=12 pol 0 = 0.46492, -10.0009deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=0 time=2011/09/10/19:52:50.1 ant=12 pol 1 = 0.455011, -9.85742deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=1 pol 0 = 0.45787, 4.67895e-09deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=1 pol 1 = 0.448251, 6.99664e-11deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=2 pol 0 = 0.469755, -4.89525deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=2 pol 1 = 0.467665, 2.34898deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=3 pol 0 = 0.461821, -3.42914deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=3 pol 1 = 0.454225, -1.5031deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=4 pol 0 = 0.460566, -1.54879deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=4 pol 1 = 0.463361, 0.154435deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=5 pol 0 = 0.466533, -1.4887deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=5 pol 1 = 0.457433, 0.727029deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=6 pol 0 = 0.43794, -4.46289deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=6 pol 1 = 0.422738, 0.922158deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=7 pol 0 = 0.458886, -1.35941deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=7 pol 1 = 0.463605, 1.58678deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=8 pol 0 = 0.469255, -5.05808deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=8 pol 1 = 0.451386, 1.78636deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=9 pol 0 = 0.455888, -1.18502deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=9 pol 1 = 0.458981, 2.53566deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=10 pol 0 = 0.466433, 0.932572deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=10 pol 1 = 0.452266, 6.15966deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=11 pol 0 = 0.442932, -1.95863deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=11 pol 1 = 0.43182, 0.988217deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=12 pol 0 = 0.466065, -5.43296deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=1 time=2011/09/10/19:52:50.1 ant=12 pol 1 = 0.457678, -2.60541deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=1 pol 0 = 0.470482, 3.95502e-09deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=1 pol 1 = 0.460059, -9.86533e-09deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=2 pol 0 = 0.484803, 4.66884deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=2 pol 1 = 0.476136, 0.314193deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=3 pol 0 = 0.472851, 2.80963deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=3 pol 1 = 0.465379, 2.58399deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=4 pol 0 = 0.480952, 1.30384deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=4 pol 1 = 0.469112, 3.61355deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=5 pol 0 = 0.481217, 0.894661deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=5 pol 1 = 0.471632, 3.36522deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=6 pol 0 = 0.447146, 1.31886deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=6 pol 1 = 0.43818, 1.26789deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=7 pol 0 = 0.478124, -0.655177deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=7 pol 1 = 0.470307, 2.06544deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=8 pol 0 = 0.473763, 3.949deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=8 pol 1 = 0.469492, 3.06315deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=9 pol 0 = 0.480584, -0.562684deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=9 pol 1 = 0.469903, -1.89723deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=10 pol 0 = 0.477051, -3.22166deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=10 pol 1 = 0.469702, -0.130825deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=11 pol 0 = 0.461861, 2.74154deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=11 pol 1 = 0.450673, 3.98813deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=12 pol 0 = 0.484881, 4.91108deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=2 time=2011/09/10/19:52:50.1 ant=12 pol 1 = 0.474038, 1.62748deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=1 pol 0 = 0.477791, 2.90572e-09deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=1 pol 1 = 0.472076, 3.03998e-09deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=2 pol 0 = 0.485178, 3.16372deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=2 pol 1 = 0.476101, 2.70424deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=3 pol 0 = 0.476606, 0.808794deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=3 pol 1 = 0.467583, 1.08546deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=4 pol 0 = 0.472099, 1.21968deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=4 pol 1 = 0.463979, 3.66178deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=5 pol 0 = 0.487977, 3.3401deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=5 pol 1 = 0.473536, 3.56672deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=6 pol 0 = 0.453454, -0.142656deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=6 pol 1 = 0.441755, 7.01451deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=7 pol 0 = 0.483299, 0.749704deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=7 pol 1 = 0.467358, 2.60012deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=8 pol 0 = 0.480091, 2.00005deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=8 pol 1 = 0.474662, 4.91826deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=9 pol 0 = 0.484332, 3.96448deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=9 pol 1 = 0.478909, 5.02591deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=10 pol 0 = 0.48098, 6.35889deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=10 pol 1 = 0.477666, 3.65175deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=11 pol 0 = 0.470766, -0.926194deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=11 pol 1 = 0.463256, 1.15873deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=12 pol 0 = 0.482712, 1.88785deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                 Normalization factor (MEAN) for spw=3 time=2011/09/10/19:52:50.1 ant=12 pol 1 = 0.47593, 3.5551deg
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                Filling in flagged solution channels by interpolation.
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                Normalizing solutions per spw, pol, ant, time.
18-Sep-2026 05:57:20 2026-09-18 05:57:20        INFO                Writing solutions to table: cal-X220.B1
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9    ANT: 10    ANT: 11    ANT: 12   
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        Calibrater::solve        SPW: 0 [0, 0]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        Calibrater::solve        SPW: 1 [0, 0]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        Calibrater::solve        SPW: 2 [0, 0]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        Calibrater::solve        SPW: 3 [0, 0]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]  [1, 1]
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        Calibrater::solve        ----- PER SPW INFO -----
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        Calibrater::solve        SPW: 0 [1, 1]  [1, 1]        [1, 1]            [1, 1]
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        Calibrater::solve        SPW: 1 [1, 1]  [1, 1]        [1, 1]            [1, 1]
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        Calibrater::solve        SPW: 2 [1, 1]  [1, 1]        [1, 1]            [1, 1]
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        Calibrater::solve        SPW: 3 [1, 1]  [1, 1]        [1, 1]            [1, 1]
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        Calibrater::solve        ----- GLOBAL INFO -----
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        Calibrater::solve        [4, 4]  [4, 4]        [4, 4]            [4, 4]
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        calibrater::solve        Finished solving.
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        bandpass::::casa        Task bandpass complete. Start time: 2026-09-18 05:57:18.190302 End time: 2026-09-18 05:57:20.456095
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        bandpass::::casa        ##### End Task: bandpass             #####
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        bandpass::::casa        ##########################################
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        plotms::::casa        ##### Begin Task: plotms             #####
18-Sep-2026 05:57:22 2026-09-18 05:57:20        INFO        plotms::::casa        plotms( vis='cal-X220.B1', caltable='', gridrows=4, gridcols=3, rowindex=0, colindex=0, plotindex=0, xaxis='freq', xdatacolumn='', xframe='', xinterp='', yaxis='phase', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='0', 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, -70.0, 70.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-X220-phase.spw0.B1.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 )
18-Sep-2026 05:57:22
18-Sep-2026 05:57:22 2026-09-18 05:57:21        INFO        plotms::::casa        Exporting the plot to /home/casatest/work/test_regression_alma_M100_if_mpi/cal-X220-phase.spw0.B1.png
18-Sep-2026 05:57:22 NOTICE: Exporting to images in screen resolution is currently not working.  Switching to high resolution (which is slower, but works).
18-Sep-2026 05:57:22 2026-09-18 05:57:22        INFO        plotms::::casa        Task plotms complete. Start time: 2026-09-18 05:57:20.466471 End time: 2026-09-18 05:57:21.533301
18-Sep-2026 05:57:22 2026-09-18 05:57:22        INFO        plotms::::casa        ##### End Task: plotms               #####
18-Sep-2026 05:57:22 2026-09-18 05:57:22        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:22 2026-09-18 05:57:22        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:22 2026-09-18 05:57:22        INFO        plotms::::casa        ##### Begin Task: plotms             #####
18-Sep-2026 05:57:22 2026-09-18 05:57:22        INFO        plotms::::casa        plotms( vis='cal-X220.B1', caltable='', gridrows=4, gridcols=3, rowindex=0, colindex=0, plotindex=0, xaxis='freq', xdatacolumn='', xframe='', xinterp='', yaxis='amp', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='0', 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=[], 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-X220-amplitude.spw0.B1.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 )
18-Sep-2026 05:57:22
18-Sep-2026 05:57:22 2026-09-18 05:57:22        INFO        plotms::::casa        Exporting the plot to /home/casatest/work/test_regression_alma_M100_if_mpi/cal-X220-amplitude.spw0.B1.png
18-Sep-2026 05:57:22 NOTICE: Exporting to images in screen resolution is currently not working.  Switching to high resolution (which is slower, but works).
18-Sep-2026 05:57:22 2026-09-18 05:57:22        INFO        plotms::::casa        Task plotms complete. Start time: 2026-09-18 05:57:21.536305 End time: 2026-09-18 05:57:22.479316
18-Sep-2026 05:57:22 2026-09-18 05:57:22        INFO        plotms::::casa        ##### End Task: plotms               #####
18-Sep-2026 05:57:22 2026-09-18 05:57:22        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:22 2026-09-18 05:57:22        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:22 2026-09-18 05:57:22        INFO        plotms::::casa        ##### Begin Task: plotms             #####
18-Sep-2026 05:57:25 2026-09-18 05:57:22        INFO        plotms::::casa        plotms( vis='cal-X220.B1', caltable='', gridrows=4, gridcols=3, rowindex=0, colindex=0, plotindex=0, xaxis='freq', xdatacolumn='', xframe='', xinterp='', yaxis='phase', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='1', 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, -70.0, 70.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-X220-phase.spw1.B1.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 )
18-Sep-2026 05:57:25
18-Sep-2026 05:57:25 2026-09-18 05:57:23        INFO        plotms::::casa        Exporting the plot to /home/casatest/work/test_regression_alma_M100_if_mpi/cal-X220-phase.spw1.B1.png
18-Sep-2026 05:57:25 NOTICE: Exporting to images in screen resolution is currently not working.  Switching to high resolution (which is slower, but works).
18-Sep-2026 05:57:25 2026-09-18 05:57:24        INFO        plotms::::casa        Task plotms complete. Start time: 2026-09-18 05:57:22.482396 End time: 2026-09-18 05:57:23.545688
18-Sep-2026 05:57:25 2026-09-18 05:57:24        INFO        plotms::::casa        ##### End Task: plotms               #####
18-Sep-2026 05:57:25 2026-09-18 05:57:24        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:25 2026-09-18 05:57:24        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:25 2026-09-18 05:57:24        INFO        plotms::::casa        ##### Begin Task: plotms             #####
18-Sep-2026 05:57:25 2026-09-18 05:57:24        INFO        plotms::::casa        plotms( vis='cal-X220.B1', caltable='', gridrows=4, gridcols=3, rowindex=0, colindex=0, plotindex=0, xaxis='freq', xdatacolumn='', xframe='', xinterp='', yaxis='amp', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='1', 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=[], 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-X220-amplitude.spw1.B1.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 )
18-Sep-2026 05:57:25
18-Sep-2026 05:57:25 2026-09-18 05:57:24        INFO        plotms::::casa        Exporting the plot to /home/casatest/work/test_regression_alma_M100_if_mpi/cal-X220-amplitude.spw1.B1.png
18-Sep-2026 05:57:25 NOTICE: Exporting to images in screen resolution is currently not working.  Switching to high resolution (which is slower, but works).
18-Sep-2026 05:57:25 2026-09-18 05:57:24        INFO        plotms::::casa        Task plotms complete. Start time: 2026-09-18 05:57:23.548681 End time: 2026-09-18 05:57:24.499259
18-Sep-2026 05:57:25 2026-09-18 05:57:24        INFO        plotms::::casa        ##### End Task: plotms               #####
18-Sep-2026 05:57:25 2026-09-18 05:57:24        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:25 2026-09-18 05:57:25        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:25 2026-09-18 05:57:25        INFO        plotms::::casa        ##### Begin Task: plotms             #####
18-Sep-2026 05:57:25 2026-09-18 05:57:25        INFO        plotms::::casa        plotms( vis='cal-X220.B1', caltable='', gridrows=4, gridcols=3, rowindex=0, colindex=0, plotindex=0, xaxis='freq', xdatacolumn='', xframe='', xinterp='', yaxis='phase', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='2', 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, -70.0, 70.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-X220-phase.spw2.B1.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 )
18-Sep-2026 05:57:25
18-Sep-2026 05:57:25 2026-09-18 05:57:25        INFO        plotms::::casa        Exporting the plot to /home/casatest/work/test_regression_alma_M100_if_mpi/cal-X220-phase.spw2.B1.png
18-Sep-2026 05:57:25 NOTICE: Exporting to images in screen resolution is currently not working.  Switching to high resolution (which is slower, but works).
18-Sep-2026 05:57:25 2026-09-18 05:57:26        INFO        plotms::::casa        Task plotms complete. Start time: 2026-09-18 05:57:24.502366 End time: 2026-09-18 05:57:25.566568
18-Sep-2026 05:57:25 2026-09-18 05:57:26        INFO        plotms::::casa        ##### End Task: plotms               #####
18-Sep-2026 05:57:25 2026-09-18 05:57:26        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:25 2026-09-18 05:57:26        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:25 2026-09-18 05:57:26        INFO        plotms::::casa        ##### Begin Task: plotms             #####
18-Sep-2026 05:57:28 2026-09-18 05:57:26        INFO        plotms::::casa        plotms( vis='cal-X220.B1', caltable='', gridrows=4, gridcols=3, rowindex=0, colindex=0, plotindex=0, xaxis='freq', xdatacolumn='', xframe='', xinterp='', yaxis='amp', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='2', 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=[], 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-X220-amplitude.spw2.B1.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 )
18-Sep-2026 05:57:28
18-Sep-2026 05:57:28 2026-09-18 05:57:26        INFO        plotms::::casa        Exporting the plot to /home/casatest/work/test_regression_alma_M100_if_mpi/cal-X220-amplitude.spw2.B1.png
18-Sep-2026 05:57:28 NOTICE: Exporting to images in screen resolution is currently not working.  Switching to high resolution (which is slower, but works).
18-Sep-2026 05:57:28 2026-09-18 05:57:27        INFO        plotms::::casa        Task plotms complete. Start time: 2026-09-18 05:57:25.569590 End time: 2026-09-18 05:57:26.518067
18-Sep-2026 05:57:28 2026-09-18 05:57:27        INFO        plotms::::casa        ##### End Task: plotms               #####
18-Sep-2026 05:57:28 2026-09-18 05:57:27        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:28 2026-09-18 05:57:27        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:28 2026-09-18 05:57:27        INFO        plotms::::casa        ##### Begin Task: plotms             #####
18-Sep-2026 05:57:28 2026-09-18 05:57:27        INFO        plotms::::casa        plotms( vis='cal-X220.B1', caltable='', gridrows=4, gridcols=3, rowindex=0, colindex=0, plotindex=0, xaxis='freq', xdatacolumn='', xframe='', xinterp='', yaxis='phase', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='3', 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, -70.0, 70.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-X220-phase.spw3.B1.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 )
18-Sep-2026 05:57:28
18-Sep-2026 05:57:28 2026-09-18 05:57:27        INFO        plotms::::casa        Exporting the plot to /home/casatest/work/test_regression_alma_M100_if_mpi/cal-X220-phase.spw3.B1.png
18-Sep-2026 05:57:28 NOTICE: Exporting to images in screen resolution is currently not working.  Switching to high resolution (which is slower, but works).
18-Sep-2026 05:57:28 2026-09-18 05:57:28        INFO        plotms::::casa        Task plotms complete. Start time: 2026-09-18 05:57:26.521095 End time: 2026-09-18 05:57:27.588483
18-Sep-2026 05:57:28 2026-09-18 05:57:28        INFO        plotms::::casa        ##### End Task: plotms               #####
18-Sep-2026 05:57:28 2026-09-18 05:57:28        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:28 2026-09-18 05:57:28        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:28 2026-09-18 05:57:28        INFO        plotms::::casa        ##### Begin Task: plotms             #####
18-Sep-2026 05:57:28 2026-09-18 05:57:28        INFO        plotms::::casa        plotms( vis='cal-X220.B1', caltable='', gridrows=4, gridcols=3, rowindex=0, colindex=0, plotindex=0, xaxis='freq', xdatacolumn='', xframe='', xinterp='', yaxis='amp', ydatacolumn='', yframe='', yinterp='', yaxislocation='', selectdata=True, field='', spw='3', 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=[], 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-X220-amplitude.spw3.B1.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 )
18-Sep-2026 05:57:28
18-Sep-2026 05:57:28 2026-09-18 05:57:28        INFO        plotms::::casa        Exporting the plot to /home/casatest/work/test_regression_alma_M100_if_mpi/cal-X220-amplitude.spw3.B1.png
18-Sep-2026 05:57:28 NOTICE: Exporting to images in screen resolution is currently not working.  Switching to high resolution (which is slower, but works).
18-Sep-2026 05:57:28 2026-09-18 05:57:29        INFO        plotms::::casa        Task plotms complete. Start time: 2026-09-18 05:57:27.591464 End time: 2026-09-18 05:57:28.543816
18-Sep-2026 05:57:28 2026-09-18 05:57:29        INFO        plotms::::casa        ##### End Task: plotms               #####
18-Sep-2026 05:57:28 2026-09-18 05:57:29        INFO        plotms::::casa        ##########################################
18-Sep-2026 05:57:28 2026-09-18 05:57:29        WARN        TIMING::::casa        Step 12: Bandpass
18-Sep-2026 05:57:28 2026-09-18 05:57:29        WARN        TIMING::::casa        Time now: 1789711048.5439734
18-Sep-2026 05:57:28 2026-09-18 05:57:29        WARN        TIMING::::casa        Time used this step: 20.718679189682007
18-Sep-2026 05:57:28 2026-09-18 05:57:29        WARN        TIMING::::casa        Total time used so far: 506.2859513759613
18-Sep-2026 05:57:28 2026-09-18 05:57:29        WARN        TIMING::::casa        Step  Time used (s)     Fraction of total time (percent) [description]
18-Sep-2026 05:57:28 2026-09-18 05:57:29        WARN        TIMING::::casa          0   123.43224310874939  24.37994630767272 [Data import]
18-Sep-2026 05:57:28 2026-09-18 05:57:29        WARN        TIMING::::casa          1   0.598240852355957  0.11816264123665388 [Generate antenna position cal tables]
18-Sep-2026 05:57:28 2026-09-18 05:57:29        WARN        TIMING::::casa          2   10.415772676467896  2.0572904794534344 [Generate tsys cal tables]
18-Sep-2026 05:57:28 2026-09-18 05:57:29        WARN        TIMING::::casa          3   5.63817834854126  1.1136351568156435 [Correct the Titan position]
18-Sep-2026 05:57:28 2026-09-18 05:57:29        WARN        TIMING::::casa          4   9.69564938545227  1.9150540043826751 [Apriori flagging]
18-Sep-2026 05:57:29 2026-09-18 05:57:29        WARN        TIMING::::casa          5   33.62544226646423  6.641591016910208 [Generate WVR cal tables]
18-Sep-2026 05:57:29 2026-09-18 05:57:29        WARN        TIMING::::casa          6   37.3748140335083  7.382155071048822 [Generate delay calibration tables]
18-Sep-2026 05:57:29
18-Sep-2026 05:57:29 2026-09-18 05:57:29        WARN        TIMING::::casa          7   178.60818934440613  35.278124715685436 [Apply antpos, wvr, tsys, and delay cal tables]
18-Sep-2026 05:57:29 2026-09-18 05:57:29        WARN        TIMING::::casa          8   47.118454694747925  9.30668816045389 [Split off non-wvr spws and save flags]
18-Sep-2026 05:57:29 2026-09-18 05:57:29        WARN        TIMING::::casa          9   6.167239189147949  1.218133580911519 [Flagging]
18-Sep-2026 05:57:29 2026-09-18 05:57:29        WARN        TIMING::::casa          10   27.59984254837036  5.451433616390252 [Rebin to a reduced resolution of approx. 10 km/s]
18-Sep-2026 05:57:29 2026-09-18 05:57:29        WARN        TIMING::::casa          11   5.293205738067627  1.0454972577615456 [Fast phase-only gaincal for bandpass]
18-Sep-2026 05:57:29 2026-09-18 05:57:29        WARN        TIMING::::casa          12   20.718679189682007  4.092287991277203 [Bandpass]
18-Sep-2026 05:57:29 Step 13: Setjy
18-Sep-2026 05:57:29 2026-09-18 05:57:29        INFO        flagmanager::::casa        ##########################################
18-Sep-2026 05:57:29 2026-09-18 05:57:29        INFO        flagmanager::::casa        ##### Begin Task: flagmanager        #####
18-Sep-2026 05:57:29 2026-09-18 05:57:29        INFO        flagmanager::::casa        flagmanager( vis='X54-line-vs.ms', mode='restore', versionname='apriori', oldname='', comment='', merge='replace' )
18-Sep-2026 05:57:29 2026-09-18 05:57:29        INFO        flagmanager::AgentFlagger::open        Table type is Measurement Set
18-Sep-2026 05:57:29 2026-09-18 05:57:29        INFO        flagmanager::::casa        Restore flagversions apriori
18-Sep-2026 05:57:29 2026-09-18 05:57:29        INFO        flagmanager::::casa        Task flagmanager complete. Start time: 2026-09-18 05:57:28.544620 End time: 2026-09-18 05:57:28.899659
18-Sep-2026 05:57:29 2026-09-18 05:57:29        INFO        flagmanager::::casa        ##### End Task: flagmanager          #####
18-Sep-2026 05:57:29 2026-09-18 05:57:29        INFO        flagmanager::::casa        ##########################################
18-Sep-2026 05:57:29 2026-09-18 05:57:29        INFO        flagdata::::casa        ##########################################
18-Sep-2026 05:57:29 2026-09-18 05:57:29        INFO        flagdata::::casa        ##### Begin Task: flagdata           #####
18-Sep-2026 05:57:29 2026-09-18 05:57:29        INFO        flagdata::::casa        flagdata( vis='X54-line-vs.ms', mode='manual', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='', field='Titan', antenna='', uvrange='0~40', timerange='', correlation='', scan='', intent='', array='', observation='', feed='', clipminmax=[], datacolumn='DATA', clipoutside=True, channelavg=False, chanbin=1, timeavg=False, timebin='0s', clipzeros=False, quackinterval=1.0, quackmode='beg', quackincrement=False, tolerance=0.0, addantenna='', lowerlimit=0.0, upperlimit=90.0, ntime='scan', combinescans=False, timecutoff=4.0, freqcutoff=3.0, timefit='line', freqfit='poly', maxnpieces=7, flagdimension='freqtime', usewindowstats='none', halfwin=1, extendflags=True, winsize=3, timedev='', freqdev='', timedevscale=5.0, freqdevscale=5.0, spectralmax=1000000.0, spectralmin=0.0, antint_ref_antenna='', minchanfrac=0.6, verbose=False, extendpols=True, growtime=50.0, growfreq=50.0, growaround=False, flagneartime=False, flagnearfreq=False, minrel=0.0, maxrel=1.0, minabs=0, maxabs=-1, spwchan=False, spwcorr=False, basecnt=False, fieldcnt=False, name='Summary', action='apply', display='', flagbackup=False, savepars=False, cmdreason='', outfile='', overwrite=True, writeflags=True )
18-Sep-2026 05:57:29 2026-09-18 05:57:29        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
18-Sep-2026 05:57:29 2026-09-18 05:57:29        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
18-Sep-2026 05:57:29 2026-09-18 05:57:29        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
18-Sep-2026 05:57:29 2026-09-18 05:57:29        INFO        flagdata::::casa        Task flagdata complete. Start time: 2026-09-18 05:57:28.905850 End time: 2026-09-18 05:57:29.432200
18-Sep-2026 05:57:29 2026-09-18 05:57:29        INFO        flagdata::::casa        ##### End Task: flagdata             #####
18-Sep-2026 05:57:29 2026-09-18 05:57:29        INFO        flagdata::::casa        ##########################################
18-Sep-2026 05:57:29 2026-09-18 05:57:29        INFO        flagdata::::casa        ##########################################
18-Sep-2026 05:57:29 2026-09-18 05:57:29        INFO        flagdata::::casa        ##### Begin Task: flagdata           #####
18-Sep-2026 05:57:29 2026-09-18 05:57:29        INFO        flagdata::::casa        flagdata( vis='X54-line-vs.ms', mode='manual', autocorr=False, inpfile='', reason='any', tbuff=0.0, spw='0:200~479', field='Titan', antenna='', uvrange='', timerange='', correlation='', scan='', intent='', array='', observation='', feed='', clipminmax=[], datacolumn='DATA', clipoutside=True, channelavg=False, chanbin=1, timeavg=False, timebin='0s', clipzeros=False, quackinterval=1.0, quackmode='beg', quackincrement=False, tolerance=0.0, addantenna='', lowerlimit=0.0, upperlimit=90.0, ntime='scan', combinescans=False, timecutoff=4.0, freqcutoff=3.0, timefit='line', freqfit='poly', maxnpieces=7, flagdimension='freqtime', usewindowstats='none', halfwin=1, extendflags=True, winsize=3, timedev='', freqdev='', timedevscale=5.0, freqdevscale=5.0, spectralmax=1000000.0, spectralmin=0.0, antint_ref_antenna='', minchanfrac=0.6, verbose=False, extendpols=True, growtime=50.0, growfreq=50.0, growaround=False, flagneartime=False, flagnearfreq=False, minrel=0.0, maxrel=1.0, minabs=0, maxabs=-1, spwchan=False, spwcorr=False, basecnt=False, fieldcnt=False, name='Summary', action='apply', display='', flagbackup=False, savepars=False, cmdreason='', outfile='', overwrite=True, writeflags=True )
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa        Command request with id 74 failed in server n# 2 with traceback Traceback (most recent call last):
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/lib/python3.12/site-packages/casampi/private/MPICommandServer.py", line 213, in __command_request_handler_service
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            command_response['ret'] = eval(eval_str, globals(), locals())
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+                                      ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "<string>", line 1, in <module>
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/flagdata.py", line 1136, in __call__
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            task_result = _flagdata_t( _pc.document['vis'], _pc.document['mode'], _pc.document['autocorr'], _pc.document['inpfile'], _pc.document['reason'], _pc.document['tbuff'], _pc.document['spw'], _pc.document['field'], _pc.document['antenna'], _pc.document['uvrange'], _pc.document['timerange'], _pc.document['correlation'], _pc.document['scan'], _pc.document['intent'], _pc.document['array'], _pc.document['observation'], _pc.document['feed'], _pc.document['clipminmax'], _pc.document['datacolumn'], _pc.document['clipoutside'], _pc.document['channelavg'], _pc.document['chanbin'], _pc.document['timeavg'], _pc.document['timebin'], _pc.document['clipzeros'], _pc.document['quackinterval'], _pc.document['quackmode'], _pc.document['quackincrement'], _pc.document['tolerance'], _pc.document['addantenna'], _pc.document['lowerlimit'], _pc.document['upperlimit'], _pc.document['ntime'], _pc.document['combinescans'], _pc.document['timecutoff'], _pc.document['freqcutoff'], _pc.document['timefit'], _pc.document['freqfit'], _pc.document['maxnpieces'], _pc.document['flagdimension'], _pc.document['usewindowstats'], _pc.document['halfwin'], _pc.document['extendflags'], _pc.document['winsize'], _pc.document['timedev'], _pc.document['freqdev'], _pc.document['timedevscale'], _pc.document['freqdevscale'], _pc.document['spectralmax'], _pc.document['spectralmin'], _pc.document['antint_ref_antenna'], _pc.document['minchanfrac'], _pc.document['verbose'], _pc.document['extendpols'], _pc.document['growtime'], _pc.document['growfreq'], _pc.document['growaround'], _pc.document['flagneartime'], _pc.document['flagnearfreq'], _pc.document['minrel'], _pc.document['maxrel'], _pc.document['minabs'], _pc.document['maxabs'], _pc.document['spwchan'], _pc.document['spwcorr'], _pc.document['basecnt'], _pc.document['fieldcnt'], _pc.document['name'], _pc.document['action'], _pc.document['display'], _pc.document['flagbackup'], _pc.document['savepars'], _pc.document['cmdreason'], _pc.document['outfile'], _pc.document['overwrite'], _pc.document['writeflags'] )
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+                          ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/private/task_flagdata.py", line 618, in flagdata
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            aflocal.selectdata(field=field, spw=spw, array=array, feed=feed, scan=scan, \
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/lib/python3.12/site-packages/casatools/agentflagger.py", line 36, in selectdata
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return self._swigobj.selectdata(config, field, spw, array, feed, scan, antenna, uvrange, timerange, correlation, intent, observation)
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+                   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/lib/python3.12/site-packages/casatools/__casac__/agentflagger.py", line 197, in selectdata
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return _agentflagger.agentflagger_selectdata(self, *args, **kwargs)
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+                   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+        RuntimeError: MSSelectionNullSelection : The selected table has zero rows.
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa        Command request with id 75 failed in server n# 1 with traceback Traceback (most recent call last):
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/lib/python3.12/site-packages/casampi/private/MPICommandServer.py", line 213, in __command_request_handler_service
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            command_response['ret'] = eval(eval_str, globals(), locals())
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+                                      ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "<string>", line 1, in <module>
18-Sep-2026 05:57:29 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/flagdata.py", line 1136, in __call__
18-Sep-2026 05:57:31 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            task_result = _flagdata_t( _pc.document['vis'], _pc.document['mode'], _pc.document['autocorr'], _pc.document['inpfile'], _pc.document['reason'], _pc.document['tbuff'], _pc.document['spw'], _pc.document['field'], _pc.document['antenna'], _pc.document['uvrange'], _pc.document['timerange'], _pc.document['correlation'], _pc.document['scan'], _pc.document['intent'], _pc.document['array'], _pc.document['observation'], _pc.document['feed'], _pc.document['clipminmax'], _pc.document['datacolumn'], _pc.document['clipoutside'], _pc.document['channelavg'], _pc.document['chanbin'], _pc.document['timeavg'], _pc.document['timebin'], _pc.document['clipzeros'], _pc.document['quackinterval'], _pc.document['quackmode'], _pc.document['quackincrement'], _pc.document['tolerance'], _pc.document['addantenna'], _pc.document['lowerlimit'], _pc.document['upperlimit'], _pc.document['ntime'], _pc.document['combinescans'], _pc.document['timecutoff'], _pc.document['freqcutoff'], _pc.document['timefit'], _pc.document['freqfit'], _pc.document['maxnpieces'], _pc.document['flagdimension'], _pc.document['usewindowstats'], _pc.document['halfwin'], _pc.document['extendflags'], _pc.document['winsize'], _pc.document['timedev'], _pc.document['freqdev'], _pc.document['timedevscale'], _pc.document['freqdevscale'], _pc.document['spectralmax'], _pc.document['spectralmin'], _pc.document['antint_ref_antenna'], _pc.document['minchanfrac'], _pc.document['verbose'], _pc.document['extendpols'], _pc.document['growtime'], _pc.document['growfreq'], _pc.document['growaround'], _pc.document['flagneartime'], _pc.document['flagnearfreq'], _pc.document['minrel'], _pc.document['maxrel'], _pc.document['minabs'], _pc.document['maxabs'], _pc.document['spwchan'], _pc.document['spwcorr'], _pc.document['basecnt'], _pc.document['fieldcnt'], _pc.document['name'], _pc.document['action'], _pc.document['display'], _pc.document['flagbackup'], _pc.document['savepars'], _pc.document['cmdreason'], _pc.document['outfile'], _pc.document['overwrite'], _pc.document['writeflags'] )
18-Sep-2026 05:57:31 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+                          ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
18-Sep-2026 05:57:31 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/lib/python3.12/site-packages/casatasks/private/task_flagdata.py", line 618, in flagdata
18-Sep-2026 05:57:31 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            aflocal.selectdata(field=field, spw=spw, array=array, feed=feed, scan=scan, \
18-Sep-2026 05:57:31 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/lib/python3.12/site-packages/casatools/agentflagger.py", line 36, in selectdata
18-Sep-2026 05:57:31 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return self._swigobj.selectdata(config, field, spw, array, feed, scan, antenna, uvrange, timerange, correlation, intent, observation)
18-Sep-2026 05:57:31 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+                   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
18-Sep-2026 05:57:31 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+          File "/home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/lib/python3.12/site-packages/casatools/__casac__/agentflagger.py", line 197, in selectdata
18-Sep-2026 05:57:31 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+            return _agentflagger.agentflagger_selectdata(self, *args, **kwargs)
18-Sep-2026 05:57:31 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+                   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
18-Sep-2026 05:57:31 2026-09-18 05:57:30        SEVERE        MPICommandClient::command_response_handler_service::MPICommandClient::command_response_handler_service::casa+        RuntimeError: MSSelectionNullSelection : The selected table has zero rows.
18-Sep-2026 05:57:31 2026-09-18 05:57:30        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: {}
18-Sep-2026 05:57:31 2026-09-18 05:57:30        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: None
18-Sep-2026 05:57:31 2026-09-18 05:57:30        WARN        ParallelTaskHelper::consolidateResults::casa         ***** consolidateResults, subMS: None
18-Sep-2026 05:57:31 2026-09-18 05:57:30        INFO        flagdata::::casa        Task flagdata complete. Start time: 2026-09-18 05:57:29.438355 End time: 2026-09-18 05:57:30.077553
18-Sep-2026 05:57:31 2026-09-18 05:57:30        INFO        flagdata::::casa        ##### End Task: flagdata             #####
18-Sep-2026 05:57:31 2026-09-18 05:57:30        INFO        flagdata::::casa        ##########################################
18-Sep-2026 05:57:31 2026-09-18 05:57:30        INFO        setjy::::casa        ##########################################
18-Sep-2026 05:57:31 2026-09-18 05:57:30        INFO        setjy::::casa        ##### Begin Task: setjy              #####
18-Sep-2026 05:57:31 2026-09-18 05:57:30        INFO        setjy::::casa        setjy( vis='X54-line-vs.ms', field='Titan', spw='0,1,2,3', selectdata=False, timerange='', scan='', intent='', observation='', scalebychan=False, standard='Butler-JPL-Horizons 2012', model='', listmodels=False, fluxdensity=-1, spix=0.0, reffreq='1GHz', polindex=[], polangle=[], rotmeas=0.0, fluxdict={}, useephemdir=False, interpolation='nearest', usescratch=True, ismms=False )
18-Sep-2026 05:57:31 2026-09-18 05:57:31        SEVERE        Calibrater::initialize (file /source/casa6/casatools/src/code/synthesis/MeasurementComponents/Calibrater.cc, line 433)        Caught exception: Invalid Table operation: TableDesc::add; columns not disjoint
18-Sep-2026 05:57:31 2026-09-18 05:57:31        SEVERE                Exception Reported: Error in Calibrater::initialize()
18-Sep-2026 09:48:59 terminate called after throwing an instance of 'casacore::AipsError'
18-Sep-2026 09:48:59   what():  RegularFileIO: error in open or create of file /home/casatest/work/test_regression_alma_M100_if_mpi/X54-line-vs.ms/SUBMSS/X54-line-vs.ms.0001.ms/table.dat_tmp: No space left on device
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] *** Process received signal ***
18-Sep-2026 09:48:59 Traceback (most recent call last):
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] Signal: Aborted (6)
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] Signal code:  (-6)
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [ 0] /lib64/libpthread.so.0(+0x12990)[0x7f8f2c0bb990]
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [ 1] /lib64/libc.so.6(gsignal+0x10f)[0x7f8f2b59752f]
18-Sep-2026 09:48:59   File "/home/casatest/casa6/casatestutils/runtest.py", line 1483, in <module>
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [ 2] /lib64/libc.so.6(abort+0x127)[0x7f8f2b56ae65]
18-Sep-2026 09:48:59     atlassian_helper.run_bamboo(args.pkg, args.work_dir, fetch_tests,
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [ 3] /lib64/libstdc++.so.6(+0x9009b)[0x7f8f2828809b]
18-Sep-2026 09:48:59   File "/home/casatest/casa6/casatestutils/testrunner/atlassian_helper.py", line 260, in run_bamboo
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [ 4] /lib64/libstdc++.so.6(+0x9654c)[0x7f8f2828e54c]
18-Sep-2026 09:48:59     output, runtime = run_bamboo_test(r, cmd, test.timeout, cwd)
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [ 5] /lib64/libstdc++.so.6(+0x95569)[0x7f8f2828d569]
18-Sep-2026 09:48:59   File "/home/casatest/casa6/casatestutils/testrunner/atlassian_helper.py", line 303, in run_bamboo_test
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [ 6] /lib64/libstdc++.so.6(__gxx_personality_v0+0x2a8)[0x7f8f2828dee8]
18-Sep-2026 09:48:59     os.makedirs(cwd)
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [ 7] /lib64/libgcc_s.so.1(+0x10b03)[0x7f8f27ff0b03]
18-Sep-2026 09:48:59   File "/usr/local/lib/python3.10/os.py", line 225, in makedirs
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [ 8] /lib64/libgcc_s.so.1(_Unwind_Resume+0x12d)[0x7f8f27ff141d]
18-Sep-2026 09:48:59     mkdir(name, mode)
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [ 9] /home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/lib/python3.12/site-packages/casatools/__casac__/lib/libcasa_tables.so.9(+0x2ccd7f)[0x7f8f1526fd7f]
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [10] /home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/lib/python3.12/site-packages/casatools/__casac__/lib/libcasa_tables.so.9(_ZN8casacore10PlainTable17doReleaseCallBackEb+0x2e)[0x7f8f1537b4ee]
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [11] /home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/lib/python3.12/site-packages/casatools/__casac__/lib/libcasa_tables.so.9(_ZN8casacore13TableLockData7releaseEb+0x48)[0x7f8f15406fb8]
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [12] /home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/lib/python3.12/site-packages/casatools/__casac__/lib/libcasa_tables.so.9(_ZN8casacore10PlainTable11closeObjectEv+0x128)[0x7f8f1537b018]
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [13] /home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/lib/python3.12/site-packages/casatools/__casac__/lib/libcasa_tables.so.9(_ZN8casacore10PlainTableD1Ev+0x7d)[0x7f8f1537b0bd]
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [14] /home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/lib/python3.12/site-packages/casatools/__casac__/lib/libcasa_tables.so.9(_ZN8casacore5TableD1Ev+0x4a)[0x7f8f153e0f0a]
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [15] /home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/lib/python3.12/site-packages/casatools/__casac__/lib/libcasa_ms.so.9(_ZN8casacore14MeasurementSetD0Ev+0x9)[0x7f8f1410eb09]
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [16] /home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/lib/python3.12/site-packages/casatools/__casac__/_calibrater.cpython-312-x86_64-linux-gnu.so(_ZN5casac10calibraterD1Ev+0x17)[0x7f8f0ce53d67]
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [17] /home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/lib/python3.12/site-packages/casatools/__casac__/_calibrater.cpython-312-x86_64-linux-gnu.so(+0x209b8)[0x7f8f0ce329b8]
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [18] /home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/bin/python3[0x539878]
18-Sep-2026 09:48:59 OSError: [Errno 28] No space left on device: '/home/casatest/work/test_regression_alma_M100_if'
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [19] /home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/bin/python3(_PyObject_MakeTpCall+0x6b)[0x5174fb]
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [20] /home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/bin/python3[0x517ec9]
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [21] /home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/bin/python3(PyObject_CallFunctionObjArgs+0x9f)[0x5a408f]
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [22] /home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/lib/python3.12/site-packages/casatools/__casac__/_calibrater.cpython-312-x86_64-linux-gnu.so(+0x1e540)[0x7f8f0ce30540]
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [23] /home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/bin/python3[0x535926]
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [24] /home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/bin/python3[0x546f56]
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [25] /home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/bin/python3[0x53807a]
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [26] /home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/bin/python3[0x546dad]
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [27] /home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/bin/python3[0x56baf0]
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [28] /home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/bin/python3[0x563f13]
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] [29] /home/casatest/work/pkg/casa-6.7.7-9-py3.12.el8/lib/py/bin/python3[0x4a073d]
18-Sep-2026 09:48:59 [4e87a00a3bb5:04763] *** End of error message ***
18-Sep-2026 09:48:59
18-Sep-2026 09:48:59 Failed tests:['Caught exception during test execution.']
18-Sep-2026 09:48:59
18-Sep-2026 09:48:59 Running test: test_regression_alma_M100_if in Serial mode
18-Sep-2026 09:48:59 Running cmd ['/home/casatest/work/pkg/casa-6.7.7-9-py3.12.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
18-Sep-2026 09:48:59 mv: cannot create directory '/dockershare/png_list': No space left on device
18-Sep-2026 09:49:00 find: './proc/319/task/319/net': Invalid argument
18-Sep-2026 09:49:00 find: './proc/319/net': Invalid argument
18-Sep-2026 09:49:00 find: './proc/320/task/320/net': Invalid argument
18-Sep-2026 09:49:00 find: './proc/320/net': Invalid argument
18-Sep-2026 09:49:00 find: './proc/321/task/321/net': Invalid argument
18-Sep-2026 09:49:00 find: './proc/321/net': Invalid argument
18-Sep-2026 09:49:00 find: './proc/1121/task/1121/net': Invalid argument
18-Sep-2026 09:49:00 find: './proc/1121/net': Invalid argument
18-Sep-2026 09:49:00 find: './proc/4799/task/4799/net': Invalid argument
18-Sep-2026 09:49:00 find: './proc/4799/net': Invalid argument
18-Sep-2026 09:49:00 find: './proc/4803/task/4803/net': Invalid argument
18-Sep-2026 09:49:00 find: './proc/4803/net': Invalid argument
18-Sep-2026 09:49:00 find: './proc/4807/task/4807/net': Invalid argument
18-Sep-2026 09:49:00 find: './proc/4807/net': Invalid argument
18-Sep-2026 09:49:00 find: './tmp/.mount_casaplPoAchK': Permission denied
18-Sep-2026 09:49:01 mv: cannot stat '/dockershare/xUnit-suite.xml': No such file or directory
18-Sep-2026 09:49:01 useradd: /etc/passwd.5229: No space left on device
18-Sep-2026 09:49:01 useradd: cannot lock /etc/passwd; try again later.
18-Sep-2026 09:49:01 chown: invalid user: 'casaci'
18-Sep-2026 09:49:01 total 779100
18-Sep-2026 09:49:01 -rw-r--r-- 1 9285 15001 797796912 Sep 18 05:29 casa-6.7.7-9-py3.12.el8.tar.xz
18-Sep-2026 09:49:01 Finished task 'Run casatests/regression scripts using a casalith' with result: Success
18-Sep-2026 09:49:01 Starting task 'Parse test results' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
18-Sep-2026 09:49:01 Parsing test results under /export/cvpost134-nvme/casa/bamboohome/xml-data/build-dir/CASASPECS-MASTERTESTCASALITHPY312-CRR85D...
18-Sep-2026 09:49:01 Failing task since test cases were expected but none were found.
18-Sep-2026 09:49:01 Finished task 'Parse test results' with result: Failed
18-Sep-2026 09:49:01 Running post build plugin 'Docker Container Cleanup'
18-Sep-2026 09:49:01 Running post build plugin 'NCover Results Collector'
18-Sep-2026 09:49:01 Running post build plugin 'Build Results Label Collector'
18-Sep-2026 09:49:01 Running post build plugin 'Clover Results Collector'
18-Sep-2026 09:49:01 Running post build plugin 'npm Cache Cleanup'
18-Sep-2026 09:49:01 Running post build plugin 'Artifact Copier'
18-Sep-2026 09:49:01 Publishing an artifact: Regression images
18-Sep-2026 09:49:01 Failing as no matching files has been found and empty artifacts are not allowed.
18-Sep-2026 09:49:01 Unable to publish artifact [Regression images]:
18-Sep-2026 09:49:01 The artifact hasn't been successfully published after 59.42 ms
18-Sep-2026 09:49:01 Finalising the build...
18-Sep-2026 09:49:01 Stopping timer.
18-Sep-2026 09:49:01 Build CASASPECS-MASTERTESTCASALITHPY312-CRR85D-294 completed.
18-Sep-2026 05:49:02 Running on server: post build plugin 'Build Hanging Detection Configuration'
18-Sep-2026 05:49:02 Running on server: post build plugin 'NCover Results Collector'
18-Sep-2026 05:49:02 Running on server: post build plugin 'Build Labeller'
18-Sep-2026 05:49:02 Running on server: post build plugin 'Clover Delta Calculator'
18-Sep-2026 05:49:02 Running on server: post build plugin 'Maven Dependencies Postprocessor'
18-Sep-2026 05:49:02 All post build plugins have finished
18-Sep-2026 05:49:02 Generating build results summary...
18-Sep-2026 05:49:02 Saving build results to disk...
18-Sep-2026 05:49:02 Store variable context...
18-Sep-2026 05:49:02 Finished building CASASPECS-MASTERTESTCASALITHPY312-CRR85D-294.