Apr 10 07:11:21 foreman dhcpd: DHCPDISCOVER from 0c:c4:7a:cd:6a:08 via eno2 Apr 10 07:11:22 foreman dhcpd: none: host unknown. Apr 10 07:11:22 foreman dhcpd: DHCPOFFER on 192.168.1.12 to 0c:c4:7a:cd:6a:08 via eno2 Apr 10 07:11:24 foreman dhcpd: DHCPREQUEST for 192.168.1.12 (192.168.1.1) from 0c:c4:7a:cd:6a:08 via eno2 Apr 10 07:11:24 foreman dhcpd: DHCPACK on 192.168.1.12 to 0c:c4:7a:cd:6a:08 via eno2 Apr 10 07:11:24 foreman in.tftpd[3859]: RRQ from 192.168.1.12 filename grub2/shim.efi Apr 10 07:11:24 foreman in.tftpd[3859]: tftp: client does not accept options Apr 10 07:11:24 foreman in.tftpd[3860]: RRQ from 192.168.1.12 filename grub2/shim.efi ==> /var/log/foreman-proxy/proxy.log <== D, [2017-04-10T07:11:24.252165 ] DEBUG -- : caught :modify event on /var/lib/dhcpd/dhcpd.leases. D, [2017-04-10T07:11:24.253271 ] DEBUG -- : Added a lease record: 192.168.1.12:0c:c4:7a:cd:6a:08 ==> /var/log/messages <== Apr 10 07:11:24 foreman in.tftpd[3860]: Client 192.168.1.12 finished grub2/shim.efi Apr 10 07:11:24 foreman in.tftpd[3861]: RRQ from 192.168.1.12 filename grub2/grubx64.efi Apr 10 07:11:24 foreman in.tftpd[3861]: Client 192.168.1.12 finished grub2/grubx64.efi Apr 10 07:11:25 foreman in.tftpd[3862]: RRQ from 192.168.1.12 filename /grub2/grub.cfg-01-0c-c4-7a-cd-6a-08 Apr 10 07:11:25 foreman in.tftpd[3862]: Client 192.168.1.12 File not found /grub2/grub.cfg-01-0c-c4-7a-cd-6a-08 Apr 10 07:11:25 foreman in.tftpd[3863]: RRQ from 192.168.1.12 filename /grub2/grub.cfg-C0A8010C Apr 10 07:11:25 foreman in.tftpd[3863]: Client 192.168.1.12 File not found /grub2/grub.cfg-C0A8010C Apr 10 07:11:25 foreman in.tftpd[3864]: RRQ from 192.168.1.12 filename /grub2/grub.cfg-C0A8010 Apr 10 07:11:25 foreman in.tftpd[3864]: Client 192.168.1.12 File not found /grub2/grub.cfg-C0A8010 Apr 10 07:11:25 foreman in.tftpd[3865]: RRQ from 192.168.1.12 filename /grub2/grub.cfg-C0A801 Apr 10 07:11:25 foreman in.tftpd[3865]: Client 192.168.1.12 File not found /grub2/grub.cfg-C0A801 Apr 10 07:11:25 foreman in.tftpd[3866]: RRQ from 192.168.1.12 filename /grub2/grub.cfg-C0A80 Apr 10 07:11:25 foreman in.tftpd[3866]: Client 192.168.1.12 File not found /grub2/grub.cfg-C0A80 Apr 10 07:11:25 foreman in.tftpd[3867]: RRQ from 192.168.1.12 filename /grub2/grub.cfg-C0A8 Apr 10 07:11:25 foreman in.tftpd[3867]: Client 192.168.1.12 File not found /grub2/grub.cfg-C0A8 Apr 10 07:11:25 foreman in.tftpd[3868]: RRQ from 192.168.1.12 filename /grub2/grub.cfg-C0A Apr 10 07:11:25 foreman in.tftpd[3868]: Client 192.168.1.12 File not found /grub2/grub.cfg-C0A Apr 10 07:11:25 foreman in.tftpd[3869]: RRQ from 192.168.1.12 filename /grub2/grub.cfg-C0 Apr 10 07:11:25 foreman in.tftpd[3869]: Client 192.168.1.12 File not found /grub2/grub.cfg-C0 Apr 10 07:11:25 foreman in.tftpd[3870]: RRQ from 192.168.1.12 filename /grub2/grub.cfg-C Apr 10 07:11:25 foreman in.tftpd[3870]: Client 192.168.1.12 File not found /grub2/grub.cfg-C Apr 10 07:11:25 foreman in.tftpd[3871]: RRQ from 192.168.1.12 filename /grub2/grub.cfg Apr 10 07:11:25 foreman in.tftpd[3871]: Client 192.168.1.12 finished /grub2/grub.cfg Apr 10 07:11:25 foreman in.tftpd[3872]: RRQ from 192.168.1.12 filename /grub2/grub.cfg Apr 10 07:11:25 foreman in.tftpd[3872]: Client 192.168.1.12 finished /grub2/grub.cfg Apr 10 07:11:25 foreman in.tftpd[3873]: RRQ from 192.168.1.12 filename /EFI/centos/x86_64-efi/command.lst Apr 10 07:11:25 foreman in.tftpd[3873]: Client 192.168.1.12 File not found /EFI/centos/x86_64-efi/command.lst Apr 10 07:11:25 foreman in.tftpd[3874]: RRQ from 192.168.1.12 filename /EFI/centos/x86_64-efi/fs.lst Apr 10 07:11:25 foreman in.tftpd[3874]: Client 192.168.1.12 File not found /EFI/centos/x86_64-efi/fs.lst Apr 10 07:11:25 foreman in.tftpd[3875]: RRQ from 192.168.1.12 filename /EFI/centos/x86_64-efi/crypto.lst Apr 10 07:11:25 foreman in.tftpd[3875]: Client 192.168.1.12 File not found /EFI/centos/x86_64-efi/crypto.lst Apr 10 07:11:25 foreman in.tftpd[3876]: RRQ from 192.168.1.12 filename /EFI/centos/x86_64-efi/terminal.lst Apr 10 07:11:25 foreman in.tftpd[3876]: Client 192.168.1.12 File not found /EFI/centos/x86_64-efi/terminal.lst Apr 10 07:11:25 foreman in.tftpd[3877]: RRQ from 192.168.1.12 filename /grub2/grub.cfg Apr 10 07:11:25 foreman in.tftpd[3877]: Client 192.168.1.12 finished /grub2/grub.cfg Apr 10 07:11:25 foreman in.tftpd[3878]: RRQ from 192.168.1.12 filename /grub2/grub.cfg Apr 10 07:11:25 foreman in.tftpd[3878]: Client 192.168.1.12 finished /grub2/grub.cfg Apr 10 07:11:25 foreman in.tftpd[3879]: RRQ from 192.168.1.12 filename /grub2/grub.cfg Apr 10 07:11:25 foreman in.tftpd[3879]: Client 192.168.1.12 finished /grub2/grub.cfg Apr 10 07:11:25 foreman in.tftpd[3880]: RRQ from 192.168.1.12 filename boot/fdi-image/vmlinuz0 Apr 10 07:11:26 foreman in.tftpd[3880]: Client 192.168.1.12 finished boot/fdi-image/vmlinuz0 Apr 10 07:11:26 foreman in.tftpd[3883]: RRQ from 192.168.1.12 filename boot/fdi-image/vmlinuz0 Apr 10 07:11:27 foreman in.tftpd[3883]: Client 192.168.1.12 finished boot/fdi-image/vmlinuz0 Apr 10 07:11:27 foreman in.tftpd[3884]: RRQ from 192.168.1.12 filename boot/fdi-image/initrd0.img Apr 10 07:11:48 foreman in.tftpd[3884]: Client 192.168.1.12 finished boot/fdi-image/initrd0.img Apr 10 07:11:52 foreman kernel: igb 0000:02:00.0 eno2: igb: eno2 NIC Link is Down Apr 10 07:11:55 foreman kernel: igb 0000:02:00.0 eno2: igb: eno2 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX/TX Apr 10 07:11:56 foreman kernel: igb 0000:02:00.0 eno2: igb: eno2 NIC Link is Down Apr 10 07:11:59 foreman kernel: igb 0000:02:00.0 eno2: igb: eno2 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX/TX Apr 10 07:11:59 foreman dhcpd: DHCPDISCOVER from 0c:c4:7a:cd:6a:08 via eno2 Apr 10 07:11:59 foreman dhcpd: DHCPOFFER on 192.168.1.12 to 0c:c4:7a:cd:6a:08 via eno2 Apr 10 07:11:59 foreman dhcpd: DHCPREQUEST for 192.168.1.12 (192.168.1.1) from 0c:c4:7a:cd:6a:08 via eno2 Apr 10 07:11:59 foreman dhcpd: DHCPACK on 192.168.1.12 to 0c:c4:7a:cd:6a:08 via eno2 ==> /var/log/foreman-proxy/proxy.log <== D, [2017-04-10T07:11:59.646063 ] DEBUG -- : caught :modify event on /var/lib/dhcpd/dhcpd.leases. D, [2017-04-10T07:11:59.646574 ] DEBUG -- : Deleted a lease record: 192.168.1.12:0c:c4:7a:cd:6a:08 D, [2017-04-10T07:11:59.646619 ] DEBUG -- : Added a lease record: 192.168.1.12:0c:c4:7a:cd:6a:08 ==> /var/log/foreman/production.log <== 2017-04-10 07:12:07 8066c669 [app] [I] Started POST "/api/v2/discovered_hosts/facts" for 192.168.1.12 at 2017-04-10 07:12:07 -0500 2017-04-10 07:12:07 8066c669 [app] [I] Processing by Api::V2::DiscoveredHostsController#facts as JSON 2017-04-10 07:12:07 8066c669 [app] [I] Parameters: {"facts"=>"[FILTERED]", "apiv"=>"v2", "discovered_host"=>{"facts"=>"[FILTERED]"}} 2017-04-10 07:12:07 8066c669 [sql] [D] Setting Load (0.3ms) SELECT "settings".* FROM "settings" WHERE "settings"."name" = $1 ORDER BY "settings"."name" ASC LIMIT 1 [["name", "discovery_fact"]] 2017-04-10 07:12:07 8066c669 [sql] [D] Setting Load (0.2ms) SELECT "settings".* FROM "settings" WHERE "settings"."name" = $1 ORDER BY "settings"."name" ASC LIMIT 1 [["name", "discovery_prefix"]] 2017-04-10 07:12:07 8066c669 [sql] [D] Setting Load (0.1ms) SELECT "settings".* FROM "settings" WHERE "settings"."name" = $1 ORDER BY "settings"."name" ASC LIMIT 1 [["name", "discovery_hostname"]] 2017-04-10 07:12:07 8066c669 [sql] [D] (0.2ms) SELECT COUNT(*) FROM "nics" WHERE "nics"."type" IN ('Nic::Managed', 'Nic::BMC', 'Nic::Bond', 'Nic::Bridge') AND "nics"."mac" = $1 AND "nics"."primary" = $2 [["mac", "0c:c4:7a:cd:6a:08"], ["primary", "t"]] 2017-04-10 07:12:07 8066c669 [sql] [D] (0.2ms) BEGIN 2017-04-10 07:12:07 8066c669 [sql] [D] SQL (0.9ms) INSERT INTO "hosts" ("type", "name", "created_at", "updated_at") VALUES ($1, $2, $3, $4) RETURNING "id" [["type", "Host::Discovered"], ["name", "mac0cc47acd6a08"], ["created_at", "2017-04-10 12:12:07.463917"], ["updated_at", "2017-04-10 12:12:07.463917"]] 2017-04-10 07:12:07 8066c669 [sql] [D] Using nic queue 2017-04-10 07:12:07 8066c669 [sql] [D] SQL (0.5ms) INSERT INTO "nics" ("type", "primary", "provision", "name", "host_id", "created_at", "updated_at") VALUES ($1, $2, $3, $4, $5, $6, $7) RETURNING "id" [["type", "Nic::Managed"], ["primary", "t"], ["provision", "t"], ["name", "mac0cc47acd6a08"], ["host_id", 45], ["created_at", "2017-04-10 12:12:07.466370"], ["updated_at", "2017-04-10 12:12:07.466370"]] 2017-04-10 07:12:07 8066c669 [sql] [D] SQL (0.2ms) UPDATE "lookup_values" SET "match" = 'discovery-not-matched' WHERE "lookup_values"."match" = $1 [["match", "fqdn="]] 2017-04-10 07:12:07 8066c669 [sql] [D] (9.2ms) COMMIT 2017-04-10 07:12:07 8066c669 [sql] [D] Setting Load (0.3ms) SELECT "settings".* FROM "settings" WHERE "settings"."name" = $1 ORDER BY "settings"."name" ASC LIMIT 1 [["name", "create_new_host_when_facts_are_uploaded"]] 2017-04-10 07:12:07 8066c669 [sql] [D] (0.1ms) BEGIN 2017-04-10 07:12:07 8066c669 [sql] [D] SQL (0.9ms) DELETE FROM "fact_values" WHERE "fact_values"."id" IN (SELECT "fact_values"."id" FROM "fact_values" INNER JOIN "fact_names" ON "fact_names"."id" = "fact_values"."fact_name_id" WHERE "fact_values"."host_id" = 45 AND "fact_names"."type" = 'PuppetFactName' AND ("fact_names"."name" NOT IN ('lib', 'virtual', 'architecture', 'hardwaremodel', 'os', 'os::name', 'os::family', 'os::release', 'os::release::major', 'os::release::minor', 'os::release::full', 'domain', 'interfaces', 'ipaddress_eno1', 'macaddress_eno1', 'netmask_eno1', 'mtu_eno1', 'macaddress_eno2', 'mtu_eno2', 'macaddress_eno3', 'mtu_eno3', 'macaddress_eno4', 'mtu_eno4', 'ipaddress_lo', 'netmask_lo', 'mtu_lo', 'memorysize', 'memorysize_mb', 'netmask', 'physicalprocessorcount', 'partitions', 'partitions::sda1', 'partitions::sda1::size', 'partitions::sda1::label', 'partitions::sda1::filesystem', 'partitions::sda2', 'partitions::sda2::uuid', 'partitions::sda2::size', 'partitions::sda2::label', 'partitions::sda2::filesystem', 'partitions::sda3', 'partitions::sda3::size', 'partitions::sda3::filesystem', 'partitions::sda4', 'partitions::sda4::size', 'partitions::sda4::filesystem', 'partitions::sdb1', 'partitions::sdb1::size', 'partitions::sdb1::filesystem', 'ipaddress', 'facterversion', 'gid', 'uniqueid', 'processors', 'processors::models', 'processors::count', 'processors::physicalcount', 'ps', 'macaddress', 'blockdevice_sda_size', 'blockdevice_sda_vendor', 'blockdevice_sda_model', 'blockdevice_sdb_size', 'blockdevice_sdb_vendor', 'blockdevice_sdb_model', 'blockdevices', 'processor0', 'processor1', 'processor2', 'processor3', 'processorcount', 'dhcp_servers', 'dhcp_servers::system', 'dhcp_servers::eno1', 'fqdn', 'hardwareisa', 'boardmanufacturer', 'boardproductname', 'boardserialnumber', 'bios_vendor', 'bios_version', 'bios_release_date', 'manufacturer', 'productname', 'serialnumber', 'uuid', 'type', 'hostname', 'id', 'network_eno1', 'network_lo', 'discovery_version', 'discovery_release', 'discovery_bootif', 'discovery_bootip', 'speed_eno1', 'duplex_eno1', 'port_eno1', 'auto_negotiation_eno1', 'wol_eno1', 'link_eno1', 'duplex_eno2', 'port_eno2', 'auto_negotiation_eno2', 'wol_eno2', 'link_eno2', 'duplex_eno3', 'port_eno3', 'auto_negotiation_eno3', 'wol_eno3', 'link_eno3', 'duplex_eno4', 'port_eno4',