Build: #3 was successful

Job: Old CMake build ManyLinux 2.28 was successful

Build log

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

28-Oct-2022 11:22:40 2022-10-28 15:22:41        INFO        Summary::getResult          correlation LL flagged: 378048 total: 1.09978e+06 (34.4%)
28-Oct-2022 11:22:40 2022-10-28 15:22:41        INFO        Summary::getResult          correlation LR flagged: 378048 total: 1.09978e+06 (34.4%)
28-Oct-2022 11:22:40 2022-10-28 15:22:41        INFO        Summary::getResult          correlation RR flagged: 378048 total: 1.09978e+06 (34.4%)
28-Oct-2022 11:22:40 2022-10-28 15:22:41        INFO        Summary::getResult          correlation RL flagged: 378048 total: 1.09978e+06 (34.4%)
28-Oct-2022 11:22:40 2022-10-28 15:22:41        INFO        Summary::getResult          array 0 flagged: 1.51219e+06 total: 4.3991e+06 (34.4%)
28-Oct-2022 11:22:40 2022-10-28 15:22:41        INFO        Summary::getResult          Total Flagged: 1.51219e+06 Total Counts: 4.3991e+06 (34.4%)
28-Oct-2022 11:22:40 2022-10-28 15:22:41        INFO        Display::displayReports         Report Displays are turned OFF
28-Oct-2022 11:22:40 test_tool_agentflagger.py::test_display::test_display_data_multiple_channel_selection
28-Oct-2022 11:22:40 AgentFlagger:: Check behaviour for multiple spw:chan selection 
28-Oct-2022 11:22:40 Moving data...
28-Oct-2022 11:22:40 PASSED
28-Oct-2022 11:22:40
28-Oct-2022 11:22:40 2022-10-28 15:22:41        INFO        AgentFlagger::open        Table type is Measurement Set
28-Oct-2022 11:22:40 2022-10-28 15:22:41        INFO        AgentFlagger::initAgents        There are initially 1 agents in the list. Agents: unflag
28-Oct-2022 11:22:40 2022-10-28 15:22:41        INFO        AgentFlagger::initAgents        There are 1 valid agents in the list. Agents: unflag
28-Oct-2022 11:22:41 2022-10-28 15:22:41        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
28-Oct-2022 11:22:41 2022-10-28 15:22:41        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
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (546816/546816)
28-Oct-2022 11:22:41 2022-10-28 15:22:41        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
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (410112/410112)
28-Oct-2022 11:22:41 2022-10-28 15:22:41        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
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (410112/410112)
28-Oct-2022 11:22:41 2022-10-28 15:22:41        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
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (410112/410112)
28-Oct-2022 11:22:41 2022-10-28 15:22:41        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
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (548352/548352)
28-Oct-2022 11:22:41 2022-10-28 15:22:41        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
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
28-Oct-2022 11:22:41 2022-10-28 15:22:41        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
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
28-Oct-2022 11:22:41 2022-10-28 15:22:41        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
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
28-Oct-2022 11:22:41 2022-10-28 15:22:41        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
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
28-Oct-2022 11:22:41 2022-10-28 15:22:41        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
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        FlagMSHandler::nextChunk         ====================================================================================
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        Unflag::tableSummary        => Percentage of data un-flagged in table selection: 100%
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        AgentFlagger::run        => Writing flags to the MS
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        AgentFlagger::open        Table type is Measurement Set
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        AgentFlagger::initAgents        There are initially 3 agents in the list. Agents: manual, summary, display
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        Display::setAgentParameters          data column is DATA
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        Display::setAgentParameters          Visibility expression is ABS RR,RL,LR,LL
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        Display::setAgentParameters          pause is 0
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        Display::setAgentParameters          datadisplay is 1
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        Display::setAgentParameters          reportdisplay is 0
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        Display::setAgentParameters          format is screen
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        AgentFlagger::initAgents        There are 3 valid agents in the list. Agents: manual, summary, display
28-Oct-2022 11:22:41 2022-10-28 15:22:41        INFO        FlagDataHandler::preLoadColumn         Setting row blocking to number of rows in selected table: 17184
28-Oct-2022 11:22:41 2022-10-28 15:22:42        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
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 0 Scan : 30 : 30
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:41 /data/test_env/bin/python: No module named casaplotserver
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 1 Scan : 30 : 30
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 2 Scan : 30 : 30
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        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
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 3 Scan : 30 : 30
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (179424/546816)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 4 Scan : 30 : 30
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 5 Scan : 30 : 30
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        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
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 6 Scan : 30 : 30
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (134568/410112)
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 7 Scan : 30 : 30
28-Oct-2022 11:22:41 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 8 Scan : 30 : 30
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        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
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 9 Scan : 30 : 30
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (134568/410112)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 10 Scan : 30 : 30
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 11 Scan : 30 : 30
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        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
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 12 Scan : 30 : 30
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (134568/410112)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 13 Scan : 30 : 30
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 14 Scan : 30 : 30
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 15 Scan : 30 : 30
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        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
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 0 Scan : 31 : 31
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (179928/548352)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 1 Scan : 31 : 31
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:42        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 2 Scan : 31 : 31
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        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
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 3 Scan : 31 : 31
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 4 Scan : 31 : 31
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 5 Scan : 31 : 31
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        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
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 6 Scan : 31 : 31
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 7 Scan : 31 : 31
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 8 Scan : 31 : 31
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        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
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 9 Scan : 31 : 31
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 10 Scan : 31 : 31
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 11 Scan : 31 : 31
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        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
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 12 Scan : 31 : 31
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:42 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 13 Scan : 31 : 31
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 14 Scan : 31 : 31
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        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
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 15 Scan : 31 : 31
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        FlagMSHandler::nextChunk         ====================================================================================
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Manual::tableSummary        => Percentage of data flagged in table selection: 32.8125%
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        AgentFlagger::run        => Writing flags to the MS
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          observation 0 flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          scan 31 flagged: 725760 total: 2.21184e+06 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          scan 30 flagged: 717696 total: 2.18726e+06 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          antenna ea24 flagged: 721728 total: 2.19955e+06 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          antenna ea19 flagged: 721728 total: 2.19955e+06 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          antenna ea01 flagged: 721728 total: 2.19955e+06 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          antenna ea11 flagged: 721728 total: 2.19955e+06 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          field 3C286_A flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          spw 15 flagged: 90216 total: 274944 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          spw 14 flagged: 90216 total: 274944 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          spw 10 flagged: 90216 total: 274944 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          spw 7 flagged: 90216 total: 274944 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          spw 12 flagged: 90216 total: 274944 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          spw 6 flagged: 90216 total: 274944 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          spw 8 flagged: 90216 total: 274944 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          spw 5 flagged: 90216 total: 274944 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          spw 0 flagged: 90216 total: 274944 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          spw 11 flagged: 90216 total: 274944 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          spw 9 flagged: 90216 total: 274944 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          spw 4 flagged: 90216 total: 274944 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          spw 1 flagged: 90216 total: 274944 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          spw 2 flagged: 90216 total: 274944 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          spw 13 flagged: 90216 total: 274944 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          spw 3 flagged: 90216 total: 274944 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          correlation LL flagged: 360864 total: 1.09978e+06 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          correlation LR flagged: 360864 total: 1.09978e+06 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          correlation RR flagged: 360864 total: 1.09978e+06 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          correlation RL flagged: 360864 total: 1.09978e+06 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          array 0 flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Summary::getResult          Total Flagged: 1.44346e+06 Total Counts: 4.3991e+06 (32.8%)
28-Oct-2022 11:22:43 2022-10-28 15:22:43        INFO        Display::displayReports         Report Displays are turned OFF
28-Oct-2022 11:22:46 test_tool_agentflagger.py::test_display::test_display_data_single_channel_selection
28-Oct-2022 11:22:46 AgentFlagger:: Check nominal behaviour for single spw:chan selection 
28-Oct-2022 11:22:46 The MS is already around, just unflag
28-Oct-2022 11:22:46 PASSED
28-Oct-2022 11:22:46
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        AgentFlagger::open        Table type is Measurement Set
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        AgentFlagger::initAgents        There are initially 1 agents in the list. Agents: unflag
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        AgentFlagger::initAgents        There are 1 valid agents in the list. Agents: unflag
28-Oct-2022 11:22:46 2022-10-28 15:22:47        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
28-Oct-2022 11:22:46 2022-10-28 15:22:47        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
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (1028/1028)
28-Oct-2022 11:22:46 2022-10-28 15:22:47        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
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2/2)
28-Oct-2022 11:22:46 2022-10-28 15:22:47        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
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (1026/1026)
28-Oct-2022 11:22:46 2022-10-28 15:22:47        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
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4/4)
28-Oct-2022 11:22:46 2022-10-28 15:22:47        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
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2050/2050)
28-Oct-2022 11:22:46 2022-10-28 15:22:47        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
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4096/4096)
28-Oct-2022 11:22:46 2022-10-28 15:22:47        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
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (6/6)
28-Oct-2022 11:22:46 2022-10-28 15:22:47        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
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2048/2048)
28-Oct-2022 11:22:46 2022-10-28 15:22:47        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
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4098/4098)
28-Oct-2022 11:22:46 2022-10-28 15:22:47        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
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2/2)
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        FlagMSHandler::nextChunk         ====================================================================================
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        Unflag::tableSummary        => Percentage of data un-flagged in table selection: 100%
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        AgentFlagger::run        => Writing flags to the MS
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        AgentFlagger::open        Table type is Measurement Set
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        FlagMSHandler::selectData          Selected spw-channels ids are Axis Lengths: [4, 4]  (NB: Matrix in Row/Column order)
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        FlagMSHandler::selectData +        [1, 0, 511, 1
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        FlagMSHandler::selectData +         2, 0, 0, 1
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        FlagMSHandler::selectData +         3, 0, 511, 1
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        FlagMSHandler::selectData +         4, 0, 0, 1]
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        AgentFlagger::initAgents        There are initially 3 agents in the list. Agents: manual, summary, display
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        Manual::setAgentParameters         autocorr is 0
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        Display::setAgentParameters          data column is FLOAT_DATA
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        Display::setAgentParameters          Visibility expression is REAL XX,YY
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        Display::setAgentParameters          pause is 0
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        Display::setAgentParameters          datadisplay is 1
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        Display::setAgentParameters          reportdisplay is 0
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        Display::setAgentParameters          format is screen
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        AgentFlagger::initAgents        There are 3 valid agents in the list. Agents: manual, summary, display
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        FlagDataHandler::preLoadColumn         Setting row blocking to number of rows in selected table: 4
28-Oct-2022 11:22:46 2022-10-28 15:22:47        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
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 1 Scan : 1 : 1
28-Oct-2022 11:22:46 2022-10-28 15:22:47        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
28-Oct-2022 11:22:47 /data/test_env/bin/python: No module named casaplotserver
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Manual::chunkSummary        => Data flagged so far 100% (1024/1024)
28-Oct-2022 11:22:47 2022-10-28 15:22:47        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
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 2 Scan : 1 : 1
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Manual::chunkSummary        => Data flagged so far 100% (2/2)
28-Oct-2022 11:22:47 2022-10-28 15:22:47        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
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 3 Scan : 1 : 1
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Manual::chunkSummary        => Data flagged so far 100% (1024/1024)
28-Oct-2022 11:22:47 2022-10-28 15:22:47        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
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 4 Scan : 1 : 1
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Manual::chunkSummary        => Data flagged so far 100% (2/2)
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        FlagMSHandler::nextChunk         ====================================================================================
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Manual::tableSummary        => Percentage of data flagged in table selection: 100%
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        AgentFlagger::run        => Writing flags to the MS
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Summary::getResult          observation 0 flagged: 2052 total: 2052 (100%)
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Summary::getResult          scan 1 flagged: 2052 total: 2052 (100%)
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Summary::getResult          antenna PM04 flagged: 2052 total: 2052 (100%)
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Summary::getResult          field r aqr flagged: 2052 total: 2052 (100%)
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Summary::getResult          spw 4 flagged: 2 total: 2 (100%)
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Summary::getResult          spw 3 flagged: 1024 total: 1024 (100%)
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Summary::getResult          spw 1 flagged: 1024 total: 1024 (100%)
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Summary::getResult          spw 2 flagged: 2 total: 2 (100%)
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Summary::getResult          correlation YY flagged: 1026 total: 1026 (100%)
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Summary::getResult          correlation XX flagged: 1026 total: 1026 (100%)
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Summary::getResult          array 0 flagged: 2052 total: 2052 (100%)
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Summary::getResult          Total Flagged: 2052 Total Counts: 2052 (100%)
28-Oct-2022 11:22:47 2022-10-28 15:22:47        INFO        Display::displayReports         Report Displays are turned OFF
28-Oct-2022 11:22:47 test_tool_agentflagger.py::test_display::test_display_float_data
28-Oct-2022 11:22:47 AgentFlagger: Select spw, display and flag single-dish MS
28-Oct-2022 11:22:47 Moving data...
28-Oct-2022 11:22:47 PASSED
28-Oct-2022 11:22:47
28-Oct-2022 11:22:47 - generated xml file: /data/source/casa6/casatestutils/nosedir/xml/test_tool_agentflagger/nose.xml -
28-Oct-2022 11:22:47 ======================== 35 passed, 1 warning in 30.59s ========================
28-Oct-2022 11:22:47 ============================= test session starts ==============================
28-Oct-2022 11:22:47 platform linux -- Python 3.8.12, pytest-7.2.0, pluggy-1.0.0 -- /data/test_env/bin/python
28-Oct-2022 11:22:47 cachedir: .pytest_cache
28-Oct-2022 11:22:47 rootdir: /data/source/casa6/casatestutils/nosedir/test_tool_image_statistics, configfile: pytest.ini
28-Oct-2022 11:22:48 collecting ... collected 11 items
28-Oct-2022 11:22:48
28-Oct-2022 11:22:48
28-Oct-2022 11:22:48 2022-10-28 15:22:48        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
28-Oct-2022 11:22:48 2022-10-28 15:22:48        INFO        name::        No table opened.
28-Oct-2022 11:22:48 2022-10-28 15:22:48        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:22:48 test_tool_image_statistics.py::ia_statistics_test::test_CAS_2195_image_can_have_linear_rather_than_direction_coordinate
28-Oct-2022 11:22:48 verify fix for CAS-2195, image has linear, not direction, coordinate
28-Oct-2022 11:22:48 PASSED
28-Oct-2022 11:22:48
28-Oct-2022 11:23:01 2022-10-28 15:23:01        INFO        name::        No table opened.
28-Oct-2022 11:23:01 2022-10-28 15:23:01        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:01 test_tool_image_statistics.py::ia_statistics_test::test_biweight
28-Oct-2022 11:23:01 Test biweight algorithm CAS-11100
28-Oct-2022 11:23:01 PASSED
28-Oct-2022 11:23:01
28-Oct-2022 11:23:01 2022-10-28 15:23:02        INFO        ImageFactory::createImage        Created Paged image 'chauvtest.im' of shape [107] with float valued pixels.
28-Oct-2022 11:23:01 2022-10-28 15:23:02        WARN        image::open (file /tmp/build-via-sdist-tla0v_e4/casatools-6.5.3.9a13970.dev1/src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
28-Oct-2022 11:23:01 2022-10-28 15:23:02        WARN        image::open (file /tmp/build-via-sdist-tla0v_e4/casatools-6.5.3.9a13970.dev1/src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
28-Oct-2022 11:23:01 2022-10-28 15:23:02        WARN        image::open (file /tmp/build-via-sdist-tla0v_e4/casatools-6.5.3.9a13970.dev1/src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
28-Oct-2022 11:23:01 2022-10-28 15:23:02        WARN        image::open (file /tmp/build-via-sdist-tla0v_e4/casatools-6.5.3.9a13970.dev1/src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
28-Oct-2022 11:23:01 2022-10-28 15:23:02        WARN        image::open (file /tmp/build-via-sdist-tla0v_e4/casatools-6.5.3.9a13970.dev1/src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
28-Oct-2022 11:23:01 2022-10-28 15:23:02        INFO        name::        No table opened.
28-Oct-2022 11:23:01 2022-10-28 15:23:02        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:01 test_tool_image_statistics.py::ia_statistics_test::test_chauvenet
28-Oct-2022 11:23:01 Test Chauvenet's criterion algorithm
28-Oct-2022 11:23:01 PASSED
28-Oct-2022 11:23:01
28-Oct-2022 11:23:01 2022-10-28 15:23:02        INFO        ImageFactory::createImage        Created Paged image 'fhtest.im' of shape [100] with float valued pixels.
28-Oct-2022 11:23:01 2022-10-28 15:23:02        INFO        name::        No table opened.
28-Oct-2022 11:23:01 2022-10-28 15:23:02        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:01 test_tool_image_statistics.py::ia_statistics_test::test_fithalf
28-Oct-2022 11:23:01 Test fit to half algorithm
28-Oct-2022 11:23:01 PASSED
28-Oct-2022 11:23:01
28-Oct-2022 11:23:02 2022-10-28 15:23:02        INFO        ImageFactory::createImage        Created Paged image 'hftest.im' of shape [100] with float valued pixels.
28-Oct-2022 11:23:02 2022-10-28 15:23:02        INFO        name::        No table opened.
28-Oct-2022 11:23:02 2022-10-28 15:23:02        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:02 test_tool_image_statistics.py::ia_statistics_test::test_hingesfences
28-Oct-2022 11:23:02 Test hinges-fences algorithm
28-Oct-2022 11:23:02 PASSED
28-Oct-2022 11:23:02
28-Oct-2022 11:23:02 2022-10-28 15:23:02        INFO        ImageFactory::createImage        Created Paged image 'internally_excluded_region.im' of shape [100, 200, 110, 4] with float valued pixels.
28-Oct-2022 11:23:03 2022-10-28 15:23:03        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
28-Oct-2022 11:23:03 2022-10-28 15:23:03        INFO        CasacRegionManager::fromBCS        Using channel range(s)
28-Oct-2022 11:23:03 2022-10-28 15:23:03        INFO        CasacRegionManager::fromBCS        Using polarizations IV
28-Oct-2022 11:23:03 2022-10-28 15:23:03        WARN                Stokes cannot be determined because this region type is not handled yet. But chances are very good this is no need to be alarmed.
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        name::        No table opened.
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:03 test_tool_image_statistics.py::ia_statistics_test::test_internal_region_exclusion
28-Oct-2022 11:23:03 Verify data not returned for internally excluded regions
28-Oct-2022 11:23:03 PASSED
28-Oct-2022 11:23:03
28-Oct-2022 11:23:03 test_tool_image_statistics.py::ia_statistics_test::test_logfile_param
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        name::        No table opened.
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:03 test logfile 
28-Oct-2022 11:23:03 i 1
28-Oct-2022 11:23:03 i 2
28-Oct-2022 11:23:03 PASSED
28-Oct-2022 11:23:03
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary        
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        Image name       : moment_map.im
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        Object name      : G11.92
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        Image type       : PagedImage
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        Image quantity   : Intensity
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        Pixel mask(s)    : mask0
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        Region(s)        : None
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        Image units      : Jy/beam.km/s
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        Restoring Beam   : 3.15627 arcsec, 1.80243 arcsec, 58.3141 deg
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary        
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        Direction reference : J2000
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        Spectral  reference : LSRK
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        Velocity  type      : RADIO
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        Rest frequency      : 2.30538e+11 Hz
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        Pointing center     :  18:13:58.097081  -18.54.16.695951
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        Telescope           : SMA
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        Observer            : SMA
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        Date observation    : 2008/06/23/00:00:00.000000
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        Axis Coord Type      Name             Proj Shape Tile   Coord value at pixel      Coord incr Units
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        --------------------------------------------------------------------------------------------------
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        0    0     Direction Right Ascension   SIN   256  256  18:13:58.097   128.00   -4.000000e-01 arcsec
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        1    0     Direction Declination       SIN   256  256 -18.54.16.696   128.00    4.000000e-01 arcsec
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        2    1     Stokes    Stokes                    1    1             I
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+        3    2     Spectral  Frequency                 1    1   2.30392e+11   -37.00 2.536257562e+06 Hz
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        ImageMetaData::summary+                             Velocity                               189.963   -37.00   -3.298159e+00 km/s
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        name::        No table opened.
28-Oct-2022 11:23:03 2022-10-28 15:23:04        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:03 test_tool_image_statistics.py::ia_statistics_test::test_moment_map_flux
28-Oct-2022 11:23:03 Test 1: verify moment maps can have flux densities computed in statistics
28-Oct-2022 11:23:03 PASSED
28-Oct-2022 11:23:03
28-Oct-2022 11:23:04 2022-10-28 15:23:04        INFO        ImageFactory::createImage        Created Paged image 'test011.im' of shape [10, 10, 10] with float valued pixels.
28-Oct-2022 11:23:04 2022-10-28 15:23:04        INFO        CasacRegionManager::fromBCS        Using specified box(es) 0, 0, 2, 2, 4, 4, 6, 6
28-Oct-2022 11:23:04 2022-10-28 15:23:04        INFO        name::        No table opened.
28-Oct-2022 11:23:04 2022-10-28 15:23:04        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:04 test_tool_image_statistics.py::ia_statistics_test::test_multiple_region_support
28-Oct-2022 11:23:04 test multiple region support
28-Oct-2022 11:23:04 PASSED
28-Oct-2022 11:23:04
28-Oct-2022 11:23:04 2022-10-28 15:23:04        INFO        name::        No table opened.
28-Oct-2022 11:23:04 2022-10-28 15:23:04        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:04 test_tool_image_statistics.py::ia_statistics_test::test_specifying_axes_param
28-Oct-2022 11:23:04 choose axes works
28-Oct-2022 11:23:04 PASSED
28-Oct-2022 11:23:04
28-Oct-2022 11:23:04 2022-10-28 15:23:04        INFO        ImageFactory::createImage        Created Paged image 'maskim' of shape [200, 200, 1, 1] with float valued pixels.
28-Oct-2022 11:23:04 2022-10-28 15:23:05        INFO        ImageFactory::createImage        Created Paged image 'tmp.im' of shape [200, 200, 1, 20] with float valued pixels.
28-Oct-2022 11:23:04 2022-10-28 15:23:05        SEVERE        image::statistics (file /tmp/build-via-sdist-tla0v_e4/casatools-6.5.3.9a13970.dev1/src/tools/image/image_cmpt.cc, line 5972)        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: /data/install/include/casacpp/imageanalysis/ImageAnalysis/SubImageFactory.tcc, line: 306
28-Oct-2022 11:23:04 2022-10-28 15:23:05        INFO        name::        No table opened.
28-Oct-2022 11:23:04 2022-10-28 15:23:05        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:04 test_tool_image_statistics.py::ia_statistics_test::test_stretch
28-Oct-2022 11:23:04 Test stretch parameter
28-Oct-2022 11:23:04 PASSED
28-Oct-2022 11:23:04
28-Oct-2022 11:23:04 - generated xml file: /data/source/casa6/casatestutils/nosedir/xml/test_tool_image_statistics/nose.xml -
28-Oct-2022 11:23:04 ======================== 11 passed, 1 warning in 17.33s ========================
28-Oct-2022 11:23:05 ============================= test session starts ==============================
28-Oct-2022 11:23:05 platform linux -- Python 3.8.12, pytest-7.2.0, pluggy-1.0.0 -- /data/test_env/bin/python
28-Oct-2022 11:23:05 cachedir: .pytest_cache
28-Oct-2022 11:23:05 rootdir: /data/source/casa6/casatestutils/nosedir/test_tool_image_pv, configfile: pytest.ini
28-Oct-2022 11:23:06 collecting ... collected 7 items
28-Oct-2022 11:23:06
28-Oct-2022 11:23:06
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageFactory::createImage        Created Temp image  of shape [30, 30, 30] with float valued pixels.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        PVGenerator::setEndpoints         Setting pixel end points [8.5, 15.5], [22.5, 15.5]
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:06        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        PVGenerator::setEndpoints         Setting pixel end points [22.5, 15.5], [8.5, 15.5]
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        PVGenerator::generate         Rotating image by -180 degrees about direction coordinate pixel (15.5, 15.5) to align specified slice with the x axis
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:06        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:06        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        name::        No table opened.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:06 test_tool_image_pv.py::ia_pv_test::test_CAS10968
28-Oct-2022 11:23:06 Fix for pa=90,270 when segment y pixel falls on half pixel
28-Oct-2022 11:23:06 PASSED
28-Oct-2022 11:23:06
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        PVGenerator::generate         Rotating image by -45 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:06        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:06        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:06        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        PVGenerator::generate         Rotating image by 45 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:06        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:06        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:06        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        PVGenerator::generate         Rotating image by -225 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:06        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:06        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:06        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        PVGenerator::generate         Rotating image by -135 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:06        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:06        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:06        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
28-Oct-2022 11:23:06 2022-10-28 15:23:06        WARN        image::open (file /tmp/build-via-sdist-tla0v_e4/casatools-6.5.3.9a13970.dev1/src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        PVGenerator::generate         Rotating image by -137.67 degrees about direction coordinate pixel (216.468, 187) to align specified slice with the x axis
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:06        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:06        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:07        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
28-Oct-2022 11:23:06 2022-10-28 15:23:07        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
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:07        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:07        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        PVGenerator::generate         Rotating image by 42.3301 degrees about direction coordinate pixel (216.468, 187) to align specified slice with the x axis
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:07        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:07        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
28-Oct-2022 11:23:06 2022-10-28 15:23:07        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
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:07        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:07        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        name::        No table opened.
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:06 test_tool_image_pv.py::ia_pv_test::test_CAS_2996
28-Oct-2022 11:23:06 ia.pv(): Test issues raised in CAS-2996
28-Oct-2022 11:23:06 PASSED
28-Oct-2022 11:23:06
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        PVGenerator::generate         Rotating image by -45 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:07        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:07        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:06 2022-10-28 15:23:07        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)
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageFitsConverter::ImageHeaderToFITS         Truncating miscinfo field secondary_coordinates to secondar
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageFitsConverter::ImageHeaderToFITS         Not writing miscInfo field 'secondar' - cannot handle type Record
28-Oct-2022 11:23:06 2022-10-28 15:23:07        WARN        image::open (file /tmp/build-via-sdist-tla0v_e4/casatools-6.5.3.9a13970.dev1/src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageFitsConverter::ImageHeaderToFITS         Truncating miscinfo field secondary_coordinates to secondar
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        ImageFitsConverter::ImageHeaderToFITS         Not writing miscInfo field 'secondar' - cannot handle type Record
28-Oct-2022 11:23:06 2022-10-28 15:23:07        WARN        image::open (file /tmp/build-via-sdist-tla0v_e4/casatools-6.5.3.9a13970.dev1/src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        name::        No table opened.
28-Oct-2022 11:23:06 2022-10-28 15:23:07        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:06 test_tool_image_pv.py::ia_pv_test::test_fits
28-Oct-2022 11:23:06 ia.pv(): Test exporting and importing to/from FITS
28-Oct-2022 11:23:06 PASSED
28-Oct-2022 11:23:06
28-Oct-2022 11:23:07 2022-10-28 15:23:07        INFO        ImageFactory::createImage        Created Paged image 'zz.im' of shape [30, 30, 30] with float valued pixels.
28-Oct-2022 11:23:07 2022-10-28 15:23:07        INFO        PVGenerator::setEndpoints         Setting pixel end points [10.0503, 19.9497], [19.9497, 10.0503]
28-Oct-2022 11:23:07 2022-10-28 15:23:07        INFO        PVGenerator::generate         Rotating image by 45 degrees about direction coordinate pixel (15, 15) to align specified slice with the x axis
28-Oct-2022 11:23:07 2022-10-28 15:23:07        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:07 2022-10-28 15:23:07        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)
28-Oct-2022 11:23:07 2022-10-28 15:23:07        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
28-Oct-2022 11:23:07 2022-10-28 15:23:07        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
28-Oct-2022 11:23:07 2022-10-28 15:23:07        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
28-Oct-2022 11:23:07 2022-10-28 15:23:07        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
28-Oct-2022 11:23:07 2022-10-28 15:23:07        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
28-Oct-2022 11:23:07 2022-10-28 15:23:07        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:07 2022-10-28 15:23:07        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)
28-Oct-2022 11:23:07 2022-10-28 15:23:07        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
28-Oct-2022 11:23:07 2022-10-28 15:23:07        INFO        ::::ImageFactory::createImage        Created Paged image 'zz.im' of shape [30, 30, 30] with float valued pixels.
28-Oct-2022 11:23:07 2022-10-28 15:23:07        INFO        ::::image::fromshape        Ran ia.fromshape
28-Oct-2022 11:23:07 2022-10-28 15:23:07        INFO        ::::image::fromshape        ia.fromshape(outfile="zz.im", shape=[30,30,30], csys={...}, linear=false, overwrite=false, log=true, type="f")
28-Oct-2022 11:23:07 2022-10-28 15:23:07        INFO        ::::image::pv        Ran ia.pv
28-Oct-2022 11:23:07 2022-10-28 15:23:07        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)
28-Oct-2022 11:23:07 2022-10-28 15:23:07        INFO        name::        No table opened.
28-Oct-2022 11:23:07 2022-10-28 15:23:07        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:07 test_tool_image_pv.py::ia_pv_test::test_history
28-Oct-2022 11:23:07 Verify history is written to created image
28-Oct-2022 11:23:07 PASSED
28-Oct-2022 11:23:07
28-Oct-2022 11:23:07 2022-10-28 15:23:07        INFO        ImageFactory::createImage        Created Paged image 'zxye.im' of shape [10, 10, 10] with float valued pixels.
28-Oct-2022 11:23:07 2022-10-28 15:23:08        INFO        name::        No table opened.
28-Oct-2022 11:23:07 2022-10-28 15:23:08        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:07 2022-10-28 15:23:08        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
28-Oct-2022 11:23:07 2022-10-28 15:23:08        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:07 2022-10-28 15:23:08        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)
28-Oct-2022 11:23:07 2022-10-28 15:23:08        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
28-Oct-2022 11:23:07 2022-10-28 15:23:08        INFO        SubImageFactory::createImage        Creating image 'test_pv_0' of shape [6, 10]
28-Oct-2022 11:23:08 2022-10-28 15:23:08        INFO        name::        No table opened.
28-Oct-2022 11:23:08 2022-10-28 15:23:08        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:08 2022-10-28 15:23:08        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
28-Oct-2022 11:23:08 2022-10-28 15:23:08        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
28-Oct-2022 11:23:08 2022-10-28 15:23:08        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:08 2022-10-28 15:23:08        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)
28-Oct-2022 11:23:08 2022-10-28 15:23:08        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
28-Oct-2022 11:23:08 2022-10-28 15:23:08        INFO        SubImageFactory::createImage        Creating image 'test_pv_1' of shape [6, 10]
28-Oct-2022 11:23:08 2022-10-28 15:23:08        INFO        name::        No table opened.
28-Oct-2022 11:23:08 2022-10-28 15:23:08        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:08 2022-10-28 15:23:08        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
28-Oct-2022 11:23:08 2022-10-28 15:23:08        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
28-Oct-2022 11:23:08 2022-10-28 15:23:08        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:08 2022-10-28 15:23:08        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)
28-Oct-2022 11:23:08 2022-10-28 15:23:08        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
28-Oct-2022 11:23:08 2022-10-28 15:23:09        INFO        SubImageFactory::createImage        Creating image 'test_pv_2' of shape [6, 10]
28-Oct-2022 11:23:08 2022-10-28 15:23:09        INFO        name::        No table opened.
28-Oct-2022 11:23:08 2022-10-28 15:23:09        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:08 2022-10-28 15:23:09        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
28-Oct-2022 11:23:08 2022-10-28 15:23:09        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
28-Oct-2022 11:23:08 2022-10-28 15:23:09        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:08 2022-10-28 15:23:09        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)
28-Oct-2022 11:23:08 2022-10-28 15:23:09        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
28-Oct-2022 11:23:08 2022-10-28 15:23:09        INFO        SubImageFactory::createImage        Creating image 'test_pv_3' of shape [6, 10]
28-Oct-2022 11:23:09 2022-10-28 15:23:09        INFO        name::        No table opened.
28-Oct-2022 11:23:09 2022-10-28 15:23:09        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:09 2022-10-28 15:23:09        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
28-Oct-2022 11:23:09 2022-10-28 15:23:09        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
28-Oct-2022 11:23:09 2022-10-28 15:23:09        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:09 2022-10-28 15:23:09        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)
28-Oct-2022 11:23:09 2022-10-28 15:23:09        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
28-Oct-2022 11:23:09 2022-10-28 15:23:09        INFO        SubImageFactory::createImage        Creating image 'test_pv_4' of shape [6, 10]
28-Oct-2022 11:23:09 2022-10-28 15:23:10        INFO        name::        No table opened.
28-Oct-2022 11:23:09 2022-10-28 15:23:10        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:09 2022-10-28 15:23:10        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
28-Oct-2022 11:23:09 2022-10-28 15:23:10        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
28-Oct-2022 11:23:09 2022-10-28 15:23:10        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:09 2022-10-28 15:23:10        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)
28-Oct-2022 11:23:09 2022-10-28 15:23:10        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
28-Oct-2022 11:23:09 2022-10-28 15:23:10        INFO        SubImageFactory::createImage        Creating image 'test_pv_5' of shape [6, 10]
28-Oct-2022 11:23:09 2022-10-28 15:23:10        INFO        name::        No table opened.
28-Oct-2022 11:23:09 2022-10-28 15:23:10        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:09 2022-10-28 15:23:10        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
28-Oct-2022 11:23:09 2022-10-28 15:23:10        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
28-Oct-2022 11:23:09 2022-10-28 15:23:10        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:09 2022-10-28 15:23:10        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)
28-Oct-2022 11:23:09 2022-10-28 15:23:10        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
28-Oct-2022 11:23:10 2022-10-28 15:23:10        INFO        SubImageFactory::createImage        Creating image 'test_pv_6' of shape [6, 10]
28-Oct-2022 11:23:10 2022-10-28 15:23:10        INFO        name::        No table opened.
28-Oct-2022 11:23:10 2022-10-28 15:23:10        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:10 2022-10-28 15:23:10        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
28-Oct-2022 11:23:10 2022-10-28 15:23:10        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:10 2022-10-28 15:23:10        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)
28-Oct-2022 11:23:10 2022-10-28 15:23:10        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_0' of shape [6, 10]
28-Oct-2022 11:23:10 2022-10-28 15:23:11        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
28-Oct-2022 11:23:10 2022-10-28 15:23:11        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:10 2022-10-28 15:23:11        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)
28-Oct-2022 11:23:10 2022-10-28 15:23:11        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_1' of shape [6, 10]
28-Oct-2022 11:23:10 2022-10-28 15:23:11        INFO        PVGenerator::setWidth         Rounding width up to next odd number of pixels (3), or 3arcmin
28-Oct-2022 11:23:10 2022-10-28 15:23:11        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
28-Oct-2022 11:23:10 2022-10-28 15:23:11        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:10 2022-10-28 15:23:11        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)
28-Oct-2022 11:23:10 2022-10-28 15:23:11        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_2' of shape [6, 10]
28-Oct-2022 11:23:11 2022-10-28 15:23:11        INFO        PVGenerator::setWidth         Rounding width up to next odd number of pixels (3), or 3arcmin
28-Oct-2022 11:23:11 2022-10-28 15:23:11        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
28-Oct-2022 11:23:11 2022-10-28 15:23:11        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:11 2022-10-28 15:23:11        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)
28-Oct-2022 11:23:11 2022-10-28 15:23:11        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_3' of shape [6, 10]
28-Oct-2022 11:23:11 2022-10-28 15:23:11        INFO        PVGenerator::setWidth         Rounding width up to next odd number of pixels (3), or 180000marcsec
28-Oct-2022 11:23:11 2022-10-28 15:23:11        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
28-Oct-2022 11:23:11 2022-10-28 15:23:11        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:11 2022-10-28 15:23:11        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)
28-Oct-2022 11:23:11 2022-10-28 15:23:12        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_4' of shape [6, 10]
28-Oct-2022 11:23:11 2022-10-28 15:23:12        INFO        name::        No table opened.
28-Oct-2022 11:23:11 2022-10-28 15:23:12        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:11 test_tool_image_pv.py::ia_pv_test::test_pv
28-Oct-2022 11:23:11 ia.pv(): Test pv()
28-Oct-2022 11:23:11 PASSED
28-Oct-2022 11:23:11
28-Oct-2022 11:23:11 2022-10-28 15:23:12        INFO        ImageFactory::createImage        Created Temp image  of shape [50, 50, 1000] with float valued pixels.
28-Oct-2022 11:23:11 2022-10-28 15:23:12        INFO        PVGenerator::generate         Rotating image by -45 degrees about direction coordinate pixel (7.5, 7.5) to align specified slice with the x axis
28-Oct-2022 11:23:11 2022-10-28 15:23:12        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:11 2022-10-28 15:23:12        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)
28-Oct-2022 11:23:11 2022-10-28 15:23:12        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
28-Oct-2022 11:23:11 2022-10-28 15:23:12        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
28-Oct-2022 11:23:11 2022-10-28 15:23:12        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
28-Oct-2022 11:23:11 2022-10-28 15:23:12        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
28-Oct-2022 11:23:11 2022-10-28 15:23:12        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
28-Oct-2022 11:23:11 2022-10-28 15:23:12        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:11 2022-10-28 15:23:12        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)
28-Oct-2022 11:23:11 2022-10-28 15:23:12        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
28-Oct-2022 11:23:11 2022-10-28 15:23:12        INFO        name::        No table opened.
28-Oct-2022 11:23:11 2022-10-28 15:23:12        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:11 test_tool_image_pv.py::ia_pv_test::test_refpix_far_outside_image
28-Oct-2022 11:23:11 Test refpix far outside image doesn't lead to malloc error, CAS-5251
28-Oct-2022 11:23:11 PASSED
28-Oct-2022 11:23:11
28-Oct-2022 11:23:11 2022-10-28 15:23:12        INFO        ImageFactory::createImage        Created Paged image 'maskim' of shape [200, 200, 1, 1] with float valued pixels.
28-Oct-2022 11:23:12 2022-10-28 15:23:12        INFO        ImageFactory::createImage        Created Paged image 'kk' of shape [200, 200, 1, 20] with float valued pixels.
28-Oct-2022 11:23:12 2022-10-28 15:23:13        SEVERE        image::pv (file /tmp/build-via-sdist-tla0v_e4/casatools-6.5.3.9a13970.dev1/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: /data/install/include/casacpp/imageanalysis/ImageAnalysis/SubImageFactory.tcc, line: 306
28-Oct-2022 11:23:12 2022-10-28 15:23:13        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
28-Oct-2022 11:23:12 2022-10-28 15:23:13        INFO        ImageRegion::fromRecord        Selected bounding box :
28-Oct-2022 11:23:12 2022-10-28 15:23:13        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)
28-Oct-2022 11:23:12 2022-10-28 15:23:13        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
28-Oct-2022 11:23:12 2022-10-28 15:23:13        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
28-Oct-2022 11:23:12 2022-10-28 15:23:13        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
28-Oct-2022 11:23:12 2022-10-28 15:23:13        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
28-Oct-2022 11:23:12 2022-10-28 15:23:13        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
28-Oct-2022 11:23:12 2022-10-28 15:23:13        INFO        name::        No table opened.
28-Oct-2022 11:23:12 2022-10-28 15:23:13        INFO        showcache::        The Table Cache is empty.
28-Oct-2022 11:23:12 test_tool_image_pv.py::ia_pv_test::test_stretch
28-Oct-2022 11:23:12 ia.pv(): Test stretch parameter
28-Oct-2022 11:23:12 PASSED
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12 - generated xml file: /data/source/casa6/casatestutils/nosedir/xml/test_tool_image_pv/nose.xml -
28-Oct-2022 11:23:12 ========================= 7 passed, 1 warning in 7.17s =========================
28-Oct-2022 11:23:12 Running Command: pytest ['--junitxml=/data/source/casa6/casatestutils/nosedir/xml/test_tool_calanalysis/nose.xml', '-s', '--disable-pytest-warnings', '--verbose', '-ra', '--tb=short', '/data/source/casa6/casatestutils/nosedir/test_tool_calanalysis/']
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12 Setting Working Directory: /data/source/casa6/casatestutils/nosedir/test_tool_image_fromcomplist/
28-Oct-2022 11:23:12 Traceback (most recent call last):
28-Oct-2022 11:23:12 Copying: /data/source/casa6/casatestutils/nosedir/tests/ to test_tool_image_fromcomplist /data/source/casa6/casatestutils/nosedir/test_tool_image_fromcomplist/
28-Oct-2022 11:23:12 Test Directory: /data/source/casa6/casatestutils/nosedir/test_tool_image_fromcomplist
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12 Running Command: pytest ['--junitxml=/data/source/casa6/casatestutils/nosedir/xml/test_tool_image_fromcomplist/nose.xml', '-s', '--disable-pytest-warnings', '--verbose', '-ra', '--tb=short', '/data/source/casa6/casatestutils/nosedir/test_tool_image_fromcomplist/']
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12 Setting Working Directory: /data/source/casa6/casatestutils/nosedir/test_tool_quanta/
28-Oct-2022 11:23:12 Copying: /data/source/casa6/casatestutils/nosedir/tests/ to test_tool_quanta /data/source/casa6/casatestutils/nosedir/test_tool_quanta/
28-Oct-2022 11:23:12   File "runtest.py", line 613, in run
28-Oct-2022 11:23:12 Test Directory: /data/source/casa6/casatestutils/nosedir/test_tool_quanta
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12     shutil.copy2("{}{}.py".format(workdir + "tests/",test), workdir + "{}/".format(test if not test.endswith(".py") else test[:-3]))
28-Oct-2022 11:23:12   File "/usr/lib64/python3.8/shutil.py", line 435, in copy2
28-Oct-2022 11:23:12     copyfile(src, dst, follow_symlinks=follow_symlinks)
28-Oct-2022 11:23:12   File "/usr/lib64/python3.8/shutil.py", line 264, in copyfile
28-Oct-2022 11:23:12     with open(src, 'rb') as fsrc, open(dst, 'wb') as fdst:
28-Oct-2022 11:23:12 FileNotFoundError: [Errno 2] No such file or directory: '/data/source/casa6/casatestutils/nosedir/tests/test_tool_image_fromcomplist.py'
28-Oct-2022 11:23:12 Running Command: pytest ['--junitxml=/data/source/casa6/casatestutils/nosedir/xml/test_tool_quanta/nose.xml', '-s', '--disable-pytest-warnings', '--verbose', '-ra', '--tb=short', '/data/source/casa6/casatestutils/nosedir/test_tool_quanta/']
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12 Setting Working Directory: /data/source/casa6/casatestutils/nosedir/test_tool_logsink/
28-Oct-2022 11:23:12 Copying: /data/source/casa6/casatestutils/nosedir/tests/ to test_tool_logsink /data/source/casa6/casatestutils/nosedir/test_tool_logsink/
28-Oct-2022 11:23:12 Test Directory: /data/source/casa6/casatestutils/nosedir/test_tool_logsink
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12 Running Command: pytest ['--junitxml=/data/source/casa6/casatestutils/nosedir/xml/test_tool_logsink/nose.xml', '-s', '--disable-pytest-warnings', '--verbose', '-ra', '--tb=short', '/data/source/casa6/casatestutils/nosedir/test_tool_logsink/']
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12 Setting Working Directory: /data/source/casa6/casatestutils/nosedir/test_tool_ms_createmultims/
28-Oct-2022 11:23:12 Copying: /data/source/casa6/casatestutils/nosedir/tests/ to test_tool_ms_createmultims /data/source/casa6/casatestutils/nosedir/test_tool_ms_createmultims/
28-Oct-2022 11:23:12 Test Directory: /data/source/casa6/casatestutils/nosedir/test_tool_ms_createmultims
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12 Running Command: pytest ['--junitxml=/data/source/casa6/casatestutils/nosedir/xml/test_tool_ms_createmultims/nose.xml', '-s', '--disable-pytest-warnings', '--verbose', '-ra', '--tb=short', '/data/source/casa6/casatestutils/nosedir/test_tool_ms_createmultims/']
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12 Setting Working Directory: /data/source/casa6/casatestutils/nosedir/test_tool_agentflagger/
28-Oct-2022 11:23:12 Copying: /data/source/casa6/casatestutils/nosedir/tests/ to test_tool_agentflagger /data/source/casa6/casatestutils/nosedir/test_tool_agentflagger/
28-Oct-2022 11:23:12 Test Directory: /data/source/casa6/casatestutils/nosedir/test_tool_agentflagger
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12 Running Command: pytest ['--junitxml=/data/source/casa6/casatestutils/nosedir/xml/test_tool_agentflagger/nose.xml', '-s', '--disable-pytest-warnings', '--verbose', '-ra', '--tb=short', '/data/source/casa6/casatestutils/nosedir/test_tool_agentflagger/']
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12 Setting Working Directory: /data/source/casa6/casatestutils/nosedir/test_tool_image_statistics/
28-Oct-2022 11:23:12 Copying: /data/source/casa6/casatestutils/nosedir/tests/ to test_tool_image_statistics /data/source/casa6/casatestutils/nosedir/test_tool_image_statistics/
28-Oct-2022 11:23:12 Test Directory: /data/source/casa6/casatestutils/nosedir/test_tool_image_statistics
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12 Running Command: pytest ['--junitxml=/data/source/casa6/casatestutils/nosedir/xml/test_tool_image_statistics/nose.xml', '-s', '--disable-pytest-warnings', '--verbose', '-ra', '--tb=short', '/data/source/casa6/casatestutils/nosedir/test_tool_image_statistics/']
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12 Setting Working Directory: /data/source/casa6/casatestutils/nosedir/test_tool_image_pv/
28-Oct-2022 11:23:12 Copying: /data/source/casa6/casatestutils/nosedir/tests/ to test_tool_image_pv /data/source/casa6/casatestutils/nosedir/test_tool_image_pv/
28-Oct-2022 11:23:12 Test Directory: /data/source/casa6/casatestutils/nosedir/test_tool_image_pv
28-Oct-2022 11:23:12
28-Oct-2022 11:23:12 Running Command: pytest ['--junitxml=/data/source/casa6/casatestutils/nosedir/xml/test_tool_image_pv/nose.xml', '-s', '--disable-pytest-warnings', '--verbose', '-ra', '--tb=short', '/data/source/casa6/casatestutils/nosedir/test_tool_image_pv/']
28-Oct-2022 11:23:12
28-Oct-2022 11:23:13 /test_tool_image_fromcomplist
28-Oct-2022 11:23:13 /test_tool_simulator
28-Oct-2022 11:23:13 /test_tool_image_pv
28-Oct-2022 11:23:13 /test_tool_imagepol
28-Oct-2022 11:23:13 /test_tool_ms_statwt
28-Oct-2022 11:23:13 /test_tool_ms
28-Oct-2022 11:23:13 /test_tool_vpmanager
28-Oct-2022 11:23:13 /test_tool_sdm
28-Oct-2022 11:23:13 /test_tool_image_transpose
28-Oct-2022 11:23:13 /test_tool_measures
28-Oct-2022 11:23:13 /test_tool_image_subimage
28-Oct-2022 11:23:13 /test_tool_sdm_toms
28-Oct-2022 11:23:13 /test_tool_linearmosaic
28-Oct-2022 11:23:13 /test_tool_quanta
28-Oct-2022 11:23:13 /test_tool_image_fitprofile
28-Oct-2022 11:23:13 /test_tool_image
28-Oct-2022 11:23:13 /test_tool_calanalysis
28-Oct-2022 11:23:13 /test_tool_image_rebin
28-Oct-2022 11:23:13 /test_tool_image_deviation
28-Oct-2022 11:23:13 /test_tool_msmetadata
28-Oct-2022 11:23:13 /test_tool_image_collapse
28-Oct-2022 11:23:13 /test_tool_componentlist
28-Oct-2022 11:23:13 /test_tool_image_pbcor
28-Oct-2022 11:23:13 /test_tool_image_regrid
28-Oct-2022 11:23:13 /test_tool_image_statistics
28-Oct-2022 11:23:13 /test_tool_ms_createmultims
28-Oct-2022 11:23:13 /test_tool_table
28-Oct-2022 11:23:13 /test_tool_agentflagger
28-Oct-2022 11:23:13 /test_tool_calibrater
28-Oct-2022 11:23:13 /test_tool_logsink
28-Oct-2022 11:23:13 /test_tool_coordsys
28-Oct-2022 11:23:13 /test_tool_regionmanager
28-Oct-2022 11:23:13 Finished task 'Test casatools' with result: Success
28-Oct-2022 11:23:13 Starting task 'Parse test results' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
28-Oct-2022 11:23:13 Parsing test results under /export/home/cbt-el7-10/bamboohome/xml-data/build-dir/CASA-CMAKECI1-JOB1...
28-Oct-2022 11:23:13 Finished task 'Parse test results' with result: Success
28-Oct-2022 11:23:13 Running post build plugin 'Docker Container Cleanup'
28-Oct-2022 11:23:13
Beginning to execute external process for build 'CASA - CMake CI Build - CAS-13970 - CMake build ManyLinux 2.28 #3 (CASA-CMAKECI1-JOB1-3)'
... running command line:
/bin/docker rm -f build_container
... in: /export/home/cbt-el7-10/bamboohome/xml-data/build-dir/CASA-CMAKECI1-JOB1
28-Oct-2022 11:23:17 build_container
28-Oct-2022 11:23:17 Running post build plugin 'NCover Results Collector'
28-Oct-2022 11:23:17 Running post build plugin 'Clover Results Collector'
28-Oct-2022 11:23:17 Running post build plugin 'npm Cache Cleanup'
28-Oct-2022 11:23:17 Running post build plugin 'Artifact Copier'
28-Oct-2022 11:23:17 Finalising the build...
28-Oct-2022 11:23:17 Stopping timer.
28-Oct-2022 11:23:17 Build CASA-CMAKECI1-JOB1-3 completed.
28-Oct-2022 11:23:17 Running on server: post build plugin 'NCover Results Collector'
28-Oct-2022 11:23:17 Running on server: post build plugin 'Build Hanging Detection Configuration'
28-Oct-2022 11:23:17 Running on server: post build plugin 'Clover Delta Calculator'
28-Oct-2022 11:23:17 Running on server: post build plugin 'Maven Dependencies Postprocessor'
28-Oct-2022 11:23:17 All post build plugins have finished
28-Oct-2022 11:23:17 Generating build results summary...
28-Oct-2022 11:23:18 Saving build results to disk...
28-Oct-2022 11:23:18 Store variable context...
28-Oct-2022 11:23:18 Indexing build results...
28-Oct-2022 11:23:18 Finished building CASA-CMAKECI1-JOB1-3.