sigs.k8s.io/cloud-provider-azure PR #269 chewong-cloud-provider-azure-multiple-zones #1205270407788105728
Recent runs || View in Spyglass
Recent runs || View in Spyglass
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-16147365-vmssCSE'. Error message: \\\"Enable failed: failed to execute command: command terminated with exit status=14\\n[stdout]\\nFri Dec 13 00:07:18 UTC 2019,k8s-master-16147365-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
Build
Deferred TearDown
DumpClusterLogs (--up failed)
TearDown Previous
Timeout
... skipping 518 lines ... I1212 23:38:31.017] .../coreos => go.etcd.io}/etcd/clientv3/sort.go | 0 I1212 23:38:31.017] .../coreos => go.etcd.io}/etcd/clientv3/txn.go | 2 +- I1212 23:38:31.017] vendor/go.etcd.io/etcd/clientv3/utils.go | 49 + I1212 23:38:31.017] .../coreos => go.etcd.io}/etcd/clientv3/watch.go | 219 +- I1212 23:38:31.017] .../etcd/etcdserver/api/v3rpc/rpctypes/BUILD.bazel | 5 +- I1212 23:38:31.017] .../etcd/etcdserver/api/v3rpc/rpctypes/doc.go | 0 I1212 23:38:31.017] .../etcd/etcdserver/api/v3rpc/rpctypes/error.go | 20 + I1212 23:38:31.017] .../etcd/etcdserver/api/v3rpc/rpctypes/md.go | 0 I1212 23:38:31.017] .../api/v3rpc/rpctypes/metadatafields.go | 20 + I1212 23:38:31.018] .../etcd/etcdserver/etcdserverpb/BUILD.bazel | 8 +- I1212 23:38:31.018] .../etcd/etcdserver/etcdserverpb/etcdserver.pb.go | 6 + I1212 23:38:31.018] .../etcd/etcdserver/etcdserverpb/etcdserver.proto | 0 I1212 23:38:31.018] .../etcdserver/etcdserverpb/raft_internal.pb.go | 226 +- ... skipping 76 lines ... I1212 23:38:31.026] vendor/go.uber.org/atomic/BUILD.bazel | 12 + I1212 23:38:31.026] vendor/go.uber.org/atomic/LICENSE.txt | 19 + I1212 23:38:31.026] vendor/go.uber.org/atomic/atomic.go | 351 + I1212 23:38:31.026] vendor/go.uber.org/atomic/string.go | 49 + I1212 23:38:31.026] vendor/go.uber.org/multierr/BUILD.bazel | 10 + I1212 23:38:31.026] vendor/go.uber.org/multierr/LICENSE.txt | 19 + I1212 23:38:31.027] vendor/go.uber.org/multierr/error.go | 401 + I1212 23:38:31.027] vendor/go.uber.org/zap/BUILD.bazel | 35 + I1212 23:38:31.027] vendor/go.uber.org/zap/LICENSE.txt | 19 + I1212 23:38:31.027] vendor/go.uber.org/zap/array.go | 320 + I1212 23:38:31.027] vendor/go.uber.org/zap/buffer/BUILD.bazel | 12 + I1212 23:38:31.027] vendor/go.uber.org/zap/buffer/buffer.go | 115 + I1212 23:38:31.027] vendor/go.uber.org/zap/buffer/pool.go | 49 + I1212 23:38:31.027] vendor/go.uber.org/zap/config.go | 243 + I1212 23:38:31.027] vendor/go.uber.org/zap/doc.go | 113 + I1212 23:38:31.027] vendor/go.uber.org/zap/encoder.go | 75 + I1212 23:38:31.028] vendor/go.uber.org/zap/error.go | 80 + I1212 23:38:31.028] vendor/go.uber.org/zap/field.go | 310 + I1212 23:38:31.028] vendor/go.uber.org/zap/flag.go | 39 + I1212 23:38:31.028] vendor/go.uber.org/zap/global.go | 168 + I1212 23:38:31.028] vendor/go.uber.org/zap/global_go112.go | 26 + I1212 23:38:31.028] vendor/go.uber.org/zap/global_prego112.go | 26 + I1212 23:38:31.028] vendor/go.uber.org/zap/http_handler.go | 81 + ... skipping 14 lines ... I1212 23:38:31.030] vendor/go.uber.org/zap/zapcore/BUILD.bazel | 34 + I1212 23:38:31.030] vendor/go.uber.org/zap/zapcore/console_encoder.go | 147 + I1212 23:38:31.030] vendor/go.uber.org/zap/zapcore/core.go | 113 + I1212 23:38:31.030] vendor/go.uber.org/zap/zapcore/doc.go | 24 + I1212 23:38:31.030] vendor/go.uber.org/zap/zapcore/encoder.go | 348 + I1212 23:38:31.030] vendor/go.uber.org/zap/zapcore/entry.go | 257 + I1212 23:38:31.030] vendor/go.uber.org/zap/zapcore/error.go | 120 + I1212 23:38:31.031] vendor/go.uber.org/zap/zapcore/field.go | 212 + I1212 23:38:31.031] vendor/go.uber.org/zap/zapcore/hook.go | 68 + I1212 23:38:31.031] vendor/go.uber.org/zap/zapcore/json_encoder.go | 505 ++ I1212 23:38:31.031] vendor/go.uber.org/zap/zapcore/level.go | 175 + I1212 23:38:31.031] vendor/go.uber.org/zap/zapcore/level_strings.go | 46 + I1212 23:38:31.031] vendor/go.uber.org/zap/zapcore/marshaler.go | 53 + ... skipping 989 lines ... I1212 23:38:31.139] rename vendor/{github.com/coreos => go.etcd.io}/etcd/clientv3/sort.go (100%) I1212 23:38:31.139] rename vendor/{github.com/coreos => go.etcd.io}/etcd/clientv3/txn.go (98%) I1212 23:38:31.139] create mode 100644 vendor/go.etcd.io/etcd/clientv3/utils.go I1212 23:38:31.139] rename vendor/{github.com/coreos => go.etcd.io}/etcd/clientv3/watch.go (77%) I1212 23:38:31.139] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/api/v3rpc/rpctypes/BUILD.bazel (65%) I1212 23:38:31.139] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/api/v3rpc/rpctypes/doc.go (100%) I1212 23:38:31.140] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/api/v3rpc/rpctypes/error.go (86%) I1212 23:38:31.140] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/api/v3rpc/rpctypes/md.go (100%) I1212 23:38:31.140] create mode 100644 vendor/go.etcd.io/etcd/etcdserver/api/v3rpc/rpctypes/metadatafields.go I1212 23:38:31.140] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/etcdserverpb/BUILD.bazel (64%) I1212 23:38:31.140] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/etcdserverpb/etcdserver.pb.go (99%) I1212 23:38:31.140] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/etcdserverpb/etcdserver.proto (100%) I1212 23:38:31.140] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/etcdserverpb/raft_internal.pb.go (86%) ... skipping 76 lines ... I1212 23:38:31.149] create mode 100644 vendor/go.uber.org/atomic/BUILD.bazel I1212 23:38:31.149] create mode 100644 vendor/go.uber.org/atomic/LICENSE.txt I1212 23:38:31.149] create mode 100644 vendor/go.uber.org/atomic/atomic.go I1212 23:38:31.149] create mode 100644 vendor/go.uber.org/atomic/string.go I1212 23:38:31.149] create mode 100644 vendor/go.uber.org/multierr/BUILD.bazel I1212 23:38:31.149] create mode 100644 vendor/go.uber.org/multierr/LICENSE.txt I1212 23:38:31.149] create mode 100644 vendor/go.uber.org/multierr/error.go I1212 23:38:31.149] create mode 100644 vendor/go.uber.org/zap/BUILD.bazel I1212 23:38:31.150] create mode 100644 vendor/go.uber.org/zap/LICENSE.txt I1212 23:38:31.150] create mode 100644 vendor/go.uber.org/zap/array.go I1212 23:38:31.150] create mode 100644 vendor/go.uber.org/zap/buffer/BUILD.bazel I1212 23:38:31.150] create mode 100644 vendor/go.uber.org/zap/buffer/buffer.go I1212 23:38:31.150] create mode 100644 vendor/go.uber.org/zap/buffer/pool.go I1212 23:38:31.150] create mode 100644 vendor/go.uber.org/zap/config.go I1212 23:38:31.150] create mode 100644 vendor/go.uber.org/zap/doc.go I1212 23:38:31.150] create mode 100644 vendor/go.uber.org/zap/encoder.go I1212 23:38:31.150] create mode 100644 vendor/go.uber.org/zap/error.go I1212 23:38:31.150] create mode 100644 vendor/go.uber.org/zap/field.go I1212 23:38:31.151] create mode 100644 vendor/go.uber.org/zap/flag.go I1212 23:38:31.151] create mode 100644 vendor/go.uber.org/zap/global.go I1212 23:38:31.151] create mode 100644 vendor/go.uber.org/zap/global_go112.go I1212 23:38:31.151] create mode 100644 vendor/go.uber.org/zap/global_prego112.go I1212 23:38:31.151] create mode 100644 vendor/go.uber.org/zap/http_handler.go ... skipping 14 lines ... I1212 23:38:31.152] create mode 100644 vendor/go.uber.org/zap/zapcore/BUILD.bazel I1212 23:38:31.153] create mode 100644 vendor/go.uber.org/zap/zapcore/console_encoder.go I1212 23:38:31.153] create mode 100644 vendor/go.uber.org/zap/zapcore/core.go I1212 23:38:31.153] create mode 100644 vendor/go.uber.org/zap/zapcore/doc.go I1212 23:38:31.153] create mode 100644 vendor/go.uber.org/zap/zapcore/encoder.go I1212 23:38:31.153] create mode 100644 vendor/go.uber.org/zap/zapcore/entry.go I1212 23:38:31.153] create mode 100644 vendor/go.uber.org/zap/zapcore/error.go I1212 23:38:31.153] create mode 100644 vendor/go.uber.org/zap/zapcore/field.go I1212 23:38:31.154] create mode 100644 vendor/go.uber.org/zap/zapcore/hook.go I1212 23:38:31.154] create mode 100644 vendor/go.uber.org/zap/zapcore/json_encoder.go I1212 23:38:31.154] create mode 100644 vendor/go.uber.org/zap/zapcore/level.go I1212 23:38:31.154] create mode 100644 vendor/go.uber.org/zap/zapcore/level_strings.go I1212 23:38:31.154] create mode 100644 vendor/go.uber.org/zap/zapcore/marshaler.go ... skipping 526 lines ... I1213 00:22:27.523] daemonset.apps "log-dump-node" deleted W1213 00:22:27.624] 2019/12/13 00:22:27 process.go:155: Step 'bash -c ./log-dump.sh' finished in 43.237343956s W1213 00:22:27.624] 2019/12/13 00:22:27 azure.go:1147: Deleting resource group: kubetest-83a4e91b-1d38-11ea-9333-0242b804e184. W1213 00:29:12.999] 2019/12/13 00:29:12 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml. W1213 00:29:13.000] 2019/12/13 00:29:12 process.go:153: Running: bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}" W1213 00:29:13.770] 2019/12/13 00:29:13 process.go:155: Step 'bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}"' finished in 769.98946ms W1213 00:29:13.770] 2019/12/13 00:29:13 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-16147365-vmssCSE'. Error message: \\\"Enable failed: failed to execute command: command terminated with exit status=14\\n[stdout]\\nFri Dec 13 00:07:18 UTC 2019,k8s-master-16147365-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 00:29:13.771] Traceback (most recent call last): W1213 00:29:13.772] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 778, in <module> W1213 00:29:13.772] main(parse_args()) W1213 00:29:13.773] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 626, in main W1213 00:29:13.773] mode.start(runner_args) W1213 00:29:13.773] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 262, in start W1213 00:29:13.773] check_env(env, self.command, *args) W1213 00:29:13.773] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env W1213 00:29:13.773] subprocess.check_call(cmd, env=env) W1213 00:29:13.773] File "/usr/lib/python2.7/subprocess.py", line 190, in check_call W1213 00:29:13.774] raise CalledProcessError(retcode, cmd) W1213 00:29:13.775] 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 00:29:13.780] Command failed I1213 00:29:13.781] process 709 exited with code 1 after 50.6m E1213 00:29:13.781] FAIL: chewong-cloud-provider-azure-multiple-zones I1213 00:29:13.781] Call: gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json W1213 00:29:14.839] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com] I1213 00:29:14.872] process 31872 exited with code 0 after 0.0m I1213 00:29:14.872] Call: gcloud config get-value account I1213 00:29:15.115] process 31885 exited with code 0 after 0.0m I1213 00:29:15.115] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com I1213 00:29:15.115] Upload result and artifacts... I1213 00:29:15.115] 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/1205270407788105728 I1213 00:29:15.116] Call: gsutil ls gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_cloud-provider-azure/269/chewong-cloud-provider-azure-multiple-zones/1205270407788105728/artifacts W1213 00:29:16.299] CommandException: One or more URLs matched no objects. E1213 00:29:16.379] Command failed I1213 00:29:16.380] process 31898 exited with code 1 after 0.0m W1213 00:29:16.380] Remote dir gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_cloud-provider-azure/269/chewong-cloud-provider-azure-multiple-zones/1205270407788105728/artifacts not exist yet I1213 00:29:16.380] 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/1205270407788105728/artifacts I1213 00:29:18.639] process 32043 exited with code 0 after 0.0m I1213 00:29:18.639] Call: git rev-parse HEAD I1213 00:29:18.642] process 32711 exited with code 0 after 0.0m ... skipping 21 lines ...