Build: #2 was successful

Job: Test Tools Many Linux 2.28 was successful

Stages & jobs

  1. Default Stage

  2. Test

Build log

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

24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 11 Scan : 31 : 31
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        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
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 12 Scan : 31 : 31
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Manual::chunkSummary        => Data flagged so far 34.375% (142560/414720)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 13 Scan : 31 : 31
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 14 Scan : 31 : 31
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        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
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 15 Scan : 31 : 31
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Manual::chunkSummary        => Data flagged so far 34.375% (142560/414720)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        FlagMSHandler::nextChunk         ====================================================================================
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Unflag::tableSummary        => Percentage of data un-flagged in table selection: 100%
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Manual::tableSummary        => Percentage of data flagged in table selection: 34.375%
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        AgentFlagger::run        => Writing flags to the MS
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          observation 0 flagged: 1.51219e+06 total: 4.3991e+06 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          scan 31 flagged: 760320 total: 2.21184e+06 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          scan 30 flagged: 751872 total: 2.18726e+06 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          antenna ea24 flagged: 756096 total: 2.19955e+06 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          antenna ea19 flagged: 756096 total: 2.19955e+06 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          antenna ea01 flagged: 756096 total: 2.19955e+06 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          antenna ea11 flagged: 756096 total: 2.19955e+06 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          field 3C286_A flagged: 1.51219e+06 total: 4.3991e+06 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          spw 15 flagged: 94512 total: 274944 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          spw 14 flagged: 94512 total: 274944 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          spw 10 flagged: 94512 total: 274944 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          spw 7 flagged: 94512 total: 274944 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          spw 12 flagged: 94512 total: 274944 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          spw 6 flagged: 94512 total: 274944 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          spw 8 flagged: 94512 total: 274944 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          spw 5 flagged: 94512 total: 274944 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          spw 0 flagged: 94512 total: 274944 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          spw 11 flagged: 94512 total: 274944 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          spw 9 flagged: 94512 total: 274944 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          spw 4 flagged: 94512 total: 274944 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          spw 1 flagged: 94512 total: 274944 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          spw 2 flagged: 94512 total: 274944 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          spw 13 flagged: 94512 total: 274944 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          spw 3 flagged: 94512 total: 274944 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          correlation LL flagged: 378048 total: 1.09978e+06 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          correlation LR flagged: 378048 total: 1.09978e+06 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          correlation RR flagged: 378048 total: 1.09978e+06 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          correlation RL flagged: 378048 total: 1.09978e+06 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          array 0 flagged: 1.51219e+06 total: 4.3991e+06 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Summary::getResult          Total Flagged: 1.51219e+06 Total Counts: 4.3991e+06 (34.4%)
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Display::displayReports         Report Displays are turned OFF
24-Dec-2025 00:38:30 test_tool_agentflagger.py::test_display::test_display_data_multiple_channel_selection
24-Dec-2025 00:38:30 AgentFlagger:: Check behaviour for multiple spw:chan selection 
24-Dec-2025 00:38:30 Moving data...
24-Dec-2025 00:38:30 PASSED
24-Dec-2025 00:38:30
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        AgentFlagger::open        Table type is Measurement Set
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        AgentFlagger::initAgents        There are initially 1 agents in the list. Agents: unflag
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        AgentFlagger::initAgents        There are 1 valid agents in the list. Agents: unflag
24-Dec-2025 00:38:30 2025-12-24 05:38:31        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
24-Dec-2025 00:38:30 2025-12-24 05:38:31        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
24-Dec-2025 00:38:30 2025-12-24 05:38:31        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (546816/546816)
24-Dec-2025 00:38:31 2025-12-24 05:38:31        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
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (410112/410112)
24-Dec-2025 00:38:31 2025-12-24 05:38:31        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
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (410112/410112)
24-Dec-2025 00:38:31 2025-12-24 05:38:31        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
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (410112/410112)
24-Dec-2025 00:38:31 2025-12-24 05:38:31        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
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (548352/548352)
24-Dec-2025 00:38:31 2025-12-24 05:38:31        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
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
24-Dec-2025 00:38:31 2025-12-24 05:38:31        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
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
24-Dec-2025 00:38:31 2025-12-24 05:38:31        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
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
24-Dec-2025 00:38:31 2025-12-24 05:38:31        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
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
24-Dec-2025 00:38:31 2025-12-24 05:38:31        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
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        FlagMSHandler::nextChunk         ====================================================================================
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Unflag::tableSummary        => Percentage of data un-flagged in table selection: 100%
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        AgentFlagger::run        => Writing flags to the MS
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        AgentFlagger::open        Table type is Measurement Set
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        AgentFlagger::initAgents        There are initially 3 agents in the list. Agents: manual, summary, display
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Display::setAgentParameters          data column is DATA
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Display::setAgentParameters          Visibility expression is ABS RR,RL,LR,LL
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Display::setAgentParameters          pause is 0
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Display::setAgentParameters          datadisplay is 1
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Display::setAgentParameters          reportdisplay is 0
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Display::setAgentParameters          format is screen
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        AgentFlagger::initAgents        There are 3 valid agents in the list. Agents: manual, summary, display
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        FlagDataHandler::preLoadColumn         Setting row blocking to number of rows in selected table: 17184
24-Dec-2025 00:38:31 2025-12-24 05:38:31        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
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 0 Scan : 30 : 30
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:31 /home/casatest/venv/bin/python3.12: No module named casaplotserver
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:31        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 1 Scan : 30 : 30
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 2 Scan : 30 : 30
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        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
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 3 Scan : 30 : 30
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (179424/546816)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 4 Scan : 30 : 30
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 5 Scan : 30 : 30
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        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
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 6 Scan : 30 : 30
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (134568/410112)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 7 Scan : 30 : 30
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 8 Scan : 30 : 30
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        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
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 9 Scan : 30 : 30
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (134568/410112)
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 10 Scan : 30 : 30
24-Dec-2025 00:38:31 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 11 Scan : 30 : 30
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        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
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 12 Scan : 30 : 30
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (134568/410112)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 13 Scan : 30 : 30
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 14 Scan : 30 : 30
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 15 Scan : 30 : 30
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        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
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 0 Scan : 31 : 31
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (179928/548352)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 1 Scan : 31 : 31
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 2 Scan : 31 : 31
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        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
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 3 Scan : 31 : 31
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:32 2025-12-24 05:38:32        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 4 Scan : 31 : 31
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 5 Scan : 31 : 31
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        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
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 6 Scan : 31 : 31
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 7 Scan : 31 : 31
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 8 Scan : 31 : 31
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        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
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 9 Scan : 31 : 31
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 10 Scan : 31 : 31
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 11 Scan : 31 : 31
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        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
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 12 Scan : 31 : 31
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:32 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 13 Scan : 31 : 31
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 14 Scan : 31 : 31
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        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
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 15 Scan : 31 : 31
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        FlagMSHandler::nextChunk         ====================================================================================
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Manual::tableSummary        => Percentage of data flagged in table selection: 32.8125%
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        AgentFlagger::run        => Writing flags to the MS
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          observation 0 flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          scan 31 flagged: 725760 total: 2.21184e+06 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          scan 30 flagged: 717696 total: 2.18726e+06 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          antenna ea24 flagged: 721728 total: 2.19955e+06 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          antenna ea19 flagged: 721728 total: 2.19955e+06 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          antenna ea01 flagged: 721728 total: 2.19955e+06 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          antenna ea11 flagged: 721728 total: 2.19955e+06 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          field 3C286_A flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          spw 15 flagged: 90216 total: 274944 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          spw 14 flagged: 90216 total: 274944 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          spw 10 flagged: 90216 total: 274944 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          spw 7 flagged: 90216 total: 274944 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          spw 12 flagged: 90216 total: 274944 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          spw 6 flagged: 90216 total: 274944 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          spw 8 flagged: 90216 total: 274944 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          spw 5 flagged: 90216 total: 274944 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          spw 0 flagged: 90216 total: 274944 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          spw 11 flagged: 90216 total: 274944 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          spw 9 flagged: 90216 total: 274944 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          spw 4 flagged: 90216 total: 274944 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          spw 1 flagged: 90216 total: 274944 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          spw 2 flagged: 90216 total: 274944 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          spw 13 flagged: 90216 total: 274944 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          spw 3 flagged: 90216 total: 274944 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          correlation LL flagged: 360864 total: 1.09978e+06 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          correlation LR flagged: 360864 total: 1.09978e+06 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          correlation RR flagged: 360864 total: 1.09978e+06 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          correlation RL flagged: 360864 total: 1.09978e+06 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          array 0 flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          Total Flagged: 1.44346e+06 Total Counts: 4.3991e+06 (32.8%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::displayReports         Report Displays are turned OFF
24-Dec-2025 00:38:33 test_tool_agentflagger.py::test_display::test_display_data_single_channel_selection
24-Dec-2025 00:38:33 AgentFlagger:: Check nominal behaviour for single spw:chan selection 
24-Dec-2025 00:38:33 The MS is already around, just unflag
24-Dec-2025 00:38:33 PASSED
24-Dec-2025 00:38:33
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        AgentFlagger::open        Table type is Measurement Set
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        AgentFlagger::initAgents        There are initially 1 agents in the list. Agents: unflag
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        AgentFlagger::initAgents        There are 1 valid agents in the list. Agents: unflag
24-Dec-2025 00:38:33 2025-12-24 05:38:33        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
24-Dec-2025 00:38:33 2025-12-24 05:38:33        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
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (1028/1028)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        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
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2/2)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        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
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (1026/1026)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        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
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4/4)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        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
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2050/2050)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        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
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4096/4096)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        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
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (6/6)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        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
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2048/2048)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        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
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4098/4098)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        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
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2/2)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        FlagMSHandler::nextChunk         ====================================================================================
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Unflag::tableSummary        => Percentage of data un-flagged in table selection: 100%
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        AgentFlagger::run        => Writing flags to the MS
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        AgentFlagger::open        Table type is Measurement Set
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        FlagMSHandler::selectData          Selected spw-channels ids are Axis Lengths: [4, 4]  (NB: Matrix in Row/Column order)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        FlagMSHandler::selectData +        [1, 0, 511, 1
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        FlagMSHandler::selectData +         2, 0, 0, 1
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        FlagMSHandler::selectData +         3, 0, 511, 1
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        FlagMSHandler::selectData +         4, 0, 0, 1]
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        AgentFlagger::initAgents        There are initially 3 agents in the list. Agents: manual, summary, display
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Manual::setAgentParameters         autocorr is 0
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::setAgentParameters          data column is FLOAT_DATA
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::setAgentParameters          Visibility expression is REAL XX,YY
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::setAgentParameters          pause is 0
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::setAgentParameters          datadisplay is 1
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::setAgentParameters          reportdisplay is 0
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::setAgentParameters          format is screen
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        AgentFlagger::initAgents        There are 3 valid agents in the list. Agents: manual, summary, display
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        FlagDataHandler::preLoadColumn         Setting row blocking to number of rows in selected table: 4
24-Dec-2025 00:38:33 2025-12-24 05:38:33        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
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 1 Scan : 1 : 1
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
24-Dec-2025 00:38:33 /home/casatest/venv/bin/python3.12: No module named casaplotserver
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Manual::chunkSummary        => Data flagged so far 100% (1024/1024)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        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
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 2 Scan : 1 : 1
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Manual::chunkSummary        => Data flagged so far 100% (2/2)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        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
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 3 Scan : 1 : 1
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Manual::chunkSummary        => Data flagged so far 100% (1024/1024)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        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
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 4 Scan : 1 : 1
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Manual::chunkSummary        => Data flagged so far 100% (2/2)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        FlagMSHandler::nextChunk         ====================================================================================
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Manual::tableSummary        => Percentage of data flagged in table selection: 100%
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        AgentFlagger::run        => Writing flags to the MS
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          observation 0 flagged: 2052 total: 2052 (100%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          scan 1 flagged: 2052 total: 2052 (100%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          antenna PM04 flagged: 2052 total: 2052 (100%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          field r aqr flagged: 2052 total: 2052 (100%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          spw 4 flagged: 2 total: 2 (100%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          spw 3 flagged: 1024 total: 1024 (100%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          spw 1 flagged: 1024 total: 1024 (100%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          spw 2 flagged: 2 total: 2 (100%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          correlation YY flagged: 1026 total: 1026 (100%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          correlation XX flagged: 1026 total: 1026 (100%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          array 0 flagged: 2052 total: 2052 (100%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Summary::getResult          Total Flagged: 2052 Total Counts: 2052 (100%)
24-Dec-2025 00:38:33 2025-12-24 05:38:33        INFO        Display::displayReports         Report Displays are turned OFF
24-Dec-2025 00:38:33 test_tool_agentflagger.py::test_display::test_display_float_data
24-Dec-2025 00:38:33 AgentFlagger: Select spw, display and flag single-dish MS
24-Dec-2025 00:38:33 Moving data...
24-Dec-2025 00:38:33 PASSED
24-Dec-2025 00:38:33
24-Dec-2025 00:38:33 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_agentflagger/nose.xml -
24-Dec-2025 00:38:33 ======================== 35 passed, 1 warning in 18.90s ========================
24-Dec-2025 00:38:33 ============================= test session starts ==============================
24-Dec-2025 00:38:33 platform linux -- Python 3.12.9, pytest-9.0.2, pluggy-1.6.0 -- /home/casatest/venv/bin/python3.12
24-Dec-2025 00:38:33 cachedir: .pytest_cache
24-Dec-2025 00:38:33 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv
24-Dec-2025 00:38:33 configfile: pytest.ini
24-Dec-2025 00:38:34 collecting ... collected 7 items
24-Dec-2025 00:38:34
24-Dec-2025 00:38:34
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        ImageFactory::createImage        Created Temp image  of shape [30, 30, 30] with float valued pixels.
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        PVGenerator::setEndpoints         Setting pixel end points [8.5, 15.5], [22.5, 15.5]
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        ImageRegion::fromRecord+            [9, 15, 0] to [22, 15, 29]  (00:00:24.000, +00.00.00.000, 1.41498e+09Hz to 23:59:32.000, +00.00.00.000, 1.41501e+09Hz)
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        PVGenerator::setEndpoints         Setting pixel end points [22.5, 15.5], [8.5, 15.5]
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        PVGenerator::generate         Rotating image by -180 degrees about direction coordinate pixel (15.5, 15.5) to align specified slice with the x axis
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        ImageRegion::fromRecord+            [0, 0, 0] to [29, 29, 29]  (00:01:00.001, -00.15.00.003, 1.41498e+09Hz to 23:59:03.999, +00.14.00.002, 1.41501e+09Hz)
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        ImageRegion::fromRecord+            [9, 15, 0] to [22, 15, 29]  (23:59:32.000, +00.01.00.000, 1.41498e+09Hz to 00:00:24.000, +00.01.00.000, 1.41501e+09Hz)
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        name::        No table opened.
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        showcache::        The Table Cache is empty.
24-Dec-2025 00:38:34 test_tool_image_pv.py::ia_pv_test::test_CAS10968
24-Dec-2025 00:38:34 Fix for pa=90,270 when segment y pixel falls on half pixel
24-Dec-2025 00:38:34 PASSED
24-Dec-2025 00:38:34
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        PVGenerator::generate         Rotating image by -45 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [299, 299, 0, 2]  (09:48:01.492, +13.15.40.658, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [316, 316, 0, 2]  (09:48:01.957, +13.15.33.858, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Dec-2025 00:38:34 2025-12-24 05:38:34        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [1, 157, 0, 0] to [313, 157, 0, 2]  (09:48:00.678, +13.15.52.535, I, 3.63994e+10Hz to 09:47:54.633, +13.17.20.782, I, 3.63991e+10Hz)
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        PVGenerator::generate         Rotating image by 45 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [299, 299, 0, 2]  (09:48:01.492, +13.15.40.658, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [316, 316, 0, 2]  (09:48:01.957, +13.15.33.858, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [1, 157, 0, 0] to [313, 157, 0, 2]  (09:48:00.678, +13.17.20.782, I, 3.63994e+10Hz to 09:47:54.634, +13.15.52.535, I, 3.63991e+10Hz)
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        PVGenerator::generate         Rotating image by -225 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [299, 299, 0, 2]  (09:48:01.492, +13.15.40.658, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [316, 316, 0, 2]  (09:48:01.957, +13.15.33.858, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [1, 157, 0, 0] to [313, 157, 0, 2]  (09:47:54.633, +13.17.20.782, I, 3.63994e+10Hz to 09:48:00.678, +13.15.52.535, I, 3.63991e+10Hz)
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        PVGenerator::generate         Rotating image by -135 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [299, 299, 0, 2]  (09:48:01.492, +13.15.40.658, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [316, 316, 0, 2]  (09:48:01.957, +13.15.33.858, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [1, 157, 0, 0] to [313, 157, 0, 2]  (09:47:54.634, +13.15.52.535, I, 3.63994e+10Hz to 09:48:00.678, +13.17.20.782, I, 3.63991e+10Hz)
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        PVGenerator::generate         Rotating image by -137.67 degrees about direction coordinate pixel (216.468, 187) to align specified slice with the x axis
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [399, 399, 0, 2]  (18:54:07.171, +01.59.37.999, I, 2.369292e+10Hz to 18:53:53.862, +02.02.57.499, I, 2.369285e+10Hz)
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [151, 187, 0, 0] to [284, 187, 0, 2]  (18:53:58.336, +02.00.49.457, I, 2.369292e+10Hz to 18:54:01.616, +02.01.34.238, I, 2.369285e+10Hz)
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        PVGenerator::generate         Rotating image by -42.3301 degrees about direction coordinate pixel (215.598, 187.793) to align specified slice with the x axis
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [399, 399, 0, 2]  (18:54:07.171, +01.59.37.999, I, 2.369292e+10Hz to 18:53:53.862, +02.02.57.499, I, 2.369285e+10Hz)
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [149, 188, 0, 0] to [282, 188, 0, 2]  (18:54:01.627, +02.00.49.549, I, 2.369292e+10Hz to 18:53:58.347, +02.01.34.331, I, 2.369285e+10Hz)
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        PVGenerator::generate         Rotating image by 42.3301 degrees about direction coordinate pixel (216.468, 187) to align specified slice with the x axis
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [399, 399, 0, 2]  (18:54:07.171, +01.59.37.999, I, 2.369292e+10Hz to 18:53:53.862, +02.02.57.499, I, 2.369285e+10Hz)
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Dec-2025 00:38:34 2025-12-24 05:38:35        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [149, 187, 0, 0] to [282, 187, 0, 2]  (18:54:01.614, +02.01.34.216, I, 2.369292e+10Hz to 18:53:58.335, +02.00.49.435, I, 2.369285e+10Hz)
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        PVGenerator::generate         Rotating image by -222.33 degrees about direction coordinate pixel (215.598, 187.793) to align specified slice with the x axis
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [399, 399, 0, 2]  (18:54:07.171, +01.59.37.999, I, 2.369292e+10Hz to 18:53:53.862, +02.02.57.499, I, 2.369285e+10Hz)
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [149, 188, 0, 0] to [282, 188, 0, 2]  (18:53:58.333, +02.01.34.243, I, 2.369292e+10Hz to 18:54:01.612, +02.00.49.462, I, 2.369285e+10Hz)
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        name::        No table opened.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        showcache::        The Table Cache is empty.
24-Dec-2025 00:38:35 test_tool_image_pv.py::ia_pv_test::test_CAS_2996
24-Dec-2025 00:38:35 ia.pv(): Test issues raised in CAS-2996
24-Dec-2025 00:38:35 PASSED
24-Dec-2025 00:38:35
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        PVGenerator::generate         Rotating image by -45 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [299, 299, 0, 2]  (09:48:01.492, +13.15.40.658, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [316, 316, 0, 2]  (09:48:01.957, +13.15.33.858, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [1, 157, 0, 0] to [313, 157, 0, 2]  (09:48:00.678, +13.15.52.535, I, 3.63994e+10Hz to 09:47:54.633, +13.17.20.782, I, 3.63991e+10Hz)
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageFitsConverter::ImageHeaderToFITS         Truncating miscinfo field secondary_coordinates to secondar
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageFitsConverter::ImageHeaderToFITS         Not writing miscInfo field 'secondar' - cannot handle type Record
24-Dec-2025 00:38:35 2025-12-24 05:38:35        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageFitsConverter::ImageHeaderToFITS         Truncating miscinfo field secondary_coordinates to secondar
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageFitsConverter::ImageHeaderToFITS         Not writing miscInfo field 'secondar' - cannot handle type Record
24-Dec-2025 00:38:35 2025-12-24 05:38:35        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        name::        No table opened.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        showcache::        The Table Cache is empty.
24-Dec-2025 00:38:35 test_tool_image_pv.py::ia_pv_test::test_fits
24-Dec-2025 00:38:35 ia.pv(): Test exporting and importing to/from FITS
24-Dec-2025 00:38:35 PASSED
24-Dec-2025 00:38:35
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageFactory::createImage        Created Paged image 'zz.im' of shape [30, 30, 30] with float valued pixels.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        PVGenerator::setEndpoints         Setting pixel end points [10.0503, 19.9497], [19.9497, 10.0503]
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        PVGenerator::generate         Rotating image by 45 degrees about direction coordinate pixel (15, 15) to align specified slice with the x axis
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [0, 0, 0] to [29, 29, 29]  (00:01:00.001, -00.15.00.003, 1.41498e+09Hz to 23:59:03.999, +00.14.00.002, 1.41501e+09Hz)
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [8, 15, 0] to [22, 15, 29]  (00:00:19.799, +00.04.56.985, 1.41498e+09Hz to 23:59:40.201, -00.04.56.985, 1.41501e+09Hz)
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ::::ImageFactory::createImage        Created Paged image 'zz.im' of shape [30, 30, 30] with float valued pixels.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ::::image::fromshape        Ran ia.fromshape
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ::::image::fromshape        ia.fromshape(outfile="zz.im", shape=[30,30,30], csys={...}, linear=false, overwrite=false, log=true, type="f")
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ::::image::pv        Ran ia.pv
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ::::image::pv        ia.pv(outfile="", start=[], end=[], center=[15,15], length="14arcmin", pa="45deg", width=1, unit="arcsec", overwrite=false, region={...}, chans="", stokes="", mask="", stretch=false, wantreturn=true)
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        name::        No table opened.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        showcache::        The Table Cache is empty.
24-Dec-2025 00:38:35 test_tool_image_pv.py::ia_pv_test::test_history
24-Dec-2025 00:38:35 Verify history is written to created image
24-Dec-2025 00:38:35 PASSED
24-Dec-2025 00:38:35
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageFactory::createImage        Created Paged image 'zxye.im' of shape [10, 10, 10] with float valued pixels.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        name::        No table opened.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        showcache::        The Table Cache is empty.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        SubImageFactory::createImage        Creating image 'test_pv_0' of shape [6, 10]
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        name::        No table opened.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        showcache::        The Table Cache is empty.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        SubImageFactory::createImage        Creating image 'test_pv_1' of shape [6, 10]
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        name::        No table opened.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        showcache::        The Table Cache is empty.
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
24-Dec-2025 00:38:35 2025-12-24 05:38:35        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        SubImageFactory::createImage        Creating image 'test_pv_2' of shape [6, 10]
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        name::        No table opened.
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        showcache::        The Table Cache is empty.
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        SubImageFactory::createImage        Creating image 'test_pv_3' of shape [6, 10]
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        name::        No table opened.
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        showcache::        The Table Cache is empty.
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        SubImageFactory::createImage        Creating image 'test_pv_4' of shape [6, 10]
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        name::        No table opened.
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        showcache::        The Table Cache is empty.
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        SubImageFactory::createImage        Creating image 'test_pv_5' of shape [6, 10]
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        name::        No table opened.
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        showcache::        The Table Cache is empty.
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        SubImageFactory::createImage        Creating image 'test_pv_6' of shape [6, 10]
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        name::        No table opened.
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        showcache::        The Table Cache is empty.
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord+            [2, 4, 0] to [7, 6, 9]  (00:00:12.000, -00.01.00.000, 1.415e+09Hz to 23:59:52.000, +00.01.00.000, 1.415e+09Hz)
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_0' of shape [6, 10]
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord+            [2, 4, 0] to [7, 6, 9]  (00:00:12.000, -00.01.00.000, 1.415e+09Hz to 23:59:52.000, +00.01.00.000, 1.415e+09Hz)
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_1' of shape [6, 10]
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        PVGenerator::setWidth         Rounding width up to next odd number of pixels (3), or 3arcmin
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord+            [2, 4, 0] to [7, 6, 9]  (00:00:12.000, -00.01.00.000, 1.415e+09Hz to 23:59:52.000, +00.01.00.000, 1.415e+09Hz)
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_2' of shape [6, 10]
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        PVGenerator::setWidth         Rounding width up to next odd number of pixels (3), or 3arcmin
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord+            [2, 4, 0] to [7, 6, 9]  (00:00:12.000, -00.01.00.000, 1.415e+09Hz to 23:59:52.000, +00.01.00.000, 1.415e+09Hz)
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_3' of shape [6, 10]
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        PVGenerator::setWidth         Rounding width up to next odd number of pixels (3), or 180000marcsec
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:35 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord+            [2, 4, 0] to [7, 6, 9]  (00:00:12.000, -00.01.00.000, 1.415e+09Hz to 23:59:52.000, +00.01.00.000, 1.415e+09Hz)
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_4' of shape [6, 10]
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        name::        No table opened.
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        showcache::        The Table Cache is empty.
24-Dec-2025 00:38:36 test_tool_image_pv.py::ia_pv_test::test_pv
24-Dec-2025 00:38:36 ia.pv(): Test pv()
24-Dec-2025 00:38:36 PASSED
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        ImageFactory::createImage        Created Temp image  of shape [50, 50, 1000] with float valued pixels.
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        PVGenerator::generate         Rotating image by -45 degrees about direction coordinate pixel (7.5, 7.5) to align specified slice with the x axis
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord+            [0, 0, 0] to [49, 49, 999]  (03:01:57.530, -35.32.49.013, 1.4145e+09Hz to 02:57:58.673, -34.43.38.701, 1.4155e+09Hz)
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord+            [4, 7, 0] to [11, 7, 999]  (03:01:31.077, -35.28.09.040, 1.4145e+09Hz to 03:01:06.781, -35.23.12.033, 1.4155e+09Hz)
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        name::        No table opened.
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        showcache::        The Table Cache is empty.
24-Dec-2025 00:38:36 test_tool_image_pv.py::ia_pv_test::test_refpix_far_outside_image
24-Dec-2025 00:38:36 Test refpix far outside image doesn't lead to malloc error, CAS-5251
24-Dec-2025 00:38:36 PASSED
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        ImageFactory::createImage        Created Paged image 'maskim' of shape [200, 200, 1, 1] with float valued pixels.
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        ImageFactory::createImage        Created Paged image 'kk' of shape [200, 200, 1, 20] with float valued pixels.
24-Dec-2025 00:38:36 2025-12-24 05:38:36        SEVERE        image::pv (file src/tools/image/image_cmpt.cc, line 4856)        Exception Reported: The input image shape ([200, 200, 1, 20]) 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
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord        Selected bounding box :
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        ImageRegion::fromRecord+            [2, 2, 0, 0] to [20, 2, 0, 19]  (00:06:32.213, -01.38.00.797, I, 1.41499e+09Hz to 00:05:20.159, -01.38.00.797, I, 1.41501e+09Hz)
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        name::        No table opened.
24-Dec-2025 00:38:36 2025-12-24 05:38:36        INFO        showcache::        The Table Cache is empty.
24-Dec-2025 00:38:36 test_tool_image_pv.py::ia_pv_test::test_stretch
24-Dec-2025 00:38:36 ia.pv(): Test stretch parameter
24-Dec-2025 00:38:36 PASSED
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_pv/nose.xml -
24-Dec-2025 00:38:36 ========================= 7 passed, 1 warning in 2.54s =========================
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_sdm/
24-Dec-2025 00:38:36 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_sdm
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_sdm/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_sdm/
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_componentlist/
24-Dec-2025 00:38:36 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_componentlist
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 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/
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_coordsys/
24-Dec-2025 00:38:36 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_coordsys
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_coordsys/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_coordsys/
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_regionmanager/
24-Dec-2025 00:38:36 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_regionmanager
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_regionmanager/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_regionmanager/
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image/
24-Dec-2025 00:38:36 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 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/
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/
24-Dec-2025 00:38:36 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_calibrater/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_statwt/
24-Dec-2025 00:38:36 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_statwt
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_ms_statwt/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_statwt/
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_sdm_toms/
24-Dec-2025 00:38:36 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_sdm_toms
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_sdm_toms/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_sdm_toms/
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms/
24-Dec-2025 00:38:36 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 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/
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msuvbinner/
24-Dec-2025 00:38:36 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msuvbinner
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 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/
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_fitprofile/
24-Dec-2025 00:38:36 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_fitprofile
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_fitprofile/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_fitprofile/
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_simulator/
24-Dec-2025 00:38:36 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_simulator
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_simulator/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_simulator/
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_imagepol/
24-Dec-2025 00:38:36 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_imagepol
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 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/
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_table/
24-Dec-2025 00:38:36 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_table
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_table/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_table/
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_synthesisutils/
24-Dec-2025 00:38:36 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_synthesisutils
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_synthesisutils/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_synthesisutils/
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager/
24-Dec-2025 00:38:36 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 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/
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_agentflagger/
24-Dec-2025 00:38:36 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_agentflagger
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 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/
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv/
24-Dec-2025 00:38:36 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv
24-Dec-2025 00:38:36
24-Dec-2025 00:38:36 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/
24-Dec-2025 00:38:37 total 77008
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci 15001   136953 Dec 24 05:24 casatestutils-6.7.3.14a14710.dev1-py3-none-any.whl
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci 15001 78544217 Dec 24 05:24 casatools-6.7.3.14a14710.dev1-cp312-cp312-manylinux_2_28_x86_64.whl
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      4340 Dec 24 05:38 test_tool_agentflagger.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      1006 Dec 24 05:38 test_tool_calanalysis.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      2656 Dec 24 05:38 test_tool_calibrater.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root       687 Dec 24 05:38 test_tool_componentlist.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      7467 Dec 24 05:38 test_tool_coordsys.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root     12935 Dec 24 05:38 test_tool_image.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      2220 Dec 24 05:38 test_tool_image_collapse.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      1048 Dec 24 05:38 test_tool_image_deviation.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      2575 Dec 24 05:38 test_tool_image_fitprofile.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      1178 Dec 24 05:38 test_tool_image_pbcor.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root       883 Dec 24 05:38 test_tool_image_pv.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      1006 Dec 24 05:38 test_tool_image_rebin.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      1336 Dec 24 05:38 test_tool_image_regrid.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      1533 Dec 24 05:38 test_tool_image_statistics.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root       765 Dec 24 05:38 test_tool_image_subimage.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root       890 Dec 24 05:38 test_tool_image_transpose.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      1966 Dec 24 05:38 test_tool_imagepol.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root       839 Dec 24 05:38 test_tool_linearmosaic.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root       669 Dec 24 05:38 test_tool_logsink.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root       549 Dec 24 05:38 test_tool_measures.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      5224 Dec 24 05:38 test_tool_ms.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root       367 Dec 24 05:38 test_tool_ms_createmultims.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      2095 Dec 24 05:38 test_tool_ms_statwt.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      8633 Dec 24 05:38 test_tool_msmetadata.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root       359 Dec 24 05:38 test_tool_msuvbinner.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      1171 Dec 24 05:38 test_tool_quanta.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      3977 Dec 24 05:38 test_tool_regionmanager.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      2072 Dec 24 05:38 test_tool_sdm.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      2096 Dec 24 05:38 test_tool_sdm_toms.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root       670 Dec 24 05:38 test_tool_simulator.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      1716 Dec 24 05:38 test_tool_synthesisutils.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      1462 Dec 24 05:38 test_tool_table.xml
24-Dec-2025 00:38:37 -rw-r--r-- 1 casaci root      1717 Dec 24 05:38 test_tool_vpmanager.xml
24-Dec-2025 00:38:37 Finished task 'Test wheel' with result: Success
24-Dec-2025 00:38:37 Starting task 'Parse tests' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
24-Dec-2025 00:38:37 Parsing test results under /export/home/cbt-el7-7/bamboohome/xml-data/build-dir/CASASPECS-CI209-TTOML228...
24-Dec-2025 00:38:37 Finished task 'Parse tests' with result: Success
24-Dec-2025 00:38:37 Starting task 'Cleanup' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
24-Dec-2025 00:38:37
Beginning to execute external process for build 'CASASPECS - CI Build - CAS-14710 - Test Tools Many Linux 2.28 #2 (CASASPECS-CI209-TTOML228-2)'
... running command line:
/export/home/cbt-el7-7/bamboohome/temp/CASASPECS-CI209-TTOML228-2-ScriptBuildTask-17294198788413094050.sh
... in: /export/home/cbt-el7-7/bamboohome/xml-data/build-dir/CASASPECS-CI209-TTOML228
24-Dec-2025 00:38:37 Starting cleanup
24-Dec-2025 00:38:48 wheel-container-test
24-Dec-2025 00:38:50 wheel-container-test
24-Dec-2025 00:38:50 Cleanup complete
24-Dec-2025 00:38:50 Finished task 'Cleanup' with result: Success
24-Dec-2025 00:38:50 Running post build plugin 'Docker Container Cleanup'
24-Dec-2025 00:38:50
Beginning to execute external process for build 'CASASPECS - CI Build - CAS-14710 - Test Tools Many Linux 2.28 #2 (CASASPECS-CI209-TTOML228-2)'
... running command line:
/usr/bin/docker rm -f wheel-container-test
... in: /export/home/cbt-el7-7/bamboohome/xml-data/build-dir/CASASPECS-CI209-TTOML228
24-Dec-2025 00:38:50 Error response from daemon: No such container: wheel-container-test
24-Dec-2025 00:38:50 Running post build plugin 'NCover Results Collector'
24-Dec-2025 00:38:50 Running post build plugin 'Build Results Label Collector'
24-Dec-2025 00:38:50 Running post build plugin 'Clover Results Collector'
24-Dec-2025 00:38:50 Running post build plugin 'npm Cache Cleanup'
24-Dec-2025 00:38:50 Running post build plugin 'Artifact Copier'
24-Dec-2025 00:38:50 Publishing an artifact: Tests
24-Dec-2025 00:38:50 Finished publishing of artifact Non required job artifact Http Compression On : [Tests], patterns: [*.xml] anchored at: [wheeldirectory/] in 432.3 ms
24-Dec-2025 00:38:50 Publishing an artifact: xml Directories
24-Dec-2025 00:38:51 Finished publishing of artifact Non required job artifact Http Compression On : [xml Directories], patterns: [**/*.xml] anchored at: [wheeldirectory/] in 250.9 ms
24-Dec-2025 00:38:51 Finalising the build...
24-Dec-2025 00:38:51 Stopping timer.
24-Dec-2025 00:38:51 Build CASASPECS-CI209-TTOML228-2 completed.
24-Dec-2025 00:38:51 Running on server: post build plugin 'Build Hanging Detection Configuration'
24-Dec-2025 00:38:51 Running on server: post build plugin 'NCover Results Collector'
24-Dec-2025 00:38:51 Running on server: post build plugin 'Build Labeller'
24-Dec-2025 00:38:51 Running on server: post build plugin 'Clover Delta Calculator'
24-Dec-2025 00:38:51 Running on server: post build plugin 'Maven Dependencies Postprocessor'
24-Dec-2025 00:38:51 All post build plugins have finished
24-Dec-2025 00:38:51 Generating build results summary...
24-Dec-2025 00:38:51 Saving build results to disk...
24-Dec-2025 00:38:51 Store variable context...
24-Dec-2025 00:38:51 Finished building CASASPECS-CI209-TTOML228-2.