sigs.k8s.io/cloud-provider-azure PR #269 chewong-cloud-provider-azure-multiple-zones #1206644084245008384
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-33780007-vmssCSE'. Error message: \\\"Enable failed: failed to execute command: command terminated with exit status=14\\n[stdout]\\nMon Dec 16 19:09:57 UTC 2019,k8s-master-33780007-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 ... I1216 18:37:43.905] .../coreos => go.etcd.io}/etcd/clientv3/sort.go | 0 I1216 18:37:43.905] .../coreos => go.etcd.io}/etcd/clientv3/txn.go | 2 +- I1216 18:37:43.905] vendor/go.etcd.io/etcd/clientv3/utils.go | 49 + I1216 18:37:43.905] .../coreos => go.etcd.io}/etcd/clientv3/watch.go | 219 +- I1216 18:37:43.905] .../etcd/etcdserver/api/v3rpc/rpctypes/BUILD.bazel | 5 +- I1216 18:37:43.905] .../etcd/etcdserver/api/v3rpc/rpctypes/doc.go | 0 I1216 18:37:43.906] .../etcd/etcdserver/api/v3rpc/rpctypes/error.go | 20 + I1216 18:37:43.906] .../etcd/etcdserver/api/v3rpc/rpctypes/md.go | 0 I1216 18:37:43.906] .../api/v3rpc/rpctypes/metadatafields.go | 20 + I1216 18:37:43.906] .../etcd/etcdserver/etcdserverpb/BUILD.bazel | 8 +- I1216 18:37:43.906] .../etcd/etcdserver/etcdserverpb/etcdserver.pb.go | 6 + I1216 18:37:43.906] .../etcd/etcdserver/etcdserverpb/etcdserver.proto | 0 I1216 18:37:43.906] .../etcdserver/etcdserverpb/raft_internal.pb.go | 226 +- ... skipping 76 lines ... I1216 18:37:43.917] vendor/go.uber.org/atomic/BUILD.bazel | 12 + I1216 18:37:43.917] vendor/go.uber.org/atomic/LICENSE.txt | 19 + I1216 18:37:43.917] vendor/go.uber.org/atomic/atomic.go | 351 + I1216 18:37:43.917] vendor/go.uber.org/atomic/string.go | 49 + I1216 18:37:43.917] vendor/go.uber.org/multierr/BUILD.bazel | 10 + I1216 18:37:43.917] vendor/go.uber.org/multierr/LICENSE.txt | 19 + I1216 18:37:43.917] vendor/go.uber.org/multierr/error.go | 401 + I1216 18:37:43.917] vendor/go.uber.org/zap/BUILD.bazel | 35 + I1216 18:37:43.918] vendor/go.uber.org/zap/LICENSE.txt | 19 + I1216 18:37:43.918] vendor/go.uber.org/zap/array.go | 320 + I1216 18:37:43.918] vendor/go.uber.org/zap/buffer/BUILD.bazel | 12 + I1216 18:37:43.918] vendor/go.uber.org/zap/buffer/buffer.go | 115 + I1216 18:37:43.918] vendor/go.uber.org/zap/buffer/pool.go | 49 + I1216 18:37:43.918] vendor/go.uber.org/zap/config.go | 243 + I1216 18:37:43.918] vendor/go.uber.org/zap/doc.go | 113 + I1216 18:37:43.919] vendor/go.uber.org/zap/encoder.go | 75 + I1216 18:37:43.919] vendor/go.uber.org/zap/error.go | 80 + I1216 18:37:43.919] vendor/go.uber.org/zap/field.go | 310 + I1216 18:37:43.919] vendor/go.uber.org/zap/flag.go | 39 + I1216 18:37:43.919] vendor/go.uber.org/zap/global.go | 168 + I1216 18:37:43.919] vendor/go.uber.org/zap/global_go112.go | 26 + I1216 18:37:43.919] vendor/go.uber.org/zap/global_prego112.go | 26 + I1216 18:37:43.919] vendor/go.uber.org/zap/http_handler.go | 81 + ... skipping 14 lines ... I1216 18:37:43.922] vendor/go.uber.org/zap/zapcore/BUILD.bazel | 34 + I1216 18:37:43.922] vendor/go.uber.org/zap/zapcore/console_encoder.go | 147 + I1216 18:37:43.922] vendor/go.uber.org/zap/zapcore/core.go | 113 + I1216 18:37:43.922] vendor/go.uber.org/zap/zapcore/doc.go | 24 + I1216 18:37:43.922] vendor/go.uber.org/zap/zapcore/encoder.go | 348 + I1216 18:37:43.922] vendor/go.uber.org/zap/zapcore/entry.go | 257 + I1216 18:37:43.922] vendor/go.uber.org/zap/zapcore/error.go | 120 + I1216 18:37:43.923] vendor/go.uber.org/zap/zapcore/field.go | 212 + I1216 18:37:43.923] vendor/go.uber.org/zap/zapcore/hook.go | 68 + I1216 18:37:43.923] vendor/go.uber.org/zap/zapcore/json_encoder.go | 505 ++ I1216 18:37:43.923] vendor/go.uber.org/zap/zapcore/level.go | 175 + I1216 18:37:43.923] vendor/go.uber.org/zap/zapcore/level_strings.go | 46 + I1216 18:37:43.923] vendor/go.uber.org/zap/zapcore/marshaler.go | 53 + ... skipping 989 lines ... I1216 18:37:44.037] rename vendor/{github.com/coreos => go.etcd.io}/etcd/clientv3/sort.go (100%) I1216 18:37:44.037] rename vendor/{github.com/coreos => go.etcd.io}/etcd/clientv3/txn.go (98%) I1216 18:37:44.037] create mode 100644 vendor/go.etcd.io/etcd/clientv3/utils.go I1216 18:37:44.038] rename vendor/{github.com/coreos => go.etcd.io}/etcd/clientv3/watch.go (77%) I1216 18:37:44.038] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/api/v3rpc/rpctypes/BUILD.bazel (65%) I1216 18:37:44.038] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/api/v3rpc/rpctypes/doc.go (100%) I1216 18:37:44.038] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/api/v3rpc/rpctypes/error.go (86%) I1216 18:37:44.038] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/api/v3rpc/rpctypes/md.go (100%) I1216 18:37:44.038] create mode 100644 vendor/go.etcd.io/etcd/etcdserver/api/v3rpc/rpctypes/metadatafields.go I1216 18:37:44.038] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/etcdserverpb/BUILD.bazel (64%) I1216 18:37:44.039] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/etcdserverpb/etcdserver.pb.go (99%) I1216 18:37:44.039] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/etcdserverpb/etcdserver.proto (100%) I1216 18:37:44.039] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/etcdserverpb/raft_internal.pb.go (86%) ... skipping 76 lines ... I1216 18:37:44.049] create mode 100644 vendor/go.uber.org/atomic/BUILD.bazel I1216 18:37:44.049] create mode 100644 vendor/go.uber.org/atomic/LICENSE.txt I1216 18:37:44.049] create mode 100644 vendor/go.uber.org/atomic/atomic.go I1216 18:37:44.049] create mode 100644 vendor/go.uber.org/atomic/string.go I1216 18:37:44.049] create mode 100644 vendor/go.uber.org/multierr/BUILD.bazel I1216 18:37:44.049] create mode 100644 vendor/go.uber.org/multierr/LICENSE.txt I1216 18:37:44.049] create mode 100644 vendor/go.uber.org/multierr/error.go I1216 18:37:44.049] create mode 100644 vendor/go.uber.org/zap/BUILD.bazel I1216 18:37:44.050] create mode 100644 vendor/go.uber.org/zap/LICENSE.txt I1216 18:37:44.050] create mode 100644 vendor/go.uber.org/zap/array.go I1216 18:37:44.050] create mode 100644 vendor/go.uber.org/zap/buffer/BUILD.bazel I1216 18:37:44.050] create mode 100644 vendor/go.uber.org/zap/buffer/buffer.go I1216 18:37:44.050] create mode 100644 vendor/go.uber.org/zap/buffer/pool.go I1216 18:37:44.050] create mode 100644 vendor/go.uber.org/zap/config.go I1216 18:37:44.050] create mode 100644 vendor/go.uber.org/zap/doc.go I1216 18:37:44.050] create mode 100644 vendor/go.uber.org/zap/encoder.go I1216 18:37:44.050] create mode 100644 vendor/go.uber.org/zap/error.go I1216 18:37:44.051] create mode 100644 vendor/go.uber.org/zap/field.go I1216 18:37:44.051] create mode 100644 vendor/go.uber.org/zap/flag.go I1216 18:37:44.051] create mode 100644 vendor/go.uber.org/zap/global.go I1216 18:37:44.051] create mode 100644 vendor/go.uber.org/zap/global_go112.go I1216 18:37:44.051] create mode 100644 vendor/go.uber.org/zap/global_prego112.go I1216 18:37:44.051] create mode 100644 vendor/go.uber.org/zap/http_handler.go ... skipping 14 lines ... I1216 18:37:44.053] create mode 100644 vendor/go.uber.org/zap/zapcore/BUILD.bazel I1216 18:37:44.053] create mode 100644 vendor/go.uber.org/zap/zapcore/console_encoder.go I1216 18:37:44.053] create mode 100644 vendor/go.uber.org/zap/zapcore/core.go I1216 18:37:44.054] create mode 100644 vendor/go.uber.org/zap/zapcore/doc.go I1216 18:37:44.054] create mode 100644 vendor/go.uber.org/zap/zapcore/encoder.go I1216 18:37:44.054] create mode 100644 vendor/go.uber.org/zap/zapcore/entry.go I1216 18:37:44.054] create mode 100644 vendor/go.uber.org/zap/zapcore/error.go I1216 18:37:44.054] create mode 100644 vendor/go.uber.org/zap/zapcore/field.go I1216 18:37:44.054] create mode 100644 vendor/go.uber.org/zap/zapcore/hook.go I1216 18:37:44.054] create mode 100644 vendor/go.uber.org/zap/zapcore/json_encoder.go I1216 18:37:44.055] create mode 100644 vendor/go.uber.org/zap/zapcore/level.go I1216 18:37:44.055] create mode 100644 vendor/go.uber.org/zap/zapcore/level_strings.go I1216 18:37:44.055] create mode 100644 vendor/go.uber.org/zap/zapcore/marshaler.go ... skipping 516 lines ... I1216 19:23:49.162] daemonset.apps "log-dump-node" deleted W1216 19:23:49.263] 2019/12/16 19:23:49 process.go:155: Step 'bash -c ./log-dump.sh' finished in 42.538878343s W1216 19:23:49.263] 2019/12/16 19:23:49 azure.go:1147: Deleting resource group: kubetest-2878d719-2033-11ea-9620-024272829d85. W1216 19:38:35.345] 2019/12/16 19:38:35 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml. W1216 19:38:35.345] 2019/12/16 19:38:35 process.go:153: Running: bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}" W1216 19:38:36.073] 2019/12/16 19:38:36 process.go:155: Step 'bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}"' finished in 727.948711ms W1216 19:38:36.074] 2019/12/16 19:38:36 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-33780007-vmssCSE'. Error message: \\\"Enable failed: failed to execute command: command terminated with exit status=14\\n[stdout]\\nMon Dec 16 19:09:57 UTC 2019,k8s-master-33780007-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}"}] W1216 19:38:36.075] Traceback (most recent call last): W1216 19:38:36.075] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 778, in <module> W1216 19:38:36.076] main(parse_args()) W1216 19:38:36.076] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 626, in main W1216 19:38:36.076] mode.start(runner_args) W1216 19:38:36.076] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 262, in start W1216 19:38:36.076] check_env(env, self.command, *args) W1216 19:38:36.077] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env W1216 19:38:36.077] subprocess.check_call(cmd, env=env) W1216 19:38:36.077] File "/usr/lib/python2.7/subprocess.py", line 190, in check_call W1216 19:38:36.077] raise CalledProcessError(retcode, cmd) W1216 19:38:36.078] 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 E1216 19:38:36.081] Command failed I1216 19:38:36.082] process 698 exited with code 1 after 60.8m E1216 19:38:36.082] FAIL: chewong-cloud-provider-azure-multiple-zones I1216 19:38:36.082] Call: gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json W1216 19:38:36.651] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com] I1216 19:38:36.682] process 31832 exited with code 0 after 0.0m I1216 19:38:36.683] Call: gcloud config get-value account I1216 19:38:36.901] process 31845 exited with code 0 after 0.0m I1216 19:38:36.901] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com I1216 19:38:36.901] Upload result and artifacts... I1216 19:38:36.902] 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/1206644084245008384 I1216 19:38:36.902] Call: gsutil ls gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_cloud-provider-azure/269/chewong-cloud-provider-azure-multiple-zones/1206644084245008384/artifacts W1216 19:38:37.883] CommandException: One or more URLs matched no objects. E1216 19:38:37.965] Command failed I1216 19:38:37.966] process 31858 exited with code 1 after 0.0m W1216 19:38:37.966] Remote dir gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_cloud-provider-azure/269/chewong-cloud-provider-azure-multiple-zones/1206644084245008384/artifacts not exist yet I1216 19:38:37.966] 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/1206644084245008384/artifacts I1216 19:38:40.595] process 32003 exited with code 0 after 0.0m I1216 19:38:40.596] Call: git rev-parse HEAD I1216 19:38:40.598] process 32668 exited with code 0 after 0.0m ... skipping 21 lines ...