Ticket #3888: log_file

File log_file, 20.9 KB (added by wlodekwencel, 5 years ago)
Line 
12015-06-03 05:46:20.884 DEBUG [kea-dhcp4.dhcp4/23999] DHCP4_START_INFO pid: 23999, port: 67, verbose: yes
22015-06-03 05:46:20.884 INFO  [kea-dhcp4.dhcp4/23999] DHCP4_STARTING Kea DHCPv4 server version 0.9.1-git starting
32015-06-03 05:46:20.884 DEBUG [kea-dhcp4.dhcp4/23999] DHCP4_OPEN_SOCKET opening sockets on port 67
42015-06-03 05:46:20.885 DEBUG [kea-dhcp4.dhcp4/23999] DHCP4_COMMAND_RECEIVED received command config-reload, arguments: { "interfaces-config": { "interfaces": [ "eth2" ] }, "lease-database": { "type": "memfile" }, "rebind-timer": 3, "renew-timer": 2, "subnet4": [ { "interface": "eth2", "pools": [ { "pool": "192.168.50.1-192.168.50.10" } ], "subnet": "192.168.50.0/24" } ], "valid-lifetime": 4 }
52015-06-03 05:46:20.885 DEBUG [kea-dhcp4.dhcp4/23999] DHCP4_CONFIG_RECEIVED received configuration { "interfaces-config": { "interfaces": [ "eth2" ] }, "lease-database": { "type": "memfile" }, "rebind-timer": 3, "renew-timer": 2, "subnet4": [ { "interface": "eth2", "pools": [ { "pool": "192.168.50.1-192.168.50.10" } ], "subnet": "192.168.50.0/24" } ], "valid-lifetime": 4 }
62015-06-03 05:46:20.885 DEBUG [kea-dhcp4.dhcp4/23999] DHCP4_CONFIG_START DHCPv4 server is processing the following configuration: { "interfaces-config": { "interfaces": [ "eth2" ] }, "lease-database": { "type": "memfile" }, "rebind-timer": 3, "renew-timer": 2, "subnet4": [ { "interface": "eth2", "pools": [ { "pool": "192.168.50.1-192.168.50.10" } ], "subnet": "192.168.50.0/24" } ], "valid-lifetime": 4 }
72015-06-03 05:46:20.885 DEBUG [kea-dhcp4.dhcp4/23999] DHCP4_PARSER_CREATED created parser for configuration element interfaces-config
82015-06-03 05:46:20.885 INFO  [kea-dhcp4.dhcpsrv/23999] DHCPSRV_CFGMGR_ADD_IFACE listening on interface eth2
92015-06-03 05:46:20.885 INFO  [kea-dhcp4.dhcpsrv/23999] DHCPSRV_CFGMGR_SOCKET_TYPE_DEFAULT "dhcp-socket-type" not specified , using default socket type raw
102015-06-03 05:46:20.885 DEBUG [kea-dhcp4.dhcp4/23999] DHCP4_PARSER_CREATED created parser for configuration element lease-database
112015-06-03 05:46:20.885 DEBUG [kea-dhcp4.dhcp4/23999] DHCP4_PARSER_CREATED created parser for configuration element rebind-timer
122015-06-03 05:46:20.885 DEBUG [kea-dhcp4.dhcp4/23999] DHCP4_PARSER_CREATED created parser for configuration element renew-timer
132015-06-03 05:46:20.885 DEBUG [kea-dhcp4.dhcp4/23999] DHCP4_PARSER_CREATED created parser for configuration element subnet4
142015-06-03 05:46:20.885 DEBUG [kea-dhcp4.dhcp4/23999] DHCP4_PARSER_CREATED created parser for configuration element valid-lifetime
152015-06-03 05:46:20.885 INFO  [kea-dhcp4.dhcp4/23999] DHCP4_CONFIG_NEW_SUBNET a new subnet has been added to configuration: 192.168.50.0/24 with params: t1=2, t2=3, valid-lifetime=4
162015-06-03 05:46:20.886 DEBUG [kea-dhcp4.dhcpsrv/23999] DHCPSRV_CFGMGR_ADD_SUBNET4 adding subnet 192.168.50.0/24
172015-06-03 05:46:20.886 INFO  [kea-dhcp4.dhcpsrv/23999] DHCPSRV_MEMFILE_DB opening memory file lease database: type=memfile universe=4
182015-06-03 05:46:20.886 INFO  [kea-dhcp4.dhcpsrv/23999] DHCPSRV_MEMFILE_LEASE_FILE_LOAD loading leases from file /usr/local/var/kea/kea-leases4.csv
192015-06-03 05:46:20.886 INFO  [kea-dhcp4.dhcp4/23999] DHCP4_CONFIG_COMPLETE DHCPv4 server has completed configuration: added IPv4 subnets: 1; DDNS: disabled
202015-06-03 05:46:20.905 INFO  [kea-dhcp4.dhcp4/23999] DHCP4_STARTED Kea DHCPv4 server version 0.9.1-git started
212015-06-03 05:46:20.905 DEBUG [kea-dhcp4.packets/23999] DHCP4_BUFFER_WAIT waiting for next DHCPv4 packet with timeout 1000 ms
222015-06-03 05:46:23.851 DEBUG [kea-dhcp4.packets/23999] DHCP4_BUFFER_WAIT_SIGNAL signal received while waiting for next packet, next waiting signal is 1
232015-06-03 05:46:23.851 INFO  [kea-dhcp4.dhcp4/23999] DHCP4_DYNAMIC_RECONFIGURATION initiate server reconfiguration using file: /usr/local/etc/kea/kea.conf, after receiving SIGHUP signal
242015-06-03 05:46:23.851 DEBUG [kea-dhcp4.dhcp4/23999] DHCP4_COMMAND_RECEIVED received command config-reload, arguments: { "interfaces-config": { "interfaces": [ "eth2" ] }, "lease-database": { "type": "memfile" }, "rebind-timer": 3, "renew-timer": 2, "subnet4": [ { "interface": "eth2", "pools": [ { "pool": "192.168.50.1-192.168.50.10" } ], "subnet": "192.168.50.0/24" } ], "valid-lifetime": 4 }
252015-06-03 05:46:23.851 DEBUG [kea-dhcp4.dhcp4/23999] DHCP4_CONFIG_RECEIVED received configuration { "interfaces-config": { "interfaces": [ "eth2" ] }, "lease-database": { "type": "memfile" }, "rebind-timer": 3, "renew-timer": 2, "subnet4": [ { "interface": "eth2", "pools": [ { "pool": "192.168.50.1-192.168.50.10" } ], "subnet": "192.168.50.0/24" } ], "valid-lifetime": 4 }
262015-06-03 05:46:23.851 DEBUG [kea-dhcp4.dhcp4/23999] DHCP4_CONFIG_START DHCPv4 server is processing the following configuration: { "interfaces-config": { "interfaces": [ "eth2" ] }, "lease-database": { "type": "memfile" }, "rebind-timer": 3, "renew-timer": 2, "subnet4": [ { "interface": "eth2", "pools": [ { "pool": "192.168.50.1-192.168.50.10" } ], "subnet": "192.168.50.0/24" } ], "valid-lifetime": 4 }
272015-06-03 05:46:23.851 DEBUG [kea-dhcp4.dhcp4/23999] DHCP4_PARSER_CREATED created parser for configuration element interfaces-config
282015-06-03 05:46:23.851 INFO  [kea-dhcp4.dhcpsrv/23999] DHCPSRV_CFGMGR_ADD_IFACE listening on interface eth2
292015-06-03 05:46:23.852 INFO  [kea-dhcp4.dhcpsrv/23999] DHCPSRV_CFGMGR_SOCKET_TYPE_DEFAULT "dhcp-socket-type" not specified , using default socket type raw
302015-06-03 05:46:23.852 DEBUG [kea-dhcp4.dhcp4/23999] DHCP4_PARSER_CREATED created parser for configuration element lease-database
312015-06-03 05:46:23.852 DEBUG [kea-dhcp4.dhcp4/23999] DHCP4_PARSER_CREATED created parser for configuration element rebind-timer
322015-06-03 05:46:23.852 DEBUG [kea-dhcp4.dhcp4/23999] DHCP4_PARSER_CREATED created parser for configuration element renew-timer
332015-06-03 05:46:23.852 DEBUG [kea-dhcp4.dhcp4/23999] DHCP4_PARSER_CREATED created parser for configuration element subnet4
342015-06-03 05:46:23.852 DEBUG [kea-dhcp4.dhcp4/23999] DHCP4_PARSER_CREATED created parser for configuration element valid-lifetime
352015-06-03 05:46:23.852 INFO  [kea-dhcp4.dhcp4/23999] DHCP4_CONFIG_NEW_SUBNET a new subnet has been added to configuration: 192.168.50.0/24 with params: t1=2, t2=3, valid-lifetime=4
362015-06-03 05:46:23.852 DEBUG [kea-dhcp4.dhcpsrv/23999] DHCPSRV_CFGMGR_ADD_SUBNET4 adding subnet 192.168.50.0/24
372015-06-03 05:46:23.852 DEBUG [kea-dhcp4.dhcpsrv/23999] DHCPSRV_CLOSE_DB closing currently open memfile database
382015-06-03 05:46:23.852 INFO  [kea-dhcp4.dhcpsrv/23999] DHCPSRV_MEMFILE_DB opening memory file lease database: type=memfile universe=4
392015-06-03 05:46:23.852 INFO  [kea-dhcp4.dhcpsrv/23999] DHCPSRV_MEMFILE_LEASE_FILE_LOAD loading leases from file /usr/local/var/kea/kea-leases4.csv
402015-06-03 05:46:23.852 INFO  [kea-dhcp4.dhcp4/23999] DHCP4_CONFIG_COMPLETE DHCPv4 server has completed configuration: added IPv4 subnets: 1; DDNS: disabled
412015-06-03 05:46:23.937 DEBUG [kea-dhcp4.packets/23999] DHCP4_BUFFER_WAIT waiting for next DHCPv4 packet with timeout 1000 ms
422015-06-03 05:46:23.996 DEBUG [kea-dhcp4.packets/23999] DHCP4_BUFFER_RECEIVED received buffer from 0.0.0.0:68 to 255.255.255.255:67 over interface eth2
432015-06-03 05:46:23.996 DEBUG [kea-dhcp4.options/23999] DHCP4_BUFFER_UNPACK parsing buffer received from 0.0.0.0 to 255.255.255.255 over interface eth2
442015-06-03 05:46:23.996 DEBUG [kea-dhcp4.packets/23999] DHCP4_SUBNET_SELECTED [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0xf995d9: the subnet with ID 1 was selected for client assignments
452015-06-03 05:46:23.996 DEBUG [kea-dhcp4.packets/23999] DHCP4_SUBNET_DATA [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0xf995d9: the selected subnet details: 192.168.50.0/24
462015-06-03 05:46:23.996 DEBUG [kea-dhcp4.packets/23999] DHCP4_PACKET_RECEIVED [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0xf995d9: DHCPDISCOVER (type 1) received from 0.0.0.0 to 255.255.255.255 on interface eth2
472015-06-03 05:46:23.996 DEBUG [kea-dhcp4.packets/23999] DHCP4_QUERY_DATA [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0xf995d9, packet details: local_address=255.255.255.255:67, remote_adress=0.0.0.0:68, msg_type=DHCPDISCOVER (1), transid=0xf995d9,
48options:
49  type=053, len=001: 1 (uint8)
50  type=055, len=001: (uint8)
512015-06-03 05:46:23.996 DEBUG [kea-dhcp4.packets/23999] DHCP4_SUBNET_SELECTED [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0xf995d9: the subnet with ID 1 was selected for client assignments
522015-06-03 05:46:23.996 DEBUG [kea-dhcp4.packets/23999] DHCP4_SUBNET_DATA [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0xf995d9: the selected subnet details: 192.168.50.0/24
532015-06-03 05:46:23.997 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ONE_SUBNET_ID_HWADDR_DUID get one host with IPv4 reservation for subnet id 1, HWADDR hwtype=1 0a:00:27:00:00:01, DUID (no-duid)
542015-06-03 05:46:23.997 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ALL_HWADDR_DUID get all hosts with reservations for HWADDR hwtype=1 0a:00:27:00:00:01 and DUID (no-duid)
552015-06-03 05:46:23.997 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ALL_IDENTIFIER get all hosts with reservations using identifier: hwaddr=0a:00:27:00:00:01
562015-06-03 05:46:23.997 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ALL_IDENTIFIER_COUNT using identifier hwaddr=0a:00:27:00:00:01, found 0 host(s)
572015-06-03 05:46:23.997 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ONE_SUBNET_ID_HWADDR_DUID_NULL host not found using subnet id 1, HW address hwtype=1 0a:00:27:00:00:01 and DUID (no-duid)
582015-06-03 05:46:23.997 DEBUG [kea-dhcp4.dhcpsrv/23999] DHCPSRV_MEMFILE_GET_SUBID_HWADDR obtaining IPv4 lease for subnet ID 1 and hardware address hwtype=1 0a:00:27:00:00:01
592015-06-03 05:46:23.997 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4 get one host with reservation for subnet id 1 and IPv4 address 192.168.50.1
602015-06-03 05:46:23.997 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ALL_ADDRESS4 get all hosts with reservations for IPv4 address 192.168.50.1
612015-06-03 05:46:23.997 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ALL_ADDRESS4_COUNT using address 192.168.50.1, found 0 host(s)
622015-06-03 05:46:23.997 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4_NULL host not found using subnet id 1 and address 192.168.50.1
632015-06-03 05:46:23.997 DEBUG [kea-dhcp4.dhcpsrv/23999] DHCPSRV_MEMFILE_GET_ADDR4 obtaining IPv4 lease for address 192.168.50.1
642015-06-03 05:46:23.997 DEBUG [kea-dhcp4.dhcpsrv/23999] DHCPSRV_MEMFILE_GET_ADDR4 obtaining IPv4 lease for address 192.168.50.1
652015-06-03 05:46:23.997 DEBUG [kea-dhcp4.leases/23999] DHCP4_LEASE_ADVERT [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0xf995d9: lease 192.168.50.1 will be advertised
662015-06-03 05:46:23.997 DEBUG [kea-dhcp4.options/23999] DHCP4_PACKET_PACK [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0xf995d9: preparing on-wire format of the packet to be sent
672015-06-03 05:46:23.997 DEBUG [kea-dhcp4.packets/23999] DHCP4_PACKET_SEND [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0xf995d9: sending packet DHCPOFFER (type 2) from 192.168.50.250:67 to 192.168.50.1:68 on interface eth2
682015-06-03 05:46:23.997 DEBUG [kea-dhcp4.packets/23999] DHCP4_RESPONSE_DATA [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0xf995d9: responding with packet DHCPOFFER (type 2), packet details: local_address=192.168.50.250:67, remote_adress=192.168.50.1:68, msg_type=DHCPOFFER (2), transid=0xf995d9,
69options:
70  type=001, len=004: 4294967040 (uint32)
71  type=051, len=004: 4 (uint32)
72  type=053, len=001: 02
73  type=054, len=004: 192.168.50.250
74  type=058, len=004: 2 (uint32)
75  type=059, len=004: 3 (uint32)
762015-06-03 05:46:23.997 DEBUG [kea-dhcp4.packets/23999] DHCP4_BUFFER_WAIT waiting for next DHCPv4 packet with timeout 1000 ms
772015-06-03 05:46:25.214 DEBUG [kea-dhcp4.packets/23999] DHCP4_BUFFER_RECEIVED received buffer from 0.0.0.0:68 to 255.255.255.255:67 over interface eth2
782015-06-03 05:46:25.214 DEBUG [kea-dhcp4.options/23999] DHCP4_BUFFER_UNPACK parsing buffer received from 0.0.0.0 to 255.255.255.255 over interface eth2
792015-06-03 05:46:25.215 DEBUG [kea-dhcp4.packets/23999] DHCP4_SUBNET_SELECTED [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0xdde449: the subnet with ID 1 was selected for client assignments
802015-06-03 05:46:25.215 DEBUG [kea-dhcp4.packets/23999] DHCP4_SUBNET_DATA [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0xdde449: the selected subnet details: 192.168.50.0/24
812015-06-03 05:46:25.215 DEBUG [kea-dhcp4.packets/23999] DHCP4_PACKET_RECEIVED [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0xdde449: DHCPREQUEST (type 3) received from 0.0.0.0 to 255.255.255.255 on interface eth2
822015-06-03 05:46:25.215 DEBUG [kea-dhcp4.packets/23999] DHCP4_QUERY_DATA [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0xdde449, packet details: local_address=255.255.255.255:67, remote_adress=0.0.0.0:68, msg_type=DHCPREQUEST (3), transid=0xdde449,
83options:
84  type=050, len=004: 192.168.50.1 (ipv4-address)
85  type=053, len=001: 3 (uint8)
86  type=054, len=004: 192.168.50.250 (ipv4-address)
87  type=055, len=001: (uint8)
882015-06-03 05:46:25.215 DEBUG [kea-dhcp4.packets/23999] DHCP4_SUBNET_SELECTED [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0xdde449: the subnet with ID 1 was selected for client assignments
892015-06-03 05:46:25.215 DEBUG [kea-dhcp4.packets/23999] DHCP4_SUBNET_DATA [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0xdde449: the selected subnet details: 192.168.50.0/24
902015-06-03 05:46:25.215 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ONE_SUBNET_ID_HWADDR_DUID get one host with IPv4 reservation for subnet id 1, HWADDR hwtype=1 0a:00:27:00:00:01, DUID (no-duid)
912015-06-03 05:46:25.215 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ALL_HWADDR_DUID get all hosts with reservations for HWADDR hwtype=1 0a:00:27:00:00:01 and DUID (no-duid)
922015-06-03 05:46:25.215 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ALL_IDENTIFIER get all hosts with reservations using identifier: hwaddr=0a:00:27:00:00:01
932015-06-03 05:46:25.215 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ALL_IDENTIFIER_COUNT using identifier hwaddr=0a:00:27:00:00:01, found 0 host(s)
942015-06-03 05:46:25.216 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ONE_SUBNET_ID_HWADDR_DUID_NULL host not found using subnet id 1, HW address hwtype=1 0a:00:27:00:00:01 and DUID (no-duid)
952015-06-03 05:46:25.216 DEBUG [kea-dhcp4.dhcpsrv/23999] DHCPSRV_MEMFILE_GET_SUBID_HWADDR obtaining IPv4 lease for subnet ID 1 and hardware address hwtype=1 0a:00:27:00:00:01
962015-06-03 05:46:25.216 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4 get one host with reservation for subnet id 1 and IPv4 address 192.168.50.1
972015-06-03 05:46:25.216 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ALL_ADDRESS4 get all hosts with reservations for IPv4 address 192.168.50.1
982015-06-03 05:46:25.216 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ALL_ADDRESS4_COUNT using address 192.168.50.1, found 0 host(s)
992015-06-03 05:46:25.216 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4_NULL host not found using subnet id 1 and address 192.168.50.1
1002015-06-03 05:46:25.216 DEBUG [kea-dhcp4.dhcpsrv/23999] DHCPSRV_MEMFILE_GET_ADDR4 obtaining IPv4 lease for address 192.168.50.1
1012015-06-03 05:46:25.216 DEBUG [kea-dhcp4.dhcpsrv/23999] DHCPSRV_MEMFILE_GET_ADDR4 obtaining IPv4 lease for address 192.168.50.1
1022015-06-03 05:46:25.216 DEBUG [kea-dhcp4.dhcpsrv/23999] DHCPSRV_MEMFILE_ADD_ADDR4 adding IPv4 lease with address 192.168.50.1
1032015-06-03 05:46:25.216 DEBUG [kea-dhcp4.dhcpsrv/23999] DHCPSRV_MEMFILE_GET_ADDR4 obtaining IPv4 lease for address 192.168.50.1
1042015-06-03 05:46:25.216 DEBUG [kea-dhcp4.leases/23999] DHCP4_LEASE_ALLOC [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0xdde449: lease 192.168.50.1 has been allocated
1052015-06-03 05:46:25.216 DEBUG [kea-dhcp4.options/23999] DHCP4_PACKET_PACK [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0xdde449: preparing on-wire format of the packet to be sent
1062015-06-03 05:46:25.217 DEBUG [kea-dhcp4.packets/23999] DHCP4_PACKET_SEND [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0xdde449: sending packet DHCPACK (type 5) from 192.168.50.250:67 to 192.168.50.1:68 on interface eth2
1072015-06-03 05:46:25.217 DEBUG [kea-dhcp4.packets/23999] DHCP4_RESPONSE_DATA [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0xdde449: responding with packet DHCPACK (type 5), packet details: local_address=192.168.50.250:67, remote_adress=192.168.50.1:68, msg_type=DHCPACK (5), transid=0xdde449,
108options:
109  type=001, len=004: 4294967040 (uint32)
110  type=051, len=004: 4 (uint32)
111  type=053, len=001: 05
112  type=054, len=004: 192.168.50.250
113  type=058, len=004: 2 (uint32)
114  type=059, len=004: 3 (uint32)
1152015-06-03 05:46:25.217 DEBUG [kea-dhcp4.packets/23999] DHCP4_BUFFER_WAIT waiting for next DHCPv4 packet with timeout 1000 ms
1162015-06-03 05:46:41.416 DEBUG [kea-dhcp4.packets/23999] DHCP4_BUFFER_RECEIVED received buffer from 0.0.0.0:68 to 255.255.255.255:67 over interface eth2
1172015-06-03 05:46:41.416 DEBUG [kea-dhcp4.options/23999] DHCP4_BUFFER_UNPACK parsing buffer received from 0.0.0.0 to 255.255.255.255 over interface eth2
1182015-06-03 05:46:41.416 DEBUG [kea-dhcp4.packets/23999] DHCP4_SUBNET_SELECTED [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0x611b06: the subnet with ID 1 was selected for client assignments
1192015-06-03 05:46:41.416 DEBUG [kea-dhcp4.packets/23999] DHCP4_SUBNET_DATA [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0x611b06: the selected subnet details: 192.168.50.0/24
1202015-06-03 05:46:41.416 DEBUG [kea-dhcp4.packets/23999] DHCP4_PACKET_RECEIVED [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0x611b06: DHCPREQUEST (type 3) received from 0.0.0.0 to 255.255.255.255 on interface eth2
1212015-06-03 05:46:41.416 DEBUG [kea-dhcp4.packets/23999] DHCP4_QUERY_DATA [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0x611b06, packet details: local_address=255.255.255.255:67, remote_adress=0.0.0.0:68, msg_type=DHCPREQUEST (3), transid=0x611b06,
122options:
123  type=053, len=001: 3 (uint8)
1242015-06-03 05:46:41.416 DEBUG [kea-dhcp4.packets/23999] DHCP4_SUBNET_SELECTED [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0x611b06: the subnet with ID 1 was selected for client assignments
1252015-06-03 05:46:41.416 DEBUG [kea-dhcp4.packets/23999] DHCP4_SUBNET_DATA [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0x611b06: the selected subnet details: 192.168.50.0/24
1262015-06-03 05:46:41.416 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ONE_SUBNET_ID_HWADDR_DUID get one host with IPv4 reservation for subnet id 1, HWADDR hwtype=1 0a:00:27:00:00:01, DUID (no-duid)
1272015-06-03 05:46:41.417 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ALL_HWADDR_DUID get all hosts with reservations for HWADDR hwtype=1 0a:00:27:00:00:01 and DUID (no-duid)
1282015-06-03 05:46:41.417 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ALL_IDENTIFIER get all hosts with reservations using identifier: hwaddr=0a:00:27:00:00:01
1292015-06-03 05:46:41.417 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ALL_IDENTIFIER_COUNT using identifier hwaddr=0a:00:27:00:00:01, found 0 host(s)
1302015-06-03 05:46:41.417 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ONE_SUBNET_ID_HWADDR_DUID_NULL host not found using subnet id 1, HW address hwtype=1 0a:00:27:00:00:01 and DUID (no-duid)
1312015-06-03 05:46:41.417 DEBUG [kea-dhcp4.dhcpsrv/23999] DHCPSRV_MEMFILE_GET_SUBID_HWADDR obtaining IPv4 lease for subnet ID 1 and hardware address hwtype=1 0a:00:27:00:00:01
1322015-06-03 05:46:41.417 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4 get one host with reservation for subnet id 1 and IPv4 address 192.168.50.1
1332015-06-03 05:46:41.417 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ALL_ADDRESS4 get all hosts with reservations for IPv4 address 192.168.50.1
1342015-06-03 05:46:41.417 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ALL_ADDRESS4_COUNT using address 192.168.50.1, found 0 host(s)
1352015-06-03 05:46:41.417 DEBUG [kea-dhcp4.hosts/23999] HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4_NULL host not found using subnet id 1 and address 192.168.50.1
1362015-06-03 05:46:41.417 DEBUG [kea-dhcp4.dhcpsrv/23999] DHCPSRV_MEMFILE_GET_ADDR4 obtaining IPv4 lease for address 192.168.50.1
1372015-06-03 05:46:41.417 DEBUG [kea-dhcp4.dhcpsrv/23999] DHCPSRV_MEMFILE_UPDATE_ADDR4 updating IPv4 lease for address 192.168.50.1
1382015-06-03 05:46:41.417 DEBUG [kea-dhcp4.leases/23999] DHCP4_LEASE_ALLOC [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0x611b06: lease 192.168.50.1 has been allocated
1392015-06-03 05:46:41.417 DEBUG [kea-dhcp4.options/23999] DHCP4_PACKET_PACK [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0x611b06: preparing on-wire format of the packet to be sent
1402015-06-03 05:46:41.417 DEBUG [kea-dhcp4.packets/23999] DHCP4_PACKET_SEND [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0x611b06: sending packet DHCPACK (type 5) from 192.168.50.250:67 to 192.168.50.1:68 on interface eth2
1412015-06-03 05:46:41.417 DEBUG [kea-dhcp4.packets/23999] DHCP4_RESPONSE_DATA [hwtype=1 0a:00:27:00:00:01], cid=[no info], tid=0x611b06: responding with packet DHCPACK (type 5), packet details: local_address=192.168.50.250:67, remote_adress=192.168.50.1:68, msg_type=DHCPACK (5), transid=0x611b06,
142options:
143  type=001, len=004: 4294967040 (uint32)
144  type=051, len=004: 4 (uint32)
145  type=053, len=001: 05
146  type=054, len=004: 192.168.50.250
147  type=058, len=004: 2 (uint32)
148  type=059, len=004: 3 (uint32)
1492015-06-03 05:46:41.417 DEBUG [kea-dhcp4.packets/23999] DHCP4_BUFFER_WAIT waiting for next DHCPv4 packet with timeout 1000 ms