ResultFAILURE
Tests 1 failed / 5 succeeded
Started2019-12-13 00:33
Elapsed50m3s
Revision
Builder18d333b4-1d40-11ea-b3d3-b20db476995a
infra-commit78c32e52a
job-versionv1.17.1-beta.0.5+512f09638c517a-dirty
repok8s.io/kubernetes
repo-commit512f09638c517ad6375070af15af905ac00051a7
repos{u'k8s.io/kubernetes': u'release-1.17', u'sigs.k8s.io/cloud-provider-azure': u'master:8074fd7b7993847c0086cccf276c4dca0d85710e,269:78faf930c955aa068242620244b907dfa0a599ad'}
revisionv1.17.1-beta.0.5+512f09638c517a-dirty

Test Failures


Up 25m28s

error creating cluster: cannot deploy: cannot get the create deployment future response: Code="DeploymentFailed" Message="At least one resource deployment operation failed. Please list deployment operations for details. Please see https://aka.ms/DeployOperations for usage details." Details=[{"code":"Conflict","message":"{\r\n  \"status\": \"Failed\",\r\n  \"error\": {\r\n    \"code\": \"ResourceDeploymentFailure\",\r\n    \"message\": \"The resource operation completed with terminal provisioning state 'Failed'.\",\r\n    \"details\": [\r\n      {\r\n        \"code\": \"VMExtensionProvisioningError\",\r\n        \"message\": \"VM has reported a failure when processing extension 'k8s-master-39019275-vmssCSE'. Error message: \\\"Enable failed: failed to execute command: command terminated with exit status=14\\n[stdout]\\nFri Dec 13 01:01:51 UTC 2019,k8s-master-39019275-vmss000005\\n\\n[stderr]\\n\\\"\\r\\n\\r\\nMore information on troubleshooting is available at https://aka.ms/VMExtensionCSELinuxTroubleshoot \"\r\n      }\r\n    ]\r\n  }\r\n}"}]
				from junit_runner.xml

Filter through log files


Show 5 Passed Tests

Error lines from build-log.txt

... skipping 518 lines ...
I1213 00:34:34.988]  .../coreos => go.etcd.io}/etcd/clientv3/sort.go    |    0
I1213 00:34:34.988]  .../coreos => go.etcd.io}/etcd/clientv3/txn.go     |    2 +-
I1213 00:34:34.988]  vendor/go.etcd.io/etcd/clientv3/utils.go           |   49 +
I1213 00:34:34.988]  .../coreos => go.etcd.io}/etcd/clientv3/watch.go   |  219 +-
I1213 00:34:34.989]  .../etcd/etcdserver/api/v3rpc/rpctypes/BUILD.bazel |    5 +-
I1213 00:34:34.989]  .../etcd/etcdserver/api/v3rpc/rpctypes/doc.go      |    0
I1213 00:34:34.989]  .../etcd/etcdserver/api/v3rpc/rpctypes/error.go    |   20 +
I1213 00:34:34.989]  .../etcd/etcdserver/api/v3rpc/rpctypes/md.go       |    0
I1213 00:34:34.989]  .../api/v3rpc/rpctypes/metadatafields.go           |   20 +
I1213 00:34:34.989]  .../etcd/etcdserver/etcdserverpb/BUILD.bazel       |    8 +-
I1213 00:34:34.989]  .../etcd/etcdserver/etcdserverpb/etcdserver.pb.go  |    6 +
I1213 00:34:34.990]  .../etcd/etcdserver/etcdserverpb/etcdserver.proto  |    0
I1213 00:34:34.990]  .../etcdserver/etcdserverpb/raft_internal.pb.go    |  226 +-
... skipping 76 lines ...
I1213 00:34:35.000]  vendor/go.uber.org/atomic/BUILD.bazel              |   12 +
I1213 00:34:35.001]  vendor/go.uber.org/atomic/LICENSE.txt              |   19 +
I1213 00:34:35.001]  vendor/go.uber.org/atomic/atomic.go                |  351 +
I1213 00:34:35.001]  vendor/go.uber.org/atomic/string.go                |   49 +
I1213 00:34:35.001]  vendor/go.uber.org/multierr/BUILD.bazel            |   10 +
I1213 00:34:35.001]  vendor/go.uber.org/multierr/LICENSE.txt            |   19 +
I1213 00:34:35.001]  vendor/go.uber.org/multierr/error.go               |  401 +
I1213 00:34:35.001]  vendor/go.uber.org/zap/BUILD.bazel                 |   35 +
I1213 00:34:35.001]  vendor/go.uber.org/zap/LICENSE.txt                 |   19 +
I1213 00:34:35.002]  vendor/go.uber.org/zap/array.go                    |  320 +
I1213 00:34:35.002]  vendor/go.uber.org/zap/buffer/BUILD.bazel          |   12 +
I1213 00:34:35.002]  vendor/go.uber.org/zap/buffer/buffer.go            |  115 +
I1213 00:34:35.002]  vendor/go.uber.org/zap/buffer/pool.go              |   49 +
I1213 00:34:35.002]  vendor/go.uber.org/zap/config.go                   |  243 +
I1213 00:34:35.002]  vendor/go.uber.org/zap/doc.go                      |  113 +
I1213 00:34:35.002]  vendor/go.uber.org/zap/encoder.go                  |   75 +
I1213 00:34:35.002]  vendor/go.uber.org/zap/error.go                    |   80 +
I1213 00:34:35.003]  vendor/go.uber.org/zap/field.go                    |  310 +
I1213 00:34:35.003]  vendor/go.uber.org/zap/flag.go                     |   39 +
I1213 00:34:35.003]  vendor/go.uber.org/zap/global.go                   |  168 +
I1213 00:34:35.003]  vendor/go.uber.org/zap/global_go112.go             |   26 +
I1213 00:34:35.003]  vendor/go.uber.org/zap/global_prego112.go          |   26 +
I1213 00:34:35.003]  vendor/go.uber.org/zap/http_handler.go             |   81 +
... skipping 14 lines ...
I1213 00:34:35.005]  vendor/go.uber.org/zap/zapcore/BUILD.bazel         |   34 +
I1213 00:34:35.005]  vendor/go.uber.org/zap/zapcore/console_encoder.go  |  147 +
I1213 00:34:35.005]  vendor/go.uber.org/zap/zapcore/core.go             |  113 +
I1213 00:34:35.005]  vendor/go.uber.org/zap/zapcore/doc.go              |   24 +
I1213 00:34:35.006]  vendor/go.uber.org/zap/zapcore/encoder.go          |  348 +
I1213 00:34:35.006]  vendor/go.uber.org/zap/zapcore/entry.go            |  257 +
I1213 00:34:35.006]  vendor/go.uber.org/zap/zapcore/error.go            |  120 +
I1213 00:34:35.006]  vendor/go.uber.org/zap/zapcore/field.go            |  212 +
I1213 00:34:35.006]  vendor/go.uber.org/zap/zapcore/hook.go             |   68 +
I1213 00:34:35.006]  vendor/go.uber.org/zap/zapcore/json_encoder.go     |  505 ++
I1213 00:34:35.006]  vendor/go.uber.org/zap/zapcore/level.go            |  175 +
I1213 00:34:35.006]  vendor/go.uber.org/zap/zapcore/level_strings.go    |   46 +
I1213 00:34:35.007]  vendor/go.uber.org/zap/zapcore/marshaler.go        |   53 +
... skipping 989 lines ...
I1213 00:34:35.126]  rename vendor/{github.com/coreos => go.etcd.io}/etcd/clientv3/sort.go (100%)
I1213 00:34:35.126]  rename vendor/{github.com/coreos => go.etcd.io}/etcd/clientv3/txn.go (98%)
I1213 00:34:35.126]  create mode 100644 vendor/go.etcd.io/etcd/clientv3/utils.go
I1213 00:34:35.127]  rename vendor/{github.com/coreos => go.etcd.io}/etcd/clientv3/watch.go (77%)
I1213 00:34:35.127]  rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/api/v3rpc/rpctypes/BUILD.bazel (65%)
I1213 00:34:35.127]  rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/api/v3rpc/rpctypes/doc.go (100%)
I1213 00:34:35.127]  rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/api/v3rpc/rpctypes/error.go (86%)
I1213 00:34:35.127]  rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/api/v3rpc/rpctypes/md.go (100%)
I1213 00:34:35.127]  create mode 100644 vendor/go.etcd.io/etcd/etcdserver/api/v3rpc/rpctypes/metadatafields.go
I1213 00:34:35.127]  rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/etcdserverpb/BUILD.bazel (64%)
I1213 00:34:35.127]  rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/etcdserverpb/etcdserver.pb.go (99%)
I1213 00:34:35.128]  rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/etcdserverpb/etcdserver.proto (100%)
I1213 00:34:35.128]  rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/etcdserverpb/raft_internal.pb.go (86%)
... skipping 76 lines ...
I1213 00:34:35.136]  create mode 100644 vendor/go.uber.org/atomic/BUILD.bazel
I1213 00:34:35.136]  create mode 100644 vendor/go.uber.org/atomic/LICENSE.txt
I1213 00:34:35.136]  create mode 100644 vendor/go.uber.org/atomic/atomic.go
I1213 00:34:35.137]  create mode 100644 vendor/go.uber.org/atomic/string.go
I1213 00:34:35.137]  create mode 100644 vendor/go.uber.org/multierr/BUILD.bazel
I1213 00:34:35.137]  create mode 100644 vendor/go.uber.org/multierr/LICENSE.txt
I1213 00:34:35.137]  create mode 100644 vendor/go.uber.org/multierr/error.go
I1213 00:34:35.137]  create mode 100644 vendor/go.uber.org/zap/BUILD.bazel
I1213 00:34:35.137]  create mode 100644 vendor/go.uber.org/zap/LICENSE.txt
I1213 00:34:35.137]  create mode 100644 vendor/go.uber.org/zap/array.go
I1213 00:34:35.137]  create mode 100644 vendor/go.uber.org/zap/buffer/BUILD.bazel
I1213 00:34:35.137]  create mode 100644 vendor/go.uber.org/zap/buffer/buffer.go
I1213 00:34:35.138]  create mode 100644 vendor/go.uber.org/zap/buffer/pool.go
I1213 00:34:35.138]  create mode 100644 vendor/go.uber.org/zap/config.go
I1213 00:34:35.138]  create mode 100644 vendor/go.uber.org/zap/doc.go
I1213 00:34:35.138]  create mode 100644 vendor/go.uber.org/zap/encoder.go
I1213 00:34:35.138]  create mode 100644 vendor/go.uber.org/zap/error.go
I1213 00:34:35.138]  create mode 100644 vendor/go.uber.org/zap/field.go
I1213 00:34:35.138]  create mode 100644 vendor/go.uber.org/zap/flag.go
I1213 00:34:35.138]  create mode 100644 vendor/go.uber.org/zap/global.go
I1213 00:34:35.138]  create mode 100644 vendor/go.uber.org/zap/global_go112.go
I1213 00:34:35.138]  create mode 100644 vendor/go.uber.org/zap/global_prego112.go
I1213 00:34:35.139]  create mode 100644 vendor/go.uber.org/zap/http_handler.go
... skipping 14 lines ...
I1213 00:34:35.140]  create mode 100644 vendor/go.uber.org/zap/zapcore/BUILD.bazel
I1213 00:34:35.140]  create mode 100644 vendor/go.uber.org/zap/zapcore/console_encoder.go
I1213 00:34:35.140]  create mode 100644 vendor/go.uber.org/zap/zapcore/core.go
I1213 00:34:35.140]  create mode 100644 vendor/go.uber.org/zap/zapcore/doc.go
I1213 00:34:35.141]  create mode 100644 vendor/go.uber.org/zap/zapcore/encoder.go
I1213 00:34:35.141]  create mode 100644 vendor/go.uber.org/zap/zapcore/entry.go
I1213 00:34:35.141]  create mode 100644 vendor/go.uber.org/zap/zapcore/error.go
I1213 00:34:35.141]  create mode 100644 vendor/go.uber.org/zap/zapcore/field.go
I1213 00:34:35.141]  create mode 100644 vendor/go.uber.org/zap/zapcore/hook.go
I1213 00:34:35.141]  create mode 100644 vendor/go.uber.org/zap/zapcore/json_encoder.go
I1213 00:34:35.141]  create mode 100644 vendor/go.uber.org/zap/zapcore/level.go
I1213 00:34:35.141]  create mode 100644 vendor/go.uber.org/zap/zapcore/level_strings.go
I1213 00:34:35.141]  create mode 100644 vendor/go.uber.org/zap/zapcore/marshaler.go
... skipping 526 lines ...
I1213 01:16:35.979] daemonset.apps "log-dump-node" deleted
W1213 01:16:36.080] 2019/12/13 01:16:35 process.go:155: Step 'bash -c ./log-dump.sh' finished in 43.305523427s
W1213 01:16:36.080] 2019/12/13 01:16:35 azure.go:1147: Deleting resource group: kubetest-58ac33c7-1d40-11ea-bec4-0242cf25eb67.
W1213 01:23:21.517] 2019/12/13 01:23:21 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml.
W1213 01:23:21.517] 2019/12/13 01:23:21 process.go:153: Running: bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}"
W1213 01:23:22.272] 2019/12/13 01:23:22 process.go:155: Step 'bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}"' finished in 754.972018ms
W1213 01:23:22.273] 2019/12/13 01:23:22 main.go:319: Something went wrong: starting e2e cluster: error creating cluster: cannot deploy: cannot get the create deployment future response: Code="DeploymentFailed" Message="At least one resource deployment operation failed. Please list deployment operations for details. Please see https://aka.ms/DeployOperations for usage details." Details=[{"code":"Conflict","message":"{\r\n  \"status\": \"Failed\",\r\n  \"error\": {\r\n    \"code\": \"ResourceDeploymentFailure\",\r\n    \"message\": \"The resource operation completed with terminal provisioning state 'Failed'.\",\r\n    \"details\": [\r\n      {\r\n        \"code\": \"VMExtensionProvisioningError\",\r\n        \"message\": \"VM has reported a failure when processing extension 'k8s-master-39019275-vmssCSE'. Error message: \\\"Enable failed: failed to execute command: command terminated with exit status=14\\n[stdout]\\nFri Dec 13 01:01:51 UTC 2019,k8s-master-39019275-vmss000005\\n\\n[stderr]\\n\\\"\\r\\n\\r\\nMore information on troubleshooting is available at https://aka.ms/VMExtensionCSELinuxTroubleshoot \"\r\n      }\r\n    ]\r\n  }\r\n}"}]
W1213 01:23:22.274] Traceback (most recent call last):
W1213 01:23:22.274]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 778, in <module>
W1213 01:23:22.274]     main(parse_args())
W1213 01:23:22.274]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 626, in main
W1213 01:23:22.275]     mode.start(runner_args)
W1213 01:23:22.275]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 262, in start
W1213 01:23:22.275]     check_env(env, self.command, *args)
W1213 01:23:22.275]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W1213 01:23:22.275]     subprocess.check_call(cmd, env=env)
W1213 01:23:22.275]   File "/usr/lib/python2.7/subprocess.py", line 190, in check_call
W1213 01:23:22.275]     raise CalledProcessError(retcode, cmd)
W1213 01:23:22.276] subprocess.CalledProcessError: Command '('kubetest', '--dump=/workspace/_artifacts', '--gcp-service-account=/etc/service-account/service-account.json', '--build=quick', '--up', '--down', '--test', '--deployment=aksengine', '--provider=skeleton', '--cluster=bootstrap-e2e', '--gcp-network=bootstrap-e2e', '--ginkgo-parallel=30', '--aksengine-agentpoolcount=2', '--aksengine-admin-username=azureuser', '--aksengine-creds=/etc/azure-cred/credentials', '--aksengine-orchestratorRelease=1.17', '--aksengine-mastervmsize=Standard_DS4_v2', '--aksengine-agentvmsize=Standard_D4s_v3', '--aksengine-ccm=True', '--aksengine-cnm=True', '--aksengine-deploy-custom-k8s=True', '--aksengine-location=westus2', '--aksengine-public-key=/etc/azure-ssh/azure-ssh-pub', '--aksengine-template-url=https://raw.githubusercontent.com/kubernetes-sigs/cloud-provider-azure/master/tests/k8s-azure/manifest/linux-vmss-multi-zones.json', '--aksengine-download-url=https://chuwon.blob.core.windows.net/aks-engine/aks-engine-master-linux-amd64.tar.gz', "--test_args=--ginkgo.skip=\\[Slow\\]|\\[Serial\\]|\\[Disruptive\\]|\\[Flaky\\]|\\[Feature:.+\\]|Network\\sshould\\sset\\sTCP\\sCLOSE_WAIT\\stimeout|Mount\\spropagation\\sshould\\spropagate\\smounts\\sto\\sthe\\shost|PodSecurityPolicy|PVC\\sProtection\\sVerify|should\\sprovide\\sbasic\\sidentity|should\\sadopt\\smatching\\sorphans\\sand\\srelease|should\\snot\\sdeadlock\\swhen\\sa\\spod's\\spredecessor\\sfails|should\\sperform\\srolling\\supdates\\sand\\sroll\\sbacks\\sof\\stemplate\\smodifications\\swith\\sPVCs|should\\sperform\\srolling\\supdates\\sand\\sroll\\sbacks\\sof\\stemplate\\smodifications|Services\\sshould\\sbe\\sable\\sto\\screate\\sa\\sfunctioning\\sNodePort\\sservice$|volumeMode\\sshould\\snot\\smount\\s/\\smap\\sunused\\svolumes\\sin\\sa\\spod", '--timeout=420m')' returned non-zero exit status 1
E1213 01:23:22.282] Command failed
I1213 01:23:22.282] process 707 exited with code 1 after 48.7m
E1213 01:23:22.282] FAIL: chewong-cloud-provider-azure-multiple-zones
I1213 01:23:22.282] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W1213 01:23:23.145] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com]
I1213 01:23:23.176] process 31990 exited with code 0 after 0.0m
I1213 01:23:23.176] Call:  gcloud config get-value account
I1213 01:23:23.422] process 32003 exited with code 0 after 0.0m
I1213 01:23:23.422] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com
I1213 01:23:23.422] Upload result and artifacts...
I1213 01:23:23.423] Gubernator results at https://gubernator.k8s.io/build/kubernetes-upstream/pr-logs/pull/sigs.k8s.io_cloud-provider-azure/269/chewong-cloud-provider-azure-multiple-zones/1205284500649545728
I1213 01:23:23.423] Call:  gsutil ls gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_cloud-provider-azure/269/chewong-cloud-provider-azure-multiple-zones/1205284500649545728/artifacts
W1213 01:23:24.461] CommandException: One or more URLs matched no objects.
E1213 01:23:24.547] Command failed
I1213 01:23:24.547] process 32016 exited with code 1 after 0.0m
W1213 01:23:24.548] Remote dir gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_cloud-provider-azure/269/chewong-cloud-provider-azure-multiple-zones/1205284500649545728/artifacts not exist yet
I1213 01:23:24.548] Call:  gsutil -m -q -o GSUtil:use_magicfile=True cp -r -c -z log,txt,xml /workspace/_artifacts gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_cloud-provider-azure/269/chewong-cloud-provider-azure-multiple-zones/1205284500649545728/artifacts
I1213 01:23:26.856] process 32161 exited with code 0 after 0.0m
I1213 01:23:26.857] Call:  git rev-parse HEAD
I1213 01:23:26.859] process 361 exited with code 0 after 0.0m
... skipping 21 lines ...