Actions
Bug #31518
closedforeman_hooks: create hook fails to render host with "You cannot call create unless the parent is saved"
Difficulty:
Triaged:
No
Bugzilla link:
Pull request:
Description
The issue only seems present during the create hook, other hooks (update, destroy, before_update, ...) have a correct json representation of the hook object.
I upgraded from 2.2.1 (which works fine) directly to 2.3.1 (have not tested this behavior on 2.3.0).
limited / incorrect json of the host object provided during create hook:
{ "id": null, "name": "testhost.lan", "last_compile": null, "last_report": null, "updated_at": null, "created_at": null, "root_pass": "< removed >", "architecture_id": 1, "operatingsystem_id": 7, "environment_id": 32, "ptable_id": 143, "medium_id": 18, "build": true, "comment": "testhost install", "disk": "", "installed_at": null, "model_id": null, "hostgroup_id": 3, "owner_id": 7, "owner_type": "User", "enabled": true, "puppet_ca_proxy_id": 3, "managed": true, "use_image": null, "image_file": "", "uuid": null, "compute_resource_id": 7, "puppet_proxy_id": 2, "certname": "testhost.lan", "image_id": null, "organization_id": 1, "location_id": 2, "otp": null, "realm_id": null, "compute_profile_id": 4, "provision_method": "build", "grub_pass": "< removed >", "global_status": 0, "lookup_value_matcher": "fqdn=testhost.lan", "pxe_loader": "PXELinux BIOS", "initiated_at": null, "build_errors": null }
full / correct json of the host object provided during other hooks:
{ "host": { "ip": "< removed >", "ip6": "", "environment_id": 32, "environment_name": "< removed >", "last_report": "2020-12-16 09:15:48 +0100", "mac": "< removed >", "realm_id": null, "realm_name": null, "sp_mac": null, "sp_ip": null, "sp_name": null, "domain_id": 1, "domain_name": "< removed >", "architecture_id": 1, "architecture_name": "x86_64", "operatingsystem_id": 7, "operatingsystem_name": "RHEL 7.8", "subnet_id": 1, "subnet_name": "< removed >", "subnet6_id": null, "subnet6_name": null, "sp_subnet_id": null, "ptable_id": 143, "ptable_name": "< removed >", "medium_id": 18, "medium_name": "< removed >", "pxe_loader": "PXELinux BIOS", "build": false, "comment": "testhost update", "disk": "", "installed_at": "2020-12-15 13:40:04 +0100", "model_id": 1, "hostgroup_id": 3, "owner_id": 7, "owner_name": "< removed >", "owner_type": "User", "enabled": true, "managed": true, "use_image": null, "image_file": "", "uuid": "< removed >", "compute_resource_id": 7, "compute_resource_name": "< removed >", "compute_profile_id": 4, "compute_profile_name": "< removed >", "capabilities": [ "build", "image", "snapshots", "snapshot_include_ram", "editable_snapshot_name" ], "provision_method": "build", "certname": "testhost.lan", "image_id": null, "image_name": null, "created_at": "2020-12-15 13:29:33 +0100", "updated_at": "2020-12-16 09:16:53 +0100", "last_compile": null, "global_status": 0, "global_status_label": "OK", "uptime_seconds": 71759, "organization_id": 1, "organization_name": "< removed >", "location_id": 2, "location_name": "< removed >", "puppet_status": 0, "model_name": "VMware Virtual Platform", "configuration_status": 0, "configuration_status_label": "No changes", "build_status": 0, "build_status_label": "Installed", "name": "testhost.lan", "id": 184, "puppet_proxy_id": 2, "puppet_proxy_name": "< removed >", "puppet_ca_proxy_id": 3, "puppet_ca_proxy_name": "< removed >", "puppet_proxy": { "name": "< removed >", "id": 2, "url": "< removed >" }, "puppet_ca_proxy": { "name": "< removed >", "id": 3, "url": "< removed >" }, "registration_token": "< removed >", "hostgroup_name": "< removed >", "hostgroup_title": "< removed >", "parameters": [], "all_parameters": [ { "priority": 60, "created_at": "2020-08-27 13:02:49 +0200", "updated_at": "2020-08-27 13:02:49 +0200", "id": 15, "name": "< removed >", "parameter_type": "string", "value": "< removed >" }, { "priority": 60, "created_at": "2020-08-27 13:02:49 +0200", "updated_at": "2020-08-27 13:02:49 +0200", "id": 13, "name": "< removed >", "parameter_type": "string", "value": "417" }, { "priority": 60, "created_at": "2020-08-27 13:02:49 +0200", "updated_at": "2020-08-27 13:02:49 +0200", "id": 14, "name": "< removed >", "parameter_type": "string", "value": "418" }, { "priority": 60, "created_at": "2020-08-27 13:02:49 +0200", "updated_at": "2020-08-28 17:24:05 +0200", "id": 12, "name": "< removed >", "parameter_type": "string", "value": "333" }, { "priority": 60, "created_at": "2020-08-27 13:02:49 +0200", "updated_at": "2020-08-27 13:02:49 +0200", "id": 11, "name": "< removed >", "parameter_type": "string", "value": "< removed >" }, { "priority": 0, "created_at": "2020-12-15 17:02:58 +0100", "updated_at": "2020-12-15 17:02:58 +0100", "id": 56, "name": "host_registration_remote_execution", "parameter_type": "boolean", "value": true }, { "priority": 0, "created_at": "2020-12-15 17:02:58 +0100", "updated_at": "2020-12-15 17:02:58 +0100", "id": 55, "name": "host_registration_insights", "parameter_type": "boolean", "value": false } ], "interfaces": [ { "subnet_id": 1, "subnet_name": "< removed >", "subnet6_id": null, "subnet6_name": null, "domain_id": 1, "domain_name": "< removed >", "created_at": "2020-12-15 13:29:42 +0100", "updated_at": "2020-12-15 14:15:59 +0100", "managed": true, "identifier": "eth0", "id": 222, "name": "testhost.lan", "ip": "< removed >", "ip6": "", "mac": "< removed >", "mtu": 1500, "fqdn": "testhost.lan", "primary": true, "provision": true, "type": "interface", "virtual": false }, { "subnet_id": null, "subnet_name": null, "subnet6_id": null, "subnet6_name": null, "domain_id": null, "domain_name": null, "created_at": "2020-12-15 13:29:42 +0100", "updated_at": "2020-12-15 14:15:59 +0100", "managed": true, "identifier": "eth1", "id": 223, "name": "", "ip": "< removed >", "ip6": "", "mac": "< removed >", "mtu": 1500, "fqdn": "", "primary": false, "provision": false, "type": "interface", "virtual": false }, { "subnet_id": null, "subnet_name": null, "subnet6_id": null, "subnet6_name": null, "domain_id": null, "domain_name": null, "created_at": "2020-12-15 13:29:42 +0100", "updated_at": "2020-12-15 14:15:59 +0100", "managed": true, "identifier": "eth2", "id": 224, "name": "", "ip": "< removed >", "ip6": "", "mac": "< removed >", "mtu": 1500, "fqdn": "", "primary": false, "provision": false, "type": "interface", "virtual": false } ], "puppetclasses": [], "config_groups": [], "all_puppetclasses": [], "permissions": { "view_hosts": true, "create_hosts": true, "edit_hosts": true, "destroy_hosts": true, "build_hosts": true, "power_hosts": true, "console_hosts": true, "ipmi_boot_hosts": true, "forget_status_hosts": true, "view_snapshots": true, "create_snapshots": true, "edit_snapshots": true, "destroy_snapshots": true, "revert_snapshots": true } } }
Related logs:
2020-12-16T09:33:35 [I|app|3932de9d] Started POST "/hosts" for 127.0.0.1 at 2020-12-16 09:33:35 +0100 2020-12-16T09:33:35 [I|app|3932de9d] Processing by HostsController#create as */* 2020-12-16T09:33:35 [I|app|3932de9d] Parameters: {"utf8"=>"✓", "authenticity_token"=>"NeXp8srqIdh1D/bri8ZKG8rucFMtbjI9zVVvZBsmHIUZ9oDAwfCU/fXe1Jd03B1Ywf6CgYNkTNgzreUy7RVBAA==", "host"=>{"name"=>"testhost", "organization_id"=>"1", "location_id"=>"2", "hostgroup_id"=>"3", "compute_resource_id"=>"7", "environment_id"=>"32", "puppetclass_ids"=>[""], "managed"=>"true", "progress_report_id"=>"[FILTERED]", "type"=>"Host::Managed", "interfaces_attributes"=>{"0"=>{"_destroy"=>"0", "type"=>"Nic::Managed", "identifier"=>"", "name"=>"testhost", "domain_id"=>"1", "subnet_id"=>"1", "ip"=>"< removed >", "ip6"=>"", "managed"=>"1", "primary"=>"1", "provision"=>"1", "virtual"=>"0", "tag"=>"", "attached_to"=>"", "compute_attributes"=>{"type"=>"VirtualVmxnet3", "network"=>"< removed >"}}, "1"=>{"_destroy"=>"0", "type"=>"Nic::Managed", "identifier"=>"", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"", "ip6"=>"", "managed"=>"1", "primary"=>"0", "provision"=>"0", "virtual"=>"0", "tag"=>"", "attached_to"=>"", "compute_attributes"=>{"type"=>"VirtualVmxnet3", "network"=>"< removed >"}}, "2"=>{"_destroy"=>"0", "type"=>"Nic::Managed", "identifier"=>"", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"", "ip6"=>"", "managed"=>"1", "primary"=>"0", "provision"=>"0", "virtual"=>"0", "tag"=>"", "attached_to"=>"", "compute_attributes"=>{"type"=>"VirtualVmxnet3", "network"=>"< removed >"}}}, "compute_attributes"=>{"cpus"=>"2", "corespersocket"=>"1", "memory_mb"=>"2048", "firmware"=>"bios", "cluster"=>"< removed >", "resource_pool"=>"Resources", "path"=>"< removed >", "guest_id"=>"rhel7_64Guest", "hardware_version"=>"Default", "memoryHotAddEnabled"=>"1", "cpuHotAddEnabled"=>"1", "add_cdrom"=>"0", "boot_order"=>["network", "disk"], "start"=>"1", "annotation"=>"", "scsi_controllers"=>"{\"scsiControllers\":[{\"type\":\"ParaVirtualSCSIController\",\"key\":1000}],\"volumes\":[{\"thin\":\"false\",\"name\":\"sda\",\"mode\":\"persistent\",\"controllerKey\":1000,\"datastore\":\"< removed >\",\"sizeGb\":1,\"eagerZero\":\"false\",\"storagePod\":null},{\"thin\":\"false\",\"name\":\"sdb\",\"mode\":\"persistent\",\"controllerKey\":1000,\"datastore\":\"< removed >\",\"sizeGb\":40,\"eagerZero\":\"false\",\"storagePod\":null}]}"}, "architecture_id"=>"1", "operatingsystem_id"=>"7", "provision_method"=>"build", "build"=>"1", "medium_id"=>"18", "ptable_id"=>"143", "pxe_loader"=>"PXELinux BIOS", "disk"=>"", "root_pass"=>"[FILTERED]", "is_owned_by"=>"7-Users", "enabled"=>"1", "comment"=>"testhost install", "overwrite"=>"false"}} 2020-12-16T09:33:35 [D|tax|3932de9d] Current location set to none 2020-12-16T09:33:35 [D|tax|3932de9d] Current organization set to none 2020-12-16T09:33:35 [D|app|3932de9d] Scheduling new DHCP reservations for testhost.lan 2020-12-16T09:33:35 [D|app|3932de9d] Enqueued task 'dhcp_create_10.122.84.48' to 'Host::Managed Main' queue 2020-12-16T09:33:35 [D|app|3932de9d] Scheduling new DNS entries 2020-12-16T09:33:35 [D|app|3932de9d] Enqueued task 'Create IPv4 DNS record for testhost.lan' to 'Host::Managed Main' queue 2020-12-16T09:33:35 [D|app|3932de9d] Enqueued task 'Create Reverse IPv4 DNS record for testhost.lan' to 'Host::Managed Main' queue 2020-12-16T09:33:35 [D|tax|3932de9d] Current organization set to < removed > 2020-12-16T09:33:35 [D|tax|3932de9d] Current location set to < removed > 2020-12-16T09:33:35 [D|tax|3932de9d] Current location set to none 2020-12-16T09:33:35 [D|tax|3932de9d] Current organization set to none 2020-12-16T09:33:35 [D|app|3932de9d] Enqueued task 'Deploy TFTP PXELinux config for testhost.lan' to 'Host::Managed Main' queue 2020-12-16T09:33:35 [D|app|3932de9d] Enqueued task 'Deploy TFTP PXEGrub2 config for testhost.lan' to 'Host::Managed Main' queue 2020-12-16T09:33:35 [D|app|3932de9d] Enqueued task 'Deploy TFTP PXEGrub config for testhost.lan' to 'Host::Managed Main' queue 2020-12-16T09:33:35 [D|app|3932de9d] Enqueued task 'Deploy TFTP iPXE config for testhost.lan' to 'Host::Managed Main' queue 2020-12-16T09:33:35 [D|app|3932de9d] Enqueued task 'Fetch TFTP boot files for testhost.lan' to 'Host::Managed Main' queue 2020-12-16T09:33:35 [D|app|3932de9d] Enqueued task 'Set up compute instance testhost.lan' to 'Host::Managed Main' queue 2020-12-16T09:33:35 [D|app|3932de9d] Enqueued task 'Query instance details for testhost.lan' to 'Host::Managed Main' queue 2020-12-16T09:33:35 [D|app|3932de9d] Enqueued task 'Power up compute instance testhost.lan' to 'Host::Managed Main' queue 2020-12-16T09:33:35 [D|app|3932de9d] Observed create hook on testhost.lan 2020-12-16T09:33:35 [D|app|3932de9d] Queuing 2 hooks for Host::Managed#create 2020-12-16T09:33:35 [D|app|3932de9d] Queuing hook /usr/share/foreman/config/hooks/host/managed/create/0_create-custom_hook_actions for Host::Managed#create at priority 0 2020-12-16T09:33:35 [D|app|3932de9d] Enqueued task 'Hook: /usr/share/foreman/config/hooks/host/managed/create/0_create-custom_hook_actions' to 'Host::Managed Main' queue 2020-12-16T09:33:35 [D|app|3932de9d] Queuing hook /usr/share/foreman/config/hooks/host/managed/create/5_create-custom_hook_actions for Host::Managed#create at priority 5 2020-12-16T09:33:35 [D|app|3932de9d] Enqueued task 'Hook: /usr/share/foreman/config/hooks/host/managed/create/5_create-custom_hook_actions' to 'Host::Managed Main' queue 2020-12-16T09:33:35 [D|app|3932de9d] Observed postcreate hook on testhost.lan 2020-12-16T09:33:35 [D|app|3932de9d] Processing task 'Hook: /usr/share/foreman/config/hooks/host/managed/create/0_create-custom_hook_actions' from 'Host::Managed Main' 2020-12-16T09:33:35 [D|app|3932de9d] Running hook: /usr/share/foreman/config/hooks/host/managed/create/0_create-custom_hook_actions create testhost.lan 2020-12-16T09:33:35 [W|app|3932de9d] Unable to render testhost.lan (Host::Managed) using RABL: You cannot call create unless the parent is saved 2020-12-16T09:33:35 [D|app|3932de9d] /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/associations/has_one_association.rb:111:in `_create_record' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/associations/association.rb:199:in `create!' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/associations/builder/singular_association.rb:37:in `create_registration_facet!' 3932de9d | /usr/share/foreman/app/models/concerns/foreman_register/host_extensions.rb:8:in `registration_facet!' 3932de9d | /usr/share/foreman/app/models/concerns/foreman_register/host_extensions.rb:12:in `registration_token' 3932de9d | /usr/share/foreman/app/views/api/v2/hosts/main.json.rabl:37:in `block in cached_source_2132320255127778590' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/builder.rb:157:in `node' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/builder.rb:116:in `block in compile_settings' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/builder.rb:115:in `each' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/builder.rb:115:in `compile_settings' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/builder.rb:60:in `block in to_hash' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/builder.rb:252:in `cache_results' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/builder.rb:51:in `to_hash' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/engine.rb:90:in `to_hash' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/engine.rb:50:in `block in render' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/engine.rb:385:in `cache_results' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/engine.rb:49:in `render' 3932de9d | /usr/share/foreman/config/initializers/rabl_init.rb:49:in `render' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/builder.rb:129:in `block in merge_engines_into_result' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/builder.rb:121:in `each' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/builder.rb:121:in `merge_engines_into_result' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/builder.rb:57:in `block in to_hash' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/builder.rb:252:in `cache_results' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/builder.rb:51:in `to_hash' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/engine.rb:90:in `to_hash' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/engine.rb:103:in `to_dumpable' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/engine.rb:112:in `to_json' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/engine.rb:50:in `block in render' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/engine.rb:385:in `cache_results' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/engine.rb:49:in `render' 3932de9d | /usr/share/foreman/config/initializers/rabl_init.rb:49:in `render' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl/renderer.rb:54:in `render' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rabl-0.14.3/lib/rabl.rb:77:in `render' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/foreman_hooks-0.3.17/lib/foreman_hooks/util.rb:27:in `render_hook_json' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/foreman_hooks-0.3.17/lib/foreman_hooks/util.rb:44:in `block in exec_hook' 3932de9d | /opt/rh/rh-ruby25/root/usr/share/gems/gems/bundler-1.16.1/lib/bundler.rb:297:in `block in with_clean_env' 3932de9d | /opt/rh/rh-ruby25/root/usr/share/gems/gems/bundler-1.16.1/lib/bundler.rb:540:in `with_env' 3932de9d | /opt/rh/rh-ruby25/root/usr/share/gems/gems/bundler-1.16.1/lib/bundler.rb:297:in `with_clean_env' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/foreman_hooks-0.3.17/lib/foreman_hooks/util.rb:44:in `exec_hook' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/foreman_hooks-0.3.17/lib/foreman_hooks/orchestration_hook.rb:58:in `hook_execute_set' 3932de9d | /usr/share/foreman/app/models/concerns/orchestration.rb:227:in `execute' 3932de9d | /usr/share/foreman/app/models/concerns/orchestration.rb:152:in `block in process' 3932de9d | /usr/share/foreman/app/models/concerns/orchestration.rb:144:in `each' 3932de9d | /usr/share/foreman/app/models/concerns/orchestration.rb:144:in `process' 3932de9d | /usr/share/foreman/app/models/concerns/orchestration.rb:44:in `around_save_orchestration' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:121:in `block in run_callbacks' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:139:in `run_callbacks' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:825:in `_run_save_callbacks' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/callbacks.rb:327:in `create_or_update' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/timestamp.rb:128:in `create_or_update' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/persistence.rb:470:in `save' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/validations.rb:47:in `save' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/transactions.rb:314:in `block in save' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/transactions.rb:375:in `block in with_transaction_returning_status' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/connection_adapters/abstract/database_statements.rb:280:in `block in transaction' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/connection_adapters/abstract/transaction.rb:280:in `block in within_new_transaction' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/concurrency/load_interlock_aware_monitor.rb:26:in `block (2 levels) in synchronize' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/concurrency/load_interlock_aware_monitor.rb:25:in `handle_interrupt' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/concurrency/load_interlock_aware_monitor.rb:25:in `block in synchronize' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/concurrency/load_interlock_aware_monitor.rb:21:in `handle_interrupt' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/concurrency/load_interlock_aware_monitor.rb:21:in `synchronize' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/connection_adapters/abstract/transaction.rb:278:in `within_new_transaction' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/connection_adapters/abstract/database_statements.rb:280:in `transaction' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/transactions.rb:212:in `transaction' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/transactions.rb:366:in `with_transaction_returning_status' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/transactions.rb:314:in `save' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/suppressor.rb:44:in `save' 3932de9d | /usr/share/foreman/app/models/concerns/foreman/sti.rb:26:in `save' 3932de9d | /usr/share/foreman/app/controllers/hosts_controller.rb:98:in `create' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_controller/metal/basic_implicit_render.rb:6:in `send_action' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/abstract_controller/base.rb:195:in `process_action' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_controller/metal/rendering.rb:30:in `process_action' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/abstract_controller/callbacks.rb:42:in `block in process_action' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:112:in `block in run_callbacks' 3932de9d | /usr/share/foreman/app/controllers/concerns/foreman/controller/timezone.rb:10:in `set_timezone' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:121:in `block in run_callbacks' 3932de9d | /usr/share/foreman/app/models/concerns/foreman/thread_session.rb:32:in `clear_thread' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:121:in `block in run_callbacks' 3932de9d | /usr/share/foreman/app/controllers/concerns/foreman/controller/topbar_sweeper.rb:12:in `set_topbar_sweeper_controller' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:121:in `block in run_callbacks' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/audited-4.9.0/lib/audited/sweeper.rb:14:in `around' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:121:in `block in run_callbacks' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/audited-4.9.0/lib/audited/sweeper.rb:14:in `around' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:121:in `block in run_callbacks' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:139:in `run_callbacks' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/abstract_controller/callbacks.rb:41:in `process_action' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_controller/metal/rescue.rb:22:in `process_action' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_controller/metal/instrumentation.rb:33:in `block in process_action' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/notifications.rb:180:in `block in instrument' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/notifications/instrumenter.rb:24:in `instrument' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/notifications.rb:180:in `instrument' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_controller/metal/instrumentation.rb:32:in `process_action' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_controller/metal/params_wrapper.rb:245:in `process_action' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/railties/controller_runtime.rb:27:in `process_action' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/abstract_controller/base.rb:136:in `process' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionview-6.0.3.4/lib/action_view/rendering.rb:39:in `process' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_controller/metal.rb:190:in `dispatch' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_controller/metal.rb:254:in `dispatch' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/routing/route_set.rb:50:in `dispatch' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/routing/route_set.rb:33:in `serve' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/journey/router.rb:49:in `block in serve' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/journey/router.rb:32:in `each' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/journey/router.rb:32:in `serve' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/routing/route_set.rb:834:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/apipie-dsl-2.3.0/lib/apipie_dsl/static_dispatcher.rb:67:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/apipie-rails-0.5.17/lib/apipie/static_dispatcher.rb:66:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/apipie-rails-0.5.17/lib/apipie/extractor/recorder.rb:137:in `call' 3932de9d | /usr/share/foreman/lib/foreman/middleware/telemetry.rb:10:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/apipie-rails-0.5.17/lib/apipie/middleware/checksum_in_headers.rb:27:in `call' 3932de9d | /usr/share/foreman/lib/foreman/middleware/catch_json_parse_errors.rb:9:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/tempfile_reaper.rb:15:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/etag.rb:27:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/conditional_get.rb:40:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/head.rb:12:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/http/content_security_policy.rb:18:in `call' 3932de9d | /usr/share/foreman/lib/foreman/middleware/logging_context_session.rb:22:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/session/abstract/id.rb:266:in `context' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/session/abstract/id.rb:260:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/cookies.rb:648:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/callbacks.rb:27:in `block in call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:101:in `run_callbacks' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/callbacks.rb:26:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/actionable_exceptions.rb:18:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/debug_exceptions.rb:32:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/show_exceptions.rb:33:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/railties-6.0.3.4/lib/rails/rack/logger.rb:37:in `call_app' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/railties-6.0.3.4/lib/rails/rack/logger.rb:28:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/sprockets-rails-3.2.1/lib/sprockets/rails/quiet_assets.rb:13:in `call' 3932de9d | /usr/share/foreman/lib/foreman/middleware/logging_context_request.rb:11:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/remote_ip.rb:81:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/request_id.rb:27:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/method_override.rb:24:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/runtime.rb:22:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/cache/strategy/local_cache_middleware.rb:29:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/executor.rb:14:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/static.rb:126:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/sendfile.rb:110:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/host_authorization.rb:76:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/secure_headers-6.3.0/lib/secure_headers/middleware.rb:11:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/railties-6.0.3.4/lib/rails/engine.rb:527:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/railties-6.0.3.4/lib/rails/railtie.rb:190:in `public_send' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/railties-6.0.3.4/lib/rails/railtie.rb:190:in `method_missing' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/urlmap.rb:74:in `block in call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/urlmap.rb:58:in `each' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/urlmap.rb:58:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/puma-4.3.6/lib/puma/configuration.rb:228:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/puma-4.3.6/lib/puma/server.rb:713:in `handle_request' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/puma-4.3.6/lib/puma/server.rb:472:in `process_client' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/puma-4.3.6/lib/puma/server.rb:328:in `block in run' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/puma-4.3.6/lib/puma/thread_pool.rb:134:in `block in spawn_thread' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/logging-2.3.0/lib/logging/diagnostic_context.rb:474:in `block in create_with_logging_context' 2020-12-16T09:33:36 [I|app|eb41e8b4] Started GET "/tasks/1746e212-fb37-4f13-b48a-0cf961ba3005" for 127.0.0.1 at 2020-12-16 09:33:36 +0100 2020-12-16T09:33:36 [I|app|eb41e8b4] Processing by TasksController#show as */* 2020-12-16T09:33:36 [I|app|eb41e8b4] Parameters: {"id"=>"1746e212-fb37-4f13-b48a-0cf961ba3005"} 2020-12-16T09:33:36 [I|app|eb41e8b4] Rendered tasks/_list.html.erb (Duration: 0.9ms | Allocations: 689) 2020-12-16T09:33:36 [I|app|eb41e8b4] Completed 200 OK in 8ms (Views: 2.2ms | ActiveRecord: 1.0ms | Allocations: 3269) 2020-12-16T09:33:38 [I|app|1af756af] Started GET "/users/login" for 127.0.0.1 at 2020-12-16 09:33:38 +0100 2020-12-16T09:33:38 [I|app|5cdeac80] Started GET "/users/login" for 127.0.0.1 at 2020-12-16 09:33:38 +0100 2020-12-16T09:33:38 [I|app|1af756af] Processing by UsersController#login as HTML 2020-12-16T09:33:38 [I|app|5cdeac80] Processing by UsersController#login as HTML 2020-12-16T09:33:38 [I|app|df1ab7b3] Started GET "/users/login" for 127.0.0.1 at 2020-12-16 09:33:38 +0100 2020-12-16T09:33:38 [I|app|df1ab7b3] Processing by UsersController#login as HTML 2020-12-16T09:33:38 [I|app|5cdeac80] Rendering users/login.html.erb within layouts/login 2020-12-16T09:33:38 [I|app|1af756af] Rendering users/login.html.erb within layouts/login 2020-12-16T09:33:38 [I|app|5cdeac80] Rendered common/_login.html.erb (Duration: 2.7ms | Allocations: 5081) 2020-12-16T09:33:38 [I|app|5cdeac80] Rendered users/login.html.erb within layouts/login (Duration: 7.4ms | Allocations: 10220) 2020-12-16T09:33:38 [I|app|5cdeac80] Rendering layouts/base.html.erb 2020-12-16T09:33:38 [I|app|1af756af] Rendered common/_login.html.erb (Duration: 3.2ms | Allocations: 5120) 2020-12-16T09:33:38 [I|app|1af756af] Rendered users/login.html.erb within layouts/login (Duration: 7.9ms | Allocations: 10295) 2020-12-16T09:33:38 [I|app|5cdeac80] Rendered layouts/base.html.erb (Duration: 4.3ms | Allocations: 6120) 2020-12-16T09:33:38 [I|app|1af756af] Rendering layouts/base.html.erb 2020-12-16T09:33:38 [I|app|5cdeac80] Completed 200 OK in 26ms (Views: 15.0ms | ActiveRecord: 4.2ms | Allocations: 23007) 2020-12-16T09:33:38 [I|app|df1ab7b3] Rendering users/login.html.erb within layouts/login 2020-12-16T09:33:38 [I|app|1af756af] Rendered layouts/base.html.erb (Duration: 6.3ms | Allocations: 6689) 2020-12-16T09:33:38 [I|app|df1ab7b3] Rendered common/_login.html.erb (Duration: 2.6ms | Allocations: 5120) 2020-12-16T09:33:38 [I|app|df1ab7b3] Rendered users/login.html.erb within layouts/login (Duration: 6.6ms | Allocations: 10369) 2020-12-16T09:33:38 [I|app|df1ab7b3] Rendering layouts/base.html.erb 2020-12-16T09:33:38 [I|app|df1ab7b3] Rendered layouts/base.html.erb (Duration: 3.7ms | Allocations: 6155) 2020-12-16T09:33:38 [I|app|1af756af] Completed 200 OK in 47ms (Views: 23.7ms | ActiveRecord: 4.3ms | Allocations: 48026) 2020-12-16T09:33:38 [I|app|df1ab7b3] Completed 200 OK in 45ms (Views: 14.0ms | ActiveRecord: 7.4ms | Allocations: 46361) 2020-12-16T09:33:38 [I|app|45235c27] Started GET "/tasks/1746e212-fb37-4f13-b48a-0cf961ba3005" for 127.0.0.1 at 2020-12-16 09:33:38 +0100 2020-12-16T09:33:38 [I|app|45235c27] Processing by TasksController#show as */* 2020-12-16T09:33:38 [I|app|45235c27] Parameters: {"id"=>"1746e212-fb37-4f13-b48a-0cf961ba3005"} 2020-12-16T09:33:38 [I|app|45235c27] Rendered tasks/_list.html.erb (Duration: 3.9ms | Allocations: 5388) 2020-12-16T09:33:38 [I|app|45235c27] Completed 200 OK in 10ms (Views: 4.5ms | ActiveRecord: 1.1ms | Allocations: 7196) 2020-12-16T09:33:40 [I|app|7fe6cc67] Started GET "/tasks/1746e212-fb37-4f13-b48a-0cf961ba3005" for 127.0.0.1 at 2020-12-16 09:33:40 +0100 2020-12-16T09:33:40 [I|app|7fe6cc67] Processing by TasksController#show as */* 2020-12-16T09:33:40 [I|app|7fe6cc67] Parameters: {"id"=>"1746e212-fb37-4f13-b48a-0cf961ba3005"} 2020-12-16T09:33:40 [I|app|7fe6cc67] Rendered tasks/_list.html.erb (Duration: 3.8ms | Allocations: 5388) 2020-12-16T09:33:40 [I|app|7fe6cc67] Completed 200 OK in 9ms (Views: 4.2ms | ActiveRecord: 1.0ms | Allocations: 7194) 2020-12-16T09:33:41 [D|app|3932de9d] Hook output: ✘✘✘ HOOK SCRIPT OUTPUT ✘✘✘ please select a puppet environment (required by nsx-t) ✘✘✘ 3932de9d | 2020-12-16T09:33:41 [W|app|3932de9d] Hook: /usr/share/foreman/config/hooks/host/managed/create/0_create-custom_hook_actions task failed with the following error: Hook failure running `/usr/share/foreman/config/hooks/host/managed/create/0_create-custom_hook_actions create testhost.lan`: ✘✘✘ HOOK SCRIPT OUTPUT ✘✘✘ please select a puppet environment (required by nsx-t) ✘✘✘ 3932de9d | 2020-12-16T09:33:41 [I|app|3932de9d] Backtrace for 'Hook: /usr/share/foreman/config/hooks/host/managed/create/0_create-custom_hook_actions task failed with the following error: Hook failure running `/usr/share/foreman/config/hooks/host/managed/create/0_create-custom_hook_actions create testhost.lan`: ✘✘✘ HOOK SCRIPT OUTPUT ✘✘✘ please select a puppet environment (required by nsx-t) ✘✘✘ 3932de9d | ' error (ForemanHooks::Error): Hook failure running `/usr/share/foreman/config/hooks/host/managed/create/0_create-custom_hook_actions create testhost.lan`: ✘✘✘ HOOK SCRIPT OUTPUT ✘✘✘ please select a puppet environment (required by nsx-t) ✘✘✘ 3932de9d | 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/foreman_hooks-0.3.17/lib/foreman_hooks/util.rb:49:in `exec_hook' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/foreman_hooks-0.3.17/lib/foreman_hooks/orchestration_hook.rb:58:in `hook_execute_set' 3932de9d | /usr/share/foreman/app/models/concerns/orchestration.rb:227:in `execute' 3932de9d | /usr/share/foreman/app/models/concerns/orchestration.rb:152:in `block in process' 3932de9d | /usr/share/foreman/app/models/concerns/orchestration.rb:144:in `each' 3932de9d | /usr/share/foreman/app/models/concerns/orchestration.rb:144:in `process' 3932de9d | /usr/share/foreman/app/models/concerns/orchestration.rb:44:in `around_save_orchestration' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:121:in `block in run_callbacks' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:139:in `run_callbacks' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:825:in `_run_save_callbacks' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/callbacks.rb:327:in `create_or_update' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/timestamp.rb:128:in `create_or_update' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/persistence.rb:470:in `save' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/validations.rb:47:in `save' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/transactions.rb:314:in `block in save' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/transactions.rb:375:in `block in with_transaction_returning_status' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/connection_adapters/abstract/database_statements.rb:280:in `block in transaction' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/connection_adapters/abstract/transaction.rb:280:in `block in within_new_transaction' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/concurrency/load_interlock_aware_monitor.rb:26:in `block (2 levels) in synchronize' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/concurrency/load_interlock_aware_monitor.rb:25:in `handle_interrupt' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/concurrency/load_interlock_aware_monitor.rb:25:in `block in synchronize' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/concurrency/load_interlock_aware_monitor.rb:21:in `handle_interrupt' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/concurrency/load_interlock_aware_monitor.rb:21:in `synchronize' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/connection_adapters/abstract/transaction.rb:278:in `within_new_transaction' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/connection_adapters/abstract/database_statements.rb:280:in `transaction' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/transactions.rb:212:in `transaction' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/transactions.rb:366:in `with_transaction_returning_status' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/transactions.rb:314:in `save' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/suppressor.rb:44:in `save' 3932de9d | /usr/share/foreman/app/models/concerns/foreman/sti.rb:26:in `save' 3932de9d | /usr/share/foreman/app/controllers/hosts_controller.rb:98:in `create' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_controller/metal/basic_implicit_render.rb:6:in `send_action' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/abstract_controller/base.rb:195:in `process_action' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_controller/metal/rendering.rb:30:in `process_action' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/abstract_controller/callbacks.rb:42:in `block in process_action' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:112:in `block in run_callbacks' 3932de9d | /usr/share/foreman/app/controllers/concerns/foreman/controller/timezone.rb:10:in `set_timezone' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:121:in `block in run_callbacks' 3932de9d | /usr/share/foreman/app/models/concerns/foreman/thread_session.rb:32:in `clear_thread' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:121:in `block in run_callbacks' 3932de9d | /usr/share/foreman/app/controllers/concerns/foreman/controller/topbar_sweeper.rb:12:in `set_topbar_sweeper_controller' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:121:in `block in run_callbacks' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/audited-4.9.0/lib/audited/sweeper.rb:14:in `around' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:121:in `block in run_callbacks' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/audited-4.9.0/lib/audited/sweeper.rb:14:in `around' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:121:in `block in run_callbacks' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:139:in `run_callbacks' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/abstract_controller/callbacks.rb:41:in `process_action' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_controller/metal/rescue.rb:22:in `process_action' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_controller/metal/instrumentation.rb:33:in `block in process_action' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/notifications.rb:180:in `block in instrument' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/notifications/instrumenter.rb:24:in `instrument' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/notifications.rb:180:in `instrument' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_controller/metal/instrumentation.rb:32:in `process_action' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_controller/metal/params_wrapper.rb:245:in `process_action' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activerecord-6.0.3.4/lib/active_record/railties/controller_runtime.rb:27:in `process_action' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/abstract_controller/base.rb:136:in `process' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionview-6.0.3.4/lib/action_view/rendering.rb:39:in `process' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_controller/metal.rb:190:in `dispatch' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_controller/metal.rb:254:in `dispatch' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/routing/route_set.rb:50:in `dispatch' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/routing/route_set.rb:33:in `serve' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/journey/router.rb:49:in `block in serve' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/journey/router.rb:32:in `each' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/journey/router.rb:32:in `serve' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/routing/route_set.rb:834:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/apipie-dsl-2.3.0/lib/apipie_dsl/static_dispatcher.rb:67:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/apipie-rails-0.5.17/lib/apipie/static_dispatcher.rb:66:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/apipie-rails-0.5.17/lib/apipie/extractor/recorder.rb:137:in `call' 3932de9d | /usr/share/foreman/lib/foreman/middleware/telemetry.rb:10:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/apipie-rails-0.5.17/lib/apipie/middleware/checksum_in_headers.rb:27:in `call' 3932de9d | /usr/share/foreman/lib/foreman/middleware/catch_json_parse_errors.rb:9:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/tempfile_reaper.rb:15:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/etag.rb:27:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/conditional_get.rb:40:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/head.rb:12:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/http/content_security_policy.rb:18:in `call' 3932de9d | /usr/share/foreman/lib/foreman/middleware/logging_context_session.rb:22:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/session/abstract/id.rb:266:in `context' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/session/abstract/id.rb:260:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/cookies.rb:648:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/callbacks.rb:27:in `block in call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/callbacks.rb:101:in `run_callbacks' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/callbacks.rb:26:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/actionable_exceptions.rb:18:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/debug_exceptions.rb:32:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/show_exceptions.rb:33:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/railties-6.0.3.4/lib/rails/rack/logger.rb:37:in `call_app' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/railties-6.0.3.4/lib/rails/rack/logger.rb:28:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/sprockets-rails-3.2.1/lib/sprockets/rails/quiet_assets.rb:13:in `call' 3932de9d | /usr/share/foreman/lib/foreman/middleware/logging_context_request.rb:11:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/remote_ip.rb:81:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/request_id.rb:27:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/method_override.rb:24:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/runtime.rb:22:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/activesupport-6.0.3.4/lib/active_support/cache/strategy/local_cache_middleware.rb:29:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/executor.rb:14:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/static.rb:126:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/sendfile.rb:110:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/actionpack-6.0.3.4/lib/action_dispatch/middleware/host_authorization.rb:76:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/secure_headers-6.3.0/lib/secure_headers/middleware.rb:11:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/railties-6.0.3.4/lib/rails/engine.rb:527:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/railties-6.0.3.4/lib/rails/railtie.rb:190:in `public_send' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/railties-6.0.3.4/lib/rails/railtie.rb:190:in `method_missing' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/urlmap.rb:74:in `block in call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/urlmap.rb:58:in `each' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/rack-2.2.3/lib/rack/urlmap.rb:58:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/puma-4.3.6/lib/puma/configuration.rb:228:in `call' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/puma-4.3.6/lib/puma/server.rb:713:in `handle_request' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/puma-4.3.6/lib/puma/server.rb:472:in `process_client' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/puma-4.3.6/lib/puma/server.rb:328:in `block in run' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/puma-4.3.6/lib/puma/thread_pool.rb:134:in `block in spawn_thread' 3932de9d | /opt/theforeman/tfm/root/usr/share/gems/gems/logging-2.3.0/lib/logging/diagnostic_context.rb:474:in `block in create_with_logging_context' 2020-12-16T09:33:41 [W|app|3932de9d] Rolling back due to a problem: [#<Orchestration::Task:0x00007f4aefa6e168 @name="Hook: /usr/share/foreman/config/hooks/host/managed/create/0_create-custom_hook_actions", @id="Hook: /usr/share/foreman/config/hooks/host/managed/create/0_create-custom_hook_actions", @status="failed", @priority=0, @action=[#<ForemanHooks::OrchestrationHook::HookRunner:0x00007f4aefa6e230 @filename="/usr/share/foreman/config/hooks/host/managed/create/0_create-custom_hook_actions", @obj=#<Host::Managed id: nil, name: "testhost.lan", last_compile: nil, last_report: nil, updated_at: nil, created_at: nil, root_pass: [FILTERED], architecture_id: 1, operatingsystem_id: 7, environment_id: 32, ptable_id: 143, medium_id: 18, build: true, comment: "koen test", disk: "", installed_at: nil, model_id: nil, hostgroup_id: 3, owner_id: 7, owner_type: "User", enabled: true, puppet_ca_proxy_id: 3, managed: true, use_image: nil, image_file: nil, uuid: nil, compute_resource_id: 7, puppet_proxy_id: 2, certname: nil, image_id: nil, organization_id: 1, location_id: 2, type: "Host::Managed", otp: nil, realm_id: nil, compute_profile_id: 4, provision_method: "build", grub_pass: "$6$iWfTJ2QjaBoiDuFU$FSLrqUFXvMZB8EwsMjrN7/VEBMK5DW...", global_status: 0, lookup_value_matcher: [FILTERED], pxe_loader: "PXELinux BIOS", initiated_at: nil, build_errors: nil>, @event="create">, :hook_execute_set], @created=1608107615.3711407, @timestamp=2020-12-16 08:33:41 UTC>] 2020-12-16T09:33:41 [E|app|3932de9d] Failed to save: Hook: /usr/share/foreman/config/hooks/host/managed/create/0_create-custom_hook_actions task failed with the following error: Hook failure running `/usr/share/foreman/config/hooks/host/managed/create/0_create-custom_hook_actions create testhost.lan`: ✘✘✘ HOOK SCRIPT OUTPUT ✘✘✘ please select a puppet environment (required by nsx-t) ✘✘✘ 3932de9d | 2020-12-16T09:33:41 [I|app|3932de9d] Rendering hosts/new.html.erb within layouts/application 2020-12-16T09:33:41 [I|app|3932de9d] Rendered hosts/_progress.html.erb (Duration: 4.2ms | Allocations: 5054)
Actions