You signed in with another tab or window. Reload to refresh your session.You signed out in another tab or window. Reload to refresh your session.You switched accounts on another tab or window. Reload to refresh your session.Dismiss alert
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/s2i_quota.go:55
Expected
<bool>: false
to be true
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/s2i_quota.go:40
This is also one of the places where using the built-in gOmega assertion comment would be nice ... would make it easier to describe the error than "expected false to be true"
full output below the fold:
Stacktrace
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/s2i_quota.go:55
Expected
<bool>: false
to be true
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/s2i_quota.go:40
Standard Output
[BeforeEach] [Top Level]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/util/test.go:47
[BeforeEach] [builds][Conformance] s2i build with a quota
/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
Jan 28 04:43:49.788: INFO: >>> kubeConfig: /tmp/openshift/test-extended/core/openshift.local.config/master/admin.kubeconfig
STEP: Building a namespace api object
Jan 28 04:43:49.804: INFO: configPath is now "/tmp/extended-test-s2i-build-quota-4h6xz-p784w-user.kubeconfig"
Jan 28 04:43:49.804: INFO: The user is now "extended-test-s2i-build-quota-4h6xz-p784w-user"
Jan 28 04:43:49.804: INFO: Creating project "extended-test-s2i-build-quota-4h6xz-p784w"
STEP: Waiting for a default service account to be provisioned in namespace
[JustBeforeEach] [builds][Conformance] s2i build with a quota
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/s2i_quota.go:28
STEP: waiting for builder service account
[It] should create an s2i build with a quota and run it
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/s2i_quota.go:55
STEP: calling oc create -f "/data/src/github.com/openshift/origin/test/extended/testdata/test-s2i-build-quota.json"
Jan 28 04:43:49.999: INFO: Running 'oc create --config=/tmp/extended-test-s2i-build-quota-4h6xz-p784w-user.kubeconfig --namespace=extended-test-s2i-build-quota-4h6xz-p784w -f /data/src/github.com/openshift/origin/test/extended/testdata/test-s2i-build-quota.json'
buildconfig "s2i-build-quota" created
STEP: starting a test build
Jan 28 04:43:50.280: INFO: Running 'oc start-build --config=/tmp/extended-test-s2i-build-quota-4h6xz-p784w-user.kubeconfig --namespace=extended-test-s2i-build-quota-4h6xz-p784w s2i-build-quota --from-dir /data/src/github.com/openshift/origin/test/extended/testdata/build-quota -o=name'
Jan 28 04:44:50.594: INFO: Error running &{/data/src/github.com/openshift/origin/_output/local/bin/linux/amd64/oc [oc start-build --config=/tmp/extended-test-s2i-build-quota-4h6xz-p784w-user.kubeconfig --namespace=extended-test-s2i-build-quota-4h6xz-p784w s2i-build-quota --from-dir /data/src/github.com/openshift/origin/test/extended/testdata/build-quota -o=name] [] Uploading directory "/data/src/github.com/openshift/origin/test/extended/testdata/build-quota" as binary input for the build ...
Error from server (ServerTimeout): the server cannot complete the requested operation at this time, try again later (post buildConfigs s2i-build-quota)
[] <nil> 0xc421257d40 exit status 1 <nil> <nil> true [0xc42044e770 0xc42044e798 0xc42044e7a8] [0xc42044e770 0xc42044e798 0xc42044e7a8] [0xc42044e778 0xc42044e790 0xc42044e7a0] [0x986010 0x986110 0x986110] 0xc4210554a0 <nil>}:
StdOut>
StdErr>
Uploading directory "/data/src/github.com/openshift/origin/test/extended/testdata/build-quota" as binary input for the build ...
Error from server (ServerTimeout): the server cannot complete the requested operation at this time, try again later (post buildConfigs s2i-build-quota)
start-build output with args [s2i-build-quota --from-dir /data/src/github.com/openshift/origin/test/extended/testdata/build-quota -o=name]:
Error>exit status 1
StdOut>
StdErr>
Uploading directory "/data/src/github.com/openshift/origin/test/extended/testdata/build-quota" as binary input for the build ...
Error from server (ServerTimeout): the server cannot complete the requested operation at this time, try again later (post buildConfigs s2i-build-quota)
*****************************************
Dumping Build Result: util.BuildResult{BuildPath:"", StartBuildStdErr:"Uploading directory \"/data/src/github.com/openshift/origin/test/extended/testdata/build-quota\" as binary input for the build ...\nError from server (ServerTimeout): the server cannot complete the requested operation at this time, try again later (post buildConfigs s2i-build-quota)", StartBuildStdOut:"", StartBuildErr:(*exec.ExitError)(0xc421c40020), BuildConfigName:"", Build:(*api.Build)(nil), BuildAttempt:false, BuildSuccess:false, BuildFailure:false, BuildCancelled:false, BuildTimeout:false, oc:(*util.CLI)(0xc420093e00)}
Jan 28 04:44:50.595: INFO: Running 'oc describe --config=/tmp/extended-test-s2i-build-quota-4h6xz-p784w-user.kubeconfig --namespace=extended-test-s2i-build-quota-4h6xz-p784w '
Jan 28 04:44:51.350: INFO: Error running &{/data/src/github.com/openshift/origin/_output/local/bin/linux/amd64/oc [oc describe --config=/tmp/extended-test-s2i-build-quota-4h6xz-p784w-user.kubeconfig --namespace=extended-test-s2i-build-quota-4h6xz-p784w ] [] a resource must be present, got: { }
a resource must be present, got: { }
a resource must be present, got: { }
a resource must be present, got: { }
[] <nil> 0xc421e16300 exit status 1 <nil> <nil> true [0xc42044e2c0 0xc42044e378 0xc42044e378] [0xc42044e2c0 0xc42044e378] [0xc42044e318 0xc42044e370] [0x986010 0x986110] 0xc4213e0120 <nil>}:
a resource must be present, got: { }
a resource must be present, got: { }
** Build Description:
Error during description retrieval: exit status 1
** Build Logs:
Error during log retrieval: Not enough information to retrieve logs for util.BuildResult{BuildPath:"", StartBuildStdErr:"Uploading directory \"/data/src/github.com/openshift/origin/test/extended/testdata/build-quota\" as binary input for the build ...\nError from server (ServerTimeout): the server cannot complete the requested operation at this time, try again later (post buildConfigs s2i-build-quota)", StartBuildStdOut:"", StartBuildErr:(*exec.ExitError)(0xc421c40020), BuildConfigName:"", Build:(*api.Build)(nil), BuildAttempt:false, BuildSuccess:false, BuildFailure:false, BuildCancelled:false, BuildTimeout:false, oc:(*util.CLI)(0xc420093e00)}
[AfterEach] [builds][Conformance] s2i build with a quota
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:142
STEP: Collecting events from namespace "extended-test-s2i-build-quota-4h6xz-p784w".
STEP: Found 4 events.
Jan 28 04:44:51.353: INFO: At 2017-01-28 04:43:51.614628637 -0500 EST - event for s2i-build-quota-1-build: {default-scheduler } Scheduled: Successfully assigned s2i-build-quota-1-build to 172.18.11.13
Jan 28 04:44:51.353: INFO: At 2017-01-28 04:44:09.182407397 -0500 EST - event for s2i-build-quota-1-build: {kubelet 172.18.11.13} Pulled: Container image "openshift/origin-sti-builder:954ade4" already present on machine
Jan 28 04:44:51.353: INFO: At 2017-01-28 04:44:43.141078621 -0500 EST - event for s2i-build-quota-1-build: {kubelet 172.18.11.13} Created: Created container with docker id 6b45d2cd44d7; Security:[seccomp=unconfined]
Jan 28 04:44:51.353: INFO: At 2017-01-28 04:44:43.681966722 -0500 EST - event for s2i-build-quota-1-build: {kubelet 172.18.11.13} Started: Started container with docker id 6b45d2cd44d7
Jan 28 04:44:51.358: INFO: POD NODE PHASE GRACE CONDITIONS
Jan 28 04:44:51.358: INFO: docker-registry-1-qdwj3 172.18.11.13 Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:38:00 -0500 EST } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:38:11 -0500 EST } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:38:00 -0500 EST }]
Jan 28 04:44:51.358: INFO: router-2-rn2b4 172.18.11.13 Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:38:44 -0500 EST } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:39:04 -0500 EST } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:38:44 -0500 EST }]
Jan 28 04:44:51.358: INFO: dns-test-3f41e6d1-e53e-11e6-ab7b-0e8944f0351e 172.18.11.13 Pending [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:39 -0500 EST } {Ready False 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:39 -0500 EST ContainersNotReady containers with unready status: [webserver querier jessie-querier]} {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:39 -0500 EST }]
Jan 28 04:44:51.358: INFO: pod-init-377a8a6b-e53e-11e6-9e31-0e8944f0351e 172.18.11.13 Pending [{Initialized False 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:26 -0500 EST ContainersNotInitialized containers with incomplete status: [init1 init2]} {Ready False 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:26 -0500 EST ContainersNotReady containers with unready status: [run1]} {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:26 -0500 EST }]
Jan 28 04:44:51.358: INFO: history-limit-10-deploy 172.18.11.13 Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:36 -0500 EST } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:42 -0500 EST } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:36 -0500 EST }]
Jan 28 04:44:51.359: INFO: history-limit-10-hook-pre 172.18.11.13 Pending [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:40 -0500 EST } {Ready False 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:40 -0500 EST ContainersNotReady containers with unready status: [lifecycle]} {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:39 -0500 EST }]
Jan 28 04:44:51.359: INFO: history-limit-7-29drx 172.18.11.13 Running 30s [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:03 -0500 EST } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:05 -0500 EST } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:03 -0500 EST }]
Jan 28 04:44:51.359: INFO: history-limit-8-3lvr7 172.18.11.13 Running 30s [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:14 -0500 EST } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:16 -0500 EST } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:13 -0500 EST }]
Jan 28 04:44:51.359: INFO: history-limit-9-t0fvd 172.18.11.13 Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:30 -0500 EST } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:34 -0500 EST } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:30 -0500 EST }]
Jan 28 04:44:51.359: INFO: s2i-build-quota-1-build 172.18.11.13 Pending [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:51 -0500 EST } {Ready False 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:51 -0500 EST ContainersNotReady containers with unready status: [sti-build]} {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:51 -0500 EST }]
Jan 28 04:44:51.359: INFO: endpoint-1 172.18.11.13 Pending [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:38 -0500 EST } {Ready False 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:38 -0500 EST ContainersNotReady containers with unready status: [test]} {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:38 -0500 EST }]
Jan 28 04:44:51.359: INFO: execpod 172.18.11.13 Running [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:38 -0500 EST } {Ready True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:44:08 -0500 EST } {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:38 -0500 EST }]
Jan 28 04:44:51.359: INFO: router-override 172.18.11.13 Pending [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:38 -0500 EST } {Ready False 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:38 -0500 EST ContainersNotReady containers with unready status: [router]} {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:38 -0500 EST }]
Jan 28 04:44:51.359: INFO: scoped-router 172.18.11.13 Pending [{Initialized True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:38 -0500 EST } {Ready False 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:38 -0500 EST ContainersNotReady containers with unready status: [router]} {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2017-01-28 04:43:38 -0500 EST }]
Jan 28 04:44:51.359: INFO:
Jan 28 04:44:51.360: INFO:
Logging node info for node 172.18.11.13
Jan 28 04:44:51.362: INFO: Node Info: &TypeMeta{Kind:,APIVersion:,}
Jan 28 04:44:51.362: INFO:
Logging kubelet events for node 172.18.11.13
Jan 28 04:44:51.364: INFO:
Logging pods the kubelet thinks is on node 172.18.11.13
Jan 28 04:44:51.373: INFO: history-limit-7-29drx started at 2017-01-28 04:43:03 -0500 EST (0+1 container statuses recorded)
Jan 28 04:44:51.373: INFO: Container myapp ready: true, restart count 0
Jan 28 04:44:51.373: INFO: docker-registry-1-qdwj3 started at 2017-01-28 04:38:00 -0500 EST (0+1 container statuses recorded)
Jan 28 04:44:51.373: INFO: Container registry ready: true, restart count 0
Jan 28 04:44:51.373: INFO: history-limit-10-deploy started at 2017-01-28 04:43:36 -0500 EST (0+1 container statuses recorded)
Jan 28 04:44:51.373: INFO: Container deployment ready: true, restart count 0
Jan 28 04:44:51.373: INFO: endpoint-1 started at 2017-01-28 04:43:38 -0500 EST (0+1 container statuses recorded)
Jan 28 04:44:51.373: INFO: Container test ready: false, restart count 0
Jan 28 04:44:51.373: INFO: s2i-build-quota-1-build started at 2017-01-28 04:43:51 -0500 EST (0+1 container statuses recorded)
Jan 28 04:44:51.373: INFO: Container sti-build ready: false, restart count 0
Jan 28 04:44:51.373: INFO: dns-test-3f41e6d1-e53e-11e6-ab7b-0e8944f0351e started at 2017-01-28 04:43:39 -0500 EST (0+3 container statuses recorded)
Jan 28 04:44:51.373: INFO: Container jessie-querier ready: false, restart count 0
Jan 28 04:44:51.373: INFO: Container querier ready: false, restart count 0
Jan 28 04:44:51.373: INFO: Container webserver ready: false, restart count 0
Jan 28 04:44:51.373: INFO: history-limit-10-hook-pre started at 2017-01-28 04:43:40 -0500 EST (0+1 container statuses recorded)
Jan 28 04:44:51.373: INFO: Container lifecycle ready: false, restart count 0
Jan 28 04:44:51.373: INFO: history-limit-8-3lvr7 started at 2017-01-28 04:43:14 -0500 EST (0+1 container statuses recorded)
Jan 28 04:44:51.373: INFO: Container myapp ready: true, restart count 0
Jan 28 04:44:51.373: INFO: pod-init-377a8a6b-e53e-11e6-9e31-0e8944f0351e started at 2017-01-28 04:43:26 -0500 EST (2+1 container statuses recorded)
Jan 28 04:44:51.373: INFO: Init container init1 ready: false, restart count 2
Jan 28 04:44:51.373: INFO: Init container init2 ready: false, restart count 0
Jan 28 04:44:51.373: INFO: Container run1 ready: false, restart count 0
Jan 28 04:44:51.373: INFO: execpod started at 2017-01-28 04:43:38 -0500 EST (0+1 container statuses recorded)
Jan 28 04:44:51.373: INFO: Container hostexec ready: true, restart count 0
Jan 28 04:44:51.373: INFO: router-2-rn2b4 started at 2017-01-28 04:38:44 -0500 EST (0+1 container statuses recorded)
Jan 28 04:44:51.373: INFO: Container router ready: true, restart count 0
Jan 28 04:44:51.373: INFO: router-override started at 2017-01-28 04:43:38 -0500 EST (0+1 container statuses recorded)
Jan 28 04:44:51.373: INFO: Container router ready: false, restart count 0
Jan 28 04:44:51.373: INFO: scoped-router started at 2017-01-28 04:43:38 -0500 EST (0+1 container statuses recorded)
Jan 28 04:44:51.373: INFO: Container router ready: false, restart count 0
Jan 28 04:44:51.373: INFO: history-limit-9-t0fvd started at 2017-01-28 04:43:30 -0500 EST (0+1 container statuses recorded)
Jan 28 04:44:51.373: INFO: Container myapp ready: true, restart count 0
Jan 28 04:45:15.012: INFO:
Latency metrics for node 172.18.11.13
Jan 28 04:45:15.012: INFO: {Operation:sync Method:pod_worker_latency_microseconds Quantile:0.9 Latency:2m1.045878s}
Jan 28 04:45:15.012: INFO: {Operation:sync Method:pod_worker_latency_microseconds Quantile:0.99 Latency:2m1.045878s}
Jan 28 04:45:15.012: INFO: {Operation: Method:pod_start_latency_microseconds Quantile:0.99 Latency:1m41.868983s}
Jan 28 04:45:15.012: INFO: {Operation: Method:pod_start_latency_microseconds Quantile:0.9 Latency:36.169432s}
Jan 28 04:45:15.012: INFO: {Operation:stop_container Method:docker_operations_latency_microseconds Quantile:0.99 Latency:31.736893s}
Jan 28 04:45:15.012: INFO: {Operation:SyncPod Method:container_manager_latency_microseconds Quantile:0.99 Latency:23.667357s}
Jan 28 04:45:15.012: INFO: {Operation: Method:pleg_relist_latency_microseconds Quantile:0.99 Latency:17.301734s}
Jan 28 04:45:15.012: INFO: {Operation:create_container Method:docker_operations_latency_microseconds Quantile:0.99 Latency:15.802966s}
Jan 28 04:45:15.012: INFO: {Operation:runContainerInPod Method:container_manager_latency_microseconds Quantile:0.99 Latency:15.551535s}
Jan 28 04:45:15.012: INFO: {Operation:createPodInfraContainer Method:container_manager_latency_microseconds Quantile:0.99 Latency:14.976178s}
Jan 28 04:45:15.012: INFO: {Operation:pull_image Method:docker_operations_latency_microseconds Quantile:0.99 Latency:14.433165s}
Jan 28 04:45:15.012: INFO: {Operation:pull_image Method:docker_operations_latency_microseconds Quantile:0.9 Latency:12.367992s}
STEP: Dumping a list of prepulled images on each node
Jan 28 04:45:15.015: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "extended-test-s2i-build-quota-4h6xz-p784w" for this suite.
Jan 28 04:46:00.058: INFO: namespace: extended-test-s2i-build-quota-4h6xz-p784w, resource: bindings, ignored listing per whitelist
The text was updated successfully, but these errors were encountered:
Seen here:
This is also one of the places where using the built-in gOmega assertion comment would be nice ... would make it easier to describe the error than "expected false to be true"
full output below the fold:
The text was updated successfully, but these errors were encountered: