SOLUM_TASK_DIR No initialization

[caowei]

2016-08-02 03:06:57.356 65412 DEBUG solum.worker.handlers.shell [-] Building languagepack java build_lp /opt/stack/solum/solum/worker/handlers/shell.py:684
2016-08-02 03:06:57.357 65412 DEBUG solum.worker.handlers.shell [-] Updating languagepack java status to BUILDING and external_ref to None update_lp_status /opt/stack/solum/solum/worker/handlers/shell.py:157
2016-08-02 03:06:57.454 65412 DEBUG oslo_messaging._drivers.amqpdriver [-] CAST unique_id: 913a2152530a4e19800905427356288f exchange 'openstack' topic 'solum-conductor' _send /usr/local/lib/python2.7/dist-packages/oslo_messaging/_drivers/amqpdriver.py:448
2016-08-02 03:06:57.462 65412 DEBUG keystoneclient.auth.identity.v3.base [-] Making authentication request to http://192.168.132.152/identity/v3/auth/tokens get_auth_ref /usr/local/lib/python2.7/dist-packages/keystoneclient/auth/identity/v3/base.py:189
2016-08-02 03:06:57.589 65412 DEBUG keystoneclient.session [-] Request returned failure status: 401 request /usr/local/lib/python2.7/dist-packages/keystoneclient/session.py:418
2016-08-02 03:06:57.589 65412 DEBUG keystoneclient.v3.client [-] Authorization failed. get_raw_token_from_identity_service /usr/local/lib/python2.7/dist-packages/keystoneclient/v3/client.py:309
2016-08-02 03:06:57.590 65412 ERROR solum.worker.handlers.shell [-] Failed to successfully get environment for building languagepack: `1`
2016-08-02 03:06:57.590 65412 ERROR solum.worker.handlers.shell Traceback (most recent call last):
2016-08-02 03:06:57.590 65412 ERROR solum.worker.handlers.shell File "/opt/stack/solum/solum/worker/handlers/shell.py", line 702, in build_lp
2016-08-02 03:06:57.590 65412 ERROR solum.worker.handlers.shell lp_access=lp_access)
2016-08-02 03:06:57.590 65412 ERROR solum.worker.handlers.shell File "/opt/stack/solum/solum/common/exception.py", line 222, in wrapped
2016-08-02 03:06:57.590 65412 ERROR solum.worker.handlers.shell % sys.exc_info()[1])
2016-08-02 03:06:57.590 65412 ERROR solum.worker.handlers.shell AuthorizationFailure: _get_environment connection failed. unexpected keystone client error occurred: The request you have made requires authentication. (HTTP 401) (Request-ID: req-544a528f-99b9-48b9-a07a-c317b712badd)
2016-08-02 03:06:57.590 65412 ERROR solum.worker.handlers.shell
2016-08-02 03:06:57.674 65412 ERROR solum.worker.handlers.shell [-] _get_environment connection failed. unexpected keystone client error occurred: The request you have made requires authentication. (HTTP 401) (Request-ID: req-544a528f-99b9-48b9-a07a-c317b712badd)
2016-08-02 03:06:57.674 65412 ERROR solum.worker.handlers.shell Traceback (most recent call last):
2016-08-02 03:06:57.674 65412 ERROR solum.worker.handlers.shell File "/opt/stack/solum/solum/worker/handlers/shell.py", line 702, in build_lp
2016-08-02 03:06:57.674 65412 ERROR solum.worker.handlers.shell lp_access=lp_access)
2016-08-02 03:06:57.674 65412 ERROR solum.worker.handlers.shell File "/opt/stack/solum/solum/common/exception.py", line 222, in wrapped
2016-08-02 03:06:57.674 65412 ERROR solum.worker.handlers.shell % sys.exc_info()[1])
2016-08-02 03:06:57.674 65412 ERROR solum.worker.handlers.shell AuthorizationFailure: _get_environment connection failed. unexpected keystone client error occurred: The request you have made requires authentication. (HTTP 401) (Request-ID: req-544a528f-99b9-48b9-a07a-c317b712badd)
2016-08-02 03:06:57.674 65412 ERROR solum.worker.handlers.shell
2016-08-02 03:06:57.677 65412 ERROR oslo_messaging.rpc.server [-] Exception during message handling
2016-08-02 03:06:57.677 65412 ERROR oslo_messaging.rpc.server Traceback (most recent call last):
2016-08-02 03:06:57.677 65412 ERROR oslo_messaging.rpc.server File "/usr/local/lib/python2.7/dist-packages/oslo_messaging/rpc/server.py", line 133, in _process_incoming
2016-08-02 03:06:57.677 65412 ERROR oslo_messaging.rpc.server res = self.dispatcher.dispatch(message)
2016-08-02 03:06:57.677 65412 ERROR oslo_messaging.rpc.server File "/usr/local/lib/python2.7/dist-packages/oslo_messaging/rpc/dispatcher.py", line 150, in dispatch
2016-08-02 03:06:57.677 65412 ERROR oslo_messaging.rpc.server return self._do_dispatch(endpoint, method, ctxt, args)
2016-08-02 03:06:57.677 65412 ERROR oslo_messaging.rpc.server File "/usr/local/lib/python2.7/dist-packages/oslo_messaging/rpc/dispatcher.py", line 121, in _do_dispatch
2016-08-02 03:06:57.677 65412 ERROR oslo_messaging.rpc.server result = func(ctxt, **new_args)
2016-08-02 03:06:57.677 65412 ERROR oslo_messaging.rpc.server File "/opt/stack/solum/solum/worker/handlers/shell.py", line 718, in build_lp
2016-08-02 03:06:57.677 65412 ERROR oslo_messaging.rpc.server logpath = "%s/%s-%s.log" % (user_env['SOLUM_TASK_DIR'],
2016-08-02 03:06:57.677 65412 ERROR oslo_messaging.rpc.server KeyError: 'SOLUM_TASK_DIR'
2016-08-02 03:06:57.677 65412 ERROR oslo_messaging.rpc.server

[OpenStack Infra (hudson-openstack)]

Fix proposed to branch: master
Review: https://review.openstack.org/350583

[OpenStack Infra (hudson-openstack)]

Change abandoned by Wei Cao ([e-mail]) on branch: master
Review: https://review.openstack.org/350583

[Devdatta Kulkarni (devdatta-kulkarni)]

This is similar to the other bug related to the deployer log file not getting created.

In this particular instance this seems to happen if for some reason the SOLUM_TASK_DIR is not set in the user_env dictionary.

When this happens, it is indicative of something else going wrong such as the Keystone authorization failure that we see in the stacktrace. So probably there is nothing for us to fix here as we do want to fail in such cases. However, what we can do is we can add a check to see if SOLUM_TASK_DIR attribute is available in the user_env dictionary or not. If it is not, then we can raise an exception.

Can you propose a patch for this?