User that does not have Admin checkbox checked:

• Attempting to provision a new host. Provision > Host Tab > Environment > Any Environment
• Click on Puppet Classes tab and Notice Please select an environment first.

Take same user and click Admin it now loads the Puppet Classes.

Failure, debug logs:


2016-11-14 10:10:17 [app] [I] Started POST "/hosts/hostgroup_or_environment_selected" for 172.31.100.214 at 2016-11-14 10:10:17 -0600
2016-11-14 10:10:17 [app] [I] Processing by HostsController#hostgroup_or_environment_selected as */*
2016-11-14 10:10:17 [app] [I] Parameters: {"utf8"=>"✓", "authenticity_token"=>"WHE2AN+I/S/YnJ3ggXuumJv11aIsAXD7gF9KGYXeyKo=", "host"=>{"name"=>"cml90b11c3b4892", "hostgroup_id"=>"", "environment_id"=>"1", "puppet_ca_proxy_id"=>"", "puppet_proxy_id"=>"", "managed"=>"true", "progress_report_id"=>"[FILTERED]", "type"=>"Host::Managed", "interfaces_attributes"=>{"0"=>{"_destroy"=>"0", "mac"=>"90:b1:1c:3b:48:92", "identifier"=>"eno1", "name"=>"cml90b11c3b4892", "domain_id"=>"", "subnet_id"=>"13", "ip"=>"172.21.72.12", "managed"=>"1", "primary"=>"1", "provision"=>"1", "execution"=>"1", "tag"=>"", "attached_to"=>"", "id"=>"2962"}, "1"=>{"_destroy"=>"0", "mac"=>"90:b1:1c:3b:48:93", "identifier"=>"eno2", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"", "managed"=>"0", "primary"=>"0", "provision"=>"0", "execution"=>"0", "tag"=>"", "attached_to"=>"", "id"=>"2963"}, "2"=>{"_destroy"=>"0", "mac"=>"a0:36:9f:15:85:08", "identifier"=>"enp12s0f0", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"", "managed"=>"0", "primary"=>"0", "provision"=>"0", "execution"=>"0", "tag"=>"", "attached_to"=>"", "id"=>"2964"}, "3"=>{"_destroy"=>"0", "mac"=>"a0:36:9f:15:85:0a", "identifier"=>"enp12s0f1", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"", "managed"=>"0", "primary"=>"0", "provision"=>"0", "execution"=>"0", "tag"=>"", "attached_to"=>"", "id"=>"2965"}, "4"=>{"_destroy"=>"0", "mac"=>"00:c0:dd:25:75:4c", "identifier"=>"enp9s1f0", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"", "managed"=>"0", "primary"=>"0", "provision"=>"0", "execution"=>"0", "tag"=>"", "attached_to"=>"", "id"=>"2966"}, "5"=>{"_destroy"=>"0", "mac"=>"00:c0:dd:25:75:4e", "identifier"=>"enp9s1f2", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"", "managed"=>"0", "primary"=>"0", "provision"=>"0", "execution"=>"0", "tag"=>"", "attached_to"=>"", "id"=>"2967"}, "6"=>{"_destroy"=>"0", "mac"=>"90:b1:1c:3b:48:94", "identifier"=>"ipmi", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"172.21.72.80", "managed"=>"0", "primary"=>"0", "provision"=>"0", "execution"=>"0", "username"=>"", "provider"=>"IPMI", "id"=>"2968"}, "new_interfaces"=>{"_destroy"=>"1", "type"=>"Nic::Managed", "mac"=>"", "identifier"=>"", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"", "managed"=>"1", "primary"=>"0", "provision"=>"0", "execution"=>"0", "virtual"=>"0", "tag"=>"", "attached_to"=>""}}, "architecture_id"=>"", "build"=>"1", "disk"=>"", "is_owned_by"=>"53-Users", "enabled"=>"1", "model_id"=>"2", "comment"=>"", "overwrite"=>"false"}, "fakepassword"=>"[FILTERED]", "bare_metal_capabilities"=>"build", "host_id"=>"2178"}
2016-11-14 10:10:17 [sql] [D] ActiveRecord::SessionStore::Session Load (0.1ms) SELECT `sessions`.* FROM `sessions` WHERE `sessions`.`session_id` = '6609e8a2574d5fe1cccf4eaaab485a7d' ORDER BY `sessions`.`id` ASC LIMIT 1
2016-11-14 10:10:17 [sql] [D] User Load (0.1ms) SELECT `users`.* FROM `users` WHERE `users`.`id` = 53 LIMIT 1
2016-11-14 10:10:17 [app] [D] Setting current user thread-local variable to roletest
2016-11-14 10:10:17 [sql] [D] AuthSource Load (0.1ms) SELECT `auth_sources`.* FROM `auth_sources` WHERE `auth_sources`.`id` = 1 LIMIT 1
2016-11-14 10:10:17 [sql] [D] Usergroup Load (0.1ms) SELECT `usergroups`.* FROM `usergroups` INNER JOIN `cached_usergroup_members` ON `usergroups`.`id` = `cached_usergroup_members`.`usergroup_id` WHERE `cached_usergroup_members`.`user_id` = 53 ORDER BY usergroups.name
2016-11-14 10:10:17 [sql] [D] Role Load (0.1ms) SELECT DISTINCT `roles`.* FROM `roles` INNER JOIN `cached_user_roles` ON `roles`.`id` = `cached_user_roles`.`role_id` WHERE `cached_user_roles`.`user_id` = 53
2016-11-14 10:10:17 [sql] [D] (0.1ms) SELECT permissions.name FROM `permissions` INNER JOIN `filterings` ON `permissions`.`id` = `filterings`.`permission_id` INNER JOIN `filters` ON `filterings`.`filter_id` = `filters`.`id` WHERE `filters`.`role_id` = 8 ORDER BY filters.role_id, filters.id
2016-11-14 10:10:17 [sql] [D] (0.1ms) SELECT permissions.name FROM `permissions` INNER JOIN `filterings` ON `permissions`.`id` = `filterings`.`permission_id` INNER JOIN `filters` ON `filterings`.`filter_id` = `filters`.`id` WHERE `filters`.`role_id` = 5 ORDER BY filters.role_id, filters.id
2016-11-14 10:10:17 [sql] [D] Organization Load (0.1ms) SELECT `taxonomies`.* FROM `taxonomies` WHERE `taxonomies`.`type` IN ('Organization') AND `taxonomies`.`id` IS NULL ORDER BY `taxonomies`.`title` ASC LIMIT 1
2016-11-14 10:10:17 [sql] [D] Location Load (0.1ms) SELECT `taxonomies`.* FROM `taxonomies` WHERE `taxonomies`.`type` IN ('Location') AND `taxonomies`.`id` IS NULL ORDER BY `taxonomies`.`title` ASC LIMIT 1
2016-11-14 10:10:17 [app] [D] Setting current organization thread-local variable to none
2016-11-14 10:10:17 [app] [D] Setting current location thread-local variable to none
2016-11-14 10:10:17 [permissions] [D] checking permission view_hosts
2016-11-14 10:10:17 [sql] [D] Filter Load (0.7ms) SELECT `filters`.* FROM `filters` INNER JOIN `filterings` ON `filterings`.`filter_id` = `filters`.`id` INNER JOIN `permissions` ON `permissions`.`id` = `filterings`.`permission_id` INNER JOIN `roles` ON `filters`.`role_id` = `roles`.`id` INNER JOIN `cached_user_roles` ON `roles`.`id` = `cached_user_roles`.`role_id` WHERE `cached_user_roles`.`user_id` = 53 AND (permissions.resource_type = 'Host') AND (permissions.name = 'view_hosts') ORDER BY filters.role_id, filters.id
2016-11-14 10:10:17 [permissions] [D] filter with role_id: 5 limited: false search: taxonomy_search:
2016-11-14 10:10:17 [sql] [D] Host::Managed Load (0.2ms) SELECT `hosts`.* FROM `hosts` WHERE `hosts`.`type` IN ('Host::Managed') AND `hosts`.`id` = 2178 LIMIT 1
2016-11-14 10:10:17 [sql] [D] User Load (0.2ms) SELECT `users`.* FROM `users` WHERE `users`.`id` = 53 ORDER BY firstname LIMIT 1
2016-11-14 10:10:17 [app] [D] Setting current location thread-local variable to none
2016-11-14 10:10:17 [app] [D] Setting current organization thread-local variable to none
2016-11-14 10:10:17 [app] [D] not found: Couldn't find Nic::Base with ID=2962 for Host::Managed with ID=
2016-11-14 10:10:17 [app] [I] Rendered common/404.html.erb within layouts/application (1.6ms)
2016-11-14 10:10:17 [app] [I] Rendered layouts/_application_content.html.erb (0.2ms)
2016-11-14 10:10:17 [app] [I] Rendered layouts/base.html.erb (0.7ms)
2016-11-14 10:10:17 [app] [I] Completed 404 Not Found in 22ms (Views: 3.8ms | ActiveRecord: 1.9ms)
2016-11-14 10:10:17 [sql] [D] (0.1ms) BEGIN
2016-11-14 10:10:17 [sql] [D] SQL (0.2ms) UPDATE `sessions` SET `data` = 'BAh7DEkiCXVzZXIGOgZFRmk6SSIPZXhwaXJlc19hdAY7AEZsKwdpMytYSSIL\nbG9jYWxlBjsARiIHZW5JIhBfY3NyZl90b2tlbgY7AEZJIjFXSEUyQU4rSS9T\nL1luSjNnZ1h1dW1KdjExYUlzQVhEN2dGOUtHWVhleUtvPQY7AEZJIityZWRp\ncmVjdF90b191cmxfcHJvdmlzaW9uaW5nX3RlbXBsYXRlcwY7AFQiQWh0dHA6\nLy9wdXBwZXQubGFiLmJlZXIudG93bi90ZW1wbGF0ZXMvcHJvdmlzaW9uaW5n\nX3RlbXBsYXRlc0kiGnJlZGlyZWN0X3RvX3VybF9ob3N0cwY7AFQiRmh0dHA6\nLy9wdXBwZXQubGFiLmJlZXIudG93bi9kaXNjb3ZlcmVkX2hvc3RzL2NtbDkw\nYjExYzNiNDg5Mi9lZGl0SSIlcmVkaXJlY3RfdG9fdXJsX2Rpc2NvdmVyZWRf\naG9zdHMGOwBUIjFodHRwOi8vcHVwcGV0LmxhYi5iZWVyLnRvd24vZGlzY292\nZXJlZF9ob3N0cw==\n', `updated_at` = '2016-11-14 16:10:17' WHERE `sessions`.`id` = 2279826
2016-11-14 10:10:17 [sql] [D] (3.7ms) COMMIT


Success:


2016-11-14 10:09:02 [app] [I] Started POST "/hosts/hostgroup_or_environment_selected" for 172.31.100.214 at 2016-11-14 10:09:02 -0600
2016-11-14 10:09:02 [app] [I] Processing by HostsController#hostgroup_or_environment_selected as */*
2016-11-14 10:09:02 [app] [I] Parameters: {"utf8"=>"✓", "authenticity_token"=>"WHE2AN+I/S/YnJ3ggXuumJv11aIsAXD7gF9KGYXeyKo=", "host"=>{"name"=>"cml90b11c3b4892", "hostgroup_id"=>"", "environment_id"=>"1", "puppet_ca_proxy_id"=>"", "puppet_proxy_id"=>"", "managed"=>"true", "progress_report_id"=>"[FILTERED]", "type"=>"Host::Managed", "interfaces_attributes"=>{"0"=>{"_destroy"=>"0", "mac"=>"90:b1:1c:3b:48:92", "identifier"=>"eno1", "name"=>"cml90b11c3b4892", "domain_id"=>"", "subnet_id"=>"13", "ip"=>"172.21.72.12", "managed"=>"1", "primary"=>"1", "provision"=>"1", "execution"=>"1", "tag"=>"", "attached_to"=>"", "id"=>"2962"}, "1"=>{"_destroy"=>"0", "mac"=>"90:b1:1c:3b:48:93", "identifier"=>"eno2", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"", "managed"=>"0", "primary"=>"0", "provision"=>"0", "execution"=>"0", "tag"=>"", "attached_to"=>"", "id"=>"2963"}, "2"=>{"_destroy"=>"0", "mac"=>"a0:36:9f:15:85:08", "identifier"=>"enp12s0f0", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"", "managed"=>"0", "primary"=>"0", "provision"=>"0", "execution"=>"0", "tag"=>"", "attached_to"=>"", "id"=>"2964"}, "3"=>{"_destroy"=>"0", "mac"=>"a0:36:9f:15:85:0a", "identifier"=>"enp12s0f1", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"", "managed"=>"0", "primary"=>"0", "provision"=>"0", "execution"=>"0", "tag"=>"", "attached_to"=>"", "id"=>"2965"}, "4"=>{"_destroy"=>"0", "mac"=>"00:c0:dd:25:75:4c", "identifier"=>"enp9s1f0", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"", "managed"=>"0", "primary"=>"0", "provision"=>"0", "execution"=>"0", "tag"=>"", "attached_to"=>"", "id"=>"2966"}, "5"=>{"_destroy"=>"0", "mac"=>"00:c0:dd:25:75:4e", "identifier"=>"enp9s1f2", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"", "managed"=>"0", "primary"=>"0", "provision"=>"0", "execution"=>"0", "tag"=>"", "attached_to"=>"", "id"=>"2967"}, "6"=>{"_destroy"=>"0", "mac"=>"90:b1:1c:3b:48:94", "identifier"=>"ipmi", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"172.21.72.80", "managed"=>"0", "primary"=>"0", "provision"=>"0", "execution"=>"0", "username"=>"", "provider"=>"IPMI", "id"=>"2968"}, "new_interfaces"=>{"_destroy"=>"1", "type"=>"Nic::Managed", "mac"=>"", "identifier"=>"", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"", "managed"=>"1", "primary"=>"0", "provision"=>"0", "execution"=>"0", "virtual"=>"0", "tag"=>"", "attached_to"=>""}}, "architecture_id"=>"", "build"=>"1", "disk"=>"", "is_owned_by"=>"53-Users", "enabled"=>"1", "model_id"=>"2", "comment"=>"", "overwrite"=>"false"}, "fakepassword"=>"[FILTERED]", "bare_metal_capabilities"=>"build", "host_id"=>"2178"}
2016-11-14 10:09:02 [sql] [D] ActiveRecord::SessionStore::Session Load (0.3ms) SELECT `sessions`.* FROM `sessions` WHERE `sessions`.`session_id` = '6609e8a2574d5fe1cccf4eaaab485a7d' ORDER BY `sessions`.`id` ASC LIMIT 1
2016-11-14 10:09:02 [sql] [D] User Load (0.2ms) SELECT `users`.* FROM `users` WHERE `users`.`id` = 53 LIMIT 1
2016-11-14 10:09:02 [app] [D] Setting current user thread-local variable to roletest
2016-11-14 10:09:02 [sql] [D] AuthSource Load (0.1ms) SELECT `auth_sources`.* FROM `auth_sources` WHERE `auth_sources`.`id` = 1 LIMIT 1
2016-11-14 10:09:02 [sql] [D] Organization Load (0.1ms) SELECT `taxonomies`.* FROM `taxonomies` WHERE `taxonomies`.`type` IN ('Organization') AND `taxonomies`.`id` IS NULL ORDER BY `taxonomies`.`title` ASC LIMIT 1
2016-11-14 10:09:02 [sql] [D] Location Load (0.1ms) SELECT `taxonomies`.* FROM `taxonomies` WHERE `taxonomies`.`type` IN ('Location') AND `taxonomies`.`id` IS NULL ORDER BY `taxonomies`.`title` ASC LIMIT 1
2016-11-14 10:09:02 [app] [D] Setting current organization thread-local variable to none
2016-11-14 10:09:02 [app] [D] Setting current location thread-local variable to none
2016-11-14 10:09:02 [sql] [D] Host::Base Load (0.3ms) SELECT `hosts`.* FROM `hosts` WHERE `hosts`.`id` = 2178 LIMIT 1
2016-11-14 10:09:02 [sql] [D] Nic::Base Load (0.3ms) SELECT `nics`.* FROM `nics` WHERE `nics`.`host_id` = 2178 ORDER BY `nics`.`identifier` ASC
2016-11-14 10:09:02 [sql] [D] (0.1ms) BEGIN
2016-11-14 10:09:02 [sql] [D] Nic::Base Load (2.2ms) SELECT `nics`.* FROM `nics` WHERE `nics`.`ip` = '172.21.72.12'
2016-11-14 10:09:02 [sql] [D] Nic::Base Load (1.8ms) SELECT `nics`.* FROM `nics` WHERE `nics`.`domain_id` IS NULL AND `nics`.`name` = 'cml90b11c3b4892'
2016-11-14 10:09:02 [sql] [D] Subnet Load (0.1ms) SELECT `subnets`.* FROM `subnets` WHERE `subnets`.`id` = 13 ORDER BY vlanid LIMIT 1
2016-11-14 10:09:02 [sql] [D] Using host queue
2016-11-14 10:09:02 [sql] [D] SQL (0.4ms) UPDATE `nics` SET `attrs` = '--- !ruby/hash:ActiveSupport::HashWithIndifferentAccess\nnetwork: 172.21.72.0\nnetmask: 255.255.255.0\nmtu: 1500\nspeed: \'1000\'\nduplex: full\nport: Twisted Pair\nauto_negotiation: \'true\'\nwol: false\nlldp_neighbor_chassisid: ec:f4:bb:fc:08:e0\nlldp_neighbor_portid: ManagementEthernet 0/0\n', `compute_attributes` = '--- {}\n', `updated_at` = '2016-11-14 16:09:02' WHERE `nics`.`type` IN ('Nic::Managed', 'Nic::BMC', 'Nic::Bond', 'Nic::Bridge') AND `nics`.`id` = 2962
2016-11-14 10:09:02 [sql] [D] Using host queue
2016-11-14 10:09:02 [sql] [D] SQL (0.2ms) UPDATE `nics` SET `attrs` = '--- !ruby/hash:ActiveSupport::HashWithIndifferentAccess\nmtu: 1500\nspeed: \'1000\'\nduplex: full\nport: Twisted Pair\nauto_negotiation: \'true\'\nwol: false\nlldp_neighbor_chassisid: f8:b1:56:67:64:c0\nlldp_neighbor_portid: Te1/0/15\n', `compute_attributes` = '--- {}\n', `updated_at` = '2016-11-14 16:09:02' WHERE `nics`.`type` IN ('Nic::Managed', 'Nic::BMC', 'Nic::Bond', 'Nic::Bridge') AND `nics`.`id` = 2963
2016-11-14 10:09:02 [sql] [D] Using host queue
2016-11-14 10:09:02 [sql] [D] SQL (0.2ms) UPDATE `nics` SET `attrs` = '--- !ruby/hash:ActiveSupport::HashWithIndifferentAccess\nmtu: 1500\nspeed: \'10000\'\nduplex: full\nport: Direct Attach Copper\nauto_negotiation: \'false\'\nwol: false\nlldp_neighbor_chassisid: 00:01:e8:8b:40:40\nlldp_neighbor_portid: TenGigabitEthernet 0/23\n', `compute_attributes` = '--- {}\n', `updated_at` = '2016-11-14 16:09:02' WHERE `nics`.`type` IN ('Nic::Managed', 'Nic::BMC', 'Nic::Bond', 'Nic::Bridge') AND `nics`.`id` = 2964
2016-11-14 10:09:02 [sql] [D] Using host queue
2016-11-14 10:09:02 [sql] [D] SQL (0.2ms) UPDATE `nics` SET `attrs` = '--- !ruby/hash:ActiveSupport::HashWithIndifferentAccess\nmtu: 1500\nspeed: \'10000\'\nduplex: full\nport: Direct Attach Copper\nauto_negotiation: \'false\'\nwol: false\nlldp_neighbor_chassisid: 00:01:e8:8b:40:40\nlldp_neighbor_portid: TenGigabitEthernet 0/21\n', `compute_attributes` = '--- {}\n', `updated_at` = '2016-11-14 16:09:02' WHERE `nics`.`type` IN ('Nic::Managed', 'Nic::BMC', 'Nic::Bond', 'Nic::Bridge') AND `nics`.`id` = 2965
2016-11-14 10:09:02 [sql] [D] Using host queue
2016-11-14 10:09:02 [sql] [D] SQL (0.2ms) UPDATE `nics` SET `attrs` = '--- !ruby/hash:ActiveSupport::HashWithIndifferentAccess\nmtu: 1500\nspeed: \'1000\'\nduplex: full\nport: Twisted Pair\nauto_negotiation: \'true\'\nlldp_neighbor_chassisid: f8:b1:56:67:64:c0\nlldp_neighbor_portid: Te1/0/19\n', `compute_attributes` = '--- {}\n', `updated_at` = '2016-11-14 16:09:02' WHERE `nics`.`type` IN ('Nic::Managed', 'Nic::BMC', 'Nic::Bond', 'Nic::Bridge') AND `nics`.`id` = 2966
2016-11-14 10:09:02 [sql] [D] Using host queue
2016-11-14 10:09:02 [sql] [D] SQL (0.4ms) UPDATE `nics` SET `attrs` = '--- !ruby/hash:ActiveSupport::HashWithIndifferentAccess\nmtu: 1500\nspeed: \'1000\'\nduplex: full\nport: Twisted Pair\nauto_negotiation: \'true\'\nlldp_neighbor_chassisid: f8:b1:56:67:64:c0\nlldp_neighbor_portid: Te1/0/17\n', `compute_attributes` = '--- {}\n', `updated_at` = '2016-11-14 16:09:02' WHERE `nics`.`type` IN ('Nic::Managed', 'Nic::BMC', 'Nic::Bond', 'Nic::Bridge') AND `nics`.`id` = 2967
2016-11-14 10:09:02 [sql] [D] Nic::Base Load (2.2ms) SELECT `nics`.* FROM `nics` WHERE `nics`.`ip` = '172.21.72.80'
2016-11-14 10:09:02 [sql] [D] Using host queue
2016-11-14 10:09:02 [sql] [D] SQL (0.2ms) UPDATE `nics` SET `attrs` = '--- !ruby/hash:ActiveSupport::HashWithIndifferentAccess\nenabled: true\nipaddress_source: Static Address\nsubnet_mask: 255.255.255.0\ngateway: 172.21.72.1\n1_ipaddress_source: Static Address\n1_ipaddress: 172.21.72.80\n1_subnet_mask: 255.255.255.0\n1_macaddress: 90:b1:1c:3b:48:94\n1_gateway: 172.21.72.1\n', `compute_attributes` = '--- {}\n', `updated_at` = '2016-11-14 16:09:02' WHERE `nics`.`type` IN ('Nic::BMC') AND `nics`.`id` = 2968
2016-11-14 10:09:02 [sql] [D] (9.8ms) COMMIT
2016-11-14 10:09:02 [sql] [D] User Load (0.2ms) SELECT `users`.* FROM `users` WHERE `users`.`id` = 53 ORDER BY firstname LIMIT 1
2016-11-14 10:09:02 [sql] [D] (0.1ms) SELECT COUNT(*) FROM `config_groups`
2016-11-14 10:09:02 [sql] [D] ConfigGroup Load (0.1ms) SELECT `config_groups`.* FROM `config_groups` INNER JOIN `host_config_groups` ON `config_groups`.`id` = `host_config_groups`.`config_group_id` WHERE `host_config_groups`.`host_id` = 2178 AND `host_config_groups`.`host_type` = 'Host::Base' ORDER BY config_groups.name
2016-11-14 10:09:02 [sql] [D] ConfigGroup Load (0.1ms) SELECT `config_groups`.* FROM `config_groups` ORDER BY config_groups.name
2016-11-14 10:09:02 [sql] [D] ConfigGroupClass Load (0.1ms) SELECT `config_group_classes`.* FROM `config_group_classes` WHERE `config_group_classes`.`config_group_id` IN (23, 5, 14, 7, 9, 8, 10, 15, 20, 16, 6, 3, 12, 21, 19, 22, 18)
2016-11-14 10:09:02 [sql] [D] Puppetclass Load (0.1ms) SELECT `puppetclasses`.* FROM `puppetclasses` WHERE `puppetclasses`.`id` IN (212, 213, 107, 88, 204, 73, 41, 77, 9, 111, 109, 31, 87, 215, 200, 267, 266) ORDER BY puppetclasses.name
2016-11-14 10:09:02 [sql] [D] Environment Load (0.1ms) SELECT `environments`.* FROM `environments` WHERE `environments`.`id` = 1 ORDER BY environments.name LIMIT 1
2016-11-14 10:09:02 [sql] [D] Puppetclass Load (0.2ms) SELECT DISTINCT `puppetclasses`.* FROM `puppetclasses` INNER JOIN `environment_classes` ON `puppetclasses`.`id` = `environment_classes`.`puppetclass_id` WHERE `environment_classes`.`environment_id` = 1 ORDER BY puppetclasses.name
2016-11-14 10:09:02 [app] [I] Rendered config_groups/_config_group.html.erb (11.4ms)
2016-11-14 10:09:02 [app] [I] Rendered config_groups/_config_group.html.erb (1.6ms)
2016-11-14 10:09:02 [app] [I] Rendered config_groups/_config_group.html.erb (1.6ms)
2016-11-14 10:09:02 [app] [I] Rendered config_groups/_config_group.html.erb (1.2ms)
2016-11-14 10:09:02 [app] [I] Rendered config_groups/_config_group.html.erb (1.2ms)
2016-11-14 10:09:02 [app] [I] Rendered config_groups/_config_group.html.erb (1.2ms)
2016-11-14 10:09:02 [app] [I] Rendered config_groups/_config_group.html.erb (1.2ms)
2016-11-14 10:09:02 [app] [I] Rendered config_groups/_config_group.html.erb (1.1ms)
2016-11-14 10:09:02 [app] [I] Rendered config_groups/_config_group.html.erb (1.0ms)
2016-11-14 10:09:02 [app] [I] Rendered config_groups/_config_group.html.erb (1.2ms)
2016-11-14 10:09:02 [app] [I] Rendered config_groups/_config_group.html.erb (1.4ms)
2016-11-14 10:09:02 [app] [I] Rendered config_groups/_config_group.html.erb (1.8ms)
2016-11-14 10:09:02 [app] [I] Rendered config_groups/_config_group.html.erb (1.2ms)
2016-11-14 10:09:02 [app] [I] Rendered config_groups/_config_group.html.erb (1.1ms)
2016-11-14 10:09:02 [app] [I] Rendered config_groups/_config_group.html.erb (1.4ms)
2016-11-14 10:09:02 [app] [I] Rendered config_groups/_config_group.html.erb (1.6ms)
2016-11-14 10:09:02 [app] [I] Rendered config_groups/_config_group.html.erb (1.4ms)
2016-11-14 10:09:02 [app] [I] Rendered config_groups/_config_groups_selection.html.erb (56.5ms)
2016-11-14 10:09:02 [sql] [D] HostClass Load (0.2ms) SELECT `host_classes`.* FROM `host_classes` WHERE `host_classes`.`host_id` = 2178
2016-11-14 10:09:02 [sql] [D] (0.1ms) SELECT `config_group_classes`.`puppetclass_id` FROM `config_group_classes` WHERE 1=0
2016-11-14 10:09:02 [sql] [D] Puppetclass Load (0.1ms) SELECT DISTINCT `puppetclasses`.* FROM `puppetclasses` INNER JOIN `environment_classes` ON `puppetclasses`.`id` = `environment_classes`.`puppetclass_id` WHERE `environment_classes`.`environment_id` = 1 AND 1=0 ORDER BY puppetclasses.name
2016-11-14 10:09:02 [app] [I] Rendered puppetclasses/_selectedClasses.html.erb (0.0ms)
2016-11-14 10:09:02 [sql] [D] CACHE (0.0ms) SELECT `config_group_classes`.`puppetclass_id` FROM `config_group_classes` WHERE 1=0
2016-11-14 10:09:02 [sql] [D] CACHE (0.0ms) SELECT DISTINCT `puppetclasses`.* FROM `puppetclasses` INNER JOIN `environment_classes` ON `puppetclasses`.`id` = `environment_classes`.`puppetclass_id` WHERE `environment_classes`.`environment_id` = 1 AND 1=0 ORDER BY puppetclasses.name [["environment_id", 1]]
2016-11-14 10:09:02 [app] [I] Rendered puppetclasses/_classes_in_groups.html.erb (0.0ms)
2016-11-14 10:09:02 [sql] [D] CACHE (0.0ms) SELECT `config_group_classes`.`puppetclass_id` FROM `config_group_classes` WHERE 1=0
2016-11-14 10:09:02 [sql] [D] (0.1ms) SELECT `hostgroup_classes`.`puppetclass_id` FROM `hostgroup_classes` WHERE `hostgroup_classes`.`hostgroup_id` IS NULL
2016-11-14 10:09:02 [sql] [D] CACHE (0.0ms) SELECT DISTINCT `puppetclasses`.* FROM `puppetclasses` INNER JOIN `environment_classes` ON `puppetclasses`.`id` = `environment_classes`.`puppetclass_id` WHERE `environment_classes`.`environment_id` = 1 AND 1=0 ORDER BY puppetclasses.name [["environment_id", 1]]
2016-11-14 10:09:02 [sql] [D] Puppetclass Load (0.1ms) SELECT `puppetclasses`.* FROM `puppetclasses` INNER JOIN `host_classes` ON `puppetclasses`.`id` = `host_classes`.`puppetclass_id` WHERE `host_classes`.`host_id` = 2178 ORDER BY puppetclasses.name
2016-11-14 10:09:02 [app] [I] Rendered puppetclasses/_classes.html.erb (90.4ms)
2016-11-14 10:09:02 [app] [I] Rendered puppetclasses/_class_selection.html.erb (166.8ms)
2016-11-14 10:09:02 [app] [D] Setting current location thread-local variable to none
2016-11-14 10:09:02 [app] [D] Setting current organization thread-local variable to none
2016-11-14 10:09:02 [app] [I] Completed 200 OK in 242ms (Views: 167.5ms | ActiveRecord: 21.8ms)
2016-11-14 10:09:02 [sql] [D] (0.1ms) BEGIN
2016-11-14 10:09:02 [sql] [D] SQL (0.3ms) UPDATE `sessions` SET `data` = 'BAh7DEkiCXVzZXIGOgZFRmk6SSIPZXhwaXJlc19hdAY7AEZsKwceMytYSSIL\nbG9jYWxlBjsARiIHZW5JIhBfY3NyZl90b2tlbgY7AEZJIjFXSEUyQU4rSS9T\nL1luSjNnZ1h1dW1KdjExYUlzQVhEN2dGOUtHWVhleUtvPQY7AEZJIiVyZWRp\ncmVjdF90b191cmxfZGlzY292ZXJlZF9ob3N0cwY7AFQiMWh0dHA6Ly9wdXBw\nZXQubGFiLmJlZXIudG93bi9kaXNjb3ZlcmVkX2hvc3RzSSIrcmVkaXJlY3Rf\ndG9fdXJsX3Byb3Zpc2lvbmluZ190ZW1wbGF0ZXMGOwBUIkFodHRwOi8vcHVw\ncGV0LmxhYi5iZWVyLnRvd24vdGVtcGxhdGVzL3Byb3Zpc2lvbmluZ190ZW1w\nbGF0ZXNJIhpyZWRpcmVjdF90b191cmxfaG9zdHMGOwBUIkZodHRwOi8vcHVw\ncGV0LmxhYi5iZWVyLnRvd24vZGlzY292ZXJlZF9ob3N0cy9jbWw5MGIxMWMz\nYjQ4OTIvZWRpdA==\n', `updated_at` = '2016-11-14 16:09:02' WHERE `sessions`.`id` = 2279826
2016-11-14 10:09:02 [sql] [D] (8.2ms) COMMIT
2016-11-14 10:09:02 [app] [I] Started POST "/hosts/puppetclass_parameters" for 172.31.100.214 at 2016-11-14 10:09:02 -0600
2016-11-14 10:09:02 [app] [I] Processing by HostsController#puppetclass_parameters as */*
2016-11-14 10:09:02 [app] [I] Parameters: {"utf8"=>"✓", "authenticity_token"=>"WHE2AN+I/S/YnJ3ggXuumJv11aIsAXD7gF9KGYXeyKo=", "host"=>{"name"=>"cml90b11c3b4892", "hostgroup_id"=>"", "environment_id"=>"1", "puppet_ca_proxy_id"=>"", "puppet_proxy_id"=>"", "config_group_ids"=>[""], "puppetclass_ids"=>[""], "managed"=>"true", "progress_report_id"=>"[FILTERED]", "type"=>"Host::Managed", "interfaces_attributes"=>{"0"=>{"_destroy"=>"0", "mac"=>"90:b1:1c:3b:48:92", "identifier"=>"eno1", "name"=>"cml90b11c3b4892", "domain_id"=>"", "subnet_id"=>"13", "ip"=>"172.21.72.12", "managed"=>"1", "primary"=>"1", "provision"=>"1", "execution"=>"1", "tag"=>"", "attached_to"=>"", "id"=>"2962"}, "1"=>{"_destroy"=>"0", "mac"=>"90:b1:1c:3b:48:93", "identifier"=>"eno2", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"", "managed"=>"0", "primary"=>"0", "provision"=>"0", "execution"=>"0", "tag"=>"", "attached_to"=>"", "id"=>"2963"}, "2"=>{"_destroy"=>"0", "mac"=>"a0:36:9f:15:85:08", "identifier"=>"enp12s0f0", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"", "managed"=>"0", "primary"=>"0", "provision"=>"0", "execution"=>"0", "tag"=>"", "attached_to"=>"", "id"=>"2964"}, "3"=>{"_destroy"=>"0", "mac"=>"a0:36:9f:15:85:0a", "identifier"=>"enp12s0f1", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"", "managed"=>"0", "primary"=>"0", "provision"=>"0", "execution"=>"0", "tag"=>"", "attached_to"=>"", "id"=>"2965"}, "4"=>{"_destroy"=>"0", "mac"=>"00:c0:dd:25:75:4c", "identifier"=>"enp9s1f0", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"", "managed"=>"0", "primary"=>"0", "provision"=>"0", "execution"=>"0", "tag"=>"", "attached_to"=>"", "id"=>"2966"}, "5"=>{"_destroy"=>"0", "mac"=>"00:c0:dd:25:75:4e", "identifier"=>"enp9s1f2", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"", "managed"=>"0", "primary"=>"0", "provision"=>"0", "execution"=>"0", "tag"=>"", "attached_to"=>"", "id"=>"2967"}, "6"=>{"_destroy"=>"0", "mac"=>"90:b1:1c:3b:48:94", "identifier"=>"ipmi", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"172.21.72.80", "managed"=>"0", "primary"=>"0", "provision"=>"0", "execution"=>"0", "username"=>"", "provider"=>"IPMI", "id"=>"2968"}, "new_interfaces"=>{"_destroy"=>"1", "type"=>"Nic::Managed", "mac"=>"", "identifier"=>"", "name"=>"", "domain_id"=>"", "subnet_id"=>"", "ip"=>"", "managed"=>"1", "primary"=>"0", "provision"=>"0", "execution"=>"0", "virtual"=>"0", "tag"=>"", "attached_to"=>""}}, "architecture_id"=>"", "build"=>"1", "disk"=>"", "is_owned_by"=>"53-Users", "enabled"=>"1", "model_id"=>"2", "comment"=>"", "overwrite"=>"false"}, "fakepassword"=>"[FILTERED]", "bare_metal_capabilities"=>"build", "host_id"=>"2178"}
2016-11-14 10:09:02 [sql] [D] ActiveRecord::SessionStore::Session Load (0.3ms) SELECT `sessions`.* FROM `sessions` WHERE `sessions`.`session_id` = '6609e8a2574d5fe1cccf4eaaab485a7d' ORDER BY `sessions`.`id` ASC LIMIT 1
2016-11-14 10:09:02 [sql] [D] User Load (0.1ms) SELECT `users`.* FROM `users` WHERE `users`.`id` = 53 LIMIT 1
2016-11-14 10:09:02 [app] [D] Setting current user thread-local variable to roletest
2016-11-14 10:09:02 [sql] [D] AuthSource Load (0.1ms) SELECT `auth_sources`.* FROM `auth_sources` WHERE `auth_sources`.`id` = 1 LIMIT 1
2016-11-14 10:09:02 [sql] [D] Organization Load (0.1ms) SELECT `taxonomies`.* FROM `taxonomies` WHERE `taxonomies`.`type` IN ('Organization') AND `taxonomies`.`id` IS NULL ORDER BY `taxonomies`.`title` ASC LIMIT 1
2016-11-14 10:09:02 [sql] [D] Location Load (0.1ms) SELECT `taxonomies`.* FROM `taxonomies` WHERE `taxonomies`.`type` IN ('Location') AND `taxonomies`.`id` IS NULL ORDER BY `taxonomies`.`title` ASC LIMIT 1
2016-11-14 10:09:02 [app] [D] Setting current organization thread-local variable to none
2016-11-14 10:09:02 [app] [D] Setting current location thread-local variable to none
2016-11-14 10:09:02 [sql] [D] Host::Base Load (0.1ms) SELECT `hosts`.* FROM `hosts` WHERE `hosts`.`id` = 2178 LIMIT 1
2016-11-14 10:09:02 [sql] [D] Nic::Base Load (0.3ms) SELECT `nics`.* FROM `nics` WHERE `nics`.`host_id` = 2178 ORDER BY `nics`.`identifier` ASC
2016-11-14 10:09:02 [sql] [D] (0.1ms) BEGIN
2016-11-14 10:09:02 [sql] [D] Nic::Base Load (2.2ms) SELECT `nics`.* FROM `nics` WHERE `nics`.`ip` = '172.21.72.12'
2016-11-14 10:09:02 [sql] [D] Nic::Base Load (3.0ms) SELECT `nics`.* FROM `nics` WHERE `nics`.`domain_id` IS NULL AND `nics`.`name` = 'cml90b11c3b4892'
2016-11-14 10:09:02 [sql] [D] Subnet Load (0.1ms) SELECT `subnets`.* FROM `subnets` WHERE `subnets`.`id` = 13 ORDER BY vlanid LIMIT 1
2016-11-14 10:09:02 [sql] [D] Using host queue
2016-11-14 10:09:02 [sql] [D] SQL (0.3ms) UPDATE `nics` SET `attrs` = '--- !ruby/hash:ActiveSupport::HashWithIndifferentAccess\nnetwork: 172.21.72.0\nnetmask: 255.255.255.0\nmtu: 1500\nspeed: \'1000\'\nduplex: full\nport: Twisted Pair\nauto_negotiation: \'true\'\nwol: false\nlldp_neighbor_chassisid: ec:f4:bb:fc:08:e0\nlldp_neighbor_portid: ManagementEthernet 0/0\n', `compute_attributes` = '--- {}\n', `updated_at` = '2016-11-14 16:09:02' WHERE `nics`.`type` IN ('Nic::Managed', 'Nic::BMC', 'Nic::Bond', 'Nic::Bridge') AND `nics`.`id` = 2962
2016-11-14 10:09:02 [sql] [D] Using host queue
2016-11-14 10:09:02 [sql] [D] SQL (0.3ms) UPDATE `nics` SET `attrs` = '--- !ruby/hash:ActiveSupport::HashWithIndifferentAccess\nmtu: 1500\nspeed: \'1000\'\nduplex: full\nport: Twisted Pair\nauto_negotiation: \'true\'\nwol: false\nlldp_neighbor_chassisid: f8:b1:56:67:64:c0\nlldp_neighbor_portid: Te1/0/15\n', `compute_attributes` = '--- {}\n', `updated_at` = '2016-11-14 16:09:02' WHERE `nics`.`type` IN ('Nic::Managed', 'Nic::BMC', 'Nic::Bond', 'Nic::Bridge') AND `nics`.`id` = 2963
2016-11-14 10:09:02 [sql] [D] Using host queue
2016-11-14 10:09:02 [sql] [D] SQL (0.3ms) UPDATE `nics` SET `attrs` = '--- !ruby/hash:ActiveSupport::HashWithIndifferentAccess\nmtu: 1500\nspeed: \'10000\'\nduplex: full\nport: Direct Attach Copper\nauto_negotiation: \'false\'\nwol: false\nlldp_neighbor_chassisid: 00:01:e8:8b:40:40\nlldp_neighbor_portid: TenGigabitEthernet 0/23\n', `compute_attributes` = '--- {}\n', `updated_at` = '2016-11-14 16:09:02' WHERE `nics`.`type` IN ('Nic::Managed', 'Nic::BMC', 'Nic::Bond', 'Nic::Bridge') AND `nics`.`id` = 2964
2016-11-14 10:09:02 [sql] [D] Using host queue
2016-11-14 10:09:02 [sql] [D] SQL (0.3ms) UPDATE `nics` SET `attrs` = '--- !ruby/hash:ActiveSupport::HashWithIndifferentAccess\nmtu: 1500\nspeed: \'10000\'\nduplex: full\nport: Direct Attach Copper\nauto_negotiation: \'false\'\nwol: false\nlldp_neighbor_chassisid: 00:01:e8:8b:40:40\nlldp_neighbor_portid: TenGigabitEthernet 0/21\n', `compute_attributes` = '--- {}\n', `updated_at` = '2016-11-14 16:09:02' WHERE `nics`.`type` IN ('Nic::Managed', 'Nic::BMC', 'Nic::Bond', 'Nic::Bridge') AND `nics`.`id` = 2965
2016-11-14 10:09:02 [sql] [D] Using host queue
2016-11-14 10:09:02 [sql] [D] SQL (0.3ms) UPDATE `nics` SET `attrs` = '--- !ruby/hash:ActiveSupport::HashWithIndifferentAccess\nmtu: 1500\nspeed: \'1000\'\nduplex: full\nport: Twisted Pair\nauto_negotiation: \'true\'\nlldp_neighbor_chassisid: f8:b1:56:67:64:c0\nlldp_neighbor_portid: Te1/0/19\n', `compute_attributes` = '--- {}\n', `updated_at` = '2016-11-14 16:09:02' WHERE `nics`.`type` IN ('Nic::Managed', 'Nic::BMC', 'Nic::Bond', 'Nic::Bridge') AND `nics`.`id` = 2966
2016-11-14 10:09:02 [sql] [D] Using host queue
2016-11-14 10:09:02 [sql] [D] SQL (0.2ms) UPDATE `nics` SET `attrs` = '--- !ruby/hash:ActiveSupport::HashWithIndifferentAccess\nmtu: 1500\nspeed: \'1000\'\nduplex: full\nport: Twisted Pair\nauto_negotiation: \'true\'\nlldp_neighbor_chassisid: f8:b1:56:67:64:c0\nlldp_neighbor_portid: Te1/0/17\n', `compute_attributes` = '--- {}\n', `updated_at` = '2016-11-14 16:09:02' WHERE `nics`.`type` IN ('Nic::Managed', 'Nic::BMC', 'Nic::Bond', 'Nic::Bridge') AND `nics`.`id` = 2967
2016-11-14 10:09:02 [sql] [D] Nic::Base Load (2.2ms) SELECT `nics`.* FROM `nics` WHERE `nics`.`ip` = '172.21.72.80'
2016-11-14 10:09:02 [sql] [D] Using host queue
2016-11-14 10:09:02 [sql] [D] SQL (0.2ms) UPDATE `nics` SET `attrs` = '--- !ruby/hash:ActiveSupport::HashWithIndifferentAccess\nenabled: true\nipaddress_source: Static Address\nsubnet_mask: 255.255.255.0\ngateway: 172.21.72.1\n1_ipaddress_source: Static Address\n1_ipaddress: 172.21.72.80\n1_subnet_mask: 255.255.255.0\n1_macaddress: 90:b1:1c:3b:48:94\n1_gateway: 172.21.72.1\n', `compute_attributes` = '--- {}\n', `updated_at` = '2016-11-14 16:09:02' WHERE `nics`.`type` IN ('Nic::BMC') AND `nics`.`id` = 2968
2016-11-14 10:09:02 [sql] [D] (9.2ms) COMMIT
2016-11-14 10:09:02 [sql] [D] ConfigGroup Load (0.1ms) SELECT `config_groups`.* FROM `config_groups` INNER JOIN `host_config_groups` ON `config_groups`.`id` = `host_config_groups`.`config_group_id` WHERE `host_config_groups`.`host_id` = 2178 AND `host_config_groups`.`host_type` = 'Host::Base' ORDER BY config_groups.name
2016-11-14 10:09:02 [sql] [D] (0.1ms) BEGIN
2016-11-14 10:09:02 [sql] [D] (0.1ms) COMMIT
2016-11-14 10:09:02 [sql] [D] Puppetclass Load (0.2ms) SELECT `puppetclasses`.* FROM `puppetclasses` INNER JOIN `host_classes` ON `puppetclasses`.`id` = `host_classes`.`puppetclass_id` WHERE `host_classes`.`host_id` = 2178 ORDER BY puppetclasses.name
2016-11-14 10:09:02 [sql] [D] (0.1ms) BEGIN
2016-11-14 10:09:02 [sql] [D] (0.1ms) COMMIT
2016-11-14 10:09:02 [sql] [D] User Load (0.1ms) SELECT `users`.* FROM `users` WHERE `users`.`id` = 53 ORDER BY firstname LIMIT 1
2016-11-14 10:09:02 [sql] [D] Environment Load (0.4ms) SELECT `environments`.* FROM `environments` WHERE `environments`.`id` = 1 ORDER BY environments.name LIMIT 1
2016-11-14 10:09:02 [sql] [D] (0.3ms) SELECT `config_group_classes`.`puppetclass_id` FROM `config_group_classes` WHERE 1=0
2016-11-14 10:09:02 [sql] [D] (0.2ms) SELECT `hostgroup_classes`.`puppetclass_id` FROM `hostgroup_classes` WHERE `hostgroup_classes`.`hostgroup_id` IS NULL
2016-11-14 10:09:02 [sql] [D] HostClass Load (0.1ms) SELECT `host_classes`.* FROM `host_classes` WHERE `host_classes`.`host_id` = 2178
2016-11-14 10:09:02 [sql] [D] (0.2ms) SELECT DISTINCT puppetclasses.id FROM `puppetclasses` INNER JOIN `environment_classes` ON `puppetclasses`.`id` = `environment_classes`.`puppetclass_id` WHERE `environment_classes`.`environment_id` = 1 AND 1=0
2016-11-14 10:09:02 [sql] [D] (0.1ms) SELECT DISTINCT `lookup_keys`.`puppetclass_id` FROM `lookup_keys` WHERE `lookup_keys`.`type` IN ('VariableLookupKey') AND 1=0
2016-11-14 10:09:02 [sql] [D] (0.1ms) SELECT DISTINCT environment_classes.puppetclass_id FROM `lookup_keys` INNER JOIN `environment_classes` ON `environment_classes`.`puppetclass_lookup_key_id` = `lookup_keys`.`id` WHERE `lookup_keys`.`type` IN ('PuppetclassLookupKey') AND 1=0
2016-11-14 10:09:02 [sql] [D] Puppetclass Load (0.1ms) SELECT DISTINCT `puppetclasses`.* FROM `puppetclasses` INNER JOIN `environment_classes` ON `puppetclasses`.`id` = `environment_classes`.`puppetclass_id` WHERE `environment_classes`.`environment_id` = 1 AND 1=0 ORDER BY puppetclasses.name
2016-11-14 10:09:02 [app] [I] Rendered puppetclasses/_class_parameters.html.erb (0.0ms)
2016-11-14 10:09:02 [app] [I] Rendered puppetclasses/_classes_parameters.html.erb (11.2ms)
2016-11-14 10:09:02 [app] [D] Setting current location thread-local variable to none
2016-11-14 10:09:02 [app] [D] Setting current organization thread-local variable to none
2016-11-14 10:09:02 [app] [I] Completed 200 OK in 83ms (Views: 12.0ms | ActiveRecord: 21.7ms)
2016-11-14 10:09:02 [sql] [D] (0.1ms) BEGIN
2016-11-14 10:09:02 [sql] [D] (0.1ms) COMMIT


Setting to normal, although this to me is high or urgent because the only way to enable it for my users is to enable Admin globally.