From: Johnston, N. <Nat...@ca...> - 2011-05-03 19:21:09
|
Etch Meister(s), I am a new user of Etch, and I am trying to get it working on a couple internal systems as an experiment. Right now I have only a single client pointed at a single server. When I run etch (as "./etch --debug --generate-all --server "http://jumphost-1p.internal:8080<http://jumphost-1p.internal:8080/>") I get a long stack trace (included below), and in the Etch Dashboard the server comes up as "broken". I would appreciate any insight you might have as to what is the issue, or what tack I should use to track down the issue. For full disclosure, I am a professional sysadmin, and have only dabbled in Ruby. Thanks, Nate This is from the server side's development.log: [Multiple fact loads precede this point] Fact Load (0.1ms) SELECT * FROM "facts" WHERE ("facts"."client_id" = 2 AND "facts"."key" = 'uptime') LIMIT 1 Fact Load (0.1ms) SELECT * FROM "facts" WHERE ("facts"."client_id" = 2 AND "facts"."key" = 'interfaces') LIMIT 1 Fact Load (0.1ms) SELECT * FROM "facts" WHERE ("facts"."client_id" = 2 AND "facts"."key" = 'ipaddress_eth0') LIMIT 1 Fact Load (0.1ms) SELECT * FROM "facts" WHERE ("facts"."client_id" = 2 AND "facts"."key" = 'macaddress_eth0') LIMIT 1 Fact Load (0.1ms) SELECT * FROM "facts" WHERE ("facts"."client_id" = 2 AND "facts"."key" = 'netmask_eth0') LIMIT 1 Fact Load (0.1ms) SELECT * FROM "facts" WHERE ("facts"."client_id" = 2 AND "facts"."key" = 'hardwaremodel') LIMIT 1 Fact Load (0.1ms) SELECT * FROM "facts" WHERE ("facts"."client_id" = 2 AND "facts"."key" = 'facterversion') LIMIT 1 Fact Load (0.8ms) SELECT * FROM "facts" WHERE ("facts"."client_id" = 2) No such file or directory /opt/ruby/ruby-1.9.2-p180/lib/ruby/1.9.1/find.rb:38:in `block in find' /opt/ruby/ruby-1.9.2-p180/lib/ruby/1.9.1/find.rb:38:in `collect!' /opt/ruby/ruby-1.9.2-p180/lib/ruby/1.9.1/find.rb:38:in `find' /etc/etchserver/lib/etch.rb:173:in `generate' /etc/etchserver/lib/etchserver.rb:348:in `generate' /etc/etchserver/app/controllers/files_controller.rb:24:in `create' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/base.rb:1333:in `perform_action' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/filters.rb:617:in `call_filters' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/filters.rb:610:in `perform_action_with_filters' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/benchmarking.rb:68:in `block in perform_action_with_benchmark' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/activesupport-2.3.11/lib/active_support/core_ext/benchmark.rb:17:in `block in ms' /opt/ruby/ruby-1.9.2-p180/lib/ruby/1.9.1/benchmark.rb:309:in `realtime' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/activesupport-2.3.11/lib/active_support/core_ext/benchmark.rb:17:in `ms' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/benchmarking.rb:68:in `perform_action_with_benchmark' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/rescue.rb:160:in `perform_action_with_rescue' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/flash.rb:151:in `perform_action_with_flash' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/base.rb:532:in `process' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/filters.rb:606:in `process_with_filters' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/base.rb:391:in `process' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/base.rb:386:in `call' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/routing/route_set.rb:438:in `call' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/dispatcher.rb:87:in `dispatch' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/dispatcher.rb:121:in `_call' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/dispatcher.rb:130:in `block in build_middleware_stack' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/activerecord-2.3.11/lib/active_record/query_cache.rb:29:in `call' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/activerecord-2.3.11/lib/active_record/query_cache.rb:29:in `block in call' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/activerecord-2.3.11/lib/active_record/connection_adapters/abstract/query_cache.rb:34:in `cache' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/activerecord-2.3.11/lib/active_record/query_cache.rb:9:in `cache' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/activerecord-2.3.11/lib/active_record/query_cache.rb:28:in `call' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/activerecord-2.3.11/lib/active_record/connection_adapters/abstract/connection_pool.rb:361:in `call' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/string_coercion.rb:25:in `call' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/rack-1.1.0/lib/rack/head.rb:9:in `call' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/rack-1.1.0/lib/rack/methodoverride.rb:24:in `call' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/params_parser.rb:15:in `call' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/session/cookie_store.rb:99:in `call' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/failsafe.rb:26:in `call' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/rack-1.1.0/lib/rack/lock.rb:11:in `block in call' <internal:prelude>:10:in `synchronize' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/rack-1.1.0/lib/rack/lock.rb:11:in `call' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/dispatcher.rb:114:in `block in call' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/reloader.rb:34:in `run' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/actionpack-2.3.11/lib/action_controller/dispatcher.rb:108:in `call' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/rails-2.3.11/lib/rails/rack/static.rb:31:in `call' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/rack-1.1.0/lib/rack/urlmap.rb:47:in `block in call' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/rack-1.1.0/lib/rack/urlmap.rb:41:in `each' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/rack-1.1.0/lib/rack/urlmap.rb:41:in `call' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/rails-2.3.11/lib/rails/rack/log_tailer.rb:17:in `call' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/unicorn-3.6.2/lib/unicorn/http_server.rb:545:in `process_client' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/unicorn-3.6.2/lib/unicorn/http_server.rb:623:in `block in worker_loop' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/unicorn-3.6.2/lib/unicorn/http_server.rb:621:in `each' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/unicorn-3.6.2/lib/unicorn/http_server.rb:621:in `worker_loop' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/unicorn-3.6.2/lib/unicorn/http_server.rb:509:in `block (2 levels) in spawn_missing_workers' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/unicorn-3.6.2/lib/unicorn/http_server.rb:507:in `fork' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/unicorn-3.6.2/lib/unicorn/http_server.rb:507:in `block in spawn_missing_workers' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/unicorn-3.6.2/lib/unicorn/http_server.rb:503:in `each' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/unicorn-3.6.2/lib/unicorn/http_server.rb:503:in `spawn_missing_workers' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/unicorn-3.6.2/lib/unicorn/http_server.rb:516:in `maintain_worker_count' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/unicorn-3.6.2/lib/unicorn/http_server.rb:166:in `start' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/unicorn-3.6.2/lib/unicorn.rb:30:in `run' /opt/ruby/ruby-1.9.2-p180/lib/ruby/gems/1.9.1/gems/unicorn-3.6.2/bin/unicorn_rails:208:in `<top (required)>' /opt/ruby/current/bin/unicorn_rails:19:in `load' /opt/ruby/current/bin/unicorn_rails:19:in `<main>' Completed in 47ms (View: 1, DB: 6) | 500 Internal Server Error [http://jumphost-1p.internal/files] Processing ResultsController#create (for 10.253.91.169 at 2011-05-03 18:40:41) [POST] Parameters: {"fqdn"=>"etch-testhost.internal", "status"=>"1", "message"=>"500 \"Internal Server Error\"/opt/ruby/ruby-1.9.2-p180/lib/ruby/1.9.1/net/http.rb:2303:in `error!'\n/etc/etchclient/etchclient.rb:343:in `block (2 levels) in process_until_done'\n/etc/etchclient/etchclient.rb:312:in `times'\n/etc/etchclient/etchclient.rb:312:in `block in process_until_done'\n/etc/etchclient/etchclient.rb:240:in `catch'\n/etc/etchclient/etchclient.rb:240:in `process_until_done'\n/etc/etchclient/etch:109:in `<main>'", "timestamp"=>"2011-05-03 18:39:51 +0000"} Client Load (0.1ms) SELECT * FROM "clients" WHERE ("clients"."name" = 'etch-testhost.internal') LIMIT 1 Client Load (0.1ms) SELECT "clients".id FROM "clients" WHERE ("clients"."name" = 'etch-testhost.internal' AND "clients".id <> 2) LIMIT 1 Client Update (0.2ms) UPDATE "clients" SET "updated_at" = '2011-05-03 18:40:41' WHERE "id" = 2 Completed in 14ms (View: 0, DB: 0) | 200 OK [http://jumphost-1p.internal/results] |