Build: #4 was successful

Job: Test Tools Many Linux 2014 was successful

Build log

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

07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 11 Scan : 31 : 31
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        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
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 12 Scan : 31 : 31
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Manual::chunkSummary        => Data flagged so far 34.375% (142560/414720)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 13 Scan : 31 : 31
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 14 Scan : 31 : 31
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        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
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 15 Scan : 31 : 31
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:25 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Manual::chunkSummary        => Data flagged so far 34.375% (142560/414720)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        FlagMSHandler::nextChunk         ====================================================================================
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Unflag::tableSummary        => Percentage of data un-flagged in table selection: 100%
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Manual::tableSummary        => Percentage of data flagged in table selection: 34.375%
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        AgentFlagger::run        => Writing flags to the MS
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          observation 0 flagged: 1.51219e+06 total: 4.3991e+06 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          spw 15 flagged: 94512 total: 274944 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          spw 13 flagged: 94512 total: 274944 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          spw 11 flagged: 94512 total: 274944 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          spw 14 flagged: 94512 total: 274944 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          spw 3 flagged: 94512 total: 274944 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          spw 4 flagged: 94512 total: 274944 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          spw 2 flagged: 94512 total: 274944 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          spw 1 flagged: 94512 total: 274944 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          spw 0 flagged: 94512 total: 274944 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          spw 12 flagged: 94512 total: 274944 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          spw 6 flagged: 94512 total: 274944 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          spw 8 flagged: 94512 total: 274944 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          spw 10 flagged: 94512 total: 274944 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          spw 5 flagged: 94512 total: 274944 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          spw 7 flagged: 94512 total: 274944 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          spw 9 flagged: 94512 total: 274944 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          correlation LL flagged: 378048 total: 1.09978e+06 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          correlation LR flagged: 378048 total: 1.09978e+06 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          correlation RL flagged: 378048 total: 1.09978e+06 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          correlation RR flagged: 378048 total: 1.09978e+06 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          scan 31 flagged: 760320 total: 2.21184e+06 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          scan 30 flagged: 751872 total: 2.18726e+06 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          antenna ea11 flagged: 756096 total: 2.19955e+06 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          antenna ea24 flagged: 756096 total: 2.19955e+06 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          antenna ea19 flagged: 756096 total: 2.19955e+06 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          antenna ea01 flagged: 756096 total: 2.19955e+06 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          field 3C286_A flagged: 1.51219e+06 total: 4.3991e+06 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          array 0 flagged: 1.51219e+06 total: 4.3991e+06 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Summary::getResult          Total Flagged: 1.51219e+06 Total Counts: 4.3991e+06 (34.4%)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Display::displayReports         Report Displays are turned OFF
07-Sep-2023 17:04:26 test_tool_agentflagger.py::test_display::test_display_data_multiple_channel_selection
07-Sep-2023 17:04:26 AgentFlagger:: Check behaviour for multiple spw:chan selection 
07-Sep-2023 17:04:26 Moving data...
07-Sep-2023 17:04:26 PASSED
07-Sep-2023 17:04:26
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        AgentFlagger::open        Table type is Measurement Set
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        AgentFlagger::initAgents        There are initially 1 agents in the list. Agents: unflag
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        AgentFlagger::initAgents        There are 1 valid agents in the list. Agents: unflag
07-Sep-2023 17:04:26 2023-09-07 21:04:26        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
07-Sep-2023 17:04:26 2023-09-07 21:04:26        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
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (546816/546816)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        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
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (410112/410112)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        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
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (410112/410112)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        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
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (410112/410112)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        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
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (548352/548352)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        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
07-Sep-2023 17:04:26 2023-09-07 21:04:26        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
07-Sep-2023 17:04:26 2023-09-07 21:04:26        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
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
07-Sep-2023 17:04:26 2023-09-07 21:04:27        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
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
07-Sep-2023 17:04:26 2023-09-07 21:04:27        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
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
07-Sep-2023 17:04:26 2023-09-07 21:04:27        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
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (414720/414720)
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        FlagMSHandler::nextChunk         ====================================================================================
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Unflag::tableSummary        => Percentage of data un-flagged in table selection: 100%
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        AgentFlagger::run        => Writing flags to the MS
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        AgentFlagger::open        Table type is Measurement Set
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        AgentFlagger::initAgents        There are initially 3 agents in the list. Agents: manual, summary, display
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::setAgentParameters          data column is DATA
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::setAgentParameters          Visibility expression is ABS RR,RL,LR,LL
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::setAgentParameters          pause is 0
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::setAgentParameters          datadisplay is 1
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::setAgentParameters          reportdisplay is 0
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::setAgentParameters          format is screen
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        AgentFlagger::initAgents        There are 3 valid agents in the list. Agents: manual, summary, display
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        FlagDataHandler::preLoadColumn         Setting row blocking to number of rows in selected table: 17184
07-Sep-2023 17:04:26 2023-09-07 21:04:27        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
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 0 Scan : 30 : 30
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:26 /home/casatest/venv/bin/python3.8: No module named casaplotserver
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 1 Scan : 30 : 30
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 2 Scan : 30 : 30
07-Sep-2023 17:04:26 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        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
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 3 Scan : 30 : 30
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (179424/546816)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 4 Scan : 30 : 30
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 5 Scan : 30 : 30
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        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
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 6 Scan : 30 : 30
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (134568/410112)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 7 Scan : 30 : 30
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 8 Scan : 30 : 30
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        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
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 9 Scan : 30 : 30
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (134568/410112)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 10 Scan : 30 : 30
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 11 Scan : 30 : 30
07-Sep-2023 17:04:27 2023-09-07 21:04:27        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        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
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 12 Scan : 30 : 30
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (134568/410112)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 13 Scan : 30 : 30
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 14 Scan : 30 : 30
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 15 Scan : 30 : 30
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        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
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 0 Scan : 31 : 31
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (179928/548352)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 1 Scan : 31 : 31
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 2 Scan : 31 : 31
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        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
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 3 Scan : 31 : 31
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:27 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 4 Scan : 31 : 31
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 5 Scan : 31 : 31
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        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
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 6 Scan : 31 : 31
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 7 Scan : 31 : 31
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 8 Scan : 31 : 31
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        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
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 9 Scan : 31 : 31
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 10 Scan : 31 : 31
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 11 Scan : 31 : 31
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        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
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 12 Scan : 31 : 31
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:28        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 13 Scan : 31 : 31
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 14 Scan : 31 : 31
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        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
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 15 Scan : 31 : 31
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        FlagMSHandler::nextChunk         ====================================================================================
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Manual::tableSummary        => Percentage of data flagged in table selection: 32.8125%
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        AgentFlagger::run        => Writing flags to the MS
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          observation 0 flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          spw 15 flagged: 90216 total: 274944 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          spw 13 flagged: 90216 total: 274944 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          spw 11 flagged: 90216 total: 274944 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          spw 14 flagged: 90216 total: 274944 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          spw 3 flagged: 90216 total: 274944 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          spw 4 flagged: 90216 total: 274944 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          spw 2 flagged: 90216 total: 274944 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          spw 1 flagged: 90216 total: 274944 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          spw 0 flagged: 90216 total: 274944 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          spw 12 flagged: 90216 total: 274944 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          spw 6 flagged: 90216 total: 274944 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          spw 8 flagged: 90216 total: 274944 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          spw 10 flagged: 90216 total: 274944 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          spw 5 flagged: 90216 total: 274944 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          spw 7 flagged: 90216 total: 274944 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          spw 9 flagged: 90216 total: 274944 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          correlation LL flagged: 360864 total: 1.09978e+06 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          correlation LR flagged: 360864 total: 1.09978e+06 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          correlation RL flagged: 360864 total: 1.09978e+06 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          correlation RR flagged: 360864 total: 1.09978e+06 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          scan 31 flagged: 725760 total: 2.21184e+06 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          scan 30 flagged: 717696 total: 2.18726e+06 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          antenna ea11 flagged: 721728 total: 2.19955e+06 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          antenna ea24 flagged: 721728 total: 2.19955e+06 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          antenna ea19 flagged: 721728 total: 2.19955e+06 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          antenna ea01 flagged: 721728 total: 2.19955e+06 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          field 3C286_A flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          array 0 flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Summary::getResult          Total Flagged: 1.44346e+06 Total Counts: 4.3991e+06 (32.8%)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Display::displayReports         Report Displays are turned OFF
07-Sep-2023 17:04:28 test_tool_agentflagger.py::test_display::test_display_data_single_channel_selection
07-Sep-2023 17:04:28 AgentFlagger:: Check nominal behaviour for single spw:chan selection 
07-Sep-2023 17:04:28 The MS is already around, just unflag
07-Sep-2023 17:04:28 PASSED
07-Sep-2023 17:04:28
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        AgentFlagger::open        Table type is Measurement Set
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        AgentFlagger::initAgents        There are initially 1 agents in the list. Agents: unflag
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        AgentFlagger::initAgents        There are 1 valid agents in the list. Agents: unflag
07-Sep-2023 17:04:28 2023-09-07 21:04:29        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
07-Sep-2023 17:04:28 2023-09-07 21:04:29        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
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (1028/1028)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        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
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2/2)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        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
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (1026/1026)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        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
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4/4)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        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
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2050/2050)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        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
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4096/4096)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        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
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (6/6)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        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
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2048/2048)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        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
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4098/4098)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        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
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2/2)
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        FlagMSHandler::nextChunk         ====================================================================================
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        Unflag::tableSummary        => Percentage of data un-flagged in table selection: 100%
07-Sep-2023 17:04:28 2023-09-07 21:04:29        INFO        AgentFlagger::run        => Writing flags to the MS
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        AgentFlagger::open        Table type is Measurement Set
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        FlagMSHandler::selectData          Selected spw-channels ids are Axis Lengths: [4, 4]  (NB: Matrix in Row/Column order)
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        FlagMSHandler::selectData +        [1, 0, 511, 1
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        FlagMSHandler::selectData +         2, 0, 0, 1
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        FlagMSHandler::selectData +         3, 0, 511, 1
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        FlagMSHandler::selectData +         4, 0, 0, 1]
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        AgentFlagger::initAgents        There are initially 3 agents in the list. Agents: manual, summary, display
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Manual::setAgentParameters         autocorr is 0
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Display::setAgentParameters          data column is FLOAT_DATA
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Display::setAgentParameters          Visibility expression is REAL XX,YY
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Display::setAgentParameters          pause is 0
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Display::setAgentParameters          datadisplay is 1
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Display::setAgentParameters          reportdisplay is 0
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Display::setAgentParameters          format is screen
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        AgentFlagger::initAgents        There are 3 valid agents in the list. Agents: manual, summary, display
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        FlagDataHandler::preLoadColumn         Setting row blocking to number of rows in selected table: 4
07-Sep-2023 17:04:29 2023-09-07 21:04:29        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
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 1 Scan : 1 : 1
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
07-Sep-2023 17:04:29 /home/casatest/venv/bin/python3.8: No module named casaplotserver
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Manual::chunkSummary        => Data flagged so far 100% (1024/1024)
07-Sep-2023 17:04:29 2023-09-07 21:04:29        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
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 2 Scan : 1 : 1
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Manual::chunkSummary        => Data flagged so far 100% (2/2)
07-Sep-2023 17:04:29 2023-09-07 21:04:29        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
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 3 Scan : 1 : 1
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Manual::chunkSummary        => Data flagged so far 100% (1024/1024)
07-Sep-2023 17:04:29 2023-09-07 21:04:29        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
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 4 Scan : 1 : 1
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Manual::chunkSummary        => Data flagged so far 100% (2/2)
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        FlagMSHandler::nextChunk         ====================================================================================
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Manual::tableSummary        => Percentage of data flagged in table selection: 100%
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        AgentFlagger::run        => Writing flags to the MS
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Summary::getResult          observation 0 flagged: 2052 total: 2052 (100%)
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Summary::getResult          spw 4 flagged: 2 total: 2 (100%)
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Summary::getResult          spw 3 flagged: 1024 total: 1024 (100%)
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Summary::getResult          spw 2 flagged: 2 total: 2 (100%)
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Summary::getResult          spw 1 flagged: 1024 total: 1024 (100%)
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Summary::getResult          correlation YY flagged: 1026 total: 1026 (100%)
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Summary::getResult          correlation XX flagged: 1026 total: 1026 (100%)
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Summary::getResult          scan 1 flagged: 2052 total: 2052 (100%)
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Summary::getResult          antenna PM04 flagged: 2052 total: 2052 (100%)
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Summary::getResult          field r aqr flagged: 2052 total: 2052 (100%)
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Summary::getResult          array 0 flagged: 2052 total: 2052 (100%)
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Summary::getResult          Total Flagged: 2052 Total Counts: 2052 (100%)
07-Sep-2023 17:04:29 2023-09-07 21:04:29        INFO        Display::displayReports         Report Displays are turned OFF
07-Sep-2023 17:04:29 test_tool_agentflagger.py::test_display::test_display_float_data
07-Sep-2023 17:04:29 AgentFlagger: Select spw, display and flag single-dish MS
07-Sep-2023 17:04:29 Moving data...
07-Sep-2023 17:04:29 PASSED
07-Sep-2023 17:04:29
07-Sep-2023 17:04:29 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_agentflagger/nose.xml -
07-Sep-2023 17:04:29 ======================== 35 passed, 1 warning in 26.63s ========================
07-Sep-2023 17:04:29 ============================= test session starts ==============================
07-Sep-2023 17:04:29 platform linux -- Python 3.8.7, pytest-7.4.2, pluggy-1.3.0 -- /home/casatest/venv/bin/python3.8
07-Sep-2023 17:04:29 cachedir: .pytest_cache
07-Sep-2023 17:04:29 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_deviation
07-Sep-2023 17:04:29 configfile: pytest.ini
07-Sep-2023 17:04:30 collecting ... collected 8 items
07-Sep-2023 17:04:30
07-Sep-2023 17:04:30
07-Sep-2023 17:04:30 2023-09-07 21:04:30        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing NPTS using the classical algorithm around each of 10000 grid points in 2 planes.
07-Sep-2023 17:04:30 2023-09-07 21:04:31        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
07-Sep-2023 17:04:30 2023-09-07 21:04:31        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 10000 grid points in 2 planes.
07-Sep-2023 17:04:30 2023-09-07 21:04:31        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
07-Sep-2023 17:04:30 2023-09-07 21:04:31        INFO        name::        No table opened.
07-Sep-2023 17:04:30 2023-09-07 21:04:31        INFO        showcache::        The Table Cache is empty.
07-Sep-2023 17:04:30 2023-09-07 21:04:31        INFO        name::        No table opened.
07-Sep-2023 17:04:30 2023-09-07 21:04:31        INFO        name::        No table opened.
07-Sep-2023 17:04:30 test_tool_image_deviation.py::ia_deviation_test::test001
07-Sep-2023 17:04:30 Every pixel is a grid point
07-Sep-2023 17:04:31 PASSED
07-Sep-2023 17:04:31
07-Sep-2023 17:04:31 2023-09-07 21:04:31        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing NPTS using the classical algorithm around each of 10000 grid points in 2 planes.
07-Sep-2023 17:04:31 2023-09-07 21:04:31        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
07-Sep-2023 17:04:31 2023-09-07 21:04:31        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 10000 grid points in 2 planes.
07-Sep-2023 17:04:31 2023-09-07 21:04:32        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
07-Sep-2023 17:04:31 2023-09-07 21:04:32        INFO        name::        No table opened.
07-Sep-2023 17:04:31 2023-09-07 21:04:32        INFO        showcache::        The Table Cache is empty.
07-Sep-2023 17:04:31 2023-09-07 21:04:32        INFO        name::        No table opened.
07-Sep-2023 17:04:31 2023-09-07 21:04:32        INFO        name::        No table opened.
07-Sep-2023 17:04:31 test_tool_image_deviation.py::ia_deviation_test::test002
07-Sep-2023 17:04:31 Every pixel is a grid point with an offset, so should be the same result
07-Sep-2023 17:04:31 as test001
07-Sep-2023 17:04:31 PASSED
07-Sep-2023 17:04:31
07-Sep-2023 17:04:31 2023-09-07 21:04:32        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing NPTS using the classical algorithm around each of 1156 grid points in 2 planes.
07-Sep-2023 17:04:31 2023-09-07 21:04:32        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
07-Sep-2023 17:04:31 2023-09-07 21:04:32        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
07-Sep-2023 17:04:31 2023-09-07 21:04:32        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 1156 grid points in 2 planes.
07-Sep-2023 17:04:31 2023-09-07 21:04:32        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
07-Sep-2023 17:04:31 2023-09-07 21:04:32        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
07-Sep-2023 17:04:31 2023-09-07 21:04:32        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
07-Sep-2023 17:04:31 2023-09-07 21:04:32        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing NPTS using the classical algorithm around each of 1156 grid points in 2 planes.
07-Sep-2023 17:04:31 2023-09-07 21:04:32        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
07-Sep-2023 17:04:31 2023-09-07 21:04:32        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
07-Sep-2023 17:04:31 2023-09-07 21:04:32        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 1156 grid points in 2 planes.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        name::        No table opened.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        showcache::        The Table Cache is empty.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        name::        No table opened.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        name::        No table opened.
07-Sep-2023 17:04:32 test_tool_image_deviation.py::ia_deviation_test::test003
07-Sep-2023 17:04:32 Every third pixel is a grid point
07-Sep-2023 17:04:32 PASSED
07-Sep-2023 17:04:32
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing NPTS using the classical algorithm around each of 1089 grid points in 2 planes.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 1089 grid points in 2 planes.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing NPTS using the classical algorithm around each of 1089 grid points in 2 planes.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 1089 grid points in 2 planes.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        name::        No table opened.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        showcache::        The Table Cache is empty.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        name::        No table opened.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        name::        No table opened.
07-Sep-2023 17:04:32 test_tool_image_deviation.py::ia_deviation_test::test005
07-Sep-2023 17:04:32 Every third pixel is a grid point, using anchor [2,2]
07-Sep-2023 17:04:32 PASSED
07-Sep-2023 17:04:32
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 10.001 pix x 10.001 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 11 pix x 11 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 64 grid points in 2 planes.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        ImageRegion::fromRecord        Selected bounding box :
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        ImageRegion::fromRecord+            [5, 5, 0] to [85, 85, 1]  (00:03:00.021, -00.45.00.077, I to 23:57:39.990, +00.35.00.036, Q)
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 10.001 pix x 10.001 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 11 pix x 11 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 36 grid points in 2 planes.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        ImageRegion::fromRecord        Selected bounding box :
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        ImageRegion::fromRecord+            [27, 27, 0] to [66, 66, 0]  (00:01:32.003, -00.23.00.010, I to 23:58:55.999, +00.16.00.003, I)
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        ImageRegion::fromRecord        Selected bounding box :
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        ImageRegion::fromRecord+            [22, 22, 0] to [61, 61, 0]  (00:01:32.003, -00.23.00.010, I to 23:58:55.999, +00.16.00.003, I)
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        name::        No table opened.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        showcache::        The Table Cache is empty.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        name::        No table opened.
07-Sep-2023 17:04:32 2023-09-07 21:04:32        INFO        name::        No table opened.
07-Sep-2023 17:04:32 test_tool_image_deviation.py::ia_deviation_test::test006
07-Sep-2023 17:04:32 Test that regions work as expected
07-Sep-2023 17:04:32 PASSED
07-Sep-2023 17:04:32
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        ImageFactory::createImage        Created Paged image 'mycirc.im' of shape [100, 100] with float valued pixels.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        StatImageCreator::useReferencePixelAsAnchor        Anchor being set at pixel [50,50], at/near image reference pixel.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        StatImageCreator::_computeStat        Using circular region of radius 20 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 41 pix x 41 pix and there are 1257 good pixels in the circle that are being used) to choose pixels for computing SUM using the classical algorithm around each of 25 grid points in 1 planes.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        StatImageCreator::_doInterpolation        Interpolate using CUBIC algorithm.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        name::        No table opened.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        showcache::        The Table Cache is empty.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        name::        No table opened.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        name::        No table opened.
07-Sep-2023 17:04:32 test_tool_image_deviation.py::ia_deviation_test::test_circle
07-Sep-2023 17:04:32 test circles work correctly CAS-10296
07-Sep-2023 17:04:32 PASSED
07-Sep-2023 17:04:32
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        ImageFactory::createImage        Created Temp image  of shape [10, 10] with float valued pixels.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 9 grid points in 1 planes.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        ImageFactory::createImage        Created Temp image  of shape [10, 10, 2] with float valued pixels.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 9 grid points in 2 planes.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        name::        No table opened.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        showcache::        The Table Cache is empty.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        name::        No table opened.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        name::        No table opened.
07-Sep-2023 17:04:32 test_tool_image_deviation.py::ia_deviation_test::test_mask
07-Sep-2023 17:04:32 PASSED
07-Sep-2023 17:04:32
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        ImageFactory::createImage        Created Temp image  of shape [20, 20] with float valued pixels.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 25 grid points in 1 planes.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        StatImageCreator::_doInterpolation        Interpolate using CUBIC algorithm.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        StatImageCreator::useReferencePixelAsAnchor        Anchor being set at pixel [10,10], at/near image reference pixel.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 25 grid points in 1 planes.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        StatImageCreator::_doInterpolation        Interpolate using CUBIC algorithm.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        name::        No table opened.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        showcache::        The Table Cache is empty.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        name::        No table opened.
07-Sep-2023 17:04:32 2023-09-07 21:04:33        INFO        name::        No table opened.
07-Sep-2023 17:04:32 test_tool_image_deviation.py::ia_deviation_test::test_refpix
07-Sep-2023 17:04:32 Test using reference pixel
07-Sep-2023 17:04:32 PASSED
07-Sep-2023 17:04:32
07-Sep-2023 17:04:32 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_deviation/nose.xml -
07-Sep-2023 17:04:32 ========================= 8 passed, 1 warning in 3.23s =========================
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager/
07-Sep-2023 17:04:33 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_vpmanager/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager/
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_imagepol/
07-Sep-2023 17:04:33 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_imagepol
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_imagepol/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_imagepol/
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_table/
07-Sep-2023 17:04:33 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_table
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_table/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_table/
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_coordsys/
07-Sep-2023 17:04:33 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_coordsys
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_coordsys/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_coordsys/
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msmetadata/
07-Sep-2023 17:04:33 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msmetadata
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_msmetadata/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_msmetadata/
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_subimage/
07-Sep-2023 17:04:33 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_subimage
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_subimage/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_subimage/
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_createmultims/
07-Sep-2023 17:04:33 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_createmultims
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_ms_createmultims/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_createmultims/
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_regionmanager/
07-Sep-2023 17:04:33 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_regionmanager
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_regionmanager/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_regionmanager/
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_logsink/
07-Sep-2023 17:04:33 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_logsink
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_logsink/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_logsink/
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image/
07-Sep-2023 17:04:33 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image/
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_statistics/
07-Sep-2023 17:04:33 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_statistics
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_statistics/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_statistics/
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_rebin/
07-Sep-2023 17:04:33 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_rebin
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_rebin/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_rebin/
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_collapse/
07-Sep-2023 17:04:33 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_collapse
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_collapse/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_collapse/
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_statwt/
07-Sep-2023 17:04:33 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_statwt
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_ms_statwt/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_statwt/
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/
07-Sep-2023 17:04:33 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_calibrater/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_agentflagger/
07-Sep-2023 17:04:33 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_agentflagger
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_agentflagger/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_agentflagger/
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_deviation/
07-Sep-2023 17:04:33 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_deviation
07-Sep-2023 17:04:33
07-Sep-2023 17:04:33 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_deviation/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_deviation/
07-Sep-2023 17:04:35 total 174856
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci 15001    112583 Sep  7 20:32 casatestutils-6.6.0.11a14175.dev4-py3-none-any.whl
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci 15001 178769592 Sep  7 20:32 casatools-6.6.0.11a14175.dev4-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       4314 Sep  7 21:04 test_tool_agentflagger.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        980 Sep  7 21:04 test_tool_calanalysis.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       2632 Sep  7 21:04 test_tool_calibrater.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        545 Sep  7 21:04 test_tool_componentlist.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       7441 Sep  7 21:04 test_tool_coordsys.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root      12803 Sep  7 21:04 test_tool_image.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       2195 Sep  7 21:04 test_tool_image_collapse.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       1022 Sep  7 21:04 test_tool_image_deviation.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       2550 Sep  7 21:04 test_tool_image_fitprofile.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       1153 Sep  7 21:04 test_tool_image_pbcor.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        858 Sep  7 21:04 test_tool_image_pv.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        980 Sep  7 21:04 test_tool_image_rebin.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       1310 Sep  7 21:04 test_tool_image_regrid.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       1507 Sep  7 21:04 test_tool_image_statistics.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        739 Sep  7 21:04 test_tool_image_subimage.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        864 Sep  7 21:04 test_tool_image_transpose.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       1940 Sep  7 21:04 test_tool_imagepol.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        814 Sep  7 21:04 test_tool_linearmosaic.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        642 Sep  7 21:04 test_tool_logsink.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        523 Sep  7 21:04 test_tool_measures.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       5198 Sep  7 21:04 test_tool_ms.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        341 Sep  7 21:04 test_tool_ms_createmultims.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       2069 Sep  7 21:04 test_tool_ms_statwt.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       8486 Sep  7 21:04 test_tool_msmetadata.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        333 Sep  7 21:04 test_tool_msuvbinner.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       1145 Sep  7 21:04 test_tool_quanta.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       3951 Sep  7 21:04 test_tool_regionmanager.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       2048 Sep  7 21:04 test_tool_sdm.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       2077 Sep  7 21:04 test_tool_sdm_toms.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        422 Sep  7 21:04 test_tool_simulator.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       1337 Sep  7 21:04 test_tool_table.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       1692 Sep  7 21:04 test_tool_vpmanager.xml
07-Sep-2023 17:04:35 Finished task 'Test wheel' with result: Success
07-Sep-2023 17:04:35 Starting task 'Tar work directory' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
07-Sep-2023 17:04:35
Beginning to execute external process for build 'CASA - CMake Dev Test - CAS-14175 - Test Tools Many Linux 2014 #4 (CASA-CMDT63-TTSGRHEL7P38-4)'
... running command line:
/export/home/cbt-el7-8/bamboohome/temp/CASA-CMDT63-TTSGRHEL7P38-4-ScriptBuildTask-1924424643504536709.sh
... in: /export/home/cbt-el7-8/bamboohome/xml-data/build-dir/CASA-CMDT63-TTSGRHEL7P38
07-Sep-2023 17:04:35 Package working directory
07-Sep-2023 17:04:35 tar: work: Cannot stat: No such file or directory
07-Sep-2023 17:04:35 tar: Exiting with failure status due to previous errors
07-Sep-2023 17:04:35 total 174860
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci 15001    112583 Sep  7 20:32 casatestutils-6.6.0.11a14175.dev4-py3-none-any.whl
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci 15001 178769592 Sep  7 20:32 casatools-6.6.0.11a14175.dev4-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       4314 Sep  7 21:04 test_tool_agentflagger.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        980 Sep  7 21:04 test_tool_calanalysis.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       2632 Sep  7 21:04 test_tool_calibrater.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        545 Sep  7 21:04 test_tool_componentlist.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       7441 Sep  7 21:04 test_tool_coordsys.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root      12803 Sep  7 21:04 test_tool_image.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       2195 Sep  7 21:04 test_tool_image_collapse.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       1022 Sep  7 21:04 test_tool_image_deviation.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       2550 Sep  7 21:04 test_tool_image_fitprofile.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       1153 Sep  7 21:04 test_tool_image_pbcor.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        858 Sep  7 21:04 test_tool_image_pv.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        980 Sep  7 21:04 test_tool_image_rebin.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       1310 Sep  7 21:04 test_tool_image_regrid.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       1507 Sep  7 21:04 test_tool_image_statistics.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        739 Sep  7 21:04 test_tool_image_subimage.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        864 Sep  7 21:04 test_tool_image_transpose.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       1940 Sep  7 21:04 test_tool_imagepol.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        814 Sep  7 21:04 test_tool_linearmosaic.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        642 Sep  7 21:04 test_tool_logsink.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        523 Sep  7 21:04 test_tool_measures.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       5198 Sep  7 21:04 test_tool_ms.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        341 Sep  7 21:04 test_tool_ms_createmultims.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       2069 Sep  7 21:04 test_tool_ms_statwt.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       8486 Sep  7 21:04 test_tool_msmetadata.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        333 Sep  7 21:04 test_tool_msuvbinner.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       1145 Sep  7 21:04 test_tool_quanta.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       3951 Sep  7 21:04 test_tool_regionmanager.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       2048 Sep  7 21:04 test_tool_sdm.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       2077 Sep  7 21:04 test_tool_sdm_toms.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root        422 Sep  7 21:04 test_tool_simulator.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       1337 Sep  7 21:04 test_tool_table.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root       1692 Sep  7 21:04 test_tool_vpmanager.xml
07-Sep-2023 17:04:35 -rw-r--r-- 1 casaci root         45 Sep  7 21:04 work-el7-3.8.tar.gz
07-Sep-2023 17:04:35 Done packaging working directory
07-Sep-2023 17:04:35 Finished task 'Tar work directory' with result: Success
07-Sep-2023 17:04:35 Starting task 'Parse tests' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
07-Sep-2023 17:04:35 Parsing test results under /export/home/cbt-el7-8/bamboohome/xml-data/build-dir/CASA-CMDT63-TTSGRHEL7P38...
07-Sep-2023 17:04:35 Finished task 'Parse tests' with result: Success
07-Sep-2023 17:04:35
Substituting variable: ${bamboo.repository.branch.name} with CAS-14175
07-Sep-2023 17:04:35 Starting task 'Upload wheel' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
07-Sep-2023 17:04:35
Beginning to execute external process for build 'CASA - CMake Dev Test - CAS-14175 - Test Tools Many Linux 2014 #4 (CASA-CMDT63-TTSGRHEL7P38-4)'
... running command line:
/export/home/cbt-el7-8/bamboohome/temp/CASA-CMDT63-TTSGRHEL7P38-4-ScriptBuildTask-5819163247748584770.sh
... in: /export/home/cbt-el7-8/bamboohome/xml-data/build-dir/CASA-CMDT63-TTSGRHEL7P38
07-Sep-2023 17:04:37 Collecting twine
07-Sep-2023 17:04:37   Downloading twine-4.0.2-py3-none-any.whl (36 kB)
07-Sep-2023 17:04:37 Collecting keyring>=15.1
07-Sep-2023 17:04:37   Downloading keyring-24.2.0-py3-none-any.whl (37 kB)
07-Sep-2023 17:04:38 Collecting rfc3986>=1.4.0
07-Sep-2023 17:04:38   Downloading rfc3986-2.0.0-py2.py3-none-any.whl (31 kB)
07-Sep-2023 17:04:38 Collecting requests-toolbelt!=0.9.0,>=0.8.0
07-Sep-2023 17:04:38   Downloading requests_toolbelt-1.0.0-py2.py3-none-any.whl (54 kB)
07-Sep-2023 17:04:38 Collecting urllib3>=1.26.0
07-Sep-2023 17:04:38   Downloading urllib3-2.0.4-py3-none-any.whl (123 kB)
07-Sep-2023 17:04:38 Collecting pkginfo>=1.8.1
07-Sep-2023 17:04:38   Downloading pkginfo-1.9.6-py3-none-any.whl (30 kB)
07-Sep-2023 17:04:39 Collecting rich>=12.0.0
07-Sep-2023 17:04:39   Downloading rich-13.5.2-py3-none-any.whl (239 kB)
07-Sep-2023 17:04:39 Collecting importlib-metadata>=3.6
07-Sep-2023 17:04:39   Downloading importlib_metadata-6.8.0-py3-none-any.whl (22 kB)
07-Sep-2023 17:04:39 Collecting readme-renderer>=35.0
07-Sep-2023 17:04:39   Downloading readme_renderer-41.0-py3-none-any.whl (14 kB)
07-Sep-2023 17:04:39 Collecting requests>=2.20
07-Sep-2023 17:04:39   Downloading requests-2.31.0-py3-none-any.whl (62 kB)
07-Sep-2023 17:04:39 Collecting jaraco.classes
07-Sep-2023 17:04:39   Downloading jaraco.classes-3.3.0-py3-none-any.whl (5.9 kB)
07-Sep-2023 17:04:40 Collecting SecretStorage>=3.2; sys_platform == "linux"
07-Sep-2023 17:04:40   Downloading SecretStorage-3.3.3-py3-none-any.whl (15 kB)
07-Sep-2023 17:04:40 Collecting jeepney>=0.4.2; sys_platform == "linux"
07-Sep-2023 17:04:40   Downloading jeepney-0.8.0-py3-none-any.whl (48 kB)
07-Sep-2023 17:04:40 Collecting markdown-it-py>=2.2.0
07-Sep-2023 17:04:40   Downloading markdown_it_py-3.0.0-py3-none-any.whl (87 kB)
07-Sep-2023 17:04:40 Collecting pygments<3.0.0,>=2.13.0
07-Sep-2023 17:04:40   Downloading Pygments-2.16.1-py3-none-any.whl (1.2 MB)
07-Sep-2023 17:04:40 Collecting zipp>=0.5
07-Sep-2023 17:04:40   Downloading zipp-3.16.2-py3-none-any.whl (7.2 kB)
07-Sep-2023 17:04:41 Collecting docutils>=0.13.1
07-Sep-2023 17:04:41   Downloading docutils-0.20.1-py3-none-any.whl (572 kB)
07-Sep-2023 17:04:41 Collecting bleach>=2.1.0
07-Sep-2023 17:04:41   Downloading bleach-6.0.0-py3-none-any.whl (162 kB)
07-Sep-2023 17:04:41 Collecting charset-normalizer<4,>=2
07-Sep-2023 17:04:41   Downloading charset_normalizer-3.2.0-cp39-cp39-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (202 kB)
07-Sep-2023 17:04:41 Collecting certifi>=2017.4.17
07-Sep-2023 17:04:41   Downloading certifi-2023.7.22-py3-none-any.whl (158 kB)
07-Sep-2023 17:04:42 Collecting idna<4,>=2.5
07-Sep-2023 17:04:42   Downloading idna-3.4-py3-none-any.whl (61 kB)
07-Sep-2023 17:04:42 Collecting more-itertools
07-Sep-2023 17:04:42   Downloading more_itertools-10.1.0-py3-none-any.whl (55 kB)
07-Sep-2023 17:04:42 Collecting cryptography>=2.0
07-Sep-2023 17:04:42   Downloading cryptography-41.0.3-cp37-abi3-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (4.3 MB)
07-Sep-2023 17:04:43 Collecting mdurl~=0.1
07-Sep-2023 17:04:43   Downloading mdurl-0.1.2-py3-none-any.whl (10.0 kB)
07-Sep-2023 17:04:43 Collecting six>=1.9.0
07-Sep-2023 17:04:43   Downloading six-1.16.0-py2.py3-none-any.whl (11 kB)
07-Sep-2023 17:04:43 Collecting webencodings
07-Sep-2023 17:04:43   Downloading webencodings-0.5.1-py2.py3-none-any.whl (11 kB)
07-Sep-2023 17:04:43 Collecting cffi>=1.12
07-Sep-2023 17:04:43   Downloading cffi-1.15.1-cp39-cp39-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (441 kB)
07-Sep-2023 17:04:44 Collecting pycparser
07-Sep-2023 17:04:44   Downloading pycparser-2.21-py2.py3-none-any.whl (118 kB)
07-Sep-2023 17:04:44 Installing collected packages: more-itertools, jaraco.classes, jeepney, pycparser, cffi, cryptography, SecretStorage, zipp, importlib-metadata, keyring, rfc3986, urllib3, charset-normalizer, certifi, idna, requests, requests-toolbelt, pkginfo, mdurl, markdown-it-py, pygments, rich, docutils, six, webencodings, bleach, readme-renderer, twine
07-Sep-2023 17:04:49 Successfully installed SecretStorage-3.3.3 bleach-6.0.0 certifi-2023.7.22 cffi-1.15.1 charset-normalizer-3.2.0 cryptography-41.0.3 docutils-0.20.1 idna-3.4 importlib-metadata-6.8.0 jaraco.classes-3.3.0 jeepney-0.8.0 keyring-24.2.0 markdown-it-py-3.0.0 mdurl-0.1.2 more-itertools-10.1.0 pkginfo-1.9.6 pycparser-2.21 pygments-2.16.1 readme-renderer-41.0 requests-2.31.0 requests-toolbelt-1.0.0 rfc3986-2.0.0 rich-13.5.2 six-1.16.0 twine-4.0.2 urllib3-2.0.4 webencodings-0.5.1 zipp-3.16.2
07-Sep-2023 17:04:49 WARNING: You are using pip version 20.2.3; however, version 23.2.1 is available.
07-Sep-2023 17:04:49 You should consider upgrading via the '/usr/local/bin/python3.9 -m pip install --upgrade pip' command.
07-Sep-2023 17:04:51 Collecting pip
07-Sep-2023 17:04:51   Downloading pip-23.2.1-py3-none-any.whl (2.1 MB)
07-Sep-2023 17:04:51 Collecting urllib3==1.26.5
07-Sep-2023 17:04:52   Downloading urllib3-1.26.5-py2.py3-none-any.whl (138 kB)
07-Sep-2023 17:04:52 Requirement already up-to-date: twine in /usr/local/lib/python3.9/site-packages (4.0.2)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: keyring>=15.1 in /usr/local/lib/python3.9/site-packages (from twine) (24.2.0)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: requests-toolbelt!=0.9.0,>=0.8.0 in /usr/local/lib/python3.9/site-packages (from twine) (1.0.0)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: importlib-metadata>=3.6 in /usr/local/lib/python3.9/site-packages (from twine) (6.8.0)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: rfc3986>=1.4.0 in /usr/local/lib/python3.9/site-packages (from twine) (2.0.0)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: requests>=2.20 in /usr/local/lib/python3.9/site-packages (from twine) (2.31.0)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: readme-renderer>=35.0 in /usr/local/lib/python3.9/site-packages (from twine) (41.0)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: pkginfo>=1.8.1 in /usr/local/lib/python3.9/site-packages (from twine) (1.9.6)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: rich>=12.0.0 in /usr/local/lib/python3.9/site-packages (from twine) (13.5.2)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: jeepney>=0.4.2; sys_platform == "linux" in /usr/local/lib/python3.9/site-packages (from keyring>=15.1->twine) (0.8.0)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: jaraco.classes in /usr/local/lib/python3.9/site-packages (from keyring>=15.1->twine) (3.3.0)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: SecretStorage>=3.2; sys_platform == "linux" in /usr/local/lib/python3.9/site-packages (from keyring>=15.1->twine) (3.3.3)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: zipp>=0.5 in /usr/local/lib/python3.9/site-packages (from importlib-metadata>=3.6->twine) (3.16.2)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: charset-normalizer<4,>=2 in /usr/local/lib/python3.9/site-packages (from requests>=2.20->twine) (3.2.0)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: certifi>=2017.4.17 in /usr/local/lib/python3.9/site-packages (from requests>=2.20->twine) (2023.7.22)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: idna<4,>=2.5 in /usr/local/lib/python3.9/site-packages (from requests>=2.20->twine) (3.4)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: bleach>=2.1.0 in /usr/local/lib/python3.9/site-packages (from readme-renderer>=35.0->twine) (6.0.0)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: Pygments>=2.5.1 in /usr/local/lib/python3.9/site-packages (from readme-renderer>=35.0->twine) (2.16.1)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: docutils>=0.13.1 in /usr/local/lib/python3.9/site-packages (from readme-renderer>=35.0->twine) (0.20.1)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: markdown-it-py>=2.2.0 in /usr/local/lib/python3.9/site-packages (from rich>=12.0.0->twine) (3.0.0)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: more-itertools in /usr/local/lib/python3.9/site-packages (from jaraco.classes->keyring>=15.1->twine) (10.1.0)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: cryptography>=2.0 in /usr/local/lib/python3.9/site-packages (from SecretStorage>=3.2; sys_platform == "linux"->keyring>=15.1->twine) (41.0.3)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: six>=1.9.0 in /usr/local/lib/python3.9/site-packages (from bleach>=2.1.0->readme-renderer>=35.0->twine) (1.16.0)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: webencodings in /usr/local/lib/python3.9/site-packages (from bleach>=2.1.0->readme-renderer>=35.0->twine) (0.5.1)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: mdurl~=0.1 in /usr/local/lib/python3.9/site-packages (from markdown-it-py>=2.2.0->rich>=12.0.0->twine) (0.1.2)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: cffi>=1.12 in /usr/local/lib/python3.9/site-packages (from cryptography>=2.0->SecretStorage>=3.2; sys_platform == "linux"->keyring>=15.1->twine) (1.15.1)
07-Sep-2023 17:04:52 Requirement already satisfied, skipping upgrade: pycparser in /usr/local/lib/python3.9/site-packages (from cffi>=1.12->cryptography>=2.0->SecretStorage>=3.2; sys_platform == "linux"->keyring>=15.1->twine) (2.21)
07-Sep-2023 17:04:52 Installing collected packages: pip, urllib3
07-Sep-2023 17:04:52   Attempting uninstall: pip
07-Sep-2023 17:04:52     Found existing installation: pip 20.2.3
07-Sep-2023 17:04:52     Uninstalling pip-20.2.3:
07-Sep-2023 17:04:53       Successfully uninstalled pip-20.2.3
07-Sep-2023 17:04:54   Attempting uninstall: urllib3
07-Sep-2023 17:04:54     Found existing installation: urllib3 2.0.4
07-Sep-2023 17:04:54     Uninstalling urllib3-2.0.4:
07-Sep-2023 17:04:54       Successfully uninstalled urllib3-2.0.4
07-Sep-2023 17:04:55 Successfully installed pip-23.2.1 urllib3-1.26.5
07-Sep-2023 17:04:55 Cloning into 'casa-build-utils'...
07-Sep-2023 17:05:09 Uploading distributions to
07-Sep-2023 17:05:09 https://casa-pip.nrao.edu:443/repository/casa-dev-wheel/
07-Sep-2023 17:05:10 Uploading
07-Sep-2023 17:05:10 casatools-6.6.0.11a14175.dev4-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_
07-Sep-2023 17:05:10 64.whl
07-Sep-2023 17:05:10
07-Sep-2023 17:05:10   0% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 0.0/178.8 MB--:--?
07-Sep-2023 17:05:10   2% ╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 3.1/178.8 MB00:0444.0 MB/s
07-Sep-2023 17:05:10   7% ━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 11.9/178.8 MB00:0294.5 MB/s
07-Sep-2023 17:05:10 11% ━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 18.9/178.8 MB00:0296.8 MB/s
07-Sep-2023 17:05:11 12% ━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 21.2/178.8 MB00:0354.7 MB/s
07-Sep-2023 17:05:11 14% ━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 25.0/178.8 MB00:0630.2 MB/s
07-Sep-2023 17:05:11 17% ━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 29.6/178.8 MB00:0441.1 MB/s
07-Sep-2023 17:05:11 18% ━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 32.3/178.8 MB00:0439.0 MB/s
07-Sep-2023 17:05:11 20% ━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 36.5/178.8 MB00:0440.6 MB/s
07-Sep-2023 17:05:11 22% ━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 39.3/178.8 MB00:0439.2 MB/s
07-Sep-2023 17:05:11 24% ━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 42.3/178.8 MB00:0530.8 MB/s
07-Sep-2023 17:05:11 26% ━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 46.4/178.8 MB00:0532.4 MB/s
07-Sep-2023 17:05:11 28% ━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 50.7/178.8 MB00:0440.3 MB/s
07-Sep-2023 17:05:12 30% ━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━ 53.9/178.8 MB00:0439.8 MB/s
07-Sep-2023 17:05:12 32% ━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━ 56.8/178.8 MB00:0341.9 MB/s
07-Sep-2023 17:05:12 34% ━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━ 60.2/178.8 MB00:0342.5 MB/s
07-Sep-2023 17:05:12 35% ━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━ 63.4/178.8 MB00:0430.9 MB/s
07-Sep-2023 17:05:12 37% ━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━ 67.0/178.8 MB00:0429.2 MB/s
07-Sep-2023 17:05:12 40% ━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━ 71.2/178.8 MB00:0336.7 MB/s
07-Sep-2023 17:05:12 42% ━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━ 75.0/178.8 MB00:0340.7 MB/s
07-Sep-2023 17:05:12 43% ━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━ 77.7/178.8 MB00:0340.0 MB/s
07-Sep-2023 17:05:12 45% ━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━ 80.2/178.8 MB00:0338.7 MB/s
07-Sep-2023 17:05:12 46% ━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━ 83.0/178.8 MB00:0425.2 MB/s
07-Sep-2023 17:05:13 49% ━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━ 87.6/178.8 MB00:0331.5 MB/s
07-Sep-2023 17:05:13 51% ━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━ 91.4/178.8 MB00:0340.8 MB/s
07-Sep-2023 17:05:13 53% ━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━ 94.3/178.8 MB00:0338.8 MB/s
07-Sep-2023 17:05:13 54% ━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━ 96.9/178.8 MB00:0339.2 MB/s
07-Sep-2023 17:05:13 56% ━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━ 100.6/178.8 MB00:0240.0 MB/s
07-Sep-2023 17:05:13 58% ━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━ 103.7/178.8 MB00:0238.0 MB/s
07-Sep-2023 17:05:13 60% ━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━ 107.0/178.8 MB00:0329.6 MB/s
07-Sep-2023 17:05:13 62% ━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━ 111.7/178.8 MB00:0331.2 MB/s
07-Sep-2023 17:05:13 64% ━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━ 114.5/178.8 MB00:0331.3 MB/s
07-Sep-2023 17:05:14 66% ━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━ 117.6/178.8 MB00:0241.4 MB/s
07-Sep-2023 17:05:14 67% ━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━ 120.4/178.8 MB00:0240.4 MB/s
07-Sep-2023 17:05:14 69% ━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━ 123.8/178.8 MB00:0230.3 MB/s
07-Sep-2023 17:05:14 71% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━ 127.1/178.8 MB00:0229.4 MB/s
07-Sep-2023 17:05:14 73% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━ 130.2/178.8 MB00:0229.8 MB/s
07-Sep-2023 17:05:14 74% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━ 132.4/178.8 MB00:0230.2 MB/s
07-Sep-2023 17:05:14 76% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━ 136.2/178.8 MB00:0226.7 MB/s
07-Sep-2023 17:05:14 78% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━ 139.1/178.8 MB00:0233.8 MB/s
07-Sep-2023 17:05:14 79% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━ 141.4/178.8 MB00:0227.8 MB/s
07-Sep-2023 17:05:15 83% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━ 148.0/178.8 MB00:0146.1 MB/s
07-Sep-2023 17:05:15 87% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━ 156.0/178.8 MB00:0168.8 MB/s
07-Sep-2023 17:05:15 89% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━ 158.3/178.8 MB00:0148.6 MB/s
07-Sep-2023 17:05:15 91% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━ 162.3/178.8 MB00:0135.1 MB/s
07-Sep-2023 17:05:15 93% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━ 165.6/178.8 MB00:0127.3 MB/s
07-Sep-2023 17:05:15 95% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━ 169.4/178.8 MB00:0128.7 MB/s
07-Sep-2023 17:05:15 97% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━ 172.6/178.8 MB00:0128.2 MB/s
07-Sep-2023 17:05:15 97% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━ 174.0/178.8 MB00:0126.5 MB/s
07-Sep-2023 17:05:15 99% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸ 177.5/178.8 MB00:0125.8 MB/s
07-Sep-2023 17:05:15 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 178.8/178.8 MB00:0532.0 MB/s
07-Sep-2023 17:05:16 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 178.8/178.8 MB00:0532.0 MB/s
07-Sep-2023 17:05:16 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 178.8/178.8 MB00:0532.0 MB/s
07-Sep-2023 17:05:16 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 178.8/178.8 MB00:0532.0 MB/s
07-Sep-2023 17:05:16 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 178.8/178.8 MB00:0532.0 MB/s
07-Sep-2023 17:05:16 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 178.8/178.8 MB00:0532.0 MB/s
07-Sep-2023 17:05:16 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 178.8/178.8 MB00:0532.0 MB/s
07-Sep-2023 17:05:16 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 178.8/178.8 MB00:0532.0 MB/s
07-Sep-2023 17:05:16 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 178.8/178.8 MB00:0532.0 MB/s
07-Sep-2023 17:05:16
07-Sep-2023 17:05:16 Finished task 'Upload wheel' with result: Success
07-Sep-2023 17:05:16 Starting task 'Cleanup' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
07-Sep-2023 17:05:16
Beginning to execute external process for build 'CASA - CMake Dev Test - CAS-14175 - Test Tools Many Linux 2014 #4 (CASA-CMDT63-TTSGRHEL7P38-4)'
... running command line:
/export/home/cbt-el7-8/bamboohome/temp/CASA-CMDT63-TTSGRHEL7P38-4-ScriptBuildTask-6301585515105125808.sh
... in: /export/home/cbt-el7-8/bamboohome/xml-data/build-dir/CASA-CMDT63-TTSGRHEL7P38
07-Sep-2023 17:05:16 Starting cleanup
07-Sep-2023 17:05:36 wheel-container-test
07-Sep-2023 17:05:38 wheel-container-test
07-Sep-2023 17:05:38 Cleanup complete
07-Sep-2023 17:05:38 Finished task 'Cleanup' with result: Success
07-Sep-2023 17:05:38 Running post build plugin 'Docker Container Cleanup'
07-Sep-2023 17:05:38
Beginning to execute external process for build 'CASA - CMake Dev Test - CAS-14175 - Test Tools Many Linux 2014 #4 (CASA-CMDT63-TTSGRHEL7P38-4)'
... running command line:
/bin/docker rm -f wheel-container-test
... in: /export/home/cbt-el7-8/bamboohome/xml-data/build-dir/CASA-CMDT63-TTSGRHEL7P38
07-Sep-2023 17:05:38 Error response from daemon: No such container: wheel-container-test
07-Sep-2023 17:05:38 Running post build plugin 'NCover Results Collector'
07-Sep-2023 17:05:38 Running post build plugin 'Clover Results Collector'
07-Sep-2023 17:05:38 Running post build plugin 'npm Cache Cleanup'
07-Sep-2023 17:05:38 Running post build plugin 'Artifact Copier'
07-Sep-2023 17:05:38 Publishing an artifact: Workdir
07-Sep-2023 17:05:38 Finished publishing of artifact Non required job artifact: [Workdir], pattern: [work*.tar.gz] anchored at: [wheeldirectory/] in 76.63 ms
07-Sep-2023 17:05:38 Publishing an artifact: Tests
07-Sep-2023 17:05:38 Finished publishing of artifact Non required job artifact: [Tests], pattern: [*.xml] anchored at: [wheeldirectory/] in 162.4 ms
07-Sep-2023 17:05:38 Publishing an artifact: xml Directories
07-Sep-2023 17:05:39 Finished publishing of artifact Non required job artifact: [xml Directories], pattern: [**/*.xml] anchored at: [wheeldirectory/] in 159.5 ms
07-Sep-2023 17:05:39 Finalising the build...
07-Sep-2023 17:05:39 Stopping timer.
07-Sep-2023 17:05:39 Build CASA-CMDT63-TTSGRHEL7P38-4 completed.
07-Sep-2023 17:05:39 Running on server: post build plugin 'NCover Results Collector'
07-Sep-2023 17:05:39 Running on server: post build plugin 'Build Hanging Detection Configuration'
07-Sep-2023 17:05:39 Running on server: post build plugin 'Clover Delta Calculator'
07-Sep-2023 17:05:39 Running on server: post build plugin 'Maven Dependencies Postprocessor'
07-Sep-2023 17:05:39 All post build plugins have finished
07-Sep-2023 17:05:39 Generating build results summary...
07-Sep-2023 17:05:39 Saving build results to disk...
07-Sep-2023 17:05:39 Store variable context...
07-Sep-2023 17:05:39 Indexing build results...
07-Sep-2023 17:05:39 Finished building CASA-CMDT63-TTSGRHEL7P38-4.