Pull request #2318 updated 14:27:53 Connecting to https://api.github.com using docker-jenkins/****** (docker-jenkins GitHub credentials) Obtained Jenkinsfile from f26e9a3a61dc2f4e6b78627fb96ec31e3ccc914f+787e6387b7f33538bb5123b639b517feb1e29025 (308c615fde4030e1930c43c951e2c8a054e38121) Running in Durability level: PERFORMANCE_OPTIMIZED Loading library jps@master Examining docker/jps Attempting to resolve master as a branch Resolved master as branch master at revision 26028d2ce48352c9b2c3f496e963b79a4944a426 using credential jps-reader > git rev-parse --is-inside-work-tree # timeout=10 Fetching changes from the remote Git repository > git config remote.origin.url https://github.com/docker/jps.git # timeout=10 Fetching without tags Fetching upstream changes from https://github.com/docker/jps.git > git --version # timeout=10 using GIT_ASKPASS to set credentials GitHub credentials for docker/jps > git fetch --no-tags --progress -- https://github.com/docker/jps.git +refs/heads/master:refs/remotes/origin/master Checking out Revision 26028d2ce48352c9b2c3f496e963b79a4944a426 (master) > git config core.sparsecheckout # timeout=10 > git checkout -f 26028d2ce48352c9b2c3f496e963b79a4944a426 Commit message: "[TAR-1227] Run the sonar container as the current user (#17)" > git rev-list --no-walk 26028d2ce48352c9b2c3f496e963b79a4944a426 # timeout=10 [Pipeline] Start of Pipeline [Pipeline] node Running on EC2 (managed-agents) - ubuntu-1804-overlay2 (i-00057fc8e017db096) in /home/ubuntu/workspace/cli_PR-2318 [Pipeline] { [Pipeline] withDockerRegistry $ docker login -u dockerbuildbot -p ******** https://index.docker.io/v1/ WARNING! Using --password via the CLI is insecure. Use --password-stdin. WARNING! Your password will be stored unencrypted in /home/ubuntu/workspace/cli_PR-2318@tmp/f6c5bb54-4f0c-4dab-944a-004aa836090e/config.json. Configure a credential helper to remove this warning. See https://docs.docker.com/engine/reference/commandline/login/#credentials-store Login Succeeded [Pipeline] { [Pipeline] wrap [Pipeline] { [Pipeline] wrap [Pipeline] { [Pipeline] echo 14:27:56 cleanWorkspace: Ensuring workspace is owned by ubuntu [Pipeline] echo 14:27:56 chowning workspace [Pipeline] sh 14:27:56 + uname -m [Pipeline] sh 14:27:57 + pwd 14:27:57 + id -u 14:27:57 + id -g 14:27:57 + docker run --rm -v /home/ubuntu/workspace/cli_PR-2318:/workspace busybox chown -R 1000:1000 /workspace [Pipeline] echo 14:27:57 Removing all docker containers [Pipeline] sh 14:27:58 + docker container ls -aq [Pipeline] echo 14:27:58 Docker containers have been removed [Pipeline] echo 14:27:58 cleanWorkspace: Removing existing workspace [Pipeline] deleteDir [Pipeline] echo 14:27:58 cleanWorkspace: Workspace is clean. [Pipeline] timeout 14:27:58 Timeout set to expire in 1 hr 0 min [Pipeline] { [Pipeline] stage 14:27:58 Using the ‘stage’ step without a block argument is deprecated 14:27:58 Entering stage Git Checkout 14:27:58 Proceeding [Pipeline] checkout 14:27:58 using credential docker-jenkins-github-credentials 14:27:58 Cloning the remote Git repository 14:27:58 Cloning with configured refspecs honoured and without tags Cloning repository https://github.com/docker/cli.git > git init /home/ubuntu/workspace/cli_PR-2318 # timeout=10 Fetching upstream changes from https://github.com/docker/cli.git > git --version # timeout=10 using GIT_ASKPASS to set credentials docker-jenkins GitHub credentials > git fetch --no-tags --progress -- https://github.com/docker/cli.git +refs/pull/2318/head:refs/remotes/origin/PR-2318 +refs/heads/master:refs/remotes/origin/master 14:28:01 Fetching without tags > git config remote.origin.url https://github.com/docker/cli.git # timeout=10 > git config --add remote.origin.fetch +refs/pull/2318/head:refs/remotes/origin/PR-2318 # timeout=10 > git config --add remote.origin.fetch +refs/heads/master:refs/remotes/origin/master # timeout=10 > git config remote.origin.url https://github.com/docker/cli.git # timeout=10 Fetching upstream changes from https://github.com/docker/cli.git using GIT_ASKPASS to set credentials docker-jenkins GitHub credentials > git fetch --no-tags --progress -- https://github.com/docker/cli.git +refs/pull/2318/head:refs/remotes/origin/PR-2318 +refs/heads/master:refs/remotes/origin/master 14:28:01 Merging remotes/origin/master commit 787e6387b7f33538bb5123b639b517feb1e29025 into PR head commit f26e9a3a61dc2f4e6b78627fb96ec31e3ccc914f 14:28:02 Merge succeeded, producing 3607f3009fe8f18c91470855989d15d0ceb81075 14:28:02 Checking out Revision 3607f3009fe8f18c91470855989d15d0ceb81075 (PR-2318) > git config core.sparsecheckout # timeout=10 > git checkout -f f26e9a3a61dc2f4e6b78627fb96ec31e3ccc914f > git merge 787e6387b7f33538bb5123b639b517feb1e29025 # timeout=10 > git rev-parse HEAD^{commit} # timeout=10 > git config core.sparsecheckout # timeout=10 > git checkout -f 3607f3009fe8f18c91470855989d15d0ceb81075 14:28:03 Commit message: "Merge commit '787e6387b7f33538bb5123b639b517feb1e29025' into HEAD" 14:28:03 First time build. Skipping changelog. > git rev-list --no-walk 31f3c4b98119e92b48fcbabb6137f5fb793d36fa # timeout=10 [Pipeline] stage 14:28:04 Using the ‘stage’ step without a block argument is deprecated 14:28:04 Entering stage Run end-to-end test suite 14:28:04 Proceeding [Pipeline] sh 14:28:04 + docker version 14:28:04 Client: Docker Engine - Community 14:28:04 Version: 19.03.5 14:28:04 API version: 1.40 14:28:04 Go version: go1.12.12 14:28:04 Git commit: 633a0ea838 14:28:04 Built: Wed Nov 13 07:29:52 2019 14:28:04 OS/Arch: linux/amd64 14:28:04 Experimental: false 14:28:04 14:28:04 Server: Docker Engine - Community 14:28:04 Engine: 14:28:04 Version: 19.03.5 14:28:04 API version: 1.40 (minimum version 1.12) 14:28:04 Go version: go1.12.12 14:28:04 Git commit: 633a0ea838 14:28:04 Built: Wed Nov 13 07:28:22 2019 14:28:04 OS/Arch: linux/amd64 14:28:04 Experimental: true 14:28:04 containerd: 14:28:04 Version: 1.2.10 14:28:04 GitCommit: b34a5c8af56e510852c35414db4c1f4fa6172339 14:28:04 runc: 14:28:04 Version: 1.0.0-rc8+dev 14:28:04 GitCommit: 3e425f80a8c931f88e6d94a8c831b9d5aa481657 14:28:04 docker-init: 14:28:04 Version: 0.18.0 14:28:04 GitCommit: fec3683 [Pipeline] sh 14:28:05 + docker info 14:28:05 Client: 14:28:05 Debug Mode: false 14:28:05 14:28:05 Server: 14:28:05 Containers: 0 14:28:05 Running: 0 14:28:05 Paused: 0 14:28:05 Stopped: 0 14:28:05 Images: 4 14:28:05 Server Version: 19.03.5 14:28:05 Storage Driver: overlay2 14:28:05 Backing Filesystem: extfs 14:28:05 Supports d_type: true 14:28:05 Native Overlay Diff: true 14:28:05 Logging Driver: json-file 14:28:05 Cgroup Driver: cgroupfs 14:28:05 Plugins: 14:28:05 Volume: local 14:28:05 Network: bridge host ipvlan macvlan null overlay 14:28:05 Log: awslogs fluentd gcplogs gelf journald json-file local logentries splunk syslog 14:28:05 Swarm: inactive 14:28:05 Runtimes: runc 14:28:05 Default Runtime: runc 14:28:05 Init Binary: docker-init 14:28:05 containerd version: b34a5c8af56e510852c35414db4c1f4fa6172339 14:28:05 runc version: 3e425f80a8c931f88e6d94a8c831b9d5aa481657 14:28:05 init version: fec3683 14:28:05 Security Options: 14:28:05 apparmor 14:28:05 seccomp 14:28:05 Profile: default 14:28:05 Kernel Version: 4.15.0-1058-aws 14:28:05 Operating System: Ubuntu 18.04.4 LTS 14:28:05 OSType: linux 14:28:05 Architecture: x86_64 14:28:05 CPUs: 2 14:28:05 Total Memory: 7.501GiB 14:28:05 Name: ip-10-100-58-147 14:28:05 ID: 4CEL:5RBS:HN5G:X27E:6LIB:NDG4:JTLL:Y3PR:KAD2:JK75:FX6D:PY32 14:28:05 Docker Root Dir: /var/lib/docker 14:28:05 Debug Mode: false 14:28:05 Username: dockerbuildbot 14:28:05 Registry: https://index.docker.io/v1/ 14:28:05 Labels: 14:28:05 Experimental: true 14:28:05 Insecure Registries: 14:28:05 127.0.0.0/8 14:28:05 Live Restore Enabled: true 14:28:05 14:28:05 WARNING: No swap limit support [Pipeline] sh 14:28:05 + E2E_UNIQUE_ID=clie2e2 IMAGE_TAG=clie2e2 DOCKER_BUILDKIT=1 make -f docker.Makefile test-e2e 14:28:05 docker build -t docker-cli-e2eclie2e2 --build-arg=GO_VERSION --build-arg VERSION=19.09.0-dev --build-arg GITCOMMIT= -f ./dockerfiles/Dockerfile.e2e . 14:28:05 #2 [internal] load .dockerignore 14:28:05 #2 transferring context: 100B done 14:28:05 #2 DONE 0.0s 14:28:05 14:28:05 #1 [internal] load build definition from Dockerfile.e2e 14:28:05 #1 transferring dockerfile: 1.64kB done 14:28:05 #1 DONE 0.0s 14:28:05 14:28:05 #3 [internal] load metadata for docker.io/library/golang:1.12.16 14:28:06 #3 DONE 0.3s 14:28:06 14:28:06 #10 [internal] load build context 14:28:07 #10 transferring context: 42.71MB 1.5s done 14:28:07 #10 DONE 1.5s 14:28:07 14:28:07 #4 [1/11] FROM docker.io/library/golang:1.12.16@sha256:2af961eaeceeafc5853b... 14:28:07 #4 resolve docker.io/library/golang:1.12.16@sha256:2af961eaeceeafc5853b28664c2742c33974c9eae5071d81b83858c55fc360eb done 14:28:07 #4 sha256:2af961eaeceeafc5853b28664c2742c33974c9eae5071d81b83858c55fc360eb 1.70kB / 1.70kB done 14:28:07 #4 sha256:b1d3a5f0755294df9034371beb53e01f632d23a285dee8db193df76d11d886fb 1.79kB / 1.79kB done 14:28:07 #4 sha256:0552a674ab7093c1651aa7be2ffc273ec846ae33ef1a2f905ed582901f69c9c8 116.06MB / 126.73MB 1.4s 14:28:07 #4 sha256:94143a8c04faf394dba01c7ff835d09af770a2d3809f894e24b4276cdfe892e6 126B / 126B 0.1s done 14:28:07 #4 sha256:adc8544f3a643abff38cf0cc9053623cb10e7902a37a2d2c8914dbbad28e15d7 5.46kB / 5.46kB done 14:28:07 #4 sha256:0552a674ab7093c1651aa7be2ffc273ec846ae33ef1a2f905ed582901f69c9c8 126.73MB / 126.73MB 1.5s 14:28:07 #4 sha256:0552a674ab7093c1651aa7be2ffc273ec846ae33ef1a2f905ed582901f69c9c8 126.73MB / 126.73MB 1.6s done 14:28:07 #4 extracting sha256:0552a674ab7093c1651aa7be2ffc273ec846ae33ef1a2f905ed582901f69c9c8 0.1s 14:28:12 #4 extracting sha256:0552a674ab7093c1651aa7be2ffc273ec846ae33ef1a2f905ed582901f69c9c8 3.8s done 14:28:12 #4 extracting sha256:94143a8c04faf394dba01c7ff835d09af770a2d3809f894e24b4276cdfe892e6 done 14:28:12 #4 DONE 5.9s 14:28:12 14:28:12 #5 [2/11] RUN apt-get update && apt-get install -y build-essential ... 14:28:12 #5 0.852 Get:1 http://deb.debian.org/debian buster InRelease [122 kB] 14:28:12 #5 0.852 Get:2 http://security.debian.org/debian-security buster/updates InRelease [65.4 kB] 14:28:12 #5 0.865 Get:3 http://deb.debian.org/debian buster-updates InRelease [49.3 kB] 14:28:12 #5 0.952 Get:4 http://security.debian.org/debian-security buster/updates/main amd64 Packages [176 kB] 14:28:13 #5 1.062 Get:5 http://deb.debian.org/debian buster/main amd64 Packages [7907 kB] 14:28:13 #5 1.194 Get:6 http://deb.debian.org/debian buster-updates/main amd64 Packages [5792 B] 14:28:14 #5 2.307 Fetched 8325 kB in 2s (4872 kB/s) 14:28:14 #5 2.307 Reading package lists... 14:28:15 #5 2.932 Reading package lists... 14:28:15 #5 3.542 Building dependency tree... 14:28:15 #5 3.672 Reading state information... 14:28:15 #5 3.785 curl is already the newest version (7.64.0-4). 14:28:15 #5 3.785 openssl is already the newest version (1.1.1d-0+deb10u2). 14:28:15 #5 3.785 openssl set to manually installed. 14:28:15 #5 3.785 The following additional packages will be installed: 14:28:15 #5 3.786 bzip2 dpkg-dev fakeroot libalgorithm-diff-perl libalgorithm-diff-xs-perl 14:28:15 #5 3.786 libalgorithm-merge-perl libfakeroot patch xz-utils 14:28:15 #5 3.787 Suggested packages: 14:28:15 #5 3.787 bzip2-doc debian-keyring keychain libpam-ssh monkeysphere ssh-askpass ed 14:28:15 #5 3.787 diffutils-doc 14:28:15 #5 3.787 Recommended packages: 14:28:15 #5 3.787 xauth 14:28:15 #5 3.857 The following NEW packages will be installed: 14:28:15 #5 3.858 build-essential bzip2 dpkg-dev fakeroot libalgorithm-diff-perl 14:28:15 #5 3.859 libalgorithm-diff-xs-perl libalgorithm-merge-perl libfakeroot patch xz-utils 14:28:15 #5 3.860 The following packages will be upgraded: 14:28:15 #5 3.860 openssh-client 14:28:16 #5 4.126 1 upgraded, 10 newly installed, 0 to remove and 10 not upgraded. 14:28:16 #5 4.126 Need to get 3124 kB of archives. 14:28:16 #5 4.126 After this operation, 3601 kB of additional disk space will be used. 14:28:16 #5 4.126 Get:1 http://deb.debian.org/debian buster/main amd64 bzip2 amd64 1.0.6-9.2~deb10u1 [48.4 kB] 14:28:16 #5 4.130 Get:2 http://deb.debian.org/debian buster/main amd64 openssh-client amd64 1:7.9p1-10+deb10u2 [782 kB] 14:28:16 #5 4.149 Get:3 http://deb.debian.org/debian buster/main amd64 xz-utils amd64 5.2.4-1 [183 kB] 14:28:16 #5 4.152 Get:4 http://deb.debian.org/debian buster/main amd64 patch amd64 2.7.6-3+deb10u1 [126 kB] 14:28:16 #5 4.153 Get:5 http://deb.debian.org/debian buster/main amd64 dpkg-dev all 1.19.7 [1773 kB] 14:28:16 #5 4.173 Get:6 http://deb.debian.org/debian buster/main amd64 build-essential amd64 12.6 [7576 B] 14:28:16 #5 4.173 Get:7 http://deb.debian.org/debian buster/main amd64 libfakeroot amd64 1.23-1 [45.9 kB] 14:28:16 #5 4.176 Get:8 http://deb.debian.org/debian buster/main amd64 fakeroot amd64 1.23-1 [85.8 kB] 14:28:16 #5 4.177 Get:9 http://deb.debian.org/debian buster/main amd64 libalgorithm-diff-perl all 1.19.03-2 [47.9 kB] 14:28:16 #5 4.178 Get:10 http://deb.debian.org/debian buster/main amd64 libalgorithm-diff-xs-perl amd64 0.04-5+b1 [11.8 kB] 14:28:16 #5 4.178 Get:11 http://deb.debian.org/debian buster/main amd64 libalgorithm-merge-perl all 0.08-3 [12.7 kB] 14:28:16 #5 4.290 debconf: delaying package configuration, since apt-utils is not installed 14:28:16 #5 4.315 Fetched 3124 kB in 0s (10.1 MB/s) 14:28:16 #5 4.333 Selecting previously unselected package bzip2. 14:28:16 #5 4.333 (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 ... 15401 files and directories currently installed.) 14:28:16 #5 4.343 Preparing to unpack .../00-bzip2_1.0.6-9.2~deb10u1_amd64.deb ... 14:28:16 #5 4.347 Unpacking bzip2 (1.0.6-9.2~deb10u1) ... 14:28:16 #5 4.384 Preparing to unpack .../01-openssh-client_1%3a7.9p1-10+deb10u2_amd64.deb ... 14:28:16 #5 4.403 Unpacking openssh-client (1:7.9p1-10+deb10u2) over (1:7.9p1-10+deb10u1) ... 14:28:16 #5 4.584 Selecting previously unselected package xz-utils. 14:28:16 #5 4.584 Preparing to unpack .../02-xz-utils_5.2.4-1_amd64.deb ... 14:28:16 #5 4.587 Unpacking xz-utils (5.2.4-1) ... 14:28:16 #5 4.643 Selecting previously unselected package patch. 14:28:16 #5 4.643 Preparing to unpack .../03-patch_2.7.6-3+deb10u1_amd64.deb ... 14:28:16 #5 4.646 Unpacking patch (2.7.6-3+deb10u1) ... 14:28:16 #5 4.683 Selecting previously unselected package dpkg-dev. 14:28:16 #5 4.683 Preparing to unpack .../04-dpkg-dev_1.19.7_all.deb ... 14:28:16 #5 4.686 Unpacking dpkg-dev (1.19.7) ... 14:28:16 #5 4.789 Selecting previously unselected package build-essential. 14:28:16 #5 4.791 Preparing to unpack .../05-build-essential_12.6_amd64.deb ... 14:28:16 #5 4.794 Unpacking build-essential (12.6) ... 14:28:16 #5 4.822 Selecting previously unselected package libfakeroot:amd64. 14:28:16 #5 4.824 Preparing to unpack .../06-libfakeroot_1.23-1_amd64.deb ... 14:28:16 #5 4.830 Unpacking libfakeroot:amd64 (1.23-1) ... 14:28:16 #5 4.866 Selecting previously unselected package fakeroot. 14:28:16 #5 4.868 Preparing to unpack .../07-fakeroot_1.23-1_amd64.deb ... 14:28:16 #5 4.872 Unpacking fakeroot (1.23-1) ... 14:28:16 #5 4.904 Selecting previously unselected package libalgorithm-diff-perl. 14:28:16 #5 4.904 Preparing to unpack .../08-libalgorithm-diff-perl_1.19.03-2_all.deb ... 14:28:16 #5 4.907 Unpacking libalgorithm-diff-perl (1.19.03-2) ... 14:28:16 #5 4.936 Selecting previously unselected package libalgorithm-diff-xs-perl. 14:28:16 #5 4.938 Preparing to unpack .../09-libalgorithm-diff-xs-perl_0.04-5+b1_amd64.deb ... 14:28:16 #5 4.942 Unpacking libalgorithm-diff-xs-perl (0.04-5+b1) ... 14:28:16 #5 4.966 Selecting previously unselected package libalgorithm-merge-perl. 14:28:16 #5 4.968 Preparing to unpack .../10-libalgorithm-merge-perl_0.08-3_all.deb ... 14:28:16 #5 4.972 Unpacking libalgorithm-merge-perl (0.08-3) ... 14:28:16 #5 5.007 Setting up libalgorithm-diff-perl (1.19.03-2) ... 14:28:16 #5 5.018 Setting up openssh-client (1:7.9p1-10+deb10u2) ... 14:28:16 #5 5.045 Setting up bzip2 (1.0.6-9.2~deb10u1) ... 14:28:16 #5 5.055 Setting up libfakeroot:amd64 (1.23-1) ... 14:28:16 #5 5.066 Setting up fakeroot (1.23-1) ... 14:28:16 #5 5.074 update-alternatives: using /usr/bin/fakeroot-sysv to provide /usr/bin/fakeroot (fakeroot) in auto mode 14:28:16 #5 5.084 Setting up xz-utils (5.2.4-1) ... 14:28:16 #5 5.092 update-alternatives: using /usr/bin/xz to provide /usr/bin/lzma (lzma) in auto mode 14:28:16 #5 5.099 Setting up patch (2.7.6-3+deb10u1) ... 14:28:16 #5 5.107 Setting up libalgorithm-diff-xs-perl (0.04-5+b1) ... 14:28:17 #5 5.118 Setting up libalgorithm-merge-perl (0.08-3) ... 14:28:17 #5 5.130 Setting up dpkg-dev (1.19.7) ... 14:28:17 #5 5.148 Setting up build-essential (12.6) ... 14:28:17 #5 5.156 Processing triggers for libc-bin (2.28-10) ... 14:28:18 #5 DONE 6.6s 14:28:18 14:28:18 #6 [3/11] RUN curl -L https://github.com/docker/compose/releases/download/1... 14:28:19 #6 0.629 % Total % Received % Xferd Average Speed Time Time Time Current 14:28:19 #6 0.630 Dload Upload Total Spent Left Speed 14:28:19 #6 0.631 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 617 0 617 0 0 5141 0 --:--:-- --:--:-- --:--:-- 5141 14:28:19 #6 0.928 100 16.2M 100 16.2M 0 0 54.3M 0 --:--:-- --:--:-- --:--:-- 54.3M 14:28:19 #6 DONE 1.1s 14:28:19 14:28:19 #7 [4/11] RUN curl -Ls https://github.com/theupdateframework/notary/release... 14:28:20 #7 DONE 1.1s 14:28:20 14:28:20 #8 [5/11] RUN curl -Ls https://github.com/gotestyourself/gotestsum/releases... 14:28:21 #8 DONE 1.0s 14:28:21 14:28:21 #9 [6/11] WORKDIR /go/src/github.com/docker/cli 14:28:21 #9 DONE 0.0s 14:28:21 14:28:21 #11 [7/11] COPY e2e/testdata/notary/root-ca.cert /usr/share/ca-certificates/... 14:28:21 #11 DONE 0.1s 14:28:21 14:28:21 #12 [8/11] RUN echo 'notary.cert' >> /etc/ca-certificates.conf && update-ca-... 14:28:22 #12 0.643 Updating certificates in /etc/ssl/certs... 14:28:22 #12 1.124 1 added, 0 removed; done. 14:28:22 #12 1.124 Running hooks in /etc/ca-certificates/update.d... 14:28:22 #12 1.125 done. 14:28:22 #12 DONE 1.2s 14:28:22 14:28:22 #13 [9/11] COPY . . 14:28:23 #13 DONE 0.7s 14:28:23 14:28:23 #14 [10/11] RUN ./scripts/build/binary 14:28:24 #14 0.585 Building statically linked build/docker-linux-amd64 14:29:45 #14 DONE 76.5s 14:29:45 14:29:45 #15 [11/11] RUN ./scripts/build/plugins e2e/cli-plugins/plugins/* 14:29:45 #15 0.645 Building statically linked build/plugins-linux-amd64/docker-helloworld 14:29:45 #15 2.013 Building statically linked build/plugins-linux-amd64/docker-badmeta 14:29:45 #15 3.083 Building statically linked build/plugins-linux-amd64/docker-nopersistentprerun 14:29:45 #15 DONE 4.4s 14:29:45 14:29:45 #16 exporting to image 14:29:45 #16 exporting layers 14:29:46 #16 exporting layers 2.3s done 14:29:46 #16 writing image sha256:d7b11c8954439a9fbf045b33facc095328ce7befe6f4c1129b12f59dfabea8b0 done 14:29:46 #16 naming to docker.io/library/docker-cli-e2eclie2e2 done 14:29:46 #16 DONE 2.3s 14:29:46 docker run --rm -v /var/run/docker.sock:/var/run/docker.sock -e VERSION=19.09.0-dev -e GITCOMMIT -e PLATFORM -e TESTFLAGS -e TESTDIRS -e GOOS -e GOARCH -e GOARM docker-cli-e2eclie2e2 14:29:48 Native build is an experimental feature and could change at any time 14:29:48 Creating network "cliendtoendsuite_default" with the default driver 14:29:48 Pulling registry (registry:2)... 14:29:48 2: Pulling from library/registry 14:29:49 Digest: sha256:7d081088e4bfd632a88e3f3bcd9e007ef44a796fddfe3261407a3f9f04abe1e7 14:29:49 Status: Downloaded newer image for registry:2 14:29:49 Pulling engine (docker:stable-dind)... 14:29:49 stable-dind: Pulling from library/docker 14:29:53 Digest: sha256:033ba84f8ea98910d8fc51b8263fbeb24c48d6daf55ef7c654e2981784dac2f4 14:29:53 Status: Downloaded newer image for docker:stable-dind 14:29:53 Building notary-server 14:29:53 #2 [internal] load .dockerignore 14:29:53 #2 transferring context: 2B done 14:29:53 #2 DONE 0.0s 14:29:53 14:29:53 #1 [internal] load build definition from Dockerfile.notary-server 14:29:53 #1 transferring dockerfile: 140B done 14:29:53 #1 DONE 0.0s 14:29:53 14:29:53 #3 [internal] load metadata for docker.io/library/notary:server-0.5.0 14:29:53 #3 DONE 0.3s 14:29:53 14:29:53 #4 [1/2] FROM docker.io/library/notary:server-0.5.0@sha256:d59e4ecc20198447... 14:29:53 #4 resolve docker.io/library/notary:server-0.5.0@sha256:d59e4ecc20198447a9818e7f16d0a02ba1d9905de71e5354bc8ee0017304a244 done 14:29:53 #4 ... 14:29:53 14:29:53 #5 [internal] load build context 14:29:53 #5 transferring context: 8.26kB done 14:29:53 #5 DONE 0.0s 14:29:53 14:29:53 #4 [1/2] FROM docker.io/library/notary:server-0.5.0@sha256:d59e4ecc20198447... 14:29:53 #4 sha256:176147d1183da92e05482a5560407bfc56af52bc61b1cb5bdb323d4c7d6a8867 0B / 411B 0.1s 14:29:53 #4 sha256:9504875b8162730788ff7df926b72bcbb2bae4690f5195b6d62ec961ffc12056 0B / 4.03MB 0.1s 14:29:53 #4 sha256:d59e4ecc20198447a9818e7f16d0a02ba1d9905de71e5354bc8ee0017304a244 434B / 434B done 14:29:53 #4 sha256:88bddb53072ae1b018b3b09ac1974be903800e3595ec31401fc3c73ffb66affd 1.36kB / 1.36kB done 14:29:53 #4 sha256:16b632e954ca01326ecc36ff0c7bb651baf9dcf92366b322b112f697193eb3d5 3.40kB / 3.40kB done 14:29:53 #4 sha256:4fe2ade4980c2dda4fc95858ebb981489baec8c1e4bd282ab1c3560be8ff9bde 0B / 2.21MB 0.1s 14:29:53 #4 sha256:176147d1183da92e05482a5560407bfc56af52bc61b1cb5bdb323d4c7d6a8867 411B / 411B 0.1s done 14:29:53 #4 sha256:9504875b8162730788ff7df926b72bcbb2bae4690f5195b6d62ec961ffc12056 4.03MB / 4.03MB 0.2s done 14:29:53 #4 sha256:4fe2ade4980c2dda4fc95858ebb981489baec8c1e4bd282ab1c3560be8ff9bde 2.21MB / 2.21MB 0.1s done 14:29:53 #4 extracting sha256:4fe2ade4980c2dda4fc95858ebb981489baec8c1e4bd282ab1c3560be8ff9bde 0.1s done 14:29:53 #4 sha256:070baad58e0d2d397143ab9f03defb8b016fc8d57eab900d496727c0e2e00292 377B / 377B 0.2s done 14:29:53 #4 sha256:b9ff31535c882e16ca7c737f9b9852e6b03e10cd1cd3fdf653beecdedf3dffff 0B / 1.19kB 0.2s 14:29:54 #4 sha256:b9ff31535c882e16ca7c737f9b9852e6b03e10cd1cd3fdf653beecdedf3dffff 1.19kB / 1.19kB 0.2s done 14:29:54 #4 extracting sha256:176147d1183da92e05482a5560407bfc56af52bc61b1cb5bdb323d4c7d6a8867 done 14:29:54 #4 extracting sha256:9504875b8162730788ff7df926b72bcbb2bae4690f5195b6d62ec961ffc12056 14:29:54 #4 extracting sha256:9504875b8162730788ff7df926b72bcbb2bae4690f5195b6d62ec961ffc12056 0.2s done 14:29:54 #4 extracting sha256:070baad58e0d2d397143ab9f03defb8b016fc8d57eab900d496727c0e2e00292 14:29:54 #4 extracting sha256:070baad58e0d2d397143ab9f03defb8b016fc8d57eab900d496727c0e2e00292 done 14:29:54 #4 extracting sha256:b9ff31535c882e16ca7c737f9b9852e6b03e10cd1cd3fdf653beecdedf3dffff done 14:29:54 #4 DONE 0.8s 14:29:54 14:29:54 #6 [2/2] COPY ./notary/ /fixtures/ 14:29:55 #6 DONE 0.8s 14:29:55 14:29:55 #7 exporting to image 14:29:55 #7 exporting layers 0.0s done 14:29:55 #7 writing image sha256:78fe82fb9477a78946458bcfbab41bb8849b0650a7eedb46980e685ae0b96381 done 14:29:55 #7 naming to docker.io/library/cliendtoendsuite_notary-server done 14:29:55 #7 DONE 0.0s 14:29:55 Successfully built 78fe82fb9477a78946458bcfbab41bb8849b0650a7eedb46980e685ae0b96381 14:29:55 Building evil-notary-server 14:29:55 #2 [internal] load .dockerignore 14:29:55 #2 transferring context: 2B done 14:29:55 #2 DONE 0.0s 14:29:55 14:29:55 #1 [internal] load build definition from Dockerfile.evil-notary-server 14:29:55 #1 transferring dockerfile: 150B done 14:29:55 #1 DONE 0.0s 14:29:55 14:29:55 #3 [internal] load metadata for docker.io/library/notary:server-0.5.0 14:29:55 #3 DONE 0.0s 14:29:55 14:29:55 #4 [1/2] FROM docker.io/library/notary:server-0.5.0@sha256:d59e4ecc20198447... 14:29:55 #4 CACHED 14:29:55 14:29:55 #5 [internal] load build context 14:29:55 #5 transferring context: 8.29kB done 14:29:55 #5 DONE 0.0s 14:29:55 14:29:55 #6 [2/2] COPY ./notary-evil/ /fixtures/ 14:29:55 #6 DONE 0.1s 14:29:55 14:29:55 #7 exporting to image 14:29:55 #7 exporting layers 0.0s done 14:29:55 #7 writing image sha256:571198fe7f9fc3181f9fef4eb7d6d68921edf6e2623d48ce0529e25fde7d20dc done 14:29:55 #7 naming to docker.io/library/cliendtoendsuite_evil-notary-server done 14:29:55 #7 DONE 0.0s 14:29:55 Successfully built 571198fe7f9fc3181f9fef4eb7d6d68921edf6e2623d48ce0529e25fde7d20dc 14:29:55 Creating cliendtoendsuite_notary-server_1 ... 14:29:55 Creating cliendtoendsuite_evil-notary-server_1 ... 14:29:55 Creating cliendtoendsuite_registry_1 ... 14:29:55 Creating cliendtoendsuite_engine_1 ... 14:30:00  Creating cliendtoendsuite_evil-notary-server_1 ... done  Creating cliendtoendsuite_engine_1 ... done  Creating cliendtoendsuite_registry_1 ... done  Creating cliendtoendsuite_notary-server_1 ... done Waiting for docker daemon to become available at tcp://172.18.0.5:2375 14:30:00 Client: 14:30:00 Version: 19.09.0-dev 14:30:00 API version: 1.40 (downgraded from 1.41) 14:30:00 Go version: go1.12.16 14:30:00 Git commit: 14:30:00 Built: Mon Feb 10 14:28:24 2020 14:30:00 OS/Arch: linux/amd64 14:30:00 Experimental: false 14:30:00 14:30:00 Server: Docker Engine - Community 14:30:00 Engine: 14:30:00 Version: 19.03.5 14:30:00 API version: 1.40 (minimum version 1.12) 14:30:00 Go version: go1.12.12 14:30:00 Git commit: 633a0ea838 14:30:00 Built: Wed Nov 13 07:28:45 2019 14:30:00 OS/Arch: linux/amd64 14:30:00 Experimental: false 14:30:00 containerd: 14:30:00 Version: v1.2.10 14:30:00 GitCommit: b34a5c8af56e510852c35414db4c1f4fa6172339 14:30:00 runc: 14:30:00 Version: 1.0.0-rc8+dev 14:30:00 GitCommit: 3e425f80a8c931f88e6d94a8c831b9d5aa481657 14:30:00 docker-init: 14:30:00 Version: 0.18.0 14:30:00 GitCommit: fec3683 14:30:00 sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d: Pulling from library/alpine 14:30:00 88286f41530e: Pulling fs layer 14:30:00 88286f41530e: Download complete 14:30:01 88286f41530e: Pull complete 14:30:01 Digest: sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d 14:30:01 Status: Downloaded newer image for alpine@sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d 14:30:01 docker.io/library/alpine@sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d 14:30:01 The push refers to repository [registry:5000/alpine] 14:30:01 5bef08742407: Preparing 14:30:01 5bef08742407: Pushed 14:30:01 3.6: digest: sha256:641b95ddb2ea9dc2af1a0113b6b348ebc20872ba615204fbe12148e98fd6f23d size: 528 14:30:01 sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7: Pulling from library/busybox 14:30:01 03b1be98f3f9: Pulling fs layer 14:30:01 03b1be98f3f9: Verifying Checksum 14:30:01 03b1be98f3f9: Download complete 14:30:02 03b1be98f3f9: Pull complete 14:30:02 Digest: sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7 14:30:02 Status: Downloaded newer image for busybox@sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7 14:30:02 docker.io/library/busybox@sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7 14:30:02 The push refers to repository [registry:5000/busybox] 14:30:02 6a749002dd6a: Preparing 14:30:02 6a749002dd6a: Pushed 14:30:02 1.27.2: digest: sha256:030fcb92e1487b18c974784dcc110a93147c9fc402188370fbfd17efabffc6af size: 527 14:30:02 Swarm initialized: current node (iz7l3ah1lvlzm44c84ht3yggd) is now a manager. 14:30:02 14:30:02 To add a worker to this swarm, run the following command: 14:30:02 14:30:02 docker swarm join --token SWMTKN-1-5v1cbfi66fw4d4biaud4vsvimcxtgf392a4enctsgxh4flspmf-3p9or6sz4in6057crrk2qdq0o 172.18.0.5:2377 14:30:02 14:30:02 To add a manager to this swarm, run 'docker swarm join-token manager' and follow the instructions. 14:30:02 14:30:20 ✓ e2e/cli-plugins (2.646s) 14:30:20 ∅ e2e/cli-plugins/plugins/badmeta 14:30:20 ∅ e2e/cli-plugins/plugins/nopersistentprerun 14:30:20 ✓ e2e/context (40ms) 14:30:20 ✓ e2e/global (97ms) 14:30:27 ✓ e2e/container (9.772s) 14:30:32 ✓ e2e/plugin (3.734s) 14:30:33 ✓ e2e/image (11.743s) 14:30:33 ∅ e2e/internal/fixtures 14:30:33 ∅ e2e/plugin/basic 14:30:33 ✓ e2e/stack (667ms) 14:30:33 ✓ e2e/system (95ms) 14:30:36 ✓ e2e/trust (2.154s) 14:30:36 14:30:36 === Skipped 14:30:36 === SKIP: e2e/cli-plugins TestCLIPluginDialStdio (0.00s) 14:30:36 dial_test.go:16: skipping plugin dial-stdio test since DOCKER_CLI_PLUGIN_USE_DIAL_STDIO is not set 14:30:36 14:30:36 === SKIP: e2e/image TestBuildIidFileSquash (0.04s) 14:30:36 build_test.go:112: !experimentalBuild: running against a non-experimental daemon 14:30:36 14:30:36 === SKIP: e2e/stack TestDeployWithNamedResources/Kubernetes (0.00s) 14:30:36 --- SKIP: TestDeployWithNamedResources/Kubernetes (0.00s) 14:30:36 deploy_test.go:22: FIXME(chris-crone): currently does not work with compose for kubernetes. 14:30:36 14:30:36 === SKIP: e2e/stack TestRemove/Kubernetes (0.00s) 14:30:36 --- SKIP: TestRemove/Kubernetes (0.00s) 14:30:36 remove_test.go:22: !environment.KubernetesEnabled() 14:30:36 14:30:36 14:30:36 DONE 93 tests, 4 skipped in 33.559s 14:30:36 Stopping cliendtoendsuite_engine_1 ... 14:30:36 Stopping cliendtoendsuite_evil-notary-server_1 ... 14:30:36 Stopping cliendtoendsuite_registry_1 ... 14:30:36 Stopping cliendtoendsuite_notary-server_1 ... 14:30:38  Stopping cliendtoendsuite_evil-notary-server_1 ... done  Stopping cliendtoendsuite_notary-server_1 ... done  Stopping cliendtoendsuite_registry_1 ... done  Stopping cliendtoendsuite_engine_1 ... done Removing cliendtoendsuite_engine_1 ... 14:30:38 Removing cliendtoendsuite_evil-notary-server_1 ... 14:30:38 Removing cliendtoendsuite_registry_1 ... 14:30:38 Removing cliendtoendsuite_notary-server_1 ... 14:30:39  Removing cliendtoendsuite_notary-server_1 ... done  Removing cliendtoendsuite_evil-notary-server_1 ... done  Removing cliendtoendsuite_registry_1 ... done  Removing cliendtoendsuite_engine_1 ... done Removing network cliendtoendsuite_default 14:30:39 Removing image cliendtoendsuite_notary-server 14:30:39 Removing image cliendtoendsuite_evil-notary-server 14:30:39 docker run --rm -v /var/run/docker.sock:/var/run/docker.sock -e VERSION=19.09.0-dev -e GITCOMMIT -e PLATFORM -e TESTFLAGS -e TESTDIRS -e GOOS -e GOARCH -e GOARM -e DOCKERD_EXPERIMENTAL=1 docker-cli-e2eclie2e2 14:30:41 Native build is an experimental feature and could change at any time 14:30:41 Creating network "cliendtoendsuite_default" with the default driver 14:30:41 Building notary-server 14:30:41 #2 [internal] load .dockerignore 14:30:41 #2 transferring context: 2B done 14:30:41 #2 DONE 0.0s 14:30:41 14:30:41 #1 [internal] load build definition from Dockerfile.notary-server 14:30:41 #1 transferring dockerfile: 140B done 14:30:41 #1 DONE 0.0s 14:30:41 14:30:41 #3 [internal] load metadata for docker.io/library/notary:server-0.5.0 14:30:41 #3 DONE 0.1s 14:30:41 14:30:41 #4 [1/2] FROM docker.io/library/notary:server-0.5.0@sha256:d59e4ecc20198447... 14:30:41 #4 DONE 0.0s 14:30:41 14:30:41 #5 [internal] load build context 14:30:41 #5 transferring context: 8.26kB done 14:30:41 #5 DONE 0.0s 14:30:41 14:30:41 #6 [2/2] COPY ./notary/ /fixtures/ 14:30:41 #6 CACHED 14:30:41 14:30:41 #7 exporting to image 14:30:41 #7 exporting layers done 14:30:41 #7 writing image sha256:78fe82fb9477a78946458bcfbab41bb8849b0650a7eedb46980e685ae0b96381 done 14:30:41 #7 naming to docker.io/library/cliendtoendsuite_notary-server done 14:30:41 #7 DONE 0.0s 14:30:41 Successfully built 78fe82fb9477a78946458bcfbab41bb8849b0650a7eedb46980e685ae0b96381 14:30:41 Building evil-notary-server 14:30:41 #2 [internal] load .dockerignore 14:30:41 #2 transferring context: 2B done 14:30:41 #2 DONE 0.0s 14:30:41 14:30:41 #1 [internal] load build definition from Dockerfile.evil-notary-server 14:30:41 #1 transferring dockerfile: 150B done 14:30:41 #1 DONE 0.0s 14:30:41 14:30:41 #3 [internal] load metadata for docker.io/library/notary:server-0.5.0 14:30:41 #3 DONE 0.0s 14:30:41 14:30:41 #4 [1/2] FROM docker.io/library/notary:server-0.5.0@sha256:d59e4ecc20198447... 14:30:41 #4 DONE 0.0s 14:30:41 14:30:41 #5 [internal] load build context 14:30:41 #5 transferring context: 8.29kB done 14:30:41 #5 DONE 0.0s 14:30:41 14:30:41 #6 [2/2] COPY ./notary-evil/ /fixtures/ 14:30:41 #6 CACHED 14:30:41 14:30:41 #7 exporting to image 14:30:41 #7 exporting layers done 14:30:41 #7 writing image sha256:571198fe7f9fc3181f9fef4eb7d6d68921edf6e2623d48ce0529e25fde7d20dc done 14:30:41 #7 naming to docker.io/library/cliendtoendsuite_evil-notary-server done 14:30:41 #7 DONE 0.0s 14:30:41 Successfully built 571198fe7f9fc3181f9fef4eb7d6d68921edf6e2623d48ce0529e25fde7d20dc 14:30:41 Creating cliendtoendsuite_evil-notary-server_1 ... 14:30:41 Creating cliendtoendsuite_notary-server_1 ... 14:30:41 Creating cliendtoendsuite_registry_1 ... 14:30:41 Creating cliendtoendsuite_engine_1 ... 14:30:46  Creating cliendtoendsuite_registry_1 ... done  Creating cliendtoendsuite_engine_1 ... done  Creating cliendtoendsuite_notary-server_1 ... done  Creating cliendtoendsuite_evil-notary-server_1 ... done Waiting for docker daemon to become available at tcp://172.19.0.5:2375 14:30:46 Client: 14:30:46 Version: 19.09.0-dev 14:30:46 API version: 1.40 (downgraded from 1.41) 14:30:46 Go version: go1.12.16 14:30:46 Git commit: 14:30:46 Built: Mon Feb 10 14:28:24 2020 14:30:46 OS/Arch: linux/amd64 14:30:46 Experimental: false 14:30:46 14:30:46 Server: Docker Engine - Community 14:30:46 Engine: 14:30:46 Version: 19.03.5 14:30:46 API version: 1.40 (minimum version 1.12) 14:30:46 Go version: go1.12.12 14:30:46 Git commit: 633a0ea838 14:30:46 Built: Wed Nov 13 07:28:45 2019 14:30:46 OS/Arch: linux/amd64 14:30:46 Experimental: true 14:30:46 containerd: 14:30:46 Version: v1.2.10 14:30:46 GitCommit: b34a5c8af56e510852c35414db4c1f4fa6172339 14:30:46 runc: 14:30:46 Version: 1.0.0-rc8+dev 14:30:46 GitCommit: 3e425f80a8c931f88e6d94a8c831b9d5aa481657 14:30:46 docker-init: 14:30:46 Version: 0.18.0 14:30:46 GitCommit: fec3683 14:30:46 sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d: Pulling from library/alpine 14:30:46 88286f41530e: Pulling fs layer 14:30:46 88286f41530e: Verifying Checksum 14:30:46 88286f41530e: Download complete 14:30:46 88286f41530e: Pull complete 14:30:46 Digest: sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d 14:30:46 Status: Downloaded newer image for alpine@sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d 14:30:46 docker.io/library/alpine@sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d 14:30:46 The push refers to repository [registry:5000/alpine] 14:30:46 5bef08742407: Preparing 14:30:47 5bef08742407: Pushed 14:30:47 3.6: digest: sha256:641b95ddb2ea9dc2af1a0113b6b348ebc20872ba615204fbe12148e98fd6f23d size: 528 14:30:47 sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7: Pulling from library/busybox 14:30:47 03b1be98f3f9: Pulling fs layer 14:30:47 03b1be98f3f9: Verifying Checksum 14:30:47 03b1be98f3f9: Download complete 14:30:47 03b1be98f3f9: Pull complete 14:30:47 Digest: sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7 14:30:47 Status: Downloaded newer image for busybox@sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7 14:30:47 docker.io/library/busybox@sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7 14:30:47 The push refers to repository [registry:5000/busybox] 14:30:47 6a749002dd6a: Preparing 14:30:47 6a749002dd6a: Pushed 14:30:48 1.27.2: digest: sha256:030fcb92e1487b18c974784dcc110a93147c9fc402188370fbfd17efabffc6af size: 527 14:30:48 Swarm initialized: current node (nanlb0q6wtrbzisap2s7st3qc) is now a manager. 14:30:48 14:30:48 To add a worker to this swarm, run the following command: 14:30:48 14:30:48 docker swarm join --token SWMTKN-1-6auuju9bxm1uj9jukgjmrrm313edajsvku1cp8a89toi3aj24w-3azadby47i3mpvifhd1n1yb11 172.19.0.5:2377 14:30:48 14:30:48 To add a manager to this swarm, run 'docker swarm join-token manager' and follow the instructions. 14:30:48 14:31:06 ✓ e2e/cli-plugins (2.665s) 14:31:06 ∅ e2e/cli-plugins/plugins/badmeta 14:31:06 ∅ e2e/cli-plugins/plugins/nopersistentprerun 14:31:06 ✓ e2e/context (47ms) 14:31:06 ✓ e2e/global (123ms) 14:31:13 ✓ e2e/container (9.426s) 14:31:17 ✓ e2e/plugin (3.283s) 14:31:18 ✓ e2e/stack (634ms) 14:31:18 ✓ e2e/system (64ms) 14:31:22 ✓ e2e/image (14.981s) 14:31:22 ∅ e2e/internal/fixtures 14:31:22 ∅ e2e/plugin/basic 14:31:22 ✓ e2e/trust (3.18s) 14:31:22 14:31:22 === Skipped 14:31:22 === SKIP: e2e/cli-plugins TestCLIPluginDialStdio (0.00s) 14:31:22 dial_test.go:16: skipping plugin dial-stdio test since DOCKER_CLI_PLUGIN_USE_DIAL_STDIO is not set 14:31:22 14:31:22 === SKIP: e2e/stack TestDeployWithNamedResources/Kubernetes (0.00s) 14:31:22 --- SKIP: TestDeployWithNamedResources/Kubernetes (0.00s) 14:31:22 deploy_test.go:22: FIXME(chris-crone): currently does not work with compose for kubernetes. 14:31:22 14:31:22 === SKIP: e2e/stack TestRemove/Kubernetes (0.00s) 14:31:22 --- SKIP: TestRemove/Kubernetes (0.00s) 14:31:22 remove_test.go:22: !environment.KubernetesEnabled() 14:31:22 14:31:22 14:31:22 DONE 93 tests, 3 skipped in 34.093s 14:31:23 Stopping cliendtoendsuite_engine_1 ... 14:31:23 Stopping cliendtoendsuite_registry_1 ... 14:31:23 Stopping cliendtoendsuite_notary-server_1 ... 14:31:23 Stopping cliendtoendsuite_evil-notary-server_1 ... 14:31:25  Stopping cliendtoendsuite_evil-notary-server_1 ... done  Stopping cliendtoendsuite_registry_1 ... done  Stopping cliendtoendsuite_notary-server_1 ... done  Stopping cliendtoendsuite_engine_1 ... done Removing cliendtoendsuite_engine_1 ... 14:31:25 Removing cliendtoendsuite_registry_1 ... 14:31:25 Removing cliendtoendsuite_notary-server_1 ... 14:31:25 Removing cliendtoendsuite_evil-notary-server_1 ... 14:31:25  Removing cliendtoendsuite_evil-notary-server_1 ... done  Removing cliendtoendsuite_notary-server_1 ... done  Removing cliendtoendsuite_engine_1 ... done  Removing cliendtoendsuite_registry_1 ... done Removing network cliendtoendsuite_default 14:31:25 Removing image cliendtoendsuite_notary-server 14:31:25 Removing image cliendtoendsuite_evil-notary-server 14:31:25 docker run --rm -v /var/run/docker.sock:/var/run/docker.sock -e VERSION=19.09.0-dev -e GITCOMMIT -e PLATFORM -e TESTFLAGS -e TESTDIRS -e GOOS -e GOARCH -e GOARM -e DOCKERD_EXPERIMENTAL=1 -e TEST_CONNHELPER=ssh docker-cli-e2eclie2e2 14:31:27 Native build is an experimental feature and could change at any time 14:31:27 Creating network "cliendtoendsuite_default" with the default driver 14:31:27 Building engine 14:31:27 #2 [internal] load .dockerignore 14:31:27 #2 transferring context: 2B done 14:31:27 #2 DONE 0.0s 14:31:27 14:31:27 #1 [internal] load build definition from Dockerfile.connhelper-ssh 14:31:27 #1 transferring dockerfile: 599B done 14:31:27 #1 DONE 0.0s 14:31:27 14:31:27 #3 [internal] load metadata for docker.io/library/docker:test-dind 14:31:27 #3 DONE 0.3s 14:31:27 14:31:27 #7 [internal] load build context 14:31:27 #7 transferring context: 376B done 14:31:27 #7 DONE 0.0s 14:31:27 14:31:27 #4 [1/4] FROM docker.io/library/docker:test-dind@sha256:d0bef915133c450a058... 14:31:27 #4 resolve docker.io/library/docker:test-dind@sha256:d0bef915133c450a0584f6a35af45f290e4e6125f1cd0b2fad57b692aeddeea1 done 14:31:27 #4 sha256:d0bef915133c450a0584f6a35af45f290e4e6125f1cd0b2fad57b692aeddeea1 1.00kB / 1.00kB done 14:31:27 #4 sha256:e65cc5a657994afb60f8e36fb8d82100795c02891cf69bc8f85ee2a92b7090bd 2.61kB / 2.61kB done 14:31:27 #4 sha256:1858b6f9b12c2fd4043aa050021a447c595b1a2aef032dacd6bdf1eb59ceb646 6.57kB / 6.57kB done 14:31:27 #4 sha256:7aae0723913e410c295d4f5fedfe376630dd0a177f56989ef6b61b2e316e5884 1.02kB / 1.02kB 0.1s done 14:31:27 #4 sha256:caea7060abe9610714377bd4bba10bdc84753e6e62fa0e1ffdc5c4e12848b51e 0B / 64.17MB 0.1s 14:31:27 #4 sha256:93b866925237283b42ccdf5500fced4225fc4ffa5aff8e5e797d8cee70997177 544B / 544B 0.0s 14:31:27 #4 sha256:8eea91a5b97173d5dd2f344bc5d0e72f82699953ef1c5f959d4a9b7774afa8cf 0B / 5.59MB 0.1s 14:31:27 #4 sha256:caea7060abe9610714377bd4bba10bdc84753e6e62fa0e1ffdc5c4e12848b51e 7.17MB / 64.17MB 0.2s 14:31:27 #4 sha256:93b866925237283b42ccdf5500fced4225fc4ffa5aff8e5e797d8cee70997177 544B / 544B 0.0s done 14:31:27 #4 sha256:8eea91a5b97173d5dd2f344bc5d0e72f82699953ef1c5f959d4a9b7774afa8cf 5.59MB / 5.59MB 0.2s done 14:31:27 #4 sha256:7ae024136251285a97bd4a3b789755dcbcc96f128f498429bfab5c8f4db8355e 116B / 116B 0.2s done 14:31:27 #4 sha256:b363b8a24b99d588e888eeec2ff5552375c3d2abfa228cd2380f06f6335ee4f8 0B / 757B 0.2s 14:31:27 #4 sha256:3fbb053638ea5610c62c318ca2e653ca9d0835c05411a1daaa83b82ec3c87b24 0B / 1.28kB 0.2s 14:31:27 #4 sha256:caea7060abe9610714377bd4bba10bdc84753e6e62fa0e1ffdc5c4e12848b51e 18.84MB / 64.17MB 0.3s 14:31:27 #4 sha256:b363b8a24b99d588e888eeec2ff5552375c3d2abfa228cd2380f06f6335ee4f8 757B / 757B 0.3s done 14:31:27 #4 sha256:83d3d07de86fbe4cd8f0756a991706ead8e5663775b15af0d03643d133796463 0B / 2.53kB 0.3s 14:31:28 #4 sha256:caea7060abe9610714377bd4bba10bdc84753e6e62fa0e1ffdc5c4e12848b51e 33.54MB / 64.17MB 0.5s 14:31:28 #4 sha256:3fbb053638ea5610c62c318ca2e653ca9d0835c05411a1daaa83b82ec3c87b24 1.28kB / 1.28kB 0.4s done 14:31:28 #4 sha256:83d3d07de86fbe4cd8f0756a991706ead8e5663775b15af0d03643d133796463 2.53kB / 2.53kB 0.4s done 14:31:28 #4 sha256:caea7060abe9610714377bd4bba10bdc84753e6e62fa0e1ffdc5c4e12848b51e 47.68MB / 64.17MB 0.6s 14:31:28 #4 sha256:caea7060abe9610714377bd4bba10bdc84753e6e62fa0e1ffdc5c4e12848b51e 59.67MB / 64.17MB 0.7s 14:31:28 #4 sha256:caea7060abe9610714377bd4bba10bdc84753e6e62fa0e1ffdc5c4e12848b51e 64.17MB / 64.17MB 0.8s 14:31:28 #4 extracting sha256:caea7060abe9610714377bd4bba10bdc84753e6e62fa0e1ffdc5c4e12848b51e 14:31:28 #4 sha256:caea7060abe9610714377bd4bba10bdc84753e6e62fa0e1ffdc5c4e12848b51e 64.17MB / 64.17MB 0.9s done 14:31:30 #4 extracting sha256:caea7060abe9610714377bd4bba10bdc84753e6e62fa0e1ffdc5c4e12848b51e 1.8s done 14:31:30 #4 extracting sha256:93b866925237283b42ccdf5500fced4225fc4ffa5aff8e5e797d8cee70997177 14:31:30 #4 extracting sha256:93b866925237283b42ccdf5500fced4225fc4ffa5aff8e5e797d8cee70997177 done 14:31:30 #4 extracting sha256:7aae0723913e410c295d4f5fedfe376630dd0a177f56989ef6b61b2e316e5884 done 14:31:30 #4 extracting sha256:7ae024136251285a97bd4a3b789755dcbcc96f128f498429bfab5c8f4db8355e done 14:31:30 #4 extracting sha256:8eea91a5b97173d5dd2f344bc5d0e72f82699953ef1c5f959d4a9b7774afa8cf 14:31:31 #4 extracting sha256:8eea91a5b97173d5dd2f344bc5d0e72f82699953ef1c5f959d4a9b7774afa8cf 0.2s done 14:31:31 #4 extracting sha256:3fbb053638ea5610c62c318ca2e653ca9d0835c05411a1daaa83b82ec3c87b24 done 14:31:31 #4 extracting sha256:b363b8a24b99d588e888eeec2ff5552375c3d2abfa228cd2380f06f6335ee4f8 done 14:31:31 #4 extracting sha256:83d3d07de86fbe4cd8f0756a991706ead8e5663775b15af0d03643d133796463 14:31:31 #4 extracting sha256:83d3d07de86fbe4cd8f0756a991706ead8e5663775b15af0d03643d133796463 done 14:31:31 #4 DONE 3.6s 14:31:31 14:31:31 #5 [2/4] RUN apk --no-cache add shadow openssh-server && groupadd -f dock... 14:31:31 #5 0.574 fetch http://dl-cdn.alpinelinux.org/alpine/v3.11/main/x86_64/APKINDEX.tar.gz 14:31:32 #5 1.635 fetch http://dl-cdn.alpinelinux.org/alpine/v3.11/community/x86_64/APKINDEX.tar.gz 14:31:32 #5 1.726 (1/4) Installing openssh-server-common (8.1_p1-r0) 14:31:32 #5 1.729 (2/4) Installing openssh-server (8.1_p1-r0) 14:31:32 #5 1.738 (3/4) Installing linux-pam (1.3.1-r1) 14:31:32 #5 1.748 (4/4) Installing shadow (4.7-r1) 14:31:32 #5 1.765 Executing busybox-1.31.1-r9.trigger 14:31:32 #5 1.771 OK: 35 MiB in 50 packages 14:31:33 #5 1.842 ssh-keygen: generating new host keys: RSA DSA ECDSA ED25519 14:31:33 #5 DONE 2.6s 14:31:33 14:31:33 #6 [3/4] RUN ln -s /usr/local/bin/docker /usr/bin/docker 14:31:34 #6 DONE 0.7s 14:31:34 14:31:34 #8 [4/4] COPY ./connhelper-ssh/entrypoint.sh / 14:31:34 #8 DONE 0.1s 14:31:34 14:31:34 #9 exporting to image 14:31:34 #9 exporting layers 14:31:34 #9 exporting layers 0.1s done 14:31:34 #9 writing image sha256:ee8e59fb421a8408612aef4ed4813b93ffee36b0639cfe09feb2befb8485dadb done 14:31:34 #9 naming to docker.io/library/docker:stable-dind done 14:31:34 #9 DONE 0.1s 14:31:34 Successfully built ee8e59fb421a8408612aef4ed4813b93ffee36b0639cfe09feb2befb8485dadb 14:31:34 Building evil-notary-server 14:31:34 #2 [internal] load .dockerignore 14:31:34 #2 transferring context: 2B done 14:31:34 #2 DONE 0.0s 14:31:34 14:31:34 #1 [internal] load build definition from Dockerfile.evil-notary-server 14:31:34 #1 transferring dockerfile: 150B done 14:31:34 #1 DONE 0.0s 14:31:34 14:31:34 #3 [internal] load metadata for docker.io/library/notary:server-0.5.0 14:31:34 #3 DONE 0.1s 14:31:34 14:31:34 #4 [1/2] FROM docker.io/library/notary:server-0.5.0@sha256:d59e4ecc20198447... 14:31:34 #4 DONE 0.0s 14:31:34 14:31:34 #5 [internal] load build context 14:31:34 #5 transferring context: 8.29kB done 14:31:34 #5 DONE 0.0s 14:31:34 14:31:34 #6 [2/2] COPY ./notary-evil/ /fixtures/ 14:31:34 #6 CACHED 14:31:34 14:31:34 #7 exporting to image 14:31:34 #7 exporting layers done 14:31:34 #7 writing image sha256:571198fe7f9fc3181f9fef4eb7d6d68921edf6e2623d48ce0529e25fde7d20dc done 14:31:34 #7 naming to docker.io/library/cliendtoendsuite_evil-notary-server done 14:31:34 #7 DONE 0.0s 14:31:34 Successfully built 571198fe7f9fc3181f9fef4eb7d6d68921edf6e2623d48ce0529e25fde7d20dc 14:31:34 Building notary-server 14:31:34 #1 [internal] load build definition from Dockerfile.notary-server 14:31:34 #1 transferring dockerfile: 140B done 14:31:34 #1 DONE 0.0s 14:31:34 14:31:34 #2 [internal] load .dockerignore 14:31:34 #2 transferring context: 2B done 14:31:34 #2 DONE 0.0s 14:31:34 14:31:34 #3 [internal] load metadata for docker.io/library/notary:server-0.5.0 14:31:34 #3 DONE 0.1s 14:31:34 14:31:34 #4 [1/2] FROM docker.io/library/notary:server-0.5.0@sha256:d59e4ecc20198447... 14:31:34 #4 DONE 0.0s 14:31:34 14:31:34 #5 [internal] load build context 14:31:34 #5 transferring context: 8.26kB done 14:31:34 #5 DONE 0.0s 14:31:34 14:31:34 #6 [2/2] COPY ./notary/ /fixtures/ 14:31:34 #6 CACHED 14:31:34 14:31:34 #7 exporting to image 14:31:34 #7 exporting layers done 14:31:34 #7 writing image sha256:78fe82fb9477a78946458bcfbab41bb8849b0650a7eedb46980e685ae0b96381 done 14:31:34 #7 naming to docker.io/library/cliendtoendsuite_notary-server done 14:31:34 #7 DONE 0.0s 14:31:34 Successfully built 78fe82fb9477a78946458bcfbab41bb8849b0650a7eedb46980e685ae0b96381 14:31:35 Creating cliendtoendsuite_evil-notary-server_1 ... 14:31:35 Creating cliendtoendsuite_notary-server_1 ... 14:31:35 Creating cliendtoendsuite_registry_1 ... 14:31:35 Creating cliendtoendsuite_engine_1 ... 14:31:40  Creating cliendtoendsuite_evil-notary-server_1 ... done  Creating cliendtoendsuite_notary-server_1 ... done  Creating cliendtoendsuite_engine_1 ... done  Creating cliendtoendsuite_registry_1 ... done Waiting for docker daemon to become available at ssh://penguin@172.20.0.4 14:31:40 Client: 14:31:40 Version: 19.09.0-dev 14:31:40 API version: 1.40 (downgraded from 1.41) 14:31:40 Go version: go1.12.16 14:31:40 Git commit: 14:31:40 Built: Mon Feb 10 14:28:24 2020 14:31:40 OS/Arch: linux/amd64 14:31:40 Experimental: false 14:31:40 14:31:40 Server: Docker Engine - Community 14:31:40 Engine: 14:31:40 Version: 19.03.6-rc2 14:31:40 API version: 1.40 (minimum version 1.12) 14:31:40 Go version: go1.12.16 14:31:40 Git commit: 97049ac8a1 14:31:40 Built: Thu Feb 6 01:53:18 2020 14:31:40 OS/Arch: linux/amd64 14:31:40 Experimental: true 14:31:40 containerd: 14:31:40 Version: v1.2.12 14:31:40 GitCommit: 35bd7a5f69c13e1563af8a93431411cd9ecf5021 14:31:40 runc: 14:31:40 Version: 1.0.0-rc10 14:31:40 GitCommit: dc9208a3303feef5b3839f4323d9beb36df0a9dd 14:31:40 docker-init: 14:31:40 Version: 0.18.0 14:31:40 GitCommit: fec3683 14:31:40 sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d: Pulling from library/alpine 14:31:40 88286f41530e: Pulling fs layer 14:31:41 88286f41530e: Download complete 14:31:41 88286f41530e: Pull complete 14:31:41 Digest: sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d 14:31:41 Status: Downloaded newer image for alpine@sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d 14:31:41 docker.io/library/alpine@sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d 14:31:41 The push refers to repository [registry:5000/alpine] 14:31:41 5bef08742407: Preparing 14:31:41 5bef08742407: Pushed 14:31:41 3.6: digest: sha256:641b95ddb2ea9dc2af1a0113b6b348ebc20872ba615204fbe12148e98fd6f23d size: 528 14:31:42 sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7: Pulling from library/busybox 14:31:42 03b1be98f3f9: Pulling fs layer 14:31:42 03b1be98f3f9: Download complete 14:31:42 03b1be98f3f9: Pull complete 14:31:42 Digest: sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7 14:31:42 Status: Downloaded newer image for busybox@sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7 14:31:42 docker.io/library/busybox@sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7 14:31:43 The push refers to repository [registry:5000/busybox] 14:31:43 6a749002dd6a: Preparing 14:31:43 6a749002dd6a: Pushed 14:31:43 1.27.2: digest: sha256:030fcb92e1487b18c974784dcc110a93147c9fc402188370fbfd17efabffc6af size: 527 14:31:44 Swarm initialized: current node (wzxiucxsj53e04qoyszcmtxuj) is now a manager. 14:31:44 14:31:44 To add a worker to this swarm, run the following command: 14:31:44 14:31:44 docker swarm join --token SWMTKN-1-3uk58okjcpy91wz8680mzdx7nwutbemkp5sulevurc1k4cl85s-ek9px9l7wh6xjkxmxpznqejmg 172.20.0.4:2377 14:31:44 14:31:44 To add a manager to this swarm, run 'docker swarm join-token manager' and follow the instructions. 14:31:44 14:32:10 ✓ e2e/cli-plugins (11.633s) 14:32:10 ∅ e2e/cli-plugins/plugins/badmeta 14:32:10 ∅ e2e/cli-plugins/plugins/nopersistentprerun 14:32:10 ✓ e2e/context (58ms) 14:32:10 ✓ e2e/global (264ms) 14:32:20 ✓ e2e/container (21.23s) 14:32:24 ✓ e2e/plugin (4.094s) 14:32:28 ✓ e2e/stack (2.316s) 14:32:28 ✓ e2e/system (242ms) 14:32:33 ✖ e2e/trust (4.393s) 14:32:39 ✓ e2e/image (27.334s) 14:32:39 ∅ e2e/internal/fixtures 14:32:39 ∅ e2e/plugin/basic 14:32:39 14:32:39 === Skipped 14:32:39 === SKIP: e2e/cli-plugins TestCLIPluginDialStdio (0.00s) 14:32:39 dial_test.go:16: skipping plugin dial-stdio test since DOCKER_CLI_PLUGIN_USE_DIAL_STDIO is not set 14:32:39 14:32:39 === SKIP: e2e/stack TestDeployWithNamedResources/Kubernetes (0.00s) 14:32:39 --- SKIP: TestDeployWithNamedResources/Kubernetes (0.00s) 14:32:39 deploy_test.go:22: FIXME(chris-crone): currently does not work with compose for kubernetes. 14:32:39 14:32:39 === SKIP: e2e/stack TestRemove/Kubernetes (0.00s) 14:32:39 --- SKIP: TestRemove/Kubernetes (0.00s) 14:32:39 remove_test.go:22: !environment.KubernetesEnabled() 14:32:39 14:32:39 14:32:39 === Failed 14:32:39 === FAIL: e2e/trust TestRevokeImage (0.08s) 14:32:39 revoke_test.go:50: assertion failed: 14:32:39 Command: docker pull registry:5000/alpine:3.6 14:32:39 ExitCode: 1 14:32:39 Error: exit status 1 14:32:39 Stdout: 3.6: Pulling from alpine 14:32:39 14:32:39 Stderr: command [ssh -o ControlMaster=auto -o ControlPath=/root/.docker/%r@%h:%p -l penguin 172.20.0.4 -- docker system dial-stdio] has exited with exit status 255, please make sure the URL is valid, and Docker 18.09 or later is installed on the remote host: stderr= 14:32:39 14:32:39 14:32:39 Failures: 14:32:39 ExitCode was 1 expected 0 14:32:39 Expected no error 14:32:39 14:32:39 === FAIL: e2e/trust TestSignLocalImage (0.07s) 14:32:39 sign_test.go:26: assertion failed: 14:32:39 Command: docker pull registry:5000/alpine:3.6 14:32:39 ExitCode: 1 14:32:39 Error: exit status 1 14:32:39 Stdout: 14:32:39 Stderr: error during connect: Post http://docker/v1.40/images/create?fromImage=registry%3A5000%2Falpine&tag=3.6: command [ssh -o ControlMaster=auto -o ControlPath=/root/.docker/%r@%h:%p -l penguin 172.20.0.4 -- docker system dial-stdio] has exited with exit status 255, please make sure the URL is valid, and Docker 18.09 or later is installed on the remote host: stderr= 14:32:39 14:32:39 14:32:39 Failures: 14:32:39 ExitCode was 1 expected 0 14:32:39 Expected no error 14:32:39 14:32:39 14:32:39 DONE 93 tests, 3 skipped, 2 failures in 54.525s 14:32:39 Stopping cliendtoendsuite_registry_1 ... 14:32:39 Stopping cliendtoendsuite_notary-server_1 ... 14:32:39 Stopping cliendtoendsuite_engine_1 ... 14:32:39 Stopping cliendtoendsuite_evil-notary-server_1 ... 14:32:41  Stopping cliendtoendsuite_notary-server_1 ... done  Stopping cliendtoendsuite_registry_1 ... done  Stopping cliendtoendsuite_evil-notary-server_1 ... done  Stopping cliendtoendsuite_engine_1 ... done Removing cliendtoendsuite_registry_1 ... 14:32:41 Removing cliendtoendsuite_notary-server_1 ... 14:32:41 Removing cliendtoendsuite_engine_1 ... 14:32:41 Removing cliendtoendsuite_evil-notary-server_1 ... 14:32:41  Removing cliendtoendsuite_evil-notary-server_1 ... done  Removing cliendtoendsuite_notary-server_1 ... done  Removing cliendtoendsuite_registry_1 ... done  Removing cliendtoendsuite_engine_1 ... done Removing network cliendtoendsuite_default 14:32:41 Removing image cliendtoendsuite_notary-server 14:32:41 Removing image cliendtoendsuite_evil-notary-server 14:32:42 docker.Makefile:156: recipe for target 'test-e2e-connhelper-ssh' failed 14:32:42 make: *** [test-e2e-connhelper-ssh] Error 1 [Pipeline] } [Pipeline] // timeout [Pipeline] } [Pipeline] // wrap [Pipeline] } [Pipeline] // wrap [Pipeline] } [Pipeline] // withDockerRegistry [Pipeline] } [Pipeline] // node [Pipeline] End of Pipeline GitHub has been notified of this commit’s build result ERROR: script returned exit code 2 Finished: FAILURE