Skip to content

Console Output

Skipping 187 KB.. Full Log
ch/arm64 UpstreamClient(Go-http-client/1.1)"
09:29:22 [2024-01-03T09:29:22.295Z] time="2024-01-03T09:29:22.14098382Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=5cdf3d38-ac0c-44c0-89c4-34cd7cae76a9 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:44386" http.request.uri="/v2/test/manifests/latest" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=test vars.reference=latest 
09:29:22 [2024-01-03T09:29:22.295Z] time="2024-01-03T09:29:22.14102195Z" level=debug msg=GetImageManifest go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=5cdf3d38-ac0c-44c0-89c4-34cd7cae76a9 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:44386" http.request.uri="/v2/test/manifests/latest" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=test vars.reference=latest 
09:29:22 [2024-01-03T09:29:22.295Z] time="2024-01-03T09:29:22.141096471Z" 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=5cdf3d38-ac0c-44c0-89c4-34cd7cae76a9 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:44386" http.request.uri="/v2/test/manifests/latest" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=42.832µ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=292be863-cfa6-4247-8efc-be46cd2773cc trace.line=95 vars.name=test vars.reference=latest 
09:29:22 [2024-01-03T09:29:22.295Z] time="2024-01-03T09:29:22.14112011Z" level=debug msg="(*manifestStore).Get" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=5cdf3d38-ac0c-44c0-89c4-34cd7cae76a9 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:44386" http.request.uri="/v2/test/manifests/latest" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=test vars.reference=latest 
09:29:22 [2024-01-03T09:29:22.295Z] time="2024-01-03T09:29:22.141165354Z" 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=5cdf3d38-ac0c-44c0-89c4-34cd7cae76a9 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:44386" http.request.uri="/v2/test/manifests/latest" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=22.253µ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=4ba4a268-e06d-4f9b-b5fc-0c58a8a0ae55 trace.line=95 vars.name=test vars.reference=latest 
09:29:22 [2024-01-03T09:29:22.295Z] time="2024-01-03T09:29:22.14120977Z" 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=5cdf3d38-ac0c-44c0-89c4-34cd7cae76a9 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:44386" http.request.uri="/v2/test/manifests/latest" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=15.368µ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=1df182f9-fe02-4c58-9554-27f37951155b trace.line=155 vars.name=test vars.reference=latest 
09:29:22 [2024-01-03T09:29:22.295Z] time="2024-01-03T09:29:22.141248835Z" 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=5cdf3d38-ac0c-44c0-89c4-34cd7cae76a9 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:44386" http.request.uri="/v2/test/manifests/latest" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=12.644µ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=a41c0b77-da58-4ca7-a8b6-7d2ce4e80da7 trace.line=125 vars.name=test vars.reference=latest 
09:29:22 [2024-01-03T09:29:22.295Z] time="2024-01-03T09:29:22.141294235Z" level=debug msg="(*schema2ManifestHandler).Unmarshal" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=5cdf3d38-ac0c-44c0-89c4-34cd7cae76a9 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:44386" http.request.uri="/v2/test/manifests/latest" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=test vars.reference=latest 
09:29:22 [2024-01-03T09:29:22.295Z] time="2024-01-03T09:29:22.141383969Z" level=info msg="response completed" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=5cdf3d38-ac0c-44c0-89c4-34cd7cae76a9 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:44386" http.request.uri="/v2/test/manifests/latest" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff 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.8108ms http.response.status=200 http.response.written=417 
09:29:22 [2024-01-03T09:29:22.295Z] 127.0.0.1 - - [03/Jan/2024:09:29:22 +0000] "HEAD /v2/test/manifests/latest HTTP/1.1" 200 417 "" "docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.149246686Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=8b185559-b8d3-455b-92c8-d53843596855 http.request.method=GET http.request.remoteaddr="127.0.0.1:44400" http.request.uri="/v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=test vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.149286687Z" level=debug msg=GetImageManifest go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=8b185559-b8d3-455b-92c8-d53843596855 http.request.method=GET http.request.remoteaddr="127.0.0.1:44400" http.request.uri="/v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=test vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.149300021Z" level=debug msg="(*manifestStore).Get" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=8b185559-b8d3-455b-92c8-d53843596855 http.request.method=GET http.request.remoteaddr="127.0.0.1:44400" http.request.uri="/v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=test vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.149365376Z" 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=8b185559-b8d3-455b-92c8-d53843596855 http.request.method=GET http.request.remoteaddr="127.0.0.1:44400" http.request.uri="/v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=38.221µ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=9e2111f5-4337-465c-9ef6-cf33c1f2f118 trace.line=95 vars.name=test vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.149416389Z" 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=8b185559-b8d3-455b-92c8-d53843596855 http.request.method=GET http.request.remoteaddr="127.0.0.1:44400" http.request.uri="/v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=15.081µ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=c4c55546-454f-484c-bc63-7b6b187277c7 trace.line=155 vars.name=test vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.1494557Z" 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=8b185559-b8d3-455b-92c8-d53843596855 http.request.method=GET http.request.remoteaddr="127.0.0.1:44400" http.request.uri="/v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=12.636µ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=e8e574b1-b210-4ab5-ad62-32375190f260 trace.line=125 vars.name=test vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.149485223Z" level=debug msg="(*schema2ManifestHandler).Unmarshal" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=8b185559-b8d3-455b-92c8-d53843596855 http.request.method=GET http.request.remoteaddr="127.0.0.1:44400" http.request.uri="/v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=test vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.149581061Z" level=info msg="response completed" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=8b185559-b8d3-455b-92c8-d53843596855 http.request.method=GET http.request.remoteaddr="127.0.0.1:44400" http.request.uri="/v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff 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.091734ms http.response.status=200 http.response.written=417 
09:29:22 [2024-01-03T09:29:22.296Z] 127.0.0.1 - - [03/Jan/2024:09:29:22 +0000] "GET /v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda HTTP/1.1" 200 417 "" "docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.155546207Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=b418ad97-4620-447c-8f58-21c69ca71a25 http.request.method=GET http.request.remoteaddr="127.0.0.1:44410" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.155586537Z" level=debug msg=GetBlob go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=b418ad97-4620-447c-8f58-21c69ca71a25 http.request.method=GET http.request.remoteaddr="127.0.0.1:44410" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.155627768Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=7bfb881e-140a-4a41-a969-6e66d0f16ad5 http.request.method=GET http.request.remoteaddr="127.0.0.1:44414" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.155650382Z" 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=b418ad97-4620-447c-8f58-21c69ca71a25 http.request.method=GET http.request.remoteaddr="127.0.0.1:44410" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=35.529µ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=b2bf1f43-be8f-4c55-8940-2c6ec5f7a483 trace.line=95 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.155667507Z" level=debug msg=GetBlob go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=7bfb881e-140a-4a41-a969-6e66d0f16ad5 http.request.method=GET http.request.remoteaddr="127.0.0.1:44414" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.155691778Z" 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=b418ad97-4620-447c-8f58-21c69ca71a25 http.request.method=GET http.request.remoteaddr="127.0.0.1:44410" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=14.121µ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=9d83c106-8106-4040-a433-221f10d59f0d trace.line=155 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.155730039Z" 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=7bfb881e-140a-4a41-a969-6e66d0f16ad5 http.request.method=GET http.request.remoteaddr="127.0.0.1:44414" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=34.323µ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=58fdb073-4e81-4d89-83e4-1a92fe21d61f trace.line=95 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.15574119Z" 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=b418ad97-4620-447c-8f58-21c69ca71a25 http.request.method=GET http.request.remoteaddr="127.0.0.1:44410" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=20.292µ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=b1348420-9a12-492f-ad84-d61c0950edde trace.line=95 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.155774849Z" 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=7bfb881e-140a-4a41-a969-6e66d0f16ad5 http.request.method=GET http.request.remoteaddr="127.0.0.1:44414" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=15.41µ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=e6ca1278-b186-4519-b625-61cd0e5c06ed trace.line=155 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.155820085Z" 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=7bfb881e-140a-4a41-a969-6e66d0f16ad5 http.request.method=GET http.request.remoteaddr="127.0.0.1:44414" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=19.151µ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=7f3561a4-709e-4610-97e9-64b065267569 trace.line=95 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.155776654Z" 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=b418ad97-4620-447c-8f58-21c69ca71a25 http.request.method=GET http.request.remoteaddr="127.0.0.1:44410" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=10.068µ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=39c18644-7f49-4584-8785-d2f8810a332e trace.line=155 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.155853054Z" 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=7bfb881e-140a-4a41-a969-6e66d0f16ad5 http.request.method=GET http.request.remoteaddr="127.0.0.1:44414" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=10.06µ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=bb936214-5f1b-41c5-92dd-08bb2189fd16 trace.line=155 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.1559959Z" 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=7bfb881e-140a-4a41-a969-6e66d0f16ad5 http.request.method=GET http.request.remoteaddr="127.0.0.1:44414" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=21.654µ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=76d17171-d357-49b1-8f3e-ab96fdb75425 trace.line=155 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.156041998Z" 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=7bfb881e-140a-4a41-a969-6e66d0f16ad5 http.request.method=GET http.request.remoteaddr="127.0.0.1:44414" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=11.044µ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=b2873bd7-38cb-4f73-9455-c69c05ca9c37 trace.line=217 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.156098992Z" 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=7bfb881e-140a-4a41-a969-6e66d0f16ad5 http.request.method=GET http.request.remoteaddr="127.0.0.1:44414" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=18.962µ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=9190311e-3098-4fa7-b614-9ba087e476b0 trace.line=125 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.155925622Z" 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=b418ad97-4620-447c-8f58-21c69ca71a25 http.request.method=GET http.request.remoteaddr="127.0.0.1:44410" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=32.576µ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=522881d5-49df-45a3-b870-bd27688e3302 trace.line=155 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.156468338Z" 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=b418ad97-4620-447c-8f58-21c69ca71a25 http.request.method=GET http.request.remoteaddr="127.0.0.1:44410" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=12.792µ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=940aa6f9-c4e6-41ac-a846-180e8340aec0 trace.line=217 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
09:29:22 [2024-01-03T09:29:22.296Z] time="2024-01-03T09:29:22.156764608Z" 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=b418ad97-4620-447c-8f58-21c69ca71a25 http.request.method=GET http.request.remoteaddr="127.0.0.1:44410" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=25.256µ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=18d4ed4f-46f7-4117-a2a2-931c52c7a916 trace.line=125 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
09:29:22 [2024-01-03T09:29:22.297Z] time="2024-01-03T09:29:22.157329921Z" 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=b418ad97-4620-447c-8f58-21c69ca71a25 http.request.method=GET http.request.remoteaddr="127.0.0.1:44410" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=29.695µ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=ee034be5-eb11-4d66-8def-97839b0ad638 trace.line=95 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
09:29:22 [2024-01-03T09:29:22.297Z] time="2024-01-03T09:29:22.157382337Z" 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=b418ad97-4620-447c-8f58-21c69ca71a25 http.request.method=GET http.request.remoteaddr="127.0.0.1:44410" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=14.359µ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=000ab32b-f56a-4332-acf5-ffdea6b4beef trace.line=155 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
09:29:22 [2024-01-03T09:29:22.297Z] time="2024-01-03T09:29:22.157437608Z" level=info msg="response completed" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=b418ad97-4620-447c-8f58-21c69ca71a25 http.request.method=GET http.request.remoteaddr="127.0.0.1:44410" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff 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.250539ms http.response.status=200 http.response.written=194 
09:29:22 [2024-01-03T09:29:22.297Z] 127.0.0.1 - - [03/Jan/2024:09:29:22 +0000] "GET /v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b HTTP/1.1" 200 194 "" "docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
09:29:22 [2024-01-03T09:29:22.297Z] time="2024-01-03T09:29:22.157583991Z" 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=7bfb881e-140a-4a41-a969-6e66d0f16ad5 http.request.method=GET http.request.remoteaddr="127.0.0.1:44414" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=46.024µ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=449bfe92-b933-4754-af35-f9b820c2d499 trace.line=95 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
09:29:22 [2024-01-03T09:29:22.297Z] time="2024-01-03T09:29:22.157635701Z" 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=7bfb881e-140a-4a41-a969-6e66d0f16ad5 http.request.method=GET http.request.remoteaddr="127.0.0.1:44414" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=14.31µ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=79d92707-2ab4-4d0b-93c6-1904cd2b46cf trace.line=155 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
09:29:22 [2024-01-03T09:29:22.297Z] time="2024-01-03T09:29:22.157685491Z" level=info msg="response completed" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=7bfb881e-140a-4a41-a969-6e66d0f16ad5 http.request.method=GET http.request.remoteaddr="127.0.0.1:44414" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff 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.387076ms http.response.status=200 http.response.written=68 
09:29:22 [2024-01-03T09:29:22.297Z] 127.0.0.1 - - [03/Jan/2024:09:29:22 +0000] "GET /v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923 HTTP/1.1" 200 68 "" "docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
09:29:22 [2024-01-03T09:29:22.297Z] time="2024-01-03T09:29:22.169117277Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=1d7b1571-79af-41ae-a272-605c1fb6f55f http.request.method=GET http.request.remoteaddr="127.0.0.1:44442" http.request.uri="/v2/" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" 
09:29:22 [2024-01-03T09:29:22.297Z] time="2024-01-03T09:29:22.169151707Z" level=info msg="response completed" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=1d7b1571-79af-41ae-a272-605c1fb6f55f http.request.method=GET http.request.remoteaddr="127.0.0.1:44442" http.request.uri="/v2/" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff 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="714.946µs" http.response.status=200 http.response.written=2 
09:29:22 [2024-01-03T09:29:22.297Z] 127.0.0.1 - - [03/Jan/2024:09:29:22 +0000] "GET /v2/ HTTP/1.1" 200 2 "" "docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
09:29:22 [2024-01-03T09:29:22.297Z] time="2024-01-03T09:29:22.174754867Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=26d9299d-6b63-4481-81e8-743b4601070d http.request.method=HEAD http.request.remoteaddr="127.0.0.1:44452" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
09:29:22 [2024-01-03T09:29:22.297Z] time="2024-01-03T09:29:22.174792562Z" level=debug msg=GetImageManifest go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=26d9299d-6b63-4481-81e8-743b4601070d http.request.method=HEAD http.request.remoteaddr="127.0.0.1:44452" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
09:29:22 [2024-01-03T09:29:22.297Z] time="2024-01-03T09:29:22.174804542Z" level=debug msg="(*manifestStore).Get" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=26d9299d-6b63-4481-81e8-743b4601070d http.request.method=HEAD http.request.remoteaddr="127.0.0.1:44452" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
09:29:22 [2024-01-03T09:29:22.297Z] time="2024-01-03T09:29:22.174860831Z" 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=26d9299d-6b63-4481-81e8-743b4601070d http.request.method=HEAD http.request.remoteaddr="127.0.0.1:44452" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=28.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=84e70058-7926-42b0-90f0-d6066e2c7e39 trace.line=95 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
09:29:22 [2024-01-03T09:29:22.297Z] time="2024-01-03T09:29:22.174905443Z" 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=26d9299d-6b63-4481-81e8-743b4601070d http.request.method=HEAD http.request.remoteaddr="127.0.0.1:44452" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=14.351µ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=b7b9fbb0-f4bc-45fa-9ca1-5537329d20e1 trace.line=95 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
09:29:22 [2024-01-03T09:29:22.297Z] time="2024-01-03T09:29:22.174973235Z" 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=26d9299d-6b63-4481-81e8-743b4601070d http.request.method=HEAD http.request.remoteaddr="127.0.0.1:44452" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff 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="969.951µs" http.response.status=404 http.response.written=181 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
09:29:22 [2024-01-03T09:29:22.297Z] 127.0.0.1 - - [03/Jan/2024:09:29:22 +0000] "HEAD /v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda HTTP/1.1" 404 181 "" "docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
09:29:22 [2024-01-03T09:29:22.297Z] time="2024-01-03T09:29:22.176553367Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=99f72f46-8d3c-4592-8d69-a7cff7adb91f http.request.method=GET http.request.remoteaddr="127.0.0.1:44464" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
09:29:22 [2024-01-03T09:29:22.297Z] time="2024-01-03T09:29:22.176593097Z" level=debug msg=GetImageManifest go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=99f72f46-8d3c-4592-8d69-a7cff7adb91f http.request.method=GET http.request.remoteaddr="127.0.0.1:44464" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
09:29:22 [2024-01-03T09:29:22.297Z] time="2024-01-03T09:29:22.176606242Z" level=debug msg="(*manifestStore).Get" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=99f72f46-8d3c-4592-8d69-a7cff7adb91f http.request.method=GET http.request.remoteaddr="127.0.0.1:44464" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
09:29:22 [2024-01-03T09:29:22.297Z] time="2024-01-03T09:29:22.176660307Z" 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=99f72f46-8d3c-4592-8d69-a7cff7adb91f http.request.method=GET http.request.remoteaddr="127.0.0.1:44464" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=26.996µ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=dd4d3d64-16b0-4af6-aa93-745fbefa84fb trace.line=95 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
09:29:22 [2024-01-03T09:29:22.297Z] time="2024-01-03T09:29:22.176706872Z" 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=99f72f46-8d3c-4592-8d69-a7cff7adb91f http.request.method=GET http.request.remoteaddr="127.0.0.1:44464" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=13.883µ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=c618f85e-299d-4b8a-8e57-c700561eeb80 trace.line=95 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
09:29:22 [2024-01-03T09:29:22.297Z] time="2024-01-03T09:29:22.176750237Z" 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=99f72f46-8d3c-4592-8d69-a7cff7adb91f http.request.method=GET http.request.remoteaddr="127.0.0.1:44464" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff 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.227869ms http.response.status=404 http.response.written=181 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
09:29:22 [2024-01-03T09:29:22.297Z] 127.0.0.1 - - [03/Jan/2024:09:29:22 +0000] "GET /v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda HTTP/1.1" 404 181 "" "docker/dev go/go1.21.5 git-commit/7b0f8122b22b472e91571597f7b93f8ace5f68ff kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
09:29:22 [2024-01-03T09:29:22.297Z] --- PASS: TestImagePullStoredfDigestForOtherRepo (0.17s)
09:29:22 [2024-01-03T09:29:22.297Z] === RUN   TestImagePullNonExisting
09:29:22 [2024-01-03T09:29:22.297Z] === RUN   TestImagePullNonExisting/asdfasdf:foobar
09:29:22 [2024-01-03T09:29:22.297Z] === PAUSE TestImagePullNonExisting/asdfasdf:foobar
09:29:22 [2024-01-03T09:29:22.297Z] === RUN   TestImagePullNonExisting/library/asdfasdf:foobar
09:29:22 [2024-01-03T09:29:22.297Z] === PAUSE TestImagePullNonExisting/library/asdfasdf:foobar
09:29:22 [2024-01-03T09:29:22.297Z] === RUN   TestImagePullNonExisting/asdfasdf
09:29:22 [2024-01-03T09:29:22.297Z] === PAUSE TestImagePullNonExisting/asdfasdf
09:29:22 [2024-01-03T09:29:22.297Z] === RUN   TestImagePullNonExisting/asdfasdf:latest
09:29:22 [2024-01-03T09:29:22.297Z] === PAUSE TestImagePullNonExisting/asdfasdf:latest
09:29:22 [2024-01-03T09:29:22.297Z] === RUN   TestImagePullNonExisting/library/asdfasdf
09:29:22 [2024-01-03T09:29:22.297Z] === PAUSE TestImagePullNonExisting/library/asdfasdf
09:29:22 [2024-01-03T09:29:22.297Z] === RUN   TestImagePullNonExisting/library/asdfasdf:latest
09:29:22 [2024-01-03T09:29:22.297Z] === PAUSE TestImagePullNonExisting/library/asdfasdf:latest
09:29:22 [2024-01-03T09:29:22.297Z] === CONT  TestImagePullNonExisting/asdfasdf:foobar
09:29:22 [2024-01-03T09:29:22.297Z] === CONT  TestImagePullNonExisting/library/asdfasdf:latest
09:29:22 [2024-01-03T09:29:22.297Z] === CONT  TestImagePullNonExisting/library/asdfasdf
09:29:22 [2024-01-03T09:29:22.297Z] === CONT  TestImagePullNonExisting/asdfasdf
09:29:22 [2024-01-03T09:29:22.297Z] === CONT  TestImagePullNonExisting/library/asdfasdf:foobar
09:29:22 [2024-01-03T09:29:22.297Z] === CONT  TestImagePullNonExisting/asdfasdf:latest
09:29:23 [2024-01-03T09:29:23.662Z] --- PASS: TestImagePullNonExisting (0.01s)
09:29:23 [2024-01-03T09:29:23.662Z]     --- PASS: TestImagePullNonExisting/asdfasdf:foobar (0.95s)
09:29:23 [2024-01-03T09:29:23.662Z]     --- PASS: TestImagePullNonExisting/library/asdfasdf:latest (0.96s)
09:29:23 [2024-01-03T09:29:23.662Z]     --- PASS: TestImagePullNonExisting/asdfasdf:latest (0.96s)
09:29:23 [2024-01-03T09:29:23.662Z]     --- PASS: TestImagePullNonExisting/library/asdfasdf:foobar (1.06s)
09:29:23 [2024-01-03T09:29:23.662Z]     --- PASS: TestImagePullNonExisting/asdfasdf (1.28s)
09:29:23 [2024-01-03T09:29:23.662Z]     --- PASS: TestImagePullNonExisting/library/asdfasdf (1.29s)
09:29:23 [2024-01-03T09:29:23.662Z] === RUN   TestRemoveImageOrphaning
09:29:23 [2024-01-03T09:29:23.662Z] --- PASS: TestRemoveImageOrphaning (0.14s)
09:29:23 [2024-01-03T09:29:23.662Z] === RUN   TestRemoveByDigest
09:29:23 [2024-01-03T09:29:23.662Z]     remove_test.go:64: !testEnv.UsingSnapshotter(): RepoDigests doesn't include tags when using graphdrivers
09:29:23 [2024-01-03T09:29:23.662Z] --- SKIP: TestRemoveByDigest (0.00s)
09:29:23 [2024-01-03T09:29:23.662Z] === RUN   TestRemoveImageGarbageCollector
09:29:23 [2024-01-03T09:29:23.662Z]     remove_unix_test.go:34: (*Execution).NotAmd64-fm
09:29:23 [2024-01-03T09:29:23.662Z] --- SKIP: TestRemoveImageGarbageCollector (0.00s)
09:29:23 [2024-01-03T09:29:23.662Z] === RUN   TestSaveCheckTimes
09:29:23 [2024-01-03T09:29:23.662Z] === PAUSE TestSaveCheckTimes
09:29:23 [2024-01-03T09:29:23.662Z] === RUN   TestSaveRepoWithMultipleImages
09:29:23 [2024-01-03T09:29:23.918Z] --- PASS: TestSaveRepoWithMultipleImages (0.17s)
09:29:23 [2024-01-03T09:29:23.918Z] === RUN   TestSaveDirectoryPermissions
09:29:24 [2024-01-03T09:29:24.845Z] --- PASS: TestSaveDirectoryPermissions (0.96s)
09:29:24 [2024-01-03T09:29:24.845Z] === RUN   TestTagUnprefixedRepoByNameOrName
09:29:24 [2024-01-03T09:29:24.845Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.02s)
09:29:24 [2024-01-03T09:29:24.845Z] === RUN   TestTagUsingDigestAlgorithmAsName
09:29:24 [2024-01-03T09:29:24.845Z] --- PASS: TestTagUsingDigestAlgorithmAsName (0.01s)
09:29:24 [2024-01-03T09:29:24.845Z] === RUN   TestTagValidPrefixedRepo
09:29:24 [2024-01-03T09:29:24.845Z] === RUN   TestTagValidPrefixedRepo/fooo/bar
09:29:24 [2024-01-03T09:29:24.845Z] === PAUSE TestTagValidPrefixedRepo/fooo/bar
09:29:24 [2024-01-03T09:29:24.845Z] === RUN   TestTagValidPrefixedRepo/fooaa/test
09:29:24 [2024-01-03T09:29:24.845Z] === PAUSE TestTagValidPrefixedRepo/fooaa/test
09:29:24 [2024-01-03T09:29:24.845Z] === RUN   TestTagValidPrefixedRepo/foooo:t
09:29:24 [2024-01-03T09:29:24.845Z] === PAUSE TestTagValidPrefixedRepo/foooo:t
09:29:24 [2024-01-03T09:29:24.845Z] === RUN   TestTagValidPrefixedRepo/HOSTNAME.DOMAIN.COM:443/foo/bar
09:29:24 [2024-01-03T09:29:24.845Z] === PAUSE TestTagValidPrefixedRepo/HOSTNAME.DOMAIN.COM:443/foo/bar
09:29:24 [2024-01-03T09:29:24.845Z] === CONT  TestTagValidPrefixedRepo/fooo/bar
09:29:24 [2024-01-03T09:29:24.845Z] === CONT  TestTagValidPrefixedRepo/foooo:t
09:29:24 [2024-01-03T09:29:24.845Z] === CONT  TestTagValidPrefixedRepo/fooaa/test
09:29:24 [2024-01-03T09:29:24.845Z] === CONT  TestTagValidPrefixedRepo/HOSTNAME.DOMAIN.COM:443/foo/bar
09:29:24 [2024-01-03T09:29:24.845Z] --- PASS: TestTagValidPrefixedRepo (0.02s)
09:29:24 [2024-01-03T09:29:24.845Z]     --- PASS: TestTagValidPrefixedRepo/fooo/bar (0.01s)
09:29:24 [2024-01-03T09:29:24.845Z]     --- PASS: TestTagValidPrefixedRepo/foooo:t (0.01s)
09:29:24 [2024-01-03T09:29:24.845Z]     --- PASS: TestTagValidPrefixedRepo/HOSTNAME.DOMAIN.COM:443/foo/bar (0.01s)
09:29:24 [2024-01-03T09:29:24.845Z]     --- PASS: TestTagValidPrefixedRepo/fooaa/test (0.02s)
09:29:24 [2024-01-03T09:29:24.845Z] === RUN   TestTagExistedNameWithoutForce
09:29:24 [2024-01-03T09:29:24.845Z] --- PASS: TestTagExistedNameWithoutForce (0.01s)
09:29:24 [2024-01-03T09:29:24.845Z] === RUN   TestTagOfficialNames
09:29:24 [2024-01-03T09:29:24.845Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_docker.io/busybox
09:29:24 [2024-01-03T09:29:24.845Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_index.docker.io/busybox
09:29:24 [2024-01-03T09:29:24.845Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_library/busybox
09:29:24 [2024-01-03T09:29:24.845Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_docker.io/library/busybox
09:29:25 [2024-01-03T09:29:25.100Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_index.docker.io/library/busybox
09:29:25 [2024-01-03T09:29:25.101Z] --- PASS: TestTagOfficialNames (0.04s)
09:29:25 [2024-01-03T09:29:25.101Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_docker.io/busybox (0.01s)
09:29:25 [2024-01-03T09:29:25.101Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_index.docker.io/busybox (0.01s)
09:29:25 [2024-01-03T09:29:25.101Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_library/busybox (0.01s)
09:29:25 [2024-01-03T09:29:25.101Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_docker.io/library/busybox (0.01s)
09:29:25 [2024-01-03T09:29:25.101Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_index.docker.io/library/busybox (0.01s)
09:29:25 [2024-01-03T09:29:25.101Z] === RUN   TestTagMatchesDigest
09:29:25 [2024-01-03T09:29:25.101Z] --- PASS: TestTagMatchesDigest (0.01s)
09:29:25 [2024-01-03T09:29:25.101Z] === CONT  TestSaveCheckTimes
09:29:25 [2024-01-03T09:29:25.101Z] --- PASS: TestSaveCheckTimes (0.03s)
09:29:25 [2024-01-03T09:29:25.101Z] PASS
09:29:25 [2024-01-03T09:29:25.101Z] 
09:29:25 [2024-01-03T09:29:25.101Z] === Skipped
09:29:25 [2024-01-03T09:29:25.101Z] === SKIP: arm64.integration.image TestImportExtremelyLargeImageWorks (0.00s)
09:29:25 [2024-01-03T09:29:25.101Z]     import_test.go:23: runtime.GOARCH == "arm64": effective test will be time out
09:29:25 [2024-01-03T09:29:25.101Z] 
09:29:25 [2024-01-03T09:29:25.101Z] === SKIP: arm64.integration.image TestRemoveByDigest (0.00s)
09:29:25 [2024-01-03T09:29:25.101Z]     remove_test.go:64: !testEnv.UsingSnapshotter(): RepoDigests doesn't include tags when using graphdrivers
09:29:25 [2024-01-03T09:29:25.101Z] 
09:29:25 [2024-01-03T09:29:25.101Z] === SKIP: arm64.integration.image TestRemoveImageGarbageCollector (0.00s)
09:29:25 [2024-01-03T09:29:25.101Z]     remove_unix_test.go:34: (*Execution).NotAmd64-fm
09:29:25 [2024-01-03T09:29:25.101Z] 
09:29:25 [2024-01-03T09:29:25.101Z] DONE 54 tests, 3 skipped in 5.800s
09:29:25 [2024-01-03T09:29:25.101Z] Running /go/src/github.com/docker/docker/integration/internal/termtest (arm64.integration.internal.termtest) flags=-test.v -test.timeout=120m  
09:29:25 [2024-01-03T09:29:25.101Z] ++ '[' -n '' ']'
09:29:25 [2024-01-03T09:29:25.101Z] ++ 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
09:29:25 [2024-01-03T09:29:25.101Z] ++ set -e
09:29:25 [2024-01-03T09:29:25.101Z] ++ '[' -n 0 ']'
09:29:25 [2024-01-03T09:29:25.101Z] ++ set -x
09:29:25 [2024-01-03T09:29:25.101Z] ++ 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.hBzUI38w6x/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
09:29:25 [2024-01-03T09:29:25.101Z] === RUN   TestStripANSICommands
09:29:25 [2024-01-03T09:29:25.101Z] === RUN   TestStripANSICommands/#00
09:29:25 [2024-01-03T09:29:25.101Z] === RUN   TestStripANSICommands/#01
09:29:25 [2024-01-03T09:29:25.101Z] --- PASS: TestStripANSICommands (0.00s)
09:29:25 [2024-01-03T09:29:25.101Z]     --- PASS: TestStripANSICommands/#00 (0.00s)
09:29:25 [2024-01-03T09:29:25.101Z]     --- PASS: TestStripANSICommands/#01 (0.00s)
09:29:25 [2024-01-03T09:29:25.101Z] PASS
09:29:25 [2024-01-03T09:29:25.101Z] 
09:29:25 [2024-01-03T09:29:25.101Z] DONE 3 tests in 0.009s
09:29:25 [2024-01-03T09:29:25.101Z] Running /go/src/github.com/docker/docker/integration/network (arm64.integration.network) flags=-test.v -test.timeout=120m  
09:29:25 [2024-01-03T09:29:25.101Z] ++ '[' -n '' ']'
09:29:25 [2024-01-03T09:29:25.101Z] ++ 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
09:29:25 [2024-01-03T09:29:25.101Z] ++ set -e
09:29:25 [2024-01-03T09:29:25.101Z] ++ '[' -n 0 ']'
09:29:25 [2024-01-03T09:29:25.101Z] ++ set -x
09:29:25 [2024-01-03T09:29:25.101Z] ++ 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.hBzUI38w6x/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
09:29:25 [2024-01-03T09:29:25.101Z] INFO: Testing against a local daemon
09:29:25 [2024-01-03T09:29:25.101Z] === RUN   TestCreateWithMultiNetworks
09:29:26 [2024-01-03T09:29:26.027Z] --- PASS: TestCreateWithMultiNetworks (1.01s)
09:29:26 [2024-01-03T09:29:26.027Z] === RUN   TestNetworkCreateDelete
09:29:26 [2024-01-03T09:29:26.283Z] --- PASS: TestNetworkCreateDelete (0.18s)
09:29:26 [2024-01-03T09:29:26.283Z] === RUN   TestDockerNetworkDeletePreferID
09:29:26 [2024-01-03T09:29:26.845Z] --- PASS: TestDockerNetworkDeletePreferID (0.47s)
09:29:26 [2024-01-03T09:29:26.845Z] === RUN   TestDaemonDNSFallback
09:29:33 [2024-01-03T09:29:33.379Z] --- PASS: TestDaemonDNSFallback (6.17s)
09:29:33 [2024-01-03T09:29:33.379Z] === RUN   TestInspectNetwork
09:29:35 [2024-01-03T09:29:35.893Z] === RUN   TestInspectNetwork/full_network_id
09:29:35 [2024-01-03T09:29:35.893Z] === RUN   TestInspectNetwork/partial_network_id
09:29:35 [2024-01-03T09:29:35.893Z] === RUN   TestInspectNetwork/network_name
09:29:35 [2024-01-03T09:29:35.893Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
09:29:40 [2024-01-03T09:29:40.056Z] --- PASS: TestInspectNetwork (7.17s)
09:29:40 [2024-01-03T09:29:40.056Z]     --- PASS: TestInspectNetwork/full_network_id (0.00s)
09:29:40 [2024-01-03T09:29:40.056Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
09:29:40 [2024-01-03T09:29:40.056Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
09:29:40 [2024-01-03T09:29:40.056Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
09:29:40 [2024-01-03T09:29:40.056Z] === RUN   TestRunContainerWithBridgeNone
09:29:41 [2024-01-03T09:29:41.421Z] --- PASS: TestRunContainerWithBridgeNone (1.36s)
09:29:41 [2024-01-03T09:29:41.421Z] === RUN   TestNetworkInvalidJSON
09:29:41 [2024-01-03T09:29:41.421Z] === RUN   TestNetworkInvalidJSON/networks/create
09:29:41 [2024-01-03T09:29:41.421Z] === PAUSE TestNetworkInvalidJSON/networks/create
09:29:41 [2024-01-03T09:29:41.421Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect
09:29:41 [2024-01-03T09:29:41.421Z] === PAUSE TestNetworkInvalidJSON/networks/bridge/connect
09:29:41 [2024-01-03T09:29:41.421Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect
09:29:41 [2024-01-03T09:29:41.421Z] === PAUSE TestNetworkInvalidJSON/networks/bridge/disconnect
09:29:41 [2024-01-03T09:29:41.421Z] === CONT  TestNetworkInvalidJSON/networks/create
09:29:41 [2024-01-03T09:29:41.421Z] === CONT  TestNetworkInvalidJSON/networks/bridge/disconnect
09:29:41 [2024-01-03T09:29:41.421Z] === CONT  TestNetworkInvalidJSON/networks/bridge/connect
09:29:41 [2024-01-03T09:29:41.421Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect/invalid_content_type
09:29:41 [2024-01-03T09:29:41.421Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect/invalid_content_type
09:29:41 [2024-01-03T09:29:41.421Z] === RUN   TestNetworkInvalidJSON/networks/create/invalid_content_type
09:29:41 [2024-01-03T09:29:41.421Z] === RUN   TestNetworkInvalidJSON/networks/create/invalid_JSON
09:29:41 [2024-01-03T09:29:41.421Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect/invalid_JSON
09:29:41 [2024-01-03T09:29:41.421Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect/invalid_JSON
09:29:41 [2024-01-03T09:29:41.421Z] === RUN   TestNetworkInvalidJSON/networks/create/extra_content_after_JSON
09:29:41 [2024-01-03T09:29:41.421Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect/extra_content_after_JSON
09:29:41 [2024-01-03T09:29:41.421Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect/extra_content_after_JSON
09:29:41 [2024-01-03T09:29:41.421Z] === RUN   TestNetworkInvalidJSON/networks/create/empty_body
09:29:41 [2024-01-03T09:29:41.421Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect/empty_body
09:29:41 [2024-01-03T09:29:41.421Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect/empty_body
09:29:41 [2024-01-03T09:29:41.421Z] --- PASS: TestNetworkInvalidJSON (0.01s)
09:29:41 [2024-01-03T09:29:41.421Z]     --- PASS: TestNetworkInvalidJSON/networks/create (0.00s)
09:29:41 [2024-01-03T09:29:41.421Z]         --- PASS: TestNetworkInvalidJSON/networks/create/invalid_content_type (0.00s)
09:29:41 [2024-01-03T09:29:41.421Z]         --- PASS: TestNetworkInvalidJSON/networks/create/invalid_JSON (0.00s)
09:29:41 [2024-01-03T09:29:41.421Z]         --- PASS: TestNetworkInvalidJSON/networks/create/extra_content_after_JSON (0.00s)
09:29:41 [2024-01-03T09:29:41.421Z]         --- PASS: TestNetworkInvalidJSON/networks/create/empty_body (0.00s)
09:29:41 [2024-01-03T09:29:41.421Z]     --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect (0.00s)
09:29:41 [2024-01-03T09:29:41.421Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect/invalid_content_type (0.00s)
09:29:41 [2024-01-03T09:29:41.421Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect/invalid_JSON (0.00s)
09:29:41 [2024-01-03T09:29:41.421Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect/extra_content_after_JSON (0.00s)
09:29:41 [2024-01-03T09:29:41.421Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect/empty_body (0.00s)
09:29:41 [2024-01-03T09:29:41.421Z]     --- PASS: TestNetworkInvalidJSON/networks/bridge/connect (0.00s)
09:29:41 [2024-01-03T09:29:41.421Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/connect/invalid_content_type (0.00s)
09:29:41 [2024-01-03T09:29:41.421Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/connect/invalid_JSON (0.00s)
09:29:41 [2024-01-03T09:29:41.421Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/connect/extra_content_after_JSON (0.00s)
09:29:41 [2024-01-03T09:29:41.421Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/connect/empty_body (0.00s)
09:29:41 [2024-01-03T09:29:41.421Z] === RUN   TestNetworkList
09:29:41 [2024-01-03T09:29:41.421Z] === RUN   TestNetworkList//networks
09:29:41 [2024-01-03T09:29:41.421Z] === PAUSE TestNetworkList//networks
09:29:41 [2024-01-03T09:29:41.421Z] === RUN   TestNetworkList//networks/
09:29:41 [2024-01-03T09:29:41.421Z] === PAUSE TestNetworkList//networks/
09:29:41 [2024-01-03T09:29:41.421Z] === CONT  TestNetworkList//networks
09:29:41 [2024-01-03T09:29:41.421Z] === CONT  TestNetworkList//networks/
09:29:41 [2024-01-03T09:29:41.421Z] --- PASS: TestNetworkList (0.01s)
09:29:41 [2024-01-03T09:29:41.421Z]     --- PASS: TestNetworkList//networks (0.00s)
09:29:41 [2024-01-03T09:29:41.421Z]     --- PASS: TestNetworkList//networks/ (0.00s)
09:29:41 [2024-01-03T09:29:41.421Z] === RUN   TestHostIPv4BridgeLabel
09:29:41 [2024-01-03T09:29:41.982Z] --- PASS: TestHostIPv4BridgeLabel (0.57s)
09:29:41 [2024-01-03T09:29:41.982Z] === RUN   TestDefaultNetworkOpts
09:29:41 [2024-01-03T09:29:41.982Z] === RUN   TestDefaultNetworkOpts/default_value
09:29:43 [2024-01-03T09:29:43.347Z] === RUN   TestDefaultNetworkOpts/cmdline_value
09:29:44 [2024-01-03T09:29:44.711Z] === RUN   TestDefaultNetworkOpts/config-from_value
09:29:46 [2024-01-03T09:29:46.075Z] --- PASS: TestDefaultNetworkOpts (3.88s)
09:29:46 [2024-01-03T09:29:46.075Z]     --- PASS: TestDefaultNetworkOpts/default_value (1.24s)
09:29:46 [2024-01-03T09:29:46.075Z]     --- PASS: TestDefaultNetworkOpts/cmdline_value (1.37s)
09:29:46 [2024-01-03T09:29:46.075Z]     --- PASS: TestDefaultNetworkOpts/config-from_value (1.27s)
09:29:46 [2024-01-03T09:29:46.075Z] === RUN   TestForbidDuplicateNetworkNames
09:29:46 [2024-01-03T09:29:46.637Z] --- PASS: TestForbidDuplicateNetworkNames (0.64s)
09:29:46 [2024-01-03T09:29:46.637Z] === RUN   TestDaemonRestartWithLiveRestore
09:29:47 [2024-01-03T09:29:47.564Z] --- PASS: TestDaemonRestartWithLiveRestore (1.03s)
09:29:47 [2024-01-03T09:29:47.564Z] === RUN   TestDaemonDefaultNetworkPools
09:29:48 [2024-01-03T09:29:48.491Z] --- PASS: TestDaemonDefaultNetworkPools (0.79s)
09:29:48 [2024-01-03T09:29:48.491Z] === RUN   TestDaemonRestartWithExistingNetwork
09:29:49 [2024-01-03T09:29:49.855Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.16s)
09:29:49 [2024-01-03T09:29:49.855Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
09:29:50 [2024-01-03T09:29:50.782Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.24s)
09:29:50 [2024-01-03T09:29:50.782Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
09:29:51 [2024-01-03T09:29:51.343Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.60s)
09:29:51 [2024-01-03T09:29:51.343Z] === RUN   TestServiceWithPredefinedNetwork
09:29:53 [2024-01-03T09:29:53.858Z] --- PASS: TestServiceWithPredefinedNetwork (2.14s)
09:29:53 [2024-01-03T09:29:53.858Z] === RUN   TestServiceRemoveKeepsIngressNetwork
09:29:53 [2024-01-03T09:29:53.858Z]     service_test.go:250: FLAKY_TEST
09:29:53 [2024-01-03T09:29:53.858Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
09:29:53 [2024-01-03T09:29:53.858Z] === RUN   TestServiceWithDataPathPortInit
09:30:08 [2024-01-03T09:30:08.693Z] --- PASS: TestServiceWithDataPathPortInit (13.40s)
09:30:08 [2024-01-03T09:30:08.693Z] === RUN   TestServiceWithDefaultAddressPoolInit
09:30:09 [2024-01-03T09:30:09.254Z]     service_test.go:440: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:07fgboph2v2dws4hrormnx0ts Created:2024-01-03 09:30:08.119057424 +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[540d9571170b1fa35a644056dd6e0fee7965a00d25451c32bc1de7c91b67c18d:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.of7o446ywip22wc8klzh1isay EndpointID:9af3162868bcfc6a1ca532e3ffe9203e86673e3ff6f8ee256e2e5a2b37f670ac MacAddress:02:42:14:14:01:03 IPv4Address:20.20.1.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:b423885ae3b3a23cbcb1a0fd91d373d448e10f78effb10ed1e8128675e3459ff 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:ece3de515c3f IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.1.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.of7o446ywip22wc8klzh1isay EndpointID:9af3162868bcfc6a1ca532e3ffe9203e86673e3ff6f8ee256e2e5a2b37f670ac EndpointIP:20.20.1.3 Info:map[Host IP:127.0.0.1]}]}]}
09:30:14 [2024-01-03T09:30:14.496Z] --- PASS: TestServiceWithDefaultAddressPoolInit (6.63s)
09:30:14 [2024-01-03T09:30:14.496Z] PASS
09:30:14 [2024-01-03T09:30:14.496Z] 
09:30:14 [2024-01-03T09:30:14.496Z] === Skipped
09:30:14 [2024-01-03T09:30:14.496Z] === SKIP: arm64.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
09:30:14 [2024-01-03T09:30:14.496Z]     service_test.go:250: FLAKY_TEST
09:30:14 [2024-01-03T09:30:14.496Z] 
09:30:14 [2024-01-03T09:30:14.496Z] DONE 44 tests, 1 skipped in 48.506s
09:30:14 [2024-01-03T09:30:14.496Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (arm64.integration.network.ipvlan) flags=-test.v -test.timeout=120m  
09:30:14 [2024-01-03T09:30:14.496Z] ++ '[' -n '' ']'
09:30:14 [2024-01-03T09:30:14.496Z] ++ 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
09:30:14 [2024-01-03T09:30:14.496Z] ++ set -e
09:30:14 [2024-01-03T09:30:14.496Z] ++ '[' -n 0 ']'
09:30:14 [2024-01-03T09:30:14.496Z] ++ set -x
09:30:14 [2024-01-03T09:30:14.496Z] ++ 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.hBzUI38w6x/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
09:30:14 [2024-01-03T09:30:14.496Z] INFO: Testing against a local daemon
09:30:14 [2024-01-03T09:30:14.496Z] === RUN   TestDockerNetworkIpvlanPersistance
09:30:14 [2024-01-03T09:30:14.496Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
09:30:14 [2024-01-03T09:30:14.496Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.00s)
09:30:14 [2024-01-03T09:30:14.496Z] === RUN   TestDockerNetworkIpvlan
09:30:14 [2024-01-03T09:30:14.496Z]     ipvlan_test.go:55: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
09:30:14 [2024-01-03T09:30:14.496Z] --- SKIP: TestDockerNetworkIpvlan (0.00s)
09:30:14 [2024-01-03T09:30:14.496Z] PASS
09:30:14 [2024-01-03T09:30:14.496Z] 
09:30:14 [2024-01-03T09:30:14.496Z] === Skipped
09:30:14 [2024-01-03T09:30:14.496Z] === SKIP: arm64.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.00s)
09:30:14 [2024-01-03T09:30:14.496Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
09:30:14 [2024-01-03T09:30:14.496Z] 
09:30:14 [2024-01-03T09:30:14.496Z] === SKIP: arm64.integration.network.ipvlan TestDockerNetworkIpvlan (0.00s)
09:30:14 [2024-01-03T09:30:14.496Z]     ipvlan_test.go:55: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
09:30:14 [2024-01-03T09:30:14.496Z] 
09:30:14 [2024-01-03T09:30:14.496Z] DONE 2 tests, 2 skipped in 0.038s
09:30:14 [2024-01-03T09:30:14.496Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (arm64.integration.network.macvlan) flags=-test.v -test.timeout=120m  
09:30:14 [2024-01-03T09:30:14.496Z] ++ '[' -n '' ']'
09:30:14 [2024-01-03T09:30:14.496Z] ++ 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
09:30:14 [2024-01-03T09:30:14.496Z] ++ set -e
09:30:14 [2024-01-03T09:30:14.496Z] ++ '[' -n 0 ']'
09:30:14 [2024-01-03T09:30:14.496Z] ++ set -x
09:30:14 [2024-01-03T09:30:14.496Z] ++ 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.hBzUI38w6x/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
09:30:14 [2024-01-03T09:30:14.496Z] INFO: Testing against a local daemon
09:30:14 [2024-01-03T09:30:14.496Z] === RUN   TestDockerNetworkMacvlanPersistance
09:30:15 [2024-01-03T09:30:15.057Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.25s)
09:30:15 [2024-01-03T09:30:15.057Z] === RUN   TestDockerNetworkMacvlan
09:30:15 [2024-01-03T09:30:15.057Z] === RUN   TestDockerNetworkMacvlan/Subinterface
09:30:15 [2024-01-03T09:30:15.618Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
09:30:16 [2024-01-03T09:30:16.179Z] === RUN   TestDockerNetworkMacvlan/NilParent
09:30:16 [2024-01-03T09:30:16.740Z] === RUN   TestDockerNetworkMacvlan/InternalMode
09:30:17 [2024-01-03T09:30:17.301Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
09:30:17 [2024-01-03T09:30:17.862Z] === RUN   TestDockerNetworkMacvlan/Addressing
09:30:18 [2024-01-03T09:30:18.423Z] --- PASS: TestDockerNetworkMacvlan (3.53s)
09:30:18 [2024-01-03T09:30:18.423Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.59s)
09:30:18 [2024-01-03T09:30:18.423Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.59s)
09:30:18 [2024-01-03T09:30:18.423Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (0.59s)
09:30:18 [2024-01-03T09:30:18.423Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (0.59s)
09:30:18 [2024-01-03T09:30:18.423Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (0.59s)
09:30:18 [2024-01-03T09:30:18.423Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (0.59s)
09:30:18 [2024-01-03T09:30:18.423Z] PASS
09:30:18 [2024-01-03T09:30:18.423Z] 
09:30:18 [2024-01-03T09:30:18.423Z] DONE 8 tests in 4.816s
09:30:18 [2024-01-03T09:30:18.423Z] Running /go/src/github.com/docker/docker/integration/networking (arm64.integration.networking) flags=-test.v -test.timeout=120m  
09:30:18 [2024-01-03T09:30:18.423Z] ++ '[' -n '' ']'
09:30:18 [2024-01-03T09:30:18.423Z] ++ 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
09:30:18 [2024-01-03T09:30:18.423Z] ++ set -e
09:30:18 [2024-01-03T09:30:18.423Z] ++ '[' -n 0 ']'
09:30:18 [2024-01-03T09:30:18.423Z] ++ set -x
09:30:18 [2024-01-03T09:30:18.423Z] ++ 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.hBzUI38w6x/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
09:30:18 [2024-01-03T09:30:18.423Z] INFO: Testing against a local daemon
09:30:18 [2024-01-03T09:30:18.423Z] === RUN   TestBridgeICC
09:30:18 [2024-01-03T09:30:18.985Z] === RUN   TestBridgeICC/IPv4_non-internal_network
09:30:20 [2024-01-03T09:30:20.349Z] === RUN   TestBridgeICC/IPv4_internal_network
09:30:21 [2024-01-03T09:30:21.275Z] === RUN   TestBridgeICC/IPv6_ULA_on_non-internal_network
09:30:22 [2024-01-03T09:30:22.640Z] === RUN   TestBridgeICC/IPv6_ULA_on_internal_network
09:30:23 [2024-01-03T09:30:23.567Z] === RUN   TestBridgeICC/IPv6_link-local_address_on_non-internal_network
09:30:24 [2024-01-03T09:30:24.931Z] === RUN   TestBridgeICC/IPv6_link-local_address_on_internal_network
09:30:25 [2024-01-03T09:30:25.857Z] === RUN   TestBridgeICC/IPv6_link-local_address_on_non-internal_network_ping_by_name
09:30:27 [2024-01-03T09:30:27.301Z] === RUN   TestBridgeICC/IPv6_nonstandard_link-local_subnet_on_non-internal_network_ping_by_name
09:30:28 [2024-01-03T09:30:28.228Z] === RUN   TestBridgeICC/IPv6_non-internal_network_with_SLAAC_LL_address
09:30:30 [2024-01-03T09:30:30.741Z] === RUN   TestBridgeICC/IPv6_internal_network_with_SLAAC_LL_address
09:30:34 [2024-01-03T09:30:34.006Z] --- PASS: TestBridgeICC (15.05s)
09:30:34 [2024-01-03T09:30:34.006Z]     --- PASS: TestBridgeICC/IPv4_non-internal_network (1.18s)
09:30:34 [2024-01-03T09:30:34.006Z]     --- PASS: TestBridgeICC/IPv4_internal_network (1.00s)
09:30:34 [2024-01-03T09:30:34.006Z]     --- PASS: TestBridgeICC/IPv6_ULA_on_non-internal_network (1.18s)
09:30:34 [2024-01-03T09:30:34.006Z]     --- PASS: TestBridgeICC/IPv6_ULA_on_internal_network (1.08s)
09:30:34 [2024-01-03T09:30:34.006Z]     --- PASS: TestBridgeICC/IPv6_link-local_address_on_non-internal_network (1.15s)
09:30:34 [2024-01-03T09:30:34.006Z]     --- PASS: TestBridgeICC/IPv6_link-local_address_on_internal_network (1.06s)
09:30:34 [2024-01-03T09:30:34.006Z]     --- PASS: TestBridgeICC/IPv6_link-local_address_on_non-internal_network_ping_by_name (1.19s)
09:30:34 [2024-01-03T09:30:34.006Z]     --- PASS: TestBridgeICC/IPv6_nonstandard_link-local_subnet_on_non-internal_network_ping_by_name (1.21s)
09:30:34 [2024-01-03T09:30:34.006Z]     --- PASS: TestBridgeICC/IPv6_non-internal_network_with_SLAAC_LL_address (2.20s)
09:30:34 [2024-01-03T09:30:34.006Z]     --- PASS: TestBridgeICC/IPv6_internal_network_with_SLAAC_LL_address (3.20s)
09:30:34 [2024-01-03T09:30:34.006Z] === RUN   TestBridgeINC
09:30:34 [2024-01-03T09:30:34.006Z] === RUN   TestBridgeINC/IPv4_non-internal_network
09:30:39 [2024-01-03T09:30:39.247Z] === RUN   TestBridgeINC/IPv4_internal_network
09:30:39 [2024-01-03T09:30:39.809Z] === RUN   TestBridgeINC/IPv6_ULA_on_non-internal_network
09:30:43 [2024-01-03T09:30:43.973Z] === RUN   TestBridgeINC/IPv6_ULA_on_internal_network
09:30:45 [2024-01-03T09:30:45.337Z] --- PASS: TestBridgeINC (11.80s)
09:30:45 [2024-01-03T09:30:45.337Z]     --- PASS: TestBridgeINC/IPv4_non-internal_network (4.33s)
09:30:45 [2024-01-03T09:30:45.337Z]     --- PASS: TestBridgeINC/IPv4_internal_network (1.21s)
09:30:45 [2024-01-03T09:30:45.337Z]     --- PASS: TestBridgeINC/IPv6_ULA_on_non-internal_network (4.37s)
09:30:45 [2024-01-03T09:30:45.337Z]     --- PASS: TestBridgeINC/IPv6_ULA_on_internal_network (1.28s)
09:30:45 [2024-01-03T09:30:45.337Z] === RUN   TestDefaultBridgeIPv6
09:30:45 [2024-01-03T09:30:45.337Z] === RUN   TestDefaultBridgeIPv6/IPv6_ULA
09:30:46 [2024-01-03T09:30:46.701Z] === RUN   TestDefaultBridgeIPv6/IPv6_LLA_only
09:30:48 [2024-01-03T09:30:48.588Z] === RUN   TestDefaultBridgeIPv6/IPv6_nonstandard_LLA_only
09:30:49 [2024-01-03T09:30:49.952Z] --- PASS: TestDefaultBridgeIPv6 (4.44s)
09:30:49 [2024-01-03T09:30:49.952Z]     --- PASS: TestDefaultBridgeIPv6/IPv6_ULA (1.47s)
09:30:49 [2024-01-03T09:30:49.952Z]     --- PASS: TestDefaultBridgeIPv6/IPv6_LLA_only (1.48s)
09:30:49 [2024-01-03T09:30:49.952Z]     --- PASS: TestDefaultBridgeIPv6/IPv6_nonstandard_LLA_only (1.47s)
09:30:49 [2024-01-03T09:30:49.952Z] === RUN   TestDefaultBridgeAddresses
09:30:49 [2024-01-03T09:30:49.952Z] === RUN   TestDefaultBridgeAddresses/Unique-Local_Subnet_Changes
09:30:51 [2024-01-03T09:30:51.317Z] === RUN   TestDefaultBridgeAddresses/Link-Local_Subnet_Changes
09:30:53 [2024-01-03T09:30:53.204Z] --- PASS: TestDefaultBridgeAddresses (3.11s)
09:30:53 [2024-01-03T09:30:53.204Z]     --- PASS: TestDefaultBridgeAddresses/Unique-Local_Subnet_Changes (1.55s)
09:30:53 [2024-01-03T09:30:53.204Z]     --- PASS: TestDefaultBridgeAddresses/Link-Local_Subnet_Changes (1.55s)
09:30:53 [2024-01-03T09:30:53.204Z] PASS
09:30:53 [2024-01-03T09:30:53.204Z] 
09:30:53 [2024-01-03T09:30:53.204Z] DONE 23 tests in 34.429s
09:30:53 [2024-01-03T09:30:53.204Z] Running /go/src/github.com/docker/docker/integration/plugin (arm64.integration.plugin) flags=-test.v -test.timeout=120m  
09:30:53 [2024-01-03T09:30:53.204Z] ++ '[' -n '' ']'
09:30:53 [2024-01-03T09:30:53.204Z] ++ 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
09:30:53 [2024-01-03T09:30:53.204Z] ++ set -e
09:30:53 [2024-01-03T09:30:53.204Z] ++ '[' -n 0 ']'
09:30:53 [2024-01-03T09:30:53.204Z] ++ set -x
09:30:53 [2024-01-03T09:30:53.204Z] ++ 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.hBzUI38w6x/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
09:30:53 [2024-01-03T09:30:53.204Z] testing: warning: no tests to run
09:30:53 [2024-01-03T09:30:53.204Z] PASS
09:30:53 [2024-01-03T09:30:53.204Z] 
09:30:53 [2024-01-03T09:30:53.204Z] DONE 0 tests in 0.007s
09:30:53 [2024-01-03T09:30:53.204Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (arm64.integration.plugin.authz) flags=-test.v -test.timeout=120m  
09:30:53 [2024-01-03T09:30:53.204Z] ++ '[' -n '' ']'
09:30:53 [2024-01-03T09:30:53.204Z] ++ 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
09:30:53 [2024-01-03T09:30:53.204Z] ++ set -e
09:30:53 [2024-01-03T09:30:53.204Z] ++ '[' -n 0 ']'
09:30:53 [2024-01-03T09:30:53.204Z] ++ set -x
09:30:53 [2024-01-03T09:30:53.205Z] ++ 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.hBzUI38w6x/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
09:30:53 [2024-01-03T09:30:53.205Z] INFO: Testing against a local daemon
09:30:53 [2024-01-03T09:30:53.205Z] === RUN   TestAuthZPluginAllowRequest
09:30:54 [2024-01-03T09:30:54.131Z] --- PASS: TestAuthZPluginAllowRequest (1.06s)
09:30:54 [2024-01-03T09:30:54.131Z] === RUN   TestAuthZPluginTLS
09:30:54 [2024-01-03T09:30:54.692Z] --- PASS: TestAuthZPluginTLS (0.55s)
09:30:54 [2024-01-03T09:30:54.692Z] === RUN   TestAuthZPluginDenyRequest
09:30:55 [2024-01-03T09:30:55.253Z] --- PASS: TestAuthZPluginDenyRequest (0.53s)
09:30:55 [2024-01-03T09:30:55.253Z] === RUN   TestAuthZPluginAPIDenyResponse
09:30:55 [2024-01-03T09:30:55.509Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.52s)
09:30:55 [2024-01-03T09:30:55.509Z] === RUN   TestAuthZPluginDenyResponse
09:30:56 [2024-01-03T09:30:56.070Z] --- PASS: TestAuthZPluginDenyResponse (0.53s)
09:30:56 [2024-01-03T09:30:56.070Z] === RUN   TestAuthZPluginAllowEventStream
09:30:56 [2024-01-03T09:30:56.996Z] 2024/01/03 09:30:56 http: panic serving 127.0.0.1:33786: runtime error: invalid memory address or nil pointer dereference
09:30:56 [2024-01-03T09:30:56.996Z] goroutine 178 [running]:
09:30:56 [2024-01-03T09:30:56.996Z] net/http.(*conn).serve.func1()
09:30:56 [2024-01-03T09:30:56.996Z] 	/usr/local/go/src/net/http/server.go:1868 +0xb0
09:30:56 [2024-01-03T09:30:56.996Z] panic({0xa72d00?, 0x1589a50?})
09:30:56 [2024-01-03T09:30:56.996Z] 	/usr/local/go/src/runtime/panic.go:920 +0x26c
09:30:56 [2024-01-03T09:30:56.996Z] github.com/docker/docker/integration/plugin/authz.setupSuite.func3({0xd6b378, 0x4000418a20}, 0xffffa5804d00?)
09:30:56 [2024-01-03T09:30:56.996Z] 	/go/src/github.com/docker/docker/integration/plugin/authz/main_test.go:159 +0x14c
09:30:56 [2024-01-03T09:30:56.996Z] net/http.HandlerFunc.ServeHTTP(0x40001c9d00?, {0xd6b378?, 0x4000418a20?}, 0x402214?)
09:30:56 [2024-01-03T09:30:56.996Z] 	/usr/local/go/src/net/http/server.go:2136 +0x38
09:30:56 [2024-01-03T09:30:56.996Z] net/http.(*ServeMux).ServeHTTP(0xd71558?, {0xd6b378, 0x4000418a20}, 0x40001c9d00)
09:30:56 [2024-01-03T09:30:56.996Z] 	/usr/local/go/src/net/http/server.go:2514 +0x144
09:30:56 [2024-01-03T09:30:56.996Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.(*middleware).serveHTTP(0x400020e0b0, {0xd69f38?, 0x40000f1180}, 0x40001c9c00, {0xd603c0, 0x40003c62c0})
09:30:56 [2024-01-03T09:30:56.996Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:217 +0xf44
09:30:56 [2024-01-03T09:30:56.996Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.NewMiddleware.func1.1({0xd69f38?, 0x40000f1180?}, 0x4000310c00?)
09:30:56 [2024-01-03T09:30:56.996Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:81 +0x40
09:30:56 [2024-01-03T09:30:56.996Z] net/http.HandlerFunc.ServeHTTP(0x10?, {0xd69f38?, 0x40000f1180?}, 0x40000f1180?)
09:30:56 [2024-01-03T09:30:56.996Z] 	/usr/local/go/src/net/http/server.go:2136 +0x38
09:30:56 [2024-01-03T09:30:56.996Z] net/http.serverHandler.ServeHTTP({0xd66b68?}, {0xd69f38?, 0x40000f1180?}, 0x6?)
09:30:56 [2024-01-03T09:30:56.996Z] 	/usr/local/go/src/net/http/server.go:2938 +0xbc
09:30:56 [2024-01-03T09:30:56.996Z] net/http.(*conn).serve(0x40000ae870, {0xd71558, 0x40001a0cf0})
09:30:56 [2024-01-03T09:30:56.996Z] 	/usr/local/go/src/net/http/server.go:2009 +0x518
09:30:56 [2024-01-03T09:30:56.996Z] created by net/http.(*Server).Serve in goroutine 37
09:30:56 [2024-01-03T09:30:56.996Z] 	/usr/local/go/src/net/http/server.go:3086 +0x4cc
09:30:57 [2024-01-03T09:30:57.922Z] 2024/01/03 09:30:57 http: panic serving 127.0.0.1:33788: could not unmarshal json for /AuthZPlugin.AuthZRes: unexpected end of JSON input
09:30:57 [2024-01-03T09:30:57.922Z] goroutine 171 [running]:
09:30:57 [2024-01-03T09:30:57.922Z] net/http.(*conn).serve.func1()
09:30:57 [2024-01-03T09:30:57.922Z] 	/usr/local/go/src/net/http/server.go:1868 +0xb0
09:30:57 [2024-01-03T09:30:57.922Z] panic({0xa0a160?, 0x400059e160?})
09:30:57 [2024-01-03T09:30:57.922Z] 	/usr/local/go/src/runtime/panic.go:920 +0x26c
09:30:57 [2024-01-03T09:30:57.922Z] github.com/docker/docker/integration/plugin/authz.setupSuite.func3({0xd6b378, 0x400043c180}, 0xffff5ea46fc8?)
09:30:57 [2024-01-03T09:30:57.922Z] 	/go/src/github.com/docker/docker/integration/plugin/authz/main_test.go:149 +0x360
09:30:57 [2024-01-03T09:30:57.922Z] net/http.HandlerFunc.ServeHTTP(0x4000270000?, {0xd6b378?, 0x400043c180?}, 0x402214?)
09:30:57 [2024-01-03T09:30:57.922Z] 	/usr/local/go/src/net/http/server.go:2136 +0x38
09:30:57 [2024-01-03T09:30:57.922Z] net/http.(*ServeMux).ServeHTTP(0xd71558?, {0xd6b378, 0x400043c180}, 0x4000270000)
09:30:57 [2024-01-03T09:30:57.922Z] 	/usr/local/go/src/net/http/server.go:2514 +0x144
09:30:57 [2024-01-03T09:30:57.922Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.(*middleware).serveHTTP(0x400020e0b0, {0xd69f38?, 0x40000f0000}, 0x4000270300, {0xd603c0, 0x40003c62c0})
09:30:57 [2024-01-03T09:30:57.922Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:217 +0xf44
09:30:57 [2024-01-03T09:30:57.922Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.NewMiddleware.func1.1({0xd69f38?, 0x40000f0000?}, 0x400015e2d0?)
09:30:57 [2024-01-03T09:30:57.922Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:81 +0x40
09:30:57 [2024-01-03T09:30:57.922Z] net/http.HandlerFunc.ServeHTTP(0x15e6f80?, {0xd69f38?, 0x40000f0000?}, 0x40003d0b40?)
09:30:57 [2024-01-03T09:30:57.922Z] 	/usr/local/go/src/net/http/server.go:2136 +0x38
09:30:57 [2024-01-03T09:30:57.922Z] net/http.serverHandler.ServeHTTP({0x400015e2d0?}, {0xd69f38?, 0x40000f0000?}, 0x6?)
09:30:57 [2024-01-03T09:30:57.922Z] 	/usr/local/go/src/net/http/server.go:2938 +0xbc
09:30:57 [2024-01-03T09:30:57.922Z] net/http.(*conn).serve(0x4000112630, {0xd71558, 0x40001a0cf0})
09:30:57 [2024-01-03T09:30:57.922Z] 	/usr/local/go/src/net/http/server.go:2009 +0x518
09:30:57 [2024-01-03T09:30:57.922Z] created by net/http.(*Server).Serve in goroutine 37
09:30:57 [2024-01-03T09:30:57.922Z] 	/usr/local/go/src/net/http/server.go:3086 +0x4cc
09:31:00 [2024-01-03T09:31:00.434Z] 2024/01/03 09:30:59 http: panic serving 127.0.0.1:33796: could not unmarshal json for /AuthZPlugin.AuthZRes: unexpected end of JSON input
09:31:00 [2024-01-03T09:31:00.434Z] goroutine 134 [running]:
09:31:00 [2024-01-03T09:31:00.434Z] net/http.(*conn).serve.func1()
09:31:00 [2024-01-03T09:31:00.434Z] 	/usr/local/go/src/net/http/server.go:1868 +0xb0
09:31:00 [2024-01-03T09:31:00.434Z] panic({0xa0a160?, 0x400059e200?})
09:31:00 [2024-01-03T09:31:00.434Z] 	/usr/local/go/src/runtime/panic.go:920 +0x26c
09:31:00 [2024-01-03T09:31:00.434Z] github.com/docker/docker/integration/plugin/authz.setupSuite.func3({0xd6b378, 0x400043c2a0}, 0xffff5ea46fc8?)
09:31:00 [2024-01-03T09:31:00.434Z] 	/go/src/github.com/docker/docker/integration/plugin/authz/main_test.go:149 +0x360
09:31:00 [2024-01-03T09:31:00.434Z] net/http.HandlerFunc.ServeHTTP(0x4000270200?, {0xd6b378?, 0x400043c2a0?}, 0x402214?)
09:31:00 [2024-01-03T09:31:00.434Z] 	/usr/local/go/src/net/http/server.go:2136 +0x38
09:31:00 [2024-01-03T09:31:00.434Z] net/http.(*ServeMux).ServeHTTP(0xd71558?, {0xd6b378, 0x400043c2a0}, 0x4000270200)
09:31:00 [2024-01-03T09:31:00.434Z] 	/usr/local/go/src/net/http/server.go:2514 +0x144
09:31:00 [2024-01-03T09:31:00.434Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.(*middleware).serveHTTP(0x400020e0b0, {0xd69f38?, 0x40000f00e0}, 0x4000270100, {0xd603c0, 0x40003c62c0})
09:31:00 [2024-01-03T09:31:00.434Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:217 +0xf44
09:31:00 [2024-01-03T09:31:00.434Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.NewMiddleware.func1.1({0xd69f38?, 0x40000f00e0?}, 0x400015e300?)
09:31:00 [2024-01-03T09:31:00.434Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:81 +0x40
09:31:00 [2024-01-03T09:31:00.434Z] net/http.HandlerFunc.ServeHTTP(0x15e6f80?, {0xd69f38?, 0x40000f00e0?}, 0x40003d0b40?)
09:31:00 [2024-01-03T09:31:00.434Z] 	/usr/local/go/src/net/http/server.go:2136 +0x38
09:31:00 [2024-01-03T09:31:00.434Z] net/http.serverHandler.ServeHTTP({0x400015e300?}, {0xd69f38?, 0x40000f00e0?}, 0x6?)
09:31:00 [2024-01-03T09:31:00.434Z] 	/usr/local/go/src/net/http/server.go:2938 +0xbc
09:31:00 [2024-01-03T09:31:00.434Z] net/http.(*conn).serve(0x40003be1b0, {0xd71558, 0x40001a0cf0})
09:31:00 [2024-01-03T09:31:00.434Z] 	/usr/local/go/src/net/http/server.go:2009 +0x518
09:31:00 [2024-01-03T09:31:00.434Z] created by net/http.(*Server).Serve in goroutine 37
09:31:00 [2024-01-03T09:31:00.434Z] 	/usr/local/go/src/net/http/server.go:3086 +0x4cc
09:31:02 [2024-01-03T09:31:02.321Z] --- PASS: TestAuthZPluginAllowEventStream (6.09s)
09:31:02 [2024-01-03T09:31:02.321Z] === RUN   TestAuthZPluginErrorResponse
09:31:02 [2024-01-03T09:31:02.882Z] --- PASS: TestAuthZPluginErrorResponse (0.53s)
09:31:02 [2024-01-03T09:31:02.882Z] === RUN   TestAuthZPluginErrorRequest
09:31:03 [2024-01-03T09:31:03.443Z] --- PASS: TestAuthZPluginErrorRequest (0.53s)
09:31:03 [2024-01-03T09:31:03.443Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
09:31:04 [2024-01-03T09:31:04.004Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.53s)
09:31:04 [2024-01-03T09:31:04.004Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
09:31:04 [2024-01-03T09:31:04.930Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (1.13s)
09:31:04 [2024-01-03T09:31:04.930Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
09:31:06 [2024-01-03T09:31:06.295Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (1.42s)
09:31:06 [2024-01-03T09:31:06.295Z] === RUN   TestAuthZPluginHeader
09:31:06 [2024-01-03T09:31:06.856Z] --- PASS: TestAuthZPluginHeader (0.60s)
09:31:06 [2024-01-03T09:31:06.856Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
09:31:06 [2024-01-03T09:31:06.856Z]     authz_plugin_v2_test.go:40: (*Execution).NotAmd64-fm
09:31:06 [2024-01-03T09:31:06.856Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
09:31:06 [2024-01-03T09:31:06.856Z] === RUN   TestAuthZPluginV2Disable
09:31:06 [2024-01-03T09:31:06.856Z]     authz_plugin_v2_test.go:61: (*Execution).NotAmd64-fm
09:31:06 [2024-01-03T09:31:06.856Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
09:31:06 [2024-01-03T09:31:06.856Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
09:31:06 [2024-01-03T09:31:06.856Z]     authz_plugin_v2_test.go:87: (*Execution).NotAmd64-fm
09:31:06 [2024-01-03T09:31:06.856Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
09:31:06 [2024-01-03T09:31:06.856Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
09:31:06 [2024-01-03T09:31:06.856Z]     authz_plugin_v2_test.go:122: (*Execution).NotAmd64-fm
09:31:06 [2024-01-03T09:31:06.856Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
09:31:06 [2024-01-03T09:31:06.856Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
09:31:24 [2024-01-03T09:31:24.897Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.88s)
09:31:24 [2024-01-03T09:31:24.897Z] PASS
09:31:24 [2024-01-03T09:31:24.897Z] 
09:31:24 [2024-01-03T09:31:24.897Z] === Skipped
09:31:24 [2024-01-03T09:31:24.897Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
09:31:24 [2024-01-03T09:31:24.897Z]     authz_plugin_v2_test.go:40: (*Execution).NotAmd64-fm
09:31:24 [2024-01-03T09:31:24.897Z] 
09:31:24 [2024-01-03T09:31:24.897Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
09:31:24 [2024-01-03T09:31:24.897Z]     authz_plugin_v2_test.go:61: (*Execution).NotAmd64-fm
09:31:24 [2024-01-03T09:31:24.897Z] 
09:31:24 [2024-01-03T09:31:24.897Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
09:31:24 [2024-01-03T09:31:24.897Z]     authz_plugin_v2_test.go:87: (*Execution).NotAmd64-fm
09:31:24 [2024-01-03T09:31:24.897Z] 
09:31:24 [2024-01-03T09:31:24.897Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
09:31:24 [2024-01-03T09:31:24.897Z]     authz_plugin_v2_test.go:122: (*Execution).NotAmd64-fm
09:31:24 [2024-01-03T09:31:24.897Z] 
09:31:24 [2024-01-03T09:31:24.897Z] DONE 17 tests, 4 skipped in 30.940s
09:31:24 [2024-01-03T09:31:24.897Z] Running /go/src/github.com/docker/docker/integration/plugin/common (arm64.integration.plugin.common) flags=-test.v -test.timeout=120m  
09:31:24 [2024-01-03T09:31:24.897Z] ++ '[' -n '' ']'
09:31:24 [2024-01-03T09:31:24.897Z] ++ 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
09:31:24 [2024-01-03T09:31:24.897Z] ++ set -e
09:31:24 [2024-01-03T09:31:24.897Z] ++ '[' -n 0 ']'
09:31:24 [2024-01-03T09:31:24.897Z] ++ set -x
09:31:24 [2024-01-03T09:31:24.897Z] ++ 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.hBzUI38w6x/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
09:31:24 [2024-01-03T09:31:24.897Z] INFO: Testing against a local daemon
09:31:24 [2024-01-03T09:31:24.897Z] === RUN   TestPluginInvalidJSON
09:31:24 [2024-01-03T09:31:24.897Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set
09:31:24 [2024-01-03T09:31:24.897Z] === PAUSE TestPluginInvalidJSON/plugins/foobar/set
09:31:24 [2024-01-03T09:31:24.897Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade
09:31:24 [2024-01-03T09:31:24.897Z] === PAUSE TestPluginInvalidJSON/plugins/foobar/upgrade
09:31:24 [2024-01-03T09:31:24.897Z] === RUN   TestPluginInvalidJSON/plugins/pull
09:31:24 [2024-01-03T09:31:24.897Z] === PAUSE TestPluginInvalidJSON/plugins/pull
09:31:24 [2024-01-03T09:31:24.897Z] === CONT  TestPluginInvalidJSON/plugins/foobar/set
09:31:24 [2024-01-03T09:31:24.897Z] === CONT  TestPluginInvalidJSON/plugins/pull
09:31:24 [2024-01-03T09:31:24.897Z] === CONT  TestPluginInvalidJSON/plugins/foobar/upgrade
09:31:24 [2024-01-03T09:31:24.897Z] === RUN   TestPluginInvalidJSON/plugins/pull/invalid_content_type
09:31:24 [2024-01-03T09:31:24.897Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_content_type
09:31:24 [2024-01-03T09:31:24.897Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/invalid_content_type
09:31:24 [2024-01-03T09:31:24.897Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_JSON
09:31:24 [2024-01-03T09:31:24.897Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/invalid_JSON
09:31:24 [2024-01-03T09:31:24.897Z] === RUN   TestPluginInvalidJSON/plugins/pull/invalid_JSON
09:31:24 [2024-01-03T09:31:24.897Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/extra_content_after_JSON
09:31:24 [2024-01-03T09:31:24.897Z] === RUN   TestPluginInvalidJSON/plugins/pull/extra_content_after_JSON
09:31:24 [2024-01-03T09:31:24.897Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/extra_content_after_JSON
09:31:24 [2024-01-03T09:31:24.897Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/empty_body
09:31:24 [2024-01-03T09:31:24.897Z] === RUN   TestPluginInvalidJSON/plugins/pull/empty_body
09:31:24 [2024-01-03T09:31:24.897Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/empty_body
09:31:24 [2024-01-03T09:31:24.897Z] --- PASS: TestPluginInvalidJSON (0.01s)
09:31:24 [2024-01-03T09:31:24.897Z]     --- PASS: TestPluginInvalidJSON/plugins/pull (0.00s)
09:31:24 [2024-01-03T09:31:24.897Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/invalid_content_type (0.00s)
09:31:24 [2024-01-03T09:31:24.897Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/invalid_JSON (0.00s)
09:31:24 [2024-01-03T09:31:24.897Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/extra_content_after_JSON (0.00s)
09:31:24 [2024-01-03T09:31:24.897Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/empty_body (0.00s)
09:31:24 [2024-01-03T09:31:24.897Z]     --- PASS: TestPluginInvalidJSON/plugins/foobar/set (0.00s)
09:31:24 [2024-01-03T09:31:24.897Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/invalid_content_type (0.00s)
09:31:24 [2024-01-03T09:31:24.897Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/invalid_JSON (0.00s)
09:31:24 [2024-01-03T09:31:24.897Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/extra_content_after_JSON (0.00s)
09:31:24 [2024-01-03T09:31:24.897Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/empty_body (0.00s)
09:31:24 [2024-01-03T09:31:24.897Z]     --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade (0.00s)
09:31:24 [2024-01-03T09:31:24.897Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_content_type (0.00s)
09:31:24 [2024-01-03T09:31:24.897Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_JSON (0.00s)
09:31:24 [2024-01-03T09:31:24.897Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/extra_content_after_JSON (0.00s)
09:31:24 [2024-01-03T09:31:24.897Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/empty_body (0.00s)
09:31:24 [2024-01-03T09:31:24.897Z] === RUN   TestPluginInstall
09:31:24 [2024-01-03T09:31:24.897Z] === RUN   TestPluginInstall/no_auth
09:31:27 [2024-01-03T09:31:27.421Z] time="2024-01-03T09:31:27Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
09:31:27 [2024-01-03T09:31:27.421Z] time="2024-01-03T09:31:27Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:f7691ed022186f97d3d1cde94bb3dd82af0e78b9378b0a30002898dadfb4ccb6" mediatype=application/vnd.docker.plugin.v1+json size=522
09:31:27 [2024-01-03T09:31:27.421Z] time="2024-01-03T09:31:27Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
09:31:27 [2024-01-03T09:31:27.421Z] time="2024-01-03T09:31:27Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:f7691ed022186f97d3d1cde94bb3dd82af0e78b9378b0a30002898dadfb4ccb6" mediatype=application/vnd.docker.plugin.v1+json size=522
09:31:27 [2024-01-03T09:31:27.687Z] === RUN   TestPluginInstall/with_htpasswd
09:31:27 [2024-01-03T09:31:27.965Z] time="2024-01-03T09:31:27Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
09:31:27 [2024-01-03T09:31:27.965Z] time="2024-01-03T09:31:27Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:67f54aab99e31ef3b3937eb88fbae2109d67fa419cea9fc9d1b431317bf59cae" mediatype=application/vnd.docker.plugin.v1+json size=522
09:31:27 [2024-01-03T09:31:27.965Z] time="2024-01-03T09:31:27Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
09:31:27 [2024-01-03T09:31:27.965Z] time="2024-01-03T09:31:27Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:67f54aab99e31ef3b3937eb88fbae2109d67fa419cea9fc9d1b431317bf59cae" mediatype=application/vnd.docker.plugin.v1+json size=522
09:31:27 [2024-01-03T09:31:27.965Z] === RUN   TestPluginInstall/with_insecure
09:31:28 [2024-01-03T09:31:28.923Z] time="2024-01-03T09:31:28Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
09:31:28 [2024-01-03T09:31:28.923Z] time="2024-01-03T09:31:28Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:ddfd3b34cabc627cb4a083fb2069b72f12663c420c5b948c479bb8663595fc7e" mediatype=application/vnd.docker.plugin.v1+json size=522
09:31:28 [2024-01-03T09:31:28.923Z] time="2024-01-03T09:31:28Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
09:31:28 [2024-01-03T09:31:28.923Z] time="2024-01-03T09:31:28Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:ddfd3b34cabc627cb4a083fb2069b72f12663c420c5b948c479bb8663595fc7e" mediatype=application/vnd.docker.plugin.v1+json size=522
09:31:28 [2024-01-03T09:31:28.923Z]     plugin_test.go:204: [da6df8f63e8cf] daemon is not started
09:31:28 [2024-01-03T09:31:28.923Z] --- PASS: TestPluginInstall (5.07s)
09:31:28 [2024-01-03T09:31:28.923Z]     --- PASS: TestPluginInstall/no_auth (3.70s)
09:31:28 [2024-01-03T09:31:28.923Z]     --- PASS: TestPluginInstall/with_htpasswd (0.45s)
09:31:28 [2024-01-03T09:31:28.923Z]     --- PASS: TestPluginInstall/with_insecure (0.92s)
09:31:28 [2024-01-03T09:31:28.923Z] === RUN   TestPluginsWithRuntimes
09:31:30 [2024-01-03T09:31:30.863Z] === RUN   TestPluginsWithRuntimes/No_Args
09:31:31 [2024-01-03T09:31:31.438Z] === RUN   TestPluginsWithRuntimes/With_Args
09:31:32 [2024-01-03T09:31:32.388Z] --- PASS: TestPluginsWithRuntimes (3.41s)
09:31:32 [2024-01-03T09:31:32.388Z]     --- PASS: TestPluginsWithRuntimes/No_Args (0.92s)
09:31:32 [2024-01-03T09:31:32.388Z]     --- PASS: TestPluginsWithRuntimes/With_Args (0.91s)
09:31:32 [2024-01-03T09:31:32.388Z] === RUN   TestPluginBackCompatMediaTypes
09:31:32 [2024-01-03T09:31:32.968Z] --- PASS: TestPluginBackCompatMediaTypes (0.49s)
09:31:32 [2024-01-03T09:31:32.968Z] PASS
09:31:32 [2024-01-03T09:31:32.968Z] 
09:31:32 [2024-01-03T09:31:32.968Z] DONE 24 tests in 9.021s
09:31:32 [2024-01-03T09:31:32.968Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (arm64.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m  
09:31:32 [2024-01-03T09:31:32.968Z] ++ '[' -n '' ']'
09:31:32 [2024-01-03T09:31:32.968Z] ++ 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
09:31:32 [2024-01-03T09:31:32.968Z] ++ set -e
09:31:32 [2024-01-03T09:31:32.968Z] ++ '[' -n 0 ']'
09:31:32 [2024-01-03T09:31:32.968Z] ++ set -x
09:31:32 [2024-01-03T09:31:32.968Z] ++ 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.hBzUI38w6x/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
09:31:32 [2024-01-03T09:31:32.968Z] INFO: Testing against a local daemon
09:31:32 [2024-01-03T09:31:32.968Z] === RUN   TestExternalGraphDriver
09:31:33 [2024-01-03T09:31:33.231Z] === RUN   TestExternalGraphDriver/json
09:31:33 [2024-01-03T09:31:33.231Z] === RUN   TestExternalGraphDriver/spec
09:31:33 [2024-01-03T09:31:33.231Z] === RUN   TestExternalGraphDriver/pull
09:31:33 [2024-01-03T09:31:33.231Z] --- PASS: TestExternalGraphDriver (0.34s)
09:31:33 [2024-01-03T09:31:33.231Z]     --- PASS: TestExternalGraphDriver/json (0.00s)
09:31:33 [2024-01-03T09:31:33.231Z]     --- PASS: TestExternalGraphDriver/spec (0.00s)
09:31:33 [2024-01-03T09:31:33.231Z]     --- PASS: TestExternalGraphDriver/pull (0.00s)
09:31:33 [2024-01-03T09:31:33.231Z] === RUN   TestGraphdriverPluginV2
09:31:33 [2024-01-03T09:31:33.493Z]     external_test.go:415: (*Execution).NotAmd64-fm
09:31:33 [2024-01-03T09:31:33.493Z] --- SKIP: TestGraphdriverPluginV2 (0.32s)
09:31:33 [2024-01-03T09:31:33.493Z] PASS
09:31:33 [2024-01-03T09:31:33.493Z] 
09:31:33 [2024-01-03T09:31:33.493Z] === Skipped
09:31:33 [2024-01-03T09:31:33.493Z] === SKIP: arm64.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.32s)
09:31:33 [2024-01-03T09:31:33.493Z]     external_test.go:415: (*Execution).NotAmd64-fm
09:31:33 [2024-01-03T09:31:33.493Z] 
09:31:33 [2024-01-03T09:31:33.493Z] DONE 5 tests, 1 skipped in 0.696s
09:31:33 [2024-01-03T09:31:33.493Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (arm64.integration.plugin.logging) flags=-test.v -test.timeout=120m  
09:31:33 [2024-01-03T09:31:33.493Z] ++ '[' -n '' ']'
09:31:33 [2024-01-03T09:31:33.493Z] ++ 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
09:31:33 [2024-01-03T09:31:33.755Z] ++ set -e
09:31:33 [2024-01-03T09:31:33.755Z] ++ '[' -n 0 ']'
09:31:33 [2024-01-03T09:31:33.755Z] ++ set -x
09:31:33 [2024-01-03T09:31:33.755Z] ++ 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.hBzUI38w6x/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
09:31:33 [2024-01-03T09:31:33.755Z] INFO: Testing against a local daemon
09:31:33 [2024-01-03T09:31:33.755Z] === RUN   TestContinueAfterPluginCrash
09:31:33 [2024-01-03T09:31:33.755Z] === PAUSE TestContinueAfterPluginCrash
09:31:33 [2024-01-03T09:31:33.755Z] === RUN   TestReadPluginNoRead
09:31:33 [2024-01-03T09:31:33.755Z] === PAUSE TestReadPluginNoRead
09:31:33 [2024-01-03T09:31:33.755Z] === RUN   TestDaemonStartWithLogOpt
09:31:33 [2024-01-03T09:31:33.755Z] === PAUSE TestDaemonStartWithLogOpt
09:31:33 [2024-01-03T09:31:33.755Z] === CONT  TestDaemonStartWithLogOpt
09:31:33 [2024-01-03T09:31:33.755Z] === CONT  TestReadPluginNoRead
09:31:33 [2024-01-03T09:31:33.755Z] === CONT  TestContinueAfterPluginCrash
09:31:35 [2024-01-03T09:31:35.691Z] === RUN   TestReadPluginNoRead/default
09:31:36 [2024-01-03T09:31:36.257Z] --- PASS: TestDaemonStartWithLogOpt (2.65s)
09:31:37 [2024-01-03T09:31:37.185Z] === RUN   TestReadPluginNoRead/disabled_caching
09:31:38 [2024-01-03T09:31:38.549Z] === RUN   TestReadPluginNoRead/explicitly_enabled_caching
09:31:39 [2024-01-03T09:31:39.475Z]     read_test.go:93: [d508cf5d42db0] daemon is not started
09:31:39 [2024-01-03T09:31:39.475Z] --- PASS: TestReadPluginNoRead (5.87s)
09:31:39 [2024-01-03T09:31:39.475Z]     --- PASS: TestReadPluginNoRead/default (1.27s)
09:31:39 [2024-01-03T09:31:39.475Z]     --- PASS: TestReadPluginNoRead/disabled_caching (1.24s)
09:31:39 [2024-01-03T09:31:39.475Z]     --- PASS: TestReadPluginNoRead/explicitly_enabled_caching (1.21s)
09:31:41 [2024-01-03T09:31:41.362Z] --- PASS: TestContinueAfterPluginCrash (7.59s)
09:31:41 [2024-01-03T09:31:41.362Z] PASS
09:31:41 [2024-01-03T09:31:41.362Z] 
09:31:41 [2024-01-03T09:31:41.362Z] DONE 6 tests in 7.629s
09:31:41 [2024-01-03T09:31:41.362Z] Running /go/src/github.com/docker/docker/integration/plugin/logging/cmd/discard (arm64.integration.plugin.logging.cmd.discard) flags=-test.v -test.timeout=120m  
09:31:41 [2024-01-03T09:31:41.362Z] ++ '[' -n '' ']'
09:31:41 [2024-01-03T09:31:41.362Z] ++ 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
09:31:41 [2024-01-03T09:31:41.362Z] ++ set -e
09:31:41 [2024-01-03T09:31:41.362Z] ++ '[' -n 0 ']'
09:31:41 [2024-01-03T09:31:41.362Z] ++ set -x
09:31:41 [2024-01-03T09:31:41.362Z] ++ 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.hBzUI38w6x/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
09:31:41 [2024-01-03T09:31:41.362Z] testing: warning: no tests to run
09:31:41 [2024-01-03T09:31:41.362Z] PASS
09:31:41 [2024-01-03T09:31:41.362Z] 
09:31:41 [2024-01-03T09:31:41.362Z] DONE 0 tests in 0.007s
09:31:41 [2024-01-03T09:31:41.362Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (arm64.integration.plugin.volumes) flags=-test.v -test.timeout=120m  
09:31:41 [2024-01-03T09:31:41.362Z] ++ '[' -n '' ']'
09:31:41 [2024-01-03T09:31:41.362Z] ++ 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
09:31:41 [2024-01-03T09:31:41.362Z] ++ set -e
09:31:41 [2024-01-03T09:31:41.362Z] ++ '[' -n 0 ']'
09:31:41 [2024-01-03T09:31:41.362Z] ++ set -x
09:31:41 [2024-01-03T09:31:41.362Z] ++ 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.hBzUI38w6x/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
09:31:41 [2024-01-03T09:31:41.362Z] INFO: Testing against a local daemon
09:31:41 [2024-01-03T09:31:41.362Z] === RUN   TestPluginWithDevMounts
09:31:41 [2024-01-03T09:31:41.362Z] === PAUSE TestPluginWithDevMounts
09:31:41 [2024-01-03T09:31:41.362Z] === CONT  TestPluginWithDevMounts
09:31:42 [2024-01-03T09:31:42.726Z] --- PASS: TestPluginWithDevMounts (1.49s)
09:31:42 [2024-01-03T09:31:42.726Z] PASS
09:31:42 [2024-01-03T09:31:42.726Z] 
09:31:42 [2024-01-03T09:31:42.726Z] DONE 1 tests in 1.523s
09:31:42 [2024-01-03T09:31:42.726Z] Running /go/src/github.com/docker/docker/integration/secret (arm64.integration.secret) flags=-test.v -test.timeout=120m  
09:31:42 [2024-01-03T09:31:42.726Z] ++ '[' -n '' ']'
09:31:42 [2024-01-03T09:31:42.726Z] ++ 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
09:31:42 [2024-01-03T09:31:42.726Z] ++ set -e
09:31:42 [2024-01-03T09:31:42.726Z] ++ '[' -n 0 ']'
09:31:42 [2024-01-03T09:31:42.726Z] ++ set -x
09:31:42 [2024-01-03T09:31:42.727Z] ++ 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.hBzUI38w6x/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
09:31:42 [2024-01-03T09:31:42.982Z] INFO: Testing against a local daemon
09:31:42 [2024-01-03T09:31:42.982Z] === RUN   TestSecretInspect
09:31:44 [2024-01-03T09:31:44.869Z] --- PASS: TestSecretInspect (2.03s)
09:31:44 [2024-01-03T09:31:44.869Z] === RUN   TestSecretList
09:31:46 [2024-01-03T09:31:46.757Z] --- PASS: TestSecretList (1.93s)
09:31:46 [2024-01-03T09:31:46.757Z] === RUN   TestSecretsCreateAndDelete
09:31:48 [2024-01-03T09:31:48.645Z] --- PASS: TestSecretsCreateAndDelete (1.89s)
09:31:48 [2024-01-03T09:31:48.645Z] === RUN   TestSecretsUpdate
09:31:51 [2024-01-03T09:31:51.159Z] --- PASS: TestSecretsUpdate (1.98s)
09:31:51 [2024-01-03T09:31:51.159Z] === RUN   TestTemplatedSecret
09:31:53 [2024-01-03T09:31:53.673Z] --- PASS: TestTemplatedSecret (2.76s)
09:31:53 [2024-01-03T09:31:53.673Z] === RUN   TestSecretCreateResolve
09:31:55 [2024-01-03T09:31:55.560Z] --- PASS: TestSecretCreateResolve (2.00s)
09:31:55 [2024-01-03T09:31:55.560Z] PASS
09:31:55 [2024-01-03T09:31:55.560Z] 
09:31:55 [2024-01-03T09:31:55.560Z] DONE 6 tests in 12.640s
09:31:55 [2024-01-03T09:31:55.560Z] Running /go/src/github.com/docker/docker/integration/service (arm64.integration.service) flags=-test.v -test.timeout=120m  
09:31:55 [2024-01-03T09:31:55.560Z] ++ '[' -n '' ']'
09:31:55 [2024-01-03T09:31:55.560Z] ++ 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
09:31:55 [2024-01-03T09:31:55.560Z] ++ set -e
09:31:55 [2024-01-03T09:31:55.560Z] ++ '[' -n 0 ']'
09:31:55 [2024-01-03T09:31:55.560Z] ++ set -x
09:31:55 [2024-01-03T09:31:55.560Z] ++ 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.hBzUI38w6x/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
09:31:55 [2024-01-03T09:31:55.560Z] INFO: Testing against a local daemon
09:31:55 [2024-01-03T09:31:55.560Z] === RUN   TestServiceCreateInit
09:31:55 [2024-01-03T09:31:55.560Z] === RUN   TestServiceCreateInit/daemonInitDisabled
09:31:58 [2024-01-03T09:31:58.824Z] === RUN   TestServiceCreateInit/daemonInitEnabled
09:32:02 [2024-01-03T09:32:02.988Z] --- PASS: TestServiceCreateInit (7.09s)
09:32:02 [2024-01-03T09:32:02.988Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (3.28s)
09:32:02 [2024-01-03T09:32:02.988Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (3.80s)
09:32:02 [2024-01-03T09:32:02.988Z] === RUN   TestCreateServiceMultipleTimes
09:32:17 [2024-01-03T09:32:17.821Z] --- PASS: TestCreateServiceMultipleTimes (15.04s)
09:32:17 [2024-01-03T09:32:17.821Z] === RUN   TestCreateServiceConflict
09:32:19 [2024-01-03T09:32:19.708Z] --- PASS: TestCreateServiceConflict (1.92s)
09:32:19 [2024-01-03T09:32:19.708Z] === RUN   TestCreateServiceMaxReplicas
09:32:22 [2024-01-03T09:32:22.972Z] --- PASS: TestCreateServiceMaxReplicas (2.81s)
09:32:22 [2024-01-03T09:32:22.972Z] === RUN   TestCreateServiceSecretFileMode
09:32:35 [2024-01-03T09:32:35.134Z] --- PASS: TestCreateServiceSecretFileMode (12.64s)
09:32:35 [2024-01-03T09:32:35.134Z] === RUN   TestCreateServiceConfigFileMode
09:32:49 [2024-01-03T09:32:49.966Z] --- PASS: TestCreateServiceConfigFileMode (12.52s)
09:32:49 [2024-01-03T09:32:49.966Z] === RUN   TestCreateServiceSysctls
09:32:50 [2024-01-03T09:32:50.892Z] --- PASS: TestCreateServiceSysctls (3.25s)
09:32:50 [2024-01-03T09:32:50.892Z] === RUN   TestCreateServiceCapabilities
09:32:54 [2024-01-03T09:32:54.155Z] --- PASS: TestCreateServiceCapabilities (2.76s)
09:32:54 [2024-01-03T09:32:54.155Z] === RUN   TestInspect
09:32:56 [2024-01-03T09:32:56.668Z] --- PASS: TestInspect (2.91s)
09:32:56 [2024-01-03T09:32:56.668Z] === RUN   TestCreateJob
09:32:59 [2024-01-03T09:32:59.183Z] --- PASS: TestCreateJob (2.78s)
09:32:59 [2024-01-03T09:32:59.183Z] === RUN   TestReplicatedJob
09:33:04 [2024-01-03T09:33:04.424Z] --- PASS: TestReplicatedJob (4.94s)
09:33:04 [2024-01-03T09:33:04.424Z] === RUN   TestUpdateReplicatedJob
09:33:07 [2024-01-03T09:33:07.689Z] --- PASS: TestUpdateReplicatedJob (3.30s)
09:33:07 [2024-01-03T09:33:07.689Z] === RUN   TestServiceListWithStatuses
09:33:12 [2024-01-03T09:33:12.930Z] --- PASS: TestServiceListWithStatuses (4.71s)
09:33:12 [2024-01-03T09:33:12.930Z] === RUN   TestDockerNetworkConnectAliasPreV144
09:33:16 [2024-01-03T09:33:16.194Z] --- PASS: TestDockerNetworkConnectAliasPreV144 (3.94s)
09:33:16 [2024-01-03T09:33:16.194Z] === RUN   TestDockerNetworkReConnect
09:33:19 [2024-01-03T09:33:19.459Z] --- PASS: TestDockerNetworkReConnect (3.16s)
09:33:19 [2024-01-03T09:33:19.459Z] === RUN   TestServicePlugin
09:33:19 [2024-01-03T09:33:19.459Z]     plugin_test.go:25: (*Execution).NotAmd64-fm
09:33:19 [2024-01-03T09:33:19.459Z] --- SKIP: TestServicePlugin (0.00s)
09:33:19 [2024-01-03T09:33:19.459Z] === RUN   TestServiceUpdateLabel
09:33:21 [2024-01-03T09:33:21.346Z] --- PASS: TestServiceUpdateLabel (1.99s)
09:33:21 [2024-01-03T09:33:21.346Z] === RUN   TestServiceUpdateSecrets
09:33:36 [2024-01-03T09:33:36.180Z] --- PASS: TestServiceUpdateSecrets (14.31s)
09:33:36 [2024-01-03T09:33:36.181Z] === RUN   TestServiceUpdateConfigs
09:33:51 [2024-01-03T09:33:51.014Z] --- PASS: TestServiceUpdateConfigs (14.45s)
09:33:51 [2024-01-03T09:33:51.014Z] === RUN   TestServiceUpdateNetwork
09:34:03 [2024-01-03T09:34:03.177Z] --- PASS: TestServiceUpdateNetwork (12.16s)
09:34:03 [2024-01-03T09:34:03.177Z] === RUN   TestServiceUpdatePidsLimit
09:34:03 [2024-01-03T09:34:03.433Z] === RUN   TestServiceUpdatePidsLimit/create_service_with_PidsLimit_300
09:34:04 [2024-01-03T09:34:04.359Z] === RUN   TestServiceUpdatePidsLimit/unset_PidsLimit_to_0
09:34:10 [2024-01-03T09:34:10.891Z] === RUN   TestServiceUpdatePidsLimit/update_PidsLimit_to_100
09:34:18 [2024-01-03T09:34:18.970Z] --- PASS: TestServiceUpdatePidsLimit (16.37s)
09:34:18 [2024-01-03T09:34:18.970Z]     --- PASS: TestServiceUpdatePidsLimit/create_service_with_PidsLimit_300 (0.72s)
09:34:18 [2024-01-03T09:34:18.970Z]     --- PASS: TestServiceUpdatePidsLimit/unset_PidsLimit_to_0 (6.88s)
09:34:18 [2024-01-03T09:34:18.970Z]     --- PASS: TestServiceUpdatePidsLimit/update_PidsLimit_to_100 (6.88s)
09:34:18 [2024-01-03T09:34:18.970Z] PASS
09:34:18 [2024-01-03T09:34:18.970Z] 
09:34:18 [2024-01-03T09:34:18.970Z] === Skipped
09:34:18 [2024-01-03T09:34:18.970Z] === SKIP: arm64.integration.service TestServicePlugin (0.00s)
09:34:18 [2024-01-03T09:34:18.970Z]     plugin_test.go:25: (*Execution).NotAmd64-fm
09:34:18 [2024-01-03T09:34:18.970Z] 
09:34:18 [2024-01-03T09:34:18.970Z] DONE 26 tests, 1 skipped in 143.068s
09:34:18 [2024-01-03T09:34:18.970Z] Running /go/src/github.com/docker/docker/integration/session (arm64.integration.session) flags=-test.v -test.timeout=120m  
09:34:18 [2024-01-03T09:34:18.970Z] ++ '[' -n '' ']'
09:34:18 [2024-01-03T09:34:18.970Z] ++ 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
09:34:18 [2024-01-03T09:34:18.970Z] ++ set -e
09:34:18 [2024-01-03T09:34:18.970Z] ++ '[' -n 0 ']'
09:34:18 [2024-01-03T09:34:18.970Z] ++ set -x
09:34:18 [2024-01-03T09:34:18.970Z] ++ 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.hBzUI38w6x/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
09:34:18 [2024-01-03T09:34:18.970Z] INFO: Testing against a local daemon
09:34:18 [2024-01-03T09:34:18.970Z] === RUN   TestSessionCreate
09:34:18 [2024-01-03T09:34:18.970Z] --- PASS: TestSessionCreate (0.01s)
09:34:18 [2024-01-03T09:34:18.970Z] === RUN   TestSessionCreateWithBadUpgrade
09:34:18 [2024-01-03T09:34:18.970Z] --- PASS: TestSessionCreateWithBadUpgrade (0.01s)
09:34:18 [2024-01-03T09:34:18.970Z] PASS
09:34:18 [2024-01-03T09:34:18.970Z] 
09:34:18 [2024-01-03T09:34:18.970Z] DONE 2 tests in 0.047s
09:34:18 [2024-01-03T09:34:18.970Z] Running /go/src/github.com/docker/docker/integration/system (arm64.integration.system) flags=-test.v -test.timeout=120m  
09:34:18 [2024-01-03T09:34:18.970Z] ++ '[' -n '' ']'
09:34:18 [2024-01-03T09:34:18.970Z] ++ 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
09:34:18 [2024-01-03T09:34:18.970Z] ++ set -e
09:34:18 [2024-01-03T09:34:18.970Z] ++ '[' -n 0 ']'
09:34:18 [2024-01-03T09:34:18.970Z] ++ set -x
09:34:18 [2024-01-03T09:34:18.970Z] ++ 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.hBzUI38w6x/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
09:34:18 [2024-01-03T09:34:18.970Z] INFO: Testing against a local daemon
09:34:18 [2024-01-03T09:34:18.970Z] === RUN   TestCgroupDriverSystemdMemoryLimit
09:34:18 [2024-01-03T09:34:18.970Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
09:34:18 [2024-01-03T09:34:18.970Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
09:34:18 [2024-01-03T09:34:18.970Z] === RUN   TestDiskUsage
09:34:18 [2024-01-03T09:34:18.970Z] === PAUSE TestDiskUsage
09:34:18 [2024-01-03T09:34:18.970Z] === RUN   TestEventsExecDie
09:34:19 [2024-01-03T09:34:19.226Z] --- PASS: TestEventsExecDie (0.57s)
09:34:19 [2024-01-03T09:34:19.226Z] === RUN   TestEventsBackwardsCompatible
09:34:19 [2024-01-03T09:34:19.226Z] --- PASS: TestEventsBackwardsCompatible (0.06s)
09:34:19 [2024-01-03T09:34:19.226Z] === RUN   TestEventsVolumeCreate
09:34:19 [2024-01-03T09:34:19.226Z] --- PASS: TestEventsVolumeCreate (0.06s)
09:34:19 [2024-01-03T09:34:19.226Z] === RUN   TestInfoBinaryCommits
09:34:19 [2024-01-03T09:34:19.481Z] --- PASS: TestInfoBinaryCommits (0.01s)
09:34:19 [2024-01-03T09:34:19.481Z] === RUN   TestInfoAPIVersioned
09:34:19 [2024-01-03T09:34:19.481Z] --- PASS: TestInfoAPIVersioned (0.01s)
09:34:19 [2024-01-03T09:34:19.481Z] === RUN   TestInfoAPI
09:34:19 [2024-01-03T09:34:19.481Z] --- PASS: TestInfoAPI (0.01s)
09:34:19 [2024-01-03T09:34:19.481Z] === RUN   TestInfoAPIWarnings
09:34:37 [2024-01-03T09:34:37.516Z] --- PASS: TestInfoAPIWarnings (16.55s)
09:34:37 [2024-01-03T09:34:37.516Z] === RUN   TestInfoDebug
09:34:37 [2024-01-03T09:34:37.516Z] --- PASS: TestInfoDebug (0.52s)
09:34:37 [2024-01-03T09:34:37.516Z] === RUN   TestInfoInsecureRegistries
09:34:37 [2024-01-03T09:34:37.516Z] --- PASS: TestInfoInsecureRegistries (0.52s)
09:34:37 [2024-01-03T09:34:37.516Z] === RUN   TestInfoRegistryMirrors
09:34:37 [2024-01-03T09:34:37.516Z] --- PASS: TestInfoRegistryMirrors (0.52s)
09:34:37 [2024-01-03T09:34:37.516Z] === RUN   TestLoginFailsWithBadCredentials
09:34:38 [2024-01-03T09:34:38.442Z] --- PASS: TestLoginFailsWithBadCredentials (0.97s)
09:34:38 [2024-01-03T09:34:38.442Z] === RUN   TestPingCacheHeaders
09:34:38 [2024-01-03T09:34:38.442Z] --- PASS: TestPingCacheHeaders (0.01s)
09:34:38 [2024-01-03T09:34:38.442Z] === RUN   TestPingGet
09:34:38 [2024-01-03T09:34:38.442Z] --- PASS: TestPingGet (0.01s)
09:34:38 [2024-01-03T09:34:38.442Z] === RUN   TestPingHead
09:34:38 [2024-01-03T09:34:38.442Z] --- PASS: TestPingHead (0.01s)
09:34:38 [2024-01-03T09:34:38.442Z] === RUN   TestPingSwarmHeader
09:34:39 [2024-01-03T09:34:39.003Z] === RUN   TestPingSwarmHeader/before_swarm_init
09:34:39 [2024-01-03T09:34:39.563Z] === RUN   TestPingSwarmHeader/after_swarm_init
09:34:40 [2024-01-03T09:34:40.489Z] === RUN   TestPingSwarmHeader/after_swarm_leave
09:34:40 [2024-01-03T09:34:40.489Z] --- PASS: TestPingSwarmHeader (2.03s)
09:34:40 [2024-01-03T09:34:40.489Z]     --- PASS: TestPingSwarmHeader/before_swarm_init (0.00s)
09:34:40 [2024-01-03T09:34:40.489Z]     --- PASS: TestPingSwarmHeader/after_swarm_init (0.00s)
09:34:40 [2024-01-03T09:34:40.489Z]     --- PASS: TestPingSwarmHeader/after_swarm_leave (0.00s)
09:34:40 [2024-01-03T09:34:40.489Z] === RUN   TestPingBuilderHeader
09:34:40 [2024-01-03T09:34:40.489Z] === RUN   TestPingBuilderHeader/default_config
09:34:41 [2024-01-03T09:34:41.050Z] === RUN   TestPingBuilderHeader/buildkit_disabled
09:34:41 [2024-01-03T09:34:41.611Z] --- PASS: TestPingBuilderHeader (1.04s)
09:34:41 [2024-01-03T09:34:41.611Z]     --- PASS: TestPingBuilderHeader/default_config (0.52s)
09:34:41 [2024-01-03T09:34:41.611Z]     --- PASS: TestPingBuilderHeader/buildkit_disabled (0.52s)
09:34:41 [2024-01-03T09:34:41.611Z] === RUN   TestVersion
09:34:41 [2024-01-03T09:34:41.611Z] --- PASS: TestVersion (0.01s)
09:34:41 [2024-01-03T09:34:41.611Z] === CONT  TestDiskUsage
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/empty
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/empty/container_types
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/empty/image_types
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/empty/volume_types
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/empty/build-cache_types
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/empty/container,_volume_types
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/empty/image,_build-cache_types
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/empty/container,_volume,_build-cache_types
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/empty/image,_volume,_build-cache_types
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/empty/container,_image,_volume_types
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/empty/container,_image,_volume,_build-cache_types
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/after_LoadBusybox
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/after_LoadBusybox/container_types
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/after_LoadBusybox/image_types
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/after_LoadBusybox/volume_types
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/after_LoadBusybox/build-cache_types
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/after_LoadBusybox/container,_volume_types
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/after_LoadBusybox/image,_build-cache_types
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/after_LoadBusybox/container,_volume,_build-cache_types
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/after_LoadBusybox/image,_volume,_build-cache_types
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/after_LoadBusybox/container,_image,_volume_types
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/after_LoadBusybox/container,_image,_volume,_build-cache_types
09:34:42 [2024-01-03T09:34:42.172Z] === RUN   TestDiskUsage/after_container.Run
09:34:42 [2024-01-03T09:34:42.427Z] === RUN   TestDiskUsage/after_container.Run/container_types
09:34:42 [2024-01-03T09:34:42.427Z] === RUN   TestDiskUsage/after_container.Run/image_types
09:34:42 [2024-01-03T09:34:42.427Z] === RUN   TestDiskUsage/after_container.Run/volume_types
09:34:42 [2024-01-03T09:34:42.427Z] === RUN   TestDiskUsage/after_container.Run/build-cache_types
09:34:42 [2024-01-03T09:34:42.427Z] === RUN   TestDiskUsage/after_container.Run/container,_volume_types
09:34:42 [2024-01-03T09:34:42.427Z] === RUN   TestDiskUsage/after_container.Run/image,_build-cache_types
09:34:42 [2024-01-03T09:34:42.427Z] === RUN   TestDiskUsage/after_container.Run/container,_volume,_build-cache_types
09:34:42 [2024-01-03T09:34:42.427Z] === RUN   TestDiskUsage/after_container.Run/image,_volume,_build-cache_types
09:34:42 [2024-01-03T09:34:42.427Z] === RUN   TestDiskUsage/after_container.Run/container,_image,_volume_types
09:34:42 [2024-01-03T09:34:42.427Z] === RUN   TestDiskUsage/after_container.Run/container,_image,_volume,_build-cache_types
09:34:42 [2024-01-03T09:34:42.682Z] --- PASS: TestDiskUsage (1.11s)
09:34:42 [2024-01-03T09:34:42.682Z]     --- PASS: TestDiskUsage/empty (0.01s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/empty/container_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/empty/image_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/empty/volume_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/empty/build-cache_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/empty/container,_volume_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/empty/image,_build-cache_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/empty/container,_volume,_build-cache_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/empty/image,_volume,_build-cache_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/empty/container,_image,_volume_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/empty/container,_image,_volume,_build-cache_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]     --- PASS: TestDiskUsage/after_LoadBusybox (0.08s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/after_LoadBusybox/image_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/after_LoadBusybox/volume_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/after_LoadBusybox/build-cache_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container,_volume_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/after_LoadBusybox/image,_build-cache_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container,_volume,_build-cache_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/after_LoadBusybox/image,_volume,_build-cache_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container,_image,_volume_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container,_image,_volume,_build-cache_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]     --- PASS: TestDiskUsage/after_container.Run (0.31s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/after_container.Run/container_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/after_container.Run/image_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/after_container.Run/volume_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/after_container.Run/build-cache_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/after_container.Run/container,_volume_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/after_container.Run/image,_build-cache_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/after_container.Run/container,_volume,_build-cache_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/after_container.Run/image,_volume,_build-cache_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/after_container.Run/container,_image,_volume_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]         --- PASS: TestDiskUsage/after_container.Run/container,_image,_volume,_build-cache_types (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z] PASS
09:34:42 [2024-01-03T09:34:42.682Z] 
09:34:42 [2024-01-03T09:34:42.682Z] === Skipped
09:34:42 [2024-01-03T09:34:42.682Z] === SKIP: arm64.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
09:34:42 [2024-01-03T09:34:42.682Z] 
09:34:42 [2024-01-03T09:34:42.682Z] DONE 57 tests, 1 skipped in 24.063s
09:34:42 [2024-01-03T09:34:42.682Z] Running /go/src/github.com/docker/docker/integration/volume (arm64.integration.volume) flags=-test.v -test.timeout=120m  
09:34:42 [2024-01-03T09:34:42.682Z] ++ '[' -n '' ']'
09:34:42 [2024-01-03T09:34:42.682Z] ++ 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
09:34:42 [2024-01-03T09:34:42.682Z] ++ set -e
09:34:42 [2024-01-03T09:34:42.682Z] ++ '[' -n 0 ']'
09:34:42 [2024-01-03T09:34:42.682Z] ++ set -x
09:34:42 [2024-01-03T09:34:42.682Z] ++ 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.hBzUI38w6x/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
09:34:42 [2024-01-03T09:34:42.682Z] INFO: Testing against a local daemon
09:34:42 [2024-01-03T09:34:42.682Z] === RUN   TestVolumesCreateAndList
09:34:42 [2024-01-03T09:34:42.682Z] --- PASS: TestVolumesCreateAndList (0.01s)
09:34:42 [2024-01-03T09:34:42.682Z] === RUN   TestVolumesRemove
09:34:42 [2024-01-03T09:34:42.682Z] === RUN   TestVolumesRemove/volume_in_use
09:34:42 [2024-01-03T09:34:42.682Z] === RUN   TestVolumesRemove/volume_not_in_use
09:34:42 [2024-01-03T09:34:42.682Z] === RUN   TestVolumesRemove/non-existing_volume
09:34:42 [2024-01-03T09:34:42.682Z] === RUN   TestVolumesRemove/non-existing_volume_force
09:34:42 [2024-01-03T09:34:42.682Z] --- PASS: TestVolumesRemove (0.05s)
09:34:42 [2024-01-03T09:34:42.682Z]     --- PASS: TestVolumesRemove/volume_in_use (0.00s)
09:34:42 [2024-01-03T09:34:42.682Z]     --- PASS: TestVolumesRemove/volume_not_in_use (0.01s)
09:34:42 [2024-01-03T09:34:42.682Z]     --- PASS: TestVolumesRemove/non-existing_volume (0.00s)
09:34:42 [2024-01-03T09:34:42.683Z]     --- PASS: TestVolumesRemove/non-existing_volume_force (0.00s)
09:34:42 [2024-01-03T09:34:42.683Z] === RUN   TestVolumesRemoveSwarmEnabled
09:34:42 [2024-01-03T09:34:42.683Z] === PAUSE TestVolumesRemoveSwarmEnabled
09:34:42 [2024-01-03T09:34:42.683Z] === RUN   TestVolumesInspect
09:34:42 [2024-01-03T09:34:42.683Z] --- PASS: TestVolumesInspect (0.01s)
09:34:42 [2024-01-03T09:34:42.683Z] === RUN   TestVolumesInvalidJSON
09:34:42 [2024-01-03T09:34:42.683Z] === RUN   TestVolumesInvalidJSON/volumes/create
09:34:42 [2024-01-03T09:34:42.683Z] === PAUSE TestVolumesInvalidJSON/volumes/create
09:34:42 [2024-01-03T09:34:42.683Z] === CONT  TestVolumesInvalidJSON/volumes/create
09:34:42 [2024-01-03T09:34:42.683Z] === RUN   TestVolumesInvalidJSON/volumes/create/invalid_content_type
09:34:42 [2024-01-03T09:34:42.683Z] === RUN   TestVolumesInvalidJSON/volumes/create/invalid_JSON
09:34:42 [2024-01-03T09:34:42.683Z] === RUN   TestVolumesInvalidJSON/volumes/create/extra_content_after_JSON
09:34:42 [2024-01-03T09:34:42.683Z] === RUN   TestVolumesInvalidJSON/volumes/create/empty_body
09:34:42 [2024-01-03T09:34:42.939Z] --- PASS: TestVolumesInvalidJSON (0.01s)
09:34:42 [2024-01-03T09:34:42.939Z]     --- PASS: TestVolumesInvalidJSON/volumes/create (0.00s)
09:34:42 [2024-01-03T09:34:42.939Z]         --- PASS: TestVolumesInvalidJSON/volumes/create/invalid_content_type (0.00s)
09:34:42 [2024-01-03T09:34:42.939Z]         --- PASS: TestVolumesInvalidJSON/volumes/create/invalid_JSON (0.00s)
09:34:42 [2024-01-03T09:34:42.939Z]         --- PASS: TestVolumesInvalidJSON/volumes/create/extra_content_after_JSON (0.00s)
09:34:42 [2024-01-03T09:34:42.939Z]         --- PASS: TestVolumesInvalidJSON/volumes/create/empty_body (0.00s)
09:34:42 [2024-01-03T09:34:42.939Z] === RUN   TestVolumePruneAnonymous
09:34:42 [2024-01-03T09:34:42.939Z] --- PASS: TestVolumePruneAnonymous (0.03s)
09:34:42 [2024-01-03T09:34:42.939Z] === RUN   TestVolumePruneAnonFromImage
09:34:42 [2024-01-03T09:34:42.939Z] --- PASS: TestVolumePruneAnonFromImage (0.11s)
09:34:42 [2024-01-03T09:34:42.939Z] === CONT  TestVolumesRemoveSwarmEnabled
09:34:44 [2024-01-03T09:34:44.301Z] === RUN   TestVolumesRemoveSwarmEnabled/volume_in_use
09:34:44 [2024-01-03T09:34:44.301Z] === RUN   TestVolumesRemoveSwarmEnabled/volume_not_in_use
09:34:44 [2024-01-03T09:34:44.301Z] === RUN   TestVolumesRemoveSwarmEnabled/non-existing_volume
09:34:44 [2024-01-03T09:34:44.301Z] === RUN   TestVolumesRemoveSwarmEnabled/non-existing_volume_force
09:34:45 [2024-01-03T09:34:45.227Z] --- PASS: TestVolumesRemoveSwarmEnabled (2.11s)
09:34:45 [2024-01-03T09:34:45.227Z]     --- PASS: TestVolumesRemoveSwarmEnabled/volume_in_use (0.00s)
09:34:45 [2024-01-03T09:34:45.227Z]     --- PASS: TestVolumesRemoveSwarmEnabled/volume_not_in_use (0.01s)
09:34:45 [2024-01-03T09:34:45.227Z]     --- PASS: TestVolumesRemoveSwarmEnabled/non-existing_volume (0.00s)
09:34:45 [2024-01-03T09:34:45.227Z]     --- PASS: TestVolumesRemoveSwarmEnabled/non-existing_volume_force (0.00s)
09:34:45 [2024-01-03T09:34:45.227Z] PASS
09:34:45 [2024-01-03T09:34:45.227Z] 
09:34:45 [2024-01-03T09:34:45.227Z] DONE 20 tests in 2.363s
09:34:45 [2024-01-03T09:34:45.227Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
09:34:45 [2024-01-03T09:34:45.227Z] ++++ cat bundles/test-integration/docker.pid
09:34:45 [2024-01-03T09:34:45.227Z] +++ kill 24498
09:34:46 [2024-01-03T09:34:46.590Z] ++++ cat bundles/test-integration/TestUsernsCommit/d642e8e31b0fb/docker.pid
09:34:46 [2024-01-03T09:34:46.590Z] +++ kill 62017
09:34:46 [2024-01-03T09:34:46.590Z] /go/src/github.com/docker/docker/hack/make/.integration-daemon-stop: line 13: wait: pid 62017 is not a child of this shell
09:34:46 [2024-01-03T09:34:46.590Z] warning: PID 62017 from bundles/test-integration/TestUsernsCommit/d642e8e31b0fb/docker.pid had a nonzero exit code
09:34:46 [2024-01-03T09:34:46.590Z] umount: bundles/test-integration/TestUsernsCommit/d642e8e31b0fb/root: not mounted.
09:34:46 [2024-01-03T09:34:46.590Z] +++ /etc/init.d/apparmor stop
09:34:46 [2024-01-03T09:34:46.590Z] Leaving: AppArmorNo profiles have been unloaded.
09:34:46 [2024-01-03T09:34:46.590Z] 
09:34:46 [2024-01-03T09:34:46.590Z] Unloading profiles will leave already running processes permanently
09:34:46 [2024-01-03T09:34:46.590Z] unconfined, which can lead to unexpected situations.
09:34:46 [2024-01-03T09:34:46.590Z] 
09:34:46 [2024-01-03T09:34:46.590Z] To set a process to complain mode, use the command line tool
09:34:46 [2024-01-03T09:34:46.590Z] 'aa-complain'. To really tear down all profiles, run 'aa-teardown'."
09:34:46 [2024-01-03T09:34:46.590Z] +++ true
09:34:46 [2024-01-03T09:34:46.590Z] exiting test-integration
09:34:46 [2024-01-03T09:34:46.590Z] ++ exit 0
09:34:46 [2024-01-03T09:34:46.590Z]