Bug #9857
closedInternal server error when registering discovered host in Foreman 1.8
Description
Using Foreman 1.8 RC1 and discovery image 2.1 I'm getting the following error:
2015-03-21 15:12:55 [I] Started POST "/api/v2/discovered_hosts/facts" for 10.9.168.59 at 2015-03-21 15:12:55 +0100
2015-03-21 15:12:55 [I] Processing by Api::V2::DiscoveredHostsController#facts as JSON
2015-03-21 15:12:55 [I] Parameters: {"facts"=>"[FILTERED]", "apiv"=>"v2", "discovered_host"=>{"facts"=>"[FILTERED]"}}
2015-03-21 15:12:55 [I] Import facts for 'p0015174df244' completed. Added: 104, Updated: 0, Deleted 0 facts
2015-03-21 15:12:55 [E] address family must be specified (ArgumentError)
/usr/lib/ruby/1.9.1/ipaddr.rb:460:in `initialize'
/usr/share/foreman/app/models/subnet.rb:97:in `new'
/usr/share/foreman/app/models/subnet.rb:97:in `block in subnet_for'
/usr/share/foreman/app/models/subnet.rb:97:in `each'
/usr/share/foreman/app/models/subnet.rb:97:in `subnet_for'
/usr/share/foreman/vendor/ruby/1.9.1/gems/foreman_discovery-3.0.0/app/models/host/discovered.rb:110:in `populate_fields_from_facts'
/usr/share/foreman/app/models/host/base.rb:106:in `import_facts'
/usr/share/foreman/vendor/ruby/1.9.1/gems/foreman_discovery-3.0.0/app/models/host/discovered.rb:90:in `import_facts'
/usr/share/foreman/vendor/ruby/1.9.1/gems/foreman_discovery-3.0.0/app/models/host/discovered.rb:82:in `import_host_and_facts'
/usr/share/foreman/vendor/ruby/1.9.1/gems/foreman_discovery-3.0.0/app/controllers/api/v2/discovered_hosts_controller.rb:100:in `block in facts'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activerecord-3.2.21/lib/active_record/connection_adapters/abstract/database_statements.rb:192:in `transaction'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activerecord-3.2.21/lib/active_record/transactions.rb:208:in `transaction'
/usr/share/foreman/app/models/host.rb:15:in `method_missing'
/usr/share/foreman/vendor/ruby/1.9.1/gems/foreman_discovery-3.0.0/app/controllers/api/v2/discovered_hosts_controller.rb:99:in `facts'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_controller/metal/implicit_render.rb:4:in `send_action'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/abstract_controller/base.rb:167:in `process_action'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_controller/metal/rendering.rb:10:in `process_action'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/abstract_controller/callbacks.rb:18:in `block in process_action'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:518:in `block (5 levels) in _run__290186017224470252__process_action__600673319205174767__callbacks'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:215:in `block in _conditional_callback_around_7618'
/usr/share/foreman/app/controllers/api/v2/base_controller.rb:151:in `disable_json_root'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:214:in `_conditional_callback_around_7618'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:517:in `block (4 levels) in _run__290186017224470252__process_action__600673319205174767__callbacks'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:215:in `block in _conditional_callback_around_7617'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:326:in `around'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:310:in `_callback_around_2141'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:214:in `_conditional_callback_around_7617'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:505:in `block (3 levels) in _run__290186017224470252__process_action__600673319205174767__callbacks'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:215:in `block in _conditional_callback_around_7616'
/usr/share/foreman/app/controllers/concerns/application_shared.rb:13:in `set_timezone'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:214:in `_conditional_callback_around_7616'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:504:in `block (2 levels) in _run__290186017224470252__process_action__600673319205174767__callbacks'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:215:in `block in _conditional_callback_around_7615'
/usr/share/foreman/app/models/concerns/foreman/thread_session.rb:32:in `clear_thread'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:214:in `_conditional_callback_around_7615'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:448:in `block in _run__290186017224470252__process_action__600673319205174767__callbacks'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:215:in `block in _conditional_callback_around_7614'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:326:in `around'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:310:in `_callback_around_13'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:214:in `_conditional_callback_around_7614'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:414:in `_run__290186017224470252__process_action__600673319205174767__callbacks'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:405:in `__run_callback'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:81:in `run_callbacks'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/abstract_controller/callbacks.rb:17:in `process_action'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_controller/metal/rescue.rb:29:in `process_action'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_controller/metal/instrumentation.rb:30:in `block in process_action'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/notifications.rb:123:in `block in instrument'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/notifications/instrumenter.rb:20:in `instrument'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/notifications.rb:123:in `instrument'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_controller/metal/instrumentation.rb:29:in `process_action'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_controller/metal/params_wrapper.rb:207:in `process_action'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activerecord-3.2.21/lib/active_record/railties/controller_runtime.rb:18:in `process_action'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/abstract_controller/base.rb:121:in `process'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/abstract_controller/rendering.rb:45:in `process'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_controller/metal.rb:203:in `dispatch'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_controller/metal/rack_delegation.rb:14:in `dispatch'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_controller/metal.rb:246:in `block in action'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_dispatch/routing/route_set.rb:73:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_dispatch/routing/route_set.rb:73:in `dispatch'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_dispatch/routing/route_set.rb:36:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_dispatch/routing/mapper.rb:43:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/journey-1.0.4/lib/journey/router.rb:68:in `block in call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/journey-1.0.4/lib/journey/router.rb:56:in `each'
/usr/share/foreman/vendor/ruby/1.9.1/gems/journey-1.0.4/lib/journey/router.rb:56:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_dispatch/routing/route_set.rb:608:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/apipie-rails-0.2.6/lib/apipie/extractor/recorder.rb:97:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/apipie-rails-0.2.6/lib/apipie/middleware/checksum_in_headers.rb:27:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_dispatch/middleware/best_standards_support.rb:17:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/rack-1.4.5/lib/rack/etag.rb:23:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/rack-1.4.5/lib/rack/conditionalget.rb:35:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_dispatch/middleware/head.rb:14:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_dispatch/middleware/params_parser.rb:21:in `call'
/usr/share/foreman/lib/middleware/catch_json_parse_errors.rb:9:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_dispatch/middleware/flash.rb:242:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/rack-1.4.5/lib/rack/session/abstract/id.rb:210:in `context'
/usr/share/foreman/vendor/ruby/1.9.1/gems/rack-1.4.5/lib/rack/session/abstract/id.rb:205:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_dispatch/middleware/cookies.rb:341:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activerecord-3.2.21/lib/active_record/query_cache.rb:64:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activerecord-3.2.21/lib/active_record/connection_adapters/abstract/connection_pool.rb:479:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_dispatch/middleware/callbacks.rb:28:in `block in call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:405:in `_run__3446009319613529455__call__1766336569595475298__callbacks'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:405:in `__run_callback'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:385:in `_run_call_callbacks'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/callbacks.rb:81:in `run_callbacks'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_dispatch/middleware/callbacks.rb:27:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_dispatch/middleware/remote_ip.rb:31:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_dispatch/middleware/show_exceptions.rb:56:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/railties-3.2.21/lib/rails/rack/logger.rb:32:in `call_app'
/usr/share/foreman/vendor/ruby/1.9.1/gems/railties-3.2.21/lib/rails/rack/logger.rb:16:in `block in call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/tagged_logging.rb:22:in `tagged'
/usr/share/foreman/vendor/ruby/1.9.1/gems/railties-3.2.21/lib/rails/rack/logger.rb:16:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_dispatch/middleware/request_id.rb:22:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/rack-1.4.5/lib/rack/methodoverride.rb:21:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/rack-1.4.5/lib/rack/runtime.rb:17:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/activesupport-3.2.21/lib/active_support/cache/strategy/local_cache.rb:72:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/rack-1.4.5/lib/rack/lock.rb:15:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/actionpack-3.2.21/lib/action_dispatch/middleware/static.rb:83:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/rack-cache-1.2/lib/rack/cache/context.rb:136:in `forward'
/usr/share/foreman/vendor/ruby/1.9.1/gems/rack-cache-1.2/lib/rack/cache/context.rb:143:in `pass'
/usr/share/foreman/vendor/ruby/1.9.1/gems/rack-cache-1.2/lib/rack/cache/context.rb:155:in `invalidate'
/usr/share/foreman/vendor/ruby/1.9.1/gems/rack-cache-1.2/lib/rack/cache/context.rb:71:in `call!'
/usr/share/foreman/vendor/ruby/1.9.1/gems/rack-cache-1.2/lib/rack/cache/context.rb:51:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/railties-3.2.21/lib/rails/engine.rb:484:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/railties-3.2.21/lib/rails/application.rb:231:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/railties-3.2.21/lib/rails/railtie/configurable.rb:30:in `method_missing'
/usr/share/foreman/vendor/ruby/1.9.1/gems/rack-1.4.5/lib/rack/builder.rb:134:in `call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/rack-1.4.5/lib/rack/urlmap.rb:64:in `block in call'
/usr/share/foreman/vendor/ruby/1.9.1/gems/rack-1.4.5/lib/rack/urlmap.rb:49:in `each'
/usr/share/foreman/vendor/ruby/1.9.1/gems/rack-1.4.5/lib/rack/urlmap.rb:49:in `call'
/usr/lib/ruby/vendor_ruby/phusion_passenger/rack/thread_handler_extension.rb:77:in `process_request'
/usr/lib/ruby/vendor_ruby/phusion_passenger/request_handler/thread_handler.rb:142:in `accept_and_process_next_request'
/usr/lib/ruby/vendor_ruby/phusion_passenger/request_handler/thread_handler.rb:110:in `main_loop'
/usr/lib/ruby/vendor_ruby/phusion_passenger/request_handler.rb:448:in `block (3 levels) in start_threads'
2015-03-21 15:12:55 [I] Rendered api/v2/errors/standard_error.json.rabl within api/v2/layouts/error_layout (0.8ms)
2015-03-21 15:12:55 [I] Completed 500 Internal Server Error in 614.6ms (Views: 2.1ms | ActiveRecord: 92.1ms)
Discovery-debug information:
[root@fdi ~]# discovery-debug
* PROCESSES *
PID TTY STAT TIME COMMAND
1 ? Ss 0:01 /usr/lib/systemd/systemd --switched-root --system --deserialize 21
2 ? S 0:00 [kthreadd]
3 ? S 0:00 [ksoftirqd/0]
4 ? S 0:00 [kworker/0:0]
5 ? S< 0:00 [kworker/0:0H]
7 ? S 0:00 [migration/0]
8 ? S 0:00 [rcu_bh]
9 ? S 0:00 [rcuob/0]
10 ? S 0:00 [rcuob/1]
11 ? S 0:00 [rcuob/2]
12 ? S 0:00 [rcuob/3]
13 ? S 0:00 [rcuob/4]
14 ? S 0:00 [rcuob/5]
15 ? S 0:00 [rcuob/6]
16 ? S 0:00 [rcuob/7]
17 ? S 0:00 [rcu_sched]
18 ? S 0:00 [rcuos/0]
19 ? S 0:00 [rcuos/1]
20 ? S 0:00 [rcuos/2]
21 ? S 0:00 [rcuos/3]
22 ? S 0:00 [rcuos/4]
23 ? S 0:00 [rcuos/5]
24 ? S 0:00 [rcuos/6]
25 ? S 0:00 [rcuos/7]
26 ? S 0:00 [watchdog/0]
27 ? S 0:00 [watchdog/1]
28 ? S 0:00 [migration/1]
29 ? S 0:00 [ksoftirqd/1]
30 ? S 0:00 [kworker/1:0]
31 ? S< 0:00 [kworker/1:0H]
32 ? S 0:00 [watchdog/2]
33 ? S 0:00 [migration/2]
34 ? S 0:00 [ksoftirqd/2]
36 ? S< 0:00 [kworker/2:0H]
37 ? S 0:00 [watchdog/3]
38 ? S 0:00 [migration/3]
39 ? S 0:00 [ksoftirqd/3]
40 ? S 0:00 [kworker/3:0]
41 ? S< 0:00 [kworker/3:0H]
42 ? S 0:00 [watchdog/4]
43 ? S 0:00 [migration/4]
44 ? S 0:00 [ksoftirqd/4]
45 ? S 0:00 [kworker/4:0]
46 ? S< 0:00 [kworker/4:0H]
47 ? S 0:00 [watchdog/5]
48 ? S 0:00 [migration/5]
49 ? S 0:00 [ksoftirqd/5]
51 ? S< 0:00 [kworker/5:0H]
52 ? S 0:00 [watchdog/6]
53 ? S 0:00 [migration/6]
54 ? S 0:00 [ksoftirqd/6]
56 ? S< 0:00 [kworker/6:0H]
57 ? S 0:00 [watchdog/7]
58 ? S 0:00 [migration/7]
59 ? S 0:00 [ksoftirqd/7]
61 ? S< 0:00 [kworker/7:0H]
62 ? S< 0:00 [khelper]
63 ? S 0:00 [kdevtmpfs]
64 ? S< 0:00 [netns]
65 ? S< 0:00 [writeback]
66 ? S< 0:00 [kintegrityd]
67 ? S< 0:00 [bioset]
68 ? S< 0:00 [kblockd]
69 ? S 0:00 [khubd]
70 ? S< 0:00 [md]
71 ? S 0:00 [kworker/0:1]
72 ? S 0:00 [kworker/1:1]
74 ? S 0:00 [kworker/3:1]
76 ? S 0:00 [kworker/5:1]
77 ? S 0:00 [kworker/6:1]
78 ? S 0:00 [kworker/7:1]
80 ? S 0:00 [kswapd0]
81 ? SN 0:00 [ksmd]
82 ? SN 0:00 [khugepaged]
83 ? S 0:00 [fsnotify_mark]
84 ? S< 0:00 [crypto]
93 ? S< 0:00 [kthrotld]
96 ? S< 0:00 [kmpath_rdacd]
97 ? S< 0:00 [kpsmoused]
117 ? S< 0:00 [deferwq]
137 ? S 0:00 [kauditd]
254 ? S< 0:00 [ata_sff]
255 ? S 0:00 [scsi_eh_0]
256 ? S< 0:00 [scsi_tmf_0]
257 ? S 0:00 [scsi_eh_1]
258 ? S< 0:00 [scsi_tmf_1]
277 ? S 0:00 [kworker/5:2]
279 ? S 0:00 [kworker/6:2]
281 ? S 0:00 [kworker/7:2]
284 ? S 0:00 [kworker/3:2]
285 ? S 0:00 [kworker/4:2]
292 ? S< 0:00 [loop0]
332 ? S< 0:00 [loop1]
337 ? S< 0:00 [loop2]
341 ? S< 0:00 [loop3]
346 ? S< 0:04 [loop4]
356 ? S< 0:00 [loop5]
360 ? S< 0:00 [kdmflush]
363 ? S< 0:00 [dm_bufio_cache]
364 ? S< 0:00 [ksnaphd]
365 ? S< 0:00 [kcopyd]
366 ? S< 0:00 [bioset]
367 ? S< 0:00 [bioset]
368 ? S< 0:00 [bioset]
374 ? S< 0:00 [kdmflush]
375 ? S< 0:00 [bioset]
383 ? S< 0:00 [kdmflush]
384 ? S< 0:00 [ksnaphd]
385 ? S< 0:00 [kcopyd]
386 ? S< 0:00 [bioset]
387 ? S< 0:00 [bioset]
389 ? S< 0:00 [bioset]
422 ? S< 0:00 [loop6]
425 ? S 0:00 [jbd2/loop6-8]
426 ? S< 0:00 [ext4-dio-unwrit]
461 ? Ss 0:00 /usr/lib/systemd/systemd-journald
490 ? Ss 0:00 /usr/lib/systemd/systemd-udevd
502 ? Ssl 0:00 /usr/sbin/NetworkManager --no-daemon
505 ? Ss 0:00 avahi-daemon: running [fdi.local]
508 ? Ss 0:00 /usr/lib/systemd/systemd-logind
509 ? Ss 0:00 /bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation
513 ? Ss 0:00 /usr/sbin/acpid
539 ? S 0:00 avahi-daemon: chroot helper
542 ? S< 0:00 [edac-poller]
543 ? SN 0:04 [kipmi0]
544 ? S 0:00 [scsi_eh_2]
545 ? S< 0:00 [scsi_tmf_2]
546 ? S< 0:00 [mlx4]
547 ? S< 0:00 [kvm-irqfd-clean]
556 ? Ssl 0:00 /usr/lib/polkit-1/polkitd --no-debug
657 ? S< 0:00 [ib_addr]
658 ? S< 0:00 [ib_mcast]
659 ? S< 0:00 [mlx4_ib]
660 ? S< 0:00 [mlx4_ib_mcg]
661 ? S< 0:00 [ib_mad1]
662 ? S< 0:00 [ib_mad2]
672 ? Ss 0:00 /usr/sbin/sshd -D
673 ? S 0:00 [kworker/2:2]
694 ? Sl 0:00 ruby /usr/share/foreman-proxy/bin/smart-proxy
697 ? S 0:00 /sbin/dhclient -d -sf /usr/libexec/nm-dhcp-helper -pf /var/run/dhclient-enp16s0f0.pid -lf /var/lib/NetworkManager/dhclient-b7749f2e-ce55-4c80-977d-26959a7e9153-enp16s0f0.lease -cf /var/lib/NetworkManager/dhclient-enp16s0f0.conf enp16s0f0
699 ? Ssl 0:12 ruby /usr/bin/discovery-register
807 ? S 0:00 [kworker/2:3]
1320 ? Ss 0:00 login -- root
1322 tty2 Ss+ 0:00 -bash
4198 ? S 0:00 [kworker/u16:1]
8487 ? S 0:00 [kworker/u16:0]
10492 ? Ss 0:00 sshd: root@pts/0
10494 pts/0 Ss 0:00 -bash
10599 pts/0 S+ 0:00 /bin/bash /usr/bin/discovery-debug
10600 pts/0 R+ 0:00 ps axww
* JOURNAL (last 500 lines) *
(...)
Mar 21 12:57:25 fdi discovery-register[699]: Fact cache invalid, reloading to foreman
Mar 21 12:57:25 fdi discovery-register[699]: Parsing kernel line: initrd=boot/fdi-image/initrd0.img rootflags=loop root=live:/fdi.iso rootfstype=auto ro rd.live.image acpi=force rd.luks=0 rd.md=0 rd.dm=0 rd.lvm=0 rd.bootif=0 rd.neednet=0 nomodeset proxy.url=https://master.test.REDACTED.COM proxy.type=foreman fdi.ssh=1 fdi.rootpw=changeme BOOTIF=01-00-15-17-4d-f2-44 BOOT_IMAGE=boot/fdi-image/vmlinuz0
Mar 21 12:57:25 fdi discovery-register[699]: Discovered by URL: https://master.test.REDACTED.COM
Mar 21 12:57:25 fdi discovery-register[699]: Registering host with Foreman (https://master.test.REDACTED.COM)
Mar 21 12:57:26 fdi discovery-register[699]: Response from Foreman 500: {
Mar 21 12:57:26 fdi discovery-register[699]: "error": {"message":"address family must be specified"}
Mar 21 12:57:26 fdi discovery-register[699]: }
* PROXY (LEGACY) LOG *
tail: cannot open '/var/log/foreman-proxy/proxy.log' for reading: No such file or directory
* KERNEL COMMAND LINE *
initrd=boot/fdi-image/initrd0.img rootflags=loop root=live:/fdi.iso rootfstype=auto ro rd.live.image acpi=force rd.luks=0 rd.md=0 rd.dm=0 rd.lvm=0 rd.bootif=0 rd.neednet=0 nomodeset proxy.url=https://master.test.REDACTED.COM proxy.type=foreman fdi.ssh=1 fdi.rootpw=changeme BOOTIF=01-00-15-17-4d-f2-44 BOOT_IMAGE=boot/fdi-image/vmlinuz0
* NETWORK CONFIGURATION *
DEVICE=lo
IPADDR=127.0.0.1
NETMASK=255.0.0.0
NETWORK=127.0.0.0
# If you're having problems with gated making 127.0.0.0/8 a martian,
# you can change this to something else (255.255.255.255, for example)
BROADCAST=127.255.255.255
ONBOOT=yes
NAME=loopback
* FACTER *
architecture => x86_64
auto_negotitation_enp16s0f0 => true
auto_negotitation_enp16s0f1 => true
auto_negotitation_enp17s0f0 => true
auto_negotitation_enp17s0f1 => true
bios_release_date => 10/30/2010
bios_vendor => Dell Inc.
bios_version => 2.7.0
blockdevice_sda_model => PERC 5/i
blockdevice_sda_size => 119453777920
blockdevice_sda_vendor => DELL
blockdevice_sr0_model => CD-ROM GCR-8240N
blockdevice_sr0_size => 1073741312
blockdevice_sr0_vendor => HL-DT-ST
blockdevices => sda,sr0
boardmanufacturer => Dell Inc.
boardproductname => 0UR033
boardserialnumber => ..CN6970277A2638.
dhcp_servers => {"system"=>"10.9.0.1", "enp16s0f0"=>"10.9.0.1"}
discovery_bootif => 00:15:17:4d:f2:44
discovery_bootip => 10.9.168.59
discovery_release => 20150114.1
discovery_version => 2.1.0
domain => test.REDACTED.COM
duplex_enp16s0f0 => full
duplex_enp16s0f1 => unknown! (255)
duplex_enp17s0f0 => unknown! (255)
duplex_enp17s0f1 => unknown! (255)
facterversion => 2.2.0
filesystems => ext2,ext3,ext4,iso9660,squashfs
fqdn => fdi.test.REDACTED.COM
gid => root
hardwareisa => x86_64
hardwaremodel => x86_64
hostname => fdi
id => root
interfaces => enp16s0f0,enp16s0f1,enp17s0f0,enp17s0f1,lo
ipaddress => 10.9.168.59
ipaddress_enp16s0f0 => 10.9.168.59
ipaddress_lo => 127.0.0.1
ipmi_enabled => true
ipmi_gateway => 0.0.0.0
ipmi_ipaddress => 10.14.60.33
ipmi_ipaddress_source => DHCP Address
ipmi_macaddress => 00:1c:23:bb:11:44
ipmi_subnet_mask => 255.255.0.0
is_virtual => false
kernel => Linux
kernelmajversion => 3.10
kernelrelease => 3.10.0-123.13.2.el7.x86_64
kernelversion => 3.10.0
lib => /usr/share/fdi/facts/
link_enp16s0f0 => true
link_enp16s0f1 => false
link_enp17s0f0 => false
link_enp17s0f1 => false
link_lo => true
macaddress => 00:15:17:4d:f2:44
macaddress_enp16s0f0 => 00:15:17:4d:f2:44
macaddress_enp16s0f1 => 00:15:17:4d:f2:45
macaddress_enp17s0f0 => 00:15:17:4d:f2:46
macaddress_enp17s0f1 => 00:15:17:4d:f2:47
manufacturer => Dell Inc.
memoryfree => 15.37 GB
memoryfree_mb => 15738.26
memorysize => 15.67 GB
memorysize_mb => 16044.43
mtu_enp16s0f0 => 1500
mtu_enp16s0f1 => 1500
mtu_enp17s0f0 => 1500
mtu_enp17s0f1 => 1500
mtu_lo => 65536
netmask => 255.255.0.0
netmask_enp16s0f0 => 255.255.0.0
netmask_lo => 255.0.0.0
network_enp16s0f0 => 10.9.0.0
network_lo => 127.0.0.0
operatingsystem => CentOS
operatingsystemmajrelease => 7
operatingsystemrelease => 7.0.1406
os => {"name"=>"CentOS", "family"=>"RedHat", "release"=>{"major"=>"7", "minor"=>"0", "full"=>"7.0.1406"}}
osfamily => RedHat
partitions => {"sda1"=>{"uuid"=>"569c98da-12f1-4380-b9e6-62a18b714552", "size"=>"497664", "filesystem"=>"ext4"}, "sda2"=>{"uuid"=>"be21a473-fd13-4be3-af05-3f4f9d8a5f9a", "size"=>"232806400", "filesystem"=>"ext4"}}
path => /usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/opt/extension/bin:/root/bin
physicalprocessorcount => 2
port_enp16s0f0 => Twisted Pair
port_enp16s0f1 => Twisted Pair
port_enp17s0f0 => Twisted Pair
port_enp17s0f1 => Twisted Pair
processor0 => Intel(R) Xeon(R) CPU E5345 @ 2.33GHz
processor1 => Intel(R) Xeon(R) CPU E5345 @ 2.33GHz
processor2 => Intel(R) Xeon(R) CPU E5345 @ 2.33GHz
processor3 => Intel(R) Xeon(R) CPU E5345 @ 2.33GHz
processor4 => Intel(R) Xeon(R) CPU E5345 @ 2.33GHz
processor5 => Intel(R) Xeon(R) CPU E5345 @ 2.33GHz
processor6 => Intel(R) Xeon(R) CPU E5345 @ 2.33GHz
processor7 => Intel(R) Xeon(R) CPU E5345 @ 2.33GHz
processorcount => 8
processors => {"models"=>["Intel(R) Xeon(R) CPU E5345 @ 2.33GHz", "Intel(R) Xeon(R) CPU E5345 @ 2.33GHz", "Intel(R) Xeon(R) CPU E5345 @ 2.33GHz", "Intel(R) Xeon(R) CPU E5345 @ 2.33GHz", "Intel(R) Xeon(R) CPU E5345 @ 2.33GHz", "Intel(R) Xeon(R) CPU E5345 @ 2.33GHz", "Intel(R) Xeon(R) CPU E5345 @ 2.33GHz", "Intel(R) Xeon(R) CPU E5345 @ 2.33GHz"], "count"=>8, "physicalcount"=>2}
productname => PowerEdge 1950
ps => ps -ef
rubysitedir => /usr/local/share/ruby/site_ruby/
rubyversion => 2.0.0
selinux => false
serialnumber => H6MH23J
speed_enp16s0f0 => 1000
sshecdsakey => AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBNGanN0He78JaeI9W7lfQlJOv34qKRIECwLpOSkV2e0iUKlLqwrletinjbKmdMjDHZmRUiTxUGBhw/GfJlj3ktQ=
sshfp_ecdsa => SSHFP 3 1 ae971cf090d8bd478de8d33e5669f1a69627c9a5
SSHFP 3 2 ca34f05b34091ba0a464e58e552c262a77b32ad8f4b229b26828690541fa432e
sshfp_rsa => SSHFP 1 1 f944287a8b5b04b5161e56bfcad45c2d31f892f1
SSHFP 1 2 d6f45f2b02635846741a0ddccce184c79e316e52b95410f8179eabed7202f69d
sshrsakey => AAAAB3NzaC1yc2EAAAADAQABAAABAQCi0++4mVnPywPTZqnPXL/9UDTGVu7SWAojl1b9LJbDR95Xhn8YjrWSAIww5Lofg+nHEIwY/GWEoKNVoz+ake1R/0CBnoG5QiqUWekHsSqQ1j3jHvc9S/tcu1CzMFnQVAfEzgobYeE+s2K8XCy+MFMoTMiQWzFRcFmk8i2m+ieqoxr+HWDfdh5l4DFZeyNG0eSifSTlCNO3xqdAZTHe5ZpK631dEAxhzcpHxyuUB3QXNaip4SXv0Fgn5b1h2iNgL/zMxPexw6mge9bXX7AZtpIRus+KcVefNwsNwnmsI0qBXKf5LFELiwe8ysv1v9ughichELW9ixnwie2qOVheFAbh
swapfree => 0.00 MB
swapfree_mb => 0.00
swapsize => 0.00 MB
swapsize_mb => 0.00
system_uptime => {"seconds"=>2997, "hours"=>0, "days"=>0, "uptime"=>"0:49 hours"}
timezone => UTC
type => Rack Mount Chassis
uniqueid => 090a3ba8
uptime => 0:49 hours
uptime_days => 0
uptime_hours => 0
uptime_seconds => 2997
uuid => 44454C4C-3600-104D-8048-C8C04F32334A
virtual => physical
wol_enp16s0f0 => true
wol_enp16s0f1 => false
wol_enp17s0f0 => false
wol_enp17s0f1 => false
* IP ADDRESSES *
1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN
link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00
inet 127.0.0.1/8 scope host lo
valid_lft forever preferred_lft forever
inet6 ::1/128 scope host
valid_lft forever preferred_lft forever
2: enp16s0f0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc pfifo_fast state UP qlen 1000
link/ether 00:15:17:4d:f2:44 brd ff:ff:ff:ff:ff:ff
inet 10.9.168.59/16 brd 10.9.255.255 scope global dynamic enp16s0f0
valid_lft 1725019sec preferred_lft 1725019sec
inet6 fe80::215:17ff:fe4d:f244/64 scope link
valid_lft forever preferred_lft forever
3: enp16s0f1: <NO-CARRIER,BROADCAST,MULTICAST,UP> mtu 1500 qdisc pfifo_fast state DOWN qlen 1000
link/ether 00:15:17:4d:f2:45 brd ff:ff:ff:ff:ff:ff
4: enp17s0f0: <NO-CARRIER,BROADCAST,MULTICAST,UP> mtu 1500 qdisc pfifo_fast state DOWN qlen 1000
link/ether 00:15:17:4d:f2:46 brd ff:ff:ff:ff:ff:ff
5: enp17s0f1: <NO-CARRIER,BROADCAST,MULTICAST,UP> mtu 1500 qdisc pfifo_fast state DOWN qlen 1000
link/ether 00:15:17:4d:f2:47 brd ff:ff:ff:ff:ff:ff
* ROUTES *
default via 10.9.0.1 dev enp16s0f0 proto static metric 1024
10.9.0.0/16 dev enp16s0f0 proto kernel scope link src 10.9.168.59
* DHCP LEASES *
lease {
interface "enp16s0f0";
fixed-address 10.9.168.59;
filename "pxelinux.0";
option subnet-mask 255.255.0.0;
option routers 10.9.0.1;
option dhcp-lease-time 1728000;
option dhcp-message-type 5;
option domain-name-servers 10.9.0.1;
option dhcp-server-identifier 10.9.0.1;
option domain-name "test.REDACTED.COM";
renew 2 2015/03/31 12:44:31;
rebind 3 2015/04/08 01:23:44;
expire 5 2015/04/10 13:23:44;
}
* DNS *
# Generated by NetworkManager
domain test.REDACTED.COM
search test.REDACTED.COM
nameserver 10.9.0.1
Files
Updated by Dominic Cleal about 11 years ago
- Project changed from Foreman to Discovery
- Translation missing: en.field_release deleted (
28)
The error seems to indicate that a nil IP address is being passed from facts into the host's primary interface IP field, which is then being passed into the subnet search.
Updated by Lukas Zapletal about 11 years ago
Hello, what is your discovery_fact setting?
Updated by Lukas Zapletal about 11 years ago
Interested in Foreman Discovery version as well.
Updated by Lukas Zapletal about 11 years ago
- Category set to Discovery plugin
- Priority changed from Normal to High
- Target version set to Discovery Plugin 2.0.3
I have just realized that discovery extensions are not effective on 1.8. I don't know yet if this is expected behavior or not: https://github.com/theforeman/foreman_discovery/blob/develop/app/lib/puppet_fact_parser_extensions.rb
Marek can you elaborate please?
Updated by Lukas Zapletal about 11 years ago
- Target version changed from Discovery Plugin 2.0.3 to Discovery Plugin 3.0.0
Tom, thanks for the report. I am unable to reproduce. I wonder what is different in your environment. Primary interface should have been detected correctly. Can you run foreman-rake console and issue:
::Host::Discovered.last.primary_interface
::Host::Discovered.last.primary_interface.ip
Instead of "last" you can use "find(ID)". Paste the output please. Ty.
Updated by Lukas Zapletal about 11 years ago
This might be interesting as well:
::Host::Discovered.last.interfaces
Updated by Lukas Zapletal about 11 years ago
One last thing, please pastebin or verbosely copy this (or send me directly to lzap|redhatdotcom):
FACTERLIB=/usr/share/fdi/facts/ facter --json
Updated by Lukas Zapletal about 11 years ago
- Status changed from New to Need more information
Hello, I have just filed a new bug (#10004) - when a host is discovered with an IP that is already present in Foreman, we error out with this weird error instead of proper error message "IP address already in use" or similar. Can you verify that the IP address the discovered host was trying to register with is already defined as an existing host in Foreman?
We currently do not allow multiple hosts with same IPs.
Updated by Lukas Zapletal about 11 years ago
- Related to Bug #10004: Discovery of a host with already known IP address fails with: address family must be specified added
Updated by Lukas Zapletal almost 11 years ago
Ok it looks like app/lib/puppet_fact_parser_extensions.rb is not used at all. This has nothing to do with #10004. Fact importer in Core is broken in 1.8 or something. Need to investigate.
Updated by Rob Greenwood almost 11 years ago
Debug log attached
Updated by The Foreman Bot almost 11 years ago
- Status changed from Need more information to Ready For Testing
- Pull request https://github.com/theforeman/foreman_discovery/pull/193 added
- Pull request deleted (
)
Updated by Lukas Zapletal almost 11 years ago
We have a workaround now, set 'ignore_puppet_facts_for_provisioning' setting to false until 3.0.1 plugin is released!
Updated by Lukas Zapletal almost 11 years ago
- Related to Bug #10852: Discovery image discovery_bootif doesn't match boot interface and can't discover host added
Updated by Anonymous almost 11 years ago
- Status changed from Ready For Testing to Closed
- % Done changed from 0 to 100
Applied in changeset foreman_discovery|4c018bc136f7db433b3bbcfbdb97cca53bd3e64a.
Updated by Byron Miller almost 11 years ago
I'm having same issue of foreman discovery booting, but posting same error when calling home. This happens on anything with more than one interface where the more than one interface gets DHCP and isn't the first interface.
Updated by tony zheng almost 11 years ago
can someone tell me where is the 'ignore_puppet_facts_for_provisioning' setting? i cannot find it. i am on foreman 1.8.2 RHEL 6.
thanks,
Updated by Dominic Cleal almost 11 years ago
tony zheng wrote:
can someone tell me where is the 'ignore_puppet_facts_for_provisioning' setting? i cannot find it. i am on foreman 1.8.2 RHEL 6.
thanks,
Administer > Settings > Provisioning.
Updated by Simon Wydooghe almost 11 years ago
I've set 'ignore_puppet_facts_for_provisioning' setting to false, but it doesn't seem to affect the problem. I've confirmed the hosts with this problem have the same IP as other hosts that were built using Foreman a few days ago. We build a lot of hosts locally and then they get shipped off to remote locations where they get a new IP address in whatever LAN they end up. But for now, all these hosts are still stored on-site and Foreman doesn't want to accept newly built hosts that got the new DHCP lease. Any ideas? Foreman 1.8.2 and Discovery 3.0.0.
Foreman log:
2015-08-16 17:26:54 [I] Started POST "/api/v2/discovered_hosts/facts" for 10.30.6.56 at 2015-08-16 17:26:54 +0200
2015-08-16 17:26:54 [I] Processing by Api::V2::DiscoveredHostsController#facts as JSON
2015-08-16 17:26:54 [I] Parameters: {"facts"=>"[FILTERED]", "apiv"=>"v2", "discovered_host"=>{"facts"=>"[FILTERED]"}}
2015-08-16 17:26:54 [I] Import facts for 'mac3417eb6a0416' completed. Added: 80, Updated: 0, Deleted 0 facts
2015-08-16 17:26:54 [W] Saving enp1s0 NIC for host mac3417eb6a0416 failed, skipping because:
2015-08-16 17:26:54 [W] IP address has already been taken
2015-08-16 17:26:54 [E] address family must be specified (ArgumentError)
Updated by Lukas Zapletal almost 11 years ago
I'd suggest to modify your reservation pool outside lease pool but still inside the subnet range. Described at the end of this chapter: http://theforeman.org/manuals/1.8/#3.2.3InstallationScenarios
Updated by Simon Wydooghe almost 11 years ago
Cheers, thank you for your help, Lukas! Sorry for the late update, needed to hurry along a bit so I created a new large subnet two days ago just for provisioning. This seemed to work.
Looking forward to trying out Discovery 4.0.0!