Build: #2 was successful

Job: Test Tools Many Linux 2.28 was successful

Stages & jobs

  1. Default Stage

  2. Test

Build log

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

20-Apr-2026 15:32:52 2026-04-20 19:32:52        INFO        FlagMSHandler::        Chunk = 7 [progress: 21%], Observation = 0, Array = 0, Scan = 30, Field = 1 (3C286_A), Spw = 6, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 534
20-Apr-2026 15:32:52 2026-04-20 19:32:52        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 6 Scan : 30 : 30
20-Apr-2026 15:32:52 2026-04-20 19:32:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:52 2026-04-20 19:32:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (134568/410112)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 7 Scan : 30 : 30
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 8 Scan : 30 : 30
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        FlagMSHandler::        Chunk = 10 [progress: 31%], Observation = 0, Array = 0, Scan = 30, Field = 1 (3C286_A), Spw = 9, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 534
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 9 Scan : 30 : 30
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (134568/410112)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 10 Scan : 30 : 30
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 11 Scan : 30 : 30
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        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
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 12 Scan : 30 : 30
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (134568/410112)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 13 Scan : 30 : 30
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 14 Scan : 30 : 30
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 15 Scan : 30 : 30
20-Apr-2026 15:32:52 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        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
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 0 Scan : 31 : 31
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (179928/548352)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 1 Scan : 31 : 31
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 2 Scan : 31 : 31
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        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
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 3 Scan : 31 : 31
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 4 Scan : 31 : 31
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 5 Scan : 31 : 31
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        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
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 6 Scan : 31 : 31
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 7 Scan : 31 : 31
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:53        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 8 Scan : 31 : 31
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        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
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 9 Scan : 31 : 31
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 10 Scan : 31 : 31
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 11 Scan : 31 : 31
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        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
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 12 Scan : 31 : 31
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 13 Scan : 31 : 31
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 14 Scan : 31 : 31
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        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
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 15 Scan : 31 : 31
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
20-Apr-2026 15:32:53 2026-04-20 19:32:54        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        FlagMSHandler::nextChunk         ====================================================================================
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Manual::tableSummary        => Percentage of data flagged in table selection: 32.8125%
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        AgentFlagger::run        => Writing flags to the MS
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          observation 0 flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          scan 31 flagged: 725760 total: 2.21184e+06 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          scan 30 flagged: 717696 total: 2.18726e+06 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          antenna ea24 flagged: 721728 total: 2.19955e+06 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          antenna ea19 flagged: 721728 total: 2.19955e+06 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          antenna ea01 flagged: 721728 total: 2.19955e+06 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          antenna ea11 flagged: 721728 total: 2.19955e+06 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          field 3C286_A flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          spw 15 flagged: 90216 total: 274944 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          spw 14 flagged: 90216 total: 274944 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          spw 10 flagged: 90216 total: 274944 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          spw 7 flagged: 90216 total: 274944 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          spw 12 flagged: 90216 total: 274944 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          spw 6 flagged: 90216 total: 274944 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          spw 8 flagged: 90216 total: 274944 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          spw 5 flagged: 90216 total: 274944 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          spw 0 flagged: 90216 total: 274944 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          spw 11 flagged: 90216 total: 274944 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          spw 9 flagged: 90216 total: 274944 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          spw 4 flagged: 90216 total: 274944 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          spw 1 flagged: 90216 total: 274944 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          spw 2 flagged: 90216 total: 274944 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          spw 13 flagged: 90216 total: 274944 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          spw 3 flagged: 90216 total: 274944 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          correlation LL flagged: 360864 total: 1.09978e+06 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          correlation LR flagged: 360864 total: 1.09978e+06 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          correlation RR flagged: 360864 total: 1.09978e+06 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          correlation RL flagged: 360864 total: 1.09978e+06 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          array 0 flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Summary::getResult          Total Flagged: 1.44346e+06 Total Counts: 4.3991e+06 (32.8%)
20-Apr-2026 15:32:54 2026-04-20 19:32:54        INFO        Display::displayReports         Report Displays are turned OFF
20-Apr-2026 15:32:54 test_tool_agentflagger.py::test_display::test_display_data_single_channel_selection
20-Apr-2026 15:32:54 AgentFlagger:: Check nominal behaviour for single spw:chan selection 
20-Apr-2026 15:32:54 The MS is already around, just unflag
20-Apr-2026 15:32:54 PASSED
20-Apr-2026 15:32:54
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        AgentFlagger::open        Table type is Measurement Set
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        AgentFlagger::initAgents        There are initially 1 agents in the list. Agents: unflag
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        AgentFlagger::initAgents        There are 1 valid agents in the list. Agents: unflag
20-Apr-2026 15:32:54 2026-04-20 19:32:55        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
20-Apr-2026 15:32:54 2026-04-20 19:32:55        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
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (1028/1028)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        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
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2/2)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        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
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (1026/1026)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        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
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4/4)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        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
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2050/2050)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        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
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4096/4096)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        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
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (6/6)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        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
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2048/2048)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        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
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4098/4098)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        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
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2/2)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        FlagMSHandler::nextChunk         ====================================================================================
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Unflag::tableSummary        => Percentage of data un-flagged in table selection: 100%
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        AgentFlagger::run        => Writing flags to the MS
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        AgentFlagger::open        Table type is Measurement Set
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        FlagMSHandler::selectData          Selected spw-channels ids are Axis Lengths: [4, 4]  (NB: Matrix in Row/Column order)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        FlagMSHandler::selectData +        [1, 0, 511, 1
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        FlagMSHandler::selectData +         2, 0, 0, 1
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        FlagMSHandler::selectData +         3, 0, 511, 1
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        FlagMSHandler::selectData +         4, 0, 0, 1]
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        AgentFlagger::initAgents        There are initially 3 agents in the list. Agents: manual, summary, display
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Manual::setAgentParameters         autocorr is 0
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Display::setAgentParameters          data column is FLOAT_DATA
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Display::setAgentParameters          Visibility expression is REAL XX,YY
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Display::setAgentParameters          pause is 0
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Display::setAgentParameters          datadisplay is 1
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Display::setAgentParameters          reportdisplay is 0
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Display::setAgentParameters          format is screen
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        AgentFlagger::initAgents        There are 3 valid agents in the list. Agents: manual, summary, display
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        FlagDataHandler::preLoadColumn         Setting row blocking to number of rows in selected table: 4
20-Apr-2026 15:32:54 2026-04-20 19:32:55        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
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 1 Scan : 1 : 1
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
20-Apr-2026 15:32:54 /home/casatest/venv/bin/python3.12: No module named casaplotserver
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Manual::chunkSummary        => Data flagged so far 100% (1024/1024)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        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
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 2 Scan : 1 : 1
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Manual::chunkSummary        => Data flagged so far 100% (2/2)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        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
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 3 Scan : 1 : 1
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Manual::chunkSummary        => Data flagged so far 100% (1024/1024)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        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
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 4 Scan : 1 : 1
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Manual::chunkSummary        => Data flagged so far 100% (2/2)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        FlagMSHandler::nextChunk         ====================================================================================
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Manual::tableSummary        => Percentage of data flagged in table selection: 100%
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        AgentFlagger::run        => Writing flags to the MS
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Summary::getResult          observation 0 flagged: 2052 total: 2052 (100%)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Summary::getResult          scan 1 flagged: 2052 total: 2052 (100%)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Summary::getResult          antenna PM04 flagged: 2052 total: 2052 (100%)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Summary::getResult          field r aqr flagged: 2052 total: 2052 (100%)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Summary::getResult          spw 4 flagged: 2 total: 2 (100%)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Summary::getResult          spw 3 flagged: 1024 total: 1024 (100%)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Summary::getResult          spw 1 flagged: 1024 total: 1024 (100%)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Summary::getResult          spw 2 flagged: 2 total: 2 (100%)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Summary::getResult          correlation YY flagged: 1026 total: 1026 (100%)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Summary::getResult          correlation XX flagged: 1026 total: 1026 (100%)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Summary::getResult          array 0 flagged: 2052 total: 2052 (100%)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Summary::getResult          Total Flagged: 2052 Total Counts: 2052 (100%)
20-Apr-2026 15:32:54 2026-04-20 19:32:55        INFO        Display::displayReports         Report Displays are turned OFF
20-Apr-2026 15:32:54 test_tool_agentflagger.py::test_display::test_display_float_data
20-Apr-2026 15:32:54 AgentFlagger: Select spw, display and flag single-dish MS
20-Apr-2026 15:32:54 Moving data...
20-Apr-2026 15:32:54 PASSED
20-Apr-2026 15:32:54
20-Apr-2026 15:32:54 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_agentflagger/nose.xml -
20-Apr-2026 15:32:54 ======================== 35 passed, 1 warning in 23.74s ========================
20-Apr-2026 15:32:55 ============================= test session starts ==============================
20-Apr-2026 15:32:55 platform linux -- Python 3.12.9, pytest-9.0.3, pluggy-1.6.0 -- /home/casatest/venv/bin/python3.12
20-Apr-2026 15:32:55 cachedir: .pytest_cache
20-Apr-2026 15:32:55 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv
20-Apr-2026 15:32:55 configfile: pytest.ini
20-Apr-2026 15:32:55 collecting ... collected 7 items
20-Apr-2026 15:32:55
20-Apr-2026 15:32:55
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageFactory::createImage        Created Temp image  of shape [30, 30, 30] with float valued pixels.
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        PVGenerator::setEndpoints         Setting pixel end points [8.5, 15.5], [22.5, 15.5]
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord+            [9, 15, 0] to [22, 15, 29]  (00:00:24.000, +00.00.00.000, 1.41498e+09Hz to 23:59:32.000, +00.00.00.000, 1.41501e+09Hz)
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        PVGenerator::setEndpoints         Setting pixel end points [22.5, 15.5], [8.5, 15.5]
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        PVGenerator::generate         Rotating image by -180 degrees about direction coordinate pixel (15.5, 15.5) to align specified slice with the x axis
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord+            [0, 0, 0] to [29, 29, 29]  (00:01:00.001, -00.15.00.003, 1.41498e+09Hz to 23:59:03.999, +00.14.00.002, 1.41501e+09Hz)
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord+            [9, 15, 0] to [22, 15, 29]  (23:59:32.000, +00.01.00.000, 1.41498e+09Hz to 00:00:24.000, +00.01.00.000, 1.41501e+09Hz)
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        name::        No table opened.
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:32:55 test_tool_image_pv.py::ia_pv_test::test_CAS10968
20-Apr-2026 15:32:55 Fix for pa=90,270 when segment y pixel falls on half pixel
20-Apr-2026 15:32:55 PASSED
20-Apr-2026 15:32:55
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        PVGenerator::generate         Rotating image by -45 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [299, 299, 0, 2]  (09:48:01.492, +13.15.40.658, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [316, 316, 0, 2]  (09:48:01.957, +13.15.33.858, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord+            [1, 157, 0, 0] to [313, 157, 0, 2]  (09:48:00.678, +13.15.52.535, I, 3.63994e+10Hz to 09:47:54.633, +13.17.20.782, I, 3.63991e+10Hz)
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        PVGenerator::generate         Rotating image by 45 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [299, 299, 0, 2]  (09:48:01.492, +13.15.40.658, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
20-Apr-2026 15:32:55 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [316, 316, 0, 2]  (09:48:01.957, +13.15.33.858, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord+            [1, 157, 0, 0] to [313, 157, 0, 2]  (09:48:00.678, +13.17.20.782, I, 3.63994e+10Hz to 09:47:54.634, +13.15.52.535, I, 3.63991e+10Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        PVGenerator::generate         Rotating image by -225 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [299, 299, 0, 2]  (09:48:01.492, +13.15.40.658, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [316, 316, 0, 2]  (09:48:01.957, +13.15.33.858, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord+            [1, 157, 0, 0] to [313, 157, 0, 2]  (09:47:54.633, +13.17.20.782, I, 3.63994e+10Hz to 09:48:00.678, +13.15.52.535, I, 3.63991e+10Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        PVGenerator::generate         Rotating image by -135 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [299, 299, 0, 2]  (09:48:01.492, +13.15.40.658, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [316, 316, 0, 2]  (09:48:01.957, +13.15.33.858, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord+            [1, 157, 0, 0] to [313, 157, 0, 2]  (09:47:54.634, +13.15.52.535, I, 3.63994e+10Hz to 09:48:00.678, +13.17.20.782, I, 3.63991e+10Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
20-Apr-2026 15:32:56 2026-04-20 19:32:56        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        PVGenerator::generate         Rotating image by -137.67 degrees about direction coordinate pixel (216.468, 187) to align specified slice with the x axis
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [399, 399, 0, 2]  (18:54:07.171, +01.59.37.999, I, 2.369292e+10Hz to 18:53:53.862, +02.02.57.499, I, 2.369285e+10Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord+            [151, 187, 0, 0] to [284, 187, 0, 2]  (18:53:58.336, +02.00.49.457, I, 2.369292e+10Hz to 18:54:01.616, +02.01.34.238, I, 2.369285e+10Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        PVGenerator::generate         Rotating image by -42.3301 degrees about direction coordinate pixel (215.598, 187.793) to align specified slice with the x axis
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [399, 399, 0, 2]  (18:54:07.171, +01.59.37.999, I, 2.369292e+10Hz to 18:53:53.862, +02.02.57.499, I, 2.369285e+10Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
20-Apr-2026 15:32:56 2026-04-20 19:32:56        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [149, 188, 0, 0] to [282, 188, 0, 2]  (18:54:01.627, +02.00.49.549, I, 2.369292e+10Hz to 18:53:58.347, +02.01.34.331, I, 2.369285e+10Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        PVGenerator::generate         Rotating image by 42.3301 degrees about direction coordinate pixel (216.468, 187) to align specified slice with the x axis
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [399, 399, 0, 2]  (18:54:07.171, +01.59.37.999, I, 2.369292e+10Hz to 18:53:53.862, +02.02.57.499, I, 2.369285e+10Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [149, 187, 0, 0] to [282, 187, 0, 2]  (18:54:01.614, +02.01.34.216, I, 2.369292e+10Hz to 18:53:58.335, +02.00.49.435, I, 2.369285e+10Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        PVGenerator::generate         Rotating image by -222.33 degrees about direction coordinate pixel (215.598, 187.793) to align specified slice with the x axis
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [399, 399, 0, 2]  (18:54:07.171, +01.59.37.999, I, 2.369292e+10Hz to 18:53:53.862, +02.02.57.499, I, 2.369285e+10Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [149, 188, 0, 0] to [282, 188, 0, 2]  (18:53:58.333, +02.01.34.243, I, 2.369292e+10Hz to 18:54:01.612, +02.00.49.462, I, 2.369285e+10Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        name::        No table opened.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:32:56 test_tool_image_pv.py::ia_pv_test::test_CAS_2996
20-Apr-2026 15:32:56 ia.pv(): Test issues raised in CAS-2996
20-Apr-2026 15:32:56 PASSED
20-Apr-2026 15:32:56
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        PVGenerator::generate         Rotating image by -45 degrees about direction coordinate pixel (140, 140) to align specified slice with the x axis
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        PVGenerator::generate         Some pixels will fall outside the rotated image, so padding before rotating with 17 pixels.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [299, 299, 0, 2]  (09:48:01.492, +13.15.40.658, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Original Temporary_Image size => [300, 300, 1, 3]
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        New  size => [334, 334, 1, 3]
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [316, 316, 0, 2]  (09:48:01.957, +13.15.33.858, I, 3.63994e+10Hz to 09:47:53.299, +13.17.40.258, I, 3.63991e+10Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [1, 157, 0, 0] to [313, 157, 0, 2]  (09:48:00.678, +13.15.52.535, I, 3.63994e+10Hz to 09:47:54.633, +13.17.20.782, I, 3.63991e+10Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageFitsConverter::ImageHeaderToFITS         Truncating miscinfo field secondary_coordinates to secondar
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageFitsConverter::ImageHeaderToFITS         Not writing miscInfo field 'secondar' - cannot handle type Record
20-Apr-2026 15:32:56 2026-04-20 19:32:57        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageFitsConverter::ImageHeaderToFITS         Truncating miscinfo field secondary_coordinates to secondar
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageFitsConverter::ImageHeaderToFITS         Not writing miscInfo field 'secondar' - cannot handle type Record
20-Apr-2026 15:32:56 2026-04-20 19:32:57        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        name::        No table opened.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:32:56 test_tool_image_pv.py::ia_pv_test::test_fits
20-Apr-2026 15:32:56 ia.pv(): Test exporting and importing to/from FITS
20-Apr-2026 15:32:56 PASSED
20-Apr-2026 15:32:56
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageFactory::createImage        Created Paged image 'zz.im' of shape [30, 30, 30] with float valued pixels.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        PVGenerator::setEndpoints         Setting pixel end points [10.0503, 19.9497], [19.9497, 10.0503]
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        PVGenerator::generate         Rotating image by 45 degrees about direction coordinate pixel (15, 15) to align specified slice with the x axis
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [0, 0, 0] to [29, 29, 29]  (00:01:00.001, -00.15.00.003, 1.41498e+09Hz to 23:59:03.999, +00.14.00.002, 1.41501e+09Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [8, 15, 0] to [22, 15, 29]  (00:00:19.799, +00.04.56.985, 1.41498e+09Hz to 23:59:40.201, -00.04.56.985, 1.41501e+09Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ::::ImageFactory::createImage        Created Paged image 'zz.im' of shape [30, 30, 30] with float valued pixels.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ::::image::fromshape        Ran ia.fromshape
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ::::image::fromshape        ia.fromshape(outfile="zz.im", shape=[30,30,30], csys={...}, linear=false, overwrite=false, log=true, type="f")
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ::::image::pv        Ran ia.pv
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ::::image::pv        ia.pv(outfile="", start=[], end=[], center=[15,15], length="14arcmin", pa="45deg", width=1, unit="arcsec", overwrite=false, region={...}, chans="", stokes="", mask="", stretch=false, wantreturn=true)
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        name::        No table opened.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:32:56 test_tool_image_pv.py::ia_pv_test::test_history
20-Apr-2026 15:32:56 Verify history is written to created image
20-Apr-2026 15:32:56 PASSED
20-Apr-2026 15:32:56
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageFactory::createImage        Created Paged image 'zxye.im' of shape [10, 10, 10] with float valued pixels.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        name::        No table opened.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        SubImageFactory::createImage        Creating image 'test_pv_0' of shape [6, 10]
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        name::        No table opened.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
20-Apr-2026 15:32:56 2026-04-20 19:32:57        INFO        SubImageFactory::createImage        Creating image 'test_pv_1' of shape [6, 10]
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        name::        No table opened.
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        SubImageFactory::createImage        Creating image 'test_pv_2' of shape [6, 10]
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        name::        No table opened.
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        SubImageFactory::createImage        Creating image 'test_pv_3' of shape [6, 10]
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        name::        No table opened.
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        SubImageFactory::createImage        Creating image 'test_pv_4' of shape [6, 10]
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        name::        No table opened.
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        SubImageFactory::createImage        Creating image 'test_pv_5' of shape [6, 10]
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        name::        No table opened.
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        PVGenerator::setEndpoints         Setting pixel end points [2, 5], [7, 5]
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [2, 5, 0] to [7, 5, 9]  (00:00:12.000, +00.00.00.000, 1.415e+09Hz to 23:59:52.000, +00.00.00.000, 1.415e+09Hz)
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        SubImageFactory::createImage        Creating image 'test_pv_6' of shape [6, 10]
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        name::        No table opened.
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [2, 4, 0] to [7, 6, 9]  (00:00:12.000, -00.01.00.000, 1.415e+09Hz to 23:59:52.000, +00.01.00.000, 1.415e+09Hz)
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_0' of shape [6, 10]
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [2, 4, 0] to [7, 6, 9]  (00:00:12.000, -00.01.00.000, 1.415e+09Hz to 23:59:52.000, +00.01.00.000, 1.415e+09Hz)
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_1' of shape [6, 10]
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        PVGenerator::setWidth         Rounding width up to next odd number of pixels (3), or 3arcmin
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [2, 4, 0] to [7, 6, 9]  (00:00:12.000, -00.01.00.000, 1.415e+09Hz to 23:59:52.000, +00.01.00.000, 1.415e+09Hz)
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_2' of shape [6, 10]
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        PVGenerator::setWidth         Rounding width up to next odd number of pixels (3), or 3arcmin
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [2, 4, 0] to [7, 6, 9]  (00:00:12.000, -00.01.00.000, 1.415e+09Hz to 23:59:52.000, +00.01.00.000, 1.415e+09Hz)
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_3' of shape [6, 10]
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        PVGenerator::setWidth         Rounding width up to next odd number of pixels (3), or 180000marcsec
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageRegion::fromRecord+            [2, 4, 0] to [7, 6, 9]  (00:00:12.000, -00.01.00.000, 1.415e+09Hz to 23:59:52.000, +00.01.00.000, 1.415e+09Hz)
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        SubImageFactory::createImage        Creating image 'test_pv_1_4' of shape [6, 10]
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        name::        No table opened.
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:32:57 test_tool_image_pv.py::ia_pv_test::test_pv
20-Apr-2026 15:32:57 ia.pv(): Test pv()
20-Apr-2026 15:32:57 PASSED
20-Apr-2026 15:32:57
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        ImageFactory::createImage        Created Temp image  of shape [50, 50, 1000] with float valued pixels.
20-Apr-2026 15:32:57 2026-04-20 19:32:57        INFO        PVGenerator::generate         Rotating image by -45 degrees about direction coordinate pixel (7.5, 7.5) to align specified slice with the x axis
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        ImageRegion::fromRecord+            [0, 0, 0] to [49, 49, 999]  (03:01:57.530, -35.32.49.013, 1.4145e+09Hz to 02:57:58.673, -34.43.38.701, 1.4155e+09Hz)
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        ImageRegion::fromRecord        Rotating DirectionCoordinate holding axes [0, 1]
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        ImageMaskAttacher::makeMask        Created and initialized mask `mask0'
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        ImageRegion::fromRecord+            [4, 7, 0] to [11, 7, 999]  (03:01:31.077, -35.28.09.040, 1.4145e+09Hz to 03:01:06.781, -35.23.12.033, 1.4155e+09Hz)
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        name::        No table opened.
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:32:57 test_tool_image_pv.py::ia_pv_test::test_refpix_far_outside_image
20-Apr-2026 15:32:57 Test refpix far outside image doesn't lead to malloc error, CAS-5251
20-Apr-2026 15:32:57 PASSED
20-Apr-2026 15:32:57
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        ImageFactory::createImage        Created Paged image 'maskim' of shape [200, 200, 1, 1] with float valued pixels.
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        ImageFactory::createImage        Created Paged image 'kk' of shape [200, 200, 1, 20] with float valued pixels.
20-Apr-2026 15:32:57 2026-04-20 19:32:58        SEVERE        image::pv (file src/tools/image/image_cmpt.cc, line 4856)        Exception Reported: The input image shape ([200, 200, 1, 20]) and mask shape ([200, 200, 1, 1]) are different, and it was specified that the mask should not be extended, so the mask cannot be applied to the (sub)image. Specifying that the mask should be extended may resolve the issue at File: /source/casainstall/include/casacpp/imageanalysis/ImageAnalysis/SubImageFactory.tcc, line: 306
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        PVGenerator::generate         Rotation angle (very nearly) 0 degrees, no rotation required
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        ImageRegion::fromRecord+            [2, 2, 0, 0] to [20, 2, 0, 19]  (00:06:32.213, -01.38.00.797, I, 1.41499e+09Hz to 00:05:20.159, -01.38.00.797, I, 1.41501e+09Hz)
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        ImageCollapser::_doDegenerateAxesCase        All subimage axes to be collapsed are degenerate, using algorithm optimized for that case.
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        name::        No table opened.
20-Apr-2026 15:32:57 2026-04-20 19:32:58        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:32:57 test_tool_image_pv.py::ia_pv_test::test_stretch
20-Apr-2026 15:32:57 ia.pv(): Test stretch parameter
20-Apr-2026 15:32:57 PASSED
20-Apr-2026 15:32:57
20-Apr-2026 15:32:57 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_pv/nose.xml -
20-Apr-2026 15:32:57 ========================= 7 passed, 1 warning in 2.59s =========================
20-Apr-2026 15:32:58 ============================= test session starts ==============================
20-Apr-2026 15:32:58 platform linux -- Python 3.12.9, pytest-9.0.3, pluggy-1.6.0 -- /home/casatest/venv/bin/python3.12
20-Apr-2026 15:32:58 cachedir: .pytest_cache
20-Apr-2026 15:32:58 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_deviation
20-Apr-2026 15:32:58 configfile: pytest.ini
20-Apr-2026 15:32:58 collecting ... collected 8 items
20-Apr-2026 15:32:58
20-Apr-2026 15:32:58
20-Apr-2026 15:32:58 2026-04-20 19:32:59        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing NPTS using the classical algorithm around each of 10000 grid points in 2 planes.
20-Apr-2026 15:32:59 2026-04-20 19:32:59        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
20-Apr-2026 15:32:59 2026-04-20 19:32:59        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 10000 grid points in 2 planes.
20-Apr-2026 15:32:59 2026-04-20 19:33:00        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
20-Apr-2026 15:32:59 2026-04-20 19:33:00        INFO        name::        No table opened.
20-Apr-2026 15:32:59 2026-04-20 19:33:00        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:32:59 2026-04-20 19:33:00        INFO        name::        No table opened.
20-Apr-2026 15:32:59 2026-04-20 19:33:00        INFO        name::        No table opened.
20-Apr-2026 15:32:59 test_tool_image_deviation.py::ia_deviation_test::test001
20-Apr-2026 15:32:59 Every pixel is a grid point
20-Apr-2026 15:32:59 PASSED
20-Apr-2026 15:32:59
20-Apr-2026 15:32:59 2026-04-20 19:33:00        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing NPTS using the classical algorithm around each of 10000 grid points in 2 planes.
20-Apr-2026 15:33:00 2026-04-20 19:33:00        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
20-Apr-2026 15:33:00 2026-04-20 19:33:00        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 10000 grid points in 2 planes.
20-Apr-2026 15:33:00 2026-04-20 19:33:00        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
20-Apr-2026 15:33:00 2026-04-20 19:33:00        INFO        name::        No table opened.
20-Apr-2026 15:33:00 2026-04-20 19:33:00        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:33:00 2026-04-20 19:33:00        INFO        name::        No table opened.
20-Apr-2026 15:33:00 2026-04-20 19:33:00        INFO        name::        No table opened.
20-Apr-2026 15:33:00 test_tool_image_deviation.py::ia_deviation_test::test002
20-Apr-2026 15:33:00 Every pixel is a grid point with an offset, so should be the same result
20-Apr-2026 15:33:00 as test001
20-Apr-2026 15:33:00 PASSED
20-Apr-2026 15:33:00
20-Apr-2026 15:33:00 2026-04-20 19:33:00        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing NPTS using the classical algorithm around each of 1156 grid points in 2 planes.
20-Apr-2026 15:33:00 2026-04-20 19:33:01        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
20-Apr-2026 15:33:00 2026-04-20 19:33:01        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
20-Apr-2026 15:33:00 2026-04-20 19:33:01        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 1156 grid points in 2 planes.
20-Apr-2026 15:33:00 2026-04-20 19:33:01        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
20-Apr-2026 15:33:00 2026-04-20 19:33:01        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
20-Apr-2026 15:33:00 2026-04-20 19:33:01        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
20-Apr-2026 15:33:00 2026-04-20 19:33:01        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing NPTS using the classical algorithm around each of 1156 grid points in 2 planes.
20-Apr-2026 15:33:00 2026-04-20 19:33:01        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
20-Apr-2026 15:33:00 2026-04-20 19:33:01        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
20-Apr-2026 15:33:00 2026-04-20 19:33:01        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 1156 grid points in 2 planes.
20-Apr-2026 15:33:00 2026-04-20 19:33:01        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
20-Apr-2026 15:33:00 2026-04-20 19:33:01        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
20-Apr-2026 15:33:00 2026-04-20 19:33:01        INFO        name::        No table opened.
20-Apr-2026 15:33:00 2026-04-20 19:33:01        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:33:00 2026-04-20 19:33:01        INFO        name::        No table opened.
20-Apr-2026 15:33:00 2026-04-20 19:33:01        INFO        name::        No table opened.
20-Apr-2026 15:33:00 test_tool_image_deviation.py::ia_deviation_test::test003
20-Apr-2026 15:33:00 Every third pixel is a grid point
20-Apr-2026 15:33:00 PASSED
20-Apr-2026 15:33:00
20-Apr-2026 15:33:00 2026-04-20 19:33:01        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing NPTS using the classical algorithm around each of 1089 grid points in 2 planes.
20-Apr-2026 15:33:00 2026-04-20 19:33:01        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
20-Apr-2026 15:33:00 2026-04-20 19:33:01        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
20-Apr-2026 15:33:00 2026-04-20 19:33:01        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 1089 grid points in 2 planes.
20-Apr-2026 15:33:00 2026-04-20 19:33:01        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
20-Apr-2026 15:33:00 2026-04-20 19:33:01        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
20-Apr-2026 15:33:00 2026-04-20 19:33:01        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing NPTS using the classical algorithm around each of 1089 grid points in 2 planes.
20-Apr-2026 15:33:00 2026-04-20 19:33:01        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
20-Apr-2026 15:33:00 2026-04-20 19:33:01        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 1089 grid points in 2 planes.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        name::        No table opened.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        name::        No table opened.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        name::        No table opened.
20-Apr-2026 15:33:01 test_tool_image_deviation.py::ia_deviation_test::test005
20-Apr-2026 15:33:01 Every third pixel is a grid point, using anchor [2,2]
20-Apr-2026 15:33:01 PASSED
20-Apr-2026 15:33:01
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 10.001 pix x 10.001 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 11 pix x 11 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 64 grid points in 2 planes.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        ImageRegion::fromRecord+            [5, 5, 0] to [85, 85, 1]  (00:03:00.021, -00.45.00.077, I to 23:57:39.990, +00.35.00.036, Q)
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 10.001 pix x 10.001 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 11 pix x 11 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 36 grid points in 2 planes.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        ImageRegion::fromRecord+            [27, 27, 0] to [66, 66, 0]  (00:01:32.003, -00.23.00.010, I to 23:58:55.999, +00.16.00.003, I)
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        ImageRegion::fromRecord        Selected bounding box :
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        ImageRegion::fromRecord+            [22, 22, 0] to [61, 61, 0]  (00:01:32.003, -00.23.00.010, I to 23:58:55.999, +00.16.00.003, I)
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        name::        No table opened.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        name::        No table opened.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        name::        No table opened.
20-Apr-2026 15:33:01 test_tool_image_deviation.py::ia_deviation_test::test006
20-Apr-2026 15:33:01 Test that regions work as expected
20-Apr-2026 15:33:01 PASSED
20-Apr-2026 15:33:01
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        ImageFactory::createImage        Created Paged image 'mycirc.im' of shape [100, 100] with float valued pixels.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        StatImageCreator::useReferencePixelAsAnchor        Anchor being set at pixel [50,50], at/near image reference pixel.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        StatImageCreator::_computeStat        Using circular region of radius 20 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 41 pix x 41 pix and there are 1257 good pixels in the circle that are being used) to choose pixels for computing SUM using the classical algorithm around each of 25 grid points in 1 planes.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        StatImageCreator::_doInterpolation        Interpolate using CUBIC algorithm.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        name::        No table opened.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        name::        No table opened.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        name::        No table opened.
20-Apr-2026 15:33:01 test_tool_image_deviation.py::ia_deviation_test::test_circle
20-Apr-2026 15:33:01 test circles work correctly CAS-10296
20-Apr-2026 15:33:01 PASSED
20-Apr-2026 15:33:01
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        ImageFactory::createImage        Created Temp image  of shape [10, 10] with float valued pixels.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 9 grid points in 1 planes.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        ImageFactory::createImage        Created Temp image  of shape [10, 10, 2] with float valued pixels.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 9 grid points in 2 planes.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        StatImageCreator::_doInterpolation        Interpolate using LINEAR algorithm.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        name::        No table opened.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        name::        No table opened.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        name::        No table opened.
20-Apr-2026 15:33:01 test_tool_image_deviation.py::ia_deviation_test::test_mask
20-Apr-2026 15:33:01 PASSED
20-Apr-2026 15:33:01
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        ImageFactory::createImage        Created Temp image  of shape [20, 20] with float valued pixels.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 25 grid points in 1 planes.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        StatImageCreator::_doInterpolation        Interpolate using CUBIC algorithm.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        StatImageCreator::useReferencePixelAsAnchor        Anchor being set at pixel [10,10], at/near image reference pixel.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        StatImageCreator::_computeStat        Using rectangular region of specified dimensions 4 pix x 4 pix (because of centering and rounding to use whole pixels, actual dimensions of bounding box are 5 pix x 5 pix) to choose pixels for computing STDDEV using the classical algorithm around each of 25 grid points in 1 planes.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        StatImageCreator::_doInterpolation        Interpolate using CUBIC algorithm.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        name::        No table opened.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        showcache::        The Table Cache is empty.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        name::        No table opened.
20-Apr-2026 15:33:01 2026-04-20 19:33:01        INFO        name::        No table opened.
20-Apr-2026 15:33:01 test_tool_image_deviation.py::ia_deviation_test::test_refpix
20-Apr-2026 15:33:01 Test using reference pixel
20-Apr-2026 15:33:01 PASSED
20-Apr-2026 15:33:01
20-Apr-2026 15:33:01 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_deviation/nose.xml -
20-Apr-2026 15:33:01 ========================= 8 passed, 1 warning in 2.92s =========================
20-Apr-2026 15:33:01 ============================= test session starts ==============================
20-Apr-2026 15:33:01 platform linux -- Python 3.12.9, pytest-9.0.3, pluggy-1.6.0 -- /home/casatest/venv/bin/python3.12
20-Apr-2026 15:33:01 cachedir: .pytest_cache
20-Apr-2026 15:33:01 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_linearmosaic
20-Apr-2026 15:33:01 configfile: pytest.ini
20-Apr-2026 15:33:02 collecting ... collected 5 items
20-Apr-2026 15:33:02
20-Apr-2026 15:33:02
20-Apr-2026 15:33:03 2026-04-20 19:33:03        WARN        ImageRegrid::regrid        You are regridding an image whose beam is not well sampled by the pixel size.  Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 15:33:04 2026-04-20 19:33:05        WARN        ImageRegrid::regrid        You are regridding an image whose beam is not well sampled by the pixel size.  Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 15:33:05 test_tool_linearmosaic.py::test_tool_linearmosaic::test_flat_noise
20-Apr-2026 15:33:05 test_flat_noise (flat noise type with flat noise input)
20-Apr-2026 15:33:05 PASSED
20-Apr-2026 15:33:05
20-Apr-2026 15:33:05 2026-04-20 19:33:06        WARN        ImageRegrid::regrid        You are regridding an image whose beam is not well sampled by the pixel size.  Total flux can be lost when regridding such images, especially when the new pixel size is larger than the old pixel size. It is recommended to check the total flux of your input and output image, and if necessary rebin the input to have smaller pixels.
20-Apr-2026 15:33:06 test_tool_linearmosaic.py::test_tool_linearmosaic::test_flat_noise_existing_image
20-Apr-2026 15:33:06 test_flat_noise_existing image (flat noise type onto an existing image)
20-Apr-2026 15:33:06 PASSED
20-Apr-2026 15:33:06
20-Apr-2026 15:33:09 test_tool_linearmosaic.py::test_tool_linearmosaic::test_flat_noise_flat_sky_input
20-Apr-2026 15:33:09 test_flat_noise_flat_sky_input (flat noise type with flat sky input)
20-Apr-2026 15:33:09 PASSED
20-Apr-2026 15:33:09
20-Apr-2026 15:33:13 test_tool_linearmosaic.py::test_tool_linearmosaic::test_flat_sky
20-Apr-2026 15:33:13 test_flat_sky (flat sky type with flat noise input
20-Apr-2026 15:33:13 PASSED
20-Apr-2026 15:33:13
20-Apr-2026 15:33:16 test_tool_linearmosaic.py::test_tool_linearmosaic::test_flat_sky_flat_sky_input
20-Apr-2026 15:33:16 test_flat_sky_flat_sky_input (flat sky type with flat sky inputs)
20-Apr-2026 15:33:16 PASSED
20-Apr-2026 15:33:16
20-Apr-2026 15:33:16 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_linearmosaic/nose.xml -
20-Apr-2026 15:33:16 ======================== 5 passed, 1 warning in 15.31s =========================
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_componentlist/
20-Apr-2026 15:33:17 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_componentlist
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_componentlist/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_componentlist/
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_imagepol/
20-Apr-2026 15:33:17 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_imagepol
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_imagepol/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_imagepol/
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msmetadata/
20-Apr-2026 15:33:17 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msmetadata
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_msmetadata/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_msmetadata/
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image/
20-Apr-2026 15:33:17 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 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/
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calanalysis/
20-Apr-2026 15:33:17 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calanalysis
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_calanalysis/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_calanalysis/
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_subimage/
20-Apr-2026 15:33:17 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_subimage
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_subimage/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_subimage/
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_transpose/
20-Apr-2026 15:33:17 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_transpose
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 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/
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_rebin/
20-Apr-2026 15:33:17 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_rebin
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_rebin/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_rebin/
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_statwt/
20-Apr-2026 15:33:17 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_statwt
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 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/
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms/
20-Apr-2026 15:33:17 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_ms/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_ms/
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msuvbinner/
20-Apr-2026 15:33:17 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msuvbinner
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_msuvbinner/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_msuvbinner/
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/
20-Apr-2026 15:33:17 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 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/
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_regionmanager/
20-Apr-2026 15:33:17 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_regionmanager
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_regionmanager/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_regionmanager/
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_coordsys/
20-Apr-2026 15:33:17 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_coordsys
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 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/
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_agentflagger/
20-Apr-2026 15:33:17 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_agentflagger
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 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/
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv/
20-Apr-2026 15:33:17 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 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/
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_deviation/
20-Apr-2026 15:33:17 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_deviation
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 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/
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_linearmosaic/
20-Apr-2026 15:33:17 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_linearmosaic
20-Apr-2026 15:33:17
20-Apr-2026 15:33:17 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_linearmosaic/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_linearmosaic/
20-Apr-2026 15:33:19 total 77448
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci 15001   160823 Apr 20 19:13 casatestutils-6.7.6.0a100.dev0+dirty-py3-none-any.whl
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci 15001 78972309 Apr 20 19:13 casatools-6.7.6.0a100.dev0+dirty-cp312-cp312-manylinux_2_28_x86_64.whl
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      4340 Apr 20 19:33 test_tool_agentflagger.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      1006 Apr 20 19:33 test_tool_calanalysis.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      2658 Apr 20 19:33 test_tool_calibrater.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root       687 Apr 20 19:33 test_tool_componentlist.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      7467 Apr 20 19:33 test_tool_coordsys.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root     12935 Apr 20 19:33 test_tool_image.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      2220 Apr 20 19:33 test_tool_image_collapse.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      1048 Apr 20 19:33 test_tool_image_deviation.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      2575 Apr 20 19:33 test_tool_image_fitprofile.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      1178 Apr 20 19:33 test_tool_image_pbcor.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root       883 Apr 20 19:33 test_tool_image_pv.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      1006 Apr 20 19:33 test_tool_image_rebin.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      1336 Apr 20 19:33 test_tool_image_regrid.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      1641 Apr 20 19:33 test_tool_image_statistics.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root       765 Apr 20 19:33 test_tool_image_subimage.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root       890 Apr 20 19:33 test_tool_image_transpose.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      1966 Apr 20 19:33 test_tool_imagepol.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root       839 Apr 20 19:33 test_tool_linearmosaic.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root       669 Apr 20 19:33 test_tool_logsink.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root       549 Apr 20 19:33 test_tool_measures.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      5224 Apr 20 19:33 test_tool_ms.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root       367 Apr 20 19:33 test_tool_ms_createmultims.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      2095 Apr 20 19:33 test_tool_ms_statwt.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      8633 Apr 20 19:33 test_tool_msmetadata.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root       359 Apr 20 19:33 test_tool_msuvbinner.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      1171 Apr 20 19:33 test_tool_quanta.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      3977 Apr 20 19:33 test_tool_regionmanager.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      2072 Apr 20 19:33 test_tool_sdm.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      2096 Apr 20 19:33 test_tool_sdm_toms.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root       670 Apr 20 19:33 test_tool_simulator.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      1718 Apr 20 19:33 test_tool_synthesisutils.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      1462 Apr 20 19:33 test_tool_table.xml
20-Apr-2026 15:33:19 -rw-r--r-- 1 casaci root      1717 Apr 20 19:33 test_tool_vpmanager.xml
20-Apr-2026 15:33:19 Finished task 'Test wheel' with result: Success
20-Apr-2026 15:33:19 Starting task 'Parse tests' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
20-Apr-2026 15:33:19 Parsing test results under /export/home/cbt-el7-7/bamboohome/xml-data/build-dir/CASASPECS-CI251-TTOML228...
20-Apr-2026 15:33:19 Finished task 'Parse tests' with result: Success
20-Apr-2026 15:33:19 Starting task 'Cleanup' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
20-Apr-2026 15:33:19
Beginning to execute external process for build 'CASASPECS - CI Build - CAS-14768 - Test Tools Many Linux 2.28 #2 (CASASPECS-CI251-TTOML228-2)'
... running command line:
/export/home/cbt-el7-7/bamboohome/temp/CASASPECS-CI251-TTOML228-2-ScriptBuildTask-3049938382380457538.sh
... in: /export/home/cbt-el7-7/bamboohome/xml-data/build-dir/CASASPECS-CI251-TTOML228
20-Apr-2026 15:33:19 Starting cleanup
20-Apr-2026 15:33:30 wheel-container-test
20-Apr-2026 15:33:32 wheel-container-test
20-Apr-2026 15:33:32 Cleanup complete
20-Apr-2026 15:33:32 Finished task 'Cleanup' with result: Success
20-Apr-2026 15:33:32 Running post build plugin 'Docker Container Cleanup'
20-Apr-2026 15:33:32
Beginning to execute external process for build 'CASASPECS - CI Build - CAS-14768 - Test Tools Many Linux 2.28 #2 (CASASPECS-CI251-TTOML228-2)'
... running command line:
/usr/bin/docker rm -f wheel-container-test
... in: /export/home/cbt-el7-7/bamboohome/xml-data/build-dir/CASASPECS-CI251-TTOML228
20-Apr-2026 15:33:32 Error response from daemon: No such container: wheel-container-test
20-Apr-2026 15:33:32 Running post build plugin 'NCover Results Collector'
20-Apr-2026 15:33:33 Running post build plugin 'Build Results Label Collector'
20-Apr-2026 15:33:33 Running post build plugin 'Clover Results Collector'
20-Apr-2026 15:33:33 Running post build plugin 'npm Cache Cleanup'
20-Apr-2026 15:33:33 Running post build plugin 'Artifact Copier'
20-Apr-2026 15:33:33 Publishing an artifact: Tests
20-Apr-2026 15:33:33 Finished publishing of artifact Non required job artifact Http Compression On : [Tests], patterns: [*.xml] anchored at: [wheeldirectory/] in 369.7 ms
20-Apr-2026 15:33:33 Publishing an artifact: xml Directories
20-Apr-2026 15:33:34 Finished publishing of artifact Non required job artifact Http Compression On : [xml Directories], patterns: [**/*.xml] anchored at: [wheeldirectory/] in 350.4 ms
20-Apr-2026 15:33:34 Finalising the build...
20-Apr-2026 15:33:34 Stopping timer.
20-Apr-2026 15:33:34 Build CASASPECS-CI251-TTOML228-2 completed.
20-Apr-2026 15:33:34 Running on server: post build plugin 'Build Hanging Detection Configuration'
20-Apr-2026 15:33:34 Running on server: post build plugin 'NCover Results Collector'
20-Apr-2026 15:33:34 Running on server: post build plugin 'Build Labeller'
20-Apr-2026 15:33:34 Running on server: post build plugin 'Clover Delta Calculator'
20-Apr-2026 15:33:34 Running on server: post build plugin 'Maven Dependencies Postprocessor'
20-Apr-2026 15:33:34 All post build plugins have finished
20-Apr-2026 15:33:34 Generating build results summary...
20-Apr-2026 15:33:34 Saving build results to disk...
20-Apr-2026 15:33:34 Store variable context...
20-Apr-2026 15:33:34 Finished building CASASPECS-CI251-TTOML228-2.