Skipping 709 KB.. Full Log

02:40:32 [2024-02-01T02:40:32.089Z] time="2024-02-01T02:40:31.899982634Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=846071f8-fc4b-484b-9abc-8c84b2cf7ac0 http.request.method=GET http.request.remoteaddr="127.0.0.1:34478" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
02:40:32 [2024-02-01T02:40:32.089Z] time="2024-02-01T02:40:31.900047648Z" level=debug msg=GetBlob go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=846071f8-fc4b-484b-9abc-8c84b2cf7ac0 http.request.method=GET http.request.remoteaddr="127.0.0.1:34478" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
02:40:32 [2024-02-01T02:40:32.089Z] time="2024-02-01T02:40:31.900139Z" 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=846071f8-fc4b-484b-9abc-8c84b2cf7ac0 http.request.method=GET http.request.remoteaddr="127.0.0.1:34478" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=41.04µ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=0b7adf30-e616-4217-934d-77834851b12a trace.line=95 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
02:40:32 [2024-02-01T02:40:32.089Z] time="2024-02-01T02:40:31.900042077Z" 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=a0f82d5b-6e8a-4e77-b9f6-ff08f5a51d8e http.request.method=GET http.request.remoteaddr="127.0.0.1:34474" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=20.611µ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=dfbc640c-c761-47ea-9498-3726cbcd6b38 trace.line=95 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
02:40:32 [2024-02-01T02:40:32.089Z] time="2024-02-01T02:40:31.900203342Z" 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=846071f8-fc4b-484b-9abc-8c84b2cf7ac0 http.request.method=GET http.request.remoteaddr="127.0.0.1:34478" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=19.314µ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=4637314a-14d7-4c9b-9c2c-e96531427d4b trace.line=155 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
02:40:32 [2024-02-01T02:40:32.089Z] time="2024-02-01T02:40:31.900242265Z" 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=a0f82d5b-6e8a-4e77-b9f6-ff08f5a51d8e http.request.method=GET http.request.remoteaddr="127.0.0.1:34474" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=21.332µ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=dc6b8900-7c2c-4da4-92eb-70321b6f669a trace.line=155 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
02:40:32 [2024-02-01T02:40:32.089Z] time="2024-02-01T02:40:31.900264918Z" 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=846071f8-fc4b-484b-9abc-8c84b2cf7ac0 http.request.method=GET http.request.remoteaddr="127.0.0.1:34478" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=18.379µ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=94a6a057-584e-4e0a-b507-c67ecf040f20 trace.line=95 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
02:40:32 [2024-02-01T02:40:32.089Z] time="2024-02-01T02:40:31.900301257Z" 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=a0f82d5b-6e8a-4e77-b9f6-ff08f5a51d8e http.request.method=GET http.request.remoteaddr="127.0.0.1:34474" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=12.167µ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=bff07515-90da-4559-8111-0aa3d148182e trace.line=155 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
02:40:32 [2024-02-01T02:40:32.089Z] time="2024-02-01T02:40:31.900310192Z" 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=846071f8-fc4b-484b-9abc-8c84b2cf7ac0 http.request.method=GET http.request.remoteaddr="127.0.0.1:34478" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=11.995µ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=41e9cbe4-74f3-41ff-b5d4-ff4f03757ec5 trace.line=155 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
02:40:32 [2024-02-01T02:40:32.089Z] time="2024-02-01T02:40:31.900355507Z" 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=a0f82d5b-6e8a-4e77-b9f6-ff08f5a51d8e http.request.method=GET http.request.remoteaddr="127.0.0.1:34474" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=13.858µ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=5236f3c2-50a1-4b7e-8411-9b0fbdf1b3c7 trace.line=217 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
02:40:32 [2024-02-01T02:40:32.089Z] time="2024-02-01T02:40:31.900435372Z" 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=a0f82d5b-6e8a-4e77-b9f6-ff08f5a51d8e http.request.method=GET http.request.remoteaddr="127.0.0.1:34474" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=18.789µ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=b95175eb-1625-4456-ac58-22ee3b7dab2f trace.line=125 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
02:40:32 [2024-02-01T02:40:32.089Z] time="2024-02-01T02:40:31.900463128Z" 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=846071f8-fc4b-484b-9abc-8c84b2cf7ac0 http.request.method=GET http.request.remoteaddr="127.0.0.1:34478" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=102.411µ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=4897e630-54d4-431b-aae4-748af207b2f7 trace.line=155 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
02:40:32 [2024-02-01T02:40:32.089Z] time="2024-02-01T02:40:31.900703306Z" 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=846071f8-fc4b-484b-9abc-8c84b2cf7ac0 http.request.method=GET http.request.remoteaddr="127.0.0.1:34478" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=9.895µ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=4e2e6de9-7b62-4c12-ae10-e9bf108b92bf trace.line=217 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
02:40:32 [2024-02-01T02:40:32.089Z] time="2024-02-01T02:40:31.900766499Z" 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=846071f8-fc4b-484b-9abc-8c84b2cf7ac0 http.request.method=GET http.request.remoteaddr="127.0.0.1:34478" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=19.938µ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=8231a77b-b655-42e2-872d-9a8e2147b98d trace.line=125 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
02:40:32 [2024-02-01T02:40:32.089Z] time="2024-02-01T02:40:31.901314379Z" 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=846071f8-fc4b-484b-9abc-8c84b2cf7ac0 http.request.method=GET http.request.remoteaddr="127.0.0.1:34478" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=35.092µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).GetContent" trace.id=a2799755-01e8-40b1-b3c5-6a25ae80bc67 trace.line=95 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
02:40:32 [2024-02-01T02:40:32.089Z] time="2024-02-01T02:40:31.901432724Z" 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=846071f8-fc4b-484b-9abc-8c84b2cf7ac0 http.request.method=GET http.request.remoteaddr="127.0.0.1:34478" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=54.217µ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=2be75268-7d52-4931-80e9-b6ef5bd395d9 trace.line=155 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
02:40:32 [2024-02-01T02:40:32.089Z] time="2024-02-01T02:40:31.901520851Z" level=info msg="response completed" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=846071f8-fc4b-484b-9abc-8c84b2cf7ac0 http.request.method=GET http.request.remoteaddr="127.0.0.1:34478" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/octet-stream" http.response.duration=3.01329ms http.response.status=200 http.response.written=68 
02:40:32 [2024-02-01T02:40:32.089Z] 127.0.0.1 - - [01/Feb/2024:02:40:31 +0000] "GET /v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923 HTTP/1.1" 200 68 "" "docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
02:40:32 [2024-02-01T02:40:32.089Z] time="2024-02-01T02:40:31.902268057Z" 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=a0f82d5b-6e8a-4e77-b9f6-ff08f5a51d8e http.request.method=GET http.request.remoteaddr="127.0.0.1:34474" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=36.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).GetContent" trace.id=4421d2c6-7330-4275-a359-9a1472fd8791 trace.line=95 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
02:40:32 [2024-02-01T02:40:32.089Z] time="2024-02-01T02:40:31.902360163Z" 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=a0f82d5b-6e8a-4e77-b9f6-ff08f5a51d8e http.request.method=GET http.request.remoteaddr="127.0.0.1:34474" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=15.573µ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=cb913812-be20-4bf3-a20f-232ed6fde330 trace.line=155 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
02:40:32 [2024-02-01T02:40:32.089Z] time="2024-02-01T02:40:31.902440127Z" level=info msg="response completed" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=a0f82d5b-6e8a-4e77-b9f6-ff08f5a51d8e http.request.method=GET http.request.remoteaddr="127.0.0.1:34474" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/octet-stream" http.response.duration=3.969938ms http.response.status=200 http.response.written=194 
02:40:32 [2024-02-01T02:40:32.090Z] 127.0.0.1 - - [01/Feb/2024:02:40:31 +0000] "GET /v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b HTTP/1.1" 200 194 "" "docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
02:40:32 [2024-02-01T02:40:32.090Z] time="2024-02-01T02:40:31.91412583Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=62e887ee-3fd1-42c7-9899-4827496bf683 http.request.method=GET http.request.remoteaddr="127.0.0.1:56198" http.request.uri="/v2/" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" 
02:40:32 [2024-02-01T02:40:32.090Z] time="2024-02-01T02:40:31.914168158Z" level=info msg="response completed" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=62e887ee-3fd1-42c7-9899-4827496bf683 http.request.method=GET http.request.remoteaddr="127.0.0.1:56198" http.request.uri="/v2/" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/json; charset=utf-8" http.response.duration="879.631µs" http.response.status=200 http.response.written=2 
02:40:32 [2024-02-01T02:40:32.090Z] 127.0.0.1 - - [01/Feb/2024:02:40:31 +0000] "GET /v2/ HTTP/1.1" 200 2 "" "docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
02:40:32 [2024-02-01T02:40:32.090Z] time="2024-02-01T02:40:31.920132957Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=097b8b89-50f4-4dc8-b9c1-b447f5043dd4 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:56208" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
02:40:32 [2024-02-01T02:40:32.090Z] time="2024-02-01T02:40:31.920176639Z" level=debug msg=GetImageManifest go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=097b8b89-50f4-4dc8-b9c1-b447f5043dd4 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:56208" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
02:40:32 [2024-02-01T02:40:32.090Z] time="2024-02-01T02:40:31.920189216Z" level=debug msg="(*manifestStore).Get" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=097b8b89-50f4-4dc8-b9c1-b447f5043dd4 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:56208" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
02:40:32 [2024-02-01T02:40:32.090Z] time="2024-02-01T02:40:31.920252631Z" 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=097b8b89-50f4-4dc8-b9c1-b447f5043dd4 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:56208" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=32.236µ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=7aca3a81-6232-444b-9a22-04a58ac6dd8a trace.line=95 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
02:40:32 [2024-02-01T02:40:32.090Z] time="2024-02-01T02:40:31.920297109Z" 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=097b8b89-50f4-4dc8-b9c1-b447f5043dd4 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:56208" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=13.038µ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=a3ce2acd-b2ac-4201-99d7-ba5602f46e14 trace.line=95 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
02:40:32 [2024-02-01T02:40:32.090Z] time="2024-02-01T02:40:31.920369507Z" 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=097b8b89-50f4-4dc8-b9c1-b447f5043dd4 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:56208" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/json; charset=utf-8" http.response.duration=1.046113ms http.response.status=404 http.response.written=181 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
02:40:32 [2024-02-01T02:40:32.090Z] 127.0.0.1 - - [01/Feb/2024:02:40:31 +0000] "HEAD /v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda HTTP/1.1" 404 181 "" "docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
02:40:32 [2024-02-01T02:40:32.090Z] time="2024-02-01T02:40:31.921627664Z" level=debug msg="authorizing request" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=3e03df93-cd34-4e9d-a28f-e5a9bf73ece8 http.request.method=GET http.request.remoteaddr="127.0.0.1:56212" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
02:40:32 [2024-02-01T02:40:32.090Z] time="2024-02-01T02:40:31.92166712Z" level=debug msg=GetImageManifest go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=3e03df93-cd34-4e9d-a28f-e5a9bf73ece8 http.request.method=GET http.request.remoteaddr="127.0.0.1:56212" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
02:40:32 [2024-02-01T02:40:32.090Z] time="2024-02-01T02:40:31.921680822Z" level=debug msg="(*manifestStore).Get" go.version=go1.20.8 http.request.host="127.0.0.1:5000" http.request.id=3e03df93-cd34-4e9d-a28f-e5a9bf73ece8 http.request.method=GET http.request.remoteaddr="127.0.0.1:56212" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
02:40:32 [2024-02-01T02:40:32.090Z] time="2024-02-01T02:40:31.921736385Z" 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=3e03df93-cd34-4e9d-a28f-e5a9bf73ece8 http.request.method=GET http.request.remoteaddr="127.0.0.1:56212" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=28.388µ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=f39a91ea-8916-4d44-8f58-24b708acb72f trace.line=95 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
02:40:32 [2024-02-01T02:40:32.090Z] time="2024-02-01T02:40:31.921784547Z" 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=3e03df93-cd34-4e9d-a28f-e5a9bf73ece8 http.request.method=GET http.request.remoteaddr="127.0.0.1:56212" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=13.825µ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=bcbb9046-2561-462e-b75f-9cac8dc275a4 trace.line=95 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
02:40:32 [2024-02-01T02:40:32.090Z] time="2024-02-01T02:40:31.921830764Z" 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=3e03df93-cd34-4e9d-a28f-e5a9bf73ece8 http.request.method=GET http.request.remoteaddr="127.0.0.1:56212" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/json; charset=utf-8" http.response.duration="977.217µs" http.response.status=404 http.response.written=181 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
02:40:32 [2024-02-01T02:40:32.090Z] 127.0.0.1 - - [01/Feb/2024:02:40:31 +0000] "GET /v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda HTTP/1.1" 404 181 "" "docker/dev go/go1.21.6 git-commit/fb68292057f960f2c66de1239ab9e985a437408b kernel/5.15.0-1050-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
02:40:32 [2024-02-01T02:40:32.090Z] --- PASS: TestImagePullStoredDigestForOtherRepo (0.17s)
02:40:32 [2024-02-01T02:40:32.090Z] === RUN   TestImagePullNonExisting
02:40:32 [2024-02-01T02:40:32.090Z] === RUN   TestImagePullNonExisting/asdfasdf:foobar
02:40:32 [2024-02-01T02:40:32.090Z] === PAUSE TestImagePullNonExisting/asdfasdf:foobar
02:40:32 [2024-02-01T02:40:32.090Z] === RUN   TestImagePullNonExisting/library/asdfasdf:foobar
02:40:32 [2024-02-01T02:40:32.090Z] === PAUSE TestImagePullNonExisting/library/asdfasdf:foobar
02:40:32 [2024-02-01T02:40:32.090Z] === RUN   TestImagePullNonExisting/asdfasdf
02:40:32 [2024-02-01T02:40:32.090Z] === PAUSE TestImagePullNonExisting/asdfasdf
02:40:32 [2024-02-01T02:40:32.090Z] === RUN   TestImagePullNonExisting/asdfasdf:latest
02:40:32 [2024-02-01T02:40:32.090Z] === PAUSE TestImagePullNonExisting/asdfasdf:latest
02:40:32 [2024-02-01T02:40:32.090Z] === RUN   TestImagePullNonExisting/library/asdfasdf
02:40:32 [2024-02-01T02:40:32.090Z] === PAUSE TestImagePullNonExisting/library/asdfasdf
02:40:32 [2024-02-01T02:40:32.090Z] === RUN   TestImagePullNonExisting/library/asdfasdf:latest
02:40:32 [2024-02-01T02:40:32.090Z] === PAUSE TestImagePullNonExisting/library/asdfasdf:latest
02:40:32 [2024-02-01T02:40:32.090Z] === CONT  TestImagePullNonExisting/asdfasdf:foobar
02:40:32 [2024-02-01T02:40:32.090Z] === CONT  TestImagePullNonExisting/asdfasdf:latest
02:40:32 [2024-02-01T02:40:32.090Z] === CONT  TestImagePullNonExisting/library/asdfasdf:foobar
02:40:32 [2024-02-01T02:40:32.090Z] === CONT  TestImagePullNonExisting/library/asdfasdf:latest
02:40:32 [2024-02-01T02:40:32.090Z] === CONT  TestImagePullNonExisting/library/asdfasdf
02:40:32 [2024-02-01T02:40:32.090Z] === CONT  TestImagePullNonExisting/asdfasdf
02:40:33 [2024-02-01T02:40:33.463Z] --- PASS: TestImagePullNonExisting (0.01s)
02:40:33 [2024-02-01T02:40:33.463Z]     --- PASS: TestImagePullNonExisting/asdfasdf:foobar (0.95s)
02:40:33 [2024-02-01T02:40:33.463Z]     --- PASS: TestImagePullNonExisting/asdfasdf:latest (0.95s)
02:40:33 [2024-02-01T02:40:33.463Z]     --- PASS: TestImagePullNonExisting/library/asdfasdf:latest (0.95s)
02:40:33 [2024-02-01T02:40:33.463Z]     --- PASS: TestImagePullNonExisting/library/asdfasdf:foobar (0.96s)
02:40:33 [2024-02-01T02:40:33.463Z]     --- PASS: TestImagePullNonExisting/library/asdfasdf (1.28s)
02:40:33 [2024-02-01T02:40:33.463Z]     --- PASS: TestImagePullNonExisting/asdfasdf (1.31s)
02:40:33 [2024-02-01T02:40:33.463Z] === RUN   TestRemoveImageOrphaning
02:40:33 [2024-02-01T02:40:33.463Z] --- PASS: TestRemoveImageOrphaning (0.19s)
02:40:33 [2024-02-01T02:40:33.463Z] === RUN   TestRemoveByDigest
02:40:33 [2024-02-01T02:40:33.463Z]     remove_test.go:64: !testEnv.UsingSnapshotter(): RepoDigests doesn't include tags when using graphdrivers
02:40:33 [2024-02-01T02:40:33.463Z] --- SKIP: TestRemoveByDigest (0.00s)
02:40:33 [2024-02-01T02:40:33.463Z] === RUN   TestRemoveImageGarbageCollector
02:40:33 [2024-02-01T02:40:33.463Z]     remove_unix_test.go:35: (*Execution).NotAmd64-fm
02:40:33 [2024-02-01T02:40:33.463Z] --- SKIP: TestRemoveImageGarbageCollector (0.00s)
02:40:33 [2024-02-01T02:40:33.463Z] === RUN   TestSaveCheckTimes
02:40:33 [2024-02-01T02:40:33.463Z] === PAUSE TestSaveCheckTimes
02:40:33 [2024-02-01T02:40:33.463Z] === RUN   TestSaveCheckManifestLayers
02:40:33 [2024-02-01T02:40:33.463Z] === PAUSE TestSaveCheckManifestLayers
02:40:33 [2024-02-01T02:40:33.463Z] === RUN   TestSaveRepoWithMultipleImages
02:40:33 [2024-02-01T02:40:33.721Z] --- PASS: TestSaveRepoWithMultipleImages (0.17s)
02:40:33 [2024-02-01T02:40:33.721Z] === RUN   TestSaveDirectoryPermissions
02:40:34 [2024-02-01T02:40:34.654Z] --- PASS: TestSaveDirectoryPermissions (0.98s)
02:40:34 [2024-02-01T02:40:34.654Z] === RUN   TestTagUnprefixedRepoByNameOrName
02:40:34 [2024-02-01T02:40:34.654Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.02s)
02:40:34 [2024-02-01T02:40:34.654Z] === RUN   TestTagUsingDigestAlgorithmAsName
02:40:34 [2024-02-01T02:40:34.654Z] --- PASS: TestTagUsingDigestAlgorithmAsName (0.01s)
02:40:34 [2024-02-01T02:40:34.654Z] === RUN   TestTagValidPrefixedRepo
02:40:34 [2024-02-01T02:40:34.654Z] === RUN   TestTagValidPrefixedRepo/fooo/bar
02:40:34 [2024-02-01T02:40:34.654Z] === PAUSE TestTagValidPrefixedRepo/fooo/bar
02:40:34 [2024-02-01T02:40:34.654Z] === RUN   TestTagValidPrefixedRepo/fooaa/test
02:40:34 [2024-02-01T02:40:34.654Z] === PAUSE TestTagValidPrefixedRepo/fooaa/test
02:40:34 [2024-02-01T02:40:34.654Z] === RUN   TestTagValidPrefixedRepo/foooo:t
02:40:34 [2024-02-01T02:40:34.654Z] === PAUSE TestTagValidPrefixedRepo/foooo:t
02:40:34 [2024-02-01T02:40:34.654Z] === RUN   TestTagValidPrefixedRepo/HOSTNAME.DOMAIN.COM:443/foo/bar
02:40:34 [2024-02-01T02:40:34.654Z] === PAUSE TestTagValidPrefixedRepo/HOSTNAME.DOMAIN.COM:443/foo/bar
02:40:34 [2024-02-01T02:40:34.654Z] === CONT  TestTagValidPrefixedRepo/fooo/bar
02:40:34 [2024-02-01T02:40:34.654Z] === CONT  TestTagValidPrefixedRepo/foooo:t
02:40:34 [2024-02-01T02:40:34.654Z] === CONT  TestTagValidPrefixedRepo/HOSTNAME.DOMAIN.COM:443/foo/bar
02:40:34 [2024-02-01T02:40:34.654Z] === CONT  TestTagValidPrefixedRepo/fooaa/test
02:40:34 [2024-02-01T02:40:34.654Z] --- PASS: TestTagValidPrefixedRepo (0.02s)
02:40:34 [2024-02-01T02:40:34.654Z]     --- PASS: TestTagValidPrefixedRepo/fooo/bar (0.01s)
02:40:34 [2024-02-01T02:40:34.654Z]     --- PASS: TestTagValidPrefixedRepo/foooo:t (0.01s)
02:40:34 [2024-02-01T02:40:34.654Z]     --- PASS: TestTagValidPrefixedRepo/fooaa/test (0.01s)
02:40:34 [2024-02-01T02:40:34.654Z]     --- PASS: TestTagValidPrefixedRepo/HOSTNAME.DOMAIN.COM:443/foo/bar (0.02s)
02:40:34 [2024-02-01T02:40:34.654Z] === RUN   TestTagExistedNameWithoutForce
02:40:34 [2024-02-01T02:40:34.913Z] --- PASS: TestTagExistedNameWithoutForce (0.02s)
02:40:34 [2024-02-01T02:40:34.913Z] === RUN   TestTagOfficialNames
02:40:34 [2024-02-01T02:40:34.913Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_docker.io/busybox
02:40:34 [2024-02-01T02:40:34.913Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_index.docker.io/busybox
02:40:34 [2024-02-01T02:40:34.913Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_library/busybox
02:40:34 [2024-02-01T02:40:34.913Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_docker.io/library/busybox
02:40:34 [2024-02-01T02:40:34.913Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_index.docker.io/library/busybox
02:40:34 [2024-02-01T02:40:34.913Z] --- PASS: TestTagOfficialNames (0.05s)
02:40:34 [2024-02-01T02:40:34.913Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_docker.io/busybox (0.01s)
02:40:34 [2024-02-01T02:40:34.913Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_index.docker.io/busybox (0.01s)
02:40:34 [2024-02-01T02:40:34.913Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_library/busybox (0.01s)
02:40:34 [2024-02-01T02:40:34.913Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_docker.io/library/busybox (0.01s)
02:40:34 [2024-02-01T02:40:34.913Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_index.docker.io/library/busybox (0.01s)
02:40:34 [2024-02-01T02:40:34.913Z] === RUN   TestTagMatchesDigest
02:40:34 [2024-02-01T02:40:34.913Z] --- PASS: TestTagMatchesDigest (0.01s)
02:40:34 [2024-02-01T02:40:34.913Z] === CONT  TestSaveCheckManifestLayers
02:40:34 [2024-02-01T02:40:34.913Z] === CONT  TestSaveCheckTimes
02:40:34 [2024-02-01T02:40:34.913Z] --- PASS: TestSaveCheckTimes (0.03s)
02:40:34 [2024-02-01T02:40:34.913Z] --- PASS: TestSaveCheckManifestLayers (0.03s)
02:40:34 [2024-02-01T02:40:34.913Z] PASS
02:40:34 [2024-02-01T02:40:34.913Z] 
02:40:34 [2024-02-01T02:40:34.913Z] === Skipped
02:40:34 [2024-02-01T02:40:34.913Z] === SKIP: arm64.integration.image TestImportExtremelyLargeImageWorks (0.00s)
02:40:34 [2024-02-01T02:40:34.913Z]     import_test.go:24: runtime.GOARCH == "arm64": effective test will be time out
02:40:34 [2024-02-01T02:40:34.913Z] 
02:40:34 [2024-02-01T02:40:34.913Z] === SKIP: arm64.integration.image TestRemoveByDigest (0.00s)
02:40:34 [2024-02-01T02:40:34.913Z]     remove_test.go:64: !testEnv.UsingSnapshotter(): RepoDigests doesn't include tags when using graphdrivers
02:40:34 [2024-02-01T02:40:34.913Z] 
02:40:34 [2024-02-01T02:40:34.913Z] === SKIP: arm64.integration.image TestRemoveImageGarbageCollector (0.00s)
02:40:34 [2024-02-01T02:40:34.913Z]     remove_unix_test.go:35: (*Execution).NotAmd64-fm
02:40:34 [2024-02-01T02:40:34.913Z] 
02:40:34 [2024-02-01T02:40:34.913Z] DONE 55 tests, 3 skipped in 5.951s
02:40:34 [2024-02-01T02:40:34.913Z] Running /go/src/github.com/docker/docker/integration/internal/termtest (arm64.integration.internal.termtest) flags=-test.v -test.timeout=120m  
02:40:34 [2024-02-01T02:40:34.913Z] ++ '[' -n '' ']'
02:40:34 [2024-02-01T02:40:34.913Z] ++ 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
02:40:34 [2024-02-01T02:40:34.913Z] ++ set -e
02:40:34 [2024-02-01T02:40:34.913Z] ++ '[' -n 0 ']'
02:40:34 [2024-02-01T02:40:34.913Z] ++ set -x
02:40:34 [2024-02-01T02:40:34.913Z] ++ 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.E5Oucw1va8/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
02:40:34 [2024-02-01T02:40:34.913Z] === RUN   TestStripANSICommands
02:40:34 [2024-02-01T02:40:34.913Z] === RUN   TestStripANSICommands/#00
02:40:34 [2024-02-01T02:40:34.913Z] === RUN   TestStripANSICommands/#01
02:40:34 [2024-02-01T02:40:34.913Z] --- PASS: TestStripANSICommands (0.00s)
02:40:34 [2024-02-01T02:40:34.913Z]     --- PASS: TestStripANSICommands/#00 (0.00s)
02:40:34 [2024-02-01T02:40:34.913Z]     --- PASS: TestStripANSICommands/#01 (0.00s)
02:40:34 [2024-02-01T02:40:34.913Z] PASS
02:40:34 [2024-02-01T02:40:34.913Z] 
02:40:34 [2024-02-01T02:40:34.913Z] DONE 3 tests in 0.008s
02:40:34 [2024-02-01T02:40:34.913Z] Running /go/src/github.com/docker/docker/integration/network (arm64.integration.network) flags=-test.v -test.timeout=120m  
02:40:34 [2024-02-01T02:40:34.913Z] ++ '[' -n '' ']'
02:40:34 [2024-02-01T02:40:34.913Z] ++ 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
02:40:34 [2024-02-01T02:40:34.913Z] ++ set -e
02:40:34 [2024-02-01T02:40:34.913Z] ++ '[' -n 0 ']'
02:40:34 [2024-02-01T02:40:34.913Z] ++ set -x
02:40:34 [2024-02-01T02:40:34.913Z] ++ 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.E5Oucw1va8/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
02:40:34 [2024-02-01T02:40:34.913Z] INFO: Testing against a local daemon
02:40:34 [2024-02-01T02:40:34.913Z] === RUN   TestCreateWithMultiNetworks
02:40:35 [2024-02-01T02:40:35.846Z] --- PASS: TestCreateWithMultiNetworks (0.96s)
02:40:35 [2024-02-01T02:40:35.846Z] === RUN   TestNetworkCreateDelete
02:40:36 [2024-02-01T02:40:36.104Z] --- PASS: TestNetworkCreateDelete (0.16s)
02:40:36 [2024-02-01T02:40:36.104Z] === RUN   TestDockerNetworkDeletePreferID
02:40:36 [2024-02-01T02:40:36.669Z] --- PASS: TestDockerNetworkDeletePreferID (0.52s)
02:40:36 [2024-02-01T02:40:36.669Z] === RUN   TestDaemonDNSFallback
02:40:43 [2024-02-01T02:40:43.226Z] --- PASS: TestDaemonDNSFallback (6.16s)
02:40:43 [2024-02-01T02:40:43.226Z] === RUN   TestInspectNetwork
02:40:45 [2024-02-01T02:40:45.126Z] === RUN   TestInspectNetwork/full_network_id
02:40:45 [2024-02-01T02:40:45.126Z] === RUN   TestInspectNetwork/partial_network_id
02:40:45 [2024-02-01T02:40:45.126Z] === RUN   TestInspectNetwork/network_name
02:40:45 [2024-02-01T02:40:45.126Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
02:40:50 [2024-02-01T02:40:50.388Z] --- PASS: TestInspectNetwork (6.79s)
02:40:50 [2024-02-01T02:40:50.388Z]     --- PASS: TestInspectNetwork/full_network_id (0.00s)
02:40:50 [2024-02-01T02:40:50.388Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
02:40:50 [2024-02-01T02:40:50.388Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
02:40:50 [2024-02-01T02:40:50.388Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
02:40:50 [2024-02-01T02:40:50.388Z] === RUN   TestRunContainerWithBridgeNone
02:40:50 [2024-02-01T02:40:50.954Z] --- PASS: TestRunContainerWithBridgeNone (1.29s)
02:40:50 [2024-02-01T02:40:50.954Z] === RUN   TestNetworkInvalidJSON
02:40:50 [2024-02-01T02:40:50.954Z] === RUN   TestNetworkInvalidJSON/networks/create
02:40:50 [2024-02-01T02:40:50.954Z] === PAUSE TestNetworkInvalidJSON/networks/create
02:40:50 [2024-02-01T02:40:50.954Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect
02:40:50 [2024-02-01T02:40:50.954Z] === PAUSE TestNetworkInvalidJSON/networks/bridge/connect
02:40:50 [2024-02-01T02:40:50.954Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect
02:40:50 [2024-02-01T02:40:50.954Z] === PAUSE TestNetworkInvalidJSON/networks/bridge/disconnect
02:40:50 [2024-02-01T02:40:50.954Z] === CONT  TestNetworkInvalidJSON/networks/create
02:40:50 [2024-02-01T02:40:50.954Z] === RUN   TestNetworkInvalidJSON/networks/create/invalid_content_type
02:40:50 [2024-02-01T02:40:50.954Z] === CONT  TestNetworkInvalidJSON/networks/bridge/disconnect
02:40:50 [2024-02-01T02:40:50.954Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect/invalid_content_type
02:40:50 [2024-02-01T02:40:50.954Z] === CONT  TestNetworkInvalidJSON/networks/bridge/connect
02:40:50 [2024-02-01T02:40:50.954Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect/invalid_content_type
02:40:50 [2024-02-01T02:40:50.954Z] === RUN   TestNetworkInvalidJSON/networks/create/invalid_JSON
02:40:50 [2024-02-01T02:40:50.954Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect/invalid_JSON
02:40:50 [2024-02-01T02:40:50.954Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect/invalid_JSON
02:40:50 [2024-02-01T02:40:50.954Z] === RUN   TestNetworkInvalidJSON/networks/create/extra_content_after_JSON
02:40:50 [2024-02-01T02:40:50.954Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect/extra_content_after_JSON
02:40:50 [2024-02-01T02:40:50.954Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect/extra_content_after_JSON
02:40:50 [2024-02-01T02:40:50.954Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect/empty_body
02:40:50 [2024-02-01T02:40:50.954Z] === RUN   TestNetworkInvalidJSON/networks/create/empty_body
02:40:50 [2024-02-01T02:40:50.954Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect/empty_body
02:40:50 [2024-02-01T02:40:50.954Z] --- PASS: TestNetworkInvalidJSON (0.01s)
02:40:50 [2024-02-01T02:40:50.954Z]     --- PASS: TestNetworkInvalidJSON/networks/create (0.00s)
02:40:50 [2024-02-01T02:40:50.954Z]         --- PASS: TestNetworkInvalidJSON/networks/create/invalid_content_type (0.00s)
02:40:50 [2024-02-01T02:40:50.954Z]         --- PASS: TestNetworkInvalidJSON/networks/create/invalid_JSON (0.00s)
02:40:50 [2024-02-01T02:40:50.954Z]         --- PASS: TestNetworkInvalidJSON/networks/create/extra_content_after_JSON (0.00s)
02:40:50 [2024-02-01T02:40:50.954Z]         --- PASS: TestNetworkInvalidJSON/networks/create/empty_body (0.00s)
02:40:50 [2024-02-01T02:40:50.954Z]     --- PASS: TestNetworkInvalidJSON/networks/bridge/connect (0.00s)
02:40:50 [2024-02-01T02:40:50.954Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/connect/invalid_content_type (0.00s)
02:40:50 [2024-02-01T02:40:50.954Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/connect/invalid_JSON (0.00s)
02:40:50 [2024-02-01T02:40:50.954Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/connect/extra_content_after_JSON (0.00s)
02:40:50 [2024-02-01T02:40:50.954Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/connect/empty_body (0.00s)
02:40:50 [2024-02-01T02:40:50.954Z]     --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect (0.00s)
02:40:50 [2024-02-01T02:40:50.954Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect/invalid_content_type (0.00s)
02:40:50 [2024-02-01T02:40:50.954Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect/invalid_JSON (0.00s)
02:40:50 [2024-02-01T02:40:50.954Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect/extra_content_after_JSON (0.00s)
02:40:50 [2024-02-01T02:40:50.954Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect/empty_body (0.00s)
02:40:50 [2024-02-01T02:40:50.954Z] === RUN   TestNetworkList
02:40:50 [2024-02-01T02:40:50.954Z] === RUN   TestNetworkList//networks
02:40:50 [2024-02-01T02:40:50.954Z] === PAUSE TestNetworkList//networks
02:40:50 [2024-02-01T02:40:50.954Z] === RUN   TestNetworkList//networks/
02:40:50 [2024-02-01T02:40:50.954Z] === PAUSE TestNetworkList//networks/
02:40:50 [2024-02-01T02:40:50.954Z] === CONT  TestNetworkList//networks
02:40:50 [2024-02-01T02:40:50.954Z] === CONT  TestNetworkList//networks/
02:40:50 [2024-02-01T02:40:50.954Z] --- PASS: TestNetworkList (0.01s)
02:40:50 [2024-02-01T02:40:50.954Z]     --- PASS: TestNetworkList//networks/ (0.00s)
02:40:50 [2024-02-01T02:40:50.954Z]     --- PASS: TestNetworkList//networks (0.00s)
02:40:50 [2024-02-01T02:40:50.954Z] === RUN   TestHostIPv4BridgeLabel
02:40:51 [2024-02-01T02:40:51.520Z] --- PASS: TestHostIPv4BridgeLabel (0.56s)
02:40:51 [2024-02-01T02:40:51.520Z] === RUN   TestDefaultNetworkOpts
02:40:51 [2024-02-01T02:40:51.520Z] === RUN   TestDefaultNetworkOpts/default_value
02:40:52 [2024-02-01T02:40:52.894Z] === RUN   TestDefaultNetworkOpts/cmdline_value
02:40:53 [2024-02-01T02:40:53.827Z] === RUN   TestDefaultNetworkOpts/config-from_value
02:40:55 [2024-02-01T02:40:55.200Z] --- PASS: TestDefaultNetworkOpts (3.79s)
02:40:55 [2024-02-01T02:40:55.200Z]     --- PASS: TestDefaultNetworkOpts/default_value (1.28s)
02:40:55 [2024-02-01T02:40:55.200Z]     --- PASS: TestDefaultNetworkOpts/cmdline_value (1.26s)
02:40:55 [2024-02-01T02:40:55.200Z]     --- PASS: TestDefaultNetworkOpts/config-from_value (1.25s)
02:40:55 [2024-02-01T02:40:55.200Z] === RUN   TestForbidDuplicateNetworkNames
02:40:55 [2024-02-01T02:40:55.766Z] --- PASS: TestForbidDuplicateNetworkNames (0.63s)
02:40:55 [2024-02-01T02:40:55.766Z] === RUN   TestDaemonRestartWithLiveRestore
02:40:57 [2024-02-01T02:40:57.140Z] --- PASS: TestDaemonRestartWithLiveRestore (1.03s)
02:40:57 [2024-02-01T02:40:57.140Z] === RUN   TestDaemonDefaultNetworkPools
02:40:57 [2024-02-01T02:40:57.705Z] --- PASS: TestDaemonDefaultNetworkPools (0.77s)
02:40:57 [2024-02-01T02:40:57.705Z] === RUN   TestDaemonRestartWithExistingNetwork
02:40:59 [2024-02-01T02:40:59.078Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.17s)
02:40:59 [2024-02-01T02:40:59.078Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
02:41:00 [2024-02-01T02:41:00.012Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.28s)
02:41:00 [2024-02-01T02:41:00.012Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
02:41:00 [2024-02-01T02:41:00.579Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.63s)
02:41:00 [2024-02-01T02:41:00.579Z] === RUN   TestServiceWithPredefinedNetwork
02:41:03 [2024-02-01T02:41:03.107Z] --- PASS: TestServiceWithPredefinedNetwork (2.16s)
02:41:03 [2024-02-01T02:41:03.107Z] === RUN   TestServiceRemoveKeepsIngressNetwork
02:41:03 [2024-02-01T02:41:03.107Z]     service_test.go:250: FLAKY_TEST
02:41:03 [2024-02-01T02:41:03.107Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
02:41:03 [2024-02-01T02:41:03.107Z] === RUN   TestServiceWithDataPathPortInit
02:41:17 [2024-02-01T02:41:17.976Z] --- PASS: TestServiceWithDataPathPortInit (13.28s)
02:41:17 [2024-02-01T02:41:17.976Z] === RUN   TestServiceWithDefaultAddressPoolInit
02:41:18 [2024-02-01T02:41:18.542Z]     service_test.go:440: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:r6z1yhpxopg91vrlkpvup7ymn Created:2024-02-01 02:41:17.442146969 +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[0593ba5ee34f18ae0debac1e7fd9cc1e9f570536be06022c5dbf90149408e7a8:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.vf4zp074j579rwmw0wpmyvzrd EndpointID:65d936ec51259d7ea62c964f1b306507c0b37259f641954685da7f04cca7ec9f MacAddress:02:42:14:14:01:03 IPv4Address:20.20.1.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:68574eb1765f0b4a2767e5abcf6f5149cecb50955edd71e6c94b827ed86ec1f8 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:fdc5db657a40 IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.1.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.vf4zp074j579rwmw0wpmyvzrd EndpointID:65d936ec51259d7ea62c964f1b306507c0b37259f641954685da7f04cca7ec9f EndpointIP:20.20.1.3 Info:map[Host IP:127.0.0.1]}]}]}
02:41:23 [2024-02-01T02:41:23.805Z] --- PASS: TestServiceWithDefaultAddressPoolInit (6.76s)
02:41:23 [2024-02-01T02:41:23.805Z] PASS
02:41:23 [2024-02-01T02:41:23.805Z] 
02:41:23 [2024-02-01T02:41:23.805Z] === Skipped
02:41:23 [2024-02-01T02:41:23.805Z] === SKIP: arm64.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
02:41:23 [2024-02-01T02:41:23.805Z]     service_test.go:250: FLAKY_TEST
02:41:23 [2024-02-01T02:41:23.805Z] 
02:41:23 [2024-02-01T02:41:23.805Z] DONE 44 tests, 1 skipped in 48.004s
02:41:23 [2024-02-01T02:41:23.805Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (arm64.integration.network.ipvlan) flags=-test.v -test.timeout=120m  
02:41:23 [2024-02-01T02:41:23.805Z] ++ '[' -n '' ']'
02:41:23 [2024-02-01T02:41:23.805Z] ++ 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
02:41:23 [2024-02-01T02:41:23.805Z] ++ set -e
02:41:23 [2024-02-01T02:41:23.805Z] ++ '[' -n 0 ']'
02:41:23 [2024-02-01T02:41:23.805Z] ++ set -x
02:41:23 [2024-02-01T02:41:23.805Z] ++ 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.E5Oucw1va8/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
02:41:23 [2024-02-01T02:41:23.805Z] INFO: Testing against a local daemon
02:41:23 [2024-02-01T02:41:23.805Z] === RUN   TestDockerNetworkIpvlanPersistance
02:41:23 [2024-02-01T02:41:23.805Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
02:41:23 [2024-02-01T02:41:23.805Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.00s)
02:41:23 [2024-02-01T02:41:23.805Z] === RUN   TestDockerNetworkIpvlan
02:41:23 [2024-02-01T02:41:23.805Z]     ipvlan_test.go:55: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
02:41:23 [2024-02-01T02:41:23.805Z] --- SKIP: TestDockerNetworkIpvlan (0.00s)
02:41:23 [2024-02-01T02:41:23.805Z] PASS
02:41:23 [2024-02-01T02:41:23.805Z] 
02:41:23 [2024-02-01T02:41:23.805Z] === Skipped
02:41:23 [2024-02-01T02:41:23.805Z] === SKIP: arm64.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.00s)
02:41:23 [2024-02-01T02:41:23.805Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
02:41:23 [2024-02-01T02:41:23.805Z] 
02:41:23 [2024-02-01T02:41:23.805Z] === SKIP: arm64.integration.network.ipvlan TestDockerNetworkIpvlan (0.00s)
02:41:23 [2024-02-01T02:41:23.805Z]     ipvlan_test.go:55: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
02:41:23 [2024-02-01T02:41:23.805Z] 
02:41:23 [2024-02-01T02:41:23.805Z] DONE 2 tests, 2 skipped in 0.040s
02:41:23 [2024-02-01T02:41:23.805Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (arm64.integration.network.macvlan) flags=-test.v -test.timeout=120m  
02:41:23 [2024-02-01T02:41:23.805Z] ++ '[' -n '' ']'
02:41:23 [2024-02-01T02:41:23.805Z] ++ 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
02:41:23 [2024-02-01T02:41:23.805Z] ++ set -e
02:41:23 [2024-02-01T02:41:23.805Z] ++ '[' -n 0 ']'
02:41:23 [2024-02-01T02:41:23.805Z] ++ set -x
02:41:23 [2024-02-01T02:41:23.805Z] ++ 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.E5Oucw1va8/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
02:41:23 [2024-02-01T02:41:23.805Z] INFO: Testing against a local daemon
02:41:23 [2024-02-01T02:41:23.805Z] === RUN   TestDockerNetworkMacvlanPersistance
02:41:24 [2024-02-01T02:41:24.371Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.34s)
02:41:24 [2024-02-01T02:41:24.371Z] === RUN   TestDockerNetworkMacvlan
02:41:24 [2024-02-01T02:41:24.371Z] === RUN   TestDockerNetworkMacvlan/Subinterface
02:41:24 [2024-02-01T02:41:24.937Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
02:41:25 [2024-02-01T02:41:25.503Z] === RUN   TestDockerNetworkMacvlan/NilParent
02:41:26 [2024-02-01T02:41:26.069Z] === RUN   TestDockerNetworkMacvlan/InternalMode
02:41:26 [2024-02-01T02:41:26.635Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
02:41:27 [2024-02-01T02:41:27.200Z] === RUN   TestDockerNetworkMacvlan/Addressing
02:41:28 [2024-02-01T02:41:28.134Z] --- PASS: TestDockerNetworkMacvlan (3.55s)
02:41:28 [2024-02-01T02:41:28.134Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.59s)
02:41:28 [2024-02-01T02:41:28.134Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.59s)
02:41:28 [2024-02-01T02:41:28.134Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (0.59s)
02:41:28 [2024-02-01T02:41:28.134Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (0.59s)
02:41:28 [2024-02-01T02:41:28.134Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (0.59s)
02:41:28 [2024-02-01T02:41:28.134Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (0.59s)
02:41:28 [2024-02-01T02:41:28.134Z] PASS
02:41:28 [2024-02-01T02:41:28.134Z] 
02:41:28 [2024-02-01T02:41:28.134Z] DONE 8 tests in 4.933s
02:41:28 [2024-02-01T02:41:28.134Z] Running /go/src/github.com/docker/docker/integration/networking (arm64.integration.networking) flags=-test.v -test.timeout=120m  
02:41:28 [2024-02-01T02:41:28.134Z] ++ '[' -n '' ']'
02:41:28 [2024-02-01T02:41:28.134Z] ++ 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
02:41:28 [2024-02-01T02:41:28.134Z] ++ set -e
02:41:28 [2024-02-01T02:41:28.134Z] ++ '[' -n 0 ']'
02:41:28 [2024-02-01T02:41:28.134Z] ++ set -x
02:41:28 [2024-02-01T02:41:28.134Z] ++ 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.E5Oucw1va8/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
02:41:28 [2024-02-01T02:41:28.134Z] INFO: Testing against a local daemon
02:41:28 [2024-02-01T02:41:28.134Z] === RUN   TestBridgeICC
02:41:28 [2024-02-01T02:41:28.700Z] === RUN   TestBridgeICC/IPv4_non-internal_network
02:41:29 [2024-02-01T02:41:29.633Z] === RUN   TestBridgeICC/IPv4_internal_network
02:41:30 [2024-02-01T02:41:30.567Z] === RUN   TestBridgeICC/IPv6_ULA_on_non-internal_network
02:41:31 [2024-02-01T02:41:31.940Z] === RUN   TestBridgeICC/IPv6_ULA_on_internal_network
02:41:32 [2024-02-01T02:41:32.874Z] === RUN   TestBridgeICC/IPv6_link-local_address_on_non-internal_network
02:41:33 [2024-02-01T02:41:33.807Z] === RUN   TestBridgeICC/IPv6_link-local_address_on_internal_network
02:41:34 [2024-02-01T02:41:34.741Z] === RUN   TestBridgeICC/IPv6_link-local_address_on_non-internal_network_ping_by_name
02:41:36 [2024-02-01T02:41:36.114Z] === RUN   TestBridgeICC/IPv6_nonstandard_link-local_subnet_on_non-internal_network_ping_by_name
02:41:37 [2024-02-01T02:41:37.048Z] === RUN   TestBridgeICC/IPv6_non-internal_network_with_SLAAC_LL_address
02:41:40 [2024-02-01T02:41:40.328Z] === RUN   TestBridgeICC/IPv6_internal_network_with_SLAAC_LL_address
02:41:42 [2024-02-01T02:41:42.228Z] --- PASS: TestBridgeICC (14.32s)
02:41:42 [2024-02-01T02:41:42.228Z]     --- PASS: TestBridgeICC/IPv4_non-internal_network (1.02s)
02:41:42 [2024-02-01T02:41:42.228Z]     --- PASS: TestBridgeICC/IPv4_internal_network (0.97s)
02:41:42 [2024-02-01T02:41:42.228Z]     --- PASS: TestBridgeICC/IPv6_ULA_on_non-internal_network (1.10s)
02:41:42 [2024-02-01T02:41:42.228Z]     --- PASS: TestBridgeICC/IPv6_ULA_on_internal_network (1.09s)
02:41:42 [2024-02-01T02:41:42.228Z]     --- PASS: TestBridgeICC/IPv6_link-local_address_on_non-internal_network (1.08s)
02:41:42 [2024-02-01T02:41:42.228Z]     --- PASS: TestBridgeICC/IPv6_link-local_address_on_internal_network (0.99s)
02:41:42 [2024-02-01T02:41:42.228Z]     --- PASS: TestBridgeICC/IPv6_link-local_address_on_non-internal_network_ping_by_name (1.12s)
02:41:42 [2024-02-01T02:41:42.228Z]     --- PASS: TestBridgeICC/IPv6_nonstandard_link-local_subnet_on_non-internal_network_ping_by_name (1.10s)
02:41:42 [2024-02-01T02:41:42.228Z]     --- PASS: TestBridgeICC/IPv6_non-internal_network_with_SLAAC_LL_address (3.09s)
02:41:42 [2024-02-01T02:41:42.228Z]     --- PASS: TestBridgeICC/IPv6_internal_network_with_SLAAC_LL_address (2.16s)
02:41:42 [2024-02-01T02:41:42.228Z] === RUN   TestBridgeINC
02:41:42 [2024-02-01T02:41:42.794Z] === RUN   TestBridgeINC/IPv4_non-internal_network
02:41:48 [2024-02-01T02:41:48.057Z] === RUN   TestBridgeINC/IPv4_internal_network
02:41:48 [2024-02-01T02:41:48.317Z] === RUN   TestBridgeINC/IPv6_ULA_on_non-internal_network
02:41:52 [2024-02-01T02:41:52.499Z] === RUN   TestBridgeINC/IPv6_ULA_on_internal_network
02:41:53 [2024-02-01T02:41:53.873Z] --- PASS: TestBridgeINC (11.57s)
02:41:53 [2024-02-01T02:41:53.873Z]     --- PASS: TestBridgeINC/IPv4_non-internal_network (4.26s)
02:41:53 [2024-02-01T02:41:53.873Z]     --- PASS: TestBridgeINC/IPv4_internal_network (1.16s)
02:41:53 [2024-02-01T02:41:53.873Z]     --- PASS: TestBridgeINC/IPv6_ULA_on_non-internal_network (4.32s)
02:41:53 [2024-02-01T02:41:53.873Z]     --- PASS: TestBridgeINC/IPv6_ULA_on_internal_network (1.22s)
02:41:53 [2024-02-01T02:41:53.873Z] === RUN   TestDefaultBridgeIPv6
02:41:53 [2024-02-01T02:41:53.873Z] === RUN   TestDefaultBridgeIPv6/IPv6_ULA
02:41:55 [2024-02-01T02:41:55.246Z] === RUN   TestDefaultBridgeIPv6/IPv6_LLA_only
02:41:56 [2024-02-01T02:41:56.620Z] === RUN   TestDefaultBridgeIPv6/IPv6_nonstandard_LLA_only
02:41:58 [2024-02-01T02:41:58.579Z] --- PASS: TestDefaultBridgeIPv6 (4.32s)
02:41:58 [2024-02-01T02:41:58.579Z]     --- PASS: TestDefaultBridgeIPv6/IPv6_ULA (1.44s)
02:41:58 [2024-02-01T02:41:58.579Z]     --- PASS: TestDefaultBridgeIPv6/IPv6_LLA_only (1.43s)
02:41:58 [2024-02-01T02:41:58.579Z]     --- PASS: TestDefaultBridgeIPv6/IPv6_nonstandard_LLA_only (1.44s)
02:41:58 [2024-02-01T02:41:58.579Z] === RUN   TestDefaultBridgeAddresses
02:41:58 [2024-02-01T02:41:58.579Z] === RUN   TestDefaultBridgeAddresses/Unique-Local_Subnet_Changes
02:42:00 [2024-02-01T02:42:00.007Z] === RUN   TestDefaultBridgeAddresses/Link-Local_Subnet_Changes
02:42:01 [2024-02-01T02:42:01.444Z] --- PASS: TestDefaultBridgeAddresses (3.11s)
02:42:01 [2024-02-01T02:42:01.444Z]     --- PASS: TestDefaultBridgeAddresses/Unique-Local_Subnet_Changes (1.55s)
02:42:01 [2024-02-01T02:42:01.444Z]     --- PASS: TestDefaultBridgeAddresses/Link-Local_Subnet_Changes (1.55s)
02:42:01 [2024-02-01T02:42:01.444Z] === RUN   TestEtcHostsIpv6
02:42:02 [2024-02-01T02:42:02.034Z] === RUN   TestEtcHostsIpv6/IPv6_enabled
02:42:02 [2024-02-01T02:42:02.627Z] === RUN   TestEtcHostsIpv6/IPv6_disabled
02:42:06 [2024-02-01T02:42:06.029Z] --- PASS: TestEtcHostsIpv6 (4.69s)
02:42:06 [2024-02-01T02:42:06.029Z]     --- PASS: TestEtcHostsIpv6/IPv6_enabled (0.55s)
02:42:06 [2024-02-01T02:42:06.029Z]     --- PASS: TestEtcHostsIpv6/IPv6_disabled (3.53s)
02:42:06 [2024-02-01T02:42:06.029Z] === RUN   TestMACAddrOnRestart
02:42:08 [2024-02-01T02:42:08.557Z] --- PASS: TestMACAddrOnRestart (2.09s)
02:42:08 [2024-02-01T02:42:08.557Z] PASS
02:42:08 [2024-02-01T02:42:08.557Z] 
02:42:08 [2024-02-01T02:42:08.557Z] DONE 27 tests in 40.148s
02:42:08 [2024-02-01T02:42:08.557Z] Running /go/src/github.com/docker/docker/integration/plugin (arm64.integration.plugin) flags=-test.v -test.timeout=120m  
02:42:08 [2024-02-01T02:42:08.557Z] ++ '[' -n '' ']'
02:42:08 [2024-02-01T02:42:08.557Z] ++ 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
02:42:08 [2024-02-01T02:42:08.557Z] ++ set -e
02:42:08 [2024-02-01T02:42:08.557Z] ++ '[' -n 0 ']'
02:42:08 [2024-02-01T02:42:08.557Z] ++ set -x
02:42:08 [2024-02-01T02:42:08.557Z] ++ 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.E5Oucw1va8/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
02:42:08 [2024-02-01T02:42:08.557Z] testing: warning: no tests to run
02:42:08 [2024-02-01T02:42:08.557Z] PASS
02:42:08 [2024-02-01T02:42:08.557Z] 
02:42:08 [2024-02-01T02:42:08.557Z] DONE 0 tests in 0.007s
02:42:08 [2024-02-01T02:42:08.557Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (arm64.integration.plugin.authz) flags=-test.v -test.timeout=120m  
02:42:08 [2024-02-01T02:42:08.557Z] ++ '[' -n '' ']'
02:42:08 [2024-02-01T02:42:08.557Z] ++ 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
02:42:08 [2024-02-01T02:42:08.557Z] ++ set -e
02:42:08 [2024-02-01T02:42:08.557Z] ++ '[' -n 0 ']'
02:42:08 [2024-02-01T02:42:08.557Z] ++ set -x
02:42:08 [2024-02-01T02:42:08.557Z] ++ 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.E5Oucw1va8/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
02:42:08 [2024-02-01T02:42:08.557Z] INFO: Testing against a local daemon
02:42:08 [2024-02-01T02:42:08.557Z] === RUN   TestAuthZPluginAllowRequest
02:42:09 [2024-02-01T02:42:09.123Z] --- PASS: TestAuthZPluginAllowRequest (1.05s)
02:42:09 [2024-02-01T02:42:09.123Z] === RUN   TestAuthZPluginTLS
02:42:09 [2024-02-01T02:42:09.690Z] --- PASS: TestAuthZPluginTLS (0.55s)
02:42:09 [2024-02-01T02:42:09.690Z] === RUN   TestAuthZPluginDenyRequest
02:42:10 [2024-02-01T02:42:10.256Z] --- PASS: TestAuthZPluginDenyRequest (0.53s)
02:42:10 [2024-02-01T02:42:10.256Z] === RUN   TestAuthZPluginAPIDenyResponse
02:42:10 [2024-02-01T02:42:10.822Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.53s)
02:42:10 [2024-02-01T02:42:10.822Z] === RUN   TestAuthZPluginDenyResponse
02:42:11 [2024-02-01T02:42:11.387Z] --- PASS: TestAuthZPluginDenyResponse (0.53s)
02:42:11 [2024-02-01T02:42:11.387Z] === RUN   TestAuthZPluginAllowEventStream
02:42:12 [2024-02-01T02:42:12.321Z] 2024/02/01 02:42:12 http: panic serving 127.0.0.1:37446: runtime error: invalid memory address or nil pointer dereference
02:42:12 [2024-02-01T02:42:12.321Z] goroutine 161 [running]:
02:42:12 [2024-02-01T02:42:12.321Z] net/http.(*conn).serve.func1()
02:42:12 [2024-02-01T02:42:12.321Z] 	/usr/local/go/src/net/http/server.go:1868 +0xb0
02:42:12 [2024-02-01T02:42:12.321Z] panic({0xa74a40?, 0x1599ca0?})
02:42:12 [2024-02-01T02:42:12.321Z] 	/usr/local/go/src/runtime/panic.go:920 +0x26c
02:42:12 [2024-02-01T02:42:12.321Z] github.com/docker/docker/integration/plugin/authz.setupSuite.func3({0xd72a08, 0x40007142a0}, 0xffff4ca454a0?)
02:42:12 [2024-02-01T02:42:12.321Z] 	/go/src/github.com/docker/docker/integration/plugin/authz/main_test.go:159 +0x14c
02:42:12 [2024-02-01T02:42:12.321Z] net/http.HandlerFunc.ServeHTTP(0x400058c300?, {0xd72a08?, 0x40007142a0?}, 0x4022d4?)
02:42:12 [2024-02-01T02:42:12.321Z] 	/usr/local/go/src/net/http/server.go:2136 +0x38
02:42:12 [2024-02-01T02:42:12.321Z] net/http.(*ServeMux).ServeHTTP(0xd78fb8?, {0xd72a08, 0x40007142a0}, 0x400058c300)
02:42:12 [2024-02-01T02:42:12.321Z] 	/usr/local/go/src/net/http/server.go:2514 +0x144
02:42:12 [2024-02-01T02:42:12.321Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.(*middleware).serveHTTP(0x40000f60b0, {0xd715c8?, 0x40000b2000}, 0x400058c200, {0xd67920, 0x40000be240})
02:42:12 [2024-02-01T02:42:12.321Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:217 +0xf44
02:42:12 [2024-02-01T02:42:12.321Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.NewMiddleware.func1.1({0xd715c8?, 0x40000b2000?}, 0x4000318010?)
02:42:12 [2024-02-01T02:42:12.321Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:81 +0x40
02:42:12 [2024-02-01T02:42:12.321Z] net/http.HandlerFunc.ServeHTTP(0x10?, {0xd715c8?, 0x40000b2000?}, 0x40000b2000?)
02:42:12 [2024-02-01T02:42:12.321Z] 	/usr/local/go/src/net/http/server.go:2136 +0x38
02:42:12 [2024-02-01T02:42:12.321Z] net/http.serverHandler.ServeHTTP({0xd6e1a8?}, {0xd715c8?, 0x40000b2000?}, 0x6?)
02:42:12 [2024-02-01T02:42:12.321Z] 	/usr/local/go/src/net/http/server.go:2938 +0xbc
02:42:12 [2024-02-01T02:42:12.321Z] net/http.(*conn).serve(0x40005ca120, {0xd78fb8, 0x40001f51d0})
02:42:12 [2024-02-01T02:42:12.321Z] 	/usr/local/go/src/net/http/server.go:2009 +0x518
02:42:12 [2024-02-01T02:42:12.321Z] created by net/http.(*Server).Serve in goroutine 6
02:42:12 [2024-02-01T02:42:12.321Z] 	/usr/local/go/src/net/http/server.go:3086 +0x4cc
02:42:13 [2024-02-01T02:42:13.254Z] 2024/02/01 02:42:13 http: panic serving 127.0.0.1:37458: could not unmarshal json for /AuthZPlugin.AuthZRes: unexpected end of JSON input
02:42:13 [2024-02-01T02:42:13.254Z] goroutine 196 [running]:
02:42:13 [2024-02-01T02:42:13.254Z] net/http.(*conn).serve.func1()
02:42:13 [2024-02-01T02:42:13.254Z] 	/usr/local/go/src/net/http/server.go:1868 +0xb0
02:42:13 [2024-02-01T02:42:13.254Z] panic({0xa0ae60?, 0x4000318130?})
02:42:13 [2024-02-01T02:42:13.254Z] 	/usr/local/go/src/runtime/panic.go:920 +0x26c
02:42:13 [2024-02-01T02:42:13.254Z] github.com/docker/docker/integration/plugin/authz.setupSuite.func3({0xd72a08, 0x4000714420}, 0xffff4ca454a0?)
02:42:13 [2024-02-01T02:42:13.254Z] 	/go/src/github.com/docker/docker/integration/plugin/authz/main_test.go:149 +0x360
02:42:13 [2024-02-01T02:42:13.254Z] net/http.HandlerFunc.ServeHTTP(0x400058c400?, {0xd72a08?, 0x4000714420?}, 0x4022d4?)
02:42:13 [2024-02-01T02:42:13.254Z] 	/usr/local/go/src/net/http/server.go:2136 +0x38
02:42:13 [2024-02-01T02:42:13.254Z] net/http.(*ServeMux).ServeHTTP(0xd78fb8?, {0xd72a08, 0x4000714420}, 0x400058c400)
02:42:13 [2024-02-01T02:42:13.254Z] 	/usr/local/go/src/net/http/server.go:2514 +0x144
02:42:13 [2024-02-01T02:42:13.254Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.(*middleware).serveHTTP(0x40000f60b0, {0xd715c8?, 0x40000b20e0}, 0x4000504100, {0xd67920, 0x40000be240})
02:42:13 [2024-02-01T02:42:13.254Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:217 +0xf44
02:42:13 [2024-02-01T02:42:13.254Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.NewMiddleware.func1.1({0xd715c8?, 0x40000b20e0?}, 0x400043e3f0?)
02:42:13 [2024-02-01T02:42:13.254Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:81 +0x40
02:42:13 [2024-02-01T02:42:13.254Z] net/http.HandlerFunc.ServeHTTP(0x15f7440?, {0xd715c8?, 0x40000b20e0?}, 0x4000511b40?)
02:42:13 [2024-02-01T02:42:13.254Z] 	/usr/local/go/src/net/http/server.go:2136 +0x38
02:42:13 [2024-02-01T02:42:13.254Z] net/http.serverHandler.ServeHTTP({0x400043e3f0?}, {0xd715c8?, 0x40000b20e0?}, 0x6?)
02:42:13 [2024-02-01T02:42:13.254Z] 	/usr/local/go/src/net/http/server.go:2938 +0xbc
02:42:13 [2024-02-01T02:42:13.254Z] net/http.(*conn).serve(0x400001e750, {0xd78fb8, 0x40001f51d0})
02:42:13 [2024-02-01T02:42:13.254Z] 	/usr/local/go/src/net/http/server.go:2009 +0x518
02:42:13 [2024-02-01T02:42:13.254Z] created by net/http.(*Server).Serve in goroutine 6
02:42:13 [2024-02-01T02:42:13.254Z] 	/usr/local/go/src/net/http/server.go:3086 +0x4cc
02:42:15 [2024-02-01T02:42:15.152Z] 2024/02/01 02:42:15 http: panic serving 127.0.0.1:47870: could not unmarshal json for /AuthZPlugin.AuthZRes: unexpected end of JSON input
02:42:15 [2024-02-01T02:42:15.152Z] goroutine 171 [running]:
02:42:15 [2024-02-01T02:42:15.152Z] net/http.(*conn).serve.func1()
02:42:15 [2024-02-01T02:42:15.152Z] 	/usr/local/go/src/net/http/server.go:1868 +0xb0
02:42:15 [2024-02-01T02:42:15.152Z] panic({0xa0ae60?, 0x40003181d0?})
02:42:15 [2024-02-01T02:42:15.152Z] 	/usr/local/go/src/runtime/panic.go:920 +0x26c
02:42:15 [2024-02-01T02:42:15.152Z] github.com/docker/docker/integration/plugin/authz.setupSuite.func3({0xd72a08, 0x4000714540}, 0xffff4ca454a0?)
02:42:15 [2024-02-01T02:42:15.152Z] 	/go/src/github.com/docker/docker/integration/plugin/authz/main_test.go:149 +0x360
02:42:15 [2024-02-01T02:42:15.152Z] net/http.HandlerFunc.ServeHTTP(0x400058c600?, {0xd72a08?, 0x4000714540?}, 0x4022d4?)
02:42:15 [2024-02-01T02:42:15.152Z] 	/usr/local/go/src/net/http/server.go:2136 +0x38
02:42:15 [2024-02-01T02:42:15.152Z] net/http.(*ServeMux).ServeHTTP(0xd78fb8?, {0xd72a08, 0x4000714540}, 0x400058c600)
02:42:15 [2024-02-01T02:42:15.152Z] 	/usr/local/go/src/net/http/server.go:2514 +0x144
02:42:15 [2024-02-01T02:42:15.152Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.(*middleware).serveHTTP(0x40000f60b0, {0xd715c8?, 0x40000b21c0}, 0x400058c500, {0xd67920, 0x40000be240})
02:42:15 [2024-02-01T02:42:15.152Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:217 +0xf44
02:42:15 [2024-02-01T02:42:15.152Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.NewMiddleware.func1.1({0xd715c8?, 0x40000b21c0?}, 0x400043e510?)
02:42:15 [2024-02-01T02:42:15.152Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:81 +0x40
02:42:15 [2024-02-01T02:42:15.152Z] net/http.HandlerFunc.ServeHTTP(0x15f7440?, {0xd715c8?, 0x40000b21c0?}, 0x4000511b40?)
02:42:15 [2024-02-01T02:42:15.152Z] 	/usr/local/go/src/net/http/server.go:2136 +0x38
02:42:15 [2024-02-01T02:42:15.152Z] net/http.serverHandler.ServeHTTP({0x400043e510?}, {0xd715c8?, 0x40000b21c0?}, 0x6?)
02:42:15 [2024-02-01T02:42:15.152Z] 	/usr/local/go/src/net/http/server.go:2938 +0xbc
02:42:15 [2024-02-01T02:42:15.152Z] net/http.(*conn).serve(0x40005ca3f0, {0xd78fb8, 0x40001f51d0})
02:42:15 [2024-02-01T02:42:15.152Z] 	/usr/local/go/src/net/http/server.go:2009 +0x518
02:42:15 [2024-02-01T02:42:15.152Z] created by net/http.(*Server).Serve in goroutine 6
02:42:15 [2024-02-01T02:42:15.152Z] 	/usr/local/go/src/net/http/server.go:3086 +0x4cc
02:42:17 [2024-02-01T02:42:17.678Z] --- PASS: TestAuthZPluginAllowEventStream (6.04s)
02:42:17 [2024-02-01T02:42:17.678Z] === RUN   TestAuthZPluginErrorResponse
02:42:17 [2024-02-01T02:42:17.936Z] --- PASS: TestAuthZPluginErrorResponse (0.53s)
02:42:17 [2024-02-01T02:42:17.936Z] === RUN   TestAuthZPluginErrorRequest
02:42:18 [2024-02-01T02:42:18.502Z] --- PASS: TestAuthZPluginErrorRequest (0.53s)
02:42:18 [2024-02-01T02:42:18.502Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
02:42:19 [2024-02-01T02:42:19.068Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.53s)
02:42:19 [2024-02-01T02:42:19.068Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
02:42:20 [2024-02-01T02:42:20.001Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (1.11s)
02:42:20 [2024-02-01T02:42:20.001Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
02:42:21 [2024-02-01T02:42:21.375Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (1.11s)
02:42:21 [2024-02-01T02:42:21.375Z] === RUN   TestAuthZPluginHeader
02:42:21 [2024-02-01T02:42:21.941Z] --- PASS: TestAuthZPluginHeader (0.61s)
02:42:21 [2024-02-01T02:42:21.941Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
02:42:21 [2024-02-01T02:42:21.941Z]     authz_plugin_v2_test.go:40: (*Execution).NotAmd64-fm
02:42:21 [2024-02-01T02:42:21.941Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
02:42:21 [2024-02-01T02:42:21.941Z] === RUN   TestAuthZPluginV2Disable
02:42:21 [2024-02-01T02:42:21.941Z]     authz_plugin_v2_test.go:61: (*Execution).NotAmd64-fm
02:42:21 [2024-02-01T02:42:21.941Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
02:42:21 [2024-02-01T02:42:21.941Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
02:42:21 [2024-02-01T02:42:21.941Z]     authz_plugin_v2_test.go:87: (*Execution).NotAmd64-fm
02:42:21 [2024-02-01T02:42:21.941Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
02:42:21 [2024-02-01T02:42:21.941Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
02:42:21 [2024-02-01T02:42:21.941Z]     authz_plugin_v2_test.go:122: (*Execution).NotAmd64-fm
02:42:21 [2024-02-01T02:42:21.941Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
02:42:21 [2024-02-01T02:42:21.941Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
02:42:40 [2024-02-01T02:42:40.015Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.88s)
02:42:40 [2024-02-01T02:42:40.015Z] PASS
02:42:40 [2024-02-01T02:42:40.015Z] 
02:42:40 [2024-02-01T02:42:40.015Z] === Skipped
02:42:40 [2024-02-01T02:42:40.015Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
02:42:40 [2024-02-01T02:42:40.015Z]     authz_plugin_v2_test.go:40: (*Execution).NotAmd64-fm
02:42:40 [2024-02-01T02:42:40.015Z] 
02:42:40 [2024-02-01T02:42:40.015Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
02:42:40 [2024-02-01T02:42:40.015Z]     authz_plugin_v2_test.go:61: (*Execution).NotAmd64-fm
02:42:40 [2024-02-01T02:42:40.015Z] 
02:42:40 [2024-02-01T02:42:40.015Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
02:42:40 [2024-02-01T02:42:40.015Z]     authz_plugin_v2_test.go:87: (*Execution).NotAmd64-fm
02:42:40 [2024-02-01T02:42:40.015Z] 
02:42:40 [2024-02-01T02:42:40.015Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
02:42:40 [2024-02-01T02:42:40.015Z]     authz_plugin_v2_test.go:122: (*Execution).NotAmd64-fm
02:42:40 [2024-02-01T02:42:40.015Z] 
02:42:40 [2024-02-01T02:42:40.015Z] DONE 17 tests, 4 skipped in 30.566s
02:42:40 [2024-02-01T02:42:40.015Z] Running /go/src/github.com/docker/docker/integration/plugin/common (arm64.integration.plugin.common) flags=-test.v -test.timeout=120m  
02:42:40 [2024-02-01T02:42:40.015Z] ++ '[' -n '' ']'
02:42:40 [2024-02-01T02:42:40.015Z] ++ 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
02:42:40 [2024-02-01T02:42:40.015Z] ++ set -e
02:42:40 [2024-02-01T02:42:40.015Z] ++ '[' -n 0 ']'
02:42:40 [2024-02-01T02:42:40.015Z] ++ set -x
02:42:40 [2024-02-01T02:42:40.015Z] ++ 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.E5Oucw1va8/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
02:42:40 [2024-02-01T02:42:40.015Z] INFO: Testing against a local daemon
02:42:40 [2024-02-01T02:42:40.015Z] === RUN   TestPluginInvalidJSON
02:42:40 [2024-02-01T02:42:40.015Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set
02:42:40 [2024-02-01T02:42:40.015Z] === PAUSE TestPluginInvalidJSON/plugins/foobar/set
02:42:40 [2024-02-01T02:42:40.015Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade
02:42:40 [2024-02-01T02:42:40.015Z] === PAUSE TestPluginInvalidJSON/plugins/foobar/upgrade
02:42:40 [2024-02-01T02:42:40.015Z] === RUN   TestPluginInvalidJSON/plugins/pull
02:42:40 [2024-02-01T02:42:40.015Z] === PAUSE TestPluginInvalidJSON/plugins/pull
02:42:40 [2024-02-01T02:42:40.015Z] === CONT  TestPluginInvalidJSON/plugins/foobar/set
02:42:40 [2024-02-01T02:42:40.015Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/invalid_content_type
02:42:40 [2024-02-01T02:42:40.015Z] === CONT  TestPluginInvalidJSON/plugins/pull
02:42:40 [2024-02-01T02:42:40.015Z] === RUN   TestPluginInvalidJSON/plugins/pull/invalid_content_type
02:42:40 [2024-02-01T02:42:40.015Z] === CONT  TestPluginInvalidJSON/plugins/foobar/upgrade
02:42:40 [2024-02-01T02:42:40.015Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_content_type
02:42:40 [2024-02-01T02:42:40.015Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/invalid_JSON
02:42:40 [2024-02-01T02:42:40.015Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_JSON
02:42:40 [2024-02-01T02:42:40.015Z] === RUN   TestPluginInvalidJSON/plugins/pull/invalid_JSON
02:42:40 [2024-02-01T02:42:40.015Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/extra_content_after_JSON
02:42:40 [2024-02-01T02:42:40.015Z] === RUN   TestPluginInvalidJSON/plugins/pull/extra_content_after_JSON
02:42:40 [2024-02-01T02:42:40.015Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/extra_content_after_JSON
02:42:40 [2024-02-01T02:42:40.015Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/empty_body
02:42:40 [2024-02-01T02:42:40.015Z] === RUN   TestPluginInvalidJSON/plugins/pull/empty_body
02:42:40 [2024-02-01T02:42:40.015Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/empty_body
02:42:40 [2024-02-01T02:42:40.015Z] --- PASS: TestPluginInvalidJSON (0.01s)
02:42:40 [2024-02-01T02:42:40.015Z]     --- PASS: TestPluginInvalidJSON/plugins/foobar/set (0.00s)
02:42:40 [2024-02-01T02:42:40.015Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/invalid_content_type (0.00s)
02:42:40 [2024-02-01T02:42:40.015Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/invalid_JSON (0.00s)
02:42:40 [2024-02-01T02:42:40.015Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/extra_content_after_JSON (0.00s)
02:42:40 [2024-02-01T02:42:40.015Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/empty_body (0.00s)
02:42:40 [2024-02-01T02:42:40.015Z]     --- PASS: TestPluginInvalidJSON/plugins/pull (0.00s)
02:42:40 [2024-02-01T02:42:40.015Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/invalid_content_type (0.00s)
02:42:40 [2024-02-01T02:42:40.015Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/invalid_JSON (0.00s)
02:42:40 [2024-02-01T02:42:40.015Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/extra_content_after_JSON (0.00s)
02:42:40 [2024-02-01T02:42:40.015Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/empty_body (0.00s)
02:42:40 [2024-02-01T02:42:40.015Z]     --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade (0.00s)
02:42:40 [2024-02-01T02:42:40.015Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_content_type (0.00s)
02:42:40 [2024-02-01T02:42:40.015Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_JSON (0.00s)
02:42:40 [2024-02-01T02:42:40.015Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/extra_content_after_JSON (0.00s)
02:42:40 [2024-02-01T02:42:40.015Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/empty_body (0.00s)
02:42:40 [2024-02-01T02:42:40.015Z] === RUN   TestPluginInstall
02:42:40 [2024-02-01T02:42:40.015Z] === RUN   TestPluginInstall/no_auth
02:42:42 [2024-02-01T02:42:42.563Z] time="2024-02-01T02:42:42Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
02:42:42 [2024-02-01T02:42:42.563Z] time="2024-02-01T02:42:42Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:c1cbbc38109cb7de57c530d132a2dae5bb175cdb8f1a2b6648cb3fa8e7da07fb" mediatype=application/vnd.docker.plugin.v1+json size=522
02:42:42 [2024-02-01T02:42:42.563Z] time="2024-02-01T02:42:42Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
02:42:42 [2024-02-01T02:42:42.563Z] time="2024-02-01T02:42:42Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:c1cbbc38109cb7de57c530d132a2dae5bb175cdb8f1a2b6648cb3fa8e7da07fb" mediatype=application/vnd.docker.plugin.v1+json size=522
02:42:42 [2024-02-01T02:42:42.563Z] === RUN   TestPluginInstall/with_htpasswd
02:42:42 [2024-02-01T02:42:42.821Z] time="2024-02-01T02:42:42Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
02:42:42 [2024-02-01T02:42:42.821Z] time="2024-02-01T02:42:42Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:42a372716c5d308809fd1cbe5f4debf69921a87f5ff5b1ce9e1dde246fb116bb" mediatype=application/vnd.docker.plugin.v1+json size=522
02:42:42 [2024-02-01T02:42:42.821Z] time="2024-02-01T02:42:42Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
02:42:42 [2024-02-01T02:42:42.821Z] time="2024-02-01T02:42:42Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:42a372716c5d308809fd1cbe5f4debf69921a87f5ff5b1ce9e1dde246fb116bb" mediatype=application/vnd.docker.plugin.v1+json size=522
02:42:42 [2024-02-01T02:42:42.821Z] === RUN   TestPluginInstall/with_insecure
02:42:43 [2024-02-01T02:42:43.755Z] time="2024-02-01T02:42:43Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
02:42:43 [2024-02-01T02:42:43.755Z] time="2024-02-01T02:42:43Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:5e7d77ce14475c14fca5e86ed044835ed49337c70af87e86ab995180e1ba9077" mediatype=application/vnd.docker.plugin.v1+json size=522
02:42:43 [2024-02-01T02:42:43.755Z] time="2024-02-01T02:42:43Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
02:42:43 [2024-02-01T02:42:43.755Z] time="2024-02-01T02:42:43Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:5e7d77ce14475c14fca5e86ed044835ed49337c70af87e86ab995180e1ba9077" mediatype=application/vnd.docker.plugin.v1+json size=522
02:42:43 [2024-02-01T02:42:43.755Z]     plugin_test.go:204: [dcd8c954f0790] daemon is not started
02:42:43 [2024-02-01T02:42:43.755Z] --- PASS: TestPluginInstall (5.11s)
02:42:43 [2024-02-01T02:42:43.755Z]     --- PASS: TestPluginInstall/no_auth (3.73s)
02:42:43 [2024-02-01T02:42:43.755Z]     --- PASS: TestPluginInstall/with_htpasswd (0.45s)
02:42:43 [2024-02-01T02:42:43.755Z]     --- PASS: TestPluginInstall/with_insecure (0.92s)
02:42:43 [2024-02-01T02:42:43.755Z] === RUN   TestPluginsWithRuntimes
02:42:45 [2024-02-01T02:42:45.653Z] === RUN   TestPluginsWithRuntimes/No_Args
02:42:46 [2024-02-01T02:42:46.219Z] === RUN   TestPluginsWithRuntimes/With_Args
02:42:47 [2024-02-01T02:42:47.152Z] --- PASS: TestPluginsWithRuntimes (3.32s)
02:42:47 [2024-02-01T02:42:47.152Z]     --- PASS: TestPluginsWithRuntimes/No_Args (0.89s)
02:42:47 [2024-02-01T02:42:47.152Z]     --- PASS: TestPluginsWithRuntimes/With_Args (0.92s)
02:42:47 [2024-02-01T02:42:47.152Z] === RUN   TestPluginBackCompatMediaTypes
02:42:47 [2024-02-01T02:42:47.718Z] --- PASS: TestPluginBackCompatMediaTypes (0.49s)
02:42:47 [2024-02-01T02:42:47.718Z] PASS
02:42:47 [2024-02-01T02:42:47.718Z] 
02:42:47 [2024-02-01T02:42:47.718Z] DONE 24 tests in 8.962s
02:42:47 [2024-02-01T02:42:47.718Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (arm64.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m  
02:42:47 [2024-02-01T02:42:47.718Z] ++ '[' -n '' ']'
02:42:47 [2024-02-01T02:42:47.718Z] ++ 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
02:42:47 [2024-02-01T02:42:47.718Z] ++ set -e
02:42:47 [2024-02-01T02:42:47.718Z] ++ '[' -n 0 ']'
02:42:47 [2024-02-01T02:42:47.718Z] ++ set -x
02:42:47 [2024-02-01T02:42:47.718Z] ++ 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.E5Oucw1va8/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
02:42:47 [2024-02-01T02:42:47.718Z] INFO: Testing against a local daemon
02:42:47 [2024-02-01T02:42:47.718Z] === RUN   TestExternalGraphDriver
02:42:47 [2024-02-01T02:42:47.976Z] === RUN   TestExternalGraphDriver/json
02:42:47 [2024-02-01T02:42:47.976Z] === RUN   TestExternalGraphDriver/spec
02:42:47 [2024-02-01T02:42:47.976Z] === RUN   TestExternalGraphDriver/pull
02:42:47 [2024-02-01T02:42:47.976Z] --- PASS: TestExternalGraphDriver (0.34s)
02:42:47 [2024-02-01T02:42:47.976Z]     --- PASS: TestExternalGraphDriver/json (0.00s)
02:42:47 [2024-02-01T02:42:47.976Z]     --- PASS: TestExternalGraphDriver/spec (0.00s)
02:42:47 [2024-02-01T02:42:47.976Z]     --- PASS: TestExternalGraphDriver/pull (0.00s)
02:42:47 [2024-02-01T02:42:47.976Z] === RUN   TestGraphdriverPluginV2
02:42:48 [2024-02-01T02:42:48.234Z]     external_test.go:416: (*Execution).NotAmd64-fm
02:42:48 [2024-02-01T02:42:48.234Z] --- SKIP: TestGraphdriverPluginV2 (0.32s)
02:42:48 [2024-02-01T02:42:48.234Z] PASS
02:42:48 [2024-02-01T02:42:48.492Z] 
02:42:48 [2024-02-01T02:42:48.492Z] === Skipped
02:42:48 [2024-02-01T02:42:48.492Z] === SKIP: arm64.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.32s)
02:42:48 [2024-02-01T02:42:48.492Z]     external_test.go:416: (*Execution).NotAmd64-fm
02:42:48 [2024-02-01T02:42:48.492Z] 
02:42:48 [2024-02-01T02:42:48.492Z] DONE 5 tests, 1 skipped in 0.699s
02:42:48 [2024-02-01T02:42:48.492Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (arm64.integration.plugin.logging) flags=-test.v -test.timeout=120m  
02:42:48 [2024-02-01T02:42:48.492Z] ++ '[' -n '' ']'
02:42:48 [2024-02-01T02:42:48.492Z] ++ 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
02:42:48 [2024-02-01T02:42:48.492Z] ++ set -e
02:42:48 [2024-02-01T02:42:48.492Z] ++ '[' -n 0 ']'
02:42:48 [2024-02-01T02:42:48.492Z] ++ set -x
02:42:48 [2024-02-01T02:42:48.492Z] ++ 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.E5Oucw1va8/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
02:42:48 [2024-02-01T02:42:48.492Z] INFO: Testing against a local daemon
02:42:48 [2024-02-01T02:42:48.492Z] === RUN   TestContinueAfterPluginCrash
02:42:48 [2024-02-01T02:42:48.492Z] === PAUSE TestContinueAfterPluginCrash
02:42:48 [2024-02-01T02:42:48.492Z] === RUN   TestReadPluginNoRead
02:42:48 [2024-02-01T02:42:48.492Z] === PAUSE TestReadPluginNoRead
02:42:48 [2024-02-01T02:42:48.492Z] === RUN   TestDaemonStartWithLogOpt
02:42:48 [2024-02-01T02:42:48.492Z] === PAUSE TestDaemonStartWithLogOpt
02:42:48 [2024-02-01T02:42:48.492Z] === CONT  TestContinueAfterPluginCrash
02:42:48 [2024-02-01T02:42:48.492Z] === CONT  TestDaemonStartWithLogOpt
02:42:48 [2024-02-01T02:42:48.492Z] === CONT  TestReadPluginNoRead
02:42:50 [2024-02-01T02:42:50.391Z] === RUN   TestReadPluginNoRead/default
02:42:51 [2024-02-01T02:42:51.325Z] --- PASS: TestDaemonStartWithLogOpt (2.71s)
02:42:51 [2024-02-01T02:42:51.583Z] === RUN   TestReadPluginNoRead/disabled_caching
02:42:52 [2024-02-01T02:42:52.956Z] === RUN   TestReadPluginNoRead/explicitly_enabled_caching
02:42:54 [2024-02-01T02:42:54.329Z]     read_test.go:93: [d6c99725c42ec] daemon is not started
02:42:54 [2024-02-01T02:42:54.329Z] --- PASS: TestReadPluginNoRead (5.68s)
02:42:54 [2024-02-01T02:42:54.329Z]     --- PASS: TestReadPluginNoRead/default (1.19s)
02:42:54 [2024-02-01T02:42:54.329Z]     --- PASS: TestReadPluginNoRead/disabled_caching (1.21s)
02:42:54 [2024-02-01T02:42:54.329Z]     --- PASS: TestReadPluginNoRead/explicitly_enabled_caching (1.20s)
02:42:56 [2024-02-01T02:42:56.227Z] --- PASS: TestContinueAfterPluginCrash (7.59s)
02:42:56 [2024-02-01T02:42:56.227Z] PASS
02:42:56 [2024-02-01T02:42:56.227Z] 
02:42:56 [2024-02-01T02:42:56.227Z] DONE 6 tests in 7.623s
02:42:56 [2024-02-01T02:42:56.228Z] Running /go/src/github.com/docker/docker/integration/plugin/logging/cmd/discard (arm64.integration.plugin.logging.cmd.discard) flags=-test.v -test.timeout=120m  
02:42:56 [2024-02-01T02:42:56.228Z] ++ '[' -n '' ']'
02:42:56 [2024-02-01T02:42:56.228Z] ++ 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
02:42:56 [2024-02-01T02:42:56.228Z] ++ set -e
02:42:56 [2024-02-01T02:42:56.228Z] ++ '[' -n 0 ']'
02:42:56 [2024-02-01T02:42:56.228Z] ++ set -x
02:42:56 [2024-02-01T02:42:56.228Z] ++ 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.E5Oucw1va8/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
02:42:56 [2024-02-01T02:42:56.228Z] testing: warning: no tests to run
02:42:56 [2024-02-01T02:42:56.228Z] PASS
02:42:56 [2024-02-01T02:42:56.228Z] 
02:42:56 [2024-02-01T02:42:56.228Z] DONE 0 tests in 0.007s
02:42:56 [2024-02-01T02:42:56.228Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (arm64.integration.plugin.volumes) flags=-test.v -test.timeout=120m  
02:42:56 [2024-02-01T02:42:56.228Z] ++ '[' -n '' ']'
02:42:56 [2024-02-01T02:42:56.228Z] ++ 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
02:42:56 [2024-02-01T02:42:56.228Z] ++ set -e
02:42:56 [2024-02-01T02:42:56.228Z] ++ '[' -n 0 ']'
02:42:56 [2024-02-01T02:42:56.228Z] ++ set -x
02:42:56 [2024-02-01T02:42:56.228Z] ++ 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.E5Oucw1va8/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
02:42:56 [2024-02-01T02:42:56.228Z] INFO: Testing against a local daemon
02:42:56 [2024-02-01T02:42:56.228Z] === RUN   TestPluginWithDevMounts
02:42:56 [2024-02-01T02:42:56.228Z] === PAUSE TestPluginWithDevMounts
02:42:56 [2024-02-01T02:42:56.228Z] === CONT  TestPluginWithDevMounts
02:42:57 [2024-02-01T02:42:57.601Z] --- PASS: TestPluginWithDevMounts (1.50s)
02:42:57 [2024-02-01T02:42:57.601Z] PASS
02:42:57 [2024-02-01T02:42:57.601Z] 
02:42:57 [2024-02-01T02:42:57.601Z] DONE 1 tests in 1.534s
02:42:57 [2024-02-01T02:42:57.601Z] Running /go/src/github.com/docker/docker/integration/secret (arm64.integration.secret) flags=-test.v -test.timeout=120m  
02:42:57 [2024-02-01T02:42:57.601Z] ++ '[' -n '' ']'
02:42:57 [2024-02-01T02:42:57.601Z] ++ 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
02:42:57 [2024-02-01T02:42:57.601Z] ++ set -e
02:42:57 [2024-02-01T02:42:57.601Z] ++ '[' -n 0 ']'
02:42:57 [2024-02-01T02:42:57.601Z] ++ set -x
02:42:57 [2024-02-01T02:42:57.602Z] ++ 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.E5Oucw1va8/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
02:42:57 [2024-02-01T02:42:57.602Z] INFO: Testing against a local daemon
02:42:57 [2024-02-01T02:42:57.602Z] === RUN   TestSecretInspect
02:43:00 [2024-02-01T02:43:00.128Z] --- PASS: TestSecretInspect (1.99s)
02:43:00 [2024-02-01T02:43:00.128Z] === RUN   TestSecretList
02:43:01 [2024-02-01T02:43:01.501Z] --- PASS: TestSecretList (1.99s)
02:43:01 [2024-02-01T02:43:01.501Z] === RUN   TestSecretsCreateAndDelete
02:43:04 [2024-02-01T02:43:04.030Z] --- PASS: TestSecretsCreateAndDelete (1.92s)
02:43:04 [2024-02-01T02:43:04.030Z] === RUN   TestSecretsUpdate
02:43:05 [2024-02-01T02:43:05.404Z] --- PASS: TestSecretsUpdate (1.92s)
02:43:05 [2024-02-01T02:43:05.404Z] === RUN   TestTemplatedSecret
02:43:07 [2024-02-01T02:43:07.932Z] --- PASS: TestTemplatedSecret (2.38s)
02:43:07 [2024-02-01T02:43:07.932Z] === RUN   TestSecretCreateResolve
02:43:09 [2024-02-01T02:43:09.831Z] --- PASS: TestSecretCreateResolve (1.88s)
02:43:09 [2024-02-01T02:43:09.831Z] PASS
02:43:09 [2024-02-01T02:43:09.831Z] 
02:43:09 [2024-02-01T02:43:09.831Z] DONE 6 tests in 12.137s
02:43:09 [2024-02-01T02:43:09.831Z] Running /go/src/github.com/docker/docker/integration/service (arm64.integration.service) flags=-test.v -test.timeout=120m  
02:43:09 [2024-02-01T02:43:09.831Z] ++ '[' -n '' ']'
02:43:09 [2024-02-01T02:43:09.831Z] ++ 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
02:43:09 [2024-02-01T02:43:09.831Z] ++ set -e
02:43:09 [2024-02-01T02:43:09.831Z] ++ '[' -n 0 ']'
02:43:09 [2024-02-01T02:43:09.831Z] ++ set -x
02:43:09 [2024-02-01T02:43:09.831Z] ++ 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.E5Oucw1va8/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
02:43:09 [2024-02-01T02:43:09.831Z] INFO: Testing against a local daemon
02:43:09 [2024-02-01T02:43:09.831Z] === RUN   TestServiceCreateInit
02:43:09 [2024-02-01T02:43:09.831Z] === RUN   TestServiceCreateInit/daemonInitDisabled
02:43:14 [2024-02-01T02:43:14.014Z] === RUN   TestServiceCreateInit/daemonInitEnabled
02:43:17 [2024-02-01T02:43:17.295Z] --- PASS: TestServiceCreateInit (7.22s)
02:43:17 [2024-02-01T02:43:17.295Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (3.62s)
02:43:17 [2024-02-01T02:43:17.295Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (3.58s)
02:43:17 [2024-02-01T02:43:17.295Z] === RUN   TestCreateServiceMultipleTimes
02:43:32 [2024-02-01T02:43:32.162Z] --- PASS: TestCreateServiceMultipleTimes (14.53s)
02:43:32 [2024-02-01T02:43:32.162Z] === RUN   TestCreateServiceConflict
02:43:33 [2024-02-01T02:43:33.535Z] --- PASS: TestCreateServiceConflict (1.88s)
02:43:33 [2024-02-01T02:43:33.535Z] === RUN   TestCreateServiceMaxReplicas
02:43:36 [2024-02-01T02:43:36.064Z] --- PASS: TestCreateServiceMaxReplicas (2.62s)
02:43:36 [2024-02-01T02:43:36.064Z] === RUN   TestCreateServiceSecretFileMode
02:43:48 [2024-02-01T02:43:48.258Z] --- PASS: TestCreateServiceSecretFileMode (12.34s)
02:43:48 [2024-02-01T02:43:48.258Z] === RUN   TestCreateServiceConfigFileMode
02:44:03 [2024-02-01T02:44:03.125Z] --- PASS: TestCreateServiceConfigFileMode (12.39s)
02:44:03 [2024-02-01T02:44:03.125Z] === RUN   TestCreateServiceSysctls
02:44:03 [2024-02-01T02:44:03.691Z] --- PASS: TestCreateServiceSysctls (2.89s)
02:44:03 [2024-02-01T02:44:03.691Z] === RUN   TestCreateServiceCapabilities
02:44:06 [2024-02-01T02:44:06.219Z] --- PASS: TestCreateServiceCapabilities (2.44s)
02:44:06 [2024-02-01T02:44:06.219Z] === RUN   TestInspect
02:44:08 [2024-02-01T02:44:08.747Z] --- PASS: TestInspect (2.55s)
02:44:08 [2024-02-01T02:44:08.747Z] === RUN   TestCreateJob
02:44:12 [2024-02-01T02:44:12.027Z] --- PASS: TestCreateJob (3.10s)
02:44:12 [2024-02-01T02:44:12.027Z] === RUN   TestReplicatedJob
02:44:16 [2024-02-01T02:44:16.208Z] --- PASS: TestReplicatedJob (4.34s)
02:44:16 [2024-02-01T02:44:16.208Z] === RUN   TestUpdateReplicatedJob
02:44:19 [2024-02-01T02:44:19.488Z] --- PASS: TestUpdateReplicatedJob (2.93s)
02:44:19 [2024-02-01T02:44:19.488Z] === RUN   TestServiceListWithStatuses
02:44:23 [2024-02-01T02:44:23.673Z] --- PASS: TestServiceListWithStatuses (4.23s)
02:44:23 [2024-02-01T02:44:23.673Z] === RUN   TestDockerNetworkConnectAliasPreV144
02:44:27 [2024-02-01T02:44:27.856Z] --- PASS: TestDockerNetworkConnectAliasPreV144 (3.95s)
02:44:27 [2024-02-01T02:44:27.856Z] === RUN   TestDockerNetworkReConnect
02:44:30 [2024-02-01T02:44:30.383Z] --- PASS: TestDockerNetworkReConnect (3.28s)
02:44:30 [2024-02-01T02:44:30.383Z] === RUN   TestServicePlugin
02:44:30 [2024-02-01T02:44:30.383Z]     plugin_test.go:25: (*Execution).NotAmd64-fm
02:44:30 [2024-02-01T02:44:30.383Z] --- SKIP: TestServicePlugin (0.00s)
02:44:30 [2024-02-01T02:44:30.383Z] === RUN   TestServiceUpdateLabel
02:44:32 [2024-02-01T02:44:32.287Z] --- PASS: TestServiceUpdateLabel (1.91s)
02:44:32 [2024-02-01T02:44:32.287Z] === RUN   TestServiceUpdateSecrets
02:44:47 [2024-02-01T02:44:47.155Z] --- PASS: TestServiceUpdateSecrets (14.28s)
02:44:47 [2024-02-01T02:44:47.155Z] === RUN   TestServiceUpdateConfigs
02:45:02 [2024-02-01T02:45:02.024Z] --- PASS: TestServiceUpdateConfigs (14.28s)
02:45:02 [2024-02-01T02:45:02.024Z] === RUN   TestServiceUpdateNetwork
02:45:14 [2024-02-01T02:45:14.226Z] --- PASS: TestServiceUpdateNetwork (12.07s)
02:45:14 [2024-02-01T02:45:14.226Z] === RUN   TestServiceUpdatePidsLimit
02:45:14 [2024-02-01T02:45:14.226Z] === RUN   TestServiceUpdatePidsLimit/create_service_with_PidsLimit_300
02:45:14 [2024-02-01T02:45:14.792Z] === RUN   TestServiceUpdatePidsLimit/unset_PidsLimit_to_0
02:45:22 [2024-02-01T02:45:22.898Z] === RUN   TestServiceUpdatePidsLimit/update_PidsLimit_to_100
02:45:29 [2024-02-01T02:45:29.453Z] --- PASS: TestServiceUpdatePidsLimit (15.92s)
02:45:29 [2024-02-01T02:45:29.453Z]     --- PASS: TestServiceUpdatePidsLimit/create_service_with_PidsLimit_300 (0.52s)
02:45:29 [2024-02-01T02:45:29.453Z]     --- PASS: TestServiceUpdatePidsLimit/unset_PidsLimit_to_0 (6.88s)
02:45:29 [2024-02-01T02:45:29.453Z]     --- PASS: TestServiceUpdatePidsLimit/update_PidsLimit_to_100 (6.78s)
02:45:29 [2024-02-01T02:45:29.453Z] PASS
02:45:29 [2024-02-01T02:45:29.453Z] 
02:45:29 [2024-02-01T02:45:29.453Z] === Skipped
02:45:29 [2024-02-01T02:45:29.453Z] === SKIP: arm64.integration.service TestServicePlugin (0.00s)
02:45:29 [2024-02-01T02:45:29.453Z]     plugin_test.go:25: (*Execution).NotAmd64-fm
02:45:29 [2024-02-01T02:45:29.453Z] 
02:45:29 [2024-02-01T02:45:29.453Z] DONE 26 tests, 1 skipped in 139.160s
02:45:29 [2024-02-01T02:45:29.453Z] Running /go/src/github.com/docker/docker/integration/session (arm64.integration.session) flags=-test.v -test.timeout=120m  
02:45:29 [2024-02-01T02:45:29.453Z] ++ '[' -n '' ']'
02:45:29 [2024-02-01T02:45:29.453Z] ++ 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
02:45:29 [2024-02-01T02:45:29.453Z] ++ set -e
02:45:29 [2024-02-01T02:45:29.453Z] ++ '[' -n 0 ']'
02:45:29 [2024-02-01T02:45:29.453Z] ++ set -x
02:45:29 [2024-02-01T02:45:29.453Z] ++ 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.E5Oucw1va8/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
02:45:29 [2024-02-01T02:45:29.453Z] INFO: Testing against a local daemon
02:45:29 [2024-02-01T02:45:29.453Z] === RUN   TestSessionCreate
02:45:29 [2024-02-01T02:45:29.453Z] --- PASS: TestSessionCreate (0.01s)
02:45:29 [2024-02-01T02:45:29.453Z] === RUN   TestSessionCreateWithBadUpgrade
02:45:29 [2024-02-01T02:45:29.453Z] --- PASS: TestSessionCreateWithBadUpgrade (0.01s)
02:45:29 [2024-02-01T02:45:29.453Z] PASS
02:45:29 [2024-02-01T02:45:29.453Z] 
02:45:29 [2024-02-01T02:45:29.454Z] DONE 2 tests in 0.046s
02:45:29 [2024-02-01T02:45:29.454Z] Running /go/src/github.com/docker/docker/integration/system (arm64.integration.system) flags=-test.v -test.timeout=120m  
02:45:29 [2024-02-01T02:45:29.454Z] ++ '[' -n '' ']'
02:45:29 [2024-02-01T02:45:29.454Z] ++ 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
02:45:29 [2024-02-01T02:45:29.454Z] ++ set -e
02:45:29 [2024-02-01T02:45:29.454Z] ++ '[' -n 0 ']'
02:45:29 [2024-02-01T02:45:29.454Z] ++ set -x
02:45:29 [2024-02-01T02:45:29.454Z] ++ 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.E5Oucw1va8/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
02:45:29 [2024-02-01T02:45:29.454Z] INFO: Testing against a local daemon
02:45:29 [2024-02-01T02:45:29.454Z] === RUN   TestCgroupDriverSystemdMemoryLimit
02:45:29 [2024-02-01T02:45:29.454Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
02:45:29 [2024-02-01T02:45:29.454Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
02:45:29 [2024-02-01T02:45:29.454Z] === RUN   TestDiskUsage
02:45:29 [2024-02-01T02:45:29.454Z] === PAUSE TestDiskUsage
02:45:29 [2024-02-01T02:45:29.454Z] === RUN   TestEventsExecDie
02:45:29 [2024-02-01T02:45:29.454Z] --- PASS: TestEventsExecDie (0.54s)
02:45:29 [2024-02-01T02:45:29.454Z] === RUN   TestEventsBackwardsCompatible
02:45:29 [2024-02-01T02:45:29.711Z] --- PASS: TestEventsBackwardsCompatible (0.04s)
02:45:29 [2024-02-01T02:45:29.711Z] === RUN   TestEventsVolumeCreate
02:45:29 [2024-02-01T02:45:29.711Z] --- PASS: TestEventsVolumeCreate (0.05s)
02:45:29 [2024-02-01T02:45:29.712Z] === RUN   TestInfoBinaryCommits
02:45:29 [2024-02-01T02:45:29.712Z] --- PASS: TestInfoBinaryCommits (0.01s)
02:45:29 [2024-02-01T02:45:29.712Z] === RUN   TestInfoAPIVersioned
02:45:29 [2024-02-01T02:45:29.712Z] --- PASS: TestInfoAPIVersioned (0.01s)
02:45:29 [2024-02-01T02:45:29.712Z] === RUN   TestInfoAPI
02:45:29 [2024-02-01T02:45:29.712Z] --- PASS: TestInfoAPI (0.01s)
02:45:29 [2024-02-01T02:45:29.712Z] === RUN   TestInfoAPIWarnings
02:45:47 [2024-02-01T02:45:47.788Z] --- PASS: TestInfoAPIWarnings (16.55s)
02:45:47 [2024-02-01T02:45:47.788Z] === RUN   TestInfoDebug
02:45:47 [2024-02-01T02:45:47.788Z] --- PASS: TestInfoDebug (0.52s)
02:45:47 [2024-02-01T02:45:47.788Z] === RUN   TestInfoInsecureRegistries
02:45:47 [2024-02-01T02:45:47.788Z] --- PASS: TestInfoInsecureRegistries (0.52s)
02:45:47 [2024-02-01T02:45:47.788Z] === RUN   TestInfoRegistryMirrors
02:45:47 [2024-02-01T02:45:47.788Z] --- PASS: TestInfoRegistryMirrors (0.52s)
02:45:47 [2024-02-01T02:45:47.788Z] === RUN   TestLoginFailsWithBadCredentials
02:45:48 [2024-02-01T02:45:48.722Z] --- PASS: TestLoginFailsWithBadCredentials (0.98s)
02:45:48 [2024-02-01T02:45:48.722Z] === RUN   TestPingCacheHeaders
02:45:48 [2024-02-01T02:45:48.722Z] --- PASS: TestPingCacheHeaders (0.01s)
02:45:48 [2024-02-01T02:45:48.722Z] === RUN   TestPingGet
02:45:48 [2024-02-01T02:45:48.722Z] --- PASS: TestPingGet (0.01s)
02:45:48 [2024-02-01T02:45:48.722Z] === RUN   TestPingHead
02:45:48 [2024-02-01T02:45:48.722Z] --- PASS: TestPingHead (0.01s)
02:45:48 [2024-02-01T02:45:48.722Z] === RUN   TestPingSwarmHeader
02:45:49 [2024-02-01T02:45:49.288Z] === RUN   TestPingSwarmHeader/before_swarm_init
02:45:49 [2024-02-01T02:45:49.853Z] === RUN   TestPingSwarmHeader/after_swarm_init
02:45:50 [2024-02-01T02:45:50.787Z] === RUN   TestPingSwarmHeader/after_swarm_leave
02:45:50 [2024-02-01T02:45:50.787Z] --- PASS: TestPingSwarmHeader (1.90s)
02:45:50 [2024-02-01T02:45:50.787Z]     --- PASS: TestPingSwarmHeader/before_swarm_init (0.00s)
02:45:50 [2024-02-01T02:45:50.787Z]     --- PASS: TestPingSwarmHeader/after_swarm_init (0.00s)
02:45:50 [2024-02-01T02:45:50.787Z]     --- PASS: TestPingSwarmHeader/after_swarm_leave (0.00s)
02:45:50 [2024-02-01T02:45:50.787Z] === RUN   TestPingBuilderHeader
02:45:50 [2024-02-01T02:45:50.787Z] === RUN   TestPingBuilderHeader/default_config
02:45:51 [2024-02-01T02:45:51.352Z] === RUN   TestPingBuilderHeader/buildkit_disabled
02:45:51 [2024-02-01T02:45:51.611Z] --- PASS: TestPingBuilderHeader (1.04s)
02:45:51 [2024-02-01T02:45:51.611Z]     --- PASS: TestPingBuilderHeader/default_config (0.52s)
02:45:51 [2024-02-01T02:45:51.611Z]     --- PASS: TestPingBuilderHeader/buildkit_disabled (0.52s)
02:45:51 [2024-02-01T02:45:51.611Z] === RUN   TestVersion
02:45:51 [2024-02-01T02:45:51.869Z] --- PASS: TestVersion (0.01s)
02:45:51 [2024-02-01T02:45:51.869Z] === CONT  TestDiskUsage
02:45:52 [2024-02-01T02:45:52.127Z] === RUN   TestDiskUsage/empty
02:45:52 [2024-02-01T02:45:52.127Z] === RUN   TestDiskUsage/empty/container_types
02:45:52 [2024-02-01T02:45:52.127Z] === RUN   TestDiskUsage/empty/image_types
02:45:52 [2024-02-01T02:45:52.127Z] === RUN   TestDiskUsage/empty/volume_types
02:45:52 [2024-02-01T02:45:52.127Z] === RUN   TestDiskUsage/empty/build-cache_types
02:45:52 [2024-02-01T02:45:52.127Z] === RUN   TestDiskUsage/empty/container,_volume_types
02:45:52 [2024-02-01T02:45:52.127Z] === RUN   TestDiskUsage/empty/image,_build-cache_types
02:45:52 [2024-02-01T02:45:52.127Z] === RUN   TestDiskUsage/empty/container,_volume,_build-cache_types
02:45:52 [2024-02-01T02:45:52.127Z] === RUN   TestDiskUsage/empty/image,_volume,_build-cache_types
02:45:52 [2024-02-01T02:45:52.127Z] === RUN   TestDiskUsage/empty/container,_image,_volume_types
02:45:52 [2024-02-01T02:45:52.127Z] === RUN   TestDiskUsage/empty/container,_image,_volume,_build-cache_types
02:45:52 [2024-02-01T02:45:52.127Z] === RUN   TestDiskUsage/after_LoadBusybox
02:45:52 [2024-02-01T02:45:52.385Z] === RUN   TestDiskUsage/after_LoadBusybox/container_types
02:45:52 [2024-02-01T02:45:52.385Z] === RUN   TestDiskUsage/after_LoadBusybox/image_types
02:45:52 [2024-02-01T02:45:52.385Z] === RUN   TestDiskUsage/after_LoadBusybox/volume_types
02:45:52 [2024-02-01T02:45:52.385Z] === RUN   TestDiskUsage/after_LoadBusybox/build-cache_types
02:45:52 [2024-02-01T02:45:52.385Z] === RUN   TestDiskUsage/after_LoadBusybox/container,_volume_types
02:45:52 [2024-02-01T02:45:52.385Z] === RUN   TestDiskUsage/after_LoadBusybox/image,_build-cache_types
02:45:52 [2024-02-01T02:45:52.385Z] === RUN   TestDiskUsage/after_LoadBusybox/container,_volume,_build-cache_types
02:45:52 [2024-02-01T02:45:52.385Z] === RUN   TestDiskUsage/after_LoadBusybox/image,_volume,_build-cache_types
02:45:52 [2024-02-01T02:45:52.385Z] === RUN   TestDiskUsage/after_LoadBusybox/container,_image,_volume_types
02:45:52 [2024-02-01T02:45:52.385Z] === RUN   TestDiskUsage/after_LoadBusybox/container,_image,_volume,_build-cache_types
02:45:52 [2024-02-01T02:45:52.385Z] === RUN   TestDiskUsage/after_container.Run
02:45:52 [2024-02-01T02:45:52.644Z] === RUN   TestDiskUsage/after_container.Run/container_types
02:45:52 [2024-02-01T02:45:52.644Z] === RUN   TestDiskUsage/after_container.Run/image_types
02:45:52 [2024-02-01T02:45:52.644Z] === RUN   TestDiskUsage/after_container.Run/volume_types
02:45:52 [2024-02-01T02:45:52.644Z] === RUN   TestDiskUsage/after_container.Run/build-cache_types
02:45:52 [2024-02-01T02:45:52.644Z] === RUN   TestDiskUsage/after_container.Run/container,_volume_types
02:45:52 [2024-02-01T02:45:52.644Z] === RUN   TestDiskUsage/after_container.Run/image,_build-cache_types
02:45:52 [2024-02-01T02:45:52.644Z] === RUN   TestDiskUsage/after_container.Run/container,_volume,_build-cache_types
02:45:52 [2024-02-01T02:45:52.644Z] === RUN   TestDiskUsage/after_container.Run/image,_volume,_build-cache_types
02:45:52 [2024-02-01T02:45:52.644Z] === RUN   TestDiskUsage/after_container.Run/container,_image,_volume_types
02:45:52 [2024-02-01T02:45:52.644Z] === RUN   TestDiskUsage/after_container.Run/container,_image,_volume,_build-cache_types
02:45:52 [2024-02-01T02:45:52.644Z] --- PASS: TestDiskUsage (1.03s)
02:45:52 [2024-02-01T02:45:52.644Z]     --- PASS: TestDiskUsage/empty (0.01s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/empty/container_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/empty/image_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/empty/volume_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/empty/build-cache_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/empty/container,_volume_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/empty/image,_build-cache_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/empty/container,_volume,_build-cache_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/empty/image,_volume,_build-cache_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/empty/container,_image,_volume_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/empty/container,_image,_volume,_build-cache_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]     --- PASS: TestDiskUsage/after_LoadBusybox (0.08s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/after_LoadBusybox/image_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/after_LoadBusybox/volume_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/after_LoadBusybox/build-cache_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container,_volume_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/after_LoadBusybox/image,_build-cache_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container,_volume,_build-cache_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/after_LoadBusybox/image,_volume,_build-cache_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container,_image,_volume_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container,_image,_volume,_build-cache_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]     --- PASS: TestDiskUsage/after_container.Run (0.25s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/after_container.Run/container_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/after_container.Run/image_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/after_container.Run/volume_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/after_container.Run/build-cache_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/after_container.Run/container,_volume_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/after_container.Run/image,_build-cache_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/after_container.Run/container,_volume,_build-cache_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/after_container.Run/image,_volume,_build-cache_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/after_container.Run/container,_image,_volume_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]         --- PASS: TestDiskUsage/after_container.Run/container,_image,_volume,_build-cache_types (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z] PASS
02:45:52 [2024-02-01T02:45:52.644Z] 
02:45:52 [2024-02-01T02:45:52.644Z] === Skipped
02:45:52 [2024-02-01T02:45:52.644Z] === SKIP: arm64.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
02:45:52 [2024-02-01T02:45:52.644Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
02:45:52 [2024-02-01T02:45:52.644Z] 
02:45:52 [2024-02-01T02:45:52.644Z] DONE 57 tests, 1 skipped in 23.804s
02:45:52 [2024-02-01T02:45:52.902Z] Running /go/src/github.com/docker/docker/integration/volume (arm64.integration.volume) flags=-test.v -test.timeout=120m  
02:45:52 [2024-02-01T02:45:52.902Z] ++ '[' -n '' ']'
02:45:52 [2024-02-01T02:45:52.902Z] ++ 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
02:45:52 [2024-02-01T02:45:52.902Z] ++ set -e
02:45:52 [2024-02-01T02:45:52.902Z] ++ '[' -n 0 ']'
02:45:52 [2024-02-01T02:45:52.902Z] ++ set -x
02:45:52 [2024-02-01T02:45:52.902Z] ++ 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.E5Oucw1va8/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
02:45:52 [2024-02-01T02:45:52.902Z] INFO: Testing against a local daemon
02:45:52 [2024-02-01T02:45:52.902Z] === RUN   TestRunMountVolumeSubdir
02:45:53 [2024-02-01T02:45:53.161Z]     mount_test.go:28: Setup stderr:
02:45:53 [2024-02-01T02:45:53.161Z]     mount_test.go:28: Setup stdout:
02:45:53 [2024-02-01T02:45:53.161Z]         /volume:
02:45:53 [2024-02-01T02:45:53.161Z]         total 24K    
02:45:53 [2024-02-01T02:45:53.161Z]         drwxr-xr-x    5 root     root        4.0K Feb  1 02:45 .
02:45:53 [2024-02-01T02:45:53.161Z]         drwxr-xr-x    1 root     root        4.0K Feb  1 02:45 ..
02:45:53 [2024-02-01T02:45:53.161Z]         -rw-r--r--    1 root     root           4 Feb  1 02:45 bar.txt
02:45:53 [2024-02-01T02:45:53.161Z]         drwxr-xr-x    2 root     root        4.0K Feb  1 02:45 bin
02:45:53 [2024-02-01T02:45:53.161Z]         drwxr-xr-x    3 root     root        4.0K Feb  1 02:45 hack
02:45:53 [2024-02-01T02:45:53.161Z]         drwxr-xr-x    2 root     root        4.0K Feb  1 02:45 subdir
02:45:53 [2024-02-01T02:45:53.161Z]         
02:45:53 [2024-02-01T02:45:53.161Z]         /volume/hack/:
02:45:53 [2024-02-01T02:45:53.161Z]         total 12K    
02:45:53 [2024-02-01T02:45:53.161Z]         drwxr-xr-x    3 root     root        4.0K Feb  1 02:45 .
02:45:53 [2024-02-01T02:45:53.161Z]         drwxr-xr-x    5 root     root        4.0K Feb  1 02:45 ..
02:45:53 [2024-02-01T02:45:53.161Z]         lrwxrwxrwx    1 root     root           4 Feb  1 02:45 bad -> root
02:45:53 [2024-02-01T02:45:53.161Z]         lrwxrwxrwx    1 root     root           9 Feb  1 02:45 good -> ../subdir
02:45:53 [2024-02-01T02:45:53.161Z]         drwxr-xr-x    2 root     root        4.0K Feb  1 02:45 iwanttobehackedwithtoctou
02:45:53 [2024-02-01T02:45:53.161Z]         lrwxrwxrwx    1 root     root           1 Feb  1 02:45 root -> /
02:45:53 [2024-02-01T02:45:53.161Z] === RUN   TestRunMountVolumeSubdir/subdir
02:45:53 [2024-02-01T02:45:53.727Z]     mount_test.go:101: stdout:
02:45:53 [2024-02-01T02:45:53.727Z]         hello.txt
02:45:53 [2024-02-01T02:45:53.727Z]     mount_test.go:102: stderr:
02:45:53 [2024-02-01T02:45:53.727Z] === RUN   TestRunMountVolumeSubdir/subdir_link
02:45:53 [2024-02-01T02:45:53.985Z]     mount_test.go:101: stdout:
02:45:53 [2024-02-01T02:45:53.985Z]         hello.txt
02:45:53 [2024-02-01T02:45:53.985Z]     mount_test.go:102: stderr:
02:45:53 [2024-02-01T02:45:53.985Z] === RUN   TestRunMountVolumeSubdir/subdir_with_copy_data
02:45:54 [2024-02-01T02:45:54.550Z]     mount_test.go:101: stdout:
02:45:54 [2024-02-01T02:45:54.550Z]         /bin/busybox
02:45:54 [2024-02-01T02:45:54.550Z]     mount_test.go:102: stderr:
02:45:54 [2024-02-01T02:45:54.550Z] === RUN   TestRunMountVolumeSubdir/file
02:45:55 [2024-02-01T02:45:55.116Z]     mount_test.go:101: stdout:
02:45:55 [2024-02-01T02:45:55.116Z]         foo
02:45:55 [2024-02-01T02:45:55.116Z]     mount_test.go:102: stderr:
02:45:55 [2024-02-01T02:45:55.116Z] === RUN   TestRunMountVolumeSubdir/relative_with_backtracks
02:45:55 [2024-02-01T02:45:55.116Z] === RUN   TestRunMountVolumeSubdir/not_existing
02:45:55 [2024-02-01T02:45:55.116Z] === RUN   TestRunMountVolumeSubdir/mount_link
02:45:55 [2024-02-01T02:45:55.375Z] === RUN   TestRunMountVolumeSubdir/mount_link_link
02:45:55 [2024-02-01T02:45:55.375Z] --- PASS: TestRunMountVolumeSubdir (2.57s)
02:45:55 [2024-02-01T02:45:55.375Z]     --- PASS: TestRunMountVolumeSubdir/subdir (0.43s)
02:45:55 [2024-02-01T02:45:55.375Z]     --- PASS: TestRunMountVolumeSubdir/subdir_link (0.44s)
02:45:55 [2024-02-01T02:45:55.375Z]     --- PASS: TestRunMountVolumeSubdir/subdir_with_copy_data (0.46s)
02:45:55 [2024-02-01T02:45:55.375Z]     --- PASS: TestRunMountVolumeSubdir/file (0.42s)
02:45:55 [2024-02-01T02:45:55.375Z]     --- PASS: TestRunMountVolumeSubdir/relative_with_backtracks (0.00s)
02:45:55 [2024-02-01T02:45:55.375Z]     --- PASS: TestRunMountVolumeSubdir/not_existing (0.13s)
02:45:55 [2024-02-01T02:45:55.375Z]     --- PASS: TestRunMountVolumeSubdir/mount_link (0.14s)
02:45:55 [2024-02-01T02:45:55.375Z]     --- PASS: TestRunMountVolumeSubdir/mount_link_link (0.13s)
02:45:55 [2024-02-01T02:45:55.375Z] === RUN   TestVolumesCreateAndList
02:45:55 [2024-02-01T02:45:55.375Z] --- PASS: TestVolumesCreateAndList (0.01s)
02:45:55 [2024-02-01T02:45:55.375Z] === RUN   TestVolumesRemove
02:45:55 [2024-02-01T02:45:55.375Z] === RUN   TestVolumesRemove/volume_in_use
02:45:55 [2024-02-01T02:45:55.375Z] === RUN   TestVolumesRemove/volume_not_in_use
02:45:55 [2024-02-01T02:45:55.375Z] === RUN   TestVolumesRemove/non-existing_volume
02:45:55 [2024-02-01T02:45:55.375Z] === RUN   TestVolumesRemove/non-existing_volume_force
02:45:55 [2024-02-01T02:45:55.375Z] --- PASS: TestVolumesRemove (0.05s)
02:45:55 [2024-02-01T02:45:55.375Z]     --- PASS: TestVolumesRemove/volume_in_use (0.00s)
02:45:55 [2024-02-01T02:45:55.375Z]     --- PASS: TestVolumesRemove/volume_not_in_use (0.01s)
02:45:55 [2024-02-01T02:45:55.375Z]     --- PASS: TestVolumesRemove/non-existing_volume (0.00s)
02:45:55 [2024-02-01T02:45:55.375Z]     --- PASS: TestVolumesRemove/non-existing_volume_force (0.00s)
02:45:55 [2024-02-01T02:45:55.375Z] === RUN   TestVolumesRemoveSwarmEnabled
02:45:55 [2024-02-01T02:45:55.375Z] === PAUSE TestVolumesRemoveSwarmEnabled
02:45:55 [2024-02-01T02:45:55.375Z] === RUN   TestVolumesInspect
02:45:55 [2024-02-01T02:45:55.375Z] --- PASS: TestVolumesInspect (0.01s)
02:45:55 [2024-02-01T02:45:55.375Z] === RUN   TestVolumesInvalidJSON
02:45:55 [2024-02-01T02:45:55.375Z] === RUN   TestVolumesInvalidJSON/volumes/create
02:45:55 [2024-02-01T02:45:55.375Z] === PAUSE TestVolumesInvalidJSON/volumes/create
02:45:55 [2024-02-01T02:45:55.375Z] === CONT  TestVolumesInvalidJSON/volumes/create
02:45:55 [2024-02-01T02:45:55.375Z] === RUN   TestVolumesInvalidJSON/volumes/create/invalid_content_type
02:45:55 [2024-02-01T02:45:55.375Z] === RUN   TestVolumesInvalidJSON/volumes/create/invalid_JSON
02:45:55 [2024-02-01T02:45:55.375Z] === RUN   TestVolumesInvalidJSON/volumes/create/extra_content_after_JSON
02:45:55 [2024-02-01T02:45:55.375Z] === RUN   TestVolumesInvalidJSON/volumes/create/empty_body
02:45:55 [2024-02-01T02:45:55.375Z] --- PASS: TestVolumesInvalidJSON (0.01s)
02:45:55 [2024-02-01T02:45:55.375Z]     --- PASS: TestVolumesInvalidJSON/volumes/create (0.00s)
02:45:55 [2024-02-01T02:45:55.375Z]         --- PASS: TestVolumesInvalidJSON/volumes/create/invalid_content_type (0.00s)
02:45:55 [2024-02-01T02:45:55.375Z]         --- PASS: TestVolumesInvalidJSON/volumes/create/invalid_JSON (0.00s)
02:45:55 [2024-02-01T02:45:55.375Z]         --- PASS: TestVolumesInvalidJSON/volumes/create/extra_content_after_JSON (0.00s)
02:45:55 [2024-02-01T02:45:55.375Z]         --- PASS: TestVolumesInvalidJSON/volumes/create/empty_body (0.00s)
02:45:55 [2024-02-01T02:45:55.375Z] === RUN   TestVolumePruneAnonymous
02:45:55 [2024-02-01T02:45:55.632Z] --- PASS: TestVolumePruneAnonymous (0.03s)
02:45:55 [2024-02-01T02:45:55.632Z] === RUN   TestVolumePruneAnonFromImage
02:45:55 [2024-02-01T02:45:55.632Z] --- PASS: TestVolumePruneAnonFromImage (0.13s)
02:45:55 [2024-02-01T02:45:55.632Z] === CONT  TestVolumesRemoveSwarmEnabled
02:45:57 [2024-02-01T02:45:57.005Z] === RUN   TestVolumesRemoveSwarmEnabled/volume_in_use
02:45:57 [2024-02-01T02:45:57.005Z] === RUN   TestVolumesRemoveSwarmEnabled/volume_not_in_use
02:45:57 [2024-02-01T02:45:57.005Z] === RUN   TestVolumesRemoveSwarmEnabled/non-existing_volume
02:45:57 [2024-02-01T02:45:57.005Z] === RUN   TestVolumesRemoveSwarmEnabled/non-existing_volume_force
02:45:57 [2024-02-01T02:45:57.571Z] --- PASS: TestVolumesRemoveSwarmEnabled (1.90s)
02:45:57 [2024-02-01T02:45:57.571Z]     --- PASS: TestVolumesRemoveSwarmEnabled/volume_in_use (0.00s)
02:45:57 [2024-02-01T02:45:57.571Z]     --- PASS: TestVolumesRemoveSwarmEnabled/volume_not_in_use (0.01s)
02:45:57 [2024-02-01T02:45:57.571Z]     --- PASS: TestVolumesRemoveSwarmEnabled/non-existing_volume (0.00s)
02:45:57 [2024-02-01T02:45:57.571Z]     --- PASS: TestVolumesRemoveSwarmEnabled/non-existing_volume_force (0.00s)
02:45:57 [2024-02-01T02:45:57.571Z] PASS
02:45:57 [2024-02-01T02:45:57.571Z] 
02:45:57 [2024-02-01T02:45:57.571Z] DONE 29 tests in 4.754s
02:45:57 [2024-02-01T02:45:57.571Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
02:45:57 [2024-02-01T02:45:57.571Z] ++++ cat bundles/test-integration/docker.pid
02:45:57 [2024-02-01T02:45:57.571Z] +++ kill 24591
02:45:59 [2024-02-01T02:45:59.473Z] ++++ cat bundles/test-integration/TestUsernsCommit/d016a7fb4ea0d/docker.pid
02:45:59 [2024-02-01T02:45:59.473Z] +++ kill 60639
02:45:59 [2024-02-01T02:45:59.473Z] /go/src/github.com/docker/docker/hack/make/.integration-daemon-stop: line 13: wait: pid 60639 is not a child of this shell
02:45:59 [2024-02-01T02:45:59.473Z] warning: PID 60639 from bundles/test-integration/TestUsernsCommit/d016a7fb4ea0d/docker.pid had a nonzero exit code
02:45:59 [2024-02-01T02:45:59.473Z] umount: bundles/test-integration/TestUsernsCommit/d016a7fb4ea0d/root: not mounted.
02:45:59 [2024-02-01T02:45:59.473Z] +++ /etc/init.d/apparmor stop
02:45:59 [2024-02-01T02:45:59.473Z] Leaving: AppArmorNo profiles have been unloaded.
02:45:59 [2024-02-01T02:45:59.474Z] 
02:45:59 [2024-02-01T02:45:59.474Z] Unloading profiles will leave already running processes permanently
02:45:59 [2024-02-01T02:45:59.474Z] unconfined, which can lead to unexpected situations.
02:45:59 [2024-02-01T02:45:59.474Z] 
02:45:59 [2024-02-01T02:45:59.474Z] To set a process to complain mode, use the command line tool
02:45:59 [2024-02-01T02:45:59.474Z] 'aa-complain'. To really tear down all profiles, run 'aa-teardown'."
02:45:59 [2024-02-01T02:45:59.474Z] +++ true
02:45:59 [2024-02-01T02:45:59.474Z] exiting test-integration
02:45:59 [2024-02-01T02:45:59.474Z] ++ exit 0
02:45:59 [2024-02-01T02:45:59.474Z] 
Post stage
[Pipeline] junit
02:46:00 [2024-02-01T02:46:00.065Z] Recording test results
02:46:00 [2024-02-01T02:46:00.431Z] [Checks API] No suitable checks publisher found.
[Pipeline] }
[Pipeline] // withEnv
[Pipeline] }
[Pipeline] // stage
Post stage
[Pipeline] sh
02:46:00 [2024-02-01T02:46:00.750Z] + echo Ensuring container killed.
02:46:00 [2024-02-01T02:46:00.750Z] Ensuring container killed.
02:46:00 [2024-02-01T02:46:00.750Z] + docker rm -vf docker-pr7
02:46:00 [2024-02-01T02:46:00.750Z] Error response from daemon: No such container: docker-pr7
[Pipeline] sh
02:46:01 [2024-02-01T02:46:01.036Z] + echo Chowning /workspace to jenkins user
02:46:01 [2024-02-01T02:46:01.036Z] Chowning /workspace to jenkins user
02:46:01 [2024-02-01T02:46:01.036Z] + id -u
02:46:01 [2024-02-01T02:46:01.036Z] + id -g
02:46:01 [2024-02-01T02:46:01.036Z] + docker run --rm -v /home/ubuntu/workspace/moby_PR-47285:/workspace busybox chown -R 1000:1000 /workspace
02:46:01 [2024-02-01T02:46:01.036Z] Unable to find image 'busybox:latest' locally
02:46:01 [2024-02-01T02:46:01.036Z] latest: Pulling from library/busybox
02:46:01 [2024-02-01T02:46:01.036Z] c2bf9493c1bf: Already exists
02:46:01 [2024-02-01T02:46:01.295Z] Digest: sha256:6d9ac9237a84afe1516540f40a0fafdc86859b2141954b4d643af7066d598b74
02:46:01 [2024-02-01T02:46:01.295Z] Status: Downloaded newer image for busybox:latest
[Pipeline] catchError
[Pipeline] {
[Pipeline] sh
02:46:02 [2024-02-01T02:46:02.982Z] + bundleName=arm64-integration
02:46:02 [2024-02-01T02:46:02.982Z] + echo Creating arm64-integration-bundles.tar.gz
02:46:02 [2024-02-01T02:46:02.982Z] Creating arm64-integration-bundles.tar.gz
02:46:02 [2024-02-01T02:46:02.982Z] + find bundles -path */root/*overlay2 -prune -o -type f ( -name *-report.json -o -name *.log -o -name *.prof -o -name *-report.xml ) -print
02:46:02 [2024-02-01T02:46:02.982Z] + xargs tar -czf arm64-integration-bundles.tar.gz
[Pipeline] archiveArtifacts
02:46:03 [2024-02-01T02:46:03.255Z] Archiving artifacts
02:46:05 [2024-02-01T02:46:05.821Z] Uploaded 1 artifact(s) to https://docker-ci-jenkins-artifacts.s3.amazonaws.com/public/moby/PR-47285/7/artifacts/
[Pipeline] }
[Pipeline] // catchError
[Pipeline] sh
02:46:06 [2024-02-01T02:46:06.111Z] + make clean
02:46:06 [2024-02-01T02:46:06.111Z] docker volume rm -f docker-dev-cache docker-mod-cache
02:46:06 [2024-02-01T02:46:06.111Z] docker-dev-cache
02:46:06 [2024-02-01T02:46:06.111Z] 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

GitHub has been notified of this commit’s build result

Finished: SUCCESS