This job view page is being replaced by Spyglass soon. Check out the new job view.
PRbullrox: Fixed redundant usage of method
ResultFAILURE
Tests 0 failed / 64 succeeded
Started2019-06-13 05:44
Elapsed1h0m
Revision
Buildergke-prow-containerd-pool-bigger-170c3937-t8fm
Refs master:4f29960c
78619:76041399
pod2091f641-8d9e-11e9-8958-2a4039bc9d1b
infra-commitbf4a71fd9
pod2091f641-8d9e-11e9-8958-2a4039bc9d1b
repok8s.io/kubernetes
repo-commit7754bc7e531a5b21d5e00516e4fcb539f439e985
repos{u'k8s.io/kubernetes': u'master:4f29960cb2058c4f556bf1e5ba49c9a29a501e70,78619:76041399cf8d904ae720f2a8f5f4fac74b2e34e4'}

No Test Failures!


Show 64 Passed Tests

Error lines from build-log.txt

... skipping 357 lines ...
W0613 05:53:51.396] I0613 05:53:51.395315   48582 serving.go:312] Generated self-signed cert (/tmp/apiserver.crt, /tmp/apiserver.key)
W0613 05:53:51.396] I0613 05:53:51.395551   48582 server.go:560] external host was not specified, using 172.17.0.2
W0613 05:53:51.396] W0613 05:53:51.395596   48582 authentication.go:415] AnonymousAuth is not allowed with the AlwaysAllow authorizer. Resetting AnonymousAuth to false. You should use a different authorizer
W0613 05:53:51.396] I0613 05:53:51.396319   48582 server.go:147] Version: v1.16.0-alpha.0.930+7754bc7e531a5b
W0613 05:53:52.093] I0613 05:53:52.087475   48582 plugins.go:158] Loaded 4 mutating admission controller(s) successfully in the following order: NamespaceLifecycle,LimitRanger,TaintNodesByCondition,Priority.
W0613 05:53:52.094] I0613 05:53:52.087514   48582 plugins.go:161] Loaded 4 validating admission controller(s) successfully in the following order: LimitRanger,Priority,PersistentVolumeClaimResize,ResourceQuota.
W0613 05:53:52.094] E0613 05:53:52.088079   48582 prometheus.go:55] failed to register depth metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:52.095] E0613 05:53:52.088106   48582 prometheus.go:68] failed to register adds metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:52.095] E0613 05:53:52.088126   48582 prometheus.go:82] failed to register latency metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:52.096] E0613 05:53:52.088140   48582 prometheus.go:96] failed to register workDuration metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:52.096] E0613 05:53:52.088157   48582 prometheus.go:112] failed to register unfinished metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:52.096] E0613 05:53:52.088171   48582 prometheus.go:126] failed to register unfinished metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:52.097] E0613 05:53:52.088183   48582 prometheus.go:152] failed to register depth metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:52.097] E0613 05:53:52.088193   48582 prometheus.go:164] failed to register adds metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:52.097] E0613 05:53:52.088231   48582 prometheus.go:176] failed to register latency metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:52.097] E0613 05:53:52.088329   48582 prometheus.go:188] failed to register work_duration metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:52.097] E0613 05:53:52.088361   48582 prometheus.go:203] failed to register unfinished_work_seconds metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:52.098] E0613 05:53:52.088376   48582 prometheus.go:216] failed to register longest_running_processor_microseconds metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:52.098] I0613 05:53:52.088393   48582 plugins.go:158] Loaded 4 mutating admission controller(s) successfully in the following order: NamespaceLifecycle,LimitRanger,TaintNodesByCondition,Priority.
W0613 05:53:52.098] I0613 05:53:52.088398   48582 plugins.go:161] Loaded 4 validating admission controller(s) successfully in the following order: LimitRanger,Priority,PersistentVolumeClaimResize,ResourceQuota.
W0613 05:53:52.098] I0613 05:53:52.089984   48582 client.go:354] parsed scheme: ""
W0613 05:53:52.098] I0613 05:53:52.089999   48582 client.go:354] scheme "" not registered, fallback to default scheme
W0613 05:53:52.098] I0613 05:53:52.090060   48582 asm_amd64.s:1337] ccResolverWrapper: sending new addresses to cc: [{127.0.0.1:2379 0  <nil>}]
W0613 05:53:52.098] I0613 05:53:52.090136   48582 asm_amd64.s:1337] balancerWrapper: got update addr from Notify: [{127.0.0.1:2379 <nil>}]
... skipping 361 lines ...
W0613 05:53:52.740] W0613 05:53:52.740006   48582 genericapiserver.go:351] Skipping API storage.k8s.io/v1alpha1 because it has no resources.
W0613 05:53:53.086] I0613 05:53:53.086071   48582 client.go:354] parsed scheme: ""
W0613 05:53:53.087] I0613 05:53:53.086251   48582 client.go:354] scheme "" not registered, fallback to default scheme
W0613 05:53:53.087] I0613 05:53:53.086574   48582 asm_amd64.s:1337] ccResolverWrapper: sending new addresses to cc: [{127.0.0.1:2379 0  <nil>}]
W0613 05:53:53.087] I0613 05:53:53.086707   48582 asm_amd64.s:1337] balancerWrapper: got update addr from Notify: [{127.0.0.1:2379 <nil>}]
W0613 05:53:53.087] I0613 05:53:53.087357   48582 asm_amd64.s:1337] balancerWrapper: got update addr from Notify: [{127.0.0.1:2379 <nil>}]
W0613 05:53:53.823] E0613 05:53:53.822796   48582 prometheus.go:55] failed to register depth metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:53.824] E0613 05:53:53.822974   48582 prometheus.go:68] failed to register adds metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:53.824] E0613 05:53:53.823039   48582 prometheus.go:82] failed to register latency metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:53.824] E0613 05:53:53.823095   48582 prometheus.go:96] failed to register workDuration metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:53.824] E0613 05:53:53.823133   48582 prometheus.go:112] failed to register unfinished metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:53.825] E0613 05:53:53.823167   48582 prometheus.go:126] failed to register unfinished metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:53.825] E0613 05:53:53.823182   48582 prometheus.go:152] failed to register depth metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:53.825] E0613 05:53:53.823195   48582 prometheus.go:164] failed to register adds metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:53.825] E0613 05:53:53.823241   48582 prometheus.go:176] failed to register latency metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:53.825] E0613 05:53:53.823291   48582 prometheus.go:188] failed to register work_duration metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:53.826] E0613 05:53:53.823313   48582 prometheus.go:203] failed to register unfinished_work_seconds metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:53.826] E0613 05:53:53.823328   48582 prometheus.go:216] failed to register longest_running_processor_microseconds metric admission_quota_controller: duplicate metrics collector registration attempted
W0613 05:53:53.826] I0613 05:53:53.823362   48582 plugins.go:158] Loaded 4 mutating admission controller(s) successfully in the following order: NamespaceLifecycle,LimitRanger,TaintNodesByCondition,Priority.
W0613 05:53:53.826] I0613 05:53:53.823372   48582 plugins.go:161] Loaded 4 validating admission controller(s) successfully in the following order: LimitRanger,Priority,PersistentVolumeClaimResize,ResourceQuota.
W0613 05:53:53.826] I0613 05:53:53.824995   48582 client.go:354] parsed scheme: ""
W0613 05:53:53.826] I0613 05:53:53.825015   48582 client.go:354] scheme "" not registered, fallback to default scheme
W0613 05:53:53.826] I0613 05:53:53.825061   48582 asm_amd64.s:1337] ccResolverWrapper: sending new addresses to cc: [{127.0.0.1:2379 0  <nil>}]
W0613 05:53:53.827] I0613 05:53:53.825275   48582 asm_amd64.s:1337] balancerWrapper: got update addr from Notify: [{127.0.0.1:2379 <nil>}]
... skipping 83 lines ...
W0613 05:54:34.209] I0613 05:54:33.999730   51940 cleaner.go:81] Starting CSR cleaner controller
W0613 05:54:34.209] I0613 05:54:33.999782   51940 job_controller.go:143] Starting job controller
W0613 05:54:34.209] I0613 05:54:33.999949   51940 controller_utils.go:1029] Waiting for caches to sync for job controller
W0613 05:54:34.209] I0613 05:54:33.999804   51940 replica_set.go:182] Starting replicaset controller
W0613 05:54:34.209] I0613 05:54:33.999973   51940 controller_utils.go:1029] Waiting for caches to sync for ReplicaSet controller
W0613 05:54:34.210] I0613 05:54:34.000314   51940 node_lifecycle_controller.go:77] Sending events to api server
W0613 05:54:34.210] E0613 05:54:34.000412   51940 core.go:160] failed to start cloud node lifecycle controller: no cloud provider provided
W0613 05:54:34.210] W0613 05:54:34.000516   51940 controllermanager.go:524] Skipping "cloud-node-lifecycle"
W0613 05:54:34.210] I0613 05:54:34.001095   51940 controllermanager.go:532] Started "clusterrole-aggregation"
W0613 05:54:34.210] I0613 05:54:34.001163   51940 clusterroleaggregation_controller.go:148] Starting ClusterRoleAggregator
W0613 05:54:34.210] I0613 05:54:34.001194   51940 controller_utils.go:1029] Waiting for caches to sync for ClusterRoleAggregator controller
W0613 05:54:34.210] I0613 05:54:34.001919   51940 controllermanager.go:532] Started "endpoint"
W0613 05:54:34.211] I0613 05:54:34.001961   51940 endpoints_controller.go:166] Starting endpoint controller
... skipping 133 lines ...
W0613 05:54:34.651] I0613 05:54:34.650771   51940 controllermanager.go:532] Started "serviceaccount"
W0613 05:54:34.651] I0613 05:54:34.650868   51940 serviceaccounts_controller.go:117] Starting service account controller
W0613 05:54:34.651] I0613 05:54:34.650893   51940 controller_utils.go:1029] Waiting for caches to sync for service account controller
W0613 05:54:34.652] I0613 05:54:34.651966   51940 controllermanager.go:532] Started "statefulset"
W0613 05:54:34.652] I0613 05:54:34.652103   51940 stateful_set.go:145] Starting stateful set controller
W0613 05:54:34.652] I0613 05:54:34.652126   51940 controller_utils.go:1029] Waiting for caches to sync for stateful set controller
W0613 05:54:34.653] E0613 05:54:34.653124   51940 core.go:76] Failed to start service controller: WARNING: no cloud provider provided, services of type LoadBalancer will fail
W0613 05:54:34.653] W0613 05:54:34.653147   51940 controllermanager.go:524] Skipping "service"
W0613 05:54:34.653] W0613 05:54:34.653157   51940 controllermanager.go:524] Skipping "root-ca-cert-publisher"
W0613 05:54:34.654] I0613 05:54:34.654364   51940 controllermanager.go:532] Started "horizontalpodautoscaling"
W0613 05:54:34.654] I0613 05:54:34.654487   51940 horizontal.go:156] Starting HPA controller
W0613 05:54:34.654] I0613 05:54:34.654513   51940 controller_utils.go:1029] Waiting for caches to sync for HPA controller
W0613 05:54:34.656] I0613 05:54:34.655606   51940 controllermanager.go:532] Started "disruption"
... skipping 6 lines ...
W0613 05:54:34.661] I0613 05:54:34.657153   51940 node_lifecycle_controller.go:401] Controller will taint node by condition.
W0613 05:54:34.661] I0613 05:54:34.657178   51940 controllermanager.go:532] Started "nodelifecycle"
W0613 05:54:34.661] I0613 05:54:34.657963   51940 node_lifecycle_controller.go:425] Starting node controller
W0613 05:54:34.661] I0613 05:54:34.658020   51940 controller_utils.go:1029] Waiting for caches to sync for taint controller
W0613 05:54:34.700] I0613 05:54:34.700062   51940 controller_utils.go:1036] Caches are synced for ReplicaSet controller
W0613 05:54:34.705] I0613 05:54:34.704234   51940 controller_utils.go:1036] Caches are synced for PV protection controller
W0613 05:54:34.713] W0613 05:54:34.713132   51940 actual_state_of_world.go:506] Failed to update statusUpdateNeeded field in actual state of world: Failed to set statusUpdateNeeded to needed true, because nodeName="127.0.0.1" does not exist
W0613 05:54:34.727] W0613 05:54:34.726855   52090 flags.go:39] log_backtrace_at is DEPRECATED and will be removed in a future version. Use log-backtrace-at instead.
W0613 05:54:34.727] W0613 05:54:34.727038   52090 flags.go:39] log_backtrace_at is DEPRECATED and will be removed in a future version. Use log-backtrace-at instead.
W0613 05:54:34.728] W0613 05:54:34.727058   52090 flags.go:39] log_dir is DEPRECATED and will be removed in a future version. Use log-dir instead.
W0613 05:54:34.728] W0613 05:54:34.727079   52090 flags.go:39] log_dir is DEPRECATED and will be removed in a future version. Use log-dir instead.
W0613 05:54:34.728] W0613 05:54:34.727102   52090 flags.go:39] log_file is DEPRECATED and will be removed in a future version. Use log-file instead.
W0613 05:54:34.728] W0613 05:54:34.727122   52090 flags.go:39] log_file is DEPRECATED and will be removed in a future version. Use log-file instead.
... skipping 18 lines ...
W0613 05:54:34.812] W0613 05:54:34.812149   52103 flags.go:39] log_file_max_size is DEPRECATED and will be removed in a future version. Use log-file-max-size instead.
W0613 05:54:34.812] W0613 05:54:34.812559   52103 flags.go:39] log_file_max_size is DEPRECATED and will be removed in a future version. Use log-file-max-size instead.
W0613 05:54:34.813] W0613 05:54:34.812959   52103 flags.go:39] skip_headers is DEPRECATED and will be removed in a future version. Use skip-headers instead.
W0613 05:54:34.813] W0613 05:54:34.813343   52103 flags.go:39] skip_headers is DEPRECATED and will be removed in a future version. Use skip-headers instead.
W0613 05:54:34.813] W0613 05:54:34.813735   52103 flags.go:39] skip_log_headers is DEPRECATED and will be removed in a future version. Use skip-log-headers instead.
W0613 05:54:34.814] W0613 05:54:34.814115   52103 flags.go:39] skip_log_headers is DEPRECATED and will be removed in a future version. Use skip-log-headers instead.
W0613 05:54:34.825] E0613 05:54:34.824933   51940 clusterroleaggregation_controller.go:180] edit failed with : Operation cannot be fulfilled on clusterroles.rbac.authorization.k8s.io "edit": the object has been modified; please apply your changes to the latest version and try again
W0613 05:54:34.826] E0613 05:54:34.825144   51940 clusterroleaggregation_controller.go:180] view failed with : Operation cannot be fulfilled on clusterroles.rbac.authorization.k8s.io "view": the object has been modified; please apply your changes to the latest version and try again
W0613 05:54:34.837] E0613 05:54:34.837272   51940 clusterroleaggregation_controller.go:180] edit failed with : Operation cannot be fulfilled on clusterroles.rbac.authorization.k8s.io "edit": the object has been modified; please apply your changes to the latest version and try again
W0613 05:54:34.856] I0613 05:54:34.855917   51940 controller_utils.go:1036] Caches are synced for disruption controller
W0613 05:54:34.856] I0613 05:54:34.855949   51940 disruption.go:341] Sending events to api server.
W0613 05:54:34.899] W0613 05:54:34.898359   52117 flags.go:39] log_backtrace_at is DEPRECATED and will be removed in a future version. Use log-backtrace-at instead.
W0613 05:54:34.899] W0613 05:54:34.898843   52117 flags.go:39] log_backtrace_at is DEPRECATED and will be removed in a future version. Use log-backtrace-at instead.
W0613 05:54:34.899] W0613 05:54:34.899045   52117 flags.go:39] log_dir is DEPRECATED and will be removed in a future version. Use log-dir instead.
W0613 05:54:34.899] W0613 05:54:34.899111   52117 flags.go:39] log_dir is DEPRECATED and will be removed in a future version. Use log-dir instead.
... skipping 320 lines ...
W0613 05:55:07.547] !!! [0613 05:55:07]  1: /go/src/k8s.io/kubernetes/test/cmd/../../test/cmd/proxy.sh:27 start-proxy(...)
W0613 05:55:07.550] !!! [0613 05:55:07]  2: /go/src/k8s.io/kubernetes/test/cmd/../../third_party/forked/shell2junit/sh2ju.sh:47 run_kubectl_local_proxy_tests(...)
W0613 05:55:07.555] !!! [0613 05:55:07]  3: /go/src/k8s.io/kubernetes/test/cmd/../../third_party/forked/shell2junit/sh2ju.sh:112 eVal(...)
W0613 05:55:07.558] !!! [0613 05:55:07]  4: /go/src/k8s.io/kubernetes/test/cmd/legacy-script.sh:136 juLog(...)
W0613 05:55:07.561] !!! [0613 05:55:07]  5: /go/src/k8s.io/kubernetes/test/cmd/legacy-script.sh:426 record_command(...)
W0613 05:55:07.565] !!! [0613 05:55:07]  6: hack/make-rules/test-cmd.sh:134 runTests(...)
W0613 06:10:02.084] E0613 06:10:02.083510   48582 watcher.go:214] watch chan error: etcdserver: mvcc: required revision has been compacted
W0613 06:10:02.085] W0613 06:10:02.084128   51940 reflector.go:302] k8s.io/client-go/informers/factory.go:133: watch of *v1beta1.Event ended with: The resourceVersion for the provided watch is too old.
W0613 06:19:53.097] E0613 06:19:53.096238   48582 watcher.go:214] watch chan error: etcdserver: mvcc: required revision has been compacted
W0613 06:19:53.098] W0613 06:19:53.096987   51940 reflector.go:302] k8s.io/client-go/informers/factory.go:133: watch of *v1beta1.Event ended with: The resourceVersion for the provided watch is too old.
W0613 06:33:20.121] E0613 06:33:20.119875   48582 watcher.go:214] watch chan error: etcdserver: mvcc: required revision has been compacted
W0613 06:33:20.124] W0613 06:33:20.124098   51940 reflector.go:302] k8s.io/client-go/informers/factory.go:133: watch of *v1beta1.Event ended with: The resourceVersion for the provided watch is too old.
W0613 06:40:44.203] E0613 06:40:44.202619   48582 watcher.go:214] watch chan error: etcdserver: mvcc: required revision has been compacted
W0613 06:40:44.204] W0613 06:40:44.203104   51940 reflector.go:302] k8s.io/client-go/informers/factory.go:133: watch of *v1beta1.Event ended with: The resourceVersion for the provided watch is too old.
I0613 06:44:56.574] Terminate 656 on timeout
E0613 06:44:56.676] Build timed out
E0613 06:44:56.676] Command failed
I0613 06:44:56.677] process 656 exited with code -15 after 59.0m
E0613 06:44:56.677] FAIL: pull-kubernetes-integration
I0613 06:44:56.677] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0613 06:44:57.294] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0613 06:44:57.353] process 53750 exited with code 0 after 0.0m
I0613 06:44:57.354] Call:  gcloud config get-value account
I0613 06:44:57.701] process 53762 exited with code 0 after 0.0m
I0613 06:44:57.702] Will upload results to gs://kubernetes-jenkins/pr-logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0613 06:44:57.702] Upload result and artifacts...
I0613 06:44:57.702] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/pr-logs/pull/78619/pull-kubernetes-integration/1139045699220934656
I0613 06:44:57.703] Call:  gsutil ls gs://kubernetes-jenkins/pr-logs/pull/78619/pull-kubernetes-integration/1139045699220934656/artifacts
W0613 06:44:58.955] CommandException: One or more URLs matched no objects.
E0613 06:44:59.114] Command failed
I0613 06:44:59.114] process 53774 exited with code 1 after 0.0m
W0613 06:44:59.114] Remote dir gs://kubernetes-jenkins/pr-logs/pull/78619/pull-kubernetes-integration/1139045699220934656/artifacts not exist yet
I0613 06:44:59.114] Call:  gsutil -m -q -o GSUtil:use_magicfile=True cp -r -c -z log,txt,xml /workspace/_artifacts gs://kubernetes-jenkins/pr-logs/pull/78619/pull-kubernetes-integration/1139045699220934656/artifacts
I0613 06:45:01.346] process 53916 exited with code 0 after 0.0m
W0613 06:45:01.346] metadata path /workspace/_artifacts/metadata.json does not exist
W0613 06:45:01.346] metadata not found or invalid, init with empty metadata
... skipping 23 lines ...