Tools and Tasks tests for Python 3.12

Build: #2 was successful

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

Build log

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

23-Feb-2025 16:29:05 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:05 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:05 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:05 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:05 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:05 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:05 2025-02-23 21:29:06        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 11 Scan : 30 : 30
23-Feb-2025 16:29:05 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:05 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:05 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:05 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:05 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:05 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:05 2025-02-23 21:29:06        INFO        FlagMSHandler::        Chunk = 13 [progress: 40%], Observation = 0, Array = 0, Scan = 30, Field = 1 (3C286_A), Spw = 12, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 534
23-Feb-2025 16:29:05 2025-02-23 21:29:06        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 12 Scan : 30 : 30
23-Feb-2025 16:29:05 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:05 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:05 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (134568/410112)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 13 Scan : 30 : 30
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 14 Scan : 30 : 30
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 15 Scan : 30 : 30
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        FlagMSHandler::        Chunk = 17 [progress: 52%], Observation = 0, Array = 0, Scan = 31, Field = 1 (3C286_A), Spw = 0, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 540
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 0 Scan : 31 : 31
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (179928/548352)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 1 Scan : 31 : 31
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 2 Scan : 31 : 31
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        FlagMSHandler::        Chunk = 20 [progress: 62%], Observation = 0, Array = 0, Scan = 31, Field = 1 (3C286_A), Spw = 3, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 540
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 3 Scan : 31 : 31
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 4 Scan : 31 : 31
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 5 Scan : 31 : 31
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:06 2025-02-23 21:29:06        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        FlagMSHandler::        Chunk = 23 [progress: 71%], Observation = 0, Array = 0, Scan = 31, Field = 1 (3C286_A), Spw = 6, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 540
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 6 Scan : 31 : 31
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 7 Scan : 31 : 31
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 8 Scan : 31 : 31
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        FlagMSHandler::        Chunk = 26 [progress: 81%], Observation = 0, Array = 0, Scan = 31, Field = 1 (3C286_A), Spw = 9, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 540
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 9 Scan : 31 : 31
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 10 Scan : 31 : 31
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 11 Scan : 31 : 31
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        FlagMSHandler::        Chunk = 29 [progress: 90%], Observation = 0, Array = 0, Scan = 31, Field = 1 (3C286_A), Spw = 12, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 540
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 12 Scan : 31 : 31
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 13 Scan : 31 : 31
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 14 Scan : 31 : 31
23-Feb-2025 16:29:06 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        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
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 15 Scan : 31 : 31
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        FlagMSHandler::nextChunk         ====================================================================================
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Manual::tableSummary        => Percentage of data flagged in table selection: 32.8125%
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        AgentFlagger::run        => Writing flags to the MS
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          observation 0 flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          scan 31 flagged: 725760 total: 2.21184e+06 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          scan 30 flagged: 717696 total: 2.18726e+06 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          antenna ea24 flagged: 721728 total: 2.19955e+06 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          antenna ea19 flagged: 721728 total: 2.19955e+06 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          antenna ea01 flagged: 721728 total: 2.19955e+06 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          antenna ea11 flagged: 721728 total: 2.19955e+06 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          field 3C286_A flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          spw 15 flagged: 90216 total: 274944 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          spw 14 flagged: 90216 total: 274944 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          spw 10 flagged: 90216 total: 274944 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          spw 7 flagged: 90216 total: 274944 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          spw 12 flagged: 90216 total: 274944 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          spw 6 flagged: 90216 total: 274944 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          spw 8 flagged: 90216 total: 274944 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          spw 5 flagged: 90216 total: 274944 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          spw 0 flagged: 90216 total: 274944 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          spw 11 flagged: 90216 total: 274944 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          spw 9 flagged: 90216 total: 274944 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          spw 4 flagged: 90216 total: 274944 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          spw 1 flagged: 90216 total: 274944 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          spw 2 flagged: 90216 total: 274944 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          spw 13 flagged: 90216 total: 274944 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          spw 3 flagged: 90216 total: 274944 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          correlation LL flagged: 360864 total: 1.09978e+06 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          correlation LR flagged: 360864 total: 1.09978e+06 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          correlation RR flagged: 360864 total: 1.09978e+06 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          correlation RL flagged: 360864 total: 1.09978e+06 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          array 0 flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          Total Flagged: 1.44346e+06 Total Counts: 4.3991e+06 (32.8%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::displayReports         Report Displays are turned OFF
23-Feb-2025 16:29:07 test_tool_agentflagger.py::test_display::test_display_data_single_channel_selection
23-Feb-2025 16:29:07 AgentFlagger:: Check nominal behaviour for single spw:chan selection 
23-Feb-2025 16:29:07 The MS is already around, just unflag
23-Feb-2025 16:29:07 PASSED
23-Feb-2025 16:29:07
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        AgentFlagger::open        Table type is Measurement Set
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        AgentFlagger::initAgents        There are initially 1 agents in the list. Agents: unflag
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        AgentFlagger::initAgents        There are 1 valid agents in the list. Agents: unflag
23-Feb-2025 16:29:07 2025-02-23 21:29:07        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
23-Feb-2025 16:29:07 2025-02-23 21:29:07        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
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (1028/1028)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        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
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2/2)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        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
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (1026/1026)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        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
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4/4)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        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
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2050/2050)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        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
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4096/4096)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        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
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (6/6)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        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
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2048/2048)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        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
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4098/4098)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        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
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2/2)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        FlagMSHandler::nextChunk         ====================================================================================
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Unflag::tableSummary        => Percentage of data un-flagged in table selection: 100%
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        AgentFlagger::run        => Writing flags to the MS
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        AgentFlagger::open        Table type is Measurement Set
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        FlagMSHandler::selectData          Selected spw-channels ids are Axis Lengths: [4, 4]  (NB: Matrix in Row/Column order)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        FlagMSHandler::selectData +        [1, 0, 511, 1
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        FlagMSHandler::selectData +         2, 0, 0, 1
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        FlagMSHandler::selectData +         3, 0, 511, 1
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        FlagMSHandler::selectData +         4, 0, 0, 1]
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        AgentFlagger::initAgents        There are initially 3 agents in the list. Agents: manual, summary, display
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Manual::setAgentParameters         autocorr is 0
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::setAgentParameters          data column is FLOAT_DATA
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::setAgentParameters          Visibility expression is REAL XX,YY
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::setAgentParameters          pause is 0
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::setAgentParameters          datadisplay is 1
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::setAgentParameters          reportdisplay is 0
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::setAgentParameters          format is screen
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        AgentFlagger::initAgents        There are 3 valid agents in the list. Agents: manual, summary, display
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        FlagDataHandler::preLoadColumn         Setting row blocking to number of rows in selected table: 4
23-Feb-2025 16:29:07 2025-02-23 21:29:07        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
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 1 Scan : 1 : 1
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
23-Feb-2025 16:29:07 /home/casatest/venv/bin/python3.12: No module named casaplotserver
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Manual::chunkSummary        => Data flagged so far 100% (1024/1024)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        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
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 2 Scan : 1 : 1
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Manual::chunkSummary        => Data flagged so far 100% (2/2)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        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
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 3 Scan : 1 : 1
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Manual::chunkSummary        => Data flagged so far 100% (1024/1024)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        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
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 4 Scan : 1 : 1
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Manual::chunkSummary        => Data flagged so far 100% (2/2)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        FlagMSHandler::nextChunk         ====================================================================================
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Manual::tableSummary        => Percentage of data flagged in table selection: 100%
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        AgentFlagger::run        => Writing flags to the MS
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          observation 0 flagged: 2052 total: 2052 (100%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          scan 1 flagged: 2052 total: 2052 (100%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          antenna PM04 flagged: 2052 total: 2052 (100%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          field r aqr flagged: 2052 total: 2052 (100%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          spw 4 flagged: 2 total: 2 (100%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          spw 3 flagged: 1024 total: 1024 (100%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          spw 1 flagged: 1024 total: 1024 (100%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          spw 2 flagged: 2 total: 2 (100%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          correlation YY flagged: 1026 total: 1026 (100%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          correlation XX flagged: 1026 total: 1026 (100%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          array 0 flagged: 2052 total: 2052 (100%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Summary::getResult          Total Flagged: 2052 Total Counts: 2052 (100%)
23-Feb-2025 16:29:07 2025-02-23 21:29:07        INFO        Display::displayReports         Report Displays are turned OFF
23-Feb-2025 16:29:07 test_tool_agentflagger.py::test_display::test_display_float_data
23-Feb-2025 16:29:07 AgentFlagger: Select spw, display and flag single-dish MS
23-Feb-2025 16:29:07 Moving data...
23-Feb-2025 16:29:07 PASSED
23-Feb-2025 16:29:07
23-Feb-2025 16:29:07 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_agentflagger/nose.xml -
23-Feb-2025 16:29:07 ======================= 35 passed, 4 warnings in 24.51s ========================
23-Feb-2025 16:29:07 ============================= test session starts ==============================
23-Feb-2025 16:29:07 platform linux -- Python 3.12.6, pytest-8.3.4, pluggy-1.5.0 -- /home/casatest/venv/bin/python3.12
23-Feb-2025 16:29:07 cachedir: .pytest_cache
23-Feb-2025 16:29:07 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor
23-Feb-2025 16:29:07 configfile: pytest.ini
23-Feb-2025 16:29:08 collecting ... collected 9 items
23-Feb-2025 16:29:08
23-Feb-2025 16:29:08
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord        Selected bounding box :
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord        Selected bounding box :
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord        Selected bounding box :
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 0, 0]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, I)
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord        Selected bounding box :
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord        Selected bounding box :
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        name::        No table opened.
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        showcache::        The Table Cache is empty.
23-Feb-2025 16:29:08 test_tool_image_pbcor.py::ia_pbcor_test::test_4d_image_with_2d_pb
23-Feb-2025 16:29:08 ia.pbcor: Test full image divide with cutoff. Primary beam is 2 D, image is 4 D
23-Feb-2025 16:29:08 PASSED
23-Feb-2025 16:29:08
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [5, 5, 1, 1]
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        name::        No table opened.
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        showcache::        The Table Cache is empty.
23-Feb-2025 16:29:08 test_tool_image_pbcor.py::ia_pbcor_test::test_diff_spectral_coordinate
23-Feb-2025 16:29:08 Verify fix that a different spectral coordinates in target and template don't matter, CAS-5096
23-Feb-2025 16:29:08 PASSED
23-Feb-2025 16:29:08
23-Feb-2025 16:29:08 2025-02-23 21:29:09        INFO        ImageFactory::createImage        Created Paged image 't_in.im' of shape [20, 20, 4, 20] with float valued pixels.
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageFactory::createImage        Created Paged image 't_pb_in.im' of shape [20, 20, 4, 20] with float valued pixels.
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        CasacRegionManager::fromBCS        Using polarizations I
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord        Selected bounding box :
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [19, 19, 0, 19]  (00:00:40.000, -00.10.00.001, I, 1.41499e+09Hz to 23:59:24.000, +00.09.00.001, I, 1.41501e+09Hz)
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord        Selected bounding box :
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [19, 19, 0, 19]  (00:00:40.000, -00.10.00.001, I, 1.41499e+09Hz to 23:59:24.000, +00.09.00.001, I, 1.41501e+09Hz)
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        SubImageFactory::createImage        Creating image 't_out.im' of shape [20, 20, 1, 20]
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        name::        No table opened.
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        showcache::        The Table Cache is empty.
23-Feb-2025 16:29:09 test_tool_image_pbcor.py::ia_pbcor_test::test_empty_region_and_stokes
23-Feb-2025 16:29:09 Test specifying stokes with empty region works (CAS-11708)
23-Feb-2025 16:29:09 PASSED
23-Feb-2025 16:29:09
23-Feb-2025 16:29:09 2025-02-23 21:29:09        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Exception Reported: Exception: File name is empty.
23-Feb-2025 16:29:09 2025-02-23 21:29:09        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)+        ... thrown by static void casa::ImageFactory::_checkInfile(const casacore::String&) at File: /source/casa6/casatools/src/code/imageanalysis/ImageAnalysis/ImageFactory2.cc, line: 371
23-Feb-2025 16:29:09 2025-02-23 21:29:09        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Exception Reported: Exception: File totally_bogus does not exist..
23-Feb-2025 16:29:09 2025-02-23 21:29:09        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)+        ... thrown by static void casa::ImageFactory::_checkInfile(const casacore::String&) at File: /source/casa6/casatools/src/code/imageanalysis/ImageAnalysis/ImageFactory2.cc, line: 375
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:09        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Exception: The image filename is empty.
23-Feb-2025 16:29:09 2025-02-23 21:29:09        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)+        ... thrown by static void casacore::ImageUtilities::openImage(casacore::ImageInterface<T>*&, const casacore::String&) [with T = float] at File: /source/casainstall/include/casacore/images/Images/ImageUtilities2.tcc, line: 255
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:09        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Exception: File 'totally_bogus2' does not exist.
23-Feb-2025 16:29:09 2025-02-23 21:29:09        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)+        ... thrown by static void casacore::ImageUtilities::openImage(casacore::ImageInterface<T>*&, const casacore::String&) [with T = float] at File: /source/casainstall/include/casacore/images/Images/ImageUtilities2.tcc, line: 260
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:09        SEVERE        ImageInputProcessor::_process        Requested output image /bogusplace/bogusimage cannot be created so will not be written
23-Feb-2025 16:29:09 2025-02-23 21:29:09        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: 2025-02-23 21:29:09        SEVERE        ImageInputProcessor::_process        Requested output image /bogusplace/bogusimage cannot be created so will not be written
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:09        WARN                /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/pbtest1_im.fits is not a valid or readable table
23-Feb-2025 16:29:09 2025-02-23 21:29:09        SEVERE                Cannot read image /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/pbtest1_im.fits to get region bogus_region
23-Feb-2025 16:29:09 2025-02-23 21:29:09        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Unable to open region file or region table description bogus_region in image /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/pbtest1_im.fits at File: /source/casa6/casatools/src/code/imageanalysis/Regions/CasacRegionManager.cc, line: 486
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:09        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Unknown mode zz
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:09        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Coordinate systems of image and template are different: The DirectionCoordinates have differing LinearXform components at File: /source/casa6/casatools/src/code/imageanalysis/ImageAnalysis/ImagePrimaryBeamCorrector.cc, line: 141
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        name::        No table opened.
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        showcache::        The Table Cache is empty.
23-Feb-2025 16:29:09 test_tool_image_pbcor.py::ia_pbcor_test::test_exceptions
23-Feb-2025 16:29:09 ia.pbcor: Test various exception cases
23-Feb-2025 16:29:09 PASSED
23-Feb-2025 16:29:09
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord        Selected bounding box :
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord        Selected bounding box :
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord        Selected bounding box :
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord        Selected bounding box :
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        name::        No table opened.
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        showcache::        The Table Cache is empty.
23-Feb-2025 16:29:09 test_tool_image_pbcor.py::ia_pbcor_test::test_full_image_divide
23-Feb-2025 16:29:09 ia.pbcor: Test full image divide
23-Feb-2025 16:29:09 PASSED
23-Feb-2025 16:29:09
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord        Selected bounding box :
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord        Selected bounding box :
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord        Selected bounding box :
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord        Selected bounding box :
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        name::        No table opened.
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        showcache::        The Table Cache is empty.
23-Feb-2025 16:29:09 test_tool_image_pbcor.py::ia_pbcor_test::test_full_image_using_cutoff
23-Feb-2025 16:29:09 ia.pbcor: Test full image divide with cutoff
23-Feb-2025 16:29:09 PASSED
23-Feb-2025 16:29:09
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ImageFactory::createImage        Created Paged image 'zz.im' of shape [20, 20] with float valued pixels.
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        SubImageFactory::createImage        Creating image 'pb_out.im' of shape [20, 20]
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ::::ImageFactory::createImage        Created Paged image 'zz.im' of shape [20, 20] with float valued pixels.
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ::::image::fromshape        Ran ia.fromshape
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ::::image::fromshape        ia.fromshape(outfile="zz.im", shape=[20,20], csys={...}, linear=false, overwrite=false, log=true, type="f")
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ::::image::pbcor        Ran ia.pbcor
23-Feb-2025 16:29:09 2025-02-23 21:29:09        INFO        ::::image::pbcor        ia.pbcor(pbimage="(...)", outfile="pb_out.im", overwrite=false, box="", region={...}, chans="", stokes="", mask="", mode="divide", cutoff=-1.000000, stretch=false)
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        name::        No table opened.
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        showcache::        The Table Cache is empty.
23-Feb-2025 16:29:09 test_tool_image_pbcor.py::ia_pbcor_test::test_history
23-Feb-2025 16:29:09 Test history records are written
23-Feb-2025 16:29:09 PASSED
23-Feb-2025 16:29:09
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        ImageFactory::createImage        Created Paged image 'mult_pb.im' of shape [113, 76] with float valued pixels.
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        ImageRegion::fromRecord        Selected bounding box :
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        ImageRegion::fromRecord        Selected bounding box :
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        ImageRegion::fromRecord        Selected bounding box :
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 0, 0]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, I)
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        ImageRegion::fromRecord        Selected bounding box :
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        ImageRegion::fromRecord        Selected bounding box :
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        name::        No table opened.
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        showcache::        The Table Cache is empty.
23-Feb-2025 16:29:09 test_tool_image_pbcor.py::ia_pbcor_test::test_multiply
23-Feb-2025 16:29:09 ia.pbcor: Test full image multiply with cutoff. Primary beam is 2 D, image is 4 D
23-Feb-2025 16:29:09 PASSED
23-Feb-2025 16:29:09
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        ImageFactory::createImage        Created Temp image  of shape [113, 76, 1, 1] with float valued pixels.
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        SubImageFactory::createImage        Creating image 'maskim' of shape [113, 76, 1, 1]
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:10        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: The input image shape ([113, 76, 5, 2]) and mask shape ([113, 76, 1, 1]) are different, and it was specified that the mask should not be extended, so the mask cannot be applied to the (sub)image. Specifying that the mask should be extended may resolve the issue at File: /source/casainstall/include/casacpp/imageanalysis/ImageAnalysis/SubImageFactory.tcc, line: 306
23-Feb-2025 16:29:09 2025-02-23 21:29:10        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        SubImageFactory::createImage        Creating image 'blahblah' of shape [113, 76, 5, 2]
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        name::        No table opened.
23-Feb-2025 16:29:09 2025-02-23 21:29:10        INFO        showcache::        The Table Cache is empty.
23-Feb-2025 16:29:09 test_tool_image_pbcor.py::ia_pbcor_test::test_stretch
23-Feb-2025 16:29:09 ia.pbcor(): Test stretch parameter
23-Feb-2025 16:29:09 PASSED
23-Feb-2025 16:29:09
23-Feb-2025 16:29:09 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_pbcor/nose.xml -
23-Feb-2025 16:29:09 ======================== 9 passed, 4 warnings in 2.17s =========================
23-Feb-2025 16:29:10 ============================= test session starts ==============================
23-Feb-2025 16:29:10 platform linux -- Python 3.12.6, pytest-8.3.4, pluggy-1.5.0 -- /home/casatest/venv/bin/python3.12
23-Feb-2025 16:29:10 cachedir: .pytest_cache
23-Feb-2025 16:29:10 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_createmultims
23-Feb-2025 16:29:10 configfile: pytest.ini
23-Feb-2025 16:29:10 collecting ... collected 1 item
23-Feb-2025 16:29:10
23-Feb-2025 16:29:10
23-Feb-2025 16:29:12 2025-02-23 21:29:13        INFO        ms::createmultims        Copying subtables from part1.ms to the other MMS members.
23-Feb-2025 16:29:19 2025-02-23 21:29:19        INFO        name::        No table opened.
23-Feb-2025 16:29:19 2025-02-23 21:29:19        INFO        name::        No table opened.
23-Feb-2025 16:29:19 test_tool_ms_createmultims.py::test_createmultims::test1
23-Feb-2025 16:29:19 Test_createmultims 1: 4 parts, same sources but different spws
23-Feb-2025 16:29:19 Copying part1.ms
23-Feb-2025 16:29:19 Copying part2-mod.ms
23-Feb-2025 16:29:19 Copying part2-mod2.ms
23-Feb-2025 16:29:19 Copying part2.ms
23-Feb-2025 16:29:19 Copying part3.ms
23-Feb-2025 16:29:19 Copying part4.ms
23-Feb-2025 16:29:19 PASSED
23-Feb-2025 16:29:19
23-Feb-2025 16:29:19 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_ms_createmultims/nose.xml -
23-Feb-2025 16:29:19 ======================== 1 passed, 4 warnings in 9.03s =========================
23-Feb-2025 16:29:19 ============================= test session starts ==============================
23-Feb-2025 16:29:19 platform linux -- Python 3.12.6, pytest-8.3.4, pluggy-1.5.0 -- /home/casatest/venv/bin/python3.12
23-Feb-2025 16:29:19 cachedir: .pytest_cache
23-Feb-2025 16:29:19 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_transpose
23-Feb-2025 16:29:19 configfile: pytest.ini
23-Feb-2025 16:29:20 collecting ... collected 6 items
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        SubImageFactory::createImage        Creating image 'blahxx.im' of shape [1536, 1536, 1, 2]
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        name::        No table opened.
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        showcache::        The Table Cache is empty.
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        name::        No table opened.
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        showcache::        The Table Cache is empty.
23-Feb-2025 16:29:20 test_tool_image_transpose.py::ia_transpose_test::test_cas_2364
23-Feb-2025 16:29:20 test CAS-2364 fix
23-Feb-2025 16:29:20 PASSED
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Exception Reported: Exception: File name is empty.
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)+        ... thrown by static void casa::ImageFactory::_checkInfile(const casacore::String&) at File: /source/casa6/casatools/src/code/imageanalysis/ImageAnalysis/ImageFactory2.cc, line: 371
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        ImageTransposer::_getOrder        Image has 3 axes but 2 were given for reordering. Number of axes to reorder must match the number of image axes
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        image::transpose (file src/tools/image/image_cmpt.cc, line 6478)        Exception Reported: 2025-02-23 21:29:20        SEVERE        ImageTransposer::_getOrder        Image has 3 axes but 2 were given for reordering. Number of axes to reorder must match the number of image axes
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        ImageTransposer::_getOrder        Axis number 0 specified multiple times in order parameter 10 . It can only be specified once.
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        image::transpose (file src/tools/image/image_cmpt.cc, line 6478)        Exception Reported: 2025-02-23 21:29:20        SEVERE        ImageTransposer::_getOrder        Axis number 0 specified multiple times in order parameter 10 . It can only be specified once.
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        CoordinateSystem::getWorldAxesOrder (file /source/casa6/casatools/casacore/coordinates/Coordinates/CoordinateSystem.cc, line 4665)        Image has 3 axes but 2 were given. Number of given axes must match the number of image axes
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        image::transpose (file src/tools/image/image_cmpt.cc, line 6478)        Exception Reported: 2025-02-23 21:29:20        SEVERE        CoordinateSystem::getWorldAxesOrder (file /source/casa6/casatools/casacore/coordinates/Coordinates/CoordinateSystem.cc, line 4665)        Image has 3 axes but 2 were given. Number of given axes must match the number of image axes
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        ImageTransposer::_getOrder        Image does not contain zero-based axis number 3 but this was incorrectly specified in order parameter. 123 All digits in the order parameter must be greater than or equal to zero and less than the number of image axes.
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        image::transpose (file src/tools/image/image_cmpt.cc, line 6478)        Exception Reported: 2025-02-23 21:29:20        SEVERE        ImageTransposer::_getOrder        Image does not contain zero-based axis number 3 but this was incorrectly specified in order parameter. 123 All digits in the order parameter must be greater than or equal to zero and less than the number of image axes.
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        ImageTransposer::_getOrder        Image has 3 axes but 5 were given for reordering. Number of axes to reorder must match the number of image axes
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        image::transpose (file src/tools/image/image_cmpt.cc, line 6478)        Exception Reported: 2025-02-23 21:29:20        SEVERE        ImageTransposer::_getOrder        Image has 3 axes but 5 were given for reordering. Number of axes to reorder must match the number of image axes
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        CoordinateSystem::getWorldAxesOrder (file /source/casa6/casatools/casacore/coordinates/Coordinates/CoordinateSystem.cc, line 4665)        Image has 3 axes but 4 were given. Number of given axes must match the number of image axes
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        image::transpose (file src/tools/image/image_cmpt.cc, line 6478)        Exception Reported: 2025-02-23 21:29:20        SEVERE        CoordinateSystem::getWorldAxesOrder (file /source/casa6/casatools/casacore/coordinates/Coordinates/CoordinateSystem.cc, line 4665)        Image has 3 axes but 4 were given. Number of given axes must match the number of image axes
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        ImageTransposer::_getOrder        Image does not contain zero-based axis number 3 but this was incorrectly specified in order parameter. 123 All digits in the order parameter must be greater than or equal to zero and less than the number of image axes.
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        image::transpose (file src/tools/image/image_cmpt.cc, line 6478)        Exception Reported: 2025-02-23 21:29:20        SEVERE        ImageTransposer::_getOrder        Image does not contain zero-based axis number 3 but this was incorrectly specified in order parameter. 123 All digits in the order parameter must be greater than or equal to zero and less than the number of image axes.
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        CoordinateSystem::getWorldAxesOrder (file /source/casa6/casatools/casacore/coordinates/Coordinates/CoordinateSystem.cc, line 4665)        No axis matches requested axis s. Image axis names are [right ascension, declination, frequency]
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        image::transpose (file src/tools/image/image_cmpt.cc, line 6478)        Exception Reported: 2025-02-23 21:29:20        SEVERE        CoordinateSystem::getWorldAxesOrder (file /source/casa6/casatools/casacore/coordinates/Coordinates/CoordinateSystem.cc, line 4665)        No axis matches requested axis s. Image axis names are [right ascension, declination, frequency]
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        CoordinateSystem::getWorldAxesOrder (file /source/casa6/casatools/casacore/coordinates/Coordinates/CoordinateSystem.cc, line 4665)        Ambiguous axis specification. Both r and r match image axis name right ascension
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        image::transpose (file src/tools/image/image_cmpt.cc, line 6478)        Exception Reported: 2025-02-23 21:29:20        SEVERE        CoordinateSystem::getWorldAxesOrder (file /source/casa6/casatools/casacore/coordinates/Coordinates/CoordinateSystem.cc, line 4665)        Ambiguous axis specification. Both r and r match image axis name right ascension
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        ImageTransposer::_getOrder        Image does not contain zero-based axis number 3 but this was incorrectly specified in order parameter. 103 All digits in the order parameter must be greater than or equal to zero and less than the number of image axes.
23-Feb-2025 16:29:20 2025-02-23 21:29:20        SEVERE        image::transpose (file src/tools/image/image_cmpt.cc, line 6478)        Exception Reported: 2025-02-23 21:29:20        SEVERE        ImageTransposer::_getOrder        Image does not contain zero-based axis number 3 but this was incorrectly specified in order parameter. 103 All digits in the order parameter must be greater than or equal to zero and less than the number of image axes.
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        name::        No table opened.
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        showcache::        The Table Cache is empty.
23-Feb-2025 16:29:20 test_tool_image_transpose.py::ia_transpose_test::test_exceptions
23-Feb-2025 16:29:20 imtrans: Test various exception cases
23-Feb-2025 16:29:20 PASSED
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        ImageFactory::createImage        Created Temp image  of shape [10, 10, 4, 10] with float valued pixels.
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        ::::ImageFactory::createImage        Created Temp image  of shape [10, 10, 4, 10] with float valued pixels.
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        ::::image::fromshape        Ran ia.fromshape
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        ::::image::fromshape        ia.fromshape(outfile="", shape=[10,10,4,10], csys={...}, linear=false, overwrite=false, log=true, type="f")
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        ::::image::transpose        Ran ia.transpose
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        ::::image::transpose        ia.transpose(outfile="", order="3210")
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        name::        No table opened.
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        showcache::        The Table Cache is empty.
23-Feb-2025 16:29:20 test_tool_image_transpose.py::ia_transpose_test::test_history
23-Feb-2025 16:29:20 Test history records are written
23-Feb-2025 16:29:20 PASSED
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        ImageFactory::createImage        Created Temp image  of shape [10, 20, 30] with float valued pixels.
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        image::_casaQuantityFromVar         Will use values specified in major, minor, pa to set beam
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        BeamManipulator::set        Setting (global) restoring beam.
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        BeamManipulator::set        Beam parameters:  Major          : 4 arcmin
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        BeamManipulator::set+          Minor          : 3 arcmin
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        BeamManipulator::set+          Position Angle : 0 deg
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        name::        No table opened.
23-Feb-2025 16:29:20 2025-02-23 21:29:20        INFO        showcache::        The Table Cache is empty.
23-Feb-2025 16:29:20 test_tool_image_transpose.py::ia_transpose_test::test_imageinfo
23-Feb-2025 16:29:20 Verify image info is copied
23-Feb-2025 16:29:20 PASSED
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 2025-02-23 21:29:21        INFO        SubImageFactory::createImage        Creating image 'straight_copy_0' of shape [5, 6, 7]
23-Feb-2025 16:29:20 2025-02-23 21:29:21        INFO        SubImageFactory::createImage        Creating image 'straight_copy_1' of shape [5, 6, 7]
23-Feb-2025 16:29:20 2025-02-23 21:29:21        INFO        SubImageFactory::createImage        Creating image 'straight_copy_2' of shape [5, 6, 7]
23-Feb-2025 16:29:20 2025-02-23 21:29:21        INFO        ImageTransposer::transpose        Old to new axis mapping is [0, 1, 2]
23-Feb-2025 16:29:20 2025-02-23 21:29:21        INFO        SubImageFactory::createImage        Creating image 'straight_copy_3' of shape [5, 6, 7]
23-Feb-2025 16:29:20 2025-02-23 21:29:21        INFO        ImageTransposer::transpose        Old to new axis mapping is [0, 1, 2]
23-Feb-2025 16:29:20 2025-02-23 21:29:21        INFO        name::        No table opened.
23-Feb-2025 16:29:20 2025-02-23 21:29:21        INFO        showcache::        The Table Cache is empty.
23-Feb-2025 16:29:20 test_tool_image_transpose.py::ia_transpose_test::test_straight_copy
23-Feb-2025 16:29:20 No actual transposing
23-Feb-2025 16:29:20 PASSED
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 2025-02-23 21:29:21        INFO        SubImageFactory::createImage        Creating image 'transpose_0' of shape [6, 7, 5]
23-Feb-2025 16:29:20 2025-02-23 21:29:21        INFO        SubImageFactory::createImage        Creating image 'transpose_1' of shape [6, 7, 5]
23-Feb-2025 16:29:20 2025-02-23 21:29:21        INFO        SubImageFactory::createImage        Creating image 'transpose_2' of shape [6, 7, 5]
23-Feb-2025 16:29:20 2025-02-23 21:29:21        INFO        ImageTransposer::transpose        Old to new axis mapping is [1, 2, 0]
23-Feb-2025 16:29:20 2025-02-23 21:29:21        INFO        ImageTransposer::transpose        Old to new axis mapping is [1, 2, 0]
23-Feb-2025 16:29:20 2025-02-23 21:29:21        INFO        SubImageFactory::createImage        Creating image 'transpose_3' of shape [6, 7, 5]
23-Feb-2025 16:29:20 2025-02-23 21:29:21        INFO        ImageTransposer::transpose        Old to new axis mapping is [1, 2, 0]
23-Feb-2025 16:29:20 2025-02-23 21:29:21        INFO        ImageTransposer::transpose        Old to new axis mapping is [1, 2, 0]
23-Feb-2025 16:29:20 2025-02-23 21:29:21        INFO        name::        No table opened.
23-Feb-2025 16:29:20 2025-02-23 21:29:21        INFO        showcache::        The Table Cache is empty.
23-Feb-2025 16:29:20 test_tool_image_transpose.py::ia_transpose_test::test_transpose
23-Feb-2025 16:29:20 Test transposing
23-Feb-2025 16:29:20 PASSED
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_transpose/nose.xml -
23-Feb-2025 16:29:20 ======================== 6 passed, 4 warnings in 1.22s =========================
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/
23-Feb-2025 16:29:20 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 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/
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_statwt/
23-Feb-2025 16:29:20 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_statwt
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 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/
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_quanta/
23-Feb-2025 16:29:20 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_quanta
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_quanta/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_quanta/
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_deviation/
23-Feb-2025 16:29:20 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_deviation
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 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/
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_coordsys/
23-Feb-2025 16:29:20 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_coordsys
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_coordsys/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_coordsys/
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image/
23-Feb-2025 16:29:20 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image/
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_table/
23-Feb-2025 16:29:20 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_table
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_table/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_table/
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager/
23-Feb-2025 16:29:20 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 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/
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_measures/
23-Feb-2025 16:29:20 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_measures
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_measures/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_measures/
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_regrid/
23-Feb-2025 16:29:20 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_regrid
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 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/
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_synthesisutils/
23-Feb-2025 16:29:20 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_synthesisutils
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 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/
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_collapse/
23-Feb-2025 16:29:20 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_collapse
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_collapse/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_collapse/
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_simulator/
23-Feb-2025 16:29:20 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_simulator
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 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/
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv/
23-Feb-2025 16:29:20 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 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/
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_agentflagger/
23-Feb-2025 16:29:20 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_agentflagger
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 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/
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/
23-Feb-2025 16:29:20 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_pbcor/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_createmultims/
23-Feb-2025 16:29:20 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_createmultims
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 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/
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_transpose/
23-Feb-2025 16:29:20 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_transpose
23-Feb-2025 16:29:20
23-Feb-2025 16:29:20 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_transpose/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_transpose/
23-Feb-2025 16:29:22 total 178740
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci 15001    135100 Feb 23 21:13 casatestutils-6.7.0.31-py3-none-any.whl
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci 15001 182723987 Feb 23 21:13 casatools-6.7.0.31-cp312-cp312-manylinux_2_28_x86_64.whl
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       4320 Feb 23 21:29 test_tool_agentflagger.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        986 Feb 23 21:29 test_tool_calanalysis.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       2638 Feb 23 21:29 test_tool_calibrater.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        667 Feb 23 21:29 test_tool_componentlist.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       7447 Feb 23 21:29 test_tool_coordsys.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root      12915 Feb 23 21:29 test_tool_image.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       2200 Feb 23 21:29 test_tool_image_collapse.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       1028 Feb 23 21:29 test_tool_image_deviation.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       2555 Feb 23 21:29 test_tool_image_fitprofile.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       1158 Feb 23 21:29 test_tool_image_pbcor.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        863 Feb 23 21:29 test_tool_image_pv.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        986 Feb 23 21:29 test_tool_image_rebin.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       1316 Feb 23 21:29 test_tool_image_regrid.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       1513 Feb 23 21:29 test_tool_image_statistics.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        745 Feb 23 21:29 test_tool_image_subimage.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        870 Feb 23 21:29 test_tool_image_transpose.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       1946 Feb 23 21:29 test_tool_imagepol.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        819 Feb 23 21:29 test_tool_linearmosaic.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        648 Feb 23 21:29 test_tool_logsink.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        529 Feb 23 21:29 test_tool_measures.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       5204 Feb 23 21:29 test_tool_ms.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        347 Feb 23 21:29 test_tool_ms_createmultims.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       2075 Feb 23 21:29 test_tool_ms_statwt.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       8613 Feb 23 21:29 test_tool_msmetadata.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        339 Feb 23 21:29 test_tool_msuvbinner.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       1151 Feb 23 21:29 test_tool_quanta.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       3957 Feb 23 21:29 test_tool_regionmanager.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       2052 Feb 23 21:29 test_tool_sdm.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       2076 Feb 23 21:29 test_tool_sdm_toms.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        428 Feb 23 21:29 test_tool_simulator.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       1697 Feb 23 21:29 test_tool_synthesisutils.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       1442 Feb 23 21:29 test_tool_table.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       1697 Feb 23 21:29 test_tool_vpmanager.xml
23-Feb-2025 16:29:22 Finished task 'Test wheel' with result: Success
23-Feb-2025 16:29:22 Starting task 'Tar work directory' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
23-Feb-2025 16:29:22
Beginning to execute external process for build 'CASASPECS - Release 6.7.0 Test 3.12 - release-6.7.0 - Test Tools Many Linux 2.28 Rocky 8.10 Py3.12 #2 (CASASPECS-RELEASE670TESTPY3120-TTOMLPY38-2)'
... running command line:
/export/home/cbt-el7-2/bamboohome/temp/CASASPECS-RELEASE670TESTPY3120-TTOMLPY38-2-ScriptBuildTask-4656879018403471558.sh
... in: /export/home/cbt-el7-2/bamboohome/xml-data/build-dir/CASASPECS-RELEASE670TESTPY3120-TTOMLPY38
23-Feb-2025 16:29:22 Package working directory
23-Feb-2025 16:29:22 tar: nosedir: Cannot stat: No such file or directory
23-Feb-2025 16:29:22 tar: Exiting with failure status due to previous errors
23-Feb-2025 16:29:22 total 178744
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci 15001    135100 Feb 23 21:13 casatestutils-6.7.0.31-py3-none-any.whl
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci 15001 182723987 Feb 23 21:13 casatools-6.7.0.31-cp312-cp312-manylinux_2_28_x86_64.whl
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       4320 Feb 23 21:29 test_tool_agentflagger.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        986 Feb 23 21:29 test_tool_calanalysis.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       2638 Feb 23 21:29 test_tool_calibrater.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        667 Feb 23 21:29 test_tool_componentlist.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       7447 Feb 23 21:29 test_tool_coordsys.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root      12915 Feb 23 21:29 test_tool_image.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       2200 Feb 23 21:29 test_tool_image_collapse.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       1028 Feb 23 21:29 test_tool_image_deviation.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       2555 Feb 23 21:29 test_tool_image_fitprofile.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       1158 Feb 23 21:29 test_tool_image_pbcor.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        863 Feb 23 21:29 test_tool_image_pv.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        986 Feb 23 21:29 test_tool_image_rebin.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       1316 Feb 23 21:29 test_tool_image_regrid.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       1513 Feb 23 21:29 test_tool_image_statistics.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        745 Feb 23 21:29 test_tool_image_subimage.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        870 Feb 23 21:29 test_tool_image_transpose.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       1946 Feb 23 21:29 test_tool_imagepol.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        819 Feb 23 21:29 test_tool_linearmosaic.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        648 Feb 23 21:29 test_tool_logsink.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        529 Feb 23 21:29 test_tool_measures.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       5204 Feb 23 21:29 test_tool_ms.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        347 Feb 23 21:29 test_tool_ms_createmultims.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       2075 Feb 23 21:29 test_tool_ms_statwt.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       8613 Feb 23 21:29 test_tool_msmetadata.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        339 Feb 23 21:29 test_tool_msuvbinner.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       1151 Feb 23 21:29 test_tool_quanta.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       3957 Feb 23 21:29 test_tool_regionmanager.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       2052 Feb 23 21:29 test_tool_sdm.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       2076 Feb 23 21:29 test_tool_sdm_toms.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root        428 Feb 23 21:29 test_tool_simulator.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       1697 Feb 23 21:29 test_tool_synthesisutils.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       1442 Feb 23 21:29 test_tool_table.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root       1697 Feb 23 21:29 test_tool_vpmanager.xml
23-Feb-2025 16:29:22 -rw-r--r-- 1 casaci root         45 Feb 23 21:29 work-manylinux228-3.12.tar.gz
23-Feb-2025 16:29:22 Done packaging working directory
23-Feb-2025 16:29:22 Finished task 'Tar work directory' with result: Success
23-Feb-2025 16:29:22 Starting task 'Parse tests' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
23-Feb-2025 16:29:22 Parsing test results under /export/home/cbt-el7-2/bamboohome/xml-data/build-dir/CASASPECS-RELEASE670TESTPY3120-TTOMLPY38...
23-Feb-2025 16:29:22 Finished task 'Parse tests' with result: Success
23-Feb-2025 16:29:22 Starting task 'Upload wheel' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
23-Feb-2025 16:29:22
Beginning to execute external process for build 'CASASPECS - Release 6.7.0 Test 3.12 - release-6.7.0 - Test Tools Many Linux 2.28 Rocky 8.10 Py3.12 #2 (CASASPECS-RELEASE670TESTPY3120-TTOMLPY38-2)'
... running command line:
/export/home/cbt-el7-2/bamboohome/temp/CASASPECS-RELEASE670TESTPY3120-TTOMLPY38-2-ScriptBuildTask-7427346338945141531.sh
... in: /export/home/cbt-el7-2/bamboohome/xml-data/build-dir/CASASPECS-RELEASE670TESTPY3120-TTOMLPY38
23-Feb-2025 16:29:23 Collecting twine
23-Feb-2025 16:29:23   Downloading twine-6.1.0-py3-none-any.whl (40 kB)
23-Feb-2025 16:29:23      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 40.8/40.8 kB 5.3 MB/s eta 0:00:00
23-Feb-2025 16:29:23 Collecting id
23-Feb-2025 16:29:23   Downloading id-1.5.0-py3-none-any.whl (13 kB)
23-Feb-2025 16:29:23 Collecting readme-renderer>=35.0
23-Feb-2025 16:29:23   Downloading readme_renderer-44.0-py3-none-any.whl (13 kB)
23-Feb-2025 16:29:23 Collecting keyring>=15.1
23-Feb-2025 16:29:23   Downloading keyring-25.6.0-py3-none-any.whl (39 kB)
23-Feb-2025 16:29:24 Collecting packaging>=24.0
23-Feb-2025 16:29:24   Downloading packaging-24.2-py3-none-any.whl (65 kB)
23-Feb-2025 16:29:24      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 65.5/65.5 kB 8.0 MB/s eta 0:00:00
23-Feb-2025 16:29:24 Collecting urllib3>=1.26.0
23-Feb-2025 16:29:24   Downloading urllib3-2.3.0-py3-none-any.whl (128 kB)
23-Feb-2025 16:29:24      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 128.4/128.4 kB 13.7 MB/s eta 0:00:00
23-Feb-2025 16:29:24 Collecting rich>=12.0.0
23-Feb-2025 16:29:24   Downloading rich-13.9.4-py3-none-any.whl (242 kB)
23-Feb-2025 16:29:24      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 242.4/242.4 kB 18.4 MB/s eta 0:00:00
23-Feb-2025 16:29:24 Collecting rfc3986>=1.4.0
23-Feb-2025 16:29:24   Downloading rfc3986-2.0.0-py2.py3-none-any.whl (31 kB)
23-Feb-2025 16:29:24 Collecting requests-toolbelt!=0.9.0,>=0.8.0
23-Feb-2025 16:29:24   Downloading requests_toolbelt-1.0.0-py2.py3-none-any.whl (54 kB)
23-Feb-2025 16:29:24      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 54.5/54.5 kB 7.9 MB/s eta 0:00:00
23-Feb-2025 16:29:24 Collecting requests>=2.20
23-Feb-2025 16:29:24   Downloading requests-2.32.3-py3-none-any.whl (64 kB)
23-Feb-2025 16:29:24      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.9/64.9 kB 11.6 MB/s eta 0:00:00
23-Feb-2025 16:29:24 Collecting jeepney>=0.4.2
23-Feb-2025 16:29:24   Downloading jeepney-0.8.0-py3-none-any.whl (48 kB)
23-Feb-2025 16:29:24      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 48.4/48.4 kB 9.2 MB/s eta 0:00:00
23-Feb-2025 16:29:24 Collecting importlib_metadata>=4.11.4
23-Feb-2025 16:29:24   Downloading importlib_metadata-8.6.1-py3-none-any.whl (26 kB)
23-Feb-2025 16:29:24 Collecting SecretStorage>=3.2
23-Feb-2025 16:29:24   Downloading SecretStorage-3.3.3-py3-none-any.whl (15 kB)
23-Feb-2025 16:29:25 Collecting jaraco.functools
23-Feb-2025 16:29:25   Downloading jaraco.functools-4.1.0-py3-none-any.whl (10 kB)
23-Feb-2025 16:29:25 Collecting jaraco.context
23-Feb-2025 16:29:25   Downloading jaraco.context-6.0.1-py3-none-any.whl (6.8 kB)
23-Feb-2025 16:29:25 Collecting jaraco.classes
23-Feb-2025 16:29:25   Downloading jaraco.classes-3.4.0-py3-none-any.whl (6.8 kB)
23-Feb-2025 16:29:25 Collecting docutils>=0.21.2
23-Feb-2025 16:29:25   Downloading docutils-0.21.2-py3-none-any.whl (587 kB)
23-Feb-2025 16:29:25      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 587.4/587.4 kB 19.6 MB/s eta 0:00:00
23-Feb-2025 16:29:25 Collecting nh3>=0.2.14
23-Feb-2025 16:29:25   Downloading nh3-0.2.20-cp38-abi3-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (744 kB)
23-Feb-2025 16:29:25      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 744.4/744.4 kB 26.7 MB/s eta 0:00:00
23-Feb-2025 16:29:25 Collecting Pygments>=2.5.1
23-Feb-2025 16:29:25   Downloading pygments-2.19.1-py3-none-any.whl (1.2 MB)
23-Feb-2025 16:29:25      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.2/1.2 MB 30.0 MB/s eta 0:00:00
23-Feb-2025 16:29:25 Collecting idna<4,>=2.5
23-Feb-2025 16:29:25   Downloading idna-3.10-py3-none-any.whl (70 kB)
23-Feb-2025 16:29:25      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 70.4/70.4 kB 12.7 MB/s eta 0:00:00
23-Feb-2025 16:29:25 Collecting charset-normalizer<4,>=2
23-Feb-2025 16:29:25   Downloading charset_normalizer-3.4.1-cp310-cp310-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (146 kB)
23-Feb-2025 16:29:25      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 146.1/146.1 kB 25.7 MB/s eta 0:00:00
23-Feb-2025 16:29:26 Collecting certifi>=2017.4.17
23-Feb-2025 16:29:26   Downloading certifi-2025.1.31-py3-none-any.whl (166 kB)
23-Feb-2025 16:29:26      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 166.4/166.4 kB 24.3 MB/s eta 0:00:00
23-Feb-2025 16:29:26 Collecting typing-extensions<5.0,>=4.0.0
23-Feb-2025 16:29:26   Downloading typing_extensions-4.12.2-py3-none-any.whl (37 kB)
23-Feb-2025 16:29:26 Collecting markdown-it-py>=2.2.0
23-Feb-2025 16:29:26   Downloading markdown_it_py-3.0.0-py3-none-any.whl (87 kB)
23-Feb-2025 16:29:26      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 87.5/87.5 kB 13.8 MB/s eta 0:00:00
23-Feb-2025 16:29:26 Collecting zipp>=3.20
23-Feb-2025 16:29:26   Downloading zipp-3.21.0-py3-none-any.whl (9.6 kB)
23-Feb-2025 16:29:26 Collecting mdurl~=0.1
23-Feb-2025 16:29:26   Downloading mdurl-0.1.2-py3-none-any.whl (10.0 kB)
23-Feb-2025 16:29:27 Collecting cryptography>=2.0
23-Feb-2025 16:29:27   Downloading cryptography-44.0.1-cp39-abi3-manylinux_2_28_x86_64.whl (4.2 MB)
23-Feb-2025 16:29:27      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.2/4.2 MB 30.4 MB/s eta 0:00:00
23-Feb-2025 16:29:27 Collecting more-itertools
23-Feb-2025 16:29:27   Downloading more_itertools-10.6.0-py3-none-any.whl (63 kB)
23-Feb-2025 16:29:27      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 63.0/63.0 kB 12.7 MB/s eta 0:00:00
23-Feb-2025 16:29:27 Collecting backports.tarfile
23-Feb-2025 16:29:27   Downloading backports.tarfile-1.2.0-py3-none-any.whl (30 kB)
23-Feb-2025 16:29:27 Collecting cffi>=1.12
23-Feb-2025 16:29:27   Downloading cffi-1.17.1-cp310-cp310-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (446 kB)
23-Feb-2025 16:29:27      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 446.2/446.2 kB 30.9 MB/s eta 0:00:00
23-Feb-2025 16:29:28 Collecting pycparser
23-Feb-2025 16:29:28   Downloading pycparser-2.22-py3-none-any.whl (117 kB)
23-Feb-2025 16:29:28      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 117.6/117.6 kB 14.5 MB/s eta 0:00:00
23-Feb-2025 16:29:28 Installing collected packages: zipp, urllib3, typing-extensions, rfc3986, Pygments, pycparser, packaging, nh3, 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, id, cryptography, SecretStorage, keyring, twine
23-Feb-2025 16:29:31 Successfully installed Pygments-2.19.1 SecretStorage-3.3.3 backports.tarfile-1.2.0 certifi-2025.1.31 cffi-1.17.1 charset-normalizer-3.4.1 cryptography-44.0.1 docutils-0.21.2 id-1.5.0 idna-3.10 importlib_metadata-8.6.1 jaraco.classes-3.4.0 jaraco.context-6.0.1 jaraco.functools-4.1.0 jeepney-0.8.0 keyring-25.6.0 markdown-it-py-3.0.0 mdurl-0.1.2 more-itertools-10.6.0 nh3-0.2.20 packaging-24.2 pycparser-2.22 readme-renderer-44.0 requests-2.32.3 requests-toolbelt-1.0.0 rfc3986-2.0.0 rich-13.9.4 twine-6.1.0 typing-extensions-4.12.2 urllib3-2.3.0 zipp-3.21.0
23-Feb-2025 16:29:31 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
23-Feb-2025 16:29:31
23-Feb-2025 16:29:31 [notice] A new release of pip is available: 23.0.1 -> 25.0.1
23-Feb-2025 16:29:31 [notice] To update, run: pip3 install --upgrade pip
23-Feb-2025 16:29:32 Cloning into 'casa-build-utils'...
23-Feb-2025 16:29:33 Uploading distributions to
23-Feb-2025 16:29:33 https://casa-pip.nrao.edu:443/repository/casa-test-wheel/
23-Feb-2025 16:29:34 Uploading casatools-6.7.0.31-cp312-cp312-manylinux_2_28_x86_64.whl
23-Feb-2025 16:29:34
23-Feb-2025 16:29:35   0% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 0.0/182.7 MB--:--?
23-Feb-2025 16:29:35   1% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.4/182.7 MB00:1117.3 MB/s
23-Feb-2025 16:29:35   2% ╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 3.3/182.7 MB00:1117.9 MB/s
23-Feb-2025 16:29:35   3% ━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.1/182.7 MB00:1017.8 MB/s
23-Feb-2025 16:29:35   4% ━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.9/182.7 MB00:1117.6 MB/s
23-Feb-2025 16:29:35   5% ━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 8.8/182.7 MB00:1017.6 MB/s
23-Feb-2025 16:29:35   6% ━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 11.0/182.7 MB00:1018.2 MB/s
23-Feb-2025 16:29:35   8% ━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 14.0/182.7 MB00:0919.8 MB/s
23-Feb-2025 16:29:35   9% ━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 17.0/182.7 MB00:0821.3 MB/s
23-Feb-2025 16:29:35 11% ━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 19.5/182.7 MB00:0822.1 MB/s
23-Feb-2025 16:29:36 13% ━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 23.6/182.7 MB00:0627.1 MB/s
23-Feb-2025 16:29:36 15% ━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 28.0/182.7 MB00:0532.7 MB/s
23-Feb-2025 16:29:36 18% ━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 32.2/182.7 MB00:0535.6 MB/s
23-Feb-2025 16:29:36 20% ━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 36.4/182.7 MB00:0440.8 MB/s
23-Feb-2025 16:29:36 22% ━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 39.4/182.7 MB00:0437.7 MB/s
23-Feb-2025 16:29:36 24% ━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 43.6/182.7 MB00:0437.5 MB/s
23-Feb-2025 16:29:36 25% ━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 46.3/182.7 MB00:0434.8 MB/s
23-Feb-2025 16:29:36 27% ━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 48.8/182.7 MB00:0532.3 MB/s
23-Feb-2025 16:29:36 28% ━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 51.4/182.7 MB00:0529.7 MB/s
23-Feb-2025 16:29:36 29% ━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 53.6/182.7 MB00:0530.7 MB/s
23-Feb-2025 16:29:37 31% ━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━━ 56.2/182.7 MB00:0526.9 MB/s
23-Feb-2025 16:29:37 32% ━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━━ 58.1/182.7 MB00:0624.6 MB/s
23-Feb-2025 16:29:37 33% ━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━━ 60.4/182.7 MB00:0623.0 MB/s
23-Feb-2025 16:29:37 34% ━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━━ 62.9/182.7 MB00:0623.2 MB/s
23-Feb-2025 16:29:37 36% ━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━━ 65.1/182.7 MB00:0622.8 MB/s
23-Feb-2025 16:29:37 36% ━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━━ 66.3/182.7 MB00:0621.4 MB/s
23-Feb-2025 16:29:37 38% ━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━━━ 68.5/182.7 MB00:0620.4 MB/s
23-Feb-2025 16:29:37 39% ━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━ 70.8/182.7 MB00:0621.4 MB/s
23-Feb-2025 16:29:37 40% ━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━━ 72.7/182.7 MB00:0620.2 MB/s
23-Feb-2025 16:29:38 41% ━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━ 75.6/182.7 MB00:0521.6 MB/s
23-Feb-2025 16:29:38 42% ━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━━ 76.7/182.7 MB00:0619.8 MB/s
23-Feb-2025 16:29:38 43% ━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━━ 78.9/182.7 MB00:0619.1 MB/s
23-Feb-2025 16:29:38 44% ━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━━ 80.8/182.7 MB00:0619.2 MB/s
23-Feb-2025 16:29:38 46% ━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━━ 83.2/182.7 MB00:0520.1 MB/s
23-Feb-2025 16:29:38 47% ━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━━ 85.7/182.7 MB00:0520.5 MB/s
23-Feb-2025 16:29:38 48% ━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━━━ 87.5/182.7 MB00:0519.7 MB/s
23-Feb-2025 16:29:38 49% ━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━ 89.7/182.7 MB00:0520.7 MB/s
23-Feb-2025 16:29:38 50% ━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━━ 91.4/182.7 MB00:0518.9 MB/s
23-Feb-2025 16:29:38 52% ━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━ 94.5/182.7 MB00:0521.3 MB/s
23-Feb-2025 16:29:39 52% ━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━━━ 95.5/182.7 MB00:0520.2 MB/s
23-Feb-2025 16:29:39 53% ━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━━ 97.6/182.7 MB00:0519.9 MB/s
23-Feb-2025 16:29:39 55% ━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━ 100.6/182.7 MB00:0420.5 MB/s
23-Feb-2025 16:29:39 56% ━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━━ 102.1/182.7 MB00:0519.4 MB/s
23-Feb-2025 16:29:39 57% ━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━━ 105.0/182.7 MB00:0421.5 MB/s
23-Feb-2025 16:29:39 58% ━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━━ 106.7/182.7 MB00:0420.7 MB/s
23-Feb-2025 16:29:39 60% ━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━━ 109.4/182.7 MB00:0421.3 MB/s
23-Feb-2025 16:29:39 61% ━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━━ 111.1/182.7 MB00:0421.1 MB/s
23-Feb-2025 16:29:39 62% ━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━━ 113.8/182.7 MB00:0422.3 MB/s
23-Feb-2025 16:29:40 64% ━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━━ 116.3/182.7 MB00:0422.0 MB/s
23-Feb-2025 16:29:40 64% ━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━━ 117.3/182.7 MB00:0421.4 MB/s
23-Feb-2025 16:29:40 66% ━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━━ 120.1/182.7 MB00:0320.9 MB/s
23-Feb-2025 16:29:40 67% ━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━━ 122.2/182.7 MB00:0321.4 MB/s
23-Feb-2025 16:29:40 69% ━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━━ 125.6/182.7 MB00:0321.8 MB/s
23-Feb-2025 16:29:40 70% ━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━━ 127.2/182.7 MB00:0322.2 MB/s
23-Feb-2025 16:29:40 71% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━━ 129.2/182.7 MB00:0321.8 MB/s
23-Feb-2025 16:29:40 72% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━━ 131.9/182.7 MB00:0321.9 MB/s
23-Feb-2025 16:29:40 73% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━━ 133.8/182.7 MB00:0322.9 MB/s
23-Feb-2025 16:29:40 75% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━━ 136.7/182.7 MB00:0323.0 MB/s
23-Feb-2025 16:29:41 75% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━━ 137.8/182.7 MB00:0321.2 MB/s
23-Feb-2025 16:29:41 77% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━━ 140.1/182.7 MB00:0221.9 MB/s
23-Feb-2025 16:29:41 78% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━━ 142.6/182.7 MB00:0222.5 MB/s
23-Feb-2025 16:29:41 80% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━━ 145.4/182.7 MB00:0222.5 MB/s
23-Feb-2025 16:29:41 81% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━━ 147.4/182.7 MB00:0221.9 MB/s
23-Feb-2025 16:29:41 82% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━━ 150.0/182.7 MB00:0223.0 MB/s
23-Feb-2025 16:29:41 84% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━━━ 152.7/182.7 MB00:0222.0 MB/s
23-Feb-2025 16:29:41 84% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━━ 154.2/182.7 MB00:0223.1 MB/s
23-Feb-2025 16:29:41 86% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━ 157.7/182.7 MB00:0223.1 MB/s
23-Feb-2025 16:29:42 87% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━━ 159.5/182.7 MB00:0123.8 MB/s
23-Feb-2025 16:29:42 88% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━━ 161.0/182.7 MB00:0123.2 MB/s
23-Feb-2025 16:29:42 90% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━━━ 164.0/182.7 MB00:0122.6 MB/s
23-Feb-2025 16:29:42 91% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━━ 166.1/182.7 MB00:0121.4 MB/s
23-Feb-2025 16:29:42 93% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━ 169.3/182.7 MB00:0123.6 MB/s
23-Feb-2025 16:29:42 93% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺━━ 170.7/182.7 MB00:0122.6 MB/s
23-Feb-2025 16:29:42 95% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━━ 173.1/182.7 MB00:0121.9 MB/s
23-Feb-2025 16:29:42 97% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸━ 176.8/182.7 MB00:0123.5 MB/s
23-Feb-2025 16:29:42 98% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╺ 179.2/182.7 MB00:0125.8 MB/s
23-Feb-2025 16:29:42 99% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━╸ 181.7/182.7 MB00:0123.2 MB/s
23-Feb-2025 16:29:43 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 182.7/182.7 MB00:0725.2 MB/s
23-Feb-2025 16:29:43 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 182.7/182.7 MB00:0725.2 MB/s
23-Feb-2025 16:29:43 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 182.7/182.7 MB00:0725.2 MB/s
23-Feb-2025 16:29:43 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 182.7/182.7 MB00:0725.2 MB/s
23-Feb-2025 16:29:43 WARNING Error during upload. Retry with the --verbose option for more details.
23-Feb-2025 16:29:43 ERROR    HTTPError: 400 Bad Request from                                       
23-Feb-2025 16:29:43          https://casa-pip.nrao.edu:443/repository/casa-test-wheel/             
23-Feb-2025 16:29:43          Repository does not allow updating assets: casa-test-wheel             
23-Feb-2025 16:29:43 Uploading distributions to
23-Feb-2025 16:29:43 https://casa-pip.nrao.edu:443/repository/casa-test-wheel/
23-Feb-2025 16:29:43 Uploading casatestutils-6.7.0.31-py3-none-any.whl
23-Feb-2025 16:29:43
23-Feb-2025 16:29:43   0% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 0.0/148.0 kB--:--?
23-Feb-2025 16:29:43 100% ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 148.0/148.0 kB00:007.5 MB/s
23-Feb-2025 16:29:43 WARNING Error during upload. Retry with the --verbose option for more details.
23-Feb-2025 16:29:43 ERROR    HTTPError: 400 Bad Request from                                       
23-Feb-2025 16:29:43          https://casa-pip.nrao.edu:443/repository/casa-test-wheel/             
23-Feb-2025 16:29:43          Repository does not allow updating assets: casa-test-wheel             
23-Feb-2025 16:29:44 Finished task 'Upload wheel' with result: Success
23-Feb-2025 16:29:44 Starting task 'Cleanup' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
23-Feb-2025 16:29:44
Beginning to execute external process for build 'CASASPECS - Release 6.7.0 Test 3.12 - release-6.7.0 - Test Tools Many Linux 2.28 Rocky 8.10 Py3.12 #2 (CASASPECS-RELEASE670TESTPY3120-TTOMLPY38-2)'
... running command line:
/export/home/cbt-el7-2/bamboohome/temp/CASASPECS-RELEASE670TESTPY3120-TTOMLPY38-2-ScriptBuildTask-9216633588146872685.sh
... in: /export/home/cbt-el7-2/bamboohome/xml-data/build-dir/CASASPECS-RELEASE670TESTPY3120-TTOMLPY38
23-Feb-2025 16:29:44 Starting cleanup
23-Feb-2025 16:29:55 wheel-container-test
23-Feb-2025 16:29:58 wheel-container-test
23-Feb-2025 16:29:58 Cleanup complete
23-Feb-2025 16:29:58 Finished task 'Cleanup' with result: Success
23-Feb-2025 16:29:58 Running post build plugin 'Docker Container Cleanup'
23-Feb-2025 16:29:58
Beginning to execute external process for build 'CASASPECS - Release 6.7.0 Test 3.12 - release-6.7.0 - Test Tools Many Linux 2.28 Rocky 8.10 Py3.12 #2 (CASASPECS-RELEASE670TESTPY3120-TTOMLPY38-2)'
... running command line:
/bin/docker rm -f wheel-container-test
... in: /export/home/cbt-el7-2/bamboohome/xml-data/build-dir/CASASPECS-RELEASE670TESTPY3120-TTOMLPY38
23-Feb-2025 16:29:58 Error response from daemon: No such container: wheel-container-test
23-Feb-2025 16:29:58 Running post build plugin 'NCover Results Collector'
23-Feb-2025 16:29:58 Running post build plugin 'Build Results Label Collector'
23-Feb-2025 16:29:58 Running post build plugin 'Clover Results Collector'
23-Feb-2025 16:29:58 Running post build plugin 'npm Cache Cleanup'
23-Feb-2025 16:29:58 Running post build plugin 'Artifact Copier'
23-Feb-2025 16:29:58 Publishing an artifact: Workdir
23-Feb-2025 16:29:59 Finished publishing of artifact Non required job artifact Http Compression On : [Workdir], patterns: [work*.tar.gz] anchored at: [wheeldirectory/] in 769.3 ms
23-Feb-2025 16:29:59 Publishing an artifact: XML Directories
23-Feb-2025 16:29:59 Finished publishing of artifact Non required job artifact Http Compression On : [XML Directories], patterns: [**/*.xml] anchored at: [wheeldirectory/] in 174.7 ms
23-Feb-2025 16:29:59 Finalising the build...
23-Feb-2025 16:29:59 Stopping timer.
23-Feb-2025 16:29:59 Build CASASPECS-RELEASE670TESTPY3120-TTOMLPY38-2 completed.
23-Feb-2025 16:30:00 Running on server: post build plugin 'Build Hanging Detection Configuration'
23-Feb-2025 16:30:00 Running on server: post build plugin 'NCover Results Collector'
23-Feb-2025 16:30:00 Running on server: post build plugin 'Build Labeller'
23-Feb-2025 16:30:00 Running on server: post build plugin 'Clover Delta Calculator'
23-Feb-2025 16:30:00 Running on server: post build plugin 'Maven Dependencies Postprocessor'
23-Feb-2025 16:30:00 All post build plugins have finished
23-Feb-2025 16:30:00 Generating build results summary...
23-Feb-2025 16:30:00 Saving build results to disk...
23-Feb-2025 16:30:00 Store variable context...
23-Feb-2025 16:30:00 Finished building CASASPECS-RELEASE670TESTPY3120-TTOMLPY38-2.