Build: #315 was successful

Job: Test Tools Many Linux 2.28 was successful

Stages & jobs

  1. Default Stage

  2. Test

Build log

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

11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Manual::tableSummary        => Percentage of data flagged in table selection: 34.375%
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        AgentFlagger::run        => Writing flags to the MS
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          observation 0 flagged: 1.51219e+06 total: 4.3991e+06 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          scan 31 flagged: 760320 total: 2.21184e+06 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          scan 30 flagged: 751872 total: 2.18726e+06 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          antenna ea24 flagged: 756096 total: 2.19955e+06 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          antenna ea19 flagged: 756096 total: 2.19955e+06 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          antenna ea01 flagged: 756096 total: 2.19955e+06 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          antenna ea11 flagged: 756096 total: 2.19955e+06 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          field 3C286_A flagged: 1.51219e+06 total: 4.3991e+06 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          spw 15 flagged: 94512 total: 274944 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          spw 14 flagged: 94512 total: 274944 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          spw 10 flagged: 94512 total: 274944 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          spw 7 flagged: 94512 total: 274944 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          spw 12 flagged: 94512 total: 274944 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          spw 6 flagged: 94512 total: 274944 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          spw 8 flagged: 94512 total: 274944 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          spw 5 flagged: 94512 total: 274944 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          spw 0 flagged: 94512 total: 274944 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          spw 11 flagged: 94512 total: 274944 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          spw 9 flagged: 94512 total: 274944 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          spw 4 flagged: 94512 total: 274944 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          spw 1 flagged: 94512 total: 274944 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          spw 2 flagged: 94512 total: 274944 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          spw 13 flagged: 94512 total: 274944 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          spw 3 flagged: 94512 total: 274944 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          correlation LL flagged: 378048 total: 1.09978e+06 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          correlation LR flagged: 378048 total: 1.09978e+06 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          correlation RR flagged: 378048 total: 1.09978e+06 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          correlation RL flagged: 378048 total: 1.09978e+06 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          array 0 flagged: 1.51219e+06 total: 4.3991e+06 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Summary::getResult          Total Flagged: 1.51219e+06 Total Counts: 4.3991e+06 (34.4%)
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        Display::displayReports         Report Displays are turned OFF
11-May-2026 12:38:33 test_tool_agentflagger.py::test_display::test_display_data_multiple_channel_selection
11-May-2026 12:38:33 AgentFlagger:: Check behaviour for multiple spw:chan selection 
11-May-2026 12:38:33 Moving data...
11-May-2026 12:38:33 PASSED
11-May-2026 12:38:33
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        AgentFlagger::open        Table type is Measurement Set
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        AgentFlagger::initAgents        There are initially 1 agents in the list. Agents: unflag
11-May-2026 12:38:33 2026-05-11 16:38:34        INFO        AgentFlagger::initAgents        There are 1 valid agents in the list. Agents: unflag
11-May-2026 12:38:34 2026-05-11 16:38:34        INFO        FlagMSHandler::        Chunk = 1 [progress: 3%], Observation = 0, Array = 0, Scan = 30, Field = 1 (3C286_A), Spw = 0, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 534
11-May-2026 12:38:34 2026-05-11 16:38:34        INFO        FlagMSHandler::        Chunk = 4 [progress: 12%], Observation = 0, Array = 0, Scan = 30, Field = 1 (3C286_A), Spw = 3, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 534
11-May-2026 12:38:34 2026-05-11 16:38:34        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (546816/546816)
11-May-2026 12:38:34 2026-05-11 16:38:34        INFO        FlagMSHandler::        Chunk = 7 [progress: 21%], Observation = 0, Array = 0, Scan = 30, Field = 1 (3C286_A), Spw = 6, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 534
11-May-2026 12:38:34 2026-05-11 16:38:34        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (410112/410112)
11-May-2026 12:38:34 2026-05-11 16:38:34        INFO        FlagMSHandler::        Chunk = 10 [progress: 31%], Observation = 0, Array = 0, Scan = 30, Field = 1 (3C286_A), Spw = 9, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 534
11-May-2026 12:38:34 2026-05-11 16:38:34        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (410112/410112)
11-May-2026 12:38:34 2026-05-11 16:38:34        INFO        FlagMSHandler::        Chunk = 13 [progress: 40%], Observation = 0, Array = 0, Scan = 30, Field = 1 (3C286_A), Spw = 12, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 534
11-May-2026 12:38:34 2026-05-11 16:38:34        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (410112/410112)
11-May-2026 12:38:34 2026-05-11 16:38:34        INFO        FlagMSHandler::        Chunk = 17 [progress: 52%], Observation = 0, Array = 0, Scan = 31, Field = 1 (3C286_A), Spw = 0, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 540
11-May-2026 12:38:34 2026-05-11 16:38:34        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (548352/548352)
11-May-2026 12:38:34 2026-05-11 16:38:34        INFO        FlagMSHandler::        Chunk = 20 [progress: 62%], Observation = 0, Array = 0, Scan = 31, Field = 1 (3C286_A), Spw = 3, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 540
11-May-2026 12:38:34 2026-05-11 16:38:34        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
11-May-2026 12:38:34 2026-05-11 16:38:34        INFO        FlagMSHandler::        Chunk = 23 [progress: 71%], Observation = 0, Array = 0, Scan = 31, Field = 1 (3C286_A), Spw = 6, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 540
11-May-2026 12:38:34 2026-05-11 16:38:34        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
11-May-2026 12:38:34 2026-05-11 16:38:34        INFO        FlagMSHandler::        Chunk = 26 [progress: 81%], Observation = 0, Array = 0, Scan = 31, Field = 1 (3C286_A), Spw = 9, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 540
11-May-2026 12:38:34 2026-05-11 16:38:34        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
11-May-2026 12:38:34 2026-05-11 16:38:34        INFO        FlagMSHandler::        Chunk = 29 [progress: 90%], Observation = 0, Array = 0, Scan = 31, Field = 1 (3C286_A), Spw = 12, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 540
11-May-2026 12:38:34 2026-05-11 16:38:34        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
11-May-2026 12:38:34 2026-05-11 16:38:34        INFO        FlagMSHandler::        Chunk = 32 [progress: 100%], Observation = 0, Array = 0, Scan = 31, Field = 1 (3C286_A), Spw = 15, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 540
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        FlagMSHandler::nextChunk         ====================================================================================
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Unflag::tableSummary        => Percentage of data un-flagged in table selection: 100%
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        AgentFlagger::run        => Writing flags to the MS
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        AgentFlagger::open        Table type is Measurement Set
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        AgentFlagger::initAgents        There are initially 3 agents in the list. Agents: manual, summary, display
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::setAgentParameters          data column is DATA
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::setAgentParameters          Visibility expression is ABS RR,RL,LR,LL
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::setAgentParameters          pause is 0
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::setAgentParameters          datadisplay is 1
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::setAgentParameters          reportdisplay is 0
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::setAgentParameters          format is screen
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        AgentFlagger::initAgents        There are 3 valid agents in the list. Agents: manual, summary, display
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        FlagDataHandler::preLoadColumn         Setting row blocking to number of rows in selected table: 17184
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        FlagMSHandler::        Chunk = 1 [progress: 3%], Observation = 0, Array = 0, Scan = 30, Field = 1 (3C286_A), Spw = 0, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 534
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 0 Scan : 30 : 30
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:34 /home/casatest/venv/bin/python3.12: No module named casaplotserver
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 1 Scan : 30 : 30
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 2 Scan : 30 : 30
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        FlagMSHandler::        Chunk = 4 [progress: 12%], Observation = 0, Array = 0, Scan = 30, Field = 1 (3C286_A), Spw = 3, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 534
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 3 Scan : 30 : 30
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (179424/546816)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 4 Scan : 30 : 30
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 5 Scan : 30 : 30
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:34 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        FlagMSHandler::        Chunk = 7 [progress: 21%], Observation = 0, Array = 0, Scan = 30, Field = 1 (3C286_A), Spw = 6, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 534
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 6 Scan : 30 : 30
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (134568/410112)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 7 Scan : 30 : 30
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 8 Scan : 30 : 30
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        FlagMSHandler::        Chunk = 10 [progress: 31%], Observation = 0, Array = 0, Scan = 30, Field = 1 (3C286_A), Spw = 9, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 534
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 9 Scan : 30 : 30
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (134568/410112)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 10 Scan : 30 : 30
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 11 Scan : 30 : 30
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        FlagMSHandler::        Chunk = 13 [progress: 40%], Observation = 0, Array = 0, Scan = 30, Field = 1 (3C286_A), Spw = 12, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 534
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 12 Scan : 30 : 30
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (134568/410112)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 13 Scan : 30 : 30
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 14 Scan : 30 : 30
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 15 Scan : 30 : 30
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:35 2026-05-11 16:38:35        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        FlagMSHandler::        Chunk = 17 [progress: 52%], Observation = 0, Array = 0, Scan = 31, Field = 1 (3C286_A), Spw = 0, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 540
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 0 Scan : 31 : 31
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (179928/548352)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 1 Scan : 31 : 31
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 2 Scan : 31 : 31
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        FlagMSHandler::        Chunk = 20 [progress: 62%], Observation = 0, Array = 0, Scan = 31, Field = 1 (3C286_A), Spw = 3, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 540
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 3 Scan : 31 : 31
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 4 Scan : 31 : 31
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 5 Scan : 31 : 31
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        FlagMSHandler::        Chunk = 23 [progress: 71%], Observation = 0, Array = 0, Scan = 31, Field = 1 (3C286_A), Spw = 6, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 540
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 6 Scan : 31 : 31
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 7 Scan : 31 : 31
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 8 Scan : 31 : 31
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:35 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        FlagMSHandler::        Chunk = 26 [progress: 81%], Observation = 0, Array = 0, Scan = 31, Field = 1 (3C286_A), Spw = 9, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 540
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 9 Scan : 31 : 31
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 10 Scan : 31 : 31
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 11 Scan : 31 : 31
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        FlagMSHandler::        Chunk = 29 [progress: 90%], Observation = 0, Array = 0, Scan = 31, Field = 1 (3C286_A), Spw = 12, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 540
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 12 Scan : 31 : 31
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 13 Scan : 31 : 31
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 14 Scan : 31 : 31
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        FlagMSHandler::        Chunk = 32 [progress: 100%], Observation = 0, Array = 0, Scan = 31, Field = 1 (3C286_A), Spw = 15, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 540
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 15 Scan : 31 : 31
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        FlagMSHandler::nextChunk         ====================================================================================
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Manual::tableSummary        => Percentage of data flagged in table selection: 32.8125%
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        AgentFlagger::run        => Writing flags to the MS
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          observation 0 flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          scan 31 flagged: 725760 total: 2.21184e+06 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          scan 30 flagged: 717696 total: 2.18726e+06 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          antenna ea24 flagged: 721728 total: 2.19955e+06 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          antenna ea19 flagged: 721728 total: 2.19955e+06 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          antenna ea01 flagged: 721728 total: 2.19955e+06 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          antenna ea11 flagged: 721728 total: 2.19955e+06 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          field 3C286_A flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          spw 15 flagged: 90216 total: 274944 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          spw 14 flagged: 90216 total: 274944 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          spw 10 flagged: 90216 total: 274944 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          spw 7 flagged: 90216 total: 274944 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          spw 12 flagged: 90216 total: 274944 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          spw 6 flagged: 90216 total: 274944 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          spw 8 flagged: 90216 total: 274944 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          spw 5 flagged: 90216 total: 274944 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          spw 0 flagged: 90216 total: 274944 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          spw 11 flagged: 90216 total: 274944 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          spw 9 flagged: 90216 total: 274944 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          spw 4 flagged: 90216 total: 274944 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          spw 1 flagged: 90216 total: 274944 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          spw 2 flagged: 90216 total: 274944 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          spw 13 flagged: 90216 total: 274944 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          spw 3 flagged: 90216 total: 274944 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          correlation LL flagged: 360864 total: 1.09978e+06 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          correlation LR flagged: 360864 total: 1.09978e+06 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          correlation RR flagged: 360864 total: 1.09978e+06 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          correlation RL flagged: 360864 total: 1.09978e+06 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          array 0 flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Summary::getResult          Total Flagged: 1.44346e+06 Total Counts: 4.3991e+06 (32.8%)
11-May-2026 12:38:36 2026-05-11 16:38:36        INFO        Display::displayReports         Report Displays are turned OFF
11-May-2026 12:38:36 test_tool_agentflagger.py::test_display::test_display_data_single_channel_selection
11-May-2026 12:38:36 AgentFlagger:: Check nominal behaviour for single spw:chan selection 
11-May-2026 12:38:36 The MS is already around, just unflag
11-May-2026 12:38:36 PASSED
11-May-2026 12:38:36
11-May-2026 12:38:36 2026-05-11 16:38:37        INFO        AgentFlagger::open        Table type is Measurement Set
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        AgentFlagger::initAgents        There are initially 1 agents in the list. Agents: unflag
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        AgentFlagger::initAgents        There are 1 valid agents in the list. Agents: unflag
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::        Chunk = 1 [progress: 6%], Observation = 0, Array = 0, Scan = 1, Field = 0 (r aqr), Spw = 0, Channels = 4, Corrs = [ XX ], Total Rows = 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::        Chunk = 2 [progress: 13%], Observation = 0, Array = 0, Scan = 1, Field = 0 (r aqr), Spw = 1, Channels = 512, Corrs = [ XX YY ], Total Rows = 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (1028/1028)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::        Chunk = 3 [progress: 20%], Observation = 0, Array = 0, Scan = 1, Field = 0 (r aqr), Spw = 2, Channels = 1, Corrs = [ XX YY ], Total Rows = 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2/2)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::        Chunk = 5 [progress: 33%], Observation = 0, Array = 0, Scan = 1, Field = 0 (r aqr), Spw = 4, Channels = 1, Corrs = [ XX YY ], Total Rows = 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (1026/1026)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::        Chunk = 6 [progress: 40%], Observation = 0, Array = 0, Scan = 2, Field = 0 (r aqr), Spw = 0, Channels = 4, Corrs = [ XX ], Total Rows = 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4/4)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::        Chunk = 8 [progress: 53%], Observation = 0, Array = 0, Scan = 2, Field = 0 (r aqr), Spw = 6, Channels = 1, Corrs = [ XX YY ], Total Rows = 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2050/2050)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::        Chunk = 9 [progress: 60%], Observation = 0, Array = 0, Scan = 2, Field = 0 (r aqr), Spw = 7, Channels = 2048, Corrs = [ XX YY ], Total Rows = 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4096/4096)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::        Chunk = 11 [progress: 73%], Observation = 0, Array = 0, Scan = 3, Field = 0 (r aqr), Spw = 0, Channels = 4, Corrs = [ XX ], Total Rows = 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (6/6)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::        Chunk = 12 [progress: 80%], Observation = 0, Array = 0, Scan = 3, Field = 0 (r aqr), Spw = 5, Channels = 1024, Corrs = [ XX YY ], Total Rows = 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2048/2048)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::        Chunk = 14 [progress: 93%], Observation = 0, Array = 0, Scan = 3, Field = 0 (r aqr), Spw = 7, Channels = 2048, Corrs = [ XX YY ], Total Rows = 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4098/4098)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::        Chunk = 15 [progress: 100%], Observation = 0, Array = 0, Scan = 3, Field = 0 (r aqr), Spw = 8, Channels = 1, Corrs = [ XX YY ], Total Rows = 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2/2)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::nextChunk         ====================================================================================
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Unflag::tableSummary        => Percentage of data un-flagged in table selection: 100%
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        AgentFlagger::run        => Writing flags to the MS
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        AgentFlagger::open        Table type is Measurement Set
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::selectData          Selected spw-channels ids are Axis Lengths: [4, 4]  (NB: Matrix in Row/Column order)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::selectData +        [1, 0, 511, 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::selectData +         2, 0, 0, 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::selectData +         3, 0, 511, 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::selectData +         4, 0, 0, 1]
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        AgentFlagger::initAgents        There are initially 3 agents in the list. Agents: manual, summary, display
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Manual::setAgentParameters         autocorr is 0
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Display::setAgentParameters          data column is FLOAT_DATA
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Display::setAgentParameters          Visibility expression is REAL XX,YY
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Display::setAgentParameters          pause is 0
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Display::setAgentParameters          datadisplay is 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Display::setAgentParameters          reportdisplay is 0
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Display::setAgentParameters          format is screen
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        AgentFlagger::initAgents        There are 3 valid agents in the list. Agents: manual, summary, display
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagDataHandler::preLoadColumn         Setting row blocking to number of rows in selected table: 4
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::        Chunk = 1 [progress: 25%], Observation = 0, Array = 0, Scan = 1, Field = 0 (r aqr), Spw = 1, Channels = 512, Corrs = [ XX YY ], Total Rows = 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 1 Scan : 1 : 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
11-May-2026 12:38:37 /home/casatest/venv/bin/python3.12: No module named casaplotserver
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Manual::chunkSummary        => Data flagged so far 100% (1024/1024)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::        Chunk = 2 [progress: 50%], Observation = 0, Array = 0, Scan = 1, Field = 0 (r aqr), Spw = 2, Channels = 1, Corrs = [ XX YY ], Total Rows = 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 2 Scan : 1 : 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Manual::chunkSummary        => Data flagged so far 100% (2/2)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::        Chunk = 3 [progress: 75%], Observation = 0, Array = 0, Scan = 1, Field = 0 (r aqr), Spw = 3, Channels = 512, Corrs = [ XX YY ], Total Rows = 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 3 Scan : 1 : 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Manual::chunkSummary        => Data flagged so far 100% (1024/1024)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::        Chunk = 4 [progress: 100%], Observation = 0, Array = 0, Scan = 1, Field = 0 (r aqr), Spw = 4, Channels = 1, Corrs = [ XX YY ], Total Rows = 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 4 Scan : 1 : 1
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Manual::chunkSummary        => Data flagged so far 100% (2/2)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        FlagMSHandler::nextChunk         ====================================================================================
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Manual::tableSummary        => Percentage of data flagged in table selection: 100%
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        AgentFlagger::run        => Writing flags to the MS
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Summary::getResult          observation 0 flagged: 2052 total: 2052 (100%)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Summary::getResult          scan 1 flagged: 2052 total: 2052 (100%)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Summary::getResult          antenna PM04 flagged: 2052 total: 2052 (100%)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Summary::getResult          field r aqr flagged: 2052 total: 2052 (100%)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Summary::getResult          spw 4 flagged: 2 total: 2 (100%)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Summary::getResult          spw 3 flagged: 1024 total: 1024 (100%)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Summary::getResult          spw 1 flagged: 1024 total: 1024 (100%)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Summary::getResult          spw 2 flagged: 2 total: 2 (100%)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Summary::getResult          correlation YY flagged: 1026 total: 1026 (100%)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Summary::getResult          correlation XX flagged: 1026 total: 1026 (100%)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Summary::getResult          array 0 flagged: 2052 total: 2052 (100%)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Summary::getResult          Total Flagged: 2052 Total Counts: 2052 (100%)
11-May-2026 12:38:37 2026-05-11 16:38:37        INFO        Display::displayReports         Report Displays are turned OFF
11-May-2026 12:38:37 test_tool_agentflagger.py::test_display::test_display_float_data
11-May-2026 12:38:37 AgentFlagger: Select spw, display and flag single-dish MS
11-May-2026 12:38:37 Moving data...
11-May-2026 12:38:37 PASSED
11-May-2026 12:38:37
11-May-2026 12:38:37 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_agentflagger/nose.xml -
11-May-2026 12:38:37 ======================== 35 passed, 1 warning in 25.59s ========================
11-May-2026 12:38:37 ============================= test session starts ==============================
11-May-2026 12:38:37 platform linux -- Python 3.12.9, pytest-9.0.3, pluggy-1.6.0 -- /home/casatest/venv/bin/python3.12
11-May-2026 12:38:37 cachedir: .pytest_cache
11-May-2026 12:38:37 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_rebin
11-May-2026 12:38:37 configfile: pytest.ini
11-May-2026 12:38:38 collecting ... collected 8 items
11-May-2026 12:38:38
11-May-2026 12:38:38
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        ImageFactory::createImage        Created Paged image 'erzvd.im' of shape [30, 30, 1] with float valued pixels.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        ImageRebinner::setFactors        Not all rebinning factors were specified, filling in those not specified with factors of 1, so will rebin according to factor=[5, 5, 1]
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        name::        No table opened.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        showcache::        The Table Cache is empty.
11-May-2026 12:38:38 test_tool_image_rebin.py::ia_rebin_test::test_box
11-May-2026 12:38:38 Test use of box
11-May-2026 12:38:38 PASSED
11-May-2026 12:38:38
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        ImageFactory::createImage        Created Paged image 'xxyy.im' of shape [20, 20, 20] with float valued pixels.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        name::        No table opened.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        showcache::        The Table Cache is empty.
11-May-2026 12:38:38 test_tool_image_rebin.py::ia_rebin_test::test_crop
11-May-2026 12:38:38 Test crop parameter
11-May-2026 12:38:38 PASSED
11-May-2026 12:38:38
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        ImageFactory::createImage        Created Paged image 'kjfasd.im' of shape [20, 20, 1] with float valued pixels.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        ImageRebinner::setFactors        Not all rebinning factors were specified, filling in those not specified with factors of 1, so will rebin according to factor=[5, 5, 1]
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        ImageRegion::fromRecord+            [0, 0] to [3, 3]  (00:00:32.000, -00.08.00.000 to 23:59:32.000, +00.07.00.000)
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        name::        No table opened.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        showcache::        The Table Cache is empty.
11-May-2026 12:38:38 test_tool_image_rebin.py::ia_rebin_test::test_dropdeg
11-May-2026 12:38:38 Test dropdeg parameter
11-May-2026 12:38:38 PASSED
11-May-2026 12:38:38
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        ImageFactory::createImage        Created Paged image 'kbesd.im' of shape [20, 20, 20] with float valued pixels.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        ImageRegion::fromRecord+            [0, 0, 0] to [19, 19, 0]  (00:00:40.000, -00.10.00.001, 1.415e+09Hz to 23:59:24.000, +00.09.00.001, 1.415e+09Hz)
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        name::        No table opened.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        showcache::        The Table Cache is empty.
11-May-2026 12:38:38 test_tool_image_rebin.py::ia_rebin_test::test_dropdeg2
11-May-2026 12:38:38 axes that become degenerate when regridded are dropped if dropdeg=True: CAS-5836
11-May-2026 12:38:38 PASSED
11-May-2026 12:38:38
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        ImageFactory::createImage        Created Paged image 'st.im' of shape [20, 40] with float valued pixels.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        name::        No table opened.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        showcache::        The Table Cache is empty.
11-May-2026 12:38:38 test_tool_image_rebin.py::ia_rebin_test::test_general
11-May-2026 12:38:38 ia.rebin(): General tests
11-May-2026 12:38:38 PASSED
11-May-2026 12:38:38
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        ImageFactory::createImage        Created Paged image 'zz.im' of shape [20, 20, 20] with float valued pixels.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        ::::ImageFactory::createImage        Created Paged image 'zz.im' of shape [20, 20, 20] with float valued pixels.
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        ::::image::fromshape        Ran ia.fromshape
11-May-2026 12:38:38 2026-05-11 16:38:38        INFO        ::::image::fromshape        ia.fromshape(outfile="zz.im", shape=[20,20,20], csys={...}, linear=false, overwrite=false, log=true, type="f")
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        ::::image::rebin        Ran ia.rebin
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        ::::image::rebin        ia.rebin(outfile="", bin=[1,1,20], region="", mask="", dropdeg=false, overwrite=false, stretch=false, crop=false)
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        name::        No table opened.
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        showcache::        The Table Cache is empty.
11-May-2026 12:38:38 test_tool_image_rebin.py::ia_rebin_test::test_history
11-May-2026 12:38:38 Test history writing
11-May-2026 12:38:38 PASSED
11-May-2026 12:38:38
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        ImageFactory::createImage        Created Paged image 'gd.im' of shape [10, 10, 10] with float valued pixels.
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        image::_casaQuantityFromVar         Will use values specified in major, minor, pa to set beam
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        BeamManipulator::set        This image currently has no beams of any kind. Since channel and/or polarization were specified, a set of per plane beams, each equal to the specified beam, will be created.
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        BeamManipulator::set        Beam parameters:  Major          : 4 arcsec
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        BeamManipulator::set+          Minor          : 2 arcsec
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        BeamManipulator::set+          Position Angle : 0 deg
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
11-May-2026 12:38:38 2026-05-11 16:38:39        SEVERE        image::rebin        Exception Reported: Exception: This image has multiple beams. The spectral axis cannot be rebinned.
11-May-2026 12:38:38 2026-05-11 16:38:39        SEVERE        image::rebin+        ... thrown by casacore::RebinImage<T>::RebinImage(const casacore::ImageInterface<T>&, const casacore::IPosition&) [with T = float] at File: /source/casainstall/include/casacore/images/Images/RebinImage.tcc, line: 50
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        name::        No table opened.
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        showcache::        The Table Cache is empty.
11-May-2026 12:38:38 test_tool_image_rebin.py::ia_rebin_test::test_multibeam
11-May-2026 12:38:38 Test multiple beams
11-May-2026 12:38:38 PASSED
11-May-2026 12:38:38
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        ImageFactory::createImage        Created Paged image 'maskim' of shape [200, 200, 1, 1] with float valued pixels.
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        ImageFactory::createImage        Created Paged image 'aa.im' of shape [200, 200, 1, 10] with float valued pixels.
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
11-May-2026 12:38:38 2026-05-11 16:38:39        SEVERE        image::rebin        Exception Reported: The input image shape ([200, 200, 1, 10]) and mask shape ([200, 200, 1, 1]) are different, and it was specified that the mask should not be extended, so the mask cannot be applied to the (sub)image. Specifying that the mask should be extended may resolve the issue at File: /source/casainstall/include/casacpp/imageanalysis/ImageAnalysis/SubImageFactory.tcc, line: 306
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
11-May-2026 12:38:38 2026-05-11 16:38:39        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
11-May-2026 12:38:39 2026-05-11 16:38:39        INFO        name::        No table opened.
11-May-2026 12:38:39 2026-05-11 16:38:39        INFO        showcache::        The Table Cache is empty.
11-May-2026 12:38:39 test_tool_image_rebin.py::ia_rebin_test::test_stretch
11-May-2026 12:38:39 ia.rebin(): Test stretch parameter
11-May-2026 12:38:39 PASSED
11-May-2026 12:38:39
11-May-2026 12:38:39 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_rebin/nose.xml -
11-May-2026 12:38:39 ========================= 8 passed, 1 warning in 1.26s =========================
11-May-2026 12:38:39 ============================= test session starts ==============================
11-May-2026 12:38:39 platform linux -- Python 3.12.9, pytest-9.0.3, pluggy-1.6.0 -- /home/casatest/venv/bin/python3.12
11-May-2026 12:38:39 cachedir: .pytest_cache
11-May-2026 12:38:39 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor
11-May-2026 12:38:39 configfile: pytest.ini
11-May-2026 12:38:39 collecting ... collected 9 items
11-May-2026 12:38:39
11-May-2026 12:38:39
11-May-2026 12:38:40 2026-05-11 16:38:40        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:40 2026-05-11 16:38:40        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:40 2026-05-11 16:38:40        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
11-May-2026 12:38:40 2026-05-11 16:38:40        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
11-May-2026 12:38:40 2026-05-11 16:38:40        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
11-May-2026 12:38:40 2026-05-11 16:38:40        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:40 2026-05-11 16:38:40        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
11-May-2026 12:38:40 2026-05-11 16:38:40        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:40 2026-05-11 16:38:40        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
11-May-2026 12:38:40 2026-05-11 16:38:40        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
11-May-2026 12:38:40 2026-05-11 16:38:40        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 0, 0]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, I)
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        name::        No table opened.
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        showcache::        The Table Cache is empty.
11-May-2026 12:38:40 test_tool_image_pbcor.py::ia_pbcor_test::test_4d_image_with_2d_pb
11-May-2026 12:38:40 ia.pbcor: Test full image divide with cutoff. Primary beam is 2 D, image is 4 D
11-May-2026 12:38:40 PASSED
11-May-2026 12:38:40
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [5, 5, 1, 1]
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        name::        No table opened.
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        showcache::        The Table Cache is empty.
11-May-2026 12:38:40 test_tool_image_pbcor.py::ia_pbcor_test::test_diff_spectral_coordinate
11-May-2026 12:38:40 Verify fix that a different spectral coordinates in target and template don't matter, CAS-5096
11-May-2026 12:38:40 PASSED
11-May-2026 12:38:40
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        ImageFactory::createImage        Created Paged image 't_in.im' of shape [20, 20, 4, 20] with float valued pixels.
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        ImageFactory::createImage        Created Paged image 't_pb_in.im' of shape [20, 20, 4, 20] with float valued pixels.
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        CasacRegionManager::fromBCS        Using polarizations I
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [19, 19, 0, 19]  (00:00:40.000, -00.10.00.001, I, 1.41499e+09Hz to 23:59:24.000, +00.09.00.001, I, 1.41501e+09Hz)
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [19, 19, 0, 19]  (00:00:40.000, -00.10.00.001, I, 1.41499e+09Hz to 23:59:24.000, +00.09.00.001, I, 1.41501e+09Hz)
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        SubImageFactory::createImage        Creating image 't_out.im' of shape [20, 20, 1, 20]
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        name::        No table opened.
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        showcache::        The Table Cache is empty.
11-May-2026 12:38:40 test_tool_image_pbcor.py::ia_pbcor_test::test_empty_region_and_stokes
11-May-2026 12:38:40 Test specifying stokes with empty region works (CAS-11708)
11-May-2026 12:38:40 PASSED
11-May-2026 12:38:40
11-May-2026 12:38:40 2026-05-11 16:38:41        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Exception Reported: Exception: File name is empty.
11-May-2026 12:38:40 2026-05-11 16:38:41        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)+        ... thrown by static void casa::ImageFactory::_checkInfile(const casacore::String&) at File: /source/casa6/casatools/src/code/imageanalysis/ImageAnalysis/ImageFactory2.cc, line: 371
11-May-2026 12:38:40 2026-05-11 16:38:41        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Exception Reported: Exception: File totally_bogus does not exist..
11-May-2026 12:38:40 2026-05-11 16:38:41        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)+        ... thrown by static void casa::ImageFactory::_checkInfile(const casacore::String&) at File: /source/casa6/casatools/src/code/imageanalysis/ImageAnalysis/ImageFactory2.cc, line: 375
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:40 2026-05-11 16:38:41        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Exception: The image filename is empty.
11-May-2026 12:38:40 2026-05-11 16:38:41        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)+        ... thrown by static void casacore::ImageUtilities::openImage(casacore::ImageInterface<T>*&, const casacore::String&) [with T = float] at File: /source/casainstall/include/casacore/images/Images/ImageUtilities2.tcc, line: 255
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:40 2026-05-11 16:38:41        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Exception: File 'totally_bogus2' does not exist.
11-May-2026 12:38:40 2026-05-11 16:38:41        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)+        ... thrown by static void casacore::ImageUtilities::openImage(casacore::ImageInterface<T>*&, const casacore::String&) [with T = float] at File: /source/casainstall/include/casacore/images/Images/ImageUtilities2.tcc, line: 260
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:40 2026-05-11 16:38:41        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:41 2026-05-11 16:38:41        SEVERE        ImageInputProcessor::_process        Requested output image /bogusplace/bogusimage cannot be created so will not be written
11-May-2026 12:38:41 2026-05-11 16:38:41        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: 2026-05-11 16:38:41        SEVERE        ImageInputProcessor::_process        Requested output image /bogusplace/bogusimage cannot be created so will not be written
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:41 2026-05-11 16:38:41        WARN                /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/pbtest1_im.fits is not a valid or readable table
11-May-2026 12:38:41 2026-05-11 16:38:41        SEVERE                Cannot read image /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/pbtest1_im.fits to get region bogus_region
11-May-2026 12:38:41 2026-05-11 16:38:41        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Unable to open region file or region table description bogus_region in image /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/pbtest1_im.fits at File: /source/casa6/casatools/src/code/imageanalysis/Regions/CasacRegionManager.cc, line: 486
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:41 2026-05-11 16:38:41        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Unknown mode zz
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:41 2026-05-11 16:38:41        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Coordinate systems of image and template are different: The DirectionCoordinates have differing LinearXform components at File: /source/casa6/casatools/src/code/imageanalysis/ImageAnalysis/ImagePrimaryBeamCorrector.cc, line: 141
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        name::        No table opened.
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        showcache::        The Table Cache is empty.
11-May-2026 12:38:41 test_tool_image_pbcor.py::ia_pbcor_test::test_exceptions
11-May-2026 12:38:41 ia.pbcor: Test various exception cases
11-May-2026 12:38:41 PASSED
11-May-2026 12:38:41
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        name::        No table opened.
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        showcache::        The Table Cache is empty.
11-May-2026 12:38:41 test_tool_image_pbcor.py::ia_pbcor_test::test_full_image_divide
11-May-2026 12:38:41 ia.pbcor: Test full image divide
11-May-2026 12:38:41 PASSED
11-May-2026 12:38:41
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        name::        No table opened.
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        showcache::        The Table Cache is empty.
11-May-2026 12:38:41 test_tool_image_pbcor.py::ia_pbcor_test::test_full_image_using_cutoff
11-May-2026 12:38:41 ia.pbcor: Test full image divide with cutoff
11-May-2026 12:38:41 PASSED
11-May-2026 12:38:41
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ImageFactory::createImage        Created Paged image 'zz.im' of shape [20, 20] with float valued pixels.
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        SubImageFactory::createImage        Creating image 'pb_out.im' of shape [20, 20]
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ::::ImageFactory::createImage        Created Paged image 'zz.im' of shape [20, 20] with float valued pixels.
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ::::image::fromshape        Ran ia.fromshape
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ::::image::fromshape        ia.fromshape(outfile="zz.im", shape=[20,20], csys={...}, linear=false, overwrite=false, log=true, type="f")
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ::::image::pbcor        Ran ia.pbcor
11-May-2026 12:38:41 2026-05-11 16:38:41        INFO        ::::image::pbcor        ia.pbcor(pbimage="(...)", outfile="pb_out.im", overwrite=false, box="", region={...}, chans="", stokes="", mask="", mode="divide", cutoff=-1.000000, stretch=false)
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        name::        No table opened.
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        showcache::        The Table Cache is empty.
11-May-2026 12:38:41 test_tool_image_pbcor.py::ia_pbcor_test::test_history
11-May-2026 12:38:41 Test history records are written
11-May-2026 12:38:41 PASSED
11-May-2026 12:38:41
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        ImageFactory::createImage        Created Paged image 'mult_pb.im' of shape [113, 76] with float valued pixels.
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 0, 0]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, I)
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        ImageRegion::fromRecord        Selected bounding box :
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        name::        No table opened.
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        showcache::        The Table Cache is empty.
11-May-2026 12:38:41 test_tool_image_pbcor.py::ia_pbcor_test::test_multiply
11-May-2026 12:38:41 ia.pbcor: Test full image multiply with cutoff. Primary beam is 2 D, image is 4 D
11-May-2026 12:38:41 PASSED
11-May-2026 12:38:41
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        ImageFactory::createImage        Created Temp image  of shape [113, 76, 1, 1] with float valued pixels.
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        SubImageFactory::createImage        Creating image 'maskim' of shape [113, 76, 1, 1]
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:41 2026-05-11 16:38:42        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: The input image shape ([113, 76, 5, 2]) and mask shape ([113, 76, 1, 1]) are different, and it was specified that the mask should not be extended, so the mask cannot be applied to the (sub)image. Specifying that the mask should be extended may resolve the issue at File: /source/casainstall/include/casacpp/imageanalysis/ImageAnalysis/SubImageFactory.tcc, line: 306
11-May-2026 12:38:41 2026-05-11 16:38:42        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        SubImageFactory::createImage        Creating image 'blahblah' of shape [113, 76, 5, 2]
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        name::        No table opened.
11-May-2026 12:38:41 2026-05-11 16:38:42        INFO        showcache::        The Table Cache is empty.
11-May-2026 12:38:41 test_tool_image_pbcor.py::ia_pbcor_test::test_stretch
11-May-2026 12:38:41 ia.pbcor(): Test stretch parameter
11-May-2026 12:38:41 PASSED
11-May-2026 12:38:41
11-May-2026 12:38:41 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_pbcor/nose.xml -
11-May-2026 12:38:41 ========================= 9 passed, 1 warning in 2.45s =========================
11-May-2026 12:38:42 ============================= test session starts ==============================
11-May-2026 12:38:42 platform linux -- Python 3.12.9, pytest-9.0.3, pluggy-1.6.0 -- /home/casatest/venv/bin/python3.12
11-May-2026 12:38:42 cachedir: .pytest_cache
11-May-2026 12:38:42 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_msuvbinner
11-May-2026 12:38:42 configfile: pytest.ini
11-May-2026 12:38:42 collecting ... collected 1 item
11-May-2026 12:38:42
11-May-2026 12:38:42
11-May-2026 12:38:45 test_tool_msuvbinner.py::msuvbinnerTest::test_fill_1ms
11-May-2026 12:38:45 test uvgridding 1 ms onto an output grid 
11-May-2026 12:38:45 PASSED
11-May-2026 12:38:45
11-May-2026 12:38:45 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_msuvbinner/nose.xml -
11-May-2026 12:38:45 ========================= 1 passed, 1 warning in 3.32s =========================
11-May-2026 12:38:46 ============================= test session starts ==============================
11-May-2026 12:38:46 platform linux -- Python 3.12.9, pytest-9.0.3, pluggy-1.6.0 -- /home/casatest/venv/bin/python3.12
11-May-2026 12:38:46 cachedir: .pytest_cache
11-May-2026 12:38:46 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_calanalysis
11-May-2026 12:38:46 configfile: pytest.ini
11-May-2026 12:38:46 collecting ... collected 7 items
11-May-2026 12:38:46
11-May-2026 12:38:46
11-May-2026 12:38:47 test_tool_calanalysis.py::calanalysis_tsys1_introspective::test_introspective
11-May-2026 12:38:47 Test of introspective member functions
11-May-2026 12:38:47 PASSED
11-May-2026 12:38:47
11-May-2026 12:38:47 2026-05-11 16:38:47        WARN        CalAnalysis::getGroup() (file /source/casa6/casatools/src/code/calanalysis/CalAnalysis/CalAnalysis.cc, line 2718)        No matching rows selected
11-May-2026 12:38:47 2026-05-11 16:38:47        WARN        CalAnalysis::stats<T>() (file /source/casainstall/include/casacpp/calanalysis/CalAnalysis/CalAnalysis.h, line 686)        Cannot parse group(s)
11-May-2026 12:38:47 2026-05-11 16:38:47        WARN        CalAnalysis::getGroup() (file /source/casa6/casatools/src/code/calanalysis/CalAnalysis/CalAnalysis.cc, line 2718)        No matching rows selected
11-May-2026 12:38:47 2026-05-11 16:38:47        WARN        CalAnalysis::stats<T>() (file /source/casainstall/include/casacpp/calanalysis/CalAnalysis/CalAnalysis.h, line 686)        Cannot parse group(s)
11-May-2026 12:38:47 test_tool_calanalysis.py::calanalysis_tsys1_get::test_get_empty
11-May-2026 12:38:47 Test tool get function with wrong selections 
11-May-2026 12:38:47 PASSED
11-May-2026 12:38:47
11-May-2026 12:38:47 test_tool_calanalysis.py::calanalysis_tsys1_get::test_get_noparams
11-May-2026 12:38:47 Test tool get function, no selection, no other params.
11-May-2026 12:38:47 Uses stuff in CalAnalysys/CalStats::stats 
11-May-2026 12:38:47 PASSED
11-May-2026 12:38:47
11-May-2026 12:38:47 test_tool_calanalysis.py::calanalysis_tsys1_get::test_get_one_spw
11-May-2026 12:38:47 Test tool get function. Uses the main stuff in CalAnalysys/CalStats::stats 
11-May-2026 12:38:47 PASSED
11-May-2026 12:38:47
11-May-2026 12:38:47 test_tool_calanalysis.py::calanalysis_tsys1_fit::test_fit_amp
11-May-2026 12:38:47 Test tool fit function (amp). Exercises stuff in CalAnalysys/CalStatsFitter 
11-May-2026 12:38:47 PASSED
11-May-2026 12:38:47
11-May-2026 12:38:47 test_tool_calanalysis.py::calanalysis_tsys1_fit::test_fit_amp_sel
11-May-2026 12:38:47 Test tool fit function (amp + selection).
11-May-2026 12:38:47 Exercises stuff in CalAnalysys/CalStatsFitter 
11-May-2026 12:38:47 PASSED
11-May-2026 12:38:47
11-May-2026 12:38:48 test_tool_calanalysis.py::calanalysis_tsys1_fit::test_fit_phase
11-May-2026 12:38:48 Test tool fit function (phase). Exercises stuff in CalAnalysys/CalStatsFitter 
11-May-2026 12:38:48 PASSED
11-May-2026 12:38:48
11-May-2026 12:38:48 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_calanalysis/nose.xml -
11-May-2026 12:38:48 ========================= 7 passed, 1 warning in 1.99s =========================
11-May-2026 12:38:48 ============================= test session starts ==============================
11-May-2026 12:38:48 platform linux -- Python 3.12.9, pytest-9.0.3, pluggy-1.6.0 -- /home/casatest/venv/bin/python3.12
11-May-2026 12:38:48 cachedir: .pytest_cache
11-May-2026 12:38:48 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_linearmosaic
11-May-2026 12:38:48 configfile: pytest.ini
11-May-2026 12:38:48 collecting ... collected 5 items
11-May-2026 12:38:48
11-May-2026 12:38:48
11-May-2026 12:38:50 2026-05-11 16:38:50        WARN        ImageRegrid::regrid        You are regridding an image whose beam is not well sampled by the pixel size.  Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
11-May-2026 12:38:51 2026-05-11 16:38:52        WARN        ImageRegrid::regrid        You are regridding an image whose beam is not well sampled by the pixel size.  Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
11-May-2026 12:38:53 test_tool_linearmosaic.py::test_tool_linearmosaic::test_flat_noise
11-May-2026 12:38:53 test_flat_noise (flat noise type with flat noise input)
11-May-2026 12:38:53 PASSED
11-May-2026 12:38:53
11-May-2026 12:38:53 2026-05-11 16:38:53        WARN        ImageRegrid::regrid        You are regridding an image whose beam is not well sampled by the pixel size.  Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
11-May-2026 12:38:53 test_tool_linearmosaic.py::test_tool_linearmosaic::test_flat_noise_existing_image
11-May-2026 12:38:53 test_flat_noise_existing image (flat noise type onto an existing image)
11-May-2026 12:38:53 PASSED
11-May-2026 12:38:53
11-May-2026 12:38:56 test_tool_linearmosaic.py::test_tool_linearmosaic::test_flat_noise_flat_sky_input
11-May-2026 12:38:56 test_flat_noise_flat_sky_input (flat noise type with flat sky input)
11-May-2026 12:38:56 PASSED
11-May-2026 12:38:56
11-May-2026 12:39:00 test_tool_linearmosaic.py::test_tool_linearmosaic::test_flat_sky
11-May-2026 12:39:00 test_flat_sky (flat sky type with flat noise input
11-May-2026 12:39:00 PASSED
11-May-2026 12:39:00
11-May-2026 12:39:03 test_tool_linearmosaic.py::test_tool_linearmosaic::test_flat_sky_flat_sky_input
11-May-2026 12:39:03 test_flat_sky_flat_sky_input (flat sky type with flat sky inputs)
11-May-2026 12:39:03 PASSED
11-May-2026 12:39:03
11-May-2026 12:39:03 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_linearmosaic/nose.xml -
11-May-2026 12:39:03 ======================== 5 passed, 1 warning in 15.21s =========================
11-May-2026 12:39:03
11-May-2026 12:39:03
11-May-2026 12:39:03 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv/
11-May-2026 12:39:03 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv
11-May-2026 12:39:03
11-May-2026 12:39:03 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_pv/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv/
11-May-2026 12:39:03
11-May-2026 12:39:03 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_deviation/
11-May-2026 12:39:03 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_deviation
11-May-2026 12:39:03
11-May-2026 12:39:03 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_deviation/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_deviation/
11-May-2026 12:39:03
11-May-2026 12:39:03 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_imagepol/
11-May-2026 12:39:03 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_imagepol
11-May-2026 12:39:03
11-May-2026 12:39:03 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_imagepol/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_imagepol/
11-May-2026 12:39:03
11-May-2026 12:39:03 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_componentlist/
11-May-2026 12:39:03 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_componentlist
11-May-2026 12:39:03
11-May-2026 12:39:03 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_componentlist/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_componentlist/
11-May-2026 12:39:03
11-May-2026 12:39:03 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager/
11-May-2026 12:39:03 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager
11-May-2026 12:39:03
11-May-2026 12:39:03 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_vpmanager/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager/
11-May-2026 12:39:03
11-May-2026 12:39:03 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_transpose/
11-May-2026 12:39:03 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_transpose
11-May-2026 12:39:03
11-May-2026 12:39:03 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_transpose/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_transpose/
11-May-2026 12:39:03
11-May-2026 12:39:03 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_measures/
11-May-2026 12:39:03 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_measures
11-May-2026 12:39:03
11-May-2026 12:39:03 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_measures/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_measures/
11-May-2026 12:39:03
11-May-2026 12:39:03 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms/
11-May-2026 12:39:03 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms
11-May-2026 12:39:03
11-May-2026 12:39:03 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_ms/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_ms/
11-May-2026 12:39:03
11-May-2026 12:39:03 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_statistics/
11-May-2026 12:39:03 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_statistics
11-May-2026 12:39:03
11-May-2026 12:39:03 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_statistics/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_statistics/
11-May-2026 12:39:03
11-May-2026 12:39:03 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image/
11-May-2026 12:39:03 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image
11-May-2026 12:39:03
11-May-2026 12:39:03 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image/
11-May-2026 12:39:03
11-May-2026 12:39:03 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_collapse/
11-May-2026 12:39:03 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_collapse
11-May-2026 12:39:03
11-May-2026 12:39:03 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_collapse/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_collapse/
11-May-2026 12:39:03
11-May-2026 12:39:03 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_logsink/
11-May-2026 12:39:03 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_logsink
11-May-2026 12:39:03
11-May-2026 12:39:03 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_logsink/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_logsink/
11-May-2026 12:39:03
11-May-2026 12:39:03 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_agentflagger/
11-May-2026 12:39:03 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_agentflagger
11-May-2026 12:39:03
11-May-2026 12:39:03 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_agentflagger/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_agentflagger/
11-May-2026 12:39:03
11-May-2026 12:39:03 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_rebin/
11-May-2026 12:39:03 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_rebin
11-May-2026 12:39:03
11-May-2026 12:39:03 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_rebin/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_rebin/
11-May-2026 12:39:03
11-May-2026 12:39:03 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/
11-May-2026 12:39:03 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor
11-May-2026 12:39:03
11-May-2026 12:39:03 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_pbcor/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/
11-May-2026 12:39:03
11-May-2026 12:39:03 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msuvbinner/
11-May-2026 12:39:03 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msuvbinner
11-May-2026 12:39:03
11-May-2026 12:39:03 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_msuvbinner/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_msuvbinner/
11-May-2026 12:39:03
11-May-2026 12:39:03 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calanalysis/
11-May-2026 12:39:03 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calanalysis
11-May-2026 12:39:03
11-May-2026 12:39:03 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_calanalysis/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_calanalysis/
11-May-2026 12:39:03
11-May-2026 12:39:03 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_linearmosaic/
11-May-2026 12:39:03 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_linearmosaic
11-May-2026 12:39:03
11-May-2026 12:39:03 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_linearmosaic/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_linearmosaic/
11-May-2026 12:39:07 total 77796
11-May-2026 12:39:07 -rw-r--r-- 1 casaci 15001   160754 May 11 16:20 casatestutils-6.7.6.2+dirty-py3-none-any.whl
11-May-2026 12:39:07 -rw-r--r-- 1 casaci 15001 79327674 May 11 16:20 casatools-6.7.6.2+dirty-cp312-cp312-manylinux_2_28_x86_64.whl
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      4340 May 11 16:39 test_tool_agentflagger.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      1006 May 11 16:39 test_tool_calanalysis.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      2657 May 11 16:39 test_tool_calibrater.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root       687 May 11 16:39 test_tool_componentlist.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      7467 May 11 16:39 test_tool_coordsys.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root     12935 May 11 16:39 test_tool_image.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      2220 May 11 16:39 test_tool_image_collapse.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      1048 May 11 16:39 test_tool_image_deviation.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      2575 May 11 16:39 test_tool_image_fitprofile.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      1178 May 11 16:39 test_tool_image_pbcor.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root       883 May 11 16:39 test_tool_image_pv.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      1006 May 11 16:39 test_tool_image_rebin.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      1336 May 11 16:39 test_tool_image_regrid.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      1641 May 11 16:39 test_tool_image_statistics.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root       765 May 11 16:39 test_tool_image_subimage.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root       890 May 11 16:39 test_tool_image_transpose.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      1966 May 11 16:39 test_tool_imagepol.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root       839 May 11 16:39 test_tool_linearmosaic.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root       669 May 11 16:39 test_tool_logsink.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root       549 May 11 16:39 test_tool_measures.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      5224 May 11 16:39 test_tool_ms.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root       367 May 11 16:39 test_tool_ms_createmultims.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      2095 May 11 16:39 test_tool_ms_statwt.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      8633 May 11 16:39 test_tool_msmetadata.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root       359 May 11 16:39 test_tool_msuvbinner.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      1171 May 11 16:39 test_tool_quanta.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      3977 May 11 16:39 test_tool_regionmanager.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      2072 May 11 16:39 test_tool_sdm.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      2096 May 11 16:39 test_tool_sdm_toms.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root       670 May 11 16:39 test_tool_simulator.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      1717 May 11 16:39 test_tool_synthesisutils.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      1462 May 11 16:39 test_tool_table.xml
11-May-2026 12:39:07 -rw-r--r-- 1 casaci root      1717 May 11 16:39 test_tool_vpmanager.xml
11-May-2026 12:39:07 Finished task 'Test wheel' with result: Success
11-May-2026 12:39:07 Starting task 'Parse tests' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
11-May-2026 12:39:07 Parsing test results under /export/home/cbt-el7-7/bamboohome/xml-data/build-dir/CASASPECS-CI-TTOML228...
11-May-2026 12:39:07 Finished task 'Parse tests' with result: Success
11-May-2026 12:39:07 Starting task 'Cleanup' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
11-May-2026 12:39:07
Beginning to execute external process for build 'CASASPECS - CI Build - Test Tools Many Linux 2.28 #315 (CASASPECS-CI-TTOML228-315)'
... running command line:
/export/home/cbt-el7-7/bamboohome/temp/CASASPECS-CI-TTOML228-315-ScriptBuildTask-4088137222427318938.sh
... in: /export/home/cbt-el7-7/bamboohome/xml-data/build-dir/CASASPECS-CI-TTOML228
11-May-2026 12:39:07 Starting cleanup
11-May-2026 12:39:17 wheel-container-test
11-May-2026 12:39:20 wheel-container-test
11-May-2026 12:39:20 Cleanup complete
11-May-2026 12:39:20 Finished task 'Cleanup' with result: Success
11-May-2026 12:39:20 Running post build plugin 'Docker Container Cleanup'
11-May-2026 12:39:20
Beginning to execute external process for build 'CASASPECS - CI Build - Test Tools Many Linux 2.28 #315 (CASASPECS-CI-TTOML228-315)'
... running command line:
/usr/bin/docker rm -f wheel-container-test
... in: /export/home/cbt-el7-7/bamboohome/xml-data/build-dir/CASASPECS-CI-TTOML228
11-May-2026 12:39:20 Error response from daemon: No such container: wheel-container-test
11-May-2026 12:39:20 Running post build plugin 'NCover Results Collector'
11-May-2026 12:39:20 Running post build plugin 'Build Results Label Collector'
11-May-2026 12:39:20 Running post build plugin 'Clover Results Collector'
11-May-2026 12:39:20 Running post build plugin 'npm Cache Cleanup'
11-May-2026 12:39:20 Running post build plugin 'Artifact Copier'
11-May-2026 12:39:20 Publishing an artifact: Tests
11-May-2026 12:39:21 Finished publishing of artifact Non required job artifact Http Compression On : [Tests], patterns: [*.xml] anchored at: [wheeldirectory/] in 862.9 ms
11-May-2026 12:39:21 Publishing an artifact: xml Directories
11-May-2026 12:39:22 Finished publishing of artifact Non required job artifact Http Compression On : [xml Directories], patterns: [**/*.xml] anchored at: [wheeldirectory/] in 1.001 s
11-May-2026 12:39:22 Finalising the build...
11-May-2026 12:39:22 Stopping timer.
11-May-2026 12:39:22 Build CASASPECS-CI-TTOML228-315 completed.
11-May-2026 12:39:25 Running on server: post build plugin 'Build Hanging Detection Configuration'
11-May-2026 12:39:25 Running on server: post build plugin 'NCover Results Collector'
11-May-2026 12:39:25 Running on server: post build plugin 'Build Labeller'
11-May-2026 12:39:25 Running on server: post build plugin 'Clover Delta Calculator'
11-May-2026 12:39:25 Running on server: post build plugin 'Maven Dependencies Postprocessor'
11-May-2026 12:39:25 All post build plugins have finished
11-May-2026 12:39:25 Generating build results summary...
11-May-2026 12:39:25 Saving build results to disk...
11-May-2026 12:39:25 Store variable context...
11-May-2026 12:39:25 Finished building CASASPECS-CI-TTOML228-315.