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.

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

[ ERR] Gave up waiting for: '[[ "$(curl -s -X POST http://${FRONTEND_IP}:5432/keys/foo -d value=1337)" = "Key created" ]]' #9512

Closed
deads2k opened this issue Jun 23, 2016 · 15 comments · Fixed by #9676
Assignees
Labels
kind/test-flake Categorizes issue or PR as related to test flakes. priority/P2

Comments

@deads2k
Copy link
Contributor

deads2k commented Jun 23, 2016

from e2e: https://ci.openshift.redhat.com/jenkins/job/test_pull_requests_origin_integration/2370

[INFO] Waiting for command to finish: '[[ "$(curl -s -X POST http://${FRONTEND_IP}:5432/keys/foo -d value=1337)" = "Key created" ]]'...
[ ERR] Gave up waiting for: '[[ "$(curl -s -X POST http://${FRONTEND_IP}:5432/keys/foo -d value=1337)" = "Key created" ]]'
[ERROR] PID 31876: test/end-to-end/core.sh:306: `return 1` exited with status 1.
@deads2k deads2k added priority/P2 kind/test-flake Categorizes issue or PR as related to test flakes. labels Jun 23, 2016
@deads2k
Copy link
Contributor Author

deads2k commented Jun 23, 2016

@bparees are you familiar with the e2e app? My look at the logs suggests that it should be successfully POSTing.

@bparees
Copy link
Contributor

bparees commented Jun 23, 2016

yeah, it's not obvious to me. based on the output it appears the curl request never even got to the app (the wait_for_command timed out on the curl, it didn't return a failure code).

if we have container logs for the app pod, that might shed some light, but given that the welcome page returned successfully it seems like the app is working, unless the DB connection failed.

@deads2k
Copy link
Contributor Author

deads2k commented Jun 23, 2016

if we have container logs for the app pod, that might shed some light, but given that the welcome page returned successfully it seems like the app is working, unless the DB connection failed.

Those are attached to the jenkins job under status and labeled with the container names. There are actually two pods started and they both seem to be getting the POSTs.

@smarterclayton
Copy link
Contributor

Hrm, I've never seen that one fail before (or not in months).

@bparees
Copy link
Contributor

bparees commented Jun 23, 2016

yeah was just looking at the posts... sure looks like the app is getting the post and responding with a 200. No idea why curl isn't getting that response back.

@deads2k
Copy link
Contributor Author

deads2k commented Jun 23, 2016

Hrm, I've never seen that one fail before (or not in months).

It was triggering the SCC flake issue people started linking recently, so something broke.

@bparees
Copy link
Contributor

bparees commented Jun 28, 2016

this happened again here:
https://ci.openshift.redhat.com/jenkins/job/test_pull_requests_origin_integration/2587/consoleFull

given that the app is responding with a 200, i'm inclined to question whether the service proxy is getting the response to the client...

@knobunc see the failure here:

[ ERR] Gave up waiting for: '[[ "$(curl -s -X POST http://${FRONTEND_IP}:5432/keys/foo -d value=1337)" = "Key created" ]]'

which comes from this test:
https://github.com/openshift/origin/blob/master/test/end-to-end/core.sh#L42

and you can see the app pod logs returning 200 for the POST operation here:
https://ci.openshift.redhat.com/jenkins/job/test_pull_requests_origin_integration/2587/artifact/origin/artifacts/test-end-to-end-docker/logs/container-frontend-1-3bk00-ruby-helloworld.log
https://ci.openshift.redhat.com/jenkins/job/test_pull_requests_origin_integration/2587/artifact/origin/artifacts/test-end-to-end-docker/logs/container-frontend-1-43l9r-ruby-helloworld.log

@gabemontero
Copy link
Contributor

@bparees
Copy link
Contributor

bparees commented Jul 1, 2016

i've been seeing this one a lot the last couple days. I don't feel totally convinced by my service proxy theory, but I'm not sure what else it could be. Per @deads2k suggestion i'm going to update the curl command to report what it is getting back, in case that offers more insight.

@bparees
Copy link
Contributor

bparees commented Jul 1, 2016

attempting to recreate w/ full shell debug here:
#9676

@bparees bparees assigned bparees and unassigned knobunc Jul 2, 2016
@bparees
Copy link
Contributor

bparees commented Jul 2, 2016

further debugging on this issue has revealed we're getting back "key updated" instead of "key created" because apparently one of the earlier curl commands actually succeeded in creating the key, despite curl returning an RC=7(??).

will see if i can tighten up the logic that's testing the responses.

@deads2k
Copy link
Contributor Author

deads2k commented Jul 5, 2016

@deads2k deads2k reopened this Jul 5, 2016
@deads2k deads2k assigned stevekuznetsov and unassigned bparees Jul 5, 2016
@bparees
Copy link
Contributor

bparees commented Jul 5, 2016

dupe of #9685

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

Successfully merging a pull request may close this issue.

7 participants