Attachment 691526 Details for Bug 906744 – development.log of move db cartridge across district

development.log of move db cartridge across district

file_906744.txt (text/plain), 25.88 KB, created by Rony Gong 🔥 on 2013-02-01 11:08:53 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Rony Gong 🔥

Created: 2013-02-01 11:08:53 UTC

Size: 25.88 KB

patch

obsolete

>2013-02-01 05:58:28.178 [DEBUG] MOPED: 127.0.0.1:27017 INSERT       database=openshift_broker_dev collection=system.indexes documents=[{:unique=>true, :ns=>"openshift_broker_dev.districts", :key=>{:name=>1}, :name=>"name_1"}] flags=[] (pid:14769)
>2013-02-01 05:58:28.178 [DEBUG] COMMAND      database=openshift_broker_dev command={:getlasterror=>1, :safe=>true} (0.8845ms) (pid:14769)
>2013-02-01 05:58:28.525 [DEBUG] MOPED: 127.0.0.1:27017 INSERT       database=openshift_broker_dev collection=system.indexes documents=[{:unique=>true, :ns=>"openshift_broker_dev.distributed_locks", :key=>{:type=>1}, :name=>"type_1"}] flags=[] (pid:14769)
>2013-02-01 05:58:28.525 [DEBUG] COMMAND      database=openshift_broker_dev command={:getlasterror=>1, :safe=>true} (0.7491ms) (pid:14769)
>2013-02-01 05:58:28.650 [DEBUG] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=applications selector={"$query"=>{"group_instances.gears.uuid"=>"510b9f3b998a4012070004e2"}, "$orderby"=>{:_id=>1}} flags=[:slave_ok] limit=-1 skip=0 fields=nil (1.4408ms) (pid:14769)
>2013-02-01 05:58:28.654 [DEBUG] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=domains selector={"$query"=>{"_id"=>"510b2389998a40b00a000004"}, "$orderby"=>{:_id=>1}} flags=[:slave_ok] limit=-1 skip=0 fields=nil (0.4349ms) (pid:14769)
>2013-02-01 05:58:28.658 [DEBUG] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=cloud_users selector={"$query"=>{"_id"=>"510b2363998a40b00a000001"}, "$orderby"=>{:_id=>1}} flags=[:slave_ok] limit=-1 skip=0 fields=nil (0.4573ms) (pid:14769)
>2013-02-01 05:58:28.661 [DEBUG] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=domains selector={"owner_id"=>"510b2363998a40b00a000001"} flags=[:slave_ok] limit=0 skip=0 fields=nil (0.7327ms) (pid:14769)
>2013-02-01 05:58:28.662 [DEBUG] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=domains selector={"user_ids"=>"510b2363998a40b00a000001"} flags=[:slave_ok] limit=0 skip=0 fields=nil (0.4961ms) (pid:14769)
>2013-02-01 05:58:28.664 [DEBUG] MOPED: 127.0.0.1:27017 COMMAND      database=openshift_broker_dev command={:findAndModify=>"locks", :query=>{"user_id"=>"510b2363998a40b00a000001", "app_ids"=>{"$nin"=>["510b9ef7998a4012070004bd"]}}, :new=>true, :update=>{"$push"=>{:app_ids=>"510b9ef7998a4012070004bd"}}} (0.6888ms) (pid:14769)
>2013-02-01 05:58:29.364 [DEBUG] DEBUG: Source district uuid: 510b2386998a409610000001 (pid:14769)
>2013-02-01 05:58:29.365 [DEBUG] DEBUG: Destination district uuid: 510b74e8998a40613d000001 (pid:14769)
>2013-02-01 05:58:29.499 [DEBUG] DEBUG: Getting existing app 'qsruby18' status before moving (pid:14769)
>2013-02-01 05:58:29.504 [DEBUG] DEBUG: rpc_exec_direct: rpc_client=#<MCollective::RPC::Client:0x00000005b7fa20> (pid:14769)
>2013-02-01 05:58:29.504 [DEBUG] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"ruby-1.8", :action=>"status", :args=>"'qsruby18' 'qgong14' '510b9ef7998a4012070004bd'"}, ip-10-203-71-151, {'identity' => ip-10-203-71-151}) (pid:14769)
>2013-02-01 05:58:30.110 [DEBUG] DEBUG: [#<MCollective::RPC::Result:0x00000005b96978 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-203-71-151", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"CLIENT_RESULT: Total Accesses: 103\nCLIENT_RESULT: Total kBytes: 526\nCLIENT_RESULT: CPULoad: .0379147\nCLIENT_RESULT: Uptime: 211\nCLIENT_RESULT: ReqPerSec: .488152\nCLIENT_RESULT: BytesPerSec: 2552.72\nCLIENT_RESULT: BytesPerReq: 5229.36\nCLIENT_RESULT: BusyWorkers: 1\nCLIENT_RESULT: IdleWorkers: 1\nCLIENT_RESULT: Scoreboard: _W...\nATTR: quota_blocks=1048576\nATTR: quota_files=40000\n", :exitcode=>0}}>] (pid:14769)
>2013-02-01 05:58:30.112 [DEBUG] DEBUG: Gear component 'ruby-1.8' was running (pid:14769)
>2013-02-01 05:58:30.124 [DEBUG] DEBUG: Stopping existing app cartridge 'mysql-5.1' before moving (pid:14769)
>2013-02-01 05:58:30.127 [DEBUG] DEBUG: rpc_exec_direct: rpc_client=#<MCollective::RPC::Client:0x00000006a73b30> (pid:14769)
>2013-02-01 05:58:30.127 [DEBUG] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"embedded/mysql-5.1", :action=>"stop", :args=>"'510b9f3b99' 'qgong14' '510b9f3b998a4012070004e2'"}, ip-10-203-71-151, {'identity' => ip-10-203-71-151}) (pid:14769)
>2013-02-01 05:58:34.863 [DEBUG] DEBUG: [#<MCollective::RPC::Result:0x00000006be5798 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-203-71-151", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"", :exitcode=>0}}>] (pid:14769)
>2013-02-01 05:58:34.869 [DEBUG] DEBUG: Performing cartridge level pre-move for embedded mysql-5.1 for 'qsruby18' on ip-10-203-71-151 (pid:14769)
>2013-02-01 05:58:34.870 [DEBUG] DEBUG: rpc_exec_direct: rpc_client=#<MCollective::RPC::Client:0x00000006bac3d0> (pid:14769)
>2013-02-01 05:58:34.870 [DEBUG] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"embedded/mysql-5.1", :action=>"pre-move", :args=>"'510b9f3b99' 'qgong14' '510b9f3b998a4012070004e2'"}, ip-10-203-71-151, {'identity' => ip-10-203-71-151}) (pid:14769)
>2013-02-01 05:59:12.775 [DEBUG] DEBUG: [#<MCollective::RPC::Result:0x00000006aefd48 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-203-71-151", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"", :exitcode=>0}}>] (pid:14769)
>2013-02-01 05:59:12.802 [DEBUG] MOPED: 127.0.0.1:27017 COMMAND      database=openshift_broker_dev command={:findAndModify=>"districts", :query=>{"uuid"=>"510b74e8998a40613d000001", "available_capacity"=>{"$gt"=>0}}, :update=>{"$pop"=>{"available_uids"=>-1}, "$inc"=>{"available_capacity"=>-1}}} (20.0636ms) (pid:14769)
>2013-02-01 05:59:12.803 [DEBUG] DEBUG: Reserved uid '1031' on district: '510b74e8998a40613d000001' (pid:14769)
>2013-02-01 05:59:12.804 [DEBUG] DEBUG: Creating new account for gear '510b9f3b99' on ip-10-202-163-143 (pid:14769)
>2013-02-01 05:59:12.806 [DEBUG] DEBUG: rpc_exec_direct: rpc_client=#<MCollective::RPC::Client:0x00000006e98f30> (pid:14769)
>2013-02-01 05:59:12.806 [DEBUG] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"openshift-origin-node", :action=>"app-create", :args=>{"--with-app-uuid"=>"510b9ef7998a4012070004bd", "--with-app-name"=>"qsruby18", "--with-container-uuid"=>"510b9f3b998a4012070004e2", "--with-container-name"=>"510b9f3b99", "--with-quota-blocks"=>"1048576", "--with-quota-files"=>"40000", "--with-namespace"=>"qgong14", "--with-uid"=>1031}}, ip-10-202-163-143, {'identity' => ip-10-202-163-143}) (pid:14769)
>2013-02-01 05:59:14.210 [DEBUG] DEBUG: [#<MCollective::RPC::Result:0x00000006eeb9b0 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-202-163-143", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"", :exitcode=>0}}>] (pid:14769)
>2013-02-01 05:59:14.213 [DEBUG] DEBUG: Moving content for app 'qsruby18', gear '510b9f3b99' to ip-10-202-163-143 (pid:14769)
>2013-02-01 05:59:15.932 [DEBUG] Agent pid 15880
>unset SSH_AUTH_SOCK;
>unset SSH_AGENT_PID;
>echo Agent pid 15880 killed; (pid:14769)
>2013-02-01 05:59:16.284 [DEBUG] DEBUG: Performing cartridge level move for embedded mysql-5.1 for 'qsruby18' on ip-10-202-163-143 (pid:14769)
>2013-02-01 05:59:16.301 [DEBUG] DEBUG: rpc_exec_direct: rpc_client=#<MCollective::RPC::Client:0x00000002866698> (pid:14769)
>2013-02-01 05:59:16.302 [DEBUG] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"embedded/mysql-5.1", :action=>"move", :args=>"'510b9f3b99' 'qgong14' '510b9f3b998a4012070004e2'"}, ip-10-202-163-143, {'identity' => ip-10-202-163-143}) (pid:14769)
>2013-02-01 05:59:57.118 [DEBUG] DEBUG: [#<MCollective::RPC::Result:0x000000028b9eb0 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-202-163-143", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"APP_INFO: Connection URL: mysql://127.2.3.129:3306/\n", :exitcode=>0}}>] (pid:14769)
>2013-02-01 05:59:57.119 [DEBUG] DEBUG: Performing cartridge level post-move for embedded mysql-5.1 for 'qsruby18' on ip-10-202-163-143 (pid:14769)
>2013-02-01 05:59:57.122 [DEBUG] DEBUG: rpc_exec_direct: rpc_client=#<MCollective::RPC::Client:0x00000002915080> (pid:14769)
>2013-02-01 05:59:57.122 [DEBUG] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"embedded/mysql-5.1", :action=>"post-move", :args=>"'510b9f3b99' 'qgong14' '510b9f3b998a4012070004e2'"}, ip-10-202-163-143, {'identity' => ip-10-202-163-143}) (pid:14769)
>2013-02-01 06:00:34.232 [DEBUG] DEBUG: [#<MCollective::RPC::Result:0x000000029655a8 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-202-163-143", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"", :exitcode=>0}}>] (pid:14769)
>2013-02-01 06:00:34.348 [DEBUG] DEBUG: rpc_exec_direct: rpc_client=#<MCollective::RPC::Client:0x000000046942a0> (pid:14769)
>2013-02-01 06:00:34.349 [DEBUG] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"openshift-origin-node", :action=>"expose-port", :args=>{"--with-app-uuid"=>"510b9ef7998a4012070004bd", "--with-container-uuid"=>"510b9f3b998a4012070004e2", "--cart-name"=>"mysql-5.1"}}, ip-10-202-163-143, {'identity' => ip-10-202-163-143}) (pid:14769)
>2013-02-01 06:00:34.658 [DEBUG] DEBUG: [#<MCollective::RPC::Result:0x00000005a1d970 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-202-163-143", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"", :exitcode=>0}}>] (pid:14769)
>2013-02-01 06:00:34.670 [DEBUG] DEBUG: Starting cartridge 'mysql-5.1' in 'qsruby18' after move on ip-10-202-163-143 (pid:14769)
>2013-02-01 06:00:34.671 [DEBUG] DEBUG: rpc_exec_direct: rpc_client=#<MCollective::RPC::Client:0x000000063920f0> (pid:14769)
>2013-02-01 06:00:34.671 [DEBUG] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"mysql-5.1", :action=>"start", :args=>"'510b9f3b99' 'qgong14' '510b9f3b998a4012070004e2'"}, ip-10-202-163-143, {'identity' => ip-10-202-163-143}) (pid:14769)
>2013-02-01 06:00:36.507 [DEBUG] DEBUG: [#<MCollective::RPC::Result:0x00000006694078 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-202-163-143", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"", :exitcode=>0}}>] (pid:14769)
>2013-02-01 06:00:36.508 [DEBUG] DEBUG: Fixing DNS and mongo for gear '510b9f3b99' after move (pid:14769)
>2013-02-01 06:00:36.508 [DEBUG] DEBUG: Changing server identity of '510b9f3b99' from 'ip-10-203-71-151' to 'ip-10-202-163-143' (pid:14769)
>2013-02-01 06:00:36.510 [DEBUG] DEBUG: DYNECT Login with path: /REST/Session/ (pid:14769)
>2013-02-01 06:00:38.416 [DEBUG] DEBUG: DYNECT Response: {"status": "success", "data": {"token": "vcf6QiOrDo18+lH3MUOoJ4Qz8uOnUMQNJ64+3LZrv2IiabB3eGElaBR0IffBj51FVQsiCCVfYfqsOoQIF698K/msTNmi1Zo0eogRWu7V2/hma1Et1ECsfZnhjfasW+9j25seVxTPUxjTW3PukQEthR3W6ExhtVcx", "version": "3.3.7"}, "job_id": 260857975, "msgs": [{"INFO": "login: Login successful", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:14769)
>2013-02-01 06:00:38.417 [DEBUG] DEBUG: DYNECT Response data: {"token"=>"vcf6QiOrDo18+lH3MUOoJ4Qz8uOnUMQNJ64+3LZrv2IiabB3eGElaBR0IffBj51FVQsiCCVfYfqsOoQIF698K/msTNmi1Zo0eogRWu7V2/hma1Et1ECsfZnhjfasW+9j25seVxTPUxjTW3PukQEthR3W6ExhtVcx", "version"=>"3.3.7"} (pid:14769)
>2013-02-01 06:00:38.480 [DEBUG] DEBUG: Public ip being modified 'ec2-23-23-47-117.compute-1.amazonaws.com' to app '510b9f3b99' (pid:14769)
>2013-02-01 06:00:38.480 [DEBUG] DEBUG: DYNECT put/post with path: /REST/CNAMERecord/rhcloud.com/510b9f3b99-qgong14.dev.rhcloud.com/ json data: {"rdata":{"cname":"ec2-23-23-47-117.compute-1.amazonaws.com"},"ttl":"60"} and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:14769)
>2013-02-01 06:00:39.178 [DEBUG] DEBUG: DYNECT Response: {"status": "success", "data": {"zone": "rhcloud.com", "ttl": 60, "fqdn": "510b9f3b99-qgong14.dev.rhcloud.com", "record_type": "CNAME", "rdata": {"cname": "ec2-23-23-47-117.compute-1.amazonaws.com."}, "record_id": 0}, "job_id": 260857989, "msgs": [{"INFO": "update: Record updated", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:14769)
>2013-02-01 06:00:39.179 [DEBUG] DEBUG: DYNECT Response data: {"zone"=>"rhcloud.com", "ttl"=>60, "fqdn"=>"510b9f3b99-qgong14.dev.rhcloud.com", "record_type"=>"CNAME", "rdata"=>{"cname"=>"ec2-23-23-47-117.compute-1.amazonaws.com."}, "record_id"=>0} (pid:14769)
>2013-02-01 06:00:39.179 [DEBUG] DEBUG: DYNECT put/post with path: /REST/Zone/rhcloud.com/ json data: {"publish":"true"} and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:14769)
>2013-02-01 06:00:42.719 [DEBUG] DEBUG: DYNECT Response: {"status": "success", "data": {"zone_type": "Primary", "serial_style": "increment", "serial": 4216738, "zone": "rhcloud.com"}, "job_id": 260857998, "msgs": [{"INFO": "publish: rhcloud.com published", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:14769)
>2013-02-01 06:00:42.719 [DEBUG] DEBUG: DYNECT Response data: {"zone_type"=>"Primary", "serial_style"=>"increment", "serial"=>4216738, "zone"=>"rhcloud.com"} (pid:14769)
>2013-02-01 06:00:42.719 [DEBUG] DEBUG: DYNECT delete with path: /REST/Session/ and headers: {"Content-Type"=>"application/json", "Auth-Token"=>"[hidden]"} (pid:14769)
>2013-02-01 06:00:43.136 [DEBUG] DEBUG: DYNECT Response: {"status": "success", "data": {}, "job_id": 260858025, "msgs": [{"INFO": "logout: Logout successful", "SOURCE": "BLL", "ERR_CD": null, "LVL": "INFO"}]} (pid:14769)
>2013-02-01 06:00:43.137 [DEBUG] DEBUG: DYNECT Response data: {} (pid:14769)
>2013-02-01 06:00:43.137 [DEBUG] Running publishers (pid:14769)
>2013-02-01 06:00:43.925 [DEBUG] DEBUG: Output of parallel execute: [{:tag=>"510b9f4c998a4012070004f7", :gear=>"510b9f3b998a4012070004e2", :job=>{:cartridge=>"openshift-origin-node", :action=>"connector-execute", :args=>{"--gear-uuid"=>"510b9f3b998a4012070004e2", "--cart-name"=>"mysql-5.1", "--hook-name"=>"publish-db-connection-info", "--input-args"=>"510b9f3b99 qgong14 510b9f3b998a4012070004e2"}}, :result_stdout=>"OPENSHIFT_MYSQL_DB_GEAR_UUID=510b9f3b998a4012070004e2; OPENSHIFT_MYSQL_DB_GEAR_DNS=510b9f3b99-qgong14.dev.rhcloud.com; OPENSHIFT_MYSQL_DB_USERNAME=adminy63B4aM; OPENSHIFT_MYSQL_DB_PASSWORD=gusNun_6v4qH; OPENSHIFT_MYSQL_DB_HOST=510b9f3b99-qgong14.dev.rhcloud.com; OPENSHIFT_MYSQL_DB_PORT=38321; OPENSHIFT_MYSQL_DB_URL=mysql://adminy63B4aM:gusNun_6v4qH@510b9f3b99-qgong14.dev.rhcloud.com:38321/; \n", :result_stderr=>"", :result_exit_code=>0}, {:tag=>"510b9f4c998a4012070004f8", :gear=>"510b9ef7998a4012070004bd", :job=>{:cartridge=>"openshift-origin-node", :action=>"connector-execute", :args=>{"--gear-uuid"=>"510b9ef7998a4012070004bd", "--cart-name"=>"ruby-1.8", "--hook-name"=>"publish-http-url", "--input-args"=>"qsruby18 qgong14 510b9ef7998a4012070004bd"}}, :result_stdout=>"qsruby18-qgong14.dev.rhcloud.com|10.203.71.151:38316\n", :result_stderr=>"", :result_exit_code=>0}, {:tag=>"510b9f4c998a4012070004f9", :gear=>"510b9ef7998a4012070004bd", :job=>{:cartridge=>"openshift-origin-node", :action=>"connector-execute", :args=>{"--gear-uuid"=>"510b9ef7998a4012070004bd", "--cart-name"=>"ruby-1.8", "--hook-name"=>"publish-gear-endpoint", "--input-args"=>"qsruby18 qgong14 510b9ef7998a4012070004bd"}}, :result_stdout=>"510b9ef7998a4012070004bd@10.203.71.151:ruby-1.8;qsruby18-qgong14.dev.rhcloud.com\n", :result_stderr=>"", :result_exit_code=>0}, {:tag=>"510b9f4c998a4012070004fa", :gear=>"510b9f3b998a4012070004e2", :job=>{:cartridge=>"openshift-origin-node", :action=>"connector-execute", :args=>{"--gear-uuid"=>"510b9f3b998a4012070004e2", "--cart-name"=>"mysql-5.1", "--hook-name"=>"publish-db-connection-info", "--input-args"=>"510b9f3b99 qgong14 510b9f3b998a4012070004e2"}}, :result_stdout=>"OPENSHIFT_MYSQL_DB_GEAR_UUID=510b9f3b998a4012070004e2; OPENSHIFT_MYSQL_DB_GEAR_DNS=510b9f3b99-qgong14.dev.rhcloud.com; OPENSHIFT_MYSQL_DB_USERNAME=adminy63B4aM; OPENSHIFT_MYSQL_DB_PASSWORD=gusNun_6v4qH; OPENSHIFT_MYSQL_DB_HOST=510b9f3b99-qgong14.dev.rhcloud.com; OPENSHIFT_MYSQL_DB_PORT=38321; OPENSHIFT_MYSQL_DB_URL=mysql://adminy63B4aM:gusNun_6v4qH@510b9f3b99-qgong14.dev.rhcloud.com:38321/; \n", :result_stderr=>"", :result_exit_code=>0}], exitcode: 0, from: ip-10-203-71-151 (pid:14769)
>2013-02-01 06:00:43.926 [DEBUG] Running subscribers (pid:14769)
>2013-02-01 06:00:43.927 [DEBUG] Output of publisher - '{"510b9f4c998a4012070004f7"=>["'510b9f3b998a4012070004e2'='OPENSHIFT_MYSQL_DB_GEAR_UUID=510b9f3b998a4012070004e2; OPENSHIFT_MYSQL_DB_GEAR_DNS=510b9f3b99-qgong14.dev.rhcloud.com; OPENSHIFT_MYSQL_DB_USERNAME=adminy63B4aM; OPENSHIFT_MYSQL_DB_PASSWORD=gusNun_6v4qH; OPENSHIFT_MYSQL_DB_HOST=510b9f3b99-qgong14.dev.rhcloud.com; OPENSHIFT_MYSQL_DB_PORT=38321; OPENSHIFT_MYSQL_DB_URL=mysql://adminy63B4aM:gusNun_6v4qH@510b9f3b99-qgong14.dev.rhcloud.com:38321/; \n'"], "510b9f4c998a4012070004f8"=>["'510b9ef7998a4012070004bd'='qsruby18-qgong14.dev.rhcloud.com|10.203.71.151:38316\n'"], "510b9f4c998a4012070004f9"=>["'510b9ef7998a4012070004bd'='510b9ef7998a4012070004bd@10.203.71.151:ruby-1.8;qsruby18-qgong14.dev.rhcloud.com\n'"], "510b9f4c998a4012070004fa"=>["'510b9f3b998a4012070004e2'='OPENSHIFT_MYSQL_DB_GEAR_UUID=510b9f3b998a4012070004e2; OPENSHIFT_MYSQL_DB_GEAR_DNS=510b9f3b99-qgong14.dev.rhcloud.com; OPENSHIFT_MYSQL_DB_USERNAME=adminy63B4aM; OPENSHIFT_MYSQL_DB_PASSWORD=gusNun_6v4qH; OPENSHIFT_MYSQL_DB_HOST=510b9f3b99-qgong14.dev.rhcloud.com; OPENSHIFT_MYSQL_DB_PORT=38321; OPENSHIFT_MYSQL_DB_URL=mysql://adminy63B4aM:gusNun_6v4qH@510b9f3b99-qgong14.dev.rhcloud.com:38321/; \n'"]}' (pid:14769)
>2013-02-01 06:00:43.931 [DEBUG] Output of publisher - '{"510b9f4c998a4012070004f7"=>["'510b9f3b998a4012070004e2'='OPENSHIFT_MYSQL_DB_GEAR_UUID=510b9f3b998a4012070004e2; OPENSHIFT_MYSQL_DB_GEAR_DNS=510b9f3b99-qgong14.dev.rhcloud.com; OPENSHIFT_MYSQL_DB_USERNAME=adminy63B4aM; OPENSHIFT_MYSQL_DB_PASSWORD=gusNun_6v4qH; OPENSHIFT_MYSQL_DB_HOST=510b9f3b99-qgong14.dev.rhcloud.com; OPENSHIFT_MYSQL_DB_PORT=38321; OPENSHIFT_MYSQL_DB_URL=mysql://adminy63B4aM:gusNun_6v4qH@510b9f3b99-qgong14.dev.rhcloud.com:38321/; \n'"], "510b9f4c998a4012070004f8"=>["'510b9ef7998a4012070004bd'='qsruby18-qgong14.dev.rhcloud.com|10.203.71.151:38316\n'"], "510b9f4c998a4012070004f9"=>["'510b9ef7998a4012070004bd'='510b9ef7998a4012070004bd@10.203.71.151:ruby-1.8;qsruby18-qgong14.dev.rhcloud.com\n'"], "510b9f4c998a4012070004fa"=>["'510b9f3b998a4012070004e2'='OPENSHIFT_MYSQL_DB_GEAR_UUID=510b9f3b998a4012070004e2; OPENSHIFT_MYSQL_DB_GEAR_DNS=510b9f3b99-qgong14.dev.rhcloud.com; OPENSHIFT_MYSQL_DB_USERNAME=adminy63B4aM; OPENSHIFT_MYSQL_DB_PASSWORD=gusNun_6v4qH; OPENSHIFT_MYSQL_DB_HOST=510b9f3b99-qgong14.dev.rhcloud.com; OPENSHIFT_MYSQL_DB_PORT=38321; OPENSHIFT_MYSQL_DB_URL=mysql://adminy63B4aM:gusNun_6v4qH@510b9f3b99-qgong14.dev.rhcloud.com:38321/; \n'"]}' (pid:14769)
>2013-02-01 06:00:43.935 [DEBUG] Output of publisher - '{"510b9f4c998a4012070004f7"=>["'510b9f3b998a4012070004e2'='OPENSHIFT_MYSQL_DB_GEAR_UUID=510b9f3b998a4012070004e2; OPENSHIFT_MYSQL_DB_GEAR_DNS=510b9f3b99-qgong14.dev.rhcloud.com; OPENSHIFT_MYSQL_DB_USERNAME=adminy63B4aM; OPENSHIFT_MYSQL_DB_PASSWORD=gusNun_6v4qH; OPENSHIFT_MYSQL_DB_HOST=510b9f3b99-qgong14.dev.rhcloud.com; OPENSHIFT_MYSQL_DB_PORT=38321; OPENSHIFT_MYSQL_DB_URL=mysql://adminy63B4aM:gusNun_6v4qH@510b9f3b99-qgong14.dev.rhcloud.com:38321/; \n'"], "510b9f4c998a4012070004f8"=>["'510b9ef7998a4012070004bd'='qsruby18-qgong14.dev.rhcloud.com|10.203.71.151:38316\n'"], "510b9f4c998a4012070004f9"=>["'510b9ef7998a4012070004bd'='510b9ef7998a4012070004bd@10.203.71.151:ruby-1.8;qsruby18-qgong14.dev.rhcloud.com\n'"], "510b9f4c998a4012070004fa"=>["'510b9f3b998a4012070004e2'='OPENSHIFT_MYSQL_DB_GEAR_UUID=510b9f3b998a4012070004e2; OPENSHIFT_MYSQL_DB_GEAR_DNS=510b9f3b99-qgong14.dev.rhcloud.com; OPENSHIFT_MYSQL_DB_USERNAME=adminy63B4aM; OPENSHIFT_MYSQL_DB_PASSWORD=gusNun_6v4qH; OPENSHIFT_MYSQL_DB_HOST=510b9f3b99-qgong14.dev.rhcloud.com; OPENSHIFT_MYSQL_DB_PORT=38321; OPENSHIFT_MYSQL_DB_URL=mysql://adminy63B4aM:gusNun_6v4qH@510b9f3b99-qgong14.dev.rhcloud.com:38321/; \n'"]}' (pid:14769)
>2013-02-01 06:00:43.939 [DEBUG] Output of publisher - '{"510b9f4c998a4012070004f7"=>["'510b9f3b998a4012070004e2'='OPENSHIFT_MYSQL_DB_GEAR_UUID=510b9f3b998a4012070004e2; OPENSHIFT_MYSQL_DB_GEAR_DNS=510b9f3b99-qgong14.dev.rhcloud.com; OPENSHIFT_MYSQL_DB_USERNAME=adminy63B4aM; OPENSHIFT_MYSQL_DB_PASSWORD=gusNun_6v4qH; OPENSHIFT_MYSQL_DB_HOST=510b9f3b99-qgong14.dev.rhcloud.com; OPENSHIFT_MYSQL_DB_PORT=38321; OPENSHIFT_MYSQL_DB_URL=mysql://adminy63B4aM:gusNun_6v4qH@510b9f3b99-qgong14.dev.rhcloud.com:38321/; \n'"], "510b9f4c998a4012070004f8"=>["'510b9ef7998a4012070004bd'='qsruby18-qgong14.dev.rhcloud.com|10.203.71.151:38316\n'"], "510b9f4c998a4012070004f9"=>["'510b9ef7998a4012070004bd'='510b9ef7998a4012070004bd@10.203.71.151:ruby-1.8;qsruby18-qgong14.dev.rhcloud.com\n'"], "510b9f4c998a4012070004fa"=>["'510b9f3b998a4012070004e2'='OPENSHIFT_MYSQL_DB_GEAR_UUID=510b9f3b998a4012070004e2; OPENSHIFT_MYSQL_DB_GEAR_DNS=510b9f3b99-qgong14.dev.rhcloud.com; OPENSHIFT_MYSQL_DB_USERNAME=adminy63B4aM; OPENSHIFT_MYSQL_DB_PASSWORD=gusNun_6v4qH; OPENSHIFT_MYSQL_DB_HOST=510b9f3b99-qgong14.dev.rhcloud.com; OPENSHIFT_MYSQL_DB_PORT=38321; OPENSHIFT_MYSQL_DB_URL=mysql://adminy63B4aM:gusNun_6v4qH@510b9f3b99-qgong14.dev.rhcloud.com:38321/; \n'"]}' (pid:14769)
>2013-02-01 06:00:54.626 [DEBUG] DEBUG: Output of parallel execute: [{:tag=>"", :gear=>"510b9ef7998a4012070004bd", :job=>{:cartridge=>"openshift-origin-node", :action=>"connector-execute", :args=>{"--gear-uuid"=>"510b9ef7998a4012070004bd", "--cart-name"=>"ruby-1.8", "--hook-name"=>"set-db-connection-info", "--input-args"=>"qsruby18 qgong14 510b9ef7998a4012070004bd \\'510b9f3b998a4012070004e2\\'\\=\\'OPENSHIFT_MYSQL_DB_GEAR_UUID\\=510b9f3b998a4012070004e2\\;\\ OPENSHIFT_MYSQL_DB_GEAR_DNS\\=510b9f3b99-qgong14.dev.rhcloud.com\\;\\ OPENSHIFT_MYSQL_DB_USERNAME\\=adminy63B4aM\\;\\ OPENSHIFT_MYSQL_DB_PASSWORD\\=gusNun_6v4qH\\;\\ OPENSHIFT_MYSQL_DB_HOST\\=510b9f3b99-qgong14.dev.rhcloud.com\\;\\ OPENSHIFT_MYSQL_DB_PORT\\=38321\\;\\ OPENSHIFT_MYSQL_DB_URL\\=mysql://adminy63B4aM:gusNun_6v4qH@510b9f3b99-qgong14.dev.rhcloud.com:38321/\\;\\ '\n'\\'"}}, :result_stdout=>"", :result_stderr=>"", :result_exit_code=>0}, {:tag=>"", :gear=>"510b9ef7998a4012070004bd", :job=>{:cartridge=>"openshift-origin-node", :action=>"connector-execute", :args=>{"--gear-uuid"=>"510b9ef7998a4012070004bd", "--cart-name"=>"haproxy-1.4", "--hook-name"=>"set-proxy", "--input-args"=>"qsruby18 qgong14 510b9ef7998a4012070004bd \\'510b9ef7998a4012070004bd\\'\\=\\'qsruby18-qgong14.dev.rhcloud.com\\|10.203.71.151:38316'\n'\\'"}}, :result_stdout=>"Fri Feb  1 06:00:46 EST 2013: Conditionally reloading HAProxy service \n", :result_stderr=>"", :result_exit_code=>0}, {:tag=>"", :gear=>"510b9ef7998a4012070004bd", :job=>{:cartridge=>"openshift-origin-node", :action=>"connector-execute", :args=>{"--gear-uuid"=>"510b9ef7998a4012070004bd", "--cart-name"=>"haproxy-1.4", "--hook-name"=>"set-gear-endpoints", "--input-args"=>"qsruby18 qgong14 510b9ef7998a4012070004bd \\'510b9ef7998a4012070004bd\\'\\=\\'510b9ef7998a4012070004bd@10.203.71.151:ruby-1.8\\;qsruby18-qgong14.dev.rhcloud.com'\n'\\'"}}, :result_stdout=>"Fri Feb  1 06:00:46 EST 2013: Conditionally reloading HAProxy service \n", :result_stderr=>"", :result_exit_code=>0}, {:tag=>"", :gear=>"510b9ef7998a4012070004bd", :job=>{:cartridge=>"openshift-origin-node", :action=>"connector-execute", :args=>{"--gear-uuid"=>"510b9ef7998a4012070004bd", "--cart-name"=>"haproxy-1.4", "--hook-name"=>"set-db-connection-info", "--input-args"=>"qsruby18 qgong14 510b9ef7998a4012070004bd \\'510b9f3b998a4012070004e2\\'\\=\\'OPENSHIFT_MYSQL_DB_GEAR_UUID\\=510b9f3b998a4012070004e2\\;\\ OPENSHIFT_MYSQL_DB_GEAR_DNS\\=510b9f3b99-qgong14.dev.rhcloud.com\\;\\ OPENSHIFT_MYSQL_DB_USERNAME\\=adminy63B4aM\\;\\ OPENSHIFT_MYSQL_DB_PASSWORD\\=gusNun_6v4qH\\;\\ OPENSHIFT_MYSQL_DB_HOST\\=510b9f3b99-qgong14.dev.rhcloud.com\\;\\ OPENSHIFT_MYSQL_DB_PORT\\=38321\\;\\ OPENSHIFT_MYSQL_DB_URL\\=mysql://adminy63B4aM:gusNun_6v4qH@510b9f3b99-qgong14.dev.rhcloud.com:38321/\\;\\ '\n'\\'"}}, :result_stdout=>"", :result_stderr=>"", :result_exit_code=>0}], exitcode: 0, from: ip-10-203-71-151 (pid:14769)
>2013-02-01 06:00:54.629 [DEBUG] Connections done (pid:14769)
>2013-02-01 06:00:54.644 [DEBUG] MOPED: 127.0.0.1:27017 UPDATE       database=openshift_broker_dev collection=applications selector={"_id"=>"510b9ef7998a4012070004bd"} update={"$set"=>{"updated_at"=>2013-02-01 11:00:54 UTC, "group_instances.1.gears.0.uid"=>1031, "group_instances.1.gears.0.server_identity"=>"ip-10-202-163-143"}} flags=[] (pid:14769)
>2013-02-01 06:00:54.644 [DEBUG] COMMAND      database=openshift_broker_dev command={:getlasterror=>1, :safe=>true} (4.2045ms) (pid:14769)
>2013-02-01 06:00:54.645 [DEBUG] DEBUG: Deconfiguring old app 'qsruby18' on ip-10-203-71-151 after move (pid:14769)
>2013-02-01 06:00:54.646 [DEBUG] DEBUG: rpc_exec_direct: rpc_client=#<MCollective::RPC::Client:0x00000006c34f28> (pid:14769)
>2013-02-01 06:00:54.646 [DEBUG] DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"openshift-origin-node", :action=>"app-destroy", :args=>{"--with-app-uuid"=>"510b9ef7998a4012070004bd", "--with-app-name"=>"qsruby18", "--with-container-uuid"=>"510b9f3b998a4012070004e2", "--with-container-name"=>"510b9f3b99", "--with-namespace"=>"qgong14", "--skip-hooks"=>true}}, ip-10-203-71-151, {'identity' => ip-10-203-71-151}) (pid:14769)
>2013-02-01 06:00:56.543 [DEBUG] DEBUG: [#<MCollective::RPC::Result:0x00000006c4b700 @agent="openshift", @action="cartridge_do", @results={:sender=>"ip-10-203-71-151", :statuscode=>0, :statusmsg=>"OK", :data=>{:time=>nil, :output=>"", :exitcode=>0}}>] (pid:14769)
>2013-02-01 06:00:56.699 [DEBUG] MOPED: 127.0.0.1:27017 COMMAND      database=openshift_broker_dev command={:findAndModify=>"districts", :query=>{"uuid"=>"510b2386998a409610000001", "available_uids"=>{"$nin"=>[1058]}}, :update=>{"$push"=>{"available_uids"=>1058}, "$inc"=>{"available_capacity"=>1}}} (18.1711ms) (pid:14769)
>2013-02-01 06:00:56.700 [DEBUG] Successfully moved 'qsruby18' with gear uuid '510b9f3b998a4012070004e2' from 'ip-10-203-71-151' to 'ip-10-202-163-143' (pid:14769)
>2013-02-01 06:00:56.702 [DEBUG] MOPED: 127.0.0.1:27017 COMMAND      database=openshift_broker_dev command={:findAndModify=>"locks", :query=>{"user_id"=>"510b2363998a40b00a000001", "locked"=>false, "app_ids"=>"510b9ef7998a4012070004bd"}, :new=>true, :update=>{"$pull"=>{:app_ids=>"510b9ef7998a4012070004bd"}}} (0.6804ms) (pid:14769)

Actions: View

Attachments on bug 906744: 691526