Started by user Silvin Lubecki Replayed #2 15:01:22 Connecting to https://api.github.com using docker-jenkins/****** (docker-jenkins GitHub credentials) Obtained Jenkinsfile from 3dfcfbb2bf947a9e28611334d34741b40ecfd5c7+3c8c0ff3807ee436d1bfdc6581d718c17158c80a (67a30c4ad3f0be11124cfa0ce19bc69da7441f10) 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 ubuntu-1804-overlay2 (i-02de3db45332ab336) in /home/ubuntu/workspace/cli_PR-2298 [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-2298@tmp/670973f2-a81b-45ce-a325-d718d48bf15d/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 15:01:28 cleanWorkspace: Ensuring workspace is owned by ubuntu [Pipeline] echo 15:01:28 chowning workspace [Pipeline] sh 15:01:28 + uname -m [Pipeline] sh 15:01:28 + pwd 15:01:28 + id -u 15:01:28 + id -g 15:01:28 + docker run --rm -v /home/ubuntu/workspace/cli_PR-2298:/workspace busybox chown -R 1000:1000 /workspace [Pipeline] echo 15:01:29 Removing all docker containers [Pipeline] sh 15:01:30 + docker container ls -aq [Pipeline] echo 15:01:30 Docker containers have been removed [Pipeline] echo 15:01:30 cleanWorkspace: Removing existing workspace [Pipeline] deleteDir [Pipeline] echo 15:01:30 cleanWorkspace: Workspace is clean. [Pipeline] timeout 15:01:30 Timeout set to expire in 1 hr 0 min [Pipeline] { [Pipeline] stage 15:01:30 Using the ‘stage’ step without a block argument is deprecated 15:01:30 Entering stage Git Checkout 15:01:30 Proceeding [Pipeline] checkout 15:01:30 using credential docker-jenkins-github-credentials 15:01:30 Cloning the remote Git repository 15:01:30 Cloning with configured refspecs honoured and without tags Cloning repository https://github.com/docker/cli.git > git init /home/ubuntu/workspace/cli_PR-2298 # 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/2298/head:refs/remotes/origin/PR-2298 +refs/heads/master:refs/remotes/origin/master 15:01:33 Fetching without tags > git config remote.origin.url https://github.com/docker/cli.git # timeout=10 > git config --add remote.origin.fetch +refs/pull/2298/head:refs/remotes/origin/PR-2298 # 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/2298/head:refs/remotes/origin/PR-2298 +refs/heads/master:refs/remotes/origin/master 15:01:33 Merging remotes/origin/master commit 3c8c0ff3807ee436d1bfdc6581d718c17158c80a into PR head commit 3dfcfbb2bf947a9e28611334d34741b40ecfd5c7 15:01:34 Merge succeeded, producing 2e55d0b355e889d17a6dbf512b46088dbafa9c1e 15:01:34 Checking out Revision 2e55d0b355e889d17a6dbf512b46088dbafa9c1e (PR-2298) 15:01:34 Commit message: "Merge commit '3c8c0ff3807ee436d1bfdc6581d718c17158c80a' into HEAD" 15:01:34 First time build. Skipping changelog. > git config core.sparsecheckout # timeout=10 > git checkout -f 3dfcfbb2bf947a9e28611334d34741b40ecfd5c7 > git merge 3c8c0ff3807ee436d1bfdc6581d718c17158c80a # timeout=10 > git rev-parse HEAD^{commit} # timeout=10 > git config core.sparsecheckout # timeout=10 > git checkout -f 2e55d0b355e889d17a6dbf512b46088dbafa9c1e > git rev-list --no-walk bd6225e34cdbc319b7666fd79009895d3a9fbd3a # timeout=10 [Pipeline] stage 15:01:35 Using the ‘stage’ step without a block argument is deprecated 15:01:35 Entering stage Run end-to-end test suite 15:01:35 Proceeding [Pipeline] sh 15:01:35 + docker version 15:01:35 Client: Docker Engine - Community 15:01:35 Version: 19.03.2 15:01:35 API version: 1.40 15:01:35 Go version: go1.12.8 15:01:35 Git commit: 6a30dfc 15:01:35 Built: Thu Aug 29 05:29:11 2019 15:01:35 OS/Arch: linux/amd64 15:01:35 Experimental: false 15:01:35 15:01:35 Server: Docker Engine - Community 15:01:35 Engine: 15:01:35 Version: 19.03.2 15:01:35 API version: 1.40 (minimum version 1.12) 15:01:35 Go version: go1.12.8 15:01:35 Git commit: 6a30dfc 15:01:35 Built: Thu Aug 29 05:27:45 2019 15:01:35 OS/Arch: linux/amd64 15:01:35 Experimental: true 15:01:35 containerd: 15:01:35 Version: 1.2.6 15:01:35 GitCommit: 894b81a4b802e4eb2a91d1ce216b8817763c29fb 15:01:35 runc: 15:01:35 Version: 1.0.0-rc8 15:01:35 GitCommit: 425e105d5a03fabd737a126ad93d62a9eeede87f 15:01:35 docker-init: 15:01:35 Version: 0.18.0 15:01:35 GitCommit: fec3683 [Pipeline] sh 15:01:35 + docker info 15:01:35 Client: 15:01:35 Debug Mode: false 15:01:35 15:01:35 Server: 15:01:35 Containers: 0 15:01:35 Running: 0 15:01:35 Paused: 0 15:01:35 Stopped: 0 15:01:35 Images: 8 15:01:35 Server Version: 19.03.2 15:01:35 Storage Driver: overlay2 15:01:35 Backing Filesystem: extfs 15:01:35 Supports d_type: true 15:01:35 Native Overlay Diff: true 15:01:35 Logging Driver: json-file 15:01:35 Cgroup Driver: cgroupfs 15:01:35 Plugins: 15:01:35 Volume: local 15:01:35 Network: bridge host ipvlan macvlan null overlay 15:01:35 Log: awslogs fluentd gcplogs gelf journald json-file local logentries splunk syslog 15:01:35 Swarm: inactive 15:01:35 Runtimes: runc 15:01:35 Default Runtime: runc 15:01:35 Init Binary: docker-init 15:01:35 containerd version: 894b81a4b802e4eb2a91d1ce216b8817763c29fb 15:01:35 runc version: 425e105d5a03fabd737a126ad93d62a9eeede87f 15:01:35 init version: fec3683 15:01:35 Security Options: 15:01:35 apparmor 15:01:35 seccomp 15:01:35 Profile: default 15:01:35 Kernel Version: 4.15.0-1048-aws 15:01:35 Operating System: Ubuntu 18.04.3 LTS 15:01:35 OSType: linux 15:01:35 Architecture: x86_64 15:01:35 CPUs: 2 15:01:35 Total Memory: 7.501GiB 15:01:35 Name: ip-10-100-85-213 15:01:35 ID: O7UF:J7PM:BBOA:MCJH:BMAQ:O5XU:4D4U:YHPF:2JNI:LSPI:7LJ3:3UMG 15:01:35 Docker Root Dir: /var/lib/docker 15:01:35 Debug Mode: false 15:01:35 Username: dockerbuildbot 15:01:35 Registry: https://index.docker.io/v1/ 15:01:35 Labels: 15:01:35 Experimental: true 15:01:35 Insecure Registries: 15:01:35 127.0.0.0/8 15:01:35 Live Restore Enabled: true 15:01:35 15:01:35 WARNING: No swap limit support [Pipeline] sh 15:01:36 + E2E_UNIQUE_ID=clie2e3 IMAGE_TAG=clie2e3 DOCKER_BUILDKIT=1 make -f docker.Makefile test-e2e 15:01:36 docker build -t docker-cli-e2eclie2e3 --build-arg=GO_VERSION --build-arg VERSION=19.09.0-dev --build-arg GITCOMMIT= -f ./dockerfiles/Dockerfile.e2e . 15:01:36 #2 [internal] load .dockerignore 15:01:36 #2 transferring context: 100B done 15:01:36 #2 DONE 0.0s 15:01:36 15:01:36 #1 [internal] load build definition from Dockerfile.e2e 15:01:36 #1 transferring dockerfile: 1.64kB done 15:01:36 #1 DONE 0.0s 15:01:36 15:01:36 #3 [internal] load metadata for docker.io/library/golang:1.12.15 15:01:36 #3 DONE 0.1s 15:01:36 15:01:36 #4 [1/11] FROM docker.io/library/golang:1.12.15@sha256:649696aa119333e3cd25... 15:01:36 #4 DONE 0.0s 15:01:36 15:01:36 #10 [internal] load build context 15:01:37 #10 transferring context: 42.64MB 1.1s done 15:01:37 #10 DONE 1.1s 15:01:37 15:01:37 #14 [10/11] RUN ./scripts/build/binary 15:01:37 #14 CACHED 15:01:37 15:01:37 #9 [6/11] WORKDIR /go/src/github.com/docker/cli 15:01:37 #9 CACHED 15:01:37 15:01:37 #12 [8/11] RUN echo 'notary.cert' >> /etc/ca-certificates.conf && update-ca-... 15:01:37 #12 CACHED 15:01:37 15:01:37 #7 [4/11] RUN curl -Ls https://github.com/theupdateframework/notary/release... 15:01:37 #7 CACHED 15:01:37 15:01:37 #8 [5/11] RUN curl -Ls https://github.com/gotestyourself/gotestsum/releases... 15:01:37 #8 CACHED 15:01:37 15:01:37 #5 [2/11] RUN apt-get update && apt-get install -y build-essential ... 15:01:37 #5 CACHED 15:01:37 15:01:37 #11 [7/11] COPY e2e/testdata/notary/root-ca.cert /usr/share/ca-certificates/... 15:01:37 #11 CACHED 15:01:37 15:01:37 #13 [9/11] COPY . . 15:01:37 #13 CACHED 15:01:37 15:01:37 #6 [3/11] RUN curl -L https://github.com/docker/compose/releases/download/1... 15:01:37 #6 CACHED 15:01:37 15:01:37 #15 [11/11] RUN ./scripts/build/plugins e2e/cli-plugins/plugins/* 15:01:37 #15 CACHED 15:01:37 15:01:37 #16 exporting to image 15:01:37 #16 exporting layers done 15:01:37 #16 writing image sha256:ef3f793cdb931544a15ce1d111d40d0137624887d0e6f666a19ab65b1b5fe021 done 15:01:37 #16 naming to docker.io/library/docker-cli-e2eclie2e3 done 15:01:37 #16 DONE 0.0s 15:01:37 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-e2eclie2e3 15:01:39 Native build is an experimental feature and could change at any time 15:01:39 Creating network "cliendtoendsuite_default" with the default driver 15:01:39 Building notary-server 15:01:39 #2 [internal] load .dockerignore 15:01:39 #2 DONE 0.0s 15:01:39 15:01:39 #1 [internal] load build definition from Dockerfile.notary-server 15:01:39 #1 transferring dockerfile: 140B done 15:01:39 #1 DONE 0.0s 15:01:39 15:01:39 #2 [internal] load .dockerignore 15:01:39 #2 transferring context: 2B done 15:01:39 #2 DONE 0.0s 15:01:39 15:01:39 #3 [internal] load metadata for docker.io/library/notary:server-0.5.0 15:01:39 #3 DONE 0.1s 15:01:39 15:01:39 #4 [1/2] FROM docker.io/library/notary:server-0.5.0@sha256:d59e4ecc20198447... 15:01:39 #4 DONE 0.0s 15:01:39 15:01:39 #5 [internal] load build context 15:01:39 #5 transferring context: 8.26kB done 15:01:39 #5 DONE 0.0s 15:01:39 15:01:39 #6 [2/2] COPY ./notary/ /fixtures/ 15:01:39 #6 CACHED 15:01:39 15:01:39 #7 exporting to image 15:01:39 #7 exporting layers done 15:01:39 #7 writing image sha256:945b25bbb43837b367b41c23a06ed8b88645b88eb94edb28fb76382f6ed24c00 done 15:01:39 #7 naming to docker.io/library/cliendtoendsuite_notary-server done 15:01:39 #7 DONE 0.0s 15:01:39 Successfully built 945b25bbb43837b367b41c23a06ed8b88645b88eb94edb28fb76382f6ed24c00 15:01:39 Building evil-notary-server 15:01:39 #2 [internal] load .dockerignore 15:01:39 #2 transferring context: 2B done 15:01:39 #2 DONE 0.0s 15:01:39 15:01:39 #1 [internal] load build definition from Dockerfile.evil-notary-server 15:01:39 #1 transferring dockerfile: 150B done 15:01:39 #1 DONE 0.0s 15:01:39 15:01:39 #3 [internal] load metadata for docker.io/library/notary:server-0.5.0 15:01:39 #3 DONE 0.1s 15:01:39 15:01:39 #4 [1/2] FROM docker.io/library/notary:server-0.5.0@sha256:d59e4ecc20198447... 15:01:39 #4 DONE 0.0s 15:01:39 15:01:39 #5 [internal] load build context 15:01:39 #5 transferring context: 8.29kB done 15:01:39 #5 DONE 0.0s 15:01:39 15:01:39 #6 [2/2] COPY ./notary-evil/ /fixtures/ 15:01:39 #6 CACHED 15:01:39 15:01:39 #7 exporting to image 15:01:39 #7 exporting layers done 15:01:39 #7 writing image sha256:c88818637ee4726d50f8ec4e3374431b1f9be27642b4b694f9b4194ddc630227 done 15:01:39 #7 naming to docker.io/library/cliendtoendsuite_evil-notary-server done 15:01:39 #7 DONE 0.0s 15:01:39 Successfully built c88818637ee4726d50f8ec4e3374431b1f9be27642b4b694f9b4194ddc630227 15:01:39 Creating cliendtoendsuite_evil-notary-server_1 ... 15:01:39 Creating cliendtoendsuite_registry_1 ... 15:01:39 Creating cliendtoendsuite_engine_1 ... 15:01:39 Creating cliendtoendsuite_notary-server_1 ... 15:01:45  Creating cliendtoendsuite_notary-server_1 ... done  Creating cliendtoendsuite_engine_1 ... done  Creating cliendtoendsuite_registry_1 ... done  Creating cliendtoendsuite_evil-notary-server_1 ... done Waiting for docker daemon to become available at tcp://172.27.0.5:2375 15:01:45 Client: 15:01:45 Version: 19.09.0-dev 15:01:45 API version: 1.40 (downgraded from 1.41) 15:01:45 Go version: go1.12.15 15:01:45 Git commit: 15:01:45 Built: Tue Jan 28 14:45:40 2020 15:01:45 OS/Arch: linux/amd64 15:01:45 Experimental: false 15:01:45 15:01:45 Server: Docker Engine - Community 15:01:45 Engine: 15:01:45 Version: 19.03.5 15:01:45 API version: 1.40 (minimum version 1.12) 15:01:45 Go version: go1.12.12 15:01:45 Git commit: 633a0ea838 15:01:45 Built: Wed Nov 13 07:28:45 2019 15:01:45 OS/Arch: linux/amd64 15:01:45 Experimental: false 15:01:45 containerd: 15:01:45 Version: v1.2.10 15:01:45 GitCommit: b34a5c8af56e510852c35414db4c1f4fa6172339 15:01:45 runc: 15:01:45 Version: 1.0.0-rc8+dev 15:01:45 GitCommit: 3e425f80a8c931f88e6d94a8c831b9d5aa481657 15:01:45 docker-init: 15:01:45 Version: 0.18.0 15:01:45 GitCommit: fec3683 15:01:45 sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d: Pulling from library/alpine 15:01:45 88286f41530e: Pulling fs layer 15:01:45 88286f41530e: Verifying Checksum 15:01:45 88286f41530e: Download complete 15:01:45 88286f41530e: Pull complete 15:01:45 Digest: sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d 15:01:45 Status: Downloaded newer image for alpine@sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d 15:01:45 docker.io/library/alpine@sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d 15:01:45 The push refers to repository [registry:5000/alpine] 15:01:45 5bef08742407: Preparing 15:01:45 5bef08742407: Pushed 15:01:45 3.6: digest: sha256:641b95ddb2ea9dc2af1a0113b6b348ebc20872ba615204fbe12148e98fd6f23d size: 528 15:01:46 sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7: Pulling from library/busybox 15:01:46 03b1be98f3f9: Pulling fs layer 15:01:46 03b1be98f3f9: Verifying Checksum 15:01:46 03b1be98f3f9: Download complete 15:01:46 03b1be98f3f9: Pull complete 15:01:46 Digest: sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7 15:01:46 Status: Downloaded newer image for busybox@sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7 15:01:46 docker.io/library/busybox@sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7 15:01:46 The push refers to repository [registry:5000/busybox] 15:01:46 6a749002dd6a: Preparing 15:01:46 6a749002dd6a: Pushed 15:01:46 1.27.2: digest: sha256:030fcb92e1487b18c974784dcc110a93147c9fc402188370fbfd17efabffc6af size: 527 15:01:47 Swarm initialized: current node (ykr16wca8wu02e36jtkewtb0g) is now a manager. 15:01:47 15:01:47 To add a worker to this swarm, run the following command: 15:01:47 15:01:47 docker swarm join --token SWMTKN-1-61o4rjr6kav5u5zz5g7wlxyjg21b9s2cb8r9irvejh821c2iw5-cdjqjn2iijxm1op8ae8i0ch3q 172.27.0.5:2377 15:01:47 15:01:47 To add a manager to this swarm, run 'docker swarm join-token manager' and follow the instructions. 15:01:47 15:02:05 ✓ e2e/cli-plugins (2.634s) 15:02:05 ∅ e2e/cli-plugins/plugins/badmeta 15:02:05 ∅ e2e/cli-plugins/plugins/nopersistentprerun 15:02:05 ✓ e2e/context (64ms) 15:02:05 ✓ e2e/global (107ms) 15:02:11 ✓ e2e/container (9.842s) 15:02:17 ✓ e2e/plugin (3.681s) 15:02:17 ✓ e2e/image (11.479s) 15:02:17 ∅ e2e/internal/fixtures 15:02:17 ∅ e2e/plugin/basic 15:02:18 ✓ e2e/system (77ms) 15:02:18 ✓ e2e/stack (662ms) 15:02:20 ✓ e2e/trust (2.128s) 15:02:20 15:02:20 === Skipped 15:02:20 === SKIP: e2e/cli-plugins TestCLIPluginDialStdio (0.00s) 15:02:20 dial_test.go:16: skipping plugin dial-stdio test since DOCKER_CLI_PLUGIN_USE_DIAL_STDIO is not set 15:02:20 15:02:20 === SKIP: e2e/image TestBuildIidFileSquash (0.05s) 15:02:20 build_test.go:112: !experimentalBuild: running against a non-experimental daemon 15:02:20 15:02:20 === SKIP: e2e/stack TestDeployWithNamedResources/Kubernetes (0.00s) 15:02:20 --- SKIP: TestDeployWithNamedResources/Kubernetes (0.00s) 15:02:20 deploy_test.go:22: FIXME(chris-crone): currently does not work with compose for kubernetes. 15:02:20 15:02:20 === SKIP: e2e/stack TestRemove/Kubernetes (0.00s) 15:02:20 --- SKIP: TestRemove/Kubernetes (0.00s) 15:02:20 remove_test.go:22: !environment.KubernetesEnabled() 15:02:20 15:02:20 15:02:20 DONE 92 tests, 4 skipped in 33.365s 15:02:21 Stopping cliendtoendsuite_notary-server_1 ... 15:02:21 Stopping cliendtoendsuite_registry_1 ... 15:02:21 Stopping cliendtoendsuite_engine_1 ... 15:02:21 Stopping cliendtoendsuite_evil-notary-server_1 ... 15:02:23  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_notary-server_1 ... 15:02:23 Removing cliendtoendsuite_registry_1 ... 15:02:23 Removing cliendtoendsuite_engine_1 ... 15:02:23 Removing cliendtoendsuite_evil-notary-server_1 ... 15:02:23  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 15:02:23 Removing image cliendtoendsuite_notary-server 15:02:23 Removing image cliendtoendsuite_evil-notary-server 15:02:23 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-e2eclie2e3 15:02:25 Native build is an experimental feature and could change at any time 15:02:25 Creating network "cliendtoendsuite_default" with the default driver 15:02:25 Building notary-server 15:02:25 #2 [internal] load .dockerignore 15:02:25 #2 transferring context: 2B done 15:02:25 #2 DONE 0.0s 15:02:25 15:02:25 #1 [internal] load build definition from Dockerfile.notary-server 15:02:25 #1 transferring dockerfile: 140B done 15:02:25 #1 DONE 0.0s 15:02:25 15:02:25 #3 [internal] load metadata for docker.io/library/notary:server-0.5.0 15:02:25 #3 DONE 0.1s 15:02:25 15:02:25 #4 [1/2] FROM docker.io/library/notary:server-0.5.0@sha256:d59e4ecc20198447... 15:02:25 #4 DONE 0.0s 15:02:25 15:02:25 #5 [internal] load build context 15:02:25 #5 transferring context: 8.26kB done 15:02:25 #5 DONE 0.0s 15:02:25 15:02:25 #6 [2/2] COPY ./notary/ /fixtures/ 15:02:25 #6 CACHED 15:02:25 15:02:25 #7 exporting to image 15:02:25 #7 exporting layers done 15:02:25 #7 writing image sha256:945b25bbb43837b367b41c23a06ed8b88645b88eb94edb28fb76382f6ed24c00 done 15:02:25 #7 naming to docker.io/library/cliendtoendsuite_notary-server done 15:02:25 #7 DONE 0.0s 15:02:25 Successfully built 945b25bbb43837b367b41c23a06ed8b88645b88eb94edb28fb76382f6ed24c00 15:02:25 Building evil-notary-server 15:02:25 #2 [internal] load .dockerignore 15:02:25 #2 transferring context: 2B done 15:02:25 #2 DONE 0.0s 15:02:25 15:02:25 #1 [internal] load build definition from Dockerfile.evil-notary-server 15:02:25 #1 transferring dockerfile: 150B done 15:02:25 #1 DONE 0.0s 15:02:25 15:02:25 #3 [internal] load metadata for docker.io/library/notary:server-0.5.0 15:02:25 #3 DONE 0.1s 15:02:25 15:02:25 #4 [1/2] FROM docker.io/library/notary:server-0.5.0@sha256:d59e4ecc20198447... 15:02:25 #4 DONE 0.0s 15:02:25 15:02:25 #5 [internal] load build context 15:02:25 #5 transferring context: 8.29kB done 15:02:25 #5 DONE 0.0s 15:02:25 15:02:25 #6 [2/2] COPY ./notary-evil/ /fixtures/ 15:02:25 #6 CACHED 15:02:25 15:02:25 #7 exporting to image 15:02:25 #7 exporting layers done 15:02:25 #7 writing image sha256:c88818637ee4726d50f8ec4e3374431b1f9be27642b4b694f9b4194ddc630227 done 15:02:25 #7 naming to docker.io/library/cliendtoendsuite_evil-notary-server done 15:02:25 #7 DONE 0.0s 15:02:25 Successfully built c88818637ee4726d50f8ec4e3374431b1f9be27642b4b694f9b4194ddc630227 15:02:25 Creating cliendtoendsuite_notary-server_1 ... 15:02:25 Creating cliendtoendsuite_engine_1 ... 15:02:25 Creating cliendtoendsuite_registry_1 ... 15:02:25 Creating cliendtoendsuite_evil-notary-server_1 ... 15:02:30  Creating cliendtoendsuite_notary-server_1 ... done  Creating cliendtoendsuite_evil-notary-server_1 ... done  Creating cliendtoendsuite_engine_1 ... done  Creating cliendtoendsuite_registry_1 ... done Waiting for docker daemon to become available at tcp://172.28.0.3:2375 15:02:31 Client: 15:02:31 Version: 19.09.0-dev 15:02:31 API version: 1.40 (downgraded from 1.41) 15:02:31 Go version: go1.12.15 15:02:31 Git commit: 15:02:31 Built: Tue Jan 28 14:45:40 2020 15:02:31 OS/Arch: linux/amd64 15:02:31 Experimental: false 15:02:31 15:02:31 Server: Docker Engine - Community 15:02:31 Engine: 15:02:31 Version: 19.03.5 15:02:31 API version: 1.40 (minimum version 1.12) 15:02:31 Go version: go1.12.12 15:02:31 Git commit: 633a0ea838 15:02:31 Built: Wed Nov 13 07:28:45 2019 15:02:31 OS/Arch: linux/amd64 15:02:31 Experimental: true 15:02:31 containerd: 15:02:31 Version: v1.2.10 15:02:31 GitCommit: b34a5c8af56e510852c35414db4c1f4fa6172339 15:02:31 runc: 15:02:31 Version: 1.0.0-rc8+dev 15:02:31 GitCommit: 3e425f80a8c931f88e6d94a8c831b9d5aa481657 15:02:31 docker-init: 15:02:31 Version: 0.18.0 15:02:31 GitCommit: fec3683 15:02:31 sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d: Pulling from library/alpine 15:02:31 88286f41530e: Pulling fs layer 15:02:31 88286f41530e: Verifying Checksum 15:02:31 88286f41530e: Download complete 15:02:31 88286f41530e: Pull complete 15:02:31 Digest: sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d 15:02:31 Status: Downloaded newer image for alpine@sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d 15:02:31 docker.io/library/alpine@sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d 15:02:31 The push refers to repository [registry:5000/alpine] 15:02:31 5bef08742407: Preparing 15:02:31 5bef08742407: Pushed 15:02:31 3.6: digest: sha256:641b95ddb2ea9dc2af1a0113b6b348ebc20872ba615204fbe12148e98fd6f23d size: 528 15:02:31 sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7: Pulling from library/busybox 15:02:31 03b1be98f3f9: Pulling fs layer 15:02:32 03b1be98f3f9: Verifying Checksum 15:02:32 03b1be98f3f9: Download complete 15:02:32 03b1be98f3f9: Pull complete 15:02:32 Digest: sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7 15:02:32 Status: Downloaded newer image for busybox@sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7 15:02:32 docker.io/library/busybox@sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7 15:02:32 The push refers to repository [registry:5000/busybox] 15:02:32 6a749002dd6a: Preparing 15:02:32 6a749002dd6a: Pushed 15:02:32 1.27.2: digest: sha256:030fcb92e1487b18c974784dcc110a93147c9fc402188370fbfd17efabffc6af size: 527 15:02:32 Swarm initialized: current node (bem8a49vgfl7dvr9ijgfvz04c) is now a manager. 15:02:32 15:02:32 To add a worker to this swarm, run the following command: 15:02:32 15:02:32 docker swarm join --token SWMTKN-1-4ml590kxdpm307s83wh7i732u52c0oja40msczenfhw1q4p66g-f11xcc1m2y41hgtcxes1dyeep 172.28.0.3:2377 15:02:32 15:02:32 To add a manager to this swarm, run 'docker swarm join-token manager' and follow the instructions. 15:02:32 15:02:50 ✓ e2e/cli-plugins (2.518s) 15:02:50 ∅ e2e/cli-plugins/plugins/badmeta 15:02:50 ∅ e2e/cli-plugins/plugins/nopersistentprerun 15:02:50 ✓ e2e/context (46ms) 15:02:50 ✓ e2e/global (113ms) 15:02:57 ✓ e2e/container (9.568s) 15:03:02 ✓ e2e/plugin (3.606s) 15:03:02 ✓ e2e/stack (688ms) 15:03:03 ✓ e2e/system (52ms) 15:03:06 ✓ e2e/image (14.592s) 15:03:06 ∅ e2e/internal/fixtures 15:03:06 ∅ e2e/plugin/basic 15:03:06 ✓ e2e/trust (2.711s) 15:03:06 15:03:06 === Skipped 15:03:06 === SKIP: e2e/cli-plugins TestCLIPluginDialStdio (0.00s) 15:03:06 dial_test.go:16: skipping plugin dial-stdio test since DOCKER_CLI_PLUGIN_USE_DIAL_STDIO is not set 15:03:06 15:03:06 === SKIP: e2e/stack TestDeployWithNamedResources/Kubernetes (0.00s) 15:03:06 --- SKIP: TestDeployWithNamedResources/Kubernetes (0.00s) 15:03:06 deploy_test.go:22: FIXME(chris-crone): currently does not work with compose for kubernetes. 15:03:06 15:03:06 === SKIP: e2e/stack TestRemove/Kubernetes (0.00s) 15:03:06 --- SKIP: TestRemove/Kubernetes (0.00s) 15:03:06 remove_test.go:22: !environment.KubernetesEnabled() 15:03:06 15:03:06 15:03:06 DONE 92 tests, 3 skipped in 34.526s 15:03:07 Stopping cliendtoendsuite_evil-notary-server_1 ... 15:03:07 Stopping cliendtoendsuite_registry_1 ... 15:03:07 Stopping cliendtoendsuite_engine_1 ... 15:03:07 Stopping cliendtoendsuite_notary-server_1 ... 15:03:09  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_evil-notary-server_1 ... 15:03:09 Removing cliendtoendsuite_registry_1 ... 15:03:09 Removing cliendtoendsuite_engine_1 ... 15:03:09 Removing cliendtoendsuite_notary-server_1 ... 15:03:09  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 15:03:09 Removing image cliendtoendsuite_notary-server 15:03:09 Removing image cliendtoendsuite_evil-notary-server 15:03:10 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-e2eclie2e3 15:03:11 Native build is an experimental feature and could change at any time 15:03:11 Creating network "cliendtoendsuite_default" with the default driver 15:03:11 Building evil-notary-server 15:03:11 #2 [internal] load .dockerignore 15:03:11 #2 transferring context: 2B done 15:03:11 #2 DONE 0.0s 15:03:11 15:03:11 #1 [internal] load build definition from Dockerfile.evil-notary-server 15:03:11 #1 transferring dockerfile: 150B done 15:03:11 #1 DONE 0.0s 15:03:11 15:03:11 #3 [internal] load metadata for docker.io/library/notary:server-0.5.0 15:03:11 #3 DONE 0.1s 15:03:11 15:03:11 #4 [1/2] FROM docker.io/library/notary:server-0.5.0@sha256:d59e4ecc20198447... 15:03:11 #4 DONE 0.0s 15:03:11 15:03:11 #5 [internal] load build context 15:03:11 #5 transferring context: 8.29kB done 15:03:11 #5 DONE 0.0s 15:03:11 15:03:11 #6 [2/2] COPY ./notary-evil/ /fixtures/ 15:03:11 #6 CACHED 15:03:11 15:03:11 #7 exporting to image 15:03:11 #7 exporting layers done 15:03:11 #7 writing image sha256:c88818637ee4726d50f8ec4e3374431b1f9be27642b4b694f9b4194ddc630227 done 15:03:11 #7 naming to docker.io/library/cliendtoendsuite_evil-notary-server done 15:03:11 #7 DONE 0.0s 15:03:11 Successfully built c88818637ee4726d50f8ec4e3374431b1f9be27642b4b694f9b4194ddc630227 15:03:11 Building engine 15:03:11 #2 [internal] load .dockerignore 15:03:11 #2 transferring context: 2B done 15:03:11 #2 DONE 0.0s 15:03:11 15:03:11 #1 [internal] load build definition from Dockerfile.connhelper-ssh 15:03:11 #1 transferring dockerfile: 599B done 15:03:11 #1 DONE 0.0s 15:03:11 15:03:11 #3 [internal] load metadata for docker.io/library/docker:test-dind 15:03:11 #3 DONE 0.1s 15:03:11 15:03:11 #4 [1/4] FROM docker.io/library/docker:test-dind@sha256:033ba84f8ea98910d8f... 15:03:11 #4 DONE 0.0s 15:03:11 15:03:11 #7 [internal] load build context 15:03:12 #7 transferring context: 376B done 15:03:12 #7 DONE 0.0s 15:03:12 15:03:12 #5 [2/4] RUN apk --no-cache add shadow openssh-server && groupadd -f dock... 15:03:12 #5 CACHED 15:03:12 15:03:12 #6 [3/4] RUN ln -s /usr/local/bin/docker /usr/bin/docker 15:03:12 #6 CACHED 15:03:12 15:03:12 #8 [4/4] COPY ./connhelper-ssh/entrypoint.sh / 15:03:12 #8 CACHED 15:03:12 15:03:12 #9 exporting to image 15:03:12 #9 exporting layers done 15:03:12 #9 writing image sha256:222b8f2cede49ba90653e17841cef612a414be792e3d214f58feddaab5993ecf done 15:03:12 #9 naming to docker.io/library/docker:stable-dind done 15:03:12 #9 DONE 0.0s 15:03:12 Successfully built 222b8f2cede49ba90653e17841cef612a414be792e3d214f58feddaab5993ecf 15:03:12 Building notary-server 15:03:12 #2 [internal] load .dockerignore 15:03:12 #2 transferring context: 2B done 15:03:12 #2 DONE 0.0s 15:03:12 15:03:12 #1 [internal] load build definition from Dockerfile.notary-server 15:03:12 #1 transferring dockerfile: 140B done 15:03:12 #1 DONE 0.0s 15:03:12 15:03:12 #3 [internal] load metadata for docker.io/library/notary:server-0.5.0 15:03:12 #3 DONE 0.1s 15:03:12 15:03:12 #4 [1/2] FROM docker.io/library/notary:server-0.5.0@sha256:d59e4ecc20198447... 15:03:12 #4 DONE 0.0s 15:03:12 15:03:12 #5 [internal] load build context 15:03:12 #5 transferring context: 8.26kB done 15:03:12 #5 DONE 0.0s 15:03:12 15:03:12 #6 [2/2] COPY ./notary/ /fixtures/ 15:03:12 #6 CACHED 15:03:12 15:03:12 #7 exporting to image 15:03:12 #7 exporting layers done 15:03:12 #7 writing image sha256:945b25bbb43837b367b41c23a06ed8b88645b88eb94edb28fb76382f6ed24c00 done 15:03:12 #7 naming to docker.io/library/cliendtoendsuite_notary-server done 15:03:12 #7 DONE 0.0s 15:03:12 Successfully built 945b25bbb43837b367b41c23a06ed8b88645b88eb94edb28fb76382f6ed24c00 15:03:12 Creating cliendtoendsuite_evil-notary-server_1 ... 15:03:12 Creating cliendtoendsuite_notary-server_1 ... 15:03:12 Creating cliendtoendsuite_engine_1 ... 15:03:12 Creating cliendtoendsuite_registry_1 ... 15:03:17  Creating cliendtoendsuite_evil-notary-server_1 ... done  Creating cliendtoendsuite_registry_1 ... done  Creating cliendtoendsuite_notary-server_1 ... done  Creating cliendtoendsuite_engine_1 ... done Waiting for docker daemon to become available at ssh://penguin@172.29.0.5 15:03:18 Client: 15:03:18 Version: 19.09.0-dev 15:03:18 API version: 1.40 (downgraded from 1.41) 15:03:18 Go version: go1.12.15 15:03:18 Git commit: 15:03:18 Built: Tue Jan 28 14:45:40 2020 15:03:18 OS/Arch: linux/amd64 15:03:18 Experimental: false 15:03:18 15:03:18 Server: Docker Engine - Community 15:03:18 Engine: 15:03:18 Version: 19.03.5 15:03:18 API version: 1.40 (minimum version 1.12) 15:03:18 Go version: go1.12.12 15:03:18 Git commit: 633a0ea838 15:03:18 Built: Wed Nov 13 07:28:45 2019 15:03:18 OS/Arch: linux/amd64 15:03:18 Experimental: true 15:03:18 containerd: 15:03:18 Version: v1.2.10 15:03:18 GitCommit: b34a5c8af56e510852c35414db4c1f4fa6172339 15:03:18 runc: 15:03:18 Version: 1.0.0-rc8+dev 15:03:18 GitCommit: 3e425f80a8c931f88e6d94a8c831b9d5aa481657 15:03:18 docker-init: 15:03:18 Version: 0.18.0 15:03:18 GitCommit: fec3683 15:03:18 sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d: Pulling from library/alpine 15:03:18 88286f41530e: Pulling fs layer 15:03:18 88286f41530e: Download complete 15:03:18 88286f41530e: Pull complete 15:03:18 Digest: sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d 15:03:18 Status: Downloaded newer image for alpine@sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d 15:03:18 docker.io/library/alpine@sha256:f006ecbb824d87947d0b51ab8488634bf69fe4094959d935c0c103f4820a417d 15:03:19 The push refers to repository [registry:5000/alpine] 15:03:19 5bef08742407: Preparing 15:03:19 5bef08742407: Pushed 15:03:19 3.6: digest: sha256:641b95ddb2ea9dc2af1a0113b6b348ebc20872ba615204fbe12148e98fd6f23d size: 528 15:03:19 sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7: Pulling from library/busybox 15:03:19 03b1be98f3f9: Pulling fs layer 15:03:19 03b1be98f3f9: Verifying Checksum 15:03:19 03b1be98f3f9: Download complete 15:03:19 03b1be98f3f9: Pull complete 15:03:19 Digest: sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7 15:03:19 Status: Downloaded newer image for busybox@sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7 15:03:19 docker.io/library/busybox@sha256:3e8fa85ddfef1af9ca85a5cfb714148956984e02f00bec3f7f49d3925a91e0e7 15:03:20 The push refers to repository [registry:5000/busybox] 15:03:20 6a749002dd6a: Preparing 15:03:20 6a749002dd6a: Pushed 15:03:20 1.27.2: digest: sha256:030fcb92e1487b18c974784dcc110a93147c9fc402188370fbfd17efabffc6af size: 527 15:03:21 Swarm initialized: current node (xd3gx66uxupup61f7jzjgs6rh) is now a manager. 15:03:21 15:03:21 To add a worker to this swarm, run the following command: 15:03:21 15:03:21 docker swarm join --token SWMTKN-1-470vkg3gk46h57ol3k8wiilcugmf53vjua9dih3pvj9rr4k5da-e48let2311qgke4q10rkyx3u1 172.29.0.5:2377 15:03:21 15:03:21 To add a manager to this swarm, run 'docker swarm join-token manager' and follow the instructions. 15:03:21 15:03:47 ✓ e2e/cli-plugins (11.515s) 15:03:47 ∅ e2e/cli-plugins/plugins/badmeta 15:03:47 ∅ e2e/cli-plugins/plugins/nopersistentprerun 15:03:47 ✓ e2e/context (53ms) 15:03:47 ✓ e2e/global (91ms) 15:04:05 ✓ e2e/image (15.53s) 15:04:08 ✓ e2e/plugin (3.317s) 15:04:09 ✓ e2e/stack (593ms) 15:04:09 ✓ e2e/system (277ms) 15:04:18 ✓ e2e/trust (6.637s) 15:04:18 ✖ e2e/container (41.153s) 15:04:18 ∅ e2e/internal/fixtures 15:04:18 ∅ e2e/plugin/basic 15:04:18 15:04:18 === Skipped 15:04:18 === SKIP: e2e/cli-plugins TestCLIPluginDialStdio (0.00s) 15:04:18 dial_test.go:16: skipping plugin dial-stdio test since DOCKER_CLI_PLUGIN_USE_DIAL_STDIO is not set 15:04:18 15:04:18 === SKIP: e2e/stack TestDeployWithNamedResources/Kubernetes (0.00s) 15:04:18 --- SKIP: TestDeployWithNamedResources/Kubernetes (0.00s) 15:04:18 deploy_test.go:22: FIXME(chris-crone): currently does not work with compose for kubernetes. 15:04:18 15:04:18 === SKIP: e2e/stack TestRemove/Kubernetes (0.00s) 15:04:18 --- SKIP: TestRemove/Kubernetes (0.00s) 15:04:18 remove_test.go:22: !environment.KubernetesEnabled() 15:04:18 15:04:18 15:04:18 === Failed 15:04:18 === FAIL: e2e/container TestRunAttachedFromRemoteImageAndRemove (11.98s) 15:04:18 run_test.go:26: assertion failed: 15:04:18 Command: docker run --rm registry:5000/alpine:test-run-pulls echo this is output 15:04:18 ExitCode: 1 15:04:18 Error: exit status 1 15:04:18 Stdout: this is output 15:04:18 15:04:18 Stderr: Unable to find image 'registry:5000/alpine:test-run-pulls' locally 15:04:18 test-run-pulls: Pulling from alpine 15:04:18 Digest: sha256:641b95ddb2ea9dc2af1a0113b6b348ebc20872ba615204fbe12148e98fd6f23d 15:04:18 Status: Downloaded newer image for registry:5000/alpine:test-run-pulls 15:04:18 time="2020-01-28T15:04:09Z" level=warning msg="commandConn.CloseRead: commandconn: failed to wait: exec: Wait was already called" 15:04:18 time="2020-01-28T15:04:09Z" level=warning msg="commandConn.CloseWrite: commandconn: failed to wait: exec: Wait was already called" 15:04:18 command [ssh -o ControlMaster=auto -o ControlPath=/root/.docker/%r@%h:%p -l penguin 172.29.0.5 -- docker system dial-stdio] did not exit after EOF: stderr="" 15:04:18 15:04:18 15:04:18 Failures: 15:04:18 ExitCode was 1 expected 0 15:04:18 Expected no error 15:04:18 15:04:18 15:04:18 DONE 92 tests, 3 skipped, 1 failure in 55.901s 15:04:18 Stopping cliendtoendsuite_registry_1 ... 15:04:18 Stopping cliendtoendsuite_engine_1 ... 15:04:18 Stopping cliendtoendsuite_notary-server_1 ... 15:04:18 Stopping cliendtoendsuite_evil-notary-server_1 ... 15:04:19  Stopping cliendtoendsuite_registry_1 ... done  Stopping cliendtoendsuite_evil-notary-server_1 ... done  Stopping cliendtoendsuite_notary-server_1 ... done  Stopping cliendtoendsuite_engine_1 ... done Removing cliendtoendsuite_registry_1 ... 15:04:19 Removing cliendtoendsuite_engine_1 ... 15:04:19 Removing cliendtoendsuite_notary-server_1 ... 15:04:19 Removing cliendtoendsuite_evil-notary-server_1 ... 15:04:20  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 15:04:20 Removing image cliendtoendsuite_notary-server 15:04:20 Removing image cliendtoendsuite_evil-notary-server 15:04:20 docker.Makefile:156: recipe for target 'test-e2e-connhelper-ssh' failed 15:04:20 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