Attachment 861218 Details for Bug 1063109 – broker development.log

broker development.log

development.log (text/x-log), 184.28 KB, created by Lei Zhang on 2014-02-10 02:57:14 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Lei Zhang

Created: 2014-02-10 02:57:14 UTC

Size: 184.28 KB

patch

obsolete

>[0;37m2014-02-09 21:23:36.341[0m [[32mINFO [0m] Started POST "/broker/rest/user/keys" for 66.187.233.202 at 2014-02-09 21:23:36 -0500 (pid:11735)
>[0;37m2014-02-09 21:23:36.689[0m [[32mINFO [0m] Processing by KeysController#create as JSON (pid:11735)
>[0;37m2014-02-09 21:23:36.705[0m [[32mINFO [0m] Parameters: {"name"=>"default", "type"=>"ssh-rsa", "content"=>"AAAAB3NzaC1yc2EAAAABIwAAAQEAuA0LIdBeb6I61vB4LwGeDLYEQOZfyhA047yJbljt9cFsT1bNn+HvffJ+6dZzWIbeRv/gxVF/AlQnMk1/r6J20BBqj0WM3AJWzfIKauDkw43BlY0udkry8QXMAtO+ME3AwjcRdQ+tLFieHQRPUzJ/mWxFdjaHQWV+e0sZ7Dye4VJphJ/Ujf6tJkvOrA4wkO5V3RsQOaTuJR2O5VDQj02GbthGHfZoEIGJ1hkUEYpeXkkVesQytul62Qia1WyOrM+u24HHzUy3im57YBkBEneqOejvJ1SKPRfMXm8fi+e0nVvT98ItDNqqLg8o+qosA0KEK/RxHl6vvoLa9iNzYjoQPw==", "key"=>{"name"=>"default", "type"=>"ssh-rsa", "content"=>"AAAAB3NzaC1yc2EAAAABIwAAAQEAuA0LIdBeb6I61vB4LwGeDLYEQOZfyhA047yJbljt9cFsT1bNn+HvffJ+6dZzWIbeRv/gxVF/AlQnMk1/r6J20BBqj0WM3AJWzfIKauDkw43BlY0udkry8QXMAtO+ME3AwjcRdQ+tLFieHQRPUzJ/mWxFdjaHQWV+e0sZ7Dye4VJphJ/Ujf6tJkvOrA4wkO5V3RsQOaTuJR2O5VDQj02GbthGHfZoEIGJ1hkUEYpeXkkVesQytul62Qia1WyOrM+u24HHzUy3im57YBkBEneqOejvJ1SKPRfMXm8fi+e0nVvT98ItDNqqLg8o+qosA0KEK/RxHl6vvoLa9iNzYjoQPw=="}} (pid:11735)
>[0;37m2014-02-09 21:23:36.835[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:23:36.128[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11735)
>[0;37m2014-02-09 21:23:36.131[0m [[0;37mDEBUG[0m] Creating key name:default type:ssh-rsa for user lzhang@redhat.com (pid:11735)
>[0;37m2014-02-09 21:23:36.267[0m [[0;37mDEBUG[0m] SUCCESS ACTION=ADD_KEY USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= IP=66.187.233.202 Created SSH key default (pid:11735)
>[0;37m2014-02-09 21:23:36.303[0m [[32mINFO [0m] Completed 201 Created in 23ms (Views: 1.8ms) (pid:11735)
>[0;37m2014-02-09 21:23:36.554[0m [[32mINFO [0m] Started GET "/broker/rest/user/keys" for 66.187.233.202 at 2014-02-09 21:23:36 -0500 (pid:11735)
>[0;37m2014-02-09 21:23:36.558[0m [[32mINFO [0m] Processing by KeysController#index as JSON (pid:11735)
>[0;37m2014-02-09 21:23:36.559[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:23:36.562[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11735)
>[0;37m2014-02-09 21:23:36.564[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_KEY USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= Found 1 ssh keys (pid:11735)
>[0;37m2014-02-09 21:23:36.569[0m [[32mINFO [0m] Completed 200 OK in 10ms (Views: 2.7ms) (pid:11735)
>[0;37m2014-02-09 21:23:37.653[0m [[32mINFO [0m] Started GET "/broker/rest/domains" for 66.187.233.202 at 2014-02-09 21:23:37 -0500 (pid:11735)
>[0;37m2014-02-09 21:23:37.673[0m [[32mINFO [0m] Processing by DomainsController#index as JSON (pid:11735)
>[0;37m2014-02-09 21:23:37.676[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:23:37.713[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11735)
>[0;37m2014-02-09 21:23:37.728[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_DOMAIN USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11735)
>[0;37m2014-02-09 21:23:37.743[0m [[32mINFO [0m] Completed 200 OK in 7ms (Views: 0.5ms) (pid:11735)
>[0;37m2014-02-09 21:23:41.880[0m [[32mINFO [0m] Started POST "/broker/rest/domains" for 66.187.233.202 at 2014-02-09 21:23:41 -0500 (pid:11735)
>[0;37m2014-02-09 21:23:41.884[0m [[32mINFO [0m] Processing by DomainsController#create as JSON (pid:11735)
>[0;37m2014-02-09 21:23:41.884[0m [[32mINFO [0m] Parameters: {"id"=>"chunchen", "domain"=>{}} (pid:11735)
>[0;37m2014-02-09 21:23:41.885[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:23:41.891[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11735)
>[0;37m2014-02-09 21:23:41.901[0m [[0;37mDEBUG[0m] SUCCESS ACTION=ADD_DOMAIN USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= Namespace 'chunchen' is already in use. Please choose another. (pid:11735)
>[0;37m2014-02-09 21:23:41.904[0m [[32mINFO [0m] Completed 422 Unprocessable Entity in 19ms (Views: 0.6ms) (pid:11735)
>[0;37m2014-02-09 21:23:46.366[0m [[32mINFO [0m] Started POST "/broker/rest/domains" for 66.187.233.202 at 2014-02-09 21:23:46 -0500 (pid:11735)
>[0;37m2014-02-09 21:23:46.371[0m [[32mINFO [0m] Processing by DomainsController#create as JSON (pid:11735)
>[0;37m2014-02-09 21:23:46.372[0m [[32mINFO [0m] Parameters: {"id"=>"ray", "domain"=>{}} (pid:11735)
>[0;37m2014-02-09 21:23:46.372[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:23:46.376[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11735)
>[0;37m2014-02-09 21:23:46.386[0m [[0;37mDEBUG[0m] SUCCESS ACTION=ADD_DOMAIN USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN=ray Created domain with name ray (pid:11735)
>[0;37m2014-02-09 21:23:46.393[0m [[32mINFO [0m] Completed 201 Created in 22ms (Views: 6.0ms) (pid:11735)
>[0;37m2014-02-09 21:23:46.706[0m [[32mINFO [0m] Started GET "/broker/rest/cartridges" for 66.187.233.202 at 2014-02-09 21:23:46 -0500 (pid:11735)
>[0;37m2014-02-09 21:23:46.708[0m [[32mINFO [0m] Processing by CartridgesController#index as JSON (pid:11735)
>[0;37m2014-02-09 21:23:46.708[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:23:46.762[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_CARTRIDGE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= Listing cartridges (pid:11735)
>[0;37m2014-02-09 21:23:46.788[0m [[32mINFO [0m] Completed 200 OK in 80ms (Views: 25.0ms) (pid:11735)
>[0;37m2014-02-09 21:24:04.897[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:24:04 -0500 (pid:11735)
>[0;37m2014-02-09 21:24:04.899[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11735)
>[0;37m2014-02-09 21:24:04.899[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11735)
>[0;37m2014-02-09 21:24:04.911[0m [[32mINFO [0m] Completed 200 OK in 12ms (Views: 6.7ms) (pid:11735)
>[0;37m2014-02-09 21:24:05.231[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:24:05 -0500 (pid:11735)
>[0;37m2014-02-09 21:24:05.234[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11735)
>[0;37m2014-02-09 21:24:05.234[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:24:05.246[0m [[32mINFO [0m] Completed 200 OK in 12ms (Views: 7.2ms) (pid:11735)
>[0;37m2014-02-09 21:24:05.560[0m [[32mINFO [0m] Started GET "/broker/rest/cartridges" for 66.187.233.202 at 2014-02-09 21:24:05 -0500 (pid:11735)
>[0;37m2014-02-09 21:24:05.562[0m [[32mINFO [0m] Processing by CartridgesController#index as JSON (pid:11735)
>[0;37m2014-02-09 21:24:05.562[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:24:05.698[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_CARTRIDGE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= Listing cartridges (pid:11735)
>[0;37m2014-02-09 21:24:05.723[0m [[32mINFO [0m] Completed 200 OK in 161ms (Views: 23.9ms) (pid:11735)
>[0;37m2014-02-09 21:25:00.997[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:25:00 -0500 (pid:11735)
>[0;37m2014-02-09 21:25:00.999[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11735)
>[0;37m2014-02-09 21:25:00.999[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11735)
>[0;37m2014-02-09 21:25:01.133[0m [[32mINFO [0m] Completed 200 OK in 14ms (Views: 7.7ms) (pid:11735)
>[0;37m2014-02-09 21:25:01.333[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:25:01 -0500 (pid:11735)
>[0;37m2014-02-09 21:25:01.335[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11735)
>[0;37m2014-02-09 21:25:01.335[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:25:01.347[0m [[32mINFO [0m] Completed 200 OK in 12ms (Views: 7.1ms) (pid:11735)
>[0;37m2014-02-09 21:25:01.647[0m [[32mINFO [0m] Started GET "/broker/rest/cartridges" for 66.187.233.202 at 2014-02-09 21:25:01 -0500 (pid:11735)
>[0;37m2014-02-09 21:25:01.651[0m [[32mINFO [0m] Processing by CartridgesController#index as JSON (pid:11735)
>[0;37m2014-02-09 21:25:01.651[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:25:01.738[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_CARTRIDGE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= Listing cartridges (pid:11735)
>[0;37m2014-02-09 21:25:01.921[0m [[32mINFO [0m] Completed 200 OK in 270ms (Views: 180.4ms) (pid:11735)
>[0;37m2014-02-09 21:25:02.512[0m [[32mINFO [0m] Started GET "/broker/rest/domains" for 66.187.233.202 at 2014-02-09 21:25:02 -0500 (pid:11735)
>[0;37m2014-02-09 21:25:02.514[0m [[32mINFO [0m] Processing by DomainsController#index as JSON (pid:11735)
>[0;37m2014-02-09 21:25:02.515[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:25:02.520[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11735)
>[0;37m2014-02-09 21:25:02.525[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_DOMAIN USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11735)
>[0;37m2014-02-09 21:25:02.532[0m [[32mINFO [0m] Completed 200 OK in 18ms (Views: 6.3ms) (pid:11735)
>[0;37m2014-02-09 21:25:02.853[0m [[32mINFO [0m] Started POST "/broker/rest/domain/ray/applications" for 66.187.233.202 at 2014-02-09 21:25:02 -0500 (pid:11735)
>[0;37m2014-02-09 21:25:02.856[0m [[32mINFO [0m] Processing by ApplicationsController#create as JSON (pid:11735)
>[0;37m2014-02-09 21:25:02.857[0m [[32mINFO [0m] Parameters: {"name"=>"myjbossews10", "cartridges"=>["jbossews-1.0", "mysql-5.1", "phpmyadmin-4"], "domain_id"=>"ray", "application"=>{"name"=>"myjbossews10"}} (pid:11735)
>[0;37m2014-02-09 21:25:02.857[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:25:02.861[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11735)
>[0;37m2014-02-09 21:25:02.911[0m [[0;37mDEBUG[0m] Pre-Executing ops... (pid:11735)
>[0;37m2014-02-09 21:25:02.913[0m [[0;37mDEBUG[0m] Pre-Execute InitGearOp comp_specs=[component:jbossews-1.0/jbossews-1.0/52f805d3c1f111aad2000014, component:mysql-5.1/mysql-5.1/52f805d3c1f111aad2000024, component:mysql-5.5/mysql-5.5/52f805d3c1f111aad2000023, component:phpmyadmin-4/phpmyadmin-4/52f805d3c1f111aad200000f] gear_id=52f8387e1de544d0530002a4 group_instance_id=52f8387e1de544d0530002a6 (pid:11735)
>[0;37m2014-02-09 21:25:03.229[0m [[0;37mDEBUG[0m] Execute NotifyAppCreateOp (pid:11735)
>[0;37m2014-02-09 21:25:03.895[0m [[0;37mDEBUG[0m] Execute ReserveGearUidOp gear_id=52f8387e1de544d0530002a4 (pid:11735)
>[0;37m2014-02-09 21:25:03.974[0m [[0;37mDEBUG[0m] DEBUG: rpc_get_fact: fact=active_capacity (pid:11735)
>[0;37m2014-02-09 21:25:03.104[0m [[0;37mDEBUG[0m] DEBUG: rpc_exec: rpc_client=#<MCollective::RPC::Client:0x00000007000670> (pid:11735)
>[0;37m2014-02-09 21:25:05.304[0m [[0;37mDEBUG[0m] Selecting best fit node: server: ip-10-225-9-204 capacity: 17.77777777777778 (pid:11735)
>[0;37m2014-02-09 21:25:05.352[0m [[0;37mDEBUG[0m] Execute CreateGearOp gear_id=52f8387e1de544d0530002a4 (pid:11735)
>[0;37m2014-02-09 21:25:05.449[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"openshift-origin-node", :action=>"app-create", :args=>{"--with-app-uuid"=>"52f8387e1de544d0530002a4", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f8387e1de544d0530002a4", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"b3461105a7b69a728a9b86a85e45b5db", "--with-secret-token"=>"ZCj_B1TyIvotGO7xG186oU4EjLL5_0zYu_txi6gcIDq2U-TFIJrs3cMgcGH4DVflWvfdK5CIP5Hy6Od-2P3iqGcGy24kPowp_rZnuX3qmmCZGK-A6RTs4KZPOk778stW", "--with-initial-deployment-dir"=>true, "--cart-name"=>"openshift-origin-node"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:09.282[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x00000005e15f78 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"", :exitcode=>0, :addtl_params=>nil}}>] (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:09.308[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: app-create): 3.674530707s  (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:09.772[0m [[0;37mDEBUG[0m] Execute RegisterDnsOp gear_id=52f8387e1de544d0530002a4 (pid:11735)
>[0;37m2014-02-09 21:25:09.806[0m [[0;37mDEBUG[0m] DYNECT Login with path: /REST/Session/ (pid:11735)
>[0;37m2014-02-09 21:25:09.964[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {"token": "VrTEG1hsG/7NIMZAmv++L+1k8CJRwgn1DnyGCXSzqeWYcjlK5PkBEYI7uZVoNs6WreXmjv30ej0M6sQ8xoD1VgOV9s6pH1TzKoW0RnOxsXt4B10ZOnGSiy+patoftzpGPhUuMfUR/6gCc3exRtsZ5g==", "version": "3.5.4"}, "job_id": 692794208, "msgs": [{"INFO": "login: Login successful", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:11735)
>[0;37m2014-02-09 21:25:09.964[0m [[0;37mDEBUG[0m] DYNECT Response data: {"token"=>"VrTEG1hsG/7NIMZAmv++L+1k8CJRwgn1DnyGCXSzqeWYcjlK5PkBEYI7uZVoNs6WreXmjv30ej0M6sQ8xoD1VgOV9s6pH1TzKoW0RnOxsXt4B10ZOnGSiy+patoftzpGPhUuMfUR/6gCc3exRtsZ5g==", "version"=>"3.5.4"} (pid:11735)
>[0;37m2014-02-09 21:25:09.964[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_login): 0.884356245s  (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:10.135[0m [[0;37mDEBUG[0m] Public ip being configured 'ec2-54-80-152-50.compute-1.amazonaws.com' to app 'myjbossews10' (pid:11735)
>[0;37m2014-02-09 21:25:10.137[0m [[0;37mDEBUG[0m] DYNECT put/post with path: /REST/CNAMERecord/dev.rhcloud.com/myjbossews10-ray.dev.rhcloud.com/ json data: {"rdata":{"cname":"ec2-54-80-152-50.compute-1.amazonaws.com"},"ttl":"60"} and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:11735)
>[0;37m2014-02-09 21:25:11.115[0m [[0;37mDEBUG[0m] Retrying dyn_put_post after exception caught from DNS request: fqdn already in use. Please choose another. (pid:11735)
>[0;37m2014-02-09 21:25:11.116[0m [[0;37mDEBUG[0m] DYNECT put/post with path: /REST/CNAMERecord/dev.rhcloud.com/myjbossews10-ray.dev.rhcloud.com/ json data: {"rdata":{"cname":"ec2-54-80-152-50.compute-1.amazonaws.com"},"ttl":"60"} and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:11735)
>[0;37m2014-02-09 21:25:12.144[0m [[0;37mDEBUG[0m] Retrying dyn_put_post after exception caught from DNS request: fqdn already in use. Please choose another. (pid:11735)
>[0;37m2014-02-09 21:25:12.144[0m [[0;37mDEBUG[0m] DYNECT put/post with path: /REST/CNAMERecord/dev.rhcloud.com/myjbossews10-ray.dev.rhcloud.com/ json data: {"rdata":{"cname":"ec2-54-80-152-50.compute-1.amazonaws.com"},"ttl":"60"} and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:11735)
>[0;37m2014-02-09 21:25:13.244[0m [[0;37mDEBUG[0m] DNS entry already exists for myjbossews10-ray.  Attempting to modify... (pid:11735)
>[0;37m2014-02-09 21:25:13.245[0m [[0;37mDEBUG[0m] Public ip being modified 'ec2-54-80-152-50.compute-1.amazonaws.com' to app 'myjbossews10' (pid:11735)
>[0;37m2014-02-09 21:25:13.245[0m [[0;37mDEBUG[0m] DYNECT put/post with path: /REST/CNAMERecord/dev.rhcloud.com/myjbossews10-ray.dev.rhcloud.com/ json data: {"rdata":{"cname":"ec2-54-80-152-50.compute-1.amazonaws.com"},"ttl":"60"} and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:11735)
>[0;37m2014-02-09 21:25:14.280[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {"zone": "dev.rhcloud.com", "ttl": 60, "fqdn": "myjbossews10-ray.dev.rhcloud.com", "record_type": "CNAME", "rdata": {"cname": "ec2-54-80-152-50.compute-1.amazonaws.com."}, "record_id": 0}, "job_id": 692794298, "msgs": [{"INFO": "update: Record updated", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:11735)
>[0;37m2014-02-09 21:25:14.280[0m [[0;37mDEBUG[0m] DYNECT Response data: {"zone"=>"dev.rhcloud.com", "ttl"=>60, "fqdn"=>"myjbossews10-ray.dev.rhcloud.com", "record_type"=>"CNAME", "rdata"=>{"cname"=>"ec2-54-80-152-50.compute-1.amazonaws.com."}, "record_id"=>0} (pid:11735)
>[0;37m2014-02-09 21:25:14.280[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_put_post): 1.035165608s  (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:14.280[0m [[0;37mDEBUG[0m] DYNECT put/post with path: /REST/Zone/dev.rhcloud.com/ json data: {"publish":"true"} and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:11735)
>[0;37m2014-02-09 21:25:15.851[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {"zone_type": "Primary", "serial_style": "day", "serial": 2014236703, "zone": "dev.rhcloud.com"}, "job_id": 692794329, "msgs": [{"INFO": "publish: dev.rhcloud.com published", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:11735)
>[0;37m2014-02-09 21:25:15.851[0m [[0;37mDEBUG[0m] DYNECT Response data: {"zone_type"=>"Primary", "serial_style"=>"day", "serial"=>2014236703, "zone"=>"dev.rhcloud.com"} (pid:11735)
>[0;37m2014-02-09 21:25:15.852[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_put_post): 1.571307382s  (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:15.852[0m [[0;37mDEBUG[0m] DYNECT delete with path: /REST/Session/ and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:11735)
>[0;37m2014-02-09 21:25:16.497[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {}, "job_id": 692794382, "msgs": [{"INFO": "logout: Logout successful", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:11735)
>[0;37m2014-02-09 21:25:16.498[0m [[0;37mDEBUG[0m] DYNECT Response data: {} (pid:11735)
>[0;37m2014-02-09 21:25:16.498[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_delete): 0.646015808s  (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:16.538[0m [[0;37mDEBUG[0m] Execute UpdateAppConfigOp gear_id=52f8387e1de544d0530002a4 (pid:11735)
>[0;37m2014-02-09 21:25:16.547[0m [[0;37mDEBUG[0m] Execute AddBrokerAuthKeyOp gear_id=52f8387e1de544d0530002a4 (pid:11735)
>[0;37m2014-02-09 21:25:16.549[0m [[0;37mDEBUG[0m] Execute AddCompOp comp_spec=component:jbossews-1.0/jbossews-1.0/52f805d3c1f111aad2000014 gear_id=52f8387e1de544d0530002a4 (pid:11735)
>[0;37m2014-02-09 21:25:16.556[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"jbossews-1.0", :action=>"configure", :args=>{"--with-app-uuid"=>"52f8387e1de544d0530002a4", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f8387e1de544d0530002a4", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"b3461105a7b69a728a9b86a85e45b5db", "--component-name"=>"jbossews-1.0", "--cart-name"=>"jbossews-1.0", "--with-software-version"=>"1.0", "--cartridge-vendor"=>"redhat"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:22.539[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x00000006c5cfc8 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"added manifest\nadding: WEB-INF/(in = 0) (out= 0)(stored 0%)\nadding: WEB-INF/web.xml(in = 350) (out= 185)(deflated 47%)\nadding: images/(in = 0) (out= 0)(stored 0%)\nadding: images/jbosscorp_logo.png(in = 1914) (out= 1919)(deflated 0%)\nadding: index.html(in = 40453) (out= 16093)(deflated 60%)\nadding: snoop.jsp(in = 5115) (out= 1261)(deflated 75%)\n", :exitcode=>0, :addtl_params=>nil}}>] (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:22.540[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: configure): 5.987088497s  (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:23.165[0m [[0;37mDEBUG[0m] DEBUG: Output of parallel execute: [{:tag=>{"op_id"=>"52f8387e1de544d0530002b4"}, :gear=>"52f8387e1de544d0530002a4", :job=>{:cartridge=>"openshift-origin-node", :action=>"authorized-ssh-key-batch-add", :args=>{"--with-app-uuid"=>"52f8387e1de544d0530002a4", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f8387e1de544d0530002a4", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"b3461105a7b69a728a9b86a85e45b5db", "--with-ssh-keys"=>[{"key"=>"AAAAB3NzaC1yc2EAAAABIwAAAQEAuA0LIdBeb6I61vB4LwGeDLYEQOZfyhA047yJbljt9cFsT1bNn+HvffJ+6dZzWIbeRv/gxVF/AlQnMk1/r6J20BBqj0WM3AJWzfIKauDkw43BlY0udkry8QXMAtO+ME3AwjcRdQ+tLFieHQRPUzJ/mWxFdjaHQWV+e0sZ7Dye4VJphJ/Ujf6tJkvOrA4wkO5V3RsQOaTuJR2O5VDQj02GbthGHfZoEIGJ1hkUEYpeXkkVesQytul62Qia1WyOrM+u24HHzUy3im57YBkBEneqOejvJ1SKPRfMXm8fi+e0nVvT98ItDNqqLg8o+qosA0KEK/RxHl6vvoLa9iNzYjoQPw==", "type"=>"ssh-rsa", "comment"=>"52f837f31de544d05300029d-default", "content"=>"AAAAB3NzaC1yc2EAAAABIwAAAQEAuA0LIdBeb6I61vB4LwGeDLYEQOZfyhA047yJbljt9cFsT1bNn+HvffJ+6dZzWIbeRv/gxVF/AlQnMk1/r6J20BBqj0WM3AJWzfIKauDkw43BlY0udkry8QXMAtO+ME3AwjcRdQ+tLFieHQRPUzJ/mWxFdjaHQWV+e0sZ7Dye4VJphJ/Ujf6tJkvOrA4wkO5V3RsQOaTuJR2O5VDQj02GbthGHfZoEIGJ1hkUEYpeXkkVesQytul62Qia1WyOrM+u24HHzUy3im57YBkBEneqOejvJ1SKPRfMXm8fi+e0nVvT98ItDNqqLg8o+qosA0KEK/RxHl6vvoLa9iNzYjoQPw=="}]}}, :result_stdout=>"", :result_stderr=>"", :result_exit_code=>0, :result_addtl_params=>nil}, {:tag=>{"op_id"=>"52f8387e1de544d0530002b4"}, :gear=>"52f8387e1de544d0530002a4", :job=>{:cartridge=>"openshift-origin-node", :action=>"update-configuration", :args=>{"--with-app-uuid"=>"52f8387e1de544d0530002a4", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f8387e1de544d0530002a4", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"b3461105a7b69a728a9b86a85e45b5db", "--with-config"=>{"auto_deploy"=>true, "deployment_branch"=>"master", "keep_deployments"=>1, "deployment_type"=>"git"}}}, :result_stdout=>"", :result_stderr=>"", :result_exit_code=>0, :result_addtl_params=>nil}, {:tag=>{"op_id"=>"52f8387e1de544d0530002b5"}, :gear=>"52f8387e1de544d0530002a4", :job=>{:cartridge=>"openshift-origin-node", :action=>"broker-auth-key-add", :args=>{"--with-app-uuid"=>"52f8387e1de544d0530002a4", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f8387e1de544d0530002a4", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"b3461105a7b69a728a9b86a85e45b5db", "--with-iv"=>"z67puvOFCup4aLCPAo8JhZ9GfpUvP94hRceEmQnzFN7K9ZShzJIovMVQ+UQv\nhIOVht7lbUj4PN1gJdqIWxwieGpr/0ANq0G6T5awMocKPwaxT3S/Jh5hSpT/\nWyojmxeDNCLpWeTjzZBq0IZH9aIaFiAQwGoXasvIYW3imweRszbJQzfkmFqX\ndusFEKOwfDoYq1PMmI+MVvJgtCVcJ/gPgtOfwsBvWR+PUSyQisOxq+K0Rswt\niGvZvzqmimB5vVPKk5un1KjLQcWTataozMMYxYCz2vYhLAhhVPHOwSyq3kDE\npRNFUpTL6ITYxk7b2JjDBGyRZ+7Ko0D0jQvBT/Sp0g==\n", "--with-token"=>"PMmSIlefM4jbNbneHzTJwv495dD5u1EtaqMdwWcrJ/8ZyqVMItmyfsoAqiv5\nW2TthsoFaJZQIiP0vvTxa/B5p7EKt6U0BzG1yX0SrtI+vgA=\n"}}, :result_stdout=>"", :result_stderr=>"", :result_exit_code=>0, :result_addtl_params=>nil}], exitcode: 0, from: ip-10-225-9-204  (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:23.168[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_parallel): 624ms  (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:23.230[0m [[0;37mDEBUG[0m] Execute AddCompOp comp_spec=component:mysql-5.1/mysql-5.1/52f805d3c1f111aad2000024 gear_id=52f8387e1de544d0530002a4 (pid:11735)
>[0;37m2014-02-09 21:25:23.238[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"mysql-5.1", :action=>"configure", :args=>{"--with-app-uuid"=>"52f8387e1de544d0530002a4", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f8387e1de544d0530002a4", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"b3461105a7b69a728a9b86a85e45b5db", "--component-name"=>"mysql-5.1", "--cart-name"=>"mysql-5.1", "--with-software-version"=>"5.1", "--cartridge-vendor"=>"redhat"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:27.538[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x00000006c6fa60 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"Generating username and password\nInstalling mysqld\nCLIENT_RESULT: \nCLIENT_RESULT: MySQL 5.1 database added.  Please make note of these credentials:\nCLIENT_RESULT: \nCLIENT_RESULT:        Root User: [HIDDEN] (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:27.540[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: configure): 4.305584225s  (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:27.584[0m [[0;37mDEBUG[0m] Execute PostConfigureCompOp comp_spec=component:mysql-5.1/mysql-5.1/52f805d3c1f111aad2000024 gear_id=52f8387e1de544d0530002a4 (pid:11735)
>[0;37m2014-02-09 21:25:27.591[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"mysql-5.1", :action=>"post-configure", :args=>{"--with-app-uuid"=>"52f8387e1de544d0530002a4", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f8387e1de544d0530002a4", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"b3461105a7b69a728a9b86a85e45b5db", "--component-name"=>"mysql-5.1", "--cart-name"=>"mysql-5.1", "--with-software-version"=>"5.1", "--cartridge-vendor"=>"redhat"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:49.270[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x00000006257af0 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"Starting MySQL 5.1 cartridge\n", :exitcode=>0, :addtl_params=>nil}}>] (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:49.286[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: post-configure): 21.439895294s  (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:49.671[0m [[0;37mDEBUG[0m] Execute AddCompOp comp_spec=component:mysql-5.5/mysql-5.5/52f805d3c1f111aad2000023 gear_id=52f8387e1de544d0530002a4 (pid:11735)
>[0;37m2014-02-09 21:25:49.747[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"mysql-5.5", :action=>"configure", :args=>{"--with-app-uuid"=>"52f8387e1de544d0530002a4", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f8387e1de544d0530002a4", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"b3461105a7b69a728a9b86a85e45b5db", "--component-name"=>"mysql-5.5", "--cart-name"=>"mysql-5.5", "--with-software-version"=>"5.5", "--cartridge-vendor"=>"redhat"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:52.951[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x00000006bd6428 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>1, :statusmsg=>"cartridge_do_action failed 119. Output Shell command '/sbin/runuser -s /bin/sh 52f8387e1de544d0530002a4 -c \"exec /usr/bin/runcon 'unconfined_u:system_r:openshift_t:s0:c0,c1020' /bin/sh -c \\\"/var/lib/openshift/52f8387e1de544d0530002a4/mysql/bin/install --version 5.5\\\"\"' returned an error. rc=119\nCLIENT_MESSAGE: Generating username and password\nCLIENT_MESSAGE: Installing mysqld\n\nCLIENT_ERROR: ERROR: 1136  Column count doesn't match value count at row 1\nCLIENT_ERROR: 140209 21:25:52 [ERROR] Aborting\nCLIENT_ERROR: \nCLIENT_ERROR: 140209 21:25:52 [Note] /opt/rh/mysql55/root/usr/libexec/mysqld: Shutdown complete\nCLIENT_ERROR: \nCLIENT_ERROR: Failed to create mysqldb,\n", :data=>{:time=>nil, :output=>"Shell command '/sbin/runuser -s /bin/sh 52f8387e1de544d0530002a4 -c \"exec /usr/bin/runcon 'unconfined_u:system_r:openshift_t:s0:c0,c1020' /bin/sh -c \\\"/var/lib/openshift/52f8387e1de544d0530002a4/mysql/bin/install --version 5.5\\\"\"' returned an error. rc=119\nCLIENT_MESSAGE: Generating username and password\nCLIENT_MESSAGE: Installing mysqld\n\nCLIENT_ERROR: ERROR: 1136  Column count doesn't match value count at row 1\nCLIENT_ERROR: 140209 21:25:52 [ERROR] Aborting\nCLIENT_ERROR: \nCLIENT_ERROR: 140209 21:25:52 [Note] /opt/rh/mysql55/root/usr/libexec/mysqld: Shutdown complete\nCLIENT_ERROR: \nCLIENT_ERROR: Failed to create mysqldb,\n", :exitcode=>119, :addtl_params=>nil}}>] (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:52.953[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: configure): 3.881801339s  (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:52.953[0m [[0;37mDEBUG[0m] DEBUG: server results: Shell command '/sbin/runuser -s /bin/sh 52f8387e1de544d0530002a4 -c "exec /usr/bin/runcon 'unconfined_u:system_r:openshift_t:s0:c0,c1020' /bin/sh -c \"/var/lib/openshift/52f8387e1de544d0530002a4/mysql/bin/install --version 5.5\""' returned an error. rc=119 (pid:11735)
>[0;37m2014-02-09 21:25:52.953[0m [[0;37mDEBUG[0m] DEBUG: server results: (pid:11735)
>[0;37m2014-02-09 21:25:52.954[0m [[31mERROR[0m] ERROR: 1136  Column count doesn't match value count at row 1
>140209 21:25:52 [ERROR] Aborting
>
>140209 21:25:52 [Note] /opt/rh/mysql55/root/usr/libexec/mysqld: Shutdown complete
>
>Failed to create mysqldb, (pid:11735)
>[0;37m2014-02-09 21:25:52.954[0m [[31mERROR[0m] /opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-msg-broker-mcollective-1.20.1/lib/openshift/mcollective_application_container_proxy.rb:2737:in `parse_result'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-msg-broker-mcollective-1.20.1/lib/openshift/mcollective_application_container_proxy.rb:2895:in `run_cartridge_command'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-msg-broker-mcollective-1.20.1/lib/openshift/mcollective_application_container_proxy.rb:820:in `add_component'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.1/app/models/gear.rb:174:in `add_component'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.1/app/pending_ops_models/add_comp_op.rb:9:in `execute'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.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.20.1/app/models/pending_app_op_group.rb:93:in `each'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.1/app/models/pending_app_op_group.rb:93:in `execute'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.1/app/models/application.rb:1584:in `run_jobs'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.1/app/models/application.rb:757:in `block in add_cartridges'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.1/app/models/application.rb:1654:in `run_in_application_lock'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.1/app/models/application.rb:734:in `add_cartridges'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.1/app/models/application.rb:642:in `add_initial_cartridges'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.1/app/controllers/applications_controller.rb:149: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__1059736802866067206__process_action__3780052016072301693__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_513'
>/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.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_513'
>/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:403:in `_run__1059736802866067206__process_action__3780052016072301693__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__2697050867048833167__call__2675625258615604122__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:11735)
>[0;37m2014-02-09 21:25:52.954[0m [[31mERROR[0m] Encountered error during execute 'ERROR: 1136  Column count doesn't match value count at row 1
>140209 21:25:52 [ERROR] Aborting
>
>140209 21:25:52 [Note] /opt/rh/mysql55/root/usr/libexec/mysqld: Shutdown complete
>
>Failed to create mysqldb,
>' (pid:11735)
>[0;37m2014-02-09 21:25:52.954[0m [[0;37mDEBUG[0m] ["/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-msg-broker-mcollective-1.20.1/lib/openshift/mcollective_application_container_proxy.rb:2737:in `parse_result'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-msg-broker-mcollective-1.20.1/lib/openshift/mcollective_application_container_proxy.rb:2895:in `run_cartridge_command'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-msg-broker-mcollective-1.20.1/lib/openshift/mcollective_application_container_proxy.rb:820:in `add_component'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.1/app/models/gear.rb:174:in `add_component'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.1/app/pending_ops_models/add_comp_op.rb:9:in `execute'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.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.20.1/app/models/pending_app_op_group.rb:93:in `each'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.1/app/models/pending_app_op_group.rb:93:in `execute'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.1/app/models/application.rb:1584:in `run_jobs'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.1/app/models/application.rb:757:in `block in add_cartridges'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.1/app/models/application.rb:1654:in `run_in_application_lock'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.1/app/models/application.rb:734:in `add_cartridges'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.1/app/models/application.rb:642:in `add_initial_cartridges'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.1/app/controllers/applications_controller.rb:149: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__1059736802866067206__process_action__3780052016072301693__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_513'", "/opt/rh/ruby193/root/usr/share/gems/gems/openshift-origin-controller-1.20.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_513'", "/opt/rh/ruby193/root/usr/share/gems/gems/activesupport-3.2.8/lib/active_support/callbacks.rb:403:in `_run__1059736802866067206__process_action__3780052016072301693__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__2697050867048833167__call__2675625258615604122__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:11735)
>[0;37m2014-02-09 21:25:53.769[0m [[0;37mDEBUG[0m] Rollback UpdateAppConfigOp gear_id=52f8387e1de544d0530002a4 (pid:11735)
>[0;37m2014-02-09 21:25:53.771[0m [[0;37mDEBUG[0m] Parallel rollback not implemented: UpdateAppConfigOp (pid:11735)
>[0;37m2014-02-09 21:25:53.772[0m [[0;37mDEBUG[0m] Rollback AddBrokerAuthKeyOp gear_id=52f8387e1de544d0530002a4 (pid:11735)
>[0;37m2014-02-09 21:25:53.773[0m [[0;37mDEBUG[0m] Parallel rollback not implemented: AddBrokerAuthKeyOp (pid:11735)
>[0;37m2014-02-09 21:25:53.775[0m [[0;37mDEBUG[0m] Rollback AddCompOp comp_spec=component:mysql-5.5/mysql-5.5/52f805d3c1f111aad2000023 gear_id=52f8387e1de544d0530002a4 (pid:11735)
>[0;37m2014-02-09 21:25:53.809[0m [[0;37mDEBUG[0m] DEBUG: Deconfiguring cartridge 'mysql-5.5' in application 'myjbossews10' on node 'ip-10-225-9-204' (pid:11735)
>[0;37m2014-02-09 21:25:53.842[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"mysql-5.5", :action=>"deconfigure", :args=>{"--with-app-uuid"=>"52f8387e1de544d0530002a4", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f8387e1de544d0530002a4", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"b3461105a7b69a728a9b86a85e45b5db", "--component-name"=>"mysql-5.5", "--cart-name"=>"mysql-5.5", "--with-software-version"=>"5.5", "--cartridge-vendor"=>"redhat"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:57.231[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x000000067978d0 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"", :exitcode=>0, :addtl_params=>nil}}>] (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:57.232[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: deconfigure): 4.151580172s  (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:57.247[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_parallel): 12ms  (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:57.297[0m [[0;37mDEBUG[0m] Rollback PostConfigureCompOp comp_spec=component:mysql-5.1/mysql-5.1/52f805d3c1f111aad2000024 gear_id=52f8387e1de544d0530002a4 (pid:11735)
>[0;37m2014-02-09 21:25:57.297[0m [[0;37mDEBUG[0m] Rollback not implemented: PostConfigureCompOp (pid:11735)
>[0;37m2014-02-09 21:25:57.332[0m [[0;37mDEBUG[0m] Rollback AddCompOp comp_spec=component:mysql-5.1/mysql-5.1/52f805d3c1f111aad2000024 gear_id=52f8387e1de544d0530002a4 (pid:11735)
>[0;37m2014-02-09 21:25:57.334[0m [[0;37mDEBUG[0m] DEBUG: Deconfiguring cartridge 'mysql-5.1' in application 'myjbossews10' on node 'ip-10-225-9-204' (pid:11735)
>[0;37m2014-02-09 21:25:57.338[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"mysql-5.1", :action=>"deconfigure", :args=>{"--with-app-uuid"=>"52f8387e1de544d0530002a4", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f8387e1de544d0530002a4", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"b3461105a7b69a728a9b86a85e45b5db", "--component-name"=>"mysql-5.1", "--cart-name"=>"mysql-5.1", "--with-software-version"=>"5.1", "--cartridge-vendor"=>"redhat"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:58.201[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x0000000620ad18 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"CLIENT_ERROR: Corrupted cartridge mysql-5.1 removed. There may be extraneous data left on system.\n", :exitcode=>0, :addtl_params=>nil}}>] (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:58.217[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: deconfigure): 0.686591672s  (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:58.601[0m [[0;37mDEBUG[0m] Rollback AddCompOp comp_spec=component:jbossews-1.0/jbossews-1.0/52f805d3c1f111aad2000014 gear_id=52f8387e1de544d0530002a4 (pid:11735)
>[0;37m2014-02-09 21:25:58.631[0m [[0;37mDEBUG[0m] DEBUG: Deconfiguring cartridge 'jbossews-1.0' in application 'myjbossews10' on node 'ip-10-225-9-204' (pid:11735)
>[0;37m2014-02-09 21:25:58.666[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"jbossews-1.0", :action=>"deconfigure", :args=>{"--with-app-uuid"=>"52f8387e1de544d0530002a4", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f8387e1de544d0530002a4", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"b3461105a7b69a728a9b86a85e45b5db", "--component-name"=>"jbossews-1.0", "--cart-name"=>"jbossews-1.0", "--with-software-version"=>"1.0", "--cartridge-vendor"=>"redhat"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:59.886[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x00000006b4c070 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"", :exitcode=>0, :addtl_params=>nil}}>] (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:25:59.889[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: deconfigure): 1.825973456s  (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:26:00.570[0m [[0;37mDEBUG[0m] Rollback RegisterDnsOp gear_id=52f8387e1de544d0530002a4 (pid:11735)
>[0;37m2014-02-09 21:26:00.670[0m [[0;37mDEBUG[0m] DYNECT Login with path: /REST/Session/ (pid:11735)
>[0;37m2014-02-09 21:26:00.908[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {"token": "ZfvyRdjJn6cntMRixi3qLm5oWijpH1DtKvQMFbyEsEVbQwR0GNPQjVCLdLxqDTvBHmLn5eLqRUZMaquWrRSTLZDtD3buzXbTju1B8UZRqWoAozXLGdOT5XET99I5RoRBSSkDjM3Yo/62ON0OGQGuYQ==", "version": "3.5.4"}, "job_id": 692795090, "msgs": [{"INFO": "login: Login successful", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:11735)
>[0;37m2014-02-09 21:26:00.909[0m [[0;37mDEBUG[0m] DYNECT Response data: {"token"=>"ZfvyRdjJn6cntMRixi3qLm5oWijpH1DtKvQMFbyEsEVbQwR0GNPQjVCLdLxqDTvBHmLn5eLqRUZMaquWrRSTLZDtD3buzXbTju1B8UZRqWoAozXLGdOT5XET99I5RoRBSSkDjM3Yo/62ON0OGQGuYQ==", "version"=>"3.5.4"} (pid:11735)
>[0;37m2014-02-09 21:26:00.909[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_login): 0.902711946s  (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:26:00.909[0m [[0;37mDEBUG[0m] DYNECT delete with path: /REST/CNAMERecord/dev.rhcloud.com/myjbossews10-ray.dev.rhcloud.com/ and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:11735)
>[0;37m2014-02-09 21:26:01.861[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {}, "job_id": 692795102, "msgs": [{"INFO": "delete: 1 records deleted", "SOURCE": "API-B", "ERR_CD": null, "LVL": "INFO"}]} (pid:11735)
>[0;37m2014-02-09 21:26:01.861[0m [[0;37mDEBUG[0m] DYNECT Response data: {} (pid:11735)
>[0;37m2014-02-09 21:26:01.861[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_delete): 0.952139879s  (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:26:01.862[0m [[0;37mDEBUG[0m] DYNECT put/post with path: /REST/Zone/dev.rhcloud.com/ json data: {"publish":"true"} and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:11735)
>[0;37m2014-02-09 21:26:03.725[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {"zone_type": "Primary", "serial_style": "day", "serial": 2014236708, "zone": "dev.rhcloud.com"}, "job_id": 692795130, "msgs": [{"INFO": "publish: dev.rhcloud.com published", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:11735)
>[0;37m2014-02-09 21:26:03.725[0m [[0;37mDEBUG[0m] DYNECT Response data: {"zone_type"=>"Primary", "serial_style"=>"day", "serial"=>2014236708, "zone"=>"dev.rhcloud.com"} (pid:11735)
>[0;37m2014-02-09 21:26:03.725[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_put_post): 1.86347615s  (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:26:03.725[0m [[0;37mDEBUG[0m] DYNECT delete with path: /REST/Session/ and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:11735)
>[0;37m2014-02-09 21:26:04.319[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {}, "job_id": 692795167, "msgs": [{"INFO": "logout: Logout successful", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:11735)
>[0;37m2014-02-09 21:26:04.319[0m [[0;37mDEBUG[0m] DYNECT Response data: {} (pid:11735)
>[0;37m2014-02-09 21:26:04.319[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_delete): 0.59383767s  (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:26:04.357[0m [[0;37mDEBUG[0m] Rollback CreateGearOp gear_id=52f8387e1de544d0530002a4 (pid:11735)
>[0;37m2014-02-09 21:26:04.361[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"openshift-origin-node", :action=>"app-destroy", :args=>{"--with-app-uuid"=>"52f8387e1de544d0530002a4", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f8387e1de544d0530002a4", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"b3461105a7b69a728a9b86a85e45b5db", "--cart-name"=>"openshift-origin-node"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:26:08.253[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x00000006b41030 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"", :exitcode=>0, :addtl_params=>nil}}>] (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:26:08.256[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: app-destroy): 3.898917935s  (Request ID: b3461105a7b69a728a9b86a85e45b5db) (pid:11735)
>[0;37m2014-02-09 21:26:08.293[0m [[0;37mDEBUG[0m] Rollback ReserveGearUidOp gear_id=52f8387e1de544d0530002a4 (pid:11735)
>[0;37m2014-02-09 21:26:08.338[0m [[0;37mDEBUG[0m] Rollback NotifyAppCreateOp (pid:11735)
>[0;37m2014-02-09 21:26:08.338[0m [[0;37mDEBUG[0m] Rollback not implemented: NotifyAppCreateOp (pid:11735)
>[0;37m2014-02-09 21:26:08.340[0m [[0;37mDEBUG[0m] Rollback InitGearOp comp_specs=[component:jbossews-1.0/jbossews-1.0/52f805d3c1f111aad2000014, component:mysql-5.1/mysql-5.1/52f805d3c1f111aad2000024, component:mysql-5.5/mysql-5.5/52f805d3c1f111aad2000023, component:phpmyadmin-4/phpmyadmin-4/52f805d3c1f111aad200000f] gear_id=52f8387e1de544d0530002a4 group_instance_id=52f8387e1de544d0530002a6 (pid:11735)
>[0;37m2014-02-09 21:26:08.484[0m [[0;37mDEBUG[0m] SUCCESS ACTION=ADD_APPLICATION USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f8387e1de544d0530002a4 DOMAIN=ray ERROR: 1136  Column count doesn't match value count at row 1 (pid:11735)
>[0;37m2014-02-09 21:26:08.486[0m [[32mINFO [0m] Completed 422 Unprocessable Entity in 65629ms (Views: 0.7ms) (pid:11735)
>[0;37m2014-02-09 21:26:25.920[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:26:25 -0500 (pid:11735)
>[0;37m2014-02-09 21:26:25.923[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11735)
>[0;37m2014-02-09 21:26:25.923[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11735)
>[0;37m2014-02-09 21:26:25.936[0m [[32mINFO [0m] Completed 200 OK in 13ms (Views: 6.9ms) (pid:11735)
>[0;37m2014-02-09 21:26:26.232[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:26:26 -0500 (pid:11735)
>[0;37m2014-02-09 21:26:26.233[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11735)
>[0;37m2014-02-09 21:26:26.233[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:26:26.246[0m [[32mINFO [0m] Completed 200 OK in 12ms (Views: 7.4ms) (pid:11735)
>[0;37m2014-02-09 21:26:26.538[0m [[32mINFO [0m] Started GET "/broker/rest/applications?include=cartridges" for 66.187.233.202 at 2014-02-09 21:26:26 -0500 (pid:11735)
>[0;37m2014-02-09 21:26:26.540[0m [[32mINFO [0m] Processing by ApplicationsController#index as JSON (pid:11735)
>[0;37m2014-02-09 21:26:26.540[0m [[32mINFO [0m] Parameters: {"include"=>"cartridges"} (pid:11735)
>[0;37m2014-02-09 21:26:26.541[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:26:26.545[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11735)
>[0;37m2014-02-09 21:26:26.546[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_APPLICATION USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= Found 0 applications. (pid:11735)
>[0;37m2014-02-09 21:26:26.548[0m [[32mINFO [0m] Completed 200 OK in 8ms (Views: 0.6ms) (pid:11735)
>[0;37m2014-02-09 21:26:26.825[0m [[32mINFO [0m] Started GET "/broker/rest/domains" for 66.187.233.202 at 2014-02-09 21:26:26 -0500 (pid:11735)
>[0;37m2014-02-09 21:26:26.827[0m [[32mINFO [0m] Processing by DomainsController#index as JSON (pid:11735)
>[0;37m2014-02-09 21:26:26.827[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:26:26.831[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11735)
>[0;37m2014-02-09 21:26:26.835[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_DOMAIN USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11735)
>[0;37m2014-02-09 21:26:26.842[0m [[32mINFO [0m] Completed 200 OK in 15ms (Views: 5.7ms) (pid:11735)
>[0;37m2014-02-09 21:26:43.191[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:26:43 -0500 (pid:11735)
>[0;37m2014-02-09 21:26:43.193[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11735)
>[0;37m2014-02-09 21:26:43.193[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11735)
>[0;37m2014-02-09 21:26:43.205[0m [[32mINFO [0m] Completed 200 OK in 12ms (Views: 6.7ms) (pid:11735)
>[0;37m2014-02-09 21:26:43.495[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:26:43 -0500 (pid:11735)
>[0;37m2014-02-09 21:26:43.497[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11735)
>[0;37m2014-02-09 21:26:43.497[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:26:43.509[0m [[32mINFO [0m] Completed 200 OK in 12ms (Views: 7.1ms) (pid:11735)
>[0;37m2014-02-09 21:26:43.805[0m [[32mINFO [0m] Started GET "/broker/rest/cartridges" for 66.187.233.202 at 2014-02-09 21:26:43 -0500 (pid:11735)
>[0;37m2014-02-09 21:26:43.807[0m [[32mINFO [0m] Processing by CartridgesController#index as JSON (pid:11735)
>[0;37m2014-02-09 21:26:43.807[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:26:43.948[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_CARTRIDGE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= Listing cartridges (pid:11735)
>[0;37m2014-02-09 21:26:43.973[0m [[32mINFO [0m] Completed 200 OK in 166ms (Views: 24.3ms) (pid:11735)
>[0;37m2014-02-09 21:26:44.558[0m [[32mINFO [0m] Started GET "/broker/rest/domains" for 66.187.233.202 at 2014-02-09 21:26:44 -0500 (pid:11735)
>[0;37m2014-02-09 21:26:44.560[0m [[32mINFO [0m] Processing by DomainsController#index as JSON (pid:11735)
>[0;37m2014-02-09 21:26:44.561[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:26:44.565[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11735)
>[0;37m2014-02-09 21:26:44.570[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_DOMAIN USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11735)
>[0;37m2014-02-09 21:26:44.577[0m [[32mINFO [0m] Completed 200 OK in 16ms (Views: 5.8ms) (pid:11735)
>[0;37m2014-02-09 21:26:44.880[0m [[32mINFO [0m] Started POST "/broker/rest/domain/ray/applications" for 66.187.233.202 at 2014-02-09 21:26:44 -0500 (pid:11735)
>[0;37m2014-02-09 21:26:44.883[0m [[32mINFO [0m] Processing by ApplicationsController#create as JSON (pid:11735)
>[0;37m2014-02-09 21:26:44.884[0m [[32mINFO [0m] Parameters: {"name"=>"myjbossews10", "cartridges"=>["jbossews-1.0", "mysql-5.1"], "domain_id"=>"ray", "application"=>{"name"=>"myjbossews10"}} (pid:11735)
>[0;37m2014-02-09 21:26:44.884[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:26:44.888[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11735)
>[0;37m2014-02-09 21:26:44.921[0m [[0;37mDEBUG[0m] Pre-Executing ops... (pid:11735)
>[0;37m2014-02-09 21:26:44.922[0m [[0;37mDEBUG[0m] Pre-Execute InitGearOp comp_specs=[component:jbossews-1.0/jbossews-1.0/52f805d3c1f111aad2000014, component:mysql-5.1/mysql-5.1/52f805d3c1f111aad2000024] gear_id=52f838e41de544d0530002bf group_instance_id=52f838e41de544d0530002c1 (pid:11735)
>[0;37m2014-02-09 21:26:44.987[0m [[0;37mDEBUG[0m] Execute NotifyAppCreateOp (pid:11735)
>[0;37m2014-02-09 21:26:45.183[0m [[0;37mDEBUG[0m] Execute ReserveGearUidOp gear_id=52f838e41de544d0530002bf (pid:11735)
>[0;37m2014-02-09 21:26:45.224[0m [[0;37mDEBUG[0m] DEBUG: rpc_get_fact: fact=active_capacity (pid:11735)
>[0;37m2014-02-09 21:26:45.253[0m [[0;37mDEBUG[0m] DEBUG: rpc_exec: rpc_client=#<MCollective::RPC::Client:0x000000072ef020> (pid:11735)
>[0;37m2014-02-09 21:26:47.939[0m [[0;37mDEBUG[0m] Selecting best fit node: server: ip-10-225-9-204 capacity: 17.77777777777778 (pid:11735)
>[0;37m2014-02-09 21:26:47.126[0m [[0;37mDEBUG[0m] Execute CreateGearOp gear_id=52f838e41de544d0530002bf (pid:11735)
>[0;37m2014-02-09 21:26:47.132[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"openshift-origin-node", :action=>"app-create", :args=>{"--with-app-uuid"=>"52f838e41de544d0530002bf", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f838e41de544d0530002bf", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"7d9623c3807effdaea51ef2137ca9697", "--with-secret-token"=>"Dj04fpKiCSj06Jn04uSSusXh0boISlCgiFK9GVhvMe2jgldXZNjBAGTmJM89TIU86c_cl56MYat87YJhAlcp3_NoqR2zg9nfoaweW7itWc0R29P7piGQ1pseXReoZv3G", "--with-initial-deployment-dir"=>true, "--cart-name"=>"openshift-origin-node"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: 7d9623c3807effdaea51ef2137ca9697) (pid:11735)
>[0;37m2014-02-09 21:26:50.622[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x000000068680c0 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"", :exitcode=>0, :addtl_params=>nil}}>] (Request ID: 7d9623c3807effdaea51ef2137ca9697) (pid:11735)
>[0;37m2014-02-09 21:26:50.625[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: app-create): 3.495972397s  (Request ID: 7d9623c3807effdaea51ef2137ca9697) (pid:11735)
>[0;37m2014-02-09 21:26:50.659[0m [[0;37mDEBUG[0m] Execute RegisterDnsOp gear_id=52f838e41de544d0530002bf (pid:11735)
>[0;37m2014-02-09 21:26:50.662[0m [[0;37mDEBUG[0m] DYNECT Login with path: /REST/Session/ (pid:11735)
>[0;37m2014-02-09 21:26:51.500[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {"token": "MY5bFHWn0FGl3ci4zs1WQiiraZAUu0VeLqUiJdULP/CV5Dq/Ofy36rT98ZGn+uy/uOJgkmpVuzKQBiUGzS+zibMOanwOUTfrk2Ivs0ssk/fWWUln0zYEQOrEN8o2J6lkjd1n3wFxVFBGdNHq2B7l0Q==", "version": "3.5.4"}, "job_id": 692795756, "msgs": [{"INFO": "login: Login successful", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:11735)
>[0;37m2014-02-09 21:26:51.500[0m [[0;37mDEBUG[0m] DYNECT Response data: {"token"=>"MY5bFHWn0FGl3ci4zs1WQiiraZAUu0VeLqUiJdULP/CV5Dq/Ofy36rT98ZGn+uy/uOJgkmpVuzKQBiUGzS+zibMOanwOUTfrk2Ivs0ssk/fWWUln0zYEQOrEN8o2J6lkjd1n3wFxVFBGdNHq2B7l0Q==", "version"=>"3.5.4"} (pid:11735)
>[0;37m2014-02-09 21:26:51.501[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_login): 0.838427331s  (Request ID: 7d9623c3807effdaea51ef2137ca9697) (pid:11735)
>[0;37m2014-02-09 21:26:51.591[0m [[0;37mDEBUG[0m] Public ip being configured 'ec2-54-80-152-50.compute-1.amazonaws.com' to app 'myjbossews10' (pid:11735)
>[0;37m2014-02-09 21:26:51.591[0m [[0;37mDEBUG[0m] DYNECT put/post with path: /REST/CNAMERecord/dev.rhcloud.com/myjbossews10-ray.dev.rhcloud.com/ json data: {"rdata":{"cname":"ec2-54-80-152-50.compute-1.amazonaws.com"},"ttl":"60"} and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:11735)
>[0;37m2014-02-09 21:26:52.514[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {"zone": "dev.rhcloud.com", "ttl": 60, "fqdn": "myjbossews10-ray.dev.rhcloud.com", "record_type": "CNAME", "rdata": {"cname": "ec2-54-80-152-50.compute-1.amazonaws.com."}, "record_id": 0}, "job_id": 692795769, "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:11735)
>[0;37m2014-02-09 21:26:52.514[0m [[0;37mDEBUG[0m] DYNECT Response data: {"zone"=>"dev.rhcloud.com", "ttl"=>60, "fqdn"=>"myjbossews10-ray.dev.rhcloud.com", "record_type"=>"CNAME", "rdata"=>{"cname"=>"ec2-54-80-152-50.compute-1.amazonaws.com."}, "record_id"=>0} (pid:11735)
>[0;37m2014-02-09 21:26:52.514[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_put_post): 0.923457706s  (Request ID: 7d9623c3807effdaea51ef2137ca9697) (pid:11735)
>[0;37m2014-02-09 21:26:52.515[0m [[0;37mDEBUG[0m] DYNECT put/post with path: /REST/Zone/dev.rhcloud.com/ json data: {"publish":"true"} and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:11735)
>[0;37m2014-02-09 21:26:53.870[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {"zone_type": "Primary", "serial_style": "day", "serial": 2014236712, "zone": "dev.rhcloud.com"}, "job_id": 692795784, "msgs": [{"INFO": "publish: dev.rhcloud.com published", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:11735)
>[0;37m2014-02-09 21:26:53.870[0m [[0;37mDEBUG[0m] DYNECT Response data: {"zone_type"=>"Primary", "serial_style"=>"day", "serial"=>2014236712, "zone"=>"dev.rhcloud.com"} (pid:11735)
>[0;37m2014-02-09 21:26:53.870[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_put_post): 1.355435182s  (Request ID: 7d9623c3807effdaea51ef2137ca9697) (pid:11735)
>[0;37m2014-02-09 21:26:53.870[0m [[0;37mDEBUG[0m] DYNECT delete with path: /REST/Session/ and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:11735)
>[0;37m2014-02-09 21:26:54.411[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {}, "job_id": 692795800, "msgs": [{"INFO": "logout: Logout successful", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:11735)
>[0;37m2014-02-09 21:26:54.412[0m [[0;37mDEBUG[0m] DYNECT Response data: {} (pid:11735)
>[0;37m2014-02-09 21:26:54.412[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_delete): 0.541529099s  (Request ID: 7d9623c3807effdaea51ef2137ca9697) (pid:11735)
>[0;37m2014-02-09 21:26:54.442[0m [[0;37mDEBUG[0m] Execute UpdateAppConfigOp gear_id=52f838e41de544d0530002bf (pid:11735)
>[0;37m2014-02-09 21:26:54.450[0m [[0;37mDEBUG[0m] Execute AddBrokerAuthKeyOp gear_id=52f838e41de544d0530002bf (pid:11735)
>[0;37m2014-02-09 21:26:54.452[0m [[0;37mDEBUG[0m] Execute AddCompOp comp_spec=component:jbossews-1.0/jbossews-1.0/52f805d3c1f111aad2000014 gear_id=52f838e41de544d0530002bf (pid:11735)
>[0;37m2014-02-09 21:26:54.459[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"jbossews-1.0", :action=>"configure", :args=>{"--with-app-uuid"=>"52f838e41de544d0530002bf", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f838e41de544d0530002bf", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"7d9623c3807effdaea51ef2137ca9697", "--component-name"=>"jbossews-1.0", "--cart-name"=>"jbossews-1.0", "--with-software-version"=>"1.0", "--cartridge-vendor"=>"redhat"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: 7d9623c3807effdaea51ef2137ca9697) (pid:11735)
>[0;37m2014-02-09 21:27:00.432[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x00000005d8a0e0 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"added manifest\nadding: WEB-INF/(in = 0) (out= 0)(stored 0%)\nadding: WEB-INF/web.xml(in = 350) (out= 185)(deflated 47%)\nadding: images/(in = 0) (out= 0)(stored 0%)\nadding: images/jbosscorp_logo.png(in = 1914) (out= 1919)(deflated 0%)\nadding: index.html(in = 40453) (out= 16093)(deflated 60%)\nadding: snoop.jsp(in = 5115) (out= 1261)(deflated 75%)\n", :exitcode=>0, :addtl_params=>nil}}>] (Request ID: 7d9623c3807effdaea51ef2137ca9697) (pid:11735)
>[0;37m2014-02-09 21:27:00.434[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: configure): 5.977427921s  (Request ID: 7d9623c3807effdaea51ef2137ca9697) (pid:11735)
>[0;37m2014-02-09 21:27:01.478[0m [[0;37mDEBUG[0m] DEBUG: Output of parallel execute: [{:tag=>{"op_id"=>"52f838e41de544d0530002cb"}, :gear=>"52f838e41de544d0530002bf", :job=>{:cartridge=>"openshift-origin-node", :action=>"authorized-ssh-key-batch-add", :args=>{"--with-app-uuid"=>"52f838e41de544d0530002bf", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f838e41de544d0530002bf", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"7d9623c3807effdaea51ef2137ca9697", "--with-ssh-keys"=>[{"key"=>"AAAAB3NzaC1yc2EAAAABIwAAAQEAuA0LIdBeb6I61vB4LwGeDLYEQOZfyhA047yJbljt9cFsT1bNn+HvffJ+6dZzWIbeRv/gxVF/AlQnMk1/r6J20BBqj0WM3AJWzfIKauDkw43BlY0udkry8QXMAtO+ME3AwjcRdQ+tLFieHQRPUzJ/mWxFdjaHQWV+e0sZ7Dye4VJphJ/Ujf6tJkvOrA4wkO5V3RsQOaTuJR2O5VDQj02GbthGHfZoEIGJ1hkUEYpeXkkVesQytul62Qia1WyOrM+u24HHzUy3im57YBkBEneqOejvJ1SKPRfMXm8fi+e0nVvT98ItDNqqLg8o+qosA0KEK/RxHl6vvoLa9iNzYjoQPw==", "type"=>"ssh-rsa", "comment"=>"52f837f31de544d05300029d-default", "content"=>"AAAAB3NzaC1yc2EAAAABIwAAAQEAuA0LIdBeb6I61vB4LwGeDLYEQOZfyhA047yJbljt9cFsT1bNn+HvffJ+6dZzWIbeRv/gxVF/AlQnMk1/r6J20BBqj0WM3AJWzfIKauDkw43BlY0udkry8QXMAtO+ME3AwjcRdQ+tLFieHQRPUzJ/mWxFdjaHQWV+e0sZ7Dye4VJphJ/Ujf6tJkvOrA4wkO5V3RsQOaTuJR2O5VDQj02GbthGHfZoEIGJ1hkUEYpeXkkVesQytul62Qia1WyOrM+u24HHzUy3im57YBkBEneqOejvJ1SKPRfMXm8fi+e0nVvT98ItDNqqLg8o+qosA0KEK/RxHl6vvoLa9iNzYjoQPw=="}]}}, :result_stdout=>"", :result_stderr=>"", :result_exit_code=>0, :result_addtl_params=>nil}, {:tag=>{"op_id"=>"52f838e41de544d0530002cb"}, :gear=>"52f838e41de544d0530002bf", :job=>{:cartridge=>"openshift-origin-node", :action=>"update-configuration", :args=>{"--with-app-uuid"=>"52f838e41de544d0530002bf", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f838e41de544d0530002bf", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"7d9623c3807effdaea51ef2137ca9697", "--with-config"=>{"auto_deploy"=>true, "deployment_branch"=>"master", "keep_deployments"=>1, "deployment_type"=>"git"}}}, :result_stdout=>"", :result_stderr=>"", :result_exit_code=>0, :result_addtl_params=>nil}, {:tag=>{"op_id"=>"52f838e41de544d0530002cc"}, :gear=>"52f838e41de544d0530002bf", :job=>{:cartridge=>"openshift-origin-node", :action=>"broker-auth-key-add", :args=>{"--with-app-uuid"=>"52f838e41de544d0530002bf", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f838e41de544d0530002bf", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"7d9623c3807effdaea51ef2137ca9697", "--with-iv"=>"r2kU1gvmTA0p7MlH6PkabDxI77cEUJvUO3sIvDEzWii37YJjTzilj+GYP1EU\n8/LPYiGCh9Igb/MYjkWQZmPR5YhRMjN4IJ6qo6VItZr8ZqRi7yfWh2Og5IeN\nD9SSbfQEYZKgxWT82hI+pSer5ViMvt0BkpAZo7FdVL7eixjaanwWNxoj2G98\nWvFLbLS51B0S+xijIRCid8iG3MS1WKlhJRnsOPvxemziluRldXnitL2NaveP\n3pOGpWQ+SrutUIfZy1rqKEhFkFtoy/OVruIfJP5o/l4z3qTkBl4Z/xbPq7tm\nPio+NWa8n35kC2xlbdW1UZGAQxlHEOxnSQiUzzjz2g==\n", "--with-token"=>"IH1C6EG/AE/puH9tEuW0gVZIhbyrHns0pQ453adwSqc1I6u24DEPuHMhb7Y5\nrcxoUQHxE9rSoCDMRDqwtaoKdUXFQgosRoEccG3RMOenE9Q=\n"}}, :result_stdout=>"", :result_stderr=>"", :result_exit_code=>0, :result_addtl_params=>nil}], exitcode: 0, from: ip-10-225-9-204  (Request ID: 7d9623c3807effdaea51ef2137ca9697) (pid:11735)
>[0;37m2014-02-09 21:27:01.743[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_parallel): 570ms  (Request ID: 7d9623c3807effdaea51ef2137ca9697) (pid:11735)
>[0;37m2014-02-09 21:27:01.611[0m [[0;37mDEBUG[0m] Execute AddCompOp comp_spec=component:mysql-5.1/mysql-5.1/52f805d3c1f111aad2000024 gear_id=52f838e41de544d0530002bf (pid:11735)
>[0;37m2014-02-09 21:27:01.686[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"mysql-5.1", :action=>"configure", :args=>{"--with-app-uuid"=>"52f838e41de544d0530002bf", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f838e41de544d0530002bf", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"7d9623c3807effdaea51ef2137ca9697", "--component-name"=>"mysql-5.1", "--cart-name"=>"mysql-5.1", "--with-software-version"=>"5.1", "--cartridge-vendor"=>"redhat"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: 7d9623c3807effdaea51ef2137ca9697) (pid:11735)
>[0;37m2014-02-09 21:27:05.816[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x00000005d809c8 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"Generating username and password\nInstalling mysqld\nCLIENT_RESULT: \nCLIENT_RESULT: MySQL 5.1 database added.  Please make note of these credentials:\nCLIENT_RESULT: \nCLIENT_RESULT:        Root User: [HIDDEN] (Request ID: 7d9623c3807effdaea51ef2137ca9697) (pid:11735)
>[0;37m2014-02-09 21:27:05.819[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: configure): 4.753698179s  (Request ID: 7d9623c3807effdaea51ef2137ca9697) (pid:11735)
>[0;37m2014-02-09 21:27:05.854[0m [[0;37mDEBUG[0m] Execute PostConfigureCompOp comp_spec=component:mysql-5.1/mysql-5.1/52f805d3c1f111aad2000024 gear_id=52f838e41de544d0530002bf (pid:11735)
>[0;37m2014-02-09 21:27:05.861[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"mysql-5.1", :action=>"post-configure", :args=>{"--with-app-uuid"=>"52f838e41de544d0530002bf", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f838e41de544d0530002bf", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"7d9623c3807effdaea51ef2137ca9697", "--component-name"=>"mysql-5.1", "--cart-name"=>"mysql-5.1", "--with-software-version"=>"5.1", "--cartridge-vendor"=>"redhat"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: 7d9623c3807effdaea51ef2137ca9697) (pid:11735)
>[0;37m2014-02-09 21:27:27.300[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x00000006acb308 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"Starting MySQL 5.1 cartridge\n", :exitcode=>0, :addtl_params=>nil}}>] (Request ID: 7d9623c3807effdaea51ef2137ca9697) (pid:11735)
>[0;37m2014-02-09 21:27:27.302[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: post-configure): 21.444422247s  (Request ID: 7d9623c3807effdaea51ef2137ca9697) (pid:11735)
>[0;37m2014-02-09 21:27:27.331[0m [[0;37mDEBUG[0m] Execute ExecuteConnectionsOp (pid:11735)
>[0;37m2014-02-09 21:27:27.437[0m [[0;37mDEBUG[0m] Execute PostConfigureCompOp comp_spec=component:jbossews-1.0/jbossews-1.0/52f805d3c1f111aad2000014 gear_id=52f838e41de544d0530002bf (pid:11735)
>[0;37m2014-02-09 21:27:27.443[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"jbossews-1.0", :action=>"post-configure", :args=>{"--with-app-uuid"=>"52f838e41de544d0530002bf", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f838e41de544d0530002bf", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"7d9623c3807effdaea51ef2137ca9697", "--component-name"=>"jbossews-1.0", "--cart-name"=>"jbossews-1.0", "--with-software-version"=>"1.0", "--cartridge-vendor"=>"redhat"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: 7d9623c3807effdaea51ef2137ca9697) (pid:11735)
>[0;37m2014-02-09 21:27:33.957[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x00000005a38db0 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"Starting jbossews cartridge\nFound 127.1.254.1:8080 listening port\n", :exitcode=>0, :addtl_params=>{:deployments=>[{:id=>"7401d5b2", :ref=>"master", :sha1=>"1251021", :force_clean_build=>nil, :hot_deploy=>nil, :created_at=>1391999208.8700001, :activations=>[1391999250.345974]}]}}}>] (Request ID: 7d9623c3807effdaea51ef2137ca9697) (pid:11735)
>[0;37m2014-02-09 21:27:33.958[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: post-configure): 6.517990993s  (Request ID: 7d9623c3807effdaea51ef2137ca9697) (pid:11735)
>[0;37m2014-02-09 21:27:33.965[0m [[0;37mDEBUG[0m] Execute TrackUsageOp gear_id=52f838e41de544d0530002bf (pid:11735)
>[0;37m2014-02-09 21:27:34.198[0m [[0;37mDEBUG[0m] SUCCESS ACTION=ADD_APPLICATION USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f838e41de544d0530002bf DOMAIN=ray Application myjbossews10 was created. (pid:11735)
>[0;37m2014-02-09 21:27:34.348[0m [[32mINFO [0m] Completed 201 Created in 49151ms (Views: 13.5ms) (pid:11735)
>[0;37m2014-02-09 21:27:36.435[0m [[32mINFO [0m] Started GET "/broker/rest/user" for 66.187.233.202 at 2014-02-09 21:27:36 -0500 (pid:11735)
>[0;37m2014-02-09 21:27:36.438[0m [[32mINFO [0m] Processing by UserExtController#show as JSON (pid:11735)
>[0;37m2014-02-09 21:27:36.438[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:27:36.442[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11735)
>[0;37m2014-02-09 21:27:36.444[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_USER USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11735)
>[0;37m2014-02-09 21:27:36.447[0m [[32mINFO [0m] Completed 200 OK in 9ms (Views: 1.7ms) (pid:11735)
>[0;37m2014-02-09 21:27:36.810[0m [[32mINFO [0m] Started GET "/broker/rest/user/keys" for 66.187.233.202 at 2014-02-09 21:27:36 -0500 (pid:11735)
>[0;37m2014-02-09 21:27:36.811[0m [[32mINFO [0m] Processing by KeysController#index as JSON (pid:11735)
>[0;37m2014-02-09 21:27:36.812[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:27:36.815[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11735)
>[0;37m2014-02-09 21:27:36.817[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_KEY USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= Found 1 ssh keys (pid:11735)
>[0;37m2014-02-09 21:27:36.820[0m [[32mINFO [0m] Completed 200 OK in 8ms (Views: 1.6ms) (pid:11735)
>[0;37m2014-02-09 21:27:50.976[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:27:50 -0500 (pid:11735)
>[0;37m2014-02-09 21:27:50.978[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11735)
>[0;37m2014-02-09 21:27:50.979[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11735)
>[0;37m2014-02-09 21:27:50.991[0m [[32mINFO [0m] Completed 200 OK in 13ms (Views: 6.8ms) (pid:11735)
>[0;37m2014-02-09 21:27:51.406[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:27:51 -0500 (pid:11735)
>[0;37m2014-02-09 21:27:51.407[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11735)
>[0;37m2014-02-09 21:27:51.408[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:27:51.420[0m [[32mINFO [0m] Completed 200 OK in 12ms (Views: 7.2ms) (pid:11735)
>[0;37m2014-02-09 21:27:51.832[0m [[32mINFO [0m] Started GET "/broker/rest/domains" for 66.187.233.202 at 2014-02-09 21:27:51 -0500 (pid:11735)
>[0;37m2014-02-09 21:27:51.834[0m [[32mINFO [0m] Processing by DomainsController#index as JSON (pid:11735)
>[0;37m2014-02-09 21:27:51.834[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:27:51.838[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11735)
>[0;37m2014-02-09 21:27:51.842[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_DOMAIN USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11735)
>[0;37m2014-02-09 21:27:51.849[0m [[32mINFO [0m] Completed 200 OK in 15ms (Views: 5.8ms) (pid:11735)
>[0;37m2014-02-09 21:27:52.276[0m [[32mINFO [0m] Started GET "/broker/rest/domains/ray/applications/myjbossews10" for 66.187.233.202 at 2014-02-09 21:27:52 -0500 (pid:11735)
>[0;37m2014-02-09 21:27:52.278[0m [[32mINFO [0m] Processing by ApplicationsController#show as JSON (pid:11735)
>[0;37m2014-02-09 21:27:52.278[0m [[32mINFO [0m] Parameters: {"domain_id"=>"ray", "id"=>"myjbossews10"} (pid:11735)
>[0;37m2014-02-09 21:27:52.278[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:27:52.282[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11735)
>[0;37m2014-02-09 21:27:52.295[0m [[0;37mDEBUG[0m] SUCCESS ACTION=SHOW_APPLICATION USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f838e41de544d0530002bf DOMAIN=ray Application 'myjbossews10' found (pid:11735)
>[0;37m2014-02-09 21:27:52.389[0m [[32mINFO [0m] Completed 200 OK in 111ms (Views: 93.4ms) (pid:11735)
>[0;37m2014-02-09 21:28:04.994[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:28:04 -0500 (pid:11735)
>[0;37m2014-02-09 21:28:04.996[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11735)
>[0;37m2014-02-09 21:28:04.997[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11735)
>[0;37m2014-02-09 21:28:05.995[0m [[32mINFO [0m] Completed 200 OK in 13ms (Views: 7.1ms) (pid:11735)
>[0;37m2014-02-09 21:28:05.425[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:28:05 -0500 (pid:11735)
>[0;37m2014-02-09 21:28:05.427[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11735)
>[0;37m2014-02-09 21:28:05.427[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:28:05.440[0m [[32mINFO [0m] Completed 200 OK in 13ms (Views: 7.7ms) (pid:11735)
>[0;37m2014-02-09 21:28:05.849[0m [[32mINFO [0m] Started GET "/broker/rest/cartridges" for 66.187.233.202 at 2014-02-09 21:28:05 -0500 (pid:11735)
>[0;37m2014-02-09 21:28:05.851[0m [[32mINFO [0m] Processing by CartridgesController#index as JSON (pid:11735)
>[0;37m2014-02-09 21:28:05.851[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:28:05.902[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_CARTRIDGE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= Listing cartridges (pid:11735)
>[0;37m2014-02-09 21:28:05.926[0m [[32mINFO [0m] Completed 200 OK in 75ms (Views: 22.7ms) (pid:11735)
>[0;37m2014-02-09 21:28:16.261[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:28:16 -0500 (pid:11735)
>[0;37m2014-02-09 21:28:16.263[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11735)
>[0;37m2014-02-09 21:28:16.263[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11735)
>[0;37m2014-02-09 21:28:16.275[0m [[32mINFO [0m] Completed 200 OK in 12ms (Views: 6.7ms) (pid:11735)
>[0;37m2014-02-09 21:28:16.658[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:28:16 -0500 (pid:11735)
>[0;37m2014-02-09 21:28:16.660[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11735)
>[0;37m2014-02-09 21:28:16.660[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:28:16.672[0m [[32mINFO [0m] Completed 200 OK in 12ms (Views: 7.3ms) (pid:11735)
>[0;37m2014-02-09 21:28:17.102[0m [[32mINFO [0m] Started GET "/broker/rest/cartridges" for 66.187.233.202 at 2014-02-09 21:28:17 -0500 (pid:11735)
>[0;37m2014-02-09 21:28:17.121[0m [[32mINFO [0m] Processing by CartridgesController#index as JSON (pid:11735)
>[0;37m2014-02-09 21:28:17.124[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:28:17.145[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_CARTRIDGE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= Listing cartridges (pid:11735)
>[0;37m2014-02-09 21:28:17.169[0m [[32mINFO [0m] Completed 200 OK in 158ms (Views: 23.4ms) (pid:11735)
>[0;37m2014-02-09 21:28:17.859[0m [[32mINFO [0m] Started GET "/broker/rest/domains" for 66.187.233.202 at 2014-02-09 21:28:17 -0500 (pid:11735)
>[0;37m2014-02-09 21:28:17.861[0m [[32mINFO [0m] Processing by DomainsController#index as JSON (pid:11735)
>[0;37m2014-02-09 21:28:17.862[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:28:17.866[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11735)
>[0;37m2014-02-09 21:28:17.871[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_DOMAIN USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11735)
>[0;37m2014-02-09 21:28:17.877[0m [[32mINFO [0m] Completed 200 OK in 16ms (Views: 5.7ms) (pid:11735)
>[0;37m2014-02-09 21:28:18.194[0m [[32mINFO [0m] Started GET "/broker/rest/domains/ray/applications/myjbossews10?include=cartridges" for 66.187.233.202 at 2014-02-09 21:28:18 -0500 (pid:11735)
>[0;37m2014-02-09 21:28:18.197[0m [[32mINFO [0m] Processing by ApplicationsController#show as JSON (pid:11735)
>[0;37m2014-02-09 21:28:18.197[0m [[32mINFO [0m] Parameters: {"include"=>"cartridges", "domain_id"=>"ray", "id"=>"myjbossews10"} (pid:11735)
>[0;37m2014-02-09 21:28:18.197[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:28:18.201[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11735)
>[0;37m2014-02-09 21:28:18.222[0m [[0;37mDEBUG[0m] SUCCESS ACTION=SHOW_APPLICATION USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f838e41de544d0530002bf DOMAIN=ray Application 'myjbossews10' found (pid:11735)
>[0;37m2014-02-09 21:28:18.243[0m [[32mINFO [0m] Completed 200 OK in 46ms (Views: 18.9ms) (pid:11735)
>[0;37m2014-02-09 21:28:18.646[0m [[32mINFO [0m] Started POST "/broker/rest/application/52f838e41de544d0530002bf/cartridges" for 66.187.233.202 at 2014-02-09 21:28:18 -0500 (pid:11735)
>[0;37m2014-02-09 21:28:18.649[0m [[32mINFO [0m] Processing by EmbCartController#create as JSON (pid:11735)
>[0;37m2014-02-09 21:28:18.650[0m [[32mINFO [0m] Parameters: {"name"=>"phpmyadmin-4", "application_id"=>"52f838e41de544d0530002bf", "emb_cart"=>{"name"=>"phpmyadmin-4"}} (pid:11735)
>[0;37m2014-02-09 21:28:18.650[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11735)
>[0;37m2014-02-09 21:28:18.654[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11735)
>[0;37m2014-02-09 21:28:18.711[0m [[0;37mDEBUG[0m] Execute NewCompOp comp_spec=component:phpmyadmin-4/phpmyadmin-4/52f805d3c1f111aad200000f group_instance_id=52f838e41de544d0530002c1 (pid:11735)
>[0;37m2014-02-09 21:28:18.824[0m [[0;37mDEBUG[0m] Execute AddCompOp comp_spec=component:phpmyadmin-4/phpmyadmin-4/52f805d3c1f111aad200000f gear_id=52f838e41de544d0530002bf (pid:11735)
>[0;37m2014-02-09 21:28:18.830[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"phpmyadmin-4", :action=>"configure", :args=>{"--with-app-uuid"=>"52f838e41de544d0530002bf", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f838e41de544d0530002bf", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"f022128c82f8d24bb2c505f708157355", "--component-name"=>"phpmyadmin-4", "--cart-name"=>"phpmyadmin-4", "--with-software-version"=>"4", "--cartridge-vendor"=>"redhat"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: f022128c82f8d24bb2c505f708157355) (pid:11735)
>[0;37m2014-02-09 21:28:19.344[0m [[32mINFO [0m] Started GET "/broker/rest/domains/vseold/applications/sgeyrpch" for 127.0.0.1 at 2014-02-09 21:28:19 -0500 (pid:11705)
>[0;37m2014-02-09 21:28:19.349[0m [[32mINFO [0m] Processing by ApplicationsController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:28:19.349[0m [[32mINFO [0m] Parameters: {"broker_auth_key"=>"[FILTERED]", "broker_auth_iv"=>"[FILTERED]", "domain_id"=>"vseold", "id"=>"sgeyrpch"} (pid:11705)
>[0;37m2014-02-09 21:28:19.350[0m [[0;37mDEBUG[0m] API version 1.0 (pid:11705)
>[0;37m2014-02-09 21:28:19.364[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f81bd51de5444e5c00001d LOGIN=xjdiyvg1@redhat.com IP=127.0.0.1 SCOPES=application/52f836b21de544d053000251/scale application/52f836b21de544d053000251/report_deployments Authenticated (pid:11705)
>[0;37m2014-02-09 21:28:19.383[0m [[0;37mDEBUG[0m] SUCCESS ACTION=SHOW_APPLICATION USER_ID=52f81bd51de5444e5c00001d LOGIN=xjdiyvg1@redhat.com APP_UUID=52f836b21de544d053000251 DOMAIN=vseold Application 'sgeyrpch' found (pid:11705)
>[0;37m2014-02-09 21:28:19.393[0m [[32mINFO [0m] Completed 200 OK in 44ms (Views: 9.5ms) (pid:11705)
>[0;37m2014-02-09 21:28:20.761[0m [[32mINFO [0m] Started POST "/broker/rest/domains/vseold/applications/sgeyrpch/events" for 127.0.0.1 at 2014-02-09 21:28:20 -0500 (pid:11705)
>[0;37m2014-02-09 21:28:20.764[0m [[32mINFO [0m] Processing by AppEventsController#create as JSON (pid:11705)
>[0;37m2014-02-09 21:28:20.764[0m [[32mINFO [0m] Parameters: {"broker_auth_key"=>"[FILTERED]", "broker_auth_iv"=>"[FILTERED]", "event"=>"scale-down", "domain_id"=>"vseold", "application_id"=>"sgeyrpch"} (pid:11705)
>[0;37m2014-02-09 21:28:20.764[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:28:20.776[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f81bd51de5444e5c00001d LOGIN=xjdiyvg1@redhat.com IP=127.0.0.1 SCOPES=application/52f836b21de544d053000251/scale application/52f836b21de544d053000251/report_deployments Authenticated (pid:11705)
>[0;37m2014-02-09 21:28:20.850[0m [[0;37mDEBUG[0m] Execute DestroyGearOp gear_id=52f836ff1de544f6ee000004 (pid:11705)
>[0;37m2014-02-09 21:28:20.878[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"openshift-origin-node", :action=>"app-destroy", :args=>{"--with-app-uuid"=>"52f836b21de544d053000251", "--with-app-name"=>"sgeyrpch", "--with-container-uuid"=>"a7d3e75e91f911e3a90822000ae109cc", "--with-container-name"=>"a7d3e75e91f911e3a90822000ae109cc", "--with-namespace"=>"vseold", "--with-request-id"=>"8d16e8cddf484ec899a2d20e3620b863", "--cart-name"=>"openshift-origin-node"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: 8d16e8cddf484ec899a2d20e3620b863) (pid:11705)
>[0;37m2014-02-09 21:28:25.428[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x00000005a3b218 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"CLIENT_RESULT: \nCLIENT_RESULT: Please make note of these MySQL credentials again:\nCLIENT_RESULT:   Root User: [HIDDEN] (Request ID: f022128c82f8d24bb2c505f708157355) (pid:11735)
>[0;37m2014-02-09 21:28:25.429[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: configure): 6.602137803s  (Request ID: f022128c82f8d24bb2c505f708157355) (pid:11735)
>[0;37m2014-02-09 21:28:25.460[0m [[0;37mDEBUG[0m] Execute PostConfigureCompOp comp_spec=component:phpmyadmin-4/phpmyadmin-4/52f805d3c1f111aad200000f gear_id=52f838e41de544d0530002bf (pid:11735)
>[0;37m2014-02-09 21:28:25.471[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"phpmyadmin-4", :action=>"post-configure", :args=>{"--with-app-uuid"=>"52f838e41de544d0530002bf", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f838e41de544d0530002bf", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"f022128c82f8d24bb2c505f708157355", "--component-name"=>"phpmyadmin-4", "--cart-name"=>"phpmyadmin-4", "--with-software-version"=>"4", "--cartridge-vendor"=>"redhat"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: f022128c82f8d24bb2c505f708157355) (pid:11735)
>[0;37m2014-02-09 21:28:27.155[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x00000006a79ee0 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"Starting PHPMyAdmin cartridge\n", :exitcode=>0, :addtl_params=>nil}}>] (Request ID: f022128c82f8d24bb2c505f708157355) (pid:11735)
>[0;37m2014-02-09 21:28:27.158[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: post-configure): 1.690407506s  (Request ID: f022128c82f8d24bb2c505f708157355) (pid:11735)
>[0;37m2014-02-09 21:28:27.172[0m [[0;37mDEBUG[0m] Execute ExecuteConnectionsOp (pid:11735)
>[0;37m2014-02-09 21:28:27.291[0m [[0;37mDEBUG[0m] SUCCESS ACTION=ADD_APP_CARTRIDGE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f838e41de544d0530002bf DOMAIN=ray Added phpmyadmin-4 to application myjbossews10 (pid:11735)
>[0;37m2014-02-09 21:28:27.298[0m [[32mINFO [0m] Completed 201 Created in 8648ms (Views: 5.1ms) (pid:11735)
>[0;37m2014-02-09 21:28:27.849[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x00000005cb5e80 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"NOTIFY_ENDPOINT_DELETE: 54.80.152.50 38121\n", :exitcode=>0, :addtl_params=>nil}}>] (Request ID: 8d16e8cddf484ec899a2d20e3620b863) (pid:11705)
>[0;37m2014-02-09 21:28:27.852[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: app-destroy): 6.980051549s  (Request ID: 8d16e8cddf484ec899a2d20e3620b863) (pid:11705)
>[0;37m2014-02-09 21:28:27.876[0m [[0;37mDEBUG[0m] Execute DeregisterDnsOp gear_id=52f836ff1de544f6ee000004 (pid:11705)
>[0;37m2014-02-09 21:28:27.880[0m [[0;37mDEBUG[0m] DYNECT Login with path: /REST/Session/ (pid:11705)
>[0;37m2014-02-09 21:28:28.654[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {"token": "jpwCd2CthlF4gi2sFwDa7tW1mGaTSURDT9d9qDrBkIN20zxFWT3gu1nx+O9N3k5tieTkbAnQGHVVHME7HWFH79smQV5QzuQeCO2cMz4bRfcTQvAogCU/fP4Owkd48Twvh1yPVjouYfK1gDgWPoWzNw==", "version": "3.5.4"}, "job_id": 692796839, "msgs": [{"INFO": "login: Login successful", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:11705)
>[0;37m2014-02-09 21:28:28.655[0m [[0;37mDEBUG[0m] DYNECT Response data: {"token"=>"jpwCd2CthlF4gi2sFwDa7tW1mGaTSURDT9d9qDrBkIN20zxFWT3gu1nx+O9N3k5tieTkbAnQGHVVHME7HWFH79smQV5QzuQeCO2cMz4bRfcTQvAogCU/fP4Owkd48Twvh1yPVjouYfK1gDgWPoWzNw==", "version"=>"3.5.4"} (pid:11705)
>[0;37m2014-02-09 21:28:28.655[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_login): 0.77483738s  (Request ID: 8d16e8cddf484ec899a2d20e3620b863) (pid:11705)
>[0;37m2014-02-09 21:28:28.655[0m [[0;37mDEBUG[0m] DYNECT delete with path: /REST/CNAMERecord/dev.rhcloud.com/a7d3e75e91f911e3a90822000ae109cc-vseold.dev.rhcloud.com/ and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:11705)
>[0;37m2014-02-09 21:28:29.289[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {}, "job_id": 692796846, "msgs": [{"INFO": "delete: 1 records deleted", "SOURCE": "API-B", "ERR_CD": null, "LVL": "INFO"}]} (pid:11705)
>[0;37m2014-02-09 21:28:29.290[0m [[0;37mDEBUG[0m] DYNECT Response data: {} (pid:11705)
>[0;37m2014-02-09 21:28:29.290[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_delete): 0.634740578s  (Request ID: 8d16e8cddf484ec899a2d20e3620b863) (pid:11705)
>[0;37m2014-02-09 21:28:29.290[0m [[0;37mDEBUG[0m] DYNECT put/post with path: /REST/Zone/dev.rhcloud.com/ json data: {"publish":"true"} and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:11705)
>[0;37m2014-02-09 21:28:30.459[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {"zone_type": "Primary", "serial_style": "day", "serial": 2014236721, "zone": "dev.rhcloud.com"}, "job_id": 692796853, "msgs": [{"INFO": "publish: dev.rhcloud.com published", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:11705)
>[0;37m2014-02-09 21:28:30.459[0m [[0;37mDEBUG[0m] DYNECT Response data: {"zone_type"=>"Primary", "serial_style"=>"day", "serial"=>2014236721, "zone"=>"dev.rhcloud.com"} (pid:11705)
>[0;37m2014-02-09 21:28:30.459[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_put_post): 1.169250608s  (Request ID: 8d16e8cddf484ec899a2d20e3620b863) (pid:11705)
>[0;37m2014-02-09 21:28:30.460[0m [[0;37mDEBUG[0m] DYNECT delete with path: /REST/Session/ and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:11705)
>[0;37m2014-02-09 21:28:30.956[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {}, "job_id": 692796863, "msgs": [{"INFO": "logout: Logout successful", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:11705)
>[0;37m2014-02-09 21:28:30.957[0m [[0;37mDEBUG[0m] DYNECT Response data: {} (pid:11705)
>[0;37m2014-02-09 21:28:30.957[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_delete): 0.497178196s  (Request ID: 8d16e8cddf484ec899a2d20e3620b863) (pid:11705)
>[0;37m2014-02-09 21:28:30.976[0m [[0;37mDEBUG[0m] Execute UnreserveGearUidOp gear_id=52f836ff1de544f6ee000004 (pid:11705)
>[0;37m2014-02-09 21:28:31.156[0m [[0;37mDEBUG[0m] Execute DeleteGearOp gear_id=52f836ff1de544f6ee000004 (pid:11705)
>[0;37m2014-02-09 21:28:31.245[0m [[0;37mDEBUG[0m] Execute TrackUsageOp gear_id=52f836ff1de544f6ee000004 (pid:11705)
>[0;37m2014-02-09 21:28:31.516[0m [[0;37mDEBUG[0m] Execute ExecuteConnectionsOp (pid:11705)
>[0;37m2014-02-09 21:28:31.553[0m [[0;37mDEBUG[0m] Running publishers (pid:11705)
>[0;37m2014-02-09 21:28:31.789[0m [[0;37mDEBUG[0m] DEBUG: Output of parallel execute: [{:tag=>"52f8394f1de5442db900000e", :gear=>"52f836b21de544d053000251", :job=>{:cartridge=>"openshift-origin-node", :action=>"connector-execute", :args=>{"--with-app-uuid"=>"52f836b21de544d053000251", "--with-app-name"=>"sgeyrpch", "--with-container-uuid"=>"52f836b21de544d053000251", "--with-container-name"=>"sgeyrpch", "--with-namespace"=>"vseold", "--with-request-id"=>"8d16e8cddf484ec899a2d20e3620b863", "--component-name"=>"web_proxy", "--cart-name"=>"haproxy-1.4", "--with-software-version"=>"1.4", "--cartridge-vendor"=>"redhat", "--hook-name"=>"publish-haproxy-status-url", "--connection-type"=>"NET_TCP:haproxy-status-info", "--input-args"=>"sgeyrpch vseold 52f836b21de544d053000251"}}, :result_stdout=>"http://sgeyrpch-vseold.dev.rhcloud.com/haproxy-status/\n", :result_stderr=>"", :result_exit_code=>0, :result_addtl_params=>nil}], exitcode: 0, from: ip-10-225-9-204  (Request ID: 8d16e8cddf484ec899a2d20e3620b863) (pid:11705)
>[0;37m2014-02-09 21:28:31.792[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_parallel): 737ms  (Request ID: 8d16e8cddf484ec899a2d20e3620b863) (pid:11705)
>[0;37m2014-02-09 21:28:31.792[0m [[0;37mDEBUG[0m] Running subscribers (pid:11705)
>[0;37m2014-02-09 21:28:31.793[0m [[0;37mDEBUG[0m] Output of publisher - '{"52f8394f1de5442db900000e"=>["'52f836b21de544d053000251'='http://sgeyrpch-vseold.dev.rhcloud.com/haproxy-status/\n'"]}' (pid:11705)
>[0;37m2014-02-09 21:28:32.535[0m [[0;37mDEBUG[0m] DEBUG: Output of parallel execute: [{:tag=>"", :gear=>"52f836b21de544d053000251", :job=>{:cartridge=>"openshift-origin-node", :action=>"connector-execute", :args=>{"--with-app-uuid"=>"52f836b21de544d053000251", "--with-app-name"=>"sgeyrpch", "--with-container-uuid"=>"52f836b21de544d053000251", "--with-container-name"=>"sgeyrpch", "--with-namespace"=>"vseold", "--with-request-id"=>"8d16e8cddf484ec899a2d20e3620b863", "--component-name"=>"web_proxy", "--cart-name"=>"haproxy-1.4", "--with-software-version"=>"1.4", "--cartridge-vendor"=>"redhat", "--hook-name"=>"set-haproxy-status-url", "--publishing-cart-name"=>"haproxy-1.4", "--connection-type"=>"NET_TCP:haproxy-status-info", "--input-args"=>"sgeyrpch vseold 52f836b21de544d053000251 \\'52f836b21de544d053000251\\'\\=\\'http://sgeyrpch-vseold.dev.rhcloud.com/haproxy-status/'\n'\\'"}}, :result_stdout=>"", :result_stderr=>"", :result_exit_code=>0, :result_addtl_params=>nil}], exitcode: 0, from: ip-10-225-9-204  (Request ID: 8d16e8cddf484ec899a2d20e3620b863) (pid:11705)
>[0;37m2014-02-09 21:28:32.536[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_parallel): 742ms  (Request ID: 8d16e8cddf484ec899a2d20e3620b863) (pid:11705)
>[0;37m2014-02-09 21:28:32.537[0m [[0;37mDEBUG[0m] Connections done (pid:11705)
>[0;37m2014-02-09 21:28:32.556[0m [[0;37mDEBUG[0m] Execute UpdateClusterOp (pid:11705)
>[0;37m2014-02-09 21:28:32.781[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"openshift-origin-node", :action=>"update-cluster", :args=>{"--with-app-uuid"=>"52f836b21de544d053000251", "--with-app-name"=>"sgeyrpch", "--with-container-uuid"=>"52f836b21de544d053000251", "--with-container-name"=>"sgeyrpch", "--with-namespace"=>"vseold", "--with-request-id"=>"8d16e8cddf484ec899a2d20e3620b863", "--sync-new-gears"=>true, "--proxy-gears"=>"52f836b21de544d053000251,sgeyrpch,vseold,ec2-54-80-152-50.compute-1.amazonaws.com", "--web-gears"=>"52f836b21de544d053000251,sgeyrpch,vseold,ec2-54-80-152-50.compute-1.amazonaws.com,38111", "--cart-name"=>"openshift-origin-node"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: 8d16e8cddf484ec899a2d20e3620b863) (pid:11705)
>[0;37m2014-02-09 21:28:39.601[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x0000000613e060 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"", :exitcode=>0, :addtl_params=>nil}}>] (Request ID: 8d16e8cddf484ec899a2d20e3620b863) (pid:11705)
>[0;37m2014-02-09 21:28:39.603[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: update-cluster): 6.824410051s  (Request ID: 8d16e8cddf484ec899a2d20e3620b863) (pid:11705)
>[0;37m2014-02-09 21:28:39.646[0m [[0;37mDEBUG[0m] SUCCESS ACTION=SCALE_DOWN_APPLICATION USER_ID=52f81bd51de5444e5c00001d LOGIN=xjdiyvg1@redhat.com APP_UUID=52f836b21de544d053000251 DOMAIN=vseold Application sgeyrpch has scaled to 1 (pid:11705)
>[0;37m2014-02-09 21:28:39.660[0m [[32mINFO [0m] Completed 200 OK in 18896ms (Views: 12.6ms) (pid:11705)
>[0;37m2014-02-09 21:29:02.798[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:29:02 -0500 (pid:11705)
>[0;37m2014-02-09 21:29:02.801[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:29:02.801[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11705)
>[0;37m2014-02-09 21:29:02.814[0m [[32mINFO [0m] Completed 200 OK in 13ms (Views: 7.2ms) (pid:11705)
>[0;37m2014-02-09 21:29:03.166[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:29:03 -0500 (pid:11705)
>[0;37m2014-02-09 21:29:03.168[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:29:03.168[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:29:03.182[0m [[32mINFO [0m] Completed 200 OK in 13ms (Views: 7.7ms) (pid:11705)
>[0;37m2014-02-09 21:29:03.603[0m [[32mINFO [0m] Started GET "/broker/rest/domains" for 66.187.233.202 at 2014-02-09 21:29:03 -0500 (pid:11705)
>[0;37m2014-02-09 21:29:03.604[0m [[32mINFO [0m] Processing by DomainsController#index as JSON (pid:11705)
>[0;37m2014-02-09 21:29:03.605[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:29:03.610[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:29:03.615[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_DOMAIN USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11705)
>[0;37m2014-02-09 21:29:03.622[0m [[32mINFO [0m] Completed 200 OK in 17ms (Views: 5.9ms) (pid:11705)
>[0;37m2014-02-09 21:29:03.936[0m [[32mINFO [0m] Started GET "/broker/rest/domains/ray/applications/myjbossews10?include=cartridges" for 66.187.233.202 at 2014-02-09 21:29:03 -0500 (pid:11705)
>[0;37m2014-02-09 21:29:03.938[0m [[32mINFO [0m] Processing by ApplicationsController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:29:03.939[0m [[32mINFO [0m] Parameters: {"include"=>"cartridges", "domain_id"=>"ray", "id"=>"myjbossews10"} (pid:11705)
>[0;37m2014-02-09 21:29:03.939[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:29:03.943[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:29:03.968[0m [[0;37mDEBUG[0m] SUCCESS ACTION=SHOW_APPLICATION USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f838e41de544d0530002bf DOMAIN=ray Application 'myjbossews10' found (pid:11705)
>[0;37m2014-02-09 21:29:03.993[0m [[32mINFO [0m] Completed 200 OK in 55ms (Views: 23.8ms) (pid:11705)
>[0;37m2014-02-09 21:29:30.885[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:29:30 -0500 (pid:11705)
>[0;37m2014-02-09 21:29:30.887[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:29:30.888[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11705)
>[0;37m2014-02-09 21:29:30.899[0m [[32mINFO [0m] Completed 200 OK in 12ms (Views: 6.6ms) (pid:11705)
>[0;37m2014-02-09 21:29:31.247[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:29:31 -0500 (pid:11705)
>[0;37m2014-02-09 21:29:31.249[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:29:31.249[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:29:31.261[0m [[32mINFO [0m] Completed 200 OK in 12ms (Views: 6.9ms) (pid:11705)
>[0;37m2014-02-09 21:29:31.560[0m [[32mINFO [0m] Started GET "/broker/rest/domains" for 66.187.233.202 at 2014-02-09 21:29:31 -0500 (pid:11705)
>[0;37m2014-02-09 21:29:31.561[0m [[32mINFO [0m] Processing by DomainsController#index as JSON (pid:11705)
>[0;37m2014-02-09 21:29:31.562[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:29:31.565[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:29:31.569[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_DOMAIN USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11705)
>[0;37m2014-02-09 21:29:31.576[0m [[32mINFO [0m] Completed 200 OK in 14ms (Views: 5.3ms) (pid:11705)
>[0;37m2014-02-09 21:29:31.868[0m [[32mINFO [0m] Started GET "/broker/rest/domains/ray/applications/myjbossews10?include=cartridges" for 66.187.233.202 at 2014-02-09 21:29:31 -0500 (pid:11705)
>[0;37m2014-02-09 21:29:31.870[0m [[32mINFO [0m] Processing by ApplicationsController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:29:31.870[0m [[32mINFO [0m] Parameters: {"include"=>"cartridges", "domain_id"=>"ray", "id"=>"myjbossews10"} (pid:11705)
>[0;37m2014-02-09 21:29:31.870[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:29:31.873[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:29:31.976[0m [[0;37mDEBUG[0m] SUCCESS ACTION=SHOW_APPLICATION USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f838e41de544d0530002bf DOMAIN=ray Application 'myjbossews10' found (pid:11705)
>[0;37m2014-02-09 21:29:32.640[0m [[32mINFO [0m] Completed 200 OK in 136ms (Views: 28.1ms) (pid:11705)
>[0;37m2014-02-09 21:29:35.630[0m [[32mINFO [0m] Started DELETE "/broker/rest/application/52f838e41de544d0530002bf/cartridge/mysql-5.1" for 66.187.233.202 at 2014-02-09 21:29:35 -0500 (pid:11705)
>[0;37m2014-02-09 21:29:35.669[0m [[32mINFO [0m] Processing by EmbCartController#destroy as JSON (pid:11705)
>[0;37m2014-02-09 21:29:35.670[0m [[32mINFO [0m] Parameters: {"application_id"=>"52f838e41de544d0530002bf", "id"=>"mysql-5.1", "emb_cart"=>{}} (pid:11705)
>[0;37m2014-02-09 21:29:35.674[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:29:35.717[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:29:35.111[0m [[0;37mDEBUG[0m] SUCCESS ACTION=DELETE_APP_CARTRIDGE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f838e41de544d0530002bf DOMAIN=ray Removed mysql-5.1 from application myjbossews10 (pid:11705)
>[0;37m2014-02-09 21:29:35.113[0m [[32mINFO [0m] Completed 200 OK in 46ms (Views: 0.6ms) (pid:11705)
>[0;37m2014-02-09 21:29:40.467[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:29:40 -0500 (pid:11705)
>[0;37m2014-02-09 21:29:40.469[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:29:40.469[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11705)
>[0;37m2014-02-09 21:29:40.482[0m [[32mINFO [0m] Completed 200 OK in 13ms (Views: 6.9ms) (pid:11705)
>[0;37m2014-02-09 21:29:40.821[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:29:40 -0500 (pid:11705)
>[0;37m2014-02-09 21:29:40.823[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:29:40.823[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:29:40.836[0m [[32mINFO [0m] Completed 200 OK in 13ms (Views: 7.4ms) (pid:11705)
>[0;37m2014-02-09 21:29:41.175[0m [[32mINFO [0m] Started GET "/broker/rest/domains" for 66.187.233.202 at 2014-02-09 21:29:41 -0500 (pid:11705)
>[0;37m2014-02-09 21:29:41.177[0m [[32mINFO [0m] Processing by DomainsController#index as JSON (pid:11705)
>[0;37m2014-02-09 21:29:41.177[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:29:41.181[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:29:41.186[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_DOMAIN USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11705)
>[0;37m2014-02-09 21:29:41.192[0m [[32mINFO [0m] Completed 200 OK in 15ms (Views: 5.7ms) (pid:11705)
>[0;37m2014-02-09 21:29:41.498[0m [[32mINFO [0m] Started GET "/broker/rest/domains/ray/applications/myjbossews10?include=cartridges" for 66.187.233.202 at 2014-02-09 21:29:41 -0500 (pid:11705)
>[0;37m2014-02-09 21:29:41.501[0m [[32mINFO [0m] Processing by ApplicationsController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:29:41.501[0m [[32mINFO [0m] Parameters: {"include"=>"cartridges", "domain_id"=>"ray", "id"=>"myjbossews10"} (pid:11705)
>[0;37m2014-02-09 21:29:41.501[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:29:41.505[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:29:41.528[0m [[0;37mDEBUG[0m] SUCCESS ACTION=SHOW_APPLICATION USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f838e41de544d0530002bf DOMAIN=ray Application 'myjbossews10' found (pid:11705)
>[0;37m2014-02-09 21:29:41.551[0m [[32mINFO [0m] Completed 200 OK in 51ms (Views: 22.5ms) (pid:11705)
>[0;37m2014-02-09 21:40:05.678[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:40:05 -0500 (pid:11705)
>[0;37m2014-02-09 21:40:05.680[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:40:05.681[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11705)
>[0;37m2014-02-09 21:40:05.697[0m [[32mINFO [0m] Completed 200 OK in 17ms (Views: 7.1ms) (pid:11705)
>[0;37m2014-02-09 21:40:07.544[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:40:07 -0500 (pid:11705)
>[0;37m2014-02-09 21:40:07.546[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:40:07.546[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:40:07.559[0m [[32mINFO [0m] Completed 200 OK in 13ms (Views: 7.7ms) (pid:11705)
>[0;37m2014-02-09 21:40:08.376[0m [[32mINFO [0m] Started GET "/broker/rest/user" for 66.187.233.202 at 2014-02-09 21:40:08 -0500 (pid:11705)
>[0;37m2014-02-09 21:40:08.380[0m [[32mINFO [0m] Processing by UserExtController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:40:08.380[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:40:08.386[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:40:08.387[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_USER USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11705)
>[0;37m2014-02-09 21:40:08.390[0m [[32mINFO [0m] Completed 200 OK in 10ms (Views: 2.0ms) (pid:11705)
>[0;37m2014-02-09 21:43:57.969[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:43:57 -0500 (pid:11705)
>[0;37m2014-02-09 21:43:57.972[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:43:57.973[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11705)
>[0;37m2014-02-09 21:43:57.992[0m [[32mINFO [0m] Completed 200 OK in 20ms (Views: 11.8ms) (pid:11705)
>[0;37m2014-02-09 21:43:58.304[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:43:58 -0500 (pid:11705)
>[0;37m2014-02-09 21:43:58.306[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:43:58.307[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:43:58.319[0m [[32mINFO [0m] Completed 200 OK in 13ms (Views: 7.4ms) (pid:11705)
>[0;37m2014-02-09 21:43:58.616[0m [[32mINFO [0m] Started GET "/broker/rest/applications?include=cartridges" for 66.187.233.202 at 2014-02-09 21:43:58 -0500 (pid:11705)
>[0;37m2014-02-09 21:43:58.618[0m [[32mINFO [0m] Processing by ApplicationsController#index as JSON (pid:11705)
>[0;37m2014-02-09 21:43:58.618[0m [[32mINFO [0m] Parameters: {"include"=>"cartridges"} (pid:11705)
>[0;37m2014-02-09 21:43:58.618[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:43:58.622[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:43:58.648[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_APPLICATION USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= Found 1 applications. (pid:11705)
>[0;37m2014-02-09 21:43:58.675[0m [[32mINFO [0m] Completed 200 OK in 57ms (Views: 25.3ms) (pid:11705)
>[0;37m2014-02-09 21:44:11.847[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:44:11 -0500 (pid:11705)
>[0;37m2014-02-09 21:44:11.108[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:44:11.113[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11705)
>[0;37m2014-02-09 21:44:11.228[0m [[32mINFO [0m] Completed 200 OK in 12ms (Views: 6.7ms) (pid:11705)
>[0;37m2014-02-09 21:44:11.450[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:44:11 -0500 (pid:11705)
>[0;37m2014-02-09 21:44:11.452[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:44:11.452[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:44:11.464[0m [[32mINFO [0m] Completed 200 OK in 12ms (Views: 7.1ms) (pid:11705)
>[0;37m2014-02-09 21:44:11.903[0m [[32mINFO [0m] Started GET "/broker/rest/domains" for 66.187.233.202 at 2014-02-09 21:44:11 -0500 (pid:11705)
>[0;37m2014-02-09 21:44:11.905[0m [[32mINFO [0m] Processing by DomainsController#index as JSON (pid:11705)
>[0;37m2014-02-09 21:44:11.905[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:44:11.909[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:44:11.913[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_DOMAIN USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11705)
>[0;37m2014-02-09 21:44:11.920[0m [[32mINFO [0m] Completed 200 OK in 15ms (Views: 5.8ms) (pid:11705)
>[0;37m2014-02-09 21:44:12.370[0m [[32mINFO [0m] Started GET "/broker/rest/domains/ray/applications/myjbossews10?include=cartridges" for 66.187.233.202 at 2014-02-09 21:44:12 -0500 (pid:11705)
>[0;37m2014-02-09 21:44:12.373[0m [[32mINFO [0m] Processing by ApplicationsController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:44:12.373[0m [[32mINFO [0m] Parameters: {"include"=>"cartridges", "domain_id"=>"ray", "id"=>"myjbossews10"} (pid:11705)
>[0;37m2014-02-09 21:44:12.374[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:44:12.378[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:44:12.406[0m [[0;37mDEBUG[0m] SUCCESS ACTION=SHOW_APPLICATION USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f838e41de544d0530002bf DOMAIN=ray Application 'myjbossews10' found (pid:11705)
>[0;37m2014-02-09 21:44:12.513[0m [[32mINFO [0m] Completed 200 OK in 140ms (Views: 24.8ms) (pid:11705)
>[0;37m2014-02-09 21:44:15.442[0m [[32mINFO [0m] Started DELETE "/broker/rest/application/52f838e41de544d0530002bf/cartridge/mysql-5.1" for 66.187.233.202 at 2014-02-09 21:44:15 -0500 (pid:11705)
>[0;37m2014-02-09 21:44:15.446[0m [[32mINFO [0m] Processing by EmbCartController#destroy as JSON (pid:11705)
>[0;37m2014-02-09 21:44:15.446[0m [[32mINFO [0m] Parameters: {"application_id"=>"52f838e41de544d0530002bf", "id"=>"mysql-5.1", "emb_cart"=>{}} (pid:11705)
>[0;37m2014-02-09 21:44:15.446[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:44:15.451[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:44:15.491[0m [[0;37mDEBUG[0m] SUCCESS ACTION=DELETE_APP_CARTRIDGE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f838e41de544d0530002bf DOMAIN=ray Removed mysql-5.1 from application myjbossews10 (pid:11705)
>[0;37m2014-02-09 21:44:15.493[0m [[32mINFO [0m] Completed 200 OK in 47ms (Views: 0.6ms) (pid:11705)
>[0;37m2014-02-09 21:44:24.582[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:44:24 -0500 (pid:11705)
>[0;37m2014-02-09 21:44:24.584[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:44:24.585[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11705)
>[0;37m2014-02-09 21:44:24.597[0m [[32mINFO [0m] Completed 200 OK in 12ms (Views: 6.7ms) (pid:11705)
>[0;37m2014-02-09 21:44:25.613[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:44:25 -0500 (pid:11705)
>[0;37m2014-02-09 21:44:25.631[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:44:25.634[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:44:25.760[0m [[32mINFO [0m] Completed 200 OK in 13ms (Views: 7.4ms) (pid:11705)
>[0;37m2014-02-09 21:44:25.612[0m [[32mINFO [0m] Started GET "/broker/rest/domains" for 66.187.233.202 at 2014-02-09 21:44:25 -0500 (pid:11705)
>[0;37m2014-02-09 21:44:25.614[0m [[32mINFO [0m] Processing by DomainsController#index as JSON (pid:11705)
>[0;37m2014-02-09 21:44:25.615[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:44:25.619[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:44:25.623[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_DOMAIN USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11705)
>[0;37m2014-02-09 21:44:25.630[0m [[32mINFO [0m] Completed 200 OK in 15ms (Views: 5.6ms) (pid:11705)
>[0;37m2014-02-09 21:44:26.140[0m [[32mINFO [0m] Started GET "/broker/rest/domains/ray/applications/myjbossews10?include=cartridges" for 66.187.233.202 at 2014-02-09 21:44:26 -0500 (pid:11705)
>[0;37m2014-02-09 21:44:26.143[0m [[32mINFO [0m] Processing by ApplicationsController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:44:26.143[0m [[32mINFO [0m] Parameters: {"include"=>"cartridges", "domain_id"=>"ray", "id"=>"myjbossews10"} (pid:11705)
>[0;37m2014-02-09 21:44:26.144[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:44:26.147[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:44:26.171[0m [[0;37mDEBUG[0m] SUCCESS ACTION=SHOW_APPLICATION USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f838e41de544d0530002bf DOMAIN=ray Application 'myjbossews10' found (pid:11705)
>[0;37m2014-02-09 21:44:26.195[0m [[32mINFO [0m] Completed 200 OK in 51ms (Views: 22.9ms) (pid:11705)
>[0;37m2014-02-09 21:45:40.260[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:45:40 -0500 (pid:11705)
>[0;37m2014-02-09 21:45:40.262[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:45:40.263[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11705)
>[0;37m2014-02-09 21:45:40.274[0m [[32mINFO [0m] Completed 200 OK in 12ms (Views: 6.5ms) (pid:11705)
>[0;37m2014-02-09 21:45:40.641[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:45:40 -0500 (pid:11705)
>[0;37m2014-02-09 21:45:40.643[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:45:40.643[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:45:40.737[0m [[32mINFO [0m] Completed 200 OK in 94ms (Views: 89.1ms) (pid:11705)
>[0;37m2014-02-09 21:45:41.107[0m [[32mINFO [0m] Started GET "/broker/rest/domains" for 66.187.233.202 at 2014-02-09 21:45:41 -0500 (pid:11705)
>[0;37m2014-02-09 21:45:41.110[0m [[32mINFO [0m] Processing by DomainsController#index as JSON (pid:11705)
>[0;37m2014-02-09 21:45:41.110[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:45:41.116[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:45:41.121[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_DOMAIN USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11705)
>[0;37m2014-02-09 21:45:41.128[0m [[32mINFO [0m] Completed 200 OK in 18ms (Views: 6.1ms) (pid:11705)
>[0;37m2014-02-09 21:45:41.474[0m [[32mINFO [0m] Started GET "/broker/rest/domains/ray/applications/myjbossews10?include=cartridges" for 66.187.233.202 at 2014-02-09 21:45:41 -0500 (pid:11705)
>[0;37m2014-02-09 21:45:41.477[0m [[32mINFO [0m] Processing by ApplicationsController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:45:41.477[0m [[32mINFO [0m] Parameters: {"include"=>"cartridges", "domain_id"=>"ray", "id"=>"myjbossews10"} (pid:11705)
>[0;37m2014-02-09 21:45:41.477[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:45:41.481[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:45:41.506[0m [[0;37mDEBUG[0m] SUCCESS ACTION=SHOW_APPLICATION USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f838e41de544d0530002bf DOMAIN=ray Application 'myjbossews10' found (pid:11705)
>[0;37m2014-02-09 21:45:41.530[0m [[32mINFO [0m] Completed 200 OK in 53ms (Views: 23.4ms) (pid:11705)
>[0;37m2014-02-09 21:45:44.679[0m [[32mINFO [0m] Started DELETE "/broker/rest/application/52f838e41de544d0530002bf/cartridge/mysql-5.1" for 66.187.233.202 at 2014-02-09 21:45:44 -0500 (pid:11705)
>[0;37m2014-02-09 21:45:44.682[0m [[32mINFO [0m] Processing by EmbCartController#destroy as JSON (pid:11705)
>[0;37m2014-02-09 21:45:44.683[0m [[32mINFO [0m] Parameters: {"application_id"=>"52f838e41de544d0530002bf", "id"=>"mysql-5.1", "emb_cart"=>{}} (pid:11705)
>[0;37m2014-02-09 21:45:44.683[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:45:44.693[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:45:44.731[0m [[0;37mDEBUG[0m] SUCCESS ACTION=DELETE_APP_CARTRIDGE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f838e41de544d0530002bf DOMAIN=ray Removed mysql-5.1 from application myjbossews10 (pid:11705)
>[0;37m2014-02-09 21:45:44.732[0m [[32mINFO [0m] Completed 200 OK in 50ms (Views: 0.6ms) (pid:11705)
>[0;37m2014-02-09 21:45:50.885[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:45:50 -0500 (pid:11705)
>[0;37m2014-02-09 21:45:50.887[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:45:50.887[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11705)
>[0;37m2014-02-09 21:45:50.899[0m [[32mINFO [0m] Completed 200 OK in 12ms (Views: 6.5ms) (pid:11705)
>[0;37m2014-02-09 21:45:51.323[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:45:51 -0500 (pid:11705)
>[0;37m2014-02-09 21:45:51.324[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:45:51.325[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:45:51.337[0m [[32mINFO [0m] Completed 200 OK in 13ms (Views: 7.8ms) (pid:11705)
>[0;37m2014-02-09 21:45:51.752[0m [[32mINFO [0m] Started GET "/broker/rest/domains" for 66.187.233.202 at 2014-02-09 21:45:51 -0500 (pid:11705)
>[0;37m2014-02-09 21:45:51.754[0m [[32mINFO [0m] Processing by DomainsController#index as JSON (pid:11705)
>[0;37m2014-02-09 21:45:51.755[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:45:51.758[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:45:51.763[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_DOMAIN USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11705)
>[0;37m2014-02-09 21:45:51.769[0m [[32mINFO [0m] Completed 200 OK in 15ms (Views: 5.5ms) (pid:11705)
>[0;37m2014-02-09 21:45:52.181[0m [[32mINFO [0m] Started GET "/broker/rest/domains/ray/applications/myjbossews10?include=cartridges" for 66.187.233.202 at 2014-02-09 21:45:52 -0500 (pid:11705)
>[0;37m2014-02-09 21:45:52.184[0m [[32mINFO [0m] Processing by ApplicationsController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:45:52.184[0m [[32mINFO [0m] Parameters: {"include"=>"cartridges", "domain_id"=>"ray", "id"=>"myjbossews10"} (pid:11705)
>[0;37m2014-02-09 21:45:52.184[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:45:52.188[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:45:52.210[0m [[0;37mDEBUG[0m] SUCCESS ACTION=SHOW_APPLICATION USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f838e41de544d0530002bf DOMAIN=ray Application 'myjbossews10' found (pid:11705)
>[0;37m2014-02-09 21:45:52.311[0m [[32mINFO [0m] Completed 200 OK in 127ms (Views: 24.5ms) (pid:11705)
>[0;37m2014-02-09 21:46:44.551[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:46:44 -0500 (pid:11705)
>[0;37m2014-02-09 21:46:44.553[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:46:44.554[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11705)
>[0;37m2014-02-09 21:46:44.567[0m [[32mINFO [0m] Completed 200 OK in 14ms (Views: 7.1ms) (pid:11705)
>[0;37m2014-02-09 21:46:45.324[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:46:45 -0500 (pid:11705)
>[0;37m2014-02-09 21:46:45.343[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:46:45.346[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:46:45.485[0m [[32mINFO [0m] Completed 200 OK in 14ms (Views: 7.7ms) (pid:11705)
>[0;37m2014-02-09 21:46:45.500[0m [[32mINFO [0m] Started GET "/broker/rest/domains" for 66.187.233.202 at 2014-02-09 21:46:45 -0500 (pid:11705)
>[0;37m2014-02-09 21:46:45.502[0m [[32mINFO [0m] Processing by DomainsController#index as JSON (pid:11705)
>[0;37m2014-02-09 21:46:45.502[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:46:45.507[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:46:45.511[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_DOMAIN USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11705)
>[0;37m2014-02-09 21:46:45.518[0m [[32mINFO [0m] Completed 200 OK in 16ms (Views: 5.6ms) (pid:11705)
>[0;37m2014-02-09 21:46:45.942[0m [[32mINFO [0m] Started GET "/broker/rest/domains/ray/applications/myjbossews10" for 66.187.233.202 at 2014-02-09 21:46:45 -0500 (pid:11705)
>[0;37m2014-02-09 21:46:45.945[0m [[32mINFO [0m] Processing by ApplicationsController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:46:45.945[0m [[32mINFO [0m] Parameters: {"domain_id"=>"ray", "id"=>"myjbossews10"} (pid:11705)
>[0;37m2014-02-09 21:46:45.945[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:46:45.949[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:46:45.967[0m [[0;37mDEBUG[0m] SUCCESS ACTION=SHOW_APPLICATION USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f838e41de544d0530002bf DOMAIN=ray Application 'myjbossews10' found (pid:11705)
>[0;37m2014-02-09 21:46:45.982[0m [[32mINFO [0m] Completed 200 OK in 37ms (Views: 13.8ms) (pid:11705)
>[0;37m2014-02-09 21:46:46.822[0m [[32mINFO [0m] Started DELETE "/broker/rest/application/52f838e41de544d0530002bf" for 66.187.233.202 at 2014-02-09 21:46:46 -0500 (pid:11705)
>[0;37m2014-02-09 21:46:46.826[0m [[32mINFO [0m] Processing by ApplicationsController#destroy as JSON (pid:11705)
>[0;37m2014-02-09 21:46:46.826[0m [[32mINFO [0m] Parameters: {"id"=>"52f838e41de544d0530002bf", "application"=>{}} (pid:11705)
>[0;37m2014-02-09 21:46:46.826[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:46:46.830[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:46:47.129[0m [[0;37mDEBUG[0m] Execute DestroyGearOp gear_id=52f838e41de544d0530002bf (pid:11705)
>[0;37m2014-02-09 21:46:47.215[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"openshift-origin-node", :action=>"app-destroy", :args=>{"--with-app-uuid"=>"52f838e41de544d0530002bf", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f838e41de544d0530002bf", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"dad42b4417cb5e6a747ecf1e628e72d4", "--cart-name"=>"openshift-origin-node"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: dad42b4417cb5e6a747ecf1e628e72d4) (pid:11705)
>[0;37m2014-02-09 21:46:52.776[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x000000068dd000 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"NOTIFY_ENDPOINT_DELETE: 54.80.152.50 \nNOTIFY_ENDPOINT_DELETE: 54.80.152.50 \nNOTIFY_ENDPOINT_DELETE: 54.80.152.50 \n", :exitcode=>0, :addtl_params=>nil}}>] (Request ID: dad42b4417cb5e6a747ecf1e628e72d4) (pid:11705)
>[0;37m2014-02-09 21:46:52.778[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: app-destroy): 5.763031789s  (Request ID: dad42b4417cb5e6a747ecf1e628e72d4) (pid:11705)
>[0;37m2014-02-09 21:46:52.808[0m [[0;37mDEBUG[0m] Execute DeregisterDnsOp gear_id=52f838e41de544d0530002bf (pid:11705)
>[0;37m2014-02-09 21:46:52.811[0m [[0;37mDEBUG[0m] DYNECT Login with path: /REST/Session/ (pid:11705)
>[0;37m2014-02-09 21:46:53.480[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {"token": "xztfASeR+fsqVbH3F0vUD4dDeLObOoGIJLPUvBVG1gg7JrVHitWjAgL6amnsHESyiQG4tqRQlS7PM7LSXoE1/eNUHG9BpCqM5rE1Qy9f8i8rQ8bmLxAN8yIV5dbR0geJIt7MxOS6O+LWmSjbuG/ZQQ==", "version": "3.5.4"}, "job_id": 692810555, "msgs": [{"INFO": "login: Login successful", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:11705)
>[0;37m2014-02-09 21:46:53.481[0m [[0;37mDEBUG[0m] DYNECT Response data: {"token"=>"xztfASeR+fsqVbH3F0vUD4dDeLObOoGIJLPUvBVG1gg7JrVHitWjAgL6amnsHESyiQG4tqRQlS7PM7LSXoE1/eNUHG9BpCqM5rE1Qy9f8i8rQ8bmLxAN8yIV5dbR0geJIt7MxOS6O+LWmSjbuG/ZQQ==", "version"=>"3.5.4"} (pid:11705)
>[0;37m2014-02-09 21:46:53.481[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_login): 0.669857222s  (Request ID: dad42b4417cb5e6a747ecf1e628e72d4) (pid:11705)
>[0;37m2014-02-09 21:46:53.481[0m [[0;37mDEBUG[0m] DYNECT delete with path: /REST/CNAMERecord/dev.rhcloud.com/myjbossews10-ray.dev.rhcloud.com/ and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:11705)
>[0;37m2014-02-09 21:46:54.666[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {}, "job_id": 692810561, "msgs": [{"INFO": "delete: 1 records deleted", "SOURCE": "API-B", "ERR_CD": null, "LVL": "INFO"}]} (pid:11705)
>[0;37m2014-02-09 21:46:54.932[0m [[0;37mDEBUG[0m] DYNECT Response data: {} (pid:11705)
>[0;37m2014-02-09 21:46:54.105[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_delete): 0.519420547s  (Request ID: dad42b4417cb5e6a747ecf1e628e72d4) (pid:11705)
>[0;37m2014-02-09 21:46:54.133[0m [[0;37mDEBUG[0m] DYNECT put/post with path: /REST/Zone/dev.rhcloud.com/ json data: {"publish":"true"} and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:11705)
>[0;37m2014-02-09 21:46:55.181[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {"zone_type": "Primary", "serial_style": "day", "serial": 2014236797, "zone": "dev.rhcloud.com"}, "job_id": 692810573, "msgs": [{"INFO": "publish: dev.rhcloud.com published", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:11705)
>[0;37m2014-02-09 21:46:55.182[0m [[0;37mDEBUG[0m] DYNECT Response data: {"zone_type"=>"Primary", "serial_style"=>"day", "serial"=>2014236797, "zone"=>"dev.rhcloud.com"} (pid:11705)
>[0;37m2014-02-09 21:46:55.182[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_put_post): 1.181074454s  (Request ID: dad42b4417cb5e6a747ecf1e628e72d4) (pid:11705)
>[0;37m2014-02-09 21:46:55.182[0m [[0;37mDEBUG[0m] DYNECT delete with path: /REST/Session/ and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:11705)
>[0;37m2014-02-09 21:46:55.618[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {}, "job_id": 692810588, "msgs": [{"INFO": "logout: Logout successful", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:11705)
>[0;37m2014-02-09 21:46:55.618[0m [[0;37mDEBUG[0m] DYNECT Response data: {} (pid:11705)
>[0;37m2014-02-09 21:46:55.618[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_delete): 0.43587641s  (Request ID: dad42b4417cb5e6a747ecf1e628e72d4) (pid:11705)
>[0;37m2014-02-09 21:46:55.646[0m [[0;37mDEBUG[0m] Execute UnreserveGearUidOp gear_id=52f838e41de544d0530002bf (pid:11705)
>[0;37m2014-02-09 21:46:55.753[0m [[0;37mDEBUG[0m] Execute DeleteGearOp gear_id=52f838e41de544d0530002bf (pid:11705)
>[0;37m2014-02-09 21:46:55.794[0m [[0;37mDEBUG[0m] Execute TrackUsageOp gear_id=52f838e41de544d0530002bf (pid:11705)
>[0;37m2014-02-09 21:46:55.828[0m [[0;37mDEBUG[0m] Execute NotifyAppDeleteOp (pid:11705)
>[0;37m2014-02-09 21:46:55.854[0m [[0;37mDEBUG[0m] Execute UnsubscribeConnectionsOp (pid:11705)
>[0;37m2014-02-09 21:46:55.857[0m [[0;37mDEBUG[0m] Execute UnsubscribeConnectionsOp (pid:11705)
>[0;37m2014-02-09 21:46:55.860[0m [[0;37mDEBUG[0m] Execute UnsubscribeConnectionsOp (pid:11705)
>[0;37m2014-02-09 21:46:55.863[0m [[0;37mDEBUG[0m] Execute DeleteGroupInstanceOp group_instance_id=52f838e41de544d0530002c1 (pid:11705)
>[0;37m2014-02-09 21:46:55.886[0m [[0;37mDEBUG[0m] Execute ExecuteConnectionsOp (pid:11705)
>[0;37m2014-02-09 21:46:55.922[0m [[0;37mDEBUG[0m] SUCCESS ACTION=DELETE_APPLICATION USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f838e41de544d0530002bf DOMAIN=ray Application 52f838e41de544d0530002bf is deleted. (pid:11705)
>[0;37m2014-02-09 21:46:55.924[0m [[32mINFO [0m] Completed 200 OK in 9098ms (Views: 0.6ms) (pid:11705)
>[0;37m2014-02-09 21:47:33.624[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:47:33 -0500 (pid:11705)
>[0;37m2014-02-09 21:47:33.626[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:47:33.627[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11705)
>[0;37m2014-02-09 21:47:33.639[0m [[32mINFO [0m] Completed 200 OK in 13ms (Views: 6.5ms) (pid:11705)
>[0;37m2014-02-09 21:47:33.997[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:47:33 -0500 (pid:11705)
>[0;37m2014-02-09 21:47:33.998[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:47:33.999[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:47:34.114[0m [[32mINFO [0m] Completed 200 OK in 12ms (Views: 7.2ms) (pid:11705)
>[0;37m2014-02-09 21:47:34.344[0m [[32mINFO [0m] Started GET "/broker/rest/cartridges" for 66.187.233.202 at 2014-02-09 21:47:34 -0500 (pid:11705)
>[0;37m2014-02-09 21:47:34.346[0m [[32mINFO [0m] Processing by CartridgesController#index as JSON (pid:11705)
>[0;37m2014-02-09 21:47:34.346[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:47:34.496[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_CARTRIDGE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= Listing cartridges (pid:11705)
>[0;37m2014-02-09 21:47:34.520[0m [[32mINFO [0m] Completed 200 OK in 174ms (Views: 22.9ms) (pid:11705)
>[0;37m2014-02-09 21:47:35.269[0m [[32mINFO [0m] Started GET "/broker/rest/domains" for 66.187.233.202 at 2014-02-09 21:47:35 -0500 (pid:11705)
>[0;37m2014-02-09 21:47:35.271[0m [[32mINFO [0m] Processing by DomainsController#index as JSON (pid:11705)
>[0;37m2014-02-09 21:47:35.272[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:47:35.276[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:47:35.281[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_DOMAIN USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11705)
>[0;37m2014-02-09 21:47:35.287[0m [[32mINFO [0m] Completed 200 OK in 16ms (Views: 5.6ms) (pid:11705)
>[0;37m2014-02-09 21:47:35.688[0m [[32mINFO [0m] Started POST "/broker/rest/domain/ray/applications" for 66.187.233.202 at 2014-02-09 21:47:35 -0500 (pid:11705)
>[0;37m2014-02-09 21:47:35.691[0m [[32mINFO [0m] Processing by ApplicationsController#create as JSON (pid:11705)
>[0;37m2014-02-09 21:47:35.692[0m [[32mINFO [0m] Parameters: {"name"=>"myjbossews10", "cartridges"=>["jbossews-1.0", "mysql-5.1"], "domain_id"=>"ray", "application"=>{"name"=>"myjbossews10"}} (pid:11705)
>[0;37m2014-02-09 21:47:35.692[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:47:35.695[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:47:35.729[0m [[0;37mDEBUG[0m] Pre-Executing ops... (pid:11705)
>[0;37m2014-02-09 21:47:35.730[0m [[0;37mDEBUG[0m] Pre-Execute InitGearOp comp_specs=[component:jbossews-1.0/jbossews-1.0/52f805d3c1f111aad2000014, component:mysql-5.1/mysql-5.1/52f805d3c1f111aad2000024] gear_id=52f83dc71de54480070001b8 group_instance_id=52f83dc71de54480070001ba (pid:11705)
>[0;37m2014-02-09 21:47:35.875[0m [[0;37mDEBUG[0m] Execute NotifyAppCreateOp (pid:11705)
>[0;37m2014-02-09 21:47:35.907[0m [[0;37mDEBUG[0m] Execute ReserveGearUidOp gear_id=52f83dc71de54480070001b8 (pid:11705)
>[0;37m2014-02-09 21:47:35.912[0m [[0;37mDEBUG[0m] DEBUG: rpc_get_fact: fact=active_capacity (pid:11705)
>[0;37m2014-02-09 21:47:35.917[0m [[0;37mDEBUG[0m] DEBUG: rpc_exec: rpc_client=#<MCollective::RPC::Client:0x0000000604ece0> (pid:11705)
>[0;37m2014-02-09 21:47:38.748[0m [[0;37mDEBUG[0m] Selecting best fit node: server: ip-10-225-9-204 capacity: 16.666666666666668 (pid:11705)
>[0;37m2014-02-09 21:47:38.107[0m [[0;37mDEBUG[0m] Execute CreateGearOp gear_id=52f83dc71de54480070001b8 (pid:11705)
>[0;37m2014-02-09 21:47:38.113[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"openshift-origin-node", :action=>"app-create", :args=>{"--with-app-uuid"=>"52f83dc71de54480070001b8", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f83dc71de54480070001b8", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"dfd820b245544f79aea29364eb82427b", "--with-secret-token"=>"eBYWdVnARDft-hUcrFm7MJiA5ZXGt4EDFVoH8DvimheUL60JVFORfO00Vv4jOdAn2vb6fW20wos8wMNxZPfdBQyS5ffTHKxBL3Q9UpRcvQRnLlaz-NdBBPj8iSosmgfp", "--with-initial-deployment-dir"=>true, "--cart-name"=>"openshift-origin-node"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: dfd820b245544f79aea29364eb82427b) (pid:11705)
>[0;37m2014-02-09 21:47:41.421[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x00000006681e00 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"", :exitcode=>0, :addtl_params=>nil}}>] (Request ID: dfd820b245544f79aea29364eb82427b) (pid:11705)
>[0;37m2014-02-09 21:47:41.424[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: app-create): 3.313972361s  (Request ID: dfd820b245544f79aea29364eb82427b) (pid:11705)
>[0;37m2014-02-09 21:47:41.456[0m [[0;37mDEBUG[0m] Execute RegisterDnsOp gear_id=52f83dc71de54480070001b8 (pid:11705)
>[0;37m2014-02-09 21:47:41.459[0m [[0;37mDEBUG[0m] DYNECT Login with path: /REST/Session/ (pid:11705)
>[0;37m2014-02-09 21:47:42.103[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {"token": "xb3Jc8kpLPpvZ5Ly11Yxr4mr1XNLR7WKYtzhL208FUcAWw/cENqaHPVb5CmD3Zy4tu8po2oQ/88lODUDf9zbs1jh6VxO8QDiJzuIsqP/gcODcHMjI+YUnF22ep6E8bTvCYvBdHVK/oNnFnF6SJi9GQ==", "version": "3.5.4"}, "job_id": 692811179, "msgs": [{"INFO": "login: Login successful", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:11705)
>[0;37m2014-02-09 21:47:42.103[0m [[0;37mDEBUG[0m] DYNECT Response data: {"token"=>"xb3Jc8kpLPpvZ5Ly11Yxr4mr1XNLR7WKYtzhL208FUcAWw/cENqaHPVb5CmD3Zy4tu8po2oQ/88lODUDf9zbs1jh6VxO8QDiJzuIsqP/gcODcHMjI+YUnF22ep6E8bTvCYvBdHVK/oNnFnF6SJi9GQ==", "version"=>"3.5.4"} (pid:11705)
>[0;37m2014-02-09 21:47:42.104[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_login): 0.644475736s  (Request ID: dfd820b245544f79aea29364eb82427b) (pid:11705)
>[0;37m2014-02-09 21:47:42.230[0m [[0;37mDEBUG[0m] Public ip being configured 'ec2-54-80-152-50.compute-1.amazonaws.com' to app 'myjbossews10' (pid:11705)
>[0;37m2014-02-09 21:47:42.231[0m [[0;37mDEBUG[0m] DYNECT put/post with path: /REST/CNAMERecord/dev.rhcloud.com/myjbossews10-ray.dev.rhcloud.com/ json data: {"rdata":{"cname":"ec2-54-80-152-50.compute-1.amazonaws.com"},"ttl":"60"} and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:11705)
>[0;37m2014-02-09 21:47:42.924[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {"zone": "dev.rhcloud.com", "ttl": 60, "fqdn": "myjbossews10-ray.dev.rhcloud.com", "record_type": "CNAME", "rdata": {"cname": "ec2-54-80-152-50.compute-1.amazonaws.com."}, "record_id": 0}, "job_id": 692811187, "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:11705)
>[0;37m2014-02-09 21:47:42.924[0m [[0;37mDEBUG[0m] DYNECT Response data: {"zone"=>"dev.rhcloud.com", "ttl"=>60, "fqdn"=>"myjbossews10-ray.dev.rhcloud.com", "record_type"=>"CNAME", "rdata"=>{"cname"=>"ec2-54-80-152-50.compute-1.amazonaws.com."}, "record_id"=>0} (pid:11705)
>[0;37m2014-02-09 21:47:42.924[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_put_post): 0.693537501s  (Request ID: dfd820b245544f79aea29364eb82427b) (pid:11705)
>[0;37m2014-02-09 21:47:42.924[0m [[0;37mDEBUG[0m] DYNECT put/post with path: /REST/Zone/dev.rhcloud.com/ json data: {"publish":"true"} and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:11705)
>[0;37m2014-02-09 21:47:43.973[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {"zone_type": "Primary", "serial_style": "day", "serial": 2014236801, "zone": "dev.rhcloud.com"}, "job_id": 692811199, "msgs": [{"INFO": "publish: dev.rhcloud.com published", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:11705)
>[0;37m2014-02-09 21:47:43.973[0m [[0;37mDEBUG[0m] DYNECT Response data: {"zone_type"=>"Primary", "serial_style"=>"day", "serial"=>2014236801, "zone"=>"dev.rhcloud.com"} (pid:11705)
>[0;37m2014-02-09 21:47:43.973[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_put_post): 1.048808501s  (Request ID: dfd820b245544f79aea29364eb82427b) (pid:11705)
>[0;37m2014-02-09 21:47:43.973[0m [[0;37mDEBUG[0m] DYNECT delete with path: /REST/Session/ and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:11705)
>[0;37m2014-02-09 21:47:44.412[0m [[0;37mDEBUG[0m] DYNECT Response: {"status": "success", "data": {}, "job_id": 692811213, "msgs": [{"INFO": "logout: Logout successful", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:11705)
>[0;37m2014-02-09 21:47:44.412[0m [[0;37mDEBUG[0m] DYNECT Response data: {} (pid:11705)
>[0;37m2014-02-09 21:47:44.412[0m [[0;37mDEBUG[0m] Dynect Response Time (dyn_delete): 0.439107264s  (Request ID: dfd820b245544f79aea29364eb82427b) (pid:11705)
>[0;37m2014-02-09 21:47:44.444[0m [[0;37mDEBUG[0m] Execute UpdateAppConfigOp gear_id=52f83dc71de54480070001b8 (pid:11705)
>[0;37m2014-02-09 21:47:44.452[0m [[0;37mDEBUG[0m] Execute AddBrokerAuthKeyOp gear_id=52f83dc71de54480070001b8 (pid:11705)
>[0;37m2014-02-09 21:47:44.455[0m [[0;37mDEBUG[0m] Execute AddCompOp comp_spec=component:jbossews-1.0/jbossews-1.0/52f805d3c1f111aad2000014 gear_id=52f83dc71de54480070001b8 (pid:11705)
>[0;37m2014-02-09 21:47:44.462[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"jbossews-1.0", :action=>"configure", :args=>{"--with-app-uuid"=>"52f83dc71de54480070001b8", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f83dc71de54480070001b8", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"dfd820b245544f79aea29364eb82427b", "--component-name"=>"jbossews-1.0", "--cart-name"=>"jbossews-1.0", "--with-software-version"=>"1.0", "--cartridge-vendor"=>"redhat"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: dfd820b245544f79aea29364eb82427b) (pid:11705)
>[0;37m2014-02-09 21:47:50.212[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x00000006a8cdd8 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"added manifest\nadding: WEB-INF/(in = 0) (out= 0)(stored 0%)\nadding: WEB-INF/web.xml(in = 350) (out= 185)(deflated 47%)\nadding: images/(in = 0) (out= 0)(stored 0%)\nadding: images/jbosscorp_logo.png(in = 1914) (out= 1919)(deflated 0%)\nadding: index.html(in = 40453) (out= 16093)(deflated 60%)\nadding: snoop.jsp(in = 5115) (out= 1261)(deflated 75%)\n", :exitcode=>0, :addtl_params=>nil}}>] (Request ID: dfd820b245544f79aea29364eb82427b) (pid:11705)
>[0;37m2014-02-09 21:47:50.215[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: configure): 5.756165587s  (Request ID: dfd820b245544f79aea29364eb82427b) (pid:11705)
>[0;37m2014-02-09 21:47:50.843[0m [[0;37mDEBUG[0m] DEBUG: Output of parallel execute: [{:tag=>{"op_id"=>"52f83dc71de54480070001c4"}, :gear=>"52f83dc71de54480070001b8", :job=>{:cartridge=>"openshift-origin-node", :action=>"authorized-ssh-key-batch-add", :args=>{"--with-app-uuid"=>"52f83dc71de54480070001b8", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f83dc71de54480070001b8", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"dfd820b245544f79aea29364eb82427b", "--with-ssh-keys"=>[{"key"=>"AAAAB3NzaC1yc2EAAAABIwAAAQEAuA0LIdBeb6I61vB4LwGeDLYEQOZfyhA047yJbljt9cFsT1bNn+HvffJ+6dZzWIbeRv/gxVF/AlQnMk1/r6J20BBqj0WM3AJWzfIKauDkw43BlY0udkry8QXMAtO+ME3AwjcRdQ+tLFieHQRPUzJ/mWxFdjaHQWV+e0sZ7Dye4VJphJ/Ujf6tJkvOrA4wkO5V3RsQOaTuJR2O5VDQj02GbthGHfZoEIGJ1hkUEYpeXkkVesQytul62Qia1WyOrM+u24HHzUy3im57YBkBEneqOejvJ1SKPRfMXm8fi+e0nVvT98ItDNqqLg8o+qosA0KEK/RxHl6vvoLa9iNzYjoQPw==", "type"=>"ssh-rsa", "comment"=>"52f837f31de544d05300029d-default", "content"=>"AAAAB3NzaC1yc2EAAAABIwAAAQEAuA0LIdBeb6I61vB4LwGeDLYEQOZfyhA047yJbljt9cFsT1bNn+HvffJ+6dZzWIbeRv/gxVF/AlQnMk1/r6J20BBqj0WM3AJWzfIKauDkw43BlY0udkry8QXMAtO+ME3AwjcRdQ+tLFieHQRPUzJ/mWxFdjaHQWV+e0sZ7Dye4VJphJ/Ujf6tJkvOrA4wkO5V3RsQOaTuJR2O5VDQj02GbthGHfZoEIGJ1hkUEYpeXkkVesQytul62Qia1WyOrM+u24HHzUy3im57YBkBEneqOejvJ1SKPRfMXm8fi+e0nVvT98ItDNqqLg8o+qosA0KEK/RxHl6vvoLa9iNzYjoQPw=="}]}}, :result_stdout=>"", :result_stderr=>"", :result_exit_code=>0, :result_addtl_params=>nil}, {:tag=>{"op_id"=>"52f83dc71de54480070001c4"}, :gear=>"52f83dc71de54480070001b8", :job=>{:cartridge=>"openshift-origin-node", :action=>"update-configuration", :args=>{"--with-app-uuid"=>"52f83dc71de54480070001b8", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f83dc71de54480070001b8", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"dfd820b245544f79aea29364eb82427b", "--with-config"=>{"auto_deploy"=>true, "deployment_branch"=>"master", "keep_deployments"=>1, "deployment_type"=>"git"}}}, :result_stdout=>"", :result_stderr=>"", :result_exit_code=>0, :result_addtl_params=>nil}, {:tag=>{"op_id"=>"52f83dc71de54480070001c5"}, :gear=>"52f83dc71de54480070001b8", :job=>{:cartridge=>"openshift-origin-node", :action=>"broker-auth-key-add", :args=>{"--with-app-uuid"=>"52f83dc71de54480070001b8", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f83dc71de54480070001b8", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"dfd820b245544f79aea29364eb82427b", "--with-iv"=>"AkRaRNCETtwfTKZkhH847aCD0kzJv+CvXMFv3QRQnBuOHVNR2MzvoiEF/f3X\nE4o+sOuxskSmyF5Z5c+BsMJHfyzjH+2RcGNuqplN5rJ4Y/7q7Ih6FZw+oLDk\nhoAMEf7ETgFt7PWqCcicc0n8myW08TEYYUqniCZBfjUqrpjEACfTFEg7o3cZ\n0CXVpC37jTXCoLzi9MIBwYKhVAtfG4YVSJczB1jdmHCmwX4XQDm4J5QfWx/w\nq/IabFCK8apfly8LqK+WgVo0DkzdFhAhcUAQRlI96YCC3larMcJ2Dbylhw9W\nCaeaTN4KFu1kXwWHa5Qn2uQyJxj/7+UYmCyiHpx3Jg==\n", "--with-token"=>"Lw1txsweKyr3yHwkV77T2NYIUg4ejJ9yWXMoHoz124BdB5zfJox/j2BNfxUw\nfTy/KPBrtEkdoae4yH7PYBO4A8fhAMDbsSzffIoj7SkHV0A=\n"}}, :result_stdout=>"", :result_stderr=>"", :result_exit_code=>0, :result_addtl_params=>nil}], exitcode: 0, from: ip-10-225-9-204  (Request ID: dfd820b245544f79aea29364eb82427b) (pid:11705)
>[0;37m2014-02-09 21:47:50.846[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_parallel): 628ms  (Request ID: dfd820b245544f79aea29364eb82427b) (pid:11705)
>[0;37m2014-02-09 21:47:50.894[0m [[0;37mDEBUG[0m] Execute AddCompOp comp_spec=component:mysql-5.1/mysql-5.1/52f805d3c1f111aad2000024 gear_id=52f83dc71de54480070001b8 (pid:11705)
>[0;37m2014-02-09 21:47:50.901[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"mysql-5.1", :action=>"configure", :args=>{"--with-app-uuid"=>"52f83dc71de54480070001b8", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f83dc71de54480070001b8", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"dfd820b245544f79aea29364eb82427b", "--component-name"=>"mysql-5.1", "--cart-name"=>"mysql-5.1", "--with-software-version"=>"5.1", "--cartridge-vendor"=>"redhat"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: dfd820b245544f79aea29364eb82427b) (pid:11705)
>[0;37m2014-02-09 21:47:55.835[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x00000006a1d820 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"Generating username and password\nInstalling mysqld\nCLIENT_RESULT: \nCLIENT_RESULT: MySQL 5.1 database added.  Please make note of these credentials:\nCLIENT_RESULT: \nCLIENT_RESULT:        Root User: [HIDDEN] (Request ID: dfd820b245544f79aea29364eb82427b) (pid:11705)
>[0;37m2014-02-09 21:47:55.861[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: configure): 4.187706058s  (Request ID: dfd820b245544f79aea29364eb82427b) (pid:11705)
>[0;37m2014-02-09 21:47:55.120[0m [[0;37mDEBUG[0m] Execute PostConfigureCompOp comp_spec=component:mysql-5.1/mysql-5.1/52f805d3c1f111aad2000024 gear_id=52f83dc71de54480070001b8 (pid:11705)
>[0;37m2014-02-09 21:47:55.132[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"mysql-5.1", :action=>"post-configure", :args=>{"--with-app-uuid"=>"52f83dc71de54480070001b8", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f83dc71de54480070001b8", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"dfd820b245544f79aea29364eb82427b", "--component-name"=>"mysql-5.1", "--cart-name"=>"mysql-5.1", "--with-software-version"=>"5.1", "--cartridge-vendor"=>"redhat"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: dfd820b245544f79aea29364eb82427b) (pid:11705)
>[0;37m2014-02-09 21:48:16.602[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x00000005922138 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"Starting MySQL 5.1 cartridge\n", :exitcode=>0, :addtl_params=>nil}}>] (Request ID: dfd820b245544f79aea29364eb82427b) (pid:11705)
>[0;37m2014-02-09 21:48:16.603[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: post-configure): 21.47430395s  (Request ID: dfd820b245544f79aea29364eb82427b) (pid:11705)
>[0;37m2014-02-09 21:48:16.632[0m [[0;37mDEBUG[0m] Execute ExecuteConnectionsOp (pid:11705)
>[0;37m2014-02-09 21:48:16.661[0m [[0;37mDEBUG[0m] Execute PostConfigureCompOp comp_spec=component:jbossews-1.0/jbossews-1.0/52f805d3c1f111aad2000014 gear_id=52f83dc71de54480070001b8 (pid:11705)
>[0;37m2014-02-09 21:48:16.666[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"jbossews-1.0", :action=>"post-configure", :args=>{"--with-app-uuid"=>"52f83dc71de54480070001b8", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f83dc71de54480070001b8", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"dfd820b245544f79aea29364eb82427b", "--component-name"=>"jbossews-1.0", "--cart-name"=>"jbossews-1.0", "--with-software-version"=>"1.0", "--cartridge-vendor"=>"redhat"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: dfd820b245544f79aea29364eb82427b) (pid:11705)
>[0;37m2014-02-09 21:48:22.852[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x00000006b43308 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"Starting jbossews cartridge\nFound 127.1.253.1:8080 listening port\n", :exitcode=>0, :addtl_params=>{:deployments=>[{:id=>"2d5f484d", :ref=>"master", :sha1=>"83b0751", :force_clean_build=>nil, :hot_deploy=>nil, :created_at=>1392000459.859, :activations=>[1392000499.3961332]}]}}}>] (Request ID: dfd820b245544f79aea29364eb82427b) (pid:11705)
>[0;37m2014-02-09 21:48:22.854[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: post-configure): 6.19047119s  (Request ID: dfd820b245544f79aea29364eb82427b) (pid:11705)
>[0;37m2014-02-09 21:48:22.869[0m [[0;37mDEBUG[0m] Execute TrackUsageOp gear_id=52f83dc71de54480070001b8 (pid:11705)
>[0;37m2014-02-09 21:48:23.711[0m [[0;37mDEBUG[0m] SUCCESS ACTION=ADD_APPLICATION USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f83dc71de54480070001b8 DOMAIN=ray Application myjbossews10 was created. (pid:11705)
>[0;37m2014-02-09 21:48:23.892[0m [[32mINFO [0m] Completed 201 Created in 47397ms (Views: 16.1ms) (pid:11705)
>[0;37m2014-02-09 21:48:24.769[0m [[32mINFO [0m] Started GET "/broker/rest/user" for 66.187.233.202 at 2014-02-09 21:48:24 -0500 (pid:11705)
>[0;37m2014-02-09 21:48:24.771[0m [[32mINFO [0m] Processing by UserExtController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:48:24.772[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:48:24.776[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:48:24.778[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_USER USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11705)
>[0;37m2014-02-09 21:48:24.780[0m [[32mINFO [0m] Completed 200 OK in 9ms (Views: 1.7ms) (pid:11705)
>[0;37m2014-02-09 21:48:25.635[0m [[32mINFO [0m] Started GET "/broker/rest/user/keys" for 66.187.233.202 at 2014-02-09 21:48:25 -0500 (pid:11705)
>[0;37m2014-02-09 21:48:25.678[0m [[32mINFO [0m] Processing by KeysController#index as JSON (pid:11705)
>[0;37m2014-02-09 21:48:25.689[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:48:25.734[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:48:25.758[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_KEY USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= Found 1 ssh keys (pid:11705)
>[0;37m2014-02-09 21:48:25.801[0m [[32mINFO [0m] Completed 200 OK in 12ms (Views: 1.8ms) (pid:11705)
>[0;37m2014-02-09 21:49:04.221[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:49:04 -0500 (pid:11705)
>[0;37m2014-02-09 21:49:04.224[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:49:04.224[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11705)
>[0;37m2014-02-09 21:49:04.238[0m [[32mINFO [0m] Completed 200 OK in 14ms (Views: 7.7ms) (pid:11705)
>[0;37m2014-02-09 21:49:04.615[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:49:04 -0500 (pid:11705)
>[0;37m2014-02-09 21:49:04.616[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:49:04.617[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:49:04.633[0m [[32mINFO [0m] Completed 200 OK in 17ms (Views: 7.9ms) (pid:11705)
>[0;37m2014-02-09 21:49:05.330[0m [[32mINFO [0m] Started GET "/broker/rest/cartridges" for 66.187.233.202 at 2014-02-09 21:49:05 -0500 (pid:11705)
>[0;37m2014-02-09 21:49:05.349[0m [[32mINFO [0m] Processing by CartridgesController#index as JSON (pid:11705)
>[0;37m2014-02-09 21:49:05.353[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:49:05.889[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_CARTRIDGE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= Listing cartridges (pid:11705)
>[0;37m2014-02-09 21:49:05.115[0m [[32mINFO [0m] Completed 200 OK in 81ms (Views: 25.6ms) (pid:11705)
>[0;37m2014-02-09 21:49:05.709[0m [[32mINFO [0m] Started GET "/broker/rest/domains" for 66.187.233.202 at 2014-02-09 21:49:05 -0500 (pid:11705)
>[0;37m2014-02-09 21:49:05.711[0m [[32mINFO [0m] Processing by DomainsController#index as JSON (pid:11705)
>[0;37m2014-02-09 21:49:05.712[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:49:05.716[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:49:05.721[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_DOMAIN USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11705)
>[0;37m2014-02-09 21:49:05.728[0m [[32mINFO [0m] Completed 200 OK in 16ms (Views: 5.5ms) (pid:11705)
>[0;37m2014-02-09 21:49:06.258[0m [[32mINFO [0m] Started GET "/broker/rest/domains/ray/applications/myjbossews10?include=cartridges" for 66.187.233.202 at 2014-02-09 21:49:06 -0500 (pid:11705)
>[0;37m2014-02-09 21:49:06.282[0m [[32mINFO [0m] Processing by ApplicationsController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:49:06.283[0m [[32mINFO [0m] Parameters: {"include"=>"cartridges", "domain_id"=>"ray", "id"=>"myjbossews10"} (pid:11705)
>[0;37m2014-02-09 21:49:06.286[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:49:06.326[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:49:06.141[0m [[0;37mDEBUG[0m] SUCCESS ACTION=SHOW_APPLICATION USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f83dc71de54480070001b8 DOMAIN=ray Application 'myjbossews10' found (pid:11705)
>[0;37m2014-02-09 21:49:06.169[0m [[32mINFO [0m] Completed 200 OK in 141ms (Views: 26.7ms) (pid:11705)
>[0;37m2014-02-09 21:49:06.497[0m [[32mINFO [0m] Started POST "/broker/rest/application/52f83dc71de54480070001b8/cartridges" for 66.187.233.202 at 2014-02-09 21:49:06 -0500 (pid:11705)
>[0;37m2014-02-09 21:49:06.501[0m [[32mINFO [0m] Processing by EmbCartController#create as JSON (pid:11705)
>[0;37m2014-02-09 21:49:06.501[0m [[32mINFO [0m] Parameters: {"name"=>"phpmyadmin-4", "application_id"=>"52f83dc71de54480070001b8", "emb_cart"=>{"name"=>"phpmyadmin-4"}} (pid:11705)
>[0;37m2014-02-09 21:49:06.502[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:49:06.506[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:49:06.566[0m [[0;37mDEBUG[0m] Execute NewCompOp comp_spec=component:phpmyadmin-4/phpmyadmin-4/52f805d3c1f111aad200000f group_instance_id=52f83dc71de54480070001ba (pid:11705)
>[0;37m2014-02-09 21:49:06.591[0m [[0;37mDEBUG[0m] Execute AddCompOp comp_spec=component:phpmyadmin-4/phpmyadmin-4/52f805d3c1f111aad200000f gear_id=52f83dc71de54480070001b8 (pid:11705)
>[0;37m2014-02-09 21:49:06.597[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"phpmyadmin-4", :action=>"configure", :args=>{"--with-app-uuid"=>"52f83dc71de54480070001b8", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f83dc71de54480070001b8", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"d750367eca5c90cc4a16a95a676902d2", "--component-name"=>"phpmyadmin-4", "--cart-name"=>"phpmyadmin-4", "--with-software-version"=>"4", "--cartridge-vendor"=>"redhat"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: d750367eca5c90cc4a16a95a676902d2) (pid:11705)
>[0;37m2014-02-09 21:49:12.185[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x00000006d54368 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"CLIENT_RESULT: \nCLIENT_RESULT: Please make note of these MySQL credentials again:\nCLIENT_RESULT:   Root User: [HIDDEN] (Request ID: d750367eca5c90cc4a16a95a676902d2) (pid:11705)
>[0;37m2014-02-09 21:49:12.188[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: configure): 5.593909417s  (Request ID: d750367eca5c90cc4a16a95a676902d2) (pid:11705)
>[0;37m2014-02-09 21:49:12.319[0m [[0;37mDEBUG[0m] Execute PostConfigureCompOp comp_spec=component:phpmyadmin-4/phpmyadmin-4/52f805d3c1f111aad200000f gear_id=52f83dc71de54480070001b8 (pid:11705)
>[0;37m2014-02-09 21:49:12.326[0m [[0;37mDEBUG[0m] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"phpmyadmin-4", :action=>"post-configure", :args=>{"--with-app-uuid"=>"52f83dc71de54480070001b8", "--with-app-name"=>"myjbossews10", "--with-container-uuid"=>"52f83dc71de54480070001b8", "--with-container-name"=>"myjbossews10", "--with-namespace"=>"ray", "--with-request-id"=>"d750367eca5c90cc4a16a95a676902d2", "--component-name"=>"phpmyadmin-4", "--cart-name"=>"phpmyadmin-4", "--with-software-version"=>"4", "--cartridge-vendor"=>"redhat"}}, ip-10-225-9-204, {'identity' => ip-10-225-9-204}) (Request ID: d750367eca5c90cc4a16a95a676902d2) (pid:11705)
>[0;37m2014-02-09 21:49:13.576[0m [[0;37mDEBUG[0m] DEBUG: [#<MCollective::RPC::Result:0x000000061aa4e0 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-225-9-204", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"Starting PHPMyAdmin cartridge\n", :exitcode=>0, :addtl_params=>nil}}>] (Request ID: d750367eca5c90cc4a16a95a676902d2) (pid:11705)
>[0;37m2014-02-09 21:49:13.579[0m [[0;37mDEBUG[0m] DEBUG: MCollective Response Time (execute_direct: post-configure): 1.255956944s  (Request ID: d750367eca5c90cc4a16a95a676902d2) (pid:11705)
>[0;37m2014-02-09 21:49:13.593[0m [[0;37mDEBUG[0m] Execute ExecuteConnectionsOp (pid:11705)
>[0;37m2014-02-09 21:49:13.627[0m [[0;37mDEBUG[0m] SUCCESS ACTION=ADD_APP_CARTRIDGE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f83dc71de54480070001b8 DOMAIN=ray Added phpmyadmin-4 to application myjbossews10 (pid:11705)
>[0;37m2014-02-09 21:49:13.633[0m [[32mINFO [0m] Completed 201 Created in 7132ms (Views: 4.4ms) (pid:11705)
>[0;37m2014-02-09 21:49:31.817[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:49:31 -0500 (pid:11705)
>[0;37m2014-02-09 21:49:31.820[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:49:31.820[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11705)
>[0;37m2014-02-09 21:49:31.833[0m [[32mINFO [0m] Completed 200 OK in 13ms (Views: 7.1ms) (pid:11705)
>[0;37m2014-02-09 21:49:32.131[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:49:32 -0500 (pid:11705)
>[0;37m2014-02-09 21:49:32.133[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:49:32.133[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:49:32.147[0m [[32mINFO [0m] Completed 200 OK in 13ms (Views: 7.2ms) (pid:11705)
>[0;37m2014-02-09 21:49:32.443[0m [[32mINFO [0m] Started GET "/broker/rest/domains" for 66.187.233.202 at 2014-02-09 21:49:32 -0500 (pid:11705)
>[0;37m2014-02-09 21:49:32.445[0m [[32mINFO [0m] Processing by DomainsController#index as JSON (pid:11705)
>[0;37m2014-02-09 21:49:32.446[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:49:32.450[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:49:32.454[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_DOMAIN USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11705)
>[0;37m2014-02-09 21:49:32.461[0m [[32mINFO [0m] Completed 200 OK in 16ms (Views: 5.8ms) (pid:11705)
>[0;37m2014-02-09 21:49:32.762[0m [[32mINFO [0m] Started GET "/broker/rest/domains/ray/applications/myjbossews10?include=cartridges" for 66.187.233.202 at 2014-02-09 21:49:32 -0500 (pid:11705)
>[0;37m2014-02-09 21:49:32.764[0m [[32mINFO [0m] Processing by ApplicationsController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:49:32.764[0m [[32mINFO [0m] Parameters: {"include"=>"cartridges", "domain_id"=>"ray", "id"=>"myjbossews10"} (pid:11705)
>[0;37m2014-02-09 21:49:32.764[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:49:32.768[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:49:32.868[0m [[0;37mDEBUG[0m] SUCCESS ACTION=SHOW_APPLICATION USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f83dc71de54480070001b8 DOMAIN=ray Application 'myjbossews10' found (pid:11705)
>[0;37m2014-02-09 21:49:32.892[0m [[32mINFO [0m] Completed 200 OK in 128ms (Views: 23.4ms) (pid:11705)
>[0;37m2014-02-09 21:49:50.344[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:49:50 -0500 (pid:11705)
>[0;37m2014-02-09 21:49:50.347[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:49:50.348[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11705)
>[0;37m2014-02-09 21:49:50.363[0m [[32mINFO [0m] Completed 200 OK in 16ms (Views: 8.8ms) (pid:11705)
>[0;37m2014-02-09 21:49:50.661[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:49:50 -0500 (pid:11705)
>[0;37m2014-02-09 21:49:50.663[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:49:50.663[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:49:50.679[0m [[32mINFO [0m] Completed 200 OK in 16ms (Views: 10.5ms) (pid:11705)
>[0;37m2014-02-09 21:49:50.985[0m [[32mINFO [0m] Started GET "/broker/rest/domains" for 66.187.233.202 at 2014-02-09 21:49:50 -0500 (pid:11705)
>[0;37m2014-02-09 21:49:50.987[0m [[32mINFO [0m] Processing by DomainsController#index as JSON (pid:11705)
>[0;37m2014-02-09 21:49:50.987[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:49:50.992[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:49:50.996[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_DOMAIN USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11705)
>[0;37m2014-02-09 21:49:51.404[0m [[32mINFO [0m] Completed 200 OK in 17ms (Views: 6.2ms) (pid:11705)
>[0;37m2014-02-09 21:49:51.298[0m [[32mINFO [0m] Started GET "/broker/rest/domains/ray/applications/myjbossews10?include=cartridges" for 66.187.233.202 at 2014-02-09 21:49:51 -0500 (pid:11705)
>[0;37m2014-02-09 21:49:51.301[0m [[32mINFO [0m] Processing by ApplicationsController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:49:51.301[0m [[32mINFO [0m] Parameters: {"include"=>"cartridges", "domain_id"=>"ray", "id"=>"myjbossews10"} (pid:11705)
>[0;37m2014-02-09 21:49:51.301[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:49:51.305[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:49:51.329[0m [[0;37mDEBUG[0m] SUCCESS ACTION=SHOW_APPLICATION USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f83dc71de54480070001b8 DOMAIN=ray Application 'myjbossews10' found (pid:11705)
>[0;37m2014-02-09 21:49:51.353[0m [[32mINFO [0m] Completed 200 OK in 52ms (Views: 23.1ms) (pid:11705)
>[0;37m2014-02-09 21:49:55.556[0m [[32mINFO [0m] Started DELETE "/broker/rest/application/52f83dc71de54480070001b8/cartridge/mysql-5.1" for 66.187.233.202 at 2014-02-09 21:49:55 -0500 (pid:11705)
>[0;37m2014-02-09 21:49:55.559[0m [[32mINFO [0m] Processing by EmbCartController#destroy as JSON (pid:11705)
>[0;37m2014-02-09 21:49:55.559[0m [[32mINFO [0m] Parameters: {"application_id"=>"52f83dc71de54480070001b8", "id"=>"mysql-5.1", "emb_cart"=>{}} (pid:11705)
>[0;37m2014-02-09 21:49:55.560[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:49:55.563[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:49:55.602[0m [[0;37mDEBUG[0m] SUCCESS ACTION=DELETE_APP_CARTRIDGE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f83dc71de54480070001b8 DOMAIN=ray Removed mysql-5.1 from application myjbossews10 (pid:11705)
>[0;37m2014-02-09 21:49:55.604[0m [[32mINFO [0m] Completed 200 OK in 44ms (Views: 0.6ms) (pid:11705)
>[0;37m2014-02-09 21:50:01.320[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:50:01 -0500 (pid:11705)
>[0;37m2014-02-09 21:50:01.323[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:50:01.324[0m [[0;37mDEBUG[0m] API version 1.3 (pid:11705)
>[0;37m2014-02-09 21:50:01.344[0m [[32mINFO [0m] Completed 200 OK in 20ms (Views: 12.2ms) (pid:11705)
>[0;37m2014-02-09 21:50:01.641[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 66.187.233.202 at 2014-02-09 21:50:01 -0500 (pid:11705)
>[0;37m2014-02-09 21:50:01.643[0m [[32mINFO [0m] Processing by ApiController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:50:01.643[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:50:01.780[0m [[32mINFO [0m] Completed 200 OK in 137ms (Views: 127.9ms) (pid:11705)
>[0;37m2014-02-09 21:50:02.827[0m [[32mINFO [0m] Started GET "/broker/rest/domains" for 66.187.233.202 at 2014-02-09 21:50:02 -0500 (pid:11705)
>[0;37m2014-02-09 21:50:02.852[0m [[32mINFO [0m] Processing by DomainsController#index as JSON (pid:11705)
>[0;37m2014-02-09 21:50:02.856[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:50:02.904[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:50:02.952[0m [[0;37mDEBUG[0m] SUCCESS ACTION=LIST_DOMAIN USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com DOMAIN= (pid:11705)
>[0;37m2014-02-09 21:50:02.102[0m [[32mINFO [0m] Completed 200 OK in 17ms (Views: 6.2ms) (pid:11705)
>[0;37m2014-02-09 21:50:02.399[0m [[32mINFO [0m] Started GET "/broker/rest/domains/ray/applications/myjbossews10?include=cartridges" for 66.187.233.202 at 2014-02-09 21:50:02 -0500 (pid:11705)
>[0;37m2014-02-09 21:50:02.402[0m [[32mINFO [0m] Processing by ApplicationsController#show as JSON (pid:11705)
>[0;37m2014-02-09 21:50:02.402[0m [[32mINFO [0m] Parameters: {"include"=>"cartridges", "domain_id"=>"ray", "id"=>"myjbossews10"} (pid:11705)
>[0;37m2014-02-09 21:50:02.403[0m [[0;37mDEBUG[0m] API version 1.6 (pid:11705)
>[0;37m2014-02-09 21:50:02.407[0m [[0;37mDEBUG[0m] SUCCESS ACTION=AUTHENTICATE USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com IP=66.187.233.202 SCOPES=session Authenticated (pid:11705)
>[0;37m2014-02-09 21:50:02.433[0m [[0;37mDEBUG[0m] SUCCESS ACTION=SHOW_APPLICATION USER_ID=52f837f31de544d05300029d LOGIN=lzhang@redhat.com APP_UUID=52f83dc71de54480070001b8 DOMAIN=ray Application 'myjbossews10' found (pid:11705)
>[0;37m2014-02-09 21:50:02.459[0m [[32mINFO [0m] Completed 200 OK in 56ms (Views: 24.5ms) (pid:11705)

Actions: View

Attachments on bug 1063109: 861218 | 861219 | 861220