See
<https://builds.apache.org/job/beam_PostCommit_Python_VR_Spark/1557/display/redirect>
Changes:
------------------------------------------
[...truncated 1.68 MB...]
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2749
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2642
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2748
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2932
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2594
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2571
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2566
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2616
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2620
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2868
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2768
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2816
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2665
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2805
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2858
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2870
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2644
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2750
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2867
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2701
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2937
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2763
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2780
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2856
19/11/17 00:14:17 INFO ContextCleaner: Cleaned shuffle 63
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2700
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2557
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2895
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2621
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2522
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2528
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2837
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2795
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2765
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2884
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2872
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2860
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2652
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2835
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2918
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2812
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2593
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2554
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2875
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2736
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2920
19/11/17 00:14:17 INFO BlockManagerInfo: Removed broadcast_128_piece0 on
localhost:37851 in memory (size: 10.8 KB, free: 13.5 GB)
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2562
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2782
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2914
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2790
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2942
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2663
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2911
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2854
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2946
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2685
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2915
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2767
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2680
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2827
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2617
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2904
19/11/17 00:14:17 INFO ContextCleaner: Cleaned shuffle 62
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2686
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2604
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2928
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2813
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2533
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2514
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2589
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2769
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2648
19/11/17 00:14:17 INFO BlockManagerInfo: Removed broadcast_125_piece0 on
localhost:37851 in memory (size: 21.9 KB, free: 13.5 GB)
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2890
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2649
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2708
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2552
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2908
19/11/17 00:14:17 INFO BlockManagerInfo: Removed broadcast_122_piece0 on
localhost:37851 in memory (size: 18.4 KB, free: 13.5 GB)
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2698
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2673
19/11/17 00:14:17 INFO BlockManagerInfo: Removed broadcast_113_piece0 on
localhost:37851 in memory (size: 13.7 KB, free: 13.5 GB)
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2907
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2738
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2580
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2880
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2582
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2603
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2608
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2542
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2569
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2754
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2947
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2572
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2574
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2624
19/11/17 00:14:17 INFO ContextCleaner: Cleaned accumulator 2564
19/11/17 00:14:18 INFO GrpcLoggingService: Beam Fn Logging client connected.
19/11/17 00:14:18 INFO main: Logging handler created.
19/11/17 00:14:18 INFO start: Status HTTP server running at localhost:44039
19/11/17 00:14:18 INFO main: semi_persistent_directory: /tmp
19/11/17 00:14:18 WARN _load_main_session: No session file found:
/tmp/staged/pickled_main_session. Functions defined in __main__ (interactive
session) may fail.
19/11/17 00:14:18 WARN get_all_options: Discarding unparseable args:
[u'--job_server_timeout=60',
u'--app_name=test_windowing_1573949652.0_0a3396e3-8387-445f-8963-9179f1c25e99',
u'--direct_runner_use_stacked_bundle', u'--spark_master=local',
u'--options_id=30', u'--enable_spark_metric_sinks', u'--pipeline_type_check']
19/11/17 00:14:18 INFO main: Python sdk harness started with pipeline_options:
{'runner': u'None', 'experiments': [u'beam_fn_api'],
'environment_cache_millis': u'0', 'environment_type': u'PROCESS',
'sdk_location': u'container', 'job_name': u'test_windowing_1573949652.0',
'environment_config': u'{"command":
"<https://builds.apache.org/job/beam_PostCommit_Python_VR_Spark/ws/src/sdks/python/test-suites/portable/py2/build/sdk_worker.sh"}',>
'sdk_worker_parallelism': u'1', 'job_endpoint': u'localhost:44591'}
19/11/17 00:14:18 INFO __init__: Creating state cache with size 0
19/11/17 00:14:18 INFO __init__: Creating insecure control channel for
localhost:45857.
19/11/17 00:14:18 INFO FnApiControlClientPoolService: Beam Fn Control client
connected with id 265-1
19/11/17 00:14:18 INFO __init__: Control channel established.
19/11/17 00:14:18 INFO __init__: Initializing SDKHarness with unbounded number
of workers.
19/11/17 00:14:18 INFO create_state_handler: Creating insecure state channel
for localhost:38439.
19/11/17 00:14:18 INFO create_state_handler: State channel established.
19/11/17 00:14:18 INFO create_data_channel: Creating client data channel for
localhost:41387
19/11/17 00:14:18 INFO GrpcDataService: Beam Fn Data client connected.
19/11/17 00:14:18 INFO DefaultJobBundleFactory: Closing environment urn:
"beam:env:process:v1"
payload:
"\032\202\001<https://builds.apache.org/job/beam_PostCommit_Python_VR_Spark/ws/src/sdks/python/test-suites/portable/py2/build/sdk_worker.sh";>
19/11/17 00:14:18 INFO run: No more requests from control plane
19/11/17 00:14:18 INFO run: SDK Harness waiting for in-flight requests to
complete
19/11/17 00:14:18 WARN BeamFnDataGrpcMultiplexer: Hanged up for unknown
endpoint.
19/11/17 00:14:18 INFO close: Closing all cached grpc data channels.
19/11/17 00:14:18 INFO close: Closing all cached gRPC state handlers.
19/11/17 00:14:18 INFO run: Done consuming work.
19/11/17 00:14:18 INFO main: Python sdk harness exiting.
19/11/17 00:14:18 INFO GrpcLoggingService: Logging client hanged up.
19/11/17 00:14:18 WARN BeamFnDataGrpcMultiplexer: Hanged up for unknown
endpoint.
19/11/17 00:14:18 INFO Executor: Finished task 0.0 in stage 133.0 (TID 161).
12013 bytes result sent to driver
19/11/17 00:14:18 INFO TaskSetManager: Finished task 0.0 in stage 133.0 (TID
161) in 1065 ms on localhost (executor driver) (1/1)
19/11/17 00:14:18 INFO TaskSchedulerImpl: Removed TaskSet 133.0, whose tasks
have all completed, from pool
19/11/17 00:14:18 INFO DAGScheduler: ResultStage 133 (foreach at
BoundedDataset.java:124) finished in 1.072 s
19/11/17 00:14:18 INFO DAGScheduler: Job 47 finished: foreach at
BoundedDataset.java:124, took 5.149323 s
19/11/17 00:14:18 INFO SparkPipelineRunner: Job
test_windowing_1573949652.0_0a3396e3-8387-445f-8963-9179f1c25e99 finished.
19/11/17 00:14:18 WARN SparkPipelineResult$BatchMode: Collecting monitoring
infos is not implemented yet in Spark portable runner.
19/11/17 00:14:18 INFO AbstractArtifactRetrievalService: Manifest at
/tmp/sparktestJ1mMbD/job_3db4ce16-b754-4944-a35b-8fa6ae6a6b15/MANIFEST has 0
artifact locations
19/11/17 00:14:18 INFO BeamFileSystemArtifactStagingService: Removed dir
/tmp/sparktestJ1mMbD/job_3db4ce16-b754-4944-a35b-8fa6ae6a6b15/
INFO:apache_beam.runners.portability.portable_runner:Job state changed to DONE
.
======================================================================
ERROR: test_pardo_state_with_custom_key_coder (__main__.SparkRunnerTest)
Tests that state requests work correctly when the key coder is an
----------------------------------------------------------------------
Traceback (most recent call last):
File "apache_beam/runners/portability/portable_runner_test.py", line 231, in
test_pardo_state_with_custom_key_coder
equal_to(expected))
File "apache_beam/pipeline.py", line 436, in __exit__
self.run().wait_until_finish()
File "apache_beam/runners/portability/portable_runner.py", line 421, in
wait_until_finish
for state_response in self._state_stream:
File
"<https://builds.apache.org/job/beam_PostCommit_Python_VR_Spark/ws/src/build/gradleenv/1866363813/local/lib/python2.7/site-packages/grpc/_channel.py";,>
line 395, in next
return self._next()
File
"<https://builds.apache.org/job/beam_PostCommit_Python_VR_Spark/ws/src/build/gradleenv/1866363813/local/lib/python2.7/site-packages/grpc/_channel.py";,>
line 552, in _next
_common.wait(self._state.condition.wait, _response_ready)
File
"<https://builds.apache.org/job/beam_PostCommit_Python_VR_Spark/ws/src/build/gradleenv/1866363813/local/lib/python2.7/site-packages/grpc/_common.py";,>
line 140, in wait
_wait_once(wait_fn, MAXIMUM_WAIT_TIMEOUT, spin_cb)
File
"<https://builds.apache.org/job/beam_PostCommit_Python_VR_Spark/ws/src/build/gradleenv/1866363813/local/lib/python2.7/site-packages/grpc/_common.py";,>
line 105, in _wait_once
wait_fn(timeout=timeout)
File "/usr/lib/python2.7/threading.py", line 359, in wait
_sleep(delay)
File "apache_beam/runners/portability/portable_runner_test.py", line 75, in
handler
raise BaseException(msg)
BaseException: Timed out after 60 seconds.
======================================================================
==================== Timed out after 60 seconds. ====================
ERROR: test_pardo_timers (__main__.SparkRunnerTest)
----------------------------------------------------------------------
Traceback (most recent call last):
# Thread: <Thread(wait_until_finish_read, started daemon 139843417372416)>
File "apache_beam/runners/portability/fn_api_runner_test.py", line 328, in
test_pardo_timers
assert_that(actual, equal_to(expected))
File "apache_beam/pipeline.py", line 436, in __exit__
self.run().wait_until_finish()
File "apache_beam/runners/portability/portable_ru# Thread:
<Thread(Thread-116, started daemon 139843408979712)>
nner.py", line 421, in wait_until_finish
for state_response in self._state_stream:
# Thread: <_MainThread(MainThread, started 139844196792064)>
File
"<https://builds.apache.org/job/beam_PostCommit_Python_VR_Spark/ws/src/build/gradleenv/1866363813/local/lib/python2.7/site-packages/grpc/_channel.py";,>
line 395, in next
return self._next()
==================== Timed out after 60 seconds. ====================
File
"<https://builds.apache.org/job/beam_PostCommit_Python_VR_Spark/ws/src/build/gradleenv/1866363813/local/lib/python2.7/site-packages/grpc/_channel.py";,>
line 552, in _next
_common.wait(self._state.condition.wait, _response_ready)
File
"<https://builds.apache.org/job/beam_PostCommit_Python_VR_Spark/ws/src/build/gradleenv/1866363813/local/lib/python2.7/site-packages/grpc/_common.py";,>
line 140, in wait
_wait_once(wait_fn, MAXIMUM_WAIT_TIMEOUT, spin_cb)
# Thread: <Thread(wait_until_finish_read, started daemon 139843313063680)>
# Thread: <Thread(Thread-122, started daemon 139843321456384)>
File
"<https://builds.apache.org/job/beam_PostCommit_Python_VR_Spark/ws/src/build/gradleenv/1866363813/local/lib/python2.7/site-packages/grpc/_common.py";,>
line 105, in _wait_once
wait_fn(timeout=timeout)
# Thread: <_MainThread(MainThread, started 139844196792064)>
File "/usr/lib/python2.7/threading.py", line 359, in wait
_sleep(delay)
File "apache_beam/runners/portability/portable_runner_test.py", line 75, in
handler
raise BaseException(msg)
BaseException: Timed out after 60 seconds.
======================================================================
ERROR: test_sdf_with_watermark_tracking (__main__.SparkRunnerTest)
# Thread: <Thread(wait_until_finish_read, started daemon 139843417372416)>
----------------------------------------------------------------------
Traceback (most recent call last):
File "apache_beam/runners/portability/fn_api_runner_test.py", line 499, in
test_sdf_with_watermark_tracking
assert_that(actual, equal_to(list(''.join(data))))
File "apache_beam/pipeline.py", line 436, in __exit__
self.run().wait_until_finish()
File "apache_beam/runners/portability/portable_runner.py", line 431, in
wait_until_finish
self._job_id, self._state, self._last_error_message()))
RuntimeError: Pipeline
test_sdf_with_watermark_tracking_1573949640.64_aecddceb-9ecd-430d-bbd6-ecf4e792abf2
failed in state FAILED: java.lang.UnsupportedOperationException: The
ActiveBundle does not have a registered bundle checkpoint handler.
----------------------------------------------------------------------
Ran 38 tests in 375.772s
FAILED (errors=3, skipped=9)
# Thread: <Thread(Thread-116, started daemon 139843408979712)>
> Task :sdks:python:test-suites:portable:py2:sparkValidatesRunner FAILED
FAILURE: Build failed with an exception.
* Where:
Build file
'<https://builds.apache.org/job/beam_PostCommit_Python_VR_Spark/ws/src/sdks/python/test-suites/portable/py2/build.gradle'>
line: 198
* What went wrong:
Execution failed for task
':sdks:python:test-suites:portable:py2:sparkValidatesRunner'.
> Process 'command 'sh'' finished with non-zero exit value 1
* Try:
Run with --stacktrace option to get the stack trace. Run with --info or --debug
option to get more log output. Run with --scan to get full insights.
* Get more help at https://help.gradle.org
Deprecated Gradle features were used in this build, making it incompatible with
Gradle 6.0.
Use '--warning-mode all' to show the individual deprecation warnings.
See
https://docs.gradle.org/5.2.1/userguide/command_line_interface.html#sec:command_line_warnings
BUILD FAILED in 9m 40s
59 actionable tasks: 46 executed, 13 from cache
Publishing build scan...
https://gradle.com/s/s6jb7cthdzsti
Build step 'Invoke Gradle script' changed build result to FAILURE
Build step 'Invoke Gradle script' marked build as failure
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
