Build log

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

22-May-2026 10:13:05	2026-05-22 14:13:05        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
22-May-2026 10:13:05	2026-05-22 14:13:05        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
22-May-2026 10:13:05	2026-05-22 14:13:05        INFO        Calibrater::solve        For solint = inf, found 6 solution intervals.
22-May-2026 10:13:05	2026-05-22 14:13:05        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
22-May-2026 10:13:05	2026-05-22 14:13:05        INFO        Calibrater::solve        Beginning solution interval 1/6 (~16% complete)
22-May-2026 10:13:05	2026-05-22 14:13:05        INFO        Calibrater::solve        Beginning solution interval 2/6 (~33% complete)
22-May-2026 10:13:05	2026-05-22 14:13:05        INFO        Calibrater::solve        Beginning solution interval 3/6 (~50% complete)
22-May-2026 10:13:05	2026-05-22 14:13:05        INFO        Calibrater::solve        Beginning solution interval 4/6 (~66% complete)
22-May-2026 10:13:05	2026-05-22 14:13:05        INFO        Calibrater::solve        Beginning solution interval 5/6 (~83% complete)
22-May-2026 10:13:05	2026-05-22 14:13:05        INFO        Calibrater::solve          Found good Accor Jones solutions in 6 solution intervals.
22-May-2026 10:13:05	2026-05-22 14:13:05        INFO                Writing solutions to table: cal.B
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::solve        SPW: 0 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::solve        SPW: 1 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::solve        [0, 0]  [6, 6]        [0, 0]            [0, 0]
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        calibrater::solve        Finished solving.
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        accor::::casa        Task accor complete. Start time: 2026-05-22 14:13:04.995780 End time: 2026-05-22 14:13:06.615075
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        accor::::casa        ##### End Task: accor                #####
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        accor::::casa        ##########################################
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        accor::::casa        ##########################################
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        accor::::casa        ##### Begin Task: accor              #####
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        accor::::casa        accor( vis='VLBA_copy.ms', caltable='cal.A', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=['cal.B'], gainfield=[], interp=[], spwmap=[] )
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        accor::calibrater::open        Opening MS: VLBA_copy.ms for calibration.
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        calibrater::reset        Reseting solve/apply state
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::selectvis        By selection 34540 rows are reduced to 6280
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        calibrater::setapply        Beginning setapply--(MSSelection version)-------
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::setapply(type, applypar)        Arranging to APPLY:
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::setapply(type, applypar)        .   Accor Jones: table=cal.B select= interp=linear spwmap=[-1] calWt=true
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        calibrater::solve        Beginning solve-----------------------------
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::solve        .   Accor Jones: table=cal.B select= interp=linear spwmap=[-1] calWt=true
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::solve        For solint = inf, found 6 solution intervals.
22-May-2026 10:13:06	2026-05-22 14:13:07        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::solve        Beginning solution interval 1/6 (~16% complete)
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::solve        Beginning solution interval 2/6 (~33% complete)
22-May-2026 10:13:06	2026-05-22 14:13:07        INFO        Calibrater::solve        Beginning solution interval 3/6 (~50% complete)
22-May-2026 10:13:07	2026-05-22 14:13:07        INFO        Calibrater::solve        Beginning solution interval 4/6 (~66% complete)
22-May-2026 10:13:07	2026-05-22 14:13:07        INFO        Calibrater::solve        Beginning solution interval 5/6 (~83% complete)
22-May-2026 10:13:07	2026-05-22 14:13:07        INFO        Calibrater::solve          Found good Accor Jones solutions in 6 solution intervals.
22-May-2026 10:13:07	2026-05-22 14:13:07        INFO                Writing solutions to table: cal.A
22-May-2026 10:13:08	2026-05-22 14:13:08        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-May-2026 10:13:08	2026-05-22 14:13:08        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9
22-May-2026 10:13:08	2026-05-22 14:13:08        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:08	2026-05-22 14:13:08        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:08	2026-05-22 14:13:08        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-May-2026 10:13:08	2026-05-22 14:13:08        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:08	2026-05-22 14:13:08        INFO        Calibrater::solve        SPW: 0 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-May-2026 10:13:08	2026-05-22 14:13:08        INFO        Calibrater::solve        SPW: 1 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-May-2026 10:13:08	2026-05-22 14:13:08        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-May-2026 10:13:08	2026-05-22 14:13:08        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:08	2026-05-22 14:13:08        INFO        Calibrater::solve        [0, 0]  [6, 6]        [0, 0]            [0, 0]
22-May-2026 10:13:08	2026-05-22 14:13:08        INFO        calibrater::solve        Finished solving.
22-May-2026 10:13:08	2026-05-22 14:13:08        INFO        accor::::casa        Task accor complete. Start time: 2026-05-22 14:13:06.618912 End time: 2026-05-22 14:13:08.493661
22-May-2026 10:13:08	2026-05-22 14:13:08        INFO        accor::::casa        ##### End Task: accor                #####
22-May-2026 10:13:08	2026-05-22 14:13:08        INFO        accor::::casa        ##########################################
22-May-2026 10:13:08	2026-05-22 14:13:08        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:08	2026-05-22 14:13:08        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-May-2026 10:13:08	2026-05-22 14:13:08        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-May-2026 10:13:08	2026-05-22 14:13:08        INFO        rmtables::::casa        Removing cal.A
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-05-22 14:13:08.497650 End time: 2026-05-22 14:13:08.515862
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        rmtables::::casa        rmtables( tablenames=['cal.B'] )
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        rmtables::::casa        Removing cal.B
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-05-22 14:13:08.516909 End time: 2026-05-22 14:13:08.532733
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:08	.2026-05-22 14:13:09        INFO        accor::::casa        ##########################################
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        accor::::casa        ##### Begin Task: accor              #####
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        accor::::casa        accor( vis='uid_copy.ms', caltable='cal.A', field='', spw='', intent='*AMPLI*', selectdata=True, timerange='', antenna='', scan='', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        accor::calibrater::open        Opening MS: uid_copy.ms for calibration.
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        calibrater::reset        Reseting solve/apply state
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        Calibrater::selectvis+         Selecting on intent: '*AMPLI*'
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        Calibrater::selectvis        By selection 1080 rows are reduced to 180
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        calibrater::solve        Beginning solve-----------------------------
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        Calibrater::solve        .   (None)
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 84368488281.1505
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 86213458984.275
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        Calibrater::solve        For solint = inf, found 2 solution intervals.
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        Calibrater::solve        Beginning solution interval 1/2 (~50% complete)
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO        Calibrater::solve          Found good Accor Jones solutions in 2 solution intervals.
22-May-2026 10:13:08	2026-05-22 14:13:09        INFO                Writing solutions to table: cal.A
22-May-2026 10:13:09	2026-05-22 14:13:09        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-May-2026 10:13:09	2026-05-22 14:13:09        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2
22-May-2026 10:13:09	2026-05-22 14:13:09        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:09	2026-05-22 14:13:09        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:09	2026-05-22 14:13:09        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-May-2026 10:13:09	2026-05-22 14:13:09        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:09	2026-05-22 14:13:09        INFO        Calibrater::solve        SPW: 0 [0, 0]  [1, 1]        [0, 0]            [0, 0]
22-May-2026 10:13:09	2026-05-22 14:13:09        INFO        Calibrater::solve        SPW: 1 [0, 0]  [1, 1]        [0, 0]            [0, 0]
22-May-2026 10:13:09	2026-05-22 14:13:09        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-May-2026 10:13:09	2026-05-22 14:13:09        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:09	2026-05-22 14:13:09        INFO        Calibrater::solve        [0, 0]  [2, 2]        [0, 0]            [0, 0]
22-May-2026 10:13:09	2026-05-22 14:13:09        INFO        calibrater::solve        Finished solving.
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        accor::::casa        Task accor complete. Start time: 2026-05-22 14:13:08.536122 End time: 2026-05-22 14:13:09.500596
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        accor::::casa        ##### End Task: accor                #####
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        accor::::casa        ##########################################
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        rmtables::::casa        Removing cal.A
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-05-22 14:13:09.504635 End time: 2026-05-22 14:13:09.522810
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:09	.2026-05-22 14:13:10        INFO        accor::::casa        ##########################################
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        accor::::casa        ##### Begin Task: accor              #####
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        accor::::casa        accor( vis='vla_copy.ms', caltable='cal.B', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        accor::calibrater::open        Opening MS: vla_copy.ms for calibration.
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        calibrater::reset        Reseting solve/apply state
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        Calibrater::selectvis        By selection 22653 rows are reduced to 1619
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.B append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        calibrater::solve        Beginning solve-----------------------------
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        Calibrater::solve        .   (None)
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        Calibrater::solve        .   Accor Jones: table=cal.B append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1]
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 1413421909.70627
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        Calibrater::solve        For solint = inf, found 7 solution intervals.
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        Calibrater::solve        Beginning solution interval 1/7 (~14% complete)
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        Calibrater::solve        Beginning solution interval 2/7 (~28% complete)
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        Calibrater::solve        Beginning solution interval 3/7 (~42% complete)
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        Calibrater::solve        Beginning solution interval 4/7 (~57% complete)
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        Calibrater::solve        Beginning solution interval 5/7 (~71% complete)
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        Calibrater::solve        Beginning solution interval 6/7 (~85% complete)
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO        Calibrater::solve          Found good Accor Jones solutions in 7 solution intervals.
22-May-2026 10:13:09	2026-05-22 14:13:10        INFO                Writing solutions to table: cal.B
22-May-2026 10:13:10	2026-05-22 14:13:10        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-May-2026 10:13:10	2026-05-22 14:13: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    ANT: 13    ANT: 14    ANT: 15    ANT: 16    ANT: 17    ANT: 18    ANT: 19    ANT: 20    ANT: 21    ANT: 22    ANT: 23    ANT: 24    ANT: 25    ANT: 26    ANT: 27
22-May-2026 10:13:10	2026-05-22 14:13:10        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:10	2026-05-22 14:13:10        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-May-2026 10:13:10	2026-05-22 14:13:10        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:10	2026-05-22 14:13:10        INFO        Calibrater::solve        SPW: 0 [0, 0]  [7, 7]        [0, 0]            [0, 0]
22-May-2026 10:13:10	2026-05-22 14:13:10        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-May-2026 10:13:10	2026-05-22 14:13:10        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:10	2026-05-22 14:13:10        INFO        Calibrater::solve        [0, 0]  [7, 7]        [0, 0]            [0, 0]
22-May-2026 10:13:10	2026-05-22 14:13:10        INFO        calibrater::solve        Finished solving.
22-May-2026 10:13:10	2026-05-22 14:13:10        INFO        accor::::casa        Task accor complete. Start time: 2026-05-22 14:13:09.526752 End time: 2026-05-22 14:13:10.491284
22-May-2026 10:13:10	2026-05-22 14:13:10        INFO        accor::::casa        ##### End Task: accor                #####
22-May-2026 10:13:10	2026-05-22 14:13:10        INFO        accor::::casa        ##########################################
22-May-2026 10:13:10	2026-05-22 14:13:10        INFO        accor::::casa        ##########################################
22-May-2026 10:13:10	2026-05-22 14:13:10        INFO        accor::::casa        ##### Begin Task: accor              #####
22-May-2026 10:13:10	2026-05-22 14:13:10        INFO        accor::::casa        accor( vis='vla_copy.ms', caltable='cal.A', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=['cal.B'], gainfield=[], interp=[], spwmap=[] )
22-May-2026 10:13:10	2026-05-22 14:13:10        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-May-2026 10:13:10	2026-05-22 14:13:10        INFO        accor::calibrater::open        Opening MS: vla_copy.ms for calibration.
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        calibrater::reset        Reseting solve/apply state
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        Calibrater::selectvis        By selection 22653 rows are reduced to 1619
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        calibrater::setapply        Beginning setapply--(MSSelection version)-------
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        Calibrater::setapply(type, applypar)        Arranging to APPLY:
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        Calibrater::setapply(type, applypar)        .   Accor Jones: table=cal.B select= interp=linear spwmap=[-1] calWt=true
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        calibrater::solve        Beginning solve-----------------------------
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        Calibrater::solve        .   Accor Jones: table=cal.B select= interp=linear spwmap=[-1] calWt=true
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1]
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 1413421909.70627
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        Calibrater::solve        For solint = inf, found 7 solution intervals.
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        Calibrater::solve        Beginning solution interval 1/7 (~14% complete)
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        Calibrater::solve        Beginning solution interval 2/7 (~28% complete)
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        Calibrater::solve        Beginning solution interval 3/7 (~42% complete)
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        Calibrater::solve        Beginning solution interval 4/7 (~57% complete)
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        Calibrater::solve        Beginning solution interval 5/7 (~71% complete)
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        Calibrater::solve        Beginning solution interval 6/7 (~85% complete)
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO        Calibrater::solve          Found good Accor Jones solutions in 7 solution intervals.
22-May-2026 10:13:10	2026-05-22 14:13:11        INFO                Writing solutions to table: cal.A
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-May-2026 10:13:11	2026-05-22 14:13:12        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    ANT: 13    ANT: 14    ANT: 15    ANT: 16    ANT: 17    ANT: 18    ANT: 19    ANT: 20    ANT: 21    ANT: 22    ANT: 23    ANT: 24    ANT: 25    ANT: 26    ANT: 27
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::solve        SPW: 0 [0, 0]  [7, 7]        [0, 0]            [0, 0]
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::solve        [0, 0]  [7, 7]        [0, 0]            [0, 0]
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        calibrater::solve        Finished solving.
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        accor::::casa        Task accor complete. Start time: 2026-05-22 14:13:10.495358 End time: 2026-05-22 14:13:11.559279
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        accor::::casa        ##### End Task: accor                #####
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        accor::::casa        ##########################################
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        accor::::casa        ##########################################
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        accor::::casa        ##### Begin Task: accor              #####
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        accor::::casa        accor( vis='vla_copy.ms', caltable='cal.C', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=['cal.B'], gainfield=[], interp=['nearest'], spwmap=[] )
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        accor::calibrater::open        Opening MS: vla_copy.ms for calibration.
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        calibrater::reset        Reseting solve/apply state
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::selectvis        By selection 22653 rows are reduced to 1619
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        calibrater::setapply        Beginning setapply--(MSSelection version)-------
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::setapply(type, applypar)        Arranging to APPLY:
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::setapply(type, applypar)        .   Accor Jones: table=cal.B select= interp=nearest spwmap=[-1] calWt=true
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.C append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        calibrater::solve        Beginning solve-----------------------------
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::solve        .   Accor Jones: table=cal.B select= interp=nearest spwmap=[-1] calWt=true
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::solve        .   Accor Jones: table=cal.C append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1]
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 1413421909.70627
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::solve        For solint = inf, found 7 solution intervals.
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::solve        Beginning solution interval 1/7 (~14% complete)
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::solve        Beginning solution interval 2/7 (~28% complete)
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::solve        Beginning solution interval 3/7 (~42% complete)
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::solve        Beginning solution interval 4/7 (~57% complete)
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::solve        Beginning solution interval 5/7 (~71% complete)
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::solve        Beginning solution interval 6/7 (~85% complete)
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO        Calibrater::solve          Found good Accor Jones solutions in 7 solution intervals.
22-May-2026 10:13:11	2026-05-22 14:13:12        INFO                Writing solutions to table: cal.C
22-May-2026 10:13:17	2026-05-22 14:13:18        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-May-2026 10:13:17	2026-05-22 14:13:18        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    ANT: 13    ANT: 14    ANT: 15    ANT: 16    ANT: 17    ANT: 18    ANT: 19    ANT: 20    ANT: 21    ANT: 22    ANT: 23    ANT: 24    ANT: 25    ANT: 26    ANT: 27
22-May-2026 10:13:17	2026-05-22 14:13:18        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:17	2026-05-22 14:13:18        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-May-2026 10:13:17	2026-05-22 14:13:18        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:17	2026-05-22 14:13:18        INFO        Calibrater::solve        SPW: 0 [0, 0]  [7, 7]        [0, 0]            [0, 0]
22-May-2026 10:13:17	2026-05-22 14:13:18        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-May-2026 10:13:17	2026-05-22 14:13:18        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:17	2026-05-22 14:13:18        INFO        Calibrater::solve        [0, 0]  [7, 7]        [0, 0]            [0, 0]
22-May-2026 10:13:17	2026-05-22 14:13:18        INFO        calibrater::solve        Finished solving.
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        accor::::casa        Task accor complete. Start time: 2026-05-22 14:13:11.562750 End time: 2026-05-22 14:13:18.007682
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        accor::::casa        ##### End Task: accor                #####
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        accor::::casa        ##########################################
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        rmtables::::casa        rmtables( tablenames=['cal.C'] )
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        rmtables::::casa        Removing cal.C
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-05-22 14:13:18.013786 End time: 2026-05-22 14:13:18.031278
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        rmtables::::casa        Removing cal.A
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-05-22 14:13:18.032296 End time: 2026-05-22 14:13:18.047859
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        rmtables::::casa        rmtables( tablenames=['cal.B'] )
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        rmtables::::casa        Removing cal.B
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-05-22 14:13:18.048707 End time: 2026-05-22 14:13:18.062954
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:18	.2026-05-22 14:13:18        INFO        accor::::casa        ##########################################
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        accor::::casa        ##### Begin Task: accor              #####
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        accor::::casa        accor( vis='uid_copy.ms', caltable='cal.A', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        accor::calibrater::open        Opening MS: uid_copy.ms for calibration.
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        calibrater::reset        Reseting solve/apply state
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        Calibrater::selectvis        By selection 1080 rows are reduced to 540
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        calibrater::solve        Beginning solve-----------------------------
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        Calibrater::solve        .   (None)
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 84368488281.1505
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 86213458984.275
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        Calibrater::solve        For solint = inf, found 9 solution intervals.
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        Calibrater::solve        Beginning solution interval 1/9 (~11% complete)
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        Calibrater::solve        Beginning solution interval 2/9 (~22% complete)
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        Calibrater::solve        Beginning solution interval 3/9 (~33% complete)
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        Calibrater::solve        Beginning solution interval 4/9 (~44% complete)
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        Calibrater::solve        Beginning solution interval 5/9 (~55% complete)
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        Calibrater::solve        Beginning solution interval 6/9 (~66% complete)
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        Calibrater::solve        Beginning solution interval 7/9 (~77% complete)
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        Calibrater::solve        Beginning solution interval 8/9 (~88% complete)
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO        Calibrater::solve          Found good Accor Jones solutions in 9 solution intervals.
22-May-2026 10:13:18	2026-05-22 14:13:18        INFO                Writing solutions to table: cal.A
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        Calibrater::solve        SPW: 0 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        Calibrater::solve        SPW: 1 [0, 0]  [6, 6]        [0, 0]            [0, 0]
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        Calibrater::solve        [0, 0]  [9, 9]        [0, 0]            [0, 0]
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        calibrater::solve        Finished solving.
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        accor::::casa        Task accor complete. Start time: 2026-05-22 14:13:18.066007 End time: 2026-05-22 14:13:18.950022
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        accor::::casa        ##### End Task: accor                #####
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        accor::::casa        ##########################################
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        rmtables::::casa        Removing cal.A
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-05-22 14:13:18.951585 End time: 2026-05-22 14:13:18.970334
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:18	.2026-05-22 14:13:19        INFO        accor::::casa        ##########################################
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        accor::::casa        ##### Begin Task: accor              #####
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        accor::::casa        accor( vis='VLBA_copy.ms', caltable='cal.A', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='', observation='0', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        accor::calibrater::open        Opening MS: VLBA_copy.ms for calibration.
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        calibrater::reset        Reseting solve/apply state
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        Calibrater::selectvis+         Selecting by observation IDs: '0'
22-May-2026 10:13:18	2026-05-22 14:13:19        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        Calibrater::selectvis        By selection 34540 rows are reduced to 6280
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        calibrater::solve        Beginning solve-----------------------------
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        Calibrater::solve        .   (None)
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        Calibrater::solve        For solint = inf, found 6 solution intervals.
22-May-2026 10:13:19	2026-05-22 14:13:19        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        Calibrater::solve        Beginning solution interval 1/6 (~16% complete)
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        Calibrater::solve        Beginning solution interval 2/6 (~33% complete)
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        Calibrater::solve        Beginning solution interval 3/6 (~50% complete)
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        Calibrater::solve        Beginning solution interval 4/6 (~66% complete)
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        Calibrater::solve        Beginning solution interval 5/6 (~83% complete)
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO        Calibrater::solve          Found good Accor Jones solutions in 6 solution intervals.
22-May-2026 10:13:19	2026-05-22 14:13:19        INFO                Writing solutions to table: cal.A
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::solve        SPW: 0 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::solve        SPW: 1 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::solve        [0, 0]  [6, 6]        [0, 0]            [0, 0]
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        calibrater::solve        Finished solving.
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        accor::::casa        Task accor complete. Start time: 2026-05-22 14:13:18.974193 End time: 2026-05-22 14:13:20.330996
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        accor::::casa        ##### End Task: accor                #####
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        accor::::casa        ##########################################
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        rmtables::::casa        Removing cal.A
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-05-22 14:13:20.332682 End time: 2026-05-22 14:13:20.351269
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:20	.2026-05-22 14:13:20        INFO        accor::::casa        ##########################################
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        accor::::casa        ##### Begin Task: accor              #####
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        accor::::casa        accor( vis='VLBA_copy.ms', caltable='cal.A', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='2', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        accor::calibrater::open        Opening MS: VLBA_copy.ms for calibration.
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        calibrater::reset        Reseting solve/apply state
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::selectvis+         Selecting on scan: '2'
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::selectvis        By selection 34540 rows are reduced to 1200
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        calibrater::solve        Beginning solve-----------------------------
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::solve        .   (None)
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::solve        For solint = inf, found 2 solution intervals.
22-May-2026 10:13:20	2026-05-22 14:13:20        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
22-May-2026 10:13:20	2026-05-22 14:13:20        INFO        Calibrater::solve        Beginning solution interval 1/2 (~50% complete)
22-May-2026 10:13:20	2026-05-22 14:13:21        INFO        Calibrater::solve          Found good Accor Jones solutions in 2 solution intervals.
22-May-2026 10:13:20	2026-05-22 14:13:21        INFO                Writing solutions to table: cal.A
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        Calibrater::solve        SPW: 0 [0, 0]  [1, 1]        [0, 0]            [0, 0]
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        Calibrater::solve        SPW: 1 [0, 0]  [1, 1]        [0, 0]            [0, 0]
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        Calibrater::solve        [0, 0]  [2, 2]        [0, 0]            [0, 0]
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        calibrater::solve        Finished solving.
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        accor::::casa        Task accor complete. Start time: 2026-05-22 14:13:20.355154 End time: 2026-05-22 14:13:21.470798
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        accor::::casa        ##### End Task: accor                #####
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        accor::::casa        ##########################################
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        rmtables::::casa        Removing cal.A
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-05-22 14:13:21.474868 End time: 2026-05-22 14:13:21.493124
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:21	.2026-05-22 14:13:21        INFO        accor::::casa        ##########################################
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        accor::::casa        ##### Begin Task: accor              #####
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        accor::::casa        accor( vis='uid_copy.ms', caltable='cal.A', field='', spw='', intent='', selectdata=False, timerange='', antenna='', scan='2', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-May-2026 10:13:21	2026-05-22 14:13:21        INFO        accor::calibrater::open        Opening MS: uid_copy.ms for calibration.
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        calibrater::reset        Reseting solve/apply state
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        Calibrater::selectvis        By selection 1080 rows are reduced to 540
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        calibrater::solve        Beginning solve-----------------------------
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        Calibrater::solve        .   (None)
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 84368488281.1505
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 86213458984.275
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        Calibrater::solve        For solint = inf, found 9 solution intervals.
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        Calibrater::solve        Beginning solution interval 1/9 (~11% complete)
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        Calibrater::solve        Beginning solution interval 2/9 (~22% complete)
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        Calibrater::solve        Beginning solution interval 3/9 (~33% complete)
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        Calibrater::solve        Beginning solution interval 4/9 (~44% complete)
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        Calibrater::solve        Beginning solution interval 5/9 (~55% complete)
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        Calibrater::solve        Beginning solution interval 6/9 (~66% complete)
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        Calibrater::solve        Beginning solution interval 7/9 (~77% complete)
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        Calibrater::solve        Beginning solution interval 8/9 (~88% complete)
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO        Calibrater::solve          Found good Accor Jones solutions in 9 solution intervals.
22-May-2026 10:13:21	2026-05-22 14:13:22        INFO                Writing solutions to table: cal.A
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::solve        SPW: 0 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::solve        SPW: 1 [0, 0]  [6, 6]        [0, 0]            [0, 0]
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::solve        [0, 0]  [9, 9]        [0, 0]            [0, 0]
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        calibrater::solve        Finished solving.
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        accor::::casa        Task accor complete. Start time: 2026-05-22 14:13:21.497223 End time: 2026-05-22 14:13:22.385696
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        accor::::casa        ##### End Task: accor                #####
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        accor::::casa        ##########################################
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        rmtables::::casa        Removing cal.A
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-05-22 14:13:22.389643 End time: 2026-05-22 14:13:22.409361
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        accor::::casa        ##########################################
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        accor::::casa        ##### Begin Task: accor              #####
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        accor::::casa        accor( vis='uid_copy.ms', caltable='cal.A', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='2', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        accor::calibrater::open        Opening MS: uid_copy.ms for calibration.
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        calibrater::reset        Reseting solve/apply state
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::selectvis+         Selecting on scan: '2'
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::selectvis        By selection 1080 rows are reduced to 180
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        calibrater::solve        Beginning solve-----------------------------
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::solve        .   (None)
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 84368488281.1505
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 86213458984.275
22-May-2026 10:13:22	2026-05-22 14:13:22        INFO        Calibrater::solve        For solint = inf, found 2 solution intervals.
22-May-2026 10:13:22	2026-05-22 14:13:23        INFO        Calibrater::solve        Beginning solution interval 1/2 (~50% complete)
22-May-2026 10:13:22	2026-05-22 14:13:23        INFO        Calibrater::solve          Found good Accor Jones solutions in 2 solution intervals.
22-May-2026 10:13:22	2026-05-22 14:13:23        INFO                Writing solutions to table: cal.A
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::solve        SPW: 0 [0, 0]  [1, 1]        [0, 0]            [0, 0]
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::solve        SPW: 1 [0, 0]  [1, 1]        [0, 0]            [0, 0]
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::solve        [0, 0]  [2, 2]        [0, 0]            [0, 0]
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        calibrater::solve        Finished solving.
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        accor::::casa        Task accor complete. Start time: 2026-05-22 14:13:22.412544 End time: 2026-05-22 14:13:23.295622
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        accor::::casa        ##### End Task: accor                #####
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        accor::::casa        ##########################################
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        rmtables::::casa        Removing cal.A
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-05-22 14:13:23.299337 End time: 2026-05-22 14:13:23.317904
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-05-22 14:13:23.319025 End time: 2026-05-22 14:13:23.319552
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:23	.2026-05-22 14:13:23        INFO        accor::::casa        ##########################################
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        accor::::casa        ##### Begin Task: accor              #####
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        accor::::casa        accor( vis='VLBA_copy.ms', caltable='cal.A', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='', observation='', msselect='', solint='10s', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        accor::calibrater::open        Opening MS: VLBA_copy.ms for calibration.
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        calibrater::reset        Reseting solve/apply state
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::selectvis        By selection 34540 rows are reduced to 6280
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=10s refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        calibrater::solve        Beginning solve-----------------------------
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::solve        .   (None)
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=10s refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::solve        For solint = 10s, found 126 solution intervals.
22-May-2026 10:13:23	2026-05-22 14:13:23        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
22-May-2026 10:13:23	2026-05-22 14:13:23        INFO        Calibrater::solve        Beginning solution interval 13/126 (~10% complete)
22-May-2026 10:13:23	2026-05-22 14:13:24        INFO        Calibrater::solve        Beginning solution interval 26/126 (~20% complete)
22-May-2026 10:13:23	2026-05-22 14:13:24        INFO        Calibrater::solve        Beginning solution interval 39/126 (~30% complete)
22-May-2026 10:13:23	2026-05-22 14:13:24        INFO        Calibrater::solve        Beginning solution interval 52/126 (~41% complete)
22-May-2026 10:13:23	2026-05-22 14:13:24        INFO        Calibrater::solve        Beginning solution interval 65/126 (~51% complete)
22-May-2026 10:13:23	2026-05-22 14:13:24        INFO        Calibrater::solve        Beginning solution interval 78/126 (~61% complete)
22-May-2026 10:13:23	2026-05-22 14:13:24        INFO        Calibrater::solve        Beginning solution interval 91/126 (~72% complete)
22-May-2026 10:13:23	2026-05-22 14:13:24        INFO        Calibrater::solve        Beginning solution interval 104/126 (~82% complete)
22-May-2026 10:13:24	2026-05-22 14:13:24        INFO        Calibrater::solve        Beginning solution interval 117/126 (~92% complete)
22-May-2026 10:13:24	2026-05-22 14:13:24        INFO        Calibrater::solve          Found good Accor Jones solutions in 126 solution intervals.
22-May-2026 10:13:24	2026-05-22 14:13:24        INFO                Writing solutions to table: cal.A
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        Calibrater::solve        SPW: 0 [0, 0]  [63, 63]        [0, 0]            [0, 0]
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        Calibrater::solve        SPW: 1 [0, 0]  [63, 63]        [0, 0]            [0, 0]
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        Calibrater::solve        [0, 0]  [126, 126]        [0, 0]            [0, 0]
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        calibrater::solve        Finished solving.
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        accor::::casa        Task accor complete. Start time: 2026-05-22 14:13:23.323160 End time: 2026-05-22 14:13:24.949266
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        accor::::casa        ##### End Task: accor                #####
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        accor::::casa        ##########################################
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        rmtables::::casa        Removing cal.A
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-05-22 14:13:24.954062 End time: 2026-05-22 14:13:24.971176
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:24	.2026-05-22 14:13:25        INFO        accor::::casa        ##########################################
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        accor::::casa        ##### Begin Task: accor              #####
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        accor::::casa        accor( vis='uid_copy.ms', caltable='cal.A', field='', spw='1', intent='', selectdata=True, timerange='', antenna='', scan='', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        accor::calibrater::open        Opening MS: uid_copy.ms for calibration.
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        calibrater::reset        Reseting solve/apply state
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        Calibrater::selectvis+         Selecting on spw: '1'
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-May-2026 10:13:24	2026-05-22 14:13:25        INFO        Calibrater::selectvis        By selection 1080 rows are reduced to 405
22-May-2026 10:13:25	2026-05-22 14:13:25        INFO        Calibrater::selectvis        Frequency selection:
22-May-2026 10:13:25	2026-05-22 14:13:25        INFO        Calibrater::selectvis        .  Spw 1:0~0 (1 channels, step by 1)
22-May-2026 10:13:25	2026-05-22 14:13:25        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-May-2026 10:13:25	2026-05-22 14:13:25        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-May-2026 10:13:25	2026-05-22 14:13:25        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-May-2026 10:13:25	2026-05-22 14:13:25        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:25	2026-05-22 14:13:25        INFO        calibrater::solve        Beginning solve-----------------------------
22-May-2026 10:13:25	2026-05-22 14:13:25        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-May-2026 10:13:25	2026-05-22 14:13:25        INFO        Calibrater::solve        .   (None)
22-May-2026 10:13:25	2026-05-22 14:13:25        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-May-2026 10:13:25	2026-05-22 14:13:25        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:25	2026-05-22 14:13:25        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-May-2026 10:13:25	2026-05-22 14:13:25        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-May-2026 10:13:25	2026-05-22 14:13:25        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 86213458984.275
22-May-2026 10:13:25	2026-05-22 14:13:25        INFO        Calibrater::solve        For solint = inf, found 3 solution intervals.
22-May-2026 10:13:25	2026-05-22 14:13:25        INFO        Calibrater::solve        Beginning solution interval 1/3 (~33% complete)
22-May-2026 10:13:25	2026-05-22 14:13:25        INFO        Calibrater::solve        Beginning solution interval 2/3 (~66% complete)
22-May-2026 10:13:25	2026-05-22 14:13:25        INFO        Calibrater::solve          Found good Accor Jones solutions in 3 solution intervals.
22-May-2026 10:13:25	2026-05-22 14:13:25        INFO                Writing solutions to table: cal.A
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]        [0, 0]            [0, 0]
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        Calibrater::solve        SPW: 1 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        Calibrater::solve        [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        calibrater::solve        Finished solving.
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        accor::::casa        Task accor complete. Start time: 2026-05-22 14:13:24.974868 End time: 2026-05-22 14:13:25.918337
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        accor::::casa        ##### End Task: accor                #####
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        accor::::casa        ##########################################
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        rmtables::::casa        Removing cal.A
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-05-22 14:13:25.922272 End time: 2026-05-22 14:13:25.941043
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:25	.2026-05-22 14:13:26        INFO        accor::::casa        ##########################################
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        accor::::casa        ##### Begin Task: accor              #####
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        accor::::casa        accor( vis='VLBA_copy.ms', caltable='cal.B', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        accor::calibrater::open        Opening MS: VLBA_copy.ms for calibration.
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        calibrater::reset        Reseting solve/apply state
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        Calibrater::selectvis        By selection 34540 rows are reduced to 6280
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.B append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        calibrater::solve        Beginning solve-----------------------------
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        Calibrater::solve        .   (None)
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-May-2026 10:13:25	2026-05-22 14:13:26        INFO        Calibrater::solve        .   Accor Jones: table=cal.B append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:26	2026-05-22 14:13:26        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-May-2026 10:13:26	2026-05-22 14:13:26        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-May-2026 10:13:26	2026-05-22 14:13:26        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
22-May-2026 10:13:26	2026-05-22 14:13:26        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
22-May-2026 10:13:26	2026-05-22 14:13:26        INFO        Calibrater::solve        For solint = inf, found 6 solution intervals.
22-May-2026 10:13:26	2026-05-22 14:13:26        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
22-May-2026 10:13:26	2026-05-22 14:13:26        INFO        Calibrater::solve        Beginning solution interval 1/6 (~16% complete)
22-May-2026 10:13:26	2026-05-22 14:13:26        INFO        Calibrater::solve        Beginning solution interval 2/6 (~33% complete)
22-May-2026 10:13:26	2026-05-22 14:13:26        INFO        Calibrater::solve        Beginning solution interval 3/6 (~50% complete)
22-May-2026 10:13:26	2026-05-22 14:13:26        INFO        Calibrater::solve        Beginning solution interval 4/6 (~66% complete)
22-May-2026 10:13:26	2026-05-22 14:13:26        INFO        Calibrater::solve        Beginning solution interval 5/6 (~83% complete)
22-May-2026 10:13:26	2026-05-22 14:13:26        INFO        Calibrater::solve          Found good Accor Jones solutions in 6 solution intervals.
22-May-2026 10:13:26	2026-05-22 14:13:26        INFO                Writing solutions to table: cal.B
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::solve        SPW: 0 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::solve        SPW: 1 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::solve        [0, 0]  [6, 6]        [0, 0]            [0, 0]
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        calibrater::solve        Finished solving.
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        accor::::casa        Task accor complete. Start time: 2026-05-22 14:13:25.945480 End time: 2026-05-22 14:13:27.357812
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        accor::::casa        ##### End Task: accor                #####
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        accor::::casa        ##########################################
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        accor::::casa        ##########################################
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        accor::::casa        ##### Begin Task: accor              #####
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        accor::::casa        accor( vis='VLBA_copy.ms', caltable='cal.A', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=['cal.B'], gainfield=[], interp=[], spwmap=[0, 0] )
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        accor::calibrater::open        Opening MS: VLBA_copy.ms for calibration.
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        calibrater::reset        Reseting solve/apply state
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::selectvis        By selection 34540 rows are reduced to 6280
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        calibrater::setapply        Beginning setapply--(MSSelection version)-------
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::setapply(type, applypar)        Arranging to APPLY:
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::setapply(type, applypar)        .   Accor Jones: table=cal.B select= interp=linear spwmap=[0, 0] calWt=true
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        calibrater::solve        Beginning solve-----------------------------
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::solve        .   Accor Jones: table=cal.B select= interp=linear spwmap=[0, 0] calWt=true
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
22-May-2026 10:13:27	2026-05-22 14:13:27        INFO        Calibrater::solve        For solint = inf, found 6 solution intervals.
22-May-2026 10:13:27	2026-05-22 14:13:28        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
22-May-2026 10:13:27	2026-05-22 14:13:28        INFO        Calibrater::solve        Beginning solution interval 1/6 (~16% complete)
22-May-2026 10:13:27	2026-05-22 14:13:28        INFO        Calibrater::solve        Beginning solution interval 2/6 (~33% complete)
22-May-2026 10:13:27	2026-05-22 14:13:28        INFO        Calibrater::solve        Beginning solution interval 3/6 (~50% complete)
22-May-2026 10:13:27	2026-05-22 14:13:28        INFO        Calibrater::solve        Beginning solution interval 4/6 (~66% complete)
22-May-2026 10:13:27	2026-05-22 14:13:28        INFO        Calibrater::solve        Beginning solution interval 5/6 (~83% complete)
22-May-2026 10:13:27	2026-05-22 14:13:28        INFO        Calibrater::solve          Found good Accor Jones solutions in 6 solution intervals.
22-May-2026 10:13:27	2026-05-22 14:13:28        INFO                Writing solutions to table: cal.A
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::solve        SPW: 0 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::solve        SPW: 1 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::solve        [0, 0]  [6, 6]        [0, 0]            [0, 0]
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        calibrater::solve        Finished solving.
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        accor::::casa        Task accor complete. Start time: 2026-05-22 14:13:27.361847 End time: 2026-05-22 14:13:28.742465
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        accor::::casa        ##### End Task: accor                #####
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        accor::::casa        ##########################################
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        rmtables::::casa        Removing cal.A
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-05-22 14:13:28.746180 End time: 2026-05-22 14:13:28.762978
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        rmtables::::casa        rmtables( tablenames=['cal.B'] )
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        rmtables::::casa        Removing cal.B
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-05-22 14:13:28.763914 End time: 2026-05-22 14:13:28.778692
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:28	.2026-05-22 14:13:29        INFO        accor::::casa        ##########################################
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        accor::::casa        ##### Begin Task: accor              #####
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        accor::::casa        accor( vis='VLBA_copy.ms', caltable='cal.A', field='', spw='', intent='', selectdata=True, timerange='00:21:11.0~00:23:11.0', antenna='', scan='', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        accor::calibrater::open        Opening MS: VLBA_copy.ms for calibration.
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        calibrater::reset        Reseting solve/apply state
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::selectvis+         Selecting on time: '00:21:11.0~00:23:11.0'
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::selectvis        By selection 34540 rows are reduced to 1200
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        calibrater::solve        Beginning solve-----------------------------
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::solve        .   (None)
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::solve        For solint = inf, found 2 solution intervals.
22-May-2026 10:13:28	2026-05-22 14:13:29        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::solve        Beginning solution interval 1/2 (~50% complete)
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO        Calibrater::solve          Found good Accor Jones solutions in 2 solution intervals.
22-May-2026 10:13:28	2026-05-22 14:13:29        INFO                Writing solutions to table: cal.A
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        Calibrater::solve        SPW: 0 [0, 0]  [1, 1]        [0, 0]            [0, 0]
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        Calibrater::solve        SPW: 1 [0, 0]  [1, 1]        [0, 0]            [0, 0]
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        Calibrater::solve        [0, 0]  [2, 2]        [0, 0]            [0, 0]
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        calibrater::solve        Finished solving.
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        accor::::casa        Task accor complete. Start time: 2026-05-22 14:13:28.781914 End time: 2026-05-22 14:13:29.680590
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        accor::::casa        ##### End Task: accor                #####
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        accor::::casa        ##########################################
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        rmtables::::casa        Removing cal.A
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-05-22 14:13:29.684557 End time: 2026-05-22 14:13:29.702797
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:29	.2026-05-22 14:13:30        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        rmtables::::casa        rmtables( tablenames=['cal.default'] )
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-05-22 14:13:29.774333 End time: 2026-05-22 14:13:29.774754
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-May-2026 10:13:29	2026-05-22 14:13:30        INFO        rmtables::::casa        ##########################################
22-May-2026 10:13:29
22-May-2026 10:13:29	----------------------------------------------------------------------
22-May-2026 10:13:29	Ran 18 tests in 51.349s
22-May-2026 10:13:29
22-May-2026 10:13:29	OK
22-May-2026 10:13:29
22-May-2026 10:13:29	Generating XML reports...
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa        Using user configuration file /home/casatest/.casa/config.py
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa        loaded config file : /wheeldirectory/casa-6.7.6-4-py3.12.el8/lib/py/lib/python3.12/site-packages/casaconfig/config.py
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa        loaded config file : /home/casatest/.casa/config.py
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa        config values
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            agg = False
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            cachedir = '/home/casatest/.casa'
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            casaconfig_verbose = 1
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            colors = 'Neutral'
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            data_auto_update = False
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            data_update_interval = 1
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            datapath = ['/opt/casa/data/master', '/opt/casa/data/casatestdata']
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            iplog = False
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            iplogfile = '/home/casatest/casa6/casatasks/tests/casashell_tests/work/test_task_appendantab_casashell/ipython-20260522-141330.log'
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            log2term = True
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            logfile = '/home/casatest/casa6/casatasks/tests/casashell_tests/work/test_task_appendantab_casashell/casa-20260522-141330.log'
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            measures_auto_update = False
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            measures_site = ['https://www.astron.nl/iers/', 'https://go.nrao.edu/iers/']
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            measures_site_interval = 2
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            measures_update_interval = 1
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            measurespath = '/opt/casa/data/master'
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            nogui = False
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            nologfile = False
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            nologger = True
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            pipeline = False
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            skipnetworkcheck = False
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            startupfile = '/home/casatest/.casa/startup.py'
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa            user_site = False
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa        casarundata version is unknown, this is probably a legacy version not installed by casaconfig
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa        measures version : WSRT_Measures_20211217-160001.ztar
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa        Checking Measures tables in data repository sub-directory /opt/casa/data/master/geodetic
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa          IERSeop2000 (version date, last date in table (UTC)): 2026/04/23/12:59, 2026/03/23/00:00:00
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa          IERSeop97 (version date, last date in table (UTC)): 2026/04/23/12:59, 2026/03/23/00:00:00
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa          IERSpredict (version date, last date in table (UTC)): 2026/05/21/15:15, 2026/08/19/00:00:00
22-May-2026 10:13:35	2026-05-22 14:13:35        INFO        ::casa          TAI_UTC (version date, last date in table (UTC)): 2026/04/28/15:15, 2017/01/01/00:00:00
22-May-2026 10:13:35
22-May-2026 10:13:35	Running tests...
22-May-2026 10:13:35	----------------------------------------------------------------------
22-May-2026 10:13:35
22-May-2026 10:13:35	Using user configuration file /home/casatest/.casa/config.py
22-May-2026 10:13:35
22-May-2026 10:13:35	No event loop hook running.
22-May-2026 10:13:35	Using matplotlib backend: agg
22-May-2026 10:13:35	CASA 6.7.6.4 -- Common Astronomy Software Applications [6.7.6.4]
22-May-2026 10:15:58	2026-05-22 14:15:58        INFO        appendantab::::casa        ##########################################
22-May-2026 10:15:58	2026-05-22 14:15:58        INFO        appendantab::::casa        ##### Begin Task: appendantab        #####
22-May-2026 10:15:58	2026-05-22 14:15:58        INFO        appendantab::::casa        appendantab( vis='vla_copy.ms', outvis='corrected_overwrite.ms', antab='/opt/casa/data/casatestdata/unittest/appendantab/VLBA_7GHZ_GAINS.ANTAB', overwrite=True, append_tsys=False, append_gc=True )
22-May-2026 10:15:58	2026-05-22 14:15:58        INFO        msmetadata_cmpt.cc::open        Performing internal consistency checks on vla_copy.ms...
22-May-2026 10:16:05	2026-05-22 14:16:05        INFO        appendantab::::casa        Task appendantab complete. Start time: 2026-05-22 14:15:58.117045 End time: 2026-05-22 14:16:05.177717
22-May-2026 10:16:05	2026-05-22 14:16:05        INFO        appendantab::::casa        ##### End Task: appendantab          #####
22-May-2026 10:16:05	2026-05-22 14:16:05        INFO        appendantab::::casa        ##########################################
22-May-2026 10:16:06	Antenna MK not present in the Measurement Set. MK values will be ignored.
22-May-2026 10:16:13	.2026-05-22 14:16:13        INFO        appendantab::::casa        ##########################################
22-May-2026 10:16:13	2026-05-22 14:16:13        INFO        appendantab::::casa        ##### Begin Task: appendantab        #####
22-May-2026 10:16:13	2026-05-22 14:16:13        INFO        appendantab::::casa        appendantab( vis='dataCopy.ms', outvis='appendedData.ms', antab='/opt/casa/data/casatestdata/unittest/appendantab/n14c3.antab', overwrite=False, append_tsys=True, append_gc=True )
22-May-2026 10:16:13	2026-05-22 14:16:13        INFO        msmetadata_cmpt.cc::open        Performing internal consistency checks on dataCopy.ms...
22-May-2026 10:20:51	2026-05-22 14:20:51        INFO        appendantab::::casa        Task appendantab complete. Start time: 2026-05-22 14:16:13.398135 End time: 2026-05-22 14:20:51.383065
22-May-2026 10:20:51	2026-05-22 14:20:51        INFO        appendantab::::casa        ##### End Task: appendantab          #####
22-May-2026 10:20:51	2026-05-22 14:20:51        INFO        appendantab::::casa        ##########################################
22-May-2026 10:20:53	ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-May-2026 10:20:53	ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-May-2026 10:20:53	ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-May-2026 10:20:53	ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-May-2026 10:20:53	ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-May-2026 10:20:53	ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-May-2026 10:20:53	ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-May-2026 10:20:53	ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-May-2026 10:20:53	ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-May-2026 10:20:53	ANTAB HAS NO FREQ INFORMATION DEFAULTING TO SPW ID -1 and freq to [0, 0]
22-May-2026 10:20:53	ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-May-2026 10:20:53	ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-May-2026 10:20:53	ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-May-2026 10:20:53
22-May-2026 10:20:53	Testing column ANTENNA_ID
22-May-2026 10:20:53	Column ANTENNA_ID PASSED
22-May-2026 10:20:53
22-May-2026 10:20:53	Testing column FEED_ID
22-May-2026 10:20:53	Column FEED_ID PASSED
22-May-2026 10:20:53
22-May-2026 10:20:53	Testing column INTERVAL
22-May-2026 10:20:53	Column INTERVAL PASSED
22-May-2026 10:20:53
22-May-2026 10:20:53	Testing column SPECTRAL_WINDOW_ID
22-May-2026 10:20:53	Column SPECTRAL_WINDOW_ID PASSED
22-May-2026 10:20:53
22-May-2026 10:20:53	Testing column TIME
22-May-2026 10:20:53	Column TIME PASSED
22-May-2026 10:20:53
22-May-2026 10:20:53	Testing column TSYS
22-May-2026 10:20:53	Column TSYS PASSED
22-May-2026 10:20:53	-----------------------------
22-May-2026 10:21:02	.2026-05-22 14:21:02        INFO        appendantab::::casa        ##########################################
22-May-2026 10:21:02	2026-05-22 14:21:02        INFO        appendantab::::casa        ##### Begin Task: appendantab        #####
22-May-2026 10:21:02	2026-05-22 14:21:02        INFO        appendantab::::casa        appendantab( vis='dataCopy.ms', outvis='appendedData.ms', antab='/opt/casa/data/casatestdata/unittest/appendantab/n14c3.antab', overwrite=False, append_tsys=False, append_gc=True )
22-May-2026 10:21:02	2026-05-22 14:21:02        INFO        msmetadata_cmpt.cc::open        Performing internal consistency checks on dataCopy.ms...
22-May-2026 10:31:58	Agent 'cbt-el7-11.cv.nrao.edu' went offline while building CASASPECS-MASTERTESTCASALITHPY312-TTC2-269. The results of that build will not be available.