Tools and Tasks tests for Python 3.12

Build: #20 failed

Job: Test Tools Many Linux 2.28 Rocky 8.10 Py3.12 was successful

Build log

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

22-Oct-2024 17:53:23 2024-10-22 21:53:23        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
22-Oct-2024 17:53:23 2024-10-22 21:53:23        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
22-Oct-2024 17:53:23 2024-10-22 21:53:23        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
22-Oct-2024 17:53:23 2024-10-22 21:53:23        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 14 Scan : 31 : 31
22-Oct-2024 17:53:23 2024-10-22 21:53:23        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
22-Oct-2024 17:53:23 2024-10-22 21:53:23        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
22-Oct-2024 17:53:23 2024-10-22 21:53:23        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
22-Oct-2024 17:53:23 2024-10-22 21:53:23        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
22-Oct-2024 17:53:23 2024-10-22 21:53:23        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
22-Oct-2024 17:53:23 2024-10-22 21:53:23        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
22-Oct-2024 17:53:23 2024-10-22 21:53:23        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
22-Oct-2024 17:53:23 2024-10-22 21:53:23        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 15 Scan : 31 : 31
22-Oct-2024 17:53:23 2024-10-22 21:53:23        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
22-Oct-2024 17:53:23 2024-10-22 21:53:23        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
22-Oct-2024 17:53:23 2024-10-22 21:53:23        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        FlagMSHandler::nextChunk         ====================================================================================
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Manual::tableSummary        => Percentage of data flagged in table selection: 32.8125%
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        AgentFlagger::run        => Writing flags to the MS
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          observation 0 flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          scan 31 flagged: 725760 total: 2.21184e+06 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          scan 30 flagged: 717696 total: 2.18726e+06 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          antenna ea24 flagged: 721728 total: 2.19955e+06 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          antenna ea19 flagged: 721728 total: 2.19955e+06 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          antenna ea01 flagged: 721728 total: 2.19955e+06 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          antenna ea11 flagged: 721728 total: 2.19955e+06 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          field 3C286_A flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          spw 15 flagged: 90216 total: 274944 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          spw 14 flagged: 90216 total: 274944 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          spw 10 flagged: 90216 total: 274944 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          spw 7 flagged: 90216 total: 274944 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          spw 12 flagged: 90216 total: 274944 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          spw 6 flagged: 90216 total: 274944 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          spw 8 flagged: 90216 total: 274944 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          spw 5 flagged: 90216 total: 274944 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          spw 0 flagged: 90216 total: 274944 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          spw 11 flagged: 90216 total: 274944 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          spw 9 flagged: 90216 total: 274944 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          spw 4 flagged: 90216 total: 274944 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          spw 1 flagged: 90216 total: 274944 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          spw 2 flagged: 90216 total: 274944 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          spw 13 flagged: 90216 total: 274944 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          spw 3 flagged: 90216 total: 274944 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          correlation LL flagged: 360864 total: 1.09978e+06 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          correlation LR flagged: 360864 total: 1.09978e+06 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          correlation RR flagged: 360864 total: 1.09978e+06 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          correlation RL flagged: 360864 total: 1.09978e+06 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          array 0 flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Summary::getResult          Total Flagged: 1.44346e+06 Total Counts: 4.3991e+06 (32.8%)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Display::displayReports         Report Displays are turned OFF
22-Oct-2024 17:53:23 test_tool_agentflagger.py::test_display::test_display_data_single_channel_selection
22-Oct-2024 17:53:23 AgentFlagger:: Check nominal behaviour for single spw:chan selection 
22-Oct-2024 17:53:23 The MS is already around, just unflag
22-Oct-2024 17:53:23 PASSED
22-Oct-2024 17:53:23
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        AgentFlagger::open        Table type is Measurement Set
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        AgentFlagger::initAgents        There are initially 1 agents in the list. Agents: unflag
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        AgentFlagger::initAgents        There are 1 valid agents in the list. Agents: unflag
22-Oct-2024 17:53:23 2024-10-22 21:53:24        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
22-Oct-2024 17:53:23 2024-10-22 21:53:24        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
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (1028/1028)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        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
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2/2)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        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
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (1026/1026)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        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
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4/4)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        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
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2050/2050)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        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
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4096/4096)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        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
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (6/6)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        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
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2048/2048)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        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
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4098/4098)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        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
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2/2)
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        FlagMSHandler::nextChunk         ====================================================================================
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        Unflag::tableSummary        => Percentage of data un-flagged in table selection: 100%
22-Oct-2024 17:53:23 2024-10-22 21:53:24        INFO        AgentFlagger::run        => Writing flags to the MS
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        AgentFlagger::open        Table type is Measurement Set
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        FlagMSHandler::selectData          Selected spw-channels ids are Axis Lengths: [4, 4]  (NB: Matrix in Row/Column order)
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        FlagMSHandler::selectData +        [1, 0, 511, 1
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        FlagMSHandler::selectData +         2, 0, 0, 1
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        FlagMSHandler::selectData +         3, 0, 511, 1
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        FlagMSHandler::selectData +         4, 0, 0, 1]
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        AgentFlagger::initAgents        There are initially 3 agents in the list. Agents: manual, summary, display
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Manual::setAgentParameters         autocorr is 0
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Display::setAgentParameters          data column is FLOAT_DATA
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Display::setAgentParameters          Visibility expression is REAL XX,YY
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Display::setAgentParameters          pause is 0
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Display::setAgentParameters          datadisplay is 1
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Display::setAgentParameters          reportdisplay is 0
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Display::setAgentParameters          format is screen
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        AgentFlagger::initAgents        There are 3 valid agents in the list. Agents: manual, summary, display
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        FlagDataHandler::preLoadColumn         Setting row blocking to number of rows in selected table: 4
22-Oct-2024 17:53:24 2024-10-22 21:53:24        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
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 1 Scan : 1 : 1
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
22-Oct-2024 17:53:24 /home/casatest/venv/bin/python3.12: No module named casaplotserver
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Manual::chunkSummary        => Data flagged so far 100% (1024/1024)
22-Oct-2024 17:53:24 2024-10-22 21:53:24        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
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 2 Scan : 1 : 1
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Manual::chunkSummary        => Data flagged so far 100% (2/2)
22-Oct-2024 17:53:24 2024-10-22 21:53:24        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
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 3 Scan : 1 : 1
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Manual::chunkSummary        => Data flagged so far 100% (1024/1024)
22-Oct-2024 17:53:24 2024-10-22 21:53:24        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
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 4 Scan : 1 : 1
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Manual::chunkSummary        => Data flagged so far 100% (2/2)
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        FlagMSHandler::nextChunk         ====================================================================================
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Manual::tableSummary        => Percentage of data flagged in table selection: 100%
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        AgentFlagger::run        => Writing flags to the MS
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Summary::getResult          observation 0 flagged: 2052 total: 2052 (100%)
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Summary::getResult          scan 1 flagged: 2052 total: 2052 (100%)
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Summary::getResult          antenna PM04 flagged: 2052 total: 2052 (100%)
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Summary::getResult          field r aqr flagged: 2052 total: 2052 (100%)
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Summary::getResult          spw 4 flagged: 2 total: 2 (100%)
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Summary::getResult          spw 3 flagged: 1024 total: 1024 (100%)
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Summary::getResult          spw 1 flagged: 1024 total: 1024 (100%)
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Summary::getResult          spw 2 flagged: 2 total: 2 (100%)
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Summary::getResult          correlation YY flagged: 1026 total: 1026 (100%)
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Summary::getResult          correlation XX flagged: 1026 total: 1026 (100%)
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Summary::getResult          array 0 flagged: 2052 total: 2052 (100%)
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Summary::getResult          Total Flagged: 2052 Total Counts: 2052 (100%)
22-Oct-2024 17:53:24 2024-10-22 21:53:24        INFO        Display::displayReports         Report Displays are turned OFF
22-Oct-2024 17:53:24 test_tool_agentflagger.py::test_display::test_display_float_data
22-Oct-2024 17:53:24 AgentFlagger: Select spw, display and flag single-dish MS
22-Oct-2024 17:53:24 Moving data...
22-Oct-2024 17:53:24 PASSED
22-Oct-2024 17:53:24
22-Oct-2024 17:53:24 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_agentflagger/nose.xml -
22-Oct-2024 17:53:24 ======================= 35 passed, 4 warnings in 25.92s ========================
22-Oct-2024 17:53:24 ============================= test session starts ==============================
22-Oct-2024 17:53:24 platform linux -- Python 3.12.6, pytest-8.3.3, pluggy-1.5.0 -- /home/casatest/venv/bin/python3.12
22-Oct-2024 17:53:24 cachedir: .pytest_cache
22-Oct-2024 17:53:24 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_deviation
22-Oct-2024 17:53:24 configfile: pytest.ini
22-Oct-2024 17:53:25 collecting ... collected 8 items
22-Oct-2024 17:53:25
22-Oct-2024 17:53:25
22-Oct-2024 17:53:25 2024-10-22 21:53:26        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.
22-Oct-2024 17:53:25 2024-10-22 21:53:26        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
22-Oct-2024 17:53:25 2024-10-22 21:53:26        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.
22-Oct-2024 17:53:26 2024-10-22 21:53:26        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
22-Oct-2024 17:53:26 2024-10-22 21:53:26        INFO        name::        No table opened.
22-Oct-2024 17:53:26 2024-10-22 21:53:26        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:26 2024-10-22 21:53:26        INFO        name::        No table opened.
22-Oct-2024 17:53:26 2024-10-22 21:53:26        INFO        name::        No table opened.
22-Oct-2024 17:53:26 test_tool_image_deviation.py::ia_deviation_test::test001
22-Oct-2024 17:53:26 Every pixel is a grid point
22-Oct-2024 17:53:26 PASSED
22-Oct-2024 17:53:26
22-Oct-2024 17:53:26 2024-10-22 21:53:26        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.
22-Oct-2024 17:53:26 2024-10-22 21:53:27        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
22-Oct-2024 17:53:26 2024-10-22 21:53:27        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.
22-Oct-2024 17:53:26 2024-10-22 21:53:27        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
22-Oct-2024 17:53:26 2024-10-22 21:53:27        INFO        name::        No table opened.
22-Oct-2024 17:53:26 test_tool_image_deviation.py::ia_deviation_test::test002
22-Oct-2024 17:53:26 2024-10-22 21:53:27        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:26 Every pixel is a grid point with an offset, so should be the same result
22-Oct-2024 17:53:26 2024-10-22 21:53:27        INFO        name::        No table opened.
22-Oct-2024 17:53:26 as test001
22-Oct-2024 17:53:26 2024-10-22 21:53:27        INFO        name::        No table opened.
22-Oct-2024 17:53:26 PASSED
22-Oct-2024 17:53:26
22-Oct-2024 17:53:26 2024-10-22 21:53:27        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.
22-Oct-2024 17:53:26 2024-10-22 21:53:27        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
22-Oct-2024 17:53:26 2024-10-22 21:53:27        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
22-Oct-2024 17:53:27 2024-10-22 21:53:27        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.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
22-Oct-2024 17:53:27 2024-10-22 21:53:27        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
22-Oct-2024 17:53:27 2024-10-22 21:53:27        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.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
22-Oct-2024 17:53:27 2024-10-22 21:53:27        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.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
22-Oct-2024 17:53:27 2024-10-22 21:53:27        INFO        name::        No table opened.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        INFO        name::        No table opened.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        INFO        name::        No table opened.
22-Oct-2024 17:53:27 test_tool_image_deviation.py::ia_deviation_test::test003
22-Oct-2024 17:53:27 Every third pixel is a grid point
22-Oct-2024 17:53:27 PASSED
22-Oct-2024 17:53:27
22-Oct-2024 17:53:27 2024-10-22 21:53:27        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.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
22-Oct-2024 17:53:27 2024-10-22 21:53:27        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.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
22-Oct-2024 17:53:27 2024-10-22 21:53:27        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.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
22-Oct-2024 17:53:27 2024-10-22 21:53:27        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.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
22-Oct-2024 17:53:27 2024-10-22 21:53:27        INFO        name::        No table opened.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        INFO        name::        No table opened.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        INFO        name::        No table opened.
22-Oct-2024 17:53:27 test_tool_image_deviation.py::ia_deviation_test::test005
22-Oct-2024 17:53:27 Every third pixel is a grid point, using anchor [2,2]
22-Oct-2024 17:53:27 PASSED
22-Oct-2024 17:53:27
22-Oct-2024 17:53:27 2024-10-22 21:53:27        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.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
22-Oct-2024 17:53:27 2024-10-22 21:53:27        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:27 2024-10-22 21:53:27        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)
22-Oct-2024 17:53:27 2024-10-22 21:53:28        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.
22-Oct-2024 17:53:27 2024-10-22 21:53:28        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
22-Oct-2024 17:53:27 2024-10-22 21:53:28        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:27 2024-10-22 21:53:28        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)
22-Oct-2024 17:53:27 2024-10-22 21:53:28        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:27 2024-10-22 21:53:28        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)
22-Oct-2024 17:53:27 2024-10-22 21:53:28        INFO        name::        No table opened.
22-Oct-2024 17:53:27 2024-10-22 21:53:28        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:27 2024-10-22 21:53:28        INFO        name::        No table opened.
22-Oct-2024 17:53:27 2024-10-22 21:53:28        INFO        name::        No table opened.
22-Oct-2024 17:53:27 test_tool_image_deviation.py::ia_deviation_test::test006
22-Oct-2024 17:53:27 Test that regions work as expected
22-Oct-2024 17:53:27 PASSED
22-Oct-2024 17:53:27
22-Oct-2024 17:53:27 2024-10-22 21:53:28        INFO        ImageFactory::createImage        Created Paged image 'mycirc.im' of shape [100, 100] with float valued pixels.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        StatImageCreator::useReferencePixelAsAnchor        Anchor being set at pixel [50,50], at/near image reference pixel.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        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.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        StatImageCreator::_doInterpolation        Interpolate using CUBIC algorithm.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        name::        No table opened.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        name::        No table opened.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        name::        No table opened.
22-Oct-2024 17:53:28 test_tool_image_deviation.py::ia_deviation_test::test_circle
22-Oct-2024 17:53:28 test circles work correctly CAS-10296
22-Oct-2024 17:53:28 PASSED
22-Oct-2024 17:53:28
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        ImageFactory::createImage        Created Temp image  of shape [10, 10] with float valued pixels.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        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.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        ImageFactory::createImage        Created Temp image  of shape [10, 10, 2] with float valued pixels.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        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.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        name::        No table opened.
22-Oct-2024 17:53:28 test_tool_image_deviation.py::ia_deviation_test::test_mask
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        name::        No table opened.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        name::        No table opened.
22-Oct-2024 17:53:28 PASSED
22-Oct-2024 17:53:28
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        ImageFactory::createImage        Created Temp image  of shape [20, 20] with float valued pixels.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        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.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        StatImageCreator::_doInterpolation        Interpolate using CUBIC algorithm.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        StatImageCreator::useReferencePixelAsAnchor        Anchor being set at pixel [10,10], at/near image reference pixel.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        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.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        StatImageCreator::_doInterpolation        Interpolate using CUBIC algorithm.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        name::        No table opened.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        name::        No table opened.
22-Oct-2024 17:53:28 2024-10-22 21:53:28        INFO        name::        No table opened.
22-Oct-2024 17:53:28 test_tool_image_deviation.py::ia_deviation_test::test_refpix
22-Oct-2024 17:53:28 Test using reference pixel
22-Oct-2024 17:53:28 PASSED
22-Oct-2024 17:53:28
22-Oct-2024 17:53:28 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_deviation/nose.xml -
22-Oct-2024 17:53:28 ======================== 8 passed, 4 warnings in 3.55s =========================
22-Oct-2024 17:53:28 ============================= test session starts ==============================
22-Oct-2024 17:53:28 platform linux -- Python 3.12.6, pytest-8.3.3, pluggy-1.5.0 -- /home/casatest/venv/bin/python3.12
22-Oct-2024 17:53:28 cachedir: .pytest_cache
22-Oct-2024 17:53:28 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv
22-Oct-2024 17:53:28 configfile: pytest.ini
22-Oct-2024 17:53:29 collecting ... collected 7 items
22-Oct-2024 17:53:29
22-Oct-2024 17:53:29
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageFactory::createImage        Created Temp image  of shape [30, 30, 30] with float valued pixels.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        PVGenerator::setEndpoints         Setting pixel end points [8.5, 15.5], [22.5, 15.5]
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord+            [9, 15, 0] to [22, 15, 29]  (00:00:24.000, +00.00.00.000, 1.41498e+09Hz to 23:59:32.000, +00.00.00.000, 1.41501e+09Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        PVGenerator::setEndpoints         Setting pixel end points [22.5, 15.5], [8.5, 15.5]
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        PVGenerator::generate         Rotating image by -180 degrees about direction coordinate pixel (15.5, 15.5) to align specified slice with the x axis
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord+            [0, 0, 0] to [29, 29, 29]  (00:01:00.001, -00.15.00.003, 1.41498e+09Hz to 23:59:03.999, +00.14.00.002, 1.41501e+09Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord+            [9, 15, 0] to [22, 15, 29]  (23:59:32.000, +00.01.00.000, 1.41498e+09Hz to 00:00:24.000, +00.01.00.000, 1.41501e+09Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        name::        No table opened.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:29 test_tool_image_pv.py::ia_pv_test::test_CAS10968
22-Oct-2024 17:53:29 Fix for pa=90,270 when segment y pixel falls on half pixel
22-Oct-2024 17:53:29 PASSED
22-Oct-2024 17:53:29
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        PVGenerator::generate         Rotating image by -45 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [299, 299, 0, 2]  (09:48:01.492, +13.15.40.658, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [316, 316, 0, 2]  (09:48:01.957, +13.15.33.858, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord+            [1, 157, 0, 0] to [313, 157, 0, 2]  (09:48:00.678, +13.15.52.535, I, 3.63994e+10Hz to 09:47:54.633, +13.17.20.782, I, 3.63991e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        PVGenerator::generate         Rotating image by 45 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [299, 299, 0, 2]  (09:48:01.492, +13.15.40.658, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [316, 316, 0, 2]  (09:48:01.957, +13.15.33.858, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord+            [1, 157, 0, 0] to [313, 157, 0, 2]  (09:48:00.678, +13.17.20.782, I, 3.63994e+10Hz to 09:47:54.634, +13.15.52.535, I, 3.63991e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        PVGenerator::generate         Rotating image by -225 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [299, 299, 0, 2]  (09:48:01.492, +13.15.40.658, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [316, 316, 0, 2]  (09:48:01.957, +13.15.33.858, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord+            [1, 157, 0, 0] to [313, 157, 0, 2]  (09:47:54.633, +13.17.20.782, I, 3.63994e+10Hz to 09:48:00.678, +13.15.52.535, I, 3.63991e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        PVGenerator::generate         Rotating image by -135 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [299, 299, 0, 2]  (09:48:01.492, +13.15.40.658, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [316, 316, 0, 2]  (09:48:01.957, +13.15.33.858, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
22-Oct-2024 17:53:29 2024-10-22 21:53:29        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord+            [1, 157, 0, 0] to [313, 157, 0, 2]  (09:47:54.634, +13.15.52.535, I, 3.63994e+10Hz to 09:48:00.678, +13.17.20.782, I, 3.63991e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
22-Oct-2024 17:53:29 2024-10-22 21:53:30        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        PVGenerator::generate         Rotating image by -137.67 degrees about direction coordinate pixel (216.468, 187) to align specified slice with the x axis
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [399, 399, 0, 2]  (18:54:07.171, +01.59.37.999, I, 2.369292e+10Hz to 18:53:53.862, +02.02.57.499, I, 2.369285e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord+            [151, 187, 0, 0] to [284, 187, 0, 2]  (18:53:58.336, +02.00.49.457, I, 2.369292e+10Hz to 18:54:01.616, +02.01.34.238, I, 2.369285e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        PVGenerator::generate         Rotating image by -42.3301 degrees about direction coordinate pixel (215.598, 187.793) to align specified slice with the x axis
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [399, 399, 0, 2]  (18:54:07.171, +01.59.37.999, I, 2.369292e+10Hz to 18:53:53.862, +02.02.57.499, I, 2.369285e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord+            [149, 188, 0, 0] to [282, 188, 0, 2]  (18:54:01.627, +02.00.49.549, I, 2.369292e+10Hz to 18:53:58.347, +02.01.34.331, I, 2.369285e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        PVGenerator::generate         Rotating image by 42.3301 degrees about direction coordinate pixel (216.468, 187) to align specified slice with the x axis
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [399, 399, 0, 2]  (18:54:07.171, +01.59.37.999, I, 2.369292e+10Hz to 18:53:53.862, +02.02.57.499, I, 2.369285e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord+            [149, 187, 0, 0] to [282, 187, 0, 2]  (18:54:01.614, +02.01.34.216, I, 2.369292e+10Hz to 18:53:58.335, +02.00.49.435, I, 2.369285e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        PVGenerator::generate         Rotating image by -222.33 degrees about direction coordinate pixel (215.598, 187.793) to align specified slice with the x axis
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [399, 399, 0, 2]  (18:54:07.171, +01.59.37.999, I, 2.369292e+10Hz to 18:53:53.862, +02.02.57.499, I, 2.369285e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord+            [149, 188, 0, 0] to [282, 188, 0, 2]  (18:53:58.333, +02.01.34.243, I, 2.369292e+10Hz to 18:54:01.612, +02.00.49.462, I, 2.369285e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        name::        No table opened.
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:29 test_tool_image_pv.py::ia_pv_test::test_CAS_2996
22-Oct-2024 17:53:29 ia.pv(): Test issues raised in CAS-2996
22-Oct-2024 17:53:29 PASSED
22-Oct-2024 17:53:29
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        PVGenerator::generate         Rotating image by -45 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [299, 299, 0, 2]  (09:48:01.492, +13.15.40.658, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [316, 316, 0, 2]  (09:48:01.957, +13.15.33.858, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
22-Oct-2024 17:53:29 2024-10-22 21:53:30        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
22-Oct-2024 17:53:30 2024-10-22 21:53:30        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
22-Oct-2024 17:53:30 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:30 2024-10-22 21:53:30        INFO        ImageRegion::fromRecord+            [1, 157, 0, 0] to [313, 157, 0, 2]  (09:48:00.678, +13.15.52.535, I, 3.63994e+10Hz to 09:47:54.633, +13.17.20.782, I, 3.63991e+10Hz)
22-Oct-2024 17:53:30 2024-10-22 21:53:30        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
22-Oct-2024 17:53:30 2024-10-22 21:53:30        INFO        ImageFitsConverter::ImageHeaderToFITS         Truncating miscinfo field secondary_coordinates to secondar
22-Oct-2024 17:53:30 2024-10-22 21:53:30        INFO        ImageFitsConverter::ImageHeaderToFITS         Not writing miscInfo field 'secondar' - cannot handle type Record
22-Oct-2024 17:53:30 2024-10-22 21:53:30        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
22-Oct-2024 17:53:30 2024-10-22 21:53:30        INFO        ImageFitsConverter::ImageHeaderToFITS         Truncating miscinfo field secondary_coordinates to secondar
22-Oct-2024 17:53:30 2024-10-22 21:53:30        INFO        ImageFitsConverter::ImageHeaderToFITS         Not writing miscInfo field 'secondar' - cannot handle type Record
22-Oct-2024 17:53:30 2024-10-22 21:53:30        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
22-Oct-2024 17:53:30 2024-10-22 21:53:30        INFO        name::        No table opened.
22-Oct-2024 17:53:30 2024-10-22 21:53:30        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:30 test_tool_image_pv.py::ia_pv_test::test_fits
22-Oct-2024 17:53:30 ia.pv(): Test exporting and importing to/from FITS
22-Oct-2024 17:53:30 PASSED
22-Oct-2024 17:53:30
22-Oct-2024 17:53:30 2024-10-22 21:53:30        INFO        ImageFactory::createImage        Created Paged image 'zz.im' of shape [30, 30, 30] with float valued pixels.
22-Oct-2024 17:53:30 2024-10-22 21:53:30        INFO        PVGenerator::setEndpoints         Setting pixel end points [10.0503, 19.9497], [19.9497, 10.0503]
22-Oct-2024 17:53:30 2024-10-22 21:53:31        INFO        PVGenerator::generate         Rotating image by 45 degrees about direction coordinate pixel (15, 15) to align specified slice with the x axis
22-Oct-2024 17:53:30 2024-10-22 21:53:31        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:30 2024-10-22 21:53:31        INFO        ImageRegion::fromRecord+            [0, 0, 0] to [29, 29, 29]  (00:01:00.001, -00.15.00.003, 1.41498e+09Hz to 23:59:03.999, +00.14.00.002, 1.41501e+09Hz)
22-Oct-2024 17:53:30 2024-10-22 21:53:31        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
22-Oct-2024 17:53:30 2024-10-22 21:53:31        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
22-Oct-2024 17:53:30 2024-10-22 21:53:31        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
22-Oct-2024 17:53:30 2024-10-22 21:53:31        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
22-Oct-2024 17:53:30 2024-10-22 21:53:31        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
22-Oct-2024 17:53:30 2024-10-22 21:53:31        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:30 2024-10-22 21:53:31        INFO        ImageRegion::fromRecord+            [8, 15, 0] to [22, 15, 29]  (00:00:19.799, +00.04.56.985, 1.41498e+09Hz to 23:59:40.201, -00.04.56.985, 1.41501e+09Hz)
22-Oct-2024 17:53:30 2024-10-22 21:53:31        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
22-Oct-2024 17:53:30 2024-10-22 21:53:30        INFO        ::::ImageFactory::createImage        Created Paged image 'zz.im' of shape [30, 30, 30] with float valued pixels.
22-Oct-2024 17:53:30 2024-10-22 21:53:30        INFO        ::::image::fromshape        Ran ia.fromshape
22-Oct-2024 17:53:30 2024-10-22 21:53:30        INFO        ::::image::fromshape        ia.fromshape(outfile="zz.im", shape=[30,30,30], csys={...}, linear=false, overwrite=false, log=true, type="f")
22-Oct-2024 17:53:30 2024-10-22 21:53:31        INFO        ::::image::pv        Ran ia.pv
22-Oct-2024 17:53:30 2024-10-22 21:53:31        INFO        ::::image::pv        ia.pv(outfile="", start=[], end=[], center=[15,15], length="14arcmin", pa="45deg", width=1, unit="arcsec", overwrite=false, region={...}, chans="", stokes="", mask="", stretch=false, wantreturn=true)
22-Oct-2024 17:53:30 2024-10-22 21:53:31        INFO        name::        No table opened.
22-Oct-2024 17:53:30 2024-10-22 21:53:31        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:30 test_tool_image_pv.py::ia_pv_test::test_history
22-Oct-2024 17:53:30 Verify history is written to created image
22-Oct-2024 17:53:30 PASSED
22-Oct-2024 17:53:30
22-Oct-2024 17:53:31 2024-10-22 21:53:31        INFO        ImageFactory::createImage        Created Paged image 'zxye.im' of shape [10, 10, 10] with float valued pixels.
22-Oct-2024 17:53:31 2024-10-22 21:53:31        INFO        name::        No table opened.
22-Oct-2024 17:53:31 2024-10-22 21:53:31        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:31 2024-10-22 21:53:31        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
22-Oct-2024 17:53:31 2024-10-22 21:53:31        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:31 2024-10-22 21:53:31        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
22-Oct-2024 17:53:31 2024-10-22 21:53:31        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
22-Oct-2024 17:53:31 2024-10-22 21:53:32        INFO        SubImageFactory::createImage        Creating image 'test_pv_0' of shape [6, 10]
22-Oct-2024 17:53:31 2024-10-22 21:53:32        INFO        name::        No table opened.
22-Oct-2024 17:53:31 2024-10-22 21:53:32        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:31 2024-10-22 21:53:32        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
22-Oct-2024 17:53:31 2024-10-22 21:53:32        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
22-Oct-2024 17:53:31 2024-10-22 21:53:32        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:31 2024-10-22 21:53:32        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
22-Oct-2024 17:53:31 2024-10-22 21:53:32        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
22-Oct-2024 17:53:32 2024-10-22 21:53:32        INFO        SubImageFactory::createImage        Creating image 'test_pv_1' of shape [6, 10]
22-Oct-2024 17:53:32 2024-10-22 21:53:32        INFO        name::        No table opened.
22-Oct-2024 17:53:32 2024-10-22 21:53:32        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:32 2024-10-22 21:53:32        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
22-Oct-2024 17:53:32 2024-10-22 21:53:32        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
22-Oct-2024 17:53:32 2024-10-22 21:53:32        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:32 2024-10-22 21:53:32        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
22-Oct-2024 17:53:32 2024-10-22 21:53:32        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
22-Oct-2024 17:53:32 2024-10-22 21:53:33        INFO        SubImageFactory::createImage        Creating image 'test_pv_2' of shape [6, 10]
22-Oct-2024 17:53:33 2024-10-22 21:53:33        INFO        name::        No table opened.
22-Oct-2024 17:53:33 2024-10-22 21:53:33        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:33 2024-10-22 21:53:33        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
22-Oct-2024 17:53:33 2024-10-22 21:53:33        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
22-Oct-2024 17:53:33 2024-10-22 21:53:33        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:33 2024-10-22 21:53:33        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
22-Oct-2024 17:53:33 2024-10-22 21:53:33        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
22-Oct-2024 17:53:33 2024-10-22 21:53:33        INFO        SubImageFactory::createImage        Creating image 'test_pv_3' of shape [6, 10]
22-Oct-2024 17:53:33 2024-10-22 21:53:33        INFO        name::        No table opened.
22-Oct-2024 17:53:33 2024-10-22 21:53:33        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:33 2024-10-22 21:53:34        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
22-Oct-2024 17:53:33 2024-10-22 21:53:34        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
22-Oct-2024 17:53:33 2024-10-22 21:53:34        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:33 2024-10-22 21:53:34        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
22-Oct-2024 17:53:33 2024-10-22 21:53:34        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
22-Oct-2024 17:53:33 2024-10-22 21:53:34        INFO        SubImageFactory::createImage        Creating image 'test_pv_4' of shape [6, 10]
22-Oct-2024 17:53:34 2024-10-22 21:53:34        INFO        name::        No table opened.
22-Oct-2024 17:53:34 2024-10-22 21:53:34        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:34 2024-10-22 21:53:34        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
22-Oct-2024 17:53:34 2024-10-22 21:53:34        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
22-Oct-2024 17:53:34 2024-10-22 21:53:34        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:34 2024-10-22 21:53:34        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
22-Oct-2024 17:53:34 2024-10-22 21:53:34        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
22-Oct-2024 17:53:34 2024-10-22 21:53:34        INFO        SubImageFactory::createImage        Creating image 'test_pv_5' of shape [6, 10]
22-Oct-2024 17:53:34 2024-10-22 21:53:35        INFO        name::        No table opened.
22-Oct-2024 17:53:34 2024-10-22 21:53:35        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:34 2024-10-22 21:53:35        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
22-Oct-2024 17:53:34 2024-10-22 21:53:35        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
22-Oct-2024 17:53:34 2024-10-22 21:53:35        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:34 2024-10-22 21:53:35        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
22-Oct-2024 17:53:34 2024-10-22 21:53:35        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
22-Oct-2024 17:53:34 2024-10-22 21:53:35        INFO        SubImageFactory::createImage        Creating image 'test_pv_6' of shape [6, 10]
22-Oct-2024 17:53:35 2024-10-22 21:53:35        INFO        name::        No table opened.
22-Oct-2024 17:53:35 2024-10-22 21:53:35        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:35 2024-10-22 21:53:35        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
22-Oct-2024 17:53:35 2024-10-22 21:53:35        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:35 2024-10-22 21:53:35        INFO        ImageRegion::fromRecord+            [2, 4, 0] to [7, 6, 9]  (00:00:12.000, -00.01.00.000, 1.415e+09Hz to 23:59:52.000, +00.01.00.000, 1.415e+09Hz)
22-Oct-2024 17:53:35 2024-10-22 21:53:35        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_0' of shape [6, 10]
22-Oct-2024 17:53:35 2024-10-22 21:53:36        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
22-Oct-2024 17:53:35 2024-10-22 21:53:36        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:35 2024-10-22 21:53:36        INFO        ImageRegion::fromRecord+            [2, 4, 0] to [7, 6, 9]  (00:00:12.000, -00.01.00.000, 1.415e+09Hz to 23:59:52.000, +00.01.00.000, 1.415e+09Hz)
22-Oct-2024 17:53:35 2024-10-22 21:53:36        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_1' of shape [6, 10]
22-Oct-2024 17:53:36 2024-10-22 21:53:36        INFO        PVGenerator::setWidth         Rounding width up to next odd number of pixels (3), or 3arcmin
22-Oct-2024 17:53:36 2024-10-22 21:53:36        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
22-Oct-2024 17:53:36 2024-10-22 21:53:36        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:36 2024-10-22 21:53:36        INFO        ImageRegion::fromRecord+            [2, 4, 0] to [7, 6, 9]  (00:00:12.000, -00.01.00.000, 1.415e+09Hz to 23:59:52.000, +00.01.00.000, 1.415e+09Hz)
22-Oct-2024 17:53:36 2024-10-22 21:53:36        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_2' of shape [6, 10]
22-Oct-2024 17:53:36 2024-10-22 21:53:37        INFO        PVGenerator::setWidth         Rounding width up to next odd number of pixels (3), or 3arcmin
22-Oct-2024 17:53:36 2024-10-22 21:53:37        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
22-Oct-2024 17:53:36 2024-10-22 21:53:37        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:36 2024-10-22 21:53:37        INFO        ImageRegion::fromRecord+            [2, 4, 0] to [7, 6, 9]  (00:00:12.000, -00.01.00.000, 1.415e+09Hz to 23:59:52.000, +00.01.00.000, 1.415e+09Hz)
22-Oct-2024 17:53:37 2024-10-22 21:53:37        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_3' of shape [6, 10]
22-Oct-2024 17:53:37 2024-10-22 21:53:37        INFO        PVGenerator::setWidth         Rounding width up to next odd number of pixels (3), or 180000marcsec
22-Oct-2024 17:53:37 2024-10-22 21:53:37        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
22-Oct-2024 17:53:37 2024-10-22 21:53:37        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:37 2024-10-22 21:53:37        INFO        ImageRegion::fromRecord+            [2, 4, 0] to [7, 6, 9]  (00:00:12.000, -00.01.00.000, 1.415e+09Hz to 23:59:52.000, +00.01.00.000, 1.415e+09Hz)
22-Oct-2024 17:53:37 2024-10-22 21:53:38        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_4' of shape [6, 10]
22-Oct-2024 17:53:37 2024-10-22 21:53:38        INFO        name::        No table opened.
22-Oct-2024 17:53:37 2024-10-22 21:53:38        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:37 test_tool_image_pv.py::ia_pv_test::test_pv
22-Oct-2024 17:53:37 ia.pv(): Test pv()
22-Oct-2024 17:53:37 PASSED
22-Oct-2024 17:53:37
22-Oct-2024 17:53:38 2024-10-22 21:53:38        INFO        ImageFactory::createImage        Created Temp image  of shape [50, 50, 1000] with float valued pixels.
22-Oct-2024 17:53:38 2024-10-22 21:53:38        INFO        PVGenerator::generate         Rotating image by -45 degrees about direction coordinate pixel (7.5, 7.5) to align specified slice with the x axis
22-Oct-2024 17:53:38 2024-10-22 21:53:38        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:38 2024-10-22 21:53:38        INFO        ImageRegion::fromRecord+            [0, 0, 0] to [49, 49, 999]  (03:01:57.530, -35.32.49.013, 1.4145e+09Hz to 02:57:58.673, -34.43.38.701, 1.4155e+09Hz)
22-Oct-2024 17:53:38 2024-10-22 21:53:38        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
22-Oct-2024 17:53:38 2024-10-22 21:53:38        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
22-Oct-2024 17:53:38 2024-10-22 21:53:38        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
22-Oct-2024 17:53:38 2024-10-22 21:53:38        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
22-Oct-2024 17:53:38 2024-10-22 21:53:38        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
22-Oct-2024 17:53:38 2024-10-22 21:53:38        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:38 2024-10-22 21:53:38        INFO        ImageRegion::fromRecord+            [4, 7, 0] to [11, 7, 999]  (03:01:31.077, -35.28.09.040, 1.4145e+09Hz to 03:01:06.781, -35.23.12.033, 1.4155e+09Hz)
22-Oct-2024 17:53:38 2024-10-22 21:53:38        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
22-Oct-2024 17:53:38 2024-10-22 21:53:38        INFO        name::        No table opened.
22-Oct-2024 17:53:38 2024-10-22 21:53:38        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:38 test_tool_image_pv.py::ia_pv_test::test_refpix_far_outside_image
22-Oct-2024 17:53:38 Test refpix far outside image doesn't lead to malloc error, CAS-5251
22-Oct-2024 17:53:38 PASSED
22-Oct-2024 17:53:38
22-Oct-2024 17:53:38 2024-10-22 21:53:38        INFO        ImageFactory::createImage        Created Paged image 'maskim' of shape [200, 200, 1, 1] with float valued pixels.
22-Oct-2024 17:53:39 2024-10-22 21:53:39        INFO        ImageFactory::createImage        Created Paged image 'kk' of shape [200, 200, 1, 20] with float valued pixels.
22-Oct-2024 17:53:39 2024-10-22 21:53:39        SEVERE        image::pv (file src/tools/image/image_cmpt.cc, line 4856)        Exception Reported: The input image shape ([200, 200, 1, 20]) and mask shape ([200, 200, 1, 1]) are different, and it was specified that the mask should not be extended, so the mask cannot be applied to the (sub)image. Specifying that the mask should be extended may resolve the issue at File: /source/casainstall/include/casacpp/imageanalysis/ImageAnalysis/SubImageFactory.tcc, line: 306
22-Oct-2024 17:53:39 2024-10-22 21:53:39        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
22-Oct-2024 17:53:39 2024-10-22 21:53:39        INFO        ImageRegion::fromRecord        Selected bounding box :
22-Oct-2024 17:53:39 2024-10-22 21:53:39        INFO        ImageRegion::fromRecord+            [2, 2, 0, 0] to [20, 2, 0, 19]  (00:06:32.213, -01.38.00.797, I, 1.41499e+09Hz to 00:05:20.159, -01.38.00.797, I, 1.41501e+09Hz)
22-Oct-2024 17:53:39 2024-10-22 21:53:39        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
22-Oct-2024 17:53:39 2024-10-22 21:53:39        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
22-Oct-2024 17:53:39 2024-10-22 21:53:39        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
22-Oct-2024 17:53:39 2024-10-22 21:53:39        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
22-Oct-2024 17:53:39 2024-10-22 21:53:39        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
22-Oct-2024 17:53:39 2024-10-22 21:53:39        INFO        name::        No table opened.
22-Oct-2024 17:53:39 2024-10-22 21:53:39        INFO        showcache::        The Table Cache is empty.
22-Oct-2024 17:53:39 test_tool_image_pv.py::ia_pv_test::test_stretch
22-Oct-2024 17:53:39 ia.pv(): Test stretch parameter
22-Oct-2024 17:53:39 PASSED
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_pv/nose.xml -
22-Oct-2024 17:53:39 ======================== 7 passed, 4 warnings in 10.94s ========================
22-Oct-2024 17:53:39 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calanalysis
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_calanalysis/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_calanalysis/
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_sdm_toms/
22-Oct-2024 17:53:39 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_sdm_toms
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_sdm_toms/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_sdm_toms/
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager/
22-Oct-2024 17:53:39 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 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/
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_fitprofile/
22-Oct-2024 17:53:39 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_fitprofile
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_fitprofile/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_fitprofile/
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msmetadata/
22-Oct-2024 17:53:39 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msmetadata
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 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/
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_createmultims/
22-Oct-2024 17:53:39 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_createmultims
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 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/
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_synthesisutils/
22-Oct-2024 17:53:39 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_synthesisutils
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_synthesisutils/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_synthesisutils/
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_rebin/
22-Oct-2024 17:53:39 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_rebin
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 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/
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/
22-Oct-2024 17:53:39 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 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/
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msuvbinner/
22-Oct-2024 17:53:39 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msuvbinner
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_msuvbinner/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_msuvbinner/
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_regrid/
22-Oct-2024 17:53:39 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_regrid
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_regrid/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_regrid/
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_simulator/
22-Oct-2024 17:53:39 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_simulator
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_simulator/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_simulator/
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_componentlist/
22-Oct-2024 17:53:39 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_componentlist
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_componentlist/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_componentlist/
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_statwt/
22-Oct-2024 17:53:39 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_statwt
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 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/
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_subimage/
22-Oct-2024 17:53:39 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_subimage
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 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/
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_agentflagger/
22-Oct-2024 17:53:39 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_agentflagger
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 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/
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_deviation/
22-Oct-2024 17:53:39 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_deviation
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 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/
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv/
22-Oct-2024 17:53:39 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv
22-Oct-2024 17:53:39
22-Oct-2024 17:53:39 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_pv/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv/
22-Oct-2024 17:53:41 total 178664
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci 15001    134859 Oct 22 21:16 casatestutils-6.7.0.11-py3-none-any.whl
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci 15001 182642339 Oct 22 21:16 casatools-6.7.0.11-cp312-cp312-manylinux_2_28_x86_64.whl
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       4320 Oct 22 21:53 test_tool_agentflagger.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        986 Oct 22 21:53 test_tool_calanalysis.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       2638 Oct 22 21:53 test_tool_calibrater.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        667 Oct 22 21:53 test_tool_componentlist.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       7447 Oct 22 21:53 test_tool_coordsys.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root      12917 Oct 22 21:53 test_tool_image.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       2201 Oct 22 21:53 test_tool_image_collapse.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       1028 Oct 22 21:53 test_tool_image_deviation.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       2556 Oct 22 21:53 test_tool_image_fitprofile.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       1159 Oct 22 21:53 test_tool_image_pbcor.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        864 Oct 22 21:53 test_tool_image_pv.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        986 Oct 22 21:53 test_tool_image_rebin.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       1316 Oct 22 21:53 test_tool_image_regrid.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       1513 Oct 22 21:53 test_tool_image_statistics.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        745 Oct 22 21:53 test_tool_image_subimage.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        870 Oct 22 21:53 test_tool_image_transpose.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       1946 Oct 22 21:53 test_tool_imagepol.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        819 Oct 22 21:53 test_tool_linearmosaic.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        648 Oct 22 21:53 test_tool_logsink.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        529 Oct 22 21:53 test_tool_measures.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       5205 Oct 22 21:53 test_tool_ms.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        347 Oct 22 21:53 test_tool_ms_createmultims.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       2075 Oct 22 21:53 test_tool_ms_statwt.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       8492 Oct 22 21:53 test_tool_msmetadata.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        339 Oct 22 21:53 test_tool_msuvbinner.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       1151 Oct 22 21:53 test_tool_quanta.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       3957 Oct 22 21:53 test_tool_regionmanager.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       2053 Oct 22 21:53 test_tool_sdm.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       2083 Oct 22 21:53 test_tool_sdm_toms.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        428 Oct 22 21:53 test_tool_simulator.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       1697 Oct 22 21:53 test_tool_synthesisutils.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       1442 Oct 22 21:53 test_tool_table.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       1697 Oct 22 21:53 test_tool_vpmanager.xml
22-Oct-2024 17:53:41 Finished task 'Test wheel' with result: Success
22-Oct-2024 17:53:41 Starting task 'Tar work directory' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
22-Oct-2024 17:53:41
Beginning to execute external process for build 'CASASPECS - Master Test 3.12 - Test Tools Many Linux 2.28 Rocky 8.9 Py3.12 #20 (CASASPECS-MASTERTESTPY312-TTOMLPY38-20)'
... running command line:
/export/home/cbt-el7-8/bamboohome/temp/CASASPECS-MASTERTESTPY312-TTOMLPY38-20-ScriptBuildTask-4992828232263363017.sh
... in: /export/home/cbt-el7-8/bamboohome/xml-data/build-dir/CASASPECS-MASTERTESTPY312-TTOMLPY38
22-Oct-2024 17:53:41 Package working directory
22-Oct-2024 17:53:41 tar: nosedir: Cannot stat: No such file or directory
22-Oct-2024 17:53:41 tar: Exiting with failure status due to previous errors
22-Oct-2024 17:53:41 total 178668
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci 15001    134859 Oct 22 21:16 casatestutils-6.7.0.11-py3-none-any.whl
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci 15001 182642339 Oct 22 21:16 casatools-6.7.0.11-cp312-cp312-manylinux_2_28_x86_64.whl
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       4320 Oct 22 21:53 test_tool_agentflagger.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        986 Oct 22 21:53 test_tool_calanalysis.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       2638 Oct 22 21:53 test_tool_calibrater.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        667 Oct 22 21:53 test_tool_componentlist.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       7447 Oct 22 21:53 test_tool_coordsys.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root      12917 Oct 22 21:53 test_tool_image.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       2201 Oct 22 21:53 test_tool_image_collapse.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       1028 Oct 22 21:53 test_tool_image_deviation.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       2556 Oct 22 21:53 test_tool_image_fitprofile.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       1159 Oct 22 21:53 test_tool_image_pbcor.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        864 Oct 22 21:53 test_tool_image_pv.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        986 Oct 22 21:53 test_tool_image_rebin.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       1316 Oct 22 21:53 test_tool_image_regrid.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       1513 Oct 22 21:53 test_tool_image_statistics.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        745 Oct 22 21:53 test_tool_image_subimage.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        870 Oct 22 21:53 test_tool_image_transpose.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       1946 Oct 22 21:53 test_tool_imagepol.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        819 Oct 22 21:53 test_tool_linearmosaic.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        648 Oct 22 21:53 test_tool_logsink.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        529 Oct 22 21:53 test_tool_measures.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       5205 Oct 22 21:53 test_tool_ms.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        347 Oct 22 21:53 test_tool_ms_createmultims.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       2075 Oct 22 21:53 test_tool_ms_statwt.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       8492 Oct 22 21:53 test_tool_msmetadata.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        339 Oct 22 21:53 test_tool_msuvbinner.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       1151 Oct 22 21:53 test_tool_quanta.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       3957 Oct 22 21:53 test_tool_regionmanager.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       2053 Oct 22 21:53 test_tool_sdm.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       2083 Oct 22 21:53 test_tool_sdm_toms.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root        428 Oct 22 21:53 test_tool_simulator.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       1697 Oct 22 21:53 test_tool_synthesisutils.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       1442 Oct 22 21:53 test_tool_table.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root       1697 Oct 22 21:53 test_tool_vpmanager.xml
22-Oct-2024 17:53:41 -rw-r--r-- 1 casaci root         45 Oct 22 21:53 work-manylinux228-3.12.tar.gz
22-Oct-2024 17:53:41 Done packaging working directory
22-Oct-2024 17:53:41 Finished task 'Tar work directory' with result: Success
22-Oct-2024 17:53:41 Starting task 'Parse tests' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
22-Oct-2024 17:53:41 Parsing test results under /export/home/cbt-el7-8/bamboohome/xml-data/build-dir/CASASPECS-MASTERTESTPY312-TTOMLPY38...
22-Oct-2024 17:53:42 Finished task 'Parse tests' with result: Success
22-Oct-2024 17:53:42 Starting task 'Upload wheel' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
22-Oct-2024 17:53:42
Beginning to execute external process for build 'CASASPECS - Master Test 3.12 - Test Tools Many Linux 2.28 Rocky 8.9 Py3.12 #20 (CASASPECS-MASTERTESTPY312-TTOMLPY38-20)'
... running command line:
/export/home/cbt-el7-8/bamboohome/temp/CASASPECS-MASTERTESTPY312-TTOMLPY38-20-ScriptBuildTask-5979731823264686528.sh
... in: /export/home/cbt-el7-8/bamboohome/xml-data/build-dir/CASASPECS-MASTERTESTPY312-TTOMLPY38
22-Oct-2024 17:53:42 Collecting twine
22-Oct-2024 17:53:42   Downloading twine-5.1.1-py3-none-any.whl (38 kB)
22-Oct-2024 17:53:43 Collecting readme-renderer>=35.0
22-Oct-2024 17:53:43   Downloading readme_renderer-44.0-py3-none-any.whl (13 kB)
22-Oct-2024 17:53:43 Collecting rfc3986>=1.4.0
22-Oct-2024 17:53:43   Downloading rfc3986-2.0.0-py2.py3-none-any.whl (31 kB)
22-Oct-2024 17:53:43 Collecting pkginfo>=1.8.1
22-Oct-2024 17:53:43   Downloading pkginfo-1.11.2-py3-none-any.whl (31 kB)
22-Oct-2024 17:53:43 Collecting requests>=2.20
22-Oct-2024 17:53:43   Downloading requests-2.32.3-py3-none-any.whl (64 kB)
22-Oct-2024 17:53:43      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.9/64.9 kB 1.2 MB/s eta 0:00:00
22-Oct-2024 17:53:43 Collecting rich>=12.0.0
22-Oct-2024 17:53:43   Downloading rich-13.9.3-py3-none-any.whl (242 kB)
22-Oct-2024 17:53:43      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 242.2/242.2 kB 2.8 MB/s eta 0:00:00
22-Oct-2024 17:53:43 Collecting requests-toolbelt!=0.9.0,>=0.8.0
22-Oct-2024 17:53:44   Downloading requests_toolbelt-1.0.0-py2.py3-none-any.whl (54 kB)
22-Oct-2024 17:53:44      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 54.5/54.5 kB 855.9 kB/s eta 0:00:00
22-Oct-2024 17:53:44 Collecting importlib-metadata>=3.6
22-Oct-2024 17:53:44   Downloading importlib_metadata-8.5.0-py3-none-any.whl (26 kB)
22-Oct-2024 17:53:44 Collecting pkginfo>=1.8.1
22-Oct-2024 17:53:44   Downloading pkginfo-1.10.0-py3-none-any.whl (30 kB)
22-Oct-2024 17:53:44 Collecting urllib3>=1.26.0
22-Oct-2024 17:53:44   Downloading urllib3-2.2.3-py3-none-any.whl (126 kB)
22-Oct-2024 17:53:44      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 126.3/126.3 kB 1.6 MB/s eta 0:00:00
22-Oct-2024 17:53:44 Collecting keyring>=15.1
22-Oct-2024 17:53:44   Downloading keyring-25.4.1-py3-none-any.whl (38 kB)
22-Oct-2024 17:53:44 Collecting zipp>=3.20
22-Oct-2024 17:53:44   Downloading zipp-3.20.2-py3-none-any.whl (9.2 kB)
22-Oct-2024 17:53:45 Collecting jaraco.functools
22-Oct-2024 17:53:45   Downloading jaraco.functools-4.1.0-py3-none-any.whl (10 kB)
22-Oct-2024 17:53:45 Collecting jaraco.classes
22-Oct-2024 17:53:45   Downloading jaraco.classes-3.4.0-py3-none-any.whl (6.8 kB)
22-Oct-2024 17:53:45 Collecting jaraco.context
22-Oct-2024 17:53:45   Downloading jaraco.context-6.0.1-py3-none-any.whl (6.8 kB)
22-Oct-2024 17:53:45 Collecting SecretStorage>=3.2
22-Oct-2024 17:53:45   Downloading SecretStorage-3.3.3-py3-none-any.whl (15 kB)
22-Oct-2024 17:53:45 Collecting jeepney>=0.4.2
22-Oct-2024 17:53:45   Downloading jeepney-0.8.0-py3-none-any.whl (48 kB)
22-Oct-2024 17:53:45      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 48.4/48.4 kB 598.4 kB/s eta 0:00:00
22-Oct-2024 17:53:46 Collecting nh3>=0.2.14
22-Oct-2024 17:53:46   Downloading nh3-0.2.18-cp37-abi3-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (769 kB)
22-Oct-2024 17:53:46      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 769.2/769.2 kB 9.6 MB/s eta 0:00:00
22-Oct-2024 17:53:46 Collecting Pygments>=2.5.1
22-Oct-2024 17:53:46   Downloading pygments-2.18.0-py3-none-any.whl (1.2 MB)
22-Oct-2024 17:53:46      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.2/1.2 MB 9.7 MB/s eta 0:00:00
22-Oct-2024 17:53:46 Collecting docutils>=0.21.2
22-Oct-2024 17:53:46   Downloading docutils-0.21.2-py3-none-any.whl (587 kB)
22-Oct-2024 17:53:46      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 587.4/587.4 kB 6.4 MB/s eta 0:00:00
22-Oct-2024 17:53:46 Collecting certifi>=2017.4.17
22-Oct-2024 17:53:46   Downloading certifi-2024.8.30-py3-none-any.whl (167 kB)
22-Oct-2024 17:53:46      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 167.3/167.3 kB 3.2 MB/s eta 0:00:00
22-Oct-2024 17:53:46 Collecting idna<4,>=2.5
22-Oct-2024 17:53:46   Downloading idna-3.10-py3-none-any.whl (70 kB)
22-Oct-2024 17:53:46      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 70.4/70.4 kB 1.3 MB/s eta 0:00:00
22-Oct-2024 17:53:47 Collecting charset-normalizer<4,>=2
22-Oct-2024 17:53:47   Downloading charset_normalizer-3.4.0-cp310-cp310-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (144 kB)
22-Oct-2024 17:53:47      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 144.8/144.8 kB 1.4 MB/s eta 0:00:00
22-Oct-2024 17:53:47 Collecting markdown-it-py>=2.2.0
22-Oct-2024 17:53:47   Downloading markdown_it_py-3.0.0-py3-none-any.whl (87 kB)
22-Oct-2024 17:53:47      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 87.5/87.5 kB 2.1 MB/s eta 0:00:00
22-Oct-2024 17:53:47 Collecting typing-extensions<5.0,>=4.0.0
22-Oct-2024 17:53:47   Downloading typing_extensions-4.12.2-py3-none-any.whl (37 kB)
22-Oct-2024 17:53:47 Collecting mdurl~=0.1
22-Oct-2024 17:53:47   Downloading mdurl-0.1.2-py3-none-any.whl (10.0 kB)
22-Oct-2024 17:53:48 Collecting cryptography>=2.0
22-Oct-2024 17:53:48   Downloading cryptography-43.0.3-cp39-abi3-manylinux_2_28_x86_64.whl (4.0 MB)
22-Oct-2024 17:53:48      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.0/4.0 MB 14.5 MB/s eta 0:00:00
22-Oct-2024 17:53:48 Collecting more-itertools
22-Oct-2024 17:53:48   Downloading more_itertools-10.5.0-py3-none-any.whl (60 kB)
22-Oct-2024 17:53:48      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 61.0/61.0 kB 809.7 kB/s eta 0:00:00
22-Oct-2024 17:53:49 Collecting backports.tarfile
22-Oct-2024 17:53:49   Downloading backports.tarfile-1.2.0-py3-none-any.whl (30 kB)
22-Oct-2024 17:53:49 Collecting cffi>=1.12
22-Oct-2024 17:53:49   Downloading cffi-1.17.1-cp310-cp310-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (446 kB)
22-Oct-2024 17:53:49      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 446.2/446.2 kB 6.6 MB/s eta 0:00:00
22-Oct-2024 17:53:49 Collecting pycparser
22-Oct-2024 17:53:49   Downloading pycparser-2.22-py3-none-any.whl (117 kB)
22-Oct-2024 17:53:49      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 117.6/117.6 kB 2.1 MB/s eta 0:00:00
22-Oct-2024 17:53:50 Installing collected packages: nh3, zipp, urllib3, typing-extensions, rfc3986, Pygments, pycparser, pkginfo, more-itertools, mdurl, jeepney, idna, docutils, charset-normalizer, certifi, backports.tarfile, requests, readme-renderer, markdown-it-py, jaraco.functools, jaraco.context, jaraco.classes, importlib-metadata, cffi, rich, requests-toolbelt, cryptography, SecretStorage, keyring, twine
22-Oct-2024 17:53:55 Successfully installed Pygments-2.18.0 SecretStorage-3.3.3 backports.tarfile-1.2.0 certifi-2024.8.30 cffi-1.17.1 charset-normalizer-3.4.0 cryptography-43.0.3 docutils-0.21.2 idna-3.10 importlib-metadata-8.5.0 jaraco.classes-3.4.0 jaraco.context-6.0.1 jaraco.functools-4.1.0 jeepney-0.8.0 keyring-25.4.1 markdown-it-py-3.0.0 mdurl-0.1.2 more-itertools-10.5.0 nh3-0.2.18 pkginfo-1.10.0 pycparser-2.22 readme-renderer-44.0 requests-2.32.3 requests-toolbelt-1.0.0 rfc3986-2.0.0 rich-13.9.3 twine-5.1.1 typing-extensions-4.12.2 urllib3-2.2.3 zipp-3.20.2
22-Oct-2024 17:53:55 WARNING: Running pip as the 'root' user can result in broken permissions and conflicting behaviour with the system package manager. It is recommended to use a virtual environment instead: https://pip.pypa.io/warnings/venv
22-Oct-2024 17:53:55
22-Oct-2024 17:53:55 [notice] A new release of pip is available: 23.0.1 -> 24.2
22-Oct-2024 17:53:55 [notice] To update, run: pip3 install --upgrade pip
22-Oct-2024 17:53:56 Cloning into 'casa-build-utils'...
22-Oct-2024 17:53:57 Uploading distributions to
22-Oct-2024 17:53:57 https://casa-pip.nrao.edu:443/repository/casa-test-wheel/
22-Oct-2024 17:53:58 Uploading casatools-6.7.0.11-cp312-cp312-manylinux_2_28_x86_64.whl
22-Oct-2024 17:53:58
22-Oct-2024 17:53:58   0% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 0.0/182.7 MB--:--?
22-Oct-2024 17:53:59   4% ━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.7/182.7 MB00:0292.7 MB/s
22-Oct-2024 17:53:59   6% ━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 11.1/182.7 MB00:0291.8 MB/s
22-Oct-2024 17:53:59   8% ━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 14.5/182.7 MB00:0450.3 MB/s
22-Oct-2024 17:53:59 10% ━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 19.0/182.7 MB00:0445.7 MB/s
22-Oct-2024 17:53:59 12% ━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 21.8/182.7 MB00:0539.0 MB/s
22-Oct-2024 17:53:59 13% ━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 24.5/182.7 MB00:0533.6 MB/s
22-Oct-2024 17:53:59 15% ━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 27.0/182.7 MB00:0629.6 MB/s
22-Oct-2024 17:53:59 16% ━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 29.7/182.7 MB00:0534.0 MB/s
22-Oct-2024 17:53:59 18% ━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 33.8/182.7 MB00:0629.0 MB/s
22-Oct-2024 17:54:00 20% ━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 36.2/182.7 MB00:0628.4 MB/s
22-Oct-2024 17:54:00 22% ━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 40.2/182.7 MB00:0628.4 MB/s
22-Oct-2024 17:54:00 23% ━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 42.8/182.7 MB00:0528.5 MB/s
22-Oct-2024 17:54:00 25% ━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 45.3/182.7 MB00:0528.4 MB/s
22-Oct-2024 17:54:00 26% ━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 48.1/182.7 MB00:0528.7 MB/s
22-Oct-2024 17:54:00 28% ━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 51.1/182.7 MB00:0626.0 MB/s
22-Oct-2024 17:54:00 30% ━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━ 55.2/182.7 MB00:0529.8 MB/s
22-Oct-2024 17:54:00 32% ━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━ 58.7/182.7 MB00:0529.7 MB/s
22-Oct-2024 17:54:02 34% ━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━ 61.3/182.7 MB00:0529.8 MB/s
22-Oct-2024 17:54:02 35% ━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━ 64.7/182.7 MB00:0434.1 MB/s
22-Oct-2024 17:54:02 37% ━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━ 67.2/182.7 MB00:0429.3 MB/s
22-Oct-2024 17:54:02 38% ━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━ 69.9/182.7 MB00:0433.5 MB/s
22-Oct-2024 17:54:02 40% ━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━ 72.7/182.7 MB00:0429.3 MB/s
22-Oct-2024 17:54:02 42% ━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━ 77.4/182.7 MB00:0429.3 MB/s
22-Oct-2024 17:54:02 44% ━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━ 80.4/182.7 MB00:0429.3 MB/s
22-Oct-2024 17:54:02 46% ━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━ 84.0/182.7 MB00:0333.5 MB/s
22-Oct-2024 17:54:02 47% ━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━ 86.7/182.7 MB00:0333.3 MB/s
22-Oct-2024 17:54:02 49% ━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━ 89.4/182.7 MB00:0333.4 MB/s
22-Oct-2024 17:54:02 50% ━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━ 92.2/182.7 MB00:0332.8 MB/s
22-Oct-2024 17:54:02 52% ━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━ 94.7/182.7 MB00:0332.8 MB/s
22-Oct-2024 17:54:02 53% ━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━ 97.6/182.7 MB00:0427.7 MB/s
22-Oct-2024 17:54:02 55% ━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━ 100.7/182.7 MB00:0329.2 MB/s
22-Oct-2024 17:54:02 56% ━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━ 102.6/182.7 MB00:0426.4 MB/s
22-Oct-2024 17:54:02 57% ━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━ 104.7/182.7 MB00:0424.0 MB/s
22-Oct-2024 17:54:02 59% ━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━ 108.6/182.7 MB00:0327.0 MB/s
22-Oct-2024 17:54:02 61% ━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━ 110.5/182.7 MB00:0324.4 MB/s
22-Oct-2024 17:54:02 62% ━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━ 112.6/182.7 MB00:0422.7 MB/s
22-Oct-2024 17:54:02 64% ━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━ 116.4/182.7 MB00:0325.1 MB/s
22-Oct-2024 17:54:03 65% ━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━ 119.4/182.7 MB00:0327.9 MB/s
22-Oct-2024 17:54:03 66% ━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━ 120.9/182.7 MB00:0324.5 MB/s
22-Oct-2024 17:54:03 68% ━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━ 123.4/182.7 MB00:0327.3 MB/s
22-Oct-2024 17:54:03 69% ━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━ 126.9/182.7 MB00:0327.3 MB/s
22-Oct-2024 17:54:03 71% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━ 128.9/182.7 MB00:0324.6 MB/s
22-Oct-2024 17:54:03 72% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━ 131.6/182.7 MB00:0227.0 MB/s
22-Oct-2024 17:54:03 73% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━ 134.2/182.7 MB00:0226.0 MB/s
22-Oct-2024 17:54:03 75% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━ 136.4/182.7 MB00:0225.9 MB/s
22-Oct-2024 17:54:03 76% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━ 138.6/182.7 MB00:0225.6 MB/s
22-Oct-2024 17:54:03 77% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━ 140.5/182.7 MB00:0225.2 MB/s
22-Oct-2024 17:54:04 79% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━ 143.4/182.7 MB00:0224.7 MB/s
22-Oct-2024 17:54:04 81% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━ 147.7/182.7 MB00:0225.2 MB/s
22-Oct-2024 17:54:04 82% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━ 150.6/182.7 MB00:0225.7 MB/s
22-Oct-2024 17:54:04 84% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━ 153.7/182.7 MB00:0129.2 MB/s
22-Oct-2024 17:54:04 85% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━ 156.0/182.7 MB00:0129.0 MB/s
22-Oct-2024 17:54:04 87% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━ 158.8/182.7 MB00:0129.0 MB/s
22-Oct-2024 17:54:04 88% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━ 161.1/182.7 MB00:0129.2 MB/s
22-Oct-2024 17:54:04 90% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━ 164.0/182.7 MB00:0128.1 MB/s
22-Oct-2024 17:54:04 91% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━ 167.1/182.7 MB00:0128.0 MB/s
22-Oct-2024 17:54:05 94% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━ 171.6/182.7 MB00:0127.8 MB/s
22-Oct-2024 17:54:05 96% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━ 175.2/182.7 MB00:0131.2 MB/s
22-Oct-2024 17:54:05 97% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━ 177.9/182.7 MB00:0131.1 MB/s
22-Oct-2024 17:54:05 99% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸ 180.7/182.7 MB00:0131.5 MB/s
22-Oct-2024 17:54:05 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 182.7/182.7 MB00:0627.3 MB/s
22-Oct-2024 17:54:05 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 182.7/182.7 MB00:0627.3 MB/s
22-Oct-2024 17:54:05 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 182.7/182.7 MB00:0627.3 MB/s
22-Oct-2024 17:54:05 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 182.7/182.7 MB00:0627.3 MB/s
22-Oct-2024 17:54:05 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 182.7/182.7 MB00:0627.3 MB/s
22-Oct-2024 17:54:05 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 182.7/182.7 MB00:0627.3 MB/s
22-Oct-2024 17:54:05 WARNING Error during upload. Retry with the --verbose option for more details.
22-Oct-2024 17:54:05 ERROR    HTTPError: 400 Bad Request from                                       
22-Oct-2024 17:54:05          https://casa-pip.nrao.edu:443/repository/casa-test-wheel/             
22-Oct-2024 17:54:05          Repository does not allow updating assets: casa-test-wheel             
22-Oct-2024 17:54:06 Uploading distributions to
22-Oct-2024 17:54:06 https://casa-pip.nrao.edu:443/repository/casa-test-wheel/
22-Oct-2024 17:54:06 Uploading casatestutils-6.7.0.11-py3-none-any.whl
22-Oct-2024 17:54:06
22-Oct-2024 17:54:06   0% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 0.0/147.2 kB--:--?
22-Oct-2024 17:54:06 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 147.2/147.2 kB00:0047.9 MB/s
22-Oct-2024 17:54:06 WARNING Error during upload. Retry with the --verbose option for more details.
22-Oct-2024 17:54:06 ERROR    HTTPError: 400 Bad Request from                                       
22-Oct-2024 17:54:06          https://casa-pip.nrao.edu:443/repository/casa-test-wheel/             
22-Oct-2024 17:54:06          Repository does not allow updating assets: casa-test-wheel             
22-Oct-2024 17:54:06 Finished task 'Upload wheel' with result: Success
22-Oct-2024 17:54:06 Starting task 'Cleanup' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
22-Oct-2024 17:54:06
Beginning to execute external process for build 'CASASPECS - Master Test 3.12 - Test Tools Many Linux 2.28 Rocky 8.9 Py3.12 #20 (CASASPECS-MASTERTESTPY312-TTOMLPY38-20)'
... running command line:
/export/home/cbt-el7-8/bamboohome/temp/CASASPECS-MASTERTESTPY312-TTOMLPY38-20-ScriptBuildTask-5686685583980453639.sh
... in: /export/home/cbt-el7-8/bamboohome/xml-data/build-dir/CASASPECS-MASTERTESTPY312-TTOMLPY38
22-Oct-2024 17:54:06 Starting cleanup
22-Oct-2024 17:54:23 wheel-container-test
22-Oct-2024 17:54:25 wheel-container-test
22-Oct-2024 17:54:25 Cleanup complete
22-Oct-2024 17:54:25 Finished task 'Cleanup' with result: Success
22-Oct-2024 17:54:25 Running post build plugin 'Docker Container Cleanup'
22-Oct-2024 17:54:25
Beginning to execute external process for build 'CASASPECS - Master Test 3.12 - Test Tools Many Linux 2.28 Rocky 8.9 Py3.12 #20 (CASASPECS-MASTERTESTPY312-TTOMLPY38-20)'
... running command line:
/bin/docker rm -f wheel-container-test
... in: /export/home/cbt-el7-8/bamboohome/xml-data/build-dir/CASASPECS-MASTERTESTPY312-TTOMLPY38
22-Oct-2024 17:54:25 Error response from daemon: No such container: wheel-container-test
22-Oct-2024 17:54:25 Running post build plugin 'NCover Results Collector'
22-Oct-2024 17:54:25 Running post build plugin 'Build Results Label Collector'
22-Oct-2024 17:54:25 Running post build plugin 'Clover Results Collector'
22-Oct-2024 17:54:25 Running post build plugin 'npm Cache Cleanup'
22-Oct-2024 17:54:25 Running post build plugin 'Artifact Copier'
22-Oct-2024 17:54:25 Publishing an artifact: Workdir
22-Oct-2024 17:54:25 Finished publishing of artifact Non required job artifact Http Compression On : [Workdir], patterns: [work*.tar.gz] anchored at: [wheeldirectory/] in 84.39 ms
22-Oct-2024 17:54:25 Publishing an artifact: XML Directories
22-Oct-2024 17:54:25 Finished publishing of artifact Non required job artifact Http Compression On : [XML Directories], patterns: [**/*.xml] anchored at: [wheeldirectory/] in 281.1 ms
22-Oct-2024 17:54:25 Finalising the build...
22-Oct-2024 17:54:25 Stopping timer.
22-Oct-2024 17:54:25 Build CASASPECS-MASTERTESTPY312-TTOMLPY38-20 completed.
22-Oct-2024 17:54:26 Running on server: post build plugin 'Build Hanging Detection Configuration'
22-Oct-2024 17:54:26 Running on server: post build plugin 'NCover Results Collector'
22-Oct-2024 17:54:26 Running on server: post build plugin 'Build Labeller'
22-Oct-2024 17:54:26 Running on server: post build plugin 'Clover Delta Calculator'
22-Oct-2024 17:54:26 Running on server: post build plugin 'Maven Dependencies Postprocessor'
22-Oct-2024 17:54:26 All post build plugins have finished
22-Oct-2024 17:54:26 Generating build results summary...
22-Oct-2024 17:54:26 Saving build results to disk...
22-Oct-2024 17:54:26 Store variable context...
22-Oct-2024 17:54:26 Finished building CASASPECS-MASTERTESTPY312-TTOMLPY38-20.