SuccessConsole Output

Skipping 7,366 KB.. Full Log
time="2018-04-17T13:47:46.362475466Z" level=debug msg="(*pullthroughBlobStore).Stat: starting with dgst=sha256:5dc3552da5a018fdbac11802b8ad573fc0bc4bb8769a2ab8249daa24018a8afa" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=3f3dd0ce-22a0-41ac-b98f-d8114fa8c1a6 http.request.method=HEAD http.request.remoteaddr="10.128.0.1:58816" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/sha256:5dc3552da5a018fdbac11802b8ad573fc0bc4bb8769a2ab8249daa24018a8afa" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a vars.digest="sha256:5dc3552da5a018fdbac11802b8ad573fc0bc4bb8769a2ab8249daa24018a8afa" vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output 
time="2018-04-17T13:47:46.362541797Z" level=debug msg="(*blobDescriptorService).Stat: starting with digest=sha256:5dc3552da5a018fdbac11802b8ad573fc0bc4bb8769a2ab8249daa24018a8afa" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=3f3dd0ce-22a0-41ac-b98f-d8114fa8c1a6 http.request.method=HEAD http.request.remoteaddr="10.128.0.1:58816" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/sha256:5dc3552da5a018fdbac11802b8ad573fc0bc4bb8769a2ab8249daa24018a8afa" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a vars.digest="sha256:5dc3552da5a018fdbac11802b8ad573fc0bc4bb8769a2ab8249daa24018a8afa" vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output 
time="2018-04-17T13:47:46.362590971Z" level=debug msg="(*pullthroughBlobStore).ServeBlob: starting with dgst=sha256:5dc3552da5a018fdbac11802b8ad573fc0bc4bb8769a2ab8249daa24018a8afa" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=3f3dd0ce-22a0-41ac-b98f-d8114fa8c1a6 http.request.method=HEAD http.request.remoteaddr="10.128.0.1:58816" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/sha256:5dc3552da5a018fdbac11802b8ad573fc0bc4bb8769a2ab8249daa24018a8afa" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a vars.digest="sha256:5dc3552da5a018fdbac11802b8ad573fc0bc4bb8769a2ab8249daa24018a8afa" vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output 
time="2018-04-17T13:47:46.362626967Z" level=debug msg="(*blobDescriptorService).Stat: starting with digest=sha256:5dc3552da5a018fdbac11802b8ad573fc0bc4bb8769a2ab8249daa24018a8afa" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=3f3dd0ce-22a0-41ac-b98f-d8114fa8c1a6 http.request.method=HEAD http.request.remoteaddr="10.128.0.1:58816" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/sha256:5dc3552da5a018fdbac11802b8ad573fc0bc4bb8769a2ab8249daa24018a8afa" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a vars.digest="sha256:5dc3552da5a018fdbac11802b8ad573fc0bc4bb8769a2ab8249daa24018a8afa" vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output 
time="2018-04-17T13:47:46.362754266Z" level=debug msg="filesystem.URLFor(\"/docker/registry/v2/blobs/sha256/5d/5dc3552da5a018fdbac11802b8ad573fc0bc4bb8769a2ab8249daa24018a8afa/data\")" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=3f3dd0ce-22a0-41ac-b98f-d8114fa8c1a6 http.request.method=HEAD http.request.remoteaddr="10.128.0.1:58816" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/sha256:5dc3552da5a018fdbac11802b8ad573fc0bc4bb8769a2ab8249daa24018a8afa" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a trace.duration="18.867µs" trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).URLFor" trace.id=f14b80ba-77c2-4a83-8226-19c62c27ffcc trace.line=189 vars.digest="sha256:5dc3552da5a018fdbac11802b8ad573fc0bc4bb8769a2ab8249daa24018a8afa" vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output 
time="2018-04-17T13:47:46.362828284Z" level=debug msg="(*blobDescriptorService).Stat: starting with digest=sha256:5dc3552da5a018fdbac11802b8ad573fc0bc4bb8769a2ab8249daa24018a8afa" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=3f3dd0ce-22a0-41ac-b98f-d8114fa8c1a6 http.request.method=HEAD http.request.remoteaddr="10.128.0.1:58816" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/sha256:5dc3552da5a018fdbac11802b8ad573fc0bc4bb8769a2ab8249daa24018a8afa" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a vars.digest="sha256:5dc3552da5a018fdbac11802b8ad573fc0bc4bb8769a2ab8249daa24018a8afa" vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output 
time="2018-04-17T13:47:46.363039424Z" level=info msg="response completed" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=3f3dd0ce-22a0-41ac-b98f-d8114fa8c1a6 http.request.method=HEAD http.request.remoteaddr="10.128.0.1:58816" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/sha256:5dc3552da5a018fdbac11802b8ad573fc0bc4bb8769a2ab8249daa24018a8afa" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" http.response.contenttype=application/octet-stream http.response.duration=24.189178ms http.response.status=200 http.response.written=0 instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 
10.128.0.1 - - [17/Apr/2018:13:47:53 +0000] "GET /healthz HTTP/2.0" 200 0 "" "kube-probe/1.10+"
10.128.0.1 - - [17/Apr/2018:13:47:53 +0000] "GET /healthz HTTP/2.0" 200 0 "" "kube-probe/1.10+"
10.128.0.1 - - [17/Apr/2018:13:48:03 +0000] "GET /healthz HTTP/2.0" 200 0 "" "kube-probe/1.10+"
10.128.0.1 - - [17/Apr/2018:13:48:03 +0000] "GET /healthz HTTP/2.0" 200 0 "" "kube-probe/1.10+"
time="2018-04-17T13:48:10.311732422Z" level=debug msg="filesystem.PutContent(\"/docker/registry/v2/repositories/extended-test-build-sti-private-repo-j2q9n-t5d59/output/_uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff/hashstates/sha256/73167580\")" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=38f7b256-8f71-4f77-911e-e1251ea31058 http.request.method=PATCH http.request.remoteaddr="10.128.0.1:58724" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff?_state=VpOaJQ4WYzwlnZbjwjMEm-S3bcLqRvgvPMHJbME42Th7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1wcml2YXRlLXJlcG8tajJxOW4tdDVkNTkvb3V0cHV0IiwiVVVJRCI6ImMyMTdlMmM3LTQ5NTEtNGU1ZC04NjRlLTgzY2M1ZmU0OWJmZiIsIk9mZnNldCI6MCwiU3RhcnRlZEF0IjoiMjAxOC0wNC0xN1QxMzo0NzozOC4yMzUxNDM3MzJaIn0%3D" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a trace.duration=2.202182ms trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).PutContent" trace.id=b2476f89-d0be-4053-87c0-696751042d67 trace.line=95 vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output vars.uuid=c217e2c7-4951-4e5d-864e-83cc5fe49bff 
time="2018-04-17T13:48:10.335289908Z" level=debug msg="filesystem.PutContent(\"/docker/registry/v2/repositories/extended-test-build-sti-private-repo-j2q9n-t5d59/output/_uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff/hashstates/sha256/73167580\")" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=38f7b256-8f71-4f77-911e-e1251ea31058 http.request.method=PATCH http.request.remoteaddr="10.128.0.1:58724" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff?_state=VpOaJQ4WYzwlnZbjwjMEm-S3bcLqRvgvPMHJbME42Th7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1wcml2YXRlLXJlcG8tajJxOW4tdDVkNTkvb3V0cHV0IiwiVVVJRCI6ImMyMTdlMmM3LTQ5NTEtNGU1ZC04NjRlLTgzY2M1ZmU0OWJmZiIsIk9mZnNldCI6MCwiU3RhcnRlZEF0IjoiMjAxOC0wNC0xN1QxMzo0NzozOC4yMzUxNDM3MzJaIn0%3D" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a trace.duration=2.086171ms trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).PutContent" trace.id=50f275d2-6bf2-479e-b4cf-f956280595d8 trace.line=95 vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output vars.uuid=c217e2c7-4951-4e5d-864e-83cc5fe49bff 
time="2018-04-17T13:48:10.335387296Z" level=info msg="response completed" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=38f7b256-8f71-4f77-911e-e1251ea31058 http.request.method=PATCH http.request.remoteaddr="10.128.0.1:58724" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff?_state=VpOaJQ4WYzwlnZbjwjMEm-S3bcLqRvgvPMHJbME42Th7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1wcml2YXRlLXJlcG8tajJxOW4tdDVkNTkvb3V0cHV0IiwiVVVJRCI6ImMyMTdlMmM3LTQ5NTEtNGU1ZC04NjRlLTgzY2M1ZmU0OWJmZiIsIk9mZnNldCI6MCwiU3RhcnRlZEF0IjoiMjAxOC0wNC0xN1QxMzo0NzozOC4yMzUxNDM3MzJaIn0%3D" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" http.response.duration=31.300793855s http.response.status=202 http.response.written=0 instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 
10.128.0.1 - - [17/Apr/2018:13:47:39 +0000] "PATCH /v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff?_state=VpOaJQ4WYzwlnZbjwjMEm-S3bcLqRvgvPMHJbME42Th7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1wcml2YXRlLXJlcG8tajJxOW4tdDVkNTkvb3V0cHV0IiwiVVVJRCI6ImMyMTdlMmM3LTQ5NTEtNGU1ZC04NjRlLTgzY2M1ZmU0OWJmZiIsIk9mZnNldCI6MCwiU3RhcnRlZEF0IjoiMjAxOC0wNC0xN1QxMzo0NzozOC4yMzUxNDM3MzJaIn0%3D HTTP/1.1" 202 0 "" "docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)"
time="2018-04-17T13:48:10.363171965Z" level=debug msg="authorizing request" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=40657f33-e020-4ccb-8026-da71810cb6bb http.request.method=PUT http.request.remoteaddr="10.128.0.1:58938" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff?_state=R8R-TDa0vvRr9Mk3PZpdQBUy1VZLlIfWmnDB6uQIZcJ7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1wcml2YXRlLXJlcG8tajJxOW4tdDVkNTkvb3V0cHV0IiwiVVVJRCI6ImMyMTdlMmM3LTQ5NTEtNGU1ZC04NjRlLTgzY2M1ZmU0OWJmZiIsIk9mZnNldCI6NzMxNjc1ODAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDc6MzhaIn0%3D&digest=sha256%3A469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output vars.uuid=c217e2c7-4951-4e5d-864e-83cc5fe49bff 
time="2018-04-17T13:48:10.375508641Z" level=debug msg="Origin auth: checking for access to repository:extended-test-build-sti-private-repo-j2q9n-t5d59/output:pull" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=40657f33-e020-4ccb-8026-da71810cb6bb http.request.method=PUT http.request.remoteaddr="10.128.0.1:58938" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff?_state=R8R-TDa0vvRr9Mk3PZpdQBUy1VZLlIfWmnDB6uQIZcJ7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1wcml2YXRlLXJlcG8tajJxOW4tdDVkNTkvb3V0cHV0IiwiVVVJRCI6ImMyMTdlMmM3LTQ5NTEtNGU1ZC04NjRlLTgzY2M1ZmU0OWJmZiIsIk9mZnNldCI6NzMxNjc1ODAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDc6MzhaIn0%3D&digest=sha256%3A469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output vars.uuid=c217e2c7-4951-4e5d-864e-83cc5fe49bff 
time="2018-04-17T13:48:10.377280904Z" level=debug msg="Origin auth: checking for access to repository:extended-test-build-sti-private-repo-j2q9n-t5d59/output:push" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=40657f33-e020-4ccb-8026-da71810cb6bb http.request.method=PUT http.request.remoteaddr="10.128.0.1:58938" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff?_state=R8R-TDa0vvRr9Mk3PZpdQBUy1VZLlIfWmnDB6uQIZcJ7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1wcml2YXRlLXJlcG8tajJxOW4tdDVkNTkvb3V0cHV0IiwiVVVJRCI6ImMyMTdlMmM3LTQ5NTEtNGU1ZC04NjRlLTgzY2M1ZmU0OWJmZiIsIk9mZnNldCI6NzMxNjc1ODAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDc6MzhaIn0%3D&digest=sha256%3A469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output vars.uuid=c217e2c7-4951-4e5d-864e-83cc5fe49bff 
time="2018-04-17T13:48:10.37913456Z" level=info msg="Using \"docker-registry.default.svc:5000\" as Docker Registry URL" go.version=go1.9.2 instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 
time="2018-04-17T13:48:10.379212755Z" level=debug msg="(*linkedBlobStore).Resume" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=40657f33-e020-4ccb-8026-da71810cb6bb http.request.method=PUT http.request.remoteaddr="10.128.0.1:58938" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff?_state=R8R-TDa0vvRr9Mk3PZpdQBUy1VZLlIfWmnDB6uQIZcJ7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1wcml2YXRlLXJlcG8tajJxOW4tdDVkNTkvb3V0cHV0IiwiVVVJRCI6ImMyMTdlMmM3LTQ5NTEtNGU1ZC04NjRlLTgzY2M1ZmU0OWJmZiIsIk9mZnNldCI6NzMxNjc1ODAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDc6MzhaIn0%3D&digest=sha256%3A469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output vars.uuid=c217e2c7-4951-4e5d-864e-83cc5fe49bff 
time="2018-04-17T13:48:10.379334064Z" level=debug msg="filesystem.GetContent(\"/docker/registry/v2/repositories/extended-test-build-sti-private-repo-j2q9n-t5d59/output/_uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff/startedat\")" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=40657f33-e020-4ccb-8026-da71810cb6bb http.request.method=PUT http.request.remoteaddr="10.128.0.1:58938" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff?_state=R8R-TDa0vvRr9Mk3PZpdQBUy1VZLlIfWmnDB6uQIZcJ7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1wcml2YXRlLXJlcG8tajJxOW4tdDVkNTkvb3V0cHV0IiwiVVVJRCI6ImMyMTdlMmM3LTQ5NTEtNGU1ZC04NjRlLTgzY2M1ZmU0OWJmZiIsIk9mZnNldCI6NzMxNjc1ODAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDc6MzhaIn0%3D&digest=sha256%3A469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a trace.duration="56.369µs" trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).GetContent" trace.id=533769bb-54ab-47d2-a295-9a007027d63e trace.line=82 vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output vars.uuid=c217e2c7-4951-4e5d-864e-83cc5fe49bff 
time="2018-04-17T13:48:10.379444813Z" level=debug msg="filesystem.Writer(\"/docker/registry/v2/repositories/extended-test-build-sti-private-repo-j2q9n-t5d59/output/_uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff/data\", true)" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=40657f33-e020-4ccb-8026-da71810cb6bb http.request.method=PUT http.request.remoteaddr="10.128.0.1:58938" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff?_state=R8R-TDa0vvRr9Mk3PZpdQBUy1VZLlIfWmnDB6uQIZcJ7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1wcml2YXRlLXJlcG8tajJxOW4tdDVkNTkvb3V0cHV0IiwiVVVJRCI6ImMyMTdlMmM3LTQ5NTEtNGU1ZC04NjRlLTgzY2M1ZmU0OWJmZiIsIk9mZnNldCI6NzMxNjc1ODAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDc6MzhaIn0%3D&digest=sha256%3A469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a trace.duration="43.817µs" trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).Writer" trace.id=1d70f856-9fd6-425b-95f9-87a5474f045c trace.line=124 vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output vars.uuid=c217e2c7-4951-4e5d-864e-83cc5fe49bff 
time="2018-04-17T13:48:10.379512504Z" level=debug msg="(*blobWriter).Commit" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=40657f33-e020-4ccb-8026-da71810cb6bb http.request.method=PUT http.request.remoteaddr="10.128.0.1:58938" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff?_state=R8R-TDa0vvRr9Mk3PZpdQBUy1VZLlIfWmnDB6uQIZcJ7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1wcml2YXRlLXJlcG8tajJxOW4tdDVkNTkvb3V0cHV0IiwiVVVJRCI6ImMyMTdlMmM3LTQ5NTEtNGU1ZC04NjRlLTgzY2M1ZmU0OWJmZiIsIk9mZnNldCI6NzMxNjc1ODAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDc6MzhaIn0%3D&digest=sha256%3A469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output vars.uuid=c217e2c7-4951-4e5d-864e-83cc5fe49bff 
time="2018-04-17T13:48:10.381481638Z" level=debug msg="filesystem.PutContent(\"/docker/registry/v2/repositories/extended-test-build-sti-private-repo-j2q9n-t5d59/output/_uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff/hashstates/sha256/0\")" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=40657f33-e020-4ccb-8026-da71810cb6bb http.request.method=PUT http.request.remoteaddr="10.128.0.1:58938" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff?_state=R8R-TDa0vvRr9Mk3PZpdQBUy1VZLlIfWmnDB6uQIZcJ7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1wcml2YXRlLXJlcG8tajJxOW4tdDVkNTkvb3V0cHV0IiwiVVVJRCI6ImMyMTdlMmM3LTQ5NTEtNGU1ZC04NjRlLTgzY2M1ZmU0OWJmZiIsIk9mZnNldCI6NzMxNjc1ODAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDc6MzhaIn0%3D&digest=sha256%3A469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a trace.duration=1.76028ms trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).PutContent" trace.id=792507be-bc7b-43b5-86a9-83a023cf61ae trace.line=95 vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output vars.uuid=c217e2c7-4951-4e5d-864e-83cc5fe49bff 
time="2018-04-17T13:48:10.381660945Z" level=debug msg="filesystem.Stat(\"/docker/registry/v2/repositories/extended-test-build-sti-private-repo-j2q9n-t5d59/output/_uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff/data\")" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=40657f33-e020-4ccb-8026-da71810cb6bb http.request.method=PUT http.request.remoteaddr="10.128.0.1:58938" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff?_state=R8R-TDa0vvRr9Mk3PZpdQBUy1VZLlIfWmnDB6uQIZcJ7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1wcml2YXRlLXJlcG8tajJxOW4tdDVkNTkvb3V0cHV0IiwiVVVJRCI6ImMyMTdlMmM3LTQ5NTEtNGU1ZC04NjRlLTgzY2M1ZmU0OWJmZiIsIk9mZnNldCI6NzMxNjc1ODAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDc6MzhaIn0%3D&digest=sha256%3A469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a trace.duration="49.668µs" trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).Stat" trace.id=e1aee46d-e928-4f4d-bf5c-c410535ea9c3 trace.line=137 vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output vars.uuid=c217e2c7-4951-4e5d-864e-83cc5fe49bff 
time="2018-04-17T13:48:10.38178298Z" level=debug msg="filesystem.List(\"/docker/registry/v2/repositories/extended-test-build-sti-private-repo-j2q9n-t5d59/output/_uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff/hashstates/sha256\")" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=40657f33-e020-4ccb-8026-da71810cb6bb http.request.method=PUT http.request.remoteaddr="10.128.0.1:58938" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff?_state=R8R-TDa0vvRr9Mk3PZpdQBUy1VZLlIfWmnDB6uQIZcJ7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1wcml2YXRlLXJlcG8tajJxOW4tdDVkNTkvb3V0cHV0IiwiVVVJRCI6ImMyMTdlMmM3LTQ5NTEtNGU1ZC04NjRlLTgzY2M1ZmU0OWJmZiIsIk9mZnNldCI6NzMxNjc1ODAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDc6MzhaIn0%3D&digest=sha256%3A469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a trace.duration="52.057µs" trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).List" trace.id=6319f67d-7bbe-4716-8c93-56a4f7250fe5 trace.line=150 vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output vars.uuid=c217e2c7-4951-4e5d-864e-83cc5fe49bff 
time="2018-04-17T13:48:10.38188199Z" level=debug msg="filesystem.GetContent(\"/docker/registry/v2/repositories/extended-test-build-sti-private-repo-j2q9n-t5d59/output/_uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff/hashstates/sha256/73167580\")" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=40657f33-e020-4ccb-8026-da71810cb6bb http.request.method=PUT http.request.remoteaddr="10.128.0.1:58938" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff?_state=R8R-TDa0vvRr9Mk3PZpdQBUy1VZLlIfWmnDB6uQIZcJ7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1wcml2YXRlLXJlcG8tajJxOW4tdDVkNTkvb3V0cHV0IiwiVVVJRCI6ImMyMTdlMmM3LTQ5NTEtNGU1ZC04NjRlLTgzY2M1ZmU0OWJmZiIsIk9mZnNldCI6NzMxNjc1ODAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDc6MzhaIn0%3D&digest=sha256%3A469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a trace.duration="37.618µs" trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).GetContent" trace.id=911b5678-b189-4648-9152-47b070930dc3 trace.line=82 vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output vars.uuid=c217e2c7-4951-4e5d-864e-83cc5fe49bff 
time="2018-04-17T13:48:10.382076807Z" level=debug msg="filesystem.Stat(\"/docker/registry/v2/blobs/sha256/46/469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0/data\")" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=40657f33-e020-4ccb-8026-da71810cb6bb http.request.method=PUT http.request.remoteaddr="10.128.0.1:58938" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff?_state=R8R-TDa0vvRr9Mk3PZpdQBUy1VZLlIfWmnDB6uQIZcJ7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1wcml2YXRlLXJlcG8tajJxOW4tdDVkNTkvb3V0cHV0IiwiVVVJRCI6ImMyMTdlMmM3LTQ5NTEtNGU1ZC04NjRlLTgzY2M1ZmU0OWJmZiIsIk9mZnNldCI6NzMxNjc1ODAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDc6MzhaIn0%3D&digest=sha256%3A469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a trace.duration="19.806µs" trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).Stat" trace.id=f796a3ad-670a-46b2-8c0d-4612be6b890d trace.line=137 vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output vars.uuid=c217e2c7-4951-4e5d-864e-83cc5fe49bff 
time="2018-04-17T13:48:10.384293344Z" level=debug msg="filesystem.PutContent(\"/docker/registry/v2/repositories/extended-test-build-sti-private-repo-j2q9n-t5d59/output/_layers/sha256/469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0/link\")" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=40657f33-e020-4ccb-8026-da71810cb6bb http.request.method=PUT http.request.remoteaddr="10.128.0.1:58938" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff?_state=R8R-TDa0vvRr9Mk3PZpdQBUy1VZLlIfWmnDB6uQIZcJ7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1wcml2YXRlLXJlcG8tajJxOW4tdDVkNTkvb3V0cHV0IiwiVVVJRCI6ImMyMTdlMmM3LTQ5NTEtNGU1ZC04NjRlLTgzY2M1ZmU0OWJmZiIsIk9mZnNldCI6NzMxNjc1ODAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDc6MzhaIn0%3D&digest=sha256%3A469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a trace.duration=2.15979ms trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).PutContent" trace.id=7b5c20d1-9778-453d-a8d5-2a240d332f78 trace.line=95 vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output vars.uuid=c217e2c7-4951-4e5d-864e-83cc5fe49bff 
time="2018-04-17T13:48:10.400684468Z" level=debug msg="filesystem.Delete(\"/docker/registry/v2/repositories/extended-test-build-sti-private-repo-j2q9n-t5d59/output/_uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff\")" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=40657f33-e020-4ccb-8026-da71810cb6bb http.request.method=PUT http.request.remoteaddr="10.128.0.1:58938" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff?_state=R8R-TDa0vvRr9Mk3PZpdQBUy1VZLlIfWmnDB6uQIZcJ7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1wcml2YXRlLXJlcG8tajJxOW4tdDVkNTkvb3V0cHV0IiwiVVVJRCI6ImMyMTdlMmM3LTQ5NTEtNGU1ZC04NjRlLTgzY2M1ZmU0OWJmZiIsIk9mZnNldCI6NzMxNjc1ODAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDc6MzhaIn0%3D&digest=sha256%3A469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a trace.duration=16.322495ms trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).Delete" trace.id=1b271c15-1d7f-4021-b2ae-758303b17f72 trace.line=177 vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output vars.uuid=c217e2c7-4951-4e5d-864e-83cc5fe49bff 
10.128.0.1 - - [17/Apr/2018:13:48:10 +0000] "PUT /v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff?_state=R8R-TDa0vvRr9Mk3PZpdQBUy1VZLlIfWmnDB6uQIZcJ7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1wcml2YXRlLXJlcG8tajJxOW4tdDVkNTkvb3V0cHV0IiwiVVVJRCI6ImMyMTdlMmM3LTQ5NTEtNGU1ZC04NjRlLTgzY2M1ZmU0OWJmZiIsIk9mZnNldCI6NzMxNjc1ODAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDc6MzhaIn0%3D&digest=sha256%3A469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0 HTTP/1.1" 201 0 "" "docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)"
time="2018-04-17T13:48:10.400892059Z" level=info msg="response completed" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=40657f33-e020-4ccb-8026-da71810cb6bb http.request.method=PUT http.request.remoteaddr="10.128.0.1:58938" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/uploads/c217e2c7-4951-4e5d-864e-83cc5fe49bff?_state=R8R-TDa0vvRr9Mk3PZpdQBUy1VZLlIfWmnDB6uQIZcJ7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1wcml2YXRlLXJlcG8tajJxOW4tdDVkNTkvb3V0cHV0IiwiVVVJRCI6ImMyMTdlMmM3LTQ5NTEtNGU1ZC04NjRlLTgzY2M1ZmU0OWJmZiIsIk9mZnNldCI6NzMxNjc1ODAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDc6MzhaIn0%3D&digest=sha256%3A469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" http.response.duration=39.619624ms http.response.status=201 http.response.written=0 instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 
time="2018-04-17T13:48:10.412913816Z" level=debug msg="authorizing request" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=5027549a-af99-46ca-b491-05a5dce93572 http.request.method=HEAD http.request.remoteaddr="10.128.0.1:58940" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 vars.digest="sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output 
time="2018-04-17T13:48:10.414324684Z" level=debug msg="Origin auth: checking for access to repository:extended-test-build-sti-private-repo-j2q9n-t5d59/output:pull" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=5027549a-af99-46ca-b491-05a5dce93572 http.request.method=HEAD http.request.remoteaddr="10.128.0.1:58940" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a vars.digest="sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output 
time="2018-04-17T13:48:10.417664434Z" level=info msg="Using \"docker-registry.default.svc:5000\" as Docker Registry URL" go.version=go1.9.2 instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 
time="2018-04-17T13:48:10.417710749Z" level=debug msg=GetBlob go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=5027549a-af99-46ca-b491-05a5dce93572 http.request.method=HEAD http.request.remoteaddr="10.128.0.1:58940" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a vars.digest="sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output 
time="2018-04-17T13:48:10.417760915Z" level=debug msg="(*pullthroughBlobStore).Stat: starting with dgst=sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=5027549a-af99-46ca-b491-05a5dce93572 http.request.method=HEAD http.request.remoteaddr="10.128.0.1:58940" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a vars.digest="sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output 
time="2018-04-17T13:48:10.417801503Z" level=debug msg="(*blobDescriptorService).Stat: starting with digest=sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=5027549a-af99-46ca-b491-05a5dce93572 http.request.method=HEAD http.request.remoteaddr="10.128.0.1:58940" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a vars.digest="sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output 
time="2018-04-17T13:48:10.417849734Z" level=debug msg="(*pullthroughBlobStore).ServeBlob: starting with dgst=sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=5027549a-af99-46ca-b491-05a5dce93572 http.request.method=HEAD http.request.remoteaddr="10.128.0.1:58940" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a vars.digest="sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output 
time="2018-04-17T13:48:10.417892101Z" level=debug msg="(*blobDescriptorService).Stat: starting with digest=sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=5027549a-af99-46ca-b491-05a5dce93572 http.request.method=HEAD http.request.remoteaddr="10.128.0.1:58940" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a vars.digest="sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output 
time="2018-04-17T13:48:10.418025708Z" level=debug msg="filesystem.URLFor(\"/docker/registry/v2/blobs/sha256/46/469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0/data\")" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=5027549a-af99-46ca-b491-05a5dce93572 http.request.method=HEAD http.request.remoteaddr="10.128.0.1:58940" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a trace.duration="17.7µs" trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).URLFor" trace.id=72759f67-0471-41ed-91e1-67791f04e3ac trace.line=189 vars.digest="sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output 
time="2018-04-17T13:48:10.418095724Z" level=debug msg="(*blobDescriptorService).Stat: starting with digest=sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=5027549a-af99-46ca-b491-05a5dce93572 http.request.method=HEAD http.request.remoteaddr="10.128.0.1:58940" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-private-repo-j2q9n-t5d59:builder" openshift.auth.userid=ab45a51b-4245-11e8-84e3-0e453566a83a vars.digest="sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" vars.name=extended-test-build-sti-private-repo-j2q9n-t5d59/output 
time="2018-04-17T13:48:10.418214132Z" level=info msg="response completed" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=5027549a-af99-46ca-b491-05a5dce93572 http.request.method=HEAD http.request.remoteaddr="10.128.0.1:58940" http.request.uri="/v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" http.response.contenttype=application/octet-stream http.response.duration=6.487262ms http.response.status=200 http.response.written=0 instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 
10.128.0.1 - - [17/Apr/2018:13:48:10 +0000] "HEAD /v2/extended-test-build-sti-private-repo-j2q9n-t5d59/output/blobs/sha256:469cfcc7a4b3947a4fa549c68cf4f8570be53779725f0c19f3d33d1520b08db0 HTTP/1.1" 200 0 "" "docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)"
time="2018-04-17T13:48:12.088388667Z" level=debug msg="authorizing request" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=83bb901b-ab05-49e1-82cb-6e3215216770 http.request.method=GET http.request.remoteaddr="10.128.0.1:58958" http.request.uri=/v2/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 
time="2018-04-17T13:48:12.088499297Z" level=error msg="error authorizing context: authorization header required" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=83bb901b-ab05-49e1-82cb-6e3215216770 http.request.method=GET http.request.remoteaddr="10.128.0.1:58958" http.request.uri=/v2/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 
10.128.0.1 - - [17/Apr/2018:13:48:12 +0000] "GET /v2/ HTTP/1.1" 401 87 "" "docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)"
10.128.0.1 - - [17/Apr/2018:13:48:12 +0000] "GET /openshift/token?account=serviceaccount&scope=repository%3Aextended-test-build-sti-labels-drwvq-mgbr7%2Ftest%3Apush%2Cpull HTTP/1.1" 200 1901 "" "docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)"
time="2018-04-17T13:48:12.113610827Z" level=info msg="response completed" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=8480b92b-fc6f-4129-a6ed-f9a14af81edd http.request.method=GET http.request.remoteaddr="10.128.0.1:58960" http.request.uri="/openshift/token?account=serviceaccount&scope=repository%3Aextended-test-build-sti-labels-drwvq-mgbr7%2Ftest%3Apush%2Cpull" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" http.response.contenttype=application/json http.response.duration=8.14924ms http.response.status=200 http.response.written=1901 instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 
time="2018-04-17T13:48:12.139251633Z" level=debug msg="authorizing request" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=4e3f25aa-b1cf-4167-a4bc-8fe062f57545 http.request.method=POST http.request.remoteaddr="10.128.0.1:58968" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.140813212Z" level=debug msg="Origin auth: checking for access to repository:extended-test-build-sti-labels-drwvq-mgbr7/test:pull" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=4e3f25aa-b1cf-4167-a4bc-8fe062f57545 http.request.method=POST http.request.remoteaddr="10.128.0.1:58968" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.141605497Z" level=debug msg="authorizing request" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=e5f484f5-44b4-442a-8bb5-ff0bf4d69e70 http.request.method=POST http.request.remoteaddr="10.128.0.1:58962" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.143496571Z" level=debug msg="authorizing request" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=d61fec3a-dcf1-46cf-80cb-38e9f69118e8 http.request.method=POST http.request.remoteaddr="10.128.0.1:58966" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.144429229Z" level=debug msg="authorizing request" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=25b70c84-b166-49ba-95de-0e86adb0dd7b http.request.method=POST http.request.remoteaddr="10.128.0.1:58964" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.149128048Z" level=debug msg="Origin auth: checking for access to repository:extended-test-build-sti-labels-drwvq-mgbr7/test:push" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=4e3f25aa-b1cf-4167-a4bc-8fe062f57545 http.request.method=POST http.request.remoteaddr="10.128.0.1:58968" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.149274644Z" level=debug msg="Origin auth: checking for access to repository:extended-test-build-sti-labels-drwvq-mgbr7/test:pull" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=25b70c84-b166-49ba-95de-0e86adb0dd7b http.request.method=POST http.request.remoteaddr="10.128.0.1:58964" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.149429406Z" level=debug msg="Origin auth: checking for access to repository:extended-test-build-sti-labels-drwvq-mgbr7/test:pull" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=d61fec3a-dcf1-46cf-80cb-38e9f69118e8 http.request.method=POST http.request.remoteaddr="10.128.0.1:58966" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.149518736Z" level=debug msg="Origin auth: checking for access to repository:extended-test-build-sti-labels-drwvq-mgbr7/test:pull" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=e5f484f5-44b4-442a-8bb5-ff0bf4d69e70 http.request.method=POST http.request.remoteaddr="10.128.0.1:58962" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.1542483Z" level=debug msg="Origin auth: checking for access to repository:extended-test-build-sti-labels-drwvq-mgbr7/test:push" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=25b70c84-b166-49ba-95de-0e86adb0dd7b http.request.method=POST http.request.remoteaddr="10.128.0.1:58964" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.154494366Z" level=debug msg="Origin auth: checking for access to repository:extended-test-build-sti-labels-drwvq-mgbr7/test:push" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=e5f484f5-44b4-442a-8bb5-ff0bf4d69e70 http.request.method=POST http.request.remoteaddr="10.128.0.1:58962" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.154512772Z" level=info msg="Using \"docker-registry.default.svc:5000\" as Docker Registry URL" go.version=go1.9.2 instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 
time="2018-04-17T13:48:12.154567113Z" level=debug msg="(*linkedBlobStore).Writer" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=4e3f25aa-b1cf-4167-a4bc-8fe062f57545 http.request.method=POST http.request.remoteaddr="10.128.0.1:58968" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.155911802Z" level=debug msg="Origin auth: checking for access to repository:extended-test-build-sti-labels-drwvq-mgbr7/test:push" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=d61fec3a-dcf1-46cf-80cb-38e9f69118e8 http.request.method=POST http.request.remoteaddr="10.128.0.1:58966" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.156500835Z" level=info msg="Using \"docker-registry.default.svc:5000\" as Docker Registry URL" go.version=go1.9.2 instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 
time="2018-04-17T13:48:12.156552094Z" level=debug msg="(*linkedBlobStore).Writer" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=e5f484f5-44b4-442a-8bb5-ff0bf4d69e70 http.request.method=POST http.request.remoteaddr="10.128.0.1:58962" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.157551027Z" level=info msg="Using \"docker-registry.default.svc:5000\" as Docker Registry URL" go.version=go1.9.2 instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 
time="2018-04-17T13:48:12.157636788Z" level=debug msg="(*linkedBlobStore).Writer" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=25b70c84-b166-49ba-95de-0e86adb0dd7b http.request.method=POST http.request.remoteaddr="10.128.0.1:58964" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.158494435Z" level=debug msg="filesystem.PutContent(\"/docker/registry/v2/repositories/extended-test-build-sti-labels-drwvq-mgbr7/test/_uploads/64563fd0-b473-4a67-90c5-4fd7c0f93f8c/startedat\")" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=4e3f25aa-b1cf-4167-a4bc-8fe062f57545 http.request.method=POST http.request.remoteaddr="10.128.0.1:58968" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a trace.duration=3.854129ms trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).PutContent" trace.id=d07cfb54-5b82-4a81-980c-93c5d28c926b trace.line=95 vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.158704922Z" level=debug msg="filesystem.Writer(\"/docker/registry/v2/repositories/extended-test-build-sti-labels-drwvq-mgbr7/test/_uploads/64563fd0-b473-4a67-90c5-4fd7c0f93f8c/data\", false)" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=4e3f25aa-b1cf-4167-a4bc-8fe062f57545 http.request.method=POST http.request.remoteaddr="10.128.0.1:58968" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a trace.duration="128.164µs" trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).Writer" trace.id=452a3b68-a162-4cab-a530-ca005d5e3019 trace.line=124 vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.159099192Z" level=info msg="Using \"docker-registry.default.svc:5000\" as Docker Registry URL" go.version=go1.9.2 instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 
time="2018-04-17T13:48:12.159135908Z" level=debug msg="(*linkedBlobStore).Writer" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=d61fec3a-dcf1-46cf-80cb-38e9f69118e8 http.request.method=POST http.request.remoteaddr="10.128.0.1:58966" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.159544313Z" level=debug msg="filesystem.PutContent(\"/docker/registry/v2/repositories/extended-test-build-sti-labels-drwvq-mgbr7/test/_uploads/816671f1-b776-4647-9aef-5c6a37d24051/startedat\")" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=e5f484f5-44b4-442a-8bb5-ff0bf4d69e70 http.request.method=POST http.request.remoteaddr="10.128.0.1:58962" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a trace.duration=2.924937ms trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).PutContent" trace.id=df9d5fb5-5996-46fc-bf66-aa03c794006b trace.line=95 vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.159600976Z" level=debug msg="filesystem.PutContent(\"/docker/registry/v2/repositories/extended-test-build-sti-labels-drwvq-mgbr7/test/_uploads/93831cc8-5614-48d1-a8d7-13a728f5fad7/startedat\")" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=25b70c84-b166-49ba-95de-0e86adb0dd7b http.request.method=POST http.request.remoteaddr="10.128.0.1:58964" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a trace.duration=1.891509ms trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).PutContent" trace.id=476ed130-4562-4fc3-a720-15b0030217a9 trace.line=95 vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.15973466Z" level=debug msg="filesystem.Writer(\"/docker/registry/v2/repositories/extended-test-build-sti-labels-drwvq-mgbr7/test/_uploads/816671f1-b776-4647-9aef-5c6a37d24051/data\", false)" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=e5f484f5-44b4-442a-8bb5-ff0bf4d69e70 http.request.method=POST http.request.remoteaddr="10.128.0.1:58962" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a trace.duration="116.815µs" trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).Writer" trace.id=4e63550b-cc81-423a-8576-b49b03fa63f2 trace.line=124 vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.159762867Z" level=debug msg="filesystem.Writer(\"/docker/registry/v2/repositories/extended-test-build-sti-labels-drwvq-mgbr7/test/_uploads/93831cc8-5614-48d1-a8d7-13a728f5fad7/data\", false)" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=25b70c84-b166-49ba-95de-0e86adb0dd7b http.request.method=POST http.request.remoteaddr="10.128.0.1:58964" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a trace.duration="113.797µs" trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).Writer" trace.id=0f04dcc2-0235-4f7a-8cd3-362acdb553eb trace.line=124 vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.161755972Z" level=debug msg="filesystem.PutContent(\"/docker/registry/v2/repositories/extended-test-build-sti-labels-drwvq-mgbr7/test/_uploads/64563fd0-b473-4a67-90c5-4fd7c0f93f8c/hashstates/sha256/0\")" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=4e3f25aa-b1cf-4167-a4bc-8fe062f57545 http.request.method=POST http.request.remoteaddr="10.128.0.1:58968" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a trace.duration=2.909268ms trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).PutContent" trace.id=7df8a200-d037-4b25-909d-ad7c7ad4b09e trace.line=95 vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.161766848Z" level=debug msg="filesystem.PutContent(\"/docker/registry/v2/repositories/extended-test-build-sti-labels-drwvq-mgbr7/test/_uploads/015596af-2b58-4793-98a7-1cac001ea5aa/startedat\")" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=d61fec3a-dcf1-46cf-80cb-38e9f69118e8 http.request.method=POST http.request.remoteaddr="10.128.0.1:58966" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a trace.duration=2.567855ms trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).PutContent" trace.id=4fe6b151-35c4-4441-9e8d-5670e5b0d0bb trace.line=95 vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.161825271Z" level=debug msg="filesystem.PutContent(\"/docker/registry/v2/repositories/extended-test-build-sti-labels-drwvq-mgbr7/test/_uploads/93831cc8-5614-48d1-a8d7-13a728f5fad7/hashstates/sha256/0\")" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=25b70c84-b166-49ba-95de-0e86adb0dd7b http.request.method=POST http.request.remoteaddr="10.128.0.1:58964" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a trace.duration=1.965599ms trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).PutContent" trace.id=7284eebc-74ba-43d3-a8f4-81399a624e3b trace.line=95 vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.162078805Z" level=debug msg="filesystem.Writer(\"/docker/registry/v2/repositories/extended-test-build-sti-labels-drwvq-mgbr7/test/_uploads/015596af-2b58-4793-98a7-1cac001ea5aa/data\", false)" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=d61fec3a-dcf1-46cf-80cb-38e9f69118e8 http.request.method=POST http.request.remoteaddr="10.128.0.1:58966" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a trace.duration="153.883µs" trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).Writer" trace.id=c3df53ee-88b9-4ca3-946e-935eab0e5f20 trace.line=124 vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.162172973Z" level=debug msg="filesystem.PutContent(\"/docker/registry/v2/repositories/extended-test-build-sti-labels-drwvq-mgbr7/test/_uploads/816671f1-b776-4647-9aef-5c6a37d24051/hashstates/sha256/0\")" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=e5f484f5-44b4-442a-8bb5-ff0bf4d69e70 http.request.method=POST http.request.remoteaddr="10.128.0.1:58962" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a trace.duration=2.30861ms trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).PutContent" trace.id=a6c972c2-4467-4aee-8a55-baa967950c41 trace.line=95 vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.162115552Z" level=info msg="response completed" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=4e3f25aa-b1cf-4167-a4bc-8fe062f57545 http.request.method=POST http.request.remoteaddr="10.128.0.1:58968" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" http.response.duration=24.472625ms http.response.status=202 http.response.written=0 instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 
time="2018-04-17T13:48:12.162411567Z" level=info msg="response completed" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=25b70c84-b166-49ba-95de-0e86adb0dd7b http.request.method=POST http.request.remoteaddr="10.128.0.1:58964" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" http.response.duration=19.754972ms http.response.status=202 http.response.written=0 instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 
time="2018-04-17T13:48:12.162404994Z" level=info msg="response completed" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=e5f484f5-44b4-442a-8bb5-ff0bf4d69e70 http.request.method=POST http.request.remoteaddr="10.128.0.1:58962" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" http.response.duration=22.48763ms http.response.status=202 http.response.written=0 instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 
10.128.0.1 - - [17/Apr/2018:13:48:12 +0000] "POST /v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ HTTP/1.1" 202 0 "" "docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)"
10.128.0.1 - - [17/Apr/2018:13:48:12 +0000] "POST /v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ HTTP/1.1" 202 0 "" "docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)"
10.128.0.1 - - [17/Apr/2018:13:48:12 +0000] "POST /v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ HTTP/1.1" 202 0 "" "docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)"
10.128.0.1 - - [17/Apr/2018:13:48:12 +0000] "POST /v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ HTTP/1.1" 202 0 "" "docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)"
time="2018-04-17T13:48:12.164366107Z" level=debug msg="filesystem.PutContent(\"/docker/registry/v2/repositories/extended-test-build-sti-labels-drwvq-mgbr7/test/_uploads/015596af-2b58-4793-98a7-1cac001ea5aa/hashstates/sha256/0\")" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=d61fec3a-dcf1-46cf-80cb-38e9f69118e8 http.request.method=POST http.request.remoteaddr="10.128.0.1:58966" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a trace.duration=2.134183ms trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).PutContent" trace.id=7adc86d5-0ce6-469f-b1e6-6f9811963052 trace.line=95 vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test 
time="2018-04-17T13:48:12.164646781Z" level=info msg="response completed" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=d61fec3a-dcf1-46cf-80cb-38e9f69118e8 http.request.method=POST http.request.remoteaddr="10.128.0.1:58966" http.request.uri=/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/ http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" http.response.duration=22.224796ms http.response.status=202 http.response.written=0 instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 
time="2018-04-17T13:48:12.384524719Z" level=debug msg="authorizing request" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=54b7163e-fc49-486b-997f-7c4b3fee5e77 http.request.method=PATCH http.request.remoteaddr="10.128.0.1:58974" http.request.uri="/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/93831cc8-5614-48d1-a8d7-13a728f5fad7?_state=p_bK0LJb5ZyyilzA1unGrqSP21f-niL6KgDvddfjYhl7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1sYWJlbHMtZHJ3dnEtbWdicjcvdGVzdCIsIlVVSUQiOiI5MzgzMWNjOC01NjE0LTQ4ZDEtYThkNy0xM2E3MjhmNWZhZDciLCJPZmZzZXQiOjAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDg6MTIuMTU3Njc2NjJaIn0%3D" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test vars.uuid=93831cc8-5614-48d1-a8d7-13a728f5fad7 
time="2018-04-17T13:48:12.386620344Z" level=debug msg="Origin auth: checking for access to repository:extended-test-build-sti-labels-drwvq-mgbr7/test:pull" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=54b7163e-fc49-486b-997f-7c4b3fee5e77 http.request.method=PATCH http.request.remoteaddr="10.128.0.1:58974" http.request.uri="/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/93831cc8-5614-48d1-a8d7-13a728f5fad7?_state=p_bK0LJb5ZyyilzA1unGrqSP21f-niL6KgDvddfjYhl7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1sYWJlbHMtZHJ3dnEtbWdicjcvdGVzdCIsIlVVSUQiOiI5MzgzMWNjOC01NjE0LTQ4ZDEtYThkNy0xM2E3MjhmNWZhZDciLCJPZmZzZXQiOjAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDg6MTIuMTU3Njc2NjJaIn0%3D" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test vars.uuid=93831cc8-5614-48d1-a8d7-13a728f5fad7 
time="2018-04-17T13:48:12.388406984Z" level=debug msg="Origin auth: checking for access to repository:extended-test-build-sti-labels-drwvq-mgbr7/test:push" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=54b7163e-fc49-486b-997f-7c4b3fee5e77 http.request.method=PATCH http.request.remoteaddr="10.128.0.1:58974" http.request.uri="/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/93831cc8-5614-48d1-a8d7-13a728f5fad7?_state=p_bK0LJb5ZyyilzA1unGrqSP21f-niL6KgDvddfjYhl7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1sYWJlbHMtZHJ3dnEtbWdicjcvdGVzdCIsIlVVSUQiOiI5MzgzMWNjOC01NjE0LTQ4ZDEtYThkNy0xM2E3MjhmNWZhZDciLCJPZmZzZXQiOjAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDg6MTIuMTU3Njc2NjJaIn0%3D" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test vars.uuid=93831cc8-5614-48d1-a8d7-13a728f5fad7 
time="2018-04-17T13:48:12.391026033Z" level=info msg="Using \"docker-registry.default.svc:5000\" as Docker Registry URL" go.version=go1.9.2 instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 
time="2018-04-17T13:48:12.391145413Z" level=debug msg="(*linkedBlobStore).Resume" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=54b7163e-fc49-486b-997f-7c4b3fee5e77 http.request.method=PATCH http.request.remoteaddr="10.128.0.1:58974" http.request.uri="/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/93831cc8-5614-48d1-a8d7-13a728f5fad7?_state=p_bK0LJb5ZyyilzA1unGrqSP21f-niL6KgDvddfjYhl7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1sYWJlbHMtZHJ3dnEtbWdicjcvdGVzdCIsIlVVSUQiOiI5MzgzMWNjOC01NjE0LTQ4ZDEtYThkNy0xM2E3MjhmNWZhZDciLCJPZmZzZXQiOjAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDg6MTIuMTU3Njc2NjJaIn0%3D" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test vars.uuid=93831cc8-5614-48d1-a8d7-13a728f5fad7 
time="2018-04-17T13:48:12.391615354Z" level=debug msg="filesystem.GetContent(\"/docker/registry/v2/repositories/extended-test-build-sti-labels-drwvq-mgbr7/test/_uploads/93831cc8-5614-48d1-a8d7-13a728f5fad7/startedat\")" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=54b7163e-fc49-486b-997f-7c4b3fee5e77 http.request.method=PATCH http.request.remoteaddr="10.128.0.1:58974" http.request.uri="/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/93831cc8-5614-48d1-a8d7-13a728f5fad7?_state=p_bK0LJb5ZyyilzA1unGrqSP21f-niL6KgDvddfjYhl7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1sYWJlbHMtZHJ3dnEtbWdicjcvdGVzdCIsIlVVSUQiOiI5MzgzMWNjOC01NjE0LTQ4ZDEtYThkNy0xM2E3MjhmNWZhZDciLCJPZmZzZXQiOjAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDg6MTIuMTU3Njc2NjJaIn0%3D" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a trace.duration="353.185µs" trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).GetContent" trace.id=5a5191b5-5092-44d1-9f0b-b7dc1d6fb822 trace.line=82 vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test vars.uuid=93831cc8-5614-48d1-a8d7-13a728f5fad7 
time="2018-04-17T13:48:12.392317289Z" level=debug msg="filesystem.Writer(\"/docker/registry/v2/repositories/extended-test-build-sti-labels-drwvq-mgbr7/test/_uploads/93831cc8-5614-48d1-a8d7-13a728f5fad7/data\", true)" go.version=go1.9.2 http.request.host="docker-registry.default.svc:5000" http.request.id=54b7163e-fc49-486b-997f-7c4b3fee5e77 http.request.method=PATCH http.request.remoteaddr="10.128.0.1:58974" http.request.uri="/v2/extended-test-build-sti-labels-drwvq-mgbr7/test/blobs/uploads/93831cc8-5614-48d1-a8d7-13a728f5fad7?_state=p_bK0LJb5ZyyilzA1unGrqSP21f-niL6KgDvddfjYhl7Ik5hbWUiOiJleHRlbmRlZC10ZXN0LWJ1aWxkLXN0aS1sYWJlbHMtZHJ3dnEtbWdicjcvdGVzdCIsIlVVSUQiOiI5MzgzMWNjOC01NjE0LTQ4ZDEtYThkNy0xM2E3MjhmNWZhZDciLCJPZmZzZXQiOjAsIlN0YXJ0ZWRBdCI6IjIwMTgtMDQtMTdUMTM6NDg6MTIuMTU3Njc2NjJaIn0%3D" http.request.useragent="docker/1.13.1 go/go1.8.3 kernel/3.10.0-693.21.1.el7.x86_64 os/linux arch/amd64 UpstreamClient(go-dockerclient)" instance.id=ef9d9082-2cfe-47dd-bd8a-a24203fe9c67 openshift.auth.user="system:serviceaccount:extended-test-build-sti-labels-drwvq-mgbr7:builder" openshift.auth.userid=69723607-4245-11e8-84e3-0e453566a83a trace.duration="389.777µs" trace.file=/tmp/openshift/build-rpms/rpm/BUILD/origin-dockerregistry-3.10.0/_output/local/go/src/github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base/base.go trace.func="github.com/openshift/image-registry/vendor/github.com/docker/distribution/registry/storage/driver/base.(*Base).Writer" trace.id=fcbdba2a-97aa-40da-9bde-5c6c1c4d427b trace.line=124 vars.name=extended-test-build-sti-labels-drwvq-mgbr7/test vars.uuid=93831cc8-5614-48d1-a8d7-13a728f5fad7

Apr 17 13:48:12.764: INFO: 


Apr 17 13:48:12.771: INFO: Found event v1.Event{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"statusfail-postcommithook-1.15263d37e79c2937", GenerateName:"", Namespace:"extended-test-update-buildstatus-7x9qf-v4w2h", SelfLink:"/api/v1/namespaces/extended-test-update-buildstatus-7x9qf-v4w2h/events/statusfail-postcommithook-1.15263d37e79c2937", UID:"d5d2c204-4245-11e8-84e3-0e453566a83a", ResourceVersion:"25126", Generation:0, CreationTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:63659569634, loc:(*time.Location)(0x6e7b900)}}, DeletionTimestamp:(*v1.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string(nil), Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference(nil), Initializers:(*v1.Initializers)(nil), Finalizers:[]string(nil), ClusterName:""}, InvolvedObject:v1.ObjectReference{Kind:"Build", Namespace:"extended-test-update-buildstatus-7x9qf-v4w2h", Name:"statusfail-postcommithook-1", UID:"cff6a606-4245-11e8-84e3-0e453566a83a", APIVersion:"build.openshift.io", ResourceVersion:"25123", FieldPath:""}, Reason:"BuildStarted", Message:"Build extended-test-update-buildstatus-7x9qf-v4w2h/statusfail-postcommithook-1 is now running", Source:v1.EventSource{Component:"build-controller", Host:""}, FirstTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:63659569634, loc:(*time.Location)(0x6e7b900)}}, LastTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:63659569634, loc:(*time.Location)(0x6e7b900)}}, Count:1, Type:"Normal", EventTime:v1.MicroTime{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, Series:(*v1.EventSeries)(nil), Action:"", Related:(*v1.ObjectReference)(nil), ReportingController:"", ReportingInstance:""}
Apr 17 13:48:12.771: INFO: Found event v1.Event{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"statusfail-postcommithook-1.15263d440ad64969", GenerateName:"", Namespace:"extended-test-update-buildstatus-7x9qf-v4w2h", SelfLink:"/api/v1/namespaces/extended-test-update-buildstatus-7x9qf-v4w2h/events/statusfail-postcommithook-1.15263d440ad64969", UID:"f4e51357-4245-11e8-84e3-0e453566a83a", ResourceVersion:"25346", Generation:0, CreationTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:63659569686, loc:(*time.Location)(0x6e7b900)}}, DeletionTimestamp:(*v1.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string(nil), Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference(nil), Initializers:(*v1.Initializers)(nil), Finalizers:[]string(nil), ClusterName:""}, InvolvedObject:v1.ObjectReference{Kind:"Build", Namespace:"extended-test-update-buildstatus-7x9qf-v4w2h", Name:"statusfail-postcommithook-1", UID:"cff6a606-4245-11e8-84e3-0e453566a83a", APIVersion:"build.openshift.io", ResourceVersion:"25345", FieldPath:""}, Reason:"BuildFailed", Message:"Build extended-test-update-buildstatus-7x9qf-v4w2h/statusfail-postcommithook-1 failed", Source:v1.EventSource{Component:"build-controller", Host:""}, FirstTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:63659569686, loc:(*time.Location)(0x6e7b900)}}, LastTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:63659569686, loc:(*time.Location)(0x6e7b900)}}, Count:1, Type:"Normal", EventTime:v1.MicroTime{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, Series:(*v1.EventSeries)(nil), Action:"", Related:(*v1.ObjectReference)(nil), ReportingController:"", ReportingInstance:""}
[AfterEach] 
  /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/failure_status.go:50
[AfterEach] [Feature:Builds][Slow] update failure status
  /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:142
Apr 17 13:48:13.781: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "extended-test-update-buildstatus-7x9qf-v4w2h" for this suite.
Apr 17 13:48:21.809: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
Apr 17 13:48:21.976: INFO: namespace: extended-test-update-buildstatus-7x9qf-v4w2h, resource: bindings, ignored listing per whitelist
Apr 17 13:48:22.113: INFO: namespace extended-test-update-buildstatus-7x9qf-v4w2h deletion completed in 8.328351317s


• [SLOW TEST:79.849 seconds]
[Feature:Builds][Slow] update failure status
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/failure_status.go:19
  
  /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/failure_status.go:38
    Build status postcommit hook failure
    /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/failure_status.go:57
      should contain the post commit hook failure reason and message [Suite:openshift]
      /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/failure_status.go:58
------------------------------
Apr 17 13:48:22.166: INFO: Running AfterSuite actions on all node


[Feature:Builds][Slow] can use private repositories as build input  Build using a username, password, and CA certificate 
  should create a new build using the internal gitserver [Suite:openshift]
  /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/gitauth.go:110

[BeforeEach] [Top Level]
  /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/util/test.go:53
[BeforeEach] [Feature:Builds][Slow] can use private repositories as build input
  /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:141
STEP: Creating a kubernetes client
Apr 17 13:46:02.698: INFO: >>> kubeConfig: /etc/origin/master/admin.kubeconfig
STEP: Building a namespace api object
Apr 17 13:46:02.797: INFO: configPath is now "/tmp/extended-test-build-sti-private-repo-j2q9n-t5d59-user.kubeconfig"
Apr 17 13:46:02.797: INFO: The user is now "extended-test-build-sti-private-repo-j2q9n-t5d59-user"
Apr 17 13:46:02.797: INFO: Creating project "extended-test-build-sti-private-repo-j2q9n-t5d59"
Apr 17 13:46:02.975: INFO: Waiting on permissions in project "extended-test-build-sti-private-repo-j2q9n-t5d59" ...
STEP: Waiting for a default service account to be provisioned in namespace
[BeforeEach] 
  /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/gitauth.go:49
Apr 17 13:46:03.323: INFO: 

 docker info output: 
Containers: 67
 Running: 46
 Paused: 0
 Stopped: 21
Images: 236
Server Version: 1.13.1
Storage Driver: devicemapper
 Pool Name: docker-docker--pool
 Pool Blocksize: 524.3 kB
 Base Device Size: 10.74 GB
 Backing Filesystem: xfs
 Data file: 
 Metadata file: 
 Data Space Used: 25.24 GB
 Data Space Total: 37.14 GB
 Data Space Available: 11.9 GB
 Metadata Space Used: 8.851 MB
 Metadata Space Total: 54.53 MB
 Metadata Space Available: 45.67 MB
 Thin Pool Minimum Free Space: 3.714 GB
 Udev Sync Supported: true
 Deferred Removal Enabled: true
 Deferred Deletion Enabled: true
 Deferred Deleted Device Count: 0
 Library Version: 1.02.140-RHEL7 (2017-05-03)
Logging Driver: json-file
Cgroup Driver: systemd
Plugins: 
 Volume: local
 Network: bridge host macvlan null overlay
 Authorization: rhel-push-plugin
Swarm: inactive
Runtimes: docker-runc runc
Default Runtime: docker-runc
Init Binary: docker-init
containerd version:  (expected: aa8187dbd3b7ad67d8e5e3a15115d3eef43a7ed1)
runc version: N/A (expected: 9df8b306d01f59d3a8029be411de015b7304dd8f)
init version: N/A (expected: 949e6facb77383876aeff8a6944dde66b3089574)
Security Options:
 seccomp
  Profile: /etc/docker/seccomp.json
 selinux
Kernel Version: 3.10.0-693.21.1.el7.x86_64
Operating System: Red Hat Enterprise Linux Server 7.4 (Maipo)
OSType: linux
Architecture: x86_64
Number of Docker Hooks: 3
CPUs: 4
Total Memory: 15.51 GiB
Name: ip-172-18-6-14.ec2.internal
ID: OFNX:5JSM:SZYG:772G:DLXP:6JG3:KLUI:7Q4G:7KK5:AESH:Y3GF:E6HW
Docker Root Dir: /var/lib/docker
Debug Mode (client): false
Debug Mode (server): false
Registry: https://registry.access.redhat.com/v1/
Experimental: false
Insecure Registries:
 ci.dev.openshift.redhat.com:5000
 172.30.0.0/16
 127.0.0.0/8
Live Restore Enabled: false
Registries: registry.access.redhat.com (secure), docker.io (secure)



[JustBeforeEach] 
  /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/gitauth.go:60
STEP: waiting for builder service account
[It] should create a new build using the internal gitserver [Suite:openshift]
  /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/gitauth.go:110
STEP: obtaining the configured API server host from config
STEP: calling oc new-app -f "/tmp/fixture-testdata-dir478252087/test/extended/testdata/test-gitserver.yaml" -p ROUTE_SUFFIX=172.18.6.14.nip.io
Apr 17 13:46:03.431: INFO: Running 'oc new-app --config=/tmp/extended-test-build-sti-private-repo-j2q9n-t5d59-user.kubeconfig --namespace=extended-test-build-sti-private-repo-j2q9n-t5d59 -f /tmp/fixture-testdata-dir478252087/test/extended/testdata/test-gitserver.yaml -p ROUTE_SUFFIX=172.18.6.14.nip.io'
--> Deploying template "extended-test-build-sti-private-repo-j2q9n-t5d59/gitserver" for "/tmp/fixture-testdata-dir478252087/test/extended/testdata/test-gitserver.yaml" to project extended-test-build-sti-private-repo-j2q9n-t5d59

     * With parameters:
        * ROUTE_SUFFIX=172.18.6.14.nip.io

--> Creating resources ...
    deploymentconfig "gitserver" created
    service "gitserver" created
    route "gitserver" created
--> Success
    Access your application via route 'gitserver.172.18.6.14.nip.io' 
    Run 'oc status' to view your app.
STEP: expecting the deployment of the gitserver to be in the Complete phase
Apr 17 13:46:03.990: INFO: waiting for deploymentconfig extended-test-build-sti-private-repo-j2q9n-t5d59/gitserver to be available with version 1

Apr 17 13:46:31.017: INFO: deploymentconfig extended-test-build-sti-private-repo-j2q9n-t5d59/gitserver available after 27.026998986s
pods: gitserver-1-wdzbn

STEP: creating a new secret for the gitserver by calling oc secrets new-basicauth sourcesecret --username=gituser --password=gituserpassword --cacert=/etc/origin/master/ca.crt
Apr 17 13:46:31.018: INFO: Running 'oc secrets --config=/tmp/extended-test-build-sti-private-repo-j2q9n-t5d59-user.kubeconfig --namespace=extended-test-build-sti-private-repo-j2q9n-t5d59 new-basicauth sourcesecret --username=gituser --password=gituserpassword --ca-cert=/etc/origin/master/ca.crt'
Command "new-basicauth" is deprecated, use oc create secret
secret/sourcesecret
STEP: creating a new BuildConfig by calling oc new-app -f "/tmp/fixture-testdata-dir478252087/test/extended/testdata/builds/test-auth-build.yaml" -p SOURCE_SECRET=sourcesecret -p SOURCE_URL=https://gitserver.172.18.6.14.nip.io/ruby-hello-world
Apr 17 13:46:31.253: INFO: Running 'oc new-app --config=/tmp/extended-test-build-sti-private-repo-j2q9n-t5d59-user.kubeconfig --namespace=extended-test-build-sti-private-repo-j2q9n-t5d59 -f /tmp/fixture-testdata-dir478252087/test/extended/testdata/builds/test-auth-build.yaml -p SOURCE_SECRET=sourcesecret -p SOURCE_URL=https://gitserver.172.18.6.14.nip.io/ruby-hello-world'
--> Deploying template "extended-test-build-sti-private-repo-j2q9n-t5d59/gitserver" for "/tmp/fixture-testdata-dir478252087/test/extended/testdata/builds/test-auth-build.yaml" to project extended-test-build-sti-private-repo-j2q9n-t5d59

     * With parameters:
        * SOURCE_URL=https://gitserver.172.18.6.14.nip.io/ruby-hello-world
        * SOURCE_SECRET=sourcesecret

--> Creating resources ...
    imagestream "output" created
    buildconfig "gitauthtest" created
--> Success
    Use 'oc start-build gitauthtest' to start a build.
    Run 'oc status' to view your app.
STEP: starting a test build
Apr 17 13:46:31.563: INFO: Running 'oc start-build --config=/tmp/extended-test-build-sti-private-repo-j2q9n-t5d59-user.kubeconfig --namespace=extended-test-build-sti-private-repo-j2q9n-t5d59 gitauthtest -o=name'
Apr 17 13:46:31.885: INFO: 

start-build output with args [gitauthtest -o=name]:
Error><nil>
StdOut>
build/gitauthtest-1
StdErr>



Apr 17 13:46:31.886: INFO: Waiting for gitauthtest-1 to complete

Apr 17 13:48:17.898: INFO: Done waiting for gitauthtest-1: util.BuildResult{BuildPath:"build/gitauthtest-1", BuildName:"gitauthtest-1", StartBuildStdErr:"", StartBuildStdOut:"build/gitauthtest-1", StartBuildErr:error(nil), BuildConfigName:"", Build:(*build.Build)(0xc421344c00), BuildAttempt:true, BuildSuccess:true, BuildFailure:false, BuildCancelled:false, BuildTimeout:false, LogDumper:(util.LogDumperFunc)(nil), Oc:(*util.CLI)(0xc421027c00)}
 with error: <nil>

[AfterEach] 
  /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/gitauth.go:53
[AfterEach] [Feature:Builds][Slow] can use private repositories as build input
  /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:142
Apr 17 13:48:17.898: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "extended-test-build-sti-private-repo-j2q9n-t5d59" for this suite.
Apr 17 13:48:41.933: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
Apr 17 13:48:42.054: INFO: namespace: extended-test-build-sti-private-repo-j2q9n-t5d59, resource: bindings, ignored listing per whitelist
Apr 17 13:48:42.089: INFO: namespace extended-test-build-sti-private-repo-j2q9n-t5d59 deletion completed in 24.182222142s


• [SLOW TEST:159.392 seconds]
[Feature:Builds][Slow] can use private repositories as build input
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/gitauth.go:25
  
  /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/gitauth.go:47
    Build using a username, password, and CA certificate
    /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/gitauth.go:109
      should create a new build using the internal gitserver [Suite:openshift]
      /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/gitauth.go:110
------------------------------
Apr 17 13:48:42.091: INFO: Running AfterSuite actions on all node


[Feature:Builds][Slow] result image should have proper labels set  Docker build from a template 
  should create a image from "/tmp/fixture-testdata-dir266614785/test/extended/testdata/builds/test-docker-build.json" template with proper Docker labels [Suite:openshift]
  /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/labels.go:71

[BeforeEach] [Top Level]
  /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/util/test.go:53
[BeforeEach] [Feature:Builds][Slow] result image should have proper labels set
  /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:141
STEP: Creating a kubernetes client
Apr 17 13:44:12.249: INFO: >>> kubeConfig: /etc/origin/master/admin.kubeconfig
STEP: Building a namespace api object
Apr 17 13:44:12.381: INFO: configPath is now "/tmp/extended-test-build-sti-labels-drwvq-mgbr7-user.kubeconfig"
Apr 17 13:44:12.381: INFO: The user is now "extended-test-build-sti-labels-drwvq-mgbr7-user"
Apr 17 13:44:12.381: INFO: Creating project "extended-test-build-sti-labels-drwvq-mgbr7"
Apr 17 13:44:12.512: INFO: Waiting on permissions in project "extended-test-build-sti-labels-drwvq-mgbr7" ...
STEP: Waiting for a default service account to be provisioned in namespace
[BeforeEach] 
  /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/labels.go:24
Apr 17 13:44:13.007: INFO: 

 docker info output: 
Containers: 66
 Running: 43
 Paused: 0
 Stopped: 23
Images: 231
Server Version: 1.13.1
Storage Driver: devicemapper
 Pool Name: docker-docker--pool
 Pool Blocksize: 524.3 kB
 Base Device Size: 10.74 GB
 Backing Filesystem: xfs
 Data file: 
 Metadata file: 
 Data Space Used: 25 GB
 Data Space Total: 37.14 GB
 Data Space Available: 12.14 GB
 Metadata Space Used: 8.806 MB
 Metadata Space Total: 54.53 MB
 Metadata Space Available: 45.72 MB
 Thin Pool Minimum Free Space: 3.714 GB
 Udev Sync Supported: true
 Deferred Removal Enabled: true
 Deferred Deletion Enabled: true
 Deferred Deleted Device Count: 0
 Library Version: 1.02.140-RHEL7 (2017-05-03)
Logging Driver: json-file
Cgroup Driver: systemd
Plugins: 
 Volume: local
 Network: bridge host macvlan null overlay
 Authorization: rhel-push-plugin
Swarm: inactive
Runtimes: docker-runc runc
Default Runtime: docker-runc
Init Binary: docker-init
containerd version:  (expected: aa8187dbd3b7ad67d8e5e3a15115d3eef43a7ed1)
runc version: N/A (expected: 9df8b306d01f59d3a8029be411de015b7304dd8f)
init version: N/A (expected: 949e6facb77383876aeff8a6944dde66b3089574)
Security Options:
 seccomp
  Profile: /etc/docker/seccomp.json
 selinux
Kernel Version: 3.10.0-693.21.1.el7.x86_64
Operating System: Red Hat Enterprise Linux Server 7.4 (Maipo)
OSType: linux
Architecture: x86_64
Number of Docker Hooks: 3
CPUs: 4
Total Memory: 15.51 GiB
Name: ip-172-18-6-14.ec2.internal
ID: OFNX:5JSM:SZYG:772G:DLXP:6JG3:KLUI:7Q4G:7KK5:AESH:Y3GF:E6HW
Docker Root Dir: /var/lib/docker
Debug Mode (client): false
Debug Mode (server): false
Registry: https://registry.access.redhat.com/v1/
Experimental: false
Insecure Registries:
 ci.dev.openshift.redhat.com:5000
 172.30.0.0/16
 127.0.0.0/8
Live Restore Enabled: false
Registries: registry.access.redhat.com (secure), docker.io (secure)



[JustBeforeEach] 
  /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/labels.go:28
STEP: waiting for builder service account
[It] should create a image from "/tmp/fixture-testdata-dir266614785/test/extended/testdata/builds/test-docker-build.json" template with proper Docker labels [Suite:openshift]
  /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/labels.go:71
STEP: calling oc create -f "/tmp/fixture-testdata-dir266614785/test/integration/testdata/test-image-stream.json"
Apr 17 13:44:13.112: INFO: Running 'oc create --config=/tmp/extended-test-build-sti-labels-drwvq-mgbr7-user.kubeconfig --namespace=extended-test-build-sti-labels-drwvq-mgbr7 -f /tmp/fixture-testdata-dir266614785/test/integration/testdata/test-image-stream.json'
imagestream "test" created
STEP: calling oc create -f "/tmp/fixture-testdata-dir266614785/test/extended/testdata/builds/test-docker-build.json"
Apr 17 13:44:13.345: INFO: Running 'oc create --config=/tmp/extended-test-build-sti-labels-drwvq-mgbr7-user.kubeconfig --namespace=extended-test-build-sti-labels-drwvq-mgbr7 -f /tmp/fixture-testdata-dir266614785/test/extended/testdata/builds/test-docker-build.json'
buildconfig "test" created
STEP: starting a test build
Apr 17 13:44:13.556: INFO: Running 'oc start-build --config=/tmp/extended-test-build-sti-labels-drwvq-mgbr7-user.kubeconfig --namespace=extended-test-build-sti-labels-drwvq-mgbr7 test -o=name'
Apr 17 13:44:13.787: INFO: 

start-build output with args [test -o=name]:
Error><nil>
StdOut>
build/test-1
StdErr>



Apr 17 13:44:13.788: INFO: Waiting for test-1 to complete

Apr 17 13:48:39.797: INFO: Done waiting for test-1: util.BuildResult{BuildPath:"build/test-1", BuildName:"test-1", StartBuildStdErr:"", StartBuildStdOut:"build/test-1", StartBuildErr:error(nil), BuildConfigName:"", Build:(*build.Build)(0xc420984c00), BuildAttempt:true, BuildSuccess:true, BuildFailure:false, BuildCancelled:false, BuildTimeout:false, LogDumper:(util.LogDumperFunc)(nil), Oc:(*util.CLI)(0xc421658380)}
 with error: <nil>

STEP: getting the Docker image reference from ImageStream
STEP: inspecting the new image for proper Docker labels
[AfterEach] 
  /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/labels.go:34
[AfterEach] [Feature:Builds][Slow] result image should have proper labels set
  /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:142
Apr 17 13:48:39.806: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "extended-test-build-sti-labels-drwvq-mgbr7" for this suite.
Apr 17 13:48:45.818: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
Apr 17 13:48:45.910: INFO: namespace: extended-test-build-sti-labels-drwvq-mgbr7, resource: bindings, ignored listing per whitelist
Apr 17 13:48:45.972: INFO: namespace extended-test-build-sti-labels-drwvq-mgbr7 deletion completed in 6.163182766s


• [SLOW TEST:273.723 seconds]
[Feature:Builds][Slow] result image should have proper labels set
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/labels.go:13
  
  /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/labels.go:22
    Docker build from a template
    /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/labels.go:70
      should create a image from "/tmp/fixture-testdata-dir266614785/test/extended/testdata/builds/test-docker-build.json" template with proper Docker labels [Suite:openshift]
      /go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/labels.go:71
------------------------------
Apr 17 13:48:45.973: INFO: Running AfterSuite actions on all node


Apr 17 13:48:19.024: INFO: Running AfterSuite actions on all node
Apr 17 13:48:46.050: INFO: Running AfterSuite actions on node 1


Ran 101 of 441 Specs in 3133.339 seconds
SUCCESS! -- 101 Passed | 0 Failed | 0 Pending | 340 Skipped 

Ginkgo ran 1 suite in 52m14.159802981s
Test Suite Passed

[INFO] [13:48:46+0000] Running serial tests with focus \[Feature:Builds\]
I0417 13:48:46.375038     634 test.go:94] Extended test version v3.6.0-alpha.1+7b2d509-6764
[WARNING] [13:48:47+0000] No tests were selected
I0417 13:48:48.308478    1578 test.go:94] Extended test version v3.6.0-alpha.1+7b2d509-6764
[WARNING] [13:48:49+0000] No tests were selected
[INFO] [13:48:49+0000] [CLEANUP] Beginning cleanup routines...
[INFO] [13:48:49+0000] [CLEANUP] Dumping cluster events to _output/scripts/core/artifacts/events.txt
Logged into "https://ip-172-18-6-14.ec2.internal:8443" as "system:admin" using existing credentials.

You have access to the following projects and can switch between them with 'oc project <projectname>':

  * default
    kube-public
    kube-service-catalog
    kube-system
    management-infra
    openshift
    openshift-ansible-service-broker
    openshift-infra
    openshift-logging
    openshift-node
    openshift-sdn
    openshift-template-service-broker
    openshift-web-console

Using project "default".
[INFO] [13:48:50+0000] [CLEANUP] Dumping container logs to _output/scripts/core/logs/containers
[INFO] [13:49:21+0000] [CLEANUP] Truncating log files over 200M
[INFO] [13:49:21+0000] [CLEANUP] Stopping docker containers
Error response from daemon: No such container: 7a50463f5579155627e26c55da9d8359a8ed0960d057e4013f94aeadd12c072c
[INFO] [13:50:27+0000] [CLEANUP] Removing docker containers
Error: No such object: 97098f061735
json: cannot unmarshal array into Go value of type types.ContainerJSON
Error: No such object: da1469fcb65b
json: cannot unmarshal array into Go value of type types.ContainerJSON
Error response from daemon: You cannot remove a running container e265fa980af8884381d45b3a8c8a717aec528762ea4bfc37827bf80e9432b452. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container 733d5b39d9062736ba6602ce2d586b4cc190ed6c92f1f235439d410b32c4d536. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container 645e467628b00803b592e3e18943627aa67eac09f84ce070aedbfa30a7e46226. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container e77d252b392a067c3ff2070ce690387dd5a74e9e4ac5e25a2b1e7c554a242511. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container 690f645b6153b92a32d627f477877b0914e22425744c74331a1310705db7db3d. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container e4d1f37be7e914691fce581c19ed66045e4d81cd9d54ddec5c69ba5ecafa4353. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container 41448651ca8bc902eb580ad4ed3b87394302f745e2852f326472d2653edad154. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container fc575e8c0d89ae71de9b224ea7995170d32e473c5f8b735cfeb92a134d747b53. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container 9a89e70687022d59f2462352bdc2a35b9aee214ea46b4b79dc341b4efec40225. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container 256a8dd8b825fe0c9a3150aee34f206bcdb05b6c53ca8b6ac8f8bba53cf29a66. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container 7aef2f6149a09d5c245212872e10163a1ce3bde42b124c7f34292959ce481a3e. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container 14f043b5d116710bb40c944f36539e40f71b4e3ce3342b5fbbe1d2ad95352e0f. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container 9d46ba1777907929da58111c8eb2395cdb0075d772b2220a2c384d0762ffaa2d. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container 0bf6bdc34b59b03dd9c8d2c3072cc97c654c0e6543b952335e9c0c5239f6e24e. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container 8761fb715c1c1f3256c1eabc7369c522df7035cdeae8d2318c9d54255f481f36. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container 0289ca597699ae74d2f2f5cece5d8d562f5ecc81d6f5be4499df0280b0052534. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container cc524a453b794007930edb947ace7961599cd49c53f5284cd160959c24df2756. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container f69b3426d225626e3eeeee35bb3883789e7a5fa9021c5d71634428e127433262. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container 6b08996999a17361702654b76b87c30be10423902be1c766c232700510894c29. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container 7fc7cc400b3c4637ba7a7d40eb3dfb5187378ef13ad101033ebea90d4e887228. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container bbf013052d9c817a461945a050833438b23e47e438946a439baafe0ebdc40378. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container ad3a96ae517d7b656b8871af97de256fdb3ac1e761d1966c70d3e10545d10d38. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container 91c006dc61018712ac6d4c2b887b1902c59e4e464e744960d8d2cf010d06136e. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container 2195e9075901616715082bb54da5e42dc024310f02372d44923cd28c991e5646. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container c15257c41b2101031cb1846f3d689a22f0d390feaa3aba414a0e1d4739955324. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container b0e4abbf0723cd45b5c8ddb12fc1db2f84989aa84edf6048548ecec12c3e1a45. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container 9c746dbf708a541eeebc0578883de8126e1a948718fb65060697928761a4360e. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container 25b3c9ce87044625045ce4ba6834266559a957dba021127b9ef3f131e34d1b13. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container d23d757501158458fd45dffa1b09ae2ea5bd21a2544a7468faf08f1378a09521. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container b3bf4016b8b0970119c3d65e39f3b67b92e787ea564ee3111eb893fe3c290a7b. Stop the container before attempting removal or use -f
Error response from daemon: You cannot remove a running container fa1f0ed519e4ab29179a1edceabce637a38b299c1faa7937366a01851e173a51. Stop the container before attempting removal or use -f
Error response from daemon: removal of container 666a0bb1729905419a832005a1a3300fc218506fd331266af15aaf45b98eb921 is already in progress
[INFO] [13:50:43+0000] [CLEANUP] Killing child processes
[INFO] [13:50:43+0000] [CLEANUP] Pruning etcd data directory
rm: cannot remove ‘/tmp/etcd’: Operation not permitted
[INFO] [13:50:43+0000] test/extended/core.sh exited with code 0 after 00h 59m 03s
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: RUN EXTENDED TESTS [01h 10m 22s] ##########
[PostBuildScript] - Execution post build scripts.
[workspace] $ /bin/bash /tmp/jenkins2156443611984371465.sh
########## STARTING STAGE: DOWNLOAD ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2ac8264613c881a254c455aa448c414c3f984c4c
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2ac8264613c881a254c455aa448c414c3f984c4c
++ export PATH=/var/lib/jenkins/origin-ci-tool/2ac8264613c881a254c455aa448c414c3f984c4c/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2ac8264613c881a254c455aa448c414c3f984c4c/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/artifacts/gathered
+ rm -rf /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/artifacts/gathered
+ mkdir -p /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/artifacts/gathered
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /data/src/github.com/openshift/origin/_output/scripts
  File: ‘/data/src/github.com/openshift/origin/_output/scripts’
  Size: 65        	Blocks: 0          IO Block: 4096   directory
Device: ca02h/51714d	Inode: 96683275    Links: 5
Access: (2777/drwxrwsrwx)  Uid: ( 1001/  origin)   Gid: ( 1003/origin-git)
Context: system_u:object_r:svirt_sandbox_file_t:s0
Access: 2018-04-17 12:40:15.115917077 +0000
Modify: 2018-04-17 12:28:18.679510466 +0000
Change: 2018-04-17 12:28:18.679510466 +0000
 Birth: -
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod -R o+rX /data/src/github.com/openshift/origin/_output/scripts
+ scp -r -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel:/data/src/github.com/openshift/origin/_output/scripts /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/artifacts/gathered
+ tree /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/artifacts/gathered
/var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/artifacts/gathered
└── scripts
    ├── ansible_junit
    │   ├── coNYimWIez.xml
    │   ├── SOnyEztBbd.xml
    │   └── TXqmfaGYHu.xml
    ├── build-base-images
    │   ├── artifacts
    │   ├── logs
    │   └── openshift.local.home
    └── shell
        ├── artifacts
        ├── logs
        │   ├── 4dbecc07fd89393f3c3c26b3bf254948a698532299afdc2230a3475cee6eab5f.json
        │   └── scripts.log
        └── openshift.local.home

10 directories, 5 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins8113561448013979480.sh
########## STARTING STAGE: GENERATE ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2ac8264613c881a254c455aa448c414c3f984c4c
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2ac8264613c881a254c455aa448c414c3f984c4c
++ export PATH=/var/lib/jenkins/origin-ci-tool/2ac8264613c881a254c455aa448c414c3f984c4c/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2ac8264613c881a254c455aa448c414c3f984c4c/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/artifacts/generated
+ rm -rf /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/artifacts/generated
+ mkdir /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/artifacts/generated
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo docker version && sudo docker info && sudo docker images && sudo docker ps -a 2>&1'
  WARNING: You're not using the default seccomp profile
WARNING: bridge-nf-call-iptables is disabled
WARNING: bridge-nf-call-ip6tables is disabled
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo cat /etc/etcd/etcd.conf 2>&1'
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo cat /etc/sysconfig/docker /etc/sysconfig/docker-network /etc/sysconfig/docker-storage /etc/sysconfig/docker-storage-setup /etc/systemd/system/docker.service 2>&1'
+ true
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo find /var/lib/docker/containers -name *.log | sudo xargs tail -vn +1 2>&1'
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'oc get --raw /metrics --server=https://$( uname --nodename ):10250 --config=/etc/origin/master/admin.kubeconfig 2>&1'
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo ausearch -m AVC -m SELINUX_ERR -m USER_AVC 2>&1'
+ true
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'oc get --raw /metrics --config=/etc/origin/master/admin.kubeconfig 2>&1'
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo df -T -h && sudo pvs && sudo vgs && sudo lvs && sudo findmnt --all 2>&1'
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo yum list installed 2>&1'
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo journalctl --dmesg --no-pager --all --lines=all 2>&1'
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo journalctl _PID=1 --no-pager --all --lines=all 2>&1'
+ tree /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/artifacts/generated
/var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/artifacts/generated
├── avc_denials.log
├── containers.log
├── dmesg.log
├── docker.config
├── docker.info
├── etcd.conf
├── filesystem.info
├── installed_packages.log
├── master-metrics.log
├── node-metrics.log
└── pid1.journal

0 directories, 11 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins8971249462011707723.sh
########## STARTING STAGE: FETCH SYSTEMD JOURNALS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2ac8264613c881a254c455aa448c414c3f984c4c
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2ac8264613c881a254c455aa448c414c3f984c4c
++ export PATH=/var/lib/jenkins/origin-ci-tool/2ac8264613c881a254c455aa448c414c3f984c4c/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2ac8264613c881a254c455aa448c414c3f984c4c/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/artifacts/journals
+ rm -rf /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/artifacts/journals
+ mkdir /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/artifacts/journals
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit docker.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit dnsmasq.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit systemd-journald.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit origin-master.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit origin-master-api.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit origin-master-controllers.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit origin-node.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit openvswitch.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit ovs-vswitchd.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit ovsdb-server.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit etcd.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit systemd-journald.service --no-pager --all --lines=all
+ tree /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/artifacts/journals
/var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/artifacts/journals
├── dnsmasq.service
├── docker.service
├── etcd.service
├── openvswitch.service
├── origin-master-api.service
├── origin-master-controllers.service
├── origin-master.service
├── origin-node.service
├── ovsdb-server.service
├── ovs-vswitchd.service
└── systemd-journald.service

0 directories, 11 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins3426741933644502466.sh
########## STARTING STAGE: ASSEMBLE GCS OUTPUT ##########
+ [[ -s /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2ac8264613c881a254c455aa448c414c3f984c4c
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2ac8264613c881a254c455aa448c414c3f984c4c
++ export PATH=/var/lib/jenkins/origin-ci-tool/2ac8264613c881a254c455aa448c414c3f984c4c/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2ac8264613c881a254c455aa448c414c3f984c4c/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/.config
+ trap 'exit 0' EXIT
+ mkdir -p gcs/artifacts gcs/artifacts/generated gcs/artifacts/journals gcs/artifacts/gathered
++ python -c 'import json; import urllib; print json.load(urllib.urlopen('\''https://ci.openshift.redhat.com/jenkins/job/test_branch_origin_extended_builds_19332/8/api/json'\''))['\''result'\'']'
+ result=SUCCESS
+ cat
++ date +%s
+ cat /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/builds/8/log
+ cp artifacts/generated/avc_denials.log artifacts/generated/containers.log artifacts/generated/dmesg.log artifacts/generated/docker.config artifacts/generated/docker.info artifacts/generated/etcd.conf artifacts/generated/filesystem.info artifacts/generated/installed_packages.log artifacts/generated/master-metrics.log artifacts/generated/node-metrics.log artifacts/generated/pid1.journal gcs/artifacts/generated/
+ cp artifacts/journals/dnsmasq.service artifacts/journals/docker.service artifacts/journals/etcd.service artifacts/journals/openvswitch.service artifacts/journals/origin-master-api.service artifacts/journals/origin-master-controllers.service artifacts/journals/origin-master.service artifacts/journals/origin-node.service artifacts/journals/ovsdb-server.service artifacts/journals/ovs-vswitchd.service artifacts/journals/systemd-journald.service gcs/artifacts/journals/
+ cp -r artifacts/gathered/scripts gcs/artifacts/
++ pwd
+ scp -F ./.config/origin-ci-tool/inventory/.ssh_config -r /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/gcs openshiftdevel:/data
+ scp -F ./.config/origin-ci-tool/inventory/.ssh_config /var/lib/jenkins/.config/gcloud/gcs-publisher-credentials.json openshiftdevel:/data/credentials.json
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins9144879945192144134.sh
########## STARTING STAGE: PUSH THE ARTIFACTS AND METADATA ##########
+ [[ -s /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2ac8264613c881a254c455aa448c414c3f984c4c
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/2ac8264613c881a254c455aa448c414c3f984c4c
++ export PATH=/var/lib/jenkins/origin-ci-tool/2ac8264613c881a254c455aa448c414c3f984c4c/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/2ac8264613c881a254c455aa448c414c3f984c4c/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_branch_origin_extended_builds_19332/workspace/.config
++ mktemp
+ script=/tmp/tmp.khgFfZRnow
+ cat
+ chmod +x /tmp/tmp.khgFfZRnow
+ scp -F ./.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.khgFfZRnow openshiftdevel:/tmp/tmp.khgFfZRnow
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 300 /tmp/tmp.khgFfZRnow"'
+ cd /home/origin
+ trap 'exit 0' EXIT
+ [[ -n {"type":"periodic","job":"test_branch_origin_extended_builds_debug","buildid":"8","refs":{}} ]]
++ jq --compact-output .buildid
+ [[ "8" =~ ^"[0-9]+"$ ]]
Keeping BUILD_ID
+ echo 'Keeping BUILD_ID'
+ docker run -e 'JOB_SPEC={"type":"periodic","job":"test_branch_origin_extended_builds_debug","buildid":"8","refs":{}}' -v /data:/data:z registry.svc.ci.openshift.org/ci/gcsupload:latest --dry-run=false --gcs-bucket=origin-ci-test --gcs-credentials-file=/data/credentials.json --path-strategy=single --default-org=openshift --default-repo=origin /data/gcs/artifacts /data/gcs/build-log.txt /data/gcs/finished.json
Unable to find image 'registry.svc.ci.openshift.org/ci/gcsupload:latest' locally
Trying to pull repository registry.svc.ci.openshift.org/ci/gcsupload ... 
latest: Pulling from registry.svc.ci.openshift.org/ci/gcsupload
6d987f6f4279: Already exists
4cccebe844ee: Already exists
deb4d9262c8e: Pulling fs layer
deb4d9262c8e: Verifying Checksum
deb4d9262c8e: Download complete
deb4d9262c8e: Pull complete
Digest: sha256:937cfc74efbe5f99ac6b54a8837ce0c1ba72f9f12cf4bf484c6fb7323727f623
Status: Downloaded newer image for registry.svc.ci.openshift.org/ci/gcsupload:latest
{"component":"gcsupload","level":"info","msg":"Gathering artifacts from artifact directory: /data/gcs/artifacts","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/avc_denials.log in artifact directory. Uploading as artifacts/generated/avc_denials.log\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/containers.log in artifact directory. Uploading as artifacts/generated/containers.log\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/dmesg.log in artifact directory. Uploading as artifacts/generated/dmesg.log\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/docker.config in artifact directory. Uploading as artifacts/generated/docker.config\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/docker.info in artifact directory. Uploading as artifacts/generated/docker.info\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/etcd.conf in artifact directory. Uploading as artifacts/generated/etcd.conf\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/filesystem.info in artifact directory. Uploading as artifacts/generated/filesystem.info\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/installed_packages.log in artifact directory. Uploading as artifacts/generated/installed_packages.log\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/master-metrics.log in artifact directory. Uploading as artifacts/generated/master-metrics.log\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/node-metrics.log in artifact directory. Uploading as artifacts/generated/node-metrics.log\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/pid1.journal in artifact directory. Uploading as artifacts/generated/pid1.journal\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/journals/dnsmasq.service in artifact directory. Uploading as artifacts/journals/dnsmasq.service\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/journals/docker.service in artifact directory. Uploading as artifacts/journals/docker.service\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/journals/etcd.service in artifact directory. Uploading as artifacts/journals/etcd.service\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/journals/openvswitch.service in artifact directory. Uploading as artifacts/journals/openvswitch.service\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/journals/origin-master-api.service in artifact directory. Uploading as artifacts/journals/origin-master-api.service\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/journals/origin-master-controllers.service in artifact directory. Uploading as artifacts/journals/origin-master-controllers.service\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/journals/origin-master.service in artifact directory. Uploading as artifacts/journals/origin-master.service\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/journals/origin-node.service in artifact directory. Uploading as artifacts/journals/origin-node.service\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/journals/ovs-vswitchd.service in artifact directory. Uploading as artifacts/journals/ovs-vswitchd.service\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/journals/ovsdb-server.service in artifact directory. Uploading as artifacts/journals/ovsdb-server.service\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/journals/systemd-journald.service in artifact directory. Uploading as artifacts/journals/systemd-journald.service\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/ansible_junit/SOnyEztBbd.xml in artifact directory. Uploading as artifacts/scripts/ansible_junit/SOnyEztBbd.xml\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/ansible_junit/TXqmfaGYHu.xml in artifact directory. Uploading as artifacts/scripts/ansible_junit/TXqmfaGYHu.xml\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/ansible_junit/coNYimWIez.xml in artifact directory. Uploading as artifacts/scripts/ansible_junit/coNYimWIez.xml\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/shell/logs/4dbecc07fd89393f3c3c26b3bf254948a698532299afdc2230a3475cee6eab5f.json in artifact directory. Uploading as artifacts/scripts/shell/logs/4dbecc07fd89393f3c3c26b3bf254948a698532299afdc2230a3475cee6eab5f.json\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/shell/logs/scripts.log in artifact directory. Uploading as artifacts/scripts/shell/logs/scripts.log\n","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/docker.info","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/ovsdb-server.service","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/containers.log","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/master-metrics.log","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/node-metrics.log","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/origin-master-api.service","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/scripts/shell/logs/4dbecc07fd89393f3c3c26b3bf254948a698532299afdc2230a3475cee6eab5f.json","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/latest-build.txt","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/openvswitch.service","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/finished.json","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/dmesg.log","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/dnsmasq.service","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/ovs-vswitchd.service","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/systemd-journald.service","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/scripts/ansible_junit/SOnyEztBbd.xml","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/origin-master-controllers.service","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/origin-node.service","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/avc_denials.log","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/filesystem.info","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/origin-master.service","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/scripts/shell/logs/scripts.log","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/etcd.conf","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/pid1.journal","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/docker.service","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/scripts/ansible_junit/coNYimWIez.xml","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/docker.config","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/installed_packages.log","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/etcd.service","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/scripts/ansible_junit/TXqmfaGYHu.xml","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/build-log.txt","level":"info","msg":"Queued for upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/origin-master-api.service","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/ovsdb-server.service","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/filesystem.info","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/etcd.conf","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/scripts/ansible_junit/coNYimWIez.xml","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/systemd-journald.service","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/scripts/ansible_junit/SOnyEztBbd.xml","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/pid1.journal","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/master-metrics.log","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/docker.info","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/origin-master-controllers.service","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/latest-build.txt","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/docker.config","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/dnsmasq.service","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/scripts/shell/logs/scripts.log","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/openvswitch.service","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/avc_denials.log","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/node-metrics.log","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/scripts/shell/logs/4dbecc07fd89393f3c3c26b3bf254948a698532299afdc2230a3475cee6eab5f.json","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/finished.json","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/installed_packages.log","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/origin-master.service","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/docker.service","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/etcd.service","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/scripts/ansible_junit/TXqmfaGYHu.xml","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/dmesg.log","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/build-log.txt","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:29Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/ovs-vswitchd.service","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:30Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/generated/containers.log","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:30Z"}
{"component":"gcsupload","dest":"logs/test_branch_origin_extended_builds_debug/8/artifacts/journals/origin-node.service","level":"info","msg":"Finished upload","time":"2018-04-17T13:56:31Z"}
{"component":"gcsupload","level":"info","msg":"Finished upload to GCS","time":"2018-04-17T13:56:31Z"}
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: PUSH THE ARTIFACTS AND METADATA [00h 00m 33s] ##########
[workspace] $ /bin/bash /tmp/jenkins303903749595998560.sh
oct deprovision
Archiving artifacts
Recording test results
[WS-CLEANUP] Deleting project workspace...[WS-CLEANUP] done
Finished: SUCCESS