Skipping 722 KB.. Full Log

00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.378259783Z" 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=24a55442-7b66-47f5-acb6-227d38c4af17 http.request.method=GET http.request.remoteaddr="127.0.0.1:52040" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=10.207µ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=8d0be8b1-72ef-438f-8782-2c3320d32fb4 trace.line=155 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.378276792Z" 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=ea6c21f1-2c0e-4847-a3d0-59118d711d98 http.request.method=GET http.request.remoteaddr="127.0.0.1:52032" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=9.329µ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=41e1bc6b-5188-45dc-a89a-f2de7f9d660d trace.line=155 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.37829257Z" 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=24a55442-7b66-47f5-acb6-227d38c4af17 http.request.method=GET http.request.remoteaddr="127.0.0.1:52040" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=9.502µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).Stat" trace.id=d2224385-55c8-44ee-8f00-9494c1ddb47c trace.line=155 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.378313025Z" 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=ea6c21f1-2c0e-4847-a3d0-59118d711d98 http.request.method=GET http.request.remoteaddr="127.0.0.1:52032" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=11.028µ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=30d17844-9e22-452e-9fd5-39540b258755 trace.line=217 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.378321928Z" 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=24a55442-7b66-47f5-acb6-227d38c4af17 http.request.method=GET http.request.remoteaddr="127.0.0.1:52040" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=6.744µ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=1f68382f-949b-4ba4-adc4-3ab8b7692a19 trace.line=217 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.378620441Z" 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=ea6c21f1-2c0e-4847-a3d0-59118d711d98 http.request.method=GET http.request.remoteaddr="127.0.0.1:52032" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=24.738µ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=53522687-bfcb-42c5-a81a-77aca2bc4c00 trace.line=125 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.379188784Z" 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=24a55442-7b66-47f5-acb6-227d38c4af17 http.request.method=GET http.request.remoteaddr="127.0.0.1:52040" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=35.782µ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=3ec7536c-ee1c-4bff-8b51-6befa02896a7 trace.line=125 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.380090421Z" 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=ea6c21f1-2c0e-4847-a3d0-59118d711d98 http.request.method=GET http.request.remoteaddr="127.0.0.1:52032" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=37.284µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).GetContent" trace.id=a7c43554-a3a0-4082-85bb-87324c4def75 trace.line=95 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.380114002Z" 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=24a55442-7b66-47f5-acb6-227d38c4af17 http.request.method=GET http.request.remoteaddr="127.0.0.1:52040" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=44.545µ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=1cf22d06-5911-4b06-b35a-5561f62d2000 trace.line=95 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.380475587Z" 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=24a55442-7b66-47f5-acb6-227d38c4af17 http.request.method=GET http.request.remoteaddr="127.0.0.1:52040" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=40.549µ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=ca970d3b-7a65-44a5-8608-d1349c427b07 trace.line=155 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.380507488Z" 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=ea6c21f1-2c0e-4847-a3d0-59118d711d98 http.request.method=GET http.request.remoteaddr="127.0.0.1:52032" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=144.727µ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=08e872f4-0c1f-4386-b29a-4ee4317fc3bf trace.line=155 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.380563282Z" level=info msg="response completed" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=24a55442-7b66-47f5-acb6-227d38c4af17 http.request.method=GET http.request.remoteaddr="127.0.0.1:52040" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/octet-stream" http.response.duration=3.41131ms http.response.status=200 http.response.written=68 
00:49:52 [2024-04-02T00:49:52.576Z] 127.0.0.1 - - [02/Apr/2024:00:49:52 +0000] "GET /v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923 HTTP/1.1" 200 68 "" "docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.380642534Z" level=info msg="response completed" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=ea6c21f1-2c0e-4847-a3d0-59118d711d98 http.request.method=GET http.request.remoteaddr="127.0.0.1:52032" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/octet-stream" http.response.duration=3.548038ms http.response.status=200 http.response.written=194 
00:49:52 [2024-04-02T00:49:52.576Z] 127.0.0.1 - - [02/Apr/2024:00:49:52 +0000] "GET /v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b HTTP/1.1" 200 194 "" "docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.395710684Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=0f098cc6-0242-40bb-98df-0013c7ea5ef6 http.request.method=GET http.request.remoteaddr="127.0.0.1:52052" http.request.uri="/v2/" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" 
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.39575504Z" level=info msg="response completed" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=0f098cc6-0242-40bb-98df-0013c7ea5ef6 http.request.method=GET http.request.remoteaddr="127.0.0.1:52052" http.request.uri="/v2/" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/json; charset=utf-8" http.response.duration="945.132µs" http.response.status=200 http.response.written=2 
00:49:52 [2024-04-02T00:49:52.576Z] 127.0.0.1 - - [02/Apr/2024:00:49:52 +0000] "GET /v2/ HTTP/1.1" 200 2 "" "docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.403690855Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=53e59889-a4d9-4ba1-896f-9bf35846e6be http.request.method=HEAD http.request.remoteaddr="127.0.0.1:52068" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.403734998Z" level=debug msg=GetImageManifest go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=53e59889-a4d9-4ba1-896f-9bf35846e6be http.request.method=HEAD http.request.remoteaddr="127.0.0.1:52068" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.403748356Z" level=debug msg="(*manifestStore).Get" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=53e59889-a4d9-4ba1-896f-9bf35846e6be http.request.method=HEAD http.request.remoteaddr="127.0.0.1:52068" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.403815932Z" 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=53e59889-a4d9-4ba1-896f-9bf35846e6be http.request.method=HEAD http.request.remoteaddr="127.0.0.1:52068" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=36.537µ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=d6deb46f-b693-408f-87e9-b9476009dfbb trace.line=95 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.4038611Z" 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=53e59889-a4d9-4ba1-896f-9bf35846e6be http.request.method=HEAD http.request.remoteaddr="127.0.0.1:52068" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=12.751µ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=aed3b167-853a-4102-b109-5b1b64974f76 trace.line=95 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.403980524Z" 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=53e59889-a4d9-4ba1-896f-9bf35846e6be http.request.method=HEAD http.request.remoteaddr="127.0.0.1:52068" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/json; charset=utf-8" http.response.duration=1.205098ms http.response.status=404 http.response.written=181 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
00:49:52 [2024-04-02T00:49:52.576Z] 127.0.0.1 - - [02/Apr/2024:00:49:52 +0000] "HEAD /v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda HTTP/1.1" 404 181 "" "docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.405409191Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=2a217a44-9ac9-46e4-ab44-a99468547ba4 http.request.method=GET http.request.remoteaddr="127.0.0.1:52080" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.405449757Z" level=debug msg=GetImageManifest go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=2a217a44-9ac9-46e4-ab44-a99468547ba4 http.request.method=GET http.request.remoteaddr="127.0.0.1:52080" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
00:49:52 [2024-04-02T00:49:52.576Z] time="2024-04-02T00:49:52.405465469Z" level=debug msg="(*manifestStore).Get" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=2a217a44-9ac9-46e4-ab44-a99468547ba4 http.request.method=GET http.request.remoteaddr="127.0.0.1:52080" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
00:49:52 [2024-04-02T00:49:52.577Z] time="2024-04-02T00:49:52.405539733Z" 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=2a217a44-9ac9-46e4-ab44-a99468547ba4 http.request.method=GET http.request.remoteaddr="127.0.0.1:52080" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=43.257µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).GetContent" trace.id=c06fbff4-4ca1-4984-8c02-5cded50bec69 trace.line=95 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
00:49:52 [2024-04-02T00:49:52.577Z] time="2024-04-02T00:49:52.405587822Z" 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=2a217a44-9ac9-46e4-ab44-a99468547ba4 http.request.method=GET http.request.remoteaddr="127.0.0.1:52080" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=12.874µ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=ecf63425-fd53-4cd2-b2ac-f1c8fc0bb2ea trace.line=95 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
00:49:52 [2024-04-02T00:49:52.577Z] time="2024-04-02T00:49:52.405637782Z" 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=2a217a44-9ac9-46e4-ab44-a99468547ba4 http.request.method=GET http.request.remoteaddr="127.0.0.1:52080" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/json; charset=utf-8" http.response.duration=1.116985ms http.response.status=404 http.response.written=181 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
00:49:52 [2024-04-02T00:49:52.577Z] 127.0.0.1 - - [02/Apr/2024:00:49:52 +0000] "GET /v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda HTTP/1.1" 404 181 "" "docker/dev go/go1.21.8 git-commit/7b8c239442cd35527056bb7b82dde539e95de97f kernel/5.15.0-1053-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
00:49:52 [2024-04-02T00:49:52.577Z] --- PASS: TestImagePullStoredDigestForOtherRepo (0.18s)
00:49:52 [2024-04-02T00:49:52.577Z] === RUN   TestImagePullNonExisting
00:49:52 [2024-04-02T00:49:52.577Z] === RUN   TestImagePullNonExisting/asdfasdf:foobar
00:49:52 [2024-04-02T00:49:52.577Z] === PAUSE TestImagePullNonExisting/asdfasdf:foobar
00:49:52 [2024-04-02T00:49:52.577Z] === RUN   TestImagePullNonExisting/library/asdfasdf:foobar
00:49:52 [2024-04-02T00:49:52.577Z] === PAUSE TestImagePullNonExisting/library/asdfasdf:foobar
00:49:52 [2024-04-02T00:49:52.577Z] === RUN   TestImagePullNonExisting/asdfasdf
00:49:52 [2024-04-02T00:49:52.577Z] === PAUSE TestImagePullNonExisting/asdfasdf
00:49:52 [2024-04-02T00:49:52.577Z] === RUN   TestImagePullNonExisting/asdfasdf:latest
00:49:52 [2024-04-02T00:49:52.577Z] === PAUSE TestImagePullNonExisting/asdfasdf:latest
00:49:52 [2024-04-02T00:49:52.577Z] === RUN   TestImagePullNonExisting/library/asdfasdf
00:49:52 [2024-04-02T00:49:52.577Z] === PAUSE TestImagePullNonExisting/library/asdfasdf
00:49:52 [2024-04-02T00:49:52.577Z] === RUN   TestImagePullNonExisting/library/asdfasdf:latest
00:49:52 [2024-04-02T00:49:52.577Z] === PAUSE TestImagePullNonExisting/library/asdfasdf:latest
00:49:52 [2024-04-02T00:49:52.577Z] === CONT  TestImagePullNonExisting/asdfasdf:foobar
00:49:52 [2024-04-02T00:49:52.577Z] === CONT  TestImagePullNonExisting/asdfasdf:latest
00:49:52 [2024-04-02T00:49:52.577Z] === CONT  TestImagePullNonExisting/library/asdfasdf:latest
00:49:52 [2024-04-02T00:49:52.577Z] === CONT  TestImagePullNonExisting/library/asdfasdf:foobar
00:49:52 [2024-04-02T00:49:52.577Z] === CONT  TestImagePullNonExisting/library/asdfasdf
00:49:52 [2024-04-02T00:49:52.577Z] === CONT  TestImagePullNonExisting/asdfasdf
00:49:53 [2024-04-02T00:49:53.945Z] --- PASS: TestImagePullNonExisting (0.01s)
00:49:53 [2024-04-02T00:49:53.945Z]     --- PASS: TestImagePullNonExisting/asdfasdf:latest (0.95s)
00:49:53 [2024-04-02T00:49:53.945Z]     --- PASS: TestImagePullNonExisting/library/asdfasdf:latest (0.95s)
00:49:53 [2024-04-02T00:49:53.945Z]     --- PASS: TestImagePullNonExisting/library/asdfasdf:foobar (0.96s)
00:49:53 [2024-04-02T00:49:53.945Z]     --- PASS: TestImagePullNonExisting/asdfasdf:foobar (0.97s)
00:49:53 [2024-04-02T00:49:53.945Z]     --- PASS: TestImagePullNonExisting/library/asdfasdf (1.27s)
00:49:53 [2024-04-02T00:49:53.945Z]     --- PASS: TestImagePullNonExisting/asdfasdf (1.27s)
00:49:53 [2024-04-02T00:49:53.945Z] === RUN   TestRemoveImageOrphaning
00:49:53 [2024-04-02T00:49:53.945Z] --- PASS: TestRemoveImageOrphaning (0.16s)
00:49:53 [2024-04-02T00:49:53.945Z] === RUN   TestRemoveByDigest
00:49:53 [2024-04-02T00:49:53.945Z]     remove_test.go:64: !testEnv.UsingSnapshotter(): RepoDigests doesn't include tags when using graphdrivers
00:49:53 [2024-04-02T00:49:53.945Z] --- SKIP: TestRemoveByDigest (0.00s)
00:49:53 [2024-04-02T00:49:53.945Z] === RUN   TestRemoveImageGarbageCollector
00:49:53 [2024-04-02T00:49:53.945Z]     remove_unix_test.go:35: (*Execution).NotAmd64-fm
00:49:53 [2024-04-02T00:49:53.945Z] --- SKIP: TestRemoveImageGarbageCollector (0.00s)
00:49:53 [2024-04-02T00:49:53.945Z] === RUN   TestSaveCheckTimes
00:49:53 [2024-04-02T00:49:53.945Z] === PAUSE TestSaveCheckTimes
00:49:53 [2024-04-02T00:49:53.945Z] === RUN   TestSaveOCI
00:49:53 [2024-04-02T00:49:53.945Z] === RUN   TestSaveOCI/busybox:latest
00:49:53 [2024-04-02T00:49:53.945Z] === RUN   TestSaveOCI/busybox:latest/Manifest
00:49:53 [2024-04-02T00:49:53.945Z] === RUN   TestSaveOCI/busybox:latest/Config
00:49:53 [2024-04-02T00:49:53.945Z] === RUN   TestSaveOCI/busybox:latest/Containerd_image_name
00:49:53 [2024-04-02T00:49:53.945Z] === RUN   TestSaveOCI/busybox:latest/OCI_reference_tag
00:49:53 [2024-04-02T00:49:53.945Z] === RUN   TestSaveOCI/sha256:19d689bc58fd64da6a46d46512ea965a12b6bfb5b030400e21bc0a04c4ff155e
00:49:54 [2024-04-02T00:49:54.202Z] === RUN   TestSaveOCI/sha256:19d689bc58fd64da6a46d46512ea965a12b6bfb5b030400e21bc0a04c4ff155e/Manifest
00:49:54 [2024-04-02T00:49:54.202Z] === RUN   TestSaveOCI/sha256:19d689bc58fd64da6a46d46512ea965a12b6bfb5b030400e21bc0a04c4ff155e/Config
00:49:54 [2024-04-02T00:49:54.202Z] === RUN   TestSaveOCI/sha256:19d689bc58fd64da6a46d46512ea965a12b6bfb5b030400e21bc0a04c4ff155e/Containerd_image_name
00:49:54 [2024-04-02T00:49:54.202Z] === RUN   TestSaveOCI/sha256:19d689bc58fd64da6a46d46512ea965a12b6bfb5b030400e21bc0a04c4ff155e/OCI_reference_tag
00:49:54 [2024-04-02T00:49:54.202Z] === RUN   TestSaveOCI/multilayer:latest
00:49:54 [2024-04-02T00:49:54.202Z] === RUN   TestSaveOCI/multilayer:latest/Manifest
00:49:54 [2024-04-02T00:49:54.202Z] === RUN   TestSaveOCI/multilayer:latest/Config
00:49:54 [2024-04-02T00:49:54.202Z] === RUN   TestSaveOCI/multilayer:latest/Containerd_image_name
00:49:54 [2024-04-02T00:49:54.202Z] === RUN   TestSaveOCI/multilayer:latest/OCI_reference_tag
00:49:54 [2024-04-02T00:49:54.202Z] --- PASS: TestSaveOCI (0.13s)
00:49:54 [2024-04-02T00:49:54.202Z]     --- PASS: TestSaveOCI/busybox:latest (0.02s)
00:49:54 [2024-04-02T00:49:54.202Z]         --- PASS: TestSaveOCI/busybox:latest/Manifest (0.00s)
00:49:54 [2024-04-02T00:49:54.202Z]         --- PASS: TestSaveOCI/busybox:latest/Config (0.00s)
00:49:54 [2024-04-02T00:49:54.202Z]         --- PASS: TestSaveOCI/busybox:latest/Containerd_image_name (0.00s)
00:49:54 [2024-04-02T00:49:54.202Z]         --- PASS: TestSaveOCI/busybox:latest/OCI_reference_tag (0.00s)
00:49:54 [2024-04-02T00:49:54.202Z]     --- PASS: TestSaveOCI/sha256:19d689bc58fd64da6a46d46512ea965a12b6bfb5b030400e21bc0a04c4ff155e (0.02s)
00:49:54 [2024-04-02T00:49:54.202Z]         --- PASS: TestSaveOCI/sha256:19d689bc58fd64da6a46d46512ea965a12b6bfb5b030400e21bc0a04c4ff155e/Manifest (0.00s)
00:49:54 [2024-04-02T00:49:54.202Z]         --- PASS: TestSaveOCI/sha256:19d689bc58fd64da6a46d46512ea965a12b6bfb5b030400e21bc0a04c4ff155e/Config (0.00s)
00:49:54 [2024-04-02T00:49:54.202Z]         --- PASS: TestSaveOCI/sha256:19d689bc58fd64da6a46d46512ea965a12b6bfb5b030400e21bc0a04c4ff155e/Containerd_image_name (0.00s)
00:49:54 [2024-04-02T00:49:54.202Z]         --- PASS: TestSaveOCI/sha256:19d689bc58fd64da6a46d46512ea965a12b6bfb5b030400e21bc0a04c4ff155e/OCI_reference_tag (0.00s)
00:49:54 [2024-04-02T00:49:54.202Z]     --- PASS: TestSaveOCI/multilayer:latest (0.01s)
00:49:54 [2024-04-02T00:49:54.202Z]         --- PASS: TestSaveOCI/multilayer:latest/Manifest (0.00s)
00:49:54 [2024-04-02T00:49:54.202Z]         --- PASS: TestSaveOCI/multilayer:latest/Config (0.00s)
00:49:54 [2024-04-02T00:49:54.202Z]         --- PASS: TestSaveOCI/multilayer:latest/Containerd_image_name (0.00s)
00:49:54 [2024-04-02T00:49:54.202Z]         --- PASS: TestSaveOCI/multilayer:latest/OCI_reference_tag (0.00s)
00:49:54 [2024-04-02T00:49:54.202Z] === RUN   TestSaveRepoWithMultipleImages
00:49:54 [2024-04-02T00:49:54.202Z] --- PASS: TestSaveRepoWithMultipleImages (0.19s)
00:49:54 [2024-04-02T00:49:54.202Z] === RUN   TestSaveDirectoryPermissions
00:49:55 [2024-04-02T00:49:55.132Z] --- PASS: TestSaveDirectoryPermissions (0.93s)
00:49:55 [2024-04-02T00:49:55.132Z] === RUN   TestTagUnprefixedRepoByNameOrName
00:49:55 [2024-04-02T00:49:55.132Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.02s)
00:49:55 [2024-04-02T00:49:55.132Z] === RUN   TestTagUsingDigestAlgorithmAsName
00:49:55 [2024-04-02T00:49:55.388Z] --- PASS: TestTagUsingDigestAlgorithmAsName (0.01s)
00:49:55 [2024-04-02T00:49:55.389Z] === RUN   TestTagValidPrefixedRepo
00:49:55 [2024-04-02T00:49:55.389Z] === RUN   TestTagValidPrefixedRepo/fooo/bar
00:49:55 [2024-04-02T00:49:55.389Z] === PAUSE TestTagValidPrefixedRepo/fooo/bar
00:49:55 [2024-04-02T00:49:55.389Z] === RUN   TestTagValidPrefixedRepo/fooaa/test
00:49:55 [2024-04-02T00:49:55.389Z] === PAUSE TestTagValidPrefixedRepo/fooaa/test
00:49:55 [2024-04-02T00:49:55.389Z] === RUN   TestTagValidPrefixedRepo/foooo:t
00:49:55 [2024-04-02T00:49:55.389Z] === PAUSE TestTagValidPrefixedRepo/foooo:t
00:49:55 [2024-04-02T00:49:55.389Z] === RUN   TestTagValidPrefixedRepo/HOSTNAME.DOMAIN.COM:443/foo/bar
00:49:55 [2024-04-02T00:49:55.389Z] === PAUSE TestTagValidPrefixedRepo/HOSTNAME.DOMAIN.COM:443/foo/bar
00:49:55 [2024-04-02T00:49:55.389Z] === CONT  TestTagValidPrefixedRepo/fooo/bar
00:49:55 [2024-04-02T00:49:55.389Z] === CONT  TestTagValidPrefixedRepo/foooo:t
00:49:55 [2024-04-02T00:49:55.389Z] === CONT  TestTagValidPrefixedRepo/HOSTNAME.DOMAIN.COM:443/foo/bar
00:49:55 [2024-04-02T00:49:55.389Z] === CONT  TestTagValidPrefixedRepo/fooaa/test
00:49:55 [2024-04-02T00:49:55.389Z] --- PASS: TestTagValidPrefixedRepo (0.02s)
00:49:55 [2024-04-02T00:49:55.389Z]     --- PASS: TestTagValidPrefixedRepo/fooo/bar (0.01s)
00:49:55 [2024-04-02T00:49:55.389Z]     --- PASS: TestTagValidPrefixedRepo/foooo:t (0.01s)
00:49:55 [2024-04-02T00:49:55.389Z]     --- PASS: TestTagValidPrefixedRepo/HOSTNAME.DOMAIN.COM:443/foo/bar (0.01s)
00:49:55 [2024-04-02T00:49:55.389Z]     --- PASS: TestTagValidPrefixedRepo/fooaa/test (0.02s)
00:49:55 [2024-04-02T00:49:55.389Z] === RUN   TestTagExistedNameWithoutForce
00:49:55 [2024-04-02T00:49:55.389Z] --- PASS: TestTagExistedNameWithoutForce (0.02s)
00:49:55 [2024-04-02T00:49:55.389Z] === RUN   TestTagOfficialNames
00:49:55 [2024-04-02T00:49:55.389Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_docker.io/busybox
00:49:55 [2024-04-02T00:49:55.389Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_index.docker.io/busybox
00:49:55 [2024-04-02T00:49:55.389Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_library/busybox
00:49:55 [2024-04-02T00:49:55.389Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_docker.io/library/busybox
00:49:55 [2024-04-02T00:49:55.389Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_index.docker.io/library/busybox
00:49:55 [2024-04-02T00:49:55.389Z] --- PASS: TestTagOfficialNames (0.04s)
00:49:55 [2024-04-02T00:49:55.389Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_docker.io/busybox (0.01s)
00:49:55 [2024-04-02T00:49:55.389Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_index.docker.io/busybox (0.01s)
00:49:55 [2024-04-02T00:49:55.389Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_library/busybox (0.01s)
00:49:55 [2024-04-02T00:49:55.389Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_docker.io/library/busybox (0.01s)
00:49:55 [2024-04-02T00:49:55.389Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_index.docker.io/library/busybox (0.01s)
00:49:55 [2024-04-02T00:49:55.389Z] === RUN   TestTagMatchesDigest
00:49:55 [2024-04-02T00:49:55.389Z] --- PASS: TestTagMatchesDigest (0.01s)
00:49:55 [2024-04-02T00:49:55.389Z] === CONT  TestSaveCheckTimes
00:49:55 [2024-04-02T00:49:55.389Z] --- PASS: TestSaveCheckTimes (0.03s)
00:49:55 [2024-04-02T00:49:55.389Z] PASS
00:49:55 [2024-04-02T00:49:55.389Z] 
00:49:55 [2024-04-02T00:49:55.389Z] === Skipped
00:49:55 [2024-04-02T00:49:55.389Z] === SKIP: arm64.integration.image TestImportExtremelyLargeImageWorks (0.00s)
00:49:55 [2024-04-02T00:49:55.389Z]     import_test.go:24: runtime.GOARCH == "arm64": effective test will be time out
00:49:55 [2024-04-02T00:49:55.389Z] 
00:49:55 [2024-04-02T00:49:55.389Z] === SKIP: arm64.integration.image TestRemoveByDigest (0.00s)
00:49:55 [2024-04-02T00:49:55.389Z]     remove_test.go:64: !testEnv.UsingSnapshotter(): RepoDigests doesn't include tags when using graphdrivers
00:49:55 [2024-04-02T00:49:55.389Z] 
00:49:55 [2024-04-02T00:49:55.389Z] === SKIP: arm64.integration.image TestRemoveImageGarbageCollector (0.00s)
00:49:55 [2024-04-02T00:49:55.389Z]     remove_unix_test.go:35: (*Execution).NotAmd64-fm
00:49:55 [2024-04-02T00:49:55.389Z] 
00:49:55 [2024-04-02T00:49:55.389Z] DONE 71 tests, 3 skipped in 6.488s
00:49:55 [2024-04-02T00:49:55.389Z] Running /go/src/github.com/docker/docker/integration/internal/termtest (arm64.integration.internal.termtest) flags=-test.v -test.timeout=120m  
00:49:55 [2024-04-02T00:49:55.389Z] ++ '[' -n '' ']'
00:49:55 [2024-04-02T00:49:55.389Z] ++ 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
00:49:55 [2024-04-02T00:49:55.389Z] ++ set -e
00:49:55 [2024-04-02T00:49:55.389Z] ++ '[' -n 0 ']'
00:49:55 [2024-04-02T00:49:55.389Z] ++ set -x
00:49:55 [2024-04-02T00:49:55.389Z] ++ 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.CIAySlzEL6/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
00:49:55 [2024-04-02T00:49:55.389Z] === RUN   TestStripANSICommands
00:49:55 [2024-04-02T00:49:55.389Z] === RUN   TestStripANSICommands/#00
00:49:55 [2024-04-02T00:49:55.389Z] === RUN   TestStripANSICommands/#01
00:49:55 [2024-04-02T00:49:55.389Z] --- PASS: TestStripANSICommands (0.00s)
00:49:55 [2024-04-02T00:49:55.389Z]     --- PASS: TestStripANSICommands/#00 (0.00s)
00:49:55 [2024-04-02T00:49:55.389Z]     --- PASS: TestStripANSICommands/#01 (0.00s)
00:49:55 [2024-04-02T00:49:55.389Z] PASS
00:49:55 [2024-04-02T00:49:55.389Z] 
00:49:55 [2024-04-02T00:49:55.389Z] DONE 3 tests in 0.007s
00:49:55 [2024-04-02T00:49:55.389Z] Running /go/src/github.com/docker/docker/integration/network (arm64.integration.network) flags=-test.v -test.timeout=120m  
00:49:55 [2024-04-02T00:49:55.389Z] ++ '[' -n '' ']'
00:49:55 [2024-04-02T00:49:55.389Z] ++ 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
00:49:55 [2024-04-02T00:49:55.389Z] ++ set -e
00:49:55 [2024-04-02T00:49:55.389Z] ++ '[' -n 0 ']'
00:49:55 [2024-04-02T00:49:55.389Z] ++ set -x
00:49:55 [2024-04-02T00:49:55.389Z] ++ 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.CIAySlzEL6/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
00:49:55 [2024-04-02T00:49:55.389Z] INFO: Testing against a local daemon
00:49:55 [2024-04-02T00:49:55.389Z] === RUN   TestCreateWithMultiNetworks
00:49:56 [2024-04-02T00:49:56.318Z] --- PASS: TestCreateWithMultiNetworks (0.92s)
00:49:56 [2024-04-02T00:49:56.318Z] === RUN   TestNetworkCreateDelete
00:49:56 [2024-04-02T00:49:56.575Z] --- PASS: TestNetworkCreateDelete (0.15s)
00:49:56 [2024-04-02T00:49:56.575Z] === RUN   TestDockerNetworkDeletePreferID
00:49:57 [2024-04-02T00:49:57.138Z] --- PASS: TestDockerNetworkDeletePreferID (0.46s)
00:49:57 [2024-04-02T00:49:57.138Z] === RUN   TestDaemonDNSFallback
00:50:03 [2024-04-02T00:50:03.682Z] --- PASS: TestDaemonDNSFallback (6.16s)
00:50:03 [2024-04-02T00:50:03.682Z] === RUN   TestInspectNetwork
00:50:05 [2024-04-02T00:50:05.574Z] === RUN   TestInspectNetwork/full_network_id
00:50:05 [2024-04-02T00:50:05.574Z] === RUN   TestInspectNetwork/partial_network_id
00:50:05 [2024-04-02T00:50:05.574Z] === RUN   TestInspectNetwork/network_name
00:50:05 [2024-04-02T00:50:05.574Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
00:50:10 [2024-04-02T00:50:10.824Z] --- PASS: TestInspectNetwork (6.76s)
00:50:10 [2024-04-02T00:50:10.824Z]     --- PASS: TestInspectNetwork/full_network_id (0.00s)
00:50:10 [2024-04-02T00:50:10.825Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
00:50:10 [2024-04-02T00:50:10.825Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
00:50:10 [2024-04-02T00:50:10.825Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
00:50:10 [2024-04-02T00:50:10.825Z] === RUN   TestRunContainerWithBridgeNone
00:50:11 [2024-04-02T00:50:11.081Z] --- PASS: TestRunContainerWithBridgeNone (1.17s)
00:50:11 [2024-04-02T00:50:11.081Z] === RUN   TestNetworkInvalidJSON
00:50:11 [2024-04-02T00:50:11.081Z] === RUN   TestNetworkInvalidJSON/networks/create
00:50:11 [2024-04-02T00:50:11.081Z] === PAUSE TestNetworkInvalidJSON/networks/create
00:50:11 [2024-04-02T00:50:11.081Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect
00:50:11 [2024-04-02T00:50:11.081Z] === PAUSE TestNetworkInvalidJSON/networks/bridge/connect
00:50:11 [2024-04-02T00:50:11.081Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect
00:50:11 [2024-04-02T00:50:11.081Z] === PAUSE TestNetworkInvalidJSON/networks/bridge/disconnect
00:50:11 [2024-04-02T00:50:11.081Z] === CONT  TestNetworkInvalidJSON/networks/create
00:50:11 [2024-04-02T00:50:11.081Z] === CONT  TestNetworkInvalidJSON/networks/bridge/disconnect
00:50:11 [2024-04-02T00:50:11.081Z] === RUN   TestNetworkInvalidJSON/networks/create/invalid_content_type
00:50:11 [2024-04-02T00:50:11.081Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect/invalid_content_type
00:50:11 [2024-04-02T00:50:11.081Z] === CONT  TestNetworkInvalidJSON/networks/bridge/connect
00:50:11 [2024-04-02T00:50:11.081Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect/invalid_content_type
00:50:11 [2024-04-02T00:50:11.081Z] === RUN   TestNetworkInvalidJSON/networks/create/invalid_JSON
00:50:11 [2024-04-02T00:50:11.081Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect/invalid_JSON
00:50:11 [2024-04-02T00:50:11.081Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect/invalid_JSON
00:50:11 [2024-04-02T00:50:11.081Z] === RUN   TestNetworkInvalidJSON/networks/create/extra_content_after_JSON
00:50:11 [2024-04-02T00:50:11.081Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect/extra_content_after_JSON
00:50:11 [2024-04-02T00:50:11.081Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect/extra_content_after_JSON
00:50:11 [2024-04-02T00:50:11.081Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect/empty_body
00:50:11 [2024-04-02T00:50:11.081Z] === RUN   TestNetworkInvalidJSON/networks/create/empty_body
00:50:11 [2024-04-02T00:50:11.081Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect/empty_body
00:50:11 [2024-04-02T00:50:11.081Z] --- PASS: TestNetworkInvalidJSON (0.01s)
00:50:11 [2024-04-02T00:50:11.081Z]     --- PASS: TestNetworkInvalidJSON/networks/bridge/connect (0.00s)
00:50:11 [2024-04-02T00:50:11.081Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/connect/invalid_content_type (0.00s)
00:50:11 [2024-04-02T00:50:11.081Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/connect/invalid_JSON (0.00s)
00:50:11 [2024-04-02T00:50:11.081Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/connect/extra_content_after_JSON (0.00s)
00:50:11 [2024-04-02T00:50:11.081Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/connect/empty_body (0.00s)
00:50:11 [2024-04-02T00:50:11.081Z]     --- PASS: TestNetworkInvalidJSON/networks/create (0.00s)
00:50:11 [2024-04-02T00:50:11.081Z]         --- PASS: TestNetworkInvalidJSON/networks/create/invalid_content_type (0.00s)
00:50:11 [2024-04-02T00:50:11.081Z]         --- PASS: TestNetworkInvalidJSON/networks/create/invalid_JSON (0.00s)
00:50:11 [2024-04-02T00:50:11.081Z]         --- PASS: TestNetworkInvalidJSON/networks/create/extra_content_after_JSON (0.00s)
00:50:11 [2024-04-02T00:50:11.081Z]         --- PASS: TestNetworkInvalidJSON/networks/create/empty_body (0.00s)
00:50:11 [2024-04-02T00:50:11.081Z]     --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect (0.00s)
00:50:11 [2024-04-02T00:50:11.081Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect/invalid_content_type (0.00s)
00:50:11 [2024-04-02T00:50:11.081Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect/invalid_JSON (0.00s)
00:50:11 [2024-04-02T00:50:11.081Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect/extra_content_after_JSON (0.00s)
00:50:11 [2024-04-02T00:50:11.081Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect/empty_body (0.00s)
00:50:11 [2024-04-02T00:50:11.081Z] === RUN   TestNetworkList
00:50:11 [2024-04-02T00:50:11.081Z] === RUN   TestNetworkList//networks
00:50:11 [2024-04-02T00:50:11.081Z] === PAUSE TestNetworkList//networks
00:50:11 [2024-04-02T00:50:11.081Z] === RUN   TestNetworkList//networks/
00:50:11 [2024-04-02T00:50:11.081Z] === PAUSE TestNetworkList//networks/
00:50:11 [2024-04-02T00:50:11.081Z] === CONT  TestNetworkList//networks
00:50:11 [2024-04-02T00:50:11.081Z] === CONT  TestNetworkList//networks/
00:50:11 [2024-04-02T00:50:11.081Z] --- PASS: TestNetworkList (0.01s)
00:50:11 [2024-04-02T00:50:11.081Z]     --- PASS: TestNetworkList//networks/ (0.00s)
00:50:11 [2024-04-02T00:50:11.081Z]     --- PASS: TestNetworkList//networks (0.00s)
00:50:11 [2024-04-02T00:50:11.081Z] === RUN   TestHostIPv4BridgeLabel
00:50:11 [2024-04-02T00:50:11.644Z] --- PASS: TestHostIPv4BridgeLabel (0.55s)
00:50:11 [2024-04-02T00:50:11.644Z] === RUN   TestDefaultNetworkOpts
00:50:11 [2024-04-02T00:50:11.644Z] === RUN   TestDefaultNetworkOpts/default_value
00:50:13 [2024-04-02T00:50:13.014Z] === RUN   TestDefaultNetworkOpts/cmdline_value
00:50:14 [2024-04-02T00:50:14.382Z] === RUN   TestDefaultNetworkOpts/config-from_value
00:50:15 [2024-04-02T00:50:15.311Z] --- PASS: TestDefaultNetworkOpts (3.62s)
00:50:15 [2024-04-02T00:50:15.311Z]     --- PASS: TestDefaultNetworkOpts/default_value (1.23s)
00:50:15 [2024-04-02T00:50:15.311Z]     --- PASS: TestDefaultNetworkOpts/cmdline_value (1.18s)
00:50:15 [2024-04-02T00:50:15.311Z]     --- PASS: TestDefaultNetworkOpts/config-from_value (1.21s)
00:50:15 [2024-04-02T00:50:15.311Z] === RUN   TestForbidDuplicateNetworkNames
00:50:15 [2024-04-02T00:50:15.874Z] --- PASS: TestForbidDuplicateNetworkNames (0.62s)
00:50:15 [2024-04-02T00:50:15.874Z] === RUN   TestDaemonRestartWithLiveRestore
00:50:17 [2024-04-02T00:50:17.241Z] --- PASS: TestDaemonRestartWithLiveRestore (1.03s)
00:50:17 [2024-04-02T00:50:17.241Z] === RUN   TestDaemonDefaultNetworkPools
00:50:17 [2024-04-02T00:50:17.804Z] --- PASS: TestDaemonDefaultNetworkPools (0.80s)
00:50:17 [2024-04-02T00:50:17.804Z] === RUN   TestDaemonRestartWithExistingNetwork
00:50:19 [2024-04-02T00:50:19.172Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.15s)
00:50:19 [2024-04-02T00:50:19.172Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
00:50:20 [2024-04-02T00:50:20.101Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.23s)
00:50:20 [2024-04-02T00:50:20.101Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
00:50:20 [2024-04-02T00:50:20.664Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.60s)
00:50:20 [2024-04-02T00:50:20.664Z] === RUN   TestServiceWithPredefinedNetwork
00:50:23 [2024-04-02T00:50:23.184Z] --- PASS: TestServiceWithPredefinedNetwork (2.07s)
00:50:23 [2024-04-02T00:50:23.184Z] === RUN   TestServiceRemoveKeepsIngressNetwork
00:50:23 [2024-04-02T00:50:23.184Z]     service_test.go:250: FLAKY_TEST
00:50:23 [2024-04-02T00:50:23.184Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
00:50:23 [2024-04-02T00:50:23.184Z] === RUN   TestServiceWithDataPathPortInit
00:50:38 [2024-04-02T00:50:38.033Z] --- PASS: TestServiceWithDataPathPortInit (13.29s)
00:50:38 [2024-04-02T00:50:38.033Z] === RUN   TestServiceWithDefaultAddressPoolInit
00:50:38 [2024-04-02T00:50:38.033Z]     service_test.go:440: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:mr66uz41ihld7t9kuxsnjdby2 Created:2024-04-02 00:50:37.262460664 +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[a0fceb903b5901f40ae43420e3eac2b3199118c928b200880e7043ab62e60c8b:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.d1c4edj0rgp5n7uu54sczybdn EndpointID:70664d67c846bef888bb2626525c7f1db369119927bcb7dabb7210c01b2e6e59 MacAddress:02:42:14:14:01:03 IPv4Address:20.20.1.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:32b197f0d9d29bd88904040fe764a9eda42416fb88651f589ebf45356d1e3d39 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:732b9a552296 IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.1.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.d1c4edj0rgp5n7uu54sczybdn EndpointID:70664d67c846bef888bb2626525c7f1db369119927bcb7dabb7210c01b2e6e59 EndpointIP:20.20.1.3 Info:map[Host IP:127.0.0.1]}]}]}
00:50:43 [2024-04-02T00:50:43.283Z] --- PASS: TestServiceWithDefaultAddressPoolInit (6.52s)
00:50:43 [2024-04-02T00:50:43.283Z] PASS
00:50:43 [2024-04-02T00:50:43.283Z] 
00:50:43 [2024-04-02T00:50:43.283Z] === Skipped
00:50:43 [2024-04-02T00:50:43.283Z] === SKIP: arm64.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
00:50:43 [2024-04-02T00:50:43.283Z]     service_test.go:250: FLAKY_TEST
00:50:43 [2024-04-02T00:50:43.283Z] 
00:50:43 [2024-04-02T00:50:43.283Z] DONE 44 tests, 1 skipped in 47.160s
00:50:43 [2024-04-02T00:50:43.283Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (arm64.integration.network.ipvlan) flags=-test.v -test.timeout=120m  
00:50:43 [2024-04-02T00:50:43.283Z] ++ '[' -n '' ']'
00:50:43 [2024-04-02T00:50:43.283Z] ++ 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
00:50:43 [2024-04-02T00:50:43.283Z] ++ set -e
00:50:43 [2024-04-02T00:50:43.283Z] ++ '[' -n 0 ']'
00:50:43 [2024-04-02T00:50:43.283Z] ++ set -x
00:50:43 [2024-04-02T00:50:43.283Z] ++ 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.CIAySlzEL6/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
00:50:43 [2024-04-02T00:50:43.283Z] INFO: Testing against a local daemon
00:50:43 [2024-04-02T00:50:43.283Z] === RUN   TestDockerNetworkIpvlanPersistance
00:50:43 [2024-04-02T00:50:43.283Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
00:50:43 [2024-04-02T00:50:43.283Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.00s)
00:50:43 [2024-04-02T00:50:43.283Z] === RUN   TestDockerNetworkIpvlan
00:50:43 [2024-04-02T00:50:43.283Z]     ipvlan_test.go:55: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
00:50:43 [2024-04-02T00:50:43.283Z] --- SKIP: TestDockerNetworkIpvlan (0.00s)
00:50:43 [2024-04-02T00:50:43.283Z] PASS
00:50:43 [2024-04-02T00:50:43.283Z] 
00:50:43 [2024-04-02T00:50:43.283Z] === Skipped
00:50:43 [2024-04-02T00:50:43.283Z] === SKIP: arm64.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.00s)
00:50:43 [2024-04-02T00:50:43.283Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
00:50:43 [2024-04-02T00:50:43.283Z] 
00:50:43 [2024-04-02T00:50:43.283Z] === SKIP: arm64.integration.network.ipvlan TestDockerNetworkIpvlan (0.00s)
00:50:43 [2024-04-02T00:50:43.283Z]     ipvlan_test.go:55: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
00:50:43 [2024-04-02T00:50:43.283Z] 
00:50:43 [2024-04-02T00:50:43.283Z] DONE 2 tests, 2 skipped in 0.031s
00:50:43 [2024-04-02T00:50:43.283Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (arm64.integration.network.macvlan) flags=-test.v -test.timeout=120m  
00:50:43 [2024-04-02T00:50:43.283Z] ++ '[' -n '' ']'
00:50:43 [2024-04-02T00:50:43.283Z] ++ 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
00:50:43 [2024-04-02T00:50:43.283Z] ++ set -e
00:50:43 [2024-04-02T00:50:43.283Z] ++ '[' -n 0 ']'
00:50:43 [2024-04-02T00:50:43.283Z] ++ set -x
00:50:43 [2024-04-02T00:50:43.283Z] ++ 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.CIAySlzEL6/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
00:50:43 [2024-04-02T00:50:43.283Z] INFO: Testing against a local daemon
00:50:43 [2024-04-02T00:50:43.283Z] === RUN   TestDockerNetworkMacvlanPersistance
00:50:43 [2024-04-02T00:50:43.846Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.27s)
00:50:43 [2024-04-02T00:50:43.846Z] === RUN   TestDockerNetworkMacvlan
00:50:43 [2024-04-02T00:50:43.846Z] === RUN   TestDockerNetworkMacvlan/Subinterface
00:50:44 [2024-04-02T00:50:44.775Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
00:50:45 [2024-04-02T00:50:45.338Z] === RUN   TestDockerNetworkMacvlan/NilParent
00:50:46 [2024-04-02T00:50:46.706Z] === RUN   TestDockerNetworkMacvlan/InternalMode
00:50:48 [2024-04-02T00:50:48.074Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
00:50:50 [2024-04-02T00:50:50.593Z] === RUN   TestDockerNetworkMacvlan/Addressing
00:50:51 [2024-04-02T00:50:51.522Z] --- PASS: TestDockerNetworkMacvlan (7.57s)
00:50:51 [2024-04-02T00:50:51.522Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.66s)
00:50:51 [2024-04-02T00:50:51.522Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.69s)
00:50:51 [2024-04-02T00:50:51.522Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (1.45s)
00:50:51 [2024-04-02T00:50:51.522Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (1.42s)
00:50:51 [2024-04-02T00:50:51.522Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (2.24s)
00:50:51 [2024-04-02T00:50:51.523Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (1.11s)
00:50:51 [2024-04-02T00:50:51.523Z] PASS
00:50:51 [2024-04-02T00:50:51.523Z] 
00:50:51 [2024-04-02T00:50:51.523Z] DONE 8 tests in 8.872s
00:50:51 [2024-04-02T00:50:51.523Z] Running /go/src/github.com/docker/docker/integration/networking (arm64.integration.networking) flags=-test.v -test.timeout=120m  
00:50:51 [2024-04-02T00:50:51.523Z] ++ '[' -n '' ']'
00:50:51 [2024-04-02T00:50:51.523Z] ++ 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
00:50:51 [2024-04-02T00:50:51.523Z] ++ set -e
00:50:51 [2024-04-02T00:50:51.523Z] ++ '[' -n 0 ']'
00:50:51 [2024-04-02T00:50:51.523Z] ++ set -x
00:50:51 [2024-04-02T00:50:51.523Z] ++ 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.CIAySlzEL6/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
00:50:51 [2024-04-02T00:50:51.523Z] INFO: Testing against a local daemon
00:50:51 [2024-04-02T00:50:51.523Z] === RUN   TestBridgeICC
00:50:52 [2024-04-02T00:50:52.085Z] === RUN   TestBridgeICC/IPv4_non-internal_network
00:50:53 [2024-04-02T00:50:53.453Z] === RUN   TestBridgeICC/IPv4_internal_network
00:50:54 [2024-04-02T00:50:54.382Z] === RUN   TestBridgeICC/IPv6_ULA_on_non-internal_network
00:50:55 [2024-04-02T00:50:55.312Z] === RUN   TestBridgeICC/IPv6_ULA_on_internal_network
00:50:56 [2024-04-02T00:50:56.241Z] === RUN   TestBridgeICC/IPv6_link-local_address_on_non-internal_network
00:50:57 [2024-04-02T00:50:57.610Z] === RUN   TestBridgeICC/IPv6_link-local_address_on_internal_network
00:50:58 [2024-04-02T00:50:58.539Z] === RUN   TestBridgeICC/IPv6_link-local_address_on_non-internal_network_ping_by_name
00:50:59 [2024-04-02T00:50:59.469Z] === RUN   TestBridgeICC/IPv6_nonstandard_link-local_subnet_on_non-internal_network_ping_by_name
00:51:00 [2024-04-02T00:51:00.398Z] === RUN   TestBridgeICC/IPv6_non-internal_network_with_SLAAC_LL_address
00:51:03 [2024-04-02T00:51:03.668Z] === RUN   TestBridgeICC/IPv6_internal_network_with_SLAAC_LL_address
00:51:06 [2024-04-02T00:51:06.945Z] --- PASS: TestBridgeICC (15.15s)
00:51:06 [2024-04-02T00:51:06.945Z]     --- PASS: TestBridgeICC/IPv4_non-internal_network (1.02s)
00:51:06 [2024-04-02T00:51:06.945Z]     --- PASS: TestBridgeICC/IPv4_internal_network (1.02s)
00:51:06 [2024-04-02T00:51:06.945Z]     --- PASS: TestBridgeICC/IPv6_ULA_on_non-internal_network (1.10s)
00:51:06 [2024-04-02T00:51:06.945Z]     --- PASS: TestBridgeICC/IPv6_ULA_on_internal_network (0.99s)
00:51:06 [2024-04-02T00:51:06.945Z]     --- PASS: TestBridgeICC/IPv6_link-local_address_on_non-internal_network (1.10s)
00:51:06 [2024-04-02T00:51:06.945Z]     --- PASS: TestBridgeICC/IPv6_link-local_address_on_internal_network (1.01s)
00:51:06 [2024-04-02T00:51:06.945Z]     --- PASS: TestBridgeICC/IPv6_link-local_address_on_non-internal_network_ping_by_name (1.09s)
00:51:06 [2024-04-02T00:51:06.945Z]     --- PASS: TestBridgeICC/IPv6_nonstandard_link-local_subnet_on_non-internal_network_ping_by_name (1.02s)
00:51:06 [2024-04-02T00:51:06.945Z]     --- PASS: TestBridgeICC/IPv6_non-internal_network_with_SLAAC_LL_address (3.11s)
00:51:06 [2024-04-02T00:51:06.945Z]     --- PASS: TestBridgeICC/IPv6_internal_network_with_SLAAC_LL_address (3.09s)
00:51:06 [2024-04-02T00:51:06.945Z] === RUN   TestBridgeICCWindows
00:51:06 [2024-04-02T00:51:06.945Z]     bridge_test.go:214: testEnv.DaemonInfo.OSType != "windows"
00:51:06 [2024-04-02T00:51:06.945Z] --- SKIP: TestBridgeICCWindows (0.00s)
00:51:06 [2024-04-02T00:51:06.945Z] === RUN   TestBridgeINC
00:51:07 [2024-04-02T00:51:07.201Z] === RUN   TestBridgeINC/IPv4_non-internal_network
00:51:11 [2024-04-02T00:51:11.372Z] === RUN   TestBridgeINC/IPv4_internal_network
00:51:12 [2024-04-02T00:51:12.739Z] === RUN   TestBridgeINC/IPv6_ULA_on_non-internal_network
00:51:16 [2024-04-02T00:51:16.911Z] === RUN   TestBridgeINC/IPv6_ULA_on_internal_network
00:51:17 [2024-04-02T00:51:17.841Z] --- PASS: TestBridgeINC (11.24s)
00:51:17 [2024-04-02T00:51:17.841Z]     --- PASS: TestBridgeINC/IPv4_non-internal_network (4.17s)
00:51:17 [2024-04-02T00:51:17.841Z]     --- PASS: TestBridgeINC/IPv4_internal_network (1.08s)
00:51:17 [2024-04-02T00:51:17.841Z]     --- PASS: TestBridgeINC/IPv6_ULA_on_non-internal_network (4.28s)
00:51:17 [2024-04-02T00:51:17.841Z]     --- PASS: TestBridgeINC/IPv6_ULA_on_internal_network (1.11s)
00:51:17 [2024-04-02T00:51:17.841Z] === RUN   TestDefaultBridgeIPv6
00:51:17 [2024-04-02T00:51:17.841Z] === RUN   TestDefaultBridgeIPv6/IPv6_ULA
00:51:19 [2024-04-02T00:51:19.733Z] === RUN   TestDefaultBridgeIPv6/IPv6_LLA_only
00:51:21 [2024-04-02T00:51:21.101Z] === RUN   TestDefaultBridgeIPv6/IPv6_nonstandard_LLA_only
00:51:22 [2024-04-02T00:51:22.469Z] --- PASS: TestDefaultBridgeIPv6 (4.43s)
00:51:22 [2024-04-02T00:51:22.469Z]     --- PASS: TestDefaultBridgeIPv6/IPv6_ULA (1.49s)
00:51:22 [2024-04-02T00:51:22.469Z]     --- PASS: TestDefaultBridgeIPv6/IPv6_LLA_only (1.49s)
00:51:22 [2024-04-02T00:51:22.469Z]     --- PASS: TestDefaultBridgeIPv6/IPv6_nonstandard_LLA_only (1.44s)
00:51:22 [2024-04-02T00:51:22.469Z] === RUN   TestDefaultBridgeAddresses
00:51:22 [2024-04-02T00:51:22.469Z] === RUN   TestDefaultBridgeAddresses/Unique-Local_Subnet_Changes
00:51:23 [2024-04-02T00:51:23.838Z] === RUN   TestDefaultBridgeAddresses/Link-Local_Subnet_Changes
00:51:25 [2024-04-02T00:51:25.732Z] --- PASS: TestDefaultBridgeAddresses (3.10s)
00:51:25 [2024-04-02T00:51:25.732Z]     --- PASS: TestDefaultBridgeAddresses/Unique-Local_Subnet_Changes (1.55s)
00:51:25 [2024-04-02T00:51:25.732Z]     --- PASS: TestDefaultBridgeAddresses/Link-Local_Subnet_Changes (1.55s)
00:51:25 [2024-04-02T00:51:25.732Z] === RUN   TestInternalNwConnectivity
00:51:29 [2024-04-02T00:51:29.001Z] --- PASS: TestInternalNwConnectivity (3.29s)
00:51:29 [2024-04-02T00:51:29.001Z] === RUN   TestDisableIPv6Addrs
00:51:29 [2024-04-02T00:51:29.258Z] === RUN   TestDisableIPv6Addrs/IPv6_enabled
00:51:29 [2024-04-02T00:51:29.820Z] === RUN   TestDisableIPv6Addrs/IPv6_disabled
00:51:30 [2024-04-02T00:51:30.384Z] --- PASS: TestDisableIPv6Addrs (1.59s)
00:51:30 [2024-04-02T00:51:30.384Z]     --- PASS: TestDisableIPv6Addrs/IPv6_enabled (0.44s)
00:51:30 [2024-04-02T00:51:30.384Z]     --- PASS: TestDisableIPv6Addrs/IPv6_disabled (0.42s)
00:51:30 [2024-04-02T00:51:30.384Z] === RUN   TestSetInterfaceSysctl
00:51:31 [2024-04-02T00:51:31.313Z] --- PASS: TestSetInterfaceSysctl (0.97s)
00:51:31 [2024-04-02T00:51:31.313Z] === RUN   TestEtcHostsIpv6
00:51:31 [2024-04-02T00:51:31.876Z] === RUN   TestEtcHostsIpv6/IPv6_enabled
00:51:32 [2024-04-02T00:51:32.439Z] === RUN   TestEtcHostsIpv6/IPv6_disabled
00:51:33 [2024-04-02T00:51:33.002Z] --- PASS: TestEtcHostsIpv6 (1.63s)
00:51:33 [2024-04-02T00:51:33.002Z]     --- PASS: TestEtcHostsIpv6/IPv6_enabled (0.55s)
00:51:33 [2024-04-02T00:51:33.002Z]     --- PASS: TestEtcHostsIpv6/IPv6_disabled (0.47s)
00:51:33 [2024-04-02T00:51:33.002Z] === RUN   TestMACAddrOnRestart
00:51:35 [2024-04-02T00:51:35.522Z] --- PASS: TestMACAddrOnRestart (2.17s)
00:51:35 [2024-04-02T00:51:35.522Z] === RUN   TestCfgdMACAddrOnRestart
00:51:38 [2024-04-02T00:51:38.042Z] --- PASS: TestCfgdMACAddrOnRestart (2.50s)
00:51:38 [2024-04-02T00:51:38.042Z] === RUN   TestInspectCfgdMAC
00:51:38 [2024-04-02T00:51:38.298Z] === RUN   TestInspectCfgdMAC/generated_address_default_bridge
00:51:38 [2024-04-02T00:51:38.298Z] === RUN   TestInspectCfgdMAC/configured_address_default_bridge
00:51:38 [2024-04-02T00:51:38.298Z] === RUN   TestInspectCfgdMAC/generated_address_custom_bridge
00:51:38 [2024-04-02T00:51:38.555Z] === RUN   TestInspectCfgdMAC/configured_address_custom_bridge
00:51:38 [2024-04-02T00:51:38.555Z] === RUN   TestInspectCfgdMAC/ctr-wide_address_default_bridge
00:51:38 [2024-04-02T00:51:38.811Z] --- PASS: TestInspectCfgdMAC (1.08s)
00:51:38 [2024-04-02T00:51:38.811Z]     --- PASS: TestInspectCfgdMAC/generated_address_default_bridge (0.04s)
00:51:38 [2024-04-02T00:51:38.811Z]     --- PASS: TestInspectCfgdMAC/configured_address_default_bridge (0.03s)
00:51:38 [2024-04-02T00:51:38.811Z]     --- PASS: TestInspectCfgdMAC/generated_address_custom_bridge (0.21s)
00:51:38 [2024-04-02T00:51:38.811Z]     --- PASS: TestInspectCfgdMAC/configured_address_custom_bridge (0.15s)
00:51:38 [2024-04-02T00:51:38.811Z]     --- PASS: TestInspectCfgdMAC/ctr-wide_address_default_bridge (0.04s)
00:51:38 [2024-04-02T00:51:38.811Z] === RUN   TestWatchtowerCreate
00:51:39 [2024-04-02T00:51:39.742Z] --- PASS: TestWatchtowerCreate (1.12s)
00:51:39 [2024-04-02T00:51:39.742Z] === RUN   TestResolvConfLocalhostIPv6
00:51:41 [2024-04-02T00:51:41.109Z] --- PASS: TestResolvConfLocalhostIPv6 (1.19s)
00:51:41 [2024-04-02T00:51:41.109Z] === RUN   TestInternalNetworkDNS
00:52:07 [2024-04-02T00:52:07.613Z] --- PASS: TestInternalNetworkDNS (23.10s)
00:52:07 [2024-04-02T00:52:07.613Z] PASS
00:52:07 [2024-04-02T00:52:07.613Z] 
00:52:07 [2024-04-02T00:52:07.613Z] === Skipped
00:52:07 [2024-04-02T00:52:07.613Z] === SKIP: arm64.integration.networking TestBridgeICCWindows (0.00s)
00:52:07 [2024-04-02T00:52:07.613Z]     bridge_test.go:214: testEnv.DaemonInfo.OSType != "windows"
00:52:07 [2024-04-02T00:52:07.613Z] 
00:52:07 [2024-04-02T00:52:07.613Z] DONE 43 tests, 1 skipped in 72.585s
00:52:07 [2024-04-02T00:52:07.613Z] Running /go/src/github.com/docker/docker/integration/plugin (arm64.integration.plugin) flags=-test.v -test.timeout=120m  
00:52:07 [2024-04-02T00:52:07.613Z] ++ '[' -n '' ']'
00:52:07 [2024-04-02T00:52:07.613Z] ++ 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
00:52:07 [2024-04-02T00:52:07.613Z] ++ set -e
00:52:07 [2024-04-02T00:52:07.613Z] ++ '[' -n 0 ']'
00:52:07 [2024-04-02T00:52:07.613Z] ++ set -x
00:52:07 [2024-04-02T00:52:07.613Z] ++ 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.CIAySlzEL6/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
00:52:07 [2024-04-02T00:52:07.613Z] testing: warning: no tests to run
00:52:07 [2024-04-02T00:52:07.613Z] PASS
00:52:07 [2024-04-02T00:52:07.613Z] 
00:52:07 [2024-04-02T00:52:07.613Z] DONE 0 tests in 0.005s
00:52:07 [2024-04-02T00:52:07.613Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (arm64.integration.plugin.authz) flags=-test.v -test.timeout=120m  
00:52:07 [2024-04-02T00:52:07.613Z] ++ '[' -n '' ']'
00:52:07 [2024-04-02T00:52:07.613Z] ++ 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
00:52:07 [2024-04-02T00:52:07.613Z] ++ set -e
00:52:07 [2024-04-02T00:52:07.613Z] ++ '[' -n 0 ']'
00:52:07 [2024-04-02T00:52:07.613Z] ++ set -x
00:52:07 [2024-04-02T00:52:07.613Z] ++ 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.CIAySlzEL6/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
00:52:07 [2024-04-02T00:52:07.613Z] INFO: Testing against a local daemon
00:52:07 [2024-04-02T00:52:07.613Z] === RUN   TestAuthZPluginAllowRequest
00:52:07 [2024-04-02T00:52:07.613Z] --- PASS: TestAuthZPluginAllowRequest (1.04s)
00:52:07 [2024-04-02T00:52:07.613Z] === RUN   TestAuthZPluginTLS
00:52:07 [2024-04-02T00:52:07.613Z] --- PASS: TestAuthZPluginTLS (0.54s)
00:52:07 [2024-04-02T00:52:07.613Z] === RUN   TestAuthZPluginDenyRequest
00:52:07 [2024-04-02T00:52:07.613Z] --- PASS: TestAuthZPluginDenyRequest (0.53s)
00:52:07 [2024-04-02T00:52:07.613Z] === RUN   TestAuthZPluginAPIDenyResponse
00:52:07 [2024-04-02T00:52:07.613Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.52s)
00:52:07 [2024-04-02T00:52:07.613Z] === RUN   TestAuthZPluginDenyResponse
00:52:07 [2024-04-02T00:52:07.613Z] --- PASS: TestAuthZPluginDenyResponse (0.53s)
00:52:07 [2024-04-02T00:52:07.613Z] === RUN   TestAuthZPluginAllowEventStream
00:52:08 [2024-04-02T00:52:08.177Z] 2024/04/02 00:52:08 http: panic serving 127.0.0.1:46746: runtime error: invalid memory address or nil pointer dereference
00:52:08 [2024-04-02T00:52:08.177Z] goroutine 92 [running]:
00:52:08 [2024-04-02T00:52:08.177Z] net/http.(*conn).serve.func1()
00:52:08 [2024-04-02T00:52:08.177Z] 	/usr/local/go/src/net/http/server.go:1868 +0xb0
00:52:08 [2024-04-02T00:52:08.177Z] panic({0xa866a0?, 0x15bafd0?})
00:52:08 [2024-04-02T00:52:08.177Z] 	/usr/local/go/src/runtime/panic.go:920 +0x26c
00:52:08 [2024-04-02T00:52:08.177Z] github.com/docker/docker/integration/plugin/authz.setupSuite.func3({0xd8a1d0, 0x40003a42a0}, 0xffff63e152a8?)
00:52:08 [2024-04-02T00:52:08.177Z] 	/go/src/github.com/docker/docker/integration/plugin/authz/main_test.go:159 +0x14c
00:52:08 [2024-04-02T00:52:08.177Z] net/http.HandlerFunc.ServeHTTP(0x400049a600?, {0xd8a1d0?, 0x40003a42a0?}, 0x402c54?)
00:52:08 [2024-04-02T00:52:08.177Z] 	/usr/local/go/src/net/http/server.go:2136 +0x38
00:52:08 [2024-04-02T00:52:08.177Z] net/http.(*ServeMux).ServeHTTP(0xd90568?, {0xd8a1d0, 0x40003a42a0}, 0x400049a600)
00:52:08 [2024-04-02T00:52:08.177Z] 	/usr/local/go/src/net/http/server.go:2514 +0x144
00:52:08 [2024-04-02T00:52:08.177Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.(*middleware).serveHTTP(0x4000172000, {0xd88d90?, 0x40007861c0}, 0x400049a500, {0xd7ee20, 0x40004ac200})
00:52:08 [2024-04-02T00:52:08.177Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:229 +0xf44
00:52:08 [2024-04-02T00:52:08.177Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.NewMiddleware.func1.1({0xd88d90?, 0x40007861c0?}, 0x4000496170?)
00:52:08 [2024-04-02T00:52:08.177Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:81 +0x40
00:52:08 [2024-04-02T00:52:08.177Z] net/http.HandlerFunc.ServeHTTP(0x10?, {0xd88d90?, 0x40007861c0?}, 0x40007861c0?)
00:52:08 [2024-04-02T00:52:08.177Z] 	/usr/local/go/src/net/http/server.go:2136 +0x38
00:52:08 [2024-04-02T00:52:08.177Z] net/http.serverHandler.ServeHTTP({0xd85808?}, {0xd88d90?, 0x40007861c0?}, 0x6?)
00:52:08 [2024-04-02T00:52:08.177Z] 	/usr/local/go/src/net/http/server.go:2938 +0xbc
00:52:08 [2024-04-02T00:52:08.177Z] net/http.(*conn).serve(0x40006381b0, {0xd90568, 0x40001e6f60})
00:52:08 [2024-04-02T00:52:08.177Z] 	/usr/local/go/src/net/http/server.go:2009 +0x518
00:52:08 [2024-04-02T00:52:08.177Z] created by net/http.(*Server).Serve in goroutine 37
00:52:08 [2024-04-02T00:52:08.177Z] 	/usr/local/go/src/net/http/server.go:3086 +0x4cc
00:52:09 [2024-04-02T00:52:09.106Z] 2024/04/02 00:52:09 http: panic serving 127.0.0.1:46760: could not unmarshal json for /AuthZPlugin.AuthZRes: unexpected end of JSON input
00:52:09 [2024-04-02T00:52:09.106Z] goroutine 193 [running]:
00:52:09 [2024-04-02T00:52:09.106Z] net/http.(*conn).serve.func1()
00:52:09 [2024-04-02T00:52:09.106Z] 	/usr/local/go/src/net/http/server.go:1868 +0xb0
00:52:09 [2024-04-02T00:52:09.106Z] panic({0xa1c140?, 0x4000496450?})
00:52:09 [2024-04-02T00:52:09.106Z] 	/usr/local/go/src/runtime/panic.go:920 +0x26c
00:52:09 [2024-04-02T00:52:09.106Z] github.com/docker/docker/integration/plugin/authz.setupSuite.func3({0xd8a1d0, 0x40003a4720}, 0xffff63e152a8?)
00:52:09 [2024-04-02T00:52:09.106Z] 	/go/src/github.com/docker/docker/integration/plugin/authz/main_test.go:149 +0x360
00:52:09 [2024-04-02T00:52:09.106Z] net/http.HandlerFunc.ServeHTTP(0x400049a700?, {0xd8a1d0?, 0x40003a4720?}, 0x402c54?)
00:52:09 [2024-04-02T00:52:09.106Z] 	/usr/local/go/src/net/http/server.go:2136 +0x38
00:52:09 [2024-04-02T00:52:09.106Z] net/http.(*ServeMux).ServeHTTP(0xd90568?, {0xd8a1d0, 0x40003a4720}, 0x400049a700)
00:52:09 [2024-04-02T00:52:09.106Z] 	/usr/local/go/src/net/http/server.go:2514 +0x144
00:52:09 [2024-04-02T00:52:09.106Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.(*middleware).serveHTTP(0x4000172000, {0xd88d90?, 0x40007862a0}, 0x400049a800, {0xd7ee20, 0x40004ac200})
00:52:09 [2024-04-02T00:52:09.106Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:229 +0xf44
00:52:09 [2024-04-02T00:52:09.106Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.NewMiddleware.func1.1({0xd88d90?, 0x40007862a0?}, 0x40004824e0?)
00:52:09 [2024-04-02T00:52:09.106Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:81 +0x40
00:52:09 [2024-04-02T00:52:09.106Z] net/http.HandlerFunc.ServeHTTP(0x1618da0?, {0xd88d90?, 0x40007862a0?}, 0x4000415b40?)
00:52:09 [2024-04-02T00:52:09.106Z] 	/usr/local/go/src/net/http/server.go:2136 +0x38
00:52:09 [2024-04-02T00:52:09.106Z] net/http.serverHandler.ServeHTTP({0x40004824e0?}, {0xd88d90?, 0x40007862a0?}, 0x6?)
00:52:09 [2024-04-02T00:52:09.106Z] 	/usr/local/go/src/net/http/server.go:2938 +0xbc
00:52:09 [2024-04-02T00:52:09.106Z] net/http.(*conn).serve(0x40006585a0, {0xd90568, 0x40001e6f60})
00:52:09 [2024-04-02T00:52:09.106Z] 	/usr/local/go/src/net/http/server.go:2009 +0x518
00:52:09 [2024-04-02T00:52:09.106Z] created by net/http.(*Server).Serve in goroutine 37
00:52:09 [2024-04-02T00:52:09.106Z] 	/usr/local/go/src/net/http/server.go:3086 +0x4cc
00:52:11 [2024-04-02T00:52:11.625Z] 2024/04/02 00:52:11 http: panic serving 127.0.0.1:34252: could not unmarshal json for /AuthZPlugin.AuthZRes: unexpected end of JSON input
00:52:11 [2024-04-02T00:52:11.625Z] goroutine 212 [running]:
00:52:11 [2024-04-02T00:52:11.625Z] net/http.(*conn).serve.func1()
00:52:11 [2024-04-02T00:52:11.625Z] 	/usr/local/go/src/net/http/server.go:1868 +0xb0
00:52:11 [2024-04-02T00:52:11.625Z] panic({0xa1c140?, 0x4000496540?})
00:52:11 [2024-04-02T00:52:11.625Z] 	/usr/local/go/src/runtime/panic.go:920 +0x26c
00:52:11 [2024-04-02T00:52:11.625Z] github.com/docker/docker/integration/plugin/authz.setupSuite.func3({0xd8a1d0, 0x40003a4960}, 0xffff63e152a8?)
00:52:11 [2024-04-02T00:52:11.625Z] 	/go/src/github.com/docker/docker/integration/plugin/authz/main_test.go:149 +0x360
00:52:11 [2024-04-02T00:52:11.625Z] net/http.HandlerFunc.ServeHTTP(0x400049ad00?, {0xd8a1d0?, 0x40003a4960?}, 0x402c54?)
00:52:11 [2024-04-02T00:52:11.625Z] 	/usr/local/go/src/net/http/server.go:2136 +0x38
00:52:11 [2024-04-02T00:52:11.625Z] net/http.(*ServeMux).ServeHTTP(0xd90568?, {0xd8a1d0, 0x40003a4960}, 0x400049ad00)
00:52:11 [2024-04-02T00:52:11.625Z] 	/usr/local/go/src/net/http/server.go:2514 +0x144
00:52:11 [2024-04-02T00:52:11.625Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.(*middleware).serveHTTP(0x4000172000, {0xd88d90?, 0x4000786380}, 0x400049ab00, {0xd7ee20, 0x40004ac200})
00:52:11 [2024-04-02T00:52:11.625Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:229 +0xf44
00:52:11 [2024-04-02T00:52:11.625Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.NewMiddleware.func1.1({0xd88d90?, 0x4000786380?}, 0x40004827e0?)
00:52:11 [2024-04-02T00:52:11.625Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:81 +0x40
00:52:11 [2024-04-02T00:52:11.625Z] net/http.HandlerFunc.ServeHTTP(0x1618da0?, {0xd88d90?, 0x4000786380?}, 0x4000415b40?)
00:52:11 [2024-04-02T00:52:11.625Z] 	/usr/local/go/src/net/http/server.go:2136 +0x38
00:52:11 [2024-04-02T00:52:11.625Z] net/http.serverHandler.ServeHTTP({0x40004827e0?}, {0xd88d90?, 0x4000786380?}, 0x6?)
00:52:11 [2024-04-02T00:52:11.625Z] 	/usr/local/go/src/net/http/server.go:2938 +0xbc
00:52:11 [2024-04-02T00:52:11.625Z] net/http.(*conn).serve(0x4000658480, {0xd90568, 0x40001e6f60})
00:52:11 [2024-04-02T00:52:11.625Z] 	/usr/local/go/src/net/http/server.go:2009 +0x518
00:52:11 [2024-04-02T00:52:11.625Z] created by net/http.(*Server).Serve in goroutine 37
00:52:11 [2024-04-02T00:52:11.625Z] 	/usr/local/go/src/net/http/server.go:3086 +0x4cc
00:52:13 [2024-04-02T00:52:13.516Z] --- PASS: TestAuthZPluginAllowEventStream (6.02s)
00:52:13 [2024-04-02T00:52:13.516Z] === RUN   TestAuthZPluginErrorResponse
00:52:13 [2024-04-02T00:52:13.772Z] --- PASS: TestAuthZPluginErrorResponse (0.53s)
00:52:13 [2024-04-02T00:52:13.772Z] === RUN   TestAuthZPluginErrorRequest
00:52:14 [2024-04-02T00:52:14.350Z] --- PASS: TestAuthZPluginErrorRequest (0.53s)
00:52:14 [2024-04-02T00:52:14.350Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
00:52:14 [2024-04-02T00:52:14.934Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.53s)
00:52:14 [2024-04-02T00:52:14.934Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
00:52:15 [2024-04-02T00:52:15.917Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (1.11s)
00:52:15 [2024-04-02T00:52:15.917Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
00:52:17 [2024-04-02T00:52:17.320Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (1.12s)
00:52:17 [2024-04-02T00:52:17.320Z] === RUN   TestAuthZPluginHeader
00:52:17 [2024-04-02T00:52:17.901Z] --- PASS: TestAuthZPluginHeader (0.61s)
00:52:17 [2024-04-02T00:52:17.901Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
00:52:17 [2024-04-02T00:52:17.901Z]     authz_plugin_v2_test.go:40: (*Execution).NotAmd64-fm
00:52:17 [2024-04-02T00:52:17.901Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
00:52:17 [2024-04-02T00:52:17.901Z] === RUN   TestAuthZPluginV2Disable
00:52:17 [2024-04-02T00:52:17.901Z]     authz_plugin_v2_test.go:61: (*Execution).NotAmd64-fm
00:52:17 [2024-04-02T00:52:17.901Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
00:52:17 [2024-04-02T00:52:17.901Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
00:52:17 [2024-04-02T00:52:17.901Z]     authz_plugin_v2_test.go:87: (*Execution).NotAmd64-fm
00:52:17 [2024-04-02T00:52:17.901Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
00:52:17 [2024-04-02T00:52:17.901Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
00:52:17 [2024-04-02T00:52:17.901Z]     authz_plugin_v2_test.go:122: (*Execution).NotAmd64-fm
00:52:17 [2024-04-02T00:52:17.901Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
00:52:17 [2024-04-02T00:52:17.902Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
00:52:35 [2024-04-02T00:52:35.968Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.88s)
00:52:35 [2024-04-02T00:52:35.968Z] PASS
00:52:35 [2024-04-02T00:52:35.968Z] 
00:52:35 [2024-04-02T00:52:35.968Z] === Skipped
00:52:35 [2024-04-02T00:52:35.968Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
00:52:35 [2024-04-02T00:52:35.968Z]     authz_plugin_v2_test.go:40: (*Execution).NotAmd64-fm
00:52:35 [2024-04-02T00:52:35.968Z] 
00:52:35 [2024-04-02T00:52:35.968Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
00:52:35 [2024-04-02T00:52:35.968Z]     authz_plugin_v2_test.go:61: (*Execution).NotAmd64-fm
00:52:35 [2024-04-02T00:52:35.968Z] 
00:52:35 [2024-04-02T00:52:35.968Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
00:52:35 [2024-04-02T00:52:35.968Z]     authz_plugin_v2_test.go:87: (*Execution).NotAmd64-fm
00:52:35 [2024-04-02T00:52:35.968Z] 
00:52:35 [2024-04-02T00:52:35.968Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
00:52:35 [2024-04-02T00:52:35.968Z]     authz_plugin_v2_test.go:122: (*Execution).NotAmd64-fm
00:52:35 [2024-04-02T00:52:35.968Z] 
00:52:35 [2024-04-02T00:52:35.968Z] DONE 17 tests, 4 skipped in 30.523s
00:52:35 [2024-04-02T00:52:35.968Z] Running /go/src/github.com/docker/docker/integration/plugin/common (arm64.integration.plugin.common) flags=-test.v -test.timeout=120m  
00:52:35 [2024-04-02T00:52:35.968Z] ++ '[' -n '' ']'
00:52:35 [2024-04-02T00:52:35.968Z] ++ 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
00:52:35 [2024-04-02T00:52:35.968Z] ++ set -e
00:52:35 [2024-04-02T00:52:35.968Z] ++ '[' -n 0 ']'
00:52:35 [2024-04-02T00:52:35.968Z] ++ set -x
00:52:35 [2024-04-02T00:52:35.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.CIAySlzEL6/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
00:52:35 [2024-04-02T00:52:35.968Z] INFO: Testing against a local daemon
00:52:35 [2024-04-02T00:52:35.968Z] === RUN   TestPluginInvalidJSON
00:52:35 [2024-04-02T00:52:35.968Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set
00:52:35 [2024-04-02T00:52:35.968Z] === PAUSE TestPluginInvalidJSON/plugins/foobar/set
00:52:35 [2024-04-02T00:52:35.968Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade
00:52:35 [2024-04-02T00:52:35.968Z] === PAUSE TestPluginInvalidJSON/plugins/foobar/upgrade
00:52:35 [2024-04-02T00:52:35.968Z] === RUN   TestPluginInvalidJSON/plugins/pull
00:52:35 [2024-04-02T00:52:35.968Z] === PAUSE TestPluginInvalidJSON/plugins/pull
00:52:35 [2024-04-02T00:52:35.968Z] === CONT  TestPluginInvalidJSON/plugins/foobar/set
00:52:35 [2024-04-02T00:52:35.968Z] === CONT  TestPluginInvalidJSON/plugins/pull
00:52:35 [2024-04-02T00:52:35.968Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/invalid_content_type
00:52:35 [2024-04-02T00:52:35.968Z] === CONT  TestPluginInvalidJSON/plugins/foobar/upgrade
00:52:35 [2024-04-02T00:52:35.968Z] === RUN   TestPluginInvalidJSON/plugins/pull/invalid_content_type
00:52:35 [2024-04-02T00:52:35.968Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_content_type
00:52:35 [2024-04-02T00:52:35.968Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_JSON
00:52:35 [2024-04-02T00:52:35.968Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/invalid_JSON
00:52:35 [2024-04-02T00:52:35.968Z] === RUN   TestPluginInvalidJSON/plugins/pull/invalid_JSON
00:52:35 [2024-04-02T00:52:35.968Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/extra_content_after_JSON
00:52:35 [2024-04-02T00:52:35.968Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/extra_content_after_JSON
00:52:35 [2024-04-02T00:52:35.968Z] === RUN   TestPluginInvalidJSON/plugins/pull/extra_content_after_JSON
00:52:35 [2024-04-02T00:52:35.968Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/empty_body
00:52:35 [2024-04-02T00:52:35.968Z] === RUN   TestPluginInvalidJSON/plugins/pull/empty_body
00:52:35 [2024-04-02T00:52:35.968Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/empty_body
00:52:35 [2024-04-02T00:52:35.968Z] --- PASS: TestPluginInvalidJSON (0.01s)
00:52:35 [2024-04-02T00:52:35.968Z]     --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade (0.00s)
00:52:35 [2024-04-02T00:52:35.968Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_content_type (0.00s)
00:52:35 [2024-04-02T00:52:35.968Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_JSON (0.00s)
00:52:35 [2024-04-02T00:52:35.968Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/extra_content_after_JSON (0.00s)
00:52:35 [2024-04-02T00:52:35.968Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/empty_body (0.00s)
00:52:35 [2024-04-02T00:52:35.968Z]     --- PASS: TestPluginInvalidJSON/plugins/pull (0.00s)
00:52:35 [2024-04-02T00:52:35.968Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/invalid_content_type (0.00s)
00:52:35 [2024-04-02T00:52:35.968Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/invalid_JSON (0.00s)
00:52:35 [2024-04-02T00:52:35.968Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/extra_content_after_JSON (0.00s)
00:52:35 [2024-04-02T00:52:35.968Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/empty_body (0.00s)
00:52:35 [2024-04-02T00:52:35.968Z]     --- PASS: TestPluginInvalidJSON/plugins/foobar/set (0.00s)
00:52:35 [2024-04-02T00:52:35.968Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/invalid_content_type (0.00s)
00:52:35 [2024-04-02T00:52:35.968Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/invalid_JSON (0.00s)
00:52:35 [2024-04-02T00:52:35.968Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/extra_content_after_JSON (0.00s)
00:52:35 [2024-04-02T00:52:35.968Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/empty_body (0.00s)
00:52:35 [2024-04-02T00:52:35.968Z] === RUN   TestPluginInstall
00:52:35 [2024-04-02T00:52:35.968Z] === RUN   TestPluginInstall/no_auth
00:52:38 [2024-04-02T00:52:38.487Z] time="2024-04-02T00:52:38Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
00:52:38 [2024-04-02T00:52:38.487Z] time="2024-04-02T00:52:38Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:0b71ea791dd926d3437bdc53fed6c778a3c613c8ad5ed1f187abc817fb9330c7" mediatype=application/vnd.docker.plugin.v1+json size=522
00:52:38 [2024-04-02T00:52:38.487Z] time="2024-04-02T00:52:38Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
00:52:38 [2024-04-02T00:52:38.488Z] time="2024-04-02T00:52:38Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:0b71ea791dd926d3437bdc53fed6c778a3c613c8ad5ed1f187abc817fb9330c7" mediatype=application/vnd.docker.plugin.v1+json size=522
00:52:38 [2024-04-02T00:52:38.488Z] === RUN   TestPluginInstall/with_digest
00:52:38 [2024-04-02T00:52:38.744Z] === RUN   TestPluginInstall/with_htpasswd
00:52:39 [2024-04-02T00:52:39.307Z] time="2024-04-02T00:52:39Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
00:52:39 [2024-04-02T00:52:39.307Z] time="2024-04-02T00:52:39Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:17293285e5a54ee7e8e6790be4cf5edbb470fbbbb542a7b34197e714afcd7634" mediatype=application/vnd.docker.plugin.v1+json size=522
00:52:39 [2024-04-02T00:52:39.307Z] time="2024-04-02T00:52:39Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
00:52:39 [2024-04-02T00:52:39.307Z] time="2024-04-02T00:52:39Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:17293285e5a54ee7e8e6790be4cf5edbb470fbbbb542a7b34197e714afcd7634" mediatype=application/vnd.docker.plugin.v1+json size=522
00:52:39 [2024-04-02T00:52:39.307Z] === RUN   TestPluginInstall/with_insecure
00:52:40 [2024-04-02T00:52:40.237Z] time="2024-04-02T00:52:39Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
00:52:40 [2024-04-02T00:52:40.237Z] time="2024-04-02T00:52:39Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:3eccdc4d0ad0b3e4be3f35513aaa338f476af88837b238156432829a99c7756e" mediatype=application/vnd.docker.plugin.v1+json size=522
00:52:40 [2024-04-02T00:52:40.237Z] time="2024-04-02T00:52:39Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
00:52:40 [2024-04-02T00:52:40.237Z] time="2024-04-02T00:52:39Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:3eccdc4d0ad0b3e4be3f35513aaa338f476af88837b238156432829a99c7756e" mediatype=application/vnd.docker.plugin.v1+json size=522
00:52:40 [2024-04-02T00:52:40.237Z]     plugin_test.go:247: [d760541de7ef9] daemon is not started
00:52:40 [2024-04-02T00:52:40.237Z] --- PASS: TestPluginInstall (5.51s)
00:52:40 [2024-04-02T00:52:40.237Z]     --- PASS: TestPluginInstall/no_auth (3.66s)
00:52:40 [2024-04-02T00:52:40.237Z]     --- PASS: TestPluginInstall/with_digest (0.47s)
00:52:40 [2024-04-02T00:52:40.237Z]     --- PASS: TestPluginInstall/with_htpasswd (0.45s)
00:52:40 [2024-04-02T00:52:40.237Z]     --- PASS: TestPluginInstall/with_insecure (0.93s)
00:52:40 [2024-04-02T00:52:40.237Z] === RUN   TestPluginsWithRuntimes
00:52:41 [2024-04-02T00:52:41.605Z] === RUN   TestPluginsWithRuntimes/No_Args
00:52:42 [2024-04-02T00:52:42.534Z] === RUN   TestPluginsWithRuntimes/With_Args
00:52:43 [2024-04-02T00:52:43.463Z] --- PASS: TestPluginsWithRuntimes (3.12s)
00:52:43 [2024-04-02T00:52:43.463Z]     --- PASS: TestPluginsWithRuntimes/No_Args (0.84s)
00:52:43 [2024-04-02T00:52:43.463Z]     --- PASS: TestPluginsWithRuntimes/With_Args (0.81s)
00:52:43 [2024-04-02T00:52:43.463Z] === RUN   TestPluginBackCompatMediaTypes
00:52:43 [2024-04-02T00:52:43.719Z] --- PASS: TestPluginBackCompatMediaTypes (0.49s)
00:52:43 [2024-04-02T00:52:43.719Z] PASS
00:52:43 [2024-04-02T00:52:43.719Z] 
00:52:43 [2024-04-02T00:52:43.719Z] DONE 25 tests in 9.150s
00:52:43 [2024-04-02T00:52:43.719Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (arm64.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m  
00:52:43 [2024-04-02T00:52:43.719Z] ++ '[' -n '' ']'
00:52:43 [2024-04-02T00:52:43.719Z] ++ 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
00:52:43 [2024-04-02T00:52:43.719Z] ++ set -e
00:52:43 [2024-04-02T00:52:43.719Z] ++ '[' -n 0 ']'
00:52:43 [2024-04-02T00:52:43.719Z] ++ set -x
00:52:43 [2024-04-02T00:52:43.719Z] ++ 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.CIAySlzEL6/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
00:52:43 [2024-04-02T00:52:43.976Z] INFO: Testing against a local daemon
00:52:43 [2024-04-02T00:52:43.976Z] === RUN   TestExternalGraphDriver
00:52:44 [2024-04-02T00:52:44.232Z] === RUN   TestExternalGraphDriver/json
00:52:44 [2024-04-02T00:52:44.232Z] === RUN   TestExternalGraphDriver/spec
00:52:44 [2024-04-02T00:52:44.232Z] === RUN   TestExternalGraphDriver/pull
00:52:44 [2024-04-02T00:52:44.232Z] --- PASS: TestExternalGraphDriver (0.34s)
00:52:44 [2024-04-02T00:52:44.232Z]     --- PASS: TestExternalGraphDriver/json (0.00s)
00:52:44 [2024-04-02T00:52:44.232Z]     --- PASS: TestExternalGraphDriver/spec (0.00s)
00:52:44 [2024-04-02T00:52:44.232Z]     --- PASS: TestExternalGraphDriver/pull (0.00s)
00:52:44 [2024-04-02T00:52:44.232Z] === RUN   TestGraphdriverPluginV2
00:52:44 [2024-04-02T00:52:44.489Z]     external_test.go:416: (*Execution).NotAmd64-fm
00:52:44 [2024-04-02T00:52:44.489Z] --- SKIP: TestGraphdriverPluginV2 (0.32s)
00:52:44 [2024-04-02T00:52:44.489Z] PASS
00:52:44 [2024-04-02T00:52:44.489Z] 
00:52:44 [2024-04-02T00:52:44.489Z] === Skipped
00:52:44 [2024-04-02T00:52:44.489Z] === SKIP: arm64.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.32s)
00:52:44 [2024-04-02T00:52:44.489Z]     external_test.go:416: (*Execution).NotAmd64-fm
00:52:44 [2024-04-02T00:52:44.489Z] 
00:52:44 [2024-04-02T00:52:44.489Z] DONE 5 tests, 1 skipped in 0.690s
00:52:44 [2024-04-02T00:52:44.489Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (arm64.integration.plugin.logging) flags=-test.v -test.timeout=120m  
00:52:44 [2024-04-02T00:52:44.489Z] ++ '[' -n '' ']'
00:52:44 [2024-04-02T00:52:44.489Z] ++ 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
00:52:44 [2024-04-02T00:52:44.489Z] ++ set -e
00:52:44 [2024-04-02T00:52:44.489Z] ++ '[' -n 0 ']'
00:52:44 [2024-04-02T00:52:44.489Z] ++ set -x
00:52:44 [2024-04-02T00:52:44.489Z] ++ 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.CIAySlzEL6/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
00:52:44 [2024-04-02T00:52:44.489Z] INFO: Testing against a local daemon
00:52:44 [2024-04-02T00:52:44.489Z] === RUN   TestContinueAfterPluginCrash
00:52:44 [2024-04-02T00:52:44.489Z] === PAUSE TestContinueAfterPluginCrash
00:52:44 [2024-04-02T00:52:44.489Z] === RUN   TestReadPluginNoRead
00:52:44 [2024-04-02T00:52:44.489Z] === PAUSE TestReadPluginNoRead
00:52:44 [2024-04-02T00:52:44.489Z] === RUN   TestDaemonStartWithLogOpt
00:52:44 [2024-04-02T00:52:44.489Z] === PAUSE TestDaemonStartWithLogOpt
00:52:44 [2024-04-02T00:52:44.489Z] === CONT  TestDaemonStartWithLogOpt
00:52:44 [2024-04-02T00:52:44.489Z] === CONT  TestReadPluginNoRead
00:52:44 [2024-04-02T00:52:44.489Z] === CONT  TestContinueAfterPluginCrash
00:52:47 [2024-04-02T00:52:47.009Z] === RUN   TestReadPluginNoRead/default
00:52:47 [2024-04-02T00:52:47.009Z] --- PASS: TestDaemonStartWithLogOpt (2.57s)
00:52:47 [2024-04-02T00:52:47.938Z] === RUN   TestReadPluginNoRead/disabled_caching
00:52:48 [2024-04-02T00:52:48.867Z] === RUN   TestReadPluginNoRead/explicitly_enabled_caching
00:52:50 [2024-04-02T00:52:50.235Z]     read_test.go:93: [d2ddb7eb92bd2] daemon is not started
00:52:50 [2024-04-02T00:52:50.235Z] --- PASS: TestReadPluginNoRead (5.39s)
00:52:50 [2024-04-02T00:52:50.235Z]     --- PASS: TestReadPluginNoRead/default (1.13s)
00:52:50 [2024-04-02T00:52:50.235Z]     --- PASS: TestReadPluginNoRead/disabled_caching (1.15s)
00:52:50 [2024-04-02T00:52:50.235Z]     --- PASS: TestReadPluginNoRead/explicitly_enabled_caching (1.07s)
00:52:52 [2024-04-02T00:52:52.127Z] --- PASS: TestContinueAfterPluginCrash (7.54s)
00:52:52 [2024-04-02T00:52:52.127Z] PASS
00:52:52 [2024-04-02T00:52:52.127Z] 
00:52:52 [2024-04-02T00:52:52.127Z] DONE 6 tests in 7.574s
00:52:52 [2024-04-02T00:52:52.127Z] Running /go/src/github.com/docker/docker/integration/plugin/logging/cmd/discard (arm64.integration.plugin.logging.cmd.discard) flags=-test.v -test.timeout=120m  
00:52:52 [2024-04-02T00:52:52.127Z] ++ '[' -n '' ']'
00:52:52 [2024-04-02T00:52:52.127Z] ++ 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
00:52:52 [2024-04-02T00:52:52.127Z] ++ set -e
00:52:52 [2024-04-02T00:52:52.127Z] ++ '[' -n 0 ']'
00:52:52 [2024-04-02T00:52:52.127Z] ++ set -x
00:52:52 [2024-04-02T00:52:52.127Z] ++ 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.CIAySlzEL6/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
00:52:52 [2024-04-02T00:52:52.127Z] testing: warning: no tests to run
00:52:52 [2024-04-02T00:52:52.127Z] PASS
00:52:52 [2024-04-02T00:52:52.127Z] 
00:52:52 [2024-04-02T00:52:52.127Z] DONE 0 tests in 0.006s
00:52:52 [2024-04-02T00:52:52.127Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (arm64.integration.plugin.volumes) flags=-test.v -test.timeout=120m  
00:52:52 [2024-04-02T00:52:52.127Z] ++ '[' -n '' ']'
00:52:52 [2024-04-02T00:52:52.127Z] ++ 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
00:52:52 [2024-04-02T00:52:52.127Z] ++ set -e
00:52:52 [2024-04-02T00:52:52.127Z] ++ '[' -n 0 ']'
00:52:52 [2024-04-02T00:52:52.127Z] ++ set -x
00:52:52 [2024-04-02T00:52:52.127Z] ++ 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.CIAySlzEL6/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
00:52:52 [2024-04-02T00:52:52.127Z] INFO: Testing against a local daemon
00:52:52 [2024-04-02T00:52:52.127Z] === RUN   TestPluginWithDevMounts
00:52:52 [2024-04-02T00:52:52.127Z] === PAUSE TestPluginWithDevMounts
00:52:52 [2024-04-02T00:52:52.127Z] === CONT  TestPluginWithDevMounts
00:52:53 [2024-04-02T00:52:53.495Z] --- PASS: TestPluginWithDevMounts (1.46s)
00:52:53 [2024-04-02T00:52:53.495Z] PASS
00:52:53 [2024-04-02T00:52:53.495Z] 
00:52:53 [2024-04-02T00:52:53.495Z] DONE 1 tests in 1.487s
00:52:53 [2024-04-02T00:52:53.495Z] Running /go/src/github.com/docker/docker/integration/secret (arm64.integration.secret) flags=-test.v -test.timeout=120m  
00:52:53 [2024-04-02T00:52:53.495Z] ++ '[' -n '' ']'
00:52:53 [2024-04-02T00:52:53.495Z] ++ 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
00:52:53 [2024-04-02T00:52:53.495Z] ++ set -e
00:52:53 [2024-04-02T00:52:53.495Z] ++ '[' -n 0 ']'
00:52:53 [2024-04-02T00:52:53.495Z] ++ set -x
00:52:53 [2024-04-02T00:52:53.495Z] ++ 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.CIAySlzEL6/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
00:52:53 [2024-04-02T00:52:53.751Z] INFO: Testing against a local daemon
00:52:53 [2024-04-02T00:52:53.752Z] === RUN   TestSecretInspect
00:52:55 [2024-04-02T00:52:55.675Z] --- PASS: TestSecretInspect (1.83s)
00:52:55 [2024-04-02T00:52:55.675Z] === RUN   TestSecretList
00:52:57 [2024-04-02T00:52:57.568Z] --- PASS: TestSecretList (1.86s)
00:52:57 [2024-04-02T00:52:57.568Z] === RUN   TestSecretsCreateAndDelete
00:52:59 [2024-04-02T00:52:59.460Z] --- PASS: TestSecretsCreateAndDelete (1.90s)
00:52:59 [2024-04-02T00:52:59.460Z] === RUN   TestSecretsUpdate
00:53:01 [2024-04-02T00:53:01.352Z] --- PASS: TestSecretsUpdate (2.06s)
00:53:01 [2024-04-02T00:53:01.352Z] === RUN   TestTemplatedSecret
00:53:03 [2024-04-02T00:53:03.871Z] --- PASS: TestTemplatedSecret (2.36s)
00:53:03 [2024-04-02T00:53:03.871Z] === RUN   TestSecretCreateResolve
00:53:05 [2024-04-02T00:53:05.763Z] --- PASS: TestSecretCreateResolve (1.85s)
00:53:05 [2024-04-02T00:53:05.763Z] PASS
00:53:05 [2024-04-02T00:53:05.763Z] 
00:53:05 [2024-04-02T00:53:05.763Z] DONE 6 tests in 11.882s
00:53:05 [2024-04-02T00:53:05.763Z] Running /go/src/github.com/docker/docker/integration/service (arm64.integration.service) flags=-test.v -test.timeout=120m  
00:53:05 [2024-04-02T00:53:05.763Z] ++ '[' -n '' ']'
00:53:05 [2024-04-02T00:53:05.764Z] ++ 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
00:53:05 [2024-04-02T00:53:05.764Z] ++ set -e
00:53:05 [2024-04-02T00:53:05.764Z] ++ '[' -n 0 ']'
00:53:05 [2024-04-02T00:53:05.764Z] ++ set -x
00:53:05 [2024-04-02T00:53:05.764Z] ++ 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.CIAySlzEL6/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
00:53:05 [2024-04-02T00:53:05.764Z] INFO: Testing against a local daemon
00:53:05 [2024-04-02T00:53:05.764Z] === RUN   TestServiceCreateInit
00:53:05 [2024-04-02T00:53:05.764Z] === RUN   TestServiceCreateInit/daemonInitDisabled
00:53:09 [2024-04-02T00:53:09.035Z] === RUN   TestServiceCreateInit/daemonInitEnabled
00:53:13 [2024-04-02T00:53:13.207Z] --- PASS: TestServiceCreateInit (6.99s)
00:53:13 [2024-04-02T00:53:13.207Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (3.42s)
00:53:13 [2024-04-02T00:53:13.207Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (3.56s)
00:53:13 [2024-04-02T00:53:13.207Z] === RUN   TestCreateServiceMultipleTimes
00:53:28 [2024-04-02T00:53:28.055Z] --- PASS: TestCreateServiceMultipleTimes (14.59s)
00:53:28 [2024-04-02T00:53:28.055Z] === RUN   TestCreateServiceConflict
00:53:28 [2024-04-02T00:53:28.984Z] --- PASS: TestCreateServiceConflict (1.93s)
00:53:28 [2024-04-02T00:53:28.984Z] === RUN   TestCreateServiceMaxReplicas
00:53:32 [2024-04-02T00:53:32.255Z] --- PASS: TestCreateServiceMaxReplicas (2.73s)
00:53:32 [2024-04-02T00:53:32.255Z] === RUN   TestCreateServiceSecretFileMode
00:53:44 [2024-04-02T00:53:44.429Z] --- PASS: TestCreateServiceSecretFileMode (12.32s)
00:53:44 [2024-04-02T00:53:44.429Z] === RUN   TestCreateServiceConfigFileMode
00:53:56 [2024-04-02T00:53:56.602Z] --- PASS: TestCreateServiceConfigFileMode (12.33s)
00:53:56 [2024-04-02T00:53:56.603Z] === RUN   TestCreateServiceSysctls
00:53:59 [2024-04-02T00:53:59.873Z] --- PASS: TestCreateServiceSysctls (2.88s)
00:53:59 [2024-04-02T00:53:59.873Z] === RUN   TestCreateServiceCapabilities
00:54:01 [2024-04-02T00:54:01.766Z] --- PASS: TestCreateServiceCapabilities (2.34s)
00:54:01 [2024-04-02T00:54:01.766Z] === RUN   TestInspect
00:54:04 [2024-04-02T00:54:04.285Z] --- PASS: TestInspect (2.60s)
00:54:04 [2024-04-02T00:54:04.285Z] === RUN   TestCreateJob
00:54:07 [2024-04-02T00:54:07.554Z] --- PASS: TestCreateJob (2.86s)
00:54:07 [2024-04-02T00:54:07.554Z] === RUN   TestReplicatedJob
00:54:11 [2024-04-02T00:54:11.726Z] --- PASS: TestReplicatedJob (4.20s)
00:54:11 [2024-04-02T00:54:11.726Z] === RUN   TestUpdateReplicatedJob
00:54:14 [2024-04-02T00:54:14.246Z] --- PASS: TestUpdateReplicatedJob (2.89s)
00:54:14 [2024-04-02T00:54:14.246Z] === RUN   TestServiceListWithStatuses
00:54:18 [2024-04-02T00:54:18.418Z] --- PASS: TestServiceListWithStatuses (4.08s)
00:54:18 [2024-04-02T00:54:18.418Z] === RUN   TestDockerNetworkConnectAliasPreV144
00:54:22 [2024-04-02T00:54:22.591Z] --- PASS: TestDockerNetworkConnectAliasPreV144 (3.83s)
00:54:22 [2024-04-02T00:54:22.591Z] === RUN   TestDockerNetworkReConnect
00:54:25 [2024-04-02T00:54:25.862Z] --- PASS: TestDockerNetworkReConnect (3.18s)
00:54:25 [2024-04-02T00:54:25.862Z] === RUN   TestServicePlugin
00:54:25 [2024-04-02T00:54:25.862Z]     plugin_test.go:25: (*Execution).NotAmd64-fm
00:54:25 [2024-04-02T00:54:25.862Z] --- SKIP: TestServicePlugin (0.00s)
00:54:25 [2024-04-02T00:54:25.862Z] === RUN   TestServiceUpdateLabel
00:54:27 [2024-04-02T00:54:27.229Z] --- PASS: TestServiceUpdateLabel (1.95s)
00:54:27 [2024-04-02T00:54:27.229Z] === RUN   TestServiceUpdateSecrets
00:54:42 [2024-04-02T00:54:42.079Z] --- PASS: TestServiceUpdateSecrets (14.07s)
00:54:42 [2024-04-02T00:54:42.079Z] === RUN   TestServiceUpdateConfigs
00:54:56 [2024-04-02T00:54:56.926Z] --- PASS: TestServiceUpdateConfigs (13.66s)
00:54:56 [2024-04-02T00:54:56.926Z] === RUN   TestServiceUpdateNetwork
00:55:06 [2024-04-02T00:55:06.875Z] --- PASS: TestServiceUpdateNetwork (11.89s)
00:55:06 [2024-04-02T00:55:06.875Z] === RUN   TestServiceUpdatePidsLimit
00:55:08 [2024-04-02T00:55:08.243Z] === RUN   TestServiceUpdatePidsLimit/create_service_with_PidsLimit_300
00:55:08 [2024-04-02T00:55:08.500Z] === RUN   TestServiceUpdatePidsLimit/unset_PidsLimit_to_0
00:55:16 [2024-04-02T00:55:16.591Z] === RUN   TestServiceUpdatePidsLimit/update_PidsLimit_to_100
00:55:23 [2024-04-02T00:55:23.133Z] --- PASS: TestServiceUpdatePidsLimit (15.98s)
00:55:23 [2024-04-02T00:55:23.133Z]     --- PASS: TestServiceUpdatePidsLimit/create_service_with_PidsLimit_300 (0.61s)
00:55:23 [2024-04-02T00:55:23.133Z]     --- PASS: TestServiceUpdatePidsLimit/unset_PidsLimit_to_0 (6.78s)
00:55:23 [2024-04-02T00:55:23.133Z]     --- PASS: TestServiceUpdatePidsLimit/update_PidsLimit_to_100 (6.78s)
00:55:23 [2024-04-02T00:55:23.133Z] PASS
00:55:23 [2024-04-02T00:55:23.133Z] 
00:55:23 [2024-04-02T00:55:23.133Z] === Skipped
00:55:23 [2024-04-02T00:55:23.133Z] === SKIP: arm64.integration.service TestServicePlugin (0.00s)
00:55:23 [2024-04-02T00:55:23.133Z]     plugin_test.go:25: (*Execution).NotAmd64-fm
00:55:23 [2024-04-02T00:55:23.133Z] 
00:55:23 [2024-04-02T00:55:23.133Z] DONE 26 tests, 1 skipped in 137.331s
00:55:23 [2024-04-02T00:55:23.133Z] Running /go/src/github.com/docker/docker/integration/session (arm64.integration.session) flags=-test.v -test.timeout=120m  
00:55:23 [2024-04-02T00:55:23.133Z] ++ '[' -n '' ']'
00:55:23 [2024-04-02T00:55:23.133Z] ++ 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
00:55:23 [2024-04-02T00:55:23.133Z] ++ set -e
00:55:23 [2024-04-02T00:55:23.133Z] ++ '[' -n 0 ']'
00:55:23 [2024-04-02T00:55:23.133Z] ++ set -x
00:55:23 [2024-04-02T00:55:23.133Z] ++ 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.CIAySlzEL6/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
00:55:23 [2024-04-02T00:55:23.133Z] INFO: Testing against a local daemon
00:55:23 [2024-04-02T00:55:23.133Z] === RUN   TestSessionCreate
00:55:23 [2024-04-02T00:55:23.133Z] --- PASS: TestSessionCreate (0.01s)
00:55:23 [2024-04-02T00:55:23.133Z] === RUN   TestSessionCreateWithBadUpgrade
00:55:23 [2024-04-02T00:55:23.133Z] --- PASS: TestSessionCreateWithBadUpgrade (0.01s)
00:55:23 [2024-04-02T00:55:23.133Z] PASS
00:55:23 [2024-04-02T00:55:23.133Z] 
00:55:23 [2024-04-02T00:55:23.133Z] DONE 2 tests in 0.039s
00:55:23 [2024-04-02T00:55:23.133Z] Running /go/src/github.com/docker/docker/integration/system (arm64.integration.system) flags=-test.v -test.timeout=120m  
00:55:23 [2024-04-02T00:55:23.133Z] ++ '[' -n '' ']'
00:55:23 [2024-04-02T00:55:23.133Z] ++ 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
00:55:23 [2024-04-02T00:55:23.133Z] ++ set -e
00:55:23 [2024-04-02T00:55:23.133Z] ++ '[' -n 0 ']'
00:55:23 [2024-04-02T00:55:23.133Z] ++ set -x
00:55:23 [2024-04-02T00:55:23.133Z] ++ 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.CIAySlzEL6/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
00:55:23 [2024-04-02T00:55:23.133Z] INFO: Testing against a local daemon
00:55:23 [2024-04-02T00:55:23.133Z] === RUN   TestCgroupDriverSystemdMemoryLimit
00:55:23 [2024-04-02T00:55:23.133Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
00:55:23 [2024-04-02T00:55:23.133Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
00:55:23 [2024-04-02T00:55:23.133Z] === RUN   TestDiskUsage
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/empty
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/empty/container_types
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/empty/image_types
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/empty/volume_types
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/empty/build-cache_types
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/empty/container,_volume_types
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/empty/image,_build-cache_types
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/empty/container,_volume,_build-cache_types
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/empty/image,_volume,_build-cache_types
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/empty/container,_image,_volume_types
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/empty/container,_image,_volume,_build-cache_types
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/after_LoadBusybox
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/after_LoadBusybox/container_types
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/after_LoadBusybox/image_types
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/after_LoadBusybox/volume_types
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/after_LoadBusybox/build-cache_types
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/after_LoadBusybox/container,_volume_types
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/after_LoadBusybox/image,_build-cache_types
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/after_LoadBusybox/container,_volume,_build-cache_types
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/after_LoadBusybox/image,_volume,_build-cache_types
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/after_LoadBusybox/container,_image,_volume_types
00:55:23 [2024-04-02T00:55:23.390Z] === RUN   TestDiskUsage/after_LoadBusybox/container,_image,_volume,_build-cache_types
00:55:23 [2024-04-02T00:55:23.647Z] === RUN   TestDiskUsage/after_container.Run
00:55:23 [2024-04-02T00:55:23.647Z] === RUN   TestDiskUsage/after_container.Run/container_types
00:55:23 [2024-04-02T00:55:23.647Z] === RUN   TestDiskUsage/after_container.Run/image_types
00:55:23 [2024-04-02T00:55:23.647Z] === RUN   TestDiskUsage/after_container.Run/volume_types
00:55:23 [2024-04-02T00:55:23.647Z] === RUN   TestDiskUsage/after_container.Run/build-cache_types
00:55:23 [2024-04-02T00:55:23.647Z] === RUN   TestDiskUsage/after_container.Run/container,_volume_types
00:55:23 [2024-04-02T00:55:23.647Z] === RUN   TestDiskUsage/after_container.Run/image,_build-cache_types
00:55:23 [2024-04-02T00:55:23.647Z] === RUN   TestDiskUsage/after_container.Run/container,_volume,_build-cache_types
00:55:23 [2024-04-02T00:55:23.647Z] === RUN   TestDiskUsage/after_container.Run/image,_volume,_build-cache_types
00:55:23 [2024-04-02T00:55:23.647Z] === RUN   TestDiskUsage/after_container.Run/container,_image,_volume_types
00:55:23 [2024-04-02T00:55:23.647Z] === RUN   TestDiskUsage/after_container.Run/container,_image,_volume,_build-cache_types
00:55:23 [2024-04-02T00:55:23.904Z] --- PASS: TestDiskUsage (1.01s)
00:55:23 [2024-04-02T00:55:23.904Z]     --- PASS: TestDiskUsage/empty (0.01s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/empty/container_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/empty/image_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/empty/volume_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/empty/build-cache_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/empty/container,_volume_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/empty/image,_build-cache_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/empty/container,_volume,_build-cache_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/empty/image,_volume,_build-cache_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/empty/container,_image,_volume_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/empty/container,_image,_volume,_build-cache_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]     --- PASS: TestDiskUsage/after_LoadBusybox (0.08s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/after_LoadBusybox/image_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/after_LoadBusybox/volume_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/after_LoadBusybox/build-cache_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container,_volume_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/after_LoadBusybox/image,_build-cache_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container,_volume,_build-cache_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/after_LoadBusybox/image,_volume,_build-cache_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container,_image,_volume_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container,_image,_volume,_build-cache_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]     --- PASS: TestDiskUsage/after_container.Run (0.24s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/after_container.Run/container_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/after_container.Run/image_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/after_container.Run/volume_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/after_container.Run/build-cache_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/after_container.Run/container,_volume_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/after_container.Run/image,_build-cache_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/after_container.Run/container,_volume,_build-cache_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/after_container.Run/image,_volume,_build-cache_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/after_container.Run/container,_image,_volume_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z]         --- PASS: TestDiskUsage/after_container.Run/container,_image,_volume,_build-cache_types (0.00s)
00:55:23 [2024-04-02T00:55:23.904Z] === RUN   TestEventsExecDie
00:55:24 [2024-04-02T00:55:24.468Z] --- PASS: TestEventsExecDie (0.45s)
00:55:24 [2024-04-02T00:55:24.468Z] === RUN   TestEventsBackwardsCompatible
00:55:24 [2024-04-02T00:55:24.468Z] --- PASS: TestEventsBackwardsCompatible (0.04s)
00:55:24 [2024-04-02T00:55:24.468Z] === RUN   TestEventsVolumeCreate
00:55:24 [2024-04-02T00:55:24.468Z] --- PASS: TestEventsVolumeCreate (0.05s)
00:55:24 [2024-04-02T00:55:24.468Z] === RUN   TestInfoBinaryCommits
00:55:24 [2024-04-02T00:55:24.468Z] --- PASS: TestInfoBinaryCommits (0.01s)
00:55:24 [2024-04-02T00:55:24.468Z] === RUN   TestInfoAPIVersioned
00:55:24 [2024-04-02T00:55:24.468Z] --- PASS: TestInfoAPIVersioned (0.01s)
00:55:24 [2024-04-02T00:55:24.468Z] === RUN   TestInfoAPI
00:55:24 [2024-04-02T00:55:24.468Z] --- PASS: TestInfoAPI (0.01s)
00:55:24 [2024-04-02T00:55:24.468Z] === RUN   TestInfoAPIWarnings
00:55:42 [2024-04-02T00:55:42.522Z] --- PASS: TestInfoAPIWarnings (16.54s)
00:55:42 [2024-04-02T00:55:42.522Z] === RUN   TestInfoDebug
00:55:42 [2024-04-02T00:55:42.522Z] --- PASS: TestInfoDebug (0.52s)
00:55:42 [2024-04-02T00:55:42.522Z] === RUN   TestInfoInsecureRegistries
00:55:42 [2024-04-02T00:55:42.522Z] --- PASS: TestInfoInsecureRegistries (0.52s)
00:55:42 [2024-04-02T00:55:42.522Z] === RUN   TestInfoRegistryMirrors
00:55:42 [2024-04-02T00:55:42.522Z] --- PASS: TestInfoRegistryMirrors (0.52s)
00:55:42 [2024-04-02T00:55:42.522Z] === RUN   TestLoginFailsWithBadCredentials
00:55:43 [2024-04-02T00:55:43.889Z] --- PASS: TestLoginFailsWithBadCredentials (0.98s)
00:55:43 [2024-04-02T00:55:43.889Z] === RUN   TestPingCacheHeaders
00:55:43 [2024-04-02T00:55:43.889Z] --- PASS: TestPingCacheHeaders (0.01s)
00:55:43 [2024-04-02T00:55:43.889Z] === RUN   TestPingGet
00:55:43 [2024-04-02T00:55:43.889Z] --- PASS: TestPingGet (0.01s)
00:55:43 [2024-04-02T00:55:43.889Z] === RUN   TestPingHead
00:55:43 [2024-04-02T00:55:43.889Z] --- PASS: TestPingHead (0.01s)
00:55:43 [2024-04-02T00:55:43.889Z] === RUN   TestPingSwarmHeader
00:55:44 [2024-04-02T00:55:44.145Z] === RUN   TestPingSwarmHeader/before_swarm_init
00:55:44 [2024-04-02T00:55:44.708Z] === RUN   TestPingSwarmHeader/after_swarm_init
00:55:45 [2024-04-02T00:55:45.636Z] === RUN   TestPingSwarmHeader/after_swarm_leave
00:55:45 [2024-04-02T00:55:45.636Z] --- PASS: TestPingSwarmHeader (1.96s)
00:55:45 [2024-04-02T00:55:45.636Z]     --- PASS: TestPingSwarmHeader/before_swarm_init (0.00s)
00:55:45 [2024-04-02T00:55:45.636Z]     --- PASS: TestPingSwarmHeader/after_swarm_init (0.00s)
00:55:45 [2024-04-02T00:55:45.636Z]     --- PASS: TestPingSwarmHeader/after_swarm_leave (0.00s)
00:55:45 [2024-04-02T00:55:45.636Z] === RUN   TestPingBuilderHeader
00:55:45 [2024-04-02T00:55:45.636Z] === RUN   TestPingBuilderHeader/default_config
00:55:46 [2024-04-02T00:55:46.199Z] === RUN   TestPingBuilderHeader/buildkit_disabled
00:55:46 [2024-04-02T00:55:46.762Z] --- PASS: TestPingBuilderHeader (1.04s)
00:55:46 [2024-04-02T00:55:46.762Z]     --- PASS: TestPingBuilderHeader/default_config (0.51s)
00:55:46 [2024-04-02T00:55:46.762Z]     --- PASS: TestPingBuilderHeader/buildkit_disabled (0.52s)
00:55:46 [2024-04-02T00:55:46.762Z] === RUN   TestVersion
00:55:46 [2024-04-02T00:55:46.762Z] --- PASS: TestVersion (0.01s)
00:55:46 [2024-04-02T00:55:46.762Z] PASS
00:55:46 [2024-04-02T00:55:46.762Z] 
00:55:46 [2024-04-02T00:55:46.762Z] === Skipped
00:55:46 [2024-04-02T00:55:46.762Z] === SKIP: arm64.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
00:55:46 [2024-04-02T00:55:46.762Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
00:55:46 [2024-04-02T00:55:46.762Z] 
00:55:46 [2024-04-02T00:55:46.762Z] DONE 57 tests, 1 skipped in 23.720s
00:55:46 [2024-04-02T00:55:46.762Z] Running /go/src/github.com/docker/docker/integration/volume (arm64.integration.volume) flags=-test.v -test.timeout=120m  
00:55:46 [2024-04-02T00:55:46.762Z] ++ '[' -n '' ']'
00:55:46 [2024-04-02T00:55:46.762Z] ++ 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
00:55:46 [2024-04-02T00:55:46.762Z] ++ set -e
00:55:46 [2024-04-02T00:55:46.762Z] ++ '[' -n 0 ']'
00:55:46 [2024-04-02T00:55:46.762Z] ++ set -x
00:55:46 [2024-04-02T00:55:46.762Z] ++ 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.CIAySlzEL6/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
00:55:46 [2024-04-02T00:55:46.762Z] INFO: Testing against a local daemon
00:55:46 [2024-04-02T00:55:46.762Z] === RUN   TestRunMountVolumeSubdir
00:55:47 [2024-04-02T00:55:47.018Z]     mount_test.go:28: Setup stderr:
00:55:47 [2024-04-02T00:55:47.018Z]     mount_test.go:28: Setup stdout:
00:55:47 [2024-04-02T00:55:47.018Z]         /volume:
00:55:47 [2024-04-02T00:55:47.018Z]         total 24K    
00:55:47 [2024-04-02T00:55:47.018Z]         drwxr-xr-x    5 root     root        4.0K Apr  2 00:55 .
00:55:47 [2024-04-02T00:55:47.018Z]         drwxr-xr-x    1 root     root        4.0K Apr  2 00:55 ..
00:55:47 [2024-04-02T00:55:47.018Z]         -rw-r--r--    1 root     root           4 Apr  2 00:55 bar.txt
00:55:47 [2024-04-02T00:55:47.018Z]         drwxr-xr-x    2 root     root        4.0K Apr  2 00:55 bin
00:55:47 [2024-04-02T00:55:47.018Z]         drwxr-xr-x    3 root     root        4.0K Apr  2 00:55 hack
00:55:47 [2024-04-02T00:55:47.018Z]         drwxr-xr-x    2 root     root        4.0K Apr  2 00:55 subdir
00:55:47 [2024-04-02T00:55:47.018Z]         
00:55:47 [2024-04-02T00:55:47.018Z]         /volume/hack/:
00:55:47 [2024-04-02T00:55:47.018Z]         total 12K    
00:55:47 [2024-04-02T00:55:47.018Z]         drwxr-xr-x    3 root     root        4.0K Apr  2 00:55 .
00:55:47 [2024-04-02T00:55:47.018Z]         drwxr-xr-x    5 root     root        4.0K Apr  2 00:55 ..
00:55:47 [2024-04-02T00:55:47.018Z]         lrwxrwxrwx    1 root     root           4 Apr  2 00:55 bad -> root
00:55:47 [2024-04-02T00:55:47.018Z]         lrwxrwxrwx    1 root     root           9 Apr  2 00:55 good -> ../subdir
00:55:47 [2024-04-02T00:55:47.018Z]         drwxr-xr-x    2 root     root        4.0K Apr  2 00:55 iwanttobehackedwithtoctou
00:55:47 [2024-04-02T00:55:47.018Z]         lrwxrwxrwx    1 root     root           1 Apr  2 00:55 root -> /
00:55:47 [2024-04-02T00:55:47.018Z] === RUN   TestRunMountVolumeSubdir/subdir
00:55:47 [2024-04-02T00:55:47.581Z]     mount_test.go:101: stdout:
00:55:47 [2024-04-02T00:55:47.581Z]         hello.txt
00:55:47 [2024-04-02T00:55:47.581Z]     mount_test.go:102: stderr:
00:55:47 [2024-04-02T00:55:47.581Z] === RUN   TestRunMountVolumeSubdir/subdir_link
00:55:47 [2024-04-02T00:55:47.838Z]     mount_test.go:101: stdout:
00:55:47 [2024-04-02T00:55:47.838Z]         hello.txt
00:55:47 [2024-04-02T00:55:47.838Z]     mount_test.go:102: stderr:
00:55:47 [2024-04-02T00:55:47.838Z] === RUN   TestRunMountVolumeSubdir/subdir_with_copy_data
00:55:48 [2024-04-02T00:55:48.094Z]     mount_test.go:101: stdout:
00:55:48 [2024-04-02T00:55:48.094Z]         /bin/busybox
00:55:48 [2024-04-02T00:55:48.094Z]     mount_test.go:102: stderr:
00:55:48 [2024-04-02T00:55:48.350Z] === RUN   TestRunMountVolumeSubdir/file
00:55:48 [2024-04-02T00:55:48.607Z]     mount_test.go:101: stdout:
00:55:48 [2024-04-02T00:55:48.607Z]         foo
00:55:48 [2024-04-02T00:55:48.607Z]     mount_test.go:102: stderr:
00:55:48 [2024-04-02T00:55:48.607Z] === RUN   TestRunMountVolumeSubdir/relative_with_backtracks
00:55:48 [2024-04-02T00:55:48.607Z] === RUN   TestRunMountVolumeSubdir/not_existing
00:55:48 [2024-04-02T00:55:48.864Z] === RUN   TestRunMountVolumeSubdir/mount_link
00:55:48 [2024-04-02T00:55:48.864Z] === RUN   TestRunMountVolumeSubdir/mount_link_link
00:55:49 [2024-04-02T00:55:49.120Z] --- PASS: TestRunMountVolumeSubdir (2.42s)
00:55:49 [2024-04-02T00:55:49.120Z]     --- PASS: TestRunMountVolumeSubdir/subdir (0.38s)
00:55:49 [2024-04-02T00:55:49.120Z]     --- PASS: TestRunMountVolumeSubdir/subdir_link (0.37s)
00:55:49 [2024-04-02T00:55:49.120Z]     --- PASS: TestRunMountVolumeSubdir/subdir_with_copy_data (0.40s)
00:55:49 [2024-04-02T00:55:49.120Z]     --- PASS: TestRunMountVolumeSubdir/file (0.42s)
00:55:49 [2024-04-02T00:55:49.120Z]     --- PASS: TestRunMountVolumeSubdir/relative_with_backtracks (0.00s)
00:55:49 [2024-04-02T00:55:49.120Z]     --- PASS: TestRunMountVolumeSubdir/not_existing (0.17s)
00:55:49 [2024-04-02T00:55:49.120Z]     --- PASS: TestRunMountVolumeSubdir/mount_link (0.12s)
00:55:49 [2024-04-02T00:55:49.120Z]     --- PASS: TestRunMountVolumeSubdir/mount_link_link (0.14s)
00:55:49 [2024-04-02T00:55:49.120Z] === RUN   TestVolumesCreateAndList
00:55:49 [2024-04-02T00:55:49.120Z] --- PASS: TestVolumesCreateAndList (0.01s)
00:55:49 [2024-04-02T00:55:49.120Z] === RUN   TestVolumesRemove
00:55:49 [2024-04-02T00:55:49.120Z] === RUN   TestVolumesRemove/volume_in_use
00:55:49 [2024-04-02T00:55:49.120Z] === RUN   TestVolumesRemove/volume_not_in_use
00:55:49 [2024-04-02T00:55:49.120Z] === RUN   TestVolumesRemove/non-existing_volume
00:55:49 [2024-04-02T00:55:49.120Z] === RUN   TestVolumesRemove/non-existing_volume_force
00:55:49 [2024-04-02T00:55:49.120Z] --- PASS: TestVolumesRemove (0.05s)
00:55:49 [2024-04-02T00:55:49.120Z]     --- PASS: TestVolumesRemove/volume_in_use (0.00s)
00:55:49 [2024-04-02T00:55:49.120Z]     --- PASS: TestVolumesRemove/volume_not_in_use (0.01s)
00:55:49 [2024-04-02T00:55:49.120Z]     --- PASS: TestVolumesRemove/non-existing_volume (0.00s)
00:55:49 [2024-04-02T00:55:49.120Z]     --- PASS: TestVolumesRemove/non-existing_volume_force (0.00s)
00:55:49 [2024-04-02T00:55:49.120Z] === RUN   TestVolumesRemoveSwarmEnabled
00:55:49 [2024-04-02T00:55:49.120Z] === PAUSE TestVolumesRemoveSwarmEnabled
00:55:49 [2024-04-02T00:55:49.120Z] === RUN   TestVolumesInspect
00:55:49 [2024-04-02T00:55:49.120Z] --- PASS: TestVolumesInspect (0.01s)
00:55:49 [2024-04-02T00:55:49.120Z] === RUN   TestVolumesInvalidJSON
00:55:49 [2024-04-02T00:55:49.120Z] === RUN   TestVolumesInvalidJSON/volumes/create
00:55:49 [2024-04-02T00:55:49.120Z] === PAUSE TestVolumesInvalidJSON/volumes/create
00:55:49 [2024-04-02T00:55:49.120Z] === CONT  TestVolumesInvalidJSON/volumes/create
00:55:49 [2024-04-02T00:55:49.120Z] === RUN   TestVolumesInvalidJSON/volumes/create/invalid_content_type
00:55:49 [2024-04-02T00:55:49.120Z] === RUN   TestVolumesInvalidJSON/volumes/create/invalid_JSON
00:55:49 [2024-04-02T00:55:49.120Z] === RUN   TestVolumesInvalidJSON/volumes/create/extra_content_after_JSON
00:55:49 [2024-04-02T00:55:49.120Z] === RUN   TestVolumesInvalidJSON/volumes/create/empty_body
00:55:49 [2024-04-02T00:55:49.120Z] --- PASS: TestVolumesInvalidJSON (0.01s)
00:55:49 [2024-04-02T00:55:49.120Z]     --- PASS: TestVolumesInvalidJSON/volumes/create (0.00s)
00:55:49 [2024-04-02T00:55:49.120Z]         --- PASS: TestVolumesInvalidJSON/volumes/create/invalid_content_type (0.00s)
00:55:49 [2024-04-02T00:55:49.120Z]         --- PASS: TestVolumesInvalidJSON/volumes/create/invalid_JSON (0.00s)
00:55:49 [2024-04-02T00:55:49.120Z]         --- PASS: TestVolumesInvalidJSON/volumes/create/extra_content_after_JSON (0.00s)
00:55:49 [2024-04-02T00:55:49.120Z]         --- PASS: TestVolumesInvalidJSON/volumes/create/empty_body (0.00s)
00:55:49 [2024-04-02T00:55:49.120Z] === RUN   TestVolumePruneAnonymous
00:55:49 [2024-04-02T00:55:49.120Z] --- PASS: TestVolumePruneAnonymous (0.02s)
00:55:49 [2024-04-02T00:55:49.120Z] === RUN   TestVolumePruneAnonFromImage
00:55:49 [2024-04-02T00:55:49.377Z] --- PASS: TestVolumePruneAnonFromImage (0.11s)
00:55:49 [2024-04-02T00:55:49.377Z] === CONT  TestVolumesRemoveSwarmEnabled
00:55:50 [2024-04-02T00:55:50.743Z] === RUN   TestVolumesRemoveSwarmEnabled/volume_in_use
00:55:50 [2024-04-02T00:55:50.743Z] === RUN   TestVolumesRemoveSwarmEnabled/volume_not_in_use
00:55:50 [2024-04-02T00:55:50.743Z] === RUN   TestVolumesRemoveSwarmEnabled/non-existing_volume
00:55:50 [2024-04-02T00:55:50.743Z] === RUN   TestVolumesRemoveSwarmEnabled/non-existing_volume_force
00:55:51 [2024-04-02T00:55:51.000Z] --- PASS: TestVolumesRemoveSwarmEnabled (1.84s)
00:55:51 [2024-04-02T00:55:51.000Z]     --- PASS: TestVolumesRemoveSwarmEnabled/volume_in_use (0.00s)
00:55:51 [2024-04-02T00:55:51.000Z]     --- PASS: TestVolumesRemoveSwarmEnabled/volume_not_in_use (0.01s)
00:55:51 [2024-04-02T00:55:51.000Z]     --- PASS: TestVolumesRemoveSwarmEnabled/non-existing_volume (0.00s)
00:55:51 [2024-04-02T00:55:51.000Z]     --- PASS: TestVolumesRemoveSwarmEnabled/non-existing_volume_force (0.00s)
00:55:51 [2024-04-02T00:55:51.000Z] PASS
00:55:51 [2024-04-02T00:55:51.000Z] 
00:55:51 [2024-04-02T00:55:51.000Z] DONE 29 tests in 4.499s
00:55:51 [2024-04-02T00:55:51.257Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
00:55:51 [2024-04-02T00:55:51.257Z] ++++ cat bundles/test-integration/TestUsernsCommit/db253c5d4ae89/docker.pid
00:55:51 [2024-04-02T00:55:51.257Z] +++ kill 68287
00:55:51 [2024-04-02T00:55:51.257Z] /go/src/github.com/docker/docker/hack/make/.integration-daemon-stop: line 13: wait: pid 68287 is not a child of this shell
00:55:51 [2024-04-02T00:55:51.257Z] warning: PID 68287 from bundles/test-integration/TestUsernsCommit/db253c5d4ae89/docker.pid had a nonzero exit code
00:55:51 [2024-04-02T00:55:51.257Z] umount: bundles/test-integration/TestUsernsCommit/db253c5d4ae89/root: not mounted.
00:55:51 [2024-04-02T00:55:51.257Z] ++++ cat bundles/test-integration/docker.pid
00:55:51 [2024-04-02T00:55:51.257Z] +++ kill 25013
00:55:52 [2024-04-02T00:55:52.624Z] +++ /etc/init.d/apparmor stop
00:55:52 [2024-04-02T00:55:52.624Z] Leaving: AppArmorNo profiles have been unloaded.
00:55:52 [2024-04-02T00:55:52.624Z] 
00:55:52 [2024-04-02T00:55:52.624Z] Unloading profiles will leave already running processes permanently
00:55:52 [2024-04-02T00:55:52.624Z] unconfined, which can lead to unexpected situations.
00:55:52 [2024-04-02T00:55:52.624Z] 
00:55:52 [2024-04-02T00:55:52.624Z] To set a process to complain mode, use the command line tool
00:55:52 [2024-04-02T00:55:52.624Z] 'aa-complain'. To really tear down all profiles, run 'aa-teardown'."
00:55:52 [2024-04-02T00:55:52.624Z] +++ true
00:55:52 [2024-04-02T00:55:52.624Z] exiting test-integration
00:55:52 [2024-04-02T00:55:52.624Z] ++ exit 0
00:55:52 [2024-04-02T00:55:52.624Z] 
Post stage
[Pipeline] junit
00:55:54 [2024-04-02T00:55:54.017Z] Recording test results
00:55:54 [2024-04-02T00:55:54.270Z] [Checks API] No suitable checks publisher found.
[Pipeline] }
[Pipeline] // withEnv
[Pipeline] }
[Pipeline] // stage
Post stage
[Pipeline] sh
00:55:54 [2024-04-02T00:55:54.574Z] + echo Ensuring container killed.
00:55:54 [2024-04-02T00:55:54.574Z] Ensuring container killed.
00:55:54 [2024-04-02T00:55:54.574Z] + docker rm -vf docker-pr1
00:55:54 [2024-04-02T00:55:54.574Z] Error response from daemon: No such container: docker-pr1
[Pipeline] sh
00:55:54 [2024-04-02T00:55:54.849Z] + echo Chowning /workspace to jenkins user
00:55:54 [2024-04-02T00:55:54.849Z] Chowning /workspace to jenkins user
00:55:54 [2024-04-02T00:55:54.849Z] + id -u
00:55:54 [2024-04-02T00:55:54.849Z] + id -g
00:55:54 [2024-04-02T00:55:54.849Z] + docker run --rm -v /home/ubuntu/workspace/moby_PR-47659:/workspace busybox chown -R 1000:1000 /workspace
00:55:54 [2024-04-02T00:55:54.849Z] Unable to find image 'busybox:latest' locally
00:55:54 [2024-04-02T00:55:54.849Z] latest: Pulling from library/busybox
00:55:54 [2024-04-02T00:55:54.849Z] 45d8eb5967de: Already exists
00:55:55 [2024-04-02T00:55:55.105Z] Digest: sha256:c3839dd800b9eb7603340509769c43e146a74c63dca3045a8e7dc8ee07e53966
00:55:55 [2024-04-02T00:55:55.105Z] Status: Downloaded newer image for busybox:latest
[Pipeline] catchError
[Pipeline] {
[Pipeline] sh
00:55:56 [2024-04-02T00:55:56.751Z] + bundleName=arm64-integration
00:55:56 [2024-04-02T00:55:56.751Z] + echo Creating arm64-integration-bundles.tar.gz
00:55:56 [2024-04-02T00:55:56.751Z] Creating arm64-integration-bundles.tar.gz
00:55:56 [2024-04-02T00:55:56.751Z] + find bundles -path */root/*overlay2 -prune -o -type f ( -name *-report.json -o -name *.log -o -name *.prof -o -name *-report.xml ) -print
00:55:56 [2024-04-02T00:55:56.751Z] + xargs tar -czf arm64-integration-bundles.tar.gz
[Pipeline] archiveArtifacts
00:55:57 [2024-04-02T00:55:57.017Z] Archiving artifacts
00:55:58 [2024-04-02T00:55:58.262Z] Uploaded 1 artifact(s) to https://docker-ci-jenkins-artifacts.s3.amazonaws.com/public/moby/PR-47659/1/artifacts/
[Pipeline] }
[Pipeline] // catchError
[Pipeline] sh
00:55:58 [2024-04-02T00:55:58.592Z] + make clean
00:55:58 [2024-04-02T00:55:58.592Z] docker volume rm -f docker-dev-cache docker-mod-cache
00:55:58 [2024-04-02T00:55:58.592Z] docker-dev-cache
00:55:58 [2024-04-02T00:55:58.592Z] docker-mod-cache
[Pipeline] deleteDir
[Pipeline] }
[Pipeline] // withEnv
[Pipeline] }
[Pipeline] // withEnv
[Pipeline] }
[Pipeline] // node
[Pipeline] }
[Pipeline] // stage
[Pipeline] }
[Pipeline] // parallel
[Pipeline] }
[Pipeline] // stage
[Pipeline] }
[Pipeline] // timestamps
[Pipeline] }
[Pipeline] // timeout
[Pipeline] }
[Pipeline] // withEnv
[Pipeline] End of Pipeline
Finished: SUCCESS
Deleted 0 stash(es) from https://docker-ci-jenkins-artifacts.s3.amazonaws.com/public/moby/PR-47659/1/stashes/