Attachment 675315 Details for Bug 893365 – Some line of development.log from the broker.

Some line of development.log from the broker.

upload.log (text/plain), 39.30 KB, created by Ziqian SUN (Zamir) on 2013-01-09 08:40:34 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Ziqian SUN (Zamir)

Created: 2013-01-09 08:40:34 UTC

Size: 39.30 KB

patch

obsolete

>[0;37m2013-01-08 23:38:28.671[0m [[32mINFO [0m] Started DELETE "/broker/rest/domains/del2bug/applications/tmp2" for 203.114.244.88 at 2013-01-08 23:38:28 -0500 (pid:1849)
>[0;37m2013-01-08 23:38:28.673[0m [[32mINFO [0m] Processing by ApplicationsController#destroy as JSON (pid:1849)
>[0;37m2013-01-08 23:38:28.673[0m [[32mINFO [0m] Parameters: {"domain_id"=>"del2bug", "id"=>"tmp2"} (pid:1849)
>[0;37m2013-01-08 23:38:28.677[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=cloud_users selector={"$query"=>{"login"=>"zsun@redhat.com"}, "$orderby"=>{:_id=>1}} flags=[:slave_ok] limit=-1 skip=0 fields=nil (2.7788ms) (pid:1849)
>[0;37m2013-01-08 23:38:28.677[0m [[0;37mDEBUG[0m] application/json (pid:1849)
>[0;37m2013-01-08 23:38:28.680[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=domains selector={"$query"=>{"owner_id"=>"50ecf2dec12584a408000001", "canonical_namespace"=>"del2bug"}, "$orderby"=>{:_id=>1}} flags=[:slave_ok] limit=-1 skip=0 fields=nil (2.1212ms) (pid:1849)
>[0;37m2013-01-08 23:38:28.680[0m [[0;37mDEBUG[0m] [REQ_ID=39faf7f8589e43eaa8c39138b8c161b7] ACTION=DELETE_APPLICATION Found domain del2bug (pid:1849)
>[0;37m2013-01-08 23:38:28.681[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=applications selector={"$query"=>{"domain_id"=>"50ecf2f6c12584a408000003", "canonical_name"=>"tmp2"}, "$orderby"=>{:_id=>1}} flags=[:slave_ok] limit=-1 skip=0 fields=nil (0.5136ms) (pid:1849)
>[0;37m2013-01-08 23:38:28.684[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=domains selector={"$query"=>{"_id"=>"50ecf2f6c12584a408000003"}, "$orderby"=>{:_id=>1}} flags=[:slave_ok] limit=-1 skip=0 fields=nil (2.3663ms) (pid:1849)
>[0;37m2013-01-08 23:38:28.685[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=applications selector={"domain_id"=>"50ecf2f6c12584a408000003"} flags=[:slave_ok] limit=0 skip=0 fields=nil (0.4508ms) (pid:1849)
>[0;37m2013-01-08 23:38:28.688[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 COMMAND      database=openshift_broker_dev command={:findAndModify=>"locks", :query=>{"user_id"=>"50ecf2dec12584a408000001", "app_ids"=>{"$nin"=>["50ecf3c3c12584a40800002f"]}}, :new=>true, :update=>{"$push"=>{:app_ids=>"50ecf3c3c12584a40800002f"}}} (2.1255ms) (pid:1849)
>[0;37m2013-01-08 23:38:28.688[0m [[32mINFO [0m] Completed 500 Internal Server Error in 15ms (pid:1849)
>[0;37m2013-01-08 23:38:28.694[0m [[31mFATAL[0m] RuntimeError (Unable to perform action. Another operation is already running.):
>  openshift-origin-controller (1.3.2) app/models/application.rb:980:in `run_in_application_lock'
>  openshift-origin-controller (1.3.2) app/models/application.rb:349:in `remove_features'
>  openshift-origin-controller (1.3.2) app/models/application.rb:370:in `destroy_app'
>  openshift-origin-controller (1.3.2) app/controllers/applications_controller.rb:148:in `destroy'
>  actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action'
>  actionpack (3.2.8) lib/abstract_controller/base.rb:167:in `process_action'
>  actionpack (3.2.8) lib/action_controller/metal/rendering.rb:10:in `process_action'
>  actionpack (3.2.8) lib/abstract_controller/callbacks.rb:18:in `block in process_action'
>  activesupport (3.2.8) lib/active_support/callbacks.rb:458:in `_run__4133605196173553878__process_action__1481264994224404610__callbacks'
>  activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback'
>  activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks'
>  activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks'
>  actionpack (3.2.8) lib/abstract_controller/callbacks.rb:17:in `process_action'
>  actionpack (3.2.8) lib/action_controller/metal/rescue.rb:29:in `process_action'
>  actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:30:in `block in process_action'
>  activesupport (3.2.8) lib/active_support/notifications.rb:123:in `block in instrument'
>  activesupport (3.2.8) lib/active_support/notifications/instrumenter.rb:20:in `instrument'
>  activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument'
>  actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:29:in `process_action'
>  actionpack (3.2.8) lib/action_controller/metal/params_wrapper.rb:207:in `process_action'
>  actionpack (3.2.8) lib/abstract_controller/base.rb:121:in `process'
>  actionpack (3.2.8) lib/abstract_controller/rendering.rb:45:in `process'
>  actionpack (3.2.8) lib/action_controller/metal.rb:203:in `dispatch'
>  actionpack (3.2.8) lib/action_controller/metal/rack_delegation.rb:14:in `dispatch'
>  actionpack (3.2.8) lib/action_controller/metal.rb:246:in `block in action'
>  actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `call'
>  actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `dispatch'
>  actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:36:in `call'
>  journey (1.0.4) lib/journey/router.rb:68:in `block in call'
>  journey (1.0.4) lib/journey/router.rb:56:in `each'
>  journey (1.0.4) lib/journey/router.rb:56:in `call'
>  actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:600:in `call'
>  mongo_mapper (0.11.1) lib/mongo_mapper/middleware/identity_map.rb:10:in `call'
>  mongoid (3.0.5) lib/rack/mongoid/middleware/identity_map.rb:33:in `block in call'
>  mongoid (3.0.5) lib/mongoid/unit_of_work.rb:39:in `unit_of_work'
>  mongoid (3.0.5) lib/rack/mongoid/middleware/identity_map.rb:33:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/best_standards_support.rb:17:in `call'
>  rack (1.4.1) lib/rack/etag.rb:23:in `call'
>  rack (1.4.1) lib/rack/conditionalget.rb:35:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/head.rb:14:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/params_parser.rb:21:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/flash.rb:242:in `call'
>  rack (1.4.1) lib/rack/session/abstract/id.rb:205:in `context'
>  rack (1.4.1) lib/rack/session/abstract/id.rb:200:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/cookies.rb:339:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:28:in `block in call'
>  activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `_run__3105200502800140994__call__4318741154212299024__callbacks'
>  activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback'
>  activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_call_callbacks'
>  activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks'
>  actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/remote_ip.rb:31:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call'
>  railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app'
>  railties (3.2.8) lib/rails/rack/logger.rb:16:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call'
>  rack (1.4.1) lib/rack/methodoverride.rb:21:in `call'
>  rack (1.4.1) lib/rack/runtime.rb:17:in `call'
>  activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call'
>  rack (1.4.1) lib/rack/lock.rb:15:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call'
>  rack-cache (1.2) lib/rack/cache/context.rb:136:in `forward'
>  rack-cache (1.2) lib/rack/cache/context.rb:143:in `pass'
>  rack-cache (1.2) lib/rack/cache/context.rb:155:in `invalidate'
>  rack-cache (1.2) lib/rack/cache/context.rb:71:in `call!'
>  rack-cache (1.2) lib/rack/cache/context.rb:51:in `call'
>  railties (3.2.8) lib/rails/engine.rb:479:in `call'
>  railties (3.2.8) lib/rails/application.rb:223:in `call'
>  railties (3.2.8) lib/rails/railtie/configurable.rb:30:in `method_missing'
>  passenger (3.0.12) lib/phusion_passenger/rack/request_handler.rb:96:in `process_request'
>  passenger (3.0.12) lib/phusion_passenger/abstract_request_handler.rb:514:in `accept_and_process_next_request'
>  passenger (3.0.12) lib/phusion_passenger/abstract_request_handler.rb:274:in `main_loop'
>  passenger (3.0.12) lib/phusion_passenger/rack/application_spawner.rb:206:in `start_request_handler'
>  passenger (3.0.12) lib/phusion_passenger/rack/application_spawner.rb:79:in `block in spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/utils.rb:479:in `safe_fork'
>  passenger (3.0.12) lib/phusion_passenger/rack/application_spawner.rb:64:in `spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/spawn_manager.rb:264:in `spawn_rack_application'
>  passenger (3.0.12) lib/phusion_passenger/spawn_manager.rb:137:in `spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/spawn_manager.rb:275:in `handle_spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/abstract_server.rb:357:in `server_main_loop'
>  passenger (3.0.12) lib/phusion_passenger/abstract_server.rb:206:in `start_synchronously'
>  passenger (3.0.12) helper-scripts/passenger-spawn-server:102:in `<main>' (pid:1849)
>[0;37m2013-01-08 23:38:28.718[0m [[32mINFO [0m] Rendered /opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.5ms) (pid:1849)
>[0;37m2013-01-08 23:38:28.728[0m [[32mINFO [0m] Rendered /opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.2ms) (pid:1849)
>[0;37m2013-01-08 23:38:28.728[0m [[32mINFO [0m] Rendered /opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (18.2ms) (pid:1849)
>[0;37m2013-01-08 23:38:35.284[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 203.114.244.88 at 2013-01-08 23:38:35 -0500 (pid:1849)
>[0;37m2013-01-08 23:38:35.285[0m [[32mINFO [0m] Processing by BaseController#show as JSON (pid:1849)
>[0;37m2013-01-08 23:38:35.285[0m [[0;37mDEBUG[0m] application/json (pid:1849)
>[0;37m2013-01-08 23:38:35.301[0m [[32mINFO [0m] Completed 200 OK in 16ms (Views: 5.5ms) (pid:1849)
>[0;37m2013-01-08 23:38:36.533[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=cloud_users selector={"$query"=>{"login"=>"zsun@redhat.com"}, "$orderby"=>{:_id=>1}} flags=[:slave_ok] limit=-1 skip=0 fields=nil (0.8559ms) (pid:2212)
>
>
>
>
>
>
>[0;37m2013-01-08 23:38:36.533[0m [[0;37mDEBUG[0m] application/json (pid:2212)
>[0;37m2013-01-08 23:38:36.534[0m [[0;37mDEBUG[0m] Getting domains for user zsun@redhat.com (pid:2212)
>[0;37m2013-01-08 23:38:36.534[0m [[0;37mDEBUG[0m] #<Mongoid::Criteria:0x0000000336c3a8> (pid:2212)
>[0;37m2013-01-08 23:38:36.535[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=domains selector={"owner_id"=>"50ecf2dec12584a408000001"} flags=[:slave_ok] limit=0 skip=0 fields=nil (0.4566ms) (pid:2212)
>[0;37m2013-01-08 23:38:36.536[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=cloud_users selector={"$query"=>{"_id"=>"50ecf2dec12584a408000001"}, "$orderby"=>{:_id=>1}} flags=[:slave_ok] limit=-1 skip=0 fields=nil (0.4363ms) (pid:2212)
>[0;37m2013-01-08 23:38:36.537[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=domains selector={"owner_id"=>"50ecf2dec12584a408000001"} flags=[:slave_ok] limit=0 skip=0 fields=nil (0.4413ms) (pid:2212)
>[0;37m2013-01-08 23:38:36.538[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=domains selector={"user_ids"=>"50ecf2dec12584a408000001"} flags=[:slave_ok] limit=0 skip=0 fields=nil (0.2882ms) (pid:2212)
>[0;37m2013-01-08 23:38:36.541[0m [[0;37mDEBUG[0m] [REQ_ID=327fad6fce704ca99e866f3f9bbf7cfc] ACTION=LIST_DOMAINS (pid:2212)
>[0;37m2013-01-08 23:38:36.545[0m [[32mINFO [0m] Completed 200 OK in 14ms (Views: 3.3ms) (pid:2212)
>[0;37m2013-01-08 23:38:37.960[0m [[32mINFO [0m] Started GET "/broker/rest/domains/del2bug/applications" for 203.114.244.88 at 2013-01-08 23:38:37 -0500 (pid:2212)
>[0;37m2013-01-08 23:38:37.963[0m [[32mINFO [0m] Processing by ApplicationsController#index as JSON (pid:2212)
>[0;37m2013-01-08 23:38:37.963[0m [[32mINFO [0m] Parameters: {"include"=>"cartridges", "domain_id"=>"del2bug"} (pid:2212)
>[0;37m2013-01-08 23:38:37.965[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=cloud_users selector={"$query"=>{"login"=>"zsun@redhat.com"}, "$orderby"=>{:_id=>1}} flags=[:slave_ok] limit=-1 skip=0 fields=nil (0.7718ms) (pid:2212)
>[0;37m2013-01-08 23:38:37.965[0m [[0;37mDEBUG[0m] application/json (pid:2212)
>[0;37m2013-01-08 23:38:37.967[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=domains selector={"$query"=>{"owner_id"=>"50ecf2dec12584a408000001", "canonical_namespace"=>"del2bug"}, "$orderby"=>{:_id=>1}} flags=[:slave_ok] limit=-1 skip=0 fields=nil (0.5300ms) (pid:2212)
>[0;37m2013-01-08 23:38:37.968[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=applications selector={"domain_id"=>"50ecf2f6c12584a408000003"} flags=[:slave_ok] limit=0 skip=0 fields=nil (0.4313ms) (pid:2212)
>[0;37m2013-01-08 23:38:37.969[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=domains selector={"$query"=>{"_id"=>"50ecf2f6c12584a408000003"}, "$orderby"=>{:_id=>1}} flags=[:slave_ok] limit=-1 skip=0 fields=nil (0.4201ms) (pid:2212)
>[0;37m2013-01-08 23:38:37.971[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=applications selector={"domain_id"=>"50ecf2f6c12584a408000003"} flags=[:slave_ok] limit=0 skip=0 fields=nil (0.4416ms) (pid:2212)
>[0;37m2013-01-08 23:38:37.974[0m [[0;37mDEBUG[0m] [REQ_ID=26766d246058470fbbdb28b0c5a311b0] ACTION=LIST_APPLICATIONS Found 1 applications for domain 'del2bug' (pid:2212)
>[0;37m2013-01-08 23:38:37.981[0m [[32mINFO [0m] Completed 200 OK in 18ms (Views: 6.3ms) (pid:2212)
>[0;37m2013-01-08 23:38:52.375[0m [[32mINFO [0m] Started GET "/broker/rest/api" for 203.114.244.88 at 2013-01-08 23:38:52 -0500 (pid:2212)
>[0;37m2013-01-08 23:38:52.376[0m [[32mINFO [0m] Processing by BaseController#show as JSON (pid:2212)
>[0;37m2013-01-08 23:38:52.376[0m [[0;37mDEBUG[0m] application/json (pid:2212)
>[0;37m2013-01-08 23:38:52.383[0m [[32mINFO [0m] Completed 200 OK in 7ms (Views: 3.0ms) (pid:2212)
>[0;37m2013-01-08 23:38:53.542[0m [[32mINFO [0m] Started GET "/broker/rest/domains" for 203.114.244.88 at 2013-01-08 23:38:53 -0500 (pid:2212)
>[0;37m2013-01-08 23:38:53.543[0m [[32mINFO [0m] Processing by DomainsController#index as JSON (pid:2212)
>[0;37m2013-01-08 23:38:53.546[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=cloud_users selector={"$query"=>{"login"=>"zsun@redhat.com"}, "$orderby"=>{:_id=>1}} flags=[:slave_ok] limit=-1 skip=0 fields=nil (0.7224ms) (pid:2212)
>[0;37m2013-01-08 23:38:53.546[0m [[0;37mDEBUG[0m] application/json (pid:2212)
>[0;37m2013-01-08 23:38:53.546[0m [[0;37mDEBUG[0m] Getting domains for user zsun@redhat.com (pid:2212)
>[0;37m2013-01-08 23:38:53.546[0m [[0;37mDEBUG[0m] #<Mongoid::Criteria:0x0000000544d8d8> (pid:2212)
>[0;37m2013-01-08 23:38:53.547[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=domains selector={"owner_id"=>"50ecf2dec12584a408000001"} flags=[:slave_ok] limit=0 skip=0 fields=nil (0.4678ms) (pid:2212)
>[0;37m2013-01-08 23:38:53.548[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=cloud_users selector={"$query"=>{"_id"=>"50ecf2dec12584a408000001"}, "$orderby"=>{:_id=>1}} flags=[:slave_ok] limit=-1 skip=0 fields=nil (0.4928ms) (pid:2212)
>[0;37m2013-01-08 23:38:53.549[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=domains selector={"owner_id"=>"50ecf2dec12584a408000001"} flags=[:slave_ok] limit=0 skip=0 fields=nil (0.4439ms) (pid:2212)
>[0;37m2013-01-08 23:38:53.550[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=domains selector={"user_ids"=>"50ecf2dec12584a408000001"} flags=[:slave_ok] limit=0 skip=0 fields=nil (0.2754ms) (pid:2212)
>[0;37m2013-01-08 23:38:53.552[0m [[0;37mDEBUG[0m] [REQ_ID=7e23fb92484d44199a2b475d11edab8d] ACTION=LIST_DOMAINS (pid:2212)
>[0;37m2013-01-08 23:38:53.556[0m [[32mINFO [0m] Completed 200 OK in 13ms (Views: 3.1ms) (pid:2212)
>[0;37m2013-01-08 23:38:54.767[0m [[32mINFO [0m] Started GET "/broker/rest/domains/del2bug/applications" for 203.114.244.88 at 2013-01-08 23:38:54 -0500 (pid:2212)
>[0;37m2013-01-08 23:38:54.769[0m [[32mINFO [0m] Processing by ApplicationsController#index as JSON (pid:2212)
>[0;37m2013-01-08 23:38:54.769[0m [[32mINFO [0m] Parameters: {"domain_id"=>"del2bug"} (pid:2212)
>[0;37m2013-01-08 23:38:54.771[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=cloud_users selector={"$query"=>{"login"=>"zsun@redhat.com"}, "$orderby"=>{:_id=>1}} flags=[:slave_ok] limit=-1 skip=0 fields=nil (0.7858ms) (pid:2212)
>[0;37m2013-01-08 23:38:54.771[0m [[0;37mDEBUG[0m] application/json (pid:2212)
>[0;37m2013-01-08 23:38:54.772[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=domains selector={"$query"=>{"owner_id"=>"50ecf2dec12584a408000001", "canonical_namespace"=>"del2bug"}, "$orderby"=>{:_id=>1}} flags=[:slave_ok] limit=-1 skip=0 fields=nil (0.5262ms) (pid:2212)
>[0;37m2013-01-08 23:38:54.773[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=applications selector={"domain_id"=>"50ecf2f6c12584a408000003"} flags=[:slave_ok] limit=0 skip=0 fields=nil (0.4194ms) (pid:2212)
>[0;37m2013-01-08 23:38:54.775[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=domains selector={"$query"=>{"_id"=>"50ecf2f6c12584a408000003"}, "$orderby"=>{:_id=>1}} flags=[:slave_ok] limit=-1 skip=0 fields=nil (0.4144ms) (pid:2212)
>[0;37m2013-01-08 23:38:54.776[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=applications selector={"domain_id"=>"50ecf2f6c12584a408000003"} flags=[:slave_ok] limit=0 skip=0 fields=nil (0.4158ms) (pid:2212)
>[0;37m2013-01-08 23:38:54.779[0m [[0;37mDEBUG[0m] [REQ_ID=f66433cebeb84d9b85900d09c97d9e00] ACTION=LIST_APPLICATIONS Found 1 applications for domain 'del2bug' (pid:2212)
>[0;37m2013-01-08 23:38:54.786[0m [[32mINFO [0m] Completed 200 OK in 17ms (Views: 6.1ms) (pid:2212)
>[0;37m2013-01-08 23:38:55.938[0m [[32mINFO [0m] Started DELETE "/broker/rest/domains/del2bug/applications/tmp2" for 203.114.244.88 at 2013-01-08 23:38:55 -0500 (pid:2212)
>[0;37m2013-01-08 23:38:55.940[0m [[32mINFO [0m] Processing by ApplicationsController#destroy as JSON (pid:2212)
>[0;37m2013-01-08 23:38:55.940[0m [[32mINFO [0m] Parameters: {"domain_id"=>"del2bug", "id"=>"tmp2"} (pid:2212)
>[0;37m2013-01-08 23:38:55.942[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=cloud_users selector={"$query"=>{"login"=>"zsun@redhat.com"}, "$orderby"=>{:_id=>1}} flags=[:slave_ok] limit=-1 skip=0 fields=nil (0.9449ms) (pid:2212)
>[0;37m2013-01-08 23:38:55.943[0m [[0;37mDEBUG[0m] application/json (pid:2212)
>[0;37m2013-01-08 23:38:55.944[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=domains selector={"$query"=>{"owner_id"=>"50ecf2dec12584a408000001", "canonical_namespace"=>"del2bug"}, "$orderby"=>{:_id=>1}} flags=[:slave_ok] limit=-1 skip=0 fields=nil (0.5333ms) (pid:2212)
>[0;37m2013-01-08 23:38:55.944[0m [[0;37mDEBUG[0m] [REQ_ID=d74a72c939be4407994b29e794c7d5d2] ACTION=DELETE_APPLICATION Found domain del2bug (pid:2212)
>[0;37m2013-01-08 23:38:55.945[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=applications selector={"$query"=>{"domain_id"=>"50ecf2f6c12584a408000003", "canonical_name"=>"tmp2"}, "$orderby"=>{:_id=>1}} flags=[:slave_ok] limit=-1 skip=0 fields=nil (0.5095ms) (pid:2212)
>[0;37m2013-01-08 23:38:55.946[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=domains selector={"$query"=>{"_id"=>"50ecf2f6c12584a408000003"}, "$orderby"=>{:_id=>1}} flags=[:slave_ok] limit=-1 skip=0 fields=nil (0.5147ms) (pid:2212)
>[0;37m2013-01-08 23:38:55.947[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 QUERY        database=openshift_broker_dev collection=applications selector={"domain_id"=>"50ecf2f6c12584a408000003"} flags=[:slave_ok] limit=0 skip=0 fields=nil (0.4063ms) (pid:2212)
>[0;37m2013-01-08 23:38:55.948[0m [[0;37mDEBUG[0m] MOPED: 127.0.0.1:27017 COMMAND      database=openshift_broker_dev command={:findAndModify=>"locks", :query=>{"user_id"=>"50ecf2dec12584a408000001", "app_ids"=>{"$nin"=>["50ecf3c3c12584a40800002f"]}}, :new=>true, :update=>{"$push"=>{:app_ids=>"50ecf3c3c12584a40800002f"}}} (0.4156ms) (pid:2212)
>[0;37m2013-01-08 23:38:55.949[0m [[32mINFO [0m] Completed 500 Internal Server Error in 8ms (pid:2212)
>[0;37m2013-01-08 23:38:55.952[0m [[31mFATAL[0m] RuntimeError (Unable to perform action. Another operation is already running.):
>  openshift-origin-controller (1.3.2) app/models/application.rb:980:in `run_in_application_lock'
>  openshift-origin-controller (1.3.2) app/models/application.rb:349:in `remove_features'
>  openshift-origin-controller (1.3.2) app/models/application.rb:370:in `destroy_app'
>  openshift-origin-controller (1.3.2) app/controllers/applications_controller.rb:148:in `destroy'
>  actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action'
>  actionpack (3.2.8) lib/abstract_controller/base.rb:167:in `process_action'
>  actionpack (3.2.8) lib/action_controller/metal/rendering.rb:10:in `process_action'
>  actionpack (3.2.8) lib/abstract_controller/callbacks.rb:18:in `block in process_action'
>  activesupport (3.2.8) lib/active_support/callbacks.rb:458:in `_run__4133605196173553878__process_action__1481264994224404610__callbacks'
>  activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback'
>  activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks'
>  activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks'
>  actionpack (3.2.8) lib/abstract_controller/callbacks.rb:17:in `process_action'
>  actionpack (3.2.8) lib/action_controller/metal/rescue.rb:29:in `process_action'
>  actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:30:in `block in process_action'
>  activesupport (3.2.8) lib/active_support/notifications.rb:123:in `block in instrument'
>  activesupport (3.2.8) lib/active_support/notifications/instrumenter.rb:20:in `instrument'
>  activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument'
>  actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:29:in `process_action'
>  actionpack (3.2.8) lib/action_controller/metal/params_wrapper.rb:207:in `process_action'
>  actionpack (3.2.8) lib/abstract_controller/base.rb:121:in `process'
>  actionpack (3.2.8) lib/abstract_controller/rendering.rb:45:in `process'
>  actionpack (3.2.8) lib/action_controller/metal.rb:203:in `dispatch'
>  actionpack (3.2.8) lib/action_controller/metal/rack_delegation.rb:14:in `dispatch'
>  actionpack (3.2.8) lib/action_controller/metal.rb:246:in `block in action'
>  actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `call'
>  actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `dispatch'
>  actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:36:in `call'
>  journey (1.0.4) lib/journey/router.rb:68:in `block in call'
>  journey (1.0.4) lib/journey/router.rb:56:in `each'
>  journey (1.0.4) lib/journey/router.rb:56:in `call'
>  actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:600:in `call'
>  mongo_mapper (0.11.1) lib/mongo_mapper/middleware/identity_map.rb:10:in `call'
>  mongoid (3.0.5) lib/rack/mongoid/middleware/identity_map.rb:33:in `block in call'
>  mongoid (3.0.5) lib/mongoid/unit_of_work.rb:39:in `unit_of_work'
>  mongoid (3.0.5) lib/rack/mongoid/middleware/identity_map.rb:33:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/best_standards_support.rb:17:in `call'
>  rack (1.4.1) lib/rack/etag.rb:23:in `call'
>  rack (1.4.1) lib/rack/conditionalget.rb:35:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/head.rb:14:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/params_parser.rb:21:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/flash.rb:242:in `call'
>  rack (1.4.1) lib/rack/session/abstract/id.rb:205:in `context'
>  rack (1.4.1) lib/rack/session/abstract/id.rb:200:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/cookies.rb:339:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:28:in `block in call'
>  activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `_run__3105200502800140994__call__4318741154212299024__callbacks'
>  activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback'
>  activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_call_callbacks'
>  activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks'
>  actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/remote_ip.rb:31:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call'
>  railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app'
>  railties (3.2.8) lib/rails/rack/logger.rb:16:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call'
>  rack (1.4.1) lib/rack/methodoverride.rb:21:in `call'
>  rack (1.4.1) lib/rack/runtime.rb:17:in `call'
>  activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call'
>  rack (1.4.1) lib/rack/lock.rb:15:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call'
>  rack-cache (1.2) lib/rack/cache/context.rb:136:in `forward'
>  rack-cache (1.2) lib/rack/cache/context.rb:143:in `pass'
>  rack-cache (1.2) lib/rack/cache/context.rb:155:in `invalidate'
>  rack-cache (1.2) lib/rack/cache/context.rb:71:in `call!'
>  rack-cache (1.2) lib/rack/cache/context.rb:51:in `call'
>  railties (3.2.8) lib/rails/engine.rb:479:in `call'
>  railties (3.2.8) lib/rails/application.rb:223:in `call'
>  railties (3.2.8) lib/rails/railtie/configurable.rb:30:in `method_missing'
>  passenger (3.0.12) lib/phusion_passenger/rack/request_handler.rb:96:in `process_request'
>  passenger (3.0.12) lib/phusion_passenger/abstract_request_handler.rb:514:in `accept_and_process_next_request'
>  passenger (3.0.12) lib/phusion_passenger/abstract_request_handler.rb:274:in `main_loop'
>  passenger (3.0.12) lib/phusion_passenger/rack/application_spawner.rb:206:in `start_request_handler'
>  passenger (3.0.12) lib/phusion_passenger/rack/application_spawner.rb:79:in `block in spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/utils.rb:479:in `safe_fork'
>  passenger (3.0.12) lib/phusion_passenger/rack/application_spawner.rb:64:in `spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/spawn_manager.rb:264:in `spawn_rack_application'
>  passenger (3.0.12) lib/phusion_passenger/spawn_manager.rb:137:in `spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/spawn_manager.rb:275:in `handle_spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/abstract_server.rb:357:in `server_main_loop'
>  passenger (3.0.12) lib/phusion_passenger/abstract_server.rb:206:in `start_synchronously'
>  passenger (3.0.12) helper-scripts/passenger-spawn-server:102:in `<main>' (pid:2212)
>[0;37m2013-01-08 23:38:55.967[0m [[32mINFO [0m] Rendered /opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.5ms) (pid:2212)
>[0;37m2013-01-08 23:38:55.971[0m [[32mINFO [0m] Rendered /opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.0ms) (pid:2212)
>[0;37m2013-01-08 23:38:55.971[0m [[32mINFO [0m] Rendered /opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (11.1ms) (pid:2212)
>[0;37m2013-01-08 23:38:56.338[0m [[32mINFO [0m] Started POST "/broker/rest/user" for 66.187.233.202 at 2013-01-08 23:38:56 -0500 (pid:2212)
>[0;37m2013-01-08 23:38:56.358[0m [[31mFATAL[0m] ActionController::RoutingError (No route matches [POST] "/rest/user"):
>  actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:21:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call'
>  railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app'
>  railties (3.2.8) lib/rails/rack/logger.rb:16:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call'
>  rack (1.4.1) lib/rack/methodoverride.rb:21:in `call'
>  rack (1.4.1) lib/rack/runtime.rb:17:in `call'
>  activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call'
>  rack (1.4.1) lib/rack/lock.rb:15:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call'
>  rack-cache (1.2) lib/rack/cache/context.rb:136:in `forward'
>  rack-cache (1.2) lib/rack/cache/context.rb:143:in `pass'
>  rack-cache (1.2) lib/rack/cache/context.rb:155:in `invalidate'
>  rack-cache (1.2) lib/rack/cache/context.rb:71:in `call!'
>  rack-cache (1.2) lib/rack/cache/context.rb:51:in `call'
>  railties (3.2.8) lib/rails/engine.rb:479:in `call'
>  railties (3.2.8) lib/rails/application.rb:223:in `call'
>  railties (3.2.8) lib/rails/railtie/configurable.rb:30:in `method_missing'
>  passenger (3.0.12) lib/phusion_passenger/rack/request_handler.rb:96:in `process_request'
>  passenger (3.0.12) lib/phusion_passenger/abstract_request_handler.rb:514:in `accept_and_process_next_request'
>  passenger (3.0.12) lib/phusion_passenger/abstract_request_handler.rb:274:in `main_loop'
>  passenger (3.0.12) lib/phusion_passenger/rack/application_spawner.rb:206:in `start_request_handler'
>  passenger (3.0.12) lib/phusion_passenger/rack/application_spawner.rb:79:in `block in spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/utils.rb:479:in `safe_fork'
>  passenger (3.0.12) lib/phusion_passenger/rack/application_spawner.rb:64:in `spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/spawn_manager.rb:264:in `spawn_rack_application'
>  passenger (3.0.12) lib/phusion_passenger/spawn_manager.rb:137:in `spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/spawn_manager.rb:275:in `handle_spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/abstract_server.rb:357:in `server_main_loop'
>  passenger (3.0.12) lib/phusion_passenger/abstract_server.rb:206:in `start_synchronously'
>  passenger (3.0.12) helper-scripts/passenger-spawn-server:102:in `<main>' (pid:2212)
>[0;37m2013-01-08 23:38:56.418[0m [[32mINFO [0m] Rendered /opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/routing_error.erb within rescues/layout (0.6ms) (pid:2212)
>[0;37m2013-01-08 23:39:03.972[0m [[32mINFO [0m] Started POST "/broker/rest/user" for 66.187.233.202 at 2013-01-08 23:39:03 -0500 (pid:2212)
>[0;37m2013-01-08 23:39:03.974[0m [[31mFATAL[0m] ActionController::RoutingError (No route matches [POST] "/rest/user"):
>  actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:21:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call'
>  railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app'
>  railties (3.2.8) lib/rails/rack/logger.rb:16:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call'
>  rack (1.4.1) lib/rack/methodoverride.rb:21:in `call'
>  rack (1.4.1) lib/rack/runtime.rb:17:in `call'
>  activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call'
>  rack (1.4.1) lib/rack/lock.rb:15:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call'
>  rack-cache (1.2) lib/rack/cache/context.rb:136:in `forward'
>  rack-cache (1.2) lib/rack/cache/context.rb:143:in `pass'
>  rack-cache (1.2) lib/rack/cache/context.rb:155:in `invalidate'
>  rack-cache (1.2) lib/rack/cache/context.rb:71:in `call!'
>  rack-cache (1.2) lib/rack/cache/context.rb:51:in `call'
>  railties (3.2.8) lib/rails/engine.rb:479:in `call'
>  railties (3.2.8) lib/rails/application.rb:223:in `call'
>  railties (3.2.8) lib/rails/railtie/configurable.rb:30:in `method_missing'
>  passenger (3.0.12) lib/phusion_passenger/rack/request_handler.rb:96:in `process_request'
>  passenger (3.0.12) lib/phusion_passenger/abstract_request_handler.rb:514:in `accept_and_process_next_request'
>  passenger (3.0.12) lib/phusion_passenger/abstract_request_handler.rb:274:in `main_loop'
>  passenger (3.0.12) lib/phusion_passenger/rack/application_spawner.rb:206:in `start_request_handler'
>  passenger (3.0.12) lib/phusion_passenger/rack/application_spawner.rb:79:in `block in spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/utils.rb:479:in `safe_fork'
>  passenger (3.0.12) lib/phusion_passenger/rack/application_spawner.rb:64:in `spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/spawn_manager.rb:264:in `spawn_rack_application'
>  passenger (3.0.12) lib/phusion_passenger/spawn_manager.rb:137:in `spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/spawn_manager.rb:275:in `handle_spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/abstract_server.rb:357:in `server_main_loop'
>  passenger (3.0.12) lib/phusion_passenger/abstract_server.rb:206:in `start_synchronously'
>  passenger (3.0.12) helper-scripts/passenger-spawn-server:102:in `<main>' (pid:2212)
>[0;37m2013-01-08 23:39:03.981[0m [[32mINFO [0m] Rendered /opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/routing_error.erb within rescues/layout (0.7ms) (pid:2212)
>[0;37m2013-01-08 23:39:07.584[0m [[32mINFO [0m] Started POST "/broker/rest/users" for 66.187.233.202 at 2013-01-08 23:39:07 -0500 (pid:2212)
>[0;37m2013-01-08 23:39:07.586[0m [[31mFATAL[0m] ActionController::RoutingError (No route matches [POST] "/rest/users"):
>  actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:21:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call'
>  railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app'
>  railties (3.2.8) lib/rails/rack/logger.rb:16:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call'
>  rack (1.4.1) lib/rack/methodoverride.rb:21:in `call'
>  rack (1.4.1) lib/rack/runtime.rb:17:in `call'
>  activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call'
>  rack (1.4.1) lib/rack/lock.rb:15:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call'
>  rack-cache (1.2) lib/rack/cache/context.rb:136:in `forward'
>  rack-cache (1.2) lib/rack/cache/context.rb:143:in `pass'
>  rack-cache (1.2) lib/rack/cache/context.rb:155:in `invalidate'
>  rack-cache (1.2) lib/rack/cache/context.rb:71:in `call!'
>  rack-cache (1.2) lib/rack/cache/context.rb:51:in `call'
>  railties (3.2.8) lib/rails/engine.rb:479:in `call'
>  railties (3.2.8) lib/rails/application.rb:223:in `call'
>  railties (3.2.8) lib/rails/railtie/configurable.rb:30:in `method_missing'
>  passenger (3.0.12) lib/phusion_passenger/rack/request_handler.rb:96:in `process_request'
>  passenger (3.0.12) lib/phusion_passenger/abstract_request_handler.rb:514:in `accept_and_process_next_request'
>  passenger (3.0.12) lib/phusion_passenger/abstract_request_handler.rb:274:in `main_loop'
>  passenger (3.0.12) lib/phusion_passenger/rack/application_spawner.rb:206:in `start_request_handler'
>  passenger (3.0.12) lib/phusion_passenger/rack/application_spawner.rb:79:in `block in spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/utils.rb:479:in `safe_fork'
>  passenger (3.0.12) lib/phusion_passenger/rack/application_spawner.rb:64:in `spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/spawn_manager.rb:264:in `spawn_rack_application'
>  passenger (3.0.12) lib/phusion_passenger/spawn_manager.rb:137:in `spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/spawn_manager.rb:275:in `handle_spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/abstract_server.rb:357:in `server_main_loop'
>  passenger (3.0.12) lib/phusion_passenger/abstract_server.rb:206:in `start_synchronously'
>  passenger (3.0.12) helper-scripts/passenger-spawn-server:102:in `<main>' (pid:2212)
>[0;37m2013-01-08 23:39:07.592[0m [[32mINFO [0m] Rendered /opt/rh/ruby193/root/usr/share/gems/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/routing_error.erb within rescues/layout (0.7ms) (pid:2212)
>[0;37m2013-01-08 23:39:30.724[0m [[32mINFO [0m] Started GET "/broker/rest/users" for 66.187.233.202 at 2013-01-08 23:39:30 -0500 (pid:2212)
>[0;37m2013-01-08 23:39:30.726[0m [[31mFATAL[0m] ActionController::RoutingError (No route matches [GET] "/rest/users"):
>  actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:21:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call'
>  railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app'
>  railties (3.2.8) lib/rails/rack/logger.rb:16:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call'
>  rack (1.4.1) lib/rack/methodoverride.rb:21:in `call'
>  rack (1.4.1) lib/rack/runtime.rb:17:in `call'
>  activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call'
>  rack (1.4.1) lib/rack/lock.rb:15:in `call'
>  actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call'
>  rack-cache (1.2) lib/rack/cache/context.rb:136:in `forward'
>  rack-cache (1.2) lib/rack/cache/context.rb:245:in `fetch'
>  rack-cache (1.2) lib/rack/cache/context.rb:185:in `lookup'
>  rack-cache (1.2) lib/rack/cache/context.rb:66:in `call!'
>  rack-cache (1.2) lib/rack/cache/context.rb:51:in `call'
>  railties (3.2.8) lib/rails/engine.rb:479:in `call'
>  railties (3.2.8) lib/rails/application.rb:223:in `call'
>  railties (3.2.8) lib/rails/railtie/configurable.rb:30:in `method_missing'
>  passenger (3.0.12) lib/phusion_passenger/rack/request_handler.rb:96:in `process_request'
>  passenger (3.0.12) lib/phusion_passenger/abstract_request_handler.rb:514:in `accept_and_process_next_request'
>  passenger (3.0.12) lib/phusion_passenger/abstract_request_handler.rb:274:in `main_loop'
>  passenger (3.0.12) lib/phusion_passenger/rack/application_spawner.rb:206:in `start_request_handler'
>  passenger (3.0.12) lib/phusion_passenger/rack/application_spawner.rb:79:in `block in spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/utils.rb:479:in `safe_fork'
>  passenger (3.0.12) lib/phusion_passenger/rack/application_spawner.rb:64:in `spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/spawn_manager.rb:264:in `spawn_rack_application'
>  passenger (3.0.12) lib/phusion_passenger/spawn_manager.rb:137:in `spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/spawn_manager.rb:275:in `handle_spawn_application'
>  passenger (3.0.12) lib/phusion_passenger/abstract_server.rb:357:in `server_main_loop'
>  passenger (3.0.12) lib/phusion_passenger/abstract_server.rb:206:in `start_synchronously'
>  passenger (3.0.12) helper-scripts/passenger-spawn-server:102:in `<main>' (pid:2212)

Actions: View

Attachments on bug 893365: 675315