Build: #295 is building

Job: Test Tasks Many Linux 2.28 CasaShell Rocky 8.10 did not complete

Build log

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

29-Sep-2026 14:55:49 2026-09-29 18:55:50        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:55:49 2026-09-29 18:55:50        INFO        calibrater::solve        Beginning solve-----------------------------
29-Sep-2026 14:55:49 2026-09-29 18:55:50        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
29-Sep-2026 14:55:49 2026-09-29 18:55:50        INFO        Calibrater::solve        .   Accor Jones: table=cal.B select= interp=linear spwmap=[-1] calWt=true
29-Sep-2026 14:55:49 2026-09-29 18:55:50        INFO        Calibrater::solve        The following calibration term is arranged for solve:
29-Sep-2026 14:55:49 2026-09-29 18:55:50        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:55:49 2026-09-29 18:55:50        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
29-Sep-2026 14:55:49 2026-09-29 18:55:50        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
29-Sep-2026 14:55:49 2026-09-29 18:55:50        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
29-Sep-2026 14:55:49 2026-09-29 18:55:50        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
29-Sep-2026 14:55:49 2026-09-29 18:55:50        INFO        Calibrater::solve        For solint = inf, found 6 solution intervals.
29-Sep-2026 14:55:49 2026-09-29 18:55:50        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
29-Sep-2026 14:55:49 2026-09-29 18:55:50        INFO        Calibrater::solve        Beginning solution interval 1/6 (~16% complete)
29-Sep-2026 14:55:49 2026-09-29 18:55:50        INFO        Calibrater::solve        Beginning solution interval 2/6 (~33% complete)
29-Sep-2026 14:55:49 2026-09-29 18:55:50        INFO        Calibrater::solve        Beginning solution interval 3/6 (~50% complete)
29-Sep-2026 14:55:49 2026-09-29 18:55:50        INFO        Calibrater::solve        Beginning solution interval 4/6 (~66% complete)
29-Sep-2026 14:55:49 2026-09-29 18:55:50        INFO        Calibrater::solve        Beginning solution interval 5/6 (~83% complete)
29-Sep-2026 14:55:49 2026-09-29 18:55:50        INFO        Calibrater::solve          Found good Accor Jones solutions in 6 solution intervals.
29-Sep-2026 14:55:49 2026-09-29 18:55:50        INFO                Writing solutions to table: cal.A
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9   
29-Sep-2026 14:55:50 2026-09-29 18:55:51        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]
29-Sep-2026 14:55:50 2026-09-29 18:55:51        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]
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::solve        ----- PER SPW INFO -----
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::solve        SPW: 0 [0, 0]  [3, 3]        [0, 0]            [0, 0]
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::solve        SPW: 1 [0, 0]  [3, 3]        [0, 0]            [0, 0]
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::solve        ----- GLOBAL INFO -----
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::solve        [0, 0]  [6, 6]        [0, 0]            [0, 0]
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        calibrater::solve        Finished solving.
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        accor::::casa        Task accor complete. Start time: 2026-09-29 18:55:49.484622 End time: 2026-09-29 18:55:50.741632
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        accor::::casa        ##### End Task: accor                #####
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        accor::::casa        ##########################################
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        rmtables::::casa        Removing cal.A
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-09-29 18:55:50.744949 End time: 2026-09-29 18:55:50.761349
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        rmtables::::casa        ##### End Task: rmtables             #####
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        rmtables::::casa        rmtables( tablenames=['cal.B'] )
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        rmtables::::casa        Removing cal.B
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-09-29 18:55:50.762295 End time: 2026-09-29 18:55:50.777204
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        rmtables::::casa        ##### End Task: rmtables             #####
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:55:50 .2026-09-29 18:55:51        INFO        accor::::casa        ##########################################
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        accor::::casa        ##### Begin Task: accor              #####
29-Sep-2026 14:55:50 2026-09-29 18:55:51        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=[] )
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        accor::calibrater::open        Opening MS: uid_copy.ms for calibration.
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        calibrater::reset        Reseting solve/apply state
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::selectvis+         Selecting on intent: '*AMPLI*'
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::selectvis        By selection 1080 rows are reduced to 180
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::setsolve        Arranging to SOLVE:
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        calibrater::solve        Beginning solve-----------------------------
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::solve        .   (None)
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::solve        The following calibration term is arranged for solve:
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 84368488281.1505
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 86213458984.275
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::solve        For solint = inf, found 2 solution intervals.
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::solve        Beginning solution interval 1/2 (~50% complete)
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO        Calibrater::solve          Found good Accor Jones solutions in 2 solution intervals.
29-Sep-2026 14:55:50 2026-09-29 18:55:51        INFO                Writing solutions to table: cal.A
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2   
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::solve        ----- PER SPW INFO -----
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::solve        SPW: 0 [0, 0]  [1, 1]        [0, 0]            [0, 0]
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::solve        SPW: 1 [0, 0]  [1, 1]        [0, 0]            [0, 0]
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::solve        ----- GLOBAL INFO -----
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::solve        [0, 0]  [2, 2]        [0, 0]            [0, 0]
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        calibrater::solve        Finished solving.
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        accor::::casa        Task accor complete. Start time: 2026-09-29 18:55:50.780237 End time: 2026-09-29 18:55:55.434088
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        accor::::casa        ##### End Task: accor                #####
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        accor::::casa        ##########################################
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        rmtables::::casa        Removing cal.A
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-09-29 18:55:55.437394 End time: 2026-09-29 18:55:55.452937
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        rmtables::::casa        ##### End Task: rmtables             #####
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:55:55 .2026-09-29 18:55:55        INFO        accor::::casa        ##########################################
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        accor::::casa        ##### Begin Task: accor              #####
29-Sep-2026 14:55:55 2026-09-29 18:55:55        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=[] )
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        accor::calibrater::open        Opening MS: vla_copy.ms for calibration.
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        calibrater::reset        Reseting solve/apply state
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::selectvis        By selection 22653 rows are reduced to 1619
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::setsolve        Arranging to SOLVE:
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.B append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        calibrater::solve        Beginning solve-----------------------------
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::solve        .   (None)
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::solve        The following calibration term is arranged for solve:
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::solve        .   Accor Jones: table=cal.B append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1]
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 1413421909.70627
29-Sep-2026 14:55:55 2026-09-29 18:55:55        INFO        Calibrater::solve        For solint = inf, found 7 solution intervals.
29-Sep-2026 14:55:55 2026-09-29 18:55:56        INFO        Calibrater::solve        Beginning solution interval 1/7 (~14% complete)
29-Sep-2026 14:55:55 2026-09-29 18:55:56        INFO        Calibrater::solve        Beginning solution interval 2/7 (~28% complete)
29-Sep-2026 14:55:55 2026-09-29 18:55:56        INFO        Calibrater::solve        Beginning solution interval 3/7 (~42% complete)
29-Sep-2026 14:55:55 2026-09-29 18:55:56        INFO        Calibrater::solve        Beginning solution interval 4/7 (~57% complete)
29-Sep-2026 14:55:55 2026-09-29 18:55:56        INFO        Calibrater::solve        Beginning solution interval 5/7 (~71% complete)
29-Sep-2026 14:55:55 2026-09-29 18:55:56        INFO        Calibrater::solve        Beginning solution interval 6/7 (~85% complete)
29-Sep-2026 14:55:55 2026-09-29 18:55:56        INFO        Calibrater::solve          Found good Accor Jones solutions in 7 solution intervals.
29-Sep-2026 14:55:55 2026-09-29 18:55:56        INFO                Writing solutions to table: cal.B
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
29-Sep-2026 14:55:56 2026-09-29 18:55:57        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   
29-Sep-2026 14:55:56 2026-09-29 18:55:57        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]
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        Calibrater::solve        ----- PER SPW INFO -----
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        Calibrater::solve        SPW: 0 [0, 0]  [7, 7]        [0, 0]            [0, 0]
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        Calibrater::solve        ----- GLOBAL INFO -----
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        Calibrater::solve        [0, 0]  [7, 7]        [0, 0]            [0, 0]
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        calibrater::solve        Finished solving.
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        accor::::casa        Task accor complete. Start time: 2026-09-29 18:55:55.456443 End time: 2026-09-29 18:55:56.898231
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        accor::::casa        ##### End Task: accor                #####
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        accor::::casa        ##########################################
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        accor::::casa        ##########################################
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        accor::::casa        ##### Begin Task: accor              #####
29-Sep-2026 14:55:56 2026-09-29 18:55:57        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=[] )
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        accor::calibrater::open        Opening MS: vla_copy.ms for calibration.
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        calibrater::reset        Reseting solve/apply state
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        Calibrater::selectvis        By selection 22653 rows are reduced to 1619
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        calibrater::setapply        Beginning setapply--(MSSelection version)-------
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        Calibrater::setapply(type, applypar)        Arranging to APPLY:
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        Calibrater::setapply(type, applypar)        .   Accor Jones: table=cal.B select= interp=linear spwmap=[-1] calWt=true
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        Calibrater::setsolve        Arranging to SOLVE:
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        calibrater::solve        Beginning solve-----------------------------
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        Calibrater::solve        .   Accor Jones: table=cal.B select= interp=linear spwmap=[-1] calWt=true
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        Calibrater::solve        The following calibration term is arranged for solve:
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1]
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 1413421909.70627
29-Sep-2026 14:55:56 2026-09-29 18:55:57        INFO        Calibrater::solve        For solint = inf, found 7 solution intervals.
29-Sep-2026 14:55:57 2026-09-29 18:55:57        INFO        Calibrater::solve        Beginning solution interval 1/7 (~14% complete)
29-Sep-2026 14:55:57 2026-09-29 18:55:57        INFO        Calibrater::solve        Beginning solution interval 2/7 (~28% complete)
29-Sep-2026 14:55:57 2026-09-29 18:55:57        INFO        Calibrater::solve        Beginning solution interval 3/7 (~42% complete)
29-Sep-2026 14:55:57 2026-09-29 18:55:57        INFO        Calibrater::solve        Beginning solution interval 4/7 (~57% complete)
29-Sep-2026 14:55:57 2026-09-29 18:55:57        INFO        Calibrater::solve        Beginning solution interval 5/7 (~71% complete)
29-Sep-2026 14:55:57 2026-09-29 18:55:57        INFO        Calibrater::solve        Beginning solution interval 6/7 (~85% complete)
29-Sep-2026 14:55:57 2026-09-29 18:55:57        INFO        Calibrater::solve          Found good Accor Jones solutions in 7 solution intervals.
29-Sep-2026 14:55:57 2026-09-29 18:55:57        INFO                Writing solutions to table: cal.A
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
29-Sep-2026 14:55:57 2026-09-29 18:55:58        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   
29-Sep-2026 14:55:57 2026-09-29 18:55:58        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]
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        Calibrater::solve        ----- PER SPW INFO -----
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        Calibrater::solve        SPW: 0 [0, 0]  [7, 7]        [0, 0]            [0, 0]
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        Calibrater::solve        ----- GLOBAL INFO -----
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        Calibrater::solve        [0, 0]  [7, 7]        [0, 0]            [0, 0]
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        calibrater::solve        Finished solving.
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        accor::::casa        Task accor complete. Start time: 2026-09-29 18:55:56.901882 End time: 2026-09-29 18:55:57.938362
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        accor::::casa        ##### End Task: accor                #####
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        accor::::casa        ##########################################
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        accor::::casa        ##########################################
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        accor::::casa        ##### Begin Task: accor              #####
29-Sep-2026 14:55:57 2026-09-29 18:55:58        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=[] )
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        accor::calibrater::open        Opening MS: vla_copy.ms for calibration.
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        calibrater::reset        Reseting solve/apply state
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        Calibrater::selectvis        By selection 22653 rows are reduced to 1619
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        calibrater::setapply        Beginning setapply--(MSSelection version)-------
29-Sep-2026 14:55:57 2026-09-29 18:55:58        INFO        Calibrater::setapply(type, applypar)        Arranging to APPLY:
29-Sep-2026 14:55:58 2026-09-29 18:55:58        INFO        Calibrater::setapply(type, applypar)        .   Accor Jones: table=cal.B select= interp=nearest spwmap=[-1] calWt=true
29-Sep-2026 14:55:58 2026-09-29 18:55:58        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
29-Sep-2026 14:55:58 2026-09-29 18:55:58        INFO        Calibrater::setsolve        Arranging to SOLVE:
29-Sep-2026 14:55:58 2026-09-29 18:55:58        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.C append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:55:58 2026-09-29 18:55:58        INFO        calibrater::solve        Beginning solve-----------------------------
29-Sep-2026 14:55:58 2026-09-29 18:55:58        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
29-Sep-2026 14:55:58 2026-09-29 18:55:58        INFO        Calibrater::solve        .   Accor Jones: table=cal.B select= interp=nearest spwmap=[-1] calWt=true
29-Sep-2026 14:55:58 2026-09-29 18:55:58        INFO        Calibrater::solve        The following calibration term is arranged for solve:
29-Sep-2026 14:55:58 2026-09-29 18:55:58        INFO        Calibrater::solve        .   Accor Jones: table=cal.C append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:55:58 2026-09-29 18:55:58        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1]
29-Sep-2026 14:55:58 2026-09-29 18:55:58        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
29-Sep-2026 14:55:58 2026-09-29 18:55:58        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 1413421909.70627
29-Sep-2026 14:55:58 2026-09-29 18:55:58        INFO        Calibrater::solve        For solint = inf, found 7 solution intervals.
29-Sep-2026 14:55:58 2026-09-29 18:55:58        INFO        Calibrater::solve        Beginning solution interval 1/7 (~14% complete)
29-Sep-2026 14:55:58 2026-09-29 18:55:58        INFO        Calibrater::solve        Beginning solution interval 2/7 (~28% complete)
29-Sep-2026 14:55:58 2026-09-29 18:55:58        INFO        Calibrater::solve        Beginning solution interval 3/7 (~42% complete)
29-Sep-2026 14:55:58 2026-09-29 18:55:58        INFO        Calibrater::solve        Beginning solution interval 4/7 (~57% complete)
29-Sep-2026 14:55:58 2026-09-29 18:55:58        INFO        Calibrater::solve        Beginning solution interval 5/7 (~71% complete)
29-Sep-2026 14:55:58 2026-09-29 18:55:58        INFO        Calibrater::solve        Beginning solution interval 6/7 (~85% complete)
29-Sep-2026 14:55:58 2026-09-29 18:55:58        INFO        Calibrater::solve          Found good Accor Jones solutions in 7 solution intervals.
29-Sep-2026 14:55:58 2026-09-29 18:55:58        INFO                Writing solutions to table: cal.C
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
29-Sep-2026 14:55:58 2026-09-29 18:55:59        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   
29-Sep-2026 14:55:58 2026-09-29 18:55:59        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]
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        Calibrater::solve        ----- PER SPW INFO -----
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        Calibrater::solve        SPW: 0 [0, 0]  [7, 7]        [0, 0]            [0, 0]
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        Calibrater::solve        ----- GLOBAL INFO -----
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        Calibrater::solve        [0, 0]  [7, 7]        [0, 0]            [0, 0]
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        calibrater::solve        Finished solving.
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        accor::::casa        Task accor complete. Start time: 2026-09-29 18:55:57.942364 End time: 2026-09-29 18:55:58.877394
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        accor::::casa        ##### End Task: accor                #####
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        accor::::casa        ##########################################
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        rmtables::::casa        rmtables( tablenames=['cal.C'] )
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        rmtables::::casa        Removing cal.C
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-09-29 18:55:58.882889 End time: 2026-09-29 18:55:58.900186
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        rmtables::::casa        ##### End Task: rmtables             #####
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        rmtables::::casa        Removing cal.A
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-09-29 18:55:58.901159 End time: 2026-09-29 18:55:58.916360
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        rmtables::::casa        ##### End Task: rmtables             #####
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        rmtables::::casa        rmtables( tablenames=['cal.B'] )
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        rmtables::::casa        Removing cal.B
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-09-29 18:55:58.917208 End time: 2026-09-29 18:55:58.931179
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        rmtables::::casa        ##### End Task: rmtables             #####
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:55:58 .2026-09-29 18:55:59        INFO        accor::::casa        ##########################################
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        accor::::casa        ##### Begin Task: accor              #####
29-Sep-2026 14:55:58 2026-09-29 18:55:59        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=[] )
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        accor::calibrater::open        Opening MS: uid_copy.ms for calibration.
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        calibrater::reset        Reseting solve/apply state
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        Calibrater::selectvis        By selection 1080 rows are reduced to 540
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        Calibrater::setsolve        Arranging to SOLVE:
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        calibrater::solve        Beginning solve-----------------------------
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        Calibrater::solve        .   (None)
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        Calibrater::solve        The following calibration term is arranged for solve:
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 84368488281.1505
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 86213458984.275
29-Sep-2026 14:55:58 2026-09-29 18:55:59        INFO        Calibrater::solve        For solint = inf, found 9 solution intervals.
29-Sep-2026 14:55:59 2026-09-29 18:55:59        INFO        Calibrater::solve        Beginning solution interval 1/9 (~11% complete)
29-Sep-2026 14:55:59 2026-09-29 18:55:59        INFO        Calibrater::solve        Beginning solution interval 2/9 (~22% complete)
29-Sep-2026 14:55:59 2026-09-29 18:55:59        INFO        Calibrater::solve        Beginning solution interval 3/9 (~33% complete)
29-Sep-2026 14:55:59 2026-09-29 18:55:59        INFO        Calibrater::solve        Beginning solution interval 4/9 (~44% complete)
29-Sep-2026 14:55:59 2026-09-29 18:55:59        INFO        Calibrater::solve        Beginning solution interval 5/9 (~55% complete)
29-Sep-2026 14:55:59 2026-09-29 18:55:59        INFO        Calibrater::solve        Beginning solution interval 6/9 (~66% complete)
29-Sep-2026 14:55:59 2026-09-29 18:55:59        INFO        Calibrater::solve        Beginning solution interval 7/9 (~77% complete)
29-Sep-2026 14:55:59 2026-09-29 18:55:59        INFO        Calibrater::solve        Beginning solution interval 8/9 (~88% complete)
29-Sep-2026 14:55:59 2026-09-29 18:55:59        INFO        Calibrater::solve          Found good Accor Jones solutions in 9 solution intervals.
29-Sep-2026 14:55:59 2026-09-29 18:55:59        INFO                Writing solutions to table: cal.A
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2   
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::solve        ----- PER SPW INFO -----
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::solve        SPW: 0 [0, 0]  [3, 3]        [0, 0]            [0, 0]
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::solve        SPW: 1 [0, 0]  [6, 6]        [0, 0]            [0, 0]
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::solve        ----- GLOBAL INFO -----
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::solve        [0, 0]  [9, 9]        [0, 0]            [0, 0]
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        calibrater::solve        Finished solving.
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        accor::::casa        Task accor complete. Start time: 2026-09-29 18:55:58.934523 End time: 2026-09-29 18:56:00.071176
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        accor::::casa        ##### End Task: accor                #####
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        accor::::casa        ##########################################
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        rmtables::::casa        Removing cal.A
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-09-29 18:56:00.072715 End time: 2026-09-29 18:56:00.091881
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        rmtables::::casa        ##### End Task: rmtables             #####
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:00 .2026-09-29 18:56:00        INFO        accor::::casa        ##########################################
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        accor::::casa        ##### Begin Task: accor              #####
29-Sep-2026 14:56:00 2026-09-29 18:56:00        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=[] )
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        accor::calibrater::open        Opening MS: VLBA_copy.ms for calibration.
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        calibrater::reset        Reseting solve/apply state
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::selectvis+         Selecting by observation IDs: '0'
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::selectvis        By selection 34540 rows are reduced to 6280
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::setsolve        Arranging to SOLVE:
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        calibrater::solve        Beginning solve-----------------------------
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::solve        .   (None)
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::solve        The following calibration term is arranged for solve:
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::solve        For solint = inf, found 6 solution intervals.
29-Sep-2026 14:56:00 2026-09-29 18:56:00        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::solve        Beginning solution interval 1/6 (~16% complete)
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::solve        Beginning solution interval 2/6 (~33% complete)
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::solve        Beginning solution interval 3/6 (~50% complete)
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::solve        Beginning solution interval 4/6 (~66% complete)
29-Sep-2026 14:56:00 2026-09-29 18:56:00        INFO        Calibrater::solve        Beginning solution interval 5/6 (~83% complete)
29-Sep-2026 14:56:00 2026-09-29 18:56:01        INFO        Calibrater::solve          Found good Accor Jones solutions in 6 solution intervals.
29-Sep-2026 14:56:00 2026-09-29 18:56:01        INFO                Writing solutions to table: cal.A
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9   
29-Sep-2026 14:56:02 2026-09-29 18:56:02        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]
29-Sep-2026 14:56:02 2026-09-29 18:56:02        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]
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::solve        ----- PER SPW INFO -----
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::solve        SPW: 0 [0, 0]  [3, 3]        [0, 0]            [0, 0]
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::solve        SPW: 1 [0, 0]  [3, 3]        [0, 0]            [0, 0]
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::solve        ----- GLOBAL INFO -----
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::solve        [0, 0]  [6, 6]        [0, 0]            [0, 0]
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        calibrater::solve        Finished solving.
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        accor::::casa        Task accor complete. Start time: 2026-09-29 18:56:00.095735 End time: 2026-09-29 18:56:02.205615
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        accor::::casa        ##### End Task: accor                #####
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        accor::::casa        ##########################################
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        rmtables::::casa        Removing cal.A
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-09-29 18:56:02.207024 End time: 2026-09-29 18:56:02.225237
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        rmtables::::casa        ##### End Task: rmtables             #####
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:02 .2026-09-29 18:56:02        INFO        accor::::casa        ##########################################
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        accor::::casa        ##### Begin Task: accor              #####
29-Sep-2026 14:56:02 2026-09-29 18:56:02        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=[] )
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        accor::calibrater::open        Opening MS: VLBA_copy.ms for calibration.
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        calibrater::reset        Reseting solve/apply state
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::selectvis+         Selecting on scan: '2'
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::selectvis        By selection 34540 rows are reduced to 1200
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::setsolve        Arranging to SOLVE:
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        calibrater::solve        Beginning solve-----------------------------
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::solve        .   (None)
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::solve        The following calibration term is arranged for solve:
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::solve        For solint = inf, found 2 solution intervals.
29-Sep-2026 14:56:02 2026-09-29 18:56:02        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::solve        Beginning solution interval 1/2 (~50% complete)
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO        Calibrater::solve          Found good Accor Jones solutions in 2 solution intervals.
29-Sep-2026 14:56:02 2026-09-29 18:56:02        INFO                Writing solutions to table: cal.A
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9   
29-Sep-2026 14:56:03 2026-09-29 18:56:04        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]
29-Sep-2026 14:56:03 2026-09-29 18:56:04        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]
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve        ----- PER SPW INFO -----
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve        SPW: 0 [0, 0]  [1, 1]        [0, 0]            [0, 0]
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve        SPW: 1 [0, 0]  [1, 1]        [0, 0]            [0, 0]
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve        ----- GLOBAL INFO -----
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve        [0, 0]  [2, 2]        [0, 0]            [0, 0]
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        calibrater::solve        Finished solving.
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        accor::::casa        Task accor complete. Start time: 2026-09-29 18:56:02.229027 End time: 2026-09-29 18:56:03.709149
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        accor::::casa        ##### End Task: accor                #####
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        accor::::casa        ##########################################
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        rmtables::::casa        Removing cal.A
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-09-29 18:56:03.713009 End time: 2026-09-29 18:56:03.732264
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        rmtables::::casa        ##### End Task: rmtables             #####
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:03 .2026-09-29 18:56:04        INFO        accor::::casa        ##########################################
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        accor::::casa        ##### Begin Task: accor              #####
29-Sep-2026 14:56:03 2026-09-29 18:56:04        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=[] )
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        accor::calibrater::open        Opening MS: uid_copy.ms for calibration.
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        calibrater::reset        Reseting solve/apply state
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::selectvis        By selection 1080 rows are reduced to 540
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::setsolve        Arranging to SOLVE:
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        calibrater::solve        Beginning solve-----------------------------
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve        .   (None)
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve        The following calibration term is arranged for solve:
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 84368488281.1505
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 86213458984.275
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve        For solint = inf, found 9 solution intervals.
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve        Beginning solution interval 1/9 (~11% complete)
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve        Beginning solution interval 2/9 (~22% complete)
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve        Beginning solution interval 3/9 (~33% complete)
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve        Beginning solution interval 4/9 (~44% complete)
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve        Beginning solution interval 5/9 (~55% complete)
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve        Beginning solution interval 6/9 (~66% complete)
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve        Beginning solution interval 7/9 (~77% complete)
29-Sep-2026 14:56:03 2026-09-29 18:56:04        INFO        Calibrater::solve        Beginning solution interval 8/9 (~88% complete)
29-Sep-2026 14:56:04 2026-09-29 18:56:04        INFO        Calibrater::solve          Found good Accor Jones solutions in 9 solution intervals.
29-Sep-2026 14:56:04 2026-09-29 18:56:04        INFO                Writing solutions to table: cal.A
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2   
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::solve        ----- PER SPW INFO -----
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::solve        SPW: 0 [0, 0]  [3, 3]        [0, 0]            [0, 0]
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::solve        SPW: 1 [0, 0]  [6, 6]        [0, 0]            [0, 0]
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::solve        ----- GLOBAL INFO -----
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::solve        [0, 0]  [9, 9]        [0, 0]            [0, 0]
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        calibrater::solve        Finished solving.
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        accor::::casa        Task accor complete. Start time: 2026-09-29 18:56:03.736410 End time: 2026-09-29 18:56:05.185021
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        accor::::casa        ##### End Task: accor                #####
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        accor::::casa        ##########################################
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        rmtables::::casa        Removing cal.A
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-09-29 18:56:05.188900 End time: 2026-09-29 18:56:05.207941
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        rmtables::::casa        ##### End Task: rmtables             #####
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        accor::::casa        ##########################################
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        accor::::casa        ##### Begin Task: accor              #####
29-Sep-2026 14:56:05 2026-09-29 18:56:05        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=[] )
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        accor::calibrater::open        Opening MS: uid_copy.ms for calibration.
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        calibrater::reset        Reseting solve/apply state
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::selectvis+         Selecting on scan: '2'
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::selectvis        By selection 1080 rows are reduced to 180
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::setsolve        Arranging to SOLVE:
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        calibrater::solve        Beginning solve-----------------------------
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::solve        .   (None)
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::solve        The following calibration term is arranged for solve:
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 84368488281.1505
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 86213458984.275
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::solve        For solint = inf, found 2 solution intervals.
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::solve        Beginning solution interval 1/2 (~50% complete)
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO        Calibrater::solve          Found good Accor Jones solutions in 2 solution intervals.
29-Sep-2026 14:56:05 2026-09-29 18:56:05        INFO                Writing solutions to table: cal.A
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2   
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::solve        ----- PER SPW INFO -----
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::solve        SPW: 0 [0, 0]  [1, 1]        [0, 0]            [0, 0]
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::solve        SPW: 1 [0, 0]  [1, 1]        [0, 0]            [0, 0]
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::solve        ----- GLOBAL INFO -----
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::solve        [0, 0]  [2, 2]        [0, 0]            [0, 0]
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        calibrater::solve        Finished solving.
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        accor::::casa        Task accor complete. Start time: 2026-09-29 18:56:05.211205 End time: 2026-09-29 18:56:07.315411
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        accor::::casa        ##### End Task: accor                #####
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        accor::::casa        ##########################################
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        rmtables::::casa        Removing cal.A
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-09-29 18:56:07.318896 End time: 2026-09-29 18:56:07.336823
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        rmtables::::casa        ##### End Task: rmtables             #####
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-09-29 18:56:07.337872 End time: 2026-09-29 18:56:07.364382
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        rmtables::::casa        ##### End Task: rmtables             #####
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:07 .2026-09-29 18:56:07        INFO        accor::::casa        ##########################################
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        accor::::casa        ##### Begin Task: accor              #####
29-Sep-2026 14:56:07 2026-09-29 18:56:07        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=[] )
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        accor::calibrater::open        Opening MS: VLBA_copy.ms for calibration.
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        calibrater::reset        Reseting solve/apply state
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::selectvis        By selection 34540 rows are reduced to 6280
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::setsolve        Arranging to SOLVE:
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=10s refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        calibrater::solve        Beginning solve-----------------------------
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::solve        .   (None)
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::solve        The following calibration term is arranged for solve:
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=10s refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
29-Sep-2026 14:56:07 2026-09-29 18:56:07        INFO        Calibrater::solve        For solint = 10s, found 126 solution intervals.
29-Sep-2026 14:56:07 2026-09-29 18:56:07        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
29-Sep-2026 14:56:07 2026-09-29 18:56:08        INFO        Calibrater::solve        Beginning solution interval 13/126 (~10% complete)
29-Sep-2026 14:56:07 2026-09-29 18:56:08        INFO        Calibrater::solve        Beginning solution interval 26/126 (~20% complete)
29-Sep-2026 14:56:07 2026-09-29 18:56:08        INFO        Calibrater::solve        Beginning solution interval 39/126 (~30% complete)
29-Sep-2026 14:56:07 2026-09-29 18:56:08        INFO        Calibrater::solve        Beginning solution interval 52/126 (~41% complete)
29-Sep-2026 14:56:07 2026-09-29 18:56:08        INFO        Calibrater::solve        Beginning solution interval 65/126 (~51% complete)
29-Sep-2026 14:56:07 2026-09-29 18:56:08        INFO        Calibrater::solve        Beginning solution interval 78/126 (~61% complete)
29-Sep-2026 14:56:07 2026-09-29 18:56:08        INFO        Calibrater::solve        Beginning solution interval 91/126 (~72% complete)
29-Sep-2026 14:56:07 2026-09-29 18:56:08        INFO        Calibrater::solve        Beginning solution interval 104/126 (~82% complete)
29-Sep-2026 14:56:08 2026-09-29 18:56:08        INFO        Calibrater::solve        Beginning solution interval 117/126 (~92% complete)
29-Sep-2026 14:56:08 2026-09-29 18:56:08        INFO        Calibrater::solve          Found good Accor Jones solutions in 126 solution intervals.
29-Sep-2026 14:56:08 2026-09-29 18:56:08        INFO                Writing solutions to table: cal.A
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9   
29-Sep-2026 14:56:09 2026-09-29 18:56: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]
29-Sep-2026 14:56:09 2026-09-29 18:56:10        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]
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::solve        ----- PER SPW INFO -----
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::solve        SPW: 0 [0, 0]  [63, 63]        [0, 0]            [0, 0]
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::solve        SPW: 1 [0, 0]  [63, 63]        [0, 0]            [0, 0]
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::solve        ----- GLOBAL INFO -----
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::solve        [0, 0]  [126, 126]        [0, 0]            [0, 0]
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        calibrater::solve        Finished solving.
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        accor::::casa        Task accor complete. Start time: 2026-09-29 18:56:07.368926 End time: 2026-09-29 18:56:09.806500
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        accor::::casa        ##### End Task: accor                #####
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        accor::::casa        ##########################################
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        rmtables::::casa        Removing cal.A
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-09-29 18:56:09.811569 End time: 2026-09-29 18:56:09.829605
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        rmtables::::casa        ##### End Task: rmtables             #####
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:09 .2026-09-29 18:56:10        INFO        accor::::casa        ##########################################
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        accor::::casa        ##### Begin Task: accor              #####
29-Sep-2026 14:56:09 2026-09-29 18:56:10        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=[] )
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        accor::calibrater::open        Opening MS: uid_copy.ms for calibration.
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        calibrater::reset        Reseting solve/apply state
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::selectvis+         Selecting on spw: '1'
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::selectvis        By selection 1080 rows are reduced to 405
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::selectvis        Frequency selection:
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::selectvis        .  Spw 1:0~0 (1 channels, step by 1)
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::setsolve        Arranging to SOLVE:
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        calibrater::solve        Beginning solve-----------------------------
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::solve        .   (None)
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::solve        The following calibration term is arranged for solve:
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 86213458984.275
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::solve        For solint = inf, found 3 solution intervals.
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::solve        Beginning solution interval 1/3 (~33% complete)
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::solve        Beginning solution interval 2/3 (~66% complete)
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO        Calibrater::solve          Found good Accor Jones solutions in 3 solution intervals.
29-Sep-2026 14:56:09 2026-09-29 18:56:10        INFO                Writing solutions to table: cal.A
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2   
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::solve        ----- PER SPW INFO -----
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]        [0, 0]            [0, 0]
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::solve        SPW: 1 [0, 0]  [3, 3]        [0, 0]            [0, 0]
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::solve        ----- GLOBAL INFO -----
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::solve        [0, 0]  [3, 3]        [0, 0]            [0, 0]
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        calibrater::solve        Finished solving.
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        accor::::casa        Task accor complete. Start time: 2026-09-29 18:56:09.833404 End time: 2026-09-29 18:56:13.042034
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        accor::::casa        ##### End Task: accor                #####
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        accor::::casa        ##########################################
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        rmtables::::casa        Removing cal.A
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-09-29 18:56:13.045896 End time: 2026-09-29 18:56:13.065128
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        rmtables::::casa        ##### End Task: rmtables             #####
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:13 .2026-09-29 18:56:13        INFO        accor::::casa        ##########################################
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        accor::::casa        ##### Begin Task: accor              #####
29-Sep-2026 14:56:13 2026-09-29 18:56:13        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=[] )
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        accor::calibrater::open        Opening MS: VLBA_copy.ms for calibration.
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        calibrater::reset        Reseting solve/apply state
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::selectvis        By selection 34540 rows are reduced to 6280
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::setsolve        Arranging to SOLVE:
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.B append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        calibrater::solve        Beginning solve-----------------------------
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::solve        .   (None)
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::solve        The following calibration term is arranged for solve:
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::solve        .   Accor Jones: table=cal.B append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::solve        For solint = inf, found 6 solution intervals.
29-Sep-2026 14:56:13 2026-09-29 18:56:13        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::solve        Beginning solution interval 1/6 (~16% complete)
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::solve        Beginning solution interval 2/6 (~33% complete)
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::solve        Beginning solution interval 3/6 (~50% complete)
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::solve        Beginning solution interval 4/6 (~66% complete)
29-Sep-2026 14:56:13 2026-09-29 18:56:13        INFO        Calibrater::solve        Beginning solution interval 5/6 (~83% complete)
29-Sep-2026 14:56:13 2026-09-29 18:56:14        INFO        Calibrater::solve          Found good Accor Jones solutions in 6 solution intervals.
29-Sep-2026 14:56:13 2026-09-29 18:56:14        INFO                Writing solutions to table: cal.B
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9   
29-Sep-2026 14:56:14 2026-09-29 18:56:15        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]
29-Sep-2026 14:56:14 2026-09-29 18:56:15        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]
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        Calibrater::solve        ----- PER SPW INFO -----
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        Calibrater::solve        SPW: 0 [0, 0]  [3, 3]        [0, 0]            [0, 0]
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        Calibrater::solve        SPW: 1 [0, 0]  [3, 3]        [0, 0]            [0, 0]
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        Calibrater::solve        ----- GLOBAL INFO -----
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        Calibrater::solve        [0, 0]  [6, 6]        [0, 0]            [0, 0]
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        calibrater::solve        Finished solving.
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        accor::::casa        Task accor complete. Start time: 2026-09-29 18:56:13.069133 End time: 2026-09-29 18:56:14.885675
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        accor::::casa        ##### End Task: accor                #####
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        accor::::casa        ##########################################
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        accor::::casa        ##########################################
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        accor::::casa        ##### Begin Task: accor              #####
29-Sep-2026 14:56:14 2026-09-29 18:56:15        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] )
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        accor::calibrater::open        Opening MS: VLBA_copy.ms for calibration.
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        calibrater::reset        Reseting solve/apply state
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        Calibrater::selectvis        By selection 34540 rows are reduced to 6280
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        calibrater::setapply        Beginning setapply--(MSSelection version)-------
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        Calibrater::setapply(type, applypar)        Arranging to APPLY:
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        Calibrater::setapply(type, applypar)        .   Accor Jones: table=cal.B select= interp=linear spwmap=[0, 0] calWt=true
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        Calibrater::setsolve        Arranging to SOLVE:
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        calibrater::solve        Beginning solve-----------------------------
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        Calibrater::solve        .   Accor Jones: table=cal.B select= interp=linear spwmap=[0, 0] calWt=true
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        Calibrater::solve        The following calibration term is arranged for solve:
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:56:14 2026-09-29 18:56:15        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
29-Sep-2026 14:56:15 2026-09-29 18:56:15        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
29-Sep-2026 14:56:15 2026-09-29 18:56:15        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
29-Sep-2026 14:56:15 2026-09-29 18:56:15        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
29-Sep-2026 14:56:15 2026-09-29 18:56:15        INFO        Calibrater::solve        For solint = inf, found 6 solution intervals.
29-Sep-2026 14:56:15 2026-09-29 18:56:15        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
29-Sep-2026 14:56:15 2026-09-29 18:56:15        INFO        Calibrater::solve        Beginning solution interval 1/6 (~16% complete)
29-Sep-2026 14:56:15 2026-09-29 18:56:15        INFO        Calibrater::solve        Beginning solution interval 2/6 (~33% complete)
29-Sep-2026 14:56:15 2026-09-29 18:56:15        INFO        Calibrater::solve        Beginning solution interval 3/6 (~50% complete)
29-Sep-2026 14:56:15 2026-09-29 18:56:15        INFO        Calibrater::solve        Beginning solution interval 4/6 (~66% complete)
29-Sep-2026 14:56:15 2026-09-29 18:56:15        INFO        Calibrater::solve        Beginning solution interval 5/6 (~83% complete)
29-Sep-2026 14:56:15 2026-09-29 18:56:15        INFO        Calibrater::solve          Found good Accor Jones solutions in 6 solution intervals.
29-Sep-2026 14:56:15 2026-09-29 18:56:15        INFO                Writing solutions to table: cal.A
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9   
29-Sep-2026 14:56:16 2026-09-29 18:56:17        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]
29-Sep-2026 14:56:16 2026-09-29 18:56:17        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]
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::solve        ----- PER SPW INFO -----
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::solve        SPW: 0 [0, 0]  [3, 3]        [0, 0]            [0, 0]
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::solve        SPW: 1 [0, 0]  [3, 3]        [0, 0]            [0, 0]
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::solve        ----- GLOBAL INFO -----
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::solve        [0, 0]  [6, 6]        [0, 0]            [0, 0]
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        calibrater::solve        Finished solving.
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        accor::::casa        Task accor complete. Start time: 2026-09-29 18:56:14.890031 End time: 2026-09-29 18:56:16.801987
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        accor::::casa        ##### End Task: accor                #####
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        accor::::casa        ##########################################
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        rmtables::::casa        Removing cal.A
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-09-29 18:56:16.805655 End time: 2026-09-29 18:56:16.823254
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        rmtables::::casa        ##### End Task: rmtables             #####
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        rmtables::::casa        rmtables( tablenames=['cal.B'] )
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        rmtables::::casa        Removing cal.B
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-09-29 18:56:16.824277 End time: 2026-09-29 18:56:16.839814
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        rmtables::::casa        ##### End Task: rmtables             #####
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:16 .2026-09-29 18:56:17        INFO        accor::::casa        ##########################################
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        accor::::casa        ##### Begin Task: accor              #####
29-Sep-2026 14:56:16 2026-09-29 18:56:17        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=[] )
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        accor::calibrater::open        Opening MS: VLBA_copy.ms for calibration.
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        calibrater::reset        Reseting solve/apply state
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::selectvis+         Selecting on time: '00:21:11.0~00:23:11.0'
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::selectvis        By selection 34540 rows are reduced to 1200
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::setsolve        Arranging to SOLVE:
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        calibrater::solve        Beginning solve-----------------------------
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::solve        .   (None)
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::solve        The following calibration term is arranged for solve:
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::solve        For solint = inf, found 2 solution intervals.
29-Sep-2026 14:56:16 2026-09-29 18:56:17        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::solve        Beginning solution interval 1/2 (~50% complete)
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO        Calibrater::solve          Found good Accor Jones solutions in 2 solution intervals.
29-Sep-2026 14:56:16 2026-09-29 18:56:17        INFO                Writing solutions to table: cal.A
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9   
29-Sep-2026 14:56:18 2026-09-29 18:56: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]
29-Sep-2026 14:56:18 2026-09-29 18:56:18        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]
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        Calibrater::solve        ----- PER SPW INFO -----
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        Calibrater::solve        SPW: 0 [0, 0]  [1, 1]        [0, 0]            [0, 0]
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        Calibrater::solve        SPW: 1 [0, 0]  [1, 1]        [0, 0]            [0, 0]
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        Calibrater::solve        ----- GLOBAL INFO -----
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        Calibrater::solve        [0, 0]  [2, 2]        [0, 0]            [0, 0]
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        calibrater::solve        Finished solving.
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        accor::::casa        Task accor complete. Start time: 2026-09-29 18:56:16.843120 End time: 2026-09-29 18:56:18.118175
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        accor::::casa        ##### End Task: accor                #####
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        accor::::casa        ##########################################
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        rmtables::::casa        Removing cal.A
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-09-29 18:56:18.122222 End time: 2026-09-29 18:56:18.141172
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        rmtables::::casa        ##### End Task: rmtables             #####
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:18 .2026-09-29 18:56:18        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        rmtables::::casa        rmtables( tablenames=['cal.default'] )
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-09-29 18:56:18.211231 End time: 2026-09-29 18:56:18.211869
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        rmtables::::casa        ##### End Task: rmtables             #####
29-Sep-2026 14:56:18 2026-09-29 18:56:18        INFO        rmtables::::casa        ##########################################
29-Sep-2026 14:56:18
29-Sep-2026 14:56:18 ----------------------------------------------------------------------
29-Sep-2026 14:56:18 Ran 18 tests in 78.898s
29-Sep-2026 14:56:18
29-Sep-2026 14:56:18 OK
29-Sep-2026 14:56:18
29-Sep-2026 14:56:18 Generating XML reports...
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa        Using user configuration file /home/casatest/.casa/config.py
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa        loaded config file : /wheeldirectory/casa-6.7.7-10-py3.12.el8/lib/py/lib/python3.12/site-packages/casaconfig/config.py
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa        loaded config file : /home/casatest/.casa/config.py
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa        
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa        config values
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            agg = False
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            cachedir = '/home/casatest/.casa'
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            casaconfig_verbose = 1
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            colors = 'Neutral'
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            data_auto_update = False
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            data_update_interval = 1
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            datapath = ['/opt/casa/data/master', '/opt/casa/data/casatestdata']
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            iplog = False
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            iplogfile = '/home/casatest/casa6/casatasks/tests/casashell_tests/work/test_task_appendantab_casashell/ipython-20260929-185619.log'
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            log2term = True
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            logfile = '/home/casatest/casa6/casatasks/tests/casashell_tests/work/test_task_appendantab_casashell/casa-20260929-185619.log'
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            measures_auto_update = False
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            measures_site = ['https://www.astron.nl/iers/', 'https://go.nrao.edu/iers/']
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            measures_site_interval = 2
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            measures_update_interval = 1
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            measurespath = '/opt/casa/data/master'
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            nogui = False
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            nologfile = False
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            nologger = True
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            pipeline = False
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            skipnetworkcheck = False
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            startupfile = '/home/casatest/.casa/startup.py'
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa            user_site = False
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa        
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa        casarundata version is unknown, this is probably a legacy version not installed by casaconfig
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa        measures version : WSRT_Measures_20211217-160001.ztar
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa        
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa        Checking Measures tables in data repository sub-directory /opt/casa/data/master/geodetic
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa          IERSeop2000 (version date, last date in table (UTC)): 2026/09/10/15:15, 2026/08/11/00:00:00
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa          IERSeop97 (version date, last date in table (UTC)): 2026/09/10/15:15, 2026/08/11/00:00:00
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa          IERSpredict (version date, last date in table (UTC)): 2026/09/29/15:15, 2026/12/28/00:00:00
29-Sep-2026 14:56:22 2026-09-29 18:56:23        INFO        ::casa          TAI_UTC (version date, last date in table (UTC)): 2026/09/03/15:15, 2017/01/01/00:00:00
29-Sep-2026 14:56:22
29-Sep-2026 14:56:22 Running tests...
29-Sep-2026 14:56:22 ----------------------------------------------------------------------
29-Sep-2026 14:56:22
29-Sep-2026 14:56:22 Using user configuration file /home/casatest/.casa/config.py
29-Sep-2026 14:56:22
29-Sep-2026 14:56:22 No event loop hook running.
29-Sep-2026 14:56:22 Using matplotlib backend: agg
29-Sep-2026 14:56:22 CASA 6.7.7.10 -- Common Astronomy Software Applications [6.7.7.10]
29-Sep-2026 14:58:27 2026-09-29 18:58:28        INFO        appendantab::::casa        ##########################################
29-Sep-2026 14:58:27 2026-09-29 18:58:28        INFO        appendantab::::casa        ##### Begin Task: appendantab        #####
29-Sep-2026 14:58:27 2026-09-29 18:58:28        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 )
29-Sep-2026 14:58:27 2026-09-29 18:58:28        INFO        msmetadata_cmpt.cc::open        Performing internal consistency checks on vla_copy.ms...
29-Sep-2026 14:58:29 2026-09-29 18:58:30        INFO        appendantab::::casa        Task appendantab complete. Start time: 2026-09-29 18:58:27.883079 End time: 2026-09-29 18:58:29.520375
29-Sep-2026 14:58:29 2026-09-29 18:58:30        INFO        appendantab::::casa        ##### End Task: appendantab          #####
29-Sep-2026 14:58:29 2026-09-29 18:58:30        INFO        appendantab::::casa        ##########################################
29-Sep-2026 14:58:30 Antenna MK not present in the Measurement Set. MK values will be ignored.
29-Sep-2026 14:58:34 .2026-09-29 18:58:35        INFO        appendantab::::casa        ##########################################
29-Sep-2026 14:58:34 2026-09-29 18:58:35        INFO        appendantab::::casa        ##### Begin Task: appendantab        #####
29-Sep-2026 14:58:34 2026-09-29 18:58:35        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 )
29-Sep-2026 14:58:34 2026-09-29 18:58:35        INFO        msmetadata_cmpt.cc::open        Performing internal consistency checks on dataCopy.ms...
29-Sep-2026 15:05:00 2026-09-29 19:05:01        INFO        appendantab::::casa        Task appendantab complete. Start time: 2026-09-29 18:58:34.557586 End time: 2026-09-29 19:05:00.722517
29-Sep-2026 15:05:00 2026-09-29 19:05:01        INFO        appendantab::::casa        ##### End Task: appendantab          #####
29-Sep-2026 15:05:00 2026-09-29 19:05:01        INFO        appendantab::::casa        ##########################################
29-Sep-2026 15:05:01 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:05:01 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:05:01 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:05:01 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:05:01 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:05:01 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:05:01 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:05:01 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:05:01 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:05:01 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO SPW ID -1 and freq to [0, 0]
29-Sep-2026 15:05:01 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:05:01 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:05:01 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:05:01
29-Sep-2026 15:05:01 Testing column ANTENNA_ID
29-Sep-2026 15:05:01 Column ANTENNA_ID PASSED
29-Sep-2026 15:05:01
29-Sep-2026 15:05:01 Testing column FEED_ID
29-Sep-2026 15:05:01 Column FEED_ID PASSED
29-Sep-2026 15:05:01
29-Sep-2026 15:05:01 Testing column INTERVAL
29-Sep-2026 15:05:01 Column INTERVAL PASSED
29-Sep-2026 15:05:01
29-Sep-2026 15:05:01 Testing column SPECTRAL_WINDOW_ID
29-Sep-2026 15:05:01 Column SPECTRAL_WINDOW_ID PASSED
29-Sep-2026 15:05:01
29-Sep-2026 15:05:01 Testing column TIME
29-Sep-2026 15:05:01 Column TIME PASSED
29-Sep-2026 15:05:01
29-Sep-2026 15:05:01 Testing column TSYS
29-Sep-2026 15:05:01 Column TSYS PASSED
29-Sep-2026 15:05:01 -----------------------------
29-Sep-2026 15:05:05 .2026-09-29 19:05:05        INFO        appendantab::::casa        ##########################################
29-Sep-2026 15:05:05 2026-09-29 19:05:05        INFO        appendantab::::casa        ##### Begin Task: appendantab        #####
29-Sep-2026 15:05:05 2026-09-29 19:05:05        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 )
29-Sep-2026 15:05:05 2026-09-29 19:05:05        INFO        msmetadata_cmpt.cc::open        Performing internal consistency checks on dataCopy.ms...
29-Sep-2026 15:10:17 2026-09-29 19:10:17        INFO        appendantab::::casa        Task appendantab complete. Start time: 2026-09-29 19:05:05.008952 End time: 2026-09-29 19:10:17.490431
29-Sep-2026 15:10:17 2026-09-29 19:10:17        INFO        appendantab::::casa        ##### End Task: appendantab          #####
29-Sep-2026 15:10:17 2026-09-29 19:10:17        INFO        appendantab::::casa        ##########################################
29-Sep-2026 15:10:18 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:10:18 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:10:18 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:10:18 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:10:18 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:10:18 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:10:18 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:10:18 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:10:18 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:10:18 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO SPW ID -1 and freq to [0, 0]
29-Sep-2026 15:10:18 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:10:18 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:10:18 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
29-Sep-2026 15:10:18 -----------------------------
29-Sep-2026 15:10:18
29-Sep-2026 15:10:18 Testing column ANTENNA_ID
29-Sep-2026 15:10:18 Column ANTENNA_ID PASSED
29-Sep-2026 15:10:18
29-Sep-2026 15:10:18 Testing column FEED_ID
29-Sep-2026 15:10:18 Column FEED_ID PASSED
29-Sep-2026 15:10:18
29-Sep-2026 15:10:18 Testing column SPECTRAL_WINDOW_ID
29-Sep-2026 15:10:18 Column SPECTRAL_WINDOW_ID PASSED
29-Sep-2026 15:10:18
29-Sep-2026 15:10:18 Testing column TIME
29-Sep-2026 15:10:18 Column TIME PASSED
29-Sep-2026 15:10:18
29-Sep-2026 15:10:18 Testing column INTERVAL
29-Sep-2026 15:10:18 Column INTERVAL PASSED
29-Sep-2026 15:10:18
29-Sep-2026 15:10:18 Testing column TYPE
29-Sep-2026 15:10:18 Column TYPE PASSED
29-Sep-2026 15:10:18
29-Sep-2026 15:10:18 Testing column NUM_POLY
29-Sep-2026 15:10:18 Column NUM_POLY PASSED
29-Sep-2026 15:10:18
29-Sep-2026 15:10:18 Testing column SENSITIVITY
29-Sep-2026 15:10:18 Column SENSITIVITY PASSED
29-Sep-2026 15:10:21 .2026-09-29 19:10:22        INFO        appendantab::::casa        ##########################################
29-Sep-2026 15:10:21 2026-09-29 19:10:22        INFO        appendantab::::casa        ##### Begin Task: appendantab        #####
29-Sep-2026 15:10:21 2026-09-29 19:10:22        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=False )
29-Sep-2026 15:10:21 2026-09-29 19:10:22        INFO        msmetadata_cmpt.cc::open        Performing internal consistency checks on dataCopy.ms...
29-Sep-2026 15:20:55 Agent 'cbt-el7-11.cv.nrao.edu' went offline while building CASASPECS-MASTERTESTCASALITHPY312-TTC2-295. The results of that build will not be available.