Skip to content
[Jenkins]Jenkins
log in

Console Output

Skipping 184 KB.. Full Log
test 
01:37:23 [2023-12-06T01:37:23.122Z] time="2023-12-06T01:37:23.007593755Z" level=debug msg="filesystem.PutContent("/docker/registry/v2/repositories/test/_manifests/tags/latest/current/link")" go.version=go1.20.8 http.request.contenttype="application/vnd.docker.distribution.manifest.v2+json" http.request.host="127.0.0.1:5000" http.request.id=29e8d7f8-342d-44fe-942c-2db90f0ee161 http.request.method=PUT http.request.remoteaddr="127.0.0.1:46024" http.request.uri="/v2/test/manifests/latest" http.request.useragent="containerd/1.7.8+unknown" trace.duration=30.859µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).PutContent" trace.id=49083235-c8ad-4a29-bb83-ee79bfbdc676 trace.line=110 vars.name=test vars.reference=latest 
01:37:23 [2023-12-06T01:37:23.122Z] time="2023-12-06T01:37:23.007628963Z" level=debug msg="Succeeded in putting manifest!" go.version=go1.20.8 http.request.contenttype="application/vnd.docker.distribution.manifest.v2+json" http.request.host="127.0.0.1:5000" http.request.id=29e8d7f8-342d-44fe-942c-2db90f0ee161 http.request.method=PUT http.request.remoteaddr="127.0.0.1:46024" http.request.uri="/v2/test/manifests/latest" http.request.useragent="containerd/1.7.8+unknown" vars.name=test vars.reference=latest 
01:37:23 [2023-12-06T01:37:23.122Z] time="2023-12-06T01:37:23.007645635Z" level=info msg="response completed" go.version=go1.20.8 http.request.contenttype="application/vnd.docker.distribution.manifest.v2+json" http.request.host="127.0.0.1:5000" http.request.id=29e8d7f8-342d-44fe-942c-2db90f0ee161 http.request.method=PUT http.request.remoteaddr="127.0.0.1:46024" http.request.uri="/v2/test/manifests/latest" http.request.useragent="containerd/1.7.8+unknown" http.response.duration=2.028625ms http.response.status=201 http.response.written=0 
01:37:23 [2023-12-06T01:37:23.122Z] 127.0.0.1 - - [06/Dec/2023:01:37:23 +0000] "PUT /v2/test/manifests/latest HTTP/1.1" 201 0 "" "containerd/1.7.8+unknown"
01:37:23 [2023-12-06T01:37:23.122Z] time="2023-12-06T01:37:23.012125552Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=f9cd50f1-9a38-4fdb-a79e-19aaa9c61028 http.request.method=GET http.request.remoteaddr="127.0.0.1:46032" http.request.uri="/v2/" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" 
01:37:23 [2023-12-06T01:37:23.122Z] time="2023-12-06T01:37:23.012160128Z" level=info msg="response completed" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=f9cd50f1-9a38-4fdb-a79e-19aaa9c61028 http.request.method=GET http.request.remoteaddr="127.0.0.1:46032" http.request.uri="/v2/" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/json; charset=utf-8" http.response.duration="855.86µs" http.response.status=200 http.response.written=2 
01:37:23 [2023-12-06T01:37:23.122Z] 127.0.0.1 - - [06/Dec/2023:01:37:23 +0000] "GET /v2/ HTTP/1.1" 200 2 "" "docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
01:37:23 [2023-12-06T01:37:23.122Z] time="2023-12-06T01:37:23.014644183Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=28b0f973-09d5-4ff8-a70f-ba4d354cf790 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:46046" http.request.uri="/v2/test/manifests/latest" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=test vars.reference=latest 
01:37:23 [2023-12-06T01:37:23.122Z] time="2023-12-06T01:37:23.01468191Z" level=debug msg=GetImageManifest go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=28b0f973-09d5-4ff8-a70f-ba4d354cf790 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:46046" http.request.uri="/v2/test/manifests/latest" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=test vars.reference=latest 
01:37:23 [2023-12-06T01:37:23.122Z] time="2023-12-06T01:37:23.014765092Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/test/_manifests/tags/latest/current/link")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=28b0f973-09d5-4ff8-a70f-ba4d354cf790 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:46046" http.request.uri="/v2/test/manifests/latest" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=50.6µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).GetContent" trace.id=e43e2c94-9ba1-4568-8340-d68ad8c9ad05 trace.line=95 vars.name=test vars.reference=latest 
01:37:23 [2023-12-06T01:37:23.122Z] time="2023-12-06T01:37:23.014786475Z" level=debug msg="(*manifestStore).Get" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=28b0f973-09d5-4ff8-a70f-ba4d354cf790 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:46046" http.request.uri="/v2/test/manifests/latest" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=test vars.reference=latest 
01:37:23 [2023-12-06T01:37:23.123Z] time="2023-12-06T01:37:23.014832661Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/test/_manifests/revisions/sha256/a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda/link")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=28b0f973-09d5-4ff8-a70f-ba4d354cf790 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:46046" http.request.uri="/v2/test/manifests/latest" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=22.022µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).GetContent" trace.id=9478bc7b-2b30-4c23-a502-4431bc287ca7 trace.line=95 vars.name=test vars.reference=latest 
01:37:23 [2023-12-06T01:37:23.123Z] time="2023-12-06T01:37:23.014878519Z" level=debug msg="filesystem.Stat("/docker/registry/v2/blobs/sha256/a2/a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda/data")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=28b0f973-09d5-4ff8-a70f-ba4d354cf790 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:46046" http.request.uri="/v2/test/manifests/latest" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=16.599µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).Stat" trace.id=a77b5599-0111-4cf3-9e6b-347b10302519 trace.line=155 vars.name=test vars.reference=latest 
01:37:23 [2023-12-06T01:37:23.123Z] time="2023-12-06T01:37:23.014913735Z" level=debug msg="filesystem.Reader("/docker/registry/v2/blobs/sha256/a2/a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda/data", 0)" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=28b0f973-09d5-4ff8-a70f-ba4d354cf790 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:46046" http.request.uri="/v2/test/manifests/latest" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=12.62µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).Reader" trace.id=5586ccca-6e0d-44c3-9b1c-249dea7af4ec trace.line=125 vars.name=test vars.reference=latest 
01:37:23 [2023-12-06T01:37:23.123Z] time="2023-12-06T01:37:23.014961874Z" level=debug msg="(*schema2ManifestHandler).Unmarshal" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=28b0f973-09d5-4ff8-a70f-ba4d354cf790 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:46046" http.request.uri="/v2/test/manifests/latest" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=test vars.reference=latest 
01:37:23 [2023-12-06T01:37:23.123Z] time="2023-12-06T01:37:23.015053992Z" level=info msg="response completed" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=28b0f973-09d5-4ff8-a70f-ba4d354cf790 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:46046" http.request.uri="/v2/test/manifests/latest" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/vnd.docker.distribution.manifest.v2+json" http.response.duration=1.641133ms http.response.status=200 http.response.written=417 
01:37:23 [2023-12-06T01:37:23.123Z] 127.0.0.1 - - [06/Dec/2023:01:37:23 +0000] "HEAD /v2/test/manifests/latest HTTP/1.1" 200 417 "" "docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
01:37:23 [2023-12-06T01:37:23.123Z] time="2023-12-06T01:37:23.023684426Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=5d55598c-2c9b-4f9d-9d5f-b787903758d1 http.request.method=GET http.request.remoteaddr="127.0.0.1:46050" http.request.uri="/v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=test vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
01:37:23 [2023-12-06T01:37:23.124Z] time="2023-12-06T01:37:23.023733328Z" level=debug msg=GetImageManifest go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=5d55598c-2c9b-4f9d-9d5f-b787903758d1 http.request.method=GET http.request.remoteaddr="127.0.0.1:46050" http.request.uri="/v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=test vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
01:37:23 [2023-12-06T01:37:23.124Z] time="2023-12-06T01:37:23.023749615Z" level=debug msg="(*manifestStore).Get" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=5d55598c-2c9b-4f9d-9d5f-b787903758d1 http.request.method=GET http.request.remoteaddr="127.0.0.1:46050" http.request.uri="/v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=test vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
01:37:23 [2023-12-06T01:37:23.124Z] time="2023-12-06T01:37:23.023841134Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/test/_manifests/revisions/sha256/a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda/link")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=5d55598c-2c9b-4f9d-9d5f-b787903758d1 http.request.method=GET http.request.remoteaddr="127.0.0.1:46050" http.request.uri="/v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=57.698µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).GetContent" trace.id=85c49834-7c9c-45f4-8fdd-fdbed42fbeaa trace.line=95 vars.name=test vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
01:37:23 [2023-12-06T01:37:23.124Z] time="2023-12-06T01:37:23.023897372Z" level=debug msg="filesystem.Stat("/docker/registry/v2/blobs/sha256/a2/a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda/data")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=5d55598c-2c9b-4f9d-9d5f-b787903758d1 http.request.method=GET http.request.remoteaddr="127.0.0.1:46050" http.request.uri="/v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=17.502µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).Stat" trace.id=0806c23b-ba32-48a2-a9a2-60d7ec619580 trace.line=155 vars.name=test vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
01:37:23 [2023-12-06T01:37:23.124Z] time="2023-12-06T01:37:23.023943402Z" level=debug msg="filesystem.Reader("/docker/registry/v2/blobs/sha256/a2/a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda/data", 0)" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=5d55598c-2c9b-4f9d-9d5f-b787903758d1 http.request.method=GET http.request.remoteaddr="127.0.0.1:46050" http.request.uri="/v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=13.891µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).Reader" trace.id=f15c74a8-4a9e-4c15-aba4-5f55bd826ee8 trace.line=125 vars.name=test vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
01:37:23 [2023-12-06T01:37:23.124Z] time="2023-12-06T01:37:23.023981769Z" level=debug msg="(*schema2ManifestHandler).Unmarshal" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=5d55598c-2c9b-4f9d-9d5f-b787903758d1 http.request.method=GET http.request.remoteaddr="127.0.0.1:46050" http.request.uri="/v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=test vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
01:37:23 [2023-12-06T01:37:23.124Z] time="2023-12-06T01:37:23.02409001Z" level=info msg="response completed" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=5d55598c-2c9b-4f9d-9d5f-b787903758d1 http.request.method=GET http.request.remoteaddr="127.0.0.1:46050" http.request.uri="/v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/vnd.docker.distribution.manifest.v2+json" http.response.duration=1.315738ms http.response.status=200 http.response.written=417 
01:37:23 [2023-12-06T01:37:23.124Z] 127.0.0.1 - - [06/Dec/2023:01:37:23 +0000] "GET /v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda HTTP/1.1" 200 417 "" "docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
01:37:23 [2023-12-06T01:37:23.124Z] time="2023-12-06T01:37:23.030161247Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=d71c0588-8064-4c20-ad2b-0e52cb922e99 http.request.method=GET http.request.remoteaddr="127.0.0.1:46066" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
01:37:23 [2023-12-06T01:37:23.124Z] time="2023-12-06T01:37:23.030275158Z" level=debug msg=GetBlob go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=d71c0588-8064-4c20-ad2b-0e52cb922e99 http.request.method=GET http.request.remoteaddr="127.0.0.1:46066" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
01:37:23 [2023-12-06T01:37:23.125Z] time="2023-12-06T01:37:23.030535242Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=3c1d08cd-debf-4ef4-bc3c-3f5af4ead19a http.request.method=GET http.request.remoteaddr="127.0.0.1:46056" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
01:37:23 [2023-12-06T01:37:23.125Z] time="2023-12-06T01:37:23.030579574Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/test/_layers/sha256/5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923/link")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=d71c0588-8064-4c20-ad2b-0e52cb922e99 http.request.method=GET http.request.remoteaddr="127.0.0.1:46066" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=59.257µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).GetContent" trace.id=2b9421e1-3fe0-480e-85a5-974300b57457 trace.line=95 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
01:37:23 [2023-12-06T01:37:23.125Z] time="2023-12-06T01:37:23.03060688Z" level=debug msg=GetBlob go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=3c1d08cd-debf-4ef4-bc3c-3f5af4ead19a http.request.method=GET http.request.remoteaddr="127.0.0.1:46056" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
01:37:23 [2023-12-06T01:37:23.125Z] time="2023-12-06T01:37:23.030639331Z" level=debug msg="filesystem.Stat("/docker/registry/v2/blobs/sha256/5d/5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923/data")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=d71c0588-8064-4c20-ad2b-0e52cb922e99 http.request.method=GET http.request.remoteaddr="127.0.0.1:46066" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=19.011µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).Stat" trace.id=ccbcba98-7cbf-4d80-af2f-b0c84a7750ad trace.line=155 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
01:37:23 [2023-12-06T01:37:23.125Z] time="2023-12-06T01:37:23.030674686Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/test/_layers/sha256/cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b/link")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=3c1d08cd-debf-4ef4-bc3c-3f5af4ead19a http.request.method=GET http.request.remoteaddr="127.0.0.1:46056" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=37.202µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).GetContent" trace.id=4e98ce5f-489b-47e8-987c-0c3f00ff67c2 trace.line=95 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
01:37:23 [2023-12-06T01:37:23.125Z] time="2023-12-06T01:37:23.030690391Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/test/_layers/sha256/5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923/link")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=d71c0588-8064-4c20-ad2b-0e52cb922e99 http.request.method=GET http.request.remoteaddr="127.0.0.1:46066" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=19.455µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).GetContent" trace.id=284eb5bc-0de8-4313-be62-00df011758af trace.line=95 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
01:37:23 [2023-12-06T01:37:23.125Z] time="2023-12-06T01:37:23.030725Z" level=debug msg="filesystem.Stat("/docker/registry/v2/blobs/sha256/5d/5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923/data")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=d71c0588-8064-4c20-ad2b-0e52cb922e99 http.request.method=GET http.request.remoteaddr="127.0.0.1:46066" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=9.961µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).Stat" trace.id=ae59efc9-2ad1-4bfd-9cb7-9e45dcd14848 trace.line=155 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
01:37:23 [2023-12-06T01:37:23.125Z] time="2023-12-06T01:37:23.030761955Z" level=debug msg="filesystem.Stat("/docker/registry/v2/blobs/sha256/5d/5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923/data")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=d71c0588-8064-4c20-ad2b-0e52cb922e99 http.request.method=GET http.request.remoteaddr="127.0.0.1:46066" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=9.748µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).Stat" trace.id=76e24b70-70c8-44c9-88e8-11d3acc2d086 trace.line=155 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
01:37:23 [2023-12-06T01:37:23.125Z] time="2023-12-06T01:37:23.030726813Z" level=debug msg="filesystem.Stat("/docker/registry/v2/blobs/sha256/cf/cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b/data")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=3c1d08cd-debf-4ef4-bc3c-3f5af4ead19a http.request.method=GET http.request.remoteaddr="127.0.0.1:46056" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=17.952µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).Stat" trace.id=28ef5d98-7ff4-44ce-9a3f-d0e6dd823884 trace.line=155 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
01:37:23 [2023-12-06T01:37:23.126Z] time="2023-12-06T01:37:23.030848158Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/test/_layers/sha256/cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b/link")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=3c1d08cd-debf-4ef4-bc3c-3f5af4ead19a http.request.method=GET http.request.remoteaddr="127.0.0.1:46056" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=21.669µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).GetContent" trace.id=9778afe8-c7a1-4581-8d5e-e5548b9cfb9d trace.line=95 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
01:37:23 [2023-12-06T01:37:23.126Z] time="2023-12-06T01:37:23.030799494Z" level=debug msg="filesystem.URLFor("/docker/registry/v2/blobs/sha256/5d/5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923/data")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=d71c0588-8064-4c20-ad2b-0e52cb922e99 http.request.method=GET http.request.remoteaddr="127.0.0.1:46066" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=10.954µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).URLFor" trace.id=a27b3072-7180-460e-aff7-ae11e1ab5eab trace.line=217 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
01:37:23 [2023-12-06T01:37:23.126Z] time="2023-12-06T01:37:23.030887329Z" level=debug msg="filesystem.Stat("/docker/registry/v2/blobs/sha256/cf/cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b/data")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=3c1d08cd-debf-4ef4-bc3c-3f5af4ead19a http.request.method=GET http.request.remoteaddr="127.0.0.1:46056" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=10.092µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).Stat" trace.id=d368d922-4f86-48fc-9cf6-99e3428a08e6 trace.line=155 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
01:37:23 [2023-12-06T01:37:23.126Z] time="2023-12-06T01:37:23.030919131Z" level=debug msg="filesystem.Stat("/docker/registry/v2/blobs/sha256/cf/cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b/data")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=3c1d08cd-debf-4ef4-bc3c-3f5af4ead19a http.request.method=GET http.request.remoteaddr="127.0.0.1:46056" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=8.903µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).Stat" trace.id=f2412198-029b-44cd-b6b1-6a546f0ac422 trace.line=155 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
01:37:23 [2023-12-06T01:37:23.126Z] time="2023-12-06T01:37:23.030951771Z" level=debug msg="filesystem.URLFor("/docker/registry/v2/blobs/sha256/cf/cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b/data")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=3c1d08cd-debf-4ef4-bc3c-3f5af4ead19a http.request.method=GET http.request.remoteaddr="127.0.0.1:46056" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=6.605µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).URLFor" trace.id=afb01f2f-1dca-49e7-b9b9-ad43315c4c35 trace.line=217 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
01:37:23 [2023-12-06T01:37:23.126Z] time="2023-12-06T01:37:23.030998113Z" level=debug msg="filesystem.Reader("/docker/registry/v2/blobs/sha256/cf/cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b/data", 0)" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=3c1d08cd-debf-4ef4-bc3c-3f5af4ead19a http.request.method=GET http.request.remoteaddr="127.0.0.1:46056" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=14.433µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).Reader" trace.id=60f40db8-3d2c-4c0d-8657-bb4cf4239666 trace.line=125 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
01:37:23 [2023-12-06T01:37:23.126Z] time="2023-12-06T01:37:23.031010872Z" level=debug msg="filesystem.Reader("/docker/registry/v2/blobs/sha256/5d/5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923/data", 0)" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=d71c0588-8064-4c20-ad2b-0e52cb922e99 http.request.method=GET http.request.remoteaddr="127.0.0.1:46066" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=35.184µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).Reader" trace.id=72e2b241-b5a8-446c-86ce-d75325056e15 trace.line=125 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
01:37:23 [2023-12-06T01:37:23.127Z] time="2023-12-06T01:37:23.031452788Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/test/_layers/sha256/5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923/link")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=d71c0588-8064-4c20-ad2b-0e52cb922e99 http.request.method=GET http.request.remoteaddr="127.0.0.1:46066" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=39.712µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).GetContent" trace.id=8fba8277-ee76-4108-a8fb-be1110f0cba3 trace.line=95 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
01:37:23 [2023-12-06T01:37:23.127Z] time="2023-12-06T01:37:23.031530596Z" level=debug msg="filesystem.Stat("/docker/registry/v2/blobs/sha256/5d/5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923/data")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=d71c0588-8064-4c20-ad2b-0e52cb922e99 http.request.method=GET http.request.remoteaddr="127.0.0.1:46066" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=18.478µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).Stat" trace.id=ec888487-fff0-4b65-b28b-06f4a11600c5 trace.line=155 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
01:37:23 [2023-12-06T01:37:23.127Z] time="2023-12-06T01:37:23.031679707Z" level=info msg="response completed" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=d71c0588-8064-4c20-ad2b-0e52cb922e99 http.request.method=GET http.request.remoteaddr="127.0.0.1:46066" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/octet-stream" http.response.duration=2.705854ms http.response.status=200 http.response.written=68 
01:37:23 [2023-12-06T01:37:23.127Z] 127.0.0.1 - - [06/Dec/2023:01:37:23 +0000] "GET /v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923 HTTP/1.1" 200 68 "" "docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
01:37:23 [2023-12-06T01:37:23.127Z] time="2023-12-06T01:37:23.032474087Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/test/_layers/sha256/cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b/link")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=3c1d08cd-debf-4ef4-bc3c-3f5af4ead19a http.request.method=GET http.request.remoteaddr="127.0.0.1:46056" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=39.311µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).GetContent" trace.id=214cfafc-525a-4567-b920-90b2df21b850 trace.line=95 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
01:37:23 [2023-12-06T01:37:23.127Z] time="2023-12-06T01:37:23.032535371Z" level=debug msg="filesystem.Stat("/docker/registry/v2/blobs/sha256/cf/cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b/data")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=3c1d08cd-debf-4ef4-bc3c-3f5af4ead19a http.request.method=GET http.request.remoteaddr="127.0.0.1:46056" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=15.754µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).Stat" trace.id=ea0dbe8a-359c-436e-9b7e-0f24133402f0 trace.line=155 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
01:37:23 [2023-12-06T01:37:23.127Z] time="2023-12-06T01:37:23.032598582Z" level=info msg="response completed" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=3c1d08cd-debf-4ef4-bc3c-3f5af4ead19a http.request.method=GET http.request.remoteaddr="127.0.0.1:46056" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/octet-stream" http.response.duration=3.693184ms http.response.status=200 http.response.written=194 
01:37:23 [2023-12-06T01:37:23.127Z] 127.0.0.1 - - [06/Dec/2023:01:37:23 +0000] "GET /v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b HTTP/1.1" 200 194 "" "docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
01:37:23 [2023-12-06T01:37:23.127Z] time="2023-12-06T01:37:23.044529137Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=84b40836-6ddc-4bbf-8962-fb9f3f7b9120 http.request.method=GET http.request.remoteaddr="127.0.0.1:46092" http.request.uri="/v2/" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" 
01:37:23 [2023-12-06T01:37:23.127Z] time="2023-12-06T01:37:23.044568094Z" level=info msg="response completed" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=84b40836-6ddc-4bbf-8962-fb9f3f7b9120 http.request.method=GET http.request.remoteaddr="127.0.0.1:46092" http.request.uri="/v2/" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/json; charset=utf-8" http.response.duration="895.515µs" http.response.status=200 http.response.written=2 
01:37:23 [2023-12-06T01:37:23.127Z] 127.0.0.1 - - [06/Dec/2023:01:37:23 +0000] "GET /v2/ HTTP/1.1" 200 2 "" "docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
01:37:23 [2023-12-06T01:37:23.127Z] time="2023-12-06T01:37:23.05023447Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=088ec1a7-e864-4364-b3d0-8b90d72ef95f http.request.method=HEAD http.request.remoteaddr="127.0.0.1:46106" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
01:37:23 [2023-12-06T01:37:23.127Z] time="2023-12-06T01:37:23.050280328Z" level=debug msg=GetImageManifest go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=088ec1a7-e864-4364-b3d0-8b90d72ef95f http.request.method=HEAD http.request.remoteaddr="127.0.0.1:46106" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
01:37:23 [2023-12-06T01:37:23.127Z] time="2023-12-06T01:37:23.050294793Z" level=debug msg="(*manifestStore).Get" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=088ec1a7-e864-4364-b3d0-8b90d72ef95f http.request.method=HEAD http.request.remoteaddr="127.0.0.1:46106" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
01:37:23 [2023-12-06T01:37:23.127Z] time="2023-12-06T01:37:23.050360344Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/other/_manifests/revisions/sha256/a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda/link")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=088ec1a7-e864-4364-b3d0-8b90d72ef95f http.request.method=HEAD http.request.remoteaddr="127.0.0.1:46106" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=34.059µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).GetContent" trace.id=857d6e3b-f3cf-41b8-aca3-c1654a3660cf trace.line=95 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
01:37:23 [2023-12-06T01:37:23.127Z] time="2023-12-06T01:37:23.050408376Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/other/_layers/sha256/a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda/link")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=088ec1a7-e864-4364-b3d0-8b90d72ef95f http.request.method=HEAD http.request.remoteaddr="127.0.0.1:46106" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=13.284µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).GetContent" trace.id=78330a87-d725-4e66-bf1c-aec44bedce7b trace.line=95 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
01:37:23 [2023-12-06T01:37:23.127Z] time="2023-12-06T01:37:23.050479867Z" level=error msg="response completed with error" err.code="manifest unknown" err.detail="unknown manifest name=other revision=sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" err.message="manifest unknown" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=088ec1a7-e864-4364-b3d0-8b90d72ef95f http.request.method=HEAD http.request.remoteaddr="127.0.0.1:46106" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/json; charset=utf-8" http.response.duration=1.070234ms http.response.status=404 http.response.written=181 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
01:37:23 [2023-12-06T01:37:23.127Z] 127.0.0.1 - - [06/Dec/2023:01:37:23 +0000] "HEAD /v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda HTTP/1.1" 404 181 "" "docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
01:37:23 [2023-12-06T01:37:23.128Z] time="2023-12-06T01:37:23.051741771Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=0e90970e-6535-4faa-954b-8fb2adca8fc2 http.request.method=GET http.request.remoteaddr="127.0.0.1:46108" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
01:37:23 [2023-12-06T01:37:23.128Z] time="2023-12-06T01:37:23.051781147Z" level=debug msg=GetImageManifest go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=0e90970e-6535-4faa-954b-8fb2adca8fc2 http.request.method=GET http.request.remoteaddr="127.0.0.1:46108" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
01:37:23 [2023-12-06T01:37:23.128Z] time="2023-12-06T01:37:23.051795563Z" level=debug msg="(*manifestStore).Get" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=0e90970e-6535-4faa-954b-8fb2adca8fc2 http.request.method=GET http.request.remoteaddr="127.0.0.1:46108" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
01:37:23 [2023-12-06T01:37:23.128Z] time="2023-12-06T01:37:23.051859472Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/other/_manifests/revisions/sha256/a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda/link")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=0e90970e-6535-4faa-954b-8fb2adca8fc2 http.request.method=GET http.request.remoteaddr="127.0.0.1:46108" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=27.979µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).GetContent" trace.id=e8002208-4b3c-4976-aafc-95f201908740 trace.line=95 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
01:37:23 [2023-12-06T01:37:23.128Z] time="2023-12-06T01:37:23.051905757Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/other/_layers/sha256/a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda/link")" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=0e90970e-6535-4faa-954b-8fb2adca8fc2 http.request.method=GET http.request.remoteaddr="127.0.0.1:46108" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=13.809µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).GetContent" trace.id=da183fed-1d0d-4b30-8ab7-5502a1d6cddd trace.line=95 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
01:37:23 [2023-12-06T01:37:23.128Z] time="2023-12-06T01:37:23.051951213Z" level=error msg="response completed with error" err.code="manifest unknown" err.detail="unknown manifest name=other revision=sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" err.message="manifest unknown" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=0e90970e-6535-4faa-954b-8fb2adca8fc2 http.request.method=GET http.request.remoteaddr="127.0.0.1:46108" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/json; charset=utf-8" http.response.duration="994.494µs" http.response.status=404 http.response.written=181 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
01:37:23 [2023-12-06T01:37:23.128Z] 127.0.0.1 - - [06/Dec/2023:01:37:23 +0000] "GET /v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda HTTP/1.1" 404 181 "" "docker/dev go/go1.21.5 git-commit/7cb1efebec36e43bcfc256f4558610c13f289b05 kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
01:37:23 [2023-12-06T01:37:23.128Z] --- PASS: TestImagePullStoredfDigestForOtherRepo (0.18s)
01:37:23 [2023-12-06T01:37:23.128Z] === RUN   TestImagePullNonExisting
01:37:23 [2023-12-06T01:37:23.128Z] === RUN   TestImagePullNonExisting/asdfasdf:foobar
01:37:23 [2023-12-06T01:37:23.128Z] === PAUSE TestImagePullNonExisting/asdfasdf:foobar
01:37:23 [2023-12-06T01:37:23.128Z] === RUN   TestImagePullNonExisting/library/asdfasdf:foobar
01:37:23 [2023-12-06T01:37:23.128Z] === PAUSE TestImagePullNonExisting/library/asdfasdf:foobar
01:37:23 [2023-12-06T01:37:23.128Z] === RUN   TestImagePullNonExisting/asdfasdf
01:37:23 [2023-12-06T01:37:23.128Z] === PAUSE TestImagePullNonExisting/asdfasdf
01:37:23 [2023-12-06T01:37:23.128Z] === RUN   TestImagePullNonExisting/asdfasdf:latest
01:37:23 [2023-12-06T01:37:23.128Z] === PAUSE TestImagePullNonExisting/asdfasdf:latest
01:37:23 [2023-12-06T01:37:23.128Z] === RUN   TestImagePullNonExisting/library/asdfasdf
01:37:23 [2023-12-06T01:37:23.128Z] === PAUSE TestImagePullNonExisting/library/asdfasdf
01:37:23 [2023-12-06T01:37:23.128Z] === RUN   TestImagePullNonExisting/library/asdfasdf:latest
01:37:23 [2023-12-06T01:37:23.128Z] === PAUSE TestImagePullNonExisting/library/asdfasdf:latest
01:37:23 [2023-12-06T01:37:23.128Z] === CONT  TestImagePullNonExisting/asdfasdf:foobar
01:37:23 [2023-12-06T01:37:23.128Z] === CONT  TestImagePullNonExisting/asdfasdf:latest
01:37:23 [2023-12-06T01:37:23.128Z] === CONT  TestImagePullNonExisting/asdfasdf
01:37:23 [2023-12-06T01:37:23.128Z] === CONT  TestImagePullNonExisting/library/asdfasdf:latest
01:37:23 [2023-12-06T01:37:23.128Z] === CONT  TestImagePullNonExisting/library/asdfasdf
01:37:23 [2023-12-06T01:37:23.128Z] === CONT  TestImagePullNonExisting/library/asdfasdf:foobar
01:37:24 [2023-12-06T01:37:24.528Z] --- PASS: TestImagePullNonExisting (0.01s)
01:37:24 [2023-12-06T01:37:24.528Z]     --- PASS: TestImagePullNonExisting/asdfasdf:foobar (0.95s)
01:37:24 [2023-12-06T01:37:24.528Z]     --- PASS: TestImagePullNonExisting/library/asdfasdf:latest (0.96s)
01:37:24 [2023-12-06T01:37:24.528Z]     --- PASS: TestImagePullNonExisting/library/asdfasdf:foobar (0.96s)
01:37:24 [2023-12-06T01:37:24.528Z]     --- PASS: TestImagePullNonExisting/asdfasdf:latest (0.96s)
01:37:24 [2023-12-06T01:37:24.528Z]     --- PASS: TestImagePullNonExisting/library/asdfasdf (1.27s)
01:37:24 [2023-12-06T01:37:24.528Z]     --- PASS: TestImagePullNonExisting/asdfasdf (1.28s)
01:37:24 [2023-12-06T01:37:24.528Z] === RUN   TestRemoveImageOrphaning
01:37:24 [2023-12-06T01:37:24.788Z] --- PASS: TestRemoveImageOrphaning (0.19s)
01:37:24 [2023-12-06T01:37:24.788Z] === RUN   TestRemoveByDigest
01:37:24 [2023-12-06T01:37:24.788Z]     remove_test.go:64: !testEnv.UsingSnapshotter(): RepoDigests doesn't include tags when using graphdrivers
01:37:24 [2023-12-06T01:37:24.788Z] --- SKIP: TestRemoveByDigest (0.00s)
01:37:24 [2023-12-06T01:37:24.788Z] === RUN   TestRemoveImageGarbageCollector
01:37:24 [2023-12-06T01:37:24.788Z]     remove_unix_test.go:34: (*Execution).NotAmd64-fm
01:37:24 [2023-12-06T01:37:24.788Z] --- SKIP: TestRemoveImageGarbageCollector (0.00s)
01:37:24 [2023-12-06T01:37:24.788Z] === RUN   TestSaveCheckTimes
01:37:24 [2023-12-06T01:37:24.788Z] === PAUSE TestSaveCheckTimes
01:37:24 [2023-12-06T01:37:24.788Z] === RUN   TestSaveRepoWithMultipleImages
01:37:24 [2023-12-06T01:37:24.788Z] --- PASS: TestSaveRepoWithMultipleImages (0.22s)
01:37:24 [2023-12-06T01:37:24.788Z] === RUN   TestSaveDirectoryPermissions
01:37:26 [2023-12-06T01:37:26.161Z] --- PASS: TestSaveDirectoryPermissions (1.07s)
01:37:26 [2023-12-06T01:37:26.161Z] === RUN   TestTagUnprefixedRepoByNameOrName
01:37:26 [2023-12-06T01:37:26.161Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.03s)
01:37:26 [2023-12-06T01:37:26.161Z] === RUN   TestTagUsingDigestAlgorithmAsName
01:37:26 [2023-12-06T01:37:26.161Z] --- PASS: TestTagUsingDigestAlgorithmAsName (0.01s)
01:37:26 [2023-12-06T01:37:26.161Z] === RUN   TestTagValidPrefixedRepo
01:37:26 [2023-12-06T01:37:26.161Z] === RUN   TestTagValidPrefixedRepo/fooo/bar
01:37:26 [2023-12-06T01:37:26.161Z] === PAUSE TestTagValidPrefixedRepo/fooo/bar
01:37:26 [2023-12-06T01:37:26.161Z] === RUN   TestTagValidPrefixedRepo/fooaa/test
01:37:26 [2023-12-06T01:37:26.161Z] === PAUSE TestTagValidPrefixedRepo/fooaa/test
01:37:26 [2023-12-06T01:37:26.161Z] === RUN   TestTagValidPrefixedRepo/foooo:t
01:37:26 [2023-12-06T01:37:26.161Z] === PAUSE TestTagValidPrefixedRepo/foooo:t
01:37:26 [2023-12-06T01:37:26.161Z] === RUN   TestTagValidPrefixedRepo/HOSTNAME.DOMAIN.COM:443/foo/bar
01:37:26 [2023-12-06T01:37:26.161Z] === PAUSE TestTagValidPrefixedRepo/HOSTNAME.DOMAIN.COM:443/foo/bar
01:37:26 [2023-12-06T01:37:26.161Z] === CONT  TestTagValidPrefixedRepo/fooo/bar
01:37:26 [2023-12-06T01:37:26.161Z] === CONT  TestTagValidPrefixedRepo/foooo:t
01:37:26 [2023-12-06T01:37:26.161Z] === CONT  TestTagValidPrefixedRepo/fooaa/test
01:37:26 [2023-12-06T01:37:26.161Z] === CONT  TestTagValidPrefixedRepo/HOSTNAME.DOMAIN.COM:443/foo/bar
01:37:26 [2023-12-06T01:37:26.161Z] --- PASS: TestTagValidPrefixedRepo (0.02s)
01:37:26 [2023-12-06T01:37:26.161Z]     --- PASS: TestTagValidPrefixedRepo/fooo/bar (0.01s)
01:37:26 [2023-12-06T01:37:26.161Z]     --- PASS: TestTagValidPrefixedRepo/HOSTNAME.DOMAIN.COM:443/foo/bar (0.01s)
01:37:26 [2023-12-06T01:37:26.161Z]     --- PASS: TestTagValidPrefixedRepo/foooo:t (0.01s)
01:37:26 [2023-12-06T01:37:26.161Z]     --- PASS: TestTagValidPrefixedRepo/fooaa/test (0.02s)
01:37:26 [2023-12-06T01:37:26.161Z] === RUN   TestTagExistedNameWithoutForce
01:37:26 [2023-12-06T01:37:26.161Z] --- PASS: TestTagExistedNameWithoutForce (0.02s)
01:37:26 [2023-12-06T01:37:26.161Z] === RUN   TestTagOfficialNames
01:37:26 [2023-12-06T01:37:26.161Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_docker.io/busybox
01:37:26 [2023-12-06T01:37:26.161Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_index.docker.io/busybox
01:37:26 [2023-12-06T01:37:26.161Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_library/busybox
01:37:26 [2023-12-06T01:37:26.161Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_docker.io/library/busybox
01:37:26 [2023-12-06T01:37:26.161Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_index.docker.io/library/busybox
01:37:26 [2023-12-06T01:37:26.161Z] --- PASS: TestTagOfficialNames (0.05s)
01:37:26 [2023-12-06T01:37:26.161Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_docker.io/busybox (0.01s)
01:37:26 [2023-12-06T01:37:26.161Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_index.docker.io/busybox (0.01s)
01:37:26 [2023-12-06T01:37:26.161Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_library/busybox (0.01s)
01:37:26 [2023-12-06T01:37:26.161Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_docker.io/library/busybox (0.01s)
01:37:26 [2023-12-06T01:37:26.161Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_index.docker.io/library/busybox (0.01s)
01:37:26 [2023-12-06T01:37:26.161Z] === RUN   TestTagMatchesDigest
01:37:26 [2023-12-06T01:37:26.161Z] --- PASS: TestTagMatchesDigest (0.01s)
01:37:26 [2023-12-06T01:37:26.161Z] === CONT  TestSaveCheckTimes
01:37:26 [2023-12-06T01:37:26.161Z] --- PASS: TestSaveCheckTimes (0.03s)
01:37:26 [2023-12-06T01:37:26.161Z] PASS
01:37:26 [2023-12-06T01:37:26.161Z] 
01:37:26 [2023-12-06T01:37:26.161Z] === Skipped
01:37:26 [2023-12-06T01:37:26.161Z] === SKIP: arm64.integration.image TestImportExtremelyLargeImageWorks (0.00s)
01:37:26 [2023-12-06T01:37:26.161Z]     import_test.go:23: runtime.GOARCH == "arm64": effective test will be time out
01:37:26 [2023-12-06T01:37:26.161Z] 
01:37:26 [2023-12-06T01:37:26.161Z] === SKIP: arm64.integration.image TestRemoveByDigest (0.00s)
01:37:26 [2023-12-06T01:37:26.161Z]     remove_test.go:64: !testEnv.UsingSnapshotter(): RepoDigests doesn't include tags when using graphdrivers
01:37:26 [2023-12-06T01:37:26.161Z] 
01:37:26 [2023-12-06T01:37:26.161Z] === SKIP: arm64.integration.image TestRemoveImageGarbageCollector (0.00s)
01:37:26 [2023-12-06T01:37:26.161Z]     remove_unix_test.go:34: (*Execution).NotAmd64-fm
01:37:26 [2023-12-06T01:37:26.161Z] 
01:37:26 [2023-12-06T01:37:26.161Z] DONE 54 tests, 3 skipped in 5.643s
01:37:26 [2023-12-06T01:37:26.161Z] Running /go/src/github.com/docker/docker/integration/internal/termtest (arm64.integration.internal.termtest) flags=-test.v -test.timeout=120m  
01:37:26 [2023-12-06T01:37:26.161Z] ++ '[' -n '' ']'
01:37:26 [2023-12-06T01:37:26.161Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-internal-termtest-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-internal-termtest-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.internal.termtest -t ./test.main -test.v -test.timeout=120m
01:37:26 [2023-12-06T01:37:26.161Z] ++ set -e
01:37:26 [2023-12-06T01:37:26.161Z] ++ '[' -n 0 ']'
01:37:26 [2023-12-06T01:37:26.161Z] ++ set -x
01:37:26 [2023-12-06T01:37:26.161Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///run/docker/tmp.9zRT3ArzgE/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= GO111MODULE=off GOCACHE=/root/.cache/go-build GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=/usr/local/cli-integration/docker TEST_INTEGRATION_USE_SNAPSHOTTER= OTEL_EXPORTER_OTLP_ENDPOINT= OTEL_SERVICE_NAME= gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-internal-termtest-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-internal-termtest-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.internal.termtest -t ./test.main -test.v -test.timeout=120m
01:37:26 [2023-12-06T01:37:26.161Z] === RUN   TestStripANSICommands
01:37:26 [2023-12-06T01:37:26.161Z] === RUN   TestStripANSICommands/#00
01:37:26 [2023-12-06T01:37:26.161Z] === RUN   TestStripANSICommands/#01
01:37:26 [2023-12-06T01:37:26.161Z] --- PASS: TestStripANSICommands (0.00s)
01:37:26 [2023-12-06T01:37:26.161Z]     --- PASS: TestStripANSICommands/#00 (0.00s)
01:37:26 [2023-12-06T01:37:26.161Z]     --- PASS: TestStripANSICommands/#01 (0.00s)
01:37:26 [2023-12-06T01:37:26.161Z] PASS
01:37:26 [2023-12-06T01:37:26.161Z] 
01:37:26 [2023-12-06T01:37:26.161Z] DONE 3 tests in 0.009s
01:37:26 [2023-12-06T01:37:26.161Z] Running /go/src/github.com/docker/docker/integration/network (arm64.integration.network) flags=-test.v -test.timeout=120m  
01:37:26 [2023-12-06T01:37:26.161Z] ++ '[' -n '' ']'
01:37:26 [2023-12-06T01:37:26.161Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-network-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-network-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.network -t ./test.main -test.v -test.timeout=120m
01:37:26 [2023-12-06T01:37:26.161Z] ++ set -e
01:37:26 [2023-12-06T01:37:26.161Z] ++ '[' -n 0 ']'
01:37:26 [2023-12-06T01:37:26.161Z] ++ set -x
01:37:26 [2023-12-06T01:37:26.161Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///run/docker/tmp.9zRT3ArzgE/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= GO111MODULE=off GOCACHE=/root/.cache/go-build GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=/usr/local/cli-integration/docker TEST_INTEGRATION_USE_SNAPSHOTTER= OTEL_EXPORTER_OTLP_ENDPOINT= OTEL_SERVICE_NAME= gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-network-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-network-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.network -t ./test.main -test.v -test.timeout=120m
01:37:26 [2023-12-06T01:37:26.161Z] INFO: Testing against a local daemon
01:37:26 [2023-12-06T01:37:26.161Z] === RUN   TestCreateWithMultiNetworks
01:37:27 [2023-12-06T01:37:27.093Z] --- PASS: TestCreateWithMultiNetworks (0.99s)
01:37:27 [2023-12-06T01:37:27.093Z] === RUN   TestNetworkCreateDelete
01:37:27 [2023-12-06T01:37:27.352Z] --- PASS: TestNetworkCreateDelete (0.18s)
01:37:27 [2023-12-06T01:37:27.352Z] === RUN   TestDockerNetworkDeletePreferID
01:37:27 [2023-12-06T01:37:27.917Z] --- PASS: TestDockerNetworkDeletePreferID (0.51s)
01:37:27 [2023-12-06T01:37:27.917Z] === RUN   TestDaemonDNSFallback
01:37:34 [2023-12-06T01:37:34.470Z] --- PASS: TestDaemonDNSFallback (6.22s)
01:37:34 [2023-12-06T01:37:34.470Z] === RUN   TestInspectNetwork
01:37:36 [2023-12-06T01:37:36.997Z] === RUN   TestInspectNetwork/full_network_id
01:37:36 [2023-12-06T01:37:36.997Z] === RUN   TestInspectNetwork/partial_network_id
01:37:36 [2023-12-06T01:37:36.997Z] === RUN   TestInspectNetwork/network_name
01:37:36 [2023-12-06T01:37:36.997Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
01:37:41 [2023-12-06T01:37:41.177Z] --- PASS: TestInspectNetwork (7.00s)
01:37:41 [2023-12-06T01:37:41.177Z]     --- PASS: TestInspectNetwork/full_network_id (0.00s)
01:37:41 [2023-12-06T01:37:41.177Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
01:37:41 [2023-12-06T01:37:41.177Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
01:37:41 [2023-12-06T01:37:41.177Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
01:37:41 [2023-12-06T01:37:41.177Z] === RUN   TestRunContainerWithBridgeNone
01:37:42 [2023-12-06T01:37:42.549Z] --- PASS: TestRunContainerWithBridgeNone (1.40s)
01:37:42 [2023-12-06T01:37:42.549Z] === RUN   TestNetworkInvalidJSON
01:37:42 [2023-12-06T01:37:42.549Z] === RUN   TestNetworkInvalidJSON/networks/create
01:37:42 [2023-12-06T01:37:42.549Z] === PAUSE TestNetworkInvalidJSON/networks/create
01:37:42 [2023-12-06T01:37:42.549Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect
01:37:42 [2023-12-06T01:37:42.549Z] === PAUSE TestNetworkInvalidJSON/networks/bridge/connect
01:37:42 [2023-12-06T01:37:42.549Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect
01:37:42 [2023-12-06T01:37:42.549Z] === PAUSE TestNetworkInvalidJSON/networks/bridge/disconnect
01:37:42 [2023-12-06T01:37:42.549Z] === CONT  TestNetworkInvalidJSON/networks/create
01:37:42 [2023-12-06T01:37:42.549Z] === CONT  TestNetworkInvalidJSON/networks/bridge/disconnect
01:37:42 [2023-12-06T01:37:42.549Z] === RUN   TestNetworkInvalidJSON/networks/create/invalid_content_type
01:37:42 [2023-12-06T01:37:42.549Z] === CONT  TestNetworkInvalidJSON/networks/bridge/connect
01:37:42 [2023-12-06T01:37:42.549Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect/invalid_content_type
01:37:42 [2023-12-06T01:37:42.549Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect/invalid_content_type
01:37:42 [2023-12-06T01:37:42.549Z] === RUN   TestNetworkInvalidJSON/networks/create/invalid_JSON
01:37:42 [2023-12-06T01:37:42.549Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect/invalid_JSON
01:37:42 [2023-12-06T01:37:42.549Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect/invalid_JSON
01:37:42 [2023-12-06T01:37:42.549Z] === RUN   TestNetworkInvalidJSON/networks/create/extra_content_after_JSON
01:37:42 [2023-12-06T01:37:42.549Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect/extra_content_after_JSON
01:37:42 [2023-12-06T01:37:42.549Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect/extra_content_after_JSON
01:37:42 [2023-12-06T01:37:42.549Z] === RUN   TestNetworkInvalidJSON/networks/create/empty_body
01:37:42 [2023-12-06T01:37:42.549Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect/empty_body
01:37:42 [2023-12-06T01:37:42.549Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect/empty_body
01:37:42 [2023-12-06T01:37:42.549Z] --- PASS: TestNetworkInvalidJSON (0.01s)
01:37:42 [2023-12-06T01:37:42.549Z]     --- PASS: TestNetworkInvalidJSON/networks/create (0.00s)
01:37:42 [2023-12-06T01:37:42.549Z]         --- PASS: TestNetworkInvalidJSON/networks/create/invalid_content_type (0.00s)
01:37:42 [2023-12-06T01:37:42.549Z]         --- PASS: TestNetworkInvalidJSON/networks/create/invalid_JSON (0.00s)
01:37:42 [2023-12-06T01:37:42.549Z]         --- PASS: TestNetworkInvalidJSON/networks/create/extra_content_after_JSON (0.00s)
01:37:42 [2023-12-06T01:37:42.549Z]         --- PASS: TestNetworkInvalidJSON/networks/create/empty_body (0.00s)
01:37:42 [2023-12-06T01:37:42.549Z]     --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect (0.00s)
01:37:42 [2023-12-06T01:37:42.549Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect/invalid_content_type (0.00s)
01:37:42 [2023-12-06T01:37:42.549Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect/invalid_JSON (0.00s)
01:37:42 [2023-12-06T01:37:42.549Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect/extra_content_after_JSON (0.00s)
01:37:42 [2023-12-06T01:37:42.549Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect/empty_body (0.00s)
01:37:42 [2023-12-06T01:37:42.549Z]     --- PASS: TestNetworkInvalidJSON/networks/bridge/connect (0.00s)
01:37:42 [2023-12-06T01:37:42.549Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/connect/invalid_content_type (0.00s)
01:37:42 [2023-12-06T01:37:42.549Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/connect/invalid_JSON (0.00s)
01:37:42 [2023-12-06T01:37:42.549Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/connect/extra_content_after_JSON (0.00s)
01:37:42 [2023-12-06T01:37:42.549Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/connect/empty_body (0.00s)
01:37:42 [2023-12-06T01:37:42.549Z] === RUN   TestNetworkList
01:37:42 [2023-12-06T01:37:42.549Z] === RUN   TestNetworkList//networks
01:37:42 [2023-12-06T01:37:42.549Z] === PAUSE TestNetworkList//networks
01:37:42 [2023-12-06T01:37:42.549Z] === RUN   TestNetworkList//networks/
01:37:42 [2023-12-06T01:37:42.549Z] === PAUSE TestNetworkList//networks/
01:37:42 [2023-12-06T01:37:42.549Z] === CONT  TestNetworkList//networks
01:37:42 [2023-12-06T01:37:42.549Z] === CONT  TestNetworkList//networks/
01:37:42 [2023-12-06T01:37:42.549Z] --- PASS: TestNetworkList (0.01s)
01:37:42 [2023-12-06T01:37:42.549Z]     --- PASS: TestNetworkList//networks/ (0.00s)
01:37:42 [2023-12-06T01:37:42.549Z]     --- PASS: TestNetworkList//networks (0.00s)
01:37:42 [2023-12-06T01:37:42.549Z] === RUN   TestHostIPv4BridgeLabel
01:37:43 [2023-12-06T01:37:43.114Z] --- PASS: TestHostIPv4BridgeLabel (0.56s)
01:37:43 [2023-12-06T01:37:43.114Z] === RUN   TestDefaultNetworkOpts
01:37:43 [2023-12-06T01:37:43.114Z] === RUN   TestDefaultNetworkOpts/default_value
01:37:44 [2023-12-06T01:37:44.488Z] === RUN   TestDefaultNetworkOpts/cmdline_value
01:37:45 [2023-12-06T01:37:45.859Z] === RUN   TestDefaultNetworkOpts/config-from_value
01:37:47 [2023-12-06T01:37:47.232Z] --- PASS: TestDefaultNetworkOpts (3.93s)
01:37:47 [2023-12-06T01:37:47.232Z]     --- PASS: TestDefaultNetworkOpts/default_value (1.30s)
01:37:47 [2023-12-06T01:37:47.232Z]     --- PASS: TestDefaultNetworkOpts/cmdline_value (1.32s)
01:37:47 [2023-12-06T01:37:47.232Z]     --- PASS: TestDefaultNetworkOpts/config-from_value (1.31s)
01:37:47 [2023-12-06T01:37:47.232Z] === RUN   TestForbidDuplicateNetworkNames
01:37:47 [2023-12-06T01:37:47.797Z] --- PASS: TestForbidDuplicateNetworkNames (0.64s)
01:37:47 [2023-12-06T01:37:47.797Z] === RUN   TestDaemonRestartWithLiveRestore
01:37:48 [2023-12-06T01:37:48.730Z] --- PASS: TestDaemonRestartWithLiveRestore (1.03s)
01:37:48 [2023-12-06T01:37:48.730Z] === RUN   TestDaemonDefaultNetworkPools
01:37:49 [2023-12-06T01:37:49.664Z] --- PASS: TestDaemonDefaultNetworkPools (0.80s)
01:37:49 [2023-12-06T01:37:49.664Z] === RUN   TestDaemonRestartWithExistingNetwork
01:37:50 [2023-12-06T01:37:50.597Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.17s)
01:37:50 [2023-12-06T01:37:50.597Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
01:37:51 [2023-12-06T01:37:51.969Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.26s)
01:37:51 [2023-12-06T01:37:51.969Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
01:37:52 [2023-12-06T01:37:52.534Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.61s)
01:37:52 [2023-12-06T01:37:52.534Z] === RUN   TestServiceWithPredefinedNetwork
01:37:55 [2023-12-06T01:37:55.060Z] --- PASS: TestServiceWithPredefinedNetwork (2.15s)
01:37:55 [2023-12-06T01:37:55.060Z] === RUN   TestServiceRemoveKeepsIngressNetwork
01:37:55 [2023-12-06T01:37:55.060Z]     service_test.go:250: FLAKY_TEST
01:37:55 [2023-12-06T01:37:55.060Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
01:37:55 [2023-12-06T01:37:55.060Z] === RUN   TestServiceWithDataPathPortInit
01:38:09 [2023-12-06T01:38:09.925Z] --- PASS: TestServiceWithDataPathPortInit (13.34s)
01:38:09 [2023-12-06T01:38:09.925Z] === RUN   TestServiceWithDefaultAddressPoolInit
01:38:10 [2023-12-06T01:38:10.183Z]     service_test.go:440: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:clh5mnadtjg8urlgr9kulosh1 Created:2023-12-06 01:38:09.255200781 +0000 UTC Scope:swarm Driver:overlay EnableIPv6:false IPAM:{Driver:default Options:map[] Config:[{Subnet:20.20.1.0/24 IPRange: Gateway:20.20.1.1 AuxAddress:map[]}]} Internal:false Attachable:false Ingress:false ConfigFrom:{Network:} ConfigOnly:false Containers:map[0ef46355a81027df293ab7d3f45120bbacbf4f5a03722a0535bcf586599b1e30:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.y807a63zbwyh521c5m4enrvz6 EndpointID:dca8da725a0465901bbe41048f43479a7afc2600fc11bf429e7a46aabfa9acf6 MacAddress:02:42:14:14:01:03 IPv4Address:20.20.1.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:2adef6f833ee7ac857d5d0fa8cf8c7dda314899e2ab4828693346ed18f929ed8 MacAddress:02:42:14:14:01:04 IPv4Address:20.20.1.4/24 IPv6Address:}] Options:map[com.docker.network.driver.overlay.vxlanid_list:4097] Labels:map[] Peers:[{Name:45d6792baef8 IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.1.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.y807a63zbwyh521c5m4enrvz6 EndpointID:dca8da725a0465901bbe41048f43479a7afc2600fc11bf429e7a46aabfa9acf6 EndpointIP:20.20.1.3 Info:map[Host IP:127.0.0.1]}]}]}
01:38:15 [2023-12-06T01:38:15.440Z] --- PASS: TestServiceWithDefaultAddressPoolInit (6.66s)
01:38:15 [2023-12-06T01:38:15.440Z] PASS
01:38:15 [2023-12-06T01:38:15.440Z] 
01:38:15 [2023-12-06T01:38:15.440Z] === Skipped
01:38:15 [2023-12-06T01:38:15.440Z] === SKIP: arm64.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
01:38:15 [2023-12-06T01:38:15.440Z]     service_test.go:250: FLAKY_TEST
01:38:15 [2023-12-06T01:38:15.440Z] 
01:38:15 [2023-12-06T01:38:15.440Z] DONE 44 tests, 1 skipped in 48.541s
01:38:15 [2023-12-06T01:38:15.440Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (arm64.integration.network.ipvlan) flags=-test.v -test.timeout=120m  
01:38:15 [2023-12-06T01:38:15.440Z] ++ '[' -n '' ']'
01:38:15 [2023-12-06T01:38:15.440Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-network-ipvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-network-ipvlan-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.network.ipvlan -t ./test.main -test.v -test.timeout=120m
01:38:15 [2023-12-06T01:38:15.440Z] ++ set -e
01:38:15 [2023-12-06T01:38:15.440Z] ++ '[' -n 0 ']'
01:38:15 [2023-12-06T01:38:15.440Z] ++ set -x
01:38:15 [2023-12-06T01:38:15.440Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///run/docker/tmp.9zRT3ArzgE/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= GO111MODULE=off GOCACHE=/root/.cache/go-build GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=/usr/local/cli-integration/docker TEST_INTEGRATION_USE_SNAPSHOTTER= OTEL_EXPORTER_OTLP_ENDPOINT= OTEL_SERVICE_NAME= gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-network-ipvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-network-ipvlan-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.network.ipvlan -t ./test.main -test.v -test.timeout=120m
01:38:15 [2023-12-06T01:38:15.440Z] INFO: Testing against a local daemon
01:38:15 [2023-12-06T01:38:15.440Z] === RUN   TestDockerNetworkIpvlanPersistance
01:38:15 [2023-12-06T01:38:15.440Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
01:38:15 [2023-12-06T01:38:15.440Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.00s)
01:38:15 [2023-12-06T01:38:15.440Z] === RUN   TestDockerNetworkIpvlan
01:38:15 [2023-12-06T01:38:15.440Z]     ipvlan_test.go:55: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
01:38:15 [2023-12-06T01:38:15.440Z] --- SKIP: TestDockerNetworkIpvlan (0.00s)
01:38:15 [2023-12-06T01:38:15.440Z] PASS
01:38:15 [2023-12-06T01:38:15.440Z] 
01:38:15 [2023-12-06T01:38:15.440Z] === Skipped
01:38:15 [2023-12-06T01:38:15.440Z] === SKIP: arm64.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.00s)
01:38:15 [2023-12-06T01:38:15.440Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
01:38:15 [2023-12-06T01:38:15.440Z] 
01:38:15 [2023-12-06T01:38:15.440Z] === SKIP: arm64.integration.network.ipvlan TestDockerNetworkIpvlan (0.00s)
01:38:15 [2023-12-06T01:38:15.440Z]     ipvlan_test.go:55: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
01:38:15 [2023-12-06T01:38:15.440Z] 
01:38:15 [2023-12-06T01:38:15.440Z] DONE 2 tests, 2 skipped in 0.038s
01:38:15 [2023-12-06T01:38:15.440Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (arm64.integration.network.macvlan) flags=-test.v -test.timeout=120m  
01:38:15 [2023-12-06T01:38:15.440Z] ++ '[' -n '' ']'
01:38:15 [2023-12-06T01:38:15.440Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-network-macvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-network-macvlan-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.network.macvlan -t ./test.main -test.v -test.timeout=120m
01:38:15 [2023-12-06T01:38:15.440Z] ++ set -e
01:38:15 [2023-12-06T01:38:15.440Z] ++ '[' -n 0 ']'
01:38:15 [2023-12-06T01:38:15.440Z] ++ set -x
01:38:15 [2023-12-06T01:38:15.440Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///run/docker/tmp.9zRT3ArzgE/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= GO111MODULE=off GOCACHE=/root/.cache/go-build GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=/usr/local/cli-integration/docker TEST_INTEGRATION_USE_SNAPSHOTTER= OTEL_EXPORTER_OTLP_ENDPOINT= OTEL_SERVICE_NAME= gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-network-macvlan-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-network-macvlan-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.network.macvlan -t ./test.main -test.v -test.timeout=120m
01:38:15 [2023-12-06T01:38:15.440Z] INFO: Testing against a local daemon
01:38:15 [2023-12-06T01:38:15.440Z] === RUN   TestDockerNetworkMacvlanPersistance
01:38:16 [2023-12-06T01:38:16.005Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.24s)
01:38:16 [2023-12-06T01:38:16.005Z] === RUN   TestDockerNetworkMacvlan
01:38:16 [2023-12-06T01:38:16.005Z] === RUN   TestDockerNetworkMacvlan/Subinterface
01:38:16 [2023-12-06T01:38:16.571Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
01:38:17 [2023-12-06T01:38:17.504Z] === RUN   TestDockerNetworkMacvlan/NilParent
01:38:17 [2023-12-06T01:38:17.761Z] === RUN   TestDockerNetworkMacvlan/InternalMode
01:38:18 [2023-12-06T01:38:18.327Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
01:38:19 [2023-12-06T01:38:19.261Z] === RUN   TestDockerNetworkMacvlan/Addressing
01:38:19 [2023-12-06T01:38:19.518Z] --- PASS: TestDockerNetworkMacvlan (3.57s)
01:38:19 [2023-12-06T01:38:19.518Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.60s)
01:38:19 [2023-12-06T01:38:19.518Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.59s)
01:38:19 [2023-12-06T01:38:19.518Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (0.59s)
01:38:19 [2023-12-06T01:38:19.518Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (0.59s)
01:38:19 [2023-12-06T01:38:19.518Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (0.60s)
01:38:19 [2023-12-06T01:38:19.518Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (0.59s)
01:38:19 [2023-12-06T01:38:19.518Z] PASS
01:38:19 [2023-12-06T01:38:19.518Z] 
01:38:19 [2023-12-06T01:38:19.518Z] DONE 8 tests in 4.847s
01:38:19 [2023-12-06T01:38:19.776Z] Running /go/src/github.com/docker/docker/integration/networking (arm64.integration.networking) flags=-test.v -test.timeout=120m  
01:38:19 [2023-12-06T01:38:19.776Z] ++ '[' -n '' ']'
01:38:19 [2023-12-06T01:38:19.776Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-networking-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-networking-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.networking -t ./test.main -test.v -test.timeout=120m
01:38:19 [2023-12-06T01:38:19.776Z] ++ set -e
01:38:19 [2023-12-06T01:38:19.776Z] ++ '[' -n 0 ']'
01:38:19 [2023-12-06T01:38:19.776Z] ++ set -x
01:38:19 [2023-12-06T01:38:19.776Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///run/docker/tmp.9zRT3ArzgE/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= GO111MODULE=off GOCACHE=/root/.cache/go-build GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=/usr/local/cli-integration/docker TEST_INTEGRATION_USE_SNAPSHOTTER= OTEL_EXPORTER_OTLP_ENDPOINT= OTEL_SERVICE_NAME= gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-networking-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-networking-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.networking -t ./test.main -test.v -test.timeout=120m
01:38:19 [2023-12-06T01:38:19.776Z] INFO: Testing against a local daemon
01:38:19 [2023-12-06T01:38:19.776Z] === RUN   TestBridgeICC
01:38:20 [2023-12-06T01:38:20.341Z] === RUN   TestBridgeICC/IPv4_non-internal_network
01:38:21 [2023-12-06T01:38:21.713Z] === RUN   TestBridgeICC/IPv4_internal_network
01:38:22 [2023-12-06T01:38:22.650Z] === RUN   TestBridgeICC/IPv6_ULA_on_non-internal_network
01:38:24 [2023-12-06T01:38:24.024Z] === RUN   TestBridgeICC/IPv6_ULA_on_internal_network
01:38:24 [2023-12-06T01:38:24.956Z] === RUN   TestBridgeICC/IPv6_link-local_address_on_non-internal_network
01:38:26 [2023-12-06T01:38:26.328Z] === RUN   TestBridgeICC/IPv6_link-local_address_on_internal_network
01:38:27 [2023-12-06T01:38:27.260Z] === RUN   TestBridgeICC/IPv6_non-internal_network_with_SLAAC_LL_address
01:38:30 [2023-12-06T01:38:30.538Z] === RUN   TestBridgeICC/IPv6_internal_network_with_SLAAC_LL_address
01:38:33 [2023-12-06T01:38:33.881Z] --- PASS: TestBridgeICC (14.24s)
01:38:33 [2023-12-06T01:38:33.881Z]     --- PASS: TestBridgeICC/IPv4_non-internal_network (1.22s)
01:38:33 [2023-12-06T01:38:33.881Z]     --- PASS: TestBridgeICC/IPv4_internal_network (1.15s)
01:38:33 [2023-12-06T01:38:33.881Z]     --- PASS: TestBridgeICC/IPv6_ULA_on_non-internal_network (1.25s)
01:38:33 [2023-12-06T01:38:33.881Z]     --- PASS: TestBridgeICC/IPv6_ULA_on_internal_network (1.09s)
01:38:33 [2023-12-06T01:38:33.881Z]     --- PASS: TestBridgeICC/IPv6_link-local_address_on_non-internal_network (1.26s)
01:38:33 [2023-12-06T01:38:33.881Z]     --- PASS: TestBridgeICC/IPv6_link-local_address_on_internal_network (1.10s)
01:38:33 [2023-12-06T01:38:33.881Z]     --- PASS: TestBridgeICC/IPv6_non-internal_network_with_SLAAC_LL_address (3.30s)
01:38:33 [2023-12-06T01:38:33.881Z]     --- PASS: TestBridgeICC/IPv6_internal_network_with_SLAAC_LL_address (3.27s)
01:38:33 [2023-12-06T01:38:33.881Z] === RUN   TestBridgeINC
01:38:34 [2023-12-06T01:38:34.459Z] === RUN   TestBridgeINC/IPv4_non-internal_network
01:38:39 [2023-12-06T01:38:39.731Z] === RUN   TestBridgeINC/IPv4_internal_network
01:38:40 [2023-12-06T01:38:40.296Z] === RUN   TestBridgeINC/IPv6_ULA_on_non-internal_network
01:38:45 [2023-12-06T01:38:45.557Z] === RUN   TestBridgeINC/IPv6_ULA_on_internal_network
01:38:46 [2023-12-06T01:38:46.123Z] --- PASS: TestBridgeINC (12.06s)
01:38:46 [2023-12-06T01:38:46.123Z]     --- PASS: TestBridgeINC/IPv4_non-internal_network (4.35s)
01:38:46 [2023-12-06T01:38:46.123Z]     --- PASS: TestBridgeINC/IPv4_internal_network (1.29s)
01:38:46 [2023-12-06T01:38:46.123Z]     --- PASS: TestBridgeINC/IPv6_ULA_on_non-internal_network (4.53s)
01:38:46 [2023-12-06T01:38:46.123Z]     --- PASS: TestBridgeINC/IPv6_ULA_on_internal_network (1.26s)
01:38:46 [2023-12-06T01:38:46.123Z] PASS
01:38:46 [2023-12-06T01:38:46.123Z] 
01:38:46 [2023-12-06T01:38:46.123Z] DONE 14 tests in 26.332s
01:38:46 [2023-12-06T01:38:46.123Z] Running /go/src/github.com/docker/docker/integration/plugin (arm64.integration.plugin) flags=-test.v -test.timeout=120m  
01:38:46 [2023-12-06T01:38:46.123Z] ++ '[' -n '' ']'
01:38:46 [2023-12-06T01:38:46.123Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin -t ./test.main -test.v -test.timeout=120m
01:38:46 [2023-12-06T01:38:46.123Z] ++ set -e
01:38:46 [2023-12-06T01:38:46.123Z] ++ '[' -n 0 ']'
01:38:46 [2023-12-06T01:38:46.123Z] ++ set -x
01:38:46 [2023-12-06T01:38:46.123Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///run/docker/tmp.9zRT3ArzgE/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= GO111MODULE=off GOCACHE=/root/.cache/go-build GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=/usr/local/cli-integration/docker TEST_INTEGRATION_USE_SNAPSHOTTER= OTEL_EXPORTER_OTLP_ENDPOINT= OTEL_SERVICE_NAME= gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin -t ./test.main -test.v -test.timeout=120m
01:38:46 [2023-12-06T01:38:46.123Z] testing: warning: no tests to run
01:38:46 [2023-12-06T01:38:46.123Z] PASS
01:38:46 [2023-12-06T01:38:46.123Z] 
01:38:46 [2023-12-06T01:38:46.123Z] DONE 0 tests in 0.007s
01:38:46 [2023-12-06T01:38:46.123Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (arm64.integration.plugin.authz) flags=-test.v -test.timeout=120m  
01:38:46 [2023-12-06T01:38:46.123Z] ++ '[' -n '' ']'
01:38:46 [2023-12-06T01:38:46.124Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-authz-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-authz-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.authz -t ./test.main -test.v -test.timeout=120m
01:38:46 [2023-12-06T01:38:46.124Z] ++ set -e
01:38:46 [2023-12-06T01:38:46.124Z] ++ '[' -n 0 ']'
01:38:46 [2023-12-06T01:38:46.124Z] ++ set -x
01:38:46 [2023-12-06T01:38:46.124Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///run/docker/tmp.9zRT3ArzgE/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= GO111MODULE=off GOCACHE=/root/.cache/go-build GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=/usr/local/cli-integration/docker TEST_INTEGRATION_USE_SNAPSHOTTER= OTEL_EXPORTER_OTLP_ENDPOINT= OTEL_SERVICE_NAME= gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-authz-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-authz-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.authz -t ./test.main -test.v -test.timeout=120m
01:38:46 [2023-12-06T01:38:46.124Z] INFO: Testing against a local daemon
01:38:46 [2023-12-06T01:38:46.124Z] === RUN   TestAuthZPluginAllowRequest
01:38:47 [2023-12-06T01:38:47.058Z] --- PASS: TestAuthZPluginAllowRequest (1.08s)
01:38:47 [2023-12-06T01:38:47.058Z] === RUN   TestAuthZPluginTLS
01:38:47 [2023-12-06T01:38:47.624Z] --- PASS: TestAuthZPluginTLS (0.55s)
01:38:47 [2023-12-06T01:38:47.624Z] === RUN   TestAuthZPluginDenyRequest
01:38:48 [2023-12-06T01:38:48.191Z] --- PASS: TestAuthZPluginDenyRequest (0.53s)
01:38:48 [2023-12-06T01:38:48.191Z] === RUN   TestAuthZPluginAPIDenyResponse
01:38:48 [2023-12-06T01:38:48.756Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.53s)
01:38:48 [2023-12-06T01:38:48.756Z] === RUN   TestAuthZPluginDenyResponse
01:38:49 [2023-12-06T01:38:49.321Z] --- PASS: TestAuthZPluginDenyResponse (0.54s)
01:38:49 [2023-12-06T01:38:49.322Z] === RUN   TestAuthZPluginAllowEventStream
01:38:50 [2023-12-06T01:38:50.255Z] 2023/12/06 01:38:50 http: panic serving 127.0.0.1:58000: runtime error: invalid memory address or nil pointer dereference
01:38:50 [2023-12-06T01:38:50.255Z] goroutine 177 [running]:
01:38:50 [2023-12-06T01:38:50.255Z] net/http.(*conn).serve.func1()
01:38:50 [2023-12-06T01:38:50.255Z] 	/usr/local/go/src/net/http/server.go:1868 +0xb0
01:38:50 [2023-12-06T01:38:50.255Z] panic({0xa708e0?, 0x1579960?})
01:38:50 [2023-12-06T01:38:50.255Z] 	/usr/local/go/src/runtime/panic.go:920 +0x26c
01:38:50 [2023-12-06T01:38:50.255Z] github.com/docker/docker/integration/plugin/authz.setupSuite.func3({0xd65a48, 0x40003085a0}, 0xffffac4dc1d8?)
01:38:50 [2023-12-06T01:38:50.255Z] 	/go/src/github.com/docker/docker/integration/plugin/authz/main_test.go:159 +0x14c
01:38:50 [2023-12-06T01:38:50.255Z] net/http.HandlerFunc.ServeHTTP(0x400049af00?, {0xd65a48?, 0x40003085a0?}, 0x402a98?)
01:38:50 [2023-12-06T01:38:50.255Z] 	/usr/local/go/src/net/http/server.go:2136 +0x38
01:38:50 [2023-12-06T01:38:50.255Z] net/http.(*ServeMux).ServeHTTP(0xd6bb18?, {0xd65a48, 0x40003085a0}, 0x400049af00)
01:38:50 [2023-12-06T01:38:50.255Z] 	/usr/local/go/src/net/http/server.go:2514 +0x144
01:38:50 [2023-12-06T01:38:50.255Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.(*Handler).ServeHTTP(0x4000378180, {0xd64638?, 0x400049e380}, 0x400049ae00)
01:38:50 [2023-12-06T01:38:50.255Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:213 +0xf40
01:38:50 [2023-12-06T01:38:50.255Z] net/http.serverHandler.ServeHTTP({0xd611c8?}, {0xd64638?, 0x400049e380?}, 0x6?)
01:38:50 [2023-12-06T01:38:50.255Z] 	/usr/local/go/src/net/http/server.go:2938 +0xbc
01:38:50 [2023-12-06T01:38:50.255Z] net/http.(*conn).serve(0x400016b050, {0xd6bb18, 0x40000fa780})
01:38:50 [2023-12-06T01:38:50.255Z] 	/usr/local/go/src/net/http/server.go:2009 +0x518
01:38:50 [2023-12-06T01:38:50.255Z] created by net/http.(*Server).Serve in goroutine 49
01:38:50 [2023-12-06T01:38:50.255Z] 	/usr/local/go/src/net/http/server.go:3086 +0x4cc
01:38:51 [2023-12-06T01:38:51.187Z] 2023/12/06 01:38:51 http: panic serving 127.0.0.1:57998: could not unmarshal json for /AuthZPlugin.AuthZRes: unexpected end of JSON input
01:38:51 [2023-12-06T01:38:51.187Z] goroutine 51 [running]:
01:38:51 [2023-12-06T01:38:51.187Z] net/http.(*conn).serve.func1()
01:38:51 [2023-12-06T01:38:51.187Z] 	/usr/local/go/src/net/http/server.go:1868 +0xb0
01:38:51 [2023-12-06T01:38:51.187Z] panic({0xa08800?, 0x4000508620?})
01:38:51 [2023-12-06T01:38:51.187Z] 	/usr/local/go/src/runtime/panic.go:920 +0x26c
01:38:51 [2023-12-06T01:38:51.187Z] github.com/docker/docker/integration/plugin/authz.setupSuite.func3({0xd65a48, 0x4000308660}, 0xffffac4dc1d8?)
01:38:51 [2023-12-06T01:38:51.187Z] 	/go/src/github.com/docker/docker/integration/plugin/authz/main_test.go:149 +0x360
01:38:51 [2023-12-06T01:38:51.187Z] net/http.HandlerFunc.ServeHTTP(0x400049b100?, {0xd65a48?, 0x4000308660?}, 0x402a98?)
01:38:51 [2023-12-06T01:38:51.187Z] 	/usr/local/go/src/net/http/server.go:2136 +0x38
01:38:51 [2023-12-06T01:38:51.187Z] net/http.(*ServeMux).ServeHTTP(0xd6bb18?, {0xd65a48, 0x4000308660}, 0x400049b100)
01:38:51 [2023-12-06T01:38:51.187Z] 	/usr/local/go/src/net/http/server.go:2514 +0x144
01:38:51 [2023-12-06T01:38:51.187Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.(*Handler).ServeHTTP(0x4000378180, {0xd64638?, 0x400049e460}, 0x400049b000)
01:38:51 [2023-12-06T01:38:51.187Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:213 +0xf40
01:38:51 [2023-12-06T01:38:51.187Z] net/http.serverHandler.ServeHTTP({0x400043ad20?}, {0xd64638?, 0x400049e460?}, 0x6?)
01:38:51 [2023-12-06T01:38:51.187Z] 	/usr/local/go/src/net/http/server.go:2938 +0xbc
01:38:51 [2023-12-06T01:38:51.187Z] net/http.(*conn).serve(0x40000d05a0, {0xd6bb18, 0x40000fa780})
01:38:51 [2023-12-06T01:38:51.187Z] 	/usr/local/go/src/net/http/server.go:2009 +0x518
01:38:51 [2023-12-06T01:38:51.187Z] created by net/http.(*Server).Serve in goroutine 49
01:38:51 [2023-12-06T01:38:51.187Z] 	/usr/local/go/src/net/http/server.go:3086 +0x4cc
01:38:53 [2023-12-06T01:38:53.084Z] 2023/12/06 01:38:53 http: panic serving 127.0.0.1:46840: could not unmarshal json for /AuthZPlugin.AuthZRes: unexpected end of JSON input
01:38:53 [2023-12-06T01:38:53.084Z] goroutine 225 [running]:
01:38:53 [2023-12-06T01:38:53.084Z] net/http.(*conn).serve.func1()
01:38:53 [2023-12-06T01:38:53.084Z] 	/usr/local/go/src/net/http/server.go:1868 +0xb0
01:38:53 [2023-12-06T01:38:53.084Z] panic({0xa08800?, 0x40005086c0?})
01:38:53 [2023-12-06T01:38:53.084Z] 	/usr/local/go/src/runtime/panic.go:920 +0x26c
01:38:53 [2023-12-06T01:38:53.084Z] github.com/docker/docker/integration/plugin/authz.setupSuite.func3({0xd65a48, 0x4000308720}, 0xffffac4dc1d8?)
01:38:53 [2023-12-06T01:38:53.084Z] 	/go/src/github.com/docker/docker/integration/plugin/authz/main_test.go:149 +0x360
01:38:53 [2023-12-06T01:38:53.084Z] net/http.HandlerFunc.ServeHTTP(0x400049b300?, {0xd65a48?, 0x4000308720?}, 0x402a98?)
01:38:53 [2023-12-06T01:38:53.084Z] 	/usr/local/go/src/net/http/server.go:2136 +0x38
01:38:53 [2023-12-06T01:38:53.084Z] net/http.(*ServeMux).ServeHTTP(0xd6bb18?, {0xd65a48, 0x4000308720}, 0x400049b300)
01:38:53 [2023-12-06T01:38:53.084Z] 	/usr/local/go/src/net/http/server.go:2514 +0x144
01:38:53 [2023-12-06T01:38:53.084Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.(*Handler).ServeHTTP(0x4000378180, {0xd64638?, 0x400049e540}, 0x400049b200)
01:38:53 [2023-12-06T01:38:53.084Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:213 +0xf40
01:38:53 [2023-12-06T01:38:53.084Z] net/http.serverHandler.ServeHTTP({0x40002d5d10?}, {0xd64638?, 0x400049e540?}, 0x6?)
01:38:53 [2023-12-06T01:38:53.084Z] 	/usr/local/go/src/net/http/server.go:2938 +0xbc
01:38:53 [2023-12-06T01:38:53.084Z] net/http.(*conn).serve(0x40002c8ab0, {0xd6bb18, 0x40000fa780})
01:38:53 [2023-12-06T01:38:53.084Z] 	/usr/local/go/src/net/http/server.go:2009 +0x518
01:38:53 [2023-12-06T01:38:53.084Z] created by net/http.(*Server).Serve in goroutine 49
01:38:53 [2023-12-06T01:38:53.084Z] 	/usr/local/go/src/net/http/server.go:3086 +0x4cc
01:38:55 [2023-12-06T01:38:55.609Z] --- PASS: TestAuthZPluginAllowEventStream (6.11s)
01:38:55 [2023-12-06T01:38:55.609Z] === RUN   TestAuthZPluginErrorResponse
01:38:55 [2023-12-06T01:38:55.867Z] --- PASS: TestAuthZPluginErrorResponse (0.54s)
01:38:55 [2023-12-06T01:38:55.867Z] === RUN   TestAuthZPluginErrorRequest
01:38:56 [2023-12-06T01:38:56.431Z] --- PASS: TestAuthZPluginErrorRequest (0.53s)
01:38:56 [2023-12-06T01:38:56.431Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
01:38:56 [2023-12-06T01:38:56.996Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.53s)
01:38:56 [2023-12-06T01:38:56.996Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
01:38:58 [2023-12-06T01:38:58.367Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (1.18s)
01:38:58 [2023-12-06T01:38:58.367Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
01:38:59 [2023-12-06T01:38:59.300Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (1.14s)
01:38:59 [2023-12-06T01:38:59.300Z] === RUN   TestAuthZPluginHeader
01:38:59 [2023-12-06T01:38:59.865Z] --- PASS: TestAuthZPluginHeader (0.62s)
01:38:59 [2023-12-06T01:38:59.865Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
01:38:59 [2023-12-06T01:38:59.865Z]     authz_plugin_v2_test.go:40: (*Execution).NotAmd64-fm
01:38:59 [2023-12-06T01:38:59.865Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
01:38:59 [2023-12-06T01:38:59.865Z] === RUN   TestAuthZPluginV2Disable
01:38:59 [2023-12-06T01:38:59.865Z]     authz_plugin_v2_test.go:61: (*Execution).NotAmd64-fm
01:38:59 [2023-12-06T01:38:59.865Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
01:38:59 [2023-12-06T01:38:59.865Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
01:38:59 [2023-12-06T01:38:59.865Z]     authz_plugin_v2_test.go:87: (*Execution).NotAmd64-fm
01:38:59 [2023-12-06T01:38:59.865Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
01:38:59 [2023-12-06T01:38:59.865Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
01:38:59 [2023-12-06T01:38:59.865Z]     authz_plugin_v2_test.go:122: (*Execution).NotAmd64-fm
01:38:59 [2023-12-06T01:38:59.865Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
01:38:59 [2023-12-06T01:38:59.865Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
01:39:17 [2023-12-06T01:39:17.931Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.89s)
01:39:17 [2023-12-06T01:39:17.931Z] PASS
01:39:17 [2023-12-06T01:39:17.931Z] 
01:39:17 [2023-12-06T01:39:17.931Z] === Skipped
01:39:17 [2023-12-06T01:39:17.931Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
01:39:17 [2023-12-06T01:39:17.931Z]     authz_plugin_v2_test.go:40: (*Execution).NotAmd64-fm
01:39:17 [2023-12-06T01:39:17.931Z] 
01:39:17 [2023-12-06T01:39:17.931Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
01:39:17 [2023-12-06T01:39:17.931Z]     authz_plugin_v2_test.go:61: (*Execution).NotAmd64-fm
01:39:17 [2023-12-06T01:39:17.931Z] 
01:39:17 [2023-12-06T01:39:17.931Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
01:39:17 [2023-12-06T01:39:17.931Z]     authz_plugin_v2_test.go:87: (*Execution).NotAmd64-fm
01:39:17 [2023-12-06T01:39:17.931Z] 
01:39:17 [2023-12-06T01:39:17.931Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
01:39:17 [2023-12-06T01:39:17.931Z]     authz_plugin_v2_test.go:122: (*Execution).NotAmd64-fm
01:39:17 [2023-12-06T01:39:17.931Z] 
01:39:17 [2023-12-06T01:39:17.931Z] DONE 17 tests, 4 skipped in 30.795s
01:39:17 [2023-12-06T01:39:17.931Z] Running /go/src/github.com/docker/docker/integration/plugin/common (arm64.integration.plugin.common) flags=-test.v -test.timeout=120m  
01:39:17 [2023-12-06T01:39:17.931Z] ++ '[' -n '' ']'
01:39:17 [2023-12-06T01:39:17.931Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-common-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-common-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.common -t ./test.main -test.v -test.timeout=120m
01:39:17 [2023-12-06T01:39:17.931Z] ++ set -e
01:39:17 [2023-12-06T01:39:17.931Z] ++ '[' -n 0 ']'
01:39:17 [2023-12-06T01:39:17.931Z] ++ set -x
01:39:17 [2023-12-06T01:39:17.931Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///run/docker/tmp.9zRT3ArzgE/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= GO111MODULE=off GOCACHE=/root/.cache/go-build GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=/usr/local/cli-integration/docker TEST_INTEGRATION_USE_SNAPSHOTTER= OTEL_EXPORTER_OTLP_ENDPOINT= OTEL_SERVICE_NAME= gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-common-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-common-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.common -t ./test.main -test.v -test.timeout=120m
01:39:17 [2023-12-06T01:39:17.931Z] INFO: Testing against a local daemon
01:39:17 [2023-12-06T01:39:17.931Z] === RUN   TestPluginInvalidJSON
01:39:17 [2023-12-06T01:39:17.931Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set
01:39:17 [2023-12-06T01:39:17.931Z] === PAUSE TestPluginInvalidJSON/plugins/foobar/set
01:39:17 [2023-12-06T01:39:17.931Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade
01:39:17 [2023-12-06T01:39:17.931Z] === PAUSE TestPluginInvalidJSON/plugins/foobar/upgrade
01:39:17 [2023-12-06T01:39:17.931Z] === RUN   TestPluginInvalidJSON/plugins/pull
01:39:17 [2023-12-06T01:39:17.931Z] === PAUSE TestPluginInvalidJSON/plugins/pull
01:39:17 [2023-12-06T01:39:17.931Z] === CONT  TestPluginInvalidJSON/plugins/foobar/set
01:39:17 [2023-12-06T01:39:17.931Z] === CONT  TestPluginInvalidJSON/plugins/pull
01:39:17 [2023-12-06T01:39:17.931Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/invalid_content_type
01:39:17 [2023-12-06T01:39:17.931Z] === CONT  TestPluginInvalidJSON/plugins/foobar/upgrade
01:39:17 [2023-12-06T01:39:17.931Z] === RUN   TestPluginInvalidJSON/plugins/pull/invalid_content_type
01:39:17 [2023-12-06T01:39:17.931Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_content_type
01:39:17 [2023-12-06T01:39:17.931Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/invalid_JSON
01:39:17 [2023-12-06T01:39:17.931Z] === RUN   TestPluginInvalidJSON/plugins/pull/invalid_JSON
01:39:17 [2023-12-06T01:39:17.931Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_JSON
01:39:17 [2023-12-06T01:39:17.931Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/extra_content_after_JSON
01:39:17 [2023-12-06T01:39:17.931Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/extra_content_after_JSON
01:39:17 [2023-12-06T01:39:17.931Z] === RUN   TestPluginInvalidJSON/plugins/pull/extra_content_after_JSON
01:39:17 [2023-12-06T01:39:17.931Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/empty_body
01:39:17 [2023-12-06T01:39:17.931Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/empty_body
01:39:17 [2023-12-06T01:39:17.931Z] === RUN   TestPluginInvalidJSON/plugins/pull/empty_body
01:39:17 [2023-12-06T01:39:17.931Z] --- PASS: TestPluginInvalidJSON (0.01s)
01:39:17 [2023-12-06T01:39:17.931Z]     --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade (0.00s)
01:39:17 [2023-12-06T01:39:17.931Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_content_type (0.00s)
01:39:17 [2023-12-06T01:39:17.931Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_JSON (0.00s)
01:39:17 [2023-12-06T01:39:17.931Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/extra_content_after_JSON (0.00s)
01:39:17 [2023-12-06T01:39:17.931Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/empty_body (0.00s)
01:39:17 [2023-12-06T01:39:17.931Z]     --- PASS: TestPluginInvalidJSON/plugins/foobar/set (0.00s)
01:39:17 [2023-12-06T01:39:17.931Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/invalid_content_type (0.00s)
01:39:17 [2023-12-06T01:39:17.931Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/invalid_JSON (0.00s)
01:39:17 [2023-12-06T01:39:17.931Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/extra_content_after_JSON (0.00s)
01:39:17 [2023-12-06T01:39:17.931Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/empty_body (0.00s)
01:39:17 [2023-12-06T01:39:17.931Z]     --- PASS: TestPluginInvalidJSON/plugins/pull (0.00s)
01:39:17 [2023-12-06T01:39:17.931Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/invalid_content_type (0.00s)
01:39:17 [2023-12-06T01:39:17.931Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/invalid_JSON (0.00s)
01:39:17 [2023-12-06T01:39:17.931Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/extra_content_after_JSON (0.00s)
01:39:17 [2023-12-06T01:39:17.931Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/empty_body (0.00s)
01:39:17 [2023-12-06T01:39:17.931Z] === RUN   TestPluginInstall
01:39:17 [2023-12-06T01:39:17.931Z] === RUN   TestPluginInstall/no_auth
01:39:20 [2023-12-06T01:39:20.456Z] time="2023-12-06T01:39:20Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
01:39:20 [2023-12-06T01:39:20.456Z] time="2023-12-06T01:39:20Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:6875cec407bf07b275c17ad1a596845caaab5d7e2dbc6b7c648c87180126a9fb" mediatype=application/vnd.docker.plugin.v1+json size=522
01:39:20 [2023-12-06T01:39:20.456Z] time="2023-12-06T01:39:20Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
01:39:20 [2023-12-06T01:39:20.456Z] time="2023-12-06T01:39:20Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:6875cec407bf07b275c17ad1a596845caaab5d7e2dbc6b7c648c87180126a9fb" mediatype=application/vnd.docker.plugin.v1+json size=522
01:39:20 [2023-12-06T01:39:20.714Z] === RUN   TestPluginInstall/with_htpasswd
01:39:20 [2023-12-06T01:39:20.972Z] time="2023-12-06T01:39:20Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
01:39:20 [2023-12-06T01:39:20.972Z] time="2023-12-06T01:39:20Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:6875cec407bf07b275c17ad1a596845caaab5d7e2dbc6b7c648c87180126a9fb" mediatype=application/vnd.docker.plugin.v1+json size=522
01:39:20 [2023-12-06T01:39:20.972Z] time="2023-12-06T01:39:20Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
01:39:20 [2023-12-06T01:39:20.972Z] time="2023-12-06T01:39:20Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:6875cec407bf07b275c17ad1a596845caaab5d7e2dbc6b7c648c87180126a9fb" mediatype=application/vnd.docker.plugin.v1+json size=522
01:39:20 [2023-12-06T01:39:20.972Z] === RUN   TestPluginInstall/with_insecure
01:39:21 [2023-12-06T01:39:21.918Z] time="2023-12-06T01:39:21Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
01:39:21 [2023-12-06T01:39:21.918Z] time="2023-12-06T01:39:21Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:a87897b902ea0e6626d7fbc96d8dea895b9735b4d911ae4681efe45d3e707bd1" mediatype=application/vnd.docker.plugin.v1+json size=522
01:39:21 [2023-12-06T01:39:21.918Z] time="2023-12-06T01:39:21Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
01:39:21 [2023-12-06T01:39:21.918Z] time="2023-12-06T01:39:21Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:a87897b902ea0e6626d7fbc96d8dea895b9735b4d911ae4681efe45d3e707bd1" mediatype=application/vnd.docker.plugin.v1+json size=522
01:39:21 [2023-12-06T01:39:21.918Z]     plugin_test.go:204: [d22684ed43886] daemon is not started
01:39:21 [2023-12-06T01:39:21.918Z] --- PASS: TestPluginInstall (5.09s)
01:39:21 [2023-12-06T01:39:21.918Z]     --- PASS: TestPluginInstall/no_auth (3.71s)
01:39:21 [2023-12-06T01:39:21.918Z]     --- PASS: TestPluginInstall/with_htpasswd (0.45s)
01:39:21 [2023-12-06T01:39:21.918Z]     --- PASS: TestPluginInstall/with_insecure (0.93s)
01:39:21 [2023-12-06T01:39:21.918Z] === RUN   TestPluginsWithRuntimes
01:39:23 [2023-12-06T01:39:23.816Z] === RUN   TestPluginsWithRuntimes/No_Args
01:39:24 [2023-12-06T01:39:24.382Z] === RUN   TestPluginsWithRuntimes/With_Args
01:39:25 [2023-12-06T01:39:25.314Z] --- PASS: TestPluginsWithRuntimes (3.40s)
01:39:25 [2023-12-06T01:39:25.314Z]     --- PASS: TestPluginsWithRuntimes/No_Args (0.93s)
01:39:25 [2023-12-06T01:39:25.314Z]     --- PASS: TestPluginsWithRuntimes/With_Args (0.95s)
01:39:25 [2023-12-06T01:39:25.314Z] === RUN   TestPluginBackCompatMediaTypes
01:39:25 [2023-12-06T01:39:25.880Z] --- PASS: TestPluginBackCompatMediaTypes (0.50s)
01:39:25 [2023-12-06T01:39:25.880Z] PASS
01:39:25 [2023-12-06T01:39:25.880Z] 
01:39:25 [2023-12-06T01:39:25.880Z] DONE 24 tests in 9.044s
01:39:25 [2023-12-06T01:39:25.880Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (arm64.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m  
01:39:25 [2023-12-06T01:39:25.880Z] ++ '[' -n '' ']'
01:39:25 [2023-12-06T01:39:25.880Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-graphdriver-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-graphdriver-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.graphdriver -t ./test.main -test.v -test.timeout=120m
01:39:25 [2023-12-06T01:39:25.880Z] ++ set -e
01:39:25 [2023-12-06T01:39:25.880Z] ++ '[' -n 0 ']'
01:39:25 [2023-12-06T01:39:25.880Z] ++ set -x
01:39:25 [2023-12-06T01:39:25.881Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///run/docker/tmp.9zRT3ArzgE/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= GO111MODULE=off GOCACHE=/root/.cache/go-build GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=/usr/local/cli-integration/docker TEST_INTEGRATION_USE_SNAPSHOTTER= OTEL_EXPORTER_OTLP_ENDPOINT= OTEL_SERVICE_NAME= gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-graphdriver-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-graphdriver-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.graphdriver -t ./test.main -test.v -test.timeout=120m
01:39:25 [2023-12-06T01:39:25.881Z] INFO: Testing against a local daemon
01:39:25 [2023-12-06T01:39:25.881Z] === RUN   TestExternalGraphDriver
01:39:26 [2023-12-06T01:39:26.138Z] === RUN   TestExternalGraphDriver/json
01:39:26 [2023-12-06T01:39:26.138Z] === RUN   TestExternalGraphDriver/spec
01:39:26 [2023-12-06T01:39:26.138Z] === RUN   TestExternalGraphDriver/pull
01:39:26 [2023-12-06T01:39:26.138Z] --- PASS: TestExternalGraphDriver (0.34s)
01:39:26 [2023-12-06T01:39:26.138Z]     --- PASS: TestExternalGraphDriver/json (0.00s)
01:39:26 [2023-12-06T01:39:26.138Z]     --- PASS: TestExternalGraphDriver/spec (0.00s)
01:39:26 [2023-12-06T01:39:26.138Z]     --- PASS: TestExternalGraphDriver/pull (0.00s)
01:39:26 [2023-12-06T01:39:26.138Z] === RUN   TestGraphdriverPluginV2
01:39:26 [2023-12-06T01:39:26.703Z]     external_test.go:415: (*Execution).NotAmd64-fm
01:39:26 [2023-12-06T01:39:26.704Z] --- SKIP: TestGraphdriverPluginV2 (0.32s)
01:39:26 [2023-12-06T01:39:26.704Z] PASS
01:39:26 [2023-12-06T01:39:26.704Z] 
01:39:26 [2023-12-06T01:39:26.704Z] === Skipped
01:39:26 [2023-12-06T01:39:26.704Z] === SKIP: arm64.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.32s)
01:39:26 [2023-12-06T01:39:26.704Z]     external_test.go:415: (*Execution).NotAmd64-fm
01:39:26 [2023-12-06T01:39:26.704Z] 
01:39:26 [2023-12-06T01:39:26.704Z] DONE 5 tests, 1 skipped in 0.696s
01:39:26 [2023-12-06T01:39:26.704Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (arm64.integration.plugin.logging) flags=-test.v -test.timeout=120m  
01:39:26 [2023-12-06T01:39:26.704Z] ++ '[' -n '' ']'
01:39:26 [2023-12-06T01:39:26.704Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-logging-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-logging-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.logging -t ./test.main -test.v -test.timeout=120m
01:39:26 [2023-12-06T01:39:26.704Z] ++ set -e
01:39:26 [2023-12-06T01:39:26.704Z] ++ '[' -n 0 ']'
01:39:26 [2023-12-06T01:39:26.704Z] ++ set -x
01:39:26 [2023-12-06T01:39:26.704Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///run/docker/tmp.9zRT3ArzgE/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= GO111MODULE=off GOCACHE=/root/.cache/go-build GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=/usr/local/cli-integration/docker TEST_INTEGRATION_USE_SNAPSHOTTER= OTEL_EXPORTER_OTLP_ENDPOINT= OTEL_SERVICE_NAME= gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-logging-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-logging-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.logging -t ./test.main -test.v -test.timeout=120m
01:39:26 [2023-12-06T01:39:26.704Z] INFO: Testing against a local daemon
01:39:26 [2023-12-06T01:39:26.704Z] === RUN   TestContinueAfterPluginCrash
01:39:26 [2023-12-06T01:39:26.704Z] === PAUSE TestContinueAfterPluginCrash
01:39:26 [2023-12-06T01:39:26.704Z] === RUN   TestReadPluginNoRead
01:39:26 [2023-12-06T01:39:26.704Z] === PAUSE TestReadPluginNoRead
01:39:26 [2023-12-06T01:39:26.704Z] === RUN   TestDaemonStartWithLogOpt
01:39:26 [2023-12-06T01:39:26.704Z] === PAUSE TestDaemonStartWithLogOpt
01:39:26 [2023-12-06T01:39:26.704Z] === CONT  TestContinueAfterPluginCrash
01:39:26 [2023-12-06T01:39:26.704Z] === CONT  TestDaemonStartWithLogOpt
01:39:26 [2023-12-06T01:39:26.704Z] === CONT  TestReadPluginNoRead
01:39:29 [2023-12-06T01:39:29.232Z] === RUN   TestReadPluginNoRead/default
01:39:29 [2023-12-06T01:39:29.490Z] --- PASS: TestDaemonStartWithLogOpt (2.75s)
01:39:30 [2023-12-06T01:39:30.055Z] === RUN   TestReadPluginNoRead/disabled_caching
01:39:31 [2023-12-06T01:39:31.453Z] === RUN   TestReadPluginNoRead/explicitly_enabled_caching
01:39:32 [2023-12-06T01:39:32.390Z]     read_test.go:93: [d61f089321295] daemon is not started
01:39:32 [2023-12-06T01:39:32.390Z] --- PASS: TestReadPluginNoRead (5.85s)
01:39:32 [2023-12-06T01:39:32.390Z]     --- PASS: TestReadPluginNoRead/default (1.25s)
01:39:32 [2023-12-06T01:39:32.390Z]     --- PASS: TestReadPluginNoRead/disabled_caching (1.27s)
01:39:32 [2023-12-06T01:39:32.390Z]     --- PASS: TestReadPluginNoRead/explicitly_enabled_caching (1.21s)
01:39:34 [2023-12-06T01:39:34.287Z] --- PASS: TestContinueAfterPluginCrash (7.65s)
01:39:34 [2023-12-06T01:39:34.287Z] PASS
01:39:34 [2023-12-06T01:39:34.287Z] 
01:39:34 [2023-12-06T01:39:34.287Z] DONE 6 tests in 7.687s
01:39:34 [2023-12-06T01:39:34.287Z] Running /go/src/github.com/docker/docker/integration/plugin/logging/cmd/discard (arm64.integration.plugin.logging.cmd.discard) flags=-test.v -test.timeout=120m  
01:39:34 [2023-12-06T01:39:34.287Z] ++ '[' -n '' ']'
01:39:34 [2023-12-06T01:39:34.287Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-logging-cmd-discard-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-logging-cmd-discard-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.logging.cmd.discard -t ./test.main -test.v -test.timeout=120m
01:39:34 [2023-12-06T01:39:34.287Z] ++ set -e
01:39:34 [2023-12-06T01:39:34.287Z] ++ '[' -n 0 ']'
01:39:34 [2023-12-06T01:39:34.287Z] ++ set -x
01:39:34 [2023-12-06T01:39:34.287Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///run/docker/tmp.9zRT3ArzgE/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= GO111MODULE=off GOCACHE=/root/.cache/go-build GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=/usr/local/cli-integration/docker TEST_INTEGRATION_USE_SNAPSHOTTER= OTEL_EXPORTER_OTLP_ENDPOINT= OTEL_SERVICE_NAME= gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-logging-cmd-discard-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-logging-cmd-discard-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.logging.cmd.discard -t ./test.main -test.v -test.timeout=120m
01:39:34 [2023-12-06T01:39:34.287Z] testing: warning: no tests to run
01:39:34 [2023-12-06T01:39:34.287Z] PASS
01:39:34 [2023-12-06T01:39:34.287Z] 
01:39:34 [2023-12-06T01:39:34.287Z] DONE 0 tests in 0.008s
01:39:34 [2023-12-06T01:39:34.287Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (arm64.integration.plugin.volumes) flags=-test.v -test.timeout=120m  
01:39:34 [2023-12-06T01:39:34.287Z] ++ '[' -n '' ']'
01:39:34 [2023-12-06T01:39:34.287Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-volumes-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-volumes-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.volumes -t ./test.main -test.v -test.timeout=120m
01:39:34 [2023-12-06T01:39:34.287Z] ++ set -e
01:39:34 [2023-12-06T01:39:34.287Z] ++ '[' -n 0 ']'
01:39:34 [2023-12-06T01:39:34.287Z] ++ set -x
01:39:34 [2023-12-06T01:39:34.287Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///run/docker/tmp.9zRT3ArzgE/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= GO111MODULE=off GOCACHE=/root/.cache/go-build GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=/usr/local/cli-integration/docker TEST_INTEGRATION_USE_SNAPSHOTTER= OTEL_EXPORTER_OTLP_ENDPOINT= OTEL_SERVICE_NAME= gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-volumes-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-plugin-volumes-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.plugin.volumes -t ./test.main -test.v -test.timeout=120m
01:39:34 [2023-12-06T01:39:34.287Z] INFO: Testing against a local daemon
01:39:34 [2023-12-06T01:39:34.287Z] === RUN   TestPluginWithDevMounts
01:39:34 [2023-12-06T01:39:34.287Z] === PAUSE TestPluginWithDevMounts
01:39:34 [2023-12-06T01:39:34.287Z] === CONT  TestPluginWithDevMounts
01:39:36 [2023-12-06T01:39:36.185Z] --- PASS: TestPluginWithDevMounts (1.51s)
01:39:36 [2023-12-06T01:39:36.185Z] PASS
01:39:36 [2023-12-06T01:39:36.185Z] 
01:39:36 [2023-12-06T01:39:36.185Z] DONE 1 tests in 1.543s
01:39:36 [2023-12-06T01:39:36.185Z] Running /go/src/github.com/docker/docker/integration/secret (arm64.integration.secret) flags=-test.v -test.timeout=120m  
01:39:36 [2023-12-06T01:39:36.185Z] ++ '[' -n '' ']'
01:39:36 [2023-12-06T01:39:36.185Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-secret-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-secret-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.secret -t ./test.main -test.v -test.timeout=120m
01:39:36 [2023-12-06T01:39:36.185Z] ++ set -e
01:39:36 [2023-12-06T01:39:36.185Z] ++ '[' -n 0 ']'
01:39:36 [2023-12-06T01:39:36.185Z] ++ set -x
01:39:36 [2023-12-06T01:39:36.185Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///run/docker/tmp.9zRT3ArzgE/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= GO111MODULE=off GOCACHE=/root/.cache/go-build GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=/usr/local/cli-integration/docker TEST_INTEGRATION_USE_SNAPSHOTTER= OTEL_EXPORTER_OTLP_ENDPOINT= OTEL_SERVICE_NAME= gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-secret-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-secret-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.secret -t ./test.main -test.v -test.timeout=120m
01:39:36 [2023-12-06T01:39:36.185Z] INFO: Testing against a local daemon
01:39:36 [2023-12-06T01:39:36.185Z] === RUN   TestSecretInspect
01:39:38 [2023-12-06T01:39:38.083Z] --- PASS: TestSecretInspect (1.88s)
01:39:38 [2023-12-06T01:39:38.083Z] === RUN   TestSecretList
01:39:39 [2023-12-06T01:39:39.981Z] --- PASS: TestSecretList (1.97s)
01:39:39 [2023-12-06T01:39:39.981Z] === RUN   TestSecretsCreateAndDelete
01:39:41 [2023-12-06T01:39:41.878Z] --- PASS: TestSecretsCreateAndDelete (1.98s)
01:39:41 [2023-12-06T01:39:41.878Z] === RUN   TestSecretsUpdate
01:39:43 [2023-12-06T01:39:43.776Z] --- PASS: TestSecretsUpdate (1.88s)
01:39:43 [2023-12-06T01:39:43.776Z] === RUN   TestTemplatedSecret
01:39:46 [2023-12-06T01:39:46.302Z] --- PASS: TestTemplatedSecret (2.52s)
01:39:46 [2023-12-06T01:39:46.302Z] === RUN   TestSecretCreateResolve
01:39:48 [2023-12-06T01:39:48.199Z] --- PASS: TestSecretCreateResolve (1.88s)
01:39:48 [2023-12-06T01:39:48.199Z] PASS
01:39:48 [2023-12-06T01:39:48.199Z] 
01:39:48 [2023-12-06T01:39:48.199Z] DONE 6 tests in 12.148s
01:39:48 [2023-12-06T01:39:48.199Z] Running /go/src/github.com/docker/docker/integration/service (arm64.integration.service) flags=-test.v -test.timeout=120m  
01:39:48 [2023-12-06T01:39:48.199Z] ++ '[' -n '' ']'
01:39:48 [2023-12-06T01:39:48.199Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-service-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-service-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.service -t ./test.main -test.v -test.timeout=120m
01:39:48 [2023-12-06T01:39:48.199Z] ++ set -e
01:39:48 [2023-12-06T01:39:48.199Z] ++ '[' -n 0 ']'
01:39:48 [2023-12-06T01:39:48.199Z] ++ set -x
01:39:48 [2023-12-06T01:39:48.199Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///run/docker/tmp.9zRT3ArzgE/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= GO111MODULE=off GOCACHE=/root/.cache/go-build GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=/usr/local/cli-integration/docker TEST_INTEGRATION_USE_SNAPSHOTTER= OTEL_EXPORTER_OTLP_ENDPOINT= OTEL_SERVICE_NAME= gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-service-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-service-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.service -t ./test.main -test.v -test.timeout=120m
01:39:48 [2023-12-06T01:39:48.199Z] INFO: Testing against a local daemon
01:39:48 [2023-12-06T01:39:48.199Z] === RUN   TestServiceCreateInit
01:39:48 [2023-12-06T01:39:48.199Z] === RUN   TestServiceCreateInit/daemonInitDisabled
01:39:52 [2023-12-06T01:39:52.380Z] === RUN   TestServiceCreateInit/daemonInitEnabled
01:39:55 [2023-12-06T01:39:55.660Z] --- PASS: TestServiceCreateInit (7.49s)
01:39:55 [2023-12-06T01:39:55.660Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (3.72s)
01:39:55 [2023-12-06T01:39:55.660Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (3.76s)
01:39:55 [2023-12-06T01:39:55.660Z] === RUN   TestCreateServiceMultipleTimes
01:40:10 [2023-12-06T01:40:10.546Z] --- PASS: TestCreateServiceMultipleTimes (14.97s)
01:40:10 [2023-12-06T01:40:10.546Z] === RUN   TestCreateServiceConflict
01:40:12 [2023-12-06T01:40:12.444Z] --- PASS: TestCreateServiceConflict (1.89s)
01:40:12 [2023-12-06T01:40:12.444Z] === RUN   TestCreateServiceMaxReplicas
01:40:15 [2023-12-06T01:40:15.721Z] --- PASS: TestCreateServiceMaxReplicas (2.82s)
01:40:15 [2023-12-06T01:40:15.721Z] === RUN   TestCreateServiceSecretFileMode
01:40:27 [2023-12-06T01:40:27.909Z] --- PASS: TestCreateServiceSecretFileMode (12.54s)
01:40:27 [2023-12-06T01:40:27.910Z] === RUN   TestCreateServiceConfigFileMode
01:40:42 [2023-12-06T01:40:42.772Z] --- PASS: TestCreateServiceConfigFileMode (12.57s)
01:40:42 [2023-12-06T01:40:42.772Z] === RUN   TestCreateServiceSysctls
01:40:43 [2023-12-06T01:40:43.704Z] --- PASS: TestCreateServiceSysctls (3.20s)
01:40:43 [2023-12-06T01:40:43.704Z] === RUN   TestCreateServiceCapabilities
01:40:46 [2023-12-06T01:40:46.231Z] --- PASS: TestCreateServiceCapabilities (2.64s)
01:40:46 [2023-12-06T01:40:46.231Z] === RUN   TestInspect
01:40:49 [2023-12-06T01:40:49.510Z] --- PASS: TestInspect (2.96s)
01:40:49 [2023-12-06T01:40:49.510Z] === RUN   TestCreateJob
01:40:52 [2023-12-06T01:40:52.791Z] --- PASS: TestCreateJob (3.19s)
01:40:52 [2023-12-06T01:40:52.791Z] === RUN   TestReplicatedJob
01:40:58 [2023-12-06T01:40:58.068Z] --- PASS: TestReplicatedJob (4.84s)
01:40:58 [2023-12-06T01:40:58.068Z] === RUN   TestUpdateReplicatedJob
01:41:00 [2023-12-06T01:41:00.594Z] --- PASS: TestUpdateReplicatedJob (3.25s)
01:41:00 [2023-12-06T01:41:00.594Z] === RUN   TestServiceListWithStatuses
01:41:05 [2023-12-06T01:41:05.856Z] --- PASS: TestServiceListWithStatuses (4.81s)
01:41:05 [2023-12-06T01:41:05.856Z] === RUN   TestDockerNetworkConnectAlias
01:41:10 [2023-12-06T01:41:10.038Z] --- PASS: TestDockerNetworkConnectAlias (4.09s)
01:41:10 [2023-12-06T01:41:10.038Z] === RUN   TestDockerNetworkReConnect
01:41:12 [2023-12-06T01:41:12.564Z] --- PASS: TestDockerNetworkReConnect (3.28s)
01:41:12 [2023-12-06T01:41:12.564Z] === RUN   TestServicePlugin
01:41:12 [2023-12-06T01:41:12.564Z]     plugin_test.go:25: (*Execution).NotAmd64-fm
01:41:12 [2023-12-06T01:41:12.564Z] --- SKIP: TestServicePlugin (0.00s)
01:41:12 [2023-12-06T01:41:12.564Z] === RUN   TestServiceUpdateLabel
01:41:15 [2023-12-06T01:41:15.091Z] --- PASS: TestServiceUpdateLabel (2.13s)
01:41:15 [2023-12-06T01:41:15.091Z] === RUN   TestServiceUpdateSecrets
01:41:29 [2023-12-06T01:41:29.952Z] --- PASS: TestServiceUpdateSecrets (14.41s)
01:41:29 [2023-12-06T01:41:29.952Z] === RUN   TestServiceUpdateConfigs
01:41:44 [2023-12-06T01:41:44.815Z] --- PASS: TestServiceUpdateConfigs (14.37s)
01:41:44 [2023-12-06T01:41:44.815Z] === RUN   TestServiceUpdateNetwork
01:41:57 [2023-12-06T01:41:57.032Z] --- PASS: TestServiceUpdateNetwork (12.17s)
01:41:57 [2023-12-06T01:41:57.032Z] === RUN   TestServiceUpdatePidsLimit
01:41:57 [2023-12-06T01:41:57.032Z] === RUN   TestServiceUpdatePidsLimit/create_service_with_PidsLimit_300
01:41:57 [2023-12-06T01:41:57.597Z] === RUN   TestServiceUpdatePidsLimit/unset_PidsLimit_to_0
01:42:05 [2023-12-06T01:42:05.701Z] === RUN   TestServiceUpdatePidsLimit/update_PidsLimit_to_100
01:42:12 [2023-12-06T01:42:12.254Z] --- PASS: TestServiceUpdatePidsLimit (16.43s)
01:42:12 [2023-12-06T01:42:12.254Z]     --- PASS: TestServiceUpdatePidsLimit/create_service_with_PidsLimit_300 (0.82s)
01:42:12 [2023-12-06T01:42:12.254Z]     --- PASS: TestServiceUpdatePidsLimit/unset_PidsLimit_to_0 (6.88s)
01:42:12 [2023-12-06T01:42:12.254Z]     --- PASS: TestServiceUpdatePidsLimit/update_PidsLimit_to_100 (6.88s)
01:42:12 [2023-12-06T01:42:12.254Z] PASS
01:42:12 [2023-12-06T01:42:12.254Z] 
01:42:12 [2023-12-06T01:42:12.254Z] === Skipped
01:42:12 [2023-12-06T01:42:12.254Z] === SKIP: arm64.integration.service TestServicePlugin (0.00s)
01:42:12 [2023-12-06T01:42:12.254Z]     plugin_test.go:25: (*Execution).NotAmd64-fm
01:42:12 [2023-12-06T01:42:12.254Z] 
01:42:12 [2023-12-06T01:42:12.254Z] DONE 26 tests, 1 skipped in 144.096s
01:42:12 [2023-12-06T01:42:12.254Z] Running /go/src/github.com/docker/docker/integration/session (arm64.integration.session) flags=-test.v -test.timeout=120m  
01:42:12 [2023-12-06T01:42:12.254Z] ++ '[' -n '' ']'
01:42:12 [2023-12-06T01:42:12.254Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-session-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-session-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.session -t ./test.main -test.v -test.timeout=120m
01:42:12 [2023-12-06T01:42:12.254Z] ++ set -e
01:42:12 [2023-12-06T01:42:12.254Z] ++ '[' -n 0 ']'
01:42:12 [2023-12-06T01:42:12.254Z] ++ set -x
01:42:12 [2023-12-06T01:42:12.254Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///run/docker/tmp.9zRT3ArzgE/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= GO111MODULE=off GOCACHE=/root/.cache/go-build GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=/usr/local/cli-integration/docker TEST_INTEGRATION_USE_SNAPSHOTTER= OTEL_EXPORTER_OTLP_ENDPOINT= OTEL_SERVICE_NAME= gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-session-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-session-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.session -t ./test.main -test.v -test.timeout=120m
01:42:12 [2023-12-06T01:42:12.254Z] INFO: Testing against a local daemon
01:42:12 [2023-12-06T01:42:12.254Z] === RUN   TestSessionCreate
01:42:12 [2023-12-06T01:42:12.254Z] --- PASS: TestSessionCreate (0.01s)
01:42:12 [2023-12-06T01:42:12.254Z] === RUN   TestSessionCreateWithBadUpgrade
01:42:12 [2023-12-06T01:42:12.254Z] --- PASS: TestSessionCreateWithBadUpgrade (0.01s)
01:42:12 [2023-12-06T01:42:12.254Z] PASS
01:42:12 [2023-12-06T01:42:12.254Z] 
01:42:12 [2023-12-06T01:42:12.254Z] DONE 2 tests in 0.054s
01:42:12 [2023-12-06T01:42:12.254Z] Running /go/src/github.com/docker/docker/integration/system (arm64.integration.system) flags=-test.v -test.timeout=120m  
01:42:12 [2023-12-06T01:42:12.254Z] ++ '[' -n '' ']'
01:42:12 [2023-12-06T01:42:12.254Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-system-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-system-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.system -t ./test.main -test.v -test.timeout=120m
01:42:12 [2023-12-06T01:42:12.254Z] ++ set -e
01:42:12 [2023-12-06T01:42:12.254Z] ++ '[' -n 0 ']'
01:42:12 [2023-12-06T01:42:12.254Z] ++ set -x
01:42:12 [2023-12-06T01:42:12.254Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///run/docker/tmp.9zRT3ArzgE/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= GO111MODULE=off GOCACHE=/root/.cache/go-build GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=/usr/local/cli-integration/docker TEST_INTEGRATION_USE_SNAPSHOTTER= OTEL_EXPORTER_OTLP_ENDPOINT= OTEL_SERVICE_NAME= gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-system-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-system-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.system -t ./test.main -test.v -test.timeout=120m
01:42:12 [2023-12-06T01:42:12.254Z] INFO: Testing against a local daemon
01:42:12 [2023-12-06T01:42:12.254Z] === RUN   TestCgroupDriverSystemdMemoryLimit
01:42:12 [2023-12-06T01:42:12.254Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
01:42:12 [2023-12-06T01:42:12.254Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
01:42:12 [2023-12-06T01:42:12.254Z] === RUN   TestDiskUsage
01:42:12 [2023-12-06T01:42:12.254Z] === PAUSE TestDiskUsage
01:42:12 [2023-12-06T01:42:12.254Z] === RUN   TestEventsExecDie
01:42:12 [2023-12-06T01:42:12.820Z] --- PASS: TestEventsExecDie (0.54s)
01:42:12 [2023-12-06T01:42:12.820Z] === RUN   TestEventsBackwardsCompatible
01:42:12 [2023-12-06T01:42:12.820Z] --- PASS: TestEventsBackwardsCompatible (0.06s)
01:42:12 [2023-12-06T01:42:12.820Z] === RUN   TestEventsVolumeCreate
01:42:12 [2023-12-06T01:42:12.820Z] --- PASS: TestEventsVolumeCreate (0.06s)
01:42:12 [2023-12-06T01:42:12.820Z] === RUN   TestInfoBinaryCommits
01:42:12 [2023-12-06T01:42:12.820Z] --- PASS: TestInfoBinaryCommits (0.02s)
01:42:12 [2023-12-06T01:42:12.820Z] === RUN   TestInfoAPIVersioned
01:42:12 [2023-12-06T01:42:12.820Z] --- PASS: TestInfoAPIVersioned (0.01s)
01:42:12 [2023-12-06T01:42:12.820Z] === RUN   TestInfoAPI
01:42:13 [2023-12-06T01:42:13.078Z] --- PASS: TestInfoAPI (0.02s)
01:42:13 [2023-12-06T01:42:13.078Z] === RUN   TestInfoAPIWarnings
01:42:31 [2023-12-06T01:42:31.146Z] --- PASS: TestInfoAPIWarnings (16.55s)
01:42:31 [2023-12-06T01:42:31.147Z] === RUN   TestInfoDebug
01:42:31 [2023-12-06T01:42:31.147Z] --- PASS: TestInfoDebug (0.52s)
01:42:31 [2023-12-06T01:42:31.147Z] === RUN   TestInfoInsecureRegistries
01:42:31 [2023-12-06T01:42:31.147Z] --- PASS: TestInfoInsecureRegistries (0.52s)
01:42:31 [2023-12-06T01:42:31.147Z] === RUN   TestInfoRegistryMirrors
01:42:31 [2023-12-06T01:42:31.147Z] --- PASS: TestInfoRegistryMirrors (0.52s)
01:42:31 [2023-12-06T01:42:31.147Z] === RUN   TestLoginFailsWithBadCredentials
01:42:32 [2023-12-06T01:42:32.079Z] --- PASS: TestLoginFailsWithBadCredentials (0.99s)
01:42:32 [2023-12-06T01:42:32.079Z] === RUN   TestPingCacheHeaders
01:42:32 [2023-12-06T01:42:32.079Z] --- PASS: TestPingCacheHeaders (0.01s)
01:42:32 [2023-12-06T01:42:32.079Z] === RUN   TestPingGet
01:42:32 [2023-12-06T01:42:32.079Z] --- PASS: TestPingGet (0.01s)
01:42:32 [2023-12-06T01:42:32.079Z] === RUN   TestPingHead
01:42:32 [2023-12-06T01:42:32.079Z] --- PASS: TestPingHead (0.01s)
01:42:32 [2023-12-06T01:42:32.079Z] === RUN   TestPingSwarmHeader
01:42:32 [2023-12-06T01:42:32.645Z] === RUN   TestPingSwarmHeader/before_swarm_init
01:42:33 [2023-12-06T01:42:33.210Z] === RUN   TestPingSwarmHeader/after_swarm_init
01:42:34 [2023-12-06T01:42:34.142Z] === RUN   TestPingSwarmHeader/after_swarm_leave
01:42:34 [2023-12-06T01:42:34.142Z] --- PASS: TestPingSwarmHeader (1.90s)
01:42:34 [2023-12-06T01:42:34.142Z]     --- PASS: TestPingSwarmHeader/before_swarm_init (0.00s)
01:42:34 [2023-12-06T01:42:34.142Z]     --- PASS: TestPingSwarmHeader/after_swarm_init (0.00s)
01:42:34 [2023-12-06T01:42:34.142Z]     --- PASS: TestPingSwarmHeader/after_swarm_leave (0.00s)
01:42:34 [2023-12-06T01:42:34.142Z] === RUN   TestPingBuilderHeader
01:42:34 [2023-12-06T01:42:34.142Z] === RUN   TestPingBuilderHeader/default_config
01:42:34 [2023-12-06T01:42:34.400Z] === RUN   TestPingBuilderHeader/buildkit_disabled
01:42:34 [2023-12-06T01:42:34.966Z] --- PASS: TestPingBuilderHeader (1.04s)
01:42:34 [2023-12-06T01:42:34.966Z]     --- PASS: TestPingBuilderHeader/default_config (0.52s)
01:42:34 [2023-12-06T01:42:34.966Z]     --- PASS: TestPingBuilderHeader/buildkit_disabled (0.52s)
01:42:34 [2023-12-06T01:42:34.966Z] === RUN   TestVersion
01:42:34 [2023-12-06T01:42:34.966Z] --- PASS: TestVersion (0.02s)
01:42:34 [2023-12-06T01:42:34.966Z] === CONT  TestDiskUsage
01:42:35 [2023-12-06T01:42:35.531Z] === RUN   TestDiskUsage/empty
01:42:35 [2023-12-06T01:42:35.531Z] === RUN   TestDiskUsage/empty/container_types
01:42:35 [2023-12-06T01:42:35.531Z] === RUN   TestDiskUsage/empty/image_types
01:42:35 [2023-12-06T01:42:35.531Z] === RUN   TestDiskUsage/empty/volume_types
01:42:35 [2023-12-06T01:42:35.531Z] === RUN   TestDiskUsage/empty/build-cache_types
01:42:35 [2023-12-06T01:42:35.531Z] === RUN   TestDiskUsage/empty/container,_volume_types
01:42:35 [2023-12-06T01:42:35.531Z] === RUN   TestDiskUsage/empty/image,_build-cache_types
01:42:35 [2023-12-06T01:42:35.531Z] === RUN   TestDiskUsage/empty/container,_volume,_build-cache_types
01:42:35 [2023-12-06T01:42:35.531Z] === RUN   TestDiskUsage/empty/image,_volume,_build-cache_types
01:42:35 [2023-12-06T01:42:35.531Z] === RUN   TestDiskUsage/empty/container,_image,_volume_types
01:42:35 [2023-12-06T01:42:35.531Z] === RUN   TestDiskUsage/empty/container,_image,_volume,_build-cache_types
01:42:35 [2023-12-06T01:42:35.531Z] === RUN   TestDiskUsage/after_LoadBusybox
01:42:35 [2023-12-06T01:42:35.531Z] === RUN   TestDiskUsage/after_LoadBusybox/container_types
01:42:35 [2023-12-06T01:42:35.531Z] === RUN   TestDiskUsage/after_LoadBusybox/image_types
01:42:35 [2023-12-06T01:42:35.531Z] === RUN   TestDiskUsage/after_LoadBusybox/volume_types
01:42:35 [2023-12-06T01:42:35.531Z] === RUN   TestDiskUsage/after_LoadBusybox/build-cache_types
01:42:35 [2023-12-06T01:42:35.789Z] === RUN   TestDiskUsage/after_LoadBusybox/container,_volume_types
01:42:35 [2023-12-06T01:42:35.789Z] === RUN   TestDiskUsage/after_LoadBusybox/image,_build-cache_types
01:42:35 [2023-12-06T01:42:35.789Z] === RUN   TestDiskUsage/after_LoadBusybox/container,_volume,_build-cache_types
01:42:35 [2023-12-06T01:42:35.789Z] === RUN   TestDiskUsage/after_LoadBusybox/image,_volume,_build-cache_types
01:42:35 [2023-12-06T01:42:35.789Z] === RUN   TestDiskUsage/after_LoadBusybox/container,_image,_volume_types
01:42:35 [2023-12-06T01:42:35.789Z] === RUN   TestDiskUsage/after_LoadBusybox/container,_image,_volume,_build-cache_types
01:42:35 [2023-12-06T01:42:35.789Z] === RUN   TestDiskUsage/after_container.Run
01:42:36 [2023-12-06T01:42:36.047Z] === RUN   TestDiskUsage/after_container.Run/container_types
01:42:36 [2023-12-06T01:42:36.047Z] === RUN   TestDiskUsage/after_container.Run/image_types
01:42:36 [2023-12-06T01:42:36.047Z] === RUN   TestDiskUsage/after_container.Run/volume_types
01:42:36 [2023-12-06T01:42:36.047Z] === RUN   TestDiskUsage/after_container.Run/build-cache_types
01:42:36 [2023-12-06T01:42:36.047Z] === RUN   TestDiskUsage/after_container.Run/container,_volume_types
01:42:36 [2023-12-06T01:42:36.047Z] === RUN   TestDiskUsage/after_container.Run/image,_build-cache_types
01:42:36 [2023-12-06T01:42:36.047Z] === RUN   TestDiskUsage/after_container.Run/container,_volume,_build-cache_types
01:42:36 [2023-12-06T01:42:36.047Z] === RUN   TestDiskUsage/after_container.Run/image,_volume,_build-cache_types
01:42:36 [2023-12-06T01:42:36.047Z] === RUN   TestDiskUsage/after_container.Run/container,_image,_volume_types
01:42:36 [2023-12-06T01:42:36.047Z] === RUN   TestDiskUsage/after_container.Run/container,_image,_volume,_build-cache_types
01:42:36 [2023-12-06T01:42:36.047Z] --- PASS: TestDiskUsage (1.09s)
01:42:36 [2023-12-06T01:42:36.047Z]     --- PASS: TestDiskUsage/empty (0.01s)
01:42:36 [2023-12-06T01:42:36.047Z]         --- PASS: TestDiskUsage/empty/container_types (0.00s)
01:42:36 [2023-12-06T01:42:36.047Z]         --- PASS: TestDiskUsage/empty/image_types (0.00s)
01:42:36 [2023-12-06T01:42:36.047Z]         --- PASS: TestDiskUsage/empty/volume_types (0.00s)
01:42:36 [2023-12-06T01:42:36.047Z]         --- PASS: TestDiskUsage/empty/build-cache_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/empty/container,_volume_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/empty/image,_build-cache_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/empty/container,_volume,_build-cache_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/empty/image,_volume,_build-cache_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/empty/container,_image,_volume_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/empty/container,_image,_volume,_build-cache_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]     --- PASS: TestDiskUsage/after_LoadBusybox (0.09s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/after_LoadBusybox/image_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/after_LoadBusybox/volume_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/after_LoadBusybox/build-cache_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container,_volume_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/after_LoadBusybox/image,_build-cache_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container,_volume,_build-cache_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/after_LoadBusybox/image,_volume,_build-cache_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container,_image,_volume_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container,_image,_volume,_build-cache_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]     --- PASS: TestDiskUsage/after_container.Run (0.29s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/after_container.Run/container_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/after_container.Run/image_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/after_container.Run/volume_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/after_container.Run/build-cache_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/after_container.Run/container,_volume_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/after_container.Run/image,_build-cache_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/after_container.Run/container,_volume,_build-cache_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/after_container.Run/image,_volume,_build-cache_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/after_container.Run/container,_image,_volume_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]         --- PASS: TestDiskUsage/after_container.Run/container,_image,_volume,_build-cache_types (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z] PASS
01:42:36 [2023-12-06T01:42:36.048Z] 
01:42:36 [2023-12-06T01:42:36.048Z] === Skipped
01:42:36 [2023-12-06T01:42:36.048Z] === SKIP: arm64.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
01:42:36 [2023-12-06T01:42:36.048Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
01:42:36 [2023-12-06T01:42:36.048Z] 
01:42:36 [2023-12-06T01:42:36.048Z] DONE 57 tests, 1 skipped in 23.932s
01:42:36 [2023-12-06T01:42:36.048Z] Running /go/src/github.com/docker/docker/integration/volume (arm64.integration.volume) flags=-test.v -test.timeout=120m  
01:42:36 [2023-12-06T01:42:36.048Z] ++ '[' -n '' ']'
01:42:36 [2023-12-06T01:42:36.048Z] ++ test_env gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-volume-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-volume-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.volume -t ./test.main -test.v -test.timeout=120m
01:42:36 [2023-12-06T01:42:36.048Z] ++ set -e
01:42:36 [2023-12-06T01:42:36.048Z] ++ '[' -n 0 ']'
01:42:36 [2023-12-06T01:42:36.048Z] ++ set -x
01:42:36 [2023-12-06T01:42:36.048Z] ++ env -i DEST=/go/src/github.com/docker/docker/bundles/test-integration DOCKER_API_VERSION= DOCKER_BUILDKIT= DOCKER_INTEGRATION_DAEMON_DEST= DOCKER_TLS_VERIFY= DOCKER_CERT_PATH= DOCKER_GRAPHDRIVER=overlay2 DOCKER_USERLANDPROXY=true DOCKER_HOST=unix:///run/docker/tmp.9zRT3ArzgE/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= GO111MODULE=off GOCACHE=/root/.cache/go-build GOPATH=/go GOTRACEBACK=all HOME=/go/src/github.com/docker/docker/bundles/test-integration/fake-HOME PATH=/go/src/github.com/docker/docker/bundles/test-integration/../dynbinary-daemon:/go/src/github.com/docker/docker/bundles/test-integration/../binary-daemon:/usr/local/cli:/go/bin:/usr/local/go/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin TEMP= TEST_CLIENT_BINARY=/usr/local/cli-integration/docker TEST_INTEGRATION_USE_SNAPSHOTTER= OTEL_EXPORTER_OTLP_ENDPOINT= OTEL_SERVICE_NAME= gotestsum --format=standard-verbose --jsonfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-volume-go-test-report.json --junitfile=/go/src/github.com/docker/docker/bundles/test-integration/arm64-integration-volume-junit-report.xml --raw-command -- go tool test2json -p arm64.integration.volume -t ./test.main -test.v -test.timeout=120m
01:42:36 [2023-12-06T01:42:36.306Z] INFO: Testing against a local daemon
01:42:36 [2023-12-06T01:42:36.306Z] === RUN   TestVolumesCreateAndList
01:42:36 [2023-12-06T01:42:36.306Z] --- PASS: TestVolumesCreateAndList (0.02s)
01:42:36 [2023-12-06T01:42:36.306Z] === RUN   TestVolumesRemove
01:42:36 [2023-12-06T01:42:36.306Z] === RUN   TestVolumesRemove/volume_in_use
01:42:36 [2023-12-06T01:42:36.306Z] === RUN   TestVolumesRemove/volume_not_in_use
01:42:36 [2023-12-06T01:42:36.306Z] === RUN   TestVolumesRemove/non-existing_volume
01:42:36 [2023-12-06T01:42:36.306Z] === RUN   TestVolumesRemove/non-existing_volume_force
01:42:36 [2023-12-06T01:42:36.306Z] --- PASS: TestVolumesRemove (0.06s)
01:42:36 [2023-12-06T01:42:36.306Z]     --- PASS: TestVolumesRemove/volume_in_use (0.00s)
01:42:36 [2023-12-06T01:42:36.306Z]     --- PASS: TestVolumesRemove/volume_not_in_use (0.01s)
01:42:36 [2023-12-06T01:42:36.306Z]     --- PASS: TestVolumesRemove/non-existing_volume (0.00s)
01:42:36 [2023-12-06T01:42:36.306Z]     --- PASS: TestVolumesRemove/non-existing_volume_force (0.00s)
01:42:36 [2023-12-06T01:42:36.306Z] === RUN   TestVolumesRemoveSwarmEnabled
01:42:36 [2023-12-06T01:42:36.306Z] === PAUSE TestVolumesRemoveSwarmEnabled
01:42:36 [2023-12-06T01:42:36.306Z] === RUN   TestVolumesInspect
01:42:36 [2023-12-06T01:42:36.306Z] --- PASS: TestVolumesInspect (0.01s)
01:42:36 [2023-12-06T01:42:36.306Z] === RUN   TestVolumesInvalidJSON
01:42:36 [2023-12-06T01:42:36.306Z] === RUN   TestVolumesInvalidJSON/volumes/create
01:42:36 [2023-12-06T01:42:36.306Z] === PAUSE TestVolumesInvalidJSON/volumes/create
01:42:36 [2023-12-06T01:42:36.306Z] === CONT  TestVolumesInvalidJSON/volumes/create
01:42:36 [2023-12-06T01:42:36.306Z] === RUN   TestVolumesInvalidJSON/volumes/create/invalid_content_type
01:42:36 [2023-12-06T01:42:36.306Z] === RUN   TestVolumesInvalidJSON/volumes/create/invalid_JSON
01:42:36 [2023-12-06T01:42:36.306Z] === RUN   TestVolumesInvalidJSON/volumes/create/extra_content_after_JSON
01:42:36 [2023-12-06T01:42:36.306Z] === RUN   TestVolumesInvalidJSON/volumes/create/empty_body
01:42:36 [2023-12-06T01:42:36.306Z] --- PASS: TestVolumesInvalidJSON (0.01s)
01:42:36 [2023-12-06T01:42:36.306Z]     --- PASS: TestVolumesInvalidJSON/volumes/create (0.00s)
01:42:36 [2023-12-06T01:42:36.306Z]         --- PASS: TestVolumesInvalidJSON/volumes/create/invalid_content_type (0.00s)
01:42:36 [2023-12-06T01:42:36.306Z]         --- PASS: TestVolumesInvalidJSON/volumes/create/invalid_JSON (0.00s)
01:42:36 [2023-12-06T01:42:36.306Z]         --- PASS: TestVolumesInvalidJSON/volumes/create/extra_content_after_JSON (0.00s)
01:42:36 [2023-12-06T01:42:36.306Z]         --- PASS: TestVolumesInvalidJSON/volumes/create/empty_body (0.00s)
01:42:36 [2023-12-06T01:42:36.306Z] === RUN   TestVolumePruneAnonymous
01:42:36 [2023-12-06T01:42:36.306Z] --- PASS: TestVolumePruneAnonymous (0.04s)
01:42:36 [2023-12-06T01:42:36.306Z] === RUN   TestVolumePruneAnonFromImage
01:42:36 [2023-12-06T01:42:36.564Z] --- PASS: TestVolumePruneAnonFromImage (0.17s)
01:42:36 [2023-12-06T01:42:36.564Z] === CONT  TestVolumesRemoveSwarmEnabled
01:42:37 [2023-12-06T01:42:37.936Z] === RUN   TestVolumesRemoveSwarmEnabled/volume_in_use
01:42:37 [2023-12-06T01:42:37.936Z] === RUN   TestVolumesRemoveSwarmEnabled/volume_not_in_use
01:42:37 [2023-12-06T01:42:37.936Z] === RUN   TestVolumesRemoveSwarmEnabled/non-existing_volume
01:42:37 [2023-12-06T01:42:37.936Z] === RUN   TestVolumesRemoveSwarmEnabled/non-existing_volume_force
01:42:38 [2023-12-06T01:42:38.516Z] --- PASS: TestVolumesRemoveSwarmEnabled (1.94s)
01:42:38 [2023-12-06T01:42:38.516Z]     --- PASS: TestVolumesRemoveSwarmEnabled/volume_in_use (0.00s)
01:42:38 [2023-12-06T01:42:38.516Z]     --- PASS: TestVolumesRemoveSwarmEnabled/volume_not_in_use (0.01s)
01:42:38 [2023-12-06T01:42:38.516Z]     --- PASS: TestVolumesRemoveSwarmEnabled/non-existing_volume (0.00s)
01:42:38 [2023-12-06T01:42:38.516Z]     --- PASS: TestVolumesRemoveSwarmEnabled/non-existing_volume_force (0.00s)
01:42:38 [2023-12-06T01:42:38.516Z] PASS
01:42:38 [2023-12-06T01:42:38.516Z] 
01:42:38 [2023-12-06T01:42:38.516Z] DONE 20 tests in 2.283s
01:42:38 [2023-12-06T01:42:38.516Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
01:42:38 [2023-12-06T01:42:38.516Z] ++++ cat bundles/test-integration/docker.pid
01:42:38 [2023-12-06T01:42:38.516Z] +++ kill 23992
01:42:40 [2023-12-06T01:42:40.435Z] ++++ cat bundles/test-integration/TestUsernsCommit/d786f5915a7cd/docker.pid
01:42:40 [2023-12-06T01:42:40.435Z] +++ kill 61192
01:42:40 [2023-12-06T01:42:40.435Z] /go/src/github.com/docker/docker/hack/make/.integration-daemon-stop: line 13: wait: pid 61192 is not a child of this shell
01:42:40 [2023-12-06T01:42:40.435Z] warning: PID 61192 from bundles/test-integration/TestUsernsCommit/d786f5915a7cd/docker.pid had a nonzero exit code
01:42:40 [2023-12-06T01:42:40.435Z] umount: bundles/test-integration/TestUsernsCommit/d786f5915a7cd/root: not mounted.
01:42:40 [2023-12-06T01:42:40.435Z] +++ /etc/init.d/apparmor stop
01:42:40 [2023-12-06T01:42:40.435Z] Leaving: AppArmorNo profiles have been unloaded.
01:42:40 [2023-12-06T01:42:40.435Z] 
01:42:40 [2023-12-06T01:42:40.435Z] Unloading profiles will leave already running processes permanently
01:42:40 [2023-12-06T01:42:40.435Z] unconfined, which can lead to unexpected situations.
01:42:40 [2023-12-06T01:42:40.435Z] 
01:42:40 [2023-12-06T01:42:40.435Z] To set a process to complain mode, use the command line tool
01:42:40 [2023-12-06T01:42:40.435Z] 'aa-complain'. To really tear down all profiles, run 'aa-teardown'."
01:42:40 [2023-12-06T01:42:40.435Z] +++ true
01:42:40 [2023-12-06T01:42:40.436Z] exiting test-integration
01:42:40 [2023-12-06T01:42:40.436Z] ++ exit 0
01:42:40 [2023-12-06T01:42:40.436Z]