Bug 772244

Summary: audrey client cannot contact configserver in CLI w/ proper oauth key
Product: [Retired] CloudForms Cloud Engine Reporter: dgao
Component: aeolus-audrey-agentAssignee: Greg Blomquist <gblomqui>
Status: CLOSED NOTABUG QA Contact: dgao
Severity: unspecified Docs Contact:
Priority: unspecified    
Version: 1.0.0CC: whayutin
Target Milestone: rc   
Target Release: ---   
Hardware: Unspecified   
OS: Unspecified   
Whiteboard:
Fixed In Version: Doc Type: Bug Fix
Doc Text:
Story Points: ---
Clone Of: Environment:
Last Closed: 2012-01-06 15:26:52 UTC Type: ---
Regression: --- Mount Type: ---
Documentation: --- CRM:
Verified Versions: Category: ---
oVirt Team: --- RHEL 7.3 requirements from Atomic Host:
Cloudforms Team: --- Target Upstream Version:
Bug Depends On:    
Bug Blocks: 744194    

Description dgao 2012-01-06 15:07:07 UTC 
===========
 on server
===========
[root@configserver-qe oauth]# hostname
configserver-qe.usersys.redhat.com
[root@configserver-qe oauth]# cat 485947589250167636280510
esHWDMfuCjLpqOCz2wqQa3Fll0q7HGnRwR3KOKh8UmLbvHXs[root@configserver-qe oauth]# 


==========
 on client
==========
[root@configserver-qe-client-1 log]# audrey -e https://configserver-qe.usersys.redhat.com -L DEBUG -k 485947589250167636280510
oAuth Secret: esHWDMfuCjLpqOCz2wqQa3Fll0q7HGnRwR3KOKh8UmLbvHXs
Traceback (most recent call last):
  File "/usr/bin/audrey", line 1387, in <module>
    audrey_script_main()
  File "/usr/bin/audrey", line 1381, in audrey_script_main
    _raise_ASError('Too many erroneous Config Server responses.')
  File "/usr/bin/audrey", line 94, in _raise_ASError
    raise ASError(err_msg)
__main__.ASError: Too many erroneous Config Server responses.


server log:
>> Writing PID to /var/run/aeolus-configserver/thin.pid
>> Changing process privilege to aeolus:aeolus
>> Thin web server (v1.2.11 codename Bat-Shit Crazy)
>> Maximum connections set to 1024
>> Listening on 127.0.0.1:4567, CTRL+C to stop
10.16.120.169 - - [06/Jan/2012 09:54:35] "GET /version/1/485947589250167636280510?oauth_nonce=84945350&oauth_timestamp=1325861772&oauth_consumer_key=485947589250167636280510&oauth_signature_method=HMAC-SHA1&oauth_version=1.0&oauth_signature=C0%2BTtbMdZ7JpsAmObB4eR5172so%3D HTTP/1.1" 404 18 0.0221
10.16.120.169 - - [06/Jan/2012 09:54:35] "GET /files/1/485947589250167636280510?oauth_nonce=12977326&oauth_timestamp=1325861772&oauth_consumer_key=485947589250167636280510&oauth_signature_method=HMAC-SHA1&oauth_version=1.0&oauth_signature=piNTxT0o4aBjchOBVvO92f4dR40%3D HTTP/1.1" 404 - 0.0044
10.16.120.169 - - [06/Jan/2012 09:54:35] "GET /configs/1/485947589250167636280510?oauth_nonce=28804410&oauth_timestamp=1325861772&oauth_consumer_key=485947589250167636280510&oauth_signature_method=HMAC-SHA1&oauth_version=1.0&oauth_signature=ACsjpK%2BRAYovwWpyWWfHBo23oks%3D HTTP/1.1" 404 - 0.0027
10.16.120.169 - - [06/Jan/2012 09:54:35] "GET /params/1/485947589250167636280510?oauth_nonce=23242538&oauth_timestamp=1325861772&oauth_consumer_key=485947589250167636280510&oauth_signature_method=HMAC-SHA1&oauth_version=1.0&oauth_signature=c2s8WKMgphBkucUSOl37u4hKXR8%3D HTTP/1.1" 404 - 0.0027
10.16.120.169 - - [06/Jan/2012 09:54:35] "PUT /params/1/485947589250167636280510 HTTP/1.1" 401 15 0.0072
10.16.120.169 - - [06/Jan/2012 09:54:45] "GET /configs/1/485947589250167636280510?oauth_nonce=62444333&oauth_timestamp=1325861782&oauth_consumer_key=485947589250167636280510&oauth_signature_method=HMAC-SHA1&oauth_version=1.0&oauth_signature=n%2FimiCdV9TgkTebD5S6fFr1%2F8dM%3D HTTP/1.1" 404 - 0.0033
10.16.120.169 - - [06/Jan/2012 09:54:45] "GET /params/1/485947589250167636280510?oauth_nonce=89876524&oauth_timestamp=1325861782&oauth_consumer_key=485947589250167636280510&oauth_signature_method=HMAC-SHA1&oauth_version=1.0&oauth_signature=tAFu5UnTnELmpVEPGwhXuqhho6o%3D HTTP/1.1" 404 - 0.0027
10.16.120.169 - - [06/Jan/2012 09:54:45] "PUT /params/1/485947589250167636280510 HTTP/1.1" 401 15 0.0062
10.16.120.169 - - [06/Jan/2012 09:54:55] "GET /configs/1/485947589250167636280510?oauth_nonce=4440271&oauth_timestamp=1325861792&oauth_consumer_key=485947589250167636280510&oauth_signature_method=HMAC-SHA1&oauth_version=1.0&oauth_signature=wpgmJDtpN9m52BJnSOHtx7l4eLA%3D HTTP/1.1" 404 - 0.0030
10.16.120.169 - - [06/Jan/2012 09:54:55] "GET /params/1/485947589250167636280510?oauth_nonce=23644535&oauth_timestamp=1325861792&oauth_consumer_key=485947589250167636280510&oauth_signature_method=HMAC-SHA1&oauth_version=1.0&oauth_signature=YDdnmlnuQ3Ko7c3CpO1LnVUW0rU%3D HTTP/1.1" 404 - 0.0027
10.16.120.169 - - [06/Jan/2012 09:54:55] "PUT /params/1/485947589250167636280510 HTTP/1.1" 401 15 0.0062
10.16.120.169 - - [06/Jan/2012 09:55:05] "GET /configs/1/485947589250167636280510?oauth_nonce=70517064&oauth_timestamp=1325861802&oauth_consumer_key=485947589250167636280510&oauth_signature_method=HMAC-SHA1&oauth_version=1.0&oauth_signature=2WwnD15gl3d9tKb%2Bjh%2BjCxoyDPs%3D HTTP/1.1" 404 - 0.0026
10.16.120.169 - - [06/Jan/2012 09:55:05] "GET /params/1/485947589250167636280510?oauth_nonce=51491266&oauth_timestamp=1325861802&oauth_consumer_key=485947589250167636280510&oauth_signature_method=HMAC-SHA1&oauth_version=1.0&oauth_signature=wy1WqvVCUNrwmrZwv1bzF6U%2BWqc%3D HTTP/1.1" 404 - 0.0026
10.16.120.169 - - [06/Jan/2012 09:55:05] "PUT /params/1/485947589250167636280510 HTTP/1.1" 401 15 0.0061
10.16.120.169 - - [06/Jan/2012 09:55:16] "GET /configs/1/485947589250167636280510?oauth_nonce=31352526&oauth_timestamp=1325861812&oauth_consumer_key=485947589250167636280510&oauth_signature_method=HMAC-SHA1&oauth_version=1.0&oauth_signature=55uVuuy0gyrIl2WkruK4ev7NLFA%3D HTTP/1.1" 404 - 0.0030
10.16.120.169 - - [06/Jan/2012 09:55:16] "GET /params/1/485947589250167636280510?oauth_nonce=50059918&oauth_timestamp=1325861812&oauth_consumer_key=485947589250167636280510&oauth_signature_method=HMAC-SHA1&oauth_version=1.0&oauth_signature=ycs00a1VGxeEo87oQeoa4pqckE4%3D HTTP/1.1" 404 - 0.0026
10.16.120.169 - - [06/Jan/2012 09:55:16] "PUT /params/1/485947589250167636280510 HTTP/1.1" 401 15 0.0060
10.16.120.169 - - [06/Jan/2012 09:55:26] "GET /configs/1/485947589250167636280510?oauth_nonce=59295609&oauth_timestamp=1325861823&oauth_consumer_key=485947589250167636280510&oauth_signature_method=HMAC-SHA1&oauth_version=1.0&oauth_signature=bWAiR25%2FMQOI5YSuW7hmxwQmylQ%3D HTTP/1.1" 404 - 0.0032
10.16.120.169 - - [06/Jan/2012 09:55:26] "GET /params/1/485947589250167636280510?oauth_nonce=77887992&oauth_timestamp=1325861823&oauth_consumer_key=485947589250167636280510&oauth_signature_method=HMAC-SHA1&oauth_version=1.0&oauth_signature=YK%2BGC86qlM2zZ3LSA73ZvO23SbI%3D HTTP/1.1" 404 - 0.0029
10.16.120.169 - - [06/Jan/2012 09:55:26] "PUT /params/1/485947589250167636280510 HTTP/1.1" 401 15 0.0065


client.log:

2012-01-06 09:56:12,543 - DEBUG   : audrey:1332 Process the Requires and Provides parameters
2012-01-06 09:56:12,543 - DEBUG   : audrey:1338 Config Parameter status: -1
2012-01-06 09:56:12,543 - DEBUG   : audrey:1339 Return Parameter status: -1
2012-01-06 09:56:12,544 - INFO    : audrey:899 Invoked CSClient.get_cs_configs()
2012-01-06 09:56:12,576 - INFO    : audrey:1354 No configuration parameters provided. status: 404
2012-01-06 09:56:12,576 - INFO    : audrey:914 Invoked CSClient.get_cs_params()
2012-01-06 09:56:12,607 - INFO    : audrey:929 Invoked CSClient.put_cs_params_values()
2012-01-06 09:56:12,643 - ERROR   : audrey:1374 Requiest to Config Server failed or more to come.
2012-01-06 09:56:12,643 - ERROR   : audrey:1376 Required Config Parameter status: 404
2012-01-06 09:56:12,643 - INFO    : audrey:1377 Return Parameter status: 401
2012-01-06 09:56:22,654 - DEBUG   : audrey:1338 Config Parameter status: 404
2012-01-06 09:56:22,654 - DEBUG   : audrey:1339 Return Parameter status: 401
2012-01-06 09:56:22,654 - INFO    : audrey:899 Invoked CSClient.get_cs_configs()
2012-01-06 09:56:22,688 - INFO    : audrey:1354 No configuration parameters provided. status: 404
2012-01-06 09:56:22,688 - INFO    : audrey:914 Invoked CSClient.get_cs_params()
2012-01-06 09:56:22,718 - INFO    : audrey:929 Invoked CSClient.put_cs_params_values()
2012-01-06 09:56:22,751 - ERROR   : audrey:1374 Requiest to Config Server failed or more to come.
2012-01-06 09:56:22,751 - ERROR   : audrey:1376 Required Config Parameter status: 404
2012-01-06 09:56:22,752 - INFO    : audrey:1377 Return Parameter status: 401
2012-01-06 09:56:32,752 - DEBUG   : audrey:1338 Config Parameter status: 404
2012-01-06 09:56:32,752 - DEBUG   : audrey:1339 Return Parameter status: 401
2012-01-06 09:56:32,753 - INFO    : audrey:899 Invoked CSClient.get_cs_configs()
2012-01-06 09:56:32,782 - INFO    : audrey:1354 No configuration parameters provided. status: 404
2012-01-06 09:56:32,782 - INFO    : audrey:914 Invoked CSClient.get_cs_params()
2012-01-06 09:56:32,810 - INFO    : audrey:929 Invoked CSClient.put_cs_params_values()
2012-01-06 09:56:32,843 - ERROR   : audrey:1374 Requiest to Config Server failed or more to come.
2012-01-06 09:56:32,843 - ERROR   : audrey:1376 Required Config Parameter status: 404
2012-01-06 09:56:32,843 - INFO    : audrey:1377 Return Parameter status: 401
2012-01-06 09:56:42,853 - DEBUG   : audrey:1338 Config Parameter status: 404
2012-01-06 09:56:42,854 - DEBUG   : audrey:1339 Return Parameter status: 401
2012-01-06 09:56:42,854 - INFO    : audrey:899 Invoked CSClient.get_cs_configs()
2012-01-06 09:56:42,884 - INFO    : audrey:1354 No configuration parameters provided. status: 404
2012-01-06 09:56:42,884 - INFO    : audrey:914 Invoked CSClient.get_cs_params()
2012-01-06 09:56:42,912 - INFO    : audrey:929 Invoked CSClient.put_cs_params_values()
2012-01-06 09:56:42,944 - ERROR   : audrey:1374 Requiest to Config Server failed or more to come.
2012-01-06 09:56:42,944 - ERROR   : audrey:1376 Required Config Parameter status: 404
2012-01-06 09:56:42,944 - INFO    : audrey:1377 Return Parameter status: 401
2012-01-06 09:56:52,955 - DEBUG   : audrey:1338 Config Parameter status: 404
2012-01-06 09:56:52,955 - DEBUG   : audrey:1339 Return Parameter status: 401
2012-01-06 09:56:52,955 - INFO    : audrey:899 Invoked CSClient.get_cs_configs()
2012-01-06 09:56:52,998 - INFO    : audrey:1354 No configuration parameters provided. status: 404
2012-01-06 09:56:52,999 - INFO    : audrey:914 Invoked CSClient.get_cs_params()
2012-01-06 09:56:53,027 - INFO    : audrey:929 Invoked CSClient.put_cs_params_values()
2012-01-06 09:56:53,059 - ERROR   : audrey:1374 Requiest to Config Server failed or more to come.
2012-01-06 09:56:53,060 - ERROR   : audrey:1376 Required Config Parameter status: 404
2012-01-06 09:56:53,060 - INFO    : audrey:1377 Return Parameter status: 401
2012-01-06 09:57:03,060 - DEBUG   : audrey:1338 Config Parameter status: 404
2012-01-06 09:57:03,061 - DEBUG   : audrey:1339 Return Parameter status: 401
2012-01-06 09:57:03,061 - INFO    : audrey:899 Invoked CSClient.get_cs_configs()
2012-01-06 09:57:03,092 - INFO    : audrey:1354 No configuration parameters provided. status: 404
2012-01-06 09:57:03,092 - INFO    : audrey:914 Invoked CSClient.get_cs_params()
2012-01-06 09:57:03,123 - INFO    : audrey:929 Invoked CSClient.put_cs_params_values()
2012-01-06 09:57:03,157 - ERROR   : audrey:1374 Requiest to Config Server failed or more to come.
2012-01-06 09:57:03,157 - ERROR   : audrey:1376 Required Config Parameter status: 404
2012-01-06 09:57:03,157 - INFO    : audrey:1377 Return Parameter status: 401
2012-01-06 09:57:03,157 - ERROR   : audrey:93 Too many erroneous Config Server responses.
Comment 1 dgao 2012-01-06 15:26:52 UTC 
Closing because I'm generating the oauth pair w/o an associated instance. This is incorrect.
Comment 2 James Laska 2012-02-10 14:10:01 UTC 
Reassigning to proper 'aeolus-audrey-agent' component.