You are viewing a plain text version of this content. The canonical link for it is here.
Posted to github@trafficserver.apache.org by "ywkaras (via GitHub)" <gi...@apache.org> on 2023/02/03 00:16:32 UTC

[GitHub] [trafficserver] ywkaras opened a new issue, #9374: Reducing debug output causes "connect" Au test to fail

ywkaras opened a new issue, #9374:
URL: https://github.com/apache/trafficserver/issues/9374

   Presumably this is due to race condition(s).
   ```
   wkaras ~/REPOS/TS2/tests
   O$ git status
   # On branch master
   nothing to commit, working directory clean
   wkaras ~/REPOS/TS2/tests
   O$ goldtst -f connect
   Python 3.6 or newer detected!
   python3-dev/devel detected!
   pipenv detected!
   Using the pre-existing virtual environment.
   Environment config finished. Running AuTest...
   Running Test connect:... Passed
   
   Generating Report: --------------
   Total of 1 test
     Unknown: 0
     Exception: 0
     Failed: 0
     Warning: 0
     Skipped: 0
     Passed: 1
   wkaras ~/REPOS/TS2/tests
   O$ git diff
   diff --git a/tests/gold_tests/connect/connect.test.py b/tests/gold_tests/connect/connect.test.py
   index 95b2595..acbaa9c 100644
   --- a/tests/gold_tests/connect/connect.test.py
   +++ b/tests/gold_tests/connect/connect.test.py
   @@ -135,7 +135,7 @@ class ConnectViaPVTest:
    
            self.ts.Disk.records_config.update({
                'proxy.config.diags.debug.enabled': 1,
   -            'proxy.config.diags.debug.tags': 'http',
   +            'proxy.config.diags.debug.tags': 'http_tunnel',
                'proxy.config.http.server_ports': f"{self.ts.Variables.port}",
                'proxy.config.http.connect_ports': f"{self.server.Variables.http_port}",
            })
   wkaras ~/REPOS/TS2/tests
   O$ goldtst -f connect
   Python 3.6 or newer detected!
   python3-dev/devel detected!
   pipenv detected!
   Using the pre-existing virtual environment.
   Environment config finished. Running AuTest...
   Running Test connect:... Failed
   
   Generating Report: --------------
    Test: connect: Failed
       File: connect.test.py
       Directory: /home/wkaras/REPOS/TS2/tests/gold_tests/connect
      file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/access.log : Checking that file "/home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/access.log" exists - Passed
         Reason: File "/home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/access.log" exists
      file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/access.log : Checking that /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/access.log matches gold/connect_access.gold - Passed
         Reason: Values match
      Starting Test connect : No issues found - Passed
         Reason: Started!
      Process: httpbin: Passed
        Setting up : recycling port: 61000, queue size: 999 - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/httpbin - Passed
        Test : Checking that any test passes - Passed
           Reason: One or more tests passed
        
          Test : Checking that ReturnCode == None - Failed
             Reason: Returned Value 0 != None
          
        
          Test : Checking that ReturnCode == 0 - Passed
             Reason: Returned Value: 0 == 0
          
        Time-Out : Process finishes within expected time - Passed
           Reason: Returned value: 11.664219617843628 < 600.0
      Process: ts: Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts - Passed
        Setting up : Copying '/home/wkaras/TSX/TS2/bin' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/bin' - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config with uid: nobody gid: nobody - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config with uid: nobody gid: nogroup - Passed
        Setting up : Copying '/home/wkaras/REPOS/TS2/tests/gold_tests/autest-site/min_cfg/ip_allow.yaml' to directory '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config' as 'ip_allow.yaml'' - Passed
        Setting up : Copying '/home/wkaras/REPOS/TS2/tests/gold_tests/autest-site/min_cfg/readme.txt' to directory '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config' as 'readme.txt'' - Passed
        Setting up : Copying '/home/wkaras/REPOS/TS2/tests/gold_tests/autest-site/min_cfg/storage.config' to directory '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config' as 'storage.config'' - Passed
        Setting up : Copying '/home/wkaras/TSX/TS2/etc/trafficserver/body_factory' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config/body_factory' - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/cache - Passed
        Setting up : Copying '/home/wkaras/TSX/TS2/libexec/trafficserver' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/plugin' - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log with uid: nobody gid: nobody - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log with uid: nobody gid: nogroup - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/runtime - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/runtime with uid: nobody gid: nobody - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/runtime with uid: nobody gid: nogroup - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config/snapshots - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/ssl - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/ssl with uid: nobody gid: nobody - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/ssl with uid: nobody gid: nogroup - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/storage - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/storage with uid: nobody gid: nobody - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/storage with uid: nobody gid: nogroup - Passed
        Setting up : recycling port: 61001, queue size: 998 - Passed
        Setting up : recycling port: 61002, queue size: 997 - Passed
        Setting up : recycling port: 61003, queue size: 996 - Passed
        Setting up : recycling port: 61004, queue size: 995 - Passed
        Test : Checking that ReturnCode == 0 - Passed
           Reason: Returned Value: 0 == 0
        Time-Out : Process finishes within expected time - Passed
           Reason: Returned value: 12.455596923828125 < 600.0
        file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/diags.log : Diags log file diags.log should not contain errors - Passed
           Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/diags.log excludes expression
        file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/diags.log : Diags log file diags.log should not contain errors - Passed
           Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/diags.log excludes expression
        file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/diags.log : Diags log file diags.log should not contain a warning about an unrecognized configuration - Passed
           Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/diags.log excludes expression
        Appending File /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config/records.config : Writing config file records.config - Passed
           Reason: Success
        Appending File /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config/remap.config : Appended file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config/remap.config - Passed
           Reason: Success
        Appending File /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config/logging.yaml : Appended file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config/logging.yaml - Passed
           Reason: Success
      Process: connect-verifier-server: Passed
        Setting up : Copying '/home/wkaras/REPOS/TS2/tests/proxy-verifier/unpack/v2.6.0/bin' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-verifier-server/bin' - Passed
        Setting up : recycling port: 61005, queue size: 994 - Passed
        Setting up : recycling port: 61006, queue size: 993 - Passed
        Setting up : recycling port: 61007, queue size: 992 - Passed
        Setting up : Copying '/home/wkaras/REPOS/TS2/tests/gold_tests/autest-site/../../tools/proxy-verifier/ssl/server.pem' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-verifier-server/server.pem' - Passed
        Setting up : Copying '/home/wkaras/REPOS/TS2/tests/gold_tests/autest-site/../../tools/proxy-verifier/ssl/ca.pem' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-verifier-server/ca.pem' - Passed
        Setting up : Copying 'replays/connect.replay.yaml' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-verifier-server/connect.replay.yaml' - Passed
        Test : Checking that ReturnCode == 0 - Passed
           Reason: Returned Value: 0 == 0
        Time-Out : Process finishes within expected time - Passed
           Reason: Returned value: 3.113818407058716 < 600.0
        file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/_output/connect-connect-verifier-server/stream.stdout.txt : There should be no Proxy Verifier violation errors. - Passed
           Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/_output/connect-connect-verifier-server/stream.stdout.txt excludes expression
        file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/_output/connect-connect-verifier-server/stream.stdout.txt : Verify the CONNECT request doesn't reach the server. - Passed
           Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/_output/connect-connect-verifier-server/stream.stdout.txt excludes expression
        file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/_output/connect-connect-verifier-server/stream.stdout.txt : Verify the server gets the second request. - Passed
           Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/_output/connect-connect-verifier-server/stream.stdout.txt contained expression
      Process: connect-ts: Failed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts - Passed
        Setting up : Copying '/home/wkaras/TSX/TS2/bin' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/bin' - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config with uid: nobody gid: nobody - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config with uid: nobody gid: nogroup - Passed
        Setting up : Copying '/home/wkaras/REPOS/TS2/tests/gold_tests/autest-site/min_cfg/ip_allow.yaml' to directory '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config' as 'ip_allow.yaml'' - Passed
        Setting up : Copying '/home/wkaras/REPOS/TS2/tests/gold_tests/autest-site/min_cfg/readme.txt' to directory '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config' as 'readme.txt'' - Passed
        Setting up : Copying '/home/wkaras/REPOS/TS2/tests/gold_tests/autest-site/min_cfg/storage.config' to directory '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config' as 'storage.config'' - Passed
        Setting up : Copying '/home/wkaras/TSX/TS2/etc/trafficserver/body_factory' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config/body_factory' - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/cache - Passed
        Setting up : Copying '/home/wkaras/TSX/TS2/libexec/trafficserver' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/plugin' - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log with uid: nobody gid: nobody - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log with uid: nobody gid: nogroup - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/runtime - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/runtime with uid: nobody gid: nobody - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/runtime with uid: nobody gid: nogroup - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config/snapshots - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/ssl - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/ssl with uid: nobody gid: nobody - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/ssl with uid: nobody gid: nogroup - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/storage - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/storage with uid: nobody gid: nobody - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/storage with uid: nobody gid: nogroup - Passed
        Setting up : recycling port: 61008, queue size: 991 - Passed
        Setting up : recycling port: 61009, queue size: 990 - Passed
        Setting up : recycling port: 61010, queue size: 989 - Passed
        Setting up : recycling port: 61011, queue size: 988 - Passed
        Test : Checking that ReturnCode == 0 - Passed
           Reason: Returned Value: 0 == 0
        Time-Out : Process finishes within expected time - Passed
           Reason: Returned value: 4.19611930847168 < 600.0
        file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log/diags.log : Diags log file diags.log should not contain errors - Passed
           Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log/diags.log excludes expression
        file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log/diags.log : Diags log file diags.log should not contain errors - Passed
           Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log/diags.log excludes expression
        file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log/diags.log : Diags log file diags.log should not contain a warning about an unrecognized configuration - Passed
           Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log/diags.log excludes expression
        file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log/traffic.out : Verify that ATS recognizes the CONNECT request. - Failed
           Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log/traffic.out did not contains expression: "Proxy's Request.*
            .*
            CONNECT 127.0.0.1:61005 HTTP/1.1"
        Appending File /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config/records.config : Writing config file records.config - Passed
           Reason: Success
        Appending File /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config/remap.config : Appended file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config/remap.config - Passed
           Reason: Success
      Run: 0-tr: Passed
        Process: Default: Passed
          Test : Checking that ReturnCode == 0 - Passed
             Reason: Returned Value: 0 == 0
          file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/_output/0-tr-Default/stream.stderr.txt : Checking that /home/wkaras/REPOS/TS2/tests/_sandbox/connect/_output/0-tr-Default/stream.stderr.txt matches gold/connect_0_stderr.gold - Passed
             Reason: Values match
      Run: 1-tr: Passed
        Process: Default: Passed
          Test : Checking that ReturnCode == 0 - Passed
             Reason: Returned Value: 0 == 0
          Time-Out : Process finishes within expected time - Passed
             Reason: Returned value: 10.55914044380188 < 600.0
      Run: Verify correct handling of CONNECT request: Passed
        Process: Default: Passed
          Setting up : Copying '/home/wkaras/REPOS/TS2/tests/proxy-verifier/unpack/v2.6.0/bin' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-client/bin' - Passed
          Setting up : Copying 'replays/connect.replay.yaml' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-client/connect.replay.yaml' - Passed
          Setting up : Copying '/home/wkaras/REPOS/TS2/tests/gold_tests/autest-site/../../tools/proxy-verifier/ssl/client.pem' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-client/client.pem' - Passed
          Setting up : Copying '/home/wkaras/REPOS/TS2/tests/gold_tests/autest-site/../../tools/proxy-verifier/ssl/ca.pem' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-client/ca.pem' - Passed
          Test : Checking that ReturnCode == 0 - Passed
             Reason: Returned Value: 0 == 0
          file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/_output/2-tr-Default/stream.stdout.txt : There should be no Proxy Verifier violation errors. - Passed
             Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/_output/2-tr-Default/stream.stdout.txt excludes expression
   
   Total of 1 test
     Unknown: 0
     Exception: 0
     Failed: 1
     Warning: 0
     Skipped: 0
     Passed: 0
   wkaras ~/REPOS/TS2/tests
   O$ goldtst -f connect
   Python 3.6 or newer detected!
   python3-dev/devel detected!
   pipenv detected!
   Using the pre-existing virtual environment.
   Environment config finished. Running AuTest...
   Running Test connect:... Failed
   
   Generating Report: --------------
    Test: connect: Failed
       File: connect.test.py
       Directory: /home/wkaras/REPOS/TS2/tests/gold_tests/connect
      file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/access.log : Checking that file "/home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/access.log" exists - Passed
         Reason: File "/home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/access.log" exists
      file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/access.log : Checking that /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/access.log matches gold/connect_access.gold - Passed
         Reason: Values match
      Starting Test connect : No issues found - Passed
         Reason: Started!
      Process: httpbin: Passed
        Setting up : recycling port: 61000, queue size: 999 - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/httpbin - Passed
        Test : Checking that any test passes - Passed
           Reason: One or more tests passed
        
          Test : Checking that ReturnCode == None - Failed
             Reason: Returned Value 0 != None
          
        
          Test : Checking that ReturnCode == 0 - Passed
             Reason: Returned Value: 0 == 0
          
        Time-Out : Process finishes within expected time - Passed
           Reason: Returned value: 11.653622388839722 < 600.0
      Process: ts: Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts - Passed
        Setting up : Copying '/home/wkaras/TSX/TS2/bin' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/bin' - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config with uid: nobody gid: nobody - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config with uid: nobody gid: nogroup - Passed
        Setting up : Copying '/home/wkaras/REPOS/TS2/tests/gold_tests/autest-site/min_cfg/ip_allow.yaml' to directory '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config' as 'ip_allow.yaml'' - Passed
        Setting up : Copying '/home/wkaras/REPOS/TS2/tests/gold_tests/autest-site/min_cfg/readme.txt' to directory '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config' as 'readme.txt'' - Passed
        Setting up : Copying '/home/wkaras/REPOS/TS2/tests/gold_tests/autest-site/min_cfg/storage.config' to directory '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config' as 'storage.config'' - Passed
        Setting up : Copying '/home/wkaras/TSX/TS2/etc/trafficserver/body_factory' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config/body_factory' - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/cache - Passed
        Setting up : Copying '/home/wkaras/TSX/TS2/libexec/trafficserver' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/plugin' - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log with uid: nobody gid: nobody - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log with uid: nobody gid: nogroup - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/runtime - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/runtime with uid: nobody gid: nobody - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/runtime with uid: nobody gid: nogroup - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config/snapshots - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/ssl - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/ssl with uid: nobody gid: nobody - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/ssl with uid: nobody gid: nogroup - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/storage - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/storage with uid: nobody gid: nobody - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/storage with uid: nobody gid: nogroup - Passed
        Setting up : recycling port: 61001, queue size: 998 - Passed
        Setting up : recycling port: 61002, queue size: 997 - Passed
        Setting up : recycling port: 61003, queue size: 996 - Passed
        Setting up : recycling port: 61004, queue size: 995 - Passed
        Test : Checking that ReturnCode == 0 - Passed
           Reason: Returned Value: 0 == 0
        Time-Out : Process finishes within expected time - Passed
           Reason: Returned value: 12.442391157150269 < 600.0
        file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/diags.log : Diags log file diags.log should not contain errors - Passed
           Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/diags.log excludes expression
        file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/diags.log : Diags log file diags.log should not contain errors - Passed
           Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/diags.log excludes expression
        file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/diags.log : Diags log file diags.log should not contain a warning about an unrecognized configuration - Passed
           Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/log/diags.log excludes expression
        Appending File /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config/records.config : Writing config file records.config - Passed
           Reason: Success
        Appending File /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config/remap.config : Appended file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config/remap.config - Passed
           Reason: Success
        Appending File /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config/logging.yaml : Appended file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/ts/config/logging.yaml - Passed
           Reason: Success
      Process: connect-verifier-server: Passed
        Setting up : Copying '/home/wkaras/REPOS/TS2/tests/proxy-verifier/unpack/v2.6.0/bin' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-verifier-server/bin' - Passed
        Setting up : recycling port: 61005, queue size: 994 - Passed
        Setting up : recycling port: 61006, queue size: 993 - Passed
        Setting up : recycling port: 61007, queue size: 992 - Passed
        Setting up : Copying '/home/wkaras/REPOS/TS2/tests/gold_tests/autest-site/../../tools/proxy-verifier/ssl/server.pem' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-verifier-server/server.pem' - Passed
        Setting up : Copying '/home/wkaras/REPOS/TS2/tests/gold_tests/autest-site/../../tools/proxy-verifier/ssl/ca.pem' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-verifier-server/ca.pem' - Passed
        Setting up : Copying 'replays/connect.replay.yaml' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-verifier-server/connect.replay.yaml' - Passed
        Test : Checking that ReturnCode == 0 - Passed
           Reason: Returned Value: 0 == 0
        Time-Out : Process finishes within expected time - Passed
           Reason: Returned value: 3.1104109287261963 < 600.0
        file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/_output/connect-connect-verifier-server/stream.stdout.txt : There should be no Proxy Verifier violation errors. - Passed
           Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/_output/connect-connect-verifier-server/stream.stdout.txt excludes expression
        file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/_output/connect-connect-verifier-server/stream.stdout.txt : Verify the CONNECT request doesn't reach the server. - Passed
           Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/_output/connect-connect-verifier-server/stream.stdout.txt excludes expression
        file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/_output/connect-connect-verifier-server/stream.stdout.txt : Verify the server gets the second request. - Passed
           Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/_output/connect-connect-verifier-server/stream.stdout.txt contained expression
      Process: connect-ts: Failed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts - Passed
        Setting up : Copying '/home/wkaras/TSX/TS2/bin' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/bin' - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config with uid: nobody gid: nobody - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config with uid: nobody gid: nogroup - Passed
        Setting up : Copying '/home/wkaras/REPOS/TS2/tests/gold_tests/autest-site/min_cfg/ip_allow.yaml' to directory '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config' as 'ip_allow.yaml'' - Passed
        Setting up : Copying '/home/wkaras/REPOS/TS2/tests/gold_tests/autest-site/min_cfg/readme.txt' to directory '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config' as 'readme.txt'' - Passed
        Setting up : Copying '/home/wkaras/REPOS/TS2/tests/gold_tests/autest-site/min_cfg/storage.config' to directory '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config' as 'storage.config'' - Passed
        Setting up : Copying '/home/wkaras/TSX/TS2/etc/trafficserver/body_factory' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config/body_factory' - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/cache - Passed
        Setting up : Copying '/home/wkaras/TSX/TS2/libexec/trafficserver' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/plugin' - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log with uid: nobody gid: nobody - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log with uid: nobody gid: nogroup - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/runtime - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/runtime with uid: nobody gid: nobody - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/runtime with uid: nobody gid: nogroup - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config/snapshots - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/ssl - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/ssl with uid: nobody gid: nobody - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/ssl with uid: nobody gid: nogroup - Passed
        Setting up : Making Directory /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/storage - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/storage with uid: nobody gid: nobody - Passed
        Setting up : On /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/storage with uid: nobody gid: nogroup - Passed
        Setting up : recycling port: 61008, queue size: 991 - Passed
        Setting up : recycling port: 61009, queue size: 990 - Passed
        Setting up : recycling port: 61010, queue size: 989 - Passed
        Setting up : recycling port: 61011, queue size: 988 - Passed
        Test : Checking that ReturnCode == 0 - Passed
           Reason: Returned Value: 0 == 0
        Time-Out : Process finishes within expected time - Passed
           Reason: Returned value: 4.191974401473999 < 600.0
        file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log/diags.log : Diags log file diags.log should not contain errors - Passed
           Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log/diags.log excludes expression
        file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log/diags.log : Diags log file diags.log should not contain errors - Passed
           Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log/diags.log excludes expression
        file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log/diags.log : Diags log file diags.log should not contain a warning about an unrecognized configuration - Passed
           Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log/diags.log excludes expression
        file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log/traffic.out : Verify that ATS recognizes the CONNECT request. - Failed
           Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/log/traffic.out did not contains expression: "Proxy's Request.*
            .*
            CONNECT 127.0.0.1:61005 HTTP/1.1"
        Appending File /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config/records.config : Writing config file records.config - Passed
           Reason: Success
        Appending File /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config/remap.config : Appended file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-ts/config/remap.config - Passed
           Reason: Success
      Run: 0-tr: Passed
        Process: Default: Passed
          Test : Checking that ReturnCode == 0 - Passed
             Reason: Returned Value: 0 == 0
          file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/_output/0-tr-Default/stream.stderr.txt : Checking that /home/wkaras/REPOS/TS2/tests/_sandbox/connect/_output/0-tr-Default/stream.stderr.txt matches gold/connect_0_stderr.gold - Passed
             Reason: Values match
      Run: 1-tr: Passed
        Process: Default: Passed
          Test : Checking that ReturnCode == 0 - Passed
             Reason: Returned Value: 0 == 0
          Time-Out : Process finishes within expected time - Passed
             Reason: Returned value: 10.558431625366211 < 600.0
      Run: Verify correct handling of CONNECT request: Passed
        Process: Default: Passed
          Setting up : Copying '/home/wkaras/REPOS/TS2/tests/proxy-verifier/unpack/v2.6.0/bin' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-client/bin' - Passed
          Setting up : Copying 'replays/connect.replay.yaml' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-client/connect.replay.yaml' - Passed
          Setting up : Copying '/home/wkaras/REPOS/TS2/tests/gold_tests/autest-site/../../tools/proxy-verifier/ssl/client.pem' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-client/client.pem' - Passed
          Setting up : Copying '/home/wkaras/REPOS/TS2/tests/gold_tests/autest-site/../../tools/proxy-verifier/ssl/ca.pem' to '/home/wkaras/REPOS/TS2/tests/_sandbox/connect/connect-client/ca.pem' - Passed
          Test : Checking that ReturnCode == 0 - Passed
             Reason: Returned Value: 0 == 0
          file /home/wkaras/REPOS/TS2/tests/_sandbox/connect/_output/2-tr-Default/stream.stdout.txt : There should be no Proxy Verifier violation errors. - Passed
             Reason: Contents of /home/wkaras/REPOS/TS2/tests/_sandbox/connect/_output/2-tr-Default/stream.stdout.txt excludes expression
   
   Total of 1 test
     Unknown: 0
     Exception: 0
     Failed: 1
     Warning: 0
     Skipped: 0
     Passed: 0
   wkaras ~/REPOS/TS2/tests
   O$ git log -n 1
   commit 0c2488c7d0432698272b1433817ee62d0c263ab4 (HEAD, master)
   Author: Walt Karas <wk...@yahooinc.com>
   Date:   Tue Jan 31 21:43:11 2023 -0600
   
       Fix an error on SSL config reload (plus some cleanup). (#9334)
       
       * Fix an error on SSL config reload (plus some cleanup).
       
       This seems to have eliminated some ERROR diags we were seeing in Yahoo Prod when
       doing config reloads.
       
       The SSLSecret public functions no longer return pointers into the unorded_map of
       secrets, they return a copy of the secret data. This seemed thread unsafe. A
       periodic poll running in the background can update the secret data for an entry
       for a secret name in the map.
       
       To avoid exporting pointers, I had to change the prototype of TSSslSecretGet().
       Hopefully there are no existing plugins that are already using this TS API function,
       so breaking this rule will be moot. I added a new TS API type, TSAllocatedVarLenData,
       in order to be able to cleanly return a copy of the secret data.
       
       * YTSATS-4067: Fix deadlock with secret_map_mutex (#740)
       
       1. getOrLoadSecret grabbed the secret_map_mutex and called loadSecret.
       2. loadSecret dispatched to Continations that registered for the
          TS_EVENT_SSL_SECRET event. This would try to grab the Continuation's
          lock.
       3. In the meantime, those Continuations could call setSecret which would
          try to grab the secret_map_mutex. If this Continuation did this while
          holding the lock that step 2 is waiting upon, then there will be a
          deadlock between the Continuation lock and the secret_map_mutex
          between the two threads.
       
       This patch avoids the deadlock by releasing the secret_map_mutex lock
       before calling loadSecret. It also updates the secret_map when loading
       secrets from a file in loadSecret.
       
       ---------
       
       Co-authored-by: Brian Neradt <br...@verizonmedia.com>
   wkaras ~/REPOS/TS2/tests
   O$ cat ../config.nice
   #! /bin/sh
   #
   # Created by configure
   
   CFLAGS=" "; export CFLAGS
   CXXFLAGS="-I/opt/oath/imagemagick/7.1/include/ImageMagick-7"; export CXXFLAGS
   LDFLAGS="-L/opt/oath/libssh2/1.9/lib -L/opt/oath/nghttp2/1.43/lib -L/opt/oath/imagemagick/7.1/lib -L/opt/oath/libunwind/1.5/lib"; export LDFLAGS
   "./configure" \
   "--with-openssl=/opt/oath/openssl/1.1.1" \
   "--enable-experimental-plugins" \
   "--enable-example-plugins" \
   "--with-brotli=/opt/oath/brotli/1.0/include:/opt/oath/brotli/1.0/lib" \
   "--with-luajit=/usr/include/luajit-2.0:/usr/share/luajit-2.0.4/jit" \
   "--enable-debug" \
   "--enable-ccache" \
   "--enable-werror" \
   "--enable-yaml-headers" \
   "--prefix=/home/wkaras/TSX/TS2" \
   "--exec-prefix=/home/wkaras/TSX/TS2" \
   "PKG_CONFIG_PATH=/opt/oath/openssl/1.1.1/lib/pkgconfig:/opt/oath/pcre/8.45/lib/pkgconfig:/opt/oath/libevent/2.1/lib/pkgconfig:/opt/oath/expat/2.4/lib/pkgconfig:/opt/oath/libc-ares/1.17/lib/pkgconfig:/opt/oath/libc-ares/1.18/lib/pkgconfig:/opt/oath/brotli/1.0/lib/pkgconfig:/opt/oath/jemalloc/5.3/lib/pkgconfig:/opt/oath/libpng/1.6/lib/pkgconfig:/opt/oath/libicu/65.1/lib/pkgconfig:/opt/oath/libjpeg-turbo/2.1/lib/pkgconfig:/opt/oath/libwebp/1.2/lib/pkgconfig:/opt/oath/imagemagick/7.1/lib/pkgconfig:/opt/oath/libxml2/2.9/lib/pkgconfig:/opt/oath/libxml2/2.10/lib/pkgconfig:/opt/oath/libssh2/1.9/lib/pkgconfig:/opt/oath/libssh2/1.10/lib/pkgconfig:/opt/oath/numactl/2.0/lib/pkgconfig:/opt/oath/hwloc/2.6/lib/pkgconfig:/opt/oath/jansson/2.13/lib/pkgconfig:/opt/oath/jansson/2.14/lib/pkgconfig:/opt/oath/nghttp2/1.43/lib/pkgconfig:/opt/oath/libcurl/7.79/lib/pkgconfig:/opt/oath/libcurl/7.83/lib/pkgconfig:/opt/oath/libcurl/7.84/lib/pkgconfig:/opt/oath/libcurl/7.86/lib/pkgconfig:/opt/oath/libcurl/7.8
 7/lib/pkgconfig:/opt/oath/libunwind/1.5/lib/pkgconfig:/opt/oath/protobuf/3.17/lib/pkgconfig:/opt/oath/protobuf-c/1.4/lib/pkgconfig:/opt/oath/libyaml-cpp/0.7/share/pkgconfig:/opt/oath/libyaml-cpp/0.7/lib/pkgconfig:/opt/oath/trafficserver/9.1/lib/pkgconfig:/opt/oath/json-c/0.15/lib/pkgconfig:/opt/oath/jose/11.0/lib/pkgconfig:/opt/oath/libswoc/1.3.10/lib/pkgconfig" \
   "CFLAGS=" \
   "LDFLAGS=-L/opt/oath/libssh2/1.9/lib -L/opt/oath/nghttp2/1.43/lib -L/opt/oath/imagemagick/7.1/lib -L/opt/oath/libunwind/1.5/lib" \
   "CXXFLAGS=-I/opt/oath/imagemagick/7.1/include/ImageMagick-7" \
   "$@"
   wkaras ~/REPOS/TS2/tests
   O$ 
   ```


-- 
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.

To unsubscribe, e-mail: github-unsubscribe@trafficserver.apache.org.apache.org

For queries about this service, please contact Infrastructure at:
users@infra.apache.org


[GitHub] [trafficserver] ywkaras commented on issue #9374: Reducing debug output causes "connect" Au test to fail

Posted by "ywkaras (via GitHub)" <gi...@apache.org>.
ywkaras commented on issue #9374:
URL: https://github.com/apache/trafficserver/issues/9374#issuecomment-1414544098

   False alarm.


-- 
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.

To unsubscribe, e-mail: github-unsubscribe@trafficserver.apache.org

For queries about this service, please contact Infrastructure at:
users@infra.apache.org


[GitHub] [trafficserver] ywkaras closed issue #9374: Reducing debug output causes "connect" Au test to fail

Posted by "ywkaras (via GitHub)" <gi...@apache.org>.
ywkaras closed issue #9374: Reducing debug output causes "connect" Au test  to fail
URL: https://github.com/apache/trafficserver/issues/9374


-- 
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.

To unsubscribe, e-mail: github-unsubscribe@trafficserver.apache.org

For queries about this service, please contact Infrastructure at:
users@infra.apache.org