sigs.k8s.io/cloud-provider-azure PR #269 chewong-cloud-provider-azure-multiple-zones #1206641567662608384
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-25626108-vmssCSE'. Error message: \\\"Enable failed: failed to execute command: command terminated with exit status=14\\n[stdout]\\nMon Dec 16 18:56:24 UTC 2019,k8s-master-25626108-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:27:02.685] .../coreos => go.etcd.io}/etcd/clientv3/sort.go | 0 I1216 18:27:02.685] .../coreos => go.etcd.io}/etcd/clientv3/txn.go | 2 +- I1216 18:27:02.685] vendor/go.etcd.io/etcd/clientv3/utils.go | 49 + I1216 18:27:02.685] .../coreos => go.etcd.io}/etcd/clientv3/watch.go | 219 +- I1216 18:27:02.685] .../etcd/etcdserver/api/v3rpc/rpctypes/BUILD.bazel | 5 +- I1216 18:27:02.686] .../etcd/etcdserver/api/v3rpc/rpctypes/doc.go | 0 I1216 18:27:02.686] .../etcd/etcdserver/api/v3rpc/rpctypes/error.go | 20 + I1216 18:27:02.686] .../etcd/etcdserver/api/v3rpc/rpctypes/md.go | 0 I1216 18:27:02.686] .../api/v3rpc/rpctypes/metadatafields.go | 20 + I1216 18:27:02.686] .../etcd/etcdserver/etcdserverpb/BUILD.bazel | 8 +- I1216 18:27:02.686] .../etcd/etcdserver/etcdserverpb/etcdserver.pb.go | 6 + I1216 18:27:02.686] .../etcd/etcdserver/etcdserverpb/etcdserver.proto | 0 I1216 18:27:02.686] .../etcdserver/etcdserverpb/raft_internal.pb.go | 226 +- ... skipping 76 lines ... I1216 18:27:02.695] vendor/go.uber.org/atomic/BUILD.bazel | 12 + I1216 18:27:02.695] vendor/go.uber.org/atomic/LICENSE.txt | 19 + I1216 18:27:02.695] vendor/go.uber.org/atomic/atomic.go | 351 + I1216 18:27:02.695] vendor/go.uber.org/atomic/string.go | 49 + I1216 18:27:02.695] vendor/go.uber.org/multierr/BUILD.bazel | 10 + I1216 18:27:02.696] vendor/go.uber.org/multierr/LICENSE.txt | 19 + I1216 18:27:02.696] vendor/go.uber.org/multierr/error.go | 401 + I1216 18:27:02.696] vendor/go.uber.org/zap/BUILD.bazel | 35 + I1216 18:27:02.696] vendor/go.uber.org/zap/LICENSE.txt | 19 + I1216 18:27:02.696] vendor/go.uber.org/zap/array.go | 320 + I1216 18:27:02.696] vendor/go.uber.org/zap/buffer/BUILD.bazel | 12 + I1216 18:27:02.696] vendor/go.uber.org/zap/buffer/buffer.go | 115 + I1216 18:27:02.696] vendor/go.uber.org/zap/buffer/pool.go | 49 + I1216 18:27:02.696] vendor/go.uber.org/zap/config.go | 243 + I1216 18:27:02.696] vendor/go.uber.org/zap/doc.go | 113 + I1216 18:27:02.697] vendor/go.uber.org/zap/encoder.go | 75 + I1216 18:27:02.697] vendor/go.uber.org/zap/error.go | 80 + I1216 18:27:02.697] vendor/go.uber.org/zap/field.go | 310 + I1216 18:27:02.697] vendor/go.uber.org/zap/flag.go | 39 + I1216 18:27:02.697] vendor/go.uber.org/zap/global.go | 168 + I1216 18:27:02.697] vendor/go.uber.org/zap/global_go112.go | 26 + I1216 18:27:02.697] vendor/go.uber.org/zap/global_prego112.go | 26 + I1216 18:27:02.697] vendor/go.uber.org/zap/http_handler.go | 81 + ... skipping 14 lines ... I1216 18:27:02.699] vendor/go.uber.org/zap/zapcore/BUILD.bazel | 34 + I1216 18:27:02.699] vendor/go.uber.org/zap/zapcore/console_encoder.go | 147 + I1216 18:27:02.699] vendor/go.uber.org/zap/zapcore/core.go | 113 + I1216 18:27:02.699] vendor/go.uber.org/zap/zapcore/doc.go | 24 + I1216 18:27:02.699] vendor/go.uber.org/zap/zapcore/encoder.go | 348 + I1216 18:27:02.699] vendor/go.uber.org/zap/zapcore/entry.go | 257 + I1216 18:27:02.699] vendor/go.uber.org/zap/zapcore/error.go | 120 + I1216 18:27:02.700] vendor/go.uber.org/zap/zapcore/field.go | 212 + I1216 18:27:02.700] vendor/go.uber.org/zap/zapcore/hook.go | 68 + I1216 18:27:02.700] vendor/go.uber.org/zap/zapcore/json_encoder.go | 505 ++ I1216 18:27:02.700] vendor/go.uber.org/zap/zapcore/level.go | 175 + I1216 18:27:02.700] vendor/go.uber.org/zap/zapcore/level_strings.go | 46 + I1216 18:27:02.700] vendor/go.uber.org/zap/zapcore/marshaler.go | 53 + ... skipping 989 lines ... I1216 18:27:02.818] rename vendor/{github.com/coreos => go.etcd.io}/etcd/clientv3/sort.go (100%) I1216 18:27:02.818] rename vendor/{github.com/coreos => go.etcd.io}/etcd/clientv3/txn.go (98%) I1216 18:27:02.818] create mode 100644 vendor/go.etcd.io/etcd/clientv3/utils.go I1216 18:27:02.818] rename vendor/{github.com/coreos => go.etcd.io}/etcd/clientv3/watch.go (77%) I1216 18:27:02.818] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/api/v3rpc/rpctypes/BUILD.bazel (65%) I1216 18:27:02.818] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/api/v3rpc/rpctypes/doc.go (100%) I1216 18:27:02.819] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/api/v3rpc/rpctypes/error.go (86%) I1216 18:27:02.819] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/api/v3rpc/rpctypes/md.go (100%) I1216 18:27:02.819] create mode 100644 vendor/go.etcd.io/etcd/etcdserver/api/v3rpc/rpctypes/metadatafields.go I1216 18:27:02.819] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/etcdserverpb/BUILD.bazel (64%) I1216 18:27:02.819] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/etcdserverpb/etcdserver.pb.go (99%) I1216 18:27:02.819] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/etcdserverpb/etcdserver.proto (100%) I1216 18:27:02.819] rename vendor/{github.com/coreos => go.etcd.io}/etcd/etcdserver/etcdserverpb/raft_internal.pb.go (86%) ... skipping 76 lines ... I1216 18:27:02.831] create mode 100644 vendor/go.uber.org/atomic/BUILD.bazel I1216 18:27:02.831] create mode 100644 vendor/go.uber.org/atomic/LICENSE.txt I1216 18:27:02.832] create mode 100644 vendor/go.uber.org/atomic/atomic.go I1216 18:27:02.832] create mode 100644 vendor/go.uber.org/atomic/string.go I1216 18:27:02.832] create mode 100644 vendor/go.uber.org/multierr/BUILD.bazel I1216 18:27:02.832] create mode 100644 vendor/go.uber.org/multierr/LICENSE.txt I1216 18:27:02.832] create mode 100644 vendor/go.uber.org/multierr/error.go I1216 18:27:02.832] create mode 100644 vendor/go.uber.org/zap/BUILD.bazel I1216 18:27:02.832] create mode 100644 vendor/go.uber.org/zap/LICENSE.txt I1216 18:27:02.832] create mode 100644 vendor/go.uber.org/zap/array.go I1216 18:27:02.833] create mode 100644 vendor/go.uber.org/zap/buffer/BUILD.bazel I1216 18:27:02.833] create mode 100644 vendor/go.uber.org/zap/buffer/buffer.go I1216 18:27:02.833] create mode 100644 vendor/go.uber.org/zap/buffer/pool.go I1216 18:27:02.833] create mode 100644 vendor/go.uber.org/zap/config.go I1216 18:27:02.833] create mode 100644 vendor/go.uber.org/zap/doc.go I1216 18:27:02.833] create mode 100644 vendor/go.uber.org/zap/encoder.go I1216 18:27:02.834] create mode 100644 vendor/go.uber.org/zap/error.go I1216 18:27:02.834] create mode 100644 vendor/go.uber.org/zap/field.go I1216 18:27:02.834] create mode 100644 vendor/go.uber.org/zap/flag.go I1216 18:27:02.834] create mode 100644 vendor/go.uber.org/zap/global.go I1216 18:27:02.834] create mode 100644 vendor/go.uber.org/zap/global_go112.go I1216 18:27:02.834] create mode 100644 vendor/go.uber.org/zap/global_prego112.go I1216 18:27:02.834] create mode 100644 vendor/go.uber.org/zap/http_handler.go ... skipping 14 lines ... I1216 18:27:02.836] create mode 100644 vendor/go.uber.org/zap/zapcore/BUILD.bazel I1216 18:27:02.836] create mode 100644 vendor/go.uber.org/zap/zapcore/console_encoder.go I1216 18:27:02.837] create mode 100644 vendor/go.uber.org/zap/zapcore/core.go I1216 18:27:02.837] create mode 100644 vendor/go.uber.org/zap/zapcore/doc.go I1216 18:27:02.837] create mode 100644 vendor/go.uber.org/zap/zapcore/encoder.go I1216 18:27:02.837] create mode 100644 vendor/go.uber.org/zap/zapcore/entry.go I1216 18:27:02.837] create mode 100644 vendor/go.uber.org/zap/zapcore/error.go I1216 18:27:02.837] create mode 100644 vendor/go.uber.org/zap/zapcore/field.go I1216 18:27:02.837] create mode 100644 vendor/go.uber.org/zap/zapcore/hook.go I1216 18:27:02.838] create mode 100644 vendor/go.uber.org/zap/zapcore/json_encoder.go I1216 18:27:02.838] create mode 100644 vendor/go.uber.org/zap/zapcore/level.go I1216 18:27:02.838] create mode 100644 vendor/go.uber.org/zap/zapcore/level_strings.go I1216 18:27:02.838] create mode 100644 vendor/go.uber.org/zap/zapcore/marshaler.go ... skipping 530 lines ... I1216 19:10:15.779] daemonset.apps "log-dump-node" deleted W1216 19:10:15.880] 2019/12/16 19:10:15 process.go:155: Step 'bash -c ./log-dump.sh' finished in 45.544781365s W1216 19:10:15.880] 2019/12/16 19:10:15 azure.go:1147: Deleting resource group: kubetest-aa47a24a-2031-11ea-b18d-02429e6bbba7. W1216 19:18:01.268] 2019/12/16 19:18:01 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml. W1216 19:18:01.269] 2019/12/16 19:18:01 process.go:153: Running: bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}" W1216 19:18:01.994] 2019/12/16 19:18:01 process.go:155: Step 'bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}"' finished in 725.885148ms W1216 19:18:01.995] 2019/12/16 19:18:01 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-25626108-vmssCSE'. Error message: \\\"Enable failed: failed to execute command: command terminated with exit status=14\\n[stdout]\\nMon Dec 16 18:56:24 UTC 2019,k8s-master-25626108-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:18:01.996] Traceback (most recent call last): W1216 19:18:01.996] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 778, in <module> W1216 19:18:01.996] main(parse_args()) W1216 19:18:01.997] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 626, in main W1216 19:18:01.997] mode.start(runner_args) W1216 19:18:01.997] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 262, in start W1216 19:18:01.997] check_env(env, self.command, *args) W1216 19:18:01.997] File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env W1216 19:18:01.997] subprocess.check_call(cmd, env=env) W1216 19:18:01.998] File "/usr/lib/python2.7/subprocess.py", line 190, in check_call W1216 19:18:01.998] raise CalledProcessError(retcode, cmd) W1216 19:18:01.999] 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:18:02.003] Command failed I1216 19:18:02.003] process 709 exited with code 1 after 50.9m E1216 19:18:02.003] FAIL: chewong-cloud-provider-azure-multiple-zones I1216 19:18:02.004] Call: gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json W1216 19:18:02.782] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com] I1216 19:18:02.811] process 32118 exited with code 0 after 0.0m I1216 19:18:02.812] Call: gcloud config get-value account I1216 19:18:03.061] process 32131 exited with code 0 after 0.0m I1216 19:18:03.061] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com I1216 19:18:03.061] Upload result and artifacts... I1216 19:18:03.062] 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/1206641567662608384 I1216 19:18:03.062] Call: gsutil ls gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_cloud-provider-azure/269/chewong-cloud-provider-azure-multiple-zones/1206641567662608384/artifacts W1216 19:18:04.121] CommandException: One or more URLs matched no objects. E1216 19:18:04.203] Command failed I1216 19:18:04.203] process 32144 exited with code 1 after 0.0m W1216 19:18:04.203] Remote dir gs://kubernetes-upstream/pr-logs/pull/sigs.k8s.io_cloud-provider-azure/269/chewong-cloud-provider-azure-multiple-zones/1206641567662608384/artifacts not exist yet I1216 19:18:04.203] 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/1206641567662608384/artifacts I1216 19:18:06.485] process 32289 exited with code 0 after 0.0m I1216 19:18:06.485] Call: git rev-parse HEAD I1216 19:18:06.488] process 493 exited with code 0 after 0.0m ... skipping 21 lines ...