Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

[builds][Conformance] build without output image fails with error Expected <bool>: false to be true #14328

Closed
php-coder opened this issue May 24, 2017 · 11 comments
Closed

[builds][Conformance] build without output image fails with error Expected <bool>: false to be true #14328

php-coder opened this issue May 24, 2017 · 11 comments
Labels
kind/test-flake Categorizes issue or PR as related to test flakes.

Comments

@php-coder
Copy link
Contributor

php-coder commented May 24, 2017 •
edited
Loading

I suspect that the cause is this:

2017-05-24T14:13:31.963637000Z Installing tzinfo 1.2.2
2017-05-24T14:13:32.023798000Z Gem::RemoteFetcher::FetchError: Errno::ECONNRESET: Connection reset by peer - SSL_connect (https://rubygems.org/gems/activesupport-4.1.7.gem)
2017-05-24T14:13:32.032618000Z An error occurred while installing activesupport (4.1.7), and Bundler cannot
2017-05-24T14:13:32.032873000Z continue.
2017-05-24T14:13:32.033131000Z Make sure that `gem install activesupport -v '4.1.7'` succeeds before bundling.
2017-05-24T14:13:32.284752000Z F0524 14:13:32.284108       1 helpers.go:116] error: build error: The command '/bin/sh -c scl enable rh-ruby22 "bundle install"' returned a non-zero code: 5
[builds][Conformance] build without output image building from templates should create an image from a docker template without an output image reference defined /openshifttmp/openshift/build-rpm-release/tito/rpmbuild-originZlb6Es/BUILD/origin-3.6.0/_output/local/go/src/github.com/openshift/origin/test/extended/builds/no_outputname.go:36

[BeforeEach] [Top Level]
/openshifttmp/openshift/build-rpm-release/tito/rpmbuild-originZlb6Es/BUILD/origin-3.6.0/_output/local/go/src/github.com/openshift/origin/test/extended/util/test.go:51
[BeforeEach] [builds][Conformance] build without output image
/openshifttmp/openshift/build-rpm-release/tito/rpmbuild-originZlb6Es/BUILD/origin-3.6.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:120
STEP: Creating a kubernetes client
May 24 10:11:53.220: INFO: >>> kubeConfig: /tmp/cluster-admin.kubeconfig

STEP: Building a namespace api object
May 24 10:11:53.968: INFO: configPath is now "extended-test-build-no-outputname-0l1zl-3f5xx-user.kubeconfig"
May 24 10:11:53.968: INFO: The user is now "extended-test-build-no-outputname-0l1zl-3f5xx-user"
May 24 10:11:53.968: INFO: Creating project "extended-test-build-no-outputname-0l1zl-3f5xx"
STEP: Waiting for a default service account to be provisioned in namespace
[It] should create an image from a docker template without an output image reference defined
/openshifttmp/openshift/build-rpm-release/tito/rpmbuild-originZlb6Es/BUILD/origin-3.6.0/_output/local/go/src/github.com/openshift/origin/test/extended/builds/no_outputname.go:36
May 24 10:11:56.700: INFO: Running 'oc create --config=extended-test-build-no-outputname-0l1zl-3f5xx-user.kubeconfig --namespace=extended-test-build-no-outputname-0l1zl-3f5xx -f /tmp/fixture-testdata-dir240644369/test/extended/testdata/test-docker-no-outputname.json'
buildconfig "test-docker" created
STEP: expecting build to pass without an output image reference specified
May 24 10:11:58.907: INFO: Running 'oc start-build --config=extended-test-build-no-outputname-0l1zl-3f5xx-user.kubeconfig --namespace=extended-test-build-no-outputname-0l1zl-3f5xx test-docker -o=name'

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

Waiting for test-docker-1 to complete
WaitForABuild returning with error: The build "test-docker-1" status is "Failed"Done waiting for test-docker-1: util.BuildResult{BuildPath:"build/test-docker-1", BuildName:"test-docker-1", StartBuildStdErr:"", StartBuildStdOut:"build/test-docker-1", StartBuildErr:error(nil), BuildConfigName:"", Build:(*api.Build)(0xc421526dc0), BuildAttempt:true, BuildSuccess:false, BuildFailure:true, BuildCancelled:false, BuildTimeout:false, LogDumper:(util.LogDumperFunc)(nil), oc:(*util.CLI)(0xc420247e00)}
with error: The build "test-docker-1" status is "Failed"

Dumping Build Result: util.BuildResult{BuildPath:"build/test-docker-1", BuildName:"test-docker-1", StartBuildStdErr:"", StartBuildStdOut:"build/test-docker-1", StartBuildErr:error(nil), BuildConfigName:"", Build:(*api.Build)(0xc421526dc0), BuildAttempt:true, BuildSuccess:false, BuildFailure:true, BuildCancelled:false, BuildTimeout:false, LogDumper:(util.LogDumperFunc)(nil), oc:(*util.CLI)(0xc420247e00)}
May 24 10:13:35.552: INFO: Running 'oc describe --config=extended-test-build-no-outputname-0l1zl-3f5xx-user.kubeconfig --namespace=extended-test-build-no-outputname-0l1zl-3f5xx build/test-docker-1'

** Build Description:
Name: test-docker-1
Namespace: extended-test-build-no-outputname-0l1zl-3f5xx
Created: About a minute ago
Labels: buildconfig=test-docker
name=test-docker
openshift.io/build-config.name=test-docker
openshift.io/build.start-policy=Serial
Annotations: openshift.io/build-config.name=test-docker
openshift.io/build.number=1
openshift.io/build.pod-name=test-docker-1-build

Status: Failed (Docker build strategy has failed.)
Started: Wed, 24 May 2017 10:11:59 EDT
Duration: 1m33s

Build Config: test-docker
Build Pod: test-docker-1-build

Strategy: Docker
URL: https://github.com/openshift/ruby-hello-world
Commit: 022d87e (Merge pull request #58 from junaruga/feature/fix-for-ruby24)
Author/Committer: Ben Parees / GitHub
From Image: DockerImage centos/ruby-22-centos7

Build trigger cause: Manually triggered

Events:
FirstSeen LastSeen Count From SubObjectPath Type Reason Message

1m 1m 1 default-scheduler Normal Scheduled Successfully assigned test-docker-1-build to ci-prtest-5a37c28-2399-ig-n-bzv8
1m 1m 1 kubelet, ci-prtest-5a37c28-2399-ig-n-bzv8 spec.containers{docker-build} Normal Pulling pulling image "openshift/origin-docker-builder:v3.6.0-alpha.1"
50s 50s 1 kubelet, ci-prtest-5a37c28-2399-ig-n-bzv8 spec.containers{docker-build} Normal Pulled Successfully pulled image "openshift/origin-docker-builder:v3.6.0-alpha.1"
50s 50s 1 kubelet, ci-prtest-5a37c28-2399-ig-n-bzv8 spec.containers{docker-build} Normal Created Created container with id 67ef951eba73994fbc2d8240178e2945ba17e47b0aef020356de677c6c2e8d6d
49s 49s 1 build-pod-controller Normal BuildStarted Build extended-test-build-no-outputname-0l1zl-3f5xx/test-docker-1 is now running
49s 49s 1 kubelet, ci-prtest-5a37c28-2399-ig-n-bzv8 spec.containers{docker-build} Normal Started Started container with id 67ef951eba73994fbc2d8240178e2945ba17e47b0aef020356de677c6c2e8d6d
4s 4s 1 build-pod-controller Normal BuildFailed Build extended-test-build-no-outputname-0l1zl-3f5xx/test-docker-1 failed

** Build Logs:
May 24 10:13:36.260: INFO: Running 'oc logs --config=extended-test-build-no-outputname-0l1zl-3f5xx-user.kubeconfig --namespace=extended-test-build-no-outputname-0l1zl-3f5xx -f build/test-docker-1 --timestamps'
2017-05-24T14:12:47.241201000Z I0524 14:12:47.240289 1 builder.go:52] $BUILD env var is {"kind":"Build","apiVersion":"v1","metadata":{"name":"test-docker-1","namespace":"extended-test-build-no-outputname-0l1zl-3f5xx","selfLink":"/oapi/v1/namespaces/extended-test-build-no-outputname-0l1zl-3f5xx/builds/test-docker-1","uid":"f38b565c-408a-11e7-81ee-42010a800003","resourceVersion":"2579","creationTimestamp":"2017-05-24T14:11:59Z","labels":{"buildconfig":"test-docker","name":"test-docker","openshift.io/build-config.name":"test-docker","openshift.io/build.start-policy":"Serial"},"annotations":{"openshift.io/build-config.name":"test-docker","openshift.io/build.number":"1"},"ownerReferences":[{"apiVersion":"v1","kind":"BuildConfig","name":"test-docker","uid":"f33dce94-408a-11e7-81ee-42010a800003","controller":true}]},"spec":{"serviceAccount":"builder","source":{"type":"Git","git":{"uri":"https://github.com/openshift/ruby-hello-world"}},"strategy":{"type":"Docker","dockerStrategy":{"from":{"kind":"DockerImage","name":"centos/ruby-22-centos7"},"env":[{"name":"BUILD_LOGLEVEL","value":"5"}]}},"output":{},"resources":{},"postCommit":{},"nodeSelector":null,"triggeredBy":[{"message":"Manually triggered"}]},"status":{"phase":"New","config":{"kind":"BuildConfig","namespace":"extended-test-build-no-outputname-0l1zl-3f5xx","name":"test-docker"},"output":{}}}
2017-05-24T14:12:47.242793000Z
2017-05-24T14:12:47.244172000Z I0524 14:12:47.241316 1 builder.go:60] Build: &api.Build{TypeMeta:unversioned.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:api.ObjectMeta{Name:"test-docker-1", GenerateName:"", Namespace:"extended-test-build-no-outputname-0l1zl-3f5xx", SelfLink:"/oapi/v1/namespaces/extended-test-build-no-outputname-0l1zl-3f5xx/builds/test-docker-1", UID:"f38b565c-408a-11e7-81ee-42010a800003", ResourceVersion:"2579", Generation:0, CreationTimestamp:unversioned.Time{Time:time.Time{sec:63631231919, nsec:0, loc:(*time.Location)(0xb246500)}}, DeletionTimestamp:(*unversioned.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string{"openshift.io/build-config.name":"test-docker", "openshift.io/build.start-policy":"Serial", "buildconfig":"test-docker", "name":"test-docker"}, Annotations:map[string]string{"openshift.io/build-config.name":"test-docker", "openshift.io/build.number":"1"}, OwnerReferences:[]api.OwnerReference{api.OwnerReference{APIVersion:"v1", Kind:"BuildConfig", Name:"test-docker", UID:"f33dce94-408a-11e7-81ee-42010a800003", Controller:(*bool)(0xc42023a21a)}}, Finalizers:[]string(nil), ClusterName:""}, Spec:api.BuildSpec{CommonSpec:api.CommonSpec{ServiceAccount:"builder", Source:api.BuildSource{Binary:(*api.BinaryBuildSource)(nil), Dockerfile:(*string)(nil), Git:(*api.GitBuildSource)(0xc420937500), Images:[]api.ImageSource(nil), ContextDir:"", SourceSecret:(*api.LocalObjectReference)(nil), Secrets:[]api.SecretBuildSource(nil)}, Revision:(*api.SourceRevision)(nil), Strategy:api.BuildStrategy{DockerStrategy:(*api.DockerBuildStrategy)(0xc420a45960), SourceStrategy:(*api.SourceBuildStrategy)(nil), CustomStrategy:(*api.CustomBuildStrategy)(nil), JenkinsPipelineStrategy:(*api.JenkinsPipelineBuildStrategy)(nil)}, Output:api.BuildOutput{To:(*api.ObjectReference)(nil), PushSecret:(*api.LocalObjectReference)(nil), ImageLabels:[]api.ImageLabel(nil)}, Resources:api.ResourceRequirements{Limits:api.ResourceList(nil), Requests:api.ResourceList(nil)}, PostCommit:api.BuildPostCommitSpec{Command:[]string(nil), Args:[]string(nil), Script:""}, CompletionDeadlineSeconds:(*int64)(nil), NodeSelector:map[string]string(nil)}, TriggeredBy:[]api.BuildTriggerCause{api.BuildTriggerCause{Message:"Manually triggered", GenericWebHook:(*api.GenericWebHookCause)(nil), GitHubWebHook:(*api.GitHubWebHookCause)(nil), ImageChangeBuild:(*api.ImageChangeCause)(nil), GitLabWebHook:(*api.GitLabWebHookCause)(nil), BitbucketWebHook:(*api.BitbucketWebHookCause)(nil)}}}, Status:api.BuildStatus{Phase:"New", Cancelled:false, Reason:"", Message:"", StartTimestamp:(*unversioned.Time)(nil), CompletionTimestamp:(*unversioned.Time)(nil), Duration:0, OutputDockerImageReference:"", Config:(*api.ObjectReference)(0xc420a45a40), Output:api.BuildStatusOutput{To:(*api.BuildStatusOutputTo)(nil)}}}
2017-05-24T14:12:47.246052000Z I0524 14:12:47.241540 1 builder.go:65] warning: OpenShift server version "v3.6.0-alpha.1+c73e831-805" differs from this image "v3.6.0-alpha.1+46942ad"
2017-05-24T14:12:47.246269000Z I0524 14:12:47.242695 1 builder.go:158] Running build with cgroup limits: api.CGroupLimits{MemoryLimitBytes:92233720368547, CPUShares:2, CPUPeriod:100000, CPUQuota:-1, MemorySwap:92233720368547}
2017-05-24T14:12:47.246492000Z Cloning "https://github.com/openshift/ruby-hello-world" ...
2017-05-24T14:12:47.246698000Z I0524 14:12:47.242956 1 source.go:134] git ls-remote --heads https://github.com/openshift/ruby-hello-world
2017-05-24T14:12:47.246900000Z I0524 14:12:47.242973 1 repository.go:367] Executing git ls-remote --heads https://github.com/openshift/ruby-hello-world
2017-05-24T14:12:47.591498000Z I0524 14:12:47.590745 1 source.go:137] cf1fa898d2a78685ccde72f14b4922b474f73cd1 refs/heads/beta2
2017-05-24T14:12:47.591788000Z 2602ace61490de0513dfbd7c7de949356cf9bd17 refs/heads/beta3
2017-05-24T14:12:47.592028000Z 53023145a2a59a5ee4d3aea7e62320bac08104c4 refs/heads/beta4
2017-05-24T14:12:47.592260000Z 11e9bbac1dcf5a06df07f5a6ab893a3cb9448011 refs/heads/blog_part1
2017-05-24T14:12:47.592561000Z 5619f11232c0a623f7da419438539335d49acfa3 refs/heads/config
2017-05-24T14:12:47.592828000Z 022d87e4160c00274b63cdad7c238b5c6a299265 refs/heads/master
2017-05-24T14:12:47.593088000Z I0524 14:12:47.590772 1 source.go:236] Cloning source from https://github.com/openshift/ruby-hello-world
2017-05-24T14:12:47.593363000Z I0524 14:12:47.590807 1 repository.go:367] Executing git clone --recursive --depth=1 https://github.com/openshift/ruby-hello-world /tmp/docker-build147147903
2017-05-24T14:12:48.261892000Z I0524 14:12:48.260763 1 repository.go:367] Executing git rev-parse --abbrev-ref HEAD
2017-05-24T14:12:48.265063000Z I0524 14:12:48.263070 1 repository.go:367] Executing git rev-parse --verify HEAD
2017-05-24T14:12:48.266627000Z I0524 14:12:48.264915 1 repository.go:367] Executing git --no-pager show -s --format=%an HEAD
2017-05-24T14:12:48.267619000Z I0524 14:12:48.267136 1 repository.go:367] Executing git --no-pager show -s --format=%ae HEAD
2017-05-24T14:12:48.270471000Z I0524 14:12:48.269587 1 repository.go:367] Executing git --no-pager show -s --format=%cn HEAD
2017-05-24T14:12:48.272417000Z I0524 14:12:48.271670 1 repository.go:367] Executing git --no-pager show -s --format=%ce HEAD
2017-05-24T14:12:48.274160000Z I0524 14:12:48.273750 1 repository.go:367] Executing git --no-pager show -s --format=%ad HEAD
2017-05-24T14:12:48.276769000Z I0524 14:12:48.276234 1 repository.go:367] Executing git --no-pager show -s --format=%<(80,trunc)%s HEAD
2017-05-24T14:12:48.279382000Z I0524 14:12:48.279019 1 repository.go:367] Executing git config --get remote.origin.url
2017-05-24T14:12:48.281314000Z Commit: 022d87e4160c00274b63cdad7c238b5c6a299265 (Merge pull request #58 from junaruga/feature/fix-for-ruby24)
2017-05-24T14:12:48.281589000Z Author: Ben Parees [email protected]
2017-05-24T14:12:48.281884000Z Date: Fri Mar 3 15:29:12 2017 -0500
2017-05-24T14:12:48.282106000Z I0524 14:12:48.280927 1 repository.go:367] Executing git rev-parse --abbrev-ref HEAD
2017-05-24T14:12:48.283598000Z I0524 14:12:48.282789 1 repository.go:367] Executing git rev-parse --verify HEAD
2017-05-24T14:12:48.285359000Z I0524 14:12:48.284597 1 repository.go:367] Executing git --no-pager show -s --format=%an HEAD
2017-05-24T14:12:48.288710000Z I0524 14:12:48.287837 1 repository.go:367] Executing git --no-pager show -s --format=%ae HEAD
2017-05-24T14:12:48.290325000Z I0524 14:12:48.289912 1 repository.go:367] Executing git --no-pager show -s --format=%cn HEAD
2017-05-24T14:12:48.292647000Z I0524 14:12:48.292274 1 repository.go:367] Executing git --no-pager show -s --format=%ce HEAD
2017-05-24T14:12:48.295575000Z I0524 14:12:48.294815 1 repository.go:367] Executing git --no-pager show -s --format=%ad HEAD
2017-05-24T14:12:48.297790000Z I0524 14:12:48.297011 1 repository.go:367] Executing git --no-pager show -s --format=%<(80,trunc)%s HEAD
2017-05-24T14:12:48.299965000Z I0524 14:12:48.299230 1 repository.go:367] Executing git config --get remote.origin.url
2017-05-24T14:12:48.301620000Z I0524 14:12:48.301097 1 docker.go:87] Setting build revision with details &git.SourceInfo{SourceInfo:api.SourceInfo{Ref:"master", CommitID:"022d87e4160c00274b63cdad7c238b5c6a299265", Date:"Fri Mar 3 15:29:12 2017 -0500", AuthorName:"Ben Parees", AuthorEmail:"[email protected]", CommitterName:"GitHub", CommitterEmail:"[email protected]", Message:"Merge pull request #58 from junaruga/feature/fix-for-ruby24", Location:"https://github.com/openshift/ruby-hello-world", ContextDir:""}}
2017-05-24T14:12:48.351762000Z I0524 14:12:48.351072 1 docker.go:95] Starting Docker build from build config test-docker-1 ...
2017-05-24T14:12:48.356208000Z I0524 14:12:48.355663 1 cfg.go:44] Locating docker auth for image centos/ruby-22-centos7 and type PULL_DOCKERCFG_PATH
2017-05-24T14:12:48.356496000Z I0524 14:12:48.355774 1 cfg.go:112] Using Docker authentication configuration in '/root/.docker/config.json'
2017-05-24T14:12:48.356881000Z I0524 14:12:48.355810 1 cfg.go:56] Problem accessing /root/.docker/config.json: stat /root/.docker/config.json: no such file or directory
2017-05-24T14:12:48.357351000Z Pulling image centos/ruby-22-centos7 ...
2017-05-24T14:12:48.359761000Z Trying to pull repository registry.access.redhat.com/centos/ruby-22-centos7 ...
2017-05-24T14:12:48.906093000Z Trying to pull repository docker.io/centos/ruby-22-centos7 ...
2017-05-24T14:12:50.605745000Z sha256:0c2d134e77711d3d02f402b90827393c77d66a6fd49d231ccc461fbe6984cf2c: Pulling from docker.io/centos/ruby-22-centos7
2017-05-24T14:12:50.654917000Z 93857f76ae30: Pulling fs layer
2017-05-24T14:12:50.655219000Z 25284fed5dac: Pulling fs layer
2017-05-24T14:12:50.655495000Z 2ac1cefa07c4: Pulling fs layer
2017-05-24T14:12:50.655739000Z fb497eecae80: Pulling fs layer
2017-05-24T14:12:50.655945000Z 257cd8bddd2c: Pulling fs layer
2017-05-24T14:12:50.656151000Z 92764f9e7e5e: Pulling fs layer
2017-05-24T14:12:50.656380000Z 080a2434e3c4: Pulling fs layer
2017-05-24T14:12:50.656622000Z 1176015121cd: Pulling fs layer
2017-05-24T14:12:50.657426000Z 92764f9e7e5e: Waiting
2017-05-24T14:12:50.657709000Z 080a2434e3c4: Waiting
2017-05-24T14:12:50.657984000Z 1176015121cd: Waiting
2017-05-24T14:12:50.658268000Z fb497eecae80: Waiting
2017-05-24T14:12:50.658564000Z 257cd8bddd2c: Waiting
2017-05-24T14:12:51.009981000Z 25284fed5dac: Verifying Checksum
2017-05-24T14:12:51.010312000Z 25284fed5dac: Download complete
2017-05-24T14:12:51.362212000Z fb497eecae80: Verifying Checksum
2017-05-24T14:12:51.362527000Z fb497eecae80: Download complete
2017-05-24T14:12:52.441742000Z 2ac1cefa07c4: Verifying Checksum
2017-05-24T14:12:52.442340000Z 2ac1cefa07c4: Download complete
2017-05-24T14:12:52.487720000Z 257cd8bddd2c: Verifying Checksum
2017-05-24T14:12:52.487998000Z 257cd8bddd2c: Download complete
2017-05-24T14:12:52.802756000Z 92764f9e7e5e: Verifying Checksum
2017-05-24T14:12:52.803108000Z 92764f9e7e5e: Download complete
2017-05-24T14:12:52.860293000Z 080a2434e3c4: Verifying Checksum
2017-05-24T14:12:52.860612000Z 080a2434e3c4: Download complete
2017-05-24T14:12:53.191966000Z 1176015121cd: Verifying Checksum
2017-05-24T14:12:53.192257000Z 1176015121cd: Download complete
2017-05-24T14:12:57.192742000Z 93857f76ae30: Verifying Checksum
2017-05-24T14:12:57.193113000Z 93857f76ae30: Download complete
2017-05-24T14:13:05.863613000Z 93857f76ae30: Pull complete
2017-05-24T14:13:05.944703000Z 25284fed5dac: Pull complete
2017-05-24T14:13:17.187496000Z 2ac1cefa07c4: Pull complete
2017-05-24T14:13:17.543551000Z fb497eecae80: Pull complete
2017-05-24T14:13:22.243050000Z 257cd8bddd2c: Pull complete
2017-05-24T14:13:22.332969000Z 92764f9e7e5e: Pull complete
2017-05-24T14:13:22.419097000Z 080a2434e3c4: Pull complete
2017-05-24T14:13:22.513076000Z 1176015121cd: Pull complete
2017-05-24T14:13:22.537735000Z Digest: sha256:0c2d134e77711d3d02f402b90827393c77d66a6fd49d231ccc461fbe6984cf2c
2017-05-24T14:13:22.541648000Z Status: Downloaded newer image for docker.io/centos/ruby-22-centos7:latest
2017-05-24T14:13:22.550291000Z I0524 14:13:22.549716 1 dockerutil.go:175] Invoking Docker build to create "extended-test-build-no-outputname-0l1zl-3f5xx/test-docker-1:f7821cd8"
2017-05-24T14:13:22.550817000Z I0524 14:13:22.550214 1 tar.go:200] Adding "/tmp/docker-build147147903" to tar ...
2017-05-24T14:13:22.552229000Z I0524 14:13:22.551748 1 tar.go:286] Adding to tar: /tmp/docker-build147147903/.gitignore as .gitignore
2017-05-24T14:13:22.632686000Z I0524 14:13:22.628493 1 tar.go:286] Adding to tar: /tmp/docker-build147147903/.s2i/bin/README as .s2i/bin/README
2017-05-24T14:13:22.633014000Z I0524 14:13:22.628637 1 tar.go:286] Adding to tar: /tmp/docker-build147147903/.s2i/environment as .s2i/environment
2017-05-24T14:13:22.640598000Z I0524 14:13:22.628709 1 tar.go:286] Adding to tar: /tmp/docker-build147147903/Dockerfile as Dockerfile
2017-05-24T14:13:22.641043000Z I0524 14:13:22.628777 1 tar.go:286] Adding to tar: /tmp/docker-build147147903/Gemfile as Gemfile
2017-05-24T14:13:22.641294000Z I0524 14:13:22.628841 1 tar.go:286] Adding to tar: /tmp/docker-build147147903/Gemfile.lock as Gemfile.lock
2017-05-24T14:13:22.641609000Z I0524 14:13:22.628896 1 tar.go:286] Adding to tar: /tmp/docker-build147147903/README.md as README.md
2017-05-24T14:13:22.641838000Z I0524 14:13:22.628966 1 tar.go:286] Adding to tar: /tmp/docker-build147147903/Rakefile as Rakefile
2017-05-24T14:13:22.642081000Z I0524 14:13:22.629030 1 tar.go:286] Adding to tar: /tmp/docker-build147147903/app.rb as app.rb
2017-05-24T14:13:22.642504000Z I0524 14:13:22.629118 1 tar.go:286] Adding to tar: /tmp/docker-build147147903/config/database.rb as config/database.rb
2017-05-24T14:13:22.642964000Z I0524 14:13:22.629181 1 tar.go:286] Adding to tar: /tmp/docker-build147147903/config/database.yml as config/database.yml
2017-05-24T14:13:22.643212000Z I0524 14:13:22.629238 1 tar.go:286] Adding to tar: /tmp/docker-build147147903/config.ru as config.ru
2017-05-24T14:13:22.643508000Z I0524 14:13:22.629379 1 tar.go:286] Adding to tar: /tmp/docker-build147147903/db/migrate/20141102191902_create_key_pair.rb as db/migrate/20141102191902_create_key_pair.rb
2017-05-24T14:13:22.643894000Z I0524 14:13:22.629442 1 tar.go:286] Adding to tar: /tmp/docker-build147147903/models.rb as models.rb
2017-05-24T14:13:22.644128000Z I0524 14:13:22.629500 1 tar.go:286] Adding to tar: /tmp/docker-build147147903/run.sh as run.sh
2017-05-24T14:13:22.644385000Z I0524 14:13:22.629584 1 tar.go:286] Adding to tar: /tmp/docker-build147147903/test/sample_test.rb as test/sample_test.rb
2017-05-24T14:13:22.644707000Z I0524 14:13:22.629665 1 tar.go:286] Adding to tar: /tmp/docker-build147147903/views/main.erb as views/main.erb
2017-05-24T14:13:22.708864000Z Step 1 : FROM centos/ruby-22-centos7
2017-05-24T14:13:22.709278000Z ---> 613cea2762da
2017-05-24T14:13:22.713599000Z Step 2 : ENV "BUILD_LOGLEVEL" "5"
2017-05-24T14:13:22.874780000Z ---> Running in 74b9a77d038a
2017-05-24T14:13:22.989996000Z ---> f4d06781c3c0
2017-05-24T14:13:23.002771000Z Removing intermediate container 74b9a77d038a
2017-05-24T14:13:23.003056000Z Step 3 : USER default
2017-05-24T14:13:23.128822000Z ---> Running in dd9c6a3fdb6f
2017-05-24T14:13:23.238709000Z ---> 73734537c517
2017-05-24T14:13:23.262662000Z Removing intermediate container dd9c6a3fdb6f
2017-05-24T14:13:23.262982000Z Step 4 : EXPOSE 8080
2017-05-24T14:13:23.314654000Z ---> Running in 76501787389b
2017-05-24T14:13:23.386652000Z ---> 09a79b8287d1
2017-05-24T14:13:23.395623000Z Removing intermediate container 76501787389b
2017-05-24T14:13:23.395894000Z Step 5 : ENV RACK_ENV production
2017-05-24T14:13:23.463766000Z ---> Running in 584e12d6a2a2
2017-05-24T14:13:23.530757000Z ---> d12c84aba3ee
2017-05-24T14:13:23.567681000Z Removing intermediate container 584e12d6a2a2
2017-05-24T14:13:23.567999000Z Step 6 : ENV RAILS_ENV production
2017-05-24T14:13:23.635667000Z ---> Running in 9257c91a468c
2017-05-24T14:13:23.731929000Z ---> 38b84ad1b4bc
2017-05-24T14:13:23.732230000Z Removing intermediate container 9257c91a468c
2017-05-24T14:13:23.732516000Z Step 7 : COPY . /opt/app-root/src/
2017-05-24T14:13:23.902583000Z ---> 6fe36b52d18f
2017-05-24T14:13:23.912317000Z Removing intermediate container 193c21206cc3
2017-05-24T14:13:23.912648000Z Step 8 : RUN scl enable rh-ruby22 "bundle install"
2017-05-24T14:13:23.974665000Z ---> Running in a2012733d384
2017-05-24T14:13:28.280657000Z Fetching gem metadata from https://rubygems.org/..........
2017-05-24T14:13:28.877481000Z Installing rake 10.3.2
2017-05-24T14:13:29.129725000Z Installing i18n 0.6.11
2017-05-24T14:13:31.280069000Z Installing json 1.8.6
2017-05-24T14:13:31.491489000Z Installing minitest 5.4.2
2017-05-24T14:13:31.715459000Z Installing thread_safe 0.3.4
2017-05-24T14:13:31.963637000Z Installing tzinfo 1.2.2
2017-05-24T14:13:32.023798000Z Gem::RemoteFetcher::FetchError: Errno::ECONNRESET: Connection reset by peer - SSL_connect (https://rubygems.org/gems/activesupport-4.1.7.gem)
2017-05-24T14:13:32.032618000Z An error occurred while installing activesupport (4.1.7), and Bundler cannot
2017-05-24T14:13:32.032873000Z continue.
2017-05-24T14:13:32.033131000Z Make sure that gem install activesupport -v '4.1.7' succeeds before bundling.
2017-05-24T14:13:32.284752000Z F0524 14:13:32.284108 1 helpers.go:116] error: build error: The command '/bin/sh -c scl enable rh-ruby22 "bundle install"' returned a non-zero code: 5

** Registry Logs:
May 24 10:13:37.040: INFO: Running 'oc logs --config=/tmp/cluster-admin.kubeconfig --namespace=default dc/docker-registry --since=1m38.040294267s'
172.16.2.1 - - [24/May/2017:14:12:07 +0000] "GET /healthz HTTP/2.0" 200 0 "" "Go-http-client/2.0"
172.16.2.1 - - [24/May/2017:14:12:07 +0000] "GET /healthz HTTP/2.0" 200 0 "" "Go-http-client/2.0"
172.16.2.1 - - [24/May/2017:14:12:17 +0000] "GET /healthz HTTP/2.0" 200 0 "" "Go-http-client/2.0"
172.16.2.1 - - [24/May/2017:14:12:17 +0000] "GET /healthz HTTP/2.0" 200 0 "" "Go-http-client/2.0"
172.16.2.1 - - [24/May/2017:14:12:27 +0000] "GET /healthz HTTP/2.0" 200 0 "" "Go-http-client/2.0"
172.16.2.1 - - [24/May/2017:14:12:27 +0000] "GET /healthz HTTP/2.0" 200 0 "" "Go-http-client/2.0"
172.16.2.1 - - [24/May/2017:14:12:37 +0000] "GET /healthz HTTP/2.0" 200 0 "" "Go-http-client/2.0"
172.16.2.1 - - [24/May/2017:14:12:37 +0000] "GET /healthz HTTP/2.0" 200 0 "" "Go-http-client/2.0"
172.16.2.1 - - [24/May/2017:14:12:47 +0000] "GET /healthz HTTP/2.0" 200 0 "" "Go-http-client/2.0"
172.16.2.1 - - [24/May/2017:14:12:47 +0000] "GET /healthz HTTP/2.0" 200 0 "" "Go-http-client/2.0"
172.16.2.1 - - [24/May/2017:14:12:57 +0000] "GET /healthz HTTP/2.0" 200 0 "" "Go-http-client/2.0"
172.16.2.1 - - [24/May/2017:14:12:57 +0000] "GET /healthz HTTP/2.0" 200 0 "" "Go-http-client/2.0"
172.16.2.1 - - [24/May/2017:14:13:07 +0000] "GET /healthz HTTP/2.0" 200 0 "" "Go-http-client/2.0"
172.16.2.1 - - [24/May/2017:14:13:07 +0000] "GET /healthz HTTP/2.0" 200 0 "" "Go-http-client/2.0"
172.16.2.1 - - [24/May/2017:14:13:17 +0000] "GET /healthz HTTP/2.0" 200 0 "" "Go-http-client/2.0"
172.16.2.1 - - [24/May/2017:14:13:17 +0000] "GET /healthz HTTP/2.0" 200 0 "" "Go-http-client/2.0"
172.16.2.1 - - [24/May/2017:14:13:27 +0000] "GET /healthz HTTP/2.0" 200 0 "" "Go-http-client/2.0"
172.16.2.1 - - [24/May/2017:14:13:27 +0000] "GET /healthz HTTP/2.0" 200 0 "" "Go-http-client/2.0"
172.16.2.1 - - [24/May/2017:14:13:37 +0000] "GET /healthz HTTP/2.0" 200 0 "" "Go-http-client/2.0"
172.16.2.1 - - [24/May/2017:14:13:37 +0000] "GET /healthz HTTP/2.0" 200 0 "" "Go-http-client/2.0"

[AfterEach] [builds][Conformance] build without output image
/openshifttmp/openshift/build-rpm-release/tito/rpmbuild-originZlb6Es/BUILD/origin-3.6.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:121
STEP: Collecting events from namespace "extended-test-build-no-outputname-0l1zl-3f5xx".
STEP: Found 7 events.
May 24 10:13:38.275: INFO: At 2017-05-24 10:11:59 -0400 EDT - event for test-docker-1-build: {default-scheduler } Scheduled: Successfully assigned test-docker-1-build to ci-prtest-5a37c28-2399-ig-n-bzv8
May 24 10:13:38.275: INFO: At 2017-05-24 10:12:01 -0400 EDT - event for test-docker-1-build: {kubelet ci-prtest-5a37c28-2399-ig-n-bzv8} Pulling: pulling image "openshift/origin-docker-builder:v3.6.0-alpha.1"
May 24 10:13:38.276: INFO: At 2017-05-24 10:12:46 -0400 EDT - event for test-docker-1-build: {kubelet ci-prtest-5a37c28-2399-ig-n-bzv8} Pulled: Successfully pulled image "openshift/origin-docker-builder:v3.6.0-alpha.1"
May 24 10:13:38.276: INFO: At 2017-05-24 10:12:46 -0400 EDT - event for test-docker-1-build: {kubelet ci-prtest-5a37c28-2399-ig-n-bzv8} Created: Created container with id 67ef951eba73994fbc2d8240178e2945ba17e47b0aef020356de677c6c2e8d6d
May 24 10:13:38.276: INFO: At 2017-05-24 10:12:47 -0400 EDT - event for test-docker-1: {build-pod-controller } BuildStarted: Build extended-test-build-no-outputname-0l1zl-3f5xx/test-docker-1 is now running
May 24 10:13:38.276: INFO: At 2017-05-24 10:12:47 -0400 EDT - event for test-docker-1-build: {kubelet ci-prtest-5a37c28-2399-ig-n-bzv8} Started: Started container with id 67ef951eba73994fbc2d8240178e2945ba17e47b0aef020356de677c6c2e8d6d
May 24 10:13:38.276: INFO: At 2017-05-24 10:13:32 -0400 EDT - event for test-docker-1: {build-pod-controller } BuildFailed: Build extended-test-build-no-outputname-0l1zl-3f5xx/test-docker-1 failed
May 24 10:13:38.537: INFO: POD NODE PHASE GRACE CONDITIONS
May 24 10:13:38.537: INFO: docker-registry-2-w552c ci-prtest-5a37c28-2399-ig-m-pt16 Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:10:37 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:10:41 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:10:37 -0400 EDT }]
May 24 10:13:38.537: INFO: registry-console-1-deploy ci-prtest-5a37c28-2399-ig-n-87qc Failed [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:09:56 -0400 EDT } {Ready False 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:10:47 -0400 EDT ContainersNotReady containers with unready status: [deployment]} {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:09:56 -0400 EDT }]
May 24 10:13:38.537: INFO: router-1-q16lc ci-prtest-5a37c28-2399-ig-m-pt16 Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:09:26 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:09:46 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:09:26 -0400 EDT }]
May 24 10:13:38.537: INFO: liveness-http ci-prtest-5a37c28-2399-ig-n-bzv8 Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:26 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:30 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:26 -0400 EDT }]
May 24 10:13:38.537: INFO: test-webserver-029fa0b9-408b-11e7-8195-0eade0d3db20 ci-prtest-5a37c28-2399-ig-n-87qc Running 30s [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:25 -0400 EDT } {Ready False 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:25 -0400 EDT ContainersNotReady containers with unready status: [test-webserver]} {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:24 -0400 EDT }]
May 24 10:13:38.537: INFO: downwardapi-volume-2e8028b8-408b-11e7-9076-0eade0d3db20 Pending []
May 24 10:13:38.537: INFO: pod-2cfb87d1-408b-11e7-a641-0eade0d3db20 ci-prtest-5a37c28-2399-ig-n-bzv8 Pending [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:35 -0400 EDT } {Ready False 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:35 -0400 EDT ContainersNotReady containers with unready status: [test-container]} {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:35 -0400 EDT }]
May 24 10:13:38.537: INFO: pod-init-12d90447-408b-11e7-8308-0eade0d3db20 ci-prtest-5a37c28-2399-ig-n-bzv8 Pending [{Initialized False 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:51 -0400 EDT ContainersNotInitialized containers with incomplete status: [init1 init2]} {Ready False 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:51 -0400 EDT ContainersNotReady containers with unready status: [run1]} {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:51 -0400 EDT }]
May 24 10:13:38.537: INFO: redis-master-0k9dd ci-prtest-5a37c28-2399-ig-n-24x7 Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:16 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:37 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:16 -0400 EDT }]
May 24 10:13:38.537: INFO: host-test-container-pod ci-prtest-5a37c28-2399-ig-m-pt16 Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:32 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:35 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:32 -0400 EDT }]
May 24 10:13:38.537: INFO: netserver-0 ci-prtest-5a37c28-2399-ig-n-bzv8 Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:12 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:32 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:12 -0400 EDT }]
May 24 10:13:38.537: INFO: netserver-1 ci-prtest-5a37c28-2399-ig-n-87qc Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:12 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:32 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:12 -0400 EDT }]
May 24 10:13:38.537: INFO: netserver-2 ci-prtest-5a37c28-2399-ig-m-pt16 Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:12 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:32 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:12 -0400 EDT }]
May 24 10:13:38.537: INFO: netserver-3 ci-prtest-5a37c28-2399-ig-n-24x7 Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:12 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:32 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:12 -0400 EDT }]
May 24 10:13:38.537: INFO: test-container-pod ci-prtest-5a37c28-2399-ig-m-pt16 Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:32 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:35 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:32 -0400 EDT }]
May 24 10:13:38.538: INFO: server ci-prtest-5a37c28-2399-ig-n-bzv8 Running 30s [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:18 -0400 EDT } {Ready False 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:37 -0400 EDT ContainersNotReady containers with unready status: [server]} {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:18 -0400 EDT }]
May 24 10:13:38.538: INFO: tester ci-prtest-5a37c28-2399-ig-n-bzv8 Running 30s [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:25 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:29 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:24 -0400 EDT }]
May 24 10:13:38.538: INFO: pod-projected-secrets-08124bfb-408b-11e7-a8a7-0eade0d3db20 ci-prtest-5a37c28-2399-ig-n-bzv8 Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:33 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:36 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:33 -0400 EDT }]
May 24 10:13:38.538: INFO: pod-secrets-0fc4cd30-408b-11e7-8a19-0eade0d3db20 ci-prtest-5a37c28-2399-ig-n-24x7 Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:46 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:53 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:46 -0400 EDT }]
May 24 10:13:38.538: INFO: pod1 ci-prtest-5a37c28-2399-ig-n-87qc Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:34 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:36 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:33 -0400 EDT }]
May 24 10:13:38.538: INFO: pod2 ci-prtest-5a37c28-2399-ig-n-bzv8 Pending [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:36 -0400 EDT } {Ready False 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:36 -0400 EDT ContainersNotReady containers with unready status: [pause]} {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:36 -0400 EDT }]
May 24 10:13:38.538: INFO: ss-0 ci-prtest-5a37c28-2399-ig-m-pt16 Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:11:58 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:38 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:11:58 -0400 EDT }]
May 24 10:13:38.538: INFO: ss-1 ci-prtest-5a37c28-2399-ig-n-87qc Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:19 -0400 EDT } {Ready False 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:19 -0400 EDT ContainersNotReady containers with unready status: [nginx]} {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:19 -0400 EDT }]
May 24 10:13:38.538: INFO: test-docker-1-build ci-prtest-5a37c28-2399-ig-n-bzv8 Failed [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:11:59 -0400 EDT } {Ready False 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:32 -0400 EDT ContainersNotReady containers with unready status: [docker-build]} {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:11:59 -0400 EDT }]
May 24 10:13:38.538: INFO: deployment-simple-4-9r5z2 ci-prtest-5a37c28-2399-ig-n-24x7 Running 30s [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:05 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:12 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:05 -0400 EDT }]
May 24 10:13:38.538: INFO: deployment-simple-5-79h1b ci-prtest-5a37c28-2399-ig-n-24x7 Running 30s [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:11 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:15 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:11 -0400 EDT }]
May 24 10:13:38.538: INFO: deployment-simple-5-8mfws ci-prtest-5a37c28-2399-ig-n-87qc Running 30s [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:11 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:16 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:11 -0400 EDT }]
May 24 10:13:38.538: INFO: example-1-05c7h ci-prtest-5a37c28-2399-ig-n-87qc Running 30s [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:54 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:28 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:54 -0400 EDT }]
May 24 10:13:38.538: INFO: brokendeployment-1-deploy ci-prtest-5a37c28-2399-ig-n-24x7 Failed [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:18 -0400 EDT } {Ready False 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:04 -0400 EDT ContainersNotReady containers with unready status: [deployment]} {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:18 -0400 EDT }]
May 24 10:13:38.538: INFO: brokendeployment-1-hook-pre ci-prtest-5a37c28-2399-ig-n-24x7 Failed [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:43 -0400 EDT } {Ready False 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:43 -0400 EDT ContainersNotReady containers with unready status: [lifecycle]} {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:43 -0400 EDT }]
May 24 10:13:38.538: INFO: readiness-1-ths7x ci-prtest-5a37c28-2399-ig-n-87qc Running 30s [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:45 -0400 EDT } {Ready False 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:45 -0400 EDT ContainersNotReady containers with unready status: [never-ready]} {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:45 -0400 EDT }]
May 24 10:13:38.538: INFO: paused-1-hbb0s ci-prtest-5a37c28-2399-ig-n-24x7 Running 30s [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:44 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:04 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:44 -0400 EDT }]
May 24 10:13:38.538: INFO: deployment-simple-1-c83rk ci-prtest-5a37c28-2399-ig-n-87qc Running 30s [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:57 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:27 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:57 -0400 EDT }]
May 24 10:13:38.538: INFO: deployment-simple-1-vhx6k ci-prtest-5a37c28-2399-ig-n-24x7 Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:57 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:17 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:12:57 -0400 EDT }]
May 24 10:13:38.538: INFO: deployment-simple-2-deploy ci-prtest-5a37c28-2399-ig-n-87qc Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:29 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:31 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:29 -0400 EDT }]
May 24 10:13:38.538: INFO: deployment-simple-2-kp4nl ci-prtest-5a37c28-2399-ig-n-24x7 Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:32 -0400 EDT } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:37 -0400 EDT } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:13:32 -0400 EDT }]
May 24 10:13:38.538: INFO:
May 24 10:13:38.626: INFO:
Logging node info for node ci-prtest-5a37c28-2399-ig-m-pt16
May 24 10:13:38.688: INFO: Node Info: &Node{ObjectMeta:k8s_io_apimachinery_pkg_apis_meta_v1.ObjectMeta{Name:ci-prtest-5a37c28-2399-ig-m-pt16,GenerateName:,Namespace:,SelfLink:/api/v1/nodes/ci-prtest-5a37c28-2399-ig-m-pt16,UID:42f9d350-408a-11e7-81ee-42010a800003,ResourceVersion:7926,Generation:0,CreationTimestamp:2017-05-24 10:07:03 -0400 EDT,DeletionTimestamp:,DeletionGracePeriodSeconds:nil,Labels:map[string]string{beta.kubernetes.io/arch: amd64,beta.kubernetes.io/instance-type: n1-standard-2,beta.kubernetes.io/os: linux,failure-domain.beta.kubernetes.io/region: us-central1,failure-domain.beta.kubernetes.io/zone: us-central1-a,kubernetes.io/hostname: ci-prtest-5a37c28-2399-ig-m-pt16,role: infra,subrole: master,},Annotations:map[string]string{volumes.kubernetes.io/controller-managed-attach-detach: true,},OwnerReferences:[],Finalizers:[],ClusterName:,},Spec:NodeSpec{PodCIDR:,ExternalID:2918082786986831609,ProviderID:gce://openshift-gce-devel-ci/us-central1-a/ci-prtest-5a37c28-2399-ig-m-pt16,Unschedulable:false,Taints:[],},Status:NodeStatus{Capacity:ResourceList{cpu: {{2 0} {} 2 DecimalSI},memory: {{7674597376 0} {} 7494724Ki BinarySI},pods: {{20 0} {} 20 DecimalSI},},Allocatable:ResourceList{cpu: {{2 0} {} 2 DecimalSI},memory: {{7569739776 0} {} 7392324Ki BinarySI},pods: {{20 0} {} 20 DecimalSI},},Phase:,Conditions:[{NetworkUnavailable False 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:07:03 -0400 EDT RouteCreated openshift-sdn cleared kubelet-set NoRouteCreated} {OutOfDisk False 2017-05-24 10:13:34 -0400 EDT 2017-05-24 10:07:03 -0400 EDT KubeletHasSufficientDisk kubelet has sufficient disk space available} {MemoryPressure False 2017-05-24 10:13:34 -0400 EDT 2017-05-24 10:07:03 -0400 EDT KubeletHasSufficientMemory kubelet has sufficient memory available} {DiskPressure False 2017-05-24 10:13:34 -0400 EDT 2017-05-24 10:07:03 -0400 EDT KubeletHasNoDiskPressure kubelet has no disk pressure} {Ready True 2017-05-24 10:13:34 -0400 EDT 2017-05-24 10:07:03 -0400 EDT KubeletReady kubelet is posting ready status}],Addresses:[{InternalIP 10.128.0.3} {ExternalIP 107.178.214.101} {Hostname ci-prtest-5a37c28-2399-ig-m-pt16}],DaemonEndpoints:NodeDaemonEndpoints{KubeletEndpoint:DaemonEndpoint{Port:10250,},},NodeInfo:NodeSystemInfo{MachineID:02f1ddb1415c4feba9880b2b8c4c5925,SystemUUID:2AD75416-F8CE-FDE0-3949-D85F6068BB97,BootID:e8eeca16-bcb9-4566-a8fd-f6568bf8e3bd,KernelVersion:3.10.0-514.6.1.el7.x86_64,OSImage:Red Hat Enterprise Linux Server 7.3 (Maipo),ContainerRuntimeVersion:docker://1.12.5,KubeletVersion:v1.6.1+5115d708d7,KubeProxyVersion:v1.6.1+5115d708d7,OperatingSystem:linux,Architecture:amd64,},Images:[{[docker.io/openshift/origin-haproxy-router@sha256:8ea695c0608e086ede7786e3b9bf6ba81a2ed3d2952506dbaa3a6a385047bf76 docker.io/openshift/origin-haproxy-router:v3.6.0-alpha.1] 656266633} {[docker.io/openshift/origin-deployer@sha256:393b6ff0ceead1efaece9b2bb8b508b644cbd0c6afb8f2abb4bb6e4f540ccb65 docker.io/openshift/origin-deployer:v3.6.0-alpha.1] 635306029} {[docker.io/openshift/origin-docker-registry@sha256:ec8130ec4591925e1b8609e03a5641e6f2be62a4859f27f59f6267a415b6c01d docker.io/openshift/origin-docker-registry:v3.6.0-alpha.1] 429239546} {[gcr.io/google_containers/nginx-slim@sha256:dd4efd4c13bec2c6f3fe855deeab9524efe434505568421d4f31820485b3a795 gcr.io/google_containers/nginx-slim:0.7] 86864428} {[gcr.io/google_containers/hostexec@sha256:cab8d4e2526f8f767c64febe4ce9e0f0e58cd35fdff81b3aadba4dd041ba9f00 gcr.io/google_containers/hostexec:1.2] 13209617} {[gcr.io/google_containers/netexec@sha256:56c53846f44ea214e4aa5df37c9c50331f0b09e64a32cc7cf17c7e1808d38eef gcr.io/google_containers/netexec:1.7] 8016035} {[docker.io/openshift/origin-pod@sha256:478fd0553a9600014256dede2ad4afb0b620421f5e0353a667be3a94d06dc9b0 docker.io/openshift/origin-pod:v3.6.0-alpha.1] 1138998}],VolumesInUse:[],VolumesAttached:[],},}
May 24 10:13:38.688: INFO:
Logging kubelet events for node ci-prtest-5a37c28-2399-ig-m-pt16
May 24 10:13:38.784: INFO:
Logging pods the kubelet thinks is on node ci-prtest-5a37c28-2399-ig-m-pt16
May 24 10:13:38.928: INFO: ss-0 started at 2017-05-24 10:11:58 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:38.928: INFO: Container nginx ready: true, restart count 0
May 24 10:13:38.928: INFO: router-1-q16lc started at 2017-05-24 10:09:26 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:38.928: INFO: Container router ready: true, restart count 0
May 24 10:13:38.928: INFO: netserver-2 started at 2017-05-24 10:13:12 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:38.928: INFO: Container webserver ready: true, restart count 0
May 24 10:13:38.928: INFO: docker-registry-2-w552c started at 2017-05-24 10:10:37 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:38.928: INFO: Container registry ready: true, restart count 0
May 24 10:13:38.928: INFO: test-container-pod started at 2017-05-24 10:13:32 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:38.928: INFO: Container webserver ready: true, restart count 0
May 24 10:13:38.928: INFO: host-test-container-pod started at 2017-05-24 10:13:32 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:38.928: INFO: Container hostexec ready: true, restart count 0
W0524 10:13:38.984724 29430 metrics_grabber.go:74] Master node is not registered. Grabbing metrics from Scheduler and ControllerManager is disabled.
May 24 10:13:39.748: INFO:
Latency metrics for node ci-prtest-5a37c28-2399-ig-m-pt16
May 24 10:13:39.748: INFO: {Operation:sync Method:pod_worker_latency_microseconds Quantile:0.99 Latency:2m0.000636s}
May 24 10:13:39.748: INFO: {Operation:sync Method:pod_worker_latency_microseconds Quantile:0.9 Latency:2m0.000636s}
May 24 10:13:39.748: INFO: {Operation:sync Method:pod_worker_latency_microseconds Quantile:0.5 Latency:2m0.000636s}
May 24 10:13:39.748: INFO:
Logging node info for node ci-prtest-5a37c28-2399-ig-n-24x7
May 24 10:13:39.809: INFO: Node Info: &Node{ObjectMeta:k8s_io_apimachinery_pkg_apis_meta_v1.ObjectMeta{Name:ci-prtest-5a37c28-2399-ig-n-24x7,GenerateName:,Namespace:,SelfLink:/api/v1/nodes/ci-prtest-5a37c28-2399-ig-n-24x7,UID:42fe86bc-408a-11e7-81ee-42010a800003,ResourceVersion:7907,Generation:0,CreationTimestamp:2017-05-24 10:07:03 -0400 EDT,DeletionTimestamp:,DeletionGracePeriodSeconds:nil,Labels:map[string]string{beta.kubernetes.io/arch: amd64,beta.kubernetes.io/instance-type: n1-standard-2,beta.kubernetes.io/os: linux,failure-domain.beta.kubernetes.io/region: us-central1,failure-domain.beta.kubernetes.io/zone: us-central1-a,kubernetes.io/hostname: ci-prtest-5a37c28-2399-ig-n-24x7,role: app,},Annotations:map[string]string{volumes.kubernetes.io/controller-managed-attach-detach: true,},OwnerReferences:[],Finalizers:[],ClusterName:,},Spec:NodeSpec{PodCIDR:,ExternalID:7812482308959121145,ProviderID:gce://openshift-gce-devel-ci/us-central1-a/ci-prtest-5a37c28-2399-ig-n-24x7,Unschedulable:false,Taints:[],},Status:NodeStatus{Capacity:ResourceList{cpu: {{2 0} {} 2 DecimalSI},memory: {{7674597376 0} {} 7494724Ki BinarySI},pods: {{20 0} {} 20 DecimalSI},},Allocatable:ResourceList{cpu: {{2 0} {} 2 DecimalSI},memory: {{7569739776 0} {} 7392324Ki BinarySI},pods: {{20 0} {} 20 DecimalSI},},Phase:,Conditions:[{NetworkUnavailable False 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:07:03 -0400 EDT RouteCreated openshift-sdn cleared kubelet-set NoRouteCreated} {OutOfDisk False 2017-05-24 10:13:33 -0400 EDT 2017-05-24 10:07:03 -0400 EDT KubeletHasSufficientDisk kubelet has sufficient disk space available} {MemoryPressure False 2017-05-24 10:13:33 -0400 EDT 2017-05-24 10:07:03 -0400 EDT KubeletHasSufficientMemory kubelet has sufficient memory available} {DiskPressure False 2017-05-24 10:13:33 -0400 EDT 2017-05-24 10:07:03 -0400 EDT KubeletHasNoDiskPressure kubelet has no disk pressure} {Ready True 2017-05-24 10:13:33 -0400 EDT 2017-05-24 10:07:03 -0400 EDT KubeletReady kubelet is posting ready status}],Addresses:[{InternalIP 10.128.0.4} {ExternalIP 104.154.78.200} {Hostname ci-prtest-5a37c28-2399-ig-n-24x7}],DaemonEndpoints:NodeDaemonEndpoints{KubeletEndpoint:DaemonEndpoint{Port:10250,},},NodeInfo:NodeSystemInfo{MachineID:02f1ddb1415c4feba9880b2b8c4c5925,SystemUUID:457A193B-BC1D-08FD-72FF-F6A0ADDA9983,BootID:9ac675ae-de9b-459b-8b9f-ea1d2f146cb8,KernelVersion:3.10.0-514.6.1.el7.x86_64,OSImage:Red Hat Enterprise Linux Server 7.3 (Maipo),ContainerRuntimeVersion:docker://1.12.5,KubeletVersion:v1.6.1+5115d708d7,KubeProxyVersion:v1.6.1+5115d708d7,OperatingSystem:linux,Architecture:amd64,},Images:[{[docker.io/openshift/origin-deployer@sha256:393b6ff0ceead1efaece9b2bb8b508b644cbd0c6afb8f2abb4bb6e4f540ccb65 docker.io/openshift/origin-deployer:v3.6.0-alpha.1] 635306029} {[docker.io/centos@sha256:bba1de7c9d900a898e3cadbae040dfe8a633c06bc104a0df76ae24483e03c077 docker.io/centos:centos7] 192556318} {[gcr.io/google_containers/nginx-slim@sha256:dd4efd4c13bec2c6f3fe855deeab9524efe434505568421d4f31820485b3a795 gcr.io/google_containers/nginx-slim:0.7] 86864428} {[gcr.io/google_containers/hostexec@sha256:cab8d4e2526f8f767c64febe4ce9e0f0e58cd35fdff81b3aadba4dd041ba9f00 gcr.io/google_containers/hostexec:1.2] 13209617} {[gcr.io/google_containers/netexec@sha256:56c53846f44ea214e4aa5df37c9c50331f0b09e64a32cc7cf17c7e1808d38eef gcr.io/google_containers/netexec:1.7] 8016035} {[gcr.io/google_containers/mounttest@sha256:bec3122ddcf8bd999e44e46e096659f31241d09f5236bc3dc212ea584ca06856 gcr.io/google_containers/mounttest:0.8] 1450761} {[docker.io/openshift/origin-pod@sha256:478fd0553a9600014256dede2ad4afb0b620421f5e0353a667be3a94d06dc9b0 docker.io/openshift/origin-pod:v3.6.0-alpha.1] 1138998} {[gcr.io/google_containers/busybox@sha256:4bdd623e848417d96127e16037743f0cd8b528c026e9175e22a84f639eca58ff gcr.io/google_containers/busybox:1.24] 1113554} {[gcr.io/google_containers/pause-amd64@sha256:163ac025575b775d1c0f9bf0bdd0f086883171eb475b5068e7defa4ca9e76516 gcr.io/google_containers/pause-amd64:3.0] 746888}],VolumesInUse:[],VolumesAttached:[],},}
May 24 10:13:39.809: INFO:
Logging kubelet events for node ci-prtest-5a37c28-2399-ig-n-24x7
May 24 10:13:39.852: INFO:
Logging pods the kubelet thinks is on node ci-prtest-5a37c28-2399-ig-n-24x7
May 24 10:13:39.966: INFO: brokendeployment-1-deploy started at 2017-05-24 10:12:18 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:39.966: INFO: Container deployment ready: false, restart count 0
May 24 10:13:39.966: INFO: paused-1-hbb0s started at 2017-05-24 10:12:44 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:39.966: INFO: Container myapp ready: true, restart count 0
May 24 10:13:39.966: INFO: deployment-simple-4-9r5z2 started at 2017-05-24 10:13:05 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:39.966: INFO: Container myapp ready: true, restart count 0
May 24 10:13:39.966: INFO: deployment-simple-2-kp4nl started at 2017-05-24 10:13:32 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:39.966: INFO: Container myapp ready: true, restart count 0
May 24 10:13:39.966: INFO: redis-master-0k9dd started at 2017-05-24 10:13:16 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:39.966: INFO: Container redis-master ready: true, restart count 0
May 24 10:13:39.966: INFO: pod-init-2eba463f-408b-11e7-8308-0eade0d3db20 started at 2017-05-24 10:13:38 -0400 EDT (2+1 container statuses recorded)
May 24 10:13:39.966: INFO: Init container init1 ready: false, restart count 0
May 24 10:13:39.966: INFO: Init container init2 ready: false, restart count 0
May 24 10:13:39.966: INFO: Container run1 ready: false, restart count 0
May 24 10:13:39.966: INFO: deployment-simple-5-79h1b started at 2017-05-24 10:13:11 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:39.966: INFO: Container myapp ready: true, restart count 0
May 24 10:13:39.966: INFO: pod-secrets-0fc4cd30-408b-11e7-8a19-0eade0d3db20 started at 2017-05-24 10:12:46 -0400 EDT (0+3 container statuses recorded)
May 24 10:13:39.966: INFO: Container creates-volume-test ready: true, restart count 0
May 24 10:13:39.966: INFO: Container dels-volume-test ready: true, restart count 0
May 24 10:13:39.966: INFO: Container upds-volume-test ready: true, restart count 0
May 24 10:13:39.966: INFO: brokendeployment-1-hook-pre started at 2017-05-24 10:12:43 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:39.966: INFO: Container lifecycle ready: false, restart count 0
May 24 10:13:39.966: INFO: deployment-simple-1-vhx6k started at 2017-05-24 10:12:57 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:39.966: INFO: Container myapp ready: true, restart count 0
May 24 10:13:39.966: INFO: pod-2f0d0bd7-408b-11e7-84a2-0eade0d3db20 started at 2017-05-24 10:13:39 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:39.966: INFO: Container test-container ready: false, restart count 0
May 24 10:13:39.966: INFO: netserver-3 started at 2017-05-24 10:13:12 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:39.966: INFO: Container webserver ready: true, restart count 0
W0524 10:13:40.009562 29430 metrics_grabber.go:74] Master node is not registered. Grabbing metrics from Scheduler and ControllerManager is disabled.
May 24 10:13:40.689: INFO:
Latency metrics for node ci-prtest-5a37c28-2399-ig-n-24x7
May 24 10:13:40.689: INFO: {Operation: Method:pod_start_latency_microseconds Quantile:0.99 Latency:28.614031s}
May 24 10:13:40.689: INFO: {Operation:create Method:pod_worker_latency_microseconds Quantile:0.9 Latency:24.081515s}
May 24 10:13:40.689: INFO: {Operation:create Method:pod_worker_latency_microseconds Quantile:0.99 Latency:24.081515s}
May 24 10:13:40.689: INFO: {Operation:pull_image Method:docker_operations_latency_microseconds Quantile:0.99 Latency:19.347348s}
May 24 10:13:40.689: INFO: {Operation:create Method:pod_worker_latency_microseconds Quantile:0.5 Latency:11.476916s}
May 24 10:13:40.689: INFO: {Operation: Method:pod_start_latency_microseconds Quantile:0.9 Latency:10.897625s}
May 24 10:13:40.689: INFO:
Logging node info for node ci-prtest-5a37c28-2399-ig-n-87qc
May 24 10:13:40.733: INFO: Node Info: &Node{ObjectMeta:k8s_io_apimachinery_pkg_apis_meta_v1.ObjectMeta{Name:ci-prtest-5a37c28-2399-ig-n-87qc,GenerateName:,Namespace:,SelfLink:/api/v1/nodes/ci-prtest-5a37c28-2399-ig-n-87qc,UID:42f9f077-408a-11e7-81ee-42010a800003,ResourceVersion:7912,Generation:0,CreationTimestamp:2017-05-24 10:07:03 -0400 EDT,DeletionTimestamp:,DeletionGracePeriodSeconds:nil,Labels:map[string]string{beta.kubernetes.io/arch: amd64,beta.kubernetes.io/instance-type: n1-standard-2,beta.kubernetes.io/os: linux,failure-domain.beta.kubernetes.io/region: us-central1,failure-domain.beta.kubernetes.io/zone: us-central1-a,kubernetes.io/hostname: ci-prtest-5a37c28-2399-ig-n-87qc,role: app,},Annotations:map[string]string{volumes.kubernetes.io/controller-managed-attach-detach: true,},OwnerReferences:[],Finalizers:[],ClusterName:,},Spec:NodeSpec{PodCIDR:,ExternalID:1403296475077160697,ProviderID:gce://openshift-gce-devel-ci/us-central1-a/ci-prtest-5a37c28-2399-ig-n-87qc,Unschedulable:false,Taints:[],},Status:NodeStatus{Capacity:ResourceList{cpu: {{2 0} {} 2 DecimalSI},memory: {{7674597376 0} {} 7494724Ki BinarySI},pods: {{20 0} {} 20 DecimalSI},},Allocatable:ResourceList{cpu: {{2 0} {} 2 DecimalSI},memory: {{7569739776 0} {} 7392324Ki BinarySI},pods: {{20 0} {} 20 DecimalSI},},Phase:,Conditions:[{NetworkUnavailable False 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:07:03 -0400 EDT RouteCreated openshift-sdn cleared kubelet-set NoRouteCreated} {OutOfDisk False 2017-05-24 10:13:33 -0400 EDT 2017-05-24 10:07:03 -0400 EDT KubeletHasSufficientDisk kubelet has sufficient disk space available} {MemoryPressure False 2017-05-24 10:13:33 -0400 EDT 2017-05-24 10:07:03 -0400 EDT KubeletHasSufficientMemory kubelet has sufficient memory available} {DiskPressure False 2017-05-24 10:13:33 -0400 EDT 2017-05-24 10:07:03 -0400 EDT KubeletHasNoDiskPressure kubelet has no disk pressure} {Ready True 2017-05-24 10:13:33 -0400 EDT 2017-05-24 10:10:30 -0400 EDT KubeletReady kubelet is posting ready status}],Addresses:[{InternalIP 10.128.0.5} {ExternalIP 104.198.79.150} {Hostname ci-prtest-5a37c28-2399-ig-n-87qc}],DaemonEndpoints:NodeDaemonEndpoints{KubeletEndpoint:DaemonEndpoint{Port:10250,},},NodeInfo:NodeSystemInfo{MachineID:02f1ddb1415c4feba9880b2b8c4c5925,SystemUUID:DBFE57B2-58AE-72F5-A829-D378B35D654F,BootID:5ea19610-6fb8-47e6-97fe-f4105de321f6,KernelVersion:3.10.0-514.6.1.el7.x86_64,OSImage:Red Hat Enterprise Linux Server 7.3 (Maipo),ContainerRuntimeVersion:docker://1.12.5,KubeletVersion:v1.6.1+5115d708d7,KubeProxyVersion:v1.6.1+5115d708d7,OperatingSystem:linux,Architecture:amd64,},Images:[{[docker.io/openshift/origin-deployer@sha256:393b6ff0ceead1efaece9b2bb8b508b644cbd0c6afb8f2abb4bb6e4f540ccb65 docker.io/openshift/origin-deployer:v3.6.0-alpha.1] 635306029} {[docker.io/centos@sha256:bba1de7c9d900a898e3cadbae040dfe8a633c06bc104a0df76ae24483e03c077 docker.io/centos:centos7] 192556318} {[gcr.io/google_containers/jessie-dnsutils@sha256:2460d596912244b5f8973573f7150e7264b570015f4becc2d0096f0bd1d17e36 gcr.io/google_containers/jessie-dnsutils:e2e] 190148402} {[gcr.io/google_containers/nginx-slim@sha256:dd4efd4c13bec2c6f3fe855deeab9524efe434505568421d4f31820485b3a795 gcr.io/google_containers/nginx-slim:0.7] 86864428} {[gcr.io/google_containers/dnsutils@sha256:cd9182f6d74e616942db1cef6f25e1e54b49ba0330c2e19d3ec061f027666cc0 gcr.io/google_containers/dnsutils:e2e] 8897789} {[gcr.io/google_containers/netexec@sha256:56c53846f44ea214e4aa5df37c9c50331f0b09e64a32cc7cf17c7e1808d38eef gcr.io/google_containers/netexec:1.7] 8016035} {[gcr.io/google_containers/update-demo@sha256:89ac104fa7c43880d2324f377b79be95b0b2b3fb32e4bd03b8d1e6d91a41f009 gcr.io/google_containers/update-demo:nautilus] 4555533} {[gcr.io/google_containers/test-webserver@sha256:f804e8837490d1dfdb5002e073f715fd0a08115de74e5a4847ca952315739372 gcr.io/google_containers/test-webserver:e2e] 4534272} {[gcr.io/google_containers/eptest@sha256:bb088b26ed78613cce171420168db9a6c62a8dbea17d7be13077e7010bae162f gcr.io/google_containers/eptest:0.1] 2970692} {[gcr.io/google_containers/portforwardtester@sha256:306879729d3eff635a11b89f3e62e440c9f2fe4dabdfb9ef02bc67f2275f67ab gcr.io/google_containers/portforwardtester:1.2] 1892642} {[gcr.io/google_containers/mounttest@sha256:bec3122ddcf8bd999e44e46e096659f31241d09f5236bc3dc212ea584ca06856 gcr.io/google_containers/mounttest:0.8] 1450761} {[gcr.io/google_containers/mounttest-user@sha256:5487c126b03abf4119a8f7950cd5f591f72dbe4ab15623f3387d3917e1268b4e gcr.io/google_containers/mounttest-user:0.5] 1450761} {[docker.io/openshift/origin-pod@sha256:478fd0553a9600014256dede2ad4afb0b620421f5e0353a667be3a94d06dc9b0 docker.io/openshift/origin-pod:v3.6.0-alpha.1] 1138998} {[gcr.io/google_containers/busybox@sha256:4bdd623e848417d96127e16037743f0cd8b528c026e9175e22a84f639eca58ff gcr.io/google_containers/busybox:1.24] 1113554} {[gcr.io/google_containers/pause-amd64@sha256:163ac025575b775d1c0f9bf0bdd0f086883171eb475b5068e7defa4ca9e76516 gcr.io/google_containers/pause-amd64:3.0] 746888}],VolumesInUse:[],VolumesAttached:[],},}
May 24 10:13:40.733: INFO:
Logging kubelet events for node ci-prtest-5a37c28-2399-ig-n-87qc
May 24 10:13:40.781: INFO:
Logging pods the kubelet thinks is on node ci-prtest-5a37c28-2399-ig-n-87qc
May 24 10:13:40.878: INFO: example-1-05c7h started at 2017-05-24 10:12:54 -0400 EDT (0+2 container statuses recorded)
May 24 10:13:40.878: INFO: Container ruby ready: true, restart count 0
May 24 10:13:40.878: INFO: Container ruby2 ready: true, restart count 0
May 24 10:13:40.878: INFO: registry-console-1-deploy started at 2017-05-24 10:09:56 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:40.878: INFO: Container deployment ready: false, restart count 0
May 24 10:13:40.878: INFO: netserver-1 started at 2017-05-24 10:13:12 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:40.878: INFO: Container webserver ready: true, restart count 0
May 24 10:13:40.878: INFO: readiness-1-ths7x started at 2017-05-24 10:12:45 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:40.878: INFO: Container never-ready ready: false, restart count 0
May 24 10:13:40.878: INFO: pod1 started at 2017-05-24 10:13:34 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:40.878: INFO: Container pause ready: true, restart count 0
May 24 10:13:40.878: INFO: deployment-simple-1-c83rk started at 2017-05-24 10:12:57 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:40.878: INFO: Container myapp ready: true, restart count 0
May 24 10:13:40.878: INFO: ss-1 started at 2017-05-24 10:12:19 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:40.878: INFO: Container nginx ready: false, restart count 0
May 24 10:13:40.878: INFO: deployment-simple-5-8mfws started at 2017-05-24 10:13:11 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:40.878: INFO: Container myapp ready: true, restart count 0
May 24 10:13:40.878: INFO: deployment-simple-2-deploy started at 2017-05-24 10:13:29 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:40.878: INFO: Container deployment ready: true, restart count 0
May 24 10:13:40.878: INFO: deployment-simple-2-pngrw started at 2017-05-24 10:13:39 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:40.878: INFO: Container myapp ready: false, restart count 0
W0524 10:13:40.922583 29430 metrics_grabber.go:74] Master node is not registered. Grabbing metrics from Scheduler and ControllerManager is disabled.
May 24 10:13:41.270: INFO:
Latency metrics for node ci-prtest-5a37c28-2399-ig-n-87qc
May 24 10:13:41.270: INFO: {Operation: Method:pod_start_latency_microseconds Quantile:0.99 Latency:29.003393s}
May 24 10:13:41.270: INFO: {Operation:pull_image Method:docker_operations_latency_microseconds Quantile:0.99 Latency:18.703125s}
May 24 10:13:41.270: INFO: {Operation:pull_image Method:docker_operations_latency_microseconds Quantile:0.9 Latency:13.26381s}
May 24 10:13:41.270: INFO: {Operation:create Method:pod_worker_latency_microseconds Quantile:0.9 Latency:11.875279s}
May 24 10:13:41.270: INFO: {Operation:create Method:pod_worker_latency_microseconds Quantile:0.99 Latency:11.875279s}
May 24 10:13:41.270: INFO: {Operation:create Method:pod_worker_latency_microseconds Quantile:0.5 Latency:11.875279s}
May 24 10:13:41.270: INFO:
Logging node info for node ci-prtest-5a37c28-2399-ig-n-bzv8
May 24 10:13:41.313: INFO: Node Info: &Node{ObjectMeta:k8s_io_apimachinery_pkg_apis_meta_v1.ObjectMeta{Name:ci-prtest-5a37c28-2399-ig-n-bzv8,GenerateName:,Namespace:,SelfLink:/api/v1/nodes/ci-prtest-5a37c28-2399-ig-n-bzv8,UID:42ee1073-408a-11e7-81ee-42010a800003,ResourceVersion:7911,Generation:0,CreationTimestamp:2017-05-24 10:07:03 -0400 EDT,DeletionTimestamp:,DeletionGracePeriodSeconds:nil,Labels:map[string]string{beta.kubernetes.io/arch: amd64,beta.kubernetes.io/instance-type: n1-standard-2,beta.kubernetes.io/os: linux,failure-domain.beta.kubernetes.io/region: us-central1,failure-domain.beta.kubernetes.io/zone: us-central1-a,kubernetes.io/hostname: ci-prtest-5a37c28-2399-ig-n-bzv8,role: app,},Annotations:map[string]string{volumes.kubernetes.io/controller-managed-attach-detach: true,},OwnerReferences:[],Finalizers:[],ClusterName:,},Spec:NodeSpec{PodCIDR:,ExternalID:8045880005873905401,ProviderID:gce://openshift-gce-devel-ci/us-central1-a/ci-prtest-5a37c28-2399-ig-n-bzv8,Unschedulable:false,Taints:[],},Status:NodeStatus{Capacity:ResourceList{cpu: {{2 0} {} 2 DecimalSI},memory: {{7674597376 0} {} 7494724Ki BinarySI},pods: {{20 0} {} 20 DecimalSI},},Allocatable:ResourceList{cpu: {{2 0} {} 2 DecimalSI},memory: {{7569739776 0} {} 7392324Ki BinarySI},pods: {{20 0} {} 20 DecimalSI},},Phase:,Conditions:[{NetworkUnavailable False 0001-01-01 00:00:00 +0000 UTC 2017-05-24 10:07:03 -0400 EDT RouteCreated openshift-sdn cleared kubelet-set NoRouteCreated} {OutOfDisk False 2017-05-24 10:13:33 -0400 EDT 2017-05-24 10:07:03 -0400 EDT KubeletHasSufficientDisk kubelet has sufficient disk space available} {MemoryPressure False 2017-05-24 10:13:33 -0400 EDT 2017-05-24 10:07:03 -0400 EDT KubeletHasSufficientMemory kubelet has sufficient memory available} {DiskPressure False 2017-05-24 10:13:33 -0400 EDT 2017-05-24 10:07:03 -0400 EDT KubeletHasNoDiskPressure kubelet has no disk pressure} {Ready True 2017-05-24 10:13:33 -0400 EDT 2017-05-24 10:07:03 -0400 EDT KubeletReady kubelet is posting ready status}],Addresses:[{InternalIP 10.128.0.2} {ExternalIP 104.154.237.137} {Hostname ci-prtest-5a37c28-2399-ig-n-bzv8}],DaemonEndpoints:NodeDaemonEndpoints{KubeletEndpoint:DaemonEndpoint{Port:10250,},},NodeInfo:NodeSystemInfo{MachineID:02f1ddb1415c4feba9880b2b8c4c5925,SystemUUID:6FC876D9-7720-F2A2-BD7D-071FA15B7B87,BootID:73927e29-c112-48d3-8ab6-140c835150e8,KernelVersion:3.10.0-514.6.1.el7.x86_64,OSImage:Red Hat Enterprise Linux Server 7.3 (Maipo),ContainerRuntimeVersion:docker://1.12.5,KubeletVersion:v1.6.1+5115d708d7,KubeProxyVersion:v1.6.1+5115d708d7,OperatingSystem:linux,Architecture:amd64,},Images:[{[docker.io/openshift/origin-docker-builder@sha256:a76c1a9da9d17f59ded0070ae70f65159b861348b856b8d5e1f0fdcf29f10085 docker.io/openshift/origin-docker-builder:v3.6.0-alpha.1] 635306029} {[docker.io/openshift/origin-deployer@sha256:393b6ff0ceead1efaece9b2bb8b508b644cbd0c6afb8f2abb4bb6e4f540ccb65 docker.io/openshift/origin-deployer:v3.6.0-alpha.1] 635306029} {[gcr.io/google_containers/redis@sha256:f066bcf26497fbc55b9bf0769cb13a35c0afa2aa42e737cc46b7fb04b23a2f25 gcr.io/google_containers/redis:e2e] 419003740} {[docker.io/centos@sha256:bba1de7c9d900a898e3cadbae040dfe8a633c06bc104a0df76ae24483e03c077 docker.io/centos:centos7] 192556318} {[gcr.io/google_containers/netexec@sha256:56c53846f44ea214e4aa5df37c9c50331f0b09e64a32cc7cf17c7e1808d38eef gcr.io/google_containers/netexec:1.7] 8016035} {[gcr.io/google_containers/serve_hostname@sha256:a49737ee84a3b94f0b977f32e60c5daf11f0b5636f1f7503a2981524f351c57a gcr.io/google_containers/serve_hostname:v1.4] 6222101} {[gcr.io/google_containers/update-demo@sha256:89ac104fa7c43880d2324f377b79be95b0b2b3fb32e4bd03b8d1e6d91a41f009 gcr.io/google_containers/update-demo:nautilus] 4555533} {[gcr.io/google_containers/portforwardtester@sha256:306879729d3eff635a11b89f3e62e440c9f2fe4dabdfb9ef02bc67f2275f67ab gcr.io/google_containers/portforwardtester:1.2] 1892642} {[gcr.io/google_containers/mounttest@sha256:bec3122ddcf8bd999e44e46e096659f31241d09f5236bc3dc212ea584ca06856 gcr.io/google_containers/mounttest:0.8] 1450761} {[gcr.io/google_containers/mounttest-user@sha256:5487c126b03abf4119a8f7950cd5f591f72dbe4ab15623f3387d3917e1268b4e gcr.io/google_containers/mounttest-user:0.5] 1450761} {[docker.io/openshift/origin-pod@sha256:478fd0553a9600014256dede2ad4afb0b620421f5e0353a667be3a94d06dc9b0 docker.io/openshift/origin-pod:v3.6.0-alpha.1] 1138998} {[gcr.io/google_containers/busybox@sha256:4bdd623e848417d96127e16037743f0cd8b528c026e9175e22a84f639eca58ff gcr.io/google_containers/busybox:1.24] 1113554} {[gcr.io/google-containers/pause@sha256:9ce5316f9752b8347484ab0f6778573af15524124d52b93230b9a0dcc987e73e gcr.io/google-containers/pause:2.0] 350164}],VolumesInUse:[],VolumesAttached:[],},}
May 24 10:13:41.313: INFO:
Logging kubelet events for node ci-prtest-5a37c28-2399-ig-n-bzv8
May 24 10:13:41.359: INFO:
Logging pods the kubelet thinks is on node ci-prtest-5a37c28-2399-ig-n-bzv8
May 24 10:13:41.460: INFO: test-docker-1-build started at 2017-05-24 10:11:59 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:41.460: INFO: Container docker-build ready: false, restart count 0
May 24 10:13:41.460: INFO: pod-projected-secrets-08124bfb-408b-11e7-a8a7-0eade0d3db20 started at 2017-05-24 10:12:33 -0400 EDT (0+3 container statuses recorded)
May 24 10:13:41.460: INFO: Container creates-volume-test ready: true, restart count 0
May 24 10:13:41.460: INFO: Container dels-volume-test ready: true, restart count 0
May 24 10:13:41.460: INFO: Container upds-volume-test ready: true, restart count 0
May 24 10:13:41.460: INFO: pod2 started at 2017-05-24 10:13:36 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:41.460: INFO: Container pause ready: true, restart count 0
May 24 10:13:41.460: INFO: pod-init-12d90447-408b-11e7-8308-0eade0d3db20 started at 2017-05-24 10:12:51 -0400 EDT (2+1 container statuses recorded)
May 24 10:13:41.460: INFO: Init container init1 ready: false, restart count 3
May 24 10:13:41.460: INFO: Init container init2 ready: false, restart count 0
May 24 10:13:41.460: INFO: Container run1 ready: false, restart count 0
May 24 10:13:41.460: INFO: downwardapi-volume-2e8028b8-408b-11e7-9076-0eade0d3db20 started at 2017-05-24 10:13:38 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:41.460: INFO: Container client-container ready: false, restart count 0
May 24 10:13:41.460: INFO: tester started at 2017-05-24 10:13:25 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:41.460: INFO: Container tester ready: true, restart count 0
May 24 10:13:41.460: INFO: liveness-http started at 2017-05-24 10:13:26 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:41.460: INFO: Container liveness ready: true, restart count 0
May 24 10:13:41.460: INFO: netserver-0 started at 2017-05-24 10:13:12 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:41.460: INFO: Container webserver ready: true, restart count 0
May 24 10:13:41.460: INFO: server started at 2017-05-24 10:13:18 -0400 EDT (0+1 container statuses recorded)
May 24 10:13:41.460: INFO: Container server ready: false, restart count 0
W0524 10:13:41.505473 29430 metrics_grabber.go:74] Master node is not registered. Grabbing metrics from Scheduler and ControllerManager is disabled.
May 24 10:13:41.926: INFO:
Latency metrics for node ci-prtest-5a37c28-2399-ig-n-bzv8
May 24 10:13:41.926: INFO: {Operation: Method:pod_start_latency_microseconds Quantile:0.99 Latency:45.757579s}
May 24 10:13:41.926: INFO: {Operation:pull_image Method:docker_operations_latency_microseconds Quantile:0.99 Latency:17.382755s}
May 24 10:13:41.926: INFO: {Operation:create Method:pod_worker_latency_microseconds Quantile:0.9 Latency:17.342711s}
May 24 10:13:41.926: INFO: {Operation:create Method:pod_worker_latency_microseconds Quantile:0.99 Latency:17.342711s}
STEP: Dumping a list of prepulled images on each node
May 24 10:13:41.970: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "extended-test-build-no-outputname-0l1zl-3f5xx" for this suite.
May 24 10:13:56.390: INFO: namespace: extended-test-build-no-outputname-0l1zl-3f5xx, resource: bindings, ignored listing per whitelist

• Failure [123.381 seconds]
[builds][Conformance] build without output image
/openshifttmp/openshift/build-rpm-release/tito/rpmbuild-originZlb6Es/BUILD/origin-3.6.0/_output/local/go/src/github.com/openshift/origin/test/extended/builds/no_outputname.go:55
building from templates
/openshifttmp/openshift/build-rpm-release/tito/rpmbuild-originZlb6Es/BUILD/origin-3.6.0/_output/local/go/src/github.com/openshift/origin/test/extended/builds/no_outputname.go:54
should create an image from a docker template without an output image reference defined [It]
/openshifttmp/openshift/build-rpm-release/tito/rpmbuild-originZlb6Es/BUILD/origin-3.6.0/_output/local/go/src/github.com/openshift/origin/test/extended/builds/no_outputname.go:36

Expected
    <bool>: false
to be true

/openshifttmp/openshift/build-rpm-release/tito/rpmbuild-originZlb6Es/BUILD/origin-3.6.0/_output/local/go/src/github.com/openshift/origin/test/extended/builds/no_outputname.go:29

Link: https://ci.openshift.redhat.com/jenkins/job/test_pull_request_origin/1682/consoleFull#119394043756cbb9a5e4b02b88ae8c2f77
@php-coder php-coder added the kind/test-flake Categorizes issue or PR as related to test flakes. label May 24, 2017
@php-coder php-coder mentioned this issue May 24, 2017
Merged
@php-coder
Copy link
Contributor Author

CC @bparees

@bparees
Copy link
Contributor

bparees commented May 25, 2017

yeah it's what you suspected, rubygems didn't respond. really nothing we're going to be able to do to fix this short of insane things like checking the build log to determine why it failed and retrying it.

That said, @stevekuznetsov it looks like this test actually ran twice which doesn't seem right:

once it succeeded:

• [SLOW TEST:97.061 seconds]
[builds][Conformance] build without output image
/go/src/github.com/openshift/origin/test/extended/builds/no_outputname.go:55
  building from templates
  /go/src/github.com/openshift/origin/test/extended/builds/no_outputname.go:54
    should create an image from a docker template without an output image reference defined
    /go/src/github.com/openshift/origin/test/extended/builds/no_outputname.go:36

and the second time it failed:

• Failure [123.381 seconds]
[builds][Conformance] build without output image
/openshifttmp/openshift/build-rpm-release/tito/rpmbuild-originZlb6Es/BUILD/origin-3.6.0/_output/local/go/src/github.com/openshift/origin/test/extended/builds/no_outputname.go:55
  building from templates
  /openshifttmp/openshift/build-rpm-release/tito/rpmbuild-originZlb6Es/BUILD/origin-3.6.0/_output/local/go/src/github.com/openshift/origin/test/extended/builds/no_outputname.go:54
    should create an image from a docker template without an output image reference defined [It]
    /openshifttmp/openshift/build-rpm-release/tito/rpmbuild-originZlb6Es/BUILD/origin-3.6.0/_output/local/go/src/github.com/openshift/origin/test/extended/builds/no_outputname.go:36

    Expected
        <bool>: false
    to be true

    /openshifttmp/openshift/build-rpm-release/tito/rpmbuild-originZlb6Es/BUILD/origin-3.6.0/_output/local/go/src/github.com/openshift/origin/test/extended/builds/no_outputname.go:29

is there perhaps something wrong w/ our ginkgo test selection?

@bparees
Copy link
Contributor

bparees commented May 25, 2017

or is this because one run is w/ rpm builds and one is not?

@stevekuznetsov
Copy link
Contributor

test_pull_request_origin runs both test_pull_request_origin_extended_conformance_install_update and test_pull_request_origin_extended_conformance_gce, which both run the conformance suite, with different set-ups.

@bparees
Copy link
Contributor

bparees commented May 25, 2017

cool, thanks.

@bparees bparees closed this as completed May 25, 2017
@php-coder
Copy link
Contributor Author

Was it closed as WONTFIX?

@bparees
Copy link
Contributor

bparees commented May 25, 2017

yes:

yeah it's what you suspected, rubygems didn't respond. really nothing we're going to be able to do to fix this short of insane things like checking the build log to determine why it failed and retrying it.

i only left it open for a bit to get to the bottom of why we saw the test run twice.

@0xmichalis
Copy link
Contributor

This flaked in the merge queue yesterday: https://ci.openshift.redhat.com/jenkins/view/All/job/merge_pull_request_origin/1277/

If the problem is because we are pulling ruby gems, can we switch to a different build?

@bparees
Copy link
Contributor

bparees commented Jul 13, 2017

@Kargakis yours flaked on a php build :) So no, we probably are never going to get every test using a build ecosystem that's 100% reliable.

@0xmichalis
Copy link
Contributor

0xmichalis commented Jul 13, 2017 •
edited
Loading

Should jobs that are flakying, and we cannot fix, block merges then?

@bparees
Copy link
Contributor

bparees commented Jul 13, 2017

Should jobs that are flakying, and we cannot fix, block merges then?

yes.

our product is fundamentally based on the interconnection of services and external network access is part of that. we cannot refuse to test that functionality as part of our conformance merge requirements.

what we need is better flake retry logic.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
kind/test-flake Categorizes issue or PR as related to test flakes.
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
4 participants
@php-coder @0xmichalis @bparees @stevekuznetsov