Build: #266 did not complete

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

Build log

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

22-Apr-2026 20:26:03 2026-04-23 00:26:04        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
22-Apr-2026 20:26:03 2026-04-23 00:26:04        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
22-Apr-2026 20:26:03 2026-04-23 00:26:04        INFO        Calibrater::solve        For solint = inf, found 6 solution intervals.
22-Apr-2026 20:26:03 2026-04-23 00:26:04        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
22-Apr-2026 20:26:03 2026-04-23 00:26:04        INFO        Calibrater::solve        Beginning solution interval 1/6 (~16% complete)
22-Apr-2026 20:26:03 2026-04-23 00:26:04        INFO        Calibrater::solve        Beginning solution interval 2/6 (~33% complete)
22-Apr-2026 20:26:03 2026-04-23 00:26:04        INFO        Calibrater::solve        Beginning solution interval 3/6 (~50% complete)
22-Apr-2026 20:26:03 2026-04-23 00:26:04        INFO        Calibrater::solve        Beginning solution interval 4/6 (~66% complete)
22-Apr-2026 20:26:03 2026-04-23 00:26:04        INFO        Calibrater::solve        Beginning solution interval 5/6 (~83% complete)
22-Apr-2026 20:26:04 2026-04-23 00:26:04        INFO        Calibrater::solve          Found good Accor Jones solutions in 6 solution intervals.
22-Apr-2026 20:26:04 2026-04-23 00:26:04        INFO                Writing solutions to table: cal.B
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9   
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::solve        SPW: 0 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::solve        SPW: 1 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::solve        [0, 0]  [6, 6]        [0, 0]            [0, 0]
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        calibrater::solve        Finished solving.
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        accor::::casa        Task accor complete. Start time: 2026-04-23 00:26:03.586596 End time: 2026-04-23 00:26:06.847480
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        accor::::casa        ##### End Task: accor                #####
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        accor::::casa        ##### Begin Task: accor              #####
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        accor::::casa        accor( vis='VLBA_copy.ms', caltable='cal.A', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=['cal.B'], gainfield=[], interp=[], spwmap=[] )
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        accor::calibrater::open        Opening MS: VLBA_copy.ms for calibration.
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        calibrater::reset        Reseting solve/apply state
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::selectvis        By selection 34540 rows are reduced to 6280
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        calibrater::setapply        Beginning setapply--(MSSelection version)-------
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::setapply(type, applypar)        Arranging to APPLY:
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::setapply(type, applypar)        .   Accor Jones: table=cal.B select= interp=linear spwmap=[-1] calWt=true
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        calibrater::solve        Beginning solve-----------------------------
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::solve        .   Accor Jones: table=cal.B select= interp=linear spwmap=[-1] calWt=true
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
22-Apr-2026 20:26:06 2026-04-23 00:26:07        INFO        Calibrater::solve        For solint = inf, found 6 solution intervals.
22-Apr-2026 20:26:07 2026-04-23 00:26:07        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
22-Apr-2026 20:26:07 2026-04-23 00:26:07        INFO        Calibrater::solve        Beginning solution interval 1/6 (~16% complete)
22-Apr-2026 20:26:07 2026-04-23 00:26:07        INFO        Calibrater::solve        Beginning solution interval 2/6 (~33% complete)
22-Apr-2026 20:26:07 2026-04-23 00:26:07        INFO        Calibrater::solve        Beginning solution interval 3/6 (~50% complete)
22-Apr-2026 20:26:07 2026-04-23 00:26:07        INFO        Calibrater::solve        Beginning solution interval 4/6 (~66% complete)
22-Apr-2026 20:26:07 2026-04-23 00:26:07        INFO        Calibrater::solve        Beginning solution interval 5/6 (~83% complete)
22-Apr-2026 20:26:07 2026-04-23 00:26:07        INFO        Calibrater::solve          Found good Accor Jones solutions in 6 solution intervals.
22-Apr-2026 20:26:07 2026-04-23 00:26:07        INFO                Writing solutions to table: cal.A
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9   
22-Apr-2026 20:26:09 2026-04-23 00:26: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]
22-Apr-2026 20:26:09 2026-04-23 00:26: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]
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        Calibrater::solve        SPW: 0 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        Calibrater::solve        SPW: 1 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        Calibrater::solve        [0, 0]  [6, 6]        [0, 0]            [0, 0]
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        calibrater::solve        Finished solving.
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        accor::::casa        Task accor complete. Start time: 2026-04-23 00:26:06.851454 End time: 2026-04-23 00:26:09.949602
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        accor::::casa        ##### End Task: accor                #####
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        rmtables::::casa        Removing cal.A
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-04-23 00:26:09.953065 End time: 2026-04-23 00:26:09.968070
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        rmtables::::casa        rmtables( tablenames=['cal.B'] )
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        rmtables::::casa        Removing cal.B
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-04-23 00:26:09.968990 End time: 2026-04-23 00:26:09.982923
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:09 .2026-04-23 00:26:10        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        accor::::casa        ##### Begin Task: accor              #####
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        accor::::casa        accor( vis='uid_copy.ms', caltable='cal.A', field='', spw='', intent='*AMPLI*', selectdata=True, timerange='', antenna='', scan='', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-Apr-2026 20:26:09 2026-04-23 00:26:10        INFO        accor::calibrater::open        Opening MS: uid_copy.ms for calibration.
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        calibrater::reset        Reseting solve/apply state
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        Calibrater::selectvis+         Selecting on intent: '*AMPLI*'
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        Calibrater::selectvis        By selection 1080 rows are reduced to 180
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        calibrater::solve        Beginning solve-----------------------------
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        Calibrater::solve        .   (None)
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 84368488281.1505
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 86213458984.275
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        Calibrater::solve        For solint = inf, found 2 solution intervals.
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        Calibrater::solve        Beginning solution interval 1/2 (~50% complete)
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO        Calibrater::solve          Found good Accor Jones solutions in 2 solution intervals.
22-Apr-2026 20:26:10 2026-04-23 00:26:10        INFO                Writing solutions to table: cal.A
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2   
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve        SPW: 0 [0, 0]  [1, 1]        [0, 0]            [0, 0]
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve        SPW: 1 [0, 0]  [1, 1]        [0, 0]            [0, 0]
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve        [0, 0]  [2, 2]        [0, 0]            [0, 0]
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        calibrater::solve        Finished solving.
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        accor::::casa        Task accor complete. Start time: 2026-04-23 00:26:09.985835 End time: 2026-04-23 00:26:13.067170
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        accor::::casa        ##### End Task: accor                #####
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        rmtables::::casa        Removing cal.A
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-04-23 00:26:13.071395 End time: 2026-04-23 00:26:13.091592
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:13 .2026-04-23 00:26:13        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        accor::::casa        ##### Begin Task: accor              #####
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        accor::::casa        accor( vis='vla_copy.ms', caltable='cal.B', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        accor::calibrater::open        Opening MS: vla_copy.ms for calibration.
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        calibrater::reset        Reseting solve/apply state
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::selectvis        By selection 22653 rows are reduced to 1619
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.B append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        calibrater::solve        Beginning solve-----------------------------
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve        .   (None)
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve        .   Accor Jones: table=cal.B append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1]
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 1413421909.70627
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve        For solint = inf, found 7 solution intervals.
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve        Beginning solution interval 1/7 (~14% complete)
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve        Beginning solution interval 2/7 (~28% complete)
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve        Beginning solution interval 3/7 (~42% complete)
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve        Beginning solution interval 4/7 (~57% complete)
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve        Beginning solution interval 5/7 (~71% complete)
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve        Beginning solution interval 6/7 (~85% complete)
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO        Calibrater::solve          Found good Accor Jones solutions in 7 solution intervals.
22-Apr-2026 20:26:13 2026-04-23 00:26:13        INFO                Writing solutions to table: cal.B
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9    ANT: 10    ANT: 11    ANT: 12    ANT: 13    ANT: 14    ANT: 15    ANT: 16    ANT: 17    ANT: 18    ANT: 19    ANT: 20    ANT: 21    ANT: 22    ANT: 23    ANT: 24    ANT: 25    ANT: 26    ANT: 27   
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::solve        SPW: 0 [0, 0]  [7, 7]        [0, 0]            [0, 0]
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::solve        [0, 0]  [7, 7]        [0, 0]            [0, 0]
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        calibrater::solve        Finished solving.
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        accor::::casa        Task accor complete. Start time: 2026-04-23 00:26:13.095933 End time: 2026-04-23 00:26:15.601134
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        accor::::casa        ##### End Task: accor                #####
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        accor::::casa        ##### Begin Task: accor              #####
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        accor::::casa        accor( vis='vla_copy.ms', caltable='cal.A', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=['cal.B'], gainfield=[], interp=[], spwmap=[] )
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        accor::calibrater::open        Opening MS: vla_copy.ms for calibration.
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        calibrater::reset        Reseting solve/apply state
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::selectvis        By selection 22653 rows are reduced to 1619
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        calibrater::setapply        Beginning setapply--(MSSelection version)-------
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::setapply(type, applypar)        Arranging to APPLY:
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::setapply(type, applypar)        .   Accor Jones: table=cal.B select= interp=linear spwmap=[-1] calWt=true
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        calibrater::solve        Beginning solve-----------------------------
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::solve        .   Accor Jones: table=cal.B select= interp=linear spwmap=[-1] calWt=true
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1]
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 1413421909.70627
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::solve        For solint = inf, found 7 solution intervals.
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::solve        Beginning solution interval 1/7 (~14% complete)
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::solve        Beginning solution interval 2/7 (~28% complete)
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::solve        Beginning solution interval 3/7 (~42% complete)
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::solve        Beginning solution interval 4/7 (~57% complete)
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::solve        Beginning solution interval 5/7 (~71% complete)
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::solve        Beginning solution interval 6/7 (~85% complete)
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO        Calibrater::solve          Found good Accor Jones solutions in 7 solution intervals.
22-Apr-2026 20:26:15 2026-04-23 00:26:16        INFO                Writing solutions to table: cal.A
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9    ANT: 10    ANT: 11    ANT: 12    ANT: 13    ANT: 14    ANT: 15    ANT: 16    ANT: 17    ANT: 18    ANT: 19    ANT: 20    ANT: 21    ANT: 22    ANT: 23    ANT: 24    ANT: 25    ANT: 26    ANT: 27   
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::solve        SPW: 0 [0, 0]  [7, 7]        [0, 0]            [0, 0]
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::solve        [0, 0]  [7, 7]        [0, 0]            [0, 0]
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        calibrater::solve        Finished solving.
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        accor::::casa        Task accor complete. Start time: 2026-04-23 00:26:15.605029 End time: 2026-04-23 00:26:18.067361
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        accor::::casa        ##### End Task: accor                #####
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        accor::::casa        ##### Begin Task: accor              #####
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        accor::::casa        accor( vis='vla_copy.ms', caltable='cal.C', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=['cal.B'], gainfield=[], interp=['nearest'], spwmap=[] )
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        accor::calibrater::open        Opening MS: vla_copy.ms for calibration.
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        calibrater::reset        Reseting solve/apply state
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::selectvis        By selection 22653 rows are reduced to 1619
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        calibrater::setapply        Beginning setapply--(MSSelection version)-------
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::setapply(type, applypar)        Arranging to APPLY:
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::setapply(type, applypar)        .   Accor Jones: table=cal.B select= interp=nearest spwmap=[-1] calWt=true
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.C append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        calibrater::solve        Beginning solve-----------------------------
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::solve        .   Accor Jones: table=cal.B select= interp=nearest spwmap=[-1] calWt=true
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::solve        .   Accor Jones: table=cal.C append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1]
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 1413421909.70627
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::solve        For solint = inf, found 7 solution intervals.
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::solve        Beginning solution interval 1/7 (~14% complete)
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::solve        Beginning solution interval 2/7 (~28% complete)
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::solve        Beginning solution interval 3/7 (~42% complete)
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::solve        Beginning solution interval 4/7 (~57% complete)
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::solve        Beginning solution interval 5/7 (~71% complete)
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::solve        Beginning solution interval 6/7 (~85% complete)
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO        Calibrater::solve          Found good Accor Jones solutions in 7 solution intervals.
22-Apr-2026 20:26:18 2026-04-23 00:26:18        INFO                Writing solutions to table: cal.C
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9    ANT: 10    ANT: 11    ANT: 12    ANT: 13    ANT: 14    ANT: 15    ANT: 16    ANT: 17    ANT: 18    ANT: 19    ANT: 20    ANT: 21    ANT: 22    ANT: 23    ANT: 24    ANT: 25    ANT: 26    ANT: 27   
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        Calibrater::solve        SPW: 0 [0, 0]  [7, 7]        [0, 0]            [0, 0]
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        Calibrater::solve        [0, 0]  [7, 7]        [0, 0]            [0, 0]
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        calibrater::solve        Finished solving.
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        accor::::casa        Task accor complete. Start time: 2026-04-23 00:26:18.071794 End time: 2026-04-23 00:26:20.434305
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        accor::::casa        ##### End Task: accor                #####
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        rmtables::::casa        rmtables( tablenames=['cal.C'] )
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        rmtables::::casa        Removing cal.C
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-04-23 00:26:20.439634 End time: 2026-04-23 00:26:20.455463
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        rmtables::::casa        Removing cal.A
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-04-23 00:26:20.456443 End time: 2026-04-23 00:26:20.470727
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        rmtables::::casa        rmtables( tablenames=['cal.B'] )
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        rmtables::::casa        Removing cal.B
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-04-23 00:26:20.471647 End time: 2026-04-23 00:26:20.484771
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:20 .2026-04-23 00:26:20        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        accor::::casa        ##### Begin Task: accor              #####
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        accor::::casa        accor( vis='uid_copy.ms', caltable='cal.A', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-Apr-2026 20:26:20 2026-04-23 00:26:20        INFO        accor::calibrater::open        Opening MS: uid_copy.ms for calibration.
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        calibrater::reset        Reseting solve/apply state
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        Calibrater::selectvis        By selection 1080 rows are reduced to 540
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        calibrater::solve        Beginning solve-----------------------------
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        Calibrater::solve        .   (None)
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 84368488281.1505
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 86213458984.275
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        Calibrater::solve        For solint = inf, found 9 solution intervals.
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        Calibrater::solve        Beginning solution interval 1/9 (~11% complete)
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        Calibrater::solve        Beginning solution interval 2/9 (~22% complete)
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        Calibrater::solve        Beginning solution interval 3/9 (~33% complete)
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        Calibrater::solve        Beginning solution interval 4/9 (~44% complete)
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        Calibrater::solve        Beginning solution interval 5/9 (~55% complete)
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        Calibrater::solve        Beginning solution interval 6/9 (~66% complete)
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        Calibrater::solve        Beginning solution interval 7/9 (~77% complete)
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        Calibrater::solve        Beginning solution interval 8/9 (~88% complete)
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO        Calibrater::solve          Found good Accor Jones solutions in 9 solution intervals.
22-Apr-2026 20:26:20 2026-04-23 00:26:21        INFO                Writing solutions to table: cal.A
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2   
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::solve        SPW: 0 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::solve        SPW: 1 [0, 0]  [6, 6]        [0, 0]            [0, 0]
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::solve        [0, 0]  [9, 9]        [0, 0]            [0, 0]
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        calibrater::solve        Finished solving.
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        accor::::casa        Task accor complete. Start time: 2026-04-23 00:26:20.487619 End time: 2026-04-23 00:26:22.835665
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        accor::::casa        ##### End Task: accor                #####
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        rmtables::::casa        Removing cal.A
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-04-23 00:26:22.837043 End time: 2026-04-23 00:26:22.855056
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:22 .2026-04-23 00:26:23        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        accor::::casa        ##### Begin Task: accor              #####
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        accor::::casa        accor( vis='VLBA_copy.ms', caltable='cal.A', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='', observation='0', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        accor::calibrater::open        Opening MS: VLBA_copy.ms for calibration.
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        calibrater::reset        Reseting solve/apply state
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::selectvis+         Selecting by observation IDs: '0'
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::selectvis        By selection 34540 rows are reduced to 6280
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        calibrater::solve        Beginning solve-----------------------------
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::solve        .   (None)
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
22-Apr-2026 20:26:22 2026-04-23 00:26:23        INFO        Calibrater::solve        For solint = inf, found 6 solution intervals.
22-Apr-2026 20:26:23 2026-04-23 00:26:23        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
22-Apr-2026 20:26:23 2026-04-23 00:26:23        INFO        Calibrater::solve        Beginning solution interval 1/6 (~16% complete)
22-Apr-2026 20:26:23 2026-04-23 00:26:23        INFO        Calibrater::solve        Beginning solution interval 2/6 (~33% complete)
22-Apr-2026 20:26:23 2026-04-23 00:26:23        INFO        Calibrater::solve        Beginning solution interval 3/6 (~50% complete)
22-Apr-2026 20:26:23 2026-04-23 00:26:23        INFO        Calibrater::solve        Beginning solution interval 4/6 (~66% complete)
22-Apr-2026 20:26:23 2026-04-23 00:26:23        INFO        Calibrater::solve        Beginning solution interval 5/6 (~83% complete)
22-Apr-2026 20:26:23 2026-04-23 00:26:23        INFO        Calibrater::solve          Found good Accor Jones solutions in 6 solution intervals.
22-Apr-2026 20:26:23 2026-04-23 00:26:23        INFO                Writing solutions to table: cal.A
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9   
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::solve        SPW: 0 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::solve        SPW: 1 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::solve        [0, 0]  [6, 6]        [0, 0]            [0, 0]
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        calibrater::solve        Finished solving.
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        accor::::casa        Task accor complete. Start time: 2026-04-23 00:26:22.859517 End time: 2026-04-23 00:26:25.314501
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        accor::::casa        ##### End Task: accor                #####
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        rmtables::::casa        Removing cal.A
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-04-23 00:26:25.316082 End time: 2026-04-23 00:26:25.336093
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:25 .2026-04-23 00:26:25        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        accor::::casa        ##### Begin Task: accor              #####
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        accor::::casa        accor( vis='VLBA_copy.ms', caltable='cal.A', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='2', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        accor::calibrater::open        Opening MS: VLBA_copy.ms for calibration.
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        calibrater::reset        Reseting solve/apply state
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::selectvis+         Selecting on scan: '2'
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::selectvis        By selection 34540 rows are reduced to 1200
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        calibrater::solve        Beginning solve-----------------------------
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::solve        .   (None)
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::solve        For solint = inf, found 2 solution intervals.
22-Apr-2026 20:26:25 2026-04-23 00:26:25        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
22-Apr-2026 20:26:25 2026-04-23 00:26:25        INFO        Calibrater::solve        Beginning solution interval 1/2 (~50% complete)
22-Apr-2026 20:26:25 2026-04-23 00:26:26        INFO        Calibrater::solve          Found good Accor Jones solutions in 2 solution intervals.
22-Apr-2026 20:26:25 2026-04-23 00:26:26        INFO                Writing solutions to table: cal.A
22-Apr-2026 20:26:27 2026-04-23 00:26:27        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-Apr-2026 20:26:27 2026-04-23 00:26:27        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9   
22-Apr-2026 20:26:27 2026-04-23 00:26:27        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:27 2026-04-23 00:26:27        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:27 2026-04-23 00:26:27        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-Apr-2026 20:26:27 2026-04-23 00:26:27        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:27 2026-04-23 00:26:27        INFO        Calibrater::solve        SPW: 0 [0, 0]  [1, 1]        [0, 0]            [0, 0]
22-Apr-2026 20:26:27 2026-04-23 00:26:27        INFO        Calibrater::solve        SPW: 1 [0, 0]  [1, 1]        [0, 0]            [0, 0]
22-Apr-2026 20:26:27 2026-04-23 00:26:27        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-Apr-2026 20:26:27 2026-04-23 00:26:27        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:27 2026-04-23 00:26:27        INFO        Calibrater::solve        [0, 0]  [2, 2]        [0, 0]            [0, 0]
22-Apr-2026 20:26:27 2026-04-23 00:26:27        INFO        calibrater::solve        Finished solving.
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        accor::::casa        Task accor complete. Start time: 2026-04-23 00:26:25.340342 End time: 2026-04-23 00:26:27.502784
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        accor::::casa        ##### End Task: accor                #####
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        rmtables::::casa        Removing cal.A
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-04-23 00:26:27.506656 End time: 2026-04-23 00:26:27.525317
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:27 .2026-04-23 00:26:28        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        accor::::casa        ##### Begin Task: accor              #####
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        accor::::casa        accor( vis='uid_copy.ms', caltable='cal.A', field='', spw='', intent='', selectdata=False, timerange='', antenna='', scan='2', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        accor::calibrater::open        Opening MS: uid_copy.ms for calibration.
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        calibrater::reset        Reseting solve/apply state
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        Calibrater::selectvis        By selection 1080 rows are reduced to 540
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        calibrater::solve        Beginning solve-----------------------------
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        Calibrater::solve        .   (None)
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 84368488281.1505
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 86213458984.275
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        Calibrater::solve        For solint = inf, found 9 solution intervals.
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        Calibrater::solve        Beginning solution interval 1/9 (~11% complete)
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        Calibrater::solve        Beginning solution interval 2/9 (~22% complete)
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        Calibrater::solve        Beginning solution interval 3/9 (~33% complete)
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        Calibrater::solve        Beginning solution interval 4/9 (~44% complete)
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        Calibrater::solve        Beginning solution interval 5/9 (~55% complete)
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        Calibrater::solve        Beginning solution interval 6/9 (~66% complete)
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        Calibrater::solve        Beginning solution interval 7/9 (~77% complete)
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        Calibrater::solve        Beginning solution interval 8/9 (~88% complete)
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO        Calibrater::solve          Found good Accor Jones solutions in 9 solution intervals.
22-Apr-2026 20:26:27 2026-04-23 00:26:28        INFO                Writing solutions to table: cal.A
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2   
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::solve        SPW: 0 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::solve        SPW: 1 [0, 0]  [6, 6]        [0, 0]            [0, 0]
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::solve        [0, 0]  [9, 9]        [0, 0]            [0, 0]
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        calibrater::solve        Finished solving.
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        accor::::casa        Task accor complete. Start time: 2026-04-23 00:26:27.529360 End time: 2026-04-23 00:26:31.570655
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        accor::::casa        ##### End Task: accor                #####
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        rmtables::::casa        Removing cal.A
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-04-23 00:26:31.574170 End time: 2026-04-23 00:26:31.592388
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        accor::::casa        ##### Begin Task: accor              #####
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        accor::::casa        accor( vis='uid_copy.ms', caltable='cal.A', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='2', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        accor::calibrater::open        Opening MS: uid_copy.ms for calibration.
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        calibrater::reset        Reseting solve/apply state
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::selectvis+         Selecting on scan: '2'
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::selectvis        By selection 1080 rows are reduced to 180
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        calibrater::solve        Beginning solve-----------------------------
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::solve        .   (None)
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 84368488281.1505
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 86213458984.275
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::solve        For solint = inf, found 2 solution intervals.
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::solve        Beginning solution interval 1/2 (~50% complete)
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO        Calibrater::solve          Found good Accor Jones solutions in 2 solution intervals.
22-Apr-2026 20:26:31 2026-04-23 00:26:32        INFO                Writing solutions to table: cal.A
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2   
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        Calibrater::solve        SPW: 0 [0, 0]  [1, 1]        [0, 0]            [0, 0]
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        Calibrater::solve        SPW: 1 [0, 0]  [1, 1]        [0, 0]            [0, 0]
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        Calibrater::solve        [0, 0]  [2, 2]        [0, 0]            [0, 0]
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        calibrater::solve        Finished solving.
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        accor::::casa        Task accor complete. Start time: 2026-04-23 00:26:31.595536 End time: 2026-04-23 00:26:35.936305
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        accor::::casa        ##### End Task: accor                #####
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        rmtables::::casa        Removing cal.A
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-04-23 00:26:35.940129 End time: 2026-04-23 00:26:35.960046
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-04-23 00:26:35.961180 End time: 2026-04-23 00:26:35.972199
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:35 .2026-04-23 00:26:36        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        accor::::casa        ##### Begin Task: accor              #####
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        accor::::casa        accor( vis='VLBA_copy.ms', caltable='cal.A', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='', observation='', msselect='', solint='10s', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        accor::calibrater::open        Opening MS: VLBA_copy.ms for calibration.
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        calibrater::reset        Reseting solve/apply state
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-Apr-2026 20:26:35 2026-04-23 00:26:36        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:36 2026-04-23 00:26:36        INFO        Calibrater::selectvis        By selection 34540 rows are reduced to 6280
22-Apr-2026 20:26:36 2026-04-23 00:26:36        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-Apr-2026 20:26:36 2026-04-23 00:26:36        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:36 2026-04-23 00:26:36        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-Apr-2026 20:26:36 2026-04-23 00:26:36        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-Apr-2026 20:26:36 2026-04-23 00:26:36        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=10s refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:36 2026-04-23 00:26:36        INFO        calibrater::solve        Beginning solve-----------------------------
22-Apr-2026 20:26:36 2026-04-23 00:26:36        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-Apr-2026 20:26:36 2026-04-23 00:26:36        INFO        Calibrater::solve        .   (None)
22-Apr-2026 20:26:36 2026-04-23 00:26:36        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-Apr-2026 20:26:36 2026-04-23 00:26:36        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=10s refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:36 2026-04-23 00:26:36        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-Apr-2026 20:26:36 2026-04-23 00:26:36        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-Apr-2026 20:26:36 2026-04-23 00:26:36        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
22-Apr-2026 20:26:36 2026-04-23 00:26:36        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
22-Apr-2026 20:26:36 2026-04-23 00:26:36        INFO        Calibrater::solve        For solint = 10s, found 126 solution intervals.
22-Apr-2026 20:26:36 2026-04-23 00:26:36        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
22-Apr-2026 20:26:36 2026-04-23 00:26:36        INFO        Calibrater::solve        Beginning solution interval 13/126 (~10% complete)
22-Apr-2026 20:26:36 2026-04-23 00:26:36        INFO        Calibrater::solve        Beginning solution interval 26/126 (~20% complete)
22-Apr-2026 20:26:36 2026-04-23 00:26:36        INFO        Calibrater::solve        Beginning solution interval 39/126 (~30% complete)
22-Apr-2026 20:26:36 2026-04-23 00:26:36        INFO        Calibrater::solve        Beginning solution interval 52/126 (~41% complete)
22-Apr-2026 20:26:36 2026-04-23 00:26:36        INFO        Calibrater::solve        Beginning solution interval 65/126 (~51% complete)
22-Apr-2026 20:26:36 2026-04-23 00:26:37        INFO        Calibrater::solve        Beginning solution interval 78/126 (~61% complete)
22-Apr-2026 20:26:36 2026-04-23 00:26:37        INFO        Calibrater::solve        Beginning solution interval 91/126 (~72% complete)
22-Apr-2026 20:26:36 2026-04-23 00:26:37        INFO        Calibrater::solve        Beginning solution interval 104/126 (~82% complete)
22-Apr-2026 20:26:36 2026-04-23 00:26:37        INFO        Calibrater::solve        Beginning solution interval 117/126 (~92% complete)
22-Apr-2026 20:26:36 2026-04-23 00:26:37        INFO        Calibrater::solve          Found good Accor Jones solutions in 126 solution intervals.
22-Apr-2026 20:26:36 2026-04-23 00:26:37        INFO                Writing solutions to table: cal.A
22-Apr-2026 20:26:38 2026-04-23 00:26:39        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-Apr-2026 20:26:38 2026-04-23 00:26:39        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9   
22-Apr-2026 20:26:38 2026-04-23 00:26:39        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::solve        SPW: 0 [0, 0]  [63, 63]        [0, 0]            [0, 0]
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::solve        SPW: 1 [0, 0]  [63, 63]        [0, 0]            [0, 0]
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::solve        [0, 0]  [126, 126]        [0, 0]            [0, 0]
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        calibrater::solve        Finished solving.
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        accor::::casa        Task accor complete. Start time: 2026-04-23 00:26:35.976392 End time: 2026-04-23 00:26:39.009408
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        accor::::casa        ##### End Task: accor                #####
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        rmtables::::casa        Removing cal.A
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-04-23 00:26:39.014888 End time: 2026-04-23 00:26:39.033150
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:39 .2026-04-23 00:26:39        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        accor::::casa        ##### Begin Task: accor              #####
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        accor::::casa        accor( vis='uid_copy.ms', caltable='cal.A', field='', spw='1', intent='', selectdata=True, timerange='', antenna='', scan='', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        accor::calibrater::open        Opening MS: uid_copy.ms for calibration.
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        calibrater::reset        Reseting solve/apply state
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::selectvis+         Selecting on spw: '1'
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::selectvis        By selection 1080 rows are reduced to 405
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::selectvis        Frequency selection:
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::selectvis        .  Spw 1:0~0 (1 channels, step by 1)
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        calibrater::solve        Beginning solve-----------------------------
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::solve        .   (None)
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 86213458984.275
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::solve        For solint = inf, found 3 solution intervals.
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::solve        Beginning solution interval 1/3 (~33% complete)
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::solve        Beginning solution interval 2/3 (~66% complete)
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO        Calibrater::solve          Found good Accor Jones solutions in 3 solution intervals.
22-Apr-2026 20:26:39 2026-04-23 00:26:39        INFO                Writing solutions to table: cal.A
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2   
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]        [0, 0]            [0, 0]
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::solve        SPW: 1 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::solve        [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        calibrater::solve        Finished solving.
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        accor::::casa        Task accor complete. Start time: 2026-04-23 00:26:39.036906 End time: 2026-04-23 00:26:42.738360
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        accor::::casa        ##### End Task: accor                #####
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        rmtables::::casa        Removing cal.A
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-04-23 00:26:42.741553 End time: 2026-04-23 00:26:42.758636
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:42 .2026-04-23 00:26:43        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        accor::::casa        ##### Begin Task: accor              #####
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        accor::::casa        accor( vis='VLBA_copy.ms', caltable='cal.B', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        accor::calibrater::open        Opening MS: VLBA_copy.ms for calibration.
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        calibrater::reset        Reseting solve/apply state
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::selectvis        By selection 34540 rows are reduced to 6280
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.B append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        calibrater::solve        Beginning solve-----------------------------
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::solve        .   (None)
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::solve        .   Accor Jones: table=cal.B append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::solve        For solint = inf, found 6 solution intervals.
22-Apr-2026 20:26:42 2026-04-23 00:26:43        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
22-Apr-2026 20:26:42 2026-04-23 00:26:43        INFO        Calibrater::solve        Beginning solution interval 1/6 (~16% complete)
22-Apr-2026 20:26:43 2026-04-23 00:26:43        INFO        Calibrater::solve        Beginning solution interval 2/6 (~33% complete)
22-Apr-2026 20:26:43 2026-04-23 00:26:43        INFO        Calibrater::solve        Beginning solution interval 3/6 (~50% complete)
22-Apr-2026 20:26:43 2026-04-23 00:26:43        INFO        Calibrater::solve        Beginning solution interval 4/6 (~66% complete)
22-Apr-2026 20:26:43 2026-04-23 00:26:43        INFO        Calibrater::solve        Beginning solution interval 5/6 (~83% complete)
22-Apr-2026 20:26:43 2026-04-23 00:26:43        INFO        Calibrater::solve          Found good Accor Jones solutions in 6 solution intervals.
22-Apr-2026 20:26:43 2026-04-23 00:26:43        INFO                Writing solutions to table: cal.B
22-Apr-2026 20:26:44 2026-04-23 00:26:45        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-Apr-2026 20:26:44 2026-04-23 00:26:45        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9   
22-Apr-2026 20:26:44 2026-04-23 00:26:45        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:44 2026-04-23 00:26:45        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:44 2026-04-23 00:26:45        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-Apr-2026 20:26:44 2026-04-23 00:26:45        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:44 2026-04-23 00:26:45        INFO        Calibrater::solve        SPW: 0 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-Apr-2026 20:26:44 2026-04-23 00:26:45        INFO        Calibrater::solve        SPW: 1 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-Apr-2026 20:26:44 2026-04-23 00:26:45        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-Apr-2026 20:26:44 2026-04-23 00:26:45        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:44 2026-04-23 00:26:45        INFO        Calibrater::solve        [0, 0]  [6, 6]        [0, 0]            [0, 0]
22-Apr-2026 20:26:44 2026-04-23 00:26:45        INFO        calibrater::solve        Finished solving.
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        accor::::casa        Task accor complete. Start time: 2026-04-23 00:26:42.762427 End time: 2026-04-23 00:26:45.001453
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        accor::::casa        ##### End Task: accor                #####
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        accor::::casa        ##### Begin Task: accor              #####
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        accor::::casa        accor( vis='VLBA_copy.ms', caltable='cal.A', field='', spw='', intent='', selectdata=True, timerange='', antenna='', scan='', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=['cal.B'], gainfield=[], interp=[], spwmap=[0, 0] )
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        accor::calibrater::open        Opening MS: VLBA_copy.ms for calibration.
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        calibrater::reset        Reseting solve/apply state
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        Calibrater::selectvis        By selection 34540 rows are reduced to 6280
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        calibrater::setapply        Beginning setapply--(MSSelection version)-------
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        Calibrater::setapply(type, applypar)        Arranging to APPLY:
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        Calibrater::setapply(type, applypar)        .   Accor Jones: table=cal.B select= interp=linear spwmap=[0, 0] calWt=true
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        calibrater::solve        Beginning solve-----------------------------
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        Calibrater::solve        .   Accor Jones: table=cal.B select= interp=linear spwmap=[0, 0] calWt=true
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        Calibrater::solve        For solint = inf, found 6 solution intervals.
22-Apr-2026 20:26:45 2026-04-23 00:26:45        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        Calibrater::solve        Beginning solution interval 1/6 (~16% complete)
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        Calibrater::solve        Beginning solution interval 2/6 (~33% complete)
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        Calibrater::solve        Beginning solution interval 3/6 (~50% complete)
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        Calibrater::solve        Beginning solution interval 4/6 (~66% complete)
22-Apr-2026 20:26:45 2026-04-23 00:26:45        INFO        Calibrater::solve        Beginning solution interval 5/6 (~83% complete)
22-Apr-2026 20:26:45 2026-04-23 00:26:46        INFO        Calibrater::solve          Found good Accor Jones solutions in 6 solution intervals.
22-Apr-2026 20:26:45 2026-04-23 00:26:46        INFO                Writing solutions to table: cal.A
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9   
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::solve        SPW: 0 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::solve        SPW: 1 [0, 0]  [3, 3]        [0, 0]            [0, 0]
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::solve        [0, 0]  [6, 6]        [0, 0]            [0, 0]
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        calibrater::solve        Finished solving.
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        accor::::casa        Task accor complete. Start time: 2026-04-23 00:26:45.005052 End time: 2026-04-23 00:26:47.138571
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        accor::::casa        ##### End Task: accor                #####
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        rmtables::::casa        Removing cal.A
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-04-23 00:26:47.142819 End time: 2026-04-23 00:26:47.162124
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        rmtables::::casa        rmtables( tablenames=['cal.B'] )
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        rmtables::::casa        Removing cal.B
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-04-23 00:26:47.163225 End time: 2026-04-23 00:26:47.180252
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:47 .2026-04-23 00:26:47        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        accor::::casa        ##### Begin Task: accor              #####
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        accor::::casa        accor( vis='VLBA_copy.ms', caltable='cal.A', field='', spw='', intent='', selectdata=True, timerange='00:21:11.0~00:23:11.0', antenna='', scan='', observation='', msselect='', solint='inf', combine='', corrdepflags=False, append=False, docallib=False, callib='', gaintable=[], gainfield=[], interp=[], spwmap=[] )
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        accor::calibrater::open        ****Using NEW VI2-driven calibrater tool****
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        accor::calibrater::open        Opening MS: VLBA_copy.ms for calibration.
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        accor::Calibrater::        Initializing nominal selection to the whole MS.
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        accor::::casa        NB: accor automatically excludes crosso-correlations.
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        calibrater::setdata        Beginning selectvis--(MSSelection version)-------
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        calibrater::reset        Reseting solve/apply state
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::selectvis        Performing selection on MeasurementSet
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::selectvis+         Selecting on time: '00:21:11.0~00:23:11.0'
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::selectvis+         Selecting with TaQL: 'ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::selectvis        By selection 34540 rows are reduced to 1200
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::selectvis        Frequency selection: Selecting all channels in all spws.
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        calibrater::setdata        chanmode=none nchan=1 start=0 step=1 mStart='0km/s' mStep='0km/s' msSelect='ANTENNA1==ANTENNA2'
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        calibrater::setsolve        Beginning setsolve--(MSSelection version)-------
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::setsolve        Arranging to SOLVE:
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::setsolve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        calibrater::solve        Beginning solve-----------------------------
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::solve        The following calibration terms are arranged for apply:
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::solve        .   (None)
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::solve        The following calibration term is arranged for solve:
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::solve        .   Accor Jones: table=cal.A append=false solint=inf refantmode='flex' refant='none' minsnr=0 apmode=AP solnorm=false
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        ChannelAverageTVI::parseConfiguration        Channel bin is [-1, -1]
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        FreqMetaData::calcFreqMeta        Derived frequency meta-info for solutions:
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        FreqMetaData::calcFreqMeta         Selected spw=0 (nchan=1) has centroid freq = 43103500000
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        FreqMetaData::calcFreqMeta         Selected spw=1 (nchan=1) has centroid freq = 43231500000
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::solve        For solint = inf, found 2 solution intervals.
22-Apr-2026 20:26:47 2026-04-23 00:26:47        WARN        MSIter::setFeedInfo         time dependent feed table encountered - not correctly handled  - continuing anyway
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::solve        Beginning solution interval 1/2 (~50% complete)
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO        Calibrater::solve          Found good Accor Jones solutions in 2 solution intervals.
22-Apr-2026 20:26:47 2026-04-23 00:26:47        INFO                Writing solutions to table: cal.A
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        Calibrater::solve        ----- PER ANTENNA INFO -----
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        Calibrater::solve               ANT: 0    ANT: 1    ANT: 2    ANT: 3    ANT: 4    ANT: 5    ANT: 6    ANT: 7    ANT: 8    ANT: 9   
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        Calibrater::solve        SPW: 0 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        Calibrater::solve        SPW: 1 [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]  [0, 0]
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        Calibrater::solve        ----- PER SPW INFO -----
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        Calibrater::solve               expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        Calibrater::solve        SPW: 0 [0, 0]  [1, 1]        [0, 0]            [0, 0]
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        Calibrater::solve        SPW: 1 [0, 0]  [1, 1]        [0, 0]            [0, 0]
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        Calibrater::solve        ----- GLOBAL INFO -----
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        Calibrater::solve        expected  data_unflagged  above_minblperant  above_minsnr
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        Calibrater::solve        [0, 0]  [2, 2]        [0, 0]            [0, 0]
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        calibrater::solve        Finished solving.
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        accor::::casa        Task accor complete. Start time: 2026-04-23 00:26:47.183695 End time: 2026-04-23 00:26:48.696809
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        accor::::casa        ##### End Task: accor                #####
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        accor::::casa        ##########################################
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        rmtables::::casa        rmtables( tablenames=['cal.A'] )
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        rmtables::::casa        Removing cal.A
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-04-23 00:26:48.701160 End time: 2026-04-23 00:26:48.719583
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:48 .2026-04-23 00:26:49        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        rmtables::::casa        ##### Begin Task: rmtables           #####
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        rmtables::::casa        rmtables( tablenames=['cal.default'] )
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        rmtables::::casa        Task rmtables complete. Start time: 2026-04-23 00:26:48.810894 End time: 2026-04-23 00:26:48.811642
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        rmtables::::casa        ##### End Task: rmtables             #####
22-Apr-2026 20:26:48 2026-04-23 00:26:49        INFO        rmtables::::casa        ##########################################
22-Apr-2026 20:26:48
22-Apr-2026 20:26:48 ----------------------------------------------------------------------
22-Apr-2026 20:26:48 Ran 18 tests in 96.245s
22-Apr-2026 20:26:48
22-Apr-2026 20:26:48 OK
22-Apr-2026 20:26:48
22-Apr-2026 20:26:48 Generating XML reports...
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa        Using user configuration file /home/casatest/.casa/config.py
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa        loaded config file : /wheeldirectory/casa-6.7.6-1-py3.12.el8/lib/py/lib/python3.12/site-packages/casaconfig/config.py
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa        loaded config file : /home/casatest/.casa/config.py
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa        
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa        config values
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            agg = False
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            cachedir = '/home/casatest/.casa'
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            casaconfig_verbose = 1
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            colors = 'Neutral'
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            data_auto_update = False
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            data_update_interval = 1
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            datapath = ['/opt/casa/data/master', '/opt/casa/data/casatestdata']
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            iplog = False
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            iplogfile = '/home/casatest/casa6/casatasks/tests/casashell_tests/work/test_task_appendantab_casashell/ipython-20260423-002650.log'
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            log2term = True
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            logfile = '/home/casatest/casa6/casatasks/tests/casashell_tests/work/test_task_appendantab_casashell/casa-20260423-002650.log'
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            measures_auto_update = False
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            measures_site = ['https://www.astron.nl/iers/', 'https://go.nrao.edu/iers/']
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            measures_site_interval = 2
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            measures_update_interval = 1
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            measurespath = '/opt/casa/data/master'
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            nogui = False
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            nologfile = False
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            nologger = True
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            pipeline = False
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            skipnetworkcheck = False
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            startupfile = '/home/casatest/.casa/startup.py'
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa            user_site = False
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa        
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa        casarundata version is unknown, this is probably a legacy version not installed by casaconfig
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa        measures version : WSRT_Measures_20211217-160001.ztar
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa        
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa        Checking Measures tables in data repository sub-directory /opt/casa/data/master/geodetic
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa          IERSeop2000 (version date, last date in table (UTC)): 2026/02/23/15:15, 2025/12/31/00:00:00
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa          IERSeop97 (version date, last date in table (UTC)): 2026/02/23/15:15, 2025/12/31/00:00:00
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa          IERSpredict (version date, last date in table (UTC)): 2026/04/21/15:15, 2026/07/20/00:00:00
22-Apr-2026 20:26:55 2026-04-23 00:26:55        INFO        ::casa          TAI_UTC (version date, last date in table (UTC)): 2026/03/27/15:15, 2017/01/01/00:00:00
22-Apr-2026 20:26:55
22-Apr-2026 20:26:55 Running tests...
22-Apr-2026 20:26:55 ----------------------------------------------------------------------
22-Apr-2026 20:26:55
22-Apr-2026 20:26:55 Using user configuration file /home/casatest/.casa/config.py
22-Apr-2026 20:26:55
22-Apr-2026 20:26:55 No event loop hook running.
22-Apr-2026 20:26:55 Using matplotlib backend: agg
22-Apr-2026 20:26:55 CASA 6.7.6.1 -- Common Astronomy Software Applications [6.7.6.1]
22-Apr-2026 20:30:32 2026-04-23 00:30:33        INFO        appendantab::::casa        ##########################################
22-Apr-2026 20:30:32 2026-04-23 00:30:33        INFO        appendantab::::casa        ##### Begin Task: appendantab        #####
22-Apr-2026 20:30:32 2026-04-23 00:30:33        INFO        appendantab::::casa        appendantab( vis='vla_copy.ms', outvis='corrected_overwrite.ms', antab='/opt/casa/data/casatestdata/unittest/appendantab/VLBA_7GHZ_GAINS.ANTAB', overwrite=True, append_tsys=False, append_gc=True )
22-Apr-2026 20:30:32 2026-04-23 00:30:33        INFO        msmetadata_cmpt.cc::open        Performing internal consistency checks on vla_copy.ms...
22-Apr-2026 20:30:38 2026-04-23 00:30:38        INFO        appendantab::::casa        Task appendantab complete. Start time: 2026-04-23 00:30:32.747001 End time: 2026-04-23 00:30:38.495595
22-Apr-2026 20:30:38 2026-04-23 00:30:38        INFO        appendantab::::casa        ##### End Task: appendantab          #####
22-Apr-2026 20:30:38 2026-04-23 00:30:38        INFO        appendantab::::casa        ##########################################
22-Apr-2026 20:30:39 Antenna MK not present in the Measurement Set. MK values will be ignored.
22-Apr-2026 20:30:52 .2026-04-23 00:30:50        INFO        appendantab::::casa        ##########################################
22-Apr-2026 20:30:52 2026-04-23 00:30:53        INFO        appendantab::::casa        ##### Begin Task: appendantab        #####
22-Apr-2026 20:30:52 2026-04-23 00:30:53        INFO        appendantab::::casa        appendantab( vis='dataCopy.ms', outvis='appendedData.ms', antab='/opt/casa/data/casatestdata/unittest/appendantab/n14c3.antab', overwrite=False, append_tsys=True, append_gc=True )
22-Apr-2026 20:30:52 2026-04-23 00:30:53        INFO        msmetadata_cmpt.cc::open        Performing internal consistency checks on dataCopy.ms...
22-Apr-2026 20:37:53 2026-04-23 00:37:53        INFO        appendantab::::casa        Task appendantab complete. Start time: 2026-04-23 00:30:50.411067 End time: 2026-04-23 00:37:53.470676
22-Apr-2026 20:37:53 2026-04-23 00:37:53        INFO        appendantab::::casa        ##### End Task: appendantab          #####
22-Apr-2026 20:37:53 2026-04-23 00:37:53        INFO        appendantab::::casa        ##########################################
22-Apr-2026 20:37:55 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-Apr-2026 20:37:55 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-Apr-2026 20:37:55 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-Apr-2026 20:37:55 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-Apr-2026 20:37:55 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-Apr-2026 20:37:55 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-Apr-2026 20:37:55 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-Apr-2026 20:37:55 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-Apr-2026 20:37:55 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-Apr-2026 20:37:55 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO SPW ID -1 and freq to [0, 0]
22-Apr-2026 20:37:55 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-Apr-2026 20:37:55 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-Apr-2026 20:37:55 ANTAB HAS NO FREQ INFORMATION DEFAULTING TO FREQ ID -1
22-Apr-2026 20:37:55
22-Apr-2026 20:37:55 Testing column ANTENNA_ID
22-Apr-2026 20:37:55 Column ANTENNA_ID PASSED
22-Apr-2026 20:37:55
22-Apr-2026 20:37:55 Testing column FEED_ID
22-Apr-2026 20:37:55 Column FEED_ID PASSED
22-Apr-2026 20:37:55
22-Apr-2026 20:37:55 Testing column INTERVAL
22-Apr-2026 20:37:55 Column INTERVAL PASSED
22-Apr-2026 20:37:55
22-Apr-2026 20:37:55 Testing column SPECTRAL_WINDOW_ID
22-Apr-2026 20:37:55 Column SPECTRAL_WINDOW_ID PASSED
22-Apr-2026 20:37:55
22-Apr-2026 20:37:55 Testing column TIME
22-Apr-2026 20:37:55 Column TIME PASSED
22-Apr-2026 20:37:55
22-Apr-2026 20:37:55 Testing column TSYS
22-Apr-2026 20:37:55 Column TSYS PASSED
22-Apr-2026 20:37:55 -----------------------------
22-Apr-2026 20:38:05 .2026-04-23 00:38:06        INFO        appendantab::::casa        ##########################################
22-Apr-2026 20:38:05 2026-04-23 00:38:06        INFO        appendantab::::casa        ##### Begin Task: appendantab        #####
22-Apr-2026 20:38:05 2026-04-23 00:38:06        INFO        appendantab::::casa        appendantab( vis='dataCopy.ms', outvis='appendedData.ms', antab='/opt/casa/data/casatestdata/unittest/appendantab/n14c3.antab', overwrite=False, append_tsys=False, append_gc=True )
22-Apr-2026 20:38:05 2026-04-23 00:38:06        INFO        msmetadata_cmpt.cc::open        Performing internal consistency checks on dataCopy.ms...
22-Apr-2026 20:49:38 Agent 'cbt-el7-11.cv.nrao.edu' went offline while building CASASPECS-MASTERTESTCASALITHPY312-TTC2-266. The results of that build will not be available.