Re: [openstack-dev] devstack exercise test failed at euca-register
bump. any input is appreciated. On Thu, Aug 15, 2013 at 5:04 PM, XINYU ZHAO wrote: > Updated every project to the latest. but each time i ran devstack, the > exercise test failed at the same place bundle.sh > Any hints? > > In console.log > > Uploaded image as testbucket/bundle.img.manifest.xml > ++ euca-register testbucket/bundle.img.manifest.xml > ++ cut -f2 > + AMI='S3ResponseError: Unknown error occured.' > + die_if_not_set 57 AMI 'Failure registering testbucket/bundle.img' > + local exitcode=0 > ++ set +o > ++ grep xtrace > + FXTRACE='set -o xtrace' > + set +o xtrace > + timeout 15 sh -c 'while euca-describe-images | grep S3ResponseError: > Unknown error occured. | grep -q available; do sleep 1; done' > grep: Unknown: No such file or directory > grep: error: No such file or directory > grep: occured.: No such file or directory > close failed in file object destructor: > sys.excepthook is missing > lost sys.stderr > + euca-deregister S3ResponseError: Unknown error occured. > Only 1 argument (image_id) permitted > + die 65 'Failure deregistering S3ResponseError: Unknown error occured.' > + local exitcode=1 > + set +o xtrace > [Call Trace] > /opt/stack/new/devstack/exercises/bundle.sh:65:die > [ERROR] /opt/stack/new/devstack/exercises/bundle.sh:65 Failure deregistering > S3ResponseError: Unknown error occured. > > > > Here is what recorded in n-api log. > > 2013-08-15 15:44:20.331 27003 DEBUG nova.utils [-] Reloading cached file > /etc/nova/policy.json read_cached_file /opt/stack/new/nova/nova/utils.py:814 > 2013-08-15 15:44:20.363 DEBUG nova.api.ec2 > [req-5599cc0f-35b5-4451-9c96-88b48cc4600e demo demo] action: RegisterImage > __call__ /opt/stack/new/nova/nova/api/ec2/__init__.py:325 > 2013-08-15 15:44:20.364 DEBUG nova.api.ec2 > [req-5599cc0f-35b5-4451-9c96-88b48cc4600e demo demo] arg: Architecture > val: i386 __call__ /opt/stack/new/nova/nova/api/ec2/__init__.py:328 > 2013-08-15 15:44:20.364 DEBUG nova.api.ec2 > [req-5599cc0f-35b5-4451-9c96-88b48cc4600e demo demo] arg: ImageLocation > val: testbucket/bundle.img.manifest.xml __call__ > /opt/stack/new/nova/nova/api/ec2/__init__.py:328 > 2013-08-15 15:44:20.370 CRITICAL nova.api.ec2 > [req-5599cc0f-35b5-4451-9c96-88b48cc4600e demo demo] Unexpected > S3ResponseError raised > 2013-08-15 15:44:20.370 CRITICAL nova.api.ec2 > [req-5599cc0f-35b5-4451-9c96-88b48cc4600e demo demo] Environment: > {"CONTENT_TYPE": "application/x-www-form-urlencoded; charset=UTF-8", > "SCRIPT_NAME": "/services/Cloud", "REQUEST_METHOD": "POST", "HTTP_HOST": > "127.0.0.1:8773", "PATH_INFO": "/", "SERVER_PROTOCOL": "HTTP/1.0", > "HTTP_USER_AGENT": "Boto/2.10.0 (linux2)", "RAW_PATH_INFO": > "/services/Cloud/", "REMOTE_ADDR": "127.0.0.1", "REMOTE_PORT": "44294", > "wsgi.url_scheme": "http", "SERVER_NAME": "127.0.0.1", "SERVER_PORT": "8773", > "GATEWAY_INTERFACE": "CGI/1.1", "HTTP_ACCEPT_ENCODING": "identity"} > 2013-08-15 15:44:20.371 DEBUG nova.api.ec2.faults > [req-5599cc0f-35b5-4451-9c96-88b48cc4600e demo demo] EC2 error response: > S3ResponseError: Unknown error occured. ec2_error_response > /opt/stack/new/nova/nova/api/ec2/faults.py:31 > 2013-08-15 15:44:20.371 INFO nova.api.ec2 > [req-5599cc0f-35b5-4451-9c96-88b48cc4600e demo demo] 0.109800s 127.0.0.1 POST > /services/Cloud/ CloudController:RegisterImage 400 [Boto/2.10.0 (linux2)] > application/x-www-form-urlencoded text/xml > 2013-08-15 15:44:20.379 INFO nova.ec2.wsgi.server > [req-5599cc0f-35b5-4451-9c96-88b48cc4600e demo demo] 127.0.0.1 "POST > /services/Cloud/ HTTP/1.1" status: 400 len: 317 time: 0.1177399 > > > execute manually on the machine: > > euca-register testbucket/bundle.img.manifest.xml --debug > 2013-08-15 17:00:19,446 euca2ools [DEBUG]:Using access key provided by client. > 2013-08-15 17:00:19,446 euca2ools [DEBUG]:Using secret key provided by client. > 2013-08-15 17:00:19,446 euca2ools [DEBUG]:Method: POST > 2013-08-15 17:00:19,447 euca2ools [DEBUG]:Path: /services/Cloud/ > 2013-08-15 17:00:19,447 euca2ools [DEBUG]:Data: > 2013-08-15 17:00:19,447 euca2ools [DEBUG]:Headers: {} > 2013-08-15 17:00:19,447 euca2ools [DEBUG]:Host: 127.0.0.1:8773 > 2013-08-15 17:00:19,447 euca2ools [DEBUG]:Params: {'Action': 'RegisterImage', > 'Version': '2009-11-30', 'Architecture': 'i386', 'ImageLocation': > 'testbucket/bundle.img.manifest.xml'} > 2013-08-15 17:00:19,447 euca2ools [DEBUG]:establishing HTTP connection: > kwargs={'timeout': 70} > 2013-08-15 17:00:19,447 euca2ools [DEBUG]:Token: None > 2013-08-15 17:00:19,447 euca2ools [DEBUG]:using _calc_signature_2 > 2013-08-15 17:00:19,448 euca2ools [DEBUG]:query string: > AWSAccessKeyId=4b14f2d81b9045fdb3a0c989d283ebbe&Action=RegisterImage&Architecture=i386&ImageLocation=testbucket%2Fbundle.img.manifest.xml&SignatureMethod=HmacSHA256&SignatureVersion=2&Timestamp=2013-08-16T00%3A00%3A19Z&Version=2009-11-30 > 2013-08-15 17:00:19,448 euca2ools [DEBUG]:string_to_sign: POST127.0.0.1:8773 > /services/Cloud/ > AWSAccessKeyId=4b14f2d8
Re: [openstack-dev] devstack exercise test failed at euca-register
without proxy , the test case is PASS. with proxy set in localrc, euca-register will fail with a 400 code. it is weird that even 127.0.0.1 is already included in no_proxy and it turned out that the api was never through proxy. Here I did a capture of both with and without proxy scenario, doing a comparison will see that they are basically the same except the former received 400 bad request code: POST /services/Cloud/ HTTP/1.1 Host: 127.0.0.1:8773 Accept-Encoding: identity Content-Length: 296 Content-Type: application/x-www-form-urlencoded; charset=UTF-8 User-Agent: Boto/2.10.0 (linux2) AWSAccessKeyId=3cfbdaae44a94dc59959d0d88bfc4f9c&Action=RegisterImage&Architecture=i386&ImageLocation=testbucket%2Fbundle.img.manifest.xml&SignatureMethod=HmacSHA256&SignatureVersion=2&Timestamp=2013-08-17T01%3A24%3A51Z&Version=2009-11-30&Signature=jk8G7EpYn2mcjxQFT%2B53Lgg4usdxviKwpvXfLnxYrHI%3DHTTP/1.1 400 Bad Request Content-Type: text/xml Content-Length: 207 Date: Sat, 17 Aug 2013 01:24:51 GMT S3ResponseErrorUnknown error occured.req-d2138d8f-6363-4b65-b793-a2bb2d12baee Without proxy: POST /services/Cloud/ HTTP/1.1 Host: 127.0.0.1:8773 Accept-Encoding: identity Content-Length: 296 Content-Type: application/x-www-form-urlencoded; charset=UTF-8 User-Agent: Boto/2.10.0 (linux2) AWSAccessKeyId=b8a07080b7394dfea0954dcd13a95aca&Action=RegisterImage&Architecture=i386&ImageLocation=testbucket%2Fbundle.img.manifest.xml&SignatureMethod=HmacSHA256&SignatureVersion=2&Timestamp=2013-08-17T01%3A47%3A42Z&Version=2009-11-30&Signature=IV4heXI0GGp2a7gg90ZratX%2F2RxPbmqK6al26g72azM%3DHTTP/1.1 200 OK Content-Type: text/xml Content-Length: 198 Date: Sat, 17 Aug 2013 01:47:43 GMT http://ec2.amazonaws.com/doc/2009-11-30/";> req-6ea23353-5902-4ac3-b298-13bd841d9409 ami-0001 On Fri, Aug 16, 2013 at 9:38 AM, XINYU ZHAO wrote: > bump. > any input is appreciated. > > > On Thu, Aug 15, 2013 at 5:04 PM, XINYU ZHAO wrote: > >> Updated every project to the latest. but each time i ran devstack, the >> exercise test failed at the same place bundle.sh >> Any hints? >> >> In console.log >> >> Uploaded image as testbucket/bundle.img.manifest.xml >> ++ euca-register testbucket/bundle.img.manifest.xml >> ++ cut -f2 >> + AMI='S3ResponseError: Unknown error occured.' >> + die_if_not_set 57 AMI 'Failure registering testbucket/bundle.img' >> + local exitcode=0 >> ++ set +o >> ++ grep xtrace >> + FXTRACE='set -o xtrace' >> + set +o xtrace >> + timeout 15 sh -c 'while euca-describe-images | grep S3ResponseError: >> Unknown error occured. | grep -q available; do sleep 1; done' >> grep: Unknown: No such file or directory >> grep: error: No such file or directory >> grep: occured.: No such file or directory >> close failed in file object destructor: >> sys.excepthook is missing >> lost sys.stderr >> + euca-deregister S3ResponseError: Unknown error occured. >> Only 1 argument (image_id) permitted >> + die 65 'Failure deregistering S3ResponseError: Unknown error occured.' >> + local exitcode=1 >> + set +o xtrace >> [Call Trace] >> /opt/stack/new/devstack/exercises/bundle.sh:65:die >> [ERROR] /opt/stack/new/devstack/exercises/bundle.sh:65 Failure deregistering >> S3ResponseError: Unknown error occured. >> >> >> >> Here is what recorded in n-api log. >> >> 2013-08-15 15:44:20.331 27003 DEBUG nova.utils [-] Reloading cached file >> /etc/nova/policy.json read_cached_file /opt/stack/new/nova/nova/utils.py:814 >> 2013-08-15 15:44:20.363 DEBUG nova.api.ec2 >> [req-5599cc0f-35b5-4451-9c96-88b48cc4600e demo demo] action: RegisterImage >> __call__ /opt/stack/new/nova/nova/api/ec2/__init__.py:325 >> 2013-08-15 15:44:20.364 DEBUG nova.api.ec2 >> [req-5599cc0f-35b5-4451-9c96-88b48cc4600e demo demo] arg: Architecture >> val: i386 __call__ /opt/stack/new/nova/nova/api/ec2/__init__.py:328 >> 2013-08-15 15:44:20.364 DEBUG nova.api.ec2 >> [req-5599cc0f-35b5-4451-9c96-88b48cc4600e demo demo] arg: ImageLocation >> val: testbucket/bundle.img.manifest.xml __call__ >> /opt/stack/new/nova/nova/api/ec2/__init__.py:328 >> 2013-08-15 15:44:20.370 CRITICAL nova.api.ec2 >> [req-5599cc0f-35b5-4451-9c96-88b48cc4600e demo demo] Unexpected >> S3ResponseError raised >> 2013-08-15 15:44:20.370 CRITICAL nova.api.ec2 >> [req-5599cc0f-35b5-4451-9c96-88b48cc4600e demo demo] Environment: >> {"CONTENT_TYPE": "application/x-www-form-urlencoded; charset=UTF-8", >> "SCRIPT_NAME": "/services/Cloud", "REQUEST_METHOD": "POST", "HTTP_HOST": >> "127.0.0.1:8773", "PATH_INFO": "/", "SERVER_PROTOCOL": "HTTP/1.0", >> "HTTP_USER_AGENT": "Boto/2.10.0 (linux2)", "RAW_PATH_INFO": >> "/services/Cloud/", "REMOTE_ADDR": "127.0.0.1", "REMOTE_PORT": "44294", >> "wsgi.url_scheme": "http", "SERVER_NAME": "127.0.0.1", "SERVER_PORT": >> "8773", "GATEWAY_INTERFACE": "CGI/1.1", "HTTP_ACCEPT_ENCODING": "identity"} >> 2013-08-15 15:44:20.371 DEBUG nova.api.ec2.faults >> [req-5599cc0f-35b5-4451-9c96-88b48cc4600e demo demo] EC2 error response: >