W0923 20:44:04.489] ************************************************************************** bootstrap.py is deprecated! test-infra oncall does not support any job still using bootstrap.py. Please migrate your job to podutils! https://github.com/kubernetes/test-infra/blob/master/prow/pod-utilities.md ************************************************************************** I0923 20:44:04.489] Args: --job=pull-azurefile-csi-driver-integration --service-account=/etc/service-account/service-account.json --upload=gs://kubernetes-jenkins/logs --job=pull-azurefile-csi-driver-integration --root=/go/src --service-account=/etc/service-account/service-account.json --repo=github.com/kubernetes-sigs/azurefile-csi-driver=master:daea67167aecc01a8bfa2b24f33c4a08998cdc74,120:a4807b0328f45c802ae4e9c0e7bce26f0c5abf75 --upload=gs://kubernetes-upstream/pr-logs --scenario=execute -- make integration-test I0923 20:44:04.490] Bootstrap pull-azurefile-csi-driver-integration... I0923 20:44:04.493] Builder: d1aacb50-de42-11e9-b3d3-b20db476995a I0923 20:44:04.493] Image: gcr.io/k8s-testimages/kubekins-e2e:v20190903-df3b2f0-master I0923 20:44:04.493] Gubernator results at https://gubernator.k8s.io/build/kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-integration/1176235715755773955 I0923 20:44:04.494] Call: gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json W0923 20:44:05.067] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com] I0923 20:44:05.099] process 32 exited with code 0 after 0.0m I0923 20:44:05.100] Call: gcloud config get-value account I0923 20:44:05.360] process 44 exited with code 0 after 0.0m I0923 20:44:05.361] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com I0923 20:44:05.361] Root: /go/src I0923 20:44:05.361] cd to /go/src I0923 20:44:05.361] Checkout: /go/src/github.com/kubernetes-sigs/azurefile-csi-driver master:daea67167aecc01a8bfa2b24f33c4a08998cdc74,120:a4807b0328f45c802ae4e9c0e7bce26f0c5abf75 to /go/src/github.com/kubernetes-sigs/azurefile-csi-driver I0923 20:44:05.361] Call: git init github.com/kubernetes-sigs/azurefile-csi-driver I0923 20:44:05.366] Initialized empty Git repository in /go/src/github.com/kubernetes-sigs/azurefile-csi-driver/.git/ I0923 20:44:05.366] process 56 exited with code 0 after 0.0m I0923 20:44:05.366] Call: git config --local user.name 'K8S Bootstrap' I0923 20:44:05.369] process 57 exited with code 0 after 0.0m I0923 20:44:05.370] Call: git config --local user.email k8s_bootstrap@localhost I0923 20:44:05.372] process 58 exited with code 0 after 0.0m I0923 20:44:05.372] Call: git fetch --quiet --tags https://github.com/kubernetes-sigs/azurefile-csi-driver master +refs/pull/120/head:refs/pr/120 I0923 20:44:13.278] process 59 exited with code 0 after 0.1m I0923 20:44:13.278] Call: git checkout -B test daea67167aecc01a8bfa2b24f33c4a08998cdc74 W0923 20:44:13.760] Switched to a new branch 'test' I0923 20:44:13.763] process 71 exited with code 0 after 0.0m I0923 20:44:13.764] Call: git show -s --format=format:%ct HEAD I0923 20:44:13.774] process 72 exited with code 0 after 0.0m I0923 20:44:13.774] Call: git merge --no-ff -m 'Merge +refs/pull/120/head:refs/pr/120' a4807b0328f45c802ae4e9c0e7bce26f0c5abf75 I0923 20:44:14.145] Auto-merging test/utils/credentials/credentials_test.go I0923 20:44:14.145] Auto-merging test/utils/credentials/credentials.go I0923 20:44:14.145] Removing test/e2e/run-test.sh I0923 20:44:14.146] Removing hack/template/azure.json I0923 20:44:14.146] Merge made by the 'recursive' strategy. I0923 20:44:14.149] Makefile | 58 ++++++++++------ I0923 20:44:14.149] hack/template/azure.json | 9 --- I0923 20:44:14.149] hack/verify-golint.sh | 7 +- I0923 20:44:14.149] test/e2e/README.md | 22 +++++-- I0923 20:44:14.150] test/e2e/dynamic_provisioning.go | 17 ----- I0923 20:44:14.150] test/e2e/pre_provisioning.go | 23 +------ I0923 20:44:14.150] test/e2e/run-test.sh | 31 --------- I0923 20:44:14.150] test/e2e/suite_test.go | 84 ++++++++++++++++++++++++ I0923 20:44:14.150] test/integration/integration_test.go | 7 +- I0923 20:44:14.151] test/integration/run-tests-all-clouds.sh | 4 +- I0923 20:44:14.151] test/sanity/run-test.sh | 3 +- I0923 20:44:14.151] test/sanity/run-tests-all-clouds.sh | 4 +- I0923 20:44:14.151] test/sanity/sanity_test.go | 10 +-- I0923 20:44:14.151] test/{ => utils}/azure/azure_helpers.go | 0 I0923 20:44:14.151] test/{ => utils}/credentials/credentials.go | 22 +++++-- I0923 20:44:14.151] test/{ => utils}/credentials/credentials_test.go | 6 +- I0923 20:44:14.152] 16 files changed, 175 insertions(+), 132 deletions(-) I0923 20:44:14.152] delete mode 100644 hack/template/azure.json I0923 20:44:14.152] delete mode 100755 test/e2e/run-test.sh I0923 20:44:14.152] rename test/{ => utils}/azure/azure_helpers.go (100%) I0923 20:44:14.152] rename test/{ => utils}/credentials/credentials.go (87%) I0923 20:44:14.152] rename test/{ => utils}/credentials/credentials_test.go (98%) I0923 20:44:14.153] process 73 exited with code 0 after 0.0m I0923 20:44:14.153] Configure environment... I0923 20:44:14.153] Call: git show -s --format=format:%ct HEAD I0923 20:44:14.157] process 75 exited with code 0 after 0.0m I0923 20:44:14.157] Call: gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json W0923 20:44:14.984] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com] I0923 20:44:15.101] process 76 exited with code 0 after 0.0m I0923 20:44:15.101] Call: gcloud config get-value account I0923 20:44:15.361] process 88 exited with code 0 after 0.0m I0923 20:44:15.362] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com I0923 20:44:15.362] Start 1176235715755773955 at unknown... I0923 20:44:15.365] Call: gsutil -q -h Content-Type:application/json cp /tmp/gsutil_fpNrb8 gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-integration/1176235715755773955/started.json I0923 20:44:17.088] process 100 exited with code 0 after 0.0m I0923 20:44:17.088] Call: gsutil -q -h Content-Type:text/plain -h 'x-goog-meta-link: gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-integration/1176235715755773955' cp /tmp/gsutil_6azDTp gs://kubernetes-upstream/pr-logs/directory/pull-azurefile-csi-driver-integration/1176235715755773955.txt I0923 20:44:19.285] process 278 exited with code 0 after 0.0m I0923 20:44:19.286] Call: /workspace/./test-infra/jenkins/../scenarios/execute.py make integration-test W0923 20:44:19.322] Run: ('make', 'integration-test') I0923 20:44:19.424] CGO_ENABLED=0 GOOS=linux go build -a -ldflags "-X github.com/kubernetes-sigs/azurefile-csi-driver/pkg/azurefile.driverVersion=v0.4.0 -X github.com/kubernetes-sigs/azurefile-csi-driver/pkg/azurefile.gitCommit=9d1b081592fee813e53ab9e82ae32ca1e5e5f9b3 -X github.com/kubernetes-sigs/azurefile-csi-driver/pkg/azurefile.buildDate=2019-09-23T20:44:19Z -s -w -extldflags '-static'" -o _output/azurefileplugin ./pkg/azurefileplugin W0923 20:44:19.526] go: finding github.com/spf13/afero v1.2.2 W0923 20:44:19.527] go: finding github.com/elazarl/goproxy/ext v0.0.0-20190410145444-c548f45dcf1d W0923 20:44:19.527] go: finding github.com/prometheus/procfs v0.0.0-20190306233201-d0f344d83b0c W0923 20:44:19.528] go: finding github.com/opencontainers/go-digest v1.0.0-rc1 W0923 20:44:19.528] go: finding github.com/soheilhy/cmux v0.1.4 W0923 20:44:19.776] go: finding google.golang.org/api v0.1.0 W0923 20:44:19.786] go: finding sigs.k8s.io/kustomize v2.0.3+incompatible W0923 20:44:19.802] go: finding go.uber.org/atomic v1.3.2 W0923 20:44:19.802] go: finding k8s.io/legacy-cloud-providers v0.0.0-20190624091455-d8621ceb9c64 W0923 20:44:19.826] go: finding golang.org/x/time v0.0.0-20181108054448-85acf8d2951c W0923 20:44:21.354] go: finding github.com/googleapis/gnostic v0.2.0 W0923 20:44:21.369] go: finding github.com/grpc-ecosystem/go-grpc-prometheus v1.2.0 W0923 20:44:21.584] go: finding github.com/golang/protobuf v1.3.0 W0923 20:44:21.614] go: finding k8s.io/cli-runtime v0.0.0-20190314001948-2899ed30580f W0923 20:44:21.653] go: finding go.etcd.io/bbolt v1.3.2 W0923 20:44:21.678] go: finding github.com/golang/groupcache v0.0.0-20190129154638-5b532d6fd5ef W0923 20:44:21.944] go: finding github.com/marstr/guid v1.1.0 W0923 20:44:22.599] go: finding github.com/imdario/mergo v0.3.7 W0923 20:44:23.187] go: finding github.com/json-iterator/go v1.1.5 W0923 20:44:23.298] go: finding k8s.io/apiextensions-apiserver v0.0.0-20190315093550-53c4693659ed W0923 20:44:23.498] go: finding github.com/pelletier/go-toml v1.4.0 W0923 20:44:23.520] go: finding github.com/google/gofuzz v0.0.0-20170612174753-24818f796faf W0923 20:44:23.911] go: finding go.uber.org/multierr v1.1.0 W0923 20:44:24.093] go: finding gopkg.in/inf.v0 v0.9.1 W0923 20:44:24.121] go: finding golang.org/x/oauth2 v0.0.0-20190226205417-e64efc72b421 W0923 20:44:24.277] go: finding github.com/dgrijalva/jwt-go v3.2.0+incompatible W0923 20:44:24.561] go: finding github.com/evanphx/json-patch v3.0.0+incompatible W0923 20:44:25.007] go: finding github.com/vmware/govmomi v0.20.1 W0923 20:44:25.713] go: finding github.com/prometheus/client_golang v0.9.2 W0923 20:44:25.918] go: finding github.com/onsi/ginkgo v1.7.0 W0923 20:44:25.930] go: finding github.com/Azure/azure-sdk-for-go v21.4.0+incompatible W0923 20:44:26.140] go: finding github.com/hashicorp/golang-lru v0.5.1 W0923 20:44:26.146] go: finding github.com/go-openapi/swag v0.19.0 W0923 20:44:26.152] go: finding github.com/dnaeon/go-vcr v1.0.1 W0923 20:44:26.264] go: finding github.com/coreos/pkg v0.0.0-20180928190104-399ea9e2e55f W0923 20:44:26.727] go: finding github.com/prometheus/common v0.2.0 W0923 20:44:28.039] go: finding github.com/GoogleCloudPlatform/k8s-cloud-provider v0.0.0-20181220005116-f8e995905100 W0923 20:44:28.406] go: finding github.com/fatih/camelcase v1.0.0 W0923 20:44:28.529] go: finding k8s.io/component-base v0.0.0-20190313120452-4727f38490bc W0923 20:44:28.579] go: finding github.com/xiang90/probing v0.0.0-20190116061207-43a291ad63a2 W0923 20:44:28.609] go: finding k8s.io/csi-translation-lib v0.0.0-20190313124639-7f5cabc6aac8 W0923 20:44:28.658] go: finding go.uber.org/zap v1.9.1 W0923 20:44:28.986] go: finding github.com/go-openapi/spec v0.19.0 W0923 20:44:29.138] go: finding github.com/pkg/errors v0.8.1 W0923 20:44:29.148] go: finding github.com/pmezard/go-difflib v1.0.0 W0923 20:44:29.934] go: finding github.com/gogo/protobuf v1.2.1 W0923 20:44:31.039] go: finding google.golang.org/grpc v1.19.0 W0923 20:44:31.066] go: finding github.com/kubernetes-csi/external-snapshotter v1.0.1 W0923 20:44:31.204] go: finding github.com/stretchr/objx v0.1.1 W0923 20:44:31.379] go: finding github.com/coreos/go-systemd v0.0.0-20190321100706-95778dfbb74e W0923 20:44:31.380] go: finding golang.org/x/crypto v0.0.0-20190228161510-8dd112bcdc25 W0923 20:44:31.418] go: finding github.com/pborman/uuid v0.0.0-20180906182336-adf5a7427709 W0923 20:44:31.444] go: finding k8s.io/cloud-provider v0.0.0-20190308083404-05ccf96446f8 W0923 20:44:32.212] go: finding github.com/Azure/go-autorest v11.5.1+incompatible W0923 20:44:33.518] go: finding github.com/onsi/gomega v1.4.3 W0923 20:44:33.518] go: finding golang.org/x/sync v0.0.0-20190227155943-e225da77a7e6 W0923 20:44:33.662] go: finding golang.org/x/sys v0.0.0-20190308023053-584f3b12f43e W0923 20:44:33.842] go: finding github.com/julienschmidt/httprouter v1.2.0 W0923 20:44:33.928] go: finding github.com/PuerkitoBio/urlesc v0.0.0-20170810143723-de5bf2ad4578 W0923 20:44:34.039] go: finding k8s.io/cluster-bootstrap v0.0.0-20190313124217-0fa624df11e9 W0923 20:44:34.247] go: finding github.com/prometheus/client_model v0.0.0-20190129233127-fd36f4220a90 W0923 20:44:34.554] go: finding golang.org/x/net v0.0.0-20190301231341-16b79f2e4e95 W0923 20:44:34.733] go: finding github.com/PuerkitoBio/purell v1.1.1 W0923 20:44:34.779] go: finding github.com/docker/spdystream v0.0.0-20181023171402-6480d4af844c W0923 20:44:35.780] go: finding github.com/mailru/easyjson v0.0.0-20190312143242-1de009706dbe W0923 20:44:35.939] go: finding gopkg.in/square/go-jose.v2 v2.3.0 W0923 20:44:36.362] go: finding k8s.io/client-go v11.0.0+incompatible W0923 20:44:36.829] go: finding google.golang.org/genproto v0.0.0-20190307195333-5fe7a883aa19 W0923 20:44:38.864] go: finding github.com/google/uuid v1.1.1 W0923 20:44:39.417] go: finding github.com/inconshreveable/mousetrap v1.0.0 W0923 20:44:39.557] go: finding k8s.io/kube-aggregator v0.0.0-20190401185513-77f9841f26eb W0923 20:44:39.654] go: finding github.com/rogpeppe/go-charset v0.0.0-20180617210344-2471d30d28b4 W0923 20:44:39.742] go: finding gopkg.in/warnings.v0 v0.1.1 W0923 20:44:40.110] go: finding github.com/mwitkow/go-conntrack v0.0.0-20161129095857-cc309e4a2223 W0923 20:44:40.127] go: finding github.com/go-stack/stack v1.8.0 W0923 20:44:40.766] go: finding k8s.io/kubernetes v1.14.0 W0923 20:44:41.294] go: finding github.com/go-openapi/jsonpointer v0.19.0 W0923 20:44:41.295] go: finding github.com/aws/aws-sdk-go v1.16.26 W0923 20:44:41.707] go: finding github.com/coreos/bbolt v1.3.2 W0923 20:44:41.849] go: finding github.com/jonboulle/clockwork v0.1.0 W0923 20:44:42.115] go: finding google.golang.org/appengine v1.4.0 W0923 20:44:42.635] go: finding github.com/grpc-ecosystem/go-grpc-middleware v1.0.0 W0923 20:44:46.702] go: finding github.com/golang/mock v1.1.1 W0923 20:44:46.710] go: finding github.com/coreos/go-semver v0.3.0 W0923 20:44:47.002] go: finding github.com/alecthomas/template v0.0.0-20160405071501-a0175ee3bccc W0923 20:44:47.043] go: finding golang.org/x/tools v0.0.0-20190226205152-f727befe758c W0923 20:44:47.044] go: finding github.com/stretchr/testify v1.3.0 W0923 20:44:48.839] go: finding github.com/google/go-cmp v0.2.0 W0923 20:44:48.932] go: finding github.com/spf13/cobra v0.0.3 W0923 20:44:49.440] go: finding github.com/client9/misspell v0.3.4 W0923 20:44:50.291] go: finding sigs.k8s.io/yaml v1.1.0 W0923 20:44:51.702] go: finding github.com/sirupsen/logrus v1.2.0 W0923 20:44:52.027] go: finding go.opencensus.io v0.18.0 W0923 20:44:52.797] go: finding github.com/coreos/etcd v3.3.12+incompatible W0923 20:44:52.900] go: finding github.com/docker/distribution v0.0.0-20170905204447-5db89f0ca686 W0923 20:44:53.453] go: finding github.com/kr/logfmt v0.0.0-20140226030751-b84e30acd515 W0923 20:44:53.866] go: finding github.com/elazarl/goproxy v0.0.0-20190410145444-c548f45dcf1d W0923 20:44:53.996] go: finding github.com/emicklei/go-restful v2.9.3+incompatible W0923 20:44:54.584] go: finding github.com/davecgh/go-spew v1.1.1 W0923 20:44:55.188] go: finding cloud.google.com/go v0.34.0 W0923 20:44:55.294] go: finding golang.org/x/exp v0.0.0-20190121172915-509febef88a4 W0923 20:44:55.630] go: finding github.com/satori/go.uuid v1.2.0 W0923 20:44:55.854] go: finding github.com/container-storage-interface/spec v1.1.0 W0923 20:44:55.927] go: finding golang.org/x/text v0.3.0 W0923 20:44:57.146] go: finding github.com/alecthomas/units v0.0.0-20151022065526-2efee857e7cf W0923 20:44:57.943] go: finding github.com/hpcloud/tail v1.0.0 W0923 20:44:58.003] go: finding github.com/gregjones/httpcache v0.0.0-20190212212710-3befbb6ad0cc W0923 20:44:58.189] go: finding gopkg.in/fsnotify.v1 v1.4.7 W0923 20:44:58.351] go: finding github.com/jmespath/go-jmespath v0.0.0-20180206201540-c2b33e8439af W0923 20:44:58.404] go: finding github.com/konsorten/go-windows-terminal-sequences v1.0.1 W0923 20:44:58.816] go: finding k8s.io/kube-openapi v0.0.0-20190306001800-15615b16d372 W0923 20:44:59.779] go: finding gopkg.in/gcfg.v1 v1.2.0 W0923 20:45:00.074] go: finding github.com/spf13/pflag v1.0.3 W0923 20:45:00.078] go: finding gopkg.in/alecthomas/kingpin.v2 v2.2.6 W0923 20:45:00.319] go: finding github.com/modern-go/reflect2 v0.0.0-20180701023420-4b7aa43c6742 W0923 20:45:00.588] go: finding github.com/gorilla/websocket v1.4.0 W0923 20:45:00.906] go: finding k8s.io/apimachinery v0.0.0-20190313205120-d7deff9243b1 W0923 20:45:01.546] go: finding golang.org/x/lint v0.0.0-20190227174305-5b3e6a55c961 W0923 20:45:01.547] go: finding github.com/peterbourgon/diskv v2.0.1+incompatible W0923 20:45:02.428] go: finding github.com/go-logfmt/logfmt v0.3.0 W0923 20:45:02.787] go: finding github.com/ugorji/go v1.1.4 W0923 20:45:02.815] go: finding github.com/census-instrumentation/opencensus-proto v0.1.0 W0923 20:45:02.815] go: finding github.com/grpc-ecosystem/grpc-gateway v1.5.0 W0923 20:45:03.551] go: finding github.com/BurntSushi/toml v0.3.1 W0923 20:45:03.554] go: finding github.com/ghodss/yaml v1.0.0 W0923 20:45:03.951] go: finding github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd W0923 20:45:04.067] go: finding k8s.io/api v0.0.0-20190313235455-40a48860b5ab W0923 20:45:04.278] go: finding k8s.io/klog v0.2.0 W0923 20:45:04.331] go: finding contrib.go.opencensus.io/exporter/ocagent v0.2.0 W0923 20:45:04.795] go: finding honnef.co/go/tools v0.0.0-20190102054323-c2f93a96b099 W0923 20:45:05.257] go: finding github.com/apache/thrift v0.0.0-20180902110319-2566ecd5d999 W0923 20:45:05.292] go: finding github.com/tmc/grpc-websocket-proxy v0.0.0-20190109142713-0ad062ec5ee5 W0923 20:45:05.610] go: finding gopkg.in/yaml.v2 v2.2.2 W0923 20:45:05.757] go: finding github.com/matttproud/golang_protobuf_extensions v1.0.1 W0923 20:45:06.310] go: finding gopkg.in/tomb.v1 v1.0.0-20141024135613-dd632973f1e7 W0923 20:45:06.499] go: finding k8s.io/utils v0.0.0-20190221042446-c2654d5206da W0923 20:45:06.653] go: finding github.com/rubiojr/go-vhd v0.0.0-20160810183302-0bfd3b39853c W0923 20:45:06.973] go: finding github.com/go-kit/kit v0.8.0 W0923 20:45:07.016] go: finding github.com/go-openapi/jsonreference v0.19.0 W0923 20:45:07.091] go: finding github.com/beorn7/perks v0.0.0-20180321164747-3a771d992973 W0923 20:45:07.606] go: finding github.com/kisielk/errcheck v1.1.0 W0923 20:45:07.828] go: finding github.com/fsnotify/fsnotify v1.4.7 W0923 20:45:07.878] go: finding github.com/google/btree v1.0.0 W0923 20:45:08.541] go: finding github.com/Azure/azure-storage-file-go v0.5.0 W0923 20:45:08.855] go: finding github.com/golang/glog v0.0.0-20160126235308-23def4e6c14b W0923 20:45:08.886] go: finding github.com/openzipkin/zipkin-go v0.1.1 W0923 20:45:09.022] go: finding gopkg.in/check.v1 v0.0.0-20161208181325-20d25e280405 W0923 20:45:09.655] go: finding github.com/kisielk/gotool v1.0.0 W0923 20:45:09.656] go: finding k8s.io/apiserver v0.0.0-20190313205120-8b27c41bdbb1 W0923 20:45:10.560] go: finding github.com/kr/pretty v0.1.0 W0923 20:45:10.797] go: finding github.com/Azure/azure-pipeline-go v0.2.1 W0923 20:45:10.798] go: finding github.com/kr/pty v1.1.5 W0923 20:45:11.871] go: finding github.com/kr/text v0.1.0 W0923 20:45:12.333] go: finding github.com/mattn/go-ieproxy v0.0.0-20190610004146-91bb50d98149 W0923 20:45:13.799] go: downloading github.com/prometheus/client_golang v0.9.2 W0923 20:45:13.802] go: downloading github.com/container-storage-interface/spec v1.1.0 W0923 20:45:13.802] go: downloading github.com/Azure/azure-sdk-for-go v21.4.0+incompatible W0923 20:45:13.803] go: downloading golang.org/x/net v0.0.0-20190301231341-16b79f2e4e95 W0923 20:45:13.803] go: downloading k8s.io/kubernetes v1.14.0 W0923 20:45:13.804] go: downloading sigs.k8s.io/yaml v1.1.0 W0923 20:45:13.806] go: downloading k8s.io/legacy-cloud-providers v0.0.0-20190624091455-d8621ceb9c64 W0923 20:45:13.807] go: downloading github.com/golang/protobuf v1.3.0 W0923 20:45:13.807] go: downloading k8s.io/klog v0.2.0 W0923 20:45:13.938] go: extracting k8s.io/klog v0.2.0 W0923 20:45:13.942] go: extracting sigs.k8s.io/yaml v1.1.0 W0923 20:45:13.942] go: downloading github.com/Azure/azure-storage-file-go v0.5.0 W0923 20:45:13.959] go: downloading google.golang.org/grpc v1.19.0 W0923 20:45:14.012] go: extracting github.com/container-storage-interface/spec v1.1.0 W0923 20:45:14.166] go: extracting github.com/prometheus/client_golang v0.9.2 W0923 20:45:14.407] go: extracting github.com/Azure/azure-storage-file-go v0.5.0 W0923 20:45:14.426] go: extracting k8s.io/legacy-cloud-providers v0.0.0-20190624091455-d8621ceb9c64 W0923 20:45:14.426] go: extracting github.com/golang/protobuf v1.3.0 W0923 20:45:14.452] go: downloading github.com/Azure/azure-pipeline-go v0.2.1 W0923 20:45:14.480] go: downloading k8s.io/client-go v11.0.0+incompatible W0923 20:45:14.600] go: extracting github.com/Azure/azure-pipeline-go v0.2.1 W0923 20:45:14.605] go: downloading github.com/Azure/go-autorest v11.5.1+incompatible W0923 20:45:14.796] go: extracting github.com/Azure/go-autorest v11.5.1+incompatible W0923 20:45:14.831] go: downloading k8s.io/apimachinery v0.0.0-20190313205120-d7deff9243b1 W0923 20:45:15.112] go: extracting google.golang.org/grpc v1.19.0 W0923 20:45:15.181] go: downloading github.com/rubiojr/go-vhd v0.0.0-20160810183302-0bfd3b39853c W0923 20:45:15.182] go: downloading github.com/prometheus/common v0.2.0 W0923 20:45:15.637] go: extracting golang.org/x/net v0.0.0-20190301231341-16b79f2e4e95 W0923 20:45:15.669] go: extracting github.com/prometheus/common v0.2.0 W0923 20:45:15.730] go: extracting k8s.io/apimachinery v0.0.0-20190313205120-d7deff9243b1 W0923 20:45:15.795] go: extracting k8s.io/client-go v11.0.0+incompatible W0923 20:45:15.867] go: extracting github.com/rubiojr/go-vhd v0.0.0-20160810183302-0bfd3b39853c W0923 20:45:15.885] go: downloading github.com/beorn7/perks v0.0.0-20180321164747-3a771d992973 W0923 20:45:15.894] go: downloading github.com/prometheus/procfs v0.0.0-20190306233201-d0f344d83b0c W0923 20:45:15.978] go: extracting github.com/beorn7/perks v0.0.0-20180321164747-3a771d992973 W0923 20:45:15.986] go: downloading k8s.io/cloud-provider v0.0.0-20190308083404-05ccf96446f8 W0923 20:45:15.988] go: downloading golang.org/x/sys v0.0.0-20190308023053-584f3b12f43e W0923 20:45:16.090] go: extracting github.com/prometheus/procfs v0.0.0-20190306233201-d0f344d83b0c W0923 20:45:16.107] go: downloading github.com/pborman/uuid v0.0.0-20180906182336-adf5a7427709 W0923 20:45:16.193] go: extracting github.com/pborman/uuid v0.0.0-20180906182336-adf5a7427709 W0923 20:45:16.243] go: downloading github.com/mattn/go-ieproxy v0.0.0-20190610004146-91bb50d98149 W0923 20:45:16.322] go: extracting github.com/mattn/go-ieproxy v0.0.0-20190610004146-91bb50d98149 W0923 20:45:16.329] go: downloading k8s.io/api v0.0.0-20190313235455-40a48860b5ab W0923 20:45:16.458] go: extracting k8s.io/cloud-provider v0.0.0-20190308083404-05ccf96446f8 W0923 20:45:16.466] go: downloading google.golang.org/genproto v0.0.0-20190307195333-5fe7a883aa19 W0923 20:45:17.306] go: extracting k8s.io/api v0.0.0-20190313235455-40a48860b5ab W0923 20:45:17.434] go: extracting golang.org/x/sys v0.0.0-20190308023053-584f3b12f43e W0923 20:45:17.542] go: downloading k8s.io/utils v0.0.0-20190221042446-c2654d5206da W0923 20:45:17.770] go: extracting k8s.io/utils v0.0.0-20190221042446-c2654d5206da W0923 20:45:17.796] go: downloading github.com/gogo/protobuf v1.2.1 W0923 20:45:17.804] go: downloading github.com/google/gofuzz v0.0.0-20170612174753-24818f796faf W0923 20:45:17.807] go: downloading gopkg.in/yaml.v2 v2.2.2 W0923 20:45:17.928] go: extracting github.com/google/gofuzz v0.0.0-20170612174753-24818f796faf W0923 20:45:17.949] go: downloading golang.org/x/crypto v0.0.0-20190228161510-8dd112bcdc25 W0923 20:45:17.990] go: extracting gopkg.in/yaml.v2 v2.2.2 W0923 20:45:18.001] go: downloading github.com/googleapis/gnostic v0.2.0 W0923 20:45:19.400] go: extracting github.com/googleapis/gnostic v0.2.0 W0923 20:45:19.561] go: downloading go.opencensus.io v0.18.0 W0923 20:45:20.174] go: extracting golang.org/x/crypto v0.0.0-20190228161510-8dd112bcdc25 W0923 20:45:20.364] go: extracting go.opencensus.io v0.18.0 W0923 20:45:20.428] go: downloading github.com/google/uuid v1.1.1 W0923 20:45:20.434] go: downloading github.com/prometheus/client_model v0.0.0-20190129233127-fd36f4220a90 W0923 20:45:20.498] go: extracting github.com/google/uuid v1.1.1 W0923 20:45:20.512] go: downloading contrib.go.opencensus.io/exporter/ocagent v0.2.0 W0923 20:45:20.563] go: extracting github.com/prometheus/client_model v0.0.0-20190129233127-fd36f4220a90 W0923 20:45:20.602] go: extracting contrib.go.opencensus.io/exporter/ocagent v0.2.0 W0923 20:45:20.613] go: downloading google.golang.org/api v0.1.0 W0923 20:45:20.619] go: downloading golang.org/x/oauth2 v0.0.0-20190226205417-e64efc72b421 W0923 20:45:20.782] go: extracting golang.org/x/oauth2 v0.0.0-20190226205417-e64efc72b421 W0923 20:45:20.799] go: downloading github.com/census-instrumentation/opencensus-proto v0.1.0 W0923 20:45:21.035] go: extracting github.com/census-instrumentation/opencensus-proto v0.1.0 W0923 20:45:21.079] go: downloading github.com/davecgh/go-spew v1.1.1 W0923 20:45:21.254] go: extracting github.com/davecgh/go-spew v1.1.1 W0923 20:45:21.254] go: extracting github.com/gogo/protobuf v1.2.1 W0923 20:45:21.256] go: downloading golang.org/x/time v0.0.0-20181108054448-85acf8d2951c W0923 20:45:21.307] go: extracting golang.org/x/time v0.0.0-20181108054448-85acf8d2951c W0923 20:45:21.315] go: downloading github.com/matttproud/golang_protobuf_extensions v1.0.1 W0923 20:45:21.386] go: extracting github.com/matttproud/golang_protobuf_extensions v1.0.1 W0923 20:45:21.386] go: downloading github.com/hashicorp/golang-lru v0.5.1 W0923 20:45:21.520] go: extracting github.com/hashicorp/golang-lru v0.5.1 W0923 20:45:21.529] go: downloading github.com/json-iterator/go v1.1.5 W0923 20:45:21.778] go: extracting github.com/json-iterator/go v1.1.5 W0923 20:45:21.785] go: downloading k8s.io/kube-openapi v0.0.0-20190306001800-15615b16d372 W0923 20:45:21.807] go: downloading github.com/modern-go/reflect2 v0.0.0-20180701023420-4b7aa43c6742 W0923 20:45:21.898] go: extracting github.com/modern-go/reflect2 v0.0.0-20180701023420-4b7aa43c6742 W0923 20:45:21.903] go: downloading gopkg.in/inf.v0 v0.9.1 W0923 20:45:21.954] go: extracting gopkg.in/inf.v0 v0.9.1 W0923 20:45:21.961] go: downloading github.com/dgrijalva/jwt-go v3.2.0+incompatible W0923 20:45:22.098] go: extracting github.com/dgrijalva/jwt-go v3.2.0+incompatible W0923 20:45:22.116] go: downloading golang.org/x/text v0.3.0 W0923 20:45:22.133] go: extracting google.golang.org/genproto v0.0.0-20190307195333-5fe7a883aa19 W0923 20:45:23.410] go: downloading github.com/golang/groupcache v0.0.0-20190129154638-5b532d6fd5ef W0923 20:45:23.491] go: extracting github.com/golang/groupcache v0.0.0-20190129154638-5b532d6fd5ef W0923 20:45:23.786] go: extracting k8s.io/kube-openapi v0.0.0-20190306001800-15615b16d372 W0923 20:45:24.020] go: downloading github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd W0923 20:45:24.122] go: extracting github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd W0923 20:45:32.248] go: extracting golang.org/x/text v0.3.0 W0923 20:45:35.406] go: extracting github.com/Azure/azure-sdk-for-go v21.4.0+incompatible W0923 20:45:40.427] go: downloading github.com/marstr/guid v1.1.0 W0923 20:45:40.433] go: downloading github.com/satori/go.uuid v1.2.0 W0923 20:45:40.717] go: extracting github.com/marstr/guid v1.1.0 W0923 20:45:40.740] go: extracting github.com/satori/go.uuid v1.2.0 W0923 20:45:41.678] go: extracting google.golang.org/api v0.1.0 W0923 20:45:42.002] go: extracting k8s.io/kubernetes v1.14.0 W0923 20:45:43.930] go: downloading golang.org/x/sync v0.0.0-20190227155943-e225da77a7e6 W0923 20:45:44.074] go: extracting golang.org/x/sync v0.0.0-20190227155943-e225da77a7e6 W0923 20:45:47.038] go: downloading k8s.io/apiserver v0.0.0-20190313205120-8b27c41bdbb1 W0923 20:45:47.050] go: downloading k8s.io/apiextensions-apiserver v0.0.0-20190315093550-53c4693659ed W0923 20:45:48.675] go: extracting k8s.io/apiserver v0.0.0-20190313205120-8b27c41bdbb1 W0923 20:45:48.873] go: downloading github.com/spf13/pflag v1.0.3 W0923 20:45:49.130] go: extracting github.com/spf13/pflag v1.0.3 W0923 20:45:49.618] go: extracting k8s.io/apiextensions-apiserver v0.0.0-20190315093550-53c4693659ed I0923 20:47:38.564] go test -v -timeout=10m ./test/integration W0923 20:47:38.736] go: downloading github.com/stretchr/testify v1.3.0 W0923 20:47:38.854] go: downloading github.com/pelletier/go-toml v1.4.0 W0923 20:47:39.642] go: extracting github.com/stretchr/testify v1.3.0 W0923 20:47:39.652] go: downloading github.com/pmezard/go-difflib v1.0.0 W0923 20:47:39.654] go: extracting github.com/pelletier/go-toml v1.4.0 W0923 20:47:39.798] go: extracting github.com/pmezard/go-difflib v1.0.0 I0923 20:48:01.754] === RUN TestIntegrationOnAzurePublicCloud I0923 20:48:04.405] I0923 20:48:04.405] WARNING: apt does not have a stable CLI interface. Use with caution in scripts. I0923 20:48:04.406] I0923 20:48:04.592] Get:2 https://download.docker.com/linux/debian stretch InRelease [44.8 kB] I0923 20:48:04.703] Get:1 http://security-cdn.debian.org/debian-security stretch/updates InRelease [94.3 kB] I0923 20:48:04.750] Ign:3 http://cdn-fastly.deb.debian.org/debian stretch InRelease I0923 20:48:04.794] Get:4 http://cdn-fastly.deb.debian.org/debian stretch-updates InRelease [91.0 kB] I0923 20:48:04.873] Get:5 http://cdn-fastly.deb.debian.org/debian stretch Release [118 kB] I0923 20:48:04.884] Get:6 http://cdn-fastly.deb.debian.org/debian stretch Release.gpg [2365 B] I0923 20:48:04.918] Get:7 https://download.docker.com/linux/debian stretch/stable amd64 Packages [10.7 kB] I0923 20:48:05.278] Get:8 http://security-cdn.debian.org/debian-security stretch/updates/main amd64 Packages [506 kB] I0923 20:48:05.600] Get:9 http://cdn-fastly.deb.debian.org/debian stretch-updates/main amd64 Packages [27.4 kB] I0923 20:48:05.887] Get:10 http://cdn-fastly.deb.debian.org/debian stretch/main amd64 Packages [7086 kB] I0923 20:48:08.338] Fetched 7981 kB in 3s (2069 kB/s) I0923 20:48:09.450] Reading package lists... I0923 20:48:09.710] Building dependency tree... I0923 20:48:10.141] Reading state information... I0923 20:48:10.142] 24 packages can be upgraded. Run 'apt list --upgradable' to see them. I0923 20:48:10.142] I0923 20:48:10.143] WARNING: apt does not have a stable CLI interface. Use with caution in scripts. I0923 20:48:10.143] I0923 20:48:11.154] Reading package lists... I0923 20:48:11.300] Building dependency tree... I0923 20:48:13.059] Reading state information... I0923 20:48:13.060] procps is already the newest version (2:3.3.12-3+deb9u1). I0923 20:48:13.060] The following additional packages will be installed: I0923 20:48:13.060] libavahi-client3 libavahi-common-data libavahi-common3 libcups2 libldb1 I0923 20:48:13.060] libtalloc2 libtdb1 libtevent0 libwbclient0 python-crypto python-ldb I0923 20:48:13.060] python-samba python-talloc python-tdb samba-common samba-common-bin I0923 20:48:13.061] samba-libs I0923 20:48:13.061] Suggested packages: I0923 20:48:13.061] keyutils smbclient winbind cups-common python-crypto-dbg python-crypto-doc I0923 20:48:13.061] python-gpgme heimdal-clients I0923 20:48:13.314] The following NEW packages will be installed: I0923 20:48:13.314] cifs-utils libavahi-client3 libavahi-common-data libavahi-common3 libcups2 I0923 20:48:13.315] libldb1 libtalloc2 libtdb1 libtevent0 libwbclient0 python-crypto python-ldb I0923 20:48:13.315] python-samba python-talloc python-tdb samba-common samba-common-bin I0923 20:48:13.315] samba-libs I0923 20:48:13.398] 0 upgraded, 18 newly installed, 0 to remove and 24 not upgraded. I0923 20:48:13.398] Need to get 8646 kB of archives. I0923 20:48:13.399] After this operation, 38.4 MB of additional disk space will be used. I0923 20:48:13.399] Get:1 http://cdn-fastly.deb.debian.org/debian stretch/main amd64 libwbclient0 amd64 2:4.5.16+dfsg-1+deb9u2 [124 kB] I0923 20:48:14.241] Get:2 http://cdn-fastly.deb.debian.org/debian stretch/main amd64 samba-common all 2:4.5.16+dfsg-1+deb9u2 [174 kB] I0923 20:48:14.243] Get:3 http://cdn-fastly.deb.debian.org/debian stretch/main amd64 libtalloc2 amd64 2.1.8-1 [36.3 kB] I0923 20:48:14.244] Get:4 http://cdn-fastly.deb.debian.org/debian stretch/main amd64 cifs-utils amd64 2:6.7-1 [75.8 kB] I0923 20:48:14.246] Get:5 http://cdn-fastly.deb.debian.org/debian stretch/main amd64 libavahi-common-data amd64 0.6.32-2 [118 kB] I0923 20:48:14.250] Get:6 http://cdn-fastly.deb.debian.org/debian stretch/main amd64 libavahi-common3 amd64 0.6.32-2 [52.0 kB] I0923 20:48:14.252] Get:7 http://cdn-fastly.deb.debian.org/debian stretch/main amd64 libavahi-client3 amd64 0.6.32-2 [55.3 kB] I0923 20:48:14.262] Get:8 http://cdn-fastly.deb.debian.org/debian stretch/main amd64 libcups2 amd64 2.2.1-8+deb9u4 [307 kB] I0923 20:48:14.302] Get:9 http://cdn-fastly.deb.debian.org/debian stretch/main amd64 libtdb1 amd64 1.3.11-2 [43.2 kB] I0923 20:48:14.303] Get:10 http://cdn-fastly.deb.debian.org/debian stretch/main amd64 libtevent0 amd64 0.9.31-1 [29.3 kB] I0923 20:48:14.304] Get:11 http://cdn-fastly.deb.debian.org/debian stretch/main amd64 libldb1 amd64 2:1.1.27-1+deb9u1 [113 kB] I0923 20:48:14.410] Get:12 http://cdn-fastly.deb.debian.org/debian stretch/main amd64 python-crypto amd64 2.6.1-7 [259 kB] I0923 20:48:14.416] Get:13 http://cdn-fastly.deb.debian.org/debian stretch/main amd64 python-ldb amd64 2:1.1.27-1+deb9u1 [34.8 kB] I0923 20:48:14.416] Get:14 http://cdn-fastly.deb.debian.org/debian stretch/main amd64 python-tdb amd64 1.3.11-2 [16.2 kB] I0923 20:48:14.417] Get:15 http://cdn-fastly.deb.debian.org/debian stretch/main amd64 python-talloc amd64 2.1.8-1 [11.9 kB] I0923 20:48:14.418] Get:16 http://cdn-fastly.deb.debian.org/debian stretch/main amd64 samba-libs amd64 2:4.5.16+dfsg-1+deb9u2 [5231 kB] I0923 20:48:15.076] Get:17 http://cdn-fastly.deb.debian.org/debian stretch/main amd64 python-samba amd64 2:4.5.16+dfsg-1+deb9u2 [1360 kB] I0923 20:48:15.100] Get:18 http://cdn-fastly.deb.debian.org/debian stretch/main amd64 samba-common-bin amd64 2:4.5.16+dfsg-1+deb9u2 [603 kB] I0923 20:48:15.335] debconf: delaying package configuration, since apt-utils is not installed I0923 20:48:15.401] Fetched 8646 kB in 1s (4848 kB/s) I0923 20:48:15.509] Selecting previously unselected package libwbclient0:amd64. I0923 20:48:15.520] (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 19609 files and directories currently installed.) I0923 20:48:15.521] Preparing to unpack .../00-libwbclient0_2%3a4.5.16+dfsg-1+deb9u2_amd64.deb ... I0923 20:48:15.555] Unpacking libwbclient0:amd64 (2:4.5.16+dfsg-1+deb9u2) ... I0923 20:48:15.897] Selecting previously unselected package samba-common. I0923 20:48:15.900] Preparing to unpack .../01-samba-common_2%3a4.5.16+dfsg-1+deb9u2_all.deb ... I0923 20:48:15.948] Unpacking samba-common (2:4.5.16+dfsg-1+deb9u2) ... I0923 20:48:16.125] Selecting previously unselected package libtalloc2:amd64. I0923 20:48:16.128] Preparing to unpack .../02-libtalloc2_2.1.8-1_amd64.deb ... I0923 20:48:16.172] Unpacking libtalloc2:amd64 (2.1.8-1) ... I0923 20:48:16.359] Selecting previously unselected package cifs-utils. I0923 20:48:16.361] Preparing to unpack .../03-cifs-utils_2%3a6.7-1_amd64.deb ... I0923 20:48:16.376] Unpacking cifs-utils (2:6.7-1) ... I0923 20:48:16.528] Selecting previously unselected package libavahi-common-data:amd64. I0923 20:48:16.531] Preparing to unpack .../04-libavahi-common-data_0.6.32-2_amd64.deb ... I0923 20:48:16.568] Unpacking libavahi-common-data:amd64 (0.6.32-2) ... I0923 20:48:16.809] Selecting previously unselected package libavahi-common3:amd64. I0923 20:48:16.811] Preparing to unpack .../05-libavahi-common3_0.6.32-2_amd64.deb ... I0923 20:48:16.835] Unpacking libavahi-common3:amd64 (0.6.32-2) ... I0923 20:48:17.100] Selecting previously unselected package libavahi-client3:amd64. I0923 20:48:17.102] Preparing to unpack .../06-libavahi-client3_0.6.32-2_amd64.deb ... I0923 20:48:17.148] Unpacking libavahi-client3:amd64 (0.6.32-2) ... I0923 20:48:17.296] Selecting previously unselected package libcups2:amd64. I0923 20:48:17.298] Preparing to unpack .../07-libcups2_2.2.1-8+deb9u4_amd64.deb ... I0923 20:48:17.319] Unpacking libcups2:amd64 (2.2.1-8+deb9u4) ... I0923 20:48:17.652] Selecting previously unselected package libtdb1:amd64. I0923 20:48:17.655] Preparing to unpack .../08-libtdb1_1.3.11-2_amd64.deb ... I0923 20:48:17.672] Unpacking libtdb1:amd64 (1.3.11-2) ... I0923 20:48:17.792] Selecting previously unselected package libtevent0:amd64. I0923 20:48:17.794] Preparing to unpack .../09-libtevent0_0.9.31-1_amd64.deb ... I0923 20:48:17.812] Unpacking libtevent0:amd64 (0.9.31-1) ... I0923 20:48:17.935] Selecting previously unselected package libldb1:amd64. I0923 20:48:17.938] Preparing to unpack .../10-libldb1_2%3a1.1.27-1+deb9u1_amd64.deb ... I0923 20:48:17.959] Unpacking libldb1:amd64 (2:1.1.27-1+deb9u1) ... I0923 20:48:18.117] Selecting previously unselected package python-crypto. I0923 20:48:18.119] Preparing to unpack .../11-python-crypto_2.6.1-7_amd64.deb ... I0923 20:48:18.138] Unpacking python-crypto (2.6.1-7) ... I0923 20:48:18.343] Selecting previously unselected package python-ldb. I0923 20:48:18.345] Preparing to unpack .../12-python-ldb_2%3a1.1.27-1+deb9u1_amd64.deb ... I0923 20:48:18.360] Unpacking python-ldb (2:1.1.27-1+deb9u1) ... I0923 20:48:18.493] Selecting previously unselected package python-tdb. I0923 20:48:18.495] Preparing to unpack .../13-python-tdb_1.3.11-2_amd64.deb ... I0923 20:48:18.510] Unpacking python-tdb (1.3.11-2) ... I0923 20:48:18.624] Selecting previously unselected package python-talloc. I0923 20:48:18.626] Preparing to unpack .../14-python-talloc_2.1.8-1_amd64.deb ... I0923 20:48:18.641] Unpacking python-talloc (2.1.8-1) ... I0923 20:48:18.754] Selecting previously unselected package samba-libs:amd64. I0923 20:48:18.756] Preparing to unpack .../15-samba-libs_2%3a4.5.16+dfsg-1+deb9u2_amd64.deb ... I0923 20:48:18.784] Unpacking samba-libs:amd64 (2:4.5.16+dfsg-1+deb9u2) ... I0923 20:48:20.704] Selecting previously unselected package python-samba. I0923 20:48:20.705] Preparing to unpack .../16-python-samba_2%3a4.5.16+dfsg-1+deb9u2_amd64.deb ... I0923 20:48:20.734] Unpacking python-samba (2:4.5.16+dfsg-1+deb9u2) ... I0923 20:48:21.262] Selecting previously unselected package samba-common-bin. I0923 20:48:21.266] Preparing to unpack .../17-samba-common-bin_2%3a4.5.16+dfsg-1+deb9u2_amd64.deb ... I0923 20:48:21.289] Unpacking samba-common-bin (2:4.5.16+dfsg-1+deb9u2) ... I0923 20:48:21.696] Setting up libtdb1:amd64 (1.3.11-2) ... I0923 20:48:21.784] Setting up libwbclient0:amd64 (2:4.5.16+dfsg-1+deb9u2) ... I0923 20:48:21.850] Setting up python-crypto (2.6.1-7) ... I0923 20:48:22.626] Setting up python-tdb (1.3.11-2) ... I0923 20:48:23.193] Setting up samba-common (2:4.5.16+dfsg-1+deb9u2) ... I0923 20:48:23.491] debconf: unable to initialize frontend: Dialog I0923 20:48:23.492] debconf: (No usable dialog-like program is installed, so the dialog based frontend cannot be used. at /usr/share/perl5/Debconf/FrontEnd/Dialog.pm line 76.) I0923 20:48:23.492] debconf: falling back to frontend: Readline I0923 20:48:23.794] I0923 20:48:23.794] Creating config file /etc/samba/smb.conf with new version I0923 20:48:24.062] Processing triggers for libc-bin (2.24-11+deb9u4) ... I0923 20:48:24.174] Setting up libtalloc2:amd64 (2.1.8-1) ... I0923 20:48:24.348] Setting up libavahi-common-data:amd64 (0.6.32-2) ... I0923 20:48:24.426] Setting up python-talloc (2.1.8-1) ... I0923 20:48:24.526] Setting up cifs-utils (2:6.7-1) ... I0923 20:48:24.654] update-alternatives: using /usr/lib/x86_64-linux-gnu/cifs-utils/idmapwb.so to provide /etc/cifs-utils/idmap-plugin (idmap-plugin) in auto mode I0923 20:48:24.702] Setting up libtevent0:amd64 (0.9.31-1) ... I0923 20:48:24.810] Setting up libavahi-common3:amd64 (0.6.32-2) ... I0923 20:48:24.902] Setting up libldb1:amd64 (2:1.1.27-1+deb9u1) ... I0923 20:48:24.980] Setting up libavahi-client3:amd64 (0.6.32-2) ... I0923 20:48:25.044] Setting up libcups2:amd64 (2.2.1-8+deb9u4) ... I0923 20:48:25.137] Setting up python-ldb (2:1.1.27-1+deb9u1) ... I0923 20:48:26.130] Setting up samba-libs:amd64 (2:4.5.16+dfsg-1+deb9u2) ... I0923 20:48:26.218] Setting up python-samba (2:4.5.16+dfsg-1+deb9u2) ... I0923 20:48:27.425] Setting up samba-common-bin (2:4.5.16+dfsg-1+deb9u2) ... I0923 20:48:27.518] Processing triggers for libc-bin (2.24-11+deb9u4) ... I0923 20:49:14.972] Begin to run integration test on AzurePublicCloud... I0923 20:49:14.995] I0923 20:49:14.995102 12080 main.go:82] set up prometheus server on [::]:10252 I0923 20:49:14.996] I0923 20:49:14.996394 12080 azurefile.go:84] I0923 20:49:14.996] DRIVER INFORMATION: I0923 20:49:14.997] ------------------- I0923 20:49:14.997] Build Date: "2019-09-23T20:44:19Z" I0923 20:49:14.997] Compiler: gc I0923 20:49:14.998] Driver Name: file.csi.azure.com I0923 20:49:14.998] Driver Version: v0.4.0 I0923 20:49:14.998] Git Commit: 9d1b081592fee813e53ab9e82ae32ca1e5e5f9b3 I0923 20:49:14.999] Go Version: go1.12.9 I0923 20:49:14.999] Platform: linux/amd64 I0923 20:49:14.999] I0923 20:49:15.000] Streaming logs below: I0923 20:49:15.000] I0923 20:49:15.000425 12080 azure.go:31] AZURE_CREDENTIAL_FILE env var set as /tmp/azure.json I0923 20:49:15.001] I0923 20:49:15.001374 12080 azure_auth.go:86] azure: using client_id+client_secret to retrieve access token I0923 20:49:15.002] I0923 20:49:15.002167 12080 mount_linux.go:156] Detected OS without systemd I0923 20:49:15.002] I0923 20:49:15.002632 12080 driver.go:80] Enabling controller service capability: CREATE_DELETE_VOLUME I0923 20:49:15.003] I0923 20:49:15.003126 12080 driver.go:80] Enabling controller service capability: CREATE_DELETE_SNAPSHOT I0923 20:49:15.003] I0923 20:49:15.003598 12080 driver.go:99] Enabling volume access mode: SINGLE_NODE_WRITER I0923 20:49:15.004] I0923 20:49:15.004080 12080 driver.go:99] Enabling volume access mode: SINGLE_NODE_READER_ONLY I0923 20:49:15.004] I0923 20:49:15.004544 12080 driver.go:99] Enabling volume access mode: MULTI_NODE_READER_ONLY I0923 20:49:15.005] I0923 20:49:15.005035 12080 driver.go:99] Enabling volume access mode: MULTI_NODE_SINGLE_WRITER I0923 20:49:15.005] I0923 20:49:15.005573 12080 driver.go:99] Enabling volume access mode: MULTI_NODE_MULTI_WRITER I0923 20:49:15.006] I0923 20:49:15.006061 12080 driver.go:90] Enabling node service capability: UNKNOWN I0923 20:49:15.006] I0923 20:49:15.006678 12080 server.go:104] Listening for connections on address: &net.TCPAddr{IP:net.IP{0x7f, 0x0, 0x0, 0x1}, Port:10000, Zone:""} I0923 20:49:19.979] Create volume test: I0923 20:49:19.993] I0923 20:49:19.993245 12080 utils.go:111] GRPC call: /csi.v1.Controller/CreateVolume I0923 20:49:19.994] I0923 20:49:19.993281 12080 utils.go:112] GRPC request: name:"citest-1569271754" capacity_range: volume_capabilities: access_mode: > parameters: I0923 20:49:19.995] I0923 20:49:19.993297 12080 controllerserver.go:95] begin to create file share(citest-1569271754) on account() type(Standard_LRS) rg() location() size(2) I0923 20:49:20.339] I0923 20:49:20.339495 12080 azure_storageaccount.go:121] azure - no matching account found, begin to create a new account f9dd0d4d1de4311e9a9abe2 in resource group azurefile-csi-driver-test-6ef9ac39-de43-11e9-94bf-e23abe942fef, location: eastus2, accountType: Standard_LRS, accountKind: StorageV2 I0923 20:49:39.628] I0923 20:49:39.627929 12080 azure_storage.go:49] created share citest-1569271754 in account f9dd0d4d1de4311e9a9abe2 I0923 20:49:39.628] I0923 20:49:39.627967 12080 controllerserver.go:108] create file share citest-1569271754 on storage account f9dd0d4d1de4311e9a9abe2 successfully I0923 20:49:39.700] I0923 20:49:39.700519 12080 utils.go:118] GRPC response: volume: > I0923 20:49:54.706] Got volume id: #f9dd0d4d1de4311e9a9abe2#citest-1569271754 I0923 20:49:54.710] I0923 20:49:54.710300 12080 utils.go:111] GRPC call: /csi.v1.Controller/ValidateVolumeCapabilities I0923 20:49:54.710] I0923 20:49:54.710398 12080 utils.go:112] GRPC request: volume_id:"#f9dd0d4d1de4311e9a9abe2#citest-1569271754" volume_capabilities: access_mode: > I0923 20:49:54.892] I0923 20:49:54.891773 12080 utils.go:118] GRPC response: I0923 20:49:54.892] "#f9dd0d4d1de4311e9a9abe2#citest-1569271754" I0923 20:49:54.893] Mount volume test: I0923 20:49:54.897] I0923 20:49:54.897768 12080 utils.go:111] GRPC call: /csi.v1.Node/NodePublishVolume I0923 20:49:54.898] I0923 20:49:54.897801 12080 utils.go:112] GRPC request: volume_id:"#f9dd0d4d1de4311e9a9abe2#citest-1569271754" target_path:"/tmp/testmount1" volume_capability: access_mode: > I0923 20:49:54.898] I0923 20:49:54.897842 12080 nodeserver.go:76] target /tmp/testmount1 I0923 20:49:54.898] fstype I0923 20:49:54.898] I0923 20:49:54.898] readonly false I0923 20:49:54.899] volumeId #f9dd0d4d1de4311e9a9abe2#citest-1569271754 I0923 20:49:54.899] context map[] I0923 20:49:54.899] mountflags [] I0923 20:49:55.009] I0923 20:49:55.009129 12080 mount_linux.go:138] Mounting cmd (mount) with arguments ([-t cifs -o username=f9dd0d4d1de4311e9a9abe2,password=V/2O/KTiS5zQYi9dWVC+XlfPzGZ0GhJy8OW4Wgq1Ba+kk3ZBI/oON1jO6C7EtEY+xbHJ9jFqYdQafUx8QnGQ1A==,file_mode=0777,dir_mode=0777,vers=3.0 //f9dd0d4d1de4311e9a9abe2.file.core.windows.net/citest-1569271754 /tmp/testmount1]) I0923 20:49:56.635] I0923 20:49:56.635678 12080 utils.go:118] GRPC response: I0923 20:49:56.636] #f9dd0d4d1de4311e9a9abe2#citest-1569271754 I0923 20:49:58.638] Unmount volume test: I0923 20:49:58.643] I0923 20:49:58.643063 12080 utils.go:111] GRPC call: /csi.v1.Node/NodeUnpublishVolume I0923 20:49:58.643] I0923 20:49:58.643089 12080 utils.go:112] GRPC request: volume_id:"#f9dd0d4d1de4311e9a9abe2#citest-1569271754" target_path:"/tmp/testmount1" I0923 20:49:58.643] I0923 20:49:58.643097 12080 mount_linux.go:203] Unmounting /tmp/testmount1 I0923 20:49:59.235] I0923 20:49:59.235483 12080 nodeserver.go:180] azurefile: volume /tmp/testmount1/#f9dd0d4d1de4311e9a9abe2#citest-1569271754 has been unmounted. I0923 20:49:59.236] I0923 20:49:59.235509 12080 utils.go:118] GRPC response: I0923 20:49:59.236] #f9dd0d4d1de4311e9a9abe2#citest-1569271754 I0923 20:50:01.238] Delete volume test: I0923 20:50:01.243] I0923 20:50:01.243432 12080 utils.go:111] GRPC call: /csi.v1.Controller/DeleteVolume I0923 20:50:01.243] I0923 20:50:01.243461 12080 utils.go:112] GRPC request: volume_id:"#f9dd0d4d1de4311e9a9abe2#citest-1569271754" I0923 20:50:02.498] I0923 20:50:02.497784 12080 controllerserver.go:149] azure file(citest-1569271754) under rg() account(f9dd0d4d1de4311e9a9abe2) volumeID(#f9dd0d4d1de4311e9a9abe2#citest-1569271754) is deleted successfully I0923 20:50:02.498] I0923 20:50:02.497819 12080 utils.go:118] GRPC response: I0923 20:50:02.498] #f9dd0d4d1de4311e9a9abe2#citest-1569271754 I0923 20:50:17.508] I0923 20:50:17.507808 12080 utils.go:111] GRPC call: /csi.v1.Identity/GetPluginInfo I0923 20:50:17.508] I0923 20:50:17.507854 12080 utils.go:112] GRPC request: I0923 20:50:17.508] I0923 20:50:17.507867 12080 identityserver.go:32] Using default GetPluginInfo I0923 20:50:17.508] I0923 20:50:17.507875 12080 utils.go:118] GRPC response: name:"file.csi.azure.com" vendor_version:"v0.4.0" I0923 20:50:17.509] "file.csi.azure.com" "v0.4.0" I0923 20:50:17.515] I0923 20:50:17.514982 12080 utils.go:111] GRPC call: /csi.v1.Node/NodeGetInfo I0923 20:50:17.515] I0923 20:50:17.515014 12080 utils.go:112] GRPC request: I0923 20:50:17.515] I0923 20:50:17.515036 12080 nodeserver.go:228] Using default NodeGetInfo I0923 20:50:17.515] I0923 20:50:17.515040 12080 utils.go:118] GRPC response: node_id:"CSINode" I0923 20:50:17.516] CSINode 0 (*csi.Topology)(nil) I0923 20:50:17.516] Integration test on AzurePublicCloud is complete. I0923 20:50:17.516] pkill -f azurefileplugin I0923 20:50:17.520] --- PASS: TestIntegrationOnAzurePublicCloud (135.77s) I0923 20:50:17.520] integration_test.go:67: Creating resource group azurefile-csi-driver-test-6ef9ac39-de43-11e9-94bf-e23abe942fef in AzurePublicCloud I0923 20:50:17.520] === RUN TestIntegrationOnAzureChinaCloud I0923 20:50:18.824] I0923 20:50:18.824] WARNING: apt does not have a stable CLI interface. Use with caution in scripts. I0923 20:50:18.824] I0923 20:50:18.966] Hit:2 https://download.docker.com/linux/debian stretch InRelease I0923 20:50:18.983] Hit:1 http://security-cdn.debian.org/debian-security stretch/updates InRelease I0923 20:50:19.035] Ign:3 http://cdn-fastly.deb.debian.org/debian stretch InRelease I0923 20:50:19.094] Hit:4 http://cdn-fastly.deb.debian.org/debian stretch-updates InRelease I0923 20:50:19.167] Hit:5 http://cdn-fastly.deb.debian.org/debian stretch Release I0923 20:50:19.955] Reading package lists... I0923 20:50:20.064] Building dependency tree... I0923 20:50:20.065] Reading state information... I0923 20:50:20.072] 24 packages can be upgraded. Run 'apt list --upgradable' to see them. I0923 20:50:20.076] I0923 20:50:20.077] WARNING: apt does not have a stable CLI interface. Use with caution in scripts. I0923 20:50:20.077] I0923 20:50:20.715] Reading package lists... I0923 20:50:20.832] Building dependency tree... I0923 20:50:20.832] Reading state information... I0923 20:50:20.911] cifs-utils is already the newest version (2:6.7-1). I0923 20:50:20.911] procps is already the newest version (2:3.3.12-3+deb9u1). I0923 20:50:20.911] 0 upgraded, 0 newly installed, 0 to remove and 24 not upgraded. I0923 20:50:21.201] Begin to run integration test on AzureChinaCloud... I0923 20:50:21.216] I0923 20:50:21.216352 12510 main.go:82] set up prometheus server on [::]:10252 I0923 20:50:21.216] I0923 20:50:21.216595 12510 azurefile.go:84] I0923 20:50:21.216] DRIVER INFORMATION: I0923 20:50:21.216] ------------------- I0923 20:50:21.217] Build Date: "2019-09-23T20:44:19Z" I0923 20:50:21.217] Compiler: gc I0923 20:50:21.217] Driver Name: file.csi.azure.com I0923 20:50:21.217] Driver Version: v0.4.0 I0923 20:50:21.217] Git Commit: 9d1b081592fee813e53ab9e82ae32ca1e5e5f9b3 I0923 20:50:21.217] Go Version: go1.12.9 I0923 20:50:21.217] Platform: linux/amd64 I0923 20:50:21.217] I0923 20:50:21.217] Streaming logs below: I0923 20:50:21.218] I0923 20:50:21.216617 12510 azure.go:31] AZURE_CREDENTIAL_FILE env var set as /tmp/azure.json I0923 20:50:21.218] I0923 20:50:21.216926 12510 azure_auth.go:86] azure: using client_id+client_secret to retrieve access token I0923 20:50:21.218] I0923 20:50:21.217091 12510 mount_linux.go:156] Detected OS without systemd I0923 20:50:21.218] I0923 20:50:21.217149 12510 driver.go:80] Enabling controller service capability: CREATE_DELETE_VOLUME I0923 20:50:21.218] I0923 20:50:21.217159 12510 driver.go:80] Enabling controller service capability: CREATE_DELETE_SNAPSHOT I0923 20:50:21.218] I0923 20:50:21.217165 12510 driver.go:99] Enabling volume access mode: SINGLE_NODE_WRITER I0923 20:50:21.218] I0923 20:50:21.217171 12510 driver.go:99] Enabling volume access mode: SINGLE_NODE_READER_ONLY I0923 20:50:21.219] I0923 20:50:21.217176 12510 driver.go:99] Enabling volume access mode: MULTI_NODE_READER_ONLY I0923 20:50:21.219] I0923 20:50:21.217182 12510 driver.go:99] Enabling volume access mode: MULTI_NODE_SINGLE_WRITER I0923 20:50:21.219] I0923 20:50:21.217186 12510 driver.go:99] Enabling volume access mode: MULTI_NODE_MULTI_WRITER I0923 20:50:21.219] I0923 20:50:21.217193 12510 driver.go:90] Enabling node service capability: UNKNOWN I0923 20:50:21.219] I0923 20:50:21.217294 12510 server.go:104] Listening for connections on address: &net.TCPAddr{IP:net.IP{0x7f, 0x0, 0x0, 0x1}, Port:10000, Zone:""} I0923 20:50:46.203] Create volume test: I0923 20:50:46.209] I0923 20:50:46.209416 12510 utils.go:111] GRPC call: /csi.v1.Controller/CreateVolume I0923 20:50:46.209] I0923 20:50:46.209444 12510 utils.go:112] GRPC request: name:"citest-1569271821" capacity_range: volume_capabilities: access_mode: > parameters: I0923 20:50:46.210] I0923 20:50:46.209460 12510 controllerserver.go:95] begin to create file share(citest-1569271821) on account() type(Standard_LRS) rg() location() size(2) I0923 20:50:47.105] E0923 20:50:47.104390 12510 utils.go:116] GRPC error: failed to create file share(citest-1569271821) on account() type(Standard_LRS) rg() location() size(2), error: could not get storage key for storage account : could not list storage accounts for account type Standard_LRS: azure.BearerAuthorizer#WithAuthorization: Failed to refresh the Token for request to https://management.chinacloudapi.cn/subscriptions/940f88ce-a64b-4e73-a258-9931349b9789/resourceGroups/azurefile-csi-driver-test-bfe5ec95-de43-11e9-94bf-e23abe942fef/providers/Microsoft.Storage/storageAccounts?api-version=2018-07-01: StatusCode=400 -- Original Error: adal: Refresh request failed. Status Code = '400'. Response body: {"error":"invalid_request","error_description":"AADSTS90002: Tenant '72f988bf-86f1-41af-91ab-2d7cd011db47' not found. This may happen if there are no active subscriptions for the tenant. Check with your subscription administrator.\r\nTrace ID: 28eeb5be-abfd-4402-9f2b-ce1195584500\r\nCorrelation ID: 0c9169ef-4842-431a-be95-dbfcb69ebe2e\r\nTimestamp: 2019-09-23 20:50:46Z","error_codes":[90002],"timestamp":"2019-09-23 20:50:46Z","trace_id":"28eeb5be-abfd-4402-9f2b-ce1195584500","correlation_id":"0c9169ef-4842-431a-be95-dbfcb69ebe2e","error_uri":"https://login.chinacloudapi.cn/error?code=90002"} I0923 20:50:47.106] failed to create file share(citest-1569271821) on account() type(Standard_LRS) rg() location() size(2), error: could not get storage key for storage account : could not list storage accounts for account type Standard_LRS: azure.BearerAuthorizer#WithAuthorization: Failed to refresh the Token for request to https://management.chinacloudapi.cn/subscriptions/940f88ce-a64b-4e73-a258-9931349b9789/resourceGroups/azurefile-csi-driver-test-bfe5ec95-de43-11e9-94bf-e23abe942fef/providers/Microsoft.Storage/storageAccounts?api-version=2018-07-01: StatusCode=400 -- Original Error: adal: Refresh request failed. Status Code = '400'. Response body: {"error":"invalid_request","error_description":"AADSTS90002: Tenant '72f988bf-86f1-41af-91ab-2d7cd011db47' not found. This may happen if there are no active subscriptions for the tenant. Check with your subscription administrator.\r\nTrace ID: 28eeb5be-abfd-4402-9f2b-ce1195584500\r\nCorrelation ID: 0c9169ef-4842-431a-be95-dbfcb69ebe2e\r\nTimestamp: 2019-09-23 20:50:46Z","error_codes":[90002],"timestamp":"2019-09-23 20:50:46Z","trace_id":"28eeb5be-abfd-4402-9f2b-ce1195584500","correlation_id":"0c9169ef-4842-431a-be95-dbfcb69ebe2e","error_uri":"https://login.chinacloudapi.cn/error?code=90002"} I0923 20:50:47.106] I0923 20:50:47.106] Please use -h,--help for more information I0923 20:51:02.110] Got volume id: I0923 20:51:02.116] I0923 20:51:02.116433 12510 utils.go:111] GRPC call: /csi.v1.Controller/ValidateVolumeCapabilities I0923 20:51:02.116] I0923 20:51:02.116479 12510 utils.go:112] GRPC request: volume_capabilities: access_mode: > I0923 20:51:02.117] E0923 20:51:02.116487 12510 utils.go:116] GRPC error: rpc error: code = InvalidArgument desc = Volume ID missing in request I0923 20:51:02.117] Volume ID missing in request I0923 20:51:02.117] I0923 20:51:02.117] Please use -h,--help for more information I0923 20:51:02.118] pkill -f azurefileplugin I0923 20:51:02.121] --- FAIL: TestIntegrationOnAzureChinaCloud (44.60s) I0923 20:51:02.121] integration_test.go:67: Creating resource group azurefile-csi-driver-test-bfe5ec95-de43-11e9-94bf-e23abe942fef in AzureChinaCloud I0923 20:51:02.122] integration_test.go:69: I0923 20:51:02.122] Error Trace: integration_test.go:69 I0923 20:51:02.122] integration_test.go:57 I0923 20:51:02.122] Error: Received unexpected error: I0923 20:51:02.123] azure.BearerAuthorizer#WithAuthorization: Failed to refresh the Token for request to https://management.chinacloudapi.cn/subscriptions/940f88ce-a64b-4e73-a258-9931349b9789/resourcegroups/azurefile-csi-driver-test-bfe5ec95-de43-11e9-94bf-e23abe942fef?api-version=2018-05-01: StatusCode=400 -- Original Error: adal: Refresh request failed. Status Code = '400'. Response body: {"error":"invalid_request","error_description":"AADSTS90002: Tenant '72f988bf-86f1-41af-91ab-2d7cd011db47' not found. This may happen if there are no active subscriptions for the tenant. Check with your subscription administrator.\r\nTrace ID: 0f3716ac-726c-4d7f-b0e4-6f5a3b055200\r\nCorrelation ID: 4613d399-d032-4fbc-a15c-05a1eca78f14\r\nTimestamp: 2019-09-23 20:50:18Z","error_codes":[90002],"timestamp":"2019-09-23 20:50:18Z","trace_id":"0f3716ac-726c-4d7f-b0e4-6f5a3b055200","correlation_id":"4613d399-d032-4fbc-a15c-05a1eca78f14","error_uri":"https://login.chinacloudapi.cn/error?code=90002"} I0923 20:51:02.123] Test: TestIntegrationOnAzureChinaCloud I0923 20:51:02.124] integration_test.go:89: Integration test failed exit status 3 I0923 20:51:02.124] FAIL I0923 20:51:02.124] FAIL github.com/kubernetes-sigs/azurefile-csi-driver/test/integration 180.378s I0923 20:51:02.164] Makefile:54: recipe for target 'integration-test' failed W0923 20:51:02.169] make: *** [integration-test] Error 1 W0923 20:51:02.169] Traceback (most recent call last): W0923 20:51:02.170] File "/workspace/./test-infra/jenkins/../scenarios/execute.py", line 50, in W0923 20:51:02.170] main(ARGS.env, ARGS.cmd + ARGS.args) W0923 20:51:02.170] File "/workspace/./test-infra/jenkins/../scenarios/execute.py", line 41, in main W0923 20:51:02.170] check(*cmd) W0923 20:51:02.170] File "/workspace/./test-infra/jenkins/../scenarios/execute.py", line 30, in check W0923 20:51:02.170] subprocess.check_call(cmd) W0923 20:51:02.171] File "/usr/lib/python2.7/subprocess.py", line 186, in check_call W0923 20:51:02.171] raise CalledProcessError(retcode, cmd) W0923 20:51:02.171] subprocess.CalledProcessError: Command '('make', 'integration-test')' returned non-zero exit status 2 E0923 20:51:02.171] Command failed I0923 20:51:02.171] process 456 exited with code 1 after 6.7m E0923 20:51:02.172] FAIL: pull-azurefile-csi-driver-integration I0923 20:51:02.172] Call: gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json W0923 20:51:03.107] Activated service account credentials for: [kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com] I0923 20:51:03.139] process 12546 exited with code 0 after 0.0m I0923 20:51:03.140] Call: gcloud config get-value account I0923 20:51:03.396] process 12558 exited with code 0 after 0.0m I0923 20:51:03.397] Will upload results to gs://kubernetes-upstream/pr-logs using kubernetes-upstream@kubernetes-upstream.iam.gserviceaccount.com I0923 20:51:03.397] Upload result and artifacts... I0923 20:51:03.397] Gubernator results at https://gubernator.k8s.io/build/kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-integration/1176235715755773955 W0923 20:51:03.397] Missing local artifacts : /workspace/_artifacts W0923 20:51:03.398] metadata path /workspace/_artifacts/metadata.json does not exist W0923 20:51:03.398] metadata not found or invalid, init with empty metadata I0923 20:51:03.398] Call: git rev-parse HEAD I0923 20:51:03.401] process 12570 exited with code 0 after 0.0m I0923 20:51:03.401] Call: git rev-parse HEAD I0923 20:51:03.404] process 12571 exited with code 0 after 0.0m I0923 20:51:03.404] Call: gsutil stat gs://kubernetes-upstream/pr-logs/directory/pull-azurefile-csi-driver-integration/jobResultsCache.json I0923 20:51:04.445] process 12572 exited with code 0 after 0.0m I0923 20:51:04.446] Call: gsutil -q cat 'gs://kubernetes-upstream/pr-logs/directory/pull-azurefile-csi-driver-integration/jobResultsCache.json#1569270828826468' I0923 20:51:05.597] process 12714 exited with code 0 after 0.0m I0923 20:51:05.598] Call: gsutil -q -h Content-Type:application/json -h x-goog-if-generation-match:1569270828826468 cp /tmp/gsutil_17kGEh gs://kubernetes-upstream/pr-logs/directory/pull-azurefile-csi-driver-integration/jobResultsCache.json I0923 20:51:07.030] process 12858 exited with code 0 after 0.0m I0923 20:51:07.030] Call: gsutil stat gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-integration/jobResultsCache.json I0923 20:51:08.064] process 13036 exited with code 0 after 0.0m I0923 20:51:08.065] Call: gsutil -q cat 'gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-integration/jobResultsCache.json#1569270832446657' I0923 20:51:09.361] process 13178 exited with code 0 after 0.0m I0923 20:51:09.362] Call: gsutil -q -h Content-Type:application/json -h x-goog-if-generation-match:1569270832446657 cp /tmp/gsutil_r2D9DT gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-integration/jobResultsCache.json I0923 20:51:10.829] process 13322 exited with code 0 after 0.0m I0923 20:51:10.830] Call: gsutil -q -h Content-Type:application/json cp /tmp/gsutil_6bZEWz gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-integration/1176235715755773955/finished.json I0923 20:51:12.305] process 13500 exited with code 0 after 0.0m I0923 20:51:12.306] Call: gsutil -q -h Content-Type:text/plain -h 'Cache-Control:private, max-age=0, no-transform' cp /tmp/gsutil_HjGjg6 gs://kubernetes-upstream/pr-logs/pull/kubernetes-sigs_azurefile-csi-driver/120/pull-azurefile-csi-driver-integration/latest-build.txt I0923 20:51:13.796] process 13678 exited with code 0 after 0.0m I0923 20:51:13.797] Call: gsutil -q -h Content-Type:text/plain -h 'Cache-Control:private, max-age=0, no-transform' cp /tmp/gsutil_VQXlir gs://kubernetes-upstream/pr-logs/directory/pull-azurefile-csi-driver-integration/latest-build.txt I0923 20:51:15.210] process 13856 exited with code 0 after 0.0m