Attachment 868860 Details for Bug 1071123 – creating jbosseap log in development.log

creating jbosseap log in development.log

development_jbosseap_log.txt (text/plain), 41.27 KB, created by chunchen on 2014-02-28 06:25:30 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: chunchen

Created: 2014-02-28 06:25:30 UTC

Size: 41.27 KB

patch

obsolete

>2014-02-28 00:57:50.170 [INFO ] Started GET "/broker/rest/api" for 203.114.244.88 at 2014-02-28 00:57:50 -0500 (pid:3043)
>2014-02-28 00:57:50.172 [INFO ] Processing by ApiController#show as JSON (pid:3043)
>2014-02-28 00:57:50.172 [DEBUG] API version 1.3 (pid:3043)
>2014-02-28 00:57:50.283 [INFO ] Completed 200 OK in 111ms (Views: 106.8ms) (pid:3043)
>2014-02-28 00:57:50.590 [INFO ] Started GET "/broker/rest/api" for 203.114.244.88 at 2014-02-28 00:57:50 -0500 (pid:3043)
>2014-02-28 00:57:50.591 [INFO ] Processing by ApiController#show as JSON (pid:3043)
>2014-02-28 00:57:50.591 [DEBUG] API version 1.6 (pid:3043)
>2014-02-28 00:57:50.612 [INFO ] Completed 200 OK in 21ms (Views: 16.9ms) (pid:3043)
>2014-02-28 00:57:50.937 [INFO ] Started GET "/broker/rest/cartridges" for 203.114.244.88 at 2014-02-28 00:57:50 -0500 (pid:3043)
>2014-02-28 00:57:50.938 [INFO ] Processing by CartridgesController#index as JSON (pid:3043)
>2014-02-28 00:57:50.939 [DEBUG] API version 1.6 (pid:3043)
>2014-02-28 00:57:51.170 [DEBUG] SUCCESS ACTION=LIST_CARTRIDGE USER_ID=53101cfce12c49d649000001 LOGIN=chunchen DOMAIN= Listing cartridges (pid:3043)
>2014-02-28 00:57:51.307 [INFO ] Completed 200 OK in 92ms (Views: 27.9ms) (pid:3043)
>2014-02-28 00:57:51.677 [INFO ] Started GET "/broker/rest/domains" for 203.114.244.88 at 2014-02-28 00:57:51 -0500 (pid:3043)
>2014-02-28 00:57:51.678 [INFO ] Processing by DomainsController#index as JSON (pid:3043)
>2014-02-28 00:57:51.678 [DEBUG] API version 1.6 (pid:3043)
>2014-02-28 00:57:51.681 [DEBUG] SUCCESS ACTION=AUTHENTICATE USER_ID=53101cfce12c49d649000001 LOGIN=chunchen IP=203.114.244.88 SCOPES=session Authenticated (pid:3043)
>2014-02-28 00:57:51.684 [DEBUG] SUCCESS ACTION=LIST_DOMAIN USER_ID=53101cfce12c49d649000001 LOGIN=chunchen DOMAIN= (pid:3043)
>2014-02-28 00:57:51.696 [INFO ] Completed 200 OK in 18ms (Views: 11.5ms) (pid:3043)
>2014-02-28 00:57:51.997 [INFO ] Started POST "/broker/rest/domain/cdm/applications" for 203.114.244.88 at 2014-02-28 00:57:51 -0500 (pid:3043)
>2014-02-28 00:57:52. 90 [INFO ] Processing by ApplicationsController#create as JSON (pid:3043)
>2014-02-28 00:57:52.836 [INFO ] Parameters: {"name"=>"ceap60", "cartridges"=>["jbosseap-6"], "domain_id"=>"cdm", "application"=>{"name"=>"ceap60"}} (pid:3043)
>2014-02-28 00:57:52.857 [DEBUG] API version 1.6 (pid:3043)
>2014-02-28 00:57:52.108 [DEBUG] SUCCESS ACTION=AUTHENTICATE USER_ID=53101cfce12c49d649000001 LOGIN=chunchen IP=203.114.244.88 SCOPES=session Authenticated (pid:3043)
>2014-02-28 00:57:52.459 [DEBUG] Pre-Executing ops... (pid:3043)
>2014-02-28 00:57:52.465 [DEBUG] Pre-Execute InitGearOp comp_specs=[component:jbosseap-6/jbosseap-6/530fefd7797218131a000017] gear_id=53102560e12c49d649000064 group_instance_id=53102560e12c49d649000066 (pid:3043)
>2014-02-28 00:57:52.123 [DEBUG] Execute NotifyAppCreateOp (pid:3043)
>2014-02-28 00:57:52.259 [DEBUG] Execute ReserveGearUidOp gear_id=53102560e12c49d649000064 (pid:3043)
>2014-02-28 00:57:52.262 [DEBUG] DEBUG: rpc_get_fact: fact=active_capacity (pid:3043)
>2014-02-28 00:57:52.289 [DEBUG] DEBUG: rpc_exec: rpc_client=#<MCollective::RPC::Client:0x00000006cc6d38> (pid:3043)
>2014-02-28 00:57:54.368 [DEBUG] Selecting best fit node: server: ip-10-146-187-125 capacity: 2.2222222222222223 (pid:3043)
>2014-02-28 00:57:54.407 [DEBUG] Execute CreateGearOp gear_id=53102560e12c49d649000064 (pid:3043)
>2014-02-28 00:57:54.425 [DEBUG] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"openshift-origin-node", :action=>"app-create", :args=>{"--with-app-uuid"=>"53102560e12c49d649000064", "--with-app-name"=>"ceap60", "--with-container-uuid"=>"53102560e12c49d649000064", "--with-container-name"=>"ceap60", "--with-namespace"=>"cdm", "--with-request-id"=>"391f3be0e0887f3b0db76021ad6f7865", "--with-secret-token"=>"szVamZ2l4eBK7-gIFMAWnsj4sjRJDsZ8c-4WN_Ol4jPRpavaz9RwPi-OqehhqTDFkpUGek_qAGJj00joBMJdQotk-onDOF1OGIchVQyCidOdUXRp4qFAsVX0GOp5xLPv", "--with-initial-deployment-dir"=>true, "--cart-name"=>"openshift-origin-node"}}, ip-10-146-187-125, {'identity' => ip-10-146-187-125}) (Request ID: 391f3be0e0887f3b0db76021ad6f7865) (pid:3043)
>2014-02-28 00:57:56.661 [DEBUG] DEBUG: [#<MCollective::RPC::Result:0x00000006e17ed0 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-146-187-125", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"", :exitcode=>0, :addtl_params=>nil}}>] (Request ID: 391f3be0e0887f3b0db76021ad6f7865) (pid:3043)
>2014-02-28 00:57:56.662 [DEBUG] DEBUG: MCollective Response Time (execute_direct: app-create): 2.253642635s  (Request ID: 391f3be0e0887f3b0db76021ad6f7865) (pid:3043)
>2014-02-28 00:57:56.723 [DEBUG] Execute RegisterDnsOp gear_id=53102560e12c49d649000064 (pid:3043)
>2014-02-28 00:57:56.733 [DEBUG] DYNECT Login with path: /REST/Session/ (pid:3043)
>2014-02-28 00:57:57.404 [DEBUG] DYNECT Response: {"status": "success", "data": {"token": "EzUU4E3/bVB98RrpqOncaVNTJwuB9CpIqZKwBAaYC5VFxQ9IKxq4KqdbSQ2XEDtyR4Ha0I17rHORTX2By+zCD5Mq1shhzSYiTx8SQNNpTGef8nWC5RJV9mmOFn3biZWkW2kNFWUhRVtYP/50I4vkcA==", "version": "3.5.5"}, "job_id": 720519895, "msgs": [{"INFO": "login: Login successful", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:3043)
>2014-02-28 00:57:57.404 [DEBUG] DYNECT Response data: {"token"=>"EzUU4E3/bVB98RrpqOncaVNTJwuB9CpIqZKwBAaYC5VFxQ9IKxq4KqdbSQ2XEDtyR4Ha0I17rHORTX2By+zCD5Mq1shhzSYiTx8SQNNpTGef8nWC5RJV9mmOFn3biZWkW2kNFWUhRVtYP/50I4vkcA==", "version"=>"3.5.5"} (pid:3043)
>2014-02-28 00:57:57.404 [DEBUG] Dynect Response Time (dyn_login): 0.671087484s  (Request ID: 391f3be0e0887f3b0db76021ad6f7865) (pid:3043)
>2014-02-28 00:57:57.583 [DEBUG] Public ip being configured 'ec2-54-205-229-190.compute-1.amazonaws.com' to app 'ceap60' (pid:3043)
>2014-02-28 00:57:57.594 [DEBUG] DYNECT put/post with path: /REST/CNAMERecord/dev.rhcloud.com/ceap60-cdm.dev.rhcloud.com/ json data: {"rdata":{"cname":"ec2-54-205-229-190.compute-1.amazonaws.com"},"ttl":"60"} and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:3043)
>2014-02-28 00:57:58.229 [DEBUG] DYNECT Response: {"status": "success", "data": {"zone": "dev.rhcloud.com", "ttl": 60, "fqdn": "ceap60-cdm.dev.rhcloud.com", "record_type": "CNAME", "rdata": {"cname": "ec2-54-205-229-190.compute-1.amazonaws.com."}, "record_id": 0}, "job_id": 720519905, "msgs": [{"INFO": "add_node: Reactivating zone node", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}, {"INFO": "add: Record added", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:3043)
>2014-02-28 00:57:58.229 [DEBUG] DYNECT Response data: {"zone"=>"dev.rhcloud.com", "ttl"=>60, "fqdn"=>"ceap60-cdm.dev.rhcloud.com", "record_type"=>"CNAME", "rdata"=>{"cname"=>"ec2-54-205-229-190.compute-1.amazonaws.com."}, "record_id"=>0} (pid:3043)
>2014-02-28 00:57:58.229 [DEBUG] Dynect Response Time (dyn_put_post): 0.63652881s  (Request ID: 391f3be0e0887f3b0db76021ad6f7865) (pid:3043)
>2014-02-28 00:57:58.229 [DEBUG] DYNECT put/post with path: /REST/Zone/dev.rhcloud.com/ json data: {"publish":"true"} and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:3043)
>2014-02-28 00:57:59.123 [DEBUG] DYNECT Response: {"status": "success", "data": {"zone_type": "Primary", "serial_style": "day", "serial": 2014361973, "zone": "dev.rhcloud.com"}, "job_id": 720519912, "msgs": [{"INFO": "publish: dev.rhcloud.com published", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:3043)
>2014-02-28 00:57:59.123 [DEBUG] DYNECT Response data: {"zone_type"=>"Primary", "serial_style"=>"day", "serial"=>2014361973, "zone"=>"dev.rhcloud.com"} (pid:3043)
>2014-02-28 00:57:59.123 [DEBUG] Dynect Response Time (dyn_put_post): 0.893582811s  (Request ID: 391f3be0e0887f3b0db76021ad6f7865) (pid:3043)
>2014-02-28 00:57:59.123 [DEBUG] DYNECT delete with path: /REST/Session/ and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:3043)
>2014-02-28 00:57:59.543 [DEBUG] DYNECT Response: {"status": "success", "data": {}, "job_id": 720519925, "msgs": [{"INFO": "logout: Logout successful", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:3043)
>2014-02-28 00:57:59.543 [DEBUG] DYNECT Response data: {} (pid:3043)
>2014-02-28 00:57:59.544 [DEBUG] Dynect Response Time (dyn_delete): 0.420584329s  (Request ID: 391f3be0e0887f3b0db76021ad6f7865) (pid:3043)
>2014-02-28 00:57:59.578 [DEBUG] Execute UpdateAppConfigOp gear_id=53102560e12c49d649000064 (pid:3043)
>2014-02-28 00:57:59.590 [DEBUG] Execute AddBrokerAuthKeyOp gear_id=53102560e12c49d649000064 (pid:3043)
>2014-02-28 00:57:59.592 [DEBUG] Execute AddCompOp comp_spec=component:jbosseap-6/jbosseap-6/530fefd7797218131a000017 gear_id=53102560e12c49d649000064 (pid:3043)
>2014-02-28 00:57:59.610 [DEBUG] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"jbosseap-6", :action=>"configure", :args=>{"--with-app-uuid"=>"53102560e12c49d649000064", "--with-app-name"=>"ceap60", "--with-container-uuid"=>"53102560e12c49d649000064", "--with-container-name"=>"ceap60", "--with-namespace"=>"cdm", "--with-request-id"=>"391f3be0e0887f3b0db76021ad6f7865", "--component-name"=>"jbosseap-6", "--cart-name"=>"jbosseap-6", "--with-software-version"=>"6", "--cartridge-vendor"=>"redhat"}}, ip-10-146-187-125, {'identity' => ip-10-146-187-125}) (Request ID: 391f3be0e0887f3b0db76021ad6f7865) (pid:3043)
>2014-02-28 00:58:03.818 [DEBUG] DEBUG: [#<MCollective::RPC::Result:0x00000006b7ce78 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-146-187-125", :statuscode=>1, :statusmsg=>"cartridge_do_action failed 157. Output Shell command '/sbin/runuser -s /bin/sh 53102560e12c49d649000064 -c \"exec /usr/bin/runcon 'unconfined_u:system_r:openshift_t:s0:c0,c1002' /bin/sh -c \\\"/var/lib/openshift/53102560e12c49d649000064/jbosseap/bin/install --version 6\\\"\"' returned an error. rc=1\n\n\nCLIENT_ERROR: cp: cannot stat `/var/lib/openshift/53102560e12c49d649000064/jbosseap//versions/6/template/*': Not a directory\n", :data=>{:time=>nil, :output=>"Shell command '/sbin/runuser -s /bin/sh 53102560e12c49d649000064 -c \"exec /usr/bin/runcon 'unconfined_u:system_r:openshift_t:s0:c0,c1002' /bin/sh -c \\\"/var/lib/openshift/53102560e12c49d649000064/jbosseap/bin/install --version 6\\\"\"' returned an error. rc=1\n\n\nCLIENT_ERROR: cp: cannot stat `/var/lib/openshift/53102560e12c49d649000064/jbosseap//versions/6/template/*': Not a directory\n", :exitcode=>157, :addtl_params=>nil}}>] (Request ID: 391f3be0e0887f3b0db76021ad6f7865) (pid:3043)
>2014-02-28 00:58:03.827 [DEBUG] DEBUG: MCollective Response Time (execute_direct: configure): 4.231237975s  (Request ID: 391f3be0e0887f3b0db76021ad6f7865) (pid:3043)
>2014-02-28 00:58:03.843 [DEBUG] DEBUG: server results: Shell command '/sbin/runuser -s /bin/sh 53102560e12c49d649000064 -c "exec /usr/bin/runcon 'unconfined_u:system_r:openshift_t:s0:c0,c1002' /bin/sh -c \"/var/lib/openshift/53102560e12c49d649000064/jbosseap/bin/install --version 6\""' returned an error. rc=1 (pid:3043)
>2014-02-28 00:58:03.869 [DEBUG] DEBUG: server results: (pid:3043)
>2014-02-28 00:58:03.870 [DEBUG] DEBUG: server results: (pid:3043)
>2014-02-28 00:58:03.870 [ERROR] cp: cannot stat `/var/lib/openshift/53102560e12c49d649000064/jbosseap//versions/6/template/*': Not a directory (pid:3043)
>2014-02-28 00:58:03.870 [ERROR] /opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-msg-broker-mcollective-1.21.1/lib/openshift/mcollective_application_container_proxy.rb:2690:in `parse_result'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-msg-broker-mcollective-1.21.1/lib/openshift/mcollective_application_container_proxy.rb:2848:in `run_cartridge_command'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-msg-broker-mcollective-1.21.1/lib/openshift/mcollective_application_container_proxy.rb:798:in `add_component'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/models/gear.rb:174:in `add_component'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/pending_ops_models/add_comp_op.rb:9:in `execute'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/models/pending_app_op_group.rb:103:in `block in execute'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/models/pending_app_op_group.rb:93:in `each'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/models/pending_app_op_group.rb:93:in `execute'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/models/application.rb:1649:in `run_jobs'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/models/application.rb:766:in `block in add_cartridges'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/models/application.rb:1719:in `run_in_application_lock'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/models/application.rb:743:in `add_cartridges'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/models/application.rb:641:in `add_initial_cartridges'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/controllers/applications_controller.rb:157:in `create'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_controller/metal/implicit_render.rb:4:in `send_action'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/abstract_controller/base.rb:167:in `process_action'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_controller/metal/rendering.rb:10:in `process_action'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/abstract_controller/callbacks.rb:18:in `block in process_action'
>/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:481:in `block in _run__2571163719951172775__process_action__261519772140450846__callbacks'
>/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:215:in `block in _conditional_callback_around_557'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/lib/openshift/controller/action_log.rb:80:in `set_logged_request'
>/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:214:in `_conditional_callback_around_557'
>/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:403:in `_run__2571163719951172775__process_action__261519772140450846__callbacks'
>/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:405:in `__run_callback'
>/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks'
>/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:81:in `run_callbacks'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/abstract_controller/callbacks.rb:17:in `process_action'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_controller/metal/rescue.rb:29:in `process_action'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:30:in `block in process_action'
>/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `block in instrument'
>/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/notifications/instrumenter.rb:20:in `instrument'
>/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `instrument'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:29:in `process_action'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_controller/metal/params_wrapper.rb:207:in `process_action'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/abstract_controller/base.rb:121:in `process'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/abstract_controller/rendering.rb:45:in `process'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_controller/metal.rb:203:in `dispatch'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_controller/metal/rack_delegation.rb:14:in `dispatch'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_controller/metal.rb:246:in `block in action'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/routing/route_set.rb:73:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/routing/route_set.rb:73:in `dispatch'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/routing/route_set.rb:36:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/journey-1.0.4/lib/journey/router.rb:68:in `block in call'
>/opt/rh/ruby193/root/usr/share/gems/gems/journey-1.0.4/lib/journey/router.rb:56:in `each'
>/opt/rh/ruby193/root/usr/share/gems/gems/journey-1.0.4/lib/journey/router.rb:56:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/routing/route_set.rb:600:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/mongo_mapper-0.11.1/lib/mongo_mapper/middleware/identity_map.rb:10:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/mongoid-3.0.21/lib/rack/mongoid/middleware/identity_map.rb:34:in `block in call'
>/opt/rh/ruby193/root/usr/share/gems/gems/mongoid-3.0.21/lib/mongoid/unit_of_work.rb:39:in `unit_of_work'
>/opt/rh/ruby193/root/usr/share/gems/gems/mongoid-3.0.21/lib/rack/mongoid/middleware/identity_map.rb:34:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/best_standards_support.rb:17:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/rack-1.4.1/lib/rack/etag.rb:23:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/rack-1.4.1/lib/rack/conditionalget.rb:35:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/head.rb:14:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/params_parser.rb:21:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/flash.rb:242:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/rack-1.4.1/lib/rack/session/abstract/id.rb:205:in `context'
>/opt/rh/ruby193/root/usr/share/gems/gems/rack-1.4.1/lib/rack/session/abstract/id.rb:200:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/cookies.rb:339:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/callbacks.rb:28:in `block in call'
>/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:405:in `_run__1766682201187678458__call__3256437375256440153__callbacks'
>/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:405:in `__run_callback'
>/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:385:in `_run_call_callbacks'
>/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:81:in `run_callbacks'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/callbacks.rb:27:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/remote_ip.rb:31:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/show_exceptions.rb:56:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/railties-3.2.8/lib/rails/rack/logger.rb:26:in `call_app'
>/opt/rh/ruby193/root/usr/share/gems/gems/railties-3.2.8/lib/rails/rack/logger.rb:16:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/request_id.rb:22:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/rack-1.4.1/lib/rack/methodoverride.rb:21:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/rack-1.4.1/lib/rack/runtime.rb:17:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/cache/strategy/local_cache.rb:72:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/rack-1.4.1/lib/rack/lock.rb:15:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/static.rb:62:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/rack-cache-1.2/lib/rack/cache/context.rb:136:in `forward'
>/opt/rh/ruby193/root/usr/share/gems/gems/rack-cache-1.2/lib/rack/cache/context.rb:143:in `pass'
>/opt/rh/ruby193/root/usr/share/gems/gems/rack-cache-1.2/lib/rack/cache/context.rb:155:in `invalidate'
>/opt/rh/ruby193/root/usr/share/gems/gems/rack-cache-1.2/lib/rack/cache/context.rb:71:in `call!'
>/opt/rh/ruby193/root/usr/share/gems/gems/rack-cache-1.2/lib/rack/cache/context.rb:51:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/railties-3.2.8/lib/rails/engine.rb:479:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/railties-3.2.8/lib/rails/application.rb:223:in `call'
>/opt/rh/ruby193/root/usr/share/gems/gems/railties-3.2.8/lib/rails/railtie/configurable.rb:30:in `method_missing'
>/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/rack/request_handler.rb:97:in `process_request'
>/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/abstract_request_handler.rb:521:in `accept_and_process_next_request'
>/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/abstract_request_handler.rb:274:in `main_loop'
>/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/rack/application_spawner.rb:206:in `start_request_handler'
>/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/rack/application_spawner.rb:79:in `block in spawn_application'
>/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/utils.rb:470:in `safe_fork'
>/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/rack/application_spawner.rb:64:in `spawn_application'
>/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/spawn_manager.rb:264:in `spawn_rack_application'
>/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/spawn_manager.rb:137:in `spawn_application'
>/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/spawn_manager.rb:275:in `handle_spawn_application'
>/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/abstract_server.rb:357:in `server_main_loop'
>/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/abstract_server.rb:206:in `start_synchronously'
>/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/helper-scripts/passenger-spawn-server:102:in `<main>' (pid:3043)
>2014-02-28 00:58:03.870 [ERROR] Encountered error during execute 'cp: cannot stat `/var/lib/openshift/53102560e12c49d649000064/jbosseap//versions/6/template/*': Not a directory
>' (pid:3043)
>2014-02-28 00:58:03.871 [DEBUG] ["/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-msg-broker-mcollective-1.21.1/lib/openshift/mcollective_application_container_proxy.rb:2690:in `parse_result'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-msg-broker-mcollective-1.21.1/lib/openshift/mcollective_application_container_proxy.rb:2848:in `run_cartridge_command'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-msg-broker-mcollective-1.21.1/lib/openshift/mcollective_application_container_proxy.rb:798:in `add_component'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/models/gear.rb:174:in `add_component'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/pending_ops_models/add_comp_op.rb:9:in `execute'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/models/pending_app_op_group.rb:103:in `block in execute'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/models/pending_app_op_group.rb:93:in `each'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/models/pending_app_op_group.rb:93:in `execute'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/models/application.rb:1649:in `run_jobs'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/models/application.rb:766:in `block in add_cartridges'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/models/application.rb:1719:in `run_in_application_lock'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/models/application.rb:743:in `add_cartridges'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/models/application.rb:641:in `add_initial_cartridges'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/app/controllers/applications_controller.rb:157:in `create'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_controller/metal/implicit_render.rb:4:in `send_action'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/abstract_controller/base.rb:167:in `process_action'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_controller/metal/rendering.rb:10:in `process_action'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/abstract_controller/callbacks.rb:18:in `block in process_action'", "/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:481:in `block in _run__2571163719951172775__process_action__261519772140450846__callbacks'", "/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:215:in `block in _conditional_callback_around_557'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.21.1/lib/openshift/controller/action_log.rb:80:in `set_logged_request'", "/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:214:in `_conditional_callback_around_557'", "/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:403:in `_run__2571163719951172775__process_action__261519772140450846__callbacks'", "/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:405:in `__run_callback'", "/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks'", "/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:81:in `run_callbacks'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/abstract_controller/callbacks.rb:17:in `process_action'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_controller/metal/rescue.rb:29:in `process_action'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:30:in `block in process_action'", "/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `block in instrument'", "/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/notifications/instrumenter.rb:20:in `instrument'", "/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/notifications.rb:123:in `instrument'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_controller/metal/instrumentation.rb:29:in `process_action'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_controller/metal/params_wrapper.rb:207:in `process_action'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/abstract_controller/base.rb:121:in `process'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/abstract_controller/rendering.rb:45:in `process'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_controller/metal.rb:203:in `dispatch'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_controller/metal/rack_delegation.rb:14:in `dispatch'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_controller/metal.rb:246:in `block in action'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/routing/route_set.rb:73:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/routing/route_set.rb:73:in `dispatch'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/routing/route_set.rb:36:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/journey-1.0.4/lib/journey/router.rb:68:in `block in call'", "/opt/rh/ruby193/root/usr/share/gems/gems/journey-1.0.4/lib/journey/router.rb:56:in `each'", "/opt/rh/ruby193/root/usr/share/gems/gems/journey-1.0.4/lib/journey/router.rb:56:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/routing/route_set.rb:600:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/mongo_mapper-0.11.1/lib/mongo_mapper/middleware/identity_map.rb:10:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/mongoid-3.0.21/lib/rack/mongoid/middleware/identity_map.rb:34:in `block in call'", "/opt/rh/ruby193/root/usr/share/gems/gems/mongoid-3.0.21/lib/mongoid/unit_of_work.rb:39:in `unit_of_work'", "/opt/rh/ruby193/root/usr/share/gems/gems/mongoid-3.0.21/lib/rack/mongoid/middleware/identity_map.rb:34:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/best_standards_support.rb:17:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/rack-1.4.1/lib/rack/etag.rb:23:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/rack-1.4.1/lib/rack/conditionalget.rb:35:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/head.rb:14:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/params_parser.rb:21:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/flash.rb:242:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/rack-1.4.1/lib/rack/session/abstract/id.rb:205:in `context'", "/opt/rh/ruby193/root/usr/share/gems/gems/rack-1.4.1/lib/rack/session/abstract/id.rb:200:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/cookies.rb:339:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/callbacks.rb:28:in `block in call'", "/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:405:in `_run__1766682201187678458__call__3256437375256440153__callbacks'", "/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:405:in `__run_callback'", "/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:385:in `_run_call_callbacks'", "/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:81:in `run_callbacks'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/callbacks.rb:27:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/remote_ip.rb:31:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/show_exceptions.rb:56:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/railties-3.2.8/lib/rails/rack/logger.rb:26:in `call_app'", "/opt/rh/ruby193/root/usr/share/gems/gems/railties-3.2.8/lib/rails/rack/logger.rb:16:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/request_id.rb:22:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/rack-1.4.1/lib/rack/methodoverride.rb:21:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/rack-1.4.1/lib/rack/runtime.rb:17:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/cache/strategy/local_cache.rb:72:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/rack-1.4.1/lib/rack/lock.rb:15:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/static.rb:62:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/rack-cache-1.2/lib/rack/cache/context.rb:136:in `forward'", "/opt/rh/ruby193/root/usr/share/gems/gems/rack-cache-1.2/lib/rack/cache/context.rb:143:in `pass'", "/opt/rh/ruby193/root/usr/share/gems/gems/rack-cache-1.2/lib/rack/cache/context.rb:155:in `invalidate'", "/opt/rh/ruby193/root/usr/share/gems/gems/rack-cache-1.2/lib/rack/cache/context.rb:71:in `call!'", "/opt/rh/ruby193/root/usr/share/gems/gems/rack-cache-1.2/lib/rack/cache/context.rb:51:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/railties-3.2.8/lib/rails/engine.rb:479:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/railties-3.2.8/lib/rails/application.rb:223:in `call'", "/opt/rh/ruby193/root/usr/share/gems/gems/railties-3.2.8/lib/rails/railtie/configurable.rb:30:in `method_missing'", "/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/rack/request_handler.rb:97:in `process_request'", "/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/abstract_request_handler.rb:521:in `accept_and_process_next_request'", "/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/abstract_request_handler.rb:274:in `main_loop'", "/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/rack/application_spawner.rb:206:in `start_request_handler'", "/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/rack/application_spawner.rb:79:in `block in spawn_application'", "/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/utils.rb:470:in `safe_fork'", "/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/rack/application_spawner.rb:64:in `spawn_application'", "/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/spawn_manager.rb:264:in `spawn_rack_application'", "/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/spawn_manager.rb:137:in `spawn_application'", "/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/spawn_manager.rb:275:in `handle_spawn_application'", "/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/abstract_server.rb:357:in `server_main_loop'", "/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/lib/phusion_passenger/abstract_server.rb:206:in `start_synchronously'", "/opt/rh/ruby193/root/usr/share/gems/gems/passenger-3.0.21/helper-scripts/passenger-spawn-server:102:in `<main>'"] (pid:3043)
>2014-02-28 00:58:03.968 [DEBUG] Rollback UpdateAppConfigOp gear_id=53102560e12c49d649000064 (pid:3043)
>2014-02-28 00:58:03.968 [DEBUG] Parallel rollback not implemented: UpdateAppConfigOp (pid:3043)
>2014-02-28 00:58:03.968 [DEBUG] Rollback AddBrokerAuthKeyOp gear_id=53102560e12c49d649000064 (pid:3043)
>2014-02-28 00:58:03.968 [DEBUG] Parallel rollback not implemented: AddBrokerAuthKeyOp (pid:3043)
>2014-02-28 00:58:03.969 [DEBUG] Rollback AddCompOp comp_spec=component:jbosseap-6/jbosseap-6/530fefd7797218131a000017 gear_id=53102560e12c49d649000064 (pid:3043)
>2014-02-28 00:58:03.972 [DEBUG] DEBUG: Deconfiguring cartridge 'jbosseap-6' in application 'ceap60' on node 'ip-10-146-187-125' (pid:3043)
>2014-02-28 00:58:03.993 [DEBUG] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"jbosseap-6", :action=>"deconfigure", :args=>{"--with-app-uuid"=>"53102560e12c49d649000064", "--with-app-name"=>"ceap60", "--with-container-uuid"=>"53102560e12c49d649000064", "--with-container-name"=>"ceap60", "--with-namespace"=>"cdm", "--with-request-id"=>"391f3be0e0887f3b0db76021ad6f7865", "--component-name"=>"jbosseap-6", "--cart-name"=>"jbosseap-6", "--with-software-version"=>"6", "--cartridge-vendor"=>"redhat"}}, ip-10-146-187-125, {'identity' => ip-10-146-187-125}) (Request ID: 391f3be0e0887f3b0db76021ad6f7865) (pid:3043)
>2014-02-28 00:58:06.419 [DEBUG] DEBUG: [#<MCollective::RPC::Result:0x00000006e742c0 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-146-187-125", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"", :exitcode=>0, :addtl_params=>nil}}>] (Request ID: 391f3be0e0887f3b0db76021ad6f7865) (pid:3043)
>2014-02-28 00:58:06.420 [DEBUG] DEBUG: MCollective Response Time (execute_direct: deconfigure): 2.447855243s  (Request ID: 391f3be0e0887f3b0db76021ad6f7865) (pid:3043)
>2014-02-28 00:58:06.554 [DEBUG] Rollback RegisterDnsOp gear_id=53102560e12c49d649000064 (pid:3043)
>2014-02-28 00:58:06.579 [DEBUG] DYNECT Login with path: /REST/Session/ (pid:3043)
>2014-02-28 00:58:07.237 [DEBUG] DYNECT Response: {"status": "success", "data": {"token": "elOg+mPdUX3Vu9TZSgwiqBPQGtowVKM67qXnI+qhaUioTfRUo9stGatY6QnW1Q4lWjTLhpzbHPe/0n1bqzIbUkE9IgYLpNZj+ItLb9IYNH5dC1AlijRZL+uHD9mGDf6SB4/LTKfa+CkumrKJj94jkCUgNj5QGDoJ", "version": "3.5.5"}, "job_id": 720520095, "msgs": [{"INFO": "login: Login successful", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:3043)
>2014-02-28 00:58:07.237 [DEBUG] DYNECT Response data: {"token"=>"elOg+mPdUX3Vu9TZSgwiqBPQGtowVKM67qXnI+qhaUioTfRUo9stGatY6QnW1Q4lWjTLhpzbHPe/0n1bqzIbUkE9IgYLpNZj+ItLb9IYNH5dC1AlijRZL+uHD9mGDf6SB4/LTKfa+CkumrKJj94jkCUgNj5QGDoJ", "version"=>"3.5.5"} (pid:3043)
>2014-02-28 00:58:07.237 [DEBUG] Dynect Response Time (dyn_login): 0.658198577s  (Request ID: 391f3be0e0887f3b0db76021ad6f7865) (pid:3043)
>2014-02-28 00:58:07.237 [DEBUG] DYNECT delete with path: /REST/CNAMERecord/dev.rhcloud.com/ceap60-cdm.dev.rhcloud.com/ and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:3043)
>2014-02-28 00:58:07.768 [DEBUG] DYNECT Response: {"status": "success", "data": {}, "job_id": 720520107, "msgs": [{"INFO": "delete: 1 records deleted", "SOURCE": "API-B", "ERR_CD": null, "LVL": "INFO"}]} (pid:3043)
>2014-02-28 00:58:07.768 [DEBUG] DYNECT Response data: {} (pid:3043)
>2014-02-28 00:58:07.768 [DEBUG] Dynect Response Time (dyn_delete): 0.530654989s  (Request ID: 391f3be0e0887f3b0db76021ad6f7865) (pid:3043)
>2014-02-28 00:58:07.768 [DEBUG] DYNECT put/post with path: /REST/Zone/dev.rhcloud.com/ json data: {"publish":"true"} and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:3043)
>2014-02-28 00:58:08.782 [DEBUG] DYNECT Response: {"status": "success", "data": {"zone_type": "Primary", "serial_style": "day", "serial": 2014361974, "zone": "dev.rhcloud.com"}, "job_id": 720520129, "msgs": [{"INFO": "publish: dev.rhcloud.com published", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:3043)
>2014-02-28 00:58:08.782 [DEBUG] DYNECT Response data: {"zone_type"=>"Primary", "serial_style"=>"day", "serial"=>2014361974, "zone"=>"dev.rhcloud.com"} (pid:3043)
>2014-02-28 00:58:08.782 [DEBUG] Dynect Response Time (dyn_put_post): 1.014017207s  (Request ID: 391f3be0e0887f3b0db76021ad6f7865) (pid:3043)
>2014-02-28 00:58:08.782 [DEBUG] DYNECT delete with path: /REST/Session/ and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:3043)
>2014-02-28 00:58:09.219 [DEBUG] DYNECT Response: {"status": "success", "data": {}, "job_id": 720520152, "msgs": [{"INFO": "logout: Logout successful", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:3043)
>2014-02-28 00:58:09.220 [DEBUG] DYNECT Response data: {} (pid:3043)
>2014-02-28 00:58:09.220 [DEBUG] Dynect Response Time (dyn_delete): 0.437535413s  (Request ID: 391f3be0e0887f3b0db76021ad6f7865) (pid:3043)
>2014-02-28 00:58:09.244 [DEBUG] Rollback CreateGearOp gear_id=53102560e12c49d649000064 (pid:3043)
>2014-02-28 00:58:09.260 [DEBUG] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"openshift-origin-node", :action=>"app-destroy", :args=>{"--with-app-uuid"=>"53102560e12c49d649000064", "--with-app-name"=>"ceap60", "--with-container-uuid"=>"53102560e12c49d649000064", "--with-container-name"=>"ceap60", "--with-namespace"=>"cdm", "--with-request-id"=>"391f3be0e0887f3b0db76021ad6f7865", "--cart-name"=>"openshift-origin-node"}}, ip-10-146-187-125, {'identity' => ip-10-146-187-125}) (Request ID: 391f3be0e0887f3b0db76021ad6f7865) (pid:3043)
>2014-02-28 00:58:11.500 [DEBUG] DEBUG: [#<MCollective::RPC::Result:0x000000015e1ea0 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-146-187-125", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"", :exitcode=>0, :addtl_params=>nil}}>] (Request ID: 391f3be0e0887f3b0db76021ad6f7865) (pid:3043)
>2014-02-28 00:58:11.502 [DEBUG] DEBUG: MCollective Response Time (execute_direct: app-destroy): 2.257767354s  (Request ID: 391f3be0e0887f3b0db76021ad6f7865) (pid:3043)
>2014-02-28 00:58:11.548 [DEBUG] Rollback ReserveGearUidOp gear_id=53102560e12c49d649000064 (pid:3043)
>2014-02-28 00:58:11.583 [DEBUG] Rollback NotifyAppCreateOp (pid:3043)
>2014-02-28 00:58:11.583 [DEBUG] Rollback not implemented: NotifyAppCreateOp (pid:3043)
>2014-02-28 00:58:11.593 [DEBUG] Rollback InitGearOp comp_specs=[component:jbosseap-6/jbosseap-6/530fefd7797218131a000017] gear_id=53102560e12c49d649000064 group_instance_id=53102560e12c49d649000066 (pid:3043)
>2014-02-28 00:58:11.658 [DEBUG] SUCCESS ACTION=ADD_APPLICATION USER_ID=53101cfce12c49d649000001 LOGIN=chunchen APP_UUID=53102560e12c49d649000064 DOMAIN=cdm cp: cannot stat `/var/lib/openshift/53102560e12c49d649000064/jbosseap//versions/6/template/*': Not a directory Shell command '/sbin/runuser -s /bin/sh 53102560e12c49d649000064 -c "exec /usr/bin/runcon 'unconfined_u:system_r:openshift_t:s0:c0,c1002' /bin/sh -c \"/var/lib/openshift/53102560e12c49d649000064/jbosseap/bin/install --version 6\""' returned an error. rc=1
>
>
>, cp: cannot stat `/var/lib/openshift/53102560e12c49d649000064/jbosseap//versions/6/template/*': Not a directory (pid:3043)
>2014-02-28 00:58:11.660 [INFO ] Completed 422 Unprocessable Entity in 19652ms (Views: 0.5ms) (pid:3043)

Actions: View

Attachments on bug 1071123: 868860