See 
<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Direct/2714/display/redirect>

Changes:


------------------------------------------
[...truncated 2.56 MB...]
INFO     root:portable_runner.py:573 starting state server on port 35307
INFO     root:portable_runner.py:573 starting logging server on port 33987
INFO     root:portable_runner.py:573 Created Worker handler 
<apache_beam.runners.portability.fn_api_runner.worker_handlers.DockerSdkWorkerHandler
 object at 0x7f837c5ffe20> for environment 
ref_Environment_default_environment_2 (beam:env:docker:v1, 
b'\n$apache/beam_python3.9_sdk:2.40.0.dev')
INFO     root:portable_runner.py:573 Attempting to pull image 
apache/beam_python3.9_sdk:2.40.0.dev
INFO     root:portable_runner.py:573 Unable to pull image 
apache/beam_python3.9_sdk:2.40.0.dev, defaulting to local image if it exists
INFO     root:portable_runner.py:573 Waiting for docker to start up. Current 
status is running
INFO     root:portable_runner.py:573 Docker container is running. container_id 
= b'751589dea995a4514e23dce3697574c77e1ce04e6aa81e2a18843510257e0b37', 
worker_id = worker_73
INFO     root:portable_runner.py:573 Created Worker handler 
<apache_beam.runners.portability.fn_api_runner.worker_handlers.DockerSdkWorkerHandler
 object at 0x7f837c5f6670> for environment external_7beam:env:docker:v1 
(beam:env:docker:v1, b'\n apache/beam_java8_sdk:2.40.0.dev')
INFO     root:portable_runner.py:573 Attempting to pull image 
apache/beam_java8_sdk:2.40.0.dev
INFO     root:portable_runner.py:573 Unable to pull image 
apache/beam_java8_sdk:2.40.0.dev, defaulting to local image if it exists
INFO     root:portable_runner.py:573 Waiting for docker to start up. Current 
status is running
INFO     root:portable_runner.py:573 Docker container is running. container_id 
= b'd758aab7effa70abd0d4fb23a88bb4d3fc1fb39c67d4d7b675d64b63dfae9164', 
worker_id = worker_74
INFO     root:portable_runner.py:573 Completed job in 11.094826221466064 
seconds with state DONE.
INFO     apache_beam.runners.portability.portable_runner:portable_runner.py:580 
Job state changed to DONE
PASSED                                                                   [ 77%]
apache_beam/transforms/sql_test.py::SqlTransformTest::test_windowing_before_sql 
-------------------------------- live log call ---------------------------------
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:238 Using 
pre-built snapshot at 
<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Direct/ws/src/sdks/java/extensions/sql/expansion-service/build/libs/beam-sdks-java-extensions-sql-expansion-service-2.40.0-SNAPSHOT.jar>
INFO     root:external.py:751 Starting a JAR-based expansion service from JAR 
<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Direct/ws/src/sdks/java/extensions/sql/expansion-service/build/libs/beam-sdks-java-extensions-sql-expansion-service-2.40.0-SNAPSHOT.jar>
 
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:116 Starting 
service with ['java' '-jar' 
'<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Direct/ws/src/sdks/java/extensions/sql/expansion-service/build/libs/beam-sdks-java-extensions-sql-expansion-service-2.40.0-SNAPSHOT.jar'>
 '53715' 
'--filesToStage=<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Direct/ws/src/sdks/java/extensions/sql/expansion-service/build/libs/beam-sdks-java-extensions-sql-expansion-service-2.40.0-SNAPSHOT.jar']>
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'Starting expansion service at localhost:53715'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'May 31, 
2022 5:53:38 AM org.apache.beam.sdk.expansion.service.ExpansionService 
loadRegisteredTransforms'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'INFO: 
Registering external transforms: [beam:external:java:sql:v1, 
beam:transform:org.apache.beam:pubsub_read:v1, 
beam:transform:org.apache.beam:pubsub_write:v1, 
beam:transform:org.apache.beam:pubsublite_write:v1, 
beam:transform:org.apache.beam:pubsublite_read:v1, 
beam:transform:org.apache.beam:spanner_insert:v1, 
beam:transform:org.apache.beam:spanner_update:v1, 
beam:transform:org.apache.beam:spanner_replace:v1, 
beam:transform:org.apache.beam:spanner_insert_or_update:v1, 
beam:transform:org.apache.beam:spanner_delete:v1, 
beam:transform:org.apache.beam:spanner_read:v1, 
beam:transform:org.apache.beam:kafka_read_with_metadata:v1, 
beam:transform:org.apache.beam:kafka_read_without_metadata:v1, 
beam:transform:org.apache.beam:kafka_write:v1, 
beam:external:java:generate_sequence:v1]'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:external:java:sql:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@48f2bd5b'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:pubsub_read:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@7b2bbc3'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:pubsub_write:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@a1153bc'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:pubsublite_write:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@1aafa419'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:pubsublite_read:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@47eaca72'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:spanner_insert:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@55141def'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:spanner_update:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@55182842'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:spanner_replace:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@3270d194'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:spanner_insert_or_update:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@235834f2'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:spanner_delete:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@5656be13'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:spanner_read:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@4218d6a3'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:kafka_read_with_metadata:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@76505305'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:kafka_read_without_metadata:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@14cd1699'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:kafka_write:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@77888435'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:external:java:generate_sequence:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@73a1e9a9'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'May 31, 
2022 5:53:40 AM org.apache.beam.sdk.expansion.service.ExpansionService expand'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b"INFO: 
Expanding 'SqlTransform(beam:external:java:sql:v1)' with URN 
'beam:external:java:sql:v1'"
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'May 31, 
2022 5:53:40 AM 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader
 payloadToConfig'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b"WARNING: Configuration class 
'org.apache.beam.sdk.extensions.sql.expansion.ExternalSqlTransformRegistrar$Configuration'
 has no schema registered. Attempting to construct with setter approach."
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'May 31, 
2022 5:53:40 AM 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader
 payloadToConfig'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b"WARNING: Configuration class 
'org.apache.beam.sdk.extensions.sql.expansion.ExternalSqlTransformRegistrar$Configuration'
 has no schema registered. Attempting to construct with setter approach."
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'May 31, 
2022 5:53:41 AM org.apache.beam.sdk.extensions.sql.impl.CalciteQueryPlanner 
convertToBeamRel'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'INFO: 
SQL:'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'SELECT 
COUNT(*) AS `count`'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'FROM 
`beam`.`PCOLLECTION` AS `PCOLLECTION`'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'May 31, 
2022 5:53:42 AM org.apache.beam.sdk.extensions.sql.impl.CalciteQueryPlanner 
convertToBeamRel'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'INFO: 
SQLPlan>'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'LogicalAggregate(group=[{}], count=[COUNT()])'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'  
BeamIOSourceRel(table=[[beam, PCOLLECTION]])'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b''
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'May 31, 
2022 5:53:42 AM org.apache.beam.sdk.extensions.sql.impl.CalciteQueryPlanner 
convertToBeamRel'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'INFO: 
BEAMPlan>'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'BeamAggregationRel(group=[{}], count=[COUNT()])'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'  
BeamIOSourceRel(table=[[beam, PCOLLECTION]])'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b''
WARNING  root:environments.py:371 Make sure that locally built Python SDK 
docker image has Python 3.9 interpreter.
INFO     root:environments.py:380 Default Python SDK image for environment is 
apache/beam_python3.9_sdk:2.40.0.dev
INFO     root:environments.py:299 No image given, using default Python SDK image
WARNING  root:environments.py:371 Make sure that locally built Python SDK 
docker image has Python 3.9 interpreter.
INFO     root:environments.py:380 Default Python SDK image for environment is 
apache/beam_python3.9_sdk:2.40.0.dev
INFO     root:environments.py:302 Python SDK container image set to 
"apache/beam_python3.9_sdk:2.40.0.dev" for Docker environment
INFO     
apache_beam.runners.portability.fn_api_runner.translations:translations.py:714 
==================== <function pack_combiners at 0x7fbade6339d0> 
====================
INFO     
apache_beam.runners.portability.fn_api_runner.translations:translations.py:714 
==================== <function lift_combiners at 0x7fbade633a60> 
====================
INFO     
apache_beam.runners.portability.fn_api_runner.translations:translations.py:714 
==================== <function sort_stages at 0x7fbade6381f0> 
====================
INFO     apache_beam.runners.portability.portable_runner:portable_runner.py:580 
Job state changed to STOPPED
INFO     apache_beam.runners.portability.portable_runner:portable_runner.py:580 
Job state changed to STARTING
INFO     apache_beam.runners.portability.portable_runner:portable_runner.py:580 
Job state changed to RUNNING
WARNING  root:portable_runner.py:573 Make sure that locally built Python SDK 
docker image has Python 3.9 interpreter.
INFO     root:portable_runner.py:573 Default Python SDK image for environment 
is apache/beam_python3.9_sdk:2.40.0.dev
INFO     root:portable_runner.py:573 ==================== <function 
annotate_downstream_side_inputs at 0x7f834c59c790> ====================
INFO     root:portable_runner.py:573 ==================== <function 
fix_side_input_pcoll_coders at 0x7f834c59c8b0> ====================
INFO     root:portable_runner.py:573 ==================== <function 
pack_combiners at 0x7f834c59cdc0> ====================
INFO     root:portable_runner.py:573 ==================== <function 
lift_combiners at 0x7f834c59ce50> ====================
INFO     root:portable_runner.py:573 ==================== <function expand_sdf 
at 0x7f834c59d040> ====================
INFO     root:portable_runner.py:573 ==================== <function expand_gbk 
at 0x7f834c59d0d0> ====================
INFO     root:portable_runner.py:573 ==================== <function 
sink_flattens at 0x7f834c59d1f0> ====================
INFO     root:portable_runner.py:573 ==================== <function 
greedily_fuse at 0x7f834c59d280> ====================
INFO     root:portable_runner.py:573 ==================== <function 
read_to_impulse at 0x7f834c59d310> ====================
INFO     root:portable_runner.py:573 ==================== <function 
impulse_to_input at 0x7f834c59d3a0> ====================
INFO     root:portable_runner.py:573 ==================== <function sort_stages 
at 0x7f834c59d5e0> ====================
INFO     root:portable_runner.py:573 ==================== <function 
add_impulse_to_dangling_transforms at 0x7f834c59d700> ====================
INFO     root:portable_runner.py:573 ==================== <function 
setup_timer_mapping at 0x7f834c59d550> ====================
INFO     root:portable_runner.py:573 ==================== <function 
populate_data_channel_coders at 0x7f834c59d670> ====================
INFO     root:portable_runner.py:573 starting control server on port 44371
INFO     root:portable_runner.py:573 starting data server on port 36987
INFO     root:portable_runner.py:573 starting state server on port 42401
INFO     root:portable_runner.py:573 starting logging server on port 46407
INFO     root:portable_runner.py:573 Created Worker handler 
<apache_beam.runners.portability.fn_api_runner.worker_handlers.DockerSdkWorkerHandler
 object at 0x7f837c6160d0> for environment 
ref_Environment_default_environment_2 (beam:env:docker:v1, 
b'\n$apache/beam_python3.9_sdk:2.40.0.dev')
INFO     root:portable_runner.py:573 Attempting to pull image 
apache/beam_python3.9_sdk:2.40.0.dev
INFO     root:portable_runner.py:573 Unable to pull image 
apache/beam_python3.9_sdk:2.40.0.dev, defaulting to local image if it exists
INFO     root:portable_runner.py:573 Waiting for docker to start up. Current 
status is running
INFO     root:portable_runner.py:573 Docker container is running. container_id 
= b'adc19746aef94f81e887e69c52c393e55862452a2c64c5e472a3be3a159aa279', 
worker_id = worker_75
INFO     root:portable_runner.py:573 Created Worker handler 
<apache_beam.runners.portability.fn_api_runner.worker_handlers.DockerSdkWorkerHandler
 object at 0x7f834c460400> for environment external_8beam:env:docker:v1 
(beam:env:docker:v1, b'\n apache/beam_java8_sdk:2.40.0.dev')
INFO     root:portable_runner.py:573 Attempting to pull image 
apache/beam_java8_sdk:2.40.0.dev
INFO     root:portable_runner.py:573 Unable to pull image 
apache/beam_java8_sdk:2.40.0.dev, defaulting to local image if it exists
INFO     root:portable_runner.py:573 Waiting for docker to start up. Current 
status is running
INFO     root:portable_runner.py:573 Docker container is running. container_id 
= b'ae943d7c2c1062406fef29272aa20846ccb5d0dab86b0243a32e4e97276ba302', 
worker_id = worker_76
INFO     root:portable_runner.py:573 Completed job in 11.657600402832031 
seconds with state DONE.
INFO     apache_beam.runners.portability.portable_runner:portable_runner.py:580 
Job state changed to DONE
PASSED                                                                   [ 88%]
apache_beam/transforms/sql_test.py::SqlTransformTest::test_zetasql_generate_data
 
-------------------------------- live log call ---------------------------------
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:238 Using 
pre-built snapshot at 
<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Direct/ws/src/sdks/java/extensions/sql/expansion-service/build/libs/beam-sdks-java-extensions-sql-expansion-service-2.40.0-SNAPSHOT.jar>
INFO     root:external.py:751 Starting a JAR-based expansion service from JAR 
<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Direct/ws/src/sdks/java/extensions/sql/expansion-service/build/libs/beam-sdks-java-extensions-sql-expansion-service-2.40.0-SNAPSHOT.jar>
 
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:116 Starting 
service with ['java' '-jar' 
'<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Direct/ws/src/sdks/java/extensions/sql/expansion-service/build/libs/beam-sdks-java-extensions-sql-expansion-service-2.40.0-SNAPSHOT.jar'>
 '57479' 
'--filesToStage=<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Direct/ws/src/sdks/java/extensions/sql/expansion-service/build/libs/beam-sdks-java-extensions-sql-expansion-service-2.40.0-SNAPSHOT.jar']>
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'Starting expansion service at localhost:57479'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'May 31, 
2022 5:54:02 AM org.apache.beam.sdk.expansion.service.ExpansionService 
loadRegisteredTransforms'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'INFO: 
Registering external transforms: [beam:external:java:sql:v1, 
beam:transform:org.apache.beam:pubsub_read:v1, 
beam:transform:org.apache.beam:pubsub_write:v1, 
beam:transform:org.apache.beam:pubsublite_write:v1, 
beam:transform:org.apache.beam:pubsublite_read:v1, 
beam:transform:org.apache.beam:spanner_insert:v1, 
beam:transform:org.apache.beam:spanner_update:v1, 
beam:transform:org.apache.beam:spanner_replace:v1, 
beam:transform:org.apache.beam:spanner_insert_or_update:v1, 
beam:transform:org.apache.beam:spanner_delete:v1, 
beam:transform:org.apache.beam:spanner_read:v1, 
beam:transform:org.apache.beam:kafka_read_with_metadata:v1, 
beam:transform:org.apache.beam:kafka_read_without_metadata:v1, 
beam:transform:org.apache.beam:kafka_write:v1, 
beam:external:java:generate_sequence:v1]'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:external:java:sql:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@48f2bd5b'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:pubsub_read:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@7b2bbc3'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:pubsub_write:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@a1153bc'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:pubsublite_write:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@1aafa419'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:pubsublite_read:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@47eaca72'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:spanner_insert:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@55141def'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:spanner_update:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@55182842'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:spanner_replace:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@3270d194'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:spanner_insert_or_update:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@235834f2'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:spanner_delete:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@5656be13'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:spanner_read:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@4218d6a3'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:kafka_read_with_metadata:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@76505305'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:kafka_read_without_metadata:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@14cd1699'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:transform:org.apache.beam:kafka_write:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@77888435'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'\tbeam:external:java:generate_sequence:v1: 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader$1@73a1e9a9'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'May 31, 
2022 5:54:04 AM org.apache.beam.sdk.expansion.service.ExpansionService expand'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b"INFO: 
Expanding 'SqlTransform(beam:external:java:sql:v1)' with URN 
'beam:external:java:sql:v1'"
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'May 31, 
2022 5:54:04 AM 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader
 payloadToConfig'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b"WARNING: Configuration class 
'org.apache.beam.sdk.extensions.sql.expansion.ExternalSqlTransformRegistrar$Configuration'
 has no schema registered. Attempting to construct with setter approach."
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'May 31, 
2022 5:54:04 AM 
org.apache.beam.sdk.expansion.service.ExpansionService$ExternalTransformRegistrarLoader
 payloadToConfig'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b"WARNING: Configuration class 
'org.apache.beam.sdk.extensions.sql.expansion.ExternalSqlTransformRegistrar$Configuration'
 has no schema registered. Attempting to construct with setter approach."
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'May 31, 
2022 5:54:06 AM com.google.zetasql.io.grpc.NameResolverRegistry 
getDefaultRegistry'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b'WARNING: No NameResolverProviders found via ServiceLoader, including for DNS. 
This is probably due to a broken build. If using ProGuard, check your 
configuration'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'May 31, 
2022 5:54:07 AM org.apache.beam.sdk.extensions.sql.zetasql.ZetaSQLQueryPlanner 
convertToBeamRelInternal'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'INFO: 
BEAMPlan>'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 
b"BeamZetaSqlCalcRel(expr#0=[{inputs}], expr#1=[1:BIGINT], 
expr#2=['foo':VARCHAR], expr#3=[3.1400000000000001243E0:DOUBLE], int=[$t1], 
str=[$t2], flt=[$t3])"
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b'  
BeamValuesRel(tuples=[[{ 0 }]])'
INFO     apache_beam.utils.subprocess_server:subprocess_server.py:125 b''
WARNING  root:environments.py:371 Make sure that locally built Python SDK 
docker image has Python 3.9 interpreter.
INFO     root:environments.py:380 Default Python SDK image for environment is 
apache/beam_python3.9_sdk:2.40.0.dev
INFO     root:environments.py:299 No image given, using default Python SDK image
WARNING  root:environments.py:371 Make sure that locally built Python SDK 
docker image has Python 3.9 interpreter.
INFO     root:environments.py:380 Default Python SDK image for environment is 
apache/beam_python3.9_sdk:2.40.0.dev
INFO     root:environments.py:302 Python SDK container image set to 
"apache/beam_python3.9_sdk:2.40.0.dev" for Docker environment
INFO     
apache_beam.runners.portability.fn_api_runner.translations:translations.py:714 
==================== <function pack_combiners at 0x7fbade6339d0> 
====================
INFO     
apache_beam.runners.portability.fn_api_runner.translations:translations.py:714 
==================== <function lift_combiners at 0x7fbade633a60> 
====================
INFO     
apache_beam.runners.portability.fn_api_runner.translations:translations.py:714 
==================== <function sort_stages at 0x7fbade6381f0> 
====================
INFO     apache_beam.runners.portability.portable_runner:portable_runner.py:580 
Job state changed to STOPPED
INFO     apache_beam.runners.portability.portable_runner:portable_runner.py:580 
Job state changed to STARTING
INFO     apache_beam.runners.portability.portable_runner:portable_runner.py:580 
Job state changed to RUNNING
WARNING  root:portable_runner.py:573 Make sure that locally built Python SDK 
docker image has Python 3.9 interpreter.
INFO     root:portable_runner.py:573 Default Python SDK image for environment 
is apache/beam_python3.9_sdk:2.40.0.dev
INFO     root:portable_runner.py:573 ==================== <function 
annotate_downstream_side_inputs at 0x7f834c59c790> ====================
INFO     root:portable_runner.py:573 ==================== <function 
fix_side_input_pcoll_coders at 0x7f834c59c8b0> ====================
INFO     root:portable_runner.py:573 ==================== <function 
pack_combiners at 0x7f834c59cdc0> ====================
INFO     root:portable_runner.py:573 ==================== <function 
lift_combiners at 0x7f834c59ce50> ====================
INFO     root:portable_runner.py:573 ==================== <function expand_sdf 
at 0x7f834c59d040> ====================
INFO     root:portable_runner.py:573 ==================== <function expand_gbk 
at 0x7f834c59d0d0> ====================
INFO     root:portable_runner.py:573 ==================== <function 
sink_flattens at 0x7f834c59d1f0> ====================
INFO     root:portable_runner.py:573 ==================== <function 
greedily_fuse at 0x7f834c59d280> ====================
INFO     root:portable_runner.py:573 ==================== <function 
read_to_impulse at 0x7f834c59d310> ====================
INFO     root:portable_runner.py:573 ==================== <function 
impulse_to_input at 0x7f834c59d3a0> ====================
INFO     root:portable_runner.py:573 ==================== <function sort_stages 
at 0x7f834c59d5e0> ====================
INFO     root:portable_runner.py:573 ==================== <function 
add_impulse_to_dangling_transforms at 0x7f834c59d700> ====================
INFO     root:portable_runner.py:573 ==================== <function 
setup_timer_mapping at 0x7f834c59d550> ====================
INFO     root:portable_runner.py:573 ==================== <function 
populate_data_channel_coders at 0x7f834c59d670> ====================
INFO     root:portable_runner.py:573 starting control server on port 34135
INFO     root:portable_runner.py:573 starting data server on port 36239
INFO     root:portable_runner.py:573 starting state server on port 37107
INFO     root:portable_runner.py:573 starting logging server on port 41383
INFO     root:portable_runner.py:573 Created Worker handler 
<apache_beam.runners.portability.fn_api_runner.worker_handlers.DockerSdkWorkerHandler
 object at 0x7f834c40d580> for environment 
ref_Environment_default_environment_2 (beam:env:docker:v1, 
b'\n$apache/beam_python3.9_sdk:2.40.0.dev')
INFO     root:portable_runner.py:573 Attempting to pull image 
apache/beam_python3.9_sdk:2.40.0.dev
INFO     root:portable_runner.py:573 Unable to pull image 
apache/beam_python3.9_sdk:2.40.0.dev, defaulting to local image if it exists
INFO     root:portable_runner.py:573 Waiting for docker to start up. Current 
status is running
INFO     root:portable_runner.py:573 Docker container is running. container_id 
= b'8190820b1a7942b6e0a6f7acad4f535709963ba2def23995843046f39d6811e2', 
worker_id = worker_77
INFO     root:portable_runner.py:573 Created Worker handler 
<apache_beam.runners.portability.fn_api_runner.worker_handlers.DockerSdkWorkerHandler
 object at 0x7f837c741700> for environment external_9beam:env:docker:v1 
(beam:env:docker:v1, b'\n apache/beam_java8_sdk:2.40.0.dev')
INFO     root:portable_runner.py:573 Attempting to pull image 
apache/beam_java8_sdk:2.40.0.dev
INFO     root:portable_runner.py:573 Unable to pull image 
apache/beam_java8_sdk:2.40.0.dev, defaulting to local image if it exists
INFO     root:portable_runner.py:573 Waiting for docker to start up. Current 
status is running
INFO     root:portable_runner.py:573 Docker container is running. container_id 
= b'd4329cf8384f0f157ab4224a35ac14e056fd5b2912458d15fd32b4acdd10bc18', 
worker_id = worker_78
INFO     root:portable_runner.py:573 Completed job in 14.561922550201416 
seconds with state DONE.
INFO     apache_beam.runners.portability.portable_runner:portable_runner.py:580 
Job state changed to DONE
PASSED                                                                   [100%]

=============================== warnings summary ===============================
<unknown>:54
  <unknown>:54: DeprecationWarning: invalid escape sequence \c

<unknown>:62
  <unknown>:62: DeprecationWarning: invalid escape sequence \d

<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Direct/ws/src/build/gradleenv/1922375555/lib/python3.9/site-packages/_pytest/mark/structures.py>:331
<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Direct/ws/src/build/gradleenv/1922375555/lib/python3.9/site-packages/_pytest/mark/structures.py>:331
  
<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Direct/ws/src/build/gradleenv/1922375555/lib/python3.9/site-packages/_pytest/mark/structures.py>:331:
 PytestUnknownMarkWarning: Unknown pytest.mark.uses_java_expansion_service - is 
this a typo?  You can register custom marks to avoid this warning - for 
details, see https://docs.pytest.org/en/latest/mark.html
    warnings.warn(

<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Direct/ws/src/build/gradleenv/1922375555/lib/python3.9/site-packages/tenacity/_asyncio.py>:42
  
<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Direct/ws/src/build/gradleenv/1922375555/lib/python3.9/site-packages/tenacity/_asyncio.py>:42:
 DeprecationWarning: "@coroutine" decorator is deprecated since Python 3.8, use 
"async def" instead
    def call(self, fn, *args, **kwargs):

<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Direct/ws/src/build/gradleenv/1922375555/lib/python3.9/site-packages/_pytest/mark/structures.py>:331
  
<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Direct/ws/src/build/gradleenv/1922375555/lib/python3.9/site-packages/_pytest/mark/structures.py>:331:
 PytestUnknownMarkWarning: Unknown pytest.mark.uses_python_expansion_service - 
is this a typo?  You can register custom marks to avoid this warning - for 
details, see https://docs.pytest.org/en/latest/mark.html
    warnings.warn(

-- Docs: https://docs.pytest.org/en/latest/warnings.html
- generated xml file: 
<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Direct/ws/src/sdks/python/pytest_xlangSqlValidateRunner.xml>
 -
====== 9 passed, 1 skipped, 5579 deselected, 6 warnings in 231.08 seconds ======

> Task :sdks:python:test-suites:direct:xlang:validatesCrossLanguageRunnerCleanup
Stopping expansion service pid: 1899296.
Stopping expansion service pid: 1899297.

> Task :sdks:python:test-suites:direct:xlang:fnApiJobServerCleanup
Killing process at 1896913

FAILURE: Build failed with an exception.

* Where:
Build file 
'<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Direct/ws/src/sdks/go/test/build.gradle'>
 line: 195

* What went wrong:
Execution failed for task 
':sdks:python:test-suites:direct:xlang:validatesCrossLanguageRunnerGoUsingJava'.
> Process 'command 'sh'' finished with non-zero exit value 1

* Try:
> Run with --stacktrace option to get the stack trace.
> Run with --info or --debug option to get more log output.
> Run with --scan to get full insights.

* Get more help at https://help.gradle.org

Deprecated Gradle features were used in this build, making it incompatible with 
Gradle 8.0.

You can use '--warning-mode all' to show the individual deprecation warnings 
and determine if they come from your own scripts or plugins.

See 
https://docs.gradle.org/7.4/userguide/command_line_interface.html#sec:command_line_warnings

Execution optimizations have been disabled for 1 invalid unit(s) of work during 
this build to ensure correctness.
Please consult deprecation warnings for more details.

BUILD FAILED in 20m 43s
219 actionable tasks: 32 executed, 187 up-to-date

Publishing build scan...
https://gradle.com/s/k4g4lusrzlqfo

Build step 'Invoke Gradle script' changed build result to FAILURE
Build step 'Invoke Gradle script' marked build as failure

---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to