Build: #2 was successful

Job: Test Tools Many Linux 2.28 was successful

Stages & jobs

  1. Tag

  2. Default Stage

  3. Test

Build log

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

17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 2 Scan : 30 : 30
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        FlagMSHandler::        Chunk = 4 [progress: 12%], Observation = 0, Array = 0, Scan = 30, Field = 1 (3C286_A), Spw = 3, Channels = 64, Corrs = [ RR RL LR LL ], Total Rows = 534
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 3 Scan : 30 : 30
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (179424/546816)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 4 Scan : 30 : 30
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 5 Scan : 30 : 30
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        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
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 6 Scan : 30 : 30
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (134568/410112)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 7 Scan : 30 : 30
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 8 Scan : 30 : 30
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        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
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 9 Scan : 30 : 30
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (134568/410112)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 10 Scan : 30 : 30
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 11 Scan : 30 : 30
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:50 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        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
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 12 Scan : 30 : 30
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (134568/410112)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 13 Scan : 30 : 30
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 14 Scan : 30 : 30
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 15 Scan : 30 : 30
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        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
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 0 Scan : 31 : 31
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (179928/548352)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 1 Scan : 31 : 31
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 2 Scan : 31 : 31
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        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
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 3 Scan : 31 : 31
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 4 Scan : 31 : 31
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 5 Scan : 31 : 31
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:51        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        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
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 6 Scan : 31 : 31
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 7 Scan : 31 : 31
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 8 Scan : 31 : 31
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        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
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 9 Scan : 31 : 31
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 10 Scan : 31 : 31
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 11 Scan : 31 : 31
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        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
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 12 Scan : 31 : 31
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 13 Scan : 31 : 31
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 14 Scan : 31 : 31
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:51 2023-10-17 23:30:52        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
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 1 , 3C286_A Spw : 15 Scan : 31 : 31
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,1)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,2)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (0,3)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (1,2)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (1,3)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Display::processAntennaPair          Going to process requested baseline (2,3)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Manual::chunkSummary        => Data flagged so far 32.8125% (136080/414720)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        FlagMSHandler::nextChunk         ====================================================================================
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Manual::tableSummary        => Percentage of data flagged in table selection: 32.8125%
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        AgentFlagger::run        => Writing flags to the MS
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          observation 0 flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          scan 31 flagged: 725760 total: 2.21184e+06 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          scan 30 flagged: 717696 total: 2.18726e+06 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          antenna ea24 flagged: 721728 total: 2.19955e+06 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          antenna ea19 flagged: 721728 total: 2.19955e+06 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          antenna ea01 flagged: 721728 total: 2.19955e+06 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          antenna ea11 flagged: 721728 total: 2.19955e+06 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          field 3C286_A flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          spw 15 flagged: 90216 total: 274944 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          spw 14 flagged: 90216 total: 274944 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          spw 10 flagged: 90216 total: 274944 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          spw 7 flagged: 90216 total: 274944 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          spw 12 flagged: 90216 total: 274944 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          spw 6 flagged: 90216 total: 274944 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          spw 8 flagged: 90216 total: 274944 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          spw 5 flagged: 90216 total: 274944 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          spw 0 flagged: 90216 total: 274944 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          spw 11 flagged: 90216 total: 274944 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          spw 9 flagged: 90216 total: 274944 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          spw 4 flagged: 90216 total: 274944 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          spw 1 flagged: 90216 total: 274944 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          spw 2 flagged: 90216 total: 274944 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          spw 13 flagged: 90216 total: 274944 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          spw 3 flagged: 90216 total: 274944 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          correlation LL flagged: 360864 total: 1.09978e+06 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          correlation LR flagged: 360864 total: 1.09978e+06 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          correlation RR flagged: 360864 total: 1.09978e+06 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          correlation RL flagged: 360864 total: 1.09978e+06 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          array 0 flagged: 1.44346e+06 total: 4.3991e+06 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Summary::getResult          Total Flagged: 1.44346e+06 Total Counts: 4.3991e+06 (32.8%)
17-Oct-2023 19:30:52 2023-10-17 23:30:52        INFO        Display::displayReports         Report Displays are turned OFF
17-Oct-2023 19:30:55 test_tool_agentflagger.py::test_display::test_display_data_single_channel_selection
17-Oct-2023 19:30:55 AgentFlagger:: Check nominal behaviour for single spw:chan selection 
17-Oct-2023 19:30:55 The MS is already around, just unflag
17-Oct-2023 19:30:55 PASSED
17-Oct-2023 19:30:55
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        AgentFlagger::open        Table type is Measurement Set
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        AgentFlagger::initAgents        There are initially 1 agents in the list. Agents: unflag
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        AgentFlagger::initAgents        There are 1 valid agents in the list. Agents: unflag
17-Oct-2023 19:30:55 2023-10-17 23:30:56        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
17-Oct-2023 19:30:55 2023-10-17 23:30:56        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
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (1028/1028)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        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
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2/2)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        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
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (1026/1026)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        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
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4/4)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        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
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2050/2050)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        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
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4096/4096)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        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
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (6/6)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        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
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2048/2048)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        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
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (4098/4098)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        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
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Unflag::chunkSummary        => Data unflagged so far 100% (2/2)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        FlagMSHandler::nextChunk         ====================================================================================
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Unflag::tableSummary        => Percentage of data un-flagged in table selection: 100%
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        AgentFlagger::run        => Writing flags to the MS
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        AgentFlagger::open        Table type is Measurement Set
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        FlagMSHandler::selectData          Selected spw-channels ids are Axis Lengths: [4, 4]  (NB: Matrix in Row/Column order)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        FlagMSHandler::selectData +        [1, 0, 511, 1
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        FlagMSHandler::selectData +         2, 0, 0, 1
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        FlagMSHandler::selectData +         3, 0, 511, 1
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        FlagMSHandler::selectData +         4, 0, 0, 1]
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        AgentFlagger::initAgents        There are initially 3 agents in the list. Agents: manual, summary, display
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Manual::setAgentParameters         autocorr is 0
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Display::setAgentParameters          data column is FLOAT_DATA
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Display::setAgentParameters          Visibility expression is REAL XX,YY
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Display::setAgentParameters          pause is 0
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Display::setAgentParameters          datadisplay is 1
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Display::setAgentParameters          reportdisplay is 0
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Display::setAgentParameters          format is screen
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        AgentFlagger::initAgents        There are 3 valid agents in the list. Agents: manual, summary, display
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        FlagDataHandler::preLoadColumn         Setting row blocking to number of rows in selected table: 4
17-Oct-2023 19:30:55 2023-10-17 23:30:56        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
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 1 Scan : 1 : 1
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
17-Oct-2023 19:30:55 /home/casatest/venv/bin/python3.8: No module named casaplotserver
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Manual::chunkSummary        => Data flagged so far 100% (1024/1024)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        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
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 2 Scan : 1 : 1
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Manual::chunkSummary        => Data flagged so far 100% (2/2)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        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
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 3 Scan : 1 : 1
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Manual::chunkSummary        => Data flagged so far 100% (1024/1024)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        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
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Display::getChunkInfo         FlagAgentDisplay::getChunkInfo Field : 0 , r aqr Spw : 4 Scan : 1 : 1
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Display::processAntennaPair          Going to process requested baseline (0,0)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Manual::chunkSummary        => Data flagged so far 100% (2/2)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        FlagMSHandler::nextChunk         ====================================================================================
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Manual::tableSummary        => Percentage of data flagged in table selection: 100%
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        AgentFlagger::run        => Writing flags to the MS
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Summary::getResult          observation 0 flagged: 2052 total: 2052 (100%)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Summary::getResult          scan 1 flagged: 2052 total: 2052 (100%)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Summary::getResult          antenna PM04 flagged: 2052 total: 2052 (100%)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Summary::getResult          field r aqr flagged: 2052 total: 2052 (100%)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Summary::getResult          spw 4 flagged: 2 total: 2 (100%)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Summary::getResult          spw 3 flagged: 1024 total: 1024 (100%)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Summary::getResult          spw 1 flagged: 1024 total: 1024 (100%)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Summary::getResult          spw 2 flagged: 2 total: 2 (100%)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Summary::getResult          correlation YY flagged: 1026 total: 1026 (100%)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Summary::getResult          correlation XX flagged: 1026 total: 1026 (100%)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Summary::getResult          array 0 flagged: 2052 total: 2052 (100%)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Summary::getResult          Total Flagged: 2052 Total Counts: 2052 (100%)
17-Oct-2023 19:30:55 2023-10-17 23:30:56        INFO        Display::displayReports         Report Displays are turned OFF
17-Oct-2023 19:30:55 test_tool_agentflagger.py::test_display::test_display_float_data
17-Oct-2023 19:30:55 AgentFlagger: Select spw, display and flag single-dish MS
17-Oct-2023 19:30:55 Moving data...
17-Oct-2023 19:30:56 PASSED
17-Oct-2023 19:30:56
17-Oct-2023 19:30:56 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_agentflagger/nose.xml -
17-Oct-2023 19:30:56 ======================== 35 passed, 1 warning in 27.97s ========================
17-Oct-2023 19:30:56 ============================= test session starts ==============================
17-Oct-2023 19:30:56 platform linux -- Python 3.8.7, pytest-7.4.2, pluggy-1.3.0 -- /home/casatest/venv/bin/python3.8
17-Oct-2023 19:30:56 cachedir: .pytest_cache
17-Oct-2023 19:30:56 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager
17-Oct-2023 19:30:56 configfile: pytest.ini
17-Oct-2023 19:30:56 collecting ... collected 17 items
17-Oct-2023 19:30:56
17-Oct-2023 19:30:56
17-Oct-2023 19:30:57 test_tool_vpmanager.py::vpmanager_test::test0
17-Oct-2023 19:30:57 Test 0: reset
17-Oct-2023 19:30:57 PASSED
17-Oct-2023 19:30:57
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps        Voltage patterns internally defined in CASA (* = global default for this telescope):
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps+          Telescope: Class
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * ATCA_L1: INVERSE POLYNOMIAL
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * ATCA_L2: POLYNOMIAL
17-Oct-2023 19:30:57 2023-10-17 23:30:57        WARN        PBMath::pbMathInterfaceForCommonPB        ATCA_L3 not yet implemented defaulting to L2 version
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * ATCA_L3: POLYNOMIAL
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * ATCA_S: INVERSE POLYNOMIAL
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        PBMath1DIPoly::fillPBArray        Using wideband interpolated beam pattern
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * ATCA_C: INVERSE POLYNOMIAL
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        PBMath1DIPoly::fillPBArray        Using wideband interpolated beam pattern
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * ATCA_X: INVERSE POLYNOMIAL
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * GBT: POLYNOMIAL
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * GMRT: NUMERIC
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * HATCREEK: GAUSSIAN
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * NRAO12M: NUMERIC
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * UNKNOWN: NUMERIC
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * OVRO: NUMERIC
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * VLA: POLYNOMIAL
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * VLA_INVERSE: INVERSE POLYNOMIAL
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * VLA_NVSS: AIRY
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * VLA_2NULL: AIRY
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * VLA_4: AIRY
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * VLA_P: AIRY
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * VLA_L: AIRY
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * VLA_C: AIRY
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * VLA_X: AIRY
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * VLA_U: AIRY
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * VLA_K: AIRY
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * VLA_Q: AIRY
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * WSRT: COSINE POLYNOMIAL
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * WSRT_LOW: COSINE POLYNOMIAL
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * ALMA: AIRY
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * ALMASD: AIRY
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * ACA: AIRY
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * IRAMPDB: AIRY
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * IRAM30M: AIRY
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * SMA: NUMERIC
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * ATA: AIRY
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        PBMath::pbMathInterfaceForCommonPB        PBMath using 2011/10/22 5.5GHz PB
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * ATCA_C_RI: NUMERIC
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * ATCA: INVERSE POLYNOMIAL
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        PBMath1DIPoly::fillPBArray        Using wideband interpolated beam pattern
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * ATCA_16: INVERSE POLYNOMIAL
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * ATCA_K: INVERSE POLYNOMIAL
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * ATCA_Q: INVERSE POLYNOMIAL
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * ATCA_W: INVERSE POLYNOMIAL
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * EVLA: POLYNOMIAL
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps         * NGVLA: AIRY
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps        
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps+        Externally defined voltage patterns (* = global default for this telescope):
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vpmanager::summarizevps                None
17-Oct-2023 19:30:57 test_tool_vpmanager.py::vpmanager_test::test1
17-Oct-2023 19:30:57 Test 1: summarizevps
17-Oct-2023 19:30:57 PASSED
17-Oct-2023 19:30:57
17-Oct-2023 19:30:57 test_tool_vpmanager.py::vpmanager_test::test10
17-Oct-2023 19:30:57 Test 10: define Airy beams for ALMA antenna types, then use them
17-Oct-2023 19:30:57 PASSED
17-Oct-2023 19:30:57
17-Oct-2023 19:30:57 test_tool_vpmanager.py::vpmanager_test::test11
17-Oct-2023 19:30:57 Test 11: getvp without observation parameters
17-Oct-2023 19:30:57 PASSED
17-Oct-2023 19:30:57
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vp::createantresp        Found 0 response images in directory /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager/mydir3
17-Oct-2023 19:30:57 2023-10-17 23:30:57        SEVERE        vp::createantresp        No images found in directory mydir3
17-Oct-2023 19:30:57 test_tool_vpmanager.py::vpmanager_test::test12
17-Oct-2023 19:30:57 Test 12: EXPECTED ERROR createantresp - no images
17-Oct-2023 19:30:57 PASSED
17-Oct-2023 19:30:57
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vp::createantresp        Found 6 response images in directory /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager/mydir3
17-Oct-2023 19:30:57 2023-10-17 23:30:57        SEVERE        vp::createantresp        Image ALMA_0_DV__0._0._360._0._45._90._80._100._110._GHz_ticra2007_EFP.im has band definition inconsistent with the available bands.
17-Oct-2023 19:30:57 test_tool_vpmanager.py::vpmanager_test::test13
17-Oct-2023 19:30:57 Test 13: EXPECTED ERROR createantresp - two images have faulty band def
17-Oct-2023 19:30:57 PASSED
17-Oct-2023 19:30:57
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vp::createantresp        Found 6 response images in directory /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager/mydir3
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vp::createantresp        Created antenna responses table /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager/mydir3/AntennaResponses
17-Oct-2023 19:30:57 2023-10-17 23:30:57        INFO        vp::createantresp+         with 2 rows.
17-Oct-2023 19:30:57 test_tool_vpmanager.py::vpmanager_test::test14
17-Oct-2023 19:30:57 Test 14: createantresp - good input: six images, two antenna types
17-Oct-2023 19:30:57 PASSED
17-Oct-2023 19:30:57
17-Oct-2023 19:30:57 2023-10-17 23:30:58        SEVERE        vp::getrespimagename        No antenna responses path set for observatory: "ALMA2" in the AntennaResponses column of the Observatories table.
17-Oct-2023 19:30:57 test_tool_vpmanager.py::vpmanager_test::test15
17-Oct-2023 19:30:57 Test 15: EXPECTED ERROR get image name from non-existant observatory
17-Oct-2023 19:30:57 PASSED
17-Oct-2023 19:30:57
17-Oct-2023 19:30:57 2023-10-17 23:30:58        INFO        vpmanager::loadfromtable        Loaded 1 VP definitions and 41 VP default settings from table mydefs.tab
17-Oct-2023 19:30:57 test_tool_vpmanager.py::vpmanager_test::test16
17-Oct-2023 19:30:57 Test 16: define Airy beam for ALMA, save it, load it, then use it
17-Oct-2023 19:30:57 PASSED
17-Oct-2023 19:30:57
17-Oct-2023 19:30:57 test_tool_vpmanager.py::vpmanager_test::test2
17-Oct-2023 19:30:57 Test 2: getvp for VLA
17-Oct-2023 19:30:57 PASSED
17-Oct-2023 19:30:57
17-Oct-2023 19:30:57 test_tool_vpmanager.py::vpmanager_test::test3
17-Oct-2023 19:30:57 Test 3: getvp and getvps for ALMA
17-Oct-2023 19:30:57 PASSED
17-Oct-2023 19:30:57
17-Oct-2023 19:30:57 test_tool_vpmanager.py::vpmanager_test::test4
17-Oct-2023 19:30:57 Test 4: numvps for VLA
17-Oct-2023 19:30:57 PASSED
17-Oct-2023 19:30:57
17-Oct-2023 19:30:57 test_tool_vpmanager.py::vpmanager_test::test5
17-Oct-2023 19:30:57 Test 5: numvps for ALMA
17-Oct-2023 19:30:57 PASSED
17-Oct-2023 19:30:57
17-Oct-2023 19:30:57 test_tool_vpmanager.py::vpmanager_test::test6
17-Oct-2023 19:30:57 Test 6: numvps for ALMA with too high freq
17-Oct-2023 19:30:57 PASSED
17-Oct-2023 19:30:57
17-Oct-2023 19:30:57 test_tool_vpmanager.py::vpmanager_test::test7
17-Oct-2023 19:30:57 Test 7: setuserdefault for ALMA
17-Oct-2023 19:30:57 PASSED
17-Oct-2023 19:30:57
17-Oct-2023 19:30:57 test_tool_vpmanager.py::vpmanager_test::test8
17-Oct-2023 19:30:57 Test 8: define Airy beam for ALMA, then use it
17-Oct-2023 19:30:57 PASSED
17-Oct-2023 19:30:57
17-Oct-2023 19:30:58 test_tool_vpmanager.py::vpmanager_test::test9 Processing request for geometries from observatory ALMA, antenna type DV
17-Oct-2023 19:30:58 2023-10-17 23:30:58        INFO        BeamCalc::setBeamCalcGeometries()        Initialisation of geometries for observatory ALMA, antenna type DV
17-Oct-2023 19:30:58 2023-10-17 23:30:58        INFO        BeamCalc::setBeamCalcGeometries()        from file /opt/casa/data/master/alma/responses/ALMA_0_DV__0_0_360_0_45_90_31_506_950_GHz_beamcalc_INTERNAL.txt
17-Oct-2023 19:30:58 2023-10-17 23:30:58        INFO        BeamCalc::setBeamCalcGeometries()+        ... successful.
17-Oct-2023 19:30:58 **Writing ALMA Apertures for Pol 9 to disk
17-Oct-2023 19:30:58 Done writing apertures to disk
17-Oct-2023 19:30:59 Processing request for geometries from observatory ALMA, antenna type DA
17-Oct-2023 19:30:59 2023-10-17 23:30:59        INFO        BeamCalc::setBeamCalcGeometries()        Initialisation of geometries for observatory ALMA, antenna type DA
17-Oct-2023 19:30:59 2023-10-17 23:31:00        INFO        BeamCalc::setBeamCalcGeometries()        from file /opt/casa/data/master/alma/responses/ALMA_0_DA__0_0_360_0_45_90_31_506_950_GHz_beamcalc_INTERNAL.txt
17-Oct-2023 19:30:59 2023-10-17 23:31:00        INFO        BeamCalc::setBeamCalcGeometries()+        ... successful.
17-Oct-2023 19:30:59 **Writing ALMA Apertures for Pol 9 to disk
17-Oct-2023 19:31:00 Done writing apertures to disk
17-Oct-2023 19:31:01 Processing request for geometries from observatory ALMA, antenna type PM
17-Oct-2023 19:31:01 2023-10-17 23:31:01        INFO        BeamCalc::setBeamCalcGeometries()        Initialisation of geometries for observatory ALMA, antenna type PM
17-Oct-2023 19:31:01 2023-10-17 23:31:01        INFO        BeamCalc::setBeamCalcGeometries()        from file /opt/casa/data/master/alma/responses/ALMA_0_PM__0_0_360_0_45_90_31_506_950_GHz_beamcalc_INTERNAL.txt
17-Oct-2023 19:31:01 2023-10-17 23:31:01        INFO        BeamCalc::setBeamCalcGeometries()+        ... successful.
17-Oct-2023 19:31:01 **Writing ALMA Apertures for Pol 9 to disk
17-Oct-2023 19:31:02 Done writing apertures to disk
17-Oct-2023 19:31:02 Processing request for geometries from observatory ALMA, antenna type CM
17-Oct-2023 19:31:02 2023-10-17 23:31:03        INFO        BeamCalc::setBeamCalcGeometries()        Initialisation of geometries for observatory ALMA, antenna type CM
17-Oct-2023 19:31:03 2023-10-17 23:31:03        INFO        BeamCalc::setBeamCalcGeometries()        from file /opt/casa/data/master/alma/responses/ALMA_0_CM__0_0_360_0_45_90_31_506_950_GHz_beamcalc_INTERNAL.txt
17-Oct-2023 19:31:03 2023-10-17 23:31:03        INFO        BeamCalc::setBeamCalcGeometries()+        ... successful.
17-Oct-2023 19:31:03 **Writing ALMA Apertures for Pol 9 to disk
17-Oct-2023 19:31:03 Done writing apertures to disk
17-Oct-2023 19:31:03
17-Oct-2023 19:31:03 Test 9: define reference to antresp table for ALMA, then use it
17-Oct-2023 19:31:03 PASSED
17-Oct-2023 19:31:03
17-Oct-2023 19:31:03 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_vpmanager/nose.xml -
17-Oct-2023 19:31:03 ======================== 17 passed, 1 warning in 7.42s =========================
17-Oct-2023 19:31:04 ============================= test session starts ==============================
17-Oct-2023 19:31:04 platform linux -- Python 3.8.7, pytest-7.4.2, pluggy-1.3.0 -- /home/casatest/venv/bin/python3.8
17-Oct-2023 19:31:04 cachedir: .pytest_cache
17-Oct-2023 19:31:04 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_logsink
17-Oct-2023 19:31:04 configfile: pytest.ini
17-Oct-2023 19:31:04 collecting ... collected 4 items
17-Oct-2023 19:31:04
17-Oct-2023 19:31:04
17-Oct-2023 19:31:04 test_tool_logsink.py::LogsinkTest::test_getorigin_initial_origin
17-Oct-2023 19:31:04 Check the initial value of logsink.origin by getorigin.
17-Oct-2023 19:31:04 PASSED
17-Oct-2023 19:31:04
17-Oct-2023 19:31:04 test_tool_logsink.py::LogsinkTest::test_getorigin_set_nullvalues
17-Oct-2023 19:31:04 Check that the null values set logsink.origin can get correctly by getorigin.
17-Oct-2023 19:31:04 PASSED
17-Oct-2023 19:31:04
17-Oct-2023 19:31:04 test_tool_logsink.py::LogsinkTest::test_getorigin_set_num
17-Oct-2023 19:31:04 Check that the numeric values set logsink.origin can get correctly by getorigin.
17-Oct-2023 19:31:04 PASSED
17-Oct-2023 19:31:04
17-Oct-2023 19:31:04 test_tool_logsink.py::LogsinkTest::test_getorigin_set_strings
17-Oct-2023 19:31:04 Check that the string values set logsink.origin can get correctly by getorigin.
17-Oct-2023 19:31:04 PASSED
17-Oct-2023 19:31:04
17-Oct-2023 19:31:04 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_logsink/nose.xml -
17-Oct-2023 19:31:04 ========================= 4 passed, 1 warning in 0.44s =========================
17-Oct-2023 19:31:05 ============================= test session starts ==============================
17-Oct-2023 19:31:05 platform linux -- Python 3.8.7, pytest-7.4.2, pluggy-1.3.0 -- /home/casatest/venv/bin/python3.8
17-Oct-2023 19:31:05 cachedir: .pytest_cache
17-Oct-2023 19:31:05 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor
17-Oct-2023 19:31:05 configfile: pytest.ini
17-Oct-2023 19:31:05 collecting ... collected 9 items
17-Oct-2023 19:31:05
17-Oct-2023 19:31:05
17-Oct-2023 19:31:05 2023-10-17 23:31:06        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:05 2023-10-17 23:31:06        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:05 2023-10-17 23:31:06        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
17-Oct-2023 19:31:05 2023-10-17 23:31:06        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
17-Oct-2023 19:31:05 2023-10-17 23:31:06        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
17-Oct-2023 19:31:05 2023-10-17 23:31:06        INFO        ImageRegion::fromRecord        Selected bounding box :
17-Oct-2023 19:31:05 2023-10-17 23:31:06        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
17-Oct-2023 19:31:05 2023-10-17 23:31:06        INFO        ImageRegion::fromRecord        Selected bounding box :
17-Oct-2023 19:31:05 2023-10-17 23:31:06        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
17-Oct-2023 19:31:05 2023-10-17 23:31:06        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
17-Oct-2023 19:31:05 2023-10-17 23:31:06        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
17-Oct-2023 19:31:06 2023-10-17 23:31:06        INFO        ImageRegion::fromRecord        Selected bounding box :
17-Oct-2023 19:31:06 2023-10-17 23:31:06        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 0, 0]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, I)
17-Oct-2023 19:31:06 2023-10-17 23:31:06        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
17-Oct-2023 19:31:06 2023-10-17 23:31:06        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
17-Oct-2023 19:31:06 2023-10-17 23:31:06        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
17-Oct-2023 19:31:06 2023-10-17 23:31:06        INFO        ImageRegion::fromRecord        Selected bounding box :
17-Oct-2023 19:31:06 2023-10-17 23:31:06        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
17-Oct-2023 19:31:06 2023-10-17 23:31:06        INFO        ImageRegion::fromRecord        Selected bounding box :
17-Oct-2023 19:31:06 2023-10-17 23:31:06        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
17-Oct-2023 19:31:06 2023-10-17 23:31:06        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
17-Oct-2023 19:31:06 2023-10-17 23:31:06        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
17-Oct-2023 19:31:06 2023-10-17 23:31:07        INFO        name::        No table opened.
17-Oct-2023 19:31:06 2023-10-17 23:31:07        INFO        showcache::        The Table Cache is empty.
17-Oct-2023 19:31:06 test_tool_image_pbcor.py::ia_pbcor_test::test_4d_image_with_2d_pb
17-Oct-2023 19:31:06 ia.pbcor: Test full image divide with cutoff. Primary beam is 2 D, image is 4 D
17-Oct-2023 19:31:06 PASSED
17-Oct-2023 19:31:06
17-Oct-2023 19:31:06 2023-10-17 23:31:07        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [5, 5, 1, 1]
17-Oct-2023 19:31:07 2023-10-17 23:31:07        INFO        name::        No table opened.
17-Oct-2023 19:31:07 2023-10-17 23:31:07        INFO        showcache::        The Table Cache is empty.
17-Oct-2023 19:31:07 test_tool_image_pbcor.py::ia_pbcor_test::test_diff_spectral_coordinate
17-Oct-2023 19:31:07 Verify fix that a different spectral coordinates in target and template don't matter, CAS-5096
17-Oct-2023 19:31:07 PASSED
17-Oct-2023 19:31:07
17-Oct-2023 19:31:07 2023-10-17 23:31:08        INFO        ImageFactory::createImage        Created Paged image 't_in.im' of shape [20, 20, 4, 20] with float valued pixels.
17-Oct-2023 19:31:07 2023-10-17 23:31:08        INFO        ImageFactory::createImage        Created Paged image 't_pb_in.im' of shape [20, 20, 4, 20] with float valued pixels.
17-Oct-2023 19:31:07 2023-10-17 23:31:08        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
17-Oct-2023 19:31:07 2023-10-17 23:31:08        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
17-Oct-2023 19:31:07 2023-10-17 23:31:08        INFO        CasacRegionManager::fromBCS        Using polarizations I
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        ImageRegion::fromRecord        Selected bounding box :
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [19, 19, 0, 19]  (00:00:40.000, -00.10.00.001, I, 1.41499e+09Hz to 23:59:24.000, +00.09.00.001, I, 1.41501e+09Hz)
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        ImageRegion::fromRecord        Selected bounding box :
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [19, 19, 0, 19]  (00:00:40.000, -00.10.00.001, I, 1.41499e+09Hz to 23:59:24.000, +00.09.00.001, I, 1.41501e+09Hz)
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        SubImageFactory::createImage        Creating image 't_out.im' of shape [20, 20, 1, 20]
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        name::        No table opened.
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        showcache::        The Table Cache is empty.
17-Oct-2023 19:31:08 test_tool_image_pbcor.py::ia_pbcor_test::test_empty_region_and_stokes
17-Oct-2023 19:31:08 Test specifying stokes with empty region works (CAS-11708)
17-Oct-2023 19:31:08 PASSED
17-Oct-2023 19:31:08
17-Oct-2023 19:31:08 2023-10-17 23:31:08        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Exception Reported: Exception: File name is empty.
17-Oct-2023 19:31:08 2023-10-17 23:31:08        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)+        ... thrown by static void casa::ImageFactory::_checkInfile(const casacore::String&) at File: /source/casa6/casatools/src/code/imageanalysis/ImageAnalysis/ImageFactory2.cc, line: 371
17-Oct-2023 19:31:08 2023-10-17 23:31:08        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Exception Reported: Exception: File totally_bogus does not exist..
17-Oct-2023 19:31:08 2023-10-17 23:31:08        SEVERE        image::open (file src/tools/image/image_cmpt.cc, line 4208)+        ... thrown by static void casa::ImageFactory::_checkInfile(const casacore::String&) at File: /source/casa6/casatools/src/code/imageanalysis/ImageAnalysis/ImageFactory2.cc, line: 375
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:08 2023-10-17 23:31:08        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Exception: The image filename is empty.
17-Oct-2023 19:31:08 2023-10-17 23:31:08        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)+        ... thrown by static void casacore::ImageUtilities::openImage(casacore::ImageInterface<T>*&, const casacore::String&) [with T = float] at File: /source/casainstall/include/casacore/images/Images/ImageUtilities2.tcc, line: 255
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:08 2023-10-17 23:31:08        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Exception: File 'totally_bogus2' does not exist.
17-Oct-2023 19:31:08 2023-10-17 23:31:08        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)+        ... thrown by static void casacore::ImageUtilities::openImage(casacore::ImageInterface<T>*&, const casacore::String&) [with T = float] at File: /source/casainstall/include/casacore/images/Images/ImageUtilities2.tcc, line: 260
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:08 2023-10-17 23:31:08        SEVERE        ImageInputProcessor::_process        Requested output image /bogusplace/bogusimage cannot be created so will not be written
17-Oct-2023 19:31:08 2023-10-17 23:31:08        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: 2023-10-17 23:31:08        SEVERE        ImageInputProcessor::_process        Requested output image /bogusplace/bogusimage cannot be created so will not be written
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:08 2023-10-17 23:31:08        WARN                /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/pbtest1_im.fits is not a valid or readable table
17-Oct-2023 19:31:08 2023-10-17 23:31:08        SEVERE                Cannot read image /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/pbtest1_im.fits to get region bogus_region
17-Oct-2023 19:31:08 2023-10-17 23:31:08        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Unable to open region file or region table description bogus_region in image /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/pbtest1_im.fits at File: /source/casa6/casatools/src/code/imageanalysis/Regions/CasacRegionManager.cc, line: 486
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:08 2023-10-17 23:31:08        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Unknown mode zz
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:08 2023-10-17 23:31:08        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: Coordinate systems of image and template are different: The DirectionCoordinates have differing LinearXform components at File: /source/casa6/casatools/src/code/imageanalysis/ImageAnalysis/ImagePrimaryBeamCorrector.cc, line: 141
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        name::        No table opened.
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        showcache::        The Table Cache is empty.
17-Oct-2023 19:31:08 test_tool_image_pbcor.py::ia_pbcor_test::test_exceptions
17-Oct-2023 19:31:08 ia.pbcor: Test various exception cases
17-Oct-2023 19:31:08 PASSED
17-Oct-2023 19:31:08
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        ImageRegion::fromRecord        Selected bounding box :
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        ImageRegion::fromRecord        Selected bounding box :
17-Oct-2023 19:31:08 2023-10-17 23:31:08        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
17-Oct-2023 19:31:08 2023-10-17 23:31:09        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
17-Oct-2023 19:31:08 2023-10-17 23:31:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:08 2023-10-17 23:31:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:08 2023-10-17 23:31:09        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
17-Oct-2023 19:31:08 2023-10-17 23:31:09        INFO        ImageRegion::fromRecord        Selected bounding box :
17-Oct-2023 19:31:08 2023-10-17 23:31:09        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
17-Oct-2023 19:31:08 2023-10-17 23:31:09        INFO        ImageRegion::fromRecord        Selected bounding box :
17-Oct-2023 19:31:08 2023-10-17 23:31:09        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
17-Oct-2023 19:31:08 2023-10-17 23:31:09        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
17-Oct-2023 19:31:09 2023-10-17 23:31:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:09 2023-10-17 23:31:09        INFO        name::        No table opened.
17-Oct-2023 19:31:09 2023-10-17 23:31:09        INFO        showcache::        The Table Cache is empty.
17-Oct-2023 19:31:09 test_tool_image_pbcor.py::ia_pbcor_test::test_full_image_divide
17-Oct-2023 19:31:09 ia.pbcor: Test full image divide
17-Oct-2023 19:31:09 PASSED
17-Oct-2023 19:31:09
17-Oct-2023 19:31:09 2023-10-17 23:31:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:09 2023-10-17 23:31:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:09 2023-10-17 23:31:09        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:09 2023-10-17 23:31:09        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
17-Oct-2023 19:31:09 2023-10-17 23:31:09        INFO        ImageRegion::fromRecord        Selected bounding box :
17-Oct-2023 19:31:09 2023-10-17 23:31:09        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
17-Oct-2023 19:31:09 2023-10-17 23:31:09        INFO        ImageRegion::fromRecord        Selected bounding box :
17-Oct-2023 19:31:09 2023-10-17 23:31:09        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
17-Oct-2023 19:31:09 2023-10-17 23:31:09        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
17-Oct-2023 19:31:09 2023-10-17 23:31:09        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
17-Oct-2023 19:31:09 2023-10-17 23:31:10        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:09 2023-10-17 23:31:10        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
17-Oct-2023 19:31:09 2023-10-17 23:31:10        INFO        ImageRegion::fromRecord        Selected bounding box :
17-Oct-2023 19:31:09 2023-10-17 23:31:10        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
17-Oct-2023 19:31:09 2023-10-17 23:31:10        INFO        ImageRegion::fromRecord        Selected bounding box :
17-Oct-2023 19:31:09 2023-10-17 23:31:10        INFO        ImageRegion::fromRecord+            [0, 0] to [112, 75]  (00:00:29.333, -00.07.24.000 to 23:59:29.600, +00.07.36.000)
17-Oct-2023 19:31:09 2023-10-17 23:31:10        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76]
17-Oct-2023 19:31:09 2023-10-17 23:31:10        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
17-Oct-2023 19:31:10 2023-10-17 23:31:10        INFO        name::        No table opened.
17-Oct-2023 19:31:10 2023-10-17 23:31:10        INFO        showcache::        The Table Cache is empty.
17-Oct-2023 19:31:10 test_tool_image_pbcor.py::ia_pbcor_test::test_full_image_using_cutoff
17-Oct-2023 19:31:10 ia.pbcor: Test full image divide with cutoff
17-Oct-2023 19:31:10 PASSED
17-Oct-2023 19:31:10
17-Oct-2023 19:31:10 2023-10-17 23:31:10        INFO        ImageFactory::createImage        Created Paged image 'zz.im' of shape [20, 20] with float valued pixels.
17-Oct-2023 19:31:10 2023-10-17 23:31:11        INFO        SubImageFactory::createImage        Creating image 'pb_out.im' of shape [20, 20]
17-Oct-2023 19:31:10 2023-10-17 23:31:10        INFO        ::::ImageFactory::createImage        Created Paged image 'zz.im' of shape [20, 20] with float valued pixels.
17-Oct-2023 19:31:10 2023-10-17 23:31:10        INFO        ::::image::fromshape        Ran ia.fromshape
17-Oct-2023 19:31:10 2023-10-17 23:31:10        INFO        ::::image::fromshape        ia.fromshape(outfile="zz.im", shape=[20,20], csys={...}, linear=false, overwrite=false, log=true, type="f")
17-Oct-2023 19:31:10 2023-10-17 23:31:11        INFO        ::::image::pbcor        Ran ia.pbcor
17-Oct-2023 19:31:10 2023-10-17 23:31:11        INFO        ::::image::pbcor        ia.pbcor(pbimage="(...)", outfile="pb_out.im", overwrite=false, box="", region={...}, chans="", stokes="", mask="", mode="divide", cutoff=-1.000000, stretch=false)
17-Oct-2023 19:31:10 2023-10-17 23:31:11        INFO        name::        No table opened.
17-Oct-2023 19:31:10 2023-10-17 23:31:11        INFO        showcache::        The Table Cache is empty.
17-Oct-2023 19:31:10 test_tool_image_pbcor.py::ia_pbcor_test::test_history
17-Oct-2023 19:31:10 Test history records are written
17-Oct-2023 19:31:10 PASSED
17-Oct-2023 19:31:10
17-Oct-2023 19:31:10 2023-10-17 23:31:11        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:11 2023-10-17 23:31:11        INFO        ImageFactory::createImage        Created Paged image 'mult_pb.im' of shape [113, 76] with float valued pixels.
17-Oct-2023 19:31:11 2023-10-17 23:31:11        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
17-Oct-2023 19:31:11 2023-10-17 23:31:11        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
17-Oct-2023 19:31:11 2023-10-17 23:31:11        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
17-Oct-2023 19:31:11 2023-10-17 23:31:11        INFO        ImageRegion::fromRecord        Selected bounding box :
17-Oct-2023 19:31:11 2023-10-17 23:31:11        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
17-Oct-2023 19:31:11 2023-10-17 23:31:11        INFO        ImageRegion::fromRecord        Selected bounding box :
17-Oct-2023 19:31:11 2023-10-17 23:31:11        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
17-Oct-2023 19:31:11 2023-10-17 23:31:11        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
17-Oct-2023 19:31:11 2023-10-17 23:31:11        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
17-Oct-2023 19:31:11 2023-10-17 23:31:12        INFO        ImageRegion::fromRecord        Selected bounding box :
17-Oct-2023 19:31:11 2023-10-17 23:31:12        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 0, 0]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, I)
17-Oct-2023 19:31:11 2023-10-17 23:31:12        INFO        CasacRegionManager::fromBCS        No directional region specified. Using full positional plane.
17-Oct-2023 19:31:11 2023-10-17 23:31:12        INFO        CasacRegionManager::fromBCS        Using all spectral channels.
17-Oct-2023 19:31:11 2023-10-17 23:31:12        INFO        CasacRegionManager::fromBCS        Using polarizations ALL
17-Oct-2023 19:31:11 2023-10-17 23:31:12        INFO        ImageRegion::fromRecord        Selected bounding box :
17-Oct-2023 19:31:11 2023-10-17 23:31:12        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
17-Oct-2023 19:31:11 2023-10-17 23:31:12        INFO        ImageRegion::fromRecord        Selected bounding box :
17-Oct-2023 19:31:11 2023-10-17 23:31:12        INFO        ImageRegion::fromRecord+            [0, 0, 0, 0] to [112, 75, 4, 1]  (00:03:44.024, -00.38.00.046, 1.415e+09Hz, I to 23:56:15.977, +00.37.00.043, 1.415e+09Hz, Q)
17-Oct-2023 19:31:11 2023-10-17 23:31:12        INFO        SubImageFactory::createImage        Creating image 'mypb.im' of shape [113, 76, 5, 2]
17-Oct-2023 19:31:11 2023-10-17 23:31:12        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
17-Oct-2023 19:31:11 2023-10-17 23:31:12        INFO        name::        No table opened.
17-Oct-2023 19:31:11 2023-10-17 23:31:12        INFO        showcache::        The Table Cache is empty.
17-Oct-2023 19:31:11 test_tool_image_pbcor.py::ia_pbcor_test::test_multiply
17-Oct-2023 19:31:11 ia.pbcor: Test full image multiply with cutoff. Primary beam is 2 D, image is 4 D
17-Oct-2023 19:31:11 PASSED
17-Oct-2023 19:31:11
17-Oct-2023 19:31:11 2023-10-17 23:31:12        INFO        ImageFactory::createImage        Created Temp image  of shape [113, 76, 1, 1] with float valued pixels.
17-Oct-2023 19:31:12 2023-10-17 23:31:12        INFO        SubImageFactory::createImage        Creating image 'maskim' of shape [113, 76, 1, 1]
17-Oct-2023 19:31:12 2023-10-17 23:31:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:12 2023-10-17 23:31:12        SEVERE        image::pbcor (file src/tools/image/image_cmpt.cc, line 4289)        Exception Reported: The input image shape ([113, 76, 5, 2]) and mask shape ([113, 76, 1, 1]) are different, and it was specified that the mask should not be extended, so the mask cannot be applied to the (sub)image. Specifying that the mask should be extended may resolve the issue at File: /source/casainstall/include/casacpp/imageanalysis/ImageAnalysis/SubImageFactory.tcc, line: 306
17-Oct-2023 19:31:12 2023-10-17 23:31:12        WARN        image::open (file src/tools/image/image_cmpt.cc, line 4208)        Another image is already open, closing first
17-Oct-2023 19:31:12 2023-10-17 23:31:12        INFO        FITSCoordinateUtil::fromFITSHeader        passing empty or nonexistant spectral Coordinate axis
17-Oct-2023 19:31:12 2023-10-17 23:31:12        INFO        SubImageFactory::createImage        Creating image 'blahblah' of shape [113, 76, 5, 2]
17-Oct-2023 19:31:12 2023-10-17 23:31:12        INFO        ImageMaskAttacher::makeMask        Created mask `mask0'
17-Oct-2023 19:31:12 2023-10-17 23:31:13        INFO        name::        No table opened.
17-Oct-2023 19:31:12 2023-10-17 23:31:13        INFO        showcache::        The Table Cache is empty.
17-Oct-2023 19:31:12 test_tool_image_pbcor.py::ia_pbcor_test::test_stretch
17-Oct-2023 19:31:12 ia.pbcor(): Test stretch parameter
17-Oct-2023 19:31:12 PASSED
17-Oct-2023 19:31:12
17-Oct-2023 19:31:12 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_pbcor/nose.xml -
17-Oct-2023 19:31:12 ========================= 9 passed, 1 warning in 7.46s =========================
17-Oct-2023 19:31:13 ============================= test session starts ==============================
17-Oct-2023 19:31:13 platform linux -- Python 3.8.7, pytest-7.4.2, pluggy-1.3.0 -- /home/casatest/venv/bin/python3.8
17-Oct-2023 19:31:13 cachedir: .pytest_cache
17-Oct-2023 19:31:13 rootdir: /home/casatest/casa6/casatestutils/nosedir/test_tool_quanta
17-Oct-2023 19:31:13 configfile: pytest.ini
17-Oct-2023 19:31:13 collecting ... collected 9 items
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 2023-10-17 23:31:13        SEVERE                Exception Reported: Error in QuantumHolder::fromString with input string "bogus": Illegal input units or format
17-Oct-2023 19:31:13 2023-10-17 23:31:13        SEVERE        +         in converting quantity
17-Oct-2023 19:31:13 test_tool_quanta.py::quanta_convert_test::test_exceptions
17-Oct-2023 19:31:13 Test various exception cases
17-Oct-2023 19:31:13 PASSED
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 test_tool_quanta.py::quanta_convert_test::test_valid
17-Oct-2023 19:31:13 Test specifying the quantity as a scalar
17-Oct-2023 19:31:13 PASSED
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 test_tool_quanta.py::quanta_convert_test::test_value_as_string
17-Oct-2023 19:31:13 Test specifying value as a string
17-Oct-2023 19:31:13 PASSED
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 2023-10-17 23:31:14        SEVERE                Error in QuantumHolder::fromString with input string "blah": Illegal input units or format
17-Oct-2023 19:31:13 2023-10-17 23:31:14        SEVERE        +         in converting quantity
17-Oct-2023 19:31:13 2023-10-17 23:31:14        SEVERE                Exception Reported: Error in QuantumHolder::fromString with input string "blah": Illegal input units or format
17-Oct-2023 19:31:13 2023-10-17 23:31:14        SEVERE        +         in converting quantity
17-Oct-2023 19:31:13 2023-10-17 23:31:14        SEVERE                Error in QuantumHolder::fromString with input string "blah": Illegal input units or format
17-Oct-2023 19:31:13 2023-10-17 23:31:14        SEVERE        +         in converting quantity
17-Oct-2023 19:31:13 2023-10-17 23:31:14        SEVERE                Exception Reported: Error in QuantumHolder::fromString with input string "blah": Illegal input units or format
17-Oct-2023 19:31:13 2023-10-17 23:31:14        SEVERE        +         in converting quantity
17-Oct-2023 19:31:13 2023-10-17 23:31:14        SEVERE                Exception Reported: Unit::check Illegal unit string 'zz'
17-Oct-2023 19:31:13 2023-10-17 23:31:14        SEVERE                Exception Reported: Unit::check Illegal unit string 'zz'
17-Oct-2023 19:31:13 test_tool_quanta.py::quanta_quantity_test::test_exceptions
17-Oct-2023 19:31:13 Test various exception cases
17-Oct-2023 19:31:13 PASSED
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 test_tool_quanta.py::quanta_quantity_test::test_multidimensional_arra_value
17-Oct-2023 19:31:13 Test specifying the quantity as a multidimensional array
17-Oct-2023 19:31:13 PASSED
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 test_tool_quanta.py::quanta_quantity_test::test_scalar_value
17-Oct-2023 19:31:13 Test specifying the quantity as a scalar
17-Oct-2023 19:31:13 PASSED
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 test_tool_quanta.py::quanta_quantity_test::test_value_as_record
17-Oct-2023 19:31:13 Test value as record (eg already a quantity).
17-Oct-2023 19:31:13 This is essentially a reflection operator.
17-Oct-2023 19:31:13 PASSED
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 test_tool_quanta.py::quanta_quantity_test::test_value_as_string
17-Oct-2023 19:31:13 Test specifying value as a string
17-Oct-2023 19:31:13 PASSED
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 test_tool_quanta.py::quanta_quantity_test::test_vector_value
17-Oct-2023 19:31:13 Test specifying the quantity as a vector
17-Oct-2023 19:31:13 PASSED
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 - generated xml file: /home/casatest/casa6/casatestutils/nosedir/xml/test_tool_quanta/nose.xml -
17-Oct-2023 19:31:13 ========================= 9 passed, 1 warning in 0.45s =========================
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_componentlist/
17-Oct-2023 19:31:13 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_componentlist
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 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/
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calanalysis/
17-Oct-2023 19:31:13 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calanalysis
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 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/
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_fitprofile/
17-Oct-2023 19:31:13 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_fitprofile
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_fitprofile/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_fitprofile/
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater/
17-Oct-2023 19:31:13 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_calibrater
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 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/
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_sdm/
17-Oct-2023 19:31:13 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_sdm
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_sdm/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_sdm/
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_createmultims/
17-Oct-2023 19:31:13 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_createmultims
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_ms_createmultims/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_createmultims/
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms/
17-Oct-2023 19:31:13 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 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/
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msuvbinner/
17-Oct-2023 19:31:13 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_msuvbinner
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 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/
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_table/
17-Oct-2023 19:31:13 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_table
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_table/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_table/
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv/
17-Oct-2023 19:31:13 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pv
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 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/
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_statwt/
17-Oct-2023 19:31:13 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_ms_statwt
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 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/
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_regrid/
17-Oct-2023 19:31:13 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_regrid
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_regrid/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_regrid/
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_agentflagger/
17-Oct-2023 19:31:13 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_agentflagger
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 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/
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager/
17-Oct-2023 19:31:13 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_vpmanager/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_vpmanager/
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_logsink/
17-Oct-2023 19:31:13 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_logsink
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_logsink/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_logsink/
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/
17-Oct-2023 19:31:13 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_image_pbcor/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_image_pbcor/
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Setting Working Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_quanta/
17-Oct-2023 19:31:13 Test Directory: /home/casatest/casa6/casatestutils/nosedir/test_tool_quanta
17-Oct-2023 19:31:13
17-Oct-2023 19:31:13 Running Command: pytest --junitxml=/home/casatest/casa6/casatestutils/nosedir/xml/test_tool_quanta/nose.xml -s --disable-pytest-warnings --verbose -ra --tb=short /home/casatest/casa6/casatestutils/nosedir/test_tool_quanta/
17-Oct-2023 19:31:16 total 184832
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci 15001    112829 Oct 17 23:08 casatestutils-6.6.3.3a100.dev0+dirty-py3-none-any.whl
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci 15001 188982524 Oct 17 23:08 casatools-6.6.3.3a100.dev0+dirty-cp38-cp38-manylinux_2_28_x86_64.whl
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       4314 Oct 17 23:31 test_tool_agentflagger.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        980 Oct 17 23:31 test_tool_calanalysis.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       2632 Oct 17 23:31 test_tool_calibrater.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        545 Oct 17 23:31 test_tool_componentlist.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       7441 Oct 17 23:31 test_tool_coordsys.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root      12801 Oct 17 23:31 test_tool_image.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       2194 Oct 17 23:31 test_tool_image_collapse.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       1022 Oct 17 23:31 test_tool_image_deviation.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       2550 Oct 17 23:31 test_tool_image_fitprofile.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       1152 Oct 17 23:31 test_tool_image_pbcor.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        857 Oct 17 23:31 test_tool_image_pv.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        980 Oct 17 23:31 test_tool_image_rebin.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       1310 Oct 17 23:31 test_tool_image_regrid.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       1507 Oct 17 23:31 test_tool_image_statistics.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        740 Oct 17 23:31 test_tool_image_subimage.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        864 Oct 17 23:31 test_tool_image_transpose.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       1940 Oct 17 23:31 test_tool_imagepol.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        813 Oct 17 23:31 test_tool_linearmosaic.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        642 Oct 17 23:31 test_tool_logsink.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        523 Oct 17 23:31 test_tool_measures.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       5198 Oct 17 23:31 test_tool_ms.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        341 Oct 17 23:31 test_tool_ms_createmultims.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       2069 Oct 17 23:31 test_tool_ms_statwt.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       8487 Oct 17 23:31 test_tool_msmetadata.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        333 Oct 17 23:31 test_tool_msuvbinner.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       1145 Oct 17 23:31 test_tool_quanta.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       3951 Oct 17 23:31 test_tool_regionmanager.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       2047 Oct 17 23:31 test_tool_sdm.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       2075 Oct 17 23:31 test_tool_sdm_toms.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        422 Oct 17 23:31 test_tool_simulator.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       1337 Oct 17 23:31 test_tool_table.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       1691 Oct 17 23:31 test_tool_vpmanager.xml
17-Oct-2023 19:31:16 Finished task 'Test wheel' with result: Success
17-Oct-2023 19:31:16 Starting task 'Tar work directory' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
17-Oct-2023 19:31:16
Beginning to execute external process for build 'CASA - CMake CI Build - CAS-13901 - Test Tools Many Linux 2.28 #2 (CASA-CMAKECI101-TTOML228-2)'
... running command line:
/export/home/cbt-el7-11/bamboohome/temp/CASA-CMAKECI101-TTOML228-2-ScriptBuildTask-4485202000922677491.sh
... in: /export/home/cbt-el7-11/bamboohome/xml-data/build-dir/CASA-CMAKECI101-TTOML228
17-Oct-2023 19:31:16 Package working directory
17-Oct-2023 19:31:16 tar: work: Cannot stat: No such file or directory
17-Oct-2023 19:31:16 tar: Exiting with failure status due to previous errors
17-Oct-2023 19:31:16 total 184836
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci 15001    112829 Oct 17 23:08 casatestutils-6.6.3.3a100.dev0+dirty-py3-none-any.whl
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci 15001 188982524 Oct 17 23:08 casatools-6.6.3.3a100.dev0+dirty-cp38-cp38-manylinux_2_28_x86_64.whl
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       4314 Oct 17 23:31 test_tool_agentflagger.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        980 Oct 17 23:31 test_tool_calanalysis.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       2632 Oct 17 23:31 test_tool_calibrater.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        545 Oct 17 23:31 test_tool_componentlist.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       7441 Oct 17 23:31 test_tool_coordsys.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root      12801 Oct 17 23:31 test_tool_image.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       2194 Oct 17 23:31 test_tool_image_collapse.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       1022 Oct 17 23:31 test_tool_image_deviation.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       2550 Oct 17 23:31 test_tool_image_fitprofile.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       1152 Oct 17 23:31 test_tool_image_pbcor.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        857 Oct 17 23:31 test_tool_image_pv.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        980 Oct 17 23:31 test_tool_image_rebin.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       1310 Oct 17 23:31 test_tool_image_regrid.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       1507 Oct 17 23:31 test_tool_image_statistics.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        740 Oct 17 23:31 test_tool_image_subimage.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        864 Oct 17 23:31 test_tool_image_transpose.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       1940 Oct 17 23:31 test_tool_imagepol.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        813 Oct 17 23:31 test_tool_linearmosaic.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        642 Oct 17 23:31 test_tool_logsink.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        523 Oct 17 23:31 test_tool_measures.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       5198 Oct 17 23:31 test_tool_ms.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        341 Oct 17 23:31 test_tool_ms_createmultims.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       2069 Oct 17 23:31 test_tool_ms_statwt.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       8487 Oct 17 23:31 test_tool_msmetadata.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        333 Oct 17 23:31 test_tool_msuvbinner.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       1145 Oct 17 23:31 test_tool_quanta.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       3951 Oct 17 23:31 test_tool_regionmanager.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       2047 Oct 17 23:31 test_tool_sdm.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       2075 Oct 17 23:31 test_tool_sdm_toms.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root        422 Oct 17 23:31 test_tool_simulator.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       1337 Oct 17 23:31 test_tool_table.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root       1691 Oct 17 23:31 test_tool_vpmanager.xml
17-Oct-2023 19:31:16 -rw-r--r-- 1 casaci root         45 Oct 17 23:31 work-el7-3.8.tar.gz
17-Oct-2023 19:31:16 Done packaging working directory
17-Oct-2023 19:31:16 Finished task 'Tar work directory' with result: Success
17-Oct-2023 19:31:16 Starting task 'Parse tests' of type 'com.atlassian.bamboo.plugins.testresultparser:task.testresultparser.junit'
17-Oct-2023 19:31:16 Parsing test results under /export/home/cbt-el7-11/bamboohome/xml-data/build-dir/CASA-CMAKECI101-TTOML228...
17-Oct-2023 19:31:16 Finished task 'Parse tests' with result: Success
17-Oct-2023 19:31:16 Skipping execution of task 'Upload wheel' as it is disabled
17-Oct-2023 19:31:16 Starting task 'Cleanup' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
17-Oct-2023 19:31:16
Beginning to execute external process for build 'CASA - CMake CI Build - CAS-13901 - Test Tools Many Linux 2.28 #2 (CASA-CMAKECI101-TTOML228-2)'
... running command line:
/export/home/cbt-el7-11/bamboohome/temp/CASA-CMAKECI101-TTOML228-2-ScriptBuildTask-6891591425570903212.sh
... in: /export/home/cbt-el7-11/bamboohome/xml-data/build-dir/CASA-CMAKECI101-TTOML228
17-Oct-2023 19:31:16 Starting cleanup
17-Oct-2023 19:31:29 wheel-container-test
17-Oct-2023 19:31:30 wheel-container-test
17-Oct-2023 19:31:30 Cleanup complete
17-Oct-2023 19:31:30 Finished task 'Cleanup' with result: Success
17-Oct-2023 19:31:30 Running post build plugin 'Docker Container Cleanup'
17-Oct-2023 19:31:30
Beginning to execute external process for build 'CASA - CMake CI Build - CAS-13901 - Test Tools Many Linux 2.28 #2 (CASA-CMAKECI101-TTOML228-2)'
... running command line:
/bin/docker rm -f wheel-container-test
... in: /export/home/cbt-el7-11/bamboohome/xml-data/build-dir/CASA-CMAKECI101-TTOML228
17-Oct-2023 19:31:30 Error response from daemon: No such container: wheel-container-test
17-Oct-2023 19:31:30 Running post build plugin 'NCover Results Collector'
17-Oct-2023 19:31:30 Running post build plugin 'Clover Results Collector'
17-Oct-2023 19:31:30 Running post build plugin 'npm Cache Cleanup'
17-Oct-2023 19:31:30 Running post build plugin 'Artifact Copier'
17-Oct-2023 19:31:30 Publishing an artifact: Workdir
17-Oct-2023 19:31:30 Finished publishing of artifact Non required job artifact: [Workdir], pattern: [work*.tar.gz] anchored at: [wheeldirectory/] in 81.76 ms
17-Oct-2023 19:31:30 Publishing an artifact: Tests
17-Oct-2023 19:31:31 Finished publishing of artifact Non required job artifact: [Tests], pattern: [*.xml] anchored at: [wheeldirectory/] in 176.4 ms
17-Oct-2023 19:31:31 Publishing an artifact: xml Directories
17-Oct-2023 19:31:31 Finished publishing of artifact Non required job artifact: [xml Directories], pattern: [**/*.xml] anchored at: [wheeldirectory/] in 166.4 ms
17-Oct-2023 19:31:31 Finalising the build...
17-Oct-2023 19:31:31 Stopping timer.
17-Oct-2023 19:31:31 Build CASA-CMAKECI101-TTOML228-2 completed.
17-Oct-2023 19:31:31 Running on server: post build plugin 'NCover Results Collector'
17-Oct-2023 19:31:31 Running on server: post build plugin 'Build Hanging Detection Configuration'
17-Oct-2023 19:31:31 Running on server: post build plugin 'Clover Delta Calculator'
17-Oct-2023 19:31:31 Running on server: post build plugin 'Maven Dependencies Postprocessor'
17-Oct-2023 19:31:31 All post build plugins have finished
17-Oct-2023 19:31:31 Generating build results summary...
17-Oct-2023 19:31:31 Saving build results to disk...
17-Oct-2023 19:31:31 Store variable context...
17-Oct-2023 19:31:31 Indexing build results...
17-Oct-2023 19:31:31 Finished building CASA-CMAKECI101-TTOML228-2.