See
<https://builds.apache.org/job/beam_PostCommit_Python_Verify/3895/display/redirect>
------------------------------------------
[...truncated 1.11 MB...]
{
"@type": "kind:windowed_value",
"component_encodings": [
{
"@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
},
{
"@type": "kind:global_window"
}
],
"is_wrapper": true
}
]
},
"output_name": "out",
"user_name":
"write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(InitializeWrite.out.0).output"
}
],
"parallel_input": {
"@type": "OutputReference",
"output_name": "out",
"step_name": "s8"
},
"user_name":
"write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(InitializeWrite.out.0)"
}
},
{
"kind": "CollectionToSingleton",
"name": "SideInput-s16",
"properties": {
"output_info": [
{
"encoding": {
"@type": "kind:windowed_value",
"component_encodings": [
{
"@type": "kind:windowed_value",
"component_encodings": [
{
"@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
},
{
"@type": "kind:global_window"
}
],
"is_wrapper": true
}
]
},
"output_name": "out",
"user_name":
"write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(Extract.out.0).output"
}
],
"parallel_input": {
"@type": "OutputReference",
"output_name": "out",
"step_name": "s14"
},
"user_name":
"write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(Extract.out.0)"
}
},
{
"kind": "ParallelDo",
"name": "s17",
"properties": {
"display_data": [
{
"key": "fn",
"label": "Transform Function",
"namespace": "apache_beam.transforms.core.CallableWrapperDoFn",
"type": "STRING",
"value": "_finalize_write"
},
{
"key": "fn",
"label": "Transform Function",
"namespace": "apache_beam.transforms.core.ParDo",
"shortValue": "CallableWrapperDoFn",
"type": "STRING",
"value": "apache_beam.transforms.core.CallableWrapperDoFn"
}
],
"non_parallel_inputs": {
"SideInput-s15": {
"@type": "OutputReference",
"output_name": "out",
"step_name": "SideInput-s15"
},
"SideInput-s16": {
"@type": "OutputReference",
"output_name": "out",
"step_name": "SideInput-s16"
}
},
"output_info": [
{
"encoding": {
"@type": "kind:windowed_value",
"component_encodings": [
{
"@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
},
{
"@type": "kind:global_window"
}
],
"is_wrapper": true
},
"output_name": "out",
"user_name": "write/Write/WriteImpl/FinalizeWrite.out"
}
],
"parallel_input": {
"@type": "OutputReference",
"output_name": "out",
"step_name": "s7"
},
"serialized_fn": "<string of 2444 bytes>",
"user_name": "write/Write/WriteImpl/FinalizeWrite/FinalizeWrite"
}
}
],
"type": "JOB_TYPE_BATCH"
}
root: INFO: Create job: <Job
createTime: u'2018-01-06T21:16:22.792438Z'
currentStateTime: u'1970-01-01T00:00:00Z'
id: u'2018-01-06_13_16_22-6809552444561923799'
location: u'us-central1'
name: u'beamapp-jenkins-0106211620-866717'
projectId: u'apache-beam-testing'
stageStates: []
steps: []
tempFiles: []
type: TypeValueValuesEnum(JOB_TYPE_BATCH, 1)>
root: INFO: Created job with id: [2018-01-06_13_16_22-6809552444561923799]
root: INFO: To access the Dataflow monitoring console, please navigate to
https://console.cloud.google.com/dataflow/jobsDetail/locations/us-central1/jobs/2018-01-06_13_16_22-6809552444561923799?project=apache-beam-testing
root: INFO: Job 2018-01-06_13_16_22-6809552444561923799 is in state
JOB_STATE_PENDING
root: INFO: 2018-01-06T21:16:22.211Z: JOB_MESSAGE_WARNING: (5e8063dea98198a3):
Setting the number of workers (1) disables autoscaling for this job. If you are
trying to cap autoscaling, consider only setting max_num_workers. If you want
to disable autoscaling altogether, the documented way is to explicitly use
autoscalingAlgorithm=NONE.
root: INFO: 2018-01-06T21:16:24.641Z: JOB_MESSAGE_DETAILED: (ec9e888312ab9d61):
Checking required Cloud APIs are enabled.
root: INFO: 2018-01-06T21:16:25.490Z: JOB_MESSAGE_DETAILED: (ec9e888312ab9eff):
Expanding CoGroupByKey operations into optimizable parts.
root: INFO: 2018-01-06T21:16:25.512Z: JOB_MESSAGE_DEBUG: (ec9e888312ab9bea):
Combiner lifting skipped for step write/Write/WriteImpl/GroupByKey: GroupByKey
not followed by a combiner.
root: INFO: 2018-01-06T21:16:25.541Z: JOB_MESSAGE_DEBUG: (ec9e888312ab99dc):
Combiner lifting skipped for step group: GroupByKey not followed by a combiner.
root: INFO: 2018-01-06T21:16:25.573Z: JOB_MESSAGE_DETAILED: (ec9e888312ab97ce):
Expanding GroupByKey operations into optimizable parts.
root: INFO: 2018-01-06T21:16:25.595Z: JOB_MESSAGE_DETAILED: (ec9e888312ab95c0):
Lifting ValueCombiningMappingFns into MergeBucketsMappingFns
root: INFO: 2018-01-06T21:16:25.620Z: JOB_MESSAGE_DEBUG: (ec9e888312ab9f96):
Annotating graph with Autotuner information.
root: INFO: 2018-01-06T21:16:25.657Z: JOB_MESSAGE_DETAILED: (ec9e888312ab9b7a):
Fusing adjacent ParDo, Read, Write, and Flatten operations
root: INFO: 2018-01-06T21:16:25.679Z: JOB_MESSAGE_DETAILED: (ec9e888312ab996c):
Fusing consumer split into read/Read
root: INFO: 2018-01-06T21:16:25.708Z: JOB_MESSAGE_DETAILED: (ec9e888312ab975e):
Fusing consumer group/Write into group/Reify
root: INFO: 2018-01-06T21:16:25.738Z: JOB_MESSAGE_DETAILED: (ec9e888312ab9550):
Fusing consumer group/GroupByWindow into group/Read
root: INFO: 2018-01-06T21:16:25.769Z: JOB_MESSAGE_DETAILED: (ec9e888312ab9342):
Fusing consumer write/Write/WriteImpl/GroupByKey/GroupByWindow into
write/Write/WriteImpl/GroupByKey/Read
root: INFO: 2018-01-06T21:16:25.800Z: JOB_MESSAGE_DETAILED: (ec9e888312ab9134):
Fusing consumer write/Write/WriteImpl/GroupByKey/Write into
write/Write/WriteImpl/GroupByKey/Reify
root: INFO: 2018-01-06T21:16:25.830Z: JOB_MESSAGE_DETAILED: (ec9e888312ab9f26):
Fusing consumer write/Write/WriteImpl/WindowInto(WindowIntoFn) into
write/Write/WriteImpl/Pair
root: INFO: 2018-01-06T21:16:25.861Z: JOB_MESSAGE_DETAILED: (ec9e888312ab9d18):
Fusing consumer write/Write/WriteImpl/GroupByKey/Reify into
write/Write/WriteImpl/WindowInto(WindowIntoFn)
root: INFO: 2018-01-06T21:16:25.891Z: JOB_MESSAGE_DETAILED: (ec9e888312ab9b0a):
Fusing consumer pair_with_one into split
root: INFO: 2018-01-06T21:16:25.922Z: JOB_MESSAGE_DETAILED: (ec9e888312ab98fc):
Fusing consumer group/Reify into pair_with_one
root: INFO: 2018-01-06T21:16:25.953Z: JOB_MESSAGE_DETAILED: (ec9e888312ab96ee):
Fusing consumer write/Write/WriteImpl/WriteBundles/WriteBundles into format
root: INFO: 2018-01-06T21:16:25.984Z: JOB_MESSAGE_DETAILED: (ec9e888312ab94e0):
Fusing consumer write/Write/WriteImpl/Pair into
write/Write/WriteImpl/WriteBundles/WriteBundles
root: INFO: 2018-01-06T21:16:26.004Z: JOB_MESSAGE_DETAILED: (ec9e888312ab92d2):
Fusing consumer format into count
root: INFO: 2018-01-06T21:16:26.035Z: JOB_MESSAGE_DETAILED: (ec9e888312ab90c4):
Fusing consumer write/Write/WriteImpl/Extract into
write/Write/WriteImpl/GroupByKey/GroupByWindow
root: INFO: 2018-01-06T21:16:26.066Z: JOB_MESSAGE_DETAILED: (ec9e888312ab9eb6):
Fusing consumer count into group/GroupByWindow
root: INFO: 2018-01-06T21:16:26.096Z: JOB_MESSAGE_DETAILED: (ec9e888312ab9ca8):
Fusing consumer write/Write/WriteImpl/InitializeWrite into
write/Write/WriteImpl/DoOnce/Read
root: INFO: 2018-01-06T21:16:26.129Z: JOB_MESSAGE_DEBUG: (ec9e888312ab9a9a):
Workflow config is missing a default resource spec.
root: INFO: 2018-01-06T21:16:26.151Z: JOB_MESSAGE_DEBUG: (ec9e888312ab988c):
Adding StepResource setup and teardown to workflow graph.
root: INFO: 2018-01-06T21:16:26.181Z: JOB_MESSAGE_DEBUG: (ec9e888312ab967e):
Adding workflow start and stop steps.
root: INFO: 2018-01-06T21:16:26.212Z: JOB_MESSAGE_DEBUG: (ec9e888312ab9470):
Assigning stage ids.
root: INFO: 2018-01-06T21:16:26.355Z: JOB_MESSAGE_DEBUG: (e580e1f95945392f):
Executing wait step start25
root: INFO: 2018-01-06T21:16:26.415Z: JOB_MESSAGE_BASIC: (e580e1f959453445):
Executing operation
write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite
root: INFO: 2018-01-06T21:16:26.448Z: JOB_MESSAGE_BASIC: (cf84428efce19bde):
Executing operation group/Create
root: INFO: 2018-01-06T21:16:26.461Z: JOB_MESSAGE_DEBUG: (13152aadeffb08cb):
Starting worker pool setup.
root: INFO: 2018-01-06T21:16:26.484Z: JOB_MESSAGE_BASIC: (13152aadeffb031d):
Starting 1 workers in us-central1-f...
root: INFO: 2018-01-06T21:16:26.546Z: JOB_MESSAGE_DEBUG: (cf84428efce19c60):
Value "group/Session" materialized.
root: INFO: 2018-01-06T21:16:26.589Z: JOB_MESSAGE_BASIC: (7ddb8ee8b054fdf7):
Executing operation read/Read+split+pair_with_one+group/Reify+group/Write
root: INFO: Job 2018-01-06_13_16_22-6809552444561923799 is in state
JOB_STATE_RUNNING
root: INFO: 2018-01-06T21:16:35.078Z: JOB_MESSAGE_DETAILED: (139bb903417a1669):
Autoscaling: Raised the number of workers to 0 based on the rate of progress in
the currently running step(s).
root: INFO: 2018-01-06T21:17:09.597Z: JOB_MESSAGE_ERROR: (139bb903417a1e5c):
Startup of the worker pool in zone us-central1-f failed to bring up any of the
desired 1 workers. QUOTA_EXCEEDED: Quota 'DISKS_TOTAL_GB' exceeded. Limit:
21000.0 in region us-central1.
root: INFO: 2018-01-06T21:17:09.609Z: JOB_MESSAGE_ERROR: (139bb903417a13d2):
Workflow failed.
root: INFO: 2018-01-06T21:17:10.260Z: JOB_MESSAGE_DETAILED: (ec9e888312ab9b31):
Cleaning up.
root: INFO: 2018-01-06T21:17:10.291Z: JOB_MESSAGE_DEBUG: (ec9e888312ab9715):
Starting worker pool teardown.
root: INFO: 2018-01-06T21:17:10.301Z: JOB_MESSAGE_BASIC: (ec9e888312ab9507):
Stopping worker pool...
root: INFO: 2018-01-06T21:17:18.410Z: JOB_MESSAGE_DEBUG: (ec9e888312ab9ac1):
Tearing down pending resources...
root: INFO: Job 2018-01-06_13_16_22-6809552444561923799 is in state
JOB_STATE_FAILED
--------------------- >> end captured logging << ---------------------
======================================================================
ERROR: test_wordcount_fnapi_it
(apache_beam.examples.wordcount_it_test.WordCountIT)
----------------------------------------------------------------------
Traceback (most recent call last):
File
"<https://builds.apache.org/job/beam_PostCommit_Python_Verify/ws/src/sdks/python/.eggs/nose-1.3.7-py2.7.egg/nose/plugins/multiprocess.py";,>
line 812, in run
test(orig)
File
"<https://builds.apache.org/job/beam_PostCommit_Python_Verify/ws/src/sdks/python/.eggs/nose-1.3.7-py2.7.egg/nose/case.py";,>
line 45, in __call__
return self.run(*arg, **kwarg)
File
"<https://builds.apache.org/job/beam_PostCommit_Python_Verify/ws/src/sdks/python/.eggs/nose-1.3.7-py2.7.egg/nose/case.py";,>
line 133, in run
self.runTest(result)
File
"<https://builds.apache.org/job/beam_PostCommit_Python_Verify/ws/src/sdks/python/.eggs/nose-1.3.7-py2.7.egg/nose/case.py";,>
line 151, in runTest
test(result)
File "/usr/lib/python2.7/unittest/case.py", line 395, in __call__
return self.run(*args, **kwds)
File "/usr/lib/python2.7/unittest/case.py", line 331, in run
testMethod()
File
"<https://builds.apache.org/job/beam_PostCommit_Python_Verify/ws/src/sdks/python/apache_beam/examples/wordcount_it_test.py";,>
line 77, in test_wordcount_fnapi_it
on_success_matcher=PipelineStateMatcher()))
File
"<https://builds.apache.org/job/beam_PostCommit_Python_Verify/ws/src/sdks/python/apache_beam/examples/wordcount_fnapi.py";,>
line 130, in run
result.wait_until_finish()
File
"<https://builds.apache.org/job/beam_PostCommit_Python_Verify/ws/src/sdks/python/apache_beam/runners/dataflow/dataflow_runner.py";,>
line 956, in wait_until_finish
time.sleep(5.0)
File
"<https://builds.apache.org/job/beam_PostCommit_Python_Verify/ws/src/sdks/python/.eggs/nose-1.3.7-py2.7.egg/nose/plugins/multiprocess.py";,>
line 276, in signalhandler
raise TimedOutException()
TimedOutException: 'test_wordcount_fnapi_it
(apache_beam.examples.wordcount_it_test.WordCountIT)'
----------------------------------------------------------------------
Ran 3 tests in 901.269s
FAILED (errors=2)
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user eh...@google.com
