You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@beam.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2019/09/29 17:10:49 UTC
Build failed in Jenkins: beam_PerformanceTests_WordCountIT_Py37
#522
See <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/522/display/redirect>
Changes:
------------------------------------------
[...truncated 157.77 KB...]
"@type": "kind:windowed_value",
"component_encodings": [
{
"@type": "FastPrimitivesCoder$eNprYE5OLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqYIfgYGhvi0xJycpMTk7HiwlkJ8pgVkJmfnpEJNYQGawlpbyJZUnKQHACYlLgM=",
"component_encodings": [
{
"@type": "FastPrimitivesCoder$eNprYE5OLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqYIfgYGhvi0xJycpMTk7HiwlkJ8pgVkJmfnpEJNYQGawlpbyJZUnKQHACYlLgM=",
"component_encodings": []
},
{
"@type": "FastPrimitivesCoder$eNprYE5OLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqYIfgYGhvi0xJycpMTk7HiwlkJ8pgVkJmfnpEJNYQGawlpbyJZUnKQHACYlLgM=",
"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": "eNrNV/l/G8UV10rOwZKmAUogpIdISbumSEpC4jQuhaRKAkax4q4N3h5hGe2ONIt3d/bNzFoxtbhSOYbed6FXUnrf9L6Pv6P/TN+MJKcCm+a39POxd1dv5r2Z933f953d50pOQDISMOq3KEmqSpBUtrlIZDXggtp1EsekFdNFQbKMitP8bGpDYfJ5sHpQdLxSoVDw2ymUxoJEHP9aRFLbb0cpiaOnqd8VkaI2THi7jEuOYUVHZjSAbU1vB9oywQMqJWxnE97Neo5ayajPolRJ2DG+Rxww9mpIcZNEcSHtmfMLaH5Em23YiRu8qdkD2zGhojTLlYkn4eam2QHP1TXbrma+Bm9p5a0LsNt5fSaKXlQRt/0FvM9H6ZINb8Xoe3pwi+PtwUjtKKZ+RhTzM0Hb0UW4dSwCz9A7ldVlEuc4T/DlKKTCnldERcHj2jg3ssFtGPhtPbjd8WwMPPDQO4S9QRjFcdXXV9uPOQmN3YY7TAWkEnBnH/a5cJe3beQJ+73z+NyR07WaoklWkYgT6dAKVrdC07Ci+OBGpZK1bKUSqUoQ8zysDbCpHT42deL48amjR45NHZ2qCSrzGEvx9rx1Le2UJNSXeVun/Q6mt//OHrzLYXvZXWy/h7MKUMb5Ops0T3zJiAgl3N0omG0GHLOGA2NwGZsc3uwFPq9ElHbq3ODzblzgnh4cbHm36Kx1tMEWNGGJgvd496C9ctAZDuXJ5KFjYYW30XRtfW2D93p7x0N0Yt4axXHMYOXeTT0nTfoBT7DcUmJtByW615tAM8kVh/d5N+FjEiXD6t1nANA8qmUxiVKoePs0wXVHpVhJQaIYk/RT2sU78rG6bjrCZ5RohGrNvDXOylRRgX1VzVUU26dEJ09oquZiElDGYwPVIYTqMNPXIw3L3O+nPTh6AY453qTOHBl3qGKasrZ47TqTZHHt7LBnjQWmxpbODLds/7E0i4KlmIbzGGhG95cNx3vwfsfAEBJF4MRmjhvTT+MUG6ZxYx/owQOOt1ujF2gF0M2k84MPevvRqL2n9XZ908bTuCehFWl6+TA8aIjQjdKQd/0E8dQwohw9tJWm6TgmjLRNxUnsv8HbhpMG/uWIdnWwU2PNFwhKFDIuTwPd2DZ8yGF3eDtxviap1iCo9+G0C2echtUo4H+pcVvdXi+sFtatS8X5Apxt9uHhSeMyygUe6cOMJ9BSYzyhtadouhSlcnSvyJgs01qXiyWJedGaTsufo8LwNQ3ogu5hf5GLsM7zVM0s+HMr9x+vSRHUZLiku1sxntb+C5TaoB7VbAUeNVt5ICZJKyQPQmP2vFUvwDnvdt3lgie+wJCazBu7nTUSavAZyhs01+D8pII5Fz48BleHKh/LiYx0zTKtPIoVpgTzBmMc1qOwsAaPufD4mGuUZFwoP+FhHqPULXq3aoq8gVLg9eEjLnzUhPfRN1C+Dx9bg4+7cIE1mptVL6D4A55gWDssUxHLVGrsaNTrT6qCsq4UVwuhdbV4yeoVV4vywKp1pRQW1cSlwlUsn9q2iiNhaakoplaL4cS+Atq2h9sGdrVjYBs+lfRTu7QXry9YIc4E32k2iib1kLYJKio8qWniPYOWuTqPY2poVebtssQWLB8My91IsXKCh3FZMYIjKS3TmOqOLw8ahoZlIssEHdJOTBV669JUy2cjIVVZdflovizTNNAEoUL7YMQDB+WB+8y1Cih8rUH7xpFUEBgV0zVXnMcSQm+7/i3jKKBAzbmD1YO26dwzSaZWNnobOmY4pikwo33mnDsjBBcQsTsVPOUVTWxYMlCMSBSb1bXqQXIZUvao0WF/cxLy2des+p5CcY81Ye22dlk7raJVLEI2iTQEFwS7wHgT3wFkU4FyIe/Dsgtd9kQPLm6hGivspOzD0y58Yg1We9BDx2dceDZvsYfYyfwyPLehnIevSzmfZ6iILzjsBNMyd6kHn3TY/9a0vl6NnRpycyAhVmO+PrGq+bOG4nF5kqFerN8ovXhxXC9emv23xc5p1D/lwqcR9Zc06p9B8D7rwuc2wPv8BnhHrgu8L2jwvjgC70s9+PL1gPeVTcB7vf5+FSH8moHw6zcKwpfHIXwFJZedY7MMVfQbCOQ3XfgWAvlKk90Iifq2lij2fyNL31FwxWEBCxllbdZhjBkJucqWWMxQJr7LXn4zmXh1c5n4nibs9134AeL8qibsD5GwP3Lhx334iQs/1TLxsy1k4udGJn7hwi/X4Fc9eA0df+3CbzaY/lv6pl9UiyYgxrLhd8js3/fgD46hw2AlXOCPW/kPZtgPmxeXQRz82PkTRvmzEWt8V+50kKIp/GWrEMMp9unB6bMw/Al/xSB/Mwlj8fIkj4mutz58Kfy9YZmzVwMrFUkyH99+W/imKuAfOGQ+1iLpjw60f67nLQX/qv4HvxvURQ==",
"user_name": "write/Write/WriteImpl/FinalizeWrite/FinalizeWrite"
}
}
],
"type": "JOB_TYPE_BATCH"
}
root: INFO: Create job: <Job
createTime: '2019-09-29T17:00:29.939632Z'
currentStateTime: '1970-01-01T00:00:00Z'
id: '2019-09-29_10_00_28-11046516786482214616'
location: 'us-central1'
name: 'beamapp-jenkins-0929170026-598858'
projectId: 'apache-beam-testing'
stageStates: []
startTime: '2019-09-29T17:00:29.939632Z'
steps: []
tempFiles: []
type: TypeValueValuesEnum(JOB_TYPE_BATCH, 1)>
root: INFO: Created job with id: [2019-09-29_10_00_28-11046516786482214616]
root: INFO: To access the Dataflow monitoring console, please navigate to https://console.cloud.google.com/dataflow/jobsDetail/locations/us-central1/jobs/2019-09-29_10_00_28-11046516786482214616?project=apache-beam-testing
root: INFO: Job 2019-09-29_10_00_28-11046516786482214616 is in state JOB_STATE_RUNNING
root: INFO: 2019-09-29T17:00:32.749Z: JOB_MESSAGE_DETAILED: Checking permissions granted to controller Service Account.
root: INFO: 2019-09-29T17:00:33.248Z: JOB_MESSAGE_BASIC: Worker configuration: n1-standard-1 in us-central1-a.
root: INFO: 2019-09-29T17:00:33.805Z: JOB_MESSAGE_DETAILED: Expanding CoGroupByKey operations into optimizable parts.
root: INFO: 2019-09-29T17:00:33.850Z: JOB_MESSAGE_DEBUG: Combiner lifting skipped for step write/Write/WriteImpl/GroupByKey: GroupByKey not followed by a combiner.
root: INFO: 2019-09-29T17:00:33.884Z: JOB_MESSAGE_DEBUG: Combiner lifting skipped for step group: GroupByKey not followed by a combiner.
root: INFO: 2019-09-29T17:00:33.925Z: JOB_MESSAGE_DETAILED: Expanding GroupByKey operations into optimizable parts.
root: INFO: 2019-09-29T17:00:33.955Z: JOB_MESSAGE_DETAILED: Lifting ValueCombiningMappingFns into MergeBucketsMappingFns
root: INFO: 2019-09-29T17:00:34.066Z: JOB_MESSAGE_DEBUG: Annotating graph with Autotuner information.
root: INFO: 2019-09-29T17:00:34.115Z: JOB_MESSAGE_DETAILED: Fusing adjacent ParDo, Read, Write, and Flatten operations
root: INFO: 2019-09-29T17:00:34.144Z: JOB_MESSAGE_DETAILED: Fusing consumer split into read/Read
root: INFO: 2019-09-29T17:00:34.175Z: JOB_MESSAGE_DETAILED: Fusing consumer pair_with_one into split
root: INFO: 2019-09-29T17:00:34.212Z: JOB_MESSAGE_DETAILED: Fusing consumer group/Reify into pair_with_one
root: INFO: 2019-09-29T17:00:34.247Z: JOB_MESSAGE_DETAILED: Fusing consumer group/Write into group/Reify
root: INFO: 2019-09-29T17:00:34.275Z: JOB_MESSAGE_DETAILED: Fusing consumer group/GroupByWindow into group/Read
root: INFO: 2019-09-29T17:00:34.296Z: JOB_MESSAGE_DETAILED: Fusing consumer count into group/GroupByWindow
root: INFO: 2019-09-29T17:00:34.329Z: JOB_MESSAGE_DETAILED: Fusing consumer format into count
root: INFO: 2019-09-29T17:00:34.358Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/WriteBundles/WriteBundles into format
root: INFO: 2019-09-29T17:00:34.392Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/Pair into write/Write/WriteImpl/WriteBundles/WriteBundles
root: INFO: 2019-09-29T17:00:34.425Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/WindowInto(WindowIntoFn) into write/Write/WriteImpl/Pair
root: INFO: 2019-09-29T17:00:34.463Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/GroupByKey/Reify into write/Write/WriteImpl/WindowInto(WindowIntoFn)
root: INFO: 2019-09-29T17:00:34.494Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/GroupByKey/Write into write/Write/WriteImpl/GroupByKey/Reify
root: INFO: 2019-09-29T17:00:34.521Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/GroupByKey/GroupByWindow into write/Write/WriteImpl/GroupByKey/Read
root: INFO: 2019-09-29T17:00:34.554Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/Extract into write/Write/WriteImpl/GroupByKey/GroupByWindow
root: INFO: 2019-09-29T17:00:34.589Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/InitializeWrite into write/Write/WriteImpl/DoOnce/Read
root: INFO: 2019-09-29T17:00:34.626Z: JOB_MESSAGE_DEBUG: Workflow config is missing a default resource spec.
root: INFO: 2019-09-29T17:00:34.658Z: JOB_MESSAGE_DEBUG: Adding StepResource setup and teardown to workflow graph.
root: INFO: 2019-09-29T17:00:34.692Z: JOB_MESSAGE_DEBUG: Adding workflow start and stop steps.
root: INFO: 2019-09-29T17:00:34.727Z: JOB_MESSAGE_DEBUG: Assigning stage ids.
root: INFO: 2019-09-29T17:00:34.855Z: JOB_MESSAGE_DEBUG: Executing wait step start26
root: INFO: 2019-09-29T17:00:34.926Z: JOB_MESSAGE_BASIC: Executing operation write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite
root: INFO: 2019-09-29T17:00:34.960Z: JOB_MESSAGE_BASIC: Executing operation write/Write/WriteImpl/GroupByKey/Create
root: INFO: 2019-09-29T17:00:34.973Z: JOB_MESSAGE_DEBUG: Starting worker pool setup.
root: INFO: 2019-09-29T17:00:34.992Z: JOB_MESSAGE_BASIC: Executing operation group/Create
root: INFO: 2019-09-29T17:00:35.003Z: JOB_MESSAGE_BASIC: Starting 10 workers in us-central1-a...
root: INFO: 2019-09-29T17:00:35.061Z: JOB_MESSAGE_BASIC: Finished operation write/Write/WriteImpl/GroupByKey/Create
root: INFO: 2019-09-29T17:00:35.061Z: JOB_MESSAGE_BASIC: Finished operation group/Create
root: INFO: 2019-09-29T17:00:35.131Z: JOB_MESSAGE_DEBUG: Value "group/Session" materialized.
root: INFO: 2019-09-29T17:00:35.164Z: JOB_MESSAGE_DEBUG: Value "write/Write/WriteImpl/GroupByKey/Session" materialized.
root: INFO: 2019-09-29T17:00:35.201Z: JOB_MESSAGE_BASIC: Executing operation read/Read+split+pair_with_one+group/Reify+group/Write
root: INFO: 2019-09-29T17:01:03.923Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 4 based on the rate of progress in the currently running step(s).
root: INFO: 2019-09-29T17:01:03.961Z: JOB_MESSAGE_DETAILED: Resized worker pool to 4, though goal was 10. This could be a quota issue.
root: INFO: 2019-09-29T17:01:19.974Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 10 based on the rate of progress in the currently running step(s).
root: INFO: 2019-09-29T17:01:48.468Z: JOB_MESSAGE_DETAILED: Workers have started successfully.
root: INFO: 2019-09-29T17:01:48.502Z: JOB_MESSAGE_DETAILED: Workers have started successfully.
root: INFO: 2019-09-29T17:06:02.542Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-29T17:06:04.624Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-29T17:06:06.173Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-29T17:06:06.716Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-29T17:06:07.786Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-29T17:06:08.228Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-29T17:06:08.841Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-29T17:06:09.224Z: JOB_MESSAGE_BASIC: Finished operation write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite
root: INFO: 2019-09-29T17:06:09.291Z: JOB_MESSAGE_DEBUG: Executing failure step failure25
root: INFO: 2019-09-29T17:06:09.315Z: JOB_MESSAGE_ERROR: Workflow failed. Causes: S01:write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite failed., Internal Issue (dd68be8715759518): 63963027:24514
root: INFO: 2019-09-29T17:06:09.416Z: JOB_MESSAGE_BASIC: Finished operation read/Read+split+pair_with_one+group/Reify+group/Write
root: INFO: 2019-09-29T17:06:09.520Z: JOB_MESSAGE_DETAILED: Cleaning up.
root: INFO: 2019-09-29T17:06:09.577Z: JOB_MESSAGE_DEBUG: Starting worker pool teardown.
root: INFO: 2019-09-29T17:06:09.606Z: JOB_MESSAGE_BASIC: Stopping worker pool...
root: INFO: 2019-09-29T17:10:18.447Z: 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: 2019-09-29T17:10:18.496Z: JOB_MESSAGE_BASIC: Worker pool stopped.
root: INFO: 2019-09-29T17:10:18.541Z: JOB_MESSAGE_DEBUG: Tearing down pending resources...
root: INFO: Job 2019-09-29_10_00_28-11046516786482214616 is in state JOB_STATE_FAILED
apache_beam.io.filesystem: DEBUG: Listing files in 'gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1569776425646/results'
apache_beam.io.filesystem: DEBUG: translate_pattern: 'gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1569776425646/results*' -> 'gs://temp\\-storage\\-for\\-end\\-to\\-end\\-tests/py\\-it\\-cloud/output/1569776425646/results[^/\\\\]*'
root: INFO: Starting the size estimation of the input
root: INFO: Finished listing 0 files in 0.04501843452453613 seconds.
--------------------- >> end captured logging << ---------------------
----------------------------------------------------------------------
XML: nosetests-integrationTest-perf.xml
----------------------------------------------------------------------
XML: <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/src/sdks/python/nosetests.xml>
----------------------------------------------------------------------
Ran 1 test in 605.360s
FAILED (errors=1)
FAILURE: Build failed with an exception.
* What went wrong:
Execution failed for task ':sdks:python:test-suites:dataflow:py37:integrationTest'.
> Process 'command 'sh'' finished with non-zero exit value 1
* Try:
Run with --stacktrace option to get the stack trace. Run with --debug option to get more log output. Run with --scan to get full insights.
* Get more help at https://help.gradle.org
BUILD FAILED in 10m 52s
2019-09-29 17:10:32,434 d8cb5973 MainThread beam_integration_benchmark(1/1) ERROR Error during benchmark beam_integration_benchmark
Traceback (most recent call last):
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 841, in RunBenchmark
DoRunPhase(spec, collector, detailed_timer)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 687, in DoRunPhase
samples = spec.BenchmarkRun(spec)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/linux_benchmarks/beam_integration_benchmark.py",> line 160, in Run
job_type=job_type)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/providers/gcp/gcp_dpb_dataflow.py",> line 91, in SubmitJob
assert retcode == 0, "Integration Test Failed."
AssertionError: Integration Test Failed.
2019-09-29 17:10:32,435 d8cb5973 MainThread beam_integration_benchmark(1/1) INFO Cleaning up benchmark beam_integration_benchmark
2019-09-29 17:10:32,437 d8cb5973 MainThread beam_integration_benchmark(1/1) ERROR Exception running benchmark
Traceback (most recent call last):
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 984, in RunBenchmarkTask
RunBenchmark(spec, collector)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 841, in RunBenchmark
DoRunPhase(spec, collector, detailed_timer)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 687, in DoRunPhase
samples = spec.BenchmarkRun(spec)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/linux_benchmarks/beam_integration_benchmark.py",> line 160, in Run
job_type=job_type)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/providers/gcp/gcp_dpb_dataflow.py",> line 91, in SubmitJob
assert retcode == 0, "Integration Test Failed."
AssertionError: Integration Test Failed.
2019-09-29 17:10:32,437 d8cb5973 MainThread beam_integration_benchmark(1/1) ERROR Benchmark 1/1 beam_integration_benchmark (UID: beam_integration_benchmark0) failed. Execution will continue.
2019-09-29 17:10:32,438 d8cb5973 MainThread beam_integration_benchmark(1/1) INFO Benchmark run statuses:
---------------------------------------------------------------------------------
Name UID Status Failed Substatus
---------------------------------------------------------------------------------
beam_integration_benchmark beam_integration_benchmark0 FAILED
---------------------------------------------------------------------------------
Success rate: 0.00% (0/1)
2019-09-29 17:10:32,438 d8cb5973 MainThread beam_integration_benchmark(1/1) INFO Complete logs can be found at: <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/runs/d8cb5973/pkb.log>
2019-09-29 17:10:32,438 d8cb5973 MainThread beam_integration_benchmark(1/1) INFO Completion statuses can be found at: <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/runs/d8cb5973/completion_statuses.json>
Build step 'Execute shell' marked build as failure
---------------------------------------------------------------------
To unsubscribe, e-mail: builds-unsubscribe@beam.apache.org
For additional commands, e-mail: builds-help@beam.apache.org
Jenkins build is back to normal :
beam_PerformanceTests_WordCountIT_Py37 #528
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/528/display/redirect?page=changes>
---------------------------------------------------------------------
To unsubscribe, e-mail: builds-unsubscribe@beam.apache.org
For additional commands, e-mail: builds-help@beam.apache.org
Build failed in Jenkins: beam_PerformanceTests_WordCountIT_Py37
#527
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/527/display/redirect?page=changes>
Changes:
[ihr] Add clarification about authorized views
[kirillkozlov] [BEAM-8275] Beam SQL should support BigQuery in DIRECT_READ mode
[github] Addressed review comments
[github] Added a test for BigQuery SQL read in EXPORT mode
[lukecwik] [BEAM-6923] limit gcs buffer size to 1MB for artifact upload (#9647)
------------------------------------------
[...truncated 156.44 KB...]
],
"non_parallel_inputs": {
"side0-write/Write/WriteImpl/FinalizeWrite": {
"@type": "OutputReference",
"output_name": "out",
"step_name": "SideInput-s18"
},
"side1-write/Write/WriteImpl/FinalizeWrite": {
"@type": "OutputReference",
"output_name": "out",
"step_name": "SideInput-s19"
},
"side2-write/Write/WriteImpl/FinalizeWrite": {
"@type": "OutputReference",
"output_name": "out",
"step_name": "SideInput-s20"
}
},
"output_info": [
{
"encoding": {
"@type": "kind:windowed_value",
"component_encodings": [
{
"@type": "FastPrimitivesCoder$eNprYE5OLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqYIfgYGhvi0xJycpMTk7HiwlkJ8pgVkJmfnpEJNYQGawlpbyJZUnKQHACYlLgM=",
"component_encodings": [
{
"@type": "FastPrimitivesCoder$eNprYE5OLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqYIfgYGhvi0xJycpMTk7HiwlkJ8pgVkJmfnpEJNYQGawlpbyJZUnKQHACYlLgM=",
"component_encodings": []
},
{
"@type": "FastPrimitivesCoder$eNprYE5OLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqYIfgYGhvi0xJycpMTk7HiwlkJ8pgVkJmfnpEJNYQGawlpbyJZUnKQHACYlLgM=",
"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": "eNrNV/l/G8UV10rOwZKmAUogpIdISbumSEoIOexSSKokYBQr7trg7RGW0e5Is3h3Z9/MrBVTiwKpHBd639ArKb1vet/H39F/pm9GklOBTfNb+vnYu6s3897M+77v+87ucyUnIBkJGPVblCRVJUgq21wkshpwQe06iWPSiumiIFlGxWl+NrWhMPk8WD0oOl6pUCj47RRKY0Eijn8tIqntt6OUxNEz1O+KSFEbJrxdxiXHsKIjMxrAtqa3A22Z4AGVErazCe9mPUetZNRnUaok7BjfIw4YezWkuEmiuJD2zPkFND+qzTbsxA3e1OyB7ZhQUZrlysSTcHPT7IDn6pptVzNfg7e08tYF2O28PhNFL6qI2/4C3uejdMmGt2L0PT24xfH2YKR2FFM/I4r5maDt6CLcOhaBZ+idyuoyiXOcJ/hyFFJhzyuiouAJbZwb2eA2DPy2HtzueDYGHnjoHcLeIIziuOrrq+3HnITGbsMdpgJSCbizD/tcuMvbNvKE/d55fO7I6VpN0SSrSMSJdGgFq1uhaVhRfHCjUslatlKJVCWIeR7WBtjUDh89NnXi2NTxqUMnHjhSE1TmMZbi7XnrWtopSagv87ZO+x1Mb/+dPXiXw/ayu9h+D2cVoIzzdTZpnviSERFKuLtRMNsMOGYNB8bgMjY5vNkLfF6JKO3UucHn3bjAPT042PJu0VnraIMtaMISBe/x7kF75aAzHMqTyUNHwwpvo+na+toG7/X2jofoxLw1iuOYwcq9m3pOmvQDnmC5pcTaDkp0rzeBZpIrDu/zbsLHJEqG1bvPAKB5VMtiEqVQ8fZpguuOSrGSgkQxJumntIt35GN13XSEzyjRCNWaeWuclamiAvuqmqsotk+JTp7QVM3FJKCMxwaqQwjVYaav9zcscz9Ce/DABTjqeJM6c2TcoYppytritetMksW1s8OeNRY4NrZ0Zrhl+4+nWRQsxTScx0Azur9sON6DE46BISSKwNRmjhvTT+MUG6ZxY+/vwYOOt1ujF2gF0M2k84MPePvRqL2n9XZ908bTuCehFWl6+TA8ZIjQjdKQd/0E8dQwohw9vJWm6TgmjLRNxUnsv8HbhpMG/uWIdnWwU2PNFwhKFDIuTwPd2DZ80GF3eDtxviap1iCo9+G0C2echtUo4H+pcVvdXi+sFtatS8X5Apxt9uGRSeMyygUe7cOMJ9BSYzyhtadpuhSlcnSvyJgs01qXiyWJedGaTsufo8LwNQ3ogu5hf5GLsM7zVM0s+HMrR47XpAhqMlzS3a0YT2v/BUptUI9qtgKPma08GJOkFZKHoDF73qoX4Jx3u+5ywRNfYEhN5o3dzhoJNfgM5Q2aa3B+UsGcCx8ag6tDlY/lREa6ZplWHsUKU4J5gzEO61FYWIPHXXhizDVKMi6Un/Awj1HqFr1bNUXeQCnw+vBhFz5iwvvoGyjfh4+uwcdcuMAazc2qF1D8AU8yrB2WqYhlKjV2NOr1p1RBWVeKq4XQulq8ZPWKq0V5YNW6UgqLauJS4SqWT21bxZGwtFQUx1aL4cS+Atq2h9sGdrVjYBs+lfRTu7QXry9YIc4E32k2iib1kLYJKio8pWniPYuWuTqPY2poVebtssQWLB8My91IsXKCh3FZMYIjKS3TmOqOLw8ahoZlIssEHdJOTBV669JUy2cjIVVZdflovizTNNAEoUL7YMQDB+WB+8y1Cih8rUH7xpFUEBgV0zVXnMcSQm+7/i3jKKBAzbmD1YO26dwzSaZWNnobOmY4pikwo33mnDsjBBcQsTsVPO0VTWxYMlCMSBSb1bXqQXIZUvaY0WF/cxLy2des+p5CcY81Ye22dlk7raJVLEI2iTQEFwS7wHgT3wFkU4FyIe/Dsgtd9mQPLm6hGivspOzDMy58fA1We9BDx2dd+ETeYg+zk/lleG5DOQ9fl3I+z1ARX3DYFNMyd6kHn3TY/9a0vl6NnRpycyAhVmO+PrGq+bOG4nF5kqFerN8ovfjUuF68OPtvi53TqL/kwqcR9Rc16p9B8D7rwuc2wPv8Bnj3Xxd4X9DgfXEE3pd68OXrAe8rm4D3ev39KkL4NQPh128UhC+PQ/gKSi47x2YZqug3EMhvuvAtBPKVJrsREvVtLVHs/0aWvqPgisMCFjLK2qzDGDMScpUtsZihTHyXvfxmMvHq5jLxPU3Y77vwA8T5VU3YHyJhf+TCj/vwExd+qmXiZ1vIxM+NTPzChV+uwa968Bo6/tqF32ww/bf0Tb+oFk1AjGXD75DZv+/BHxxDh8FKuMAft/IfzLAfMS8ugzj4sfMnjPJnI9b4rtzpIEVT+MtWIYZT7NOD02dh+BP+ikH+ZhLG4uVJHhNdb334Uvh7wzJnrwZWKpJkPr79tvBNVcA/cMh8rEXSHx1o/1zPWwr+Vf0PFMnUTA==",
"user_name": "write/Write/WriteImpl/FinalizeWrite/FinalizeWrite"
}
}
],
"type": "JOB_TYPE_BATCH"
}
root: INFO: Create job: <Job
createTime: '2019-09-30T18:56:34.742152Z'
currentStateTime: '1970-01-01T00:00:00Z'
id: '2019-09-30_11_56_33-452774739975975206'
location: 'us-central1'
name: 'beamapp-jenkins-0930185631-755388'
projectId: 'apache-beam-testing'
stageStates: []
startTime: '2019-09-30T18:56:34.742152Z'
steps: []
tempFiles: []
type: TypeValueValuesEnum(JOB_TYPE_BATCH, 1)>
root: INFO: Created job with id: [2019-09-30_11_56_33-452774739975975206]
root: INFO: To access the Dataflow monitoring console, please navigate to https://console.cloud.google.com/dataflow/jobsDetail/locations/us-central1/jobs/2019-09-30_11_56_33-452774739975975206?project=apache-beam-testing
root: INFO: Job 2019-09-30_11_56_33-452774739975975206 is in state JOB_STATE_RUNNING
root: INFO: 2019-09-30T18:56:36.829Z: JOB_MESSAGE_DETAILED: Checking permissions granted to controller Service Account.
root: INFO: 2019-09-30T18:56:37.284Z: JOB_MESSAGE_BASIC: Worker configuration: n1-standard-1 in us-central1-f.
root: INFO: 2019-09-30T18:56:37.852Z: JOB_MESSAGE_DETAILED: Expanding CoGroupByKey operations into optimizable parts.
root: INFO: 2019-09-30T18:56:37.886Z: JOB_MESSAGE_DEBUG: Combiner lifting skipped for step write/Write/WriteImpl/GroupByKey: GroupByKey not followed by a combiner.
root: INFO: 2019-09-30T18:56:37.921Z: JOB_MESSAGE_DEBUG: Combiner lifting skipped for step group: GroupByKey not followed by a combiner.
root: INFO: 2019-09-30T18:56:37.962Z: JOB_MESSAGE_DETAILED: Expanding GroupByKey operations into optimizable parts.
root: INFO: 2019-09-30T18:56:37.984Z: JOB_MESSAGE_DETAILED: Lifting ValueCombiningMappingFns into MergeBucketsMappingFns
root: INFO: 2019-09-30T18:56:38.073Z: JOB_MESSAGE_DEBUG: Annotating graph with Autotuner information.
root: INFO: 2019-09-30T18:56:38.125Z: JOB_MESSAGE_DETAILED: Fusing adjacent ParDo, Read, Write, and Flatten operations
root: INFO: 2019-09-30T18:56:38.159Z: JOB_MESSAGE_DETAILED: Fusing consumer split into read/Read
root: INFO: 2019-09-30T18:56:38.191Z: JOB_MESSAGE_DETAILED: Fusing consumer pair_with_one into split
root: INFO: 2019-09-30T18:56:38.222Z: JOB_MESSAGE_DETAILED: Fusing consumer group/Reify into pair_with_one
root: INFO: 2019-09-30T18:56:38.250Z: JOB_MESSAGE_DETAILED: Fusing consumer group/Write into group/Reify
root: INFO: 2019-09-30T18:56:38.287Z: JOB_MESSAGE_DETAILED: Fusing consumer group/GroupByWindow into group/Read
root: INFO: 2019-09-30T18:56:38.315Z: JOB_MESSAGE_DETAILED: Fusing consumer count into group/GroupByWindow
root: INFO: 2019-09-30T18:56:38.344Z: JOB_MESSAGE_DETAILED: Fusing consumer format into count
root: INFO: 2019-09-30T18:56:38.378Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/WriteBundles/WriteBundles into format
root: INFO: 2019-09-30T18:56:38.408Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/Pair into write/Write/WriteImpl/WriteBundles/WriteBundles
root: INFO: 2019-09-30T18:56:38.443Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/WindowInto(WindowIntoFn) into write/Write/WriteImpl/Pair
root: INFO: 2019-09-30T18:56:38.476Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/GroupByKey/Reify into write/Write/WriteImpl/WindowInto(WindowIntoFn)
root: INFO: 2019-09-30T18:56:38.511Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/GroupByKey/Write into write/Write/WriteImpl/GroupByKey/Reify
root: INFO: 2019-09-30T18:56:38.541Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/GroupByKey/GroupByWindow into write/Write/WriteImpl/GroupByKey/Read
root: INFO: 2019-09-30T18:56:38.576Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/Extract into write/Write/WriteImpl/GroupByKey/GroupByWindow
root: INFO: 2019-09-30T18:56:38.613Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/InitializeWrite into write/Write/WriteImpl/DoOnce/Read
root: INFO: 2019-09-30T18:56:38.651Z: JOB_MESSAGE_DEBUG: Workflow config is missing a default resource spec.
root: INFO: 2019-09-30T18:56:38.682Z: JOB_MESSAGE_DEBUG: Adding StepResource setup and teardown to workflow graph.
root: INFO: 2019-09-30T18:56:38.713Z: JOB_MESSAGE_DEBUG: Adding workflow start and stop steps.
root: INFO: 2019-09-30T18:56:38.747Z: JOB_MESSAGE_DEBUG: Assigning stage ids.
root: INFO: 2019-09-30T18:56:38.883Z: JOB_MESSAGE_DEBUG: Executing wait step start26
root: INFO: 2019-09-30T18:56:38.952Z: JOB_MESSAGE_BASIC: Executing operation write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite
root: INFO: 2019-09-30T18:56:39.005Z: JOB_MESSAGE_BASIC: Executing operation write/Write/WriteImpl/GroupByKey/Create
root: INFO: 2019-09-30T18:56:39.019Z: JOB_MESSAGE_DEBUG: Starting worker pool setup.
root: INFO: 2019-09-30T18:56:39.027Z: JOB_MESSAGE_BASIC: Executing operation group/Create
root: INFO: 2019-09-30T18:56:39.052Z: JOB_MESSAGE_BASIC: Starting 10 workers in us-central1-f...
root: INFO: 2019-09-30T18:56:39.108Z: JOB_MESSAGE_BASIC: Finished operation group/Create
root: INFO: 2019-09-30T18:56:39.108Z: JOB_MESSAGE_BASIC: Finished operation write/Write/WriteImpl/GroupByKey/Create
root: INFO: 2019-09-30T18:56:39.173Z: JOB_MESSAGE_DEBUG: Value "write/Write/WriteImpl/GroupByKey/Session" materialized.
root: INFO: 2019-09-30T18:56:39.196Z: JOB_MESSAGE_DEBUG: Value "group/Session" materialized.
root: INFO: 2019-09-30T18:56:39.277Z: JOB_MESSAGE_BASIC: Executing operation read/Read+split+pair_with_one+group/Reify+group/Write
root: INFO: 2019-09-30T18:56:59.952Z: 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: 2019-09-30T18:56:59.985Z: JOB_MESSAGE_DETAILED: Resized worker pool to 1, though goal was 10. This could be a quota issue.
root: INFO: 2019-09-30T18:57:05.594Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 10 based on the rate of progress in the currently running step(s).
root: INFO: 2019-09-30T18:57:33.890Z: JOB_MESSAGE_DETAILED: Workers have started successfully.
root: INFO: 2019-09-30T18:57:33.925Z: JOB_MESSAGE_DETAILED: Workers have started successfully.
root: INFO: 2019-09-30T19:01:34.865Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T19:01:36.394Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T19:01:36.482Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T19:01:37.457Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T19:01:37.513Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T19:01:37.539Z: JOB_MESSAGE_BASIC: Finished operation read/Read+split+pair_with_one+group/Reify+group/Write
root: INFO: 2019-09-30T19:01:37.608Z: JOB_MESSAGE_DEBUG: Executing failure step failure25
root: INFO: 2019-09-30T19:01:37.668Z: JOB_MESSAGE_ERROR: Workflow failed. Causes: S06:read/Read+split+pair_with_one+group/Reify+group/Write failed., Internal Issue (e22c9f22a8f03221): 63963027:24514
root: INFO: 2019-09-30T19:01:38.162Z: JOB_MESSAGE_WARNING: S01:write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite failed.
root: INFO: 2019-09-30T19:01:38.195Z: JOB_MESSAGE_BASIC: Finished operation write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite
root: INFO: 2019-09-30T19:01:38.300Z: JOB_MESSAGE_DETAILED: Cleaning up.
root: INFO: 2019-09-30T19:01:38.355Z: JOB_MESSAGE_DEBUG: Starting worker pool teardown.
root: INFO: 2019-09-30T19:01:38.393Z: JOB_MESSAGE_BASIC: Stopping worker pool...
root: INFO: 2019-09-30T19:03:37.813Z: 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: 2019-09-30T19:03:37.863Z: JOB_MESSAGE_BASIC: Worker pool stopped.
root: INFO: 2019-09-30T19:03:37.903Z: JOB_MESSAGE_DEBUG: Tearing down pending resources...
root: INFO: Job 2019-09-30_11_56_33-452774739975975206 is in state JOB_STATE_FAILED
apache_beam.io.filesystem: DEBUG: Listing files in 'gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1569869790843/results'
apache_beam.io.filesystem: DEBUG: translate_pattern: 'gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1569869790843/results*' -> 'gs://temp\\-storage\\-for\\-end\\-to\\-end\\-tests/py\\-it\\-cloud/output/1569869790843/results[^/\\\\]*'
root: INFO: Starting the size estimation of the input
root: INFO: Finished listing 0 files in 0.06061697006225586 seconds.
--------------------- >> end captured logging << ---------------------
----------------------------------------------------------------------
XML: nosetests-integrationTest-perf.xml
----------------------------------------------------------------------
XML: <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/src/sdks/python/nosetests.xml>
----------------------------------------------------------------------
Ran 1 test in 434.606s
FAILED (errors=1)
FAILURE: Build failed with an exception.
* What went wrong:
Execution failed for task ':sdks:python:test-suites:dataflow:py37:integrationTest'.
> Process 'command 'sh'' finished with non-zero exit value 1
* Try:
Run with --stacktrace option to get the stack trace. Run with --debug option to get more log output. Run with --scan to get full insights.
* Get more help at https://help.gradle.org
BUILD FAILED in 8m 2s
2019-09-30 19:03:47,031 b87e9b7d MainThread beam_integration_benchmark(1/1) ERROR Error during benchmark beam_integration_benchmark
Traceback (most recent call last):
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 841, in RunBenchmark
DoRunPhase(spec, collector, detailed_timer)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 687, in DoRunPhase
samples = spec.BenchmarkRun(spec)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/linux_benchmarks/beam_integration_benchmark.py",> line 160, in Run
job_type=job_type)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/providers/gcp/gcp_dpb_dataflow.py",> line 91, in SubmitJob
assert retcode == 0, "Integration Test Failed."
AssertionError: Integration Test Failed.
2019-09-30 19:03:47,032 b87e9b7d MainThread beam_integration_benchmark(1/1) INFO Cleaning up benchmark beam_integration_benchmark
2019-09-30 19:03:47,034 b87e9b7d MainThread beam_integration_benchmark(1/1) ERROR Exception running benchmark
Traceback (most recent call last):
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 984, in RunBenchmarkTask
RunBenchmark(spec, collector)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 841, in RunBenchmark
DoRunPhase(spec, collector, detailed_timer)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 687, in DoRunPhase
samples = spec.BenchmarkRun(spec)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/linux_benchmarks/beam_integration_benchmark.py",> line 160, in Run
job_type=job_type)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/providers/gcp/gcp_dpb_dataflow.py",> line 91, in SubmitJob
assert retcode == 0, "Integration Test Failed."
AssertionError: Integration Test Failed.
2019-09-30 19:03:47,034 b87e9b7d MainThread beam_integration_benchmark(1/1) ERROR Benchmark 1/1 beam_integration_benchmark (UID: beam_integration_benchmark0) failed. Execution will continue.
2019-09-30 19:03:47,035 b87e9b7d MainThread beam_integration_benchmark(1/1) INFO Benchmark run statuses:
---------------------------------------------------------------------------------
Name UID Status Failed Substatus
---------------------------------------------------------------------------------
beam_integration_benchmark beam_integration_benchmark0 FAILED
---------------------------------------------------------------------------------
Success rate: 0.00% (0/1)
2019-09-30 19:03:47,035 b87e9b7d MainThread beam_integration_benchmark(1/1) INFO Complete logs can be found at: <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/runs/b87e9b7d/pkb.log>
2019-09-30 19:03:47,035 b87e9b7d MainThread beam_integration_benchmark(1/1) INFO Completion statuses can be found at: <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/runs/b87e9b7d/completion_statuses.json>
Build step 'Execute shell' marked build as failure
---------------------------------------------------------------------
To unsubscribe, e-mail: builds-unsubscribe@beam.apache.org
For additional commands, e-mail: builds-help@beam.apache.org
Build failed in Jenkins: beam_PerformanceTests_WordCountIT_Py37
#526
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/526/display/redirect>
Changes:
------------------------------------------
[...truncated 157.52 KB...]
{
"@type": "FastPrimitivesCoder$eNprYE5OLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqYIfgYGhvi0xJycpMTk7HiwlkJ8pgVkJmfnpEJNYQGawlpbyJZUnKQHACYlLgM=",
"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": "eNrNV/l/G8UV10rOwZKmAUogpIdISbumSHKAhMSlkFRJwChW3LXB2yMso92RZvHuzr6ZWSumFgVSOS70bjl7JaX3Te/7+Dv6z/TNSHIqsGl+Sz8fe3f1Zt6bed/3fd/ZfabkBCQjAaN+i5KkqgRJZZuLRFYDLqhdJ3FMWjFdFCTLqDjJT6c2FCafBasHRccrFQoFv51CaSxIxPGvRSS1/XaUkjh6ivpdESlqw4S3y7jkGFZ0ZEYD2Nb0dqAtEzygUsJ2NuFdr+eolYz6LEqVhB3je8QBY6+GFDdJFBfSnjm7gOaHtdmGnbjB65o9sB0TKkqzXJl4Eq5vmh3wXF2x7Wrma/COVt46B7udN2ei6HkVcdtfwPt8lC7Z8E6MvqcHNzjeHozUjmLqZ0QxPxO0HZ2HG8ci8Ay9U1ldJnGO8wRfjkIq7HlFVBQ8po1zIxvchIHf1YObHc/GwAMPvUPYG4RRHFd9fbX9mJPQ2G24xVRAKgG39mGfC7d520aesN87i88dOV2rKZpkFYk4kQ6tYHUrNA0rig9uVCpZy1YqkaoEMc/D2gCb2qHDR44dvffo4aPHpo5M1QSVeYyleHfeupJ2ShLqy7yt034P09t/bw/e57C97Da238NZBSjjfJ1Nmie+ZESEEm5vFMw2A45Zw4ExuIxNDm/2Ap9XIko7dW7weT8ucEcPDra8G3TWOtpgC5qwRMEHvDvQXjnoDIfyZHLqcFjhbTRdWV/b4IPe3vEQnZi3RnEcM1i5c1PPSZN+wBMst5RY20GJ7vQm0ExyxeFD3nX4mETJsHp3GQA0j2pZTKIUKt4+TXDdUSlWUpAoxiT9lHbxjnysrpuO8BklGqFaM2+NszJVVGBfVXMVxfYJ0ckTmqq5mASU8dhANYVQHWL6enfDMvd7aA/uPQeHHW9SZ46Mm6qYpqwtXrnOJFlcOz3sWWOBI2NLZ4Zbtv9omkXBUkzDeQw0o/vLhvt6cNQxMIREETi2mePG9JM4xYZp3NiHe3C/4+3W6AVaAXQz6fzgI95+NGrvab1d37TxNO5JaEWaXj4EDxgidKM05F0/QTw1jChHD26laTqOCSNtU3ES+2/xtuG4gX85ol0d7MRY8wWCEoWMy9NAN7YNH3XYLd5OnK9JqjUI6n046cIpp2E1CvhfatxUt9cLq4V160JxvgCnm314aNK4jHKBh/sw4wm01BhPaO1Jmi5FqRzdKzImy7TW5WJJYl60ptPy56gwfE0DuqB72F/kIqzzPFUzC/7cyj331aQIajJc0t2tGE9r/wVKbVCParYCj5it3B+TpBWSB6Axe9aqF+CMd7PucsETX2BITeaN3c4aCTX4DOUNmmtwdlLBnAsfG4OrQ5WP5URGumaZVh7FClOCeYMxDutRWFiDR114bMw1SjIulJ/wMI9R6ha9GzVF3kIp8PrwcRc+YcL76Bso34dPrsGnXDjHGs3NqhdQ/AGPM6wdlqmIZSo1djTq9SdUQVmXiquF0LpcvGD1iqtFeWDVulQKi2riQuEylk9tW8WRsLRUFEdWi+HEvgLatofbBna1Y2AbPpX0U7u0F6/PWSHOBN9pNoom9ZC2CSoqPKFp4j2Nlrk6j2NqaFXm7bLEFiwfDMvdSLFygodxWTGCIykt05jqji8PGoaGZSLLBB3STkwVeuvSVMunIyFVWXX5aL4s0zTQBKFC+2DEAwflgbvMtQoofK1B+8aRVBAYFdM1V5zHEkJvu/4t4yigQM25g9WDtuncU0mmVjZ6GzpmOKYpMKN95pw7JQQXELFbFTzpFU1sWDJQjEgUm9W16kFyEVL2iNFhf3MS8tk3rPqeQnGPNWHttnZZO62iVSxCNok0BBcEO8d4E98BZFOBciHvw7ILXfZ4D85voRor7Ljsw1MufHoNVnvQQ8enXfhM3mIPsuP5RXhmQzkPXZVyPstQEZ9z2DGmZe5CDz7rsP+taX29Gjsx5OZAQqzGfH1iVfNnDcXj4iRDvVi/VnrxuXG9eH723xY7o1F/wYXPI+rPa9S/gOB90YUvbYD35Q3w7r4q8L6iwfvqCLyv9eDrVwPei5uA92b9fQkhfNlA+Mq1gvDVcQhfQ8llZ9gsQxX9BgL5TRe+hUC+1mTXQqK+rSWK/d/I0ncUXHJYwEJGWZt1GGNGQi6zJRYzlInvslffTiZe31wmvqcJ+30XfoA4v64J+0Mk7I9c+HEffuLCT7VM/GwLmfi5kYlfuPDLNfhVD95Ax1+78JsNpv+Wvu0X1aIJiLFs+B0y+/c9+INj6DBYCRf441b+gxn2Q+bFZRAHP3b+hFH+bMQa35U7HaRoCn/ZKsRwin1ycPosDH/CXzHI30zCWLw8yWOi660PXwp/b1jm7NXASkWSzMe33xa+qQr4Bw6Zj7VI+qMD7Z/reUvBv6r/Actt1EY=",
"user_name": "write/Write/WriteImpl/FinalizeWrite/FinalizeWrite"
}
}
],
"type": "JOB_TYPE_BATCH"
}
root: INFO: Create job: <Job
createTime: '2019-09-30T13:03:13.120918Z'
currentStateTime: '1970-01-01T00:00:00Z'
id: '2019-09-30_06_03_11-2851491827998224685'
location: 'us-central1'
name: 'beamapp-jenkins-0930130309-963500'
projectId: 'apache-beam-testing'
stageStates: []
startTime: '2019-09-30T13:03:13.120918Z'
steps: []
tempFiles: []
type: TypeValueValuesEnum(JOB_TYPE_BATCH, 1)>
root: INFO: Created job with id: [2019-09-30_06_03_11-2851491827998224685]
root: INFO: To access the Dataflow monitoring console, please navigate to https://console.cloud.google.com/dataflow/jobsDetail/locations/us-central1/jobs/2019-09-30_06_03_11-2851491827998224685?project=apache-beam-testing
root: INFO: Job 2019-09-30_06_03_11-2851491827998224685 is in state JOB_STATE_RUNNING
root: INFO: 2019-09-30T13:03:15.157Z: JOB_MESSAGE_DETAILED: Checking permissions granted to controller Service Account.
root: INFO: 2019-09-30T13:03:15.863Z: JOB_MESSAGE_BASIC: Worker configuration: n1-standard-1 in us-central1-a.
root: INFO: 2019-09-30T13:03:16.497Z: JOB_MESSAGE_DETAILED: Expanding CoGroupByKey operations into optimizable parts.
root: INFO: 2019-09-30T13:03:16.530Z: JOB_MESSAGE_DEBUG: Combiner lifting skipped for step write/Write/WriteImpl/GroupByKey: GroupByKey not followed by a combiner.
root: INFO: 2019-09-30T13:03:16.561Z: JOB_MESSAGE_DEBUG: Combiner lifting skipped for step group: GroupByKey not followed by a combiner.
root: INFO: 2019-09-30T13:03:16.604Z: JOB_MESSAGE_DETAILED: Expanding GroupByKey operations into optimizable parts.
root: INFO: 2019-09-30T13:03:16.662Z: JOB_MESSAGE_DETAILED: Lifting ValueCombiningMappingFns into MergeBucketsMappingFns
root: INFO: 2019-09-30T13:03:16.762Z: JOB_MESSAGE_DEBUG: Annotating graph with Autotuner information.
root: INFO: 2019-09-30T13:03:16.812Z: JOB_MESSAGE_DETAILED: Fusing adjacent ParDo, Read, Write, and Flatten operations
root: INFO: 2019-09-30T13:03:16.842Z: JOB_MESSAGE_DETAILED: Fusing consumer split into read/Read
root: INFO: 2019-09-30T13:03:16.879Z: JOB_MESSAGE_DETAILED: Fusing consumer pair_with_one into split
root: INFO: 2019-09-30T13:03:16.916Z: JOB_MESSAGE_DETAILED: Fusing consumer group/Reify into pair_with_one
root: INFO: 2019-09-30T13:03:16.952Z: JOB_MESSAGE_DETAILED: Fusing consumer group/Write into group/Reify
root: INFO: 2019-09-30T13:03:16.990Z: JOB_MESSAGE_DETAILED: Fusing consumer group/GroupByWindow into group/Read
root: INFO: 2019-09-30T13:03:17.026Z: JOB_MESSAGE_DETAILED: Fusing consumer count into group/GroupByWindow
root: INFO: 2019-09-30T13:03:17.055Z: JOB_MESSAGE_DETAILED: Fusing consumer format into count
root: INFO: 2019-09-30T13:03:17.089Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/WriteBundles/WriteBundles into format
root: INFO: 2019-09-30T13:03:17.128Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/Pair into write/Write/WriteImpl/WriteBundles/WriteBundles
root: INFO: 2019-09-30T13:03:17.166Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/WindowInto(WindowIntoFn) into write/Write/WriteImpl/Pair
root: INFO: 2019-09-30T13:03:17.203Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/GroupByKey/Reify into write/Write/WriteImpl/WindowInto(WindowIntoFn)
root: INFO: 2019-09-30T13:03:17.240Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/GroupByKey/Write into write/Write/WriteImpl/GroupByKey/Reify
root: INFO: 2019-09-30T13:03:17.273Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/GroupByKey/GroupByWindow into write/Write/WriteImpl/GroupByKey/Read
root: INFO: 2019-09-30T13:03:17.308Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/Extract into write/Write/WriteImpl/GroupByKey/GroupByWindow
root: INFO: 2019-09-30T13:03:17.333Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/InitializeWrite into write/Write/WriteImpl/DoOnce/Read
root: INFO: 2019-09-30T13:03:17.369Z: JOB_MESSAGE_DEBUG: Workflow config is missing a default resource spec.
root: INFO: 2019-09-30T13:03:17.401Z: JOB_MESSAGE_DEBUG: Adding StepResource setup and teardown to workflow graph.
root: INFO: 2019-09-30T13:03:17.435Z: JOB_MESSAGE_DEBUG: Adding workflow start and stop steps.
root: INFO: 2019-09-30T13:03:17.471Z: JOB_MESSAGE_DEBUG: Assigning stage ids.
root: INFO: 2019-09-30T13:03:17.619Z: JOB_MESSAGE_DEBUG: Executing wait step start26
root: INFO: 2019-09-30T13:03:17.692Z: JOB_MESSAGE_BASIC: Executing operation write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite
root: INFO: 2019-09-30T13:03:17.726Z: JOB_MESSAGE_BASIC: Executing operation write/Write/WriteImpl/GroupByKey/Create
root: INFO: 2019-09-30T13:03:17.743Z: JOB_MESSAGE_DEBUG: Starting worker pool setup.
root: INFO: 2019-09-30T13:03:17.750Z: JOB_MESSAGE_BASIC: Executing operation group/Create
root: INFO: 2019-09-30T13:03:17.772Z: JOB_MESSAGE_BASIC: Starting 10 workers in us-central1-a...
root: INFO: 2019-09-30T13:03:17.833Z: JOB_MESSAGE_BASIC: Finished operation write/Write/WriteImpl/GroupByKey/Create
root: INFO: 2019-09-30T13:03:17.833Z: JOB_MESSAGE_BASIC: Finished operation group/Create
root: INFO: 2019-09-30T13:03:17.890Z: JOB_MESSAGE_DEBUG: Value "group/Session" materialized.
root: INFO: 2019-09-30T13:03:17.917Z: JOB_MESSAGE_DEBUG: Value "write/Write/WriteImpl/GroupByKey/Session" materialized.
root: INFO: 2019-09-30T13:03:17.952Z: JOB_MESSAGE_BASIC: Executing operation read/Read+split+pair_with_one+group/Reify+group/Write
root: INFO: 2019-09-30T13:03:48.468Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 10 based on the rate of progress in the currently running step(s).
root: INFO: 2019-09-30T13:04:16.152Z: JOB_MESSAGE_DETAILED: Workers have started successfully.
root: INFO: 2019-09-30T13:04:16.184Z: JOB_MESSAGE_DETAILED: Workers have started successfully.
root: INFO: 2019-09-30T13:08:38.015Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T13:08:38.063Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T13:08:38.991Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T13:08:39.607Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T13:08:40.103Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T13:08:40.657Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T13:08:41.155Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T13:08:41.582Z: JOB_MESSAGE_BASIC: Finished operation write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite
root: INFO: 2019-09-30T13:08:41.669Z: JOB_MESSAGE_DEBUG: Executing failure step failure25
root: INFO: 2019-09-30T13:08:41.703Z: JOB_MESSAGE_ERROR: Workflow failed. Causes: S01:write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite failed., Internal Issue (3643aa958c088720): 63963027:24514
root: INFO: 2019-09-30T13:08:41.705Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T13:08:41.731Z: JOB_MESSAGE_BASIC: Finished operation read/Read+split+pair_with_one+group/Reify+group/Write
root: INFO: 2019-09-30T13:08:41.854Z: JOB_MESSAGE_DETAILED: Cleaning up.
root: INFO: 2019-09-30T13:08:41.921Z: JOB_MESSAGE_DEBUG: Starting worker pool teardown.
root: INFO: 2019-09-30T13:08:41.948Z: JOB_MESSAGE_BASIC: Stopping worker pool...
root: INFO: 2019-09-30T13:11:57.859Z: 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: 2019-09-30T13:11:57.901Z: JOB_MESSAGE_BASIC: Worker pool stopped.
root: INFO: 2019-09-30T13:11:57.927Z: JOB_MESSAGE_DEBUG: Tearing down pending resources...
root: INFO: Job 2019-09-30_06_03_11-2851491827998224685 is in state JOB_STATE_FAILED
apache_beam.io.filesystem: DEBUG: Listing files in 'gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1569848589060/results'
apache_beam.io.filesystem: DEBUG: translate_pattern: 'gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1569848589060/results*' -> 'gs://temp\\-storage\\-for\\-end\\-to\\-end\\-tests/py\\-it\\-cloud/output/1569848589060/results[^/\\\\]*'
root: INFO: Starting the size estimation of the input
root: INFO: Finished listing 0 files in 0.03950023651123047 seconds.
--------------------- >> end captured logging << ---------------------
----------------------------------------------------------------------
XML: nosetests-integrationTest-perf.xml
----------------------------------------------------------------------
XML: <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/src/sdks/python/nosetests.xml>
----------------------------------------------------------------------
Ran 1 test in 539.768s
FAILED (errors=1)
FAILURE: Build failed with an exception.
* What went wrong:
Execution failed for task ':sdks:python:test-suites:dataflow:py37:integrationTest'.
> Process 'command 'sh'' finished with non-zero exit value 1
* Try:
Run with --stacktrace option to get the stack trace. Run with --debug option to get more log output. Run with --scan to get full insights.
* Get more help at https://help.gradle.org
BUILD FAILED in 9m 43s
2019-09-30 13:12:10,322 03da24ac MainThread beam_integration_benchmark(1/1) ERROR Error during benchmark beam_integration_benchmark
Traceback (most recent call last):
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 841, in RunBenchmark
DoRunPhase(spec, collector, detailed_timer)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 687, in DoRunPhase
samples = spec.BenchmarkRun(spec)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/linux_benchmarks/beam_integration_benchmark.py",> line 160, in Run
job_type=job_type)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/providers/gcp/gcp_dpb_dataflow.py",> line 91, in SubmitJob
assert retcode == 0, "Integration Test Failed."
AssertionError: Integration Test Failed.
2019-09-30 13:12:10,323 03da24ac MainThread beam_integration_benchmark(1/1) INFO Cleaning up benchmark beam_integration_benchmark
2019-09-30 13:12:10,325 03da24ac MainThread beam_integration_benchmark(1/1) ERROR Exception running benchmark
Traceback (most recent call last):
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 984, in RunBenchmarkTask
RunBenchmark(spec, collector)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 841, in RunBenchmark
DoRunPhase(spec, collector, detailed_timer)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 687, in DoRunPhase
samples = spec.BenchmarkRun(spec)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/linux_benchmarks/beam_integration_benchmark.py",> line 160, in Run
job_type=job_type)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/providers/gcp/gcp_dpb_dataflow.py",> line 91, in SubmitJob
assert retcode == 0, "Integration Test Failed."
AssertionError: Integration Test Failed.
2019-09-30 13:12:10,325 03da24ac MainThread beam_integration_benchmark(1/1) ERROR Benchmark 1/1 beam_integration_benchmark (UID: beam_integration_benchmark0) failed. Execution will continue.
2019-09-30 13:12:10,326 03da24ac MainThread beam_integration_benchmark(1/1) INFO Benchmark run statuses:
---------------------------------------------------------------------------------
Name UID Status Failed Substatus
---------------------------------------------------------------------------------
beam_integration_benchmark beam_integration_benchmark0 FAILED
---------------------------------------------------------------------------------
Success rate: 0.00% (0/1)
2019-09-30 13:12:10,326 03da24ac MainThread beam_integration_benchmark(1/1) INFO Complete logs can be found at: <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/runs/03da24ac/pkb.log>
2019-09-30 13:12:10,326 03da24ac MainThread beam_integration_benchmark(1/1) INFO Completion statuses can be found at: <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/runs/03da24ac/completion_statuses.json>
Build step 'Execute shell' marked build as failure
---------------------------------------------------------------------
To unsubscribe, e-mail: builds-unsubscribe@beam.apache.org
For additional commands, e-mail: builds-help@beam.apache.org
Build failed in Jenkins: beam_PerformanceTests_WordCountIT_Py37
#525
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/525/display/redirect>
Changes:
------------------------------------------
[...truncated 157.13 KB...]
"@type": "OutputReference",
"output_name": "out",
"step_name": "SideInput-s19"
},
"side2-write/Write/WriteImpl/FinalizeWrite": {
"@type": "OutputReference",
"output_name": "out",
"step_name": "SideInput-s20"
}
},
"output_info": [
{
"encoding": {
"@type": "kind:windowed_value",
"component_encodings": [
{
"@type": "FastPrimitivesCoder$eNprYE5OLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqYIfgYGhvi0xJycpMTk7HiwlkJ8pgVkJmfnpEJNYQGawlpbyJZUnKQHACYlLgM=",
"component_encodings": [
{
"@type": "FastPrimitivesCoder$eNprYE5OLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqYIfgYGhvi0xJycpMTk7HiwlkJ8pgVkJmfnpEJNYQGawlpbyJZUnKQHACYlLgM=",
"component_encodings": []
},
{
"@type": "FastPrimitivesCoder$eNprYE5OLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqYIfgYGhvi0xJycpMTk7HiwlkJ8pgVkJmfnpEJNYQGawlpbyJZUnKQHACYlLgM=",
"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": "eNrNV/l/G8UV10rOwZKmAUogpIeaknZNkRQnxBCXQlIlAaNYcdcGb4+wjHZHmsW7O/tmZq2YWhRI5bj0vgu9ktL7pvd9/B39Z/pmJDkV2DS/pZ+Pvbt6M+/NvO/7vu/sPldyApKRgFG/RUlSVYKkss1FIqsBF9SukzgmrZguCZJlVJzmZ1MbCpPPg9WDouOVCoWC306hNBYk4vjXIpLafjtKSRw9Q/2uiBS1YcLbY1xyDCs6MqMB7Gh6u9CWCR5QKWEnm/Bu1nPUakZ9FqVKwq7xPeKAsVdDipskigtpz55fRPOj2mzDbtzgTc0e2I4JFaVZrkw8CTc3zQ54rq7Z9jTzdXhTK29dgL3OazNR9KKKuO0v4n0hSpdteDNG39eDWxxvH0ZqRzH1M6KYnwnaji7CrWMReIbeqayukDjHeYKvRCEV9oIiKgqe0Mb5kQ1uw8Bv6cHtjmdj4IGH3iHsD8Iojqu+vtp+zElo7DbcYSoglYA7+3DAhbu8HSNPOOidx+eOnKnVFE2yikScSIdWsLoVmoYVxQc3KpWsZauVSFWCmOdhbYBNber49IkHjk5PHbvvxPRUTVCZx1iKt+ata2mnJKG+zNs67bcxvf239+AdDtvP7mIHPZxVgDLO19mkeeJLRkQo4Z2NgtlmwDFrODQGl7HJ4c1e5AtKRGmnzg0+78IF7u7B4ZZ3i85aRxtsQROWKHi3dzfaK4ed4VCeTB45HlZ4G03X1tc2eI+3fzxEJ+atURzHDFbu2dJz0qQf8ATLLSXWdlCie7wJNJNccXivdxM+JlEyrN69BgDNo1oWkyiFindAE1x3VIqVFCSKMUk/pV28Ix+rG6YjfEaJRqjWzFvjrEwVFdhX1VxFsX1KdPKEpmo+JgFlPDZQHUGoppi+Hm1Y5n6M9uC+C3Dc8SZ15si4IxXTlLWla9fZJItrZ4c9aywwPbZ0Zrhl+4+nWRQsxzRcwECzur9suL8HDzgGhpAoAie2ctycfhqn2DCDG3tfDx50vL0avUArgG4mnR+83zuIRu09o7frmzaewT0JrUgzK1PwkCFCN0pD3vUTxFPDiHL08HaapuOYMNI2FSex/zpvG04a+Fci2tXBTo01XyAoUci4PA10Y9vwAYfd4e3G+ZqkWoOg3ofTLpxxGlajgP+lxm11e6OwVtiwLhUXCnC22YdHJo3LKBd4tA+znkBLjfGE1p6m6XKUytG9ImOyQmtdLpYl5kVrOi1/ngrD1zSgi7qH/SUuwjrPUzW76M+vHru/JkVQk+Gy7m7FeFr7L1Bqg3pUs1V4zGzlwZgkrZA8BI2581a9AOe823WXC574AkNqMm/uds5IqMFnKG/QXIfzkwrmXfjgGFwdqnwsJzLSNcu08ihWmBIsGIxxWI/C4jo87sITY65RknGh/ISHeYxSt+TdqinyOkqB14cPufBhE95H30D5PnxkHT7qwgXWaG5VvYDiD3iSYe2wTEUsU6mxq1GvP6UKyrpSXCuE1tXiJatXXCvKQ2vWlVJYVBOXClexfGrHGo6EpeWimF4rhhMHCmjbGe4Y2NWugW34VNJP7dJ+vL5ghTgTfKfZKJrUQ9omqKjwlKaJ9yxa5us8jqmhVZm3yxJbsHw4LHcjxcoJHsZlxQiOpLRMY6o7vjxoGBqWiSwTdEg7MVXorUtTLZ+NhFRl1eWj+bJM00AThArtgxEPHZaH7jXXKqDwtQbtG0dSQWBUTNdccR5LCL2d+reMo4ACNecOVg/apnPPJJla3ext6JjhmKbAjPaZc+6MEFxAxO5U8LRXNLFh2UAxIlFsVteqB8llSNljRof9rUnI51616vsKxX3WhLXX2mPttopWsQjZJNIQXBDsAuNNfAeQTQXKhbwPKy502ZM9uLiNaqyyk7IPz7jwsXVY60EPHZ914eN5iz3MTuaX4blN5Zy6LuV8nqEivuCwE0zL3KUefMJh/1vT+no1dmrIzYGEWI2F+sSa5s86isflSYZ6sXGj9OKT43rx4ty/LXZOo/4pFz6NqL+oUf8MgvdZFz63Cd7nN8E7el3gfUGD98UReF/qwZevB7yvbAHea/X3qwjh1wyEX79REL40DuHLKLnsHJtjqKLfQCC/6cK3EMiXm+xGSNS3tUSx/xtZ+o6CKw4LWMgoa7MOY8xIyFW2zGKGMvFd9tIbycQrW8vE9zRhv+/CDxDnVzRhf4iE/ZELP+7DT1z4qZaJn20jEz83MvELF365Dr/qwavo+GsXfrPJ9N/SN/yiWjIBMZYNv0Nm/74Hf3AMHQYr4QJ/3M5/MMN+xLy4DOLgx86fMMqfjVjju3KngxRN4S/bhRhOsU8PTp/F4U/4Kwb5m0kYi5cneUx0vfXhS+HvDcucvRpYqUiS+fj228I3VQH/wCHzsRZJf3Sg/XMjbyn4V/U/aY7UPg==",
"user_name": "write/Write/WriteImpl/FinalizeWrite/FinalizeWrite"
}
}
],
"type": "JOB_TYPE_BATCH"
}
root: INFO: Create job: <Job
createTime: '2019-09-30T06:48:58.910843Z'
currentStateTime: '1970-01-01T00:00:00Z'
id: '2019-09-29_23_48_57-4038558127070785948'
location: 'us-central1'
name: 'beamapp-jenkins-0930064855-871390'
projectId: 'apache-beam-testing'
stageStates: []
startTime: '2019-09-30T06:48:58.910843Z'
steps: []
tempFiles: []
type: TypeValueValuesEnum(JOB_TYPE_BATCH, 1)>
root: INFO: Created job with id: [2019-09-29_23_48_57-4038558127070785948]
root: INFO: To access the Dataflow monitoring console, please navigate to https://console.cloud.google.com/dataflow/jobsDetail/locations/us-central1/jobs/2019-09-29_23_48_57-4038558127070785948?project=apache-beam-testing
root: INFO: Job 2019-09-29_23_48_57-4038558127070785948 is in state JOB_STATE_RUNNING
root: INFO: 2019-09-30T06:49:00.883Z: JOB_MESSAGE_DETAILED: Checking permissions granted to controller Service Account.
root: INFO: 2019-09-30T06:49:01.353Z: JOB_MESSAGE_BASIC: Worker configuration: n1-standard-1 in us-central1-a.
root: INFO: 2019-09-30T06:49:01.985Z: JOB_MESSAGE_DETAILED: Expanding CoGroupByKey operations into optimizable parts.
root: INFO: 2019-09-30T06:49:02.081Z: JOB_MESSAGE_DEBUG: Combiner lifting skipped for step write/Write/WriteImpl/GroupByKey: GroupByKey not followed by a combiner.
root: INFO: 2019-09-30T06:49:02.115Z: JOB_MESSAGE_DEBUG: Combiner lifting skipped for step group: GroupByKey not followed by a combiner.
root: INFO: 2019-09-30T06:49:02.156Z: JOB_MESSAGE_DETAILED: Expanding GroupByKey operations into optimizable parts.
root: INFO: 2019-09-30T06:49:02.187Z: JOB_MESSAGE_DETAILED: Lifting ValueCombiningMappingFns into MergeBucketsMappingFns
root: INFO: 2019-09-30T06:49:02.282Z: JOB_MESSAGE_DEBUG: Annotating graph with Autotuner information.
root: INFO: 2019-09-30T06:49:02.335Z: JOB_MESSAGE_DETAILED: Fusing adjacent ParDo, Read, Write, and Flatten operations
root: INFO: 2019-09-30T06:49:02.368Z: JOB_MESSAGE_DETAILED: Fusing consumer split into read/Read
root: INFO: 2019-09-30T06:49:02.401Z: JOB_MESSAGE_DETAILED: Fusing consumer pair_with_one into split
root: INFO: 2019-09-30T06:49:02.432Z: JOB_MESSAGE_DETAILED: Fusing consumer group/Reify into pair_with_one
root: INFO: 2019-09-30T06:49:02.458Z: JOB_MESSAGE_DETAILED: Fusing consumer group/Write into group/Reify
root: INFO: 2019-09-30T06:49:02.495Z: JOB_MESSAGE_DETAILED: Fusing consumer group/GroupByWindow into group/Read
root: INFO: 2019-09-30T06:49:02.520Z: JOB_MESSAGE_DETAILED: Fusing consumer count into group/GroupByWindow
root: INFO: 2019-09-30T06:49:02.558Z: JOB_MESSAGE_DETAILED: Fusing consumer format into count
root: INFO: 2019-09-30T06:49:02.585Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/WriteBundles/WriteBundles into format
root: INFO: 2019-09-30T06:49:02.621Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/Pair into write/Write/WriteImpl/WriteBundles/WriteBundles
root: INFO: 2019-09-30T06:49:02.656Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/WindowInto(WindowIntoFn) into write/Write/WriteImpl/Pair
root: INFO: 2019-09-30T06:49:02.692Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/GroupByKey/Reify into write/Write/WriteImpl/WindowInto(WindowIntoFn)
root: INFO: 2019-09-30T06:49:02.719Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/GroupByKey/Write into write/Write/WriteImpl/GroupByKey/Reify
root: INFO: 2019-09-30T06:49:02.753Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/GroupByKey/GroupByWindow into write/Write/WriteImpl/GroupByKey/Read
root: INFO: 2019-09-30T06:49:02.786Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/Extract into write/Write/WriteImpl/GroupByKey/GroupByWindow
root: INFO: 2019-09-30T06:49:02.817Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/InitializeWrite into write/Write/WriteImpl/DoOnce/Read
root: INFO: 2019-09-30T06:49:02.835Z: JOB_MESSAGE_DEBUG: Workflow config is missing a default resource spec.
root: INFO: 2019-09-30T06:49:02.870Z: JOB_MESSAGE_DEBUG: Adding StepResource setup and teardown to workflow graph.
root: INFO: 2019-09-30T06:49:02.905Z: JOB_MESSAGE_DEBUG: Adding workflow start and stop steps.
root: INFO: 2019-09-30T06:49:02.940Z: JOB_MESSAGE_DEBUG: Assigning stage ids.
root: INFO: 2019-09-30T06:49:03.067Z: JOB_MESSAGE_DEBUG: Executing wait step start26
root: INFO: 2019-09-30T06:49:03.133Z: JOB_MESSAGE_BASIC: Executing operation write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite
root: INFO: 2019-09-30T06:49:03.158Z: JOB_MESSAGE_BASIC: Executing operation write/Write/WriteImpl/GroupByKey/Create
root: INFO: 2019-09-30T06:49:03.172Z: JOB_MESSAGE_DEBUG: Starting worker pool setup.
root: INFO: 2019-09-30T06:49:03.193Z: JOB_MESSAGE_BASIC: Executing operation group/Create
root: INFO: 2019-09-30T06:49:03.193Z: JOB_MESSAGE_BASIC: Starting 10 workers in us-central1-a...
root: INFO: 2019-09-30T06:49:03.248Z: JOB_MESSAGE_BASIC: Finished operation group/Create
root: INFO: 2019-09-30T06:49:03.248Z: JOB_MESSAGE_BASIC: Finished operation write/Write/WriteImpl/GroupByKey/Create
root: INFO: 2019-09-30T06:49:03.308Z: JOB_MESSAGE_DEBUG: Value "write/Write/WriteImpl/GroupByKey/Session" materialized.
root: INFO: 2019-09-30T06:49:03.345Z: JOB_MESSAGE_DEBUG: Value "group/Session" materialized.
root: INFO: 2019-09-30T06:49:03.431Z: JOB_MESSAGE_BASIC: Executing operation read/Read+split+pair_with_one+group/Reify+group/Write
root: INFO: 2019-09-30T06:49:32.042Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 10 based on the rate of progress in the currently running step(s).
root: INFO: 2019-09-30T06:49:55.135Z: JOB_MESSAGE_DETAILED: Workers have started successfully.
root: INFO: 2019-09-30T06:49:55.162Z: JOB_MESSAGE_DETAILED: Workers have started successfully.
root: INFO: 2019-09-30T06:54:03.460Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T06:54:05.532Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T06:54:07.602Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T06:54:09.673Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T06:54:11.738Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T06:54:13.821Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T06:54:14.159Z: JOB_MESSAGE_BASIC: Finished operation write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite
root: INFO: 2019-09-30T06:54:14.227Z: JOB_MESSAGE_DEBUG: Executing failure step failure25
root: INFO: 2019-09-30T06:54:14.261Z: JOB_MESSAGE_ERROR: Workflow failed. Causes: S01:write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite failed., Internal Issue (974a974e920043c5): 63963027:24514
root: INFO: 2019-09-30T06:54:14.329Z: JOB_MESSAGE_BASIC: Finished operation read/Read+split+pair_with_one+group/Reify+group/Write
root: INFO: 2019-09-30T06:54:14.437Z: JOB_MESSAGE_DETAILED: Cleaning up.
root: INFO: 2019-09-30T06:54:14.495Z: JOB_MESSAGE_DEBUG: Starting worker pool teardown.
root: INFO: 2019-09-30T06:54:14.521Z: JOB_MESSAGE_BASIC: Stopping worker pool...
root: INFO: 2019-09-30T06:58:12.387Z: 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: 2019-09-30T06:58:12.429Z: JOB_MESSAGE_BASIC: Worker pool stopped.
root: INFO: 2019-09-30T06:58:12.457Z: JOB_MESSAGE_DEBUG: Tearing down pending resources...
root: INFO: Job 2019-09-29_23_48_57-4038558127070785948 is in state JOB_STATE_FAILED
apache_beam.io.filesystem: DEBUG: Listing files in 'gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1569826134961/results'
apache_beam.io.filesystem: DEBUG: translate_pattern: 'gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1569826134961/results*' -> 'gs://temp\\-storage\\-for\\-end\\-to\\-end\\-tests/py\\-it\\-cloud/output/1569826134961/results[^/\\\\]*'
root: INFO: Starting the size estimation of the input
root: INFO: Finished listing 0 files in 0.039125919342041016 seconds.
--------------------- >> end captured logging << ---------------------
----------------------------------------------------------------------
XML: nosetests-integrationTest-perf.xml
----------------------------------------------------------------------
XML: <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/src/sdks/python/nosetests.xml>
----------------------------------------------------------------------
Ran 1 test in 569.865s
FAILED (errors=1)
FAILURE: Build failed with an exception.
* What went wrong:
Execution failed for task ':sdks:python:test-suites:dataflow:py37:integrationTest'.
> Process 'command 'sh'' finished with non-zero exit value 1
* Try:
Run with --stacktrace option to get the stack trace. Run with --debug option to get more log output. Run with --scan to get full insights.
* Get more help at https://help.gradle.org
BUILD FAILED in 10m 14s
2019-09-30 06:58:26,244 f2bfa570 MainThread beam_integration_benchmark(1/1) ERROR Error during benchmark beam_integration_benchmark
Traceback (most recent call last):
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 841, in RunBenchmark
DoRunPhase(spec, collector, detailed_timer)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 687, in DoRunPhase
samples = spec.BenchmarkRun(spec)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/linux_benchmarks/beam_integration_benchmark.py",> line 160, in Run
job_type=job_type)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/providers/gcp/gcp_dpb_dataflow.py",> line 91, in SubmitJob
assert retcode == 0, "Integration Test Failed."
AssertionError: Integration Test Failed.
2019-09-30 06:58:26,245 f2bfa570 MainThread beam_integration_benchmark(1/1) INFO Cleaning up benchmark beam_integration_benchmark
2019-09-30 06:58:26,247 f2bfa570 MainThread beam_integration_benchmark(1/1) ERROR Exception running benchmark
Traceback (most recent call last):
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 984, in RunBenchmarkTask
RunBenchmark(spec, collector)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 841, in RunBenchmark
DoRunPhase(spec, collector, detailed_timer)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 687, in DoRunPhase
samples = spec.BenchmarkRun(spec)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/linux_benchmarks/beam_integration_benchmark.py",> line 160, in Run
job_type=job_type)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/providers/gcp/gcp_dpb_dataflow.py",> line 91, in SubmitJob
assert retcode == 0, "Integration Test Failed."
AssertionError: Integration Test Failed.
2019-09-30 06:58:26,248 f2bfa570 MainThread beam_integration_benchmark(1/1) ERROR Benchmark 1/1 beam_integration_benchmark (UID: beam_integration_benchmark0) failed. Execution will continue.
2019-09-30 06:58:26,248 f2bfa570 MainThread beam_integration_benchmark(1/1) INFO Benchmark run statuses:
---------------------------------------------------------------------------------
Name UID Status Failed Substatus
---------------------------------------------------------------------------------
beam_integration_benchmark beam_integration_benchmark0 FAILED
---------------------------------------------------------------------------------
Success rate: 0.00% (0/1)
2019-09-30 06:58:26,248 f2bfa570 MainThread beam_integration_benchmark(1/1) INFO Complete logs can be found at: <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/runs/f2bfa570/pkb.log>
2019-09-30 06:58:26,248 f2bfa570 MainThread beam_integration_benchmark(1/1) INFO Completion statuses can be found at: <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/runs/f2bfa570/completion_statuses.json>
Build step 'Execute shell' marked build as failure
---------------------------------------------------------------------
To unsubscribe, e-mail: builds-unsubscribe@beam.apache.org
For additional commands, e-mail: builds-help@beam.apache.org
Build failed in Jenkins: beam_PerformanceTests_WordCountIT_Py37
#524
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/524/display/redirect>
Changes:
------------------------------------------
[...truncated 156.70 KB...]
},
"side2-write/Write/WriteImpl/FinalizeWrite": {
"@type": "OutputReference",
"output_name": "out",
"step_name": "SideInput-s20"
}
},
"output_info": [
{
"encoding": {
"@type": "kind:windowed_value",
"component_encodings": [
{
"@type": "FastPrimitivesCoder$eNprYE5OLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqYIfgYGhvi0xJycpMTk7HiwlkJ8pgVkJmfnpEJNYQGawlpbyJZUnKQHACYlLgM=",
"component_encodings": [
{
"@type": "FastPrimitivesCoder$eNprYE5OLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqYIfgYGhvi0xJycpMTk7HiwlkJ8pgVkJmfnpEJNYQGawlpbyJZUnKQHACYlLgM=",
"component_encodings": []
},
{
"@type": "FastPrimitivesCoder$eNprYE5OLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqYIfgYGhvi0xJycpMTk7HiwlkJ8pgVkJmfnpEJNYQGawlpbyJZUnKQHACYlLgM=",
"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": "eNrNV/l/G8UV10rOwZKmAUogpIdISbumSLLJQeJSSKokYBQr7trg7RGW0e5Is3h3Z9/MrB1TiwKpHBd6Qw+OtknpfdP7Pv6O/jN9M5KcCmya39LPx95dvZn3Zt73fd93dp8pOQHJSMCo36IkqSpBUtnmIpHVgAtq10kck1ZMFwTJMipO8TOpDYXxZ8HqQtHxSoVCwW+nUBoJEnH8axFJbb8dpSSOnqL+sogUtWHM22VccgwrOjKjAWxrejvQlgkeUClhOxvzbtRz1EpGfRalSsKO0T3igLFXQ4qbJIoLaU+fm0fzw9psw07c4A3NLtiOCRWlWa5MPAk3Ns0OeK6u2nY18zV4RytvnYfdzpszUfSCirjtz+N9LkoXbXgnRt/ThZscbw9Gakcx9TOimJ8J2o4uwM0jEXiG3qmsLpE4x3mCL0UhFfacIioKHtPG2aENbsHA7+rCrY5nY+C+h94h7A3CKI6rvr7afsxJaOw23GYqIJWA23uwz4U7vG1DT9jvncPnjpyq1RRNsopEnEiHVrC6FZqGFcX7NyqVrGUrlUhVgpjnYa2PTW3yyNHjxyYOHzp2+NDEZE1QmcdYinfnratppyShvszbOu33ML3993bhfQ7by+5g+z2cVYAyztfZpHniS0ZEKOHORsFsM+CYNRwYgcvY5OBmz/M5JaK0U+cGn/fjAnd14WDLu0lnraP1t6AJSxR8wLsL7ZWDzmAoT8YnjoQV3kbT1fW1DT7o7R0N0Yl5axjHMYOVuzf1HDfpBzzBckuJte2X6G5vDM0kVxw+5N2Aj0mUDKp3jwFA86iWxSRKoeLt0wTXHZViJQWJYkzST+ky3pGP1XXTET6jRCNUa+atUVamigrsq2quotg+KTp5QlM1G5OAMh4bqCYQqkmmr/c2LHM/RLtw+DwccbxxnTkybqJimrK2cPU6nWRx7cygZ40Fjo4snRlu2f6jaRYFizEN5zDQtO4vG+7rwjHHwBASReD4Zo4b00/hFBumcGMf7sL9jrdboxdoBdDNpPODj3j70ai9p/R2fdPGU7gnoRVpamkSHjBEWI7SkC/7CeKpYUQ5enArTdNxTBhpm4qT2H+Ltw0nDPxLEV3WwU6ONF8gKFHIuDwNdGPb8FGH3ebtxPmapFqDoN6DUy6cdhpWo4D/pcYtdXu9sFpYty4W5wpwptmDh8aNyzAXeLgH055AS43xhNaepOlilMrhvSJjskRry1wsSsyL1nRa/iwVhq9pQOd1D/sLXIR1nqdqet6fXTl0X02KoCbDRd3divG09l+g1Pr1qGYr8IjZyv0xSVoheQAaM+esegHOerfqLhc88QWG1GTe2O2MkVCDz0DeoLkG58YVzLrwsRG4OlT5WE5kpGuWaeVRrDAlmDMY47Aehfk1eNSFx0ZcoyTjQvkJD/MYpW7Bu1lT5C2UAq8HH3fhEya8j76B8n345Bp8yoXzrNHcrHoBxR/wOMPaYZmKWKZSY0ejXn9CFZR1ubhaCK0rxYtWt7halAdWrculsKjGLhauYPnUtlUcCUuLRXF0tRiO7SugbXu4rW9XO/q2wVNJP7VLe/H6nBXiTPCdZqNoUg9pm6CiwhOaJt7TaJmt8zimhlZl3i5LbMHywbC8HClWTvAwLitGcCSlZRpT3fHlfsPQsExkmaBD2ompQm9dmmr5TCSkKqtlPpwvyzQNNEGo0D4Y8cBBeeAec60CCl+r375xJBUERsV0zRXnsYTQ265/yzgKKFBz7mD1oG0693SSqZWN3oaOGY5pCsxonznnTgvBBUTsdgVPekUTGxYNFEMSxWZ1rXqQXIKUPWJ02N+chHzmDau+p1DcY41Zu61d1k6raBWLkI0jDcEFwc4z3sR3ANlUoFzIe7DkwjJ7vAsXtlCNFXZC9uApFz69Bqtd6KLj0y58Jm+xB9mJ/BI8s6Gck9eknM8yVMTnHHacaZm72IXPOux/a1pPr8ZODrjZlxCrMVcfW9X8WUPxuDTOUC/Wr5defG5UL56f+bfFzmrUX3Dh84j68xr1LyB4X3ThSxvgfXkDvHuvCbyvaPC+OgTvxS68dC3gfW0T8N6sv19HCL9hIPzm9YLw5VEIX0HJZWfZDEMVfRWBfM2FbyGQrzTZ9ZCob2uJYv83svQdBZcdFrCQUdZmHcaYkZArbJHFDGXiu+zlt5OJ1zeXie9pwn7fhR8gzq9rwv4QCfsjF37cg5+48FMtEz/bQiZ+bmTiFy78cg1+1YU30PHXLvxmg+m/pW/7RbVgAmIsG36HzP59F/7gGDr0V8IF/riVf3+G/ZB5cenHwY+dP2GUPxuxxnflTgcpmsJftgoxmGKf6p8+84Of8FcM8jeTMBYvT/KY6Hrrw5fC3xuWOXs1sFKRJPPx7beFb6oC/oFD5mMtkv7wQPvnet5S8K/qfwD7ndQ1",
"user_name": "write/Write/WriteImpl/FinalizeWrite/FinalizeWrite"
}
}
],
"type": "JOB_TYPE_BATCH"
}
root: INFO: Create job: <Job
createTime: '2019-09-30T00:46:28.072151Z'
currentStateTime: '1970-01-01T00:00:00Z'
id: '2019-09-29_17_46_26-371537133754242835'
location: 'us-central1'
name: 'beamapp-jenkins-0930004625-180559'
projectId: 'apache-beam-testing'
stageStates: []
startTime: '2019-09-30T00:46:28.072151Z'
steps: []
tempFiles: []
type: TypeValueValuesEnum(JOB_TYPE_BATCH, 1)>
root: INFO: Created job with id: [2019-09-29_17_46_26-371537133754242835]
root: INFO: To access the Dataflow monitoring console, please navigate to https://console.cloud.google.com/dataflow/jobsDetail/locations/us-central1/jobs/2019-09-29_17_46_26-371537133754242835?project=apache-beam-testing
root: INFO: Job 2019-09-29_17_46_26-371537133754242835 is in state JOB_STATE_RUNNING
root: INFO: 2019-09-30T00:46:30.897Z: JOB_MESSAGE_DETAILED: Checking permissions granted to controller Service Account.
root: INFO: 2019-09-30T00:46:31.281Z: JOB_MESSAGE_BASIC: Worker configuration: n1-standard-1 in us-central1-a.
root: INFO: 2019-09-30T00:46:31.815Z: JOB_MESSAGE_DETAILED: Expanding CoGroupByKey operations into optimizable parts.
root: INFO: 2019-09-30T00:46:31.854Z: JOB_MESSAGE_DEBUG: Combiner lifting skipped for step write/Write/WriteImpl/GroupByKey: GroupByKey not followed by a combiner.
root: INFO: 2019-09-30T00:46:31.883Z: JOB_MESSAGE_DEBUG: Combiner lifting skipped for step group: GroupByKey not followed by a combiner.
root: INFO: 2019-09-30T00:46:31.924Z: JOB_MESSAGE_DETAILED: Expanding GroupByKey operations into optimizable parts.
root: INFO: 2019-09-30T00:46:31.955Z: JOB_MESSAGE_DETAILED: Lifting ValueCombiningMappingFns into MergeBucketsMappingFns
root: INFO: 2019-09-30T00:46:32.061Z: JOB_MESSAGE_DEBUG: Annotating graph with Autotuner information.
root: INFO: 2019-09-30T00:46:32.120Z: JOB_MESSAGE_DETAILED: Fusing adjacent ParDo, Read, Write, and Flatten operations
root: INFO: 2019-09-30T00:46:32.157Z: JOB_MESSAGE_DETAILED: Fusing consumer split into read/Read
root: INFO: 2019-09-30T00:46:32.193Z: JOB_MESSAGE_DETAILED: Fusing consumer pair_with_one into split
root: INFO: 2019-09-30T00:46:32.229Z: JOB_MESSAGE_DETAILED: Fusing consumer group/Reify into pair_with_one
root: INFO: 2019-09-30T00:46:32.264Z: JOB_MESSAGE_DETAILED: Fusing consumer group/Write into group/Reify
root: INFO: 2019-09-30T00:46:32.300Z: JOB_MESSAGE_DETAILED: Fusing consumer group/GroupByWindow into group/Read
root: INFO: 2019-09-30T00:46:32.335Z: JOB_MESSAGE_DETAILED: Fusing consumer count into group/GroupByWindow
root: INFO: 2019-09-30T00:46:32.369Z: JOB_MESSAGE_DETAILED: Fusing consumer format into count
root: INFO: 2019-09-30T00:46:32.404Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/WriteBundles/WriteBundles into format
root: INFO: 2019-09-30T00:46:32.431Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/Pair into write/Write/WriteImpl/WriteBundles/WriteBundles
root: INFO: 2019-09-30T00:46:32.465Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/WindowInto(WindowIntoFn) into write/Write/WriteImpl/Pair
root: INFO: 2019-09-30T00:46:32.501Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/GroupByKey/Reify into write/Write/WriteImpl/WindowInto(WindowIntoFn)
root: INFO: 2019-09-30T00:46:32.537Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/GroupByKey/Write into write/Write/WriteImpl/GroupByKey/Reify
root: INFO: 2019-09-30T00:46:32.559Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/GroupByKey/GroupByWindow into write/Write/WriteImpl/GroupByKey/Read
root: INFO: 2019-09-30T00:46:32.594Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/Extract into write/Write/WriteImpl/GroupByKey/GroupByWindow
root: INFO: 2019-09-30T00:46:32.620Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/InitializeWrite into write/Write/WriteImpl/DoOnce/Read
root: INFO: 2019-09-30T00:46:32.650Z: JOB_MESSAGE_DEBUG: Workflow config is missing a default resource spec.
root: INFO: 2019-09-30T00:46:32.672Z: JOB_MESSAGE_DEBUG: Adding StepResource setup and teardown to workflow graph.
root: INFO: 2019-09-30T00:46:32.694Z: JOB_MESSAGE_DEBUG: Adding workflow start and stop steps.
root: INFO: 2019-09-30T00:46:32.724Z: JOB_MESSAGE_DEBUG: Assigning stage ids.
root: INFO: 2019-09-30T00:46:32.888Z: JOB_MESSAGE_DEBUG: Executing wait step start26
root: INFO: 2019-09-30T00:46:32.957Z: JOB_MESSAGE_BASIC: Executing operation write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite
root: INFO: 2019-09-30T00:46:32.982Z: JOB_MESSAGE_BASIC: Executing operation write/Write/WriteImpl/GroupByKey/Create
root: INFO: 2019-09-30T00:46:33.005Z: JOB_MESSAGE_DEBUG: Starting worker pool setup.
root: INFO: 2019-09-30T00:46:33.016Z: JOB_MESSAGE_BASIC: Executing operation group/Create
root: INFO: 2019-09-30T00:46:33.040Z: JOB_MESSAGE_BASIC: Starting 10 workers in us-central1-a...
root: INFO: 2019-09-30T00:46:33.099Z: JOB_MESSAGE_BASIC: Finished operation write/Write/WriteImpl/GroupByKey/Create
root: INFO: 2019-09-30T00:46:33.099Z: JOB_MESSAGE_BASIC: Finished operation group/Create
root: INFO: 2019-09-30T00:46:33.167Z: JOB_MESSAGE_DEBUG: Value "group/Session" materialized.
root: INFO: 2019-09-30T00:46:33.192Z: JOB_MESSAGE_DEBUG: Value "write/Write/WriteImpl/GroupByKey/Session" materialized.
root: INFO: 2019-09-30T00:46:33.237Z: JOB_MESSAGE_BASIC: Executing operation read/Read+split+pair_with_one+group/Reify+group/Write
root: INFO: 2019-09-30T00:47:08.291Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 5 based on the rate of progress in the currently running step(s).
root: INFO: 2019-09-30T00:47:08.329Z: JOB_MESSAGE_DETAILED: Resized worker pool to 5, though goal was 10. This could be a quota issue.
root: INFO: 2019-09-30T00:47:13.728Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 10 based on the rate of progress in the currently running step(s).
root: INFO: 2019-09-30T00:47:43.083Z: JOB_MESSAGE_DETAILED: Workers have started successfully.
root: INFO: 2019-09-30T00:47:43.113Z: JOB_MESSAGE_DETAILED: Workers have started successfully.
root: INFO: 2019-09-30T00:52:06.244Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T00:52:06.501Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T00:52:07.301Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T00:52:08.410Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T00:52:08.580Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T00:52:09.468Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-30T00:52:09.496Z: JOB_MESSAGE_BASIC: Finished operation read/Read+split+pair_with_one+group/Reify+group/Write
root: INFO: 2019-09-30T00:52:09.560Z: JOB_MESSAGE_DEBUG: Executing failure step failure25
root: INFO: 2019-09-30T00:52:09.594Z: JOB_MESSAGE_ERROR: Workflow failed. Causes: S06:read/Read+split+pair_with_one+group/Reify+group/Write failed., Internal Issue (acecc22ae24fcc35): 63963027:24514
root: INFO: 2019-09-30T00:52:09.948Z: JOB_MESSAGE_WARNING: S01:write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite failed.
root: INFO: 2019-09-30T00:52:09.985Z: JOB_MESSAGE_BASIC: Finished operation write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite
root: INFO: 2019-09-30T00:52:10.103Z: JOB_MESSAGE_DETAILED: Cleaning up.
root: INFO: 2019-09-30T00:52:10.165Z: JOB_MESSAGE_DEBUG: Starting worker pool teardown.
root: INFO: 2019-09-30T00:52:10.195Z: JOB_MESSAGE_BASIC: Stopping worker pool...
root: INFO: 2019-09-30T00:55:29.027Z: 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: 2019-09-30T00:55:29.063Z: JOB_MESSAGE_BASIC: Worker pool stopped.
root: INFO: 2019-09-30T00:55:29.095Z: JOB_MESSAGE_DEBUG: Tearing down pending resources...
root: INFO: Job 2019-09-29_17_46_26-371537133754242835 is in state JOB_STATE_FAILED
apache_beam.io.filesystem: DEBUG: Listing files in 'gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1569804384301/results'
apache_beam.io.filesystem: DEBUG: translate_pattern: 'gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1569804384301/results*' -> 'gs://temp\\-storage\\-for\\-end\\-to\\-end\\-tests/py\\-it\\-cloud/output/1569804384301/results[^/\\\\]*'
root: INFO: Starting the size estimation of the input
root: INFO: Finished listing 0 files in 0.04776501655578613 seconds.
--------------------- >> end captured logging << ---------------------
----------------------------------------------------------------------
XML: nosetests-integrationTest-perf.xml
----------------------------------------------------------------------
XML: <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/src/sdks/python/nosetests.xml>
----------------------------------------------------------------------
Ran 1 test in 554.495s
FAILED (errors=1)
FAILURE: Build failed with an exception.
* What went wrong:
Execution failed for task ':sdks:python:test-suites:dataflow:py37:integrationTest'.
> Process 'command 'sh'' finished with non-zero exit value 1
* Try:
Run with --stacktrace option to get the stack trace. Run with --debug option to get more log output. Run with --scan to get full insights.
* Get more help at https://help.gradle.org
BUILD FAILED in 10m 0s
2019-09-30 00:55:40,279 afef9799 MainThread beam_integration_benchmark(1/1) ERROR Error during benchmark beam_integration_benchmark
Traceback (most recent call last):
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 841, in RunBenchmark
DoRunPhase(spec, collector, detailed_timer)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 687, in DoRunPhase
samples = spec.BenchmarkRun(spec)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/linux_benchmarks/beam_integration_benchmark.py",> line 160, in Run
job_type=job_type)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/providers/gcp/gcp_dpb_dataflow.py",> line 91, in SubmitJob
assert retcode == 0, "Integration Test Failed."
AssertionError: Integration Test Failed.
2019-09-30 00:55:40,281 afef9799 MainThread beam_integration_benchmark(1/1) INFO Cleaning up benchmark beam_integration_benchmark
2019-09-30 00:55:40,283 afef9799 MainThread beam_integration_benchmark(1/1) ERROR Exception running benchmark
Traceback (most recent call last):
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 984, in RunBenchmarkTask
RunBenchmark(spec, collector)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 841, in RunBenchmark
DoRunPhase(spec, collector, detailed_timer)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 687, in DoRunPhase
samples = spec.BenchmarkRun(spec)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/linux_benchmarks/beam_integration_benchmark.py",> line 160, in Run
job_type=job_type)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/providers/gcp/gcp_dpb_dataflow.py",> line 91, in SubmitJob
assert retcode == 0, "Integration Test Failed."
AssertionError: Integration Test Failed.
2019-09-30 00:55:40,283 afef9799 MainThread beam_integration_benchmark(1/1) ERROR Benchmark 1/1 beam_integration_benchmark (UID: beam_integration_benchmark0) failed. Execution will continue.
2019-09-30 00:55:40,284 afef9799 MainThread beam_integration_benchmark(1/1) INFO Benchmark run statuses:
---------------------------------------------------------------------------------
Name UID Status Failed Substatus
---------------------------------------------------------------------------------
beam_integration_benchmark beam_integration_benchmark0 FAILED
---------------------------------------------------------------------------------
Success rate: 0.00% (0/1)
2019-09-30 00:55:40,284 afef9799 MainThread beam_integration_benchmark(1/1) INFO Complete logs can be found at: <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/runs/afef9799/pkb.log>
2019-09-30 00:55:40,284 afef9799 MainThread beam_integration_benchmark(1/1) INFO Completion statuses can be found at: <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/runs/afef9799/completion_statuses.json>
Build step 'Execute shell' marked build as failure
---------------------------------------------------------------------
To unsubscribe, e-mail: builds-unsubscribe@beam.apache.org
For additional commands, e-mail: builds-help@beam.apache.org
Build failed in Jenkins: beam_PerformanceTests_WordCountIT_Py37
#523
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/523/display/redirect>
Changes:
------------------------------------------
[...truncated 156.95 KB...]
"encoding": {
"@type": "kind:windowed_value",
"component_encodings": [
{
"@type": "FastPrimitivesCoder$eNprYE5OLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqYIfgYGhvi0xJycpMTk7HiwlkJ8pgVkJmfnpEJNYQGawlpbyJZUnKQHACYlLgM=",
"component_encodings": [
{
"@type": "FastPrimitivesCoder$eNprYE5OLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqYIfgYGhvi0xJycpMTk7HiwlkJ8pgVkJmfnpEJNYQGawlpbyJZUnKQHACYlLgM=",
"component_encodings": []
},
{
"@type": "FastPrimitivesCoder$eNprYE5OLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqYIfgYGhvi0xJycpMTk7HiwlkJ8pgVkJmfnpEJNYQGawlpbyJZUnKQHACYlLgM=",
"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": "eNrNV/l/G8UV10rOwZKmAUogpIdISbumSHJCc7kUkioJGMWKuzZ4e4RltDvSLN7d2Tcza8XU4krlGHrfhV5J6X3T+z7+jv4zfTOSnApsmt/Sz8feXb2Z92be933fd3afKzkByUjAqN+iJKkqQVLZ5iKR1YALatdJHJNWTBcFyTIqTvOzqQ2FyefB6kHR8UqFQsFvp1AaCxJx/GsRSW2/HaUkjp6mfldEitow4e0yLjmGFR2Z0QC2Nb0daMsED6iUsJ1NeDfrOWoloz6LUiVhx/geccDYqyHFTRLFhbRnzi+g+RFttmEnbvCmZg9sx4SK0ixXJp6Em5tmBzxX12y7mvkavKWVty7Abuf1mSh6UUXc9hfwPh+lSza8FaPv6cEtjrcHI7WjmPoZUczPBG1HF+HWsQg8Q+9UVpdJnOM8wZejkAp7XhEVBY9r49zIBrdh4Lf14HbHszHwwEPvEPYGYRTHVV9fbT/mJDR2G+4wFZBKwJ192OfCXd62kSfs987jc0dO12qKJllFIk6kQytY3QpNw4rigxuVStaylUqkKkHM87A2wKZ26MjRE8eOHz5++OjU1PGaoDKPsRRvz1vX0k5JQn2Zt3Xa72B6++/swbsctpfdxfZ7OKsAZZyvs0nzxJeMiFDC3Y2C2WbAMWs4MAaXscnhzV7g80pEaafODT7vxgXu6cHBlneLzlpHG2xBE5YoeI93D9orB53hUJ5MTh0JK7yNpmvraxu819s7HqIT89YojmMGK/du6jlp0g94guWWEms7KNG93gSaSa44vM+7CR+TKBlW7z4DgOZRLYtJlELF26cJrjsqxUoKEsWYpJ/SLt6Rj9V10xE+o0QjVGvmrXFWpooK7KtqrqLYPiU6eUJTNReTgDIeG6imEKpDTF8PNyxzv5/24P0X4IjjTerMkXFTFdOUtcVr15kki2tnhz1rLHB0bOnMcMv2H0uzKFiKaTiPgWZ0f9lwrAfHHQNDSBSBE5s5bkw/jVNsmMaNfaAHDzjebo1eoBVAN5PODz7o7Uej9p7W2/VNG0/jnoRWpOnlQ/CgIUI3SkPe9RPEU8OIcvTQVpqm45gw0jYVJ7H/Bm8bThr4lyPa1cFOjTVfIChRyLg8DXRj2/Ahh93h7cT5mqRag6Deh9MunHEaVqOA/6XGbXV7vbBaWLcuFecLcLbZh4cnjcsoF3ikDzOeQEuN8YTWnqLpUpTK0b0iY7JMa10uliTmRWs6LX+OCsPXNKALuof9RS7COs9TNbPgz63cf6wmRVCT4ZLubsV4WvsvUGqDelSzFXjUbOWBmCStkDwIjdnzVr0A57zbdZcLnvgCQ2oyb+x21kiowWcob9Bcg/OTCuZc+PAYXB2qfCwnMtI1y7TyKFaYEswbjHFYj8LCGjzmwuNjrlGScaH8hId5jFK36N2qKfIGSoHXh4+48FET3kffQPk+fGwNPu7CBdZobla9gOIPeIJh7bBMRSxTqbGjUa8/qQrKulJcLYTW1eIlq1dcLcoDq9aVUlhUE5cKV7F8atsqjoSlpaI4uloMJ/YV0LY93Dawqx0D2/CppJ/apb14fcEKcSb4TrNRNKmHtE1QUeFJTRPvGbTM1XkcU0OrMm+XJbZg+WBY7kaKlRM8jMuKERxJaZnGVHd8edAwNCwTWSbokHZiqtBbl6ZaPhsJqcqqy0fzZZmmgSYIFdoHIx44KA/cZ65VQOFrDdo3jqSCwKiYrrniPJYQetv1bxlHAQVqzh2sHrRN555JMrWy0dvQMcMxTYEZ7TPn3BkhuICI3angKa9oYsOSgWJEotisrlUPksuQskeNDvubk5DPvmbV9xSKe6wJa7e1y9ppFa1iEbJJpCG4INgFxpv4DiCbCpQLeR+WXeiyJ3pwcQvVWGEnZR+eduETa7Dagx46PuPCs3mLPcRO5pfhuQ3lPHRdyvk8Q0V8wWEnmJa5Sz34pMP+t6b19Wrs1JCbAwmxGvP1iVXNnzUUj8uTDPVi/UbpxYvjevHS7L8tdk6j/ikXPo2ov6RR/wyC91kXPrcB3uc3wDt8XeB9QYP3xRF4X+rBl68HvK9sAt7r9ferCOHXDIRfv1EQvjwO4Ssouewcm2Woot9AIL/pwrcQyFea7EZI1Le1RLH/G1n6joIrDgtYyChrsw5jzEjIVbbEYoYy8V328pvJxKuby8T3NGG/78IPEOdXNWF/iIT9kQs/7sNPXPiplomfbSETPzcy8QsXfrkGv+rBa+j4axd+s8H039I3/aJaNAExlg2/Q2b/vgd/cAwdBivhAn/cyn8ww37YvLgM4uDHzp8wyp+NWOO7cqeDFE3hL1uFGE6xTw9On4XhT/grBvmbSRiLlyd5THS99eFL4e8Ny5y9GlipSJL5+PbbwjdVAf/AIfOxFkl/dKD9cz1vKfhX9T912dQ/",
"user_name": "write/Write/WriteImpl/FinalizeWrite/FinalizeWrite"
}
}
],
"type": "JOB_TYPE_BATCH"
}
root: INFO: Create job: <Job
createTime: '2019-09-29T18:47:10.261809Z'
currentStateTime: '1970-01-01T00:00:00Z'
id: '2019-09-29_11_47_08-16668928400183565296'
location: 'us-central1'
name: 'beamapp-jenkins-0929184706-936443'
projectId: 'apache-beam-testing'
stageStates: []
startTime: '2019-09-29T18:47:10.261809Z'
steps: []
tempFiles: []
type: TypeValueValuesEnum(JOB_TYPE_BATCH, 1)>
root: INFO: Created job with id: [2019-09-29_11_47_08-16668928400183565296]
root: INFO: To access the Dataflow monitoring console, please navigate to https://console.cloud.google.com/dataflow/jobsDetail/locations/us-central1/jobs/2019-09-29_11_47_08-16668928400183565296?project=apache-beam-testing
root: INFO: Job 2019-09-29_11_47_08-16668928400183565296 is in state JOB_STATE_RUNNING
root: INFO: 2019-09-29T18:47:12.056Z: JOB_MESSAGE_DETAILED: Checking permissions granted to controller Service Account.
root: INFO: 2019-09-29T18:47:12.532Z: JOB_MESSAGE_BASIC: Worker configuration: n1-standard-1 in us-central1-f.
root: INFO: 2019-09-29T18:47:13.124Z: JOB_MESSAGE_DETAILED: Expanding CoGroupByKey operations into optimizable parts.
root: INFO: 2019-09-29T18:47:13.180Z: JOB_MESSAGE_DEBUG: Combiner lifting skipped for step write/Write/WriteImpl/GroupByKey: GroupByKey not followed by a combiner.
root: INFO: 2019-09-29T18:47:13.207Z: JOB_MESSAGE_DEBUG: Combiner lifting skipped for step group: GroupByKey not followed by a combiner.
root: INFO: 2019-09-29T18:47:13.236Z: JOB_MESSAGE_DETAILED: Expanding GroupByKey operations into optimizable parts.
root: INFO: 2019-09-29T18:47:13.257Z: JOB_MESSAGE_DETAILED: Lifting ValueCombiningMappingFns into MergeBucketsMappingFns
root: INFO: 2019-09-29T18:47:13.319Z: JOB_MESSAGE_DEBUG: Annotating graph with Autotuner information.
root: INFO: 2019-09-29T18:47:13.358Z: JOB_MESSAGE_DETAILED: Fusing adjacent ParDo, Read, Write, and Flatten operations
root: INFO: 2019-09-29T18:47:13.386Z: JOB_MESSAGE_DETAILED: Fusing consumer split into read/Read
root: INFO: 2019-09-29T18:47:13.412Z: JOB_MESSAGE_DETAILED: Fusing consumer pair_with_one into split
root: INFO: 2019-09-29T18:47:13.436Z: JOB_MESSAGE_DETAILED: Fusing consumer group/Reify into pair_with_one
root: INFO: 2019-09-29T18:47:13.458Z: JOB_MESSAGE_DETAILED: Fusing consumer group/Write into group/Reify
root: INFO: 2019-09-29T18:47:13.484Z: JOB_MESSAGE_DETAILED: Fusing consumer group/GroupByWindow into group/Read
root: INFO: 2019-09-29T18:47:13.510Z: JOB_MESSAGE_DETAILED: Fusing consumer count into group/GroupByWindow
root: INFO: 2019-09-29T18:47:13.531Z: JOB_MESSAGE_DETAILED: Fusing consumer format into count
root: INFO: 2019-09-29T18:47:13.555Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/WriteBundles/WriteBundles into format
root: INFO: 2019-09-29T18:47:13.577Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/Pair into write/Write/WriteImpl/WriteBundles/WriteBundles
root: INFO: 2019-09-29T18:47:13.602Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/WindowInto(WindowIntoFn) into write/Write/WriteImpl/Pair
root: INFO: 2019-09-29T18:47:13.625Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/GroupByKey/Reify into write/Write/WriteImpl/WindowInto(WindowIntoFn)
root: INFO: 2019-09-29T18:47:13.650Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/GroupByKey/Write into write/Write/WriteImpl/GroupByKey/Reify
root: INFO: 2019-09-29T18:47:13.674Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/GroupByKey/GroupByWindow into write/Write/WriteImpl/GroupByKey/Read
root: INFO: 2019-09-29T18:47:13.697Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/Extract into write/Write/WriteImpl/GroupByKey/GroupByWindow
root: INFO: 2019-09-29T18:47:13.722Z: JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/InitializeWrite into write/Write/WriteImpl/DoOnce/Read
root: INFO: 2019-09-29T18:47:13.750Z: JOB_MESSAGE_DEBUG: Workflow config is missing a default resource spec.
root: INFO: 2019-09-29T18:47:13.776Z: JOB_MESSAGE_DEBUG: Adding StepResource setup and teardown to workflow graph.
root: INFO: 2019-09-29T18:47:13.801Z: JOB_MESSAGE_DEBUG: Adding workflow start and stop steps.
root: INFO: 2019-09-29T18:47:13.827Z: JOB_MESSAGE_DEBUG: Assigning stage ids.
root: INFO: 2019-09-29T18:47:13.942Z: JOB_MESSAGE_DEBUG: Executing wait step start26
root: INFO: 2019-09-29T18:47:13.997Z: JOB_MESSAGE_BASIC: Executing operation write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite
root: INFO: 2019-09-29T18:47:14.024Z: JOB_MESSAGE_BASIC: Executing operation write/Write/WriteImpl/GroupByKey/Create
root: INFO: 2019-09-29T18:47:14.033Z: JOB_MESSAGE_DEBUG: Starting worker pool setup.
root: INFO: 2019-09-29T18:47:14.050Z: JOB_MESSAGE_BASIC: Executing operation group/Create
root: INFO: 2019-09-29T18:47:14.061Z: JOB_MESSAGE_BASIC: Starting 10 workers in us-central1-f...
root: INFO: 2019-09-29T18:47:14.108Z: JOB_MESSAGE_BASIC: Finished operation write/Write/WriteImpl/GroupByKey/Create
root: INFO: 2019-09-29T18:47:14.108Z: JOB_MESSAGE_BASIC: Finished operation group/Create
root: INFO: 2019-09-29T18:47:14.155Z: JOB_MESSAGE_DEBUG: Value "group/Session" materialized.
root: INFO: 2019-09-29T18:47:14.183Z: JOB_MESSAGE_DEBUG: Value "write/Write/WriteImpl/GroupByKey/Session" materialized.
root: INFO: 2019-09-29T18:47:14.214Z: JOB_MESSAGE_BASIC: Executing operation read/Read+split+pair_with_one+group/Reify+group/Write
root: INFO: 2019-09-29T18:47:39.768Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 10 based on the rate of progress in the currently running step(s).
root: INFO: 2019-09-29T18:48:03.779Z: JOB_MESSAGE_DETAILED: Workers have started successfully.
root: INFO: 2019-09-29T18:48:03.800Z: JOB_MESSAGE_DETAILED: Workers have started successfully.
root: INFO: 2019-09-29T18:51:33.424Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-29T18:51:35.501Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-29T18:51:37.552Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-29T18:51:39.613Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-29T18:51:41.677Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-29T18:51:46.571Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-29T18:51:48.641Z: JOB_MESSAGE_ERROR: Traceback (most recent call last):
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 773, in run
self._load_main_session(self.local_staging_directory)
File "/usr/local/lib/python3.7/site-packages/dataflow_worker/batchworker.py", line 489, in _load_main_session
pickler.load_session(session_file)
File "/usr/local/lib/python3.7/site-packages/apache_beam/internal/pickler.py", line 287, in load_session
return dill.load_session(file_path)
File "/usr/local/lib/python3.7/site-packages/dill/_dill.py", line 410, in load_session
module = unpickler.load()
TypeError: _create_function() takes from 2 to 6 positional arguments but 7 were given
root: INFO: 2019-09-29T18:51:48.665Z: JOB_MESSAGE_BASIC: Finished operation read/Read+split+pair_with_one+group/Reify+group/Write
root: INFO: 2019-09-29T18:51:48.723Z: JOB_MESSAGE_DEBUG: Executing failure step failure25
root: INFO: 2019-09-29T18:51:48.758Z: JOB_MESSAGE_ERROR: Workflow failed. Causes: S06:read/Read+split+pair_with_one+group/Reify+group/Write failed., Internal Issue (e73f45b69c9f4bd5): 63963027:24514
root: INFO: 2019-09-29T18:51:49.167Z: JOB_MESSAGE_WARNING: S01:write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite failed.
root: INFO: 2019-09-29T18:51:49.200Z: JOB_MESSAGE_BASIC: Finished operation write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite
root: INFO: 2019-09-29T18:51:49.304Z: JOB_MESSAGE_DETAILED: Cleaning up.
root: INFO: 2019-09-29T18:51:49.364Z: JOB_MESSAGE_DEBUG: Starting worker pool teardown.
root: INFO: 2019-09-29T18:51:49.400Z: JOB_MESSAGE_BASIC: Stopping worker pool...
root: INFO: 2019-09-29T18:54:05.870Z: 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: 2019-09-29T18:54:05.910Z: JOB_MESSAGE_BASIC: Worker pool stopped.
root: INFO: 2019-09-29T18:54:05.944Z: JOB_MESSAGE_DEBUG: Tearing down pending resources...
root: INFO: Job 2019-09-29_11_47_08-16668928400183565296 is in state JOB_STATE_FAILED
apache_beam.io.filesystem: DEBUG: Listing files in 'gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1569782826008/results'
apache_beam.io.filesystem: DEBUG: translate_pattern: 'gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1569782826008/results*' -> 'gs://temp\\-storage\\-for\\-end\\-to\\-end\\-tests/py\\-it\\-cloud/output/1569782826008/results[^/\\\\]*'
root: INFO: Starting the size estimation of the input
root: INFO: Finished listing 0 files in 0.04529619216918945 seconds.
--------------------- >> end captured logging << ---------------------
----------------------------------------------------------------------
XML: nosetests-integrationTest-perf.xml
----------------------------------------------------------------------
XML: <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/src/sdks/python/nosetests.xml>
----------------------------------------------------------------------
Ran 1 test in 429.959s
FAILED (errors=1)
FAILURE: Build failed with an exception.
* What went wrong:
Execution failed for task ':sdks:python:test-suites:dataflow:py37:integrationTest'.
> Process 'command 'sh'' finished with non-zero exit value 1
* Try:
Run with --stacktrace option to get the stack trace. Run with --debug option to get more log output. Run with --scan to get full insights.
* Get more help at https://help.gradle.org
BUILD FAILED in 7m 56s
2019-09-29 18:54:17,349 dd21ddea MainThread beam_integration_benchmark(1/1) ERROR Error during benchmark beam_integration_benchmark
Traceback (most recent call last):
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 841, in RunBenchmark
DoRunPhase(spec, collector, detailed_timer)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 687, in DoRunPhase
samples = spec.BenchmarkRun(spec)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/linux_benchmarks/beam_integration_benchmark.py",> line 160, in Run
job_type=job_type)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/providers/gcp/gcp_dpb_dataflow.py",> line 91, in SubmitJob
assert retcode == 0, "Integration Test Failed."
AssertionError: Integration Test Failed.
2019-09-29 18:54:17,350 dd21ddea MainThread beam_integration_benchmark(1/1) INFO Cleaning up benchmark beam_integration_benchmark
2019-09-29 18:54:17,352 dd21ddea MainThread beam_integration_benchmark(1/1) ERROR Exception running benchmark
Traceback (most recent call last):
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 984, in RunBenchmarkTask
RunBenchmark(spec, collector)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 841, in RunBenchmark
DoRunPhase(spec, collector, detailed_timer)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/pkb.py",> line 687, in DoRunPhase
samples = spec.BenchmarkRun(spec)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/linux_benchmarks/beam_integration_benchmark.py",> line 160, in Run
job_type=job_type)
File "<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/PerfKitBenchmarker/perfkitbenchmarker/providers/gcp/gcp_dpb_dataflow.py",> line 91, in SubmitJob
assert retcode == 0, "Integration Test Failed."
AssertionError: Integration Test Failed.
2019-09-29 18:54:17,352 dd21ddea MainThread beam_integration_benchmark(1/1) ERROR Benchmark 1/1 beam_integration_benchmark (UID: beam_integration_benchmark0) failed. Execution will continue.
2019-09-29 18:54:17,352 dd21ddea MainThread beam_integration_benchmark(1/1) INFO Benchmark run statuses:
---------------------------------------------------------------------------------
Name UID Status Failed Substatus
---------------------------------------------------------------------------------
beam_integration_benchmark beam_integration_benchmark0 FAILED
---------------------------------------------------------------------------------
Success rate: 0.00% (0/1)
2019-09-29 18:54:17,353 dd21ddea MainThread beam_integration_benchmark(1/1) INFO Complete logs can be found at: <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/runs/dd21ddea/pkb.log>
2019-09-29 18:54:17,353 dd21ddea MainThread beam_integration_benchmark(1/1) INFO Completion statuses can be found at: <https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/runs/dd21ddea/completion_statuses.json>
Build step 'Execute shell' marked build as failure
---------------------------------------------------------------------
To unsubscribe, e-mail: builds-unsubscribe@beam.apache.org
For additional commands, e-mail: builds-help@beam.apache.org