[openstack-dev] devstack exercise test failed at euca-register

XINYU ZHAO xyzjerry at gmail.com
Sat Aug 17 02:02:54 UTC 2013


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



<?xml version="1.0"?>
<Response><Errors><Error><Code>S3ResponseError</Code><Message>Unknown error
occured.</Message></Error></Errors><RequestID>req-d2138d8f-6363-4b65-b793-a2bb2d12baee</RequestID></Response>





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



<RegisterImageResponse xmlns="http://ec2.amazonaws.com/doc/2009-11-30/">
  <requestId>req-6ea23353-5902-4ac3-b298-13bd841d9409</requestId>
  <imageId>ami-00000001</imageId>
</RegisterImageResponse>




On Fri, Aug 16, 2013 at 9:38 AM, XINYU ZHAO <xyzjerry at gmail.com> wrote:

> bump.
> any input is appreciated.
>
>
> On Thu, Aug 15, 2013 at 5:04 PM, XINYU ZHAO <xyzjerry at gmail.com> 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=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]:len(b64)=44
>> 2013-08-15 17:00:19,448 euca2ools [DEBUG]:base64 encoded digest: WXvtpXvmsFBMpsEE1u4FT33DBq3SuFEzC+AEOhwU7+g=
>> 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 Signature: WXvtpXvmsFBMpsEE1u4FT33DBq3SuFEzC+AEOhwU7+g=
>> send: 'POST /services/Cloud/ HTTP/1.1\r\nHost: 127.0.0.1:8773\r\nAccept-Encoding: identity\r\nContent-Length: 298\r\nContent-Type: application/x-www-form-urlencoded; charset=UTF-8\r\nUser-Agent: Boto/2.10.0 (linux2)\r\n\r\nAWSAccessKeyId=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&Signature=WXvtpXvmsFBMpsEE1u4FT33DBq3SuFEzC%2BAEOhwU7%2Bg%3D'
>> reply: 'HTTP/1.1 400 Bad Request\r\n'
>> header: Content-Type: text/xml
>> header: Content-Length: 207
>> header: Date: Fri, 16 Aug 2013 00:00:19 GMT
>> 2013-08-15 17:00:19,528 euca2ools [DEBUG]:<?xml version="1.0"?>
>> <Response><Errors><Error><Code>S3ResponseError</Code><Message>Unknown error occured.</Message></Error></Errors><RequestID>req-d55b7228-4483-4530-882f-302ea13d1857</RequestID></Response>
>> 2013-08-15 17:00:19,528 euca2ools [ERROR]:400 Bad Request
>> 2013-08-15 17:00:19,528 euca2ools [ERROR]:<?xml version="1.0"?>
>> <Response><Errors><Error><Code>S3ResponseError</Code><Message>Unknown error occured.</Message></Error></Errors><RequestID>req-d55b7228-4483-4530-882f-302ea13d1857</RequestID></Response>
>> S3ResponseError: Unknown error occured.
>>
>>
>>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.openstack.org/pipermail/openstack-dev/attachments/20130816/3b50b604/attachment.html>


More information about the OpenStack-dev mailing list