++ dirname /var/local/git/grpc/tools/run_tests/helper_scripts/run_python.sh
+ cd /var/local/git/grpc/tools/run_tests/helper_scripts/../../..
++ pwd
+ PYTHON=/var/local/git/grpc/py39/bin/python
++ pwd
+ ROOT=/var/local/git/grpc
+ /var/local/git/grpc/py39/bin/python /var/local/git/grpc/src/python/grpcio_tests/setup.py test_aio
running test_aio
Running tests_aio.unit.call_test.TestStreamStreamCall.test_async_generator
WARNING: All log messages before absl::InitializeLog() is called are written to STDERR
W0000 00:00:1730387686.567508 32632 log.cc:109] Log level DEBUG is not suitable for production. Prefer WARNING or ERROR. However if you see this message in a debug environment or test environment it is safe to ignore this message.
Running tests_aio.unit.call_test.TestStreamStreamCall.test_cancel
Running tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_after_done_writing
Running tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_with_ongoing_read
I0000 00:00:1730387686.659276 33034 chttp2_transport.cc:1154] ipv6:%5B::1%5D:34651: Got goaway [2] err=UNAVAILABLE:GOAWAY received; Error code: 2; Debug Text: Cancelling all calls {grpc_status:14, http2_error:2, created_time:"2024-10-31T15:14:46.659258375+00:00"}
Running tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_with_pending_read
Running tests_aio.unit.call_test.TestStreamStreamCall.test_early_cancel
Running tests_aio.unit.call_test.TestStreamStreamCall.test_empty_ping_pong
Running tests_aio.unit.call_test.TestStreamStreamCall.test_error_in_async_generator
Running tests_aio.unit.call_test.TestStreamStreamCall.test_late_cancel
Running tests_aio.unit.call_test.TestStreamStreamCall.test_normal_iterable_requests
Running tests_aio.unit.call_test.TestStreamStreamCall.test_read_write_after_done_writing
Running tests_aio.unit.call_test.TestStreamStreamCall.test_too_many_reads
[95m [2024-10-31 15:14:46.562082]Testing gRPC Python...
[0m[94m [2024-10-31 15:14:46.565269]START tests_aio.unit.call_test.TestStreamStreamCall.test_async_generator
[0m[92m [2024-10-31 15:14:46.595558]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_async_generator[Duration: 0:00:00.030289]
[0m[94m [2024-10-31 15:14:46.600990]START tests_aio.unit.call_test.TestStreamStreamCall.test_cancel
[0m[92m [2024-10-31 15:14:46.627280]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_cancel[Duration: 0:00:00.026290]
[0m[94m [2024-10-31 15:14:46.632818]START tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_after_done_writing
[0m[91m [2024-10-31 15:14:46.643918]FAILURE tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_after_done_writing[Duration: 0:00:00.011094]
[0m[94m [2024-10-31 15:14:46.649387]START tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_with_ongoing_read
[0m[92m [2024-10-31 15:14:46.656636]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_with_ongoing_read[Duration: 0:00:00.007249]
[0m[94m [2024-10-31 15:14:46.663185]START tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_with_pending_read
[0m[92m [2024-10-31 15:14:46.675288]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_with_pending_read[Duration: 0:00:00.012103]
[0m[94m [2024-10-31 15:14:46.680391]START tests_aio.unit.call_test.TestStreamStreamCall.test_early_cancel
[0m[92m [2024-10-31 15:14:46.685706]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_early_cancel[Duration: 0:00:00.005315]
[0m[94m [2024-10-31 15:14:46.690971]START tests_aio.unit.call_test.TestStreamStreamCall.test_empty_ping_pong
[0m[92m [2024-10-31 15:14:46.708348]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_empty_ping_pong[Duration: 0:00:00.017377]
[0m[94m [2024-10-31 15:14:46.714230]START tests_aio.unit.call_test.TestStreamStreamCall.test_error_in_async_generator
[0m[92m [2024-10-31 15:14:48.724267]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_error_in_async_generator[Duration: 0:00:02.010037]
[0m[94m [2024-10-31 15:14:48.729725]START tests_aio.unit.call_test.TestStreamStreamCall.test_late_cancel
[0m[92m [2024-10-31 15:14:48.739607]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_late_cancel[Duration: 0:00:00.009882]
[0m[94m [2024-10-31 15:14:48.744913]START tests_aio.unit.call_test.TestStreamStreamCall.test_normal_iterable_requests
[0m[92m [2024-10-31 15:14:48.762946]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_normal_iterable_requests[Duration: 0:00:00.018033]
[0m[94m [2024-10-31 15:14:48.768655]START tests_aio.unit.call_test.TestStreamStreamCall.test_read_write_after_done_writing
[0m[92m [2024-10-31 15:14:48.787347]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_read_write_after_done_writing[Duration: 0:00:00.018692]
[0m[94m [2024-10-31 15:14:48.792502]START tests_aio.unit.call_test.TestStreamStreamCall.test_too_many_reads
[0m[92m [2024-10-31 15:14:48.811553]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_too_many_reads[Duration: 0:00:00.019051]
[0m12 tests finished:
11 successful
1 unsuccessful
0 skipped
0 expected failures
0 unexpected successes
Interrupted Tests:
[]
Errors/Failures:
[91mtests_aio.unit.call_test.TestStreamStreamCall.test_cancel_after_done_writing[0m
[1mtraceback:[0m
Traceback (most recent call last):
File "/usr/lib/python3.9/unittest/case.py", line 59, in testPartExecutor
yield
File "/usr/lib/python3.9/unittest/case.py", line 593, in run
self._callTestMethod(testMethod)
File "/usr/lib/python3.9/unittest/case.py", line 550, in _callTestMethod
method()
File "/var/local/git/grpc/src/python/grpcio_tests/tests_aio/unit/_test_base.py", line 31, in wrapper
return loop.run_until_complete(f(*args, **kwargs))
File "/usr/lib/python3.9/asyncio/base_events.py", line 642, in run_until_complete
return future.result()
File "/var/local/git/grpc/src/python/grpcio_tests/tests_aio/unit/call_test.py", line 821, in test_cancel_after_done_writing
self.assertTrue(call.cancel())
File "/usr/lib/python3.9/unittest/case.py", line 682, in assertTrue
raise self.failureException(msg)
AssertionError: False is not true
[1mstdout:[0m
None
[1mstderr:[0m
None
Unexpected successes: []
Test failure
real 3.02
user 0.76
sys 0.18
+ cd /var/local/git/grpc/tools/run_tests/helper_scripts/../../..
++ pwd
+ PYTHON=/var/local/git/grpc/py39/bin/python
++ pwd
+ ROOT=/var/local/git/grpc
+ /var/local/git/grpc/py39/bin/python /var/local/git/grpc/src/python/grpcio_tests/setup.py test_aio
running test_aio
Running tests_aio.unit.call_test.TestStreamStreamCall.test_async_generator
WARNING: All log messages before absl::InitializeLog() is called are written to STDERR
W0000 00:00:1730387686.567508 32632 log.cc:109] Log level DEBUG is not suitable for production. Prefer WARNING or ERROR. However if you see this message in a debug environment or test environment it is safe to ignore this message.
Running tests_aio.unit.call_test.TestStreamStreamCall.test_cancel
Running tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_after_done_writing
Running tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_with_ongoing_read
I0000 00:00:1730387686.659276 33034 chttp2_transport.cc:1154] ipv6:%5B::1%5D:34651: Got goaway [2] err=UNAVAILABLE:GOAWAY received; Error code: 2; Debug Text: Cancelling all calls {grpc_status:14, http2_error:2, created_time:"2024-10-31T15:14:46.659258375+00:00"}
Running tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_with_pending_read
Running tests_aio.unit.call_test.TestStreamStreamCall.test_early_cancel
Running tests_aio.unit.call_test.TestStreamStreamCall.test_empty_ping_pong
Running tests_aio.unit.call_test.TestStreamStreamCall.test_error_in_async_generator
Running tests_aio.unit.call_test.TestStreamStreamCall.test_late_cancel
Running tests_aio.unit.call_test.TestStreamStreamCall.test_normal_iterable_requests
Running tests_aio.unit.call_test.TestStreamStreamCall.test_read_write_after_done_writing
Running tests_aio.unit.call_test.TestStreamStreamCall.test_too_many_reads
[95m [2024-10-31 15:14:46.562082]Testing gRPC Python...
[0m[94m [2024-10-31 15:14:46.565269]START tests_aio.unit.call_test.TestStreamStreamCall.test_async_generator
[0m[92m [2024-10-31 15:14:46.595558]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_async_generator[Duration: 0:00:00.030289]
[0m[94m [2024-10-31 15:14:46.600990]START tests_aio.unit.call_test.TestStreamStreamCall.test_cancel
[0m[92m [2024-10-31 15:14:46.627280]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_cancel[Duration: 0:00:00.026290]
[0m[94m [2024-10-31 15:14:46.632818]START tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_after_done_writing
[0m[91m [2024-10-31 15:14:46.643918]FAILURE tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_after_done_writing[Duration: 0:00:00.011094]
[0m[94m [2024-10-31 15:14:46.649387]START tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_with_ongoing_read
[0m[92m [2024-10-31 15:14:46.656636]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_with_ongoing_read[Duration: 0:00:00.007249]
[0m[94m [2024-10-31 15:14:46.663185]START tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_with_pending_read
[0m[92m [2024-10-31 15:14:46.675288]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_with_pending_read[Duration: 0:00:00.012103]
[0m[94m [2024-10-31 15:14:46.680391]START tests_aio.unit.call_test.TestStreamStreamCall.test_early_cancel
[0m[92m [2024-10-31 15:14:46.685706]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_early_cancel[Duration: 0:00:00.005315]
[0m[94m [2024-10-31 15:14:46.690971]START tests_aio.unit.call_test.TestStreamStreamCall.test_empty_ping_pong
[0m[92m [2024-10-31 15:14:46.708348]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_empty_ping_pong[Duration: 0:00:00.017377]
[0m[94m [2024-10-31 15:14:46.714230]START tests_aio.unit.call_test.TestStreamStreamCall.test_error_in_async_generator
[0m[92m [2024-10-31 15:14:48.724267]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_error_in_async_generator[Duration: 0:00:02.010037]
[0m[94m [2024-10-31 15:14:48.729725]START tests_aio.unit.call_test.TestStreamStreamCall.test_late_cancel
[0m[92m [2024-10-31 15:14:48.739607]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_late_cancel[Duration: 0:00:00.009882]
[0m[94m [2024-10-31 15:14:48.744913]START tests_aio.unit.call_test.TestStreamStreamCall.test_normal_iterable_requests
[0m[92m [2024-10-31 15:14:48.762946]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_normal_iterable_requests[Duration: 0:00:00.018033]
[0m[94m [2024-10-31 15:14:48.768655]START tests_aio.unit.call_test.TestStreamStreamCall.test_read_write_after_done_writing
[0m[92m [2024-10-31 15:14:48.787347]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_read_write_after_done_writing[Duration: 0:00:00.018692]
[0m[94m [2024-10-31 15:14:48.792502]START tests_aio.unit.call_test.TestStreamStreamCall.test_too_many_reads
[0m[92m [2024-10-31 15:14:48.811553]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_too_many_reads[Duration: 0:00:00.019051]
[0m12 tests finished:
11 successful
1 unsuccessful
0 skipped
0 expected failures
0 unexpected successes
Interrupted Tests:
[]
Errors/Failures:
[91mtests_aio.unit.call_test.TestStreamStreamCall.test_cancel_after_done_writing[0m
[1mtraceback:[0m
Traceback (most recent call last):
File "/usr/lib/python3.9/unittest/case.py", line 59, in testPartExecutor
yield
File "/usr/lib/python3.9/unittest/case.py", line 593, in run
self._callTestMethod(testMethod)
File "/usr/lib/python3.9/unittest/case.py", line 550, in _callTestMethod
method()
File "/var/local/git/grpc/src/python/grpcio_tests/tests_aio/unit/_test_base.py", line 31, in wrapper
return loop.run_until_complete(f(*args, **kwargs))
File "/usr/lib/python3.9/asyncio/base_events.py", line 642, in run_until_complete
return future.result()
File "/var/local/git/grpc/src/python/grpcio_tests/tests_aio/unit/call_test.py", line 821, in test_cancel_after_done_writing
self.assertTrue(call.cancel())
File "/usr/lib/python3.9/unittest/case.py", line 682, in assertTrue
raise self.failureException(msg)
AssertionError: False is not true
[1mstdout:[0m
None
[1mstderr:[0m
None
Unexpected successes: []
Test failure
real 3.02
user 0.76
sys 0.18
++ dirname /var/local/git/grpc/tools/run_tests/helper_scripts/run_python.sh + cd /var/local/git/grpc/tools/run_tests/helper_scripts/../../.. ++ pwd + PYTHON=/var/local/git/grpc/py39/bin/python ++ pwd + ROOT=/var/local/git/grpc + /var/local/git/grpc/py39/bin/python /var/local/git/grpc/src/python/grpcio_tests/setup.py test_aio running test_aio Running tests_aio.unit.call_test.TestStreamStreamCall.test_async_generator WARNING: All log messages before absl::InitializeLog() is called are written to STDERR W0000 00:00:1730387686.567508 32632 log.cc:109] Log level DEBUG is not suitable for production. Prefer WARNING or ERROR. However if you see this message in a debug environment or test environment it is safe to ignore this message. Running tests_aio.unit.call_test.TestStreamStreamCall.test_cancel Running tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_after_done_writing Running tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_with_ongoing_read I0000 00:00:1730387686.659276 33034 chttp2_transport.cc:1154] ipv6:%5B::1%5D:34651: Got goaway [2] err=UNAVAILABLE:GOAWAY received; Error code: 2; Debug Text: Cancelling all calls {grpc_status:14, http2_error:2, created_time:"2024-10-31T15:14:46.659258375+00:00"} Running tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_with_pending_read Running tests_aio.unit.call_test.TestStreamStreamCall.test_early_cancel Running tests_aio.unit.call_test.TestStreamStreamCall.test_empty_ping_pong Running tests_aio.unit.call_test.TestStreamStreamCall.test_error_in_async_generator Running tests_aio.unit.call_test.TestStreamStreamCall.test_late_cancel Running tests_aio.unit.call_test.TestStreamStreamCall.test_normal_iterable_requests Running tests_aio.unit.call_test.TestStreamStreamCall.test_read_write_after_done_writing Running tests_aio.unit.call_test.TestStreamStreamCall.test_too_many_reads [95m [2024-10-31 15:14:46.562082]Testing gRPC Python... [0m[94m [2024-10-31 15:14:46.565269]START tests_aio.unit.call_test.TestStreamStreamCall.test_async_generator [0m[92m [2024-10-31 15:14:46.595558]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_async_generator[Duration: 0:00:00.030289] [0m[94m [2024-10-31 15:14:46.600990]START tests_aio.unit.call_test.TestStreamStreamCall.test_cancel [0m[92m [2024-10-31 15:14:46.627280]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_cancel[Duration: 0:00:00.026290] [0m[94m [2024-10-31 15:14:46.632818]START tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_after_done_writing [0m[91m [2024-10-31 15:14:46.643918]FAILURE tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_after_done_writing[Duration: 0:00:00.011094] [0m[94m [2024-10-31 15:14:46.649387]START tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_with_ongoing_read [0m[92m [2024-10-31 15:14:46.656636]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_with_ongoing_read[Duration: 0:00:00.007249] [0m[94m [2024-10-31 15:14:46.663185]START tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_with_pending_read [0m[92m [2024-10-31 15:14:46.675288]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_cancel_with_pending_read[Duration: 0:00:00.012103] [0m[94m [2024-10-31 15:14:46.680391]START tests_aio.unit.call_test.TestStreamStreamCall.test_early_cancel [0m[92m [2024-10-31 15:14:46.685706]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_early_cancel[Duration: 0:00:00.005315] [0m[94m [2024-10-31 15:14:46.690971]START tests_aio.unit.call_test.TestStreamStreamCall.test_empty_ping_pong [0m[92m [2024-10-31 15:14:46.708348]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_empty_ping_pong[Duration: 0:00:00.017377] [0m[94m [2024-10-31 15:14:46.714230]START tests_aio.unit.call_test.TestStreamStreamCall.test_error_in_async_generator [0m[92m [2024-10-31 15:14:48.724267]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_error_in_async_generator[Duration: 0:00:02.010037] [0m[94m [2024-10-31 15:14:48.729725]START tests_aio.unit.call_test.TestStreamStreamCall.test_late_cancel [0m[92m [2024-10-31 15:14:48.739607]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_late_cancel[Duration: 0:00:00.009882] [0m[94m [2024-10-31 15:14:48.744913]START tests_aio.unit.call_test.TestStreamStreamCall.test_normal_iterable_requests [0m[92m [2024-10-31 15:14:48.762946]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_normal_iterable_requests[Duration: 0:00:00.018033] [0m[94m [2024-10-31 15:14:48.768655]START tests_aio.unit.call_test.TestStreamStreamCall.test_read_write_after_done_writing [0m[92m [2024-10-31 15:14:48.787347]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_read_write_after_done_writing[Duration: 0:00:00.018692] [0m[94m [2024-10-31 15:14:48.792502]START tests_aio.unit.call_test.TestStreamStreamCall.test_too_many_reads [0m[92m [2024-10-31 15:14:48.811553]SUCCESS tests_aio.unit.call_test.TestStreamStreamCall.test_too_many_reads[Duration: 0:00:00.019051] [0m12 tests finished: 11 successful 1 unsuccessful 0 skipped 0 expected failures 0 unexpected successes Interrupted Tests: [] Errors/Failures: [91mtests_aio.unit.call_test.TestStreamStreamCall.test_cancel_after_done_writing[0m [1mtraceback:[0m Traceback (most recent call last): File "/usr/lib/python3.9/unittest/case.py", line 59, in testPartExecutor yield File "/usr/lib/python3.9/unittest/case.py", line 593, in run self._callTestMethod(testMethod) File "/usr/lib/python3.9/unittest/case.py", line 550, in _callTestMethod method() File "/var/local/git/grpc/src/python/grpcio_tests/tests_aio/unit/_test_base.py", line 31, in wrapper return loop.run_until_complete(f(*args, **kwargs)) File "/usr/lib/python3.9/asyncio/base_events.py", line 642, in run_until_complete return future.result() File "/var/local/git/grpc/src/python/grpcio_tests/tests_aio/unit/call_test.py", line 821, in test_cancel_after_done_writing self.assertTrue(call.cancel()) File "/usr/lib/python3.9/unittest/case.py", line 682, in assertTrue raise self.failureException(msg) AssertionError: False is not true [1mstdout:[0m None [1mstderr:[0m None Unexpected successes: [] Test failure real 3.02 user 0.76 sys 0.18