Started GET "/hosts/network-test.pcable.loc/edit" for 172.25.59.144 at Tue Jun 04 17:08:09 -0400 2013

Processing by HostsController#edit as HTML

Parameters: {"id"=>"network-test.pcable.loc"}

User Load (0.8ms) SELECT "users".* FROM "users" WHERE "users"."id" = $1 LIMIT 1 [["id", 2]]

Setting current user thread-local variable to cable

Host::Managed Load (1.2ms) SELECT "hosts".* FROM "hosts" WHERE "hosts"."type" IN ('Host::Managed') AND "hosts"."name" = 'network-test.pcable.loc' LIMIT 1

Environment Load (0.6ms) SELECT "environments".* FROM "environments" WHERE "environments"."id" = 2 ORDER BY environments.name LIMIT 1

Architecture Load (0.5ms) SELECT "architectures".* FROM "architectures" WHERE "architectures"."id" = 1 LIMIT 1

Domain Load (0.6ms) SELECT "domains".* FROM "domains" WHERE "domains"."id" = 1 ORDER BY domains.name LIMIT 1

Operatingsystem Load (0.9ms) SELECT "operatingsystems".* FROM "operatingsystems" WHERE "operatingsystems"."id" = 3 ORDER BY LOWER(operatingsystems.name) LIMIT 1

Medium Load (0.6ms) SELECT "media".* FROM "media" WHERE "media"."id" = 8 ORDER BY media.name LIMIT 1

Rendered hosts/_progress.erb (1.0ms)

Setting current organization thread-local variable to none

Setting current location thread-local variable to none

(1.0ms) SELECT COUNT(*) FROM "smart_proxies" INNER JOIN "features_smart_proxies" ON "features_smart_proxies"."smart_proxy_id" = "smart_proxies"."id" INNER JOIN "features" ON "features"."id" = "features_smart_proxies"."feature_id" WHERE "features"."name" = 'Puppet'

ComputeResource Load (0.8ms) SELECT "compute_resources".* FROM "compute_resources" ORDER BY type, name

(0.8ms) SELECT COUNT(*) FROM "hostgroups" INNER JOIN "user_hostgroups" ON "hostgroups"."id" = "user_hostgroups"."hostgroup_id" WHERE "user_hostgroups"."user_id" = 2 AND (1=1)

Hostgroup Load (0.8ms) SELECT "hostgroups".* FROM "hostgroups" WHERE (1=1)

Environment Load (0.6ms) SELECT "environments".* FROM "environments" ORDER BY environments.name

(0.9ms) SELECT COUNT(*) FROM "smart_proxies" INNER JOIN "features_smart_proxies" ON "features_smart_proxies"."smart_proxy_id" = "smart_proxies"."id" INNER JOIN "features" ON "features"."id" = "features_smart_proxies"."feature_id" WHERE "features"."name" = 'Puppet CA'

SmartProxy Load (0.8ms) SELECT "smart_proxies".* FROM "smart_proxies" INNER JOIN "features_smart_proxies" ON "features_smart_proxies"."smart_proxy_id" = "smart_proxies"."id" INNER JOIN "features" ON "features"."id" = "features_smart_proxies"."feature_id" WHERE "features"."name" = 'Puppet CA' ORDER BY smart_proxies.name

CACHE (0.0ms) SELECT COUNT(*) FROM "smart_proxies" INNER JOIN "features_smart_proxies" ON "features_smart_proxies"."smart_proxy_id" = "smart_proxies"."id" INNER JOIN "features" ON "features"."id" = "features_smart_proxies"."feature_id" WHERE "features"."name" = 'Puppet'

SmartProxy Load (0.8ms) SELECT "smart_proxies".* FROM "smart_proxies" INNER JOIN "features_smart_proxies" ON "features_smart_proxies"."smart_proxy_id" = "smart_proxies"."id" INNER JOIN "features" ON "features"."id" = "features_smart_proxies"."feature_id" WHERE "features"."name" = 'Puppet' ORDER BY smart_proxies.name

Puppetclass Load (0.7ms) SELECT "puppetclasses".* FROM "puppetclasses" INNER JOIN "host_classes" ON "puppetclasses"."id" = "host_classes"."puppetclass_id" WHERE "host_classes"."host_id" = 76 ORDER BY puppetclasses.name

Rendered puppetclasses/_selectedClasses.html.erb (4.5ms)

Hostgroup Load (0.8ms) SELECT "hostgroups".* FROM "hostgroups" WHERE "hostgroups"."id" = 7 AND (1=1) LIMIT 1

Puppetclass Load (1.3ms) SELECT "puppetclasses".* FROM "puppetclasses" INNER JOIN "hostgroup_classes" ON "hostgroup_classes"."puppetclass_id" = "puppetclasses"."id" INNER JOIN "hostgroups" ON "hostgroups"."id" = "hostgroup_classes"."hostgroup_id" WHERE "hostgroups"."id" IN (6, 7) ORDER BY puppetclasses.name

CACHE (0.0ms) SELECT "puppetclasses".* FROM "puppetclasses" INNER JOIN "hostgroup_classes" ON "hostgroup_classes"."puppetclass_id" = "puppetclasses"."id" INNER JOIN "hostgroups" ON "hostgroups"."id" = "hostgroup_classes"."hostgroup_id" WHERE "hostgroups"."id" IN (6, 7) ORDER BY puppetclasses.name

Puppetclass Load (2.7ms) SELECT DISTINCT "puppetclasses".* FROM "puppetclasses" INNER JOIN "environment_classes" ON "puppetclasses"."id" = "environment_classes"."puppetclass_id" WHERE "environment_classes"."environment_id" = 2 ORDER BY puppetclasses.name

Rendered puppetclasses/_classes.html.erb (405.6ms)

Rendered puppetclasses/_class_selection.html.erb (637.3ms)

ComputeResource Load (1.0ms) SELECT "compute_resources".* FROM "compute_resources" WHERE "compute_resources"."id" = 2 ORDER BY compute_resources.name LIMIT 1

Rendered compute_resources_vms/form/vmware/_network.html.erb (619.3ms)

Rendered compute_resources_vms/form/vmware/_network.html.erb (610.6ms)

Rendered compute_resources_vms/form/vmware/_volume.html.erb (384.9ms)

Rendered compute_resources_vms/form/vmware/_volume.html.erb (385.1ms)

Rendered compute_resources_vms/form/_vmware.html.erb (5010.7ms)

Rendered hosts/_compute.html.erb (5329.9ms)

Domain Load (0.6ms) SELECT "domains".* FROM "domains" INNER JOIN "user_domains" ON "domains"."id" = "user_domains"."domain_id" WHERE "user_domains"."user_id" = 2 ORDER BY domains.name

Domain Load (0.4ms) SELECT "domains".* FROM "domains" ORDER BY domains.name

(0.7ms) SELECT COUNT(*) FROM "subnets" INNER JOIN "subnet_domains" ON "subnets"."id" = "subnet_domains"."subnet_id" WHERE "subnet_domains"."domain_id" = 1

CACHE (0.0ms) SELECT COUNT(*) FROM "subnets" INNER JOIN "subnet_domains" ON "subnets"."id" = "subnet_domains"."subnet_id" WHERE "subnet_domains"."domain_id" = 1

Subnet Load (0.9ms) SELECT "subnets".* FROM "subnets" INNER JOIN "subnet_domains" ON "subnets"."id" = "subnet_domains"."subnet_id" WHERE "subnet_domains"."domain_id" = 1 ORDER BY vlanid

Rendered common/_domain.html.erb (19.9ms)

Nic::Base Load (0.5ms) SELECT "nics".* FROM "nics" WHERE "nics"."host_id" = 76

CACHE (0.0ms) SELECT "domains".* FROM "domains" ORDER BY domains.name

CACHE (0.0ms) SELECT "domains".* FROM "domains" ORDER BY domains.name

CACHE (0.0ms) SELECT "domains".* FROM "domains" ORDER BY domains.name

Rendered hosts/_interfaces.html.erb (153.4ms)

Architecture Load (0.6ms) SELECT "architectures".* FROM "architectures"

Operatingsystem Load (0.8ms) SELECT "operatingsystems".* FROM "operatingsystems" INNER JOIN "architectures_operatingsystems" ON "operatingsystems"."id" = "architectures_operatingsystems"."operatingsystem_id" WHERE "architectures_operatingsystems"."architecture_id" = 1 ORDER BY LOWER(operatingsystems.name)

Rendered common/os_selection/_architecture.html.erb (8.7ms)

Medium Load (0.7ms) SELECT "media".* FROM "media" INNER JOIN "media_operatingsystems" ON "media"."id" = "media_operatingsystems"."medium_id" WHERE "media_operatingsystems"."operatingsystem_id" = 3 ORDER BY media.name

Ptable Load (1.0ms) SELECT "ptables".* FROM "ptables" INNER JOIN "operatingsystems_ptables" ON "ptables"."id" = "operatingsystems_ptables"."ptable_id" WHERE "operatingsystems_ptables"."operatingsystem_id" = 3 ORDER BY LOWER(ptables.name)

Rendered common/os_selection/_operatingsystem.html.erb (24.1ms)

Rendered hosts/_operating_system.html.erb (45.8ms)

Rendered hosts/_unattended.html.erb (5585.4ms)

CACHE (0.0ms) SELECT "puppetclasses".* FROM "puppetclasses" INNER JOIN "hostgroup_classes" ON "hostgroup_classes"."puppetclass_id" = "puppetclasses"."id" INNER JOIN "hostgroups" ON "hostgroups"."id" = "hostgroup_classes"."hostgroup_id" WHERE "hostgroups"."id" IN (6, 7) ORDER BY puppetclasses.name

(0.9ms) SELECT COUNT(*) AS count_all, puppetclass_id AS puppetclass_id FROM "lookup_keys" WHERE "lookup_keys"."puppetclass_id" IN (45, 21, 28, 37, 81, 53, 26, 91) GROUP BY puppetclass_id

(1.1ms) SELECT COUNT(*) AS count_all, environment_classes.puppetclass_id AS environment_classes_puppetclass_id FROM "lookup_keys" INNER JOIN "environment_classes" ON "environment_classes"."lookup_key_id" = "lookup_keys"."id" WHERE "environment_classes"."puppetclass_id" IN (45, 21, 28, 37, 81, 53, 26, 91) GROUP BY environment_classes.puppetclass_id

LookupKey Load (1.6ms) SELECT DISTINCT "lookup_keys".* FROM "lookup_keys" INNER JOIN "environment_classes" ON "lookup_keys"."id" = "environment_classes"."lookup_key_id" WHERE "environment_classes"."puppetclass_id" = 91 AND "lookup_keys"."override" = 't' AND "environment_classes"."environment_id" = 2 AND (environment_classes.lookup_key_id is NOT NULL) ORDER BY lookup_keys.key

LookupKey Load (0.5ms) SELECT "lookup_keys".* FROM "lookup_keys" WHERE "lookup_keys"."puppetclass_id" = 91 ORDER BY lookup_keys.key

(0.4ms) SELECT "host_classes"."puppetclass_id" FROM "host_classes" WHERE "host_classes"."host_id" = 76

(0.5ms) SELECT "hostgroup_classes"."puppetclass_id" FROM "hostgroup_classes" WHERE "hostgroup_classes"."hostgroup_id" IN (6, 7)

Setting Load (0.7ms) SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'remove_classes_not_in_environment' ORDER BY name LIMIT 1

SQL (1.4ms) SELECT "lookup_keys"."id" AS t0_r0, "lookup_keys"."key" AS t0_r1, "lookup_keys"."created_at" AS t0_r2, "lookup_keys"."updated_at" AS t0_r3, "lookup_keys"."puppetclass_id" AS t0_r4, "lookup_keys"."default_value" AS t0_r5, "lookup_keys"."path" AS t0_r6, "lookup_keys"."description" AS t0_r7, "lookup_keys"."validator_type" AS t0_r8, "lookup_keys"."validator_rule" AS t0_r9, "lookup_keys"."is_param" AS t0_r10, "lookup_keys"."key_type" AS t0_r11, "lookup_keys"."override" AS t0_r12, "lookup_keys"."required" AS t0_r13, "lookup_keys"."lookup_values_count" AS t0_r14, "environment_classes"."id" AS t1_r0, "environment_classes"."puppetclass_id" AS t1_r1, "environment_classes"."environment_id" AS t1_r2, "environment_classes"."lookup_key_id" AS t1_r3 FROM "lookup_keys" INNER JOIN "environment_classes" ON "environment_classes"."lookup_key_id" = "lookup_keys"."id" WHERE "lookup_keys"."override" = 't' AND "environment_classes"."puppetclass_id" IN (91, 45, 28, 37, 81, 53, 26, 21) AND "environment_classes"."environment_id" = 2 ORDER BY lookup_keys.key

Setting Load (0.7ms) SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'Default_variables_Lookup_Path' ORDER BY name LIMIT 1

Setting Load (0.5ms) SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'host_group_matchers_inheritance' ORDER BY name LIMIT 1

LookupValue Load (0.5ms) SELECT "lookup_values".* FROM "lookup_values" WHERE "lookup_values"."match" = 'fqdn=network-test.pcable.loc' AND "lookup_values"."lookup_key_id" IN (186, 184, 190, 189, 185, 191, 188, 183)

LookupValue Load (0.5ms) SELECT "lookup_values".* FROM "lookup_values" WHERE "lookup_values"."match" = 'hostgroup=Uncommon/ldap-svr' AND "lookup_values"."lookup_key_id" IN (186, 184, 190, 189, 185, 191, 188, 183)

LookupValue Load (0.5ms) SELECT "lookup_values".* FROM "lookup_values" WHERE "lookup_values"."match" = 'hostgroup=Uncommon' AND "lookup_values"."lookup_key_id" IN (186, 184, 190, 189, 185, 191, 188, 183)

LookupValue Load (0.5ms) SELECT "lookup_values".* FROM "lookup_values" WHERE "lookup_values"."match" = 'os=RedHat 6.4' AND "lookup_values"."lookup_key_id" IN (186, 184, 190, 189, 185, 191, 188, 183)

LookupValue Load (0.5ms) SELECT "lookup_values".* FROM "lookup_values" WHERE "lookup_values"."match" = 'domain=pcable.loc' AND "lookup_values"."lookup_key_id" IN (186, 184, 190, 189, 185, 191, 188, 183)

Rendered puppetclasses/_class_parameters.html.erb (79.4ms)

Rendered puppetclasses/_classes_parameters.html.erb (236.4ms)

Setting current location thread-local variable to none

Setting current organization thread-local variable to none

Rendered hosts/_form.html.erb (6560.3ms)

Rendered hosts/edit.html.erb within layouts/application (6564.9ms)

Operation FAILED: undefined method `[]' for nil:NilClass

/usr/share/foreman/app/helpers/lookup_keys_helper.rb:84:in `host_key_with_diagnostic'

/usr/share/foreman/app/views/puppetclasses/_class_parameters.html.erb:11:in `_app_views_puppetclasses__class_parameters_html_erb___567630206_69831470105780'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/core_ext/module/delegation.rb:139:in `each_with_index'

/usr/share/foreman/app/views/puppetclasses/_class_parameters.html.erb:3:in `each'

/usr/share/foreman/app/views/puppetclasses/_class_parameters.html.erb:3:in `each_with_index'

/usr/share/foreman/app/views/puppetclasses/_class_parameters.html.erb:3:in `_app_views_puppetclasses__class_parameters_html_erb___567630206_69831470105780'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/template.rb:145:in `send'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/template.rb:145:in `render'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/notifications.rb:125:in `instrument'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/template.rb:143:in `render'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/partial_renderer.rb:351:in `collection_with_template'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/partial_renderer.rb:348:in `each'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/partial_renderer.rb:348:in `collection_with_template'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/partial_renderer.rb:250:in `render_collection'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/partial_renderer.rb:234:in `render'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/abstract_renderer.rb:38:in `instrument'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/notifications.rb:123:in `instrument'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/notifications/instrumenter.rb:20:in `instrument'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/notifications.rb:123:in `instrument'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/abstract_renderer.rb:38:in `instrument'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/partial_renderer.rb:233:in `render'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/renderer.rb:41:in `render_partial'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/renderer.rb:15:in `render'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/helpers/rendering_helper.rb:24:in `render'

/usr/share/foreman/app/views/puppetclasses/_classes_parameters.html.erb:12:in `_app_views_puppetclasses__classes_parameters_html_erb___669378442_69831470394760'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/template.rb:145:in `send'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/template.rb:145:in `render'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/notifications.rb:125:in `instrument'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/template.rb:143:in `render'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/partial_renderer.rb:265:in `render_partial'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/partial_renderer.rb:238:in `render'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/abstract_renderer.rb:38:in `instrument'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/notifications.rb:123:in `instrument'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/notifications/instrumenter.rb:20:in `instrument'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/notifications.rb:123:in `instrument'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/abstract_renderer.rb:38:in `instrument'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/partial_renderer.rb:237:in `render'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/renderer.rb:41:in `render_partial'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/helpers/rendering_helper.rb:27:in `render'

/usr/share/foreman/app/views/hosts/_form.html.erb:83:in `_app_views_hosts__form_html_erb___1255002788_69831471003620'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/helpers/capture_helper.rb:40:in `capture'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/helpers/capture_helper.rb:187:in `with_output_buffer'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/helpers/capture_helper.rb:40:in `capture'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/helpers/form_helper.rb:378:in `form_for'

/usr/share/foreman/app/helpers/layout_helper.rb:209:in `form_for'

/usr/share/foreman/app/views/hosts/_form.html.erb:7:in `_app_views_hosts__form_html_erb___1255002788_69831471003620'

/usr/share/foreman/app/models/taxonomy.rb:55:in `as_taxonomy'

/usr/share/foreman/lib/foreman/thread_session.rb:140:in `as_location'

/usr/share/foreman/app/models/taxonomy.rb:54:in `as_taxonomy'

/usr/share/foreman/lib/foreman/thread_session.rb:105:in `as_org'

/usr/share/foreman/app/models/taxonomy.rb:53:in `as_taxonomy'

/usr/share/foreman/app/views/hosts/_form.html.erb:5:in `_app_views_hosts__form_html_erb___1255002788_69831471003620'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/template.rb:145:in `send'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/template.rb:145:in `render'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/notifications.rb:125:in `instrument'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/template.rb:143:in `render'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/partial_renderer.rb:265:in `render_partial'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/partial_renderer.rb:238:in `render'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/abstract_renderer.rb:38:in `instrument'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/notifications.rb:123:in `instrument'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/notifications/instrumenter.rb:20:in `instrument'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/notifications.rb:123:in `instrument'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/abstract_renderer.rb:38:in `instrument'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/partial_renderer.rb:237:in `render'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/renderer.rb:41:in `render_partial'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/renderer.rb:15:in `render'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/helpers/rendering_helper.rb:24:in `render'

/usr/share/foreman/app/views/hosts/edit.html.erb:7:in `_app_views_hosts_edit_html_erb___1140030682_69831471056820'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/template.rb:145:in `send'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/template.rb:145:in `render'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/notifications.rb:125:in `instrument'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/template.rb:143:in `render'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/template_renderer.rb:47:in `render_template'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/abstract_renderer.rb:38:in `instrument'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/notifications.rb:123:in `instrument'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/notifications/instrumenter.rb:20:in `instrument'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/notifications.rb:123:in `instrument'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/abstract_renderer.rb:38:in `instrument'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/template_renderer.rb:46:in `render_template'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/template_renderer.rb:54:in `render_with_layout'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/template_renderer.rb:45:in `render_template'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/template_renderer.rb:18:in `render'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/renderer.rb:36:in `render_template'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_view/renderer/renderer.rb:17:in `render'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/abstract_controller/rendering.rb:110:in `_render_template'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_controller/metal/streaming.rb:225:in `_render_template'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/abstract_controller/rendering.rb:103:in `render_to_body'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_controller/metal/renderers.rb:28:in `render_to_body'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_controller/metal/compatibility.rb:50:in `render_to_body'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/abstract_controller/rendering.rb:88:in `render'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_controller/metal/rendering.rb:16:in `render'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_controller/metal/instrumentation.rb:40:in `render'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/core_ext/benchmark.rb:5:in `ms'

/usr/lib/ruby/1.8/benchmark.rb:308:in `realtime'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/core_ext/benchmark.rb:5:in `ms'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_controller/metal/instrumentation.rb:40:in `render'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_controller/metal/instrumentation.rb:83:in `cleanup_view_runtime'

/usr/lib/ruby/gems/1.8/gems/activerecord-3.2.13/lib/active_record/railties/controller_runtime.rb:24:in `cleanup_view_runtime'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_controller/metal/instrumentation.rb:39:in `render'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_controller/metal/implicit_render.rb:10:in `default_render'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_controller/metal/implicit_render.rb:5:in `send_action'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/abstract_controller/base.rb:167:in `process_action'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_controller/metal/rendering.rb:10:in `process_action'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/abstract_controller/callbacks.rb:18:in `process_action'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:549:in `_run__539639951__process_action__799313808__callbacks'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:215:in `_conditional_callback_around_4548'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:326:in `around'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:310:in `send'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:310:in `_callback_around_915'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:214:in `_conditional_callback_around_4548'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:526:in `_run__539639951__process_action__799313808__callbacks'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:215:in `_conditional_callback_around_4547'

/usr/share/foreman/lib/foreman/thread_session.rb:31:in `clear_thread'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:214:in `_conditional_callback_around_4547'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:415:in `_run__539639951__process_action__799313808__callbacks'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:215:in `_conditional_callback_around_4546'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:326:in `around'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:310:in `send'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:310:in `_callback_around_13'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:214:in `_conditional_callback_around_4546'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:414:in `_run__539639951__process_action__799313808__callbacks'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:405:in `send'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:405:in `__run_callback'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:81:in `send'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:81:in `run_callbacks'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/abstract_controller/callbacks.rb:17:in `process_action'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_controller/metal/rescue.rb:29:in `process_action'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_controller/metal/instrumentation.rb:30:in `process_action'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/notifications.rb:123:in `instrument'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/notifications/instrumenter.rb:20:in `instrument'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/notifications.rb:123:in `instrument'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_controller/metal/instrumentation.rb:29:in `process_action'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_controller/metal/params_wrapper.rb:207:in `process_action'

/usr/lib/ruby/gems/1.8/gems/activerecord-3.2.13/lib/active_record/railties/controller_runtime.rb:18:in `process_action'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/abstract_controller/base.rb:121:in `process'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/abstract_controller/rendering.rb:45:in `process'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_controller/metal.rb:203:in `dispatch'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_controller/metal/rack_delegation.rb:14:in `dispatch'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_controller/metal.rb:246:in `action'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_dispatch/routing/route_set.rb:73:in `call'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_dispatch/routing/route_set.rb:73:in `dispatch'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_dispatch/routing/route_set.rb:36:in `call'

/usr/lib/ruby/gems/1.8/gems/journey-1.0.4/lib/journey/router.rb:68:in `call'

/usr/lib/ruby/gems/1.8/gems/journey-1.0.4/lib/journey/router.rb:56:in `each'

/usr/lib/ruby/gems/1.8/gems/journey-1.0.4/lib/journey/router.rb:56:in `call'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_dispatch/routing/route_set.rb:612:in `call'

/usr/lib/ruby/gems/1.8/gems/apipie-rails-0.0.16/lib/apipie/static_dispatcher.rb:56:in `call'

/usr/lib/ruby/gems/1.8/gems/rack-openid-1.3.1/lib/rack/openid.rb:98:in `call'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_dispatch/middleware/best_standards_support.rb:17:in `call'

/usr/lib/ruby/gems/1.8/gems/rack-1.4.5/lib/rack/etag.rb:23:in `call'

/usr/lib/ruby/gems/1.8/gems/rack-1.4.5/lib/rack/conditionalget.rb:25:in `call'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_dispatch/middleware/head.rb:14:in `call'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_dispatch/middleware/params_parser.rb:21:in `call'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_dispatch/middleware/flash.rb:242:in `call'

/usr/lib/ruby/gems/1.8/gems/rack-1.4.5/lib/rack/session/abstract/id.rb:210:in `context'

/usr/lib/ruby/gems/1.8/gems/rack-1.4.5/lib/rack/session/abstract/id.rb:205:in `call'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_dispatch/middleware/cookies.rb:341:in `call'

/usr/lib/ruby/gems/1.8/gems/activerecord-3.2.13/lib/active_record/query_cache.rb:64:in `call'

/usr/lib/ruby/gems/1.8/gems/activerecord-3.2.13/lib/active_record/connection_adapters/abstract/connection_pool.rb:479:in `call'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_dispatch/middleware/callbacks.rb:28:in `call'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:405:in `_run__100040639__call__4__callbacks'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:405:in `send'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:405:in `__run_callback'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:385:in `_run_call_callbacks'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:81:in `send'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/callbacks.rb:81:in `run_callbacks'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_dispatch/middleware/callbacks.rb:27:in `call'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_dispatch/middleware/remote_ip.rb:31:in `call'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_dispatch/middleware/show_exceptions.rb:56:in `call'

/usr/lib/ruby/gems/1.8/gems/railties-3.2.13/lib/rails/rack/logger.rb:32:in `call_app'

/usr/lib/ruby/gems/1.8/gems/railties-3.2.13/lib/rails/rack/logger.rb:16:in `call'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/tagged_logging.rb:22:in `tagged'

/usr/lib/ruby/gems/1.8/gems/railties-3.2.13/lib/rails/rack/logger.rb:16:in `call'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_dispatch/middleware/request_id.rb:22:in `call'

/usr/lib/ruby/gems/1.8/gems/rack-1.4.5/lib/rack/methodoverride.rb:21:in `call'

/usr/lib/ruby/gems/1.8/gems/rack-1.4.5/lib/rack/runtime.rb:17:in `call'

/usr/lib/ruby/gems/1.8/gems/activesupport-3.2.13/lib/active_support/cache/strategy/local_cache.rb:72:in `call'

/usr/lib/ruby/gems/1.8/gems/rack-1.4.5/lib/rack/lock.rb:15:in `call'

/usr/lib/ruby/gems/1.8/gems/actionpack-3.2.13/lib/action_dispatch/middleware/static.rb:63:in `call'

/usr/lib/ruby/gems/1.8/gems/rack-cache-1.2/lib/rack/cache/context.rb:136:in `forward'

/usr/lib/ruby/gems/1.8/gems/rack-cache-1.2/lib/rack/cache/context.rb:245:in `fetch'

/usr/lib/ruby/gems/1.8/gems/rack-cache-1.2/lib/rack/cache/context.rb:185:in `lookup'

/usr/lib/ruby/gems/1.8/gems/rack-cache-1.2/lib/rack/cache/context.rb:66:in `call!'

/usr/lib/ruby/gems/1.8/gems/rack-cache-1.2/lib/rack/cache/context.rb:51:in `call'

/usr/lib/ruby/gems/1.8/gems/railties-3.2.13/lib/rails/engine.rb:479:in `call'

/usr/lib/ruby/gems/1.8/gems/railties-3.2.13/lib/rails/application.rb:223:in `call'

/usr/lib/ruby/gems/1.8/gems/railties-3.2.13/lib/rails/railtie/configurable.rb:30:in `send'

/usr/lib/ruby/gems/1.8/gems/railties-3.2.13/lib/rails/railtie/configurable.rb:30:in `method_missing'

/usr/lib/ruby/gems/1.8/gems/rack-1.4.5/lib/rack/builder.rb:134:in `call'

/usr/lib/ruby/gems/1.8/gems/rack-1.4.5/lib/rack/urlmap.rb:64:in `call'

/usr/lib/ruby/gems/1.8/gems/rack-1.4.5/lib/rack/urlmap.rb:49:in `each'

/usr/lib/ruby/gems/1.8/gems/rack-1.4.5/lib/rack/urlmap.rb:49:in `call'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/rack/request_handler.rb:96:in `process_request'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/abstract_request_handler.rb:517:in `accept_and_process_next_request'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/abstract_request_handler.rb:274:in `main_loop'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/rack/application_spawner.rb:206:in `start_request_handler'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/rack/application_spawner.rb:171:in `send'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/rack/application_spawner.rb:171:in `handle_spawn_application'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/utils.rb:470:in `safe_fork'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/rack/application_spawner.rb:166:in `handle_spawn_application'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/abstract_server.rb:357:in `__send__'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/abstract_server.rb:357:in `server_main_loop'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/abstract_server.rb:206:in `start_synchronously'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/abstract_server.rb:180:in `start'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/rack/application_spawner.rb:129:in `start'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/spawn_manager.rb:253:in `spawn_rack_application'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/abstract_server_collection.rb:132:in `lookup_or_add'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/spawn_manager.rb:246:in `spawn_rack_application'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/abstract_server_collection.rb:82:in `synchronize'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/abstract_server_collection.rb:79:in `synchronize'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/spawn_manager.rb:244:in `spawn_rack_application'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/spawn_manager.rb:137:in `spawn_application'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/spawn_manager.rb:275:in `handle_spawn_application'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/abstract_server.rb:357:in `__send__'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/abstract_server.rb:357:in `server_main_loop'

/usr/share/rubygems/gems/passenger-3.0.17/lib/phusion_passenger/abstract_server.rb:206:in `start_synchronously'

/usr/share/rubygems/gems/passenger-3.0.17/helper-scripts/passenger-spawn-server:102

Rendered common/500.html.erb within layouts/application (8.8ms)

Completed 500 Internal Server Error in 6620ms (Views: 18.6ms | ActiveRecord: 47.7ms)