Attachment 636427 Details for Bug 872026 – development.log

development.log

file_872026.txt (text/plain), 9.95 KB, created by Rony Gong 🔥 on 2012-11-01 03:07:02 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Rony Gong 🔥

Created: 2012-11-01 03:07:02 UTC

Size: 9.95 KB

patch

obsolete

>28300] WARN  DEPRECATION WARNING: config.action_view.debug_rjs will be removed in 3.1, from 3.1 onwards you will need to install prototype-rails to continue to use RJS templates . (called from /var/www/openshift/broker/config/environment.rb:14)
>[28300] DEBUG MongoDataStore.find_by_gear_uuid(51d037d22f054848908ec767372e7c07)
>[28300] DEBUG DEBUG: Source district uuid: 87d0722a9ee346449d6400d1b9f65aca
>[28300] DEBUG DEBUG: Destination district uuid: 5483f4a5cee34a40a7fec62130f490af
>[28300] DEBUG CURRENT SERVER: ip-10-122-102-153
>[28300] DEBUG DEBUG: find_one_impl: current_server: ip-10-122-102-153
>[28300] DEBUG DEBUG: rpc_exec_direct: rpc_client=#<MCollective::RPC::Client:0x7ff2d98d0aa8>
>[28300] DEBUG DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"openshift-origin-node", :args=>{"--with-descriptors"=>true, "--porcelain"=>true}, :action=>"cartridge-list"}, @id, {'identity' => @id})
>[28300] DEBUG DEBUG: Getting existing app 'qzend' status before moving
>[28300] DEBUG DEBUG: rpc_exec_direct: rpc_client=#<MCollective::RPC::Client:0x7ff2d9cfc028>
>[28300] DEBUG DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"zend-5.6", :args=>"'qzend' 'qgong14' '51d037d22f054848908ec767372e7c07'", :action=>"status"}, @id, {'identity' => @id})
>[28300] DEBUG DEBUG: [#<MCollective::RPC::Result:0x7ff2d9cd89e8 @agent="openshift", @action="cartridge_do", @results={:data=>{:exitcode=>0, :output=>"CLIENT_RESULT: Total Accesses: 0\nCLIENT_RESULT: Total kBytes: 0\nCLIENT_RESULT: Uptime: 77\nCLIENT_RESULT: ReqPerSec: 0\nCLIENT_RESULT: BytesPerSec: 0\nCLIENT_RESULT: BusyWorkers: 1\nCLIENT_RESULT: IdleWorkers: 0\nCLIENT_RESULT: Scoreboard: W....\nATTR: quota_blocks=1048576\nATTR: quota_files=40000\n"}, :statusmsg=>"OK", :statuscode=>0, :sender=>"ip-10-122-102-153"}>]
>[28300] DEBUG DEBUG: Cartridge command zend-5.6::status exitcode = 0
>[28300] DEBUG DEBUG: Gear component 'zend-5.6' was running
>[28300] DEBUG DEBUG: Stopping existing app cartridge 'zend-5.6' before moving
>[28300] DEBUG DEBUG: rpc_exec_direct: rpc_client=#<MCollective::RPC::Client:0x7ff2d9cd1aa8>
>[28300] DEBUG DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"zend-5.6", :args=>"'qzend' 'qgong14' '51d037d22f054848908ec767372e7c07'", :action=>"stop"}, @id, {'identity' => @id})
>[28300] DEBUG DEBUG: [#<MCollective::RPC::Result:0x7ff2d9caebc0 @agent="openshift", @action="cartridge_do", @results={:data=>{:exitcode=>0, :output=>"Stopping Deployment \e[32m[OK]\e[0m\nStopping Zend Server Monitor node \e[32m[OK]\e[0m\nWaiting for stop to finish\nStopping JobQueue \e[32m[OK]\e[0m\nStopping Zend Server GUI [Lighttpd] \e[32m[OK]\e[0m\nATTR: status=ALREADY_STOPPED\n"}, :statusmsg=>"OK", :statuscode=>0, :sender=>"ip-10-122-102-153"}>]
>[28300] DEBUG DEBUG: Cartridge command zend-5.6::stop exitcode = 0
>[28300] DEBUG DEBUG: Force stopping existing app cartridge 'zend-5.6' before moving
>[28300] DEBUG DEBUG: rpc_exec_direct: rpc_client=#<MCollective::RPC::Client:0x7ff2d9ca9a80>
>[28300] DEBUG DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"zend-5.6", :args=>"'qzend' 'qgong14' '51d037d22f054848908ec767372e7c07'", :action=>"force-stop"}, @id, {'identity' => @id})
>[28300] DEBUG DEBUG: [#<MCollective::RPC::Result:0x7ff2d9c890a0 @agent="openshift", @action="cartridge_do", @results={:data=>{:exitcode=>0, :output=>""}, :statusmsg=>"OK", :statuscode=>0, :sender=>"ip-10-122-102-153"}>]
>[28300] DEBUG DEBUG: Cartridge command zend-5.6::force-stop exitcode = 0
>[28300] DEBUG MongoDataStore.reserve_district_uid(5483f4a5cee34a40a7fec62130f490af)
>[28300] DEBUG DEBUG: Reserved uid '1009' on district: '5483f4a5cee34a40a7fec62130f490af'
>[28300] DEBUG DEBUG: Creating new account for gear 'qzend' on ip-10-93-5-25
>[28300] DEBUG DEBUG: rpc_exec_direct: rpc_client=#<MCollective::RPC::Client:0x7ff2d9c7c468>
>[28300] DEBUG DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"openshift-origin-node", :args=>{"--with-container-uuid"=>"51d037d22f054848908ec767372e7c07", "--with-uid"=>1009, "--with-namespace"=>"qgong14", "--with-quota-blocks"=>"1048576", "--with-container-name"=>"qzend", "--with-app-name"=>"qzend", "--with-quota-files"=>"40000", "--with-app-uuid"=>"51d037d22f054848908ec767372e7c07"}, :action=>"app-create"}, @id, {'identity' => @id})
>[28300] DEBUG DEBUG: [#<MCollective::RPC::Result:0x7ff2d9c5c618 @agent="openshift", @action="cartridge_do", @results={:data=>{:exitcode=>0, :output=>""}, :statusmsg=>"OK", :statuscode=>0, :sender=>"ip-10-93-5-25"}>]
>[28300] DEBUG DEBUG: Moving content for app 'qzend', gear 'qzend' to ip-10-93-5-25
>[28300] DEBUG Agent pid 28959
>unset SSH_AUTH_SOCK;
>unset SSH_AGENT_PID;
>echo Agent pid 28959 killed;
>[28300] DEBUG DEBUG: Performing cartridge level move for 'zend-5.6' on ip-10-93-5-25
>[28300] DEBUG DEBUG: rpc_exec_direct: rpc_client=#<MCollective::RPC::Client:0x7ff2d9c1e5c0>
>[28300] DEBUG DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"zend-5.6", :args=>"'qzend' 'qgong14' '51d037d22f054848908ec767372e7c07'", :action=>"move"}, @id, {'identity' => @id})
>[28300] DEBUG DEBUG: [#<MCollective::RPC::Result:0x7ff2d9c01330 @agent="openshift", @action="cartridge_do", @results={:data=>{:exitcode=>0, :output=>"Nothing found in .openshift/config/* to redeploy\nFILES_DIR=/usr/libexec/openshift/cartridges/zend-5.6/files/user-files CART_DIR=/var/lib/openshift/51d037d22f054848908ec767372e7c07//zend-5.6 USER_ID=1009 GROUP_ID=1009 IP_ADDRESS=127.1.248.129\nConfiguring zend server on move\n"}, :statusmsg=>"OK", :statuscode=>0, :sender=>"ip-10-93-5-25"}>]
>[28300] DEBUG DEBUG: Cartridge command zend-5.6::move exitcode = 0
>[28300] DEBUG DEBUG: Starting cartridge 'zend-5.6' in 'qzend' after move on ip-10-93-5-25
>[28300] DEBUG DEBUG: rpc_exec_direct: rpc_client=#<MCollective::RPC::Client:0x7ff2d9bfc150>
>[28300] DEBUG DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"zend-5.6", :args=>"'qzend' 'qgong14' '51d037d22f054848908ec767372e7c07'", :action=>"start"}, @id, {'identity' => @id})
>[28300] DEBUG DEBUG: [#<MCollective::RPC::Result:0x7ff2d9bde5d8 @agent="openshift", @action="cartridge_do", @results={:data=>{:exitcode=>121, :output=>"Starting Deployment \e[32m[OK]\e[0m\n[31.10.2012 23:06:10 SYSTEM] watchdog for zdd is running. \n[31.10.2012 23:06:10 SYSTEM] zdd is running. \nStarting Zend Server Monitor node \e[32m[OK]\e[0m\n[31.10.2012 23:06:12 SYSTEM] watchdog for monitor is running. \n[31.10.2012 23:06:12 SYSTEM] monitor is running. \n(13)Permission denied: make_sock: could not bind to address 127.1.247.129:16083\nno listening sockets available, shutting down\nUnable to open logs\nFailed to start zend-5.6\n"}, :statusmsg=>"cartridge_do_action failed 121. Output Starting Deployment \e[32m[OK]\e[0m\n[31.10.2012 23:06:10 SYSTEM] watchdog for zdd is running. \n[31.10.2012 23:06:10 SYSTEM] zdd is running. \nStarting Zend Server Monitor node \e[32m[OK]\e[0m\n[31.10.2012 23:06:12 SYSTEM] watchdog for monitor is running. \n[31.10.2012 23:06:12 SYSTEM] monitor is running. \n(13)Permission denied: make_sock: could not bind to address 127.1.247.129:16083\nno listening sockets available, shutting down\nUnable to open logs\nFailed to start zend-5.6\n", :statuscode=>1, :sender=>"ip-10-93-5-25"}>]
>[28300] DEBUG DEBUG: Cartridge command zend-5.6::start exitcode = 121
>[28300] DEBUG DEBUG: Moving failed.  Rolling back gear 'qzend' 'qzend' with remove-httpd-proxy on 'ip-10-93-5-25'
>[28300] DEBUG DEBUG: rpc_exec_direct: rpc_client=#<MCollective::RPC::Client:0x7ff2d9bd9a88>
>[28300] DEBUG DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"zend-5.6", :args=>"'qzend' 'qgong14' '51d037d22f054848908ec767372e7c07'", :action=>"remove-httpd-proxy"}, @id, {'identity' => @id})
>[28300] DEBUG DEBUG: [#<MCollective::RPC::Result:0x7ff2d9bbc370 @agent="openshift", @action="cartridge_do", @results={:data=>{:exitcode=>0, :output=>""}, :statusmsg=>"OK", :statuscode=>0, :sender=>"ip-10-93-5-25"}>]
>[28300] DEBUG DEBUG: Cartridge command zend-5.6::remove-httpd-proxy exitcode = 0
>[28300] DEBUG DEBUG: Moving failed.  Rolling back gear 'qzend' in 'qzend' with destroy on 'ip-10-93-5-25'
>[28300] DEBUG DEBUG: rpc_exec_direct: rpc_client=#<MCollective::RPC::Client:0x7ff2d9bb79d8>
>[28300] DEBUG DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"openshift-origin-node", :args=>{"--with-container-uuid"=>"51d037d22f054848908ec767372e7c07", "--with-namespace"=>"qgong14", "--with-container-name"=>"qzend", "--with-app-name"=>"qzend", "--with-app-uuid"=>"51d037d22f054848908ec767372e7c07", "--skip-hooks"=>true}, :action=>"app-destroy"}, @id, {'identity' => @id})
>[28300] DEBUG DEBUG: [#<MCollective::RPC::Result:0x7ff2d9b9a950 @agent="openshift", @action="cartridge_do", @results={:data=>{:exitcode=>0, :output=>""}, :statusmsg=>"OK", :statuscode=>0, :sender=>"ip-10-93-5-25"}>]
>[28300] DEBUG MongoDataStore.unreserve_district_uid(5483f4a5cee34a40a7fec62130f490af)
>[28300] DEBUG DEBUG: rpc_exec_direct: rpc_client=#<MCollective::RPC::Client:0x7ff2d9b742c8>
>[28300] DEBUG DEBUG: rpc_client.custom_request('cartridge_do', {:cartridge=>"zend-5.6", :args=>"'qzend' 'qgong14' '51d037d22f054848908ec767372e7c07'", :action=>"start"}, @id, {'identity' => @id})
>[28300] DEBUG DEBUG: [#<MCollective::RPC::Result:0x7ff2d9b55198 @agent="openshift", @action="cartridge_do", @results={:data=>{:exitcode=>0, :output=>"Starting Deployment \e[32m[OK]\e[0m\n[31.10.2012 23:06:16 SYSTEM] watchdog for zdd is running. \n[31.10.2012 23:06:16 SYSTEM] zdd is running. \nStarting Zend Server Monitor node \e[32m[OK]\e[0m\n[31.10.2012 23:06:17 SYSTEM] watchdog for monitor is running. \n[31.10.2012 23:06:17 SYSTEM] monitor is running. \nStarting JobQueue \e[32m[OK]\e[0m\n[31.10.2012 23:06:19 SYSTEM] watchdog for jqd is running. \n[31.10.2012 23:06:19 SYSTEM] jqd is running. \nspawn-fcgi: child spawned successfully: PID: 29237\nStarting Zend Server GUI [Lighttpd] \e[32m[OK]\e[0m\n[31.10.2012 23:06:21 SYSTEM] watchdog for lighttpd is running. \n[31.10.2012 23:06:21 SYSTEM] lighttpd is running. \n"}, :statusmsg=>"OK", :statuscode=>0, :sender=>"ip-10-122-102-153"}>]
>[28300] DEBUG DEBUG: Cartridge command zend-5.6::start exitcode = 0

Actions: View

Attachments on bug 872026: 636427 | 646193