tests.system.test_system.TestLogging: test_list_entry_with_auditlog failed

[flaky-bot]

This test failed!

To configure my behavior, see the Flaky Bot documentation.

If I'm commenting on this issue too often, add the flakybot: quiet label and
I will stop commenting.

---

commit: 77e621c
buildURL: Build Status, Sponge
status: failed

Test output

args = (resource_names: "projects/precise-truck-742"
filter: "logName=projects/precise-truck-742/logs/audit-proto-bc34f50a-5a...htFBEhYaBgiA5oabBiIMCP-IjJsGEP-T69wDUNjXoeDZ9LqEsAFSBwjK3bCwgR9g0oLQ44-S96OZAWoaCgsIiIeLmwYQgvLbUhIHCAcQyorKBhgAIAA"
,)
kwargs = {'metadata': (), 'timeout': 60.0}
@functools.wraps(callable_)
def error_remapped_callable(*args, **kwargs):
    try:


      return callable_(*args, **kwargs)


.nox/system-3-8/lib/python3.8/site-packages/google/api_core/grpc_helpers.py:72:

self = <grpc._channel._UnaryUnaryMultiCallable object at 0x7fa8309e4a60>

request = resource_names: "projects/precise-truck-742"

filter: "logName=projects/precise-truck-742/logs/audit-proto-bc34f50a-5ae...cbhtFBEhYaBgiA5oabBiIMCP-IjJsGEP-T69wDUNjXoeDZ9LqEsAFSBwjK3bCwgR9g0oLQ44-S96OZAWoaCgsIiIeLmwYQgvLbUhIHCAcQyorKBhgAIAA"
timeout = 60.0, metadata = (), credentials = None, wait_for_ready = None

compression = None
def __call__(self,
             request,
             timeout=None,
             metadata=None,
             credentials=None,
             wait_for_ready=None,
             compression=None):
    state, call, = self._blocking(request, timeout, metadata, credentials,
                                  wait_for_ready, compression)


  return _end_unary_response_blocking(state, call, False, None)


.nox/system-3-8/lib/python3.8/site-packages/grpc/_channel.py:946:

state = <grpc._channel._RPCState object at 0x7fa8096ddc10>

call = <grpc._cython.cygrpc.SegregatedCall object at 0x7fa809702e40>

with_call = False, deadline = None
def _end_unary_response_blocking(state, call, with_call, deadline):
    if state.code is grpc.StatusCode.OK:
        if with_call:
            rendezvous = _MultiThreadedRendezvous(state, call, None, deadline)
            return state.response, rendezvous
        else:
            return state.response
    else:


      raise _InactiveRpcError(state)


E           grpc._channel._InactiveRpcError: <_InactiveRpcError of RPC that terminated with:

E           	status = StatusCode.CANCELLED

E           	details = "The operation was cancelled."

E           	debug_error_string = "UNKNOWN:Error received from peer ipv4:74.125.195.95:443 {created_time:"2022-11-02T19:22:57.127337597+00:00", grpc_status:1, grpc_message:"The operation was cancelled."}"

E           >
.nox/system-3-8/lib/python3.8/site-packages/grpc/_channel.py:849: _InactiveRpcError
The above exception was the direct cause of the following exception:
self = <test_system.TestLogging testMethod=test_list_entry_with_auditlog>
def test_list_entry_with_auditlog(self):
    """
    Test emitting and listing logs containing a google.cloud.audit.AuditLog proto message
    """
    from google.protobuf import descriptor_pool
    from google.cloud.logging_v2 import entries

    pool = descriptor_pool.Default()
    type_name = "google.cloud.audit.AuditLog"
    type_url = "type.googleapis.com/" + type_name
    # Make sure the descriptor is known in the registry.
    # Raises KeyError if unknown
    pool.FindMessageTypeByName(type_name)

    # create log
    audit_dict = {
        "@type": type_url,
        "methodName": "test",
        "resourceName": "test",
        "serviceName": "test",
    }
    audit_struct = self._dict_to_struct(audit_dict)

    gapic_logger = Config.CLIENT.logger(f"audit-proto-{uuid.uuid1()}")
    http_logger = Config.HTTP_CLIENT.logger(f"audit-proto-{uuid.uuid1()}-http")
    loggers = (
        [gapic_logger]
        if Config.use_mtls == "always"
        else [gapic_logger, http_logger]
    )
    for logger in loggers:
        logger.log_proto(audit_struct)

        # retrieve log
        retry = RetryErrors((TooManyRequests, StopIteration), max_tries=8)


      protobuf_entry = retry(lambda: next(logger.list_entries()))()


tests/system/test_system.py:211:

.nox/system-3-8/lib/python3.8/site-packages/test_utils/retry.py:100: in wrapped_function

return to_wrap(*args, **kwargs)

tests/system/test_system.py:211: in 

protobuf_entry = retry(lambda: next(logger.list_entries()))()

google/cloud/logging_v2/_gapic.py:108: in log_entries_pager

for entry in log_iter:

google/cloud/logging_v2/services/logging_service_v2/pagers.py:87: in iter

for page in self.pages:

google/cloud/logging_v2/services/logging_service_v2/pagers.py:83: in pages

self._response = self._method(self._request, metadata=self._metadata)

.nox/system-3-8/lib/python3.8/site-packages/google/api_core/gapic_v1/method.py:154: in call

return wrapped_func(*args, **kwargs)

.nox/system-3-8/lib/python3.8/site-packages/google/api_core/retry.py:283: in retry_wrapped_func

return retry_target(

.nox/system-3-8/lib/python3.8/site-packages/google/api_core/retry.py:190: in retry_target

return target()

.nox/system-3-8/lib/python3.8/site-packages/google/api_core/timeout.py:99: in func_with_timeout

return func(*args, **kwargs)

args = (resource_names: "projects/precise-truck-742"

filter: "logName=projects/precise-truck-742/logs/audit-proto-bc34f50a-5a...htFBEhYaBgiA5oabBiIMCP-IjJsGEP-T69wDUNjXoeDZ9LqEsAFSBwjK3bCwgR9g0oLQ44-S96OZAWoaCgsIiIeLmwYQgvLbUhIHCAcQyorKBhgAIAA"

,)

kwargs = {'metadata': (), 'timeout': 60.0}
@functools.wraps(callable_)
def error_remapped_callable(*args, **kwargs):
    try:
        return callable_(*args, **kwargs)
    except grpc.RpcError as exc:


      raise exceptions.from_grpc_error(exc) from exc


E           google.api_core.exceptions.Cancelled: 499 The operation was cancelled.
.nox/system-3-8/lib/python3.8/site-packages/google/api_core/grpc_helpers.py:74: Cancelled

[flaky-bot]

Looks like this issue is flaky. 😟

I'm going to leave this open and stop commenting.

A human should fix and close this.

---

When run at the same commit (77e621c), this test passed in one build (Build Status, Sponge) and failed in another build (Build Status, Sponge).

[daniel-sanche]

closing due to cancelled test