See <https://builds.apache.org/job/beam_PostCommit_Python_Verify/4911/display/redirect>
------------------------------------------ [...truncated 1.32 MB...] }, { "@type": "kind:interval_window" } ], "is_wrapper": true }, "output_name": "out", "user_name": "count.out" } ], "parallel_input": { "@type": "OutputReference", "output_name": "out", "step_name": "s6" }, "serialized_fn": "ref_AppliedPTransform_count_10", "user_name": "count" } }, { "kind": "ParallelDo", "name": "s8", "properties": { "display_data": [ { "key": "fn", "label": "Transform Function", "namespace": "apache_beam.transforms.core.CallableWrapperDoFn", "type": "STRING", "value": "format_result" }, { "key": "fn", "label": "Transform Function", "namespace": "apache_beam.transforms.core.ParDo", "shortValue": "CallableWrapperDoFn", "type": "STRING", "value": "apache_beam.transforms.core.CallableWrapperDoFn" } ], "non_parallel_inputs": {}, "output_info": [ { "encoding": { "@type": "kind:windowed_value", "component_encodings": [ { "@type": "FastPrimitivesCoder$eNprYEpOLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqZQ/vi0xJycpMTk7Hiw+kJmPEYFZCZn56RCjWABGsFaW8iWVJykBwDlGS3/", "component_encodings": [ { "@type": "FastPrimitivesCoder$eNprYEpOLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqZQ/vi0xJycpMTk7Hiw+kJmPEYFZCZn56RCjWABGsFaW8iWVJykBwDlGS3/", "component_encodings": [] }, { "@type": "FastPrimitivesCoder$eNprYEpOLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqZQ/vi0xJycpMTk7Hiw+kJmPEYFZCZn56RCjWABGsFaW8iWVJykBwDlGS3/", "component_encodings": [] } ], "is_pair_like": true }, { "@type": "kind:interval_window" } ], "is_wrapper": true }, "output_name": "out", "user_name": "format.out" } ], "parallel_input": { "@type": "OutputReference", "output_name": "out", "step_name": "s7" }, "serialized_fn": "ref_AppliedPTransform_format_11", "user_name": "format" } }, { "kind": "ParallelDo", "name": "s9", "properties": { "display_data": [ { "key": "fn", "label": "Transform Function", "namespace": "apache_beam.transforms.core.CallableWrapperDoFn", "type": "STRING", "value": "<lambda>" }, { "key": "fn", "label": "Transform Function", "namespace": "apache_beam.transforms.core.ParDo", "shortValue": "CallableWrapperDoFn", "type": "STRING", "value": "apache_beam.transforms.core.CallableWrapperDoFn" } ], "non_parallel_inputs": {}, "output_info": [ { "encoding": { "@type": "kind:windowed_value", "component_encodings": [ { "@type": "kind:bytes" }, { "@type": "kind:interval_window" } ], "is_wrapper": true }, "output_name": "out", "user_name": "WriteStringsToPubSub/EncodeString.out" } ], "parallel_input": { "@type": "OutputReference", "output_name": "out", "step_name": "s8" }, "serialized_fn": "ref_AppliedPTransform_WriteStringsToPubSub/EncodeString_13", "user_name": "WriteStringsToPubSub/EncodeString" } }, { "kind": "ParallelWrite", "name": "s10", "properties": { "display_data": [], "encoding": { "@type": "kind:windowed_value", "component_encodings": [ { "@type": "kind:bytes" }, { "@type": "kind:global_window" } ], "is_wrapper": true }, "format": "pubsub", "parallel_input": { "@type": "OutputReference", "output_name": "out", "step_name": "s9" }, "pubsub_topic": "projects/apache-beam-testing/topics/wc_topic_output50e6b5e3-6ad6-441b-96dd-ac8a24456125", "user_name": "WriteStringsToPubSub/Write/NativeWrite" } } ], "type": "JOB_TYPE_STREAMING" } root: INFO: Create job: <Job createTime: u'2018-05-09T21:30:16.857190Z' currentStateTime: u'1970-01-01T00:00:00Z' id: u'2018-05-09_14_30_16-5406977071237026756' location: u'us-central1' name: u'beamapp-jenkins-0509213014-939940' projectId: u'apache-beam-testing' stageStates: [] steps: [] tempFiles: [] type: TypeValueValuesEnum(JOB_TYPE_STREAMING, 2)> root: INFO: Created job with id: [2018-05-09_14_30_16-5406977071237026756] root: INFO: To access the Dataflow monitoring console, please navigate to https://console.cloud.google.com/dataflow/jobsDetail/locations/us-central1/jobs/2018-05-09_14_30_16-5406977071237026756?project=apache-beam-testing root: INFO: Job 2018-05-09_14_30_16-5406977071237026756 is in state JOB_STATE_RUNNING root: INFO: 2018-05-09T21:30:18.483Z: JOB_MESSAGE_DETAILED: Checking required Cloud APIs are enabled. root: INFO: 2018-05-09T21:30:18.851Z: JOB_MESSAGE_DETAILED: Checking permissions granted to controller Service Account. root: INFO: 2018-05-09T21:30:19.214Z: JOB_MESSAGE_BASIC: Worker configuration: n1-standard-4 in us-central1-b. root: INFO: 2018-05-09T21:30:19.493Z: JOB_MESSAGE_DETAILED: Expanding CollectionToSingleton operations into optimizable parts. root: INFO: 2018-05-09T21:30:19.500Z: JOB_MESSAGE_DETAILED: Expanding CoGroupByKey operations into optimizable parts. root: INFO: 2018-05-09T21:30:19.506Z: JOB_MESSAGE_DETAILED: Expanding SplittableProcessKeyed operations into optimizable parts. root: INFO: 2018-05-09T21:30:19.508Z: JOB_MESSAGE_DETAILED: Expanding GroupByKey operations into streaming Read/Write steps root: INFO: 2018-05-09T21:30:19.514Z: JOB_MESSAGE_DEBUG: Annotating graph with Autotuner information. root: INFO: 2018-05-09T21:30:19.524Z: JOB_MESSAGE_DETAILED: Fusing adjacent ParDo, Read, Write, and Flatten operations root: INFO: 2018-05-09T21:30:19.526Z: JOB_MESSAGE_DETAILED: Fusing consumer ReadStringsFromPubSub/DecodeString into ReadStringsFromPubSub/ReadFromPubSub/Read root: INFO: 2018-05-09T21:30:19.529Z: JOB_MESSAGE_DETAILED: Fusing consumer pair_with_one into split root: INFO: 2018-05-09T21:30:19.531Z: JOB_MESSAGE_DETAILED: Fusing consumer count into group/MergeBuckets root: INFO: 2018-05-09T21:30:19.533Z: JOB_MESSAGE_DETAILED: Fusing consumer WriteStringsToPubSub/Write/NativeWrite into WriteStringsToPubSub/EncodeString root: INFO: 2018-05-09T21:30:19.535Z: JOB_MESSAGE_DETAILED: Fusing consumer WriteStringsToPubSub/EncodeString into format root: INFO: 2018-05-09T21:30:19.537Z: JOB_MESSAGE_DETAILED: Fusing consumer group/MergeBuckets into group/ReadStream root: INFO: 2018-05-09T21:30:19.540Z: JOB_MESSAGE_DETAILED: Fusing consumer format into count root: INFO: 2018-05-09T21:30:19.541Z: JOB_MESSAGE_DETAILED: Fusing consumer group/WriteStream into WindowInto(WindowIntoFn) root: INFO: 2018-05-09T21:30:19.544Z: JOB_MESSAGE_DETAILED: Fusing consumer split into ReadStringsFromPubSub/DecodeString root: INFO: 2018-05-09T21:30:19.546Z: JOB_MESSAGE_DETAILED: Fusing consumer WindowInto(WindowIntoFn) into pair_with_one root: INFO: 2018-05-09T21:30:19.549Z: JOB_MESSAGE_DEBUG: Adding StepResource setup and teardown to workflow graph. root: INFO: 2018-05-09T21:30:19.582Z: JOB_MESSAGE_DEBUG: Adding workflow start and stop steps. root: INFO: 2018-05-09T21:30:19.593Z: JOB_MESSAGE_DEBUG: Assigning stage ids. root: INFO: 2018-05-09T21:30:19.738Z: JOB_MESSAGE_DEBUG: Executing wait step start2 root: INFO: 2018-05-09T21:30:19.784Z: JOB_MESSAGE_DEBUG: Starting worker pool setup. root: INFO: 2018-05-09T21:30:19.791Z: JOB_MESSAGE_BASIC: Starting 1 workers... root: INFO: 2018-05-09T21:30:22.115Z: JOB_MESSAGE_BASIC: Executing operation ReadStringsFromPubSub/ReadFromPubSub/Read+ReadStringsFromPubSub/DecodeString+split+pair_with_one+WindowInto(WindowIntoFn)+group/WriteStream root: INFO: 2018-05-09T21:30:22.115Z: JOB_MESSAGE_BASIC: Executing operation group/ReadStream+group/MergeBuckets+count+format+WriteStringsToPubSub/EncodeString+WriteStringsToPubSub/Write/NativeWrite root: INFO: 2018-05-09T21:31:15.618Z: JOB_MESSAGE_DEBUG: Executing input step topology_init_attach_disk_input_step root: INFO: 2018-05-09T21:31:36.008Z: JOB_MESSAGE_DETAILED: Workers have started successfully. root: WARNING: Timing out on waiting for job 2018-05-09_14_30_16-5406977071237026756 after 183 seconds google.auth.transport._http_client: DEBUG: Making request: GET http://169.254.169.254 google.auth.transport._http_client: DEBUG: Making request: GET http://metadata.google.internal/computeMetadata/v1/project/project-id root: DEBUG: Start pulling messages from projects/apache-beam-testing/subscriptions/wc_subscription_output50e6b5e3-6ad6-441b-96dd-ac8a24456125 google_auth_httplib2: DEBUG: Making request: GET http://metadata.google.internal/computeMetadata/v1/instance/service-accounts/default/?recursive=true google_auth_httplib2: DEBUG: Making request: GET http://metadata.google.internal/computeMetadata/v1/instance/service-accounts/844138762903-comp...@developer.gserviceaccount.com/token root: ERROR: Timeout after 400 sec. Received 0 messages from projects/apache-beam-testing/subscriptions/wc_subscription_output50e6b5e3-6ad6-441b-96dd-ac8a24456125. --------------------- >> end captured logging << --------------------- ---------------------------------------------------------------------- XML: <https://builds.apache.org/job/beam_PostCommit_Python_Verify/ws/src/sdks/python/nosetests.xml> ---------------------------------------------------------------------- Ran 4 tests in 928.424s FAILED (errors=2, failures=1) Found: https://console.cloud.google.com/dataflow/jobsDetail/locations/us-central1/jobs/2018-05-09_14_30_03-17418746177499869199?project=apache-beam-testing. Found: https://console.cloud.google.com/dataflow/jobsDetail/locations/us-central1/jobs/2018-05-09_14_30_04-6608455032604507168?project=apache-beam-testing. Found: https://console.cloud.google.com/dataflow/jobsDetail/locations/us-central1/jobs/2018-05-09_14_30_04-6445804603140249070?project=apache-beam-testing. Found: https://console.cloud.google.com/dataflow/jobsDetail/locations/us-central1/jobs/2018-05-09_14_30_16-5406977071237026756?project=apache-beam-testing. > Task :pythonPostCommit FAILED :pythonPostCommit (Thread[Task worker for ':' Thread 8,5,main]) completed. Took 45 mins 7.303 secs. FAILURE: Build failed with an exception. * Where: Build file '<https://builds.apache.org/job/beam_PostCommit_Python_Verify/ws/src/build.gradle'> line: 167 * What went wrong: Execution failed for task ':pythonPostCommit'. > 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 45m 14s 1 actionable task: 1 executed Publishing build scan... https://gradle.com/s/cbfmuzu5jdkxk Build step 'Invoke Gradle script' changed build result to FAILURE Build step 'Invoke Gradle script' marked build as failure Not sending mail to unregistered user yifan...@yifanzou-linuxworkstation.sea.corp.google.com Not sending mail to unregistered user git...@alasdairhodge.co.uk