See
<https://builds.apache.org/job/beam_PostCommit_Python_Verify/4488/display/redirect?page=changes>
Changes:
[altay] Convert big query writes to beam.io.WriteToBigQuery
------------------------------------------
[...truncated 1.12 MB...]
},
"serialized_fn": "<string of 952 bytes>",
"user_name": "write/Write/WriteImpl/FinalizeWrite/MapToVoidKey0"
}
},
{
"kind": "ParallelDo",
"name": "s32",
"properties": {
"display_data": [
{
"key": "fn",
"label": "Transform Function",
"namespace": "apache_beam.transforms.core.CallableWrapperDoFn",
"type": "STRING",
"value": "<lambda>"
},
{
"key": "fn",
"label": "Transform Function",
"namespace": "apache_beam.transforms.core.ParDo",
"shortValue": "CallableWrapperDoFn",
"type": "STRING",
"value": "apache_beam.transforms.core.CallableWrapperDoFn"
}
],
"non_parallel_inputs": {},
"output_info": [
{
"encoding": {
"@type": "kind:windowed_value",
"component_encodings": [
{
"@type": "kind:pair",
"component_encodings": [
{
"@type": "kind:bytes"
},
{
"@type":
"FastPrimitivesCoder$eNprYEpOLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqZQ/vi0xJycpMTk7Hiw+kJmPEYFZCZn56RCjWABGsFaW8iWVJykBwDlGS3/",
"component_encodings": [
{
"@type":
"FastPrimitivesCoder$eNprYEpOLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqZQ/vi0xJycpMTk7Hiw+kJmPEYFZCZn56RCjWABGsFaW8iWVJykBwDlGS3/",
"component_encodings": []
},
{
"@type":
"FastPrimitivesCoder$eNprYEpOLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqZQ/vi0xJycpMTk7Hiw+kJmPEYFZCZn56RCjWABGsFaW8iWVJykBwDlGS3/",
"component_encodings": []
}
],
"is_pair_like": true
}
],
"is_pair_like": true
},
{
"@type": "kind:global_window"
}
],
"is_wrapper": true
},
"output_name": "out",
"user_name": "write/Write/WriteImpl/FinalizeWrite/MapToVoidKey1.out"
}
],
"parallel_input": {
"@type": "OutputReference",
"output_name": "out",
"step_name": "s15"
},
"serialized_fn": "<string of 952 bytes>",
"user_name": "write/Write/WriteImpl/FinalizeWrite/MapToVoidKey1"
}
},
{
"kind": "ParallelDo",
"name": "s33",
"properties": {
"display_data": [
{
"key": "fn",
"label": "Transform Function",
"namespace": "apache_beam.transforms.core.CallableWrapperDoFn",
"type": "STRING",
"value": "<lambda>"
},
{
"key": "fn",
"label": "Transform Function",
"namespace": "apache_beam.transforms.core.ParDo",
"shortValue": "CallableWrapperDoFn",
"type": "STRING",
"value": "apache_beam.transforms.core.CallableWrapperDoFn"
}
],
"non_parallel_inputs": {},
"output_info": [
{
"encoding": {
"@type": "kind:windowed_value",
"component_encodings": [
{
"@type": "kind:pair",
"component_encodings": [
{
"@type": "kind:bytes"
},
{
"@type":
"FastPrimitivesCoder$eNprYEpOLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqZQ/vi0xJycpMTk7Hiw+kJmPEYFZCZn56RCjWABGsFaW8iWVJykBwDlGS3/",
"component_encodings": [
{
"@type":
"FastPrimitivesCoder$eNprYEpOLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqZQ/vi0xJycpMTk7Hiw+kJmPEYFZCZn56RCjWABGsFaW8iWVJykBwDlGS3/",
"component_encodings": []
},
{
"@type":
"FastPrimitivesCoder$eNprYEpOLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqZQ/vi0xJycpMTk7Hiw+kJmPEYFZCZn56RCjWABGsFaW8iWVJykBwDlGS3/",
"component_encodings": []
}
],
"is_pair_like": true
}
],
"is_pair_like": true
},
{
"@type": "kind:global_window"
}
],
"is_wrapper": true
},
"output_name": "out",
"user_name": "write/Write/WriteImpl/FinalizeWrite/MapToVoidKey2.out"
}
],
"parallel_input": {
"@type": "OutputReference",
"output_name": "out",
"step_name": "s20"
},
"serialized_fn": "<string of 952 bytes>",
"user_name": "write/Write/WriteImpl/FinalizeWrite/MapToVoidKey2"
}
}
],
"type": "JOB_TYPE_BATCH"
}
root: INFO: Create job: <Job
createTime: u'2018-03-23T06:55:57.024374Z'
currentStateTime: u'1970-01-01T00:00:00Z'
id: u'2018-03-22_23_55_55-11818490079660522886'
location: u'us-central1'
name: u'beamapp-jenkins-0323065553-986875'
projectId: u'apache-beam-testing'
stageStates: []
steps: []
tempFiles: []
type: TypeValueValuesEnum(JOB_TYPE_BATCH, 1)>
root: INFO: Created job with id: [2018-03-22_23_55_55-11818490079660522886]
root: INFO: To access the Dataflow monitoring console, please navigate to
https://console.cloud.google.com/dataflow/jobsDetail/locations/us-central1/jobs/2018-03-22_23_55_55-11818490079660522886?project=apache-beam-testing
root: INFO: Job 2018-03-22_23_55_55-11818490079660522886 is in state
JOB_STATE_PENDING
root: INFO: 2018-03-23T06:55:55.718Z: JOB_MESSAGE_WARNING: Job
2018-03-22_23_55_55-11818490079660522886 might autoscale up to 250 workers.
root: INFO: 2018-03-23T06:55:55.726Z: JOB_MESSAGE_DETAILED: Autoscaling is
enabled for job 2018-03-22_23_55_55-11818490079660522886. The number of workers
will be between 1 and 250.
root: INFO: 2018-03-23T06:55:55.738Z: JOB_MESSAGE_DETAILED: Autoscaling was
automatically enabled for job 2018-03-22_23_55_55-11818490079660522886.
root: INFO: 2018-03-23T06:55:58.849Z: JOB_MESSAGE_DETAILED: Checking required
Cloud APIs are enabled.
root: INFO: 2018-03-23T06:55:59.009Z: JOB_MESSAGE_DETAILED: Checking
permissions granted to controller Service Account.
root: INFO: 2018-03-23T06:55:59.316Z: JOB_MESSAGE_DETAILED: Expanding
CoGroupByKey operations into optimizable parts.
root: INFO: 2018-03-23T06:55:59.335Z: JOB_MESSAGE_DEBUG: Combiner lifting
skipped for step write/Write/WriteImpl/GroupByKey: GroupByKey not followed by a
combiner.
root: INFO: 2018-03-23T06:55:59.355Z: JOB_MESSAGE_DEBUG: Combiner lifting
skipped for step group: GroupByKey not followed by a combiner.
root: INFO: 2018-03-23T06:55:59.367Z: JOB_MESSAGE_DETAILED: Expanding
GroupByKey operations into optimizable parts.
root: INFO: 2018-03-23T06:55:59.389Z: JOB_MESSAGE_DETAILED: Lifting
ValueCombiningMappingFns into MergeBucketsMappingFns
root: INFO: 2018-03-23T06:55:59.410Z: JOB_MESSAGE_DEBUG: Annotating graph with
Autotuner information.
root: INFO: 2018-03-23T06:55:59.438Z: JOB_MESSAGE_DETAILED: Fusing adjacent
ParDo, Read, Write, and Flatten operations
root: INFO: 2018-03-23T06:55:59.457Z: JOB_MESSAGE_DETAILED: Fusing consumer
write/Write/WriteImpl/PreFinalize/MapToVoidKey1 into
write/Write/WriteImpl/Extract
root: INFO: 2018-03-23T06:55:59.478Z: JOB_MESSAGE_DETAILED: Fusing consumer
write/Write/WriteImpl/FinalizeWrite/MapToVoidKey1 into
write/Write/WriteImpl/Extract
root: INFO: 2018-03-23T06:55:59.489Z: JOB_MESSAGE_DETAILED: Fusing consumer
write/Write/WriteImpl/PreFinalize/MapToVoidKey1 into
write/Write/WriteImpl/Extract
root: INFO: 2018-03-23T06:55:59.509Z: JOB_MESSAGE_DETAILED: Fusing consumer
write/Write/WriteImpl/FinalizeWrite/MapToVoidKey1 into
write/Write/WriteImpl/Extract
root: INFO: 2018-03-23T06:55:59.528Z: JOB_MESSAGE_DETAILED: Fusing consumer
pair_with_one into split
root: INFO: 2018-03-23T06:55:59.550Z: JOB_MESSAGE_DETAILED: Fusing consumer
group/Reify into pair_with_one
root: INFO: 2018-03-23T06:55:59.570Z: JOB_MESSAGE_DETAILED: Fusing consumer
write/Write/WriteImpl/GroupByKey/Reify into
write/Write/WriteImpl/WindowInto(WindowIntoFn)
root: INFO: 2018-03-23T06:55:59.584Z: JOB_MESSAGE_DETAILED: Fusing consumer
write/Write/WriteImpl/WindowInto(WindowIntoFn) into write/Write/WriteImpl/Pair
root: INFO: 2018-03-23T06:55:59.601Z: JOB_MESSAGE_DETAILED: Fusing consumer
write/Write/WriteImpl/WriteBundles/WriteBundles into format
root: INFO: 2018-03-23T06:55:59.617Z: JOB_MESSAGE_DETAILED: Fusing consumer
write/Write/WriteImpl/Pair into write/Write/WriteImpl/WriteBundles/WriteBundles
root: INFO: 2018-03-23T06:55:59.631Z: JOB_MESSAGE_DETAILED: Fusing consumer
split into read/Read
root: INFO: 2018-03-23T06:55:59.649Z: JOB_MESSAGE_DETAILED: Fusing consumer
count into group/GroupByWindow
root: INFO: 2018-03-23T06:55:59.662Z: JOB_MESSAGE_DETAILED: Fusing consumer
format into count
root: INFO: 2018-03-23T06:55:59.675Z: JOB_MESSAGE_DETAILED: Fusing consumer
group/Write into group/Reify
root: INFO: 2018-03-23T06:55:59.691Z: JOB_MESSAGE_DETAILED: Fusing consumer
group/GroupByWindow into group/Read
root: INFO: 2018-03-23T06:55:59.705Z: JOB_MESSAGE_DETAILED: Fusing consumer
write/Write/WriteImpl/Extract into
write/Write/WriteImpl/GroupByKey/GroupByWindow
root: INFO: 2018-03-23T06:55:59.719Z: JOB_MESSAGE_DETAILED: Fusing consumer
write/Write/WriteImpl/GroupByKey/Write into
write/Write/WriteImpl/GroupByKey/Reify
root: INFO: 2018-03-23T06:55:59.735Z: JOB_MESSAGE_DETAILED: Fusing consumer
write/Write/WriteImpl/GroupByKey/GroupByWindow into
write/Write/WriteImpl/GroupByKey/Read
root: INFO: 2018-03-23T06:55:59.749Z: JOB_MESSAGE_DETAILED: Fusing consumer
write/Write/WriteImpl/PreFinalize/MapToVoidKey0 into
write/Write/WriteImpl/InitializeWrite
root: INFO: 2018-03-23T06:55:59.763Z: JOB_MESSAGE_DETAILED: Fusing consumer
write/Write/WriteImpl/FinalizeWrite/MapToVoidKey0 into
write/Write/WriteImpl/InitializeWrite
root: INFO: 2018-03-23T06:55:59.775Z: JOB_MESSAGE_DETAILED: Fusing consumer
write/Write/WriteImpl/WriteBundles/MapToVoidKey0 into
write/Write/WriteImpl/InitializeWrite
root: INFO: 2018-03-23T06:55:59.795Z: JOB_MESSAGE_DETAILED: Fusing consumer
write/Write/WriteImpl/PreFinalize/MapToVoidKey0 into
write/Write/WriteImpl/InitializeWrite
root: INFO: 2018-03-23T06:55:59.805Z: JOB_MESSAGE_DETAILED: Fusing consumer
write/Write/WriteImpl/FinalizeWrite/MapToVoidKey0 into
write/Write/WriteImpl/InitializeWrite
root: INFO: 2018-03-23T06:55:59.818Z: JOB_MESSAGE_DETAILED: Fusing consumer
write/Write/WriteImpl/WriteBundles/MapToVoidKey0 into
write/Write/WriteImpl/InitializeWrite
root: INFO: 2018-03-23T06:55:59.830Z: JOB_MESSAGE_DETAILED: Fusing consumer
write/Write/WriteImpl/InitializeWrite into write/Write/WriteImpl/DoOnce/Read
root: INFO: 2018-03-23T06:55:59.845Z: JOB_MESSAGE_DETAILED: Fusing consumer
write/Write/WriteImpl/FinalizeWrite/MapToVoidKey2 into
write/Write/WriteImpl/PreFinalize/PreFinalize
root: INFO: 2018-03-23T06:55:59.862Z: JOB_MESSAGE_DETAILED: Fusing consumer
write/Write/WriteImpl/FinalizeWrite/MapToVoidKey2 into
write/Write/WriteImpl/PreFinalize/PreFinalize
root: INFO: 2018-03-23T06:55:59.876Z: JOB_MESSAGE_DEBUG: Workflow config is
missing a default resource spec.
root: INFO: 2018-03-23T06:55:59.897Z: JOB_MESSAGE_DEBUG: Adding StepResource
setup and teardown to workflow graph.
root: INFO: 2018-03-23T06:55:59.908Z: JOB_MESSAGE_DEBUG: Adding workflow start
and stop steps.
root: INFO: 2018-03-23T06:55:59.926Z: JOB_MESSAGE_DEBUG: Assigning stage ids.
root: INFO: 2018-03-23T06:56:00.031Z: JOB_MESSAGE_DEBUG: Executing wait step
start26
root: INFO: 2018-03-23T06:56:00.081Z: JOB_MESSAGE_BASIC: Executing operation
write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite+write/Write/WriteImpl/PreFinalize/MapToVoidKey0+write/Write/WriteImpl/FinalizeWrite/MapToVoidKey0+write/Write/WriteImpl/WriteBundles/MapToVoidKey0+write/Write/WriteImpl/PreFinalize/MapToVoidKey0+write/Write/WriteImpl/FinalizeWrite/MapToVoidKey0+write/Write/WriteImpl/WriteBundles/MapToVoidKey0
root: INFO: 2018-03-23T06:56:00.103Z: JOB_MESSAGE_BASIC: Executing operation
write/Write/WriteImpl/GroupByKey/Create
root: INFO: 2018-03-23T06:56:00.116Z: JOB_MESSAGE_DEBUG: Starting worker pool
setup.
root: INFO: 2018-03-23T06:56:00.123Z: JOB_MESSAGE_BASIC: Executing operation
group/Create
root: INFO: 2018-03-23T06:56:00.138Z: JOB_MESSAGE_BASIC: Starting 1 workers in
us-central1-f...
root: INFO: Job 2018-03-22_23_55_55-11818490079660522886 is in state
JOB_STATE_RUNNING
root: INFO: 2018-03-23T06:56:09.293Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised
the number of workers to 0 based on the rate of progress in the currently
running step(s).
root: INFO: 2018-03-23T06:56:09.339Z: JOB_MESSAGE_DEBUG: Value
"write/Write/WriteImpl/GroupByKey/Session" materialized.
root: INFO: 2018-03-23T06:56:09.361Z: JOB_MESSAGE_DEBUG: Value "group/Session"
materialized.
root: INFO: 2018-03-23T06:56:09.405Z: JOB_MESSAGE_BASIC: Executing operation
read/Read+split+pair_with_one+group/Reify+group/Write
root: INFO: 2018-03-23T06:56:14.549Z: JOB_MESSAGE_BASIC: Autoscaling: Resizing
worker pool from 1 to 2.
root: INFO: 2018-03-23T06:56:26.225Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised
the number of workers to 1 based on the rate of progress in the currently
running step(s).
root: INFO: 2018-03-23T06:56:26.248Z: JOB_MESSAGE_DETAILED: Resized worker pool
to 1, though goal was 2. This could be a quota issue.
root: INFO: 2018-03-23T06:56:40.286Z: JOB_MESSAGE_DETAILED: Workers have
started successfully.
root: INFO: 2018-03-23T06:56:42.087Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised
the number of workers to 2 based on the rate of progress in the currently
running step(s).
root: INFO: 2018-03-23T07:01:04.434Z: JOB_MESSAGE_BASIC: Executing operation
group/Close
root: INFO: 2018-03-23T07:01:54.230Z: JOB_MESSAGE_DEBUG: Executing failure step
failure25
root: INFO: 2018-03-23T07:01:54.253Z: JOB_MESSAGE_ERROR: Workflow failed.
Causes:
S01:write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite+write/Write/WriteImpl/PreFinalize/MapToVoidKey0+write/Write/WriteImpl/FinalizeWrite/MapToVoidKey0+write/Write/WriteImpl/WriteBundles/MapToVoidKey0+write/Write/WriteImpl/PreFinalize/MapToVoidKey0+write/Write/WriteImpl/FinalizeWrite/MapToVoidKey0+write/Write/WriteImpl/WriteBundles/MapToVoidKey0
failed., Unable to rename output files from
gs://temp-storage-for-end-to-end-tests/temp-it/beamapp-jenkins-0323065553-986875.1521788153.987010/dax-tmp-2018-03-22_23_55_55-11818490079660522886-S01-2-ce13482c0d0d758a/[email protected]
to
gs://temp-storage-for-end-to-end-tests/temp-it/beamapp-jenkins-0323065553-986875.1521788153.987010/tmp-ce13482c0d0d7b01@*.avro.,
Unable to rename
"gs://temp-storage-for-end-to-end-tests/temp-it/beamapp-jenkins-0323065553-986875.1521788153.987010/dax-tmp-2018-03-22_23_55_55-11818490079660522886-S01-2-ce13482c0d0d758a/tmp-ce13482c0d0d7b01-shard--try-45a581cdfeee976d-endshard.avro"
to
"gs://temp-storage-for-end-to-end-tests/temp-it/beamapp-jenkins-0323065553-986875.1521788153.987010/tmp-ce13482c0d0d7b01-00000-of-00001.avro".
root: INFO: 2018-03-23T07:01:54.391Z: JOB_MESSAGE_DETAILED: Cleaning up.
root: INFO: 2018-03-23T07:01:54.437Z: JOB_MESSAGE_DEBUG: Starting worker pool
teardown.
root: INFO: 2018-03-23T07:01:54.465Z: JOB_MESSAGE_BASIC: Stopping worker pool...
root: INFO: 2018-03-23T07:03:43.106Z: JOB_MESSAGE_DETAILED: Autoscaling:
Reduced the number of workers to 0 based on the rate of progress in the
currently running step(s).
root: INFO: 2018-03-23T07:03:43.155Z: JOB_MESSAGE_BASIC: Worker pool stopped.
root: INFO: 2018-03-23T07:03:43.195Z: JOB_MESSAGE_DEBUG: Tearing down pending
resources...
root: INFO: Job 2018-03-22_23_55_55-11818490079660522886 is in state
JOB_STATE_FAILED
--------------------- >> end captured logging << ---------------------
----------------------------------------------------------------------
Ran 3 tests in 479.838s
FAILED (errors=1)
Found:
https://console.cloud.google.com/dataflow/jobsDetail/locations/us-central1/jobs/2018-03-22_23_55_55-11818490079660522886?project=apache-beam-testing
Found:
https://console.cloud.google.com/dataflow/jobsDetail/locations/us-central1/jobs/2018-03-22_23_55_54-9845132974698820726?project=apache-beam-testing
Found:
https://console.cloud.google.com/dataflow/jobsDetail/locations/us-central1/jobs/2018-03-22_23_55_55-13126312791456585243?project=apache-beam-testing
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user [email protected]
Not sending mail to unregistered user [email protected]
Not sending mail to unregistered user [email protected]
Not sending mail to unregistered user [email protected]
Not sending mail to unregistered user [email protected]
Not sending mail to unregistered user [email protected]
Not sending mail to unregistered user [email protected]
Not sending mail to unregistered user [email protected]
Not sending mail to unregistered user [email protected]
Not sending mail to unregistered user [email protected]
