Skipping 438 KB.. Full Log

16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.110144273Z" level=debug msg="filesystem.Stat("/docker/registry/v2/blobs/sha256/a2/a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda/data")" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=36800bfd-049d-4de0-8e1d-bcd9a307d96d http.request.method=GET http.request.remoteaddr="127.0.0.1:54654" http.request.uri="/v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=17.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=e15db3a4-40c8-49a7-af57-b1601d12d8d2 trace.line=155 vars.name=test vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.11018359Z" level=debug msg="filesystem.Reader("/docker/registry/v2/blobs/sha256/a2/a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda/data", 0)" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=36800bfd-049d-4de0-8e1d-bcd9a307d96d http.request.method=GET http.request.remoteaddr="127.0.0.1:54654" http.request.uri="/v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=12.225µ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=81c56256-e4cc-4ba6-9bbf-35d07cc19eaa trace.line=125 vars.name=test vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.110216804Z" level=debug msg="(*schema2ManifestHandler).Unmarshal" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=36800bfd-049d-4de0-8e1d-bcd9a307d96d http.request.method=GET http.request.remoteaddr="127.0.0.1:54654" http.request.uri="/v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=test vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.110309166Z" level=info msg="response completed" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=36800bfd-049d-4de0-8e1d-bcd9a307d96d http.request.method=GET http.request.remoteaddr="127.0.0.1:54654" http.request.uri="/v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/vnd.docker.distribution.manifest.v2+json" http.response.duration=1.672582ms http.response.status=200 http.response.written=417 
16:41:19 [2023-09-18T16:41:19.153Z] 127.0.0.1 - - [18/Sep/2023:16:41:19 +0000] "GET /v2/test/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda HTTP/1.1" 200 417 "" "docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.116304035Z" level=debug msg="authorizing request" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=d3a3b6f7-f464-471f-862b-f0c440cb0c7b http.request.method=GET http.request.remoteaddr="127.0.0.1:54662" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.116357859Z" level=debug msg=GetBlob go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=d3a3b6f7-f464-471f-862b-f0c440cb0c7b http.request.method=GET http.request.remoteaddr="127.0.0.1:54662" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.116397948Z" level=debug msg="authorizing request" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=ae102478-d936-4135-82e9-e306a35eac6b http.request.method=GET http.request.remoteaddr="127.0.0.1:54670" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.116443846Z" level=debug msg=GetBlob go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=ae102478-d936-4135-82e9-e306a35eac6b http.request.method=GET http.request.remoteaddr="127.0.0.1:54670" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.116440572Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/test/_layers/sha256/cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b/link")" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=d3a3b6f7-f464-471f-862b-f0c440cb0c7b http.request.method=GET http.request.remoteaddr="127.0.0.1:54662" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=45.677µ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=a12b9ec0-5212-47f2-b1b6-58ed81df93d6 trace.line=95 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.116519322Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/test/_layers/sha256/5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923/link")" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=ae102478-d936-4135-82e9-e306a35eac6b http.request.method=GET http.request.remoteaddr="127.0.0.1:54670" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=36.306µ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=01aaa91e-3ef0-4339-a2ab-cabd596f7418 trace.line=95 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.116603159Z" level=debug msg="filesystem.Stat("/docker/registry/v2/blobs/sha256/cf/cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b/data")" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=d3a3b6f7-f464-471f-862b-f0c440cb0c7b http.request.method=GET http.request.remoteaddr="127.0.0.1:54662" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=26.378µ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=aed02a7c-80cd-4a3f-9c84-c0c7c3d7ad10 trace.line=155 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.116662587Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/test/_layers/sha256/cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b/link")" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=d3a3b6f7-f464-471f-862b-f0c440cb0c7b http.request.method=GET http.request.remoteaddr="127.0.0.1:54662" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=25.066µ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=1f7fbeb8-257f-4bf5-b41e-589aee56ff4e trace.line=95 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.116694135Z" level=debug msg="filesystem.Stat("/docker/registry/v2/blobs/sha256/5d/5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923/data")" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=ae102478-d936-4135-82e9-e306a35eac6b http.request.method=GET http.request.remoteaddr="127.0.0.1:54670" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=36.454µ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=47687a75-eff0-44c1-8bca-ef2bd656ae37 trace.line=155 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.116704604Z" level=debug msg="filesystem.Stat("/docker/registry/v2/blobs/sha256/cf/cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b/data")" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=d3a3b6f7-f464-471f-862b-f0c440cb0c7b http.request.method=GET http.request.remoteaddr="127.0.0.1:54662" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=10.658µ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=d984db53-4d5a-420b-81f5-064b940be96a trace.line=155 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.116739499Z" level=debug msg="filesystem.Stat("/docker/registry/v2/blobs/sha256/cf/cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b/data")" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=d3a3b6f7-f464-471f-862b-f0c440cb0c7b http.request.method=GET http.request.remoteaddr="127.0.0.1:54662" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=9.567µ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=7a238311-34c9-4d72-8499-a40fdd25a8c7 trace.line=155 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.116756811Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/test/_layers/sha256/5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923/link")" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=ae102478-d936-4135-82e9-e306a35eac6b http.request.method=GET http.request.remoteaddr="127.0.0.1:54670" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=25.246µ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=97f10a4e-cedf-48bd-ac65-2ef89e228cee trace.line=95 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.116774575Z" level=debug msg="filesystem.URLFor("/docker/registry/v2/blobs/sha256/cf/cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b/data")" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=d3a3b6f7-f464-471f-862b-f0c440cb0c7b http.request.method=GET http.request.remoteaddr="127.0.0.1:54662" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=10.576µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).URLFor" trace.id=09e1f778-9b5d-4a20-a057-8bc91dba479a trace.line=217 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.116800141Z" level=debug msg="filesystem.Stat("/docker/registry/v2/blobs/sha256/5d/5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923/data")" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=ae102478-d936-4135-82e9-e306a35eac6b http.request.method=GET http.request.remoteaddr="127.0.0.1:54670" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=11.093µ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=6b7c2e31-c637-470b-a11c-86b3d1e35719 trace.line=155 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.116837949Z" level=debug msg="filesystem.Stat("/docker/registry/v2/blobs/sha256/5d/5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923/data")" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=ae102478-d936-4135-82e9-e306a35eac6b http.request.method=GET http.request.remoteaddr="127.0.0.1:54670" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=9.419µ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=452fde3d-7fbf-4e28-930b-dceeb661f2ea trace.line=155 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.116852816Z" level=debug msg="filesystem.Reader("/docker/registry/v2/blobs/sha256/cf/cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b/data", 0)" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=d3a3b6f7-f464-471f-862b-f0c440cb0c7b http.request.method=GET http.request.remoteaddr="127.0.0.1:54662" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=14.088µ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=026a4fdc-a4ca-4be7-b664-37d2cf79c5f4 trace.line=125 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.116872089Z" level=debug msg="filesystem.URLFor("/docker/registry/v2/blobs/sha256/5d/5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923/data")" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=ae102478-d936-4135-82e9-e306a35eac6b http.request.method=GET http.request.remoteaddr="127.0.0.1:54670" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=6.761µ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=e105a621-3b74-4ce3-bcf6-561701ce8d78 trace.line=217 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.116914279Z" level=debug msg="filesystem.Reader("/docker/registry/v2/blobs/sha256/5d/5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923/data", 0)" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=ae102478-d936-4135-82e9-e306a35eac6b http.request.method=GET http.request.remoteaddr="127.0.0.1:54670" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=12.382µ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=1afa4ac8-d89b-4089-b930-21cd66333e1b trace.line=125 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.118249732Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/test/_layers/sha256/5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923/link")" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=ae102478-d936-4135-82e9-e306a35eac6b http.request.method=GET http.request.remoteaddr="127.0.0.1:54670" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=40.105µ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=7897ee62-2359-495b-992a-2536334e696f trace.line=95 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.118324216Z" level=debug msg="filesystem.Stat("/docker/registry/v2/blobs/sha256/5d/5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923/data")" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=ae102478-d936-4135-82e9-e306a35eac6b http.request.method=GET http.request.remoteaddr="127.0.0.1:54670" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=17.099µ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=ca184e65-0b04-45c7-8a1b-3042022000f6 trace.line=155 vars.digest="sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" vars.name=test 
16:41:19 [2023-09-18T16:41:19.153Z] time="2023-09-18T16:41:19.118388049Z" level=info msg="response completed" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=ae102478-d936-4135-82e9-e306a35eac6b http.request.method=GET http.request.remoteaddr="127.0.0.1:54670" http.request.uri="/v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/octet-stream" http.response.duration=2.912137ms http.response.status=200 http.response.written=68 
16:41:19 [2023-09-18T16:41:19.154Z] 127.0.0.1 - - [18/Sep/2023:16:41:19 +0000] "GET /v2/test/blobs/sha256:5d6b514d5023c9b87d5f9688fb5812d6fbe2c27d90d935a4cd95b7a9b589e923 HTTP/1.1" 200 68 "" "docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
16:41:19 [2023-09-18T16:41:19.154Z] time="2023-09-18T16:41:19.11863335Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/test/_layers/sha256/cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b/link")" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=d3a3b6f7-f464-471f-862b-f0c440cb0c7b http.request.method=GET http.request.remoteaddr="127.0.0.1:54662" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=33.762µ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=538ffb66-e44b-401b-9028-b751a39fad7b trace.line=95 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
16:41:19 [2023-09-18T16:41:19.154Z] time="2023-09-18T16:41:19.118701122Z" level=debug msg="filesystem.Stat("/docker/registry/v2/blobs/sha256/cf/cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b/data")" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=d3a3b6f7-f464-471f-862b-f0c440cb0c7b http.request.method=GET http.request.remoteaddr="127.0.0.1:54662" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=17.107µ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=585209df-3142-4343-88c2-ed44597a6fef trace.line=155 vars.digest="sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" vars.name=test 
16:41:19 [2023-09-18T16:41:19.154Z] time="2023-09-18T16:41:19.118759983Z" level=info msg="response completed" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=d3a3b6f7-f464-471f-862b-f0c440cb0c7b http.request.method=GET http.request.remoteaddr="127.0.0.1:54662" http.request.uri="/v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/octet-stream" http.response.duration=3.283808ms http.response.status=200 http.response.written=194 
16:41:19 [2023-09-18T16:41:19.154Z] 127.0.0.1 - - [18/Sep/2023:16:41:19 +0000] "GET /v2/test/blobs/sha256:cf7f382020339d0028918c3868135c3f04f625f684b264b6a63a549bd84ee80b HTTP/1.1" 200 194 "" "docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
16:41:19 [2023-09-18T16:41:19.154Z] time="2023-09-18T16:41:19.131825616Z" level=debug msg="authorizing request" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=e01c9b0f-ec09-4231-aac4-a4fe834e5f50 http.request.method=GET http.request.remoteaddr="127.0.0.1:54688" http.request.uri="/v2/" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" 
16:41:19 [2023-09-18T16:41:19.154Z] time="2023-09-18T16:41:19.131872818Z" level=info msg="response completed" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=e01c9b0f-ec09-4231-aac4-a4fe834e5f50 http.request.method=GET http.request.remoteaddr="127.0.0.1:54688" http.request.uri="/v2/" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/json; charset=utf-8" http.response.duration="864.314µs" http.response.status=200 http.response.written=2 
16:41:19 [2023-09-18T16:41:19.154Z] 127.0.0.1 - - [18/Sep/2023:16:41:19 +0000] "GET /v2/ HTTP/1.1" 200 2 "" "docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
16:41:19 [2023-09-18T16:41:19.154Z] time="2023-09-18T16:41:19.137699283Z" level=debug msg="authorizing request" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=b61d340c-c75d-41ab-9a1f-157eccda4fc5 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:54696" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
16:41:19 [2023-09-18T16:41:19.154Z] time="2023-09-18T16:41:19.137752426Z" level=debug msg=GetImageManifest go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=b61d340c-c75d-41ab-9a1f-157eccda4fc5 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:54696" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
16:41:19 [2023-09-18T16:41:19.154Z] time="2023-09-18T16:41:19.137770009Z" level=debug msg="(*manifestStore).Get" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=b61d340c-c75d-41ab-9a1f-157eccda4fc5 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:54696" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
16:41:19 [2023-09-18T16:41:19.154Z] time="2023-09-18T16:41:19.137855077Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/other/_manifests/revisions/sha256/a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda/link")" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=b61d340c-c75d-41ab-9a1f-157eccda4fc5 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:54696" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=49.549µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).GetContent" trace.id=a116cdcf-5775-4a6a-9b42-a13b6cd26fa9 trace.line=95 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
16:41:19 [2023-09-18T16:41:19.154Z] time="2023-09-18T16:41:19.137926623Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/other/_layers/sha256/a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda/link")" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=b61d340c-c75d-41ab-9a1f-157eccda4fc5 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:54696" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=13.333µ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=3fff8475-0ce5-41a5-a5d0-bc72f065e001 trace.line=95 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
16:41:19 [2023-09-18T16:41:19.154Z] time="2023-09-18T16:41:19.138009599Z" 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.19.9 http.request.host="127.0.0.1:5000" http.request.id=b61d340c-c75d-41ab-9a1f-157eccda4fc5 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:54696" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/json; charset=utf-8" http.response.duration=1.136782ms http.response.status=404 http.response.written=181 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
16:41:19 [2023-09-18T16:41:19.154Z] 127.0.0.1 - - [18/Sep/2023:16:41:19 +0000] "HEAD /v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda HTTP/1.1" 404 181 "" "docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
16:41:19 [2023-09-18T16:41:19.154Z] time="2023-09-18T16:41:19.139424188Z" level=debug msg="authorizing request" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=029607af-4f41-4510-bd96-285794b05f39 http.request.method=GET http.request.remoteaddr="127.0.0.1:54708" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
16:41:19 [2023-09-18T16:41:19.154Z] time="2023-09-18T16:41:19.139479661Z" level=debug msg=GetImageManifest go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=029607af-4f41-4510-bd96-285794b05f39 http.request.method=GET http.request.remoteaddr="127.0.0.1:54708" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
16:41:19 [2023-09-18T16:41:19.154Z] time="2023-09-18T16:41:19.139494536Z" level=debug msg="(*manifestStore).Get" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=029607af-4f41-4510-bd96-285794b05f39 http.request.method=GET http.request.remoteaddr="127.0.0.1:54708" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
16:41:19 [2023-09-18T16:41:19.154Z] time="2023-09-18T16:41:19.139562259Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/other/_manifests/revisions/sha256/a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda/link")" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=029607af-4f41-4510-bd96-285794b05f39 http.request.method=GET http.request.remoteaddr="127.0.0.1:54708" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=31.433µs trace.file="github.com/docker/distribution/registry/storage/driver/base/base.go" trace.func="github.com/docker/distribution/registry/storage/driver/base.(*Base).GetContent" trace.id=dcc69c03-292f-4845-9492-1eb52ca6c0ae trace.line=95 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
16:41:19 [2023-09-18T16:41:19.154Z] time="2023-09-18T16:41:19.139613827Z" level=debug msg="filesystem.GetContent("/docker/registry/v2/repositories/other/_layers/sha256/a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda/link")" go.version=go1.19.9 http.request.host="127.0.0.1:5000" http.request.id=029607af-4f41-4510-bd96-285794b05f39 http.request.method=GET http.request.remoteaddr="127.0.0.1:54708" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" trace.duration=14.17µ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=7c9d07e9-5568-481a-9052-c272958beec3 trace.line=95 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
16:41:19 [2023-09-18T16:41:19.154Z] time="2023-09-18T16:41:19.139664582Z" 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.19.9 http.request.host="127.0.0.1:5000" http.request.id=029607af-4f41-4510-bd96-285794b05f39 http.request.method=GET http.request.remoteaddr="127.0.0.1:54708" http.request.uri="/v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" http.request.useragent="docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)" http.response.contenttype="application/json; charset=utf-8" http.response.duration=1.120774ms http.response.status=404 http.response.written=181 vars.name=other vars.reference="sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda" 
16:41:19 [2023-09-18T16:41:19.154Z] 127.0.0.1 - - [18/Sep/2023:16:41:19 +0000] "GET /v2/other/manifests/sha256:a250d50e44c6366699e845175235d1c4be154b0c4359b3d7ef5590bf2dcf8eda HTTP/1.1" 404 181 "" "docker/dev go/go1.20.8 git-commit/45e29ae1468e8688964fc76e2ff96585a9ddf032 kernel/5.15.0-1039-aws os/linux arch/arm64 UpstreamClient(Go-http-client/1.1)"
16:41:19 [2023-09-18T16:41:19.154Z] --- PASS: TestImagePullStoredfDigestForOtherRepo (0.18s)
16:41:19 [2023-09-18T16:41:19.154Z] === RUN   TestRemoveImageOrphaning
16:41:19 [2023-09-18T16:41:19.412Z] --- PASS: TestRemoveImageOrphaning (0.15s)
16:41:19 [2023-09-18T16:41:19.412Z] === RUN   TestRemoveByDigest
16:41:19 [2023-09-18T16:41:19.412Z]     remove_test.go:63: !testEnv.UsingSnapshotter(): RepoDigests doesn't include tags when using graphdrivers
16:41:19 [2023-09-18T16:41:19.412Z] --- SKIP: TestRemoveByDigest (0.00s)
16:41:19 [2023-09-18T16:41:19.412Z] === RUN   TestRemoveImageGarbageCollector
16:41:19 [2023-09-18T16:41:19.412Z]     remove_unix_test.go:34: (*Execution).NotAmd64-fm
16:41:19 [2023-09-18T16:41:19.412Z] --- SKIP: TestRemoveImageGarbageCollector (0.00s)
16:41:19 [2023-09-18T16:41:19.412Z] === RUN   TestSaveCheckTimes
16:41:19 [2023-09-18T16:41:19.412Z] === PAUSE TestSaveCheckTimes
16:41:19 [2023-09-18T16:41:19.412Z] === RUN   TestSaveRepoWithMultipleImages
16:41:20 [2023-09-18T16:41:20.344Z] --- PASS: TestSaveRepoWithMultipleImages (0.96s)
16:41:20 [2023-09-18T16:41:20.344Z] === RUN   TestSaveDirectoryPermissions
16:41:21 [2023-09-18T16:41:21.276Z] --- PASS: TestSaveDirectoryPermissions (0.96s)
16:41:21 [2023-09-18T16:41:21.277Z] === RUN   TestTagUnprefixedRepoByNameOrName
16:41:21 [2023-09-18T16:41:21.277Z] --- PASS: TestTagUnprefixedRepoByNameOrName (0.02s)
16:41:21 [2023-09-18T16:41:21.277Z] === RUN   TestTagUsingDigestAlgorithmAsName
16:41:21 [2023-09-18T16:41:21.277Z] --- PASS: TestTagUsingDigestAlgorithmAsName (0.01s)
16:41:21 [2023-09-18T16:41:21.277Z] === RUN   TestTagValidPrefixedRepo
16:41:21 [2023-09-18T16:41:21.277Z] === RUN   TestTagValidPrefixedRepo/fooo/bar
16:41:21 [2023-09-18T16:41:21.277Z] === PAUSE TestTagValidPrefixedRepo/fooo/bar
16:41:21 [2023-09-18T16:41:21.277Z] === RUN   TestTagValidPrefixedRepo/fooaa/test
16:41:21 [2023-09-18T16:41:21.277Z] === PAUSE TestTagValidPrefixedRepo/fooaa/test
16:41:21 [2023-09-18T16:41:21.277Z] === RUN   TestTagValidPrefixedRepo/foooo:t
16:41:21 [2023-09-18T16:41:21.277Z] === PAUSE TestTagValidPrefixedRepo/foooo:t
16:41:21 [2023-09-18T16:41:21.277Z] === RUN   TestTagValidPrefixedRepo/HOSTNAME.DOMAIN.COM:443/foo/bar
16:41:21 [2023-09-18T16:41:21.277Z] === PAUSE TestTagValidPrefixedRepo/HOSTNAME.DOMAIN.COM:443/foo/bar
16:41:21 [2023-09-18T16:41:21.277Z] === CONT  TestTagValidPrefixedRepo/fooo/bar
16:41:21 [2023-09-18T16:41:21.277Z] === CONT  TestTagValidPrefixedRepo/foooo:t
16:41:21 [2023-09-18T16:41:21.277Z] === CONT  TestTagValidPrefixedRepo/fooaa/test
16:41:21 [2023-09-18T16:41:21.277Z] === CONT  TestTagValidPrefixedRepo/HOSTNAME.DOMAIN.COM:443/foo/bar
16:41:21 [2023-09-18T16:41:21.534Z] --- PASS: TestTagValidPrefixedRepo (0.02s)
16:41:21 [2023-09-18T16:41:21.534Z]     --- PASS: TestTagValidPrefixedRepo/foooo:t (0.01s)
16:41:21 [2023-09-18T16:41:21.534Z]     --- PASS: TestTagValidPrefixedRepo/fooo/bar (0.01s)
16:41:21 [2023-09-18T16:41:21.534Z]     --- PASS: TestTagValidPrefixedRepo/fooaa/test (0.02s)
16:41:21 [2023-09-18T16:41:21.534Z]     --- PASS: TestTagValidPrefixedRepo/HOSTNAME.DOMAIN.COM:443/foo/bar (0.02s)
16:41:21 [2023-09-18T16:41:21.534Z] === RUN   TestTagExistedNameWithoutForce
16:41:21 [2023-09-18T16:41:21.534Z] --- PASS: TestTagExistedNameWithoutForce (0.02s)
16:41:21 [2023-09-18T16:41:21.534Z] === RUN   TestTagOfficialNames
16:41:21 [2023-09-18T16:41:21.534Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_docker.io/busybox
16:41:21 [2023-09-18T16:41:21.534Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_index.docker.io/busybox
16:41:21 [2023-09-18T16:41:21.534Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_library/busybox
16:41:21 [2023-09-18T16:41:21.534Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_docker.io/library/busybox
16:41:21 [2023-09-18T16:41:21.534Z] === RUN   TestTagOfficialNames/tag_from_busybox_to_index.docker.io/library/busybox
16:41:21 [2023-09-18T16:41:21.534Z] --- PASS: TestTagOfficialNames (0.05s)
16:41:21 [2023-09-18T16:41:21.534Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_docker.io/busybox (0.01s)
16:41:21 [2023-09-18T16:41:21.534Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_index.docker.io/busybox (0.01s)
16:41:21 [2023-09-18T16:41:21.534Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_library/busybox (0.01s)
16:41:21 [2023-09-18T16:41:21.534Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_docker.io/library/busybox (0.01s)
16:41:21 [2023-09-18T16:41:21.534Z]     --- PASS: TestTagOfficialNames/tag_from_busybox_to_index.docker.io/library/busybox (0.01s)
16:41:21 [2023-09-18T16:41:21.534Z] === RUN   TestTagMatchesDigest
16:41:21 [2023-09-18T16:41:21.534Z] --- PASS: TestTagMatchesDigest (0.01s)
16:41:21 [2023-09-18T16:41:21.534Z] === CONT  TestSaveCheckTimes
16:41:21 [2023-09-18T16:41:21.534Z] --- PASS: TestSaveCheckTimes (0.03s)
16:41:21 [2023-09-18T16:41:21.534Z] PASS
16:41:21 [2023-09-18T16:41:21.534Z] 
16:41:21 [2023-09-18T16:41:21.534Z] === Skipped
16:41:21 [2023-09-18T16:41:21.534Z] === SKIP: arm64.integration.image TestImportExtremelyLargeImageWorks (0.00s)
16:41:21 [2023-09-18T16:41:21.534Z]     import_test.go:23: runtime.GOARCH == "arm64": effective test will be time out
16:41:21 [2023-09-18T16:41:21.534Z] 
16:41:21 [2023-09-18T16:41:21.534Z] === SKIP: arm64.integration.image TestRemoveByDigest (0.00s)
16:41:21 [2023-09-18T16:41:21.534Z]     remove_test.go:63: !testEnv.UsingSnapshotter(): RepoDigests doesn't include tags when using graphdrivers
16:41:21 [2023-09-18T16:41:21.534Z] 
16:41:21 [2023-09-18T16:41:21.534Z] === SKIP: arm64.integration.image TestRemoveImageGarbageCollector (0.00s)
16:41:21 [2023-09-18T16:41:21.534Z]     remove_unix_test.go:34: (*Execution).NotAmd64-fm
16:41:21 [2023-09-18T16:41:21.534Z] 
16:41:21 [2023-09-18T16:41:21.534Z] DONE 44 tests, 3 skipped in 3.183s
16:41:21 [2023-09-18T16:41:21.534Z] Running /go/src/github.com/docker/docker/integration/internal/termtest (arm64.integration.internal.termtest) flags=-test.v -test.timeout=120m  
16:41:21 [2023-09-18T16:41:21.534Z] ++ 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
16:41:21 [2023-09-18T16:41:21.534Z] ++ set -e
16:41:21 [2023-09-18T16:41:21.535Z] ++ '[' -n 0 ']'
16:41:21 [2023-09-18T16:41:21.535Z] ++ set -x
16:41:21 [2023-09-18T16:41:21.535Z] ++ 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.ZTWQgV4a4B/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= 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
16:41:21 [2023-09-18T16:41:21.535Z] === RUN   TestStripANSICommands
16:41:21 [2023-09-18T16:41:21.535Z] === RUN   TestStripANSICommands/#00
16:41:21 [2023-09-18T16:41:21.535Z] === RUN   TestStripANSICommands/#01
16:41:21 [2023-09-18T16:41:21.535Z] --- PASS: TestStripANSICommands (0.00s)
16:41:21 [2023-09-18T16:41:21.535Z]     --- PASS: TestStripANSICommands/#00 (0.00s)
16:41:21 [2023-09-18T16:41:21.535Z]     --- PASS: TestStripANSICommands/#01 (0.00s)
16:41:21 [2023-09-18T16:41:21.535Z] PASS
16:41:21 [2023-09-18T16:41:21.535Z] 
16:41:21 [2023-09-18T16:41:21.535Z] DONE 3 tests in 0.009s
16:41:21 [2023-09-18T16:41:21.535Z] Running /go/src/github.com/docker/docker/integration/network (arm64.integration.network) flags=-test.v -test.timeout=120m  
16:41:21 [2023-09-18T16:41:21.535Z] ++ 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
16:41:21 [2023-09-18T16:41:21.535Z] ++ set -e
16:41:21 [2023-09-18T16:41:21.535Z] ++ '[' -n 0 ']'
16:41:21 [2023-09-18T16:41:21.535Z] ++ set -x
16:41:21 [2023-09-18T16:41:21.535Z] ++ 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.ZTWQgV4a4B/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= 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
16:41:21 [2023-09-18T16:41:21.535Z] INFO: Testing against a local daemon
16:41:21 [2023-09-18T16:41:21.535Z] === RUN   TestCreateWithMultiNetworks
16:41:22 [2023-09-18T16:41:22.906Z] --- PASS: TestCreateWithMultiNetworks (0.98s)
16:41:22 [2023-09-18T16:41:22.906Z] === RUN   TestNetworkCreateDelete
16:41:22 [2023-09-18T16:41:22.906Z] --- PASS: TestNetworkCreateDelete (0.17s)
16:41:22 [2023-09-18T16:41:22.906Z] === RUN   TestDockerNetworkDeletePreferID
16:41:23 [2023-09-18T16:41:23.164Z] --- PASS: TestDockerNetworkDeletePreferID (0.50s)
16:41:23 [2023-09-18T16:41:23.164Z] === RUN   TestDaemonDNSFallback
16:41:29 [2023-09-18T16:41:29.715Z] --- PASS: TestDaemonDNSFallback (6.23s)
16:41:29 [2023-09-18T16:41:29.715Z] === RUN   TestInspectNetwork
16:41:32 [2023-09-18T16:41:32.241Z] === RUN   TestInspectNetwork/full_network_id
16:41:32 [2023-09-18T16:41:32.241Z] === RUN   TestInspectNetwork/partial_network_id
16:41:32 [2023-09-18T16:41:32.241Z] === RUN   TestInspectNetwork/network_name
16:41:32 [2023-09-18T16:41:32.241Z] === RUN   TestInspectNetwork/network_name_and_swarm_scope
16:41:36 [2023-09-18T16:41:36.418Z] --- PASS: TestInspectNetwork (6.91s)
16:41:36 [2023-09-18T16:41:36.418Z]     --- PASS: TestInspectNetwork/full_network_id (0.00s)
16:41:36 [2023-09-18T16:41:36.418Z]     --- PASS: TestInspectNetwork/partial_network_id (0.00s)
16:41:36 [2023-09-18T16:41:36.418Z]     --- PASS: TestInspectNetwork/network_name (0.00s)
16:41:36 [2023-09-18T16:41:36.418Z]     --- PASS: TestInspectNetwork/network_name_and_swarm_scope (0.00s)
16:41:36 [2023-09-18T16:41:36.418Z] === RUN   TestRunContainerWithBridgeNone
16:41:37 [2023-09-18T16:41:37.789Z] --- PASS: TestRunContainerWithBridgeNone (1.40s)
16:41:37 [2023-09-18T16:41:37.789Z] === RUN   TestNetworkInvalidJSON
16:41:37 [2023-09-18T16:41:37.789Z] === RUN   TestNetworkInvalidJSON/networks/create
16:41:37 [2023-09-18T16:41:37.789Z] === PAUSE TestNetworkInvalidJSON/networks/create
16:41:37 [2023-09-18T16:41:37.789Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect
16:41:37 [2023-09-18T16:41:37.789Z] === PAUSE TestNetworkInvalidJSON/networks/bridge/connect
16:41:37 [2023-09-18T16:41:37.789Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect
16:41:37 [2023-09-18T16:41:37.789Z] === PAUSE TestNetworkInvalidJSON/networks/bridge/disconnect
16:41:37 [2023-09-18T16:41:37.789Z] === CONT  TestNetworkInvalidJSON/networks/create
16:41:37 [2023-09-18T16:41:37.789Z] === CONT  TestNetworkInvalidJSON/networks/bridge/disconnect
16:41:37 [2023-09-18T16:41:37.789Z] === RUN   TestNetworkInvalidJSON/networks/create/invalid_content_type
16:41:37 [2023-09-18T16:41:37.789Z] === CONT  TestNetworkInvalidJSON/networks/bridge/connect
16:41:37 [2023-09-18T16:41:37.789Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect/invalid_content_type
16:41:37 [2023-09-18T16:41:37.789Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect/invalid_content_type
16:41:37 [2023-09-18T16:41:37.789Z] === RUN   TestNetworkInvalidJSON/networks/create/invalid_JSON
16:41:37 [2023-09-18T16:41:37.789Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect/invalid_JSON
16:41:37 [2023-09-18T16:41:37.789Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect/invalid_JSON
16:41:37 [2023-09-18T16:41:37.789Z] === RUN   TestNetworkInvalidJSON/networks/create/extra_content_after_JSON
16:41:37 [2023-09-18T16:41:37.789Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect/extra_content_after_JSON
16:41:37 [2023-09-18T16:41:37.789Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect/extra_content_after_JSON
16:41:37 [2023-09-18T16:41:37.790Z] === RUN   TestNetworkInvalidJSON/networks/create/empty_body
16:41:37 [2023-09-18T16:41:37.790Z] === RUN   TestNetworkInvalidJSON/networks/bridge/connect/empty_body
16:41:37 [2023-09-18T16:41:37.790Z] === RUN   TestNetworkInvalidJSON/networks/bridge/disconnect/empty_body
16:41:37 [2023-09-18T16:41:37.790Z] --- PASS: TestNetworkInvalidJSON (0.01s)
16:41:37 [2023-09-18T16:41:37.790Z]     --- PASS: TestNetworkInvalidJSON/networks/create (0.00s)
16:41:37 [2023-09-18T16:41:37.790Z]         --- PASS: TestNetworkInvalidJSON/networks/create/invalid_content_type (0.00s)
16:41:37 [2023-09-18T16:41:37.790Z]         --- PASS: TestNetworkInvalidJSON/networks/create/invalid_JSON (0.00s)
16:41:37 [2023-09-18T16:41:37.790Z]         --- PASS: TestNetworkInvalidJSON/networks/create/extra_content_after_JSON (0.00s)
16:41:37 [2023-09-18T16:41:37.790Z]         --- PASS: TestNetworkInvalidJSON/networks/create/empty_body (0.00s)
16:41:37 [2023-09-18T16:41:37.790Z]     --- PASS: TestNetworkInvalidJSON/networks/bridge/connect (0.00s)
16:41:37 [2023-09-18T16:41:37.790Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/connect/invalid_content_type (0.00s)
16:41:37 [2023-09-18T16:41:37.790Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/connect/invalid_JSON (0.00s)
16:41:37 [2023-09-18T16:41:37.790Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/connect/extra_content_after_JSON (0.00s)
16:41:37 [2023-09-18T16:41:37.790Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/connect/empty_body (0.00s)
16:41:37 [2023-09-18T16:41:37.790Z]     --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect (0.00s)
16:41:37 [2023-09-18T16:41:37.790Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect/invalid_content_type (0.00s)
16:41:37 [2023-09-18T16:41:37.790Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect/invalid_JSON (0.00s)
16:41:37 [2023-09-18T16:41:37.790Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect/extra_content_after_JSON (0.00s)
16:41:37 [2023-09-18T16:41:37.790Z]         --- PASS: TestNetworkInvalidJSON/networks/bridge/disconnect/empty_body (0.00s)
16:41:37 [2023-09-18T16:41:37.790Z] === RUN   TestNetworkList
16:41:37 [2023-09-18T16:41:37.790Z] === RUN   TestNetworkList//networks
16:41:37 [2023-09-18T16:41:37.790Z] === PAUSE TestNetworkList//networks
16:41:37 [2023-09-18T16:41:37.790Z] === RUN   TestNetworkList//networks/
16:41:37 [2023-09-18T16:41:37.790Z] === PAUSE TestNetworkList//networks/
16:41:37 [2023-09-18T16:41:37.790Z] === CONT  TestNetworkList//networks
16:41:37 [2023-09-18T16:41:37.790Z] === CONT  TestNetworkList//networks/
16:41:37 [2023-09-18T16:41:37.790Z] --- PASS: TestNetworkList (0.01s)
16:41:37 [2023-09-18T16:41:37.790Z]     --- PASS: TestNetworkList//networks (0.00s)
16:41:37 [2023-09-18T16:41:37.790Z]     --- PASS: TestNetworkList//networks/ (0.00s)
16:41:37 [2023-09-18T16:41:37.790Z] === RUN   TestHostIPv4BridgeLabel
16:41:38 [2023-09-18T16:41:38.354Z] --- PASS: TestHostIPv4BridgeLabel (0.57s)
16:41:38 [2023-09-18T16:41:38.354Z] === RUN   TestDefaultNetworkOpts
16:41:38 [2023-09-18T16:41:38.354Z] === RUN   TestDefaultNetworkOpts/default_value
16:41:39 [2023-09-18T16:41:39.728Z] === RUN   TestDefaultNetworkOpts/cmdline_value
16:41:41 [2023-09-18T16:41:41.099Z] === RUN   TestDefaultNetworkOpts/config-from_value
16:41:42 [2023-09-18T16:41:42.471Z] --- PASS: TestDefaultNetworkOpts (4.05s)
16:41:42 [2023-09-18T16:41:42.471Z]     --- PASS: TestDefaultNetworkOpts/default_value (1.33s)
16:41:42 [2023-09-18T16:41:42.471Z]     --- PASS: TestDefaultNetworkOpts/cmdline_value (1.32s)
16:41:42 [2023-09-18T16:41:42.471Z]     --- PASS: TestDefaultNetworkOpts/config-from_value (1.39s)
16:41:42 [2023-09-18T16:41:42.471Z] === RUN   TestForbidDuplicateNetworkNames
16:41:43 [2023-09-18T16:41:43.035Z] --- PASS: TestForbidDuplicateNetworkNames (0.65s)
16:41:43 [2023-09-18T16:41:43.035Z] === RUN   TestDaemonRestartWithLiveRestore
16:41:44 [2023-09-18T16:41:44.407Z] --- PASS: TestDaemonRestartWithLiveRestore (1.04s)
16:41:44 [2023-09-18T16:41:44.407Z] === RUN   TestDaemonDefaultNetworkPools
16:41:44 [2023-09-18T16:41:44.971Z] --- PASS: TestDaemonDefaultNetworkPools (0.81s)
16:41:44 [2023-09-18T16:41:44.971Z] === RUN   TestDaemonRestartWithExistingNetwork
16:41:46 [2023-09-18T16:41:46.342Z] --- PASS: TestDaemonRestartWithExistingNetwork (1.18s)
16:41:46 [2023-09-18T16:41:46.342Z] === RUN   TestDaemonRestartWithExistingNetworkWithDefaultPoolRange
16:41:47 [2023-09-18T16:41:47.714Z] --- PASS: TestDaemonRestartWithExistingNetworkWithDefaultPoolRange (1.28s)
16:41:47 [2023-09-18T16:41:47.714Z] === RUN   TestDaemonWithBipAndDefaultNetworkPool
16:41:47 [2023-09-18T16:41:47.971Z] --- PASS: TestDaemonWithBipAndDefaultNetworkPool (0.61s)
16:41:47 [2023-09-18T16:41:47.971Z] === RUN   TestServiceWithPredefinedNetwork
16:41:50 [2023-09-18T16:41:50.495Z] --- PASS: TestServiceWithPredefinedNetwork (2.17s)
16:41:50 [2023-09-18T16:41:50.495Z] === RUN   TestServiceRemoveKeepsIngressNetwork
16:41:50 [2023-09-18T16:41:50.495Z]     service_test.go:256: FLAKY_TEST
16:41:50 [2023-09-18T16:41:50.495Z] --- SKIP: TestServiceRemoveKeepsIngressNetwork (0.00s)
16:41:50 [2023-09-18T16:41:50.495Z] === RUN   TestServiceWithDataPathPortInit
16:42:05 [2023-09-18T16:42:05.355Z] --- PASS: TestServiceWithDataPathPortInit (14.02s)
16:42:05 [2023-09-18T16:42:05.355Z] === RUN   TestServiceWithDefaultAddressPoolInit
16:42:06 [2023-09-18T16:42:06.727Z]     service_test.go:447: TestServiceWithDefaultAddressPoolInit: NetworkInspect: {Name:sthiraTestServiceWithDefaultAddressPoolInit ID:g62arytq6s6xatdym77a4l7p6 Created:2023-09-18 16:42:05.515741244 +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[5210fb26ab9c9d17fd7ad175a235d11dfff291890b5a4b071447e3ed6918c3c3:{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.m32jcixcnveeafmyeg0it2tvh EndpointID:a13e653a9faa1e4a2145aa57179045f4b2294ab03fa65de842ae94b15d17c30f MacAddress:02:42:14:14:01:03 IPv4Address:20.20.1.3/24 IPv6Address:} lb-sthiraTestServiceWithDefaultAddressPoolInit:{Name:sthiraTestServiceWithDefaultAddressPoolInit-endpoint EndpointID:198b825e2ed135ea030196fc76db9e2a7df59db7dcc7f9100398358d6c0ff490 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:3c5586218248 IP:127.0.0.1}] Services:map[TestServiceTestServiceWithDefaultAddressPoolInit:{VIP:20.20.1.2 Ports:[] LocalLBIndex:256 Tasks:[{Name:TestServiceTestServiceWithDefaultAddressPoolInit.1.m32jcixcnveeafmyeg0it2tvh EndpointID:a13e653a9faa1e4a2145aa57179045f4b2294ab03fa65de842ae94b15d17c30f EndpointIP:20.20.1.3 Info:map[Host IP:127.0.0.1]}]}]}
16:42:11 [2023-09-18T16:42:11.985Z] --- PASS: TestServiceWithDefaultAddressPoolInit (6.86s)
16:42:11 [2023-09-18T16:42:11.985Z] PASS
16:42:11 [2023-09-18T16:42:11.985Z] 
16:42:11 [2023-09-18T16:42:11.985Z] === Skipped
16:42:11 [2023-09-18T16:42:11.985Z] === SKIP: arm64.integration.network TestServiceRemoveKeepsIngressNetwork (0.00s)
16:42:11 [2023-09-18T16:42:11.985Z]     service_test.go:256: FLAKY_TEST
16:42:11 [2023-09-18T16:42:11.985Z] 
16:42:11 [2023-09-18T16:42:11.985Z] DONE 44 tests, 1 skipped in 49.508s
16:42:11 [2023-09-18T16:42:11.985Z] Running /go/src/github.com/docker/docker/integration/network/ipvlan (arm64.integration.network.ipvlan) flags=-test.v -test.timeout=120m  
16:42:11 [2023-09-18T16:42:11.985Z] ++ 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
16:42:11 [2023-09-18T16:42:11.985Z] ++ set -e
16:42:11 [2023-09-18T16:42:11.985Z] ++ '[' -n 0 ']'
16:42:11 [2023-09-18T16:42:11.985Z] ++ set -x
16:42:11 [2023-09-18T16:42:11.985Z] ++ 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.ZTWQgV4a4B/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= 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
16:42:11 [2023-09-18T16:42:11.985Z] INFO: Testing against a local daemon
16:42:11 [2023-09-18T16:42:11.985Z] === RUN   TestDockerNetworkIpvlanPersistance
16:42:11 [2023-09-18T16:42:11.985Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
16:42:11 [2023-09-18T16:42:11.985Z] --- SKIP: TestDockerNetworkIpvlanPersistance (0.00s)
16:42:11 [2023-09-18T16:42:11.985Z] === RUN   TestDockerNetworkIpvlan
16:42:11 [2023-09-18T16:42:11.985Z]     ipvlan_test.go:55: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
16:42:11 [2023-09-18T16:42:11.985Z] --- SKIP: TestDockerNetworkIpvlan (0.00s)
16:42:11 [2023-09-18T16:42:11.985Z] PASS
16:42:11 [2023-09-18T16:42:11.985Z] 
16:42:11 [2023-09-18T16:42:11.985Z] === Skipped
16:42:11 [2023-09-18T16:42:11.985Z] === SKIP: arm64.integration.network.ipvlan TestDockerNetworkIpvlanPersistance (0.00s)
16:42:11 [2023-09-18T16:42:11.985Z]     ipvlan_test.go:26: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
16:42:11 [2023-09-18T16:42:11.985Z] 
16:42:11 [2023-09-18T16:42:11.985Z] === SKIP: arm64.integration.network.ipvlan TestDockerNetworkIpvlan (0.00s)
16:42:11 [2023-09-18T16:42:11.985Z]     ipvlan_test.go:55: !ipvlanKernelSupport(t): Kernel doesn't support ipvlan
16:42:11 [2023-09-18T16:42:11.985Z] 
16:42:11 [2023-09-18T16:42:11.985Z] DONE 2 tests, 2 skipped in 0.045s
16:42:11 [2023-09-18T16:42:11.985Z] Running /go/src/github.com/docker/docker/integration/network/macvlan (arm64.integration.network.macvlan) flags=-test.v -test.timeout=120m  
16:42:11 [2023-09-18T16:42:11.985Z] ++ 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
16:42:11 [2023-09-18T16:42:11.985Z] ++ set -e
16:42:11 [2023-09-18T16:42:11.985Z] ++ '[' -n 0 ']'
16:42:11 [2023-09-18T16:42:11.985Z] ++ set -x
16:42:11 [2023-09-18T16:42:11.985Z] ++ 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.ZTWQgV4a4B/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= 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
16:42:11 [2023-09-18T16:42:11.985Z] INFO: Testing against a local daemon
16:42:11 [2023-09-18T16:42:11.985Z] === RUN   TestDockerNetworkMacvlanPersistance
16:42:12 [2023-09-18T16:42:12.550Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.25s)
16:42:12 [2023-09-18T16:42:12.550Z] === RUN   TestDockerNetworkMacvlan
16:42:12 [2023-09-18T16:42:12.550Z] === RUN   TestDockerNetworkMacvlan/Subinterface
16:42:13 [2023-09-18T16:42:13.115Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
16:42:13 [2023-09-18T16:42:13.680Z] === RUN   TestDockerNetworkMacvlan/NilParent
16:42:14 [2023-09-18T16:42:14.613Z] === RUN   TestDockerNetworkMacvlan/InternalMode
16:42:14 [2023-09-18T16:42:14.871Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
16:42:15 [2023-09-18T16:42:15.803Z] === RUN   TestDockerNetworkMacvlan/Addressing
16:42:16 [2023-09-18T16:42:16.061Z] --- PASS: TestDockerNetworkMacvlan (3.73s)
16:42:16 [2023-09-18T16:42:16.061Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.60s)
16:42:16 [2023-09-18T16:42:16.061Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.60s)
16:42:16 [2023-09-18T16:42:16.061Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (0.73s)
16:42:16 [2023-09-18T16:42:16.061Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (0.61s)
16:42:16 [2023-09-18T16:42:16.061Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (0.60s)
16:42:16 [2023-09-18T16:42:16.061Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (0.59s)
16:42:16 [2023-09-18T16:42:16.061Z] PASS
16:42:16 [2023-09-18T16:42:16.061Z] === RUN   TestDockerNetworkMacvlanPersistance
16:42:17 [2023-09-18T16:42:17.434Z] --- PASS: TestDockerNetworkMacvlanPersistance (1.18s)
16:42:17 [2023-09-18T16:42:17.434Z] === RUN   TestDockerNetworkMacvlan
16:42:17 [2023-09-18T16:42:17.434Z] === RUN   TestDockerNetworkMacvlan/Subinterface
16:42:17 [2023-09-18T16:42:17.999Z] === RUN   TestDockerNetworkMacvlan/OverlapParent
16:42:18 [2023-09-18T16:42:18.564Z] === RUN   TestDockerNetworkMacvlan/NilParent
16:42:19 [2023-09-18T16:42:19.129Z] === RUN   TestDockerNetworkMacvlan/InternalMode
16:42:19 [2023-09-18T16:42:19.693Z] === RUN   TestDockerNetworkMacvlan/MultiSubnet
16:42:20 [2023-09-18T16:42:20.258Z] === RUN   TestDockerNetworkMacvlan/Addressing
16:42:20 [2023-09-18T16:42:20.823Z] --- PASS: TestDockerNetworkMacvlan (3.58s)
16:42:20 [2023-09-18T16:42:20.823Z]     --- PASS: TestDockerNetworkMacvlan/Subinterface (0.60s)
16:42:20 [2023-09-18T16:42:20.823Z]     --- PASS: TestDockerNetworkMacvlan/OverlapParent (0.60s)
16:42:20 [2023-09-18T16:42:20.823Z]     --- PASS: TestDockerNetworkMacvlan/NilParent (0.60s)
16:42:20 [2023-09-18T16:42:20.823Z]     --- PASS: TestDockerNetworkMacvlan/InternalMode (0.60s)
16:42:20 [2023-09-18T16:42:20.823Z]     --- PASS: TestDockerNetworkMacvlan/MultiSubnet (0.59s)
16:42:20 [2023-09-18T16:42:20.823Z]     --- PASS: TestDockerNetworkMacvlan/Addressing (0.59s)
16:42:20 [2023-09-18T16:42:20.823Z] PASS
16:42:20 [2023-09-18T16:42:20.823Z] 
16:42:20 [2023-09-18T16:42:20.823Z] DONE 16 tests in 9.781s
16:42:21 [2023-09-18T16:42:21.081Z] Running /go/src/github.com/docker/docker/integration/plugin (arm64.integration.plugin) flags=-test.v -test.timeout=120m  
16:42:21 [2023-09-18T16:42:21.081Z] ++ 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
16:42:21 [2023-09-18T16:42:21.081Z] ++ set -e
16:42:21 [2023-09-18T16:42:21.081Z] ++ '[' -n 0 ']'
16:42:21 [2023-09-18T16:42:21.081Z] ++ set -x
16:42:21 [2023-09-18T16:42:21.081Z] ++ 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.ZTWQgV4a4B/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= 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
16:42:21 [2023-09-18T16:42:21.081Z] testing: warning: no tests to run
16:42:21 [2023-09-18T16:42:21.081Z] PASS
16:42:21 [2023-09-18T16:42:21.081Z] 
16:42:21 [2023-09-18T16:42:21.081Z] DONE 0 tests in 0.008s
16:42:21 [2023-09-18T16:42:21.081Z] Running /go/src/github.com/docker/docker/integration/plugin/authz (arm64.integration.plugin.authz) flags=-test.v -test.timeout=120m  
16:42:21 [2023-09-18T16:42:21.081Z] ++ 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
16:42:21 [2023-09-18T16:42:21.081Z] ++ set -e
16:42:21 [2023-09-18T16:42:21.081Z] ++ '[' -n 0 ']'
16:42:21 [2023-09-18T16:42:21.081Z] ++ set -x
16:42:21 [2023-09-18T16:42:21.081Z] ++ 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.ZTWQgV4a4B/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= 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
16:42:21 [2023-09-18T16:42:21.081Z] INFO: Testing against a local daemon
16:42:21 [2023-09-18T16:42:21.081Z] === RUN   TestAuthZPluginAllowRequest
16:42:22 [2023-09-18T16:42:22.014Z] --- PASS: TestAuthZPluginAllowRequest (1.08s)
16:42:22 [2023-09-18T16:42:22.014Z] === RUN   TestAuthZPluginTLS
16:42:22 [2023-09-18T16:42:22.579Z] --- PASS: TestAuthZPluginTLS (0.55s)
16:42:22 [2023-09-18T16:42:22.579Z] === RUN   TestAuthZPluginDenyRequest
16:42:23 [2023-09-18T16:42:23.144Z] --- PASS: TestAuthZPluginDenyRequest (0.53s)
16:42:23 [2023-09-18T16:42:23.144Z] === RUN   TestAuthZPluginAPIDenyResponse
16:42:23 [2023-09-18T16:42:23.710Z] --- PASS: TestAuthZPluginAPIDenyResponse (0.53s)
16:42:23 [2023-09-18T16:42:23.710Z] === RUN   TestAuthZPluginDenyResponse
16:42:24 [2023-09-18T16:42:24.275Z] --- PASS: TestAuthZPluginDenyResponse (0.54s)
16:42:24 [2023-09-18T16:42:24.275Z] === RUN   TestAuthZPluginAllowEventStream
16:42:25 [2023-09-18T16:42:25.208Z] 2023/09/18 16:42:25 http: panic serving 127.0.0.1:40256: runtime error: invalid memory address or nil pointer dereference
16:42:25 [2023-09-18T16:42:25.208Z] goroutine 177 [running]:
16:42:25 [2023-09-18T16:42:25.208Z] net/http.(*conn).serve.func1()
16:42:25 [2023-09-18T16:42:25.208Z] 	/usr/local/go/src/net/http/server.go:1854 +0xb0
16:42:25 [2023-09-18T16:42:25.208Z] panic({0xb04960, 0x162c030})
16:42:25 [2023-09-18T16:42:25.208Z] 	/usr/local/go/src/runtime/panic.go:890 +0x248
16:42:25 [2023-09-18T16:42:25.208Z] github.com/docker/docker/integration/plugin/authz.setupSuite.func3({0xdfd770, 0x4000441a40}, 0xffff91128278?)
16:42:25 [2023-09-18T16:42:25.208Z] 	/go/src/github.com/docker/docker/integration/plugin/authz/main_test.go:159 +0x14c
16:42:25 [2023-09-18T16:42:25.208Z] net/http.HandlerFunc.ServeHTTP(0x400056f600?, {0xdfd770?, 0x4000441a40?}, 0x412b94?)
16:42:25 [2023-09-18T16:42:25.208Z] 	/usr/local/go/src/net/http/server.go:2122 +0x38
16:42:25 [2023-09-18T16:42:25.208Z] net/http.(*ServeMux).ServeHTTP(0xdfdc38?, {0xdfd770, 0x4000441a40}, 0x400056f600)
16:42:25 [2023-09-18T16:42:25.208Z] 	/usr/local/go/src/net/http/server.go:2500 +0x13c
16:42:25 [2023-09-18T16:42:25.208Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.(*Handler).ServeHTTP(0x4000264000, {0xdfcb40?, 0x4000536c40}, 0x400056f300)
16:42:25 [2023-09-18T16:42:25.208Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:189 +0x9ac
16:42:25 [2023-09-18T16:42:25.208Z] net/http.serverHandler.ServeHTTP({0xdf36b0?}, {0xdfcb40, 0x4000536c40}, 0x400056f300)
16:42:25 [2023-09-18T16:42:25.208Z] 	/usr/local/go/src/net/http/server.go:2936 +0x2c0
16:42:25 [2023-09-18T16:42:25.208Z] net/http.(*conn).serve(0x4000113950, {0xdfdc38, 0x40002ea210})
16:42:25 [2023-09-18T16:42:25.208Z] 	/usr/local/go/src/net/http/server.go:1995 +0x518
16:42:25 [2023-09-18T16:42:25.208Z] created by net/http.(*Server).Serve
16:42:25 [2023-09-18T16:42:25.208Z] 	/usr/local/go/src/net/http/server.go:3089 +0x4e8
16:42:26 [2023-09-18T16:42:26.140Z] 2023/09/18 16:42:26 http: panic serving 127.0.0.1:40246: could not unmarshal json for /AuthZPlugin.AuthZRes: unexpected end of JSON input
16:42:26 [2023-09-18T16:42:26.140Z] goroutine 132 [running]:
16:42:26 [2023-09-18T16:42:26.140Z] net/http.(*conn).serve.func1()
16:42:26 [2023-09-18T16:42:26.140Z] 	/usr/local/go/src/net/http/server.go:1854 +0xb0
16:42:26 [2023-09-18T16:42:26.140Z] panic({0xaa9560, 0x4000235f90})
16:42:26 [2023-09-18T16:42:26.140Z] 	/usr/local/go/src/runtime/panic.go:890 +0x248
16:42:26 [2023-09-18T16:42:26.140Z] github.com/docker/docker/integration/plugin/authz.setupSuite.func3({0xdfd770, 0x4000441b60}, 0xffff91128278?)
16:42:26 [2023-09-18T16:42:26.140Z] 	/go/src/github.com/docker/docker/integration/plugin/authz/main_test.go:149 +0x36c
16:42:26 [2023-09-18T16:42:26.140Z] net/http.HandlerFunc.ServeHTTP(0x400056fb00?, {0xdfd770?, 0x4000441b60?}, 0x412b94?)
16:42:26 [2023-09-18T16:42:26.140Z] 	/usr/local/go/src/net/http/server.go:2122 +0x38
16:42:26 [2023-09-18T16:42:26.140Z] net/http.(*ServeMux).ServeHTTP(0xdfdc38?, {0xdfd770, 0x4000441b60}, 0x400056fb00)
16:42:26 [2023-09-18T16:42:26.140Z] 	/usr/local/go/src/net/http/server.go:2500 +0x13c
16:42:26 [2023-09-18T16:42:26.140Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.(*Handler).ServeHTTP(0x4000264000, {0xdfcb40?, 0x4000536d20}, 0x400056f700)
16:42:26 [2023-09-18T16:42:26.140Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:189 +0x9ac
16:42:26 [2023-09-18T16:42:26.140Z] net/http.serverHandler.ServeHTTP({0x4000259710?}, {0xdfcb40, 0x4000536d20}, 0x400056f700)
16:42:26 [2023-09-18T16:42:26.140Z] 	/usr/local/go/src/net/http/server.go:2936 +0x2c0
16:42:26 [2023-09-18T16:42:26.140Z] net/http.(*conn).serve(0x4000112cf0, {0xdfdc38, 0x40002ea210})
16:42:26 [2023-09-18T16:42:26.140Z] 	/usr/local/go/src/net/http/server.go:1995 +0x518
16:42:26 [2023-09-18T16:42:26.140Z] created by net/http.(*Server).Serve
16:42:26 [2023-09-18T16:42:26.140Z] 	/usr/local/go/src/net/http/server.go:3089 +0x4e8
16:42:28 [2023-09-18T16:42:28.664Z] 2023/09/18 16:42:28 http: panic serving 127.0.0.1:40268: could not unmarshal json for /AuthZPlugin.AuthZRes: unexpected end of JSON input
16:42:28 [2023-09-18T16:42:28.664Z] goroutine 181 [running]:
16:42:28 [2023-09-18T16:42:28.664Z] net/http.(*conn).serve.func1()
16:42:28 [2023-09-18T16:42:28.664Z] 	/usr/local/go/src/net/http/server.go:1854 +0xb0
16:42:28 [2023-09-18T16:42:28.664Z] panic({0xaa9560, 0x4000411ff0})
16:42:28 [2023-09-18T16:42:28.664Z] 	/usr/local/go/src/runtime/panic.go:890 +0x248
16:42:28 [2023-09-18T16:42:28.664Z] github.com/docker/docker/integration/plugin/authz.setupSuite.func3({0xdfd770, 0x400009d200}, 0xffff91135958?)
16:42:28 [2023-09-18T16:42:28.664Z] 	/go/src/github.com/docker/docker/integration/plugin/authz/main_test.go:149 +0x36c
16:42:28 [2023-09-18T16:42:28.664Z] net/http.HandlerFunc.ServeHTTP(0x4000157500?, {0xdfd770?, 0x400009d200?}, 0x412b94?)
16:42:28 [2023-09-18T16:42:28.664Z] 	/usr/local/go/src/net/http/server.go:2122 +0x38
16:42:28 [2023-09-18T16:42:28.664Z] net/http.(*ServeMux).ServeHTTP(0xdfdc38?, {0xdfd770, 0x400009d200}, 0x4000157500)
16:42:28 [2023-09-18T16:42:28.664Z] 	/usr/local/go/src/net/http/server.go:2500 +0x13c
16:42:28 [2023-09-18T16:42:28.664Z] github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp.(*Handler).ServeHTTP(0x4000264000, {0xdfcb40?, 0x4000528c40}, 0x4000157100)
16:42:28 [2023-09-18T16:42:28.664Z] 	/go/src/github.com/docker/docker/vendor/go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp/handler.go:189 +0x9ac
16:42:28 [2023-09-18T16:42:28.664Z] net/http.serverHandler.ServeHTTP({0x400031c000?}, {0xdfcb40, 0x4000528c40}, 0x4000157100)
16:42:28 [2023-09-18T16:42:28.664Z] 	/usr/local/go/src/net/http/server.go:2936 +0x2c0
16:42:28 [2023-09-18T16:42:28.664Z] net/http.(*conn).serve(0x400002a3f0, {0xdfdc38, 0x40002ea210})
16:42:28 [2023-09-18T16:42:28.664Z] 	/usr/local/go/src/net/http/server.go:1995 +0x518
16:42:28 [2023-09-18T16:42:28.664Z] created by net/http.(*Server).Serve
16:42:28 [2023-09-18T16:42:28.664Z] 	/usr/local/go/src/net/http/server.go:3089 +0x4e8
16:42:30 [2023-09-18T16:42:30.559Z] --- PASS: TestAuthZPluginAllowEventStream (6.25s)
16:42:30 [2023-09-18T16:42:30.559Z] === RUN   TestAuthZPluginErrorResponse
16:42:31 [2023-09-18T16:42:31.124Z] --- PASS: TestAuthZPluginErrorResponse (0.54s)
16:42:31 [2023-09-18T16:42:31.124Z] === RUN   TestAuthZPluginErrorRequest
16:42:31 [2023-09-18T16:42:31.689Z] --- PASS: TestAuthZPluginErrorRequest (0.53s)
16:42:31 [2023-09-18T16:42:31.689Z] === RUN   TestAuthZPluginEnsureNoDuplicatePluginRegistration
16:42:32 [2023-09-18T16:42:32.254Z] --- PASS: TestAuthZPluginEnsureNoDuplicatePluginRegistration (0.53s)
16:42:32 [2023-09-18T16:42:32.254Z] === RUN   TestAuthZPluginEnsureLoadImportWorking
16:42:33 [2023-09-18T16:42:33.626Z] --- PASS: TestAuthZPluginEnsureLoadImportWorking (1.28s)
16:42:33 [2023-09-18T16:42:33.626Z] === RUN   TestAuthzPluginEnsureContainerCopyToFrom
16:42:34 [2023-09-18T16:42:34.998Z] --- PASS: TestAuthzPluginEnsureContainerCopyToFrom (1.32s)
16:42:34 [2023-09-18T16:42:34.998Z] === RUN   TestAuthZPluginHeader
16:42:35 [2023-09-18T16:42:35.255Z] --- PASS: TestAuthZPluginHeader (0.61s)
16:42:35 [2023-09-18T16:42:35.255Z] === RUN   TestAuthZPluginV2AllowNonVolumeRequest
16:42:35 [2023-09-18T16:42:35.255Z]     authz_plugin_v2_test.go:40: (*Execution).NotAmd64-fm
16:42:35 [2023-09-18T16:42:35.255Z] --- SKIP: TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
16:42:35 [2023-09-18T16:42:35.255Z] === RUN   TestAuthZPluginV2Disable
16:42:35 [2023-09-18T16:42:35.255Z]     authz_plugin_v2_test.go:61: (*Execution).NotAmd64-fm
16:42:35 [2023-09-18T16:42:35.255Z] --- SKIP: TestAuthZPluginV2Disable (0.00s)
16:42:35 [2023-09-18T16:42:35.255Z] === RUN   TestAuthZPluginV2RejectVolumeRequests
16:42:35 [2023-09-18T16:42:35.255Z]     authz_plugin_v2_test.go:87: (*Execution).NotAmd64-fm
16:42:35 [2023-09-18T16:42:35.255Z] --- SKIP: TestAuthZPluginV2RejectVolumeRequests (0.00s)
16:42:35 [2023-09-18T16:42:35.255Z] === RUN   TestAuthZPluginV2BadManifestFailsDaemonStart
16:42:35 [2023-09-18T16:42:35.255Z]     authz_plugin_v2_test.go:122: (*Execution).NotAmd64-fm
16:42:35 [2023-09-18T16:42:35.255Z] --- SKIP: TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
16:42:35 [2023-09-18T16:42:35.255Z] === RUN   TestAuthZPluginV2NonexistentFailsDaemonStart
16:42:53 [2023-09-18T16:42:53.321Z] --- PASS: TestAuthZPluginV2NonexistentFailsDaemonStart (16.89s)
16:42:53 [2023-09-18T16:42:53.321Z] PASS
16:42:53 [2023-09-18T16:42:53.321Z] 
16:42:53 [2023-09-18T16:42:53.321Z] === Skipped
16:42:53 [2023-09-18T16:42:53.321Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2AllowNonVolumeRequest (0.00s)
16:42:53 [2023-09-18T16:42:53.321Z]     authz_plugin_v2_test.go:40: (*Execution).NotAmd64-fm
16:42:53 [2023-09-18T16:42:53.321Z] 
16:42:53 [2023-09-18T16:42:53.321Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2Disable (0.00s)
16:42:53 [2023-09-18T16:42:53.321Z]     authz_plugin_v2_test.go:61: (*Execution).NotAmd64-fm
16:42:53 [2023-09-18T16:42:53.321Z] 
16:42:53 [2023-09-18T16:42:53.321Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2RejectVolumeRequests (0.00s)
16:42:53 [2023-09-18T16:42:53.321Z]     authz_plugin_v2_test.go:87: (*Execution).NotAmd64-fm
16:42:53 [2023-09-18T16:42:53.321Z] 
16:42:53 [2023-09-18T16:42:53.321Z] === SKIP: arm64.integration.plugin.authz TestAuthZPluginV2BadManifestFailsDaemonStart (0.00s)
16:42:53 [2023-09-18T16:42:53.321Z]     authz_plugin_v2_test.go:122: (*Execution).NotAmd64-fm
16:42:53 [2023-09-18T16:42:53.321Z] 
16:42:53 [2023-09-18T16:42:53.321Z] DONE 17 tests, 4 skipped in 31.225s
16:42:53 [2023-09-18T16:42:53.321Z] Running /go/src/github.com/docker/docker/integration/plugin/common (arm64.integration.plugin.common) flags=-test.v -test.timeout=120m  
16:42:53 [2023-09-18T16:42:53.321Z] ++ 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
16:42:53 [2023-09-18T16:42:53.321Z] ++ set -e
16:42:53 [2023-09-18T16:42:53.321Z] ++ '[' -n 0 ']'
16:42:53 [2023-09-18T16:42:53.321Z] ++ set -x
16:42:53 [2023-09-18T16:42:53.321Z] ++ 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.ZTWQgV4a4B/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= 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
16:42:53 [2023-09-18T16:42:53.321Z] INFO: Testing against a local daemon
16:42:53 [2023-09-18T16:42:53.321Z] === RUN   TestPluginInvalidJSON
16:42:53 [2023-09-18T16:42:53.321Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set
16:42:53 [2023-09-18T16:42:53.321Z] === PAUSE TestPluginInvalidJSON/plugins/foobar/set
16:42:53 [2023-09-18T16:42:53.321Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade
16:42:53 [2023-09-18T16:42:53.321Z] === PAUSE TestPluginInvalidJSON/plugins/foobar/upgrade
16:42:53 [2023-09-18T16:42:53.321Z] === RUN   TestPluginInvalidJSON/plugins/pull
16:42:53 [2023-09-18T16:42:53.321Z] === PAUSE TestPluginInvalidJSON/plugins/pull
16:42:53 [2023-09-18T16:42:53.321Z] === CONT  TestPluginInvalidJSON/plugins/foobar/set
16:42:53 [2023-09-18T16:42:53.321Z] === CONT  TestPluginInvalidJSON/plugins/pull
16:42:53 [2023-09-18T16:42:53.321Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/invalid_content_type
16:42:53 [2023-09-18T16:42:53.321Z] === CONT  TestPluginInvalidJSON/plugins/foobar/upgrade
16:42:53 [2023-09-18T16:42:53.321Z] === RUN   TestPluginInvalidJSON/plugins/pull/invalid_content_type
16:42:53 [2023-09-18T16:42:53.321Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_content_type
16:42:53 [2023-09-18T16:42:53.321Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/invalid_JSON
16:42:53 [2023-09-18T16:42:53.321Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_JSON
16:42:53 [2023-09-18T16:42:53.321Z] === RUN   TestPluginInvalidJSON/plugins/pull/invalid_JSON
16:42:53 [2023-09-18T16:42:53.321Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/extra_content_after_JSON
16:42:53 [2023-09-18T16:42:53.321Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/extra_content_after_JSON
16:42:53 [2023-09-18T16:42:53.321Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/empty_body
16:42:53 [2023-09-18T16:42:53.321Z] === RUN   TestPluginInvalidJSON/plugins/pull/extra_content_after_JSON
16:42:53 [2023-09-18T16:42:53.321Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/empty_body
16:42:53 [2023-09-18T16:42:53.321Z] === RUN   TestPluginInvalidJSON/plugins/pull/empty_body
16:42:53 [2023-09-18T16:42:53.321Z] --- PASS: TestPluginInvalidJSON (0.01s)
16:42:53 [2023-09-18T16:42:53.321Z]     --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade (0.00s)
16:42:53 [2023-09-18T16:42:53.321Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_content_type (0.00s)
16:42:53 [2023-09-18T16:42:53.321Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_JSON (0.00s)
16:42:53 [2023-09-18T16:42:53.321Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/extra_content_after_JSON (0.00s)
16:42:53 [2023-09-18T16:42:53.321Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/empty_body (0.00s)
16:42:53 [2023-09-18T16:42:53.321Z]     --- PASS: TestPluginInvalidJSON/plugins/foobar/set (0.00s)
16:42:53 [2023-09-18T16:42:53.321Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/invalid_content_type (0.00s)
16:42:53 [2023-09-18T16:42:53.321Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/invalid_JSON (0.00s)
16:42:53 [2023-09-18T16:42:53.321Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/extra_content_after_JSON (0.00s)
16:42:53 [2023-09-18T16:42:53.321Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/empty_body (0.00s)
16:42:53 [2023-09-18T16:42:53.321Z]     --- PASS: TestPluginInvalidJSON/plugins/pull (0.00s)
16:42:53 [2023-09-18T16:42:53.321Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/invalid_content_type (0.00s)
16:42:53 [2023-09-18T16:42:53.321Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/invalid_JSON (0.00s)
16:42:53 [2023-09-18T16:42:53.321Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/extra_content_after_JSON (0.00s)
16:42:53 [2023-09-18T16:42:53.321Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/empty_body (0.00s)
16:42:53 [2023-09-18T16:42:53.321Z] === RUN   TestPluginInstall
16:42:53 [2023-09-18T16:42:53.321Z] === RUN   TestPluginInstall/no_auth
16:42:55 [2023-09-18T16:42:55.257Z] time="2023-09-18T16:42:55Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
16:42:55 [2023-09-18T16:42:55.257Z] time="2023-09-18T16:42:55Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:601b050da85a3b27bd2c4160e05b74c33f4cd90cc04ac9f0bdb955703659d76a" mediatype=application/vnd.docker.plugin.v1+json size=522
16:42:55 [2023-09-18T16:42:55.257Z] time="2023-09-18T16:42:55Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
16:42:55 [2023-09-18T16:42:55.257Z] time="2023-09-18T16:42:55Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:601b050da85a3b27bd2c4160e05b74c33f4cd90cc04ac9f0bdb955703659d76a" mediatype=application/vnd.docker.plugin.v1+json size=522
16:42:55 [2023-09-18T16:42:55.521Z] === RUN   TestPluginInstall/with_htpasswd
16:42:55 [2023-09-18T16:42:55.784Z] time="2023-09-18T16:42:55Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
16:42:55 [2023-09-18T16:42:55.784Z] time="2023-09-18T16:42:55Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:10624923254f9e29e4a7184e530f72f141c0d443f0ffb47ff64f5bd75df586c9" mediatype=application/vnd.docker.plugin.v1+json size=522
16:42:55 [2023-09-18T16:42:55.784Z] time="2023-09-18T16:42:55Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
16:42:55 [2023-09-18T16:42:55.784Z] time="2023-09-18T16:42:55Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:10624923254f9e29e4a7184e530f72f141c0d443f0ffb47ff64f5bd75df586c9" mediatype=application/vnd.docker.plugin.v1+json size=522
16:42:55 [2023-09-18T16:42:55.784Z] === RUN   TestPluginInstall/with_insecure
16:42:56 [2023-09-18T16:42:56.722Z] time="2023-09-18T16:42:56Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
16:42:56 [2023-09-18T16:42:56.722Z] time="2023-09-18T16:42:56Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:448227d5b4e2a939d52d4e77abb3f3513040eb5c7d8b96876f5818290fb43078" mediatype=application/vnd.docker.plugin.v1+json size=522
16:42:56 [2023-09-18T16:42:56.722Z] time="2023-09-18T16:42:56Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
16:42:56 [2023-09-18T16:42:56.722Z] time="2023-09-18T16:42:56Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:448227d5b4e2a939d52d4e77abb3f3513040eb5c7d8b96876f5818290fb43078" mediatype=application/vnd.docker.plugin.v1+json size=522
16:42:56 [2023-09-18T16:42:56.722Z]     plugin_test.go:204: [d734c5731d63a] daemon is not started
16:42:56 [2023-09-18T16:42:56.722Z] --- PASS: TestPluginInstall (4.50s)
16:42:56 [2023-09-18T16:42:56.722Z]     --- PASS: TestPluginInstall/no_auth (3.13s)
16:42:56 [2023-09-18T16:42:56.723Z]     --- PASS: TestPluginInstall/with_htpasswd (0.46s)
16:42:56 [2023-09-18T16:42:56.723Z]     --- PASS: TestPluginInstall/with_insecure (0.91s)
16:42:56 [2023-09-18T16:42:56.723Z] === RUN   TestPluginsWithRuntimes
16:42:58 [2023-09-18T16:42:58.172Z] === RUN   TestPluginsWithRuntimes/No_Args
16:42:59 [2023-09-18T16:42:59.118Z] === RUN   TestPluginsWithRuntimes/With_Args
16:43:00 [2023-09-18T16:43:00.076Z] --- PASS: TestPluginsWithRuntimes (3.39s)
16:43:00 [2023-09-18T16:43:00.076Z]     --- PASS: TestPluginsWithRuntimes/No_Args (0.94s)
16:43:00 [2023-09-18T16:43:00.076Z]     --- PASS: TestPluginsWithRuntimes/With_Args (0.94s)
16:43:00 [2023-09-18T16:43:00.076Z] === RUN   TestPluginBackCompatMediaTypes
16:43:00 [2023-09-18T16:43:00.658Z] --- PASS: TestPluginBackCompatMediaTypes (0.48s)
16:43:00 [2023-09-18T16:43:00.658Z] PASS
16:43:00 [2023-09-18T16:43:00.658Z] === RUN   TestPluginInvalidJSON
16:43:00 [2023-09-18T16:43:00.658Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set
16:43:00 [2023-09-18T16:43:00.658Z] === PAUSE TestPluginInvalidJSON/plugins/foobar/set
16:43:00 [2023-09-18T16:43:00.658Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade
16:43:00 [2023-09-18T16:43:00.658Z] === PAUSE TestPluginInvalidJSON/plugins/foobar/upgrade
16:43:00 [2023-09-18T16:43:00.658Z] === RUN   TestPluginInvalidJSON/plugins/pull
16:43:00 [2023-09-18T16:43:00.658Z] === PAUSE TestPluginInvalidJSON/plugins/pull
16:43:00 [2023-09-18T16:43:00.658Z] === CONT  TestPluginInvalidJSON/plugins/foobar/set
16:43:00 [2023-09-18T16:43:00.658Z] === CONT  TestPluginInvalidJSON/plugins/pull
16:43:00 [2023-09-18T16:43:00.658Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/invalid_content_type
16:43:00 [2023-09-18T16:43:00.658Z] === CONT  TestPluginInvalidJSON/plugins/foobar/upgrade
16:43:00 [2023-09-18T16:43:00.658Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_content_type
16:43:00 [2023-09-18T16:43:00.658Z] === RUN   TestPluginInvalidJSON/plugins/pull/invalid_content_type
16:43:00 [2023-09-18T16:43:00.658Z] === RUN   TestPluginInvalidJSON/plugins/pull/invalid_JSON
16:43:00 [2023-09-18T16:43:00.658Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/invalid_JSON
16:43:00 [2023-09-18T16:43:00.658Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_JSON
16:43:00 [2023-09-18T16:43:00.658Z] === RUN   TestPluginInvalidJSON/plugins/pull/extra_content_after_JSON
16:43:00 [2023-09-18T16:43:00.658Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/extra_content_after_JSON
16:43:00 [2023-09-18T16:43:00.658Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/extra_content_after_JSON
16:43:00 [2023-09-18T16:43:00.658Z] === RUN   TestPluginInvalidJSON/plugins/pull/empty_body
16:43:00 [2023-09-18T16:43:00.658Z] === RUN   TestPluginInvalidJSON/plugins/foobar/set/empty_body
16:43:00 [2023-09-18T16:43:00.658Z] === RUN   TestPluginInvalidJSON/plugins/foobar/upgrade/empty_body
16:43:00 [2023-09-18T16:43:00.658Z] --- PASS: TestPluginInvalidJSON (0.01s)
16:43:00 [2023-09-18T16:43:00.658Z]     --- PASS: TestPluginInvalidJSON/plugins/pull (0.00s)
16:43:00 [2023-09-18T16:43:00.658Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/invalid_content_type (0.00s)
16:43:00 [2023-09-18T16:43:00.658Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/invalid_JSON (0.00s)
16:43:00 [2023-09-18T16:43:00.658Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/extra_content_after_JSON (0.00s)
16:43:00 [2023-09-18T16:43:00.658Z]         --- PASS: TestPluginInvalidJSON/plugins/pull/empty_body (0.00s)
16:43:00 [2023-09-18T16:43:00.658Z]     --- PASS: TestPluginInvalidJSON/plugins/foobar/set (0.00s)
16:43:00 [2023-09-18T16:43:00.658Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/invalid_content_type (0.00s)
16:43:00 [2023-09-18T16:43:00.658Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/invalid_JSON (0.00s)
16:43:00 [2023-09-18T16:43:00.658Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/extra_content_after_JSON (0.00s)
16:43:00 [2023-09-18T16:43:00.658Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/set/empty_body (0.00s)
16:43:00 [2023-09-18T16:43:00.658Z]     --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade (0.00s)
16:43:00 [2023-09-18T16:43:00.658Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_content_type (0.00s)
16:43:00 [2023-09-18T16:43:00.658Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/invalid_JSON (0.00s)
16:43:00 [2023-09-18T16:43:00.658Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/extra_content_after_JSON (0.00s)
16:43:00 [2023-09-18T16:43:00.658Z]         --- PASS: TestPluginInvalidJSON/plugins/foobar/upgrade/empty_body (0.00s)
16:43:00 [2023-09-18T16:43:00.658Z] === RUN   TestPluginInstall
16:43:00 [2023-09-18T16:43:00.658Z] === RUN   TestPluginInstall/no_auth
16:43:00 [2023-09-18T16:43:00.915Z] time="2023-09-18T16:43:00Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
16:43:00 [2023-09-18T16:43:00.915Z] time="2023-09-18T16:43:00Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:017b3cf4edd9738c9e9c60cc68dfc92313af62e0ef8b282322a96f004f373473" mediatype=application/vnd.docker.plugin.v1+json size=522
16:43:00 [2023-09-18T16:43:00.915Z] time="2023-09-18T16:43:00Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
16:43:00 [2023-09-18T16:43:00.915Z] time="2023-09-18T16:43:00Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:017b3cf4edd9738c9e9c60cc68dfc92313af62e0ef8b282322a96f004f373473" mediatype=application/vnd.docker.plugin.v1+json size=522
16:43:01 [2023-09-18T16:43:01.173Z] === RUN   TestPluginInstall/with_htpasswd
16:43:01 [2023-09-18T16:43:01.431Z] time="2023-09-18T16:43:01Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
16:43:01 [2023-09-18T16:43:01.431Z] time="2023-09-18T16:43:01Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:017b3cf4edd9738c9e9c60cc68dfc92313af62e0ef8b282322a96f004f373473" mediatype=application/vnd.docker.plugin.v1+json size=522
16:43:01 [2023-09-18T16:43:01.431Z] time="2023-09-18T16:43:01Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
16:43:01 [2023-09-18T16:43:01.431Z] time="2023-09-18T16:43:01Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:017b3cf4edd9738c9e9c60cc68dfc92313af62e0ef8b282322a96f004f373473" mediatype=application/vnd.docker.plugin.v1+json size=522
16:43:01 [2023-09-18T16:43:01.431Z] === RUN   TestPluginInstall/with_insecure
16:43:02 [2023-09-18T16:43:02.364Z] time="2023-09-18T16:43:02Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
16:43:02 [2023-09-18T16:43:02.364Z] time="2023-09-18T16:43:02Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:c53576f4784c3d50064d697b94a08a6e2e2f5008587b423b1b7d9216011a5dc4" mediatype=application/vnd.docker.plugin.v1+json size=522
16:43:02 [2023-09-18T16:43:02.364Z] time="2023-09-18T16:43:02Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json"
16:43:02 [2023-09-18T16:43:02.364Z] time="2023-09-18T16:43:02Z" level=warning msg="reference for unknown type: application/vnd.docker.plugin.v1+json" digest="sha256:c53576f4784c3d50064d697b94a08a6e2e2f5008587b423b1b7d9216011a5dc4" mediatype=application/vnd.docker.plugin.v1+json size=522
16:43:02 [2023-09-18T16:43:02.364Z]     plugin_test.go:204: [d6446dcbd2d00] daemon is not started
16:43:02 [2023-09-18T16:43:02.364Z] --- PASS: TestPluginInstall (1.79s)
16:43:02 [2023-09-18T16:43:02.364Z]     --- PASS: TestPluginInstall/no_auth (0.42s)
16:43:02 [2023-09-18T16:43:02.364Z]     --- PASS: TestPluginInstall/with_htpasswd (0.45s)
16:43:02 [2023-09-18T16:43:02.364Z]     --- PASS: TestPluginInstall/with_insecure (0.92s)
16:43:02 [2023-09-18T16:43:02.364Z] === RUN   TestPluginsWithRuntimes
16:43:04 [2023-09-18T16:43:04.261Z] === RUN   TestPluginsWithRuntimes/No_Args
16:43:04 [2023-09-18T16:43:04.826Z] === RUN   TestPluginsWithRuntimes/With_Args
16:43:05 [2023-09-18T16:43:05.759Z] --- PASS: TestPluginsWithRuntimes (3.39s)
16:43:05 [2023-09-18T16:43:05.759Z]     --- PASS: TestPluginsWithRuntimes/No_Args (0.94s)
16:43:05 [2023-09-18T16:43:05.759Z]     --- PASS: TestPluginsWithRuntimes/With_Args (0.92s)
16:43:05 [2023-09-18T16:43:05.759Z] === RUN   TestPluginBackCompatMediaTypes
16:43:06 [2023-09-18T16:43:06.324Z] --- PASS: TestPluginBackCompatMediaTypes (0.49s)
16:43:06 [2023-09-18T16:43:06.324Z] PASS
16:43:06 [2023-09-18T16:43:06.324Z] 
16:43:06 [2023-09-18T16:43:06.324Z] DONE 48 tests in 14.123s
16:43:06 [2023-09-18T16:43:06.324Z] Running /go/src/github.com/docker/docker/integration/plugin/graphdriver (arm64.integration.plugin.graphdriver) flags=-test.v -test.timeout=120m  
16:43:06 [2023-09-18T16:43:06.324Z] ++ 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
16:43:06 [2023-09-18T16:43:06.324Z] ++ set -e
16:43:06 [2023-09-18T16:43:06.324Z] ++ '[' -n 0 ']'
16:43:06 [2023-09-18T16:43:06.324Z] ++ set -x
16:43:06 [2023-09-18T16:43:06.324Z] ++ 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.ZTWQgV4a4B/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= 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
16:43:06 [2023-09-18T16:43:06.324Z] INFO: Testing against a local daemon
16:43:06 [2023-09-18T16:43:06.324Z] === RUN   TestExternalGraphDriver
16:43:06 [2023-09-18T16:43:06.889Z] === RUN   TestExternalGraphDriver/json
16:43:06 [2023-09-18T16:43:06.889Z] === RUN   TestExternalGraphDriver/spec
16:43:06 [2023-09-18T16:43:06.889Z] === RUN   TestExternalGraphDriver/pull
16:43:06 [2023-09-18T16:43:06.889Z] --- PASS: TestExternalGraphDriver (0.34s)
16:43:06 [2023-09-18T16:43:06.889Z]     --- PASS: TestExternalGraphDriver/json (0.00s)
16:43:06 [2023-09-18T16:43:06.889Z]     --- PASS: TestExternalGraphDriver/spec (0.00s)
16:43:06 [2023-09-18T16:43:06.889Z]     --- PASS: TestExternalGraphDriver/pull (0.00s)
16:43:06 [2023-09-18T16:43:06.889Z] === RUN   TestGraphdriverPluginV2
16:43:07 [2023-09-18T16:43:07.147Z]     external_test.go:415: (*Execution).NotAmd64-fm
16:43:07 [2023-09-18T16:43:07.147Z] --- SKIP: TestGraphdriverPluginV2 (0.32s)
16:43:07 [2023-09-18T16:43:07.147Z] PASS
16:43:07 [2023-09-18T16:43:07.147Z] 
16:43:07 [2023-09-18T16:43:07.147Z] === Skipped
16:43:07 [2023-09-18T16:43:07.147Z] === SKIP: arm64.integration.plugin.graphdriver TestGraphdriverPluginV2 (0.32s)
16:43:07 [2023-09-18T16:43:07.147Z]     external_test.go:415: (*Execution).NotAmd64-fm
16:43:07 [2023-09-18T16:43:07.147Z] 
16:43:07 [2023-09-18T16:43:07.147Z] DONE 5 tests, 1 skipped in 0.705s
16:43:07 [2023-09-18T16:43:07.147Z] Running /go/src/github.com/docker/docker/integration/plugin/logging (arm64.integration.plugin.logging) flags=-test.v -test.timeout=120m  
16:43:07 [2023-09-18T16:43:07.147Z] ++ 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
16:43:07 [2023-09-18T16:43:07.147Z] ++ set -e
16:43:07 [2023-09-18T16:43:07.147Z] ++ '[' -n 0 ']'
16:43:07 [2023-09-18T16:43:07.147Z] ++ set -x
16:43:07 [2023-09-18T16:43:07.147Z] ++ 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.ZTWQgV4a4B/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= 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
16:43:07 [2023-09-18T16:43:07.147Z] INFO: Testing against a local daemon
16:43:07 [2023-09-18T16:43:07.147Z] === RUN   TestContinueAfterPluginCrash
16:43:07 [2023-09-18T16:43:07.147Z] === PAUSE TestContinueAfterPluginCrash
16:43:07 [2023-09-18T16:43:07.147Z] === RUN   TestReadPluginNoRead
16:43:07 [2023-09-18T16:43:07.147Z] === PAUSE TestReadPluginNoRead
16:43:07 [2023-09-18T16:43:07.147Z] === RUN   TestDaemonStartWithLogOpt
16:43:07 [2023-09-18T16:43:07.147Z] === PAUSE TestDaemonStartWithLogOpt
16:43:07 [2023-09-18T16:43:07.147Z] === CONT  TestContinueAfterPluginCrash
16:43:07 [2023-09-18T16:43:07.147Z] === CONT  TestReadPluginNoRead
16:43:07 [2023-09-18T16:43:07.147Z] === CONT  TestDaemonStartWithLogOpt
16:43:09 [2023-09-18T16:43:09.674Z] === RUN   TestReadPluginNoRead/default
16:43:09 [2023-09-18T16:43:09.931Z] --- PASS: TestDaemonStartWithLogOpt (2.72s)
16:43:10 [2023-09-18T16:43:10.497Z] === RUN   TestReadPluginNoRead/disabled_caching
16:43:11 [2023-09-18T16:43:11.869Z] === RUN   TestReadPluginNoRead/explicitly_enabled_caching
16:43:13 [2023-09-18T16:43:13.241Z]     read_test.go:93: [d7784c913700f] daemon is not started
16:43:13 [2023-09-18T16:43:13.241Z] --- PASS: TestReadPluginNoRead (5.95s)
16:43:13 [2023-09-18T16:43:13.241Z]     --- PASS: TestReadPluginNoRead/default (1.39s)
16:43:13 [2023-09-18T16:43:13.241Z]     --- PASS: TestReadPluginNoRead/disabled_caching (1.24s)
16:43:13 [2023-09-18T16:43:13.241Z]     --- PASS: TestReadPluginNoRead/explicitly_enabled_caching (1.23s)
16:43:15 [2023-09-18T16:43:15.138Z] --- PASS: TestContinueAfterPluginCrash (7.65s)
16:43:15 [2023-09-18T16:43:15.138Z] PASS
16:43:15 [2023-09-18T16:43:15.138Z] 
16:43:15 [2023-09-18T16:43:15.138Z] DONE 6 tests in 7.693s
16:43:15 [2023-09-18T16:43:15.138Z] Running /go/src/github.com/docker/docker/integration/plugin/logging/cmd/discard (arm64.integration.plugin.logging.cmd.discard) flags=-test.v -test.timeout=120m  
16:43:15 [2023-09-18T16:43:15.138Z] ++ 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
16:43:15 [2023-09-18T16:43:15.138Z] ++ set -e
16:43:15 [2023-09-18T16:43:15.138Z] ++ '[' -n 0 ']'
16:43:15 [2023-09-18T16:43:15.138Z] ++ set -x
16:43:15 [2023-09-18T16:43:15.138Z] ++ 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.ZTWQgV4a4B/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= 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
16:43:15 [2023-09-18T16:43:15.138Z] testing: warning: no tests to run
16:43:15 [2023-09-18T16:43:15.138Z] PASS
16:43:15 [2023-09-18T16:43:15.138Z] 
16:43:15 [2023-09-18T16:43:15.138Z] DONE 0 tests in 0.009s
16:43:15 [2023-09-18T16:43:15.138Z] Running /go/src/github.com/docker/docker/integration/plugin/volumes (arm64.integration.plugin.volumes) flags=-test.v -test.timeout=120m  
16:43:15 [2023-09-18T16:43:15.138Z] ++ 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
16:43:15 [2023-09-18T16:43:15.138Z] ++ set -e
16:43:15 [2023-09-18T16:43:15.138Z] ++ '[' -n 0 ']'
16:43:15 [2023-09-18T16:43:15.138Z] ++ set -x
16:43:15 [2023-09-18T16:43:15.138Z] ++ 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.ZTWQgV4a4B/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= 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
16:43:15 [2023-09-18T16:43:15.138Z] INFO: Testing against a local daemon
16:43:15 [2023-09-18T16:43:15.138Z] === RUN   TestPluginWithDevMounts
16:43:15 [2023-09-18T16:43:15.138Z] === PAUSE TestPluginWithDevMounts
16:43:15 [2023-09-18T16:43:15.138Z] === CONT  TestPluginWithDevMounts
16:43:16 [2023-09-18T16:43:16.510Z] --- PASS: TestPluginWithDevMounts (1.52s)
16:43:16 [2023-09-18T16:43:16.510Z] PASS
16:43:16 [2023-09-18T16:43:16.510Z] 
16:43:16 [2023-09-18T16:43:16.510Z] DONE 1 tests in 1.565s
16:43:16 [2023-09-18T16:43:16.510Z] Running /go/src/github.com/docker/docker/integration/secret (arm64.integration.secret) flags=-test.v -test.timeout=120m  
16:43:16 [2023-09-18T16:43:16.510Z] ++ 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
16:43:16 [2023-09-18T16:43:16.510Z] ++ set -e
16:43:16 [2023-09-18T16:43:16.510Z] ++ '[' -n 0 ']'
16:43:16 [2023-09-18T16:43:16.510Z] ++ set -x
16:43:16 [2023-09-18T16:43:16.510Z] ++ 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.ZTWQgV4a4B/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= 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
16:43:16 [2023-09-18T16:43:16.510Z] INFO: Testing against a local daemon
16:43:16 [2023-09-18T16:43:16.510Z] === RUN   TestSecretInspect
16:43:18 [2023-09-18T16:43:18.408Z] --- PASS: TestSecretInspect (1.86s)
16:43:18 [2023-09-18T16:43:18.408Z] === RUN   TestSecretList
16:43:20 [2023-09-18T16:43:20.305Z] --- PASS: TestSecretList (2.04s)
16:43:20 [2023-09-18T16:43:20.305Z] === RUN   TestSecretsCreateAndDelete
16:43:22 [2023-09-18T16:43:22.201Z] --- PASS: TestSecretsCreateAndDelete (1.90s)
16:43:22 [2023-09-18T16:43:22.201Z] === RUN   TestSecretsUpdate
16:43:24 [2023-09-18T16:43:24.098Z] --- PASS: TestSecretsUpdate (1.93s)
16:43:24 [2023-09-18T16:43:24.098Z] === RUN   TestTemplatedSecret
16:43:26 [2023-09-18T16:43:26.623Z] --- PASS: TestTemplatedSecret (2.55s)
16:43:26 [2023-09-18T16:43:26.623Z] === RUN   TestSecretCreateResolve
16:43:29 [2023-09-18T16:43:29.149Z] --- PASS: TestSecretCreateResolve (2.05s)
16:43:29 [2023-09-18T16:43:29.149Z] PASS
16:43:29 [2023-09-18T16:43:29.149Z] 
16:43:29 [2023-09-18T16:43:29.149Z] DONE 6 tests in 12.372s
16:43:29 [2023-09-18T16:43:29.149Z] Running /go/src/github.com/docker/docker/integration/service (arm64.integration.service) flags=-test.v -test.timeout=120m  
16:43:29 [2023-09-18T16:43:29.149Z] ++ 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
16:43:29 [2023-09-18T16:43:29.149Z] ++ set -e
16:43:29 [2023-09-18T16:43:29.149Z] ++ '[' -n 0 ']'
16:43:29 [2023-09-18T16:43:29.149Z] ++ set -x
16:43:29 [2023-09-18T16:43:29.149Z] ++ 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.ZTWQgV4a4B/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= 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
16:43:29 [2023-09-18T16:43:29.149Z] INFO: Testing against a local daemon
16:43:29 [2023-09-18T16:43:29.149Z] === RUN   TestServiceCreateInit
16:43:29 [2023-09-18T16:43:29.149Z] === RUN   TestServiceCreateInit/daemonInitDisabled
16:43:33 [2023-09-18T16:43:33.328Z] === RUN   TestServiceCreateInit/daemonInitEnabled
16:43:36 [2023-09-18T16:43:36.610Z] --- PASS: TestServiceCreateInit (7.72s)
16:43:36 [2023-09-18T16:43:36.610Z]     --- PASS: TestServiceCreateInit/daemonInitDisabled (3.92s)
16:43:36 [2023-09-18T16:43:36.610Z]     --- PASS: TestServiceCreateInit/daemonInitEnabled (3.78s)
16:43:36 [2023-09-18T16:43:36.610Z] === RUN   TestCreateServiceMultipleTimes
16:43:54 [2023-09-18T16:43:54.677Z] --- PASS: TestCreateServiceMultipleTimes (15.20s)
16:43:54 [2023-09-18T16:43:54.677Z] === RUN   TestCreateServiceConflict
16:43:54 [2023-09-18T16:43:54.677Z] --- PASS: TestCreateServiceConflict (1.86s)
16:43:54 [2023-09-18T16:43:54.677Z] === RUN   TestCreateServiceMaxReplicas
16:43:56 [2023-09-18T16:43:56.575Z] --- PASS: TestCreateServiceMaxReplicas (2.80s)
16:43:56 [2023-09-18T16:43:56.575Z] === RUN   TestCreateServiceSecretFileMode
16:44:11 [2023-09-18T16:44:11.435Z] --- PASS: TestCreateServiceSecretFileMode (12.64s)
16:44:11 [2023-09-18T16:44:11.435Z] === RUN   TestCreateServiceConfigFileMode
16:44:23 [2023-09-18T16:44:23.620Z] --- PASS: TestCreateServiceConfigFileMode (12.52s)
16:44:23 [2023-09-18T16:44:23.620Z] === RUN   TestCreateServiceSysctls
16:44:24 [2023-09-18T16:44:24.991Z] --- PASS: TestCreateServiceSysctls (3.28s)
16:44:24 [2023-09-18T16:44:24.991Z] === RUN   TestCreateServiceCapabilities
16:44:27 [2023-09-18T16:44:27.515Z] --- PASS: TestCreateServiceCapabilities (2.57s)
16:44:27 [2023-09-18T16:44:27.515Z] === RUN   TestInspect
16:44:30 [2023-09-18T16:44:30.041Z] --- PASS: TestInspect (2.74s)
16:44:30 [2023-09-18T16:44:30.041Z] === RUN   TestCreateJob
16:44:34 [2023-09-18T16:44:34.220Z] --- PASS: TestCreateJob (3.38s)
16:44:34 [2023-09-18T16:44:34.220Z] === RUN   TestReplicatedJob
16:44:38 [2023-09-18T16:44:38.399Z] --- PASS: TestReplicatedJob (4.88s)
16:44:38 [2023-09-18T16:44:38.399Z] === RUN   TestUpdateReplicatedJob
16:44:42 [2023-09-18T16:44:42.578Z] --- PASS: TestUpdateReplicatedJob (3.57s)
16:44:42 [2023-09-18T16:44:42.578Z] === RUN   TestServiceListWithStatuses
16:44:42 [2023-09-18T16:44:42.578Z]     list_test.go:33: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
16:44:42 [2023-09-18T16:44:42.578Z] --- SKIP: TestServiceListWithStatuses (0.00s)
16:44:42 [2023-09-18T16:44:42.578Z] === RUN   TestDockerNetworkConnectAlias
16:44:46 [2023-09-18T16:44:46.756Z] --- PASS: TestDockerNetworkConnectAlias (4.03s)
16:44:46 [2023-09-18T16:44:46.756Z] === RUN   TestDockerNetworkReConnect
16:44:49 [2023-09-18T16:44:49.281Z] --- PASS: TestDockerNetworkReConnect (3.19s)
16:44:49 [2023-09-18T16:44:49.281Z] === RUN   TestServicePlugin
16:44:49 [2023-09-18T16:44:49.281Z]     plugin_test.go:25: (*Execution).NotAmd64-fm
16:44:49 [2023-09-18T16:44:49.281Z] --- SKIP: TestServicePlugin (0.00s)
16:44:49 [2023-09-18T16:44:49.281Z] === RUN   TestServiceUpdateLabel
16:44:51 [2023-09-18T16:44:51.177Z] --- PASS: TestServiceUpdateLabel (1.91s)
16:44:51 [2023-09-18T16:44:51.177Z] === RUN   TestServiceUpdateSecrets
16:45:06 [2023-09-18T16:45:06.038Z] --- PASS: TestServiceUpdateSecrets (14.38s)
16:45:06 [2023-09-18T16:45:06.038Z] === RUN   TestServiceUpdateConfigs
16:45:20 [2023-09-18T16:45:20.899Z] --- PASS: TestServiceUpdateConfigs (14.60s)
16:45:20 [2023-09-18T16:45:20.899Z] === RUN   TestServiceUpdateNetwork
16:45:33 [2023-09-18T16:45:33.088Z] --- PASS: TestServiceUpdateNetwork (11.99s)
16:45:33 [2023-09-18T16:45:33.088Z] === RUN   TestServiceUpdatePidsLimit
16:45:33 [2023-09-18T16:45:33.346Z] === RUN   TestServiceUpdatePidsLimit/create_service_with_PidsLimit_300
16:45:34 [2023-09-18T16:45:34.278Z] === RUN   TestServiceUpdatePidsLimit/unset_PidsLimit_to_0
16:45:40 [2023-09-18T16:45:40.829Z] === RUN   TestServiceUpdatePidsLimit/update_PidsLimit_to_100
16:45:48 [2023-09-18T16:45:48.934Z] --- PASS: TestServiceUpdatePidsLimit (16.49s)
16:45:48 [2023-09-18T16:45:48.934Z]     --- PASS: TestServiceUpdatePidsLimit/create_service_with_PidsLimit_300 (0.72s)
16:45:48 [2023-09-18T16:45:48.934Z]     --- PASS: TestServiceUpdatePidsLimit/unset_PidsLimit_to_0 (6.88s)
16:45:48 [2023-09-18T16:45:48.934Z]     --- PASS: TestServiceUpdatePidsLimit/update_PidsLimit_to_100 (6.88s)
16:45:48 [2023-09-18T16:45:48.934Z] PASS
16:45:48 [2023-09-18T16:45:48.934Z] 
16:45:48 [2023-09-18T16:45:48.934Z] === Skipped
16:45:48 [2023-09-18T16:45:48.934Z] === SKIP: arm64.integration.service TestServiceListWithStatuses (0.00s)
16:45:48 [2023-09-18T16:45:48.934Z]     list_test.go:33: versions.LessThan(testEnv.DaemonInfo.ServerVersion, "1.41")
16:45:48 [2023-09-18T16:45:48.934Z] 
16:45:48 [2023-09-18T16:45:48.934Z] === SKIP: arm64.integration.service TestServicePlugin (0.00s)
16:45:48 [2023-09-18T16:45:48.934Z]     plugin_test.go:25: (*Execution).NotAmd64-fm
16:45:48 [2023-09-18T16:45:48.934Z] 
16:45:48 [2023-09-18T16:45:48.934Z] DONE 26 tests, 2 skipped in 139.790s
16:45:48 [2023-09-18T16:45:48.934Z] Running /go/src/github.com/docker/docker/integration/session (arm64.integration.session) flags=-test.v -test.timeout=120m  
16:45:48 [2023-09-18T16:45:48.934Z] ++ 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
16:45:48 [2023-09-18T16:45:48.934Z] ++ set -e
16:45:48 [2023-09-18T16:45:48.934Z] ++ '[' -n 0 ']'
16:45:48 [2023-09-18T16:45:48.934Z] ++ set -x
16:45:48 [2023-09-18T16:45:48.934Z] ++ 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.ZTWQgV4a4B/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= 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
16:45:48 [2023-09-18T16:45:48.934Z] INFO: Testing against a local daemon
16:45:48 [2023-09-18T16:45:48.934Z] === RUN   TestSessionCreate
16:45:48 [2023-09-18T16:45:48.934Z] --- PASS: TestSessionCreate (0.02s)
16:45:48 [2023-09-18T16:45:48.934Z] === RUN   TestSessionCreateWithBadUpgrade
16:45:48 [2023-09-18T16:45:48.934Z] --- PASS: TestSessionCreateWithBadUpgrade (0.02s)
16:45:48 [2023-09-18T16:45:48.934Z] PASS
16:45:48 [2023-09-18T16:45:48.934Z] 
16:45:48 [2023-09-18T16:45:48.934Z] DONE 2 tests in 0.070s
16:45:48 [2023-09-18T16:45:48.934Z] Running /go/src/github.com/docker/docker/integration/system (arm64.integration.system) flags=-test.v -test.timeout=120m  
16:45:48 [2023-09-18T16:45:48.934Z] ++ 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
16:45:48 [2023-09-18T16:45:48.934Z] ++ set -e
16:45:48 [2023-09-18T16:45:48.934Z] ++ '[' -n 0 ']'
16:45:48 [2023-09-18T16:45:48.934Z] ++ set -x
16:45:48 [2023-09-18T16:45:48.934Z] ++ 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.ZTWQgV4a4B/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= 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
16:45:48 [2023-09-18T16:45:48.934Z] INFO: Testing against a local daemon
16:45:48 [2023-09-18T16:45:48.934Z] === RUN   TestCgroupDriverSystemdMemoryLimit
16:45:48 [2023-09-18T16:45:48.934Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
16:45:48 [2023-09-18T16:45:48.934Z] --- SKIP: TestCgroupDriverSystemdMemoryLimit (0.00s)
16:45:48 [2023-09-18T16:45:48.934Z] === RUN   TestDiskUsage
16:45:48 [2023-09-18T16:45:48.934Z] === PAUSE TestDiskUsage
16:45:48 [2023-09-18T16:45:48.934Z] === RUN   TestEventsExecDie
16:45:49 [2023-09-18T16:45:49.192Z] --- PASS: TestEventsExecDie (0.49s)
16:45:49 [2023-09-18T16:45:49.192Z] === RUN   TestEventsBackwardsCompatible
16:45:49 [2023-09-18T16:45:49.192Z] --- PASS: TestEventsBackwardsCompatible (0.05s)
16:45:49 [2023-09-18T16:45:49.192Z] === RUN   TestEventsVolumeCreate
16:45:49 [2023-09-18T16:45:49.192Z] --- PASS: TestEventsVolumeCreate (0.05s)
16:45:49 [2023-09-18T16:45:49.192Z] === RUN   TestInfoBinaryCommits
16:45:49 [2023-09-18T16:45:49.450Z] --- PASS: TestInfoBinaryCommits (0.02s)
16:45:49 [2023-09-18T16:45:49.450Z] === RUN   TestInfoAPIVersioned
16:45:49 [2023-09-18T16:45:49.450Z] --- PASS: TestInfoAPIVersioned (0.01s)
16:45:49 [2023-09-18T16:45:49.450Z] === RUN   TestInfoAPI
16:45:49 [2023-09-18T16:45:49.450Z] --- PASS: TestInfoAPI (0.02s)
16:45:49 [2023-09-18T16:45:49.450Z] === RUN   TestInfoAPIWarnings
16:46:07 [2023-09-18T16:46:07.515Z] --- PASS: TestInfoAPIWarnings (16.55s)
16:46:07 [2023-09-18T16:46:07.515Z] === RUN   TestInfoDebug
16:46:07 [2023-09-18T16:46:07.515Z] --- PASS: TestInfoDebug (0.52s)
16:46:07 [2023-09-18T16:46:07.515Z] === RUN   TestInfoInsecureRegistries
16:46:07 [2023-09-18T16:46:07.515Z] --- PASS: TestInfoInsecureRegistries (0.52s)
16:46:07 [2023-09-18T16:46:07.515Z] === RUN   TestInfoRegistryMirrors
16:46:07 [2023-09-18T16:46:07.515Z] --- PASS: TestInfoRegistryMirrors (0.52s)
16:46:07 [2023-09-18T16:46:07.515Z] === RUN   TestLoginFailsWithBadCredentials
16:46:08 [2023-09-18T16:46:08.448Z] --- PASS: TestLoginFailsWithBadCredentials (1.00s)
16:46:08 [2023-09-18T16:46:08.448Z] === RUN   TestPingCacheHeaders
16:46:08 [2023-09-18T16:46:08.448Z] --- PASS: TestPingCacheHeaders (0.02s)
16:46:08 [2023-09-18T16:46:08.448Z] === RUN   TestPingGet
16:46:08 [2023-09-18T16:46:08.448Z] --- PASS: TestPingGet (0.01s)
16:46:08 [2023-09-18T16:46:08.448Z] === RUN   TestPingHead
16:46:08 [2023-09-18T16:46:08.448Z] --- PASS: TestPingHead (0.02s)
16:46:08 [2023-09-18T16:46:08.448Z] === RUN   TestPingSwarmHeader
16:46:09 [2023-09-18T16:46:09.013Z] === RUN   TestPingSwarmHeader/before_swarm_init
16:46:09 [2023-09-18T16:46:09.577Z] === RUN   TestPingSwarmHeader/after_swarm_init
16:46:10 [2023-09-18T16:46:10.509Z] === RUN   TestPingSwarmHeader/after_swarm_leave
16:46:10 [2023-09-18T16:46:10.509Z] --- PASS: TestPingSwarmHeader (1.95s)
16:46:10 [2023-09-18T16:46:10.509Z]     --- PASS: TestPingSwarmHeader/before_swarm_init (0.00s)
16:46:10 [2023-09-18T16:46:10.509Z]     --- PASS: TestPingSwarmHeader/after_swarm_init (0.00s)
16:46:10 [2023-09-18T16:46:10.509Z]     --- PASS: TestPingSwarmHeader/after_swarm_leave (0.00s)
16:46:10 [2023-09-18T16:46:10.509Z] === RUN   TestPingBuilderHeader
16:46:10 [2023-09-18T16:46:10.509Z] === RUN   TestPingBuilderHeader/default_config
16:46:11 [2023-09-18T16:46:11.073Z] === RUN   TestPingBuilderHeader/buildkit_disabled
16:46:11 [2023-09-18T16:46:11.638Z] --- PASS: TestPingBuilderHeader (1.04s)
16:46:11 [2023-09-18T16:46:11.638Z]     --- PASS: TestPingBuilderHeader/default_config (0.52s)
16:46:11 [2023-09-18T16:46:11.638Z]     --- PASS: TestPingBuilderHeader/buildkit_disabled (0.52s)
16:46:11 [2023-09-18T16:46:11.638Z] === RUN   TestVersion
16:46:11 [2023-09-18T16:46:11.638Z] --- PASS: TestVersion (0.02s)
16:46:11 [2023-09-18T16:46:11.638Z] === CONT  TestDiskUsage
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/empty
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/empty/container_types
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/empty/image_types
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/empty/volume_types
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/empty/build-cache_types
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/empty/container,_volume_types
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/empty/image,_build-cache_types
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/empty/container,_volume,_build-cache_types
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/empty/image,_volume,_build-cache_types
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/empty/container,_image,_volume_types
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/empty/container,_image,_volume,_build-cache_types
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/after_LoadBusybox
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/after_LoadBusybox/container_types
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/after_LoadBusybox/image_types
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/after_LoadBusybox/volume_types
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/after_LoadBusybox/build-cache_types
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/after_LoadBusybox/container,_volume_types
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/after_LoadBusybox/image,_build-cache_types
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/after_LoadBusybox/container,_volume,_build-cache_types
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/after_LoadBusybox/image,_volume,_build-cache_types
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/after_LoadBusybox/container,_image,_volume_types
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/after_LoadBusybox/container,_image,_volume,_build-cache_types
16:46:12 [2023-09-18T16:46:12.202Z] === RUN   TestDiskUsage/after_container.Run
16:46:12 [2023-09-18T16:46:12.459Z] === RUN   TestDiskUsage/after_container.Run/container_types
16:46:12 [2023-09-18T16:46:12.459Z] === RUN   TestDiskUsage/after_container.Run/image_types
16:46:12 [2023-09-18T16:46:12.459Z] === RUN   TestDiskUsage/after_container.Run/volume_types
16:46:12 [2023-09-18T16:46:12.459Z] === RUN   TestDiskUsage/after_container.Run/build-cache_types
16:46:12 [2023-09-18T16:46:12.459Z] === RUN   TestDiskUsage/after_container.Run/container,_volume_types
16:46:12 [2023-09-18T16:46:12.459Z] === RUN   TestDiskUsage/after_container.Run/image,_build-cache_types
16:46:12 [2023-09-18T16:46:12.459Z] === RUN   TestDiskUsage/after_container.Run/container,_volume,_build-cache_types
16:46:12 [2023-09-18T16:46:12.459Z] === RUN   TestDiskUsage/after_container.Run/image,_volume,_build-cache_types
16:46:12 [2023-09-18T16:46:12.459Z] === RUN   TestDiskUsage/after_container.Run/container,_image,_volume_types
16:46:12 [2023-09-18T16:46:12.459Z] === RUN   TestDiskUsage/after_container.Run/container,_image,_volume,_build-cache_types
16:46:12 [2023-09-18T16:46:12.717Z] --- PASS: TestDiskUsage (1.11s)
16:46:12 [2023-09-18T16:46:12.717Z]     --- PASS: TestDiskUsage/empty (0.01s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/empty/container_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/empty/image_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/empty/volume_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/empty/build-cache_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/empty/container,_volume_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/empty/image,_build-cache_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/empty/container,_volume,_build-cache_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/empty/image,_volume,_build-cache_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/empty/container,_image,_volume_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/empty/container,_image,_volume,_build-cache_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]     --- PASS: TestDiskUsage/after_LoadBusybox (0.08s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/after_LoadBusybox/image_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/after_LoadBusybox/volume_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/after_LoadBusybox/build-cache_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container,_volume_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/after_LoadBusybox/image,_build-cache_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container,_volume,_build-cache_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/after_LoadBusybox/image,_volume,_build-cache_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container,_image,_volume_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/after_LoadBusybox/container,_image,_volume,_build-cache_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]     --- PASS: TestDiskUsage/after_container.Run (0.27s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/after_container.Run/container_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/after_container.Run/image_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/after_container.Run/volume_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/after_container.Run/build-cache_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/after_container.Run/container,_volume_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/after_container.Run/image,_build-cache_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/after_container.Run/container,_volume,_build-cache_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/after_container.Run/image,_volume,_build-cache_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/after_container.Run/container,_image,_volume_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestDiskUsage/after_container.Run/container,_image,_volume,_build-cache_types (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z] PASS
16:46:12 [2023-09-18T16:46:12.717Z] 
16:46:12 [2023-09-18T16:46:12.717Z] === Skipped
16:46:12 [2023-09-18T16:46:12.717Z] === SKIP: arm64.integration.system TestCgroupDriverSystemdMemoryLimit (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]     cgroupdriver_systemd_test.go:32: !hasSystemd()
16:46:12 [2023-09-18T16:46:12.717Z] 
16:46:12 [2023-09-18T16:46:12.717Z] DONE 57 tests, 1 skipped in 23.950s
16:46:12 [2023-09-18T16:46:12.717Z] Running /go/src/github.com/docker/docker/integration/volume (arm64.integration.volume) flags=-test.v -test.timeout=120m  
16:46:12 [2023-09-18T16:46:12.717Z] ++ 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
16:46:12 [2023-09-18T16:46:12.717Z] ++ set -e
16:46:12 [2023-09-18T16:46:12.717Z] ++ '[' -n 0 ']'
16:46:12 [2023-09-18T16:46:12.717Z] ++ set -x
16:46:12 [2023-09-18T16:46:12.717Z] ++ 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.ZTWQgV4a4B/docker.sock DOCKER_REMAP_ROOT= DOCKER_REMOTE_DAEMON= DOCKER_ROOTLESS= GITHUB_ACTIONS= 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
16:46:12 [2023-09-18T16:46:12.717Z] INFO: Testing against a local daemon
16:46:12 [2023-09-18T16:46:12.717Z] === RUN   TestVolumesCreateAndList
16:46:12 [2023-09-18T16:46:12.717Z] --- PASS: TestVolumesCreateAndList (0.02s)
16:46:12 [2023-09-18T16:46:12.717Z] === RUN   TestVolumesRemove
16:46:12 [2023-09-18T16:46:12.717Z] === RUN   TestVolumesRemove/volume_in_use
16:46:12 [2023-09-18T16:46:12.717Z] === RUN   TestVolumesRemove/volume_not_in_use
16:46:12 [2023-09-18T16:46:12.717Z] === RUN   TestVolumesRemove/non-existing_volume
16:46:12 [2023-09-18T16:46:12.717Z] === RUN   TestVolumesRemove/non-existing_volume_force
16:46:12 [2023-09-18T16:46:12.717Z] --- PASS: TestVolumesRemove (0.06s)
16:46:12 [2023-09-18T16:46:12.717Z]     --- PASS: TestVolumesRemove/volume_in_use (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]     --- PASS: TestVolumesRemove/volume_not_in_use (0.01s)
16:46:12 [2023-09-18T16:46:12.717Z]     --- PASS: TestVolumesRemove/non-existing_volume (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]     --- PASS: TestVolumesRemove/non-existing_volume_force (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z] === RUN   TestVolumesRemoveSwarmEnabled
16:46:12 [2023-09-18T16:46:12.717Z] === PAUSE TestVolumesRemoveSwarmEnabled
16:46:12 [2023-09-18T16:46:12.717Z] === RUN   TestVolumesInspect
16:46:12 [2023-09-18T16:46:12.717Z] --- PASS: TestVolumesInspect (0.02s)
16:46:12 [2023-09-18T16:46:12.717Z] === RUN   TestVolumesInvalidJSON
16:46:12 [2023-09-18T16:46:12.717Z] === RUN   TestVolumesInvalidJSON/volumes/create
16:46:12 [2023-09-18T16:46:12.717Z] === PAUSE TestVolumesInvalidJSON/volumes/create
16:46:12 [2023-09-18T16:46:12.717Z] === CONT  TestVolumesInvalidJSON/volumes/create
16:46:12 [2023-09-18T16:46:12.717Z] === RUN   TestVolumesInvalidJSON/volumes/create/invalid_content_type
16:46:12 [2023-09-18T16:46:12.717Z] === RUN   TestVolumesInvalidJSON/volumes/create/invalid_JSON
16:46:12 [2023-09-18T16:46:12.717Z] === RUN   TestVolumesInvalidJSON/volumes/create/extra_content_after_JSON
16:46:12 [2023-09-18T16:46:12.717Z] === RUN   TestVolumesInvalidJSON/volumes/create/empty_body
16:46:12 [2023-09-18T16:46:12.717Z] --- PASS: TestVolumesInvalidJSON (0.01s)
16:46:12 [2023-09-18T16:46:12.717Z]     --- PASS: TestVolumesInvalidJSON/volumes/create (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestVolumesInvalidJSON/volumes/create/invalid_content_type (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestVolumesInvalidJSON/volumes/create/invalid_JSON (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestVolumesInvalidJSON/volumes/create/extra_content_after_JSON (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z]         --- PASS: TestVolumesInvalidJSON/volumes/create/empty_body (0.00s)
16:46:12 [2023-09-18T16:46:12.717Z] === RUN   TestVolumePruneAnonymous
16:46:12 [2023-09-18T16:46:12.717Z] --- PASS: TestVolumePruneAnonymous (0.03s)
16:46:12 [2023-09-18T16:46:12.717Z] === RUN   TestVolumePruneAnonFromImage
16:46:12 [2023-09-18T16:46:12.974Z] --- PASS: TestVolumePruneAnonFromImage (0.12s)
16:46:12 [2023-09-18T16:46:12.974Z] === CONT  TestVolumesRemoveSwarmEnabled
16:46:14 [2023-09-18T16:46:14.346Z] === RUN   TestVolumesRemoveSwarmEnabled/volume_in_use
16:46:14 [2023-09-18T16:46:14.346Z] === RUN   TestVolumesRemoveSwarmEnabled/volume_not_in_use
16:46:14 [2023-09-18T16:46:14.346Z] === RUN   TestVolumesRemoveSwarmEnabled/non-existing_volume
16:46:14 [2023-09-18T16:46:14.346Z] === RUN   TestVolumesRemoveSwarmEnabled/non-existing_volume_force
16:46:14 [2023-09-18T16:46:14.911Z] --- PASS: TestVolumesRemoveSwarmEnabled (1.95s)
16:46:14 [2023-09-18T16:46:14.911Z]     --- PASS: TestVolumesRemoveSwarmEnabled/volume_in_use (0.00s)
16:46:14 [2023-09-18T16:46:14.911Z]     --- PASS: TestVolumesRemoveSwarmEnabled/volume_not_in_use (0.01s)
16:46:14 [2023-09-18T16:46:14.911Z]     --- PASS: TestVolumesRemoveSwarmEnabled/non-existing_volume (0.00s)
16:46:14 [2023-09-18T16:46:14.911Z]     --- PASS: TestVolumesRemoveSwarmEnabled/non-existing_volume_force (0.00s)
16:46:14 [2023-09-18T16:46:14.911Z] PASS
16:46:14 [2023-09-18T16:46:14.911Z] 
16:46:14 [2023-09-18T16:46:14.911Z] DONE 20 tests in 2.252s
16:46:14 [2023-09-18T16:46:14.911Z] ---> Making bundle: .integration-daemon-stop (in bundles/test-integration)
16:46:15 [2023-09-18T16:46:15.168Z] ++++ cat bundles/test-integration/docker.pid
16:46:15 [2023-09-18T16:46:15.168Z] +++ kill 23387
16:46:16 [2023-09-18T16:46:16.538Z] +++ /etc/init.d/apparmor stop
16:46:16 [2023-09-18T16:46:16.538Z] Leaving: AppArmorNo profiles have been unloaded.
16:46:16 [2023-09-18T16:46:16.538Z] 
16:46:16 [2023-09-18T16:46:16.538Z] Unloading profiles will leave already running processes permanently
16:46:16 [2023-09-18T16:46:16.538Z] unconfined, which can lead to unexpected situations.
16:46:16 [2023-09-18T16:46:16.538Z] 
16:46:16 [2023-09-18T16:46:16.538Z] To set a process to complain mode, use the command line tool
16:46:16 [2023-09-18T16:46:16.538Z] 'aa-complain'. To really tear down all profiles, run 'aa-teardown'."
16:46:16 [2023-09-18T16:46:16.538Z] +++ true
16:46:16 [2023-09-18T16:46:16.538Z] exiting test-integration
16:46:16 [2023-09-18T16:46:16.538Z] ++ exit 0
16:46:16 [2023-09-18T16:46:16.538Z] 
Post stage
[Pipeline] junit
16:46:17 [2023-09-18T16:46:17.482Z] Recording test results
16:46:17 [2023-09-18T16:46:17.664Z] [Checks API] No suitable checks publisher found.
[Pipeline] }
[Pipeline] // withEnv
[Pipeline] }
[Pipeline] // stage
Post stage
[Pipeline] sh
16:46:17 [2023-09-18T16:46:17.955Z] + echo Ensuring container killed.
16:46:17 [2023-09-18T16:46:17.955Z] Ensuring container killed.
16:46:17 [2023-09-18T16:46:17.955Z] + docker rm -vf docker-pr20
16:46:17 [2023-09-18T16:46:17.955Z] Error response from daemon: No such container: docker-pr20
[Pipeline] sh
16:46:18 [2023-09-18T16:46:18.232Z] + echo Chowning /workspace to jenkins user
16:46:18 [2023-09-18T16:46:18.232Z] Chowning /workspace to jenkins user
16:46:18 [2023-09-18T16:46:18.232Z] + id -u
16:46:18 [2023-09-18T16:46:18.232Z] + id -g
16:46:18 [2023-09-18T16:46:18.232Z] + docker run --rm -v /home/ubuntu/workspace/moby_PR-46183:/workspace busybox chown -R 1000:1000 /workspace
[Pipeline] catchError
[Pipeline] {
[Pipeline] sh
16:46:19 [2023-09-18T16:46:19.446Z] + bundleName=arm64-integration
16:46:19 [2023-09-18T16:46:19.446Z] + echo Creating arm64-integration-bundles.tar.gz
16:46:19 [2023-09-18T16:46:19.446Z] Creating arm64-integration-bundles.tar.gz
16:46:19 [2023-09-18T16:46:19.446Z] + find bundles+  -path */root/*overlay2 -prune -o -type f ( -name *-report.json -o -name *.log -o -name *.prof -o -name *-report.xml ) -print
16:46:19 [2023-09-18T16:46:19.446Z] xargs tar -czf arm64-integration-bundles.tar.gz
[Pipeline] archiveArtifacts
16:46:19 [2023-09-18T16:46:19.716Z] Archiving artifacts
16:46:19 [2023-09-18T16:46:19.998Z] Uploaded 1 artifact(s) to https://docker-ci-jenkins-artifacts.s3.amazonaws.com/public/moby/PR-46183/20/artifacts/
[Pipeline] }
[Pipeline] // catchError
[Pipeline] sh
16:46:20 [2023-09-18T16:46:20.283Z] + make clean
16:46:20 [2023-09-18T16:46:20.283Z] docker volume rm -f docker-dev-cache docker-mod-cache
16:46:20 [2023-09-18T16:46:20.283Z] docker-dev-cache
16:46:20 [2023-09-18T16:46:20.283Z] 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