Output from 1.19
D, [2018-11-20T07:45:06.817871 ] DEBUG -- : accept: 10.100.0.107:35094
D, [2018-11-20T07:45:06.864750 ] DEBUG -- : Rack::Handler::WEBrick is invoked.
I, [2018-11-20T07:45:06.864750 0c121a6d] INFO -- : 10.100.0.107 - - [20/Nov/2018:07:45:06 -0600] "GET /features HTTP/1.1" 200 21 0.0000
D, [2018-11-20T07:45:06.911629 ] DEBUG -- : close: 10.100.0.107:35094
D, [2018-11-20T07:45:08.318398 ] DEBUG -- : accept: 10.100.0.107:35100
D, [2018-11-20T07:45:08.365277 ] DEBUG -- : Rack::Handler::WEBrick is invoked.
D, [2018-11-20T07:45:08.365277 0c121a6d] DEBUG -- : #<Proxy::DHCP::Reservation:0x00000000052fa530 @type="reservation", @name="waffles-f-1.test.com-01", @subnet=#<Proxy::DHCP::Subnet:0x00000000052fb390 @network="10.10.20.0", @netmask="255.255.255.0", @ipaddr=#<IPAddr: IPv4:10.10.20.0/255.255.255.0>, @options={}, @m=#<Monitor:0x00000000052fa6e8 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Thread::Mutex:0x00000000052fa5a8>>>, @ip="10.10.20.20", @mac="24:6e:96:1d:62:10", @options={:deleteable=>true, :hostname=>"waffles-f-1.test.com", 81=>0}>
I, [2018-11-20T07:45:08.365277 0c121a6d] INFO -- : 10.100.0.107 - - [20/Nov/2018:07:45:08 -0600] "GET /dhcp/10.10.20.0/mac/24:6e:96:1d:62:10 HTTP/1.1" 200 205 0.0000
D, [2018-11-20T07:45:08.412155 ] DEBUG -- : close: 10.100.0.107:35100
D, [2018-11-20T07:45:08.427782 ] DEBUG -- : accept: 10.100.0.107:35102
D, [2018-11-20T07:45:08.474660 ] DEBUG -- : Rack::Handler::WEBrick is invoked.
D, [2018-11-20T07:45:08.474660 0c121a6d] DEBUG -- : #<Proxy::DHCP::Reservation:0x0000000005123ec8 @type="reservation", @name="waffles-f-1.test.com-01", @subnet=#<Proxy::DHCP::Subnet:0x0000000005128b30 @network="10.10.20.0", @netmask="255.255.255.0", @ipaddr=#<IPAddr: IPv4:10.10.20.0/255.255.255.0>, @options={}, @m=#<Monitor:0x0000000005128018 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Thread::Mutex:0x0000000005123f18>>>, @ip="10.10.20.20", @mac="24:6e:96:1d:62:10", @options={:deleteable=>true, :hostname=>"waffles-f-1.test.com", 81=>0}>
I, [2018-11-20T07:45:08.474660 0c121a6d] INFO -- : 10.100.0.107 - - [20/Nov/2018:07:45:08 -0600] "GET /dhcp/10.10.20.0/ip/10.10.20.20 HTTP/1.1" 200 207 0.0000
D, [2018-11-20T07:45:08.521539 ] DEBUG -- : close: 10.100.0.107:35102
D, [2018-11-20T07:45:08.537165 ] DEBUG -- : accept: 10.100.0.107:35104
D, [2018-11-20T07:45:08.584044 ] DEBUG -- : Rack::Handler::WEBrick is invoked.
E, [2018-11-20T07:45:08.584044 0c121a6d] ERROR -- : No DHCP record for MAC 10.10.20.0/24:6e:96:1d:62:12 found
D, [2018-11-20T07:45:08.584044 0c121a6d] DEBUG -- : No DHCP record for MAC 10.10.20.0/24:6e:96:1d:62:12 found
I, [2018-11-20T07:45:08.584044 0c121a6d] INFO -- : 10.100.0.107 - - [20/Nov/2018:07:45:08 -0600] "GET /dhcp/10.10.20.0/mac/24:6e:96:1d:62:12 HTTP/1.1" 404 57 0.0000
D, [2018-11-20T07:45:08.630923 ] DEBUG -- : close: 10.100.0.107:35104
D, [2018-11-20T07:45:08.646549 ] DEBUG -- : accept: 10.100.0.107:35106
D, [2018-11-20T07:45:08.693428 ] DEBUG -- : Rack::Handler::WEBrick is invoked.
D, [2018-11-20T07:45:08.693428 0c121a6d] DEBUG -- : #<Proxy::DHCP::Reservation:0x0000000004fa3800 @type="reservation", @name="waffles-f-1.test.com-01", @subnet=#<Proxy::DHCP::Subnet:0x0000000004fa8058 @network="10.10.20.0", @netmask="255.255.255.0", @ipaddr=#<IPAddr: IPv4:10.10.20.0/255.255.255.0>, @options={}, @m=#<Monitor:0x0000000004fa38a0 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Thread::Mutex:0x0000000004fa3850>>>, @ip="10.10.20.20", @mac="24:6e:96:1d:62:10", @options={:deleteable=>true, :hostname=>"waffles-f-1.test.com", 81=>0}>
I, [2018-11-20T07:45:08.693428 0c121a6d] INFO -- : 10.100.0.107 - - [20/Nov/2018:07:45:08 -0600] "GET /dhcp/10.10.20.0/ip/10.10.20.20 HTTP/1.1" 200 207 0.0000
D, [2018-11-20T07:45:08.740306 ] DEBUG -- : close: 10.100.0.107:35106
D, [2018-11-20T07:45:08.755933 ] DEBUG -- : accept: 10.100.0.107:35108
D, [2018-11-20T07:45:08.802811 ] DEBUG -- : Rack::Handler::WEBrick is invoked.
D, [2018-11-20T07:45:08.802811 0c121a6d] DEBUG -- : #<Proxy::DHCP::Reservation:0x0000000004e5b970 @type="reservation", @name="waffles-f-1.test.com-01", @subnet=#<Proxy::DHCP::Subnet:0x0000000004eac230 @network="10.10.20.0", @netmask="255.255.255.0", @ipaddr=#<IPAddr: IPv4:10.10.20.0/255.255.255.0>, @options={}, @m=#<Monitor:0x0000000004e5ba10 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Thread::Mutex:0x0000000004e5b9c0>>>, @ip="10.10.20.20", @mac="24:6e:96:1d:62:10", @options={:deleteable=>true, :hostname=>"waffles-f-1.test.com", 81=>0}>
I, [2018-11-20T07:45:08.802811 0c121a6d] INFO -- : 10.100.0.107 - - [20/Nov/2018:07:45:08 -0600] "GET /dhcp/10.10.20.0/mac/24:6e:96:1d:62:10 HTTP/1.1" 200 205 0.0000
D, [2018-11-20T07:45:08.849690 ] DEBUG -- : close: 10.100.0.107:35108
D, [2018-11-20T07:45:08.865316 ] DEBUG -- : accept: 10.100.0.107:35110
D, [2018-11-20T07:45:08.912195 ] DEBUG -- : Rack::Handler::WEBrick is invoked.
E, [2018-11-20T07:45:08.912195 0c121a6d] ERROR -- : No DHCP record for MAC 10.10.20.0/24:6e:96:1d:62:12 found
D, [2018-11-20T07:45:08.912195 0c121a6d] DEBUG -- : No DHCP record for MAC 10.10.20.0/24:6e:96:1d:62:12 found
I, [2018-11-20T07:45:08.912195 0c121a6d] INFO -- : 10.100.0.107 - - [20/Nov/2018:07:45:08 -0600] "GET /dhcp/10.10.20.0/mac/24:6e:96:1d:62:12 HTTP/1.1" 404 57 0.0000
D, [2018-11-20T07:45:08.959074 ] DEBUG -- : close: 10.100.0.107:35110
D, [2018-11-20T07:45:09.115336 ] DEBUG -- : accept: 10.100.0.107:35114
D, [2018-11-20T07:45:09.177841 ] DEBUG -- : Rack::Handler::WEBrick is invoked.
D, [2018-11-20T07:45:09.177841 0c121a6d] DEBUG -- : #<Proxy::DHCP::Reservation:0x0000000002c6b338 @type="reservation", @name="waffles-f-1-mgmt.test.com", @subnet=#<Proxy::DHCP::Subnet:0x0000000002c71a30 @network="10.10.21.0", @netmask="255.255.255.0", @ipaddr=#<IPAddr: IPv4:10.10.21.0/255.255.255.0>, @options={}, @m=#<Monitor:0x0000000002c6b590 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Thread::Mutex:0x0000000002c6b4a0>>>, @ip="10.10.21.20", @mac="24:6e:96:1d:62:15", @options={:deleteable=>true, :hostname=>"waffles-f-1-mgmt.test.com", :nextServer=>"10.10.0.101", :filename=>"pxelinux.0", 81=>0}>
I, [2018-11-20T07:45:09.177841 0c121a6d] INFO -- : 10.100.0.107 - - [20/Nov/2018:07:45:09 -0600] "GET /dhcp/10.10.21.0/mac/24:6e:96:1d:62:15 HTTP/1.1" 200 263 0.0000
D, [2018-11-20T07:45:09.224720 ] DEBUG -- : close: 10.100.0.107:35114
D, [2018-11-20T07:45:09.240346 ] DEBUG -- : accept: 10.100.0.107:35116
D, [2018-11-20T07:45:09.287225 ] DEBUG -- : Rack::Handler::WEBrick is invoked.
D, [2018-11-20T07:45:09.287225 0c121a6d] DEBUG -- : #<Proxy::DHCP::Reservation:0x0000000001b74ac0 @type="reservation", @name="waffles-f-1-mgmt.test.com", @subnet=#<Proxy::DHCP::Subnet:0x0000000001b764b0 @network="10.10.21.0", @netmask="255.255.255.0", @ipaddr=#<IPAddr: IPv4:10.10.21.0/255.255.255.0>, @options={}, @m=#<Monitor:0x0000000001b74bd8 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Thread::Mutex:0x0000000001b74b10>>>, @ip="10.10.21.20", @mac="24:6e:96:1d:62:15", @options={:deleteable=>true, :hostname=>"waffles-f-1-mgmt.test.com", :nextServer=>"10.10.0.101", :filename=>"pxelinux.0", 81=>0}>
I, [2018-11-20T07:45:09.287225 0c121a6d] INFO -- : 10.100.0.107 - - [20/Nov/2018:07:45:09 -0600] "GET /dhcp/10.10.21.0/ip/10.10.21.20 HTTP/1.1" 200 265 0.0000
D, [2018-11-20T07:45:09.334104 ] DEBUG -- : close: 10.100.0.107:35116
D, [2018-11-20T07:45:09.349730 ] DEBUG -- : accept: 10.100.0.107:35118
D, [2018-11-20T07:45:09.396609 ] DEBUG -- : Rack::Handler::WEBrick is invoked.
D, [2018-11-20T07:45:09.396609 0c121a6d] DEBUG -- : #<Proxy::DHCP::Reservation:0x0000000005303ce8 @type="reservation", @name="waffles-f-1-mgmt.test.com", @subnet=#<Proxy::DHCP::Subnet:0x00000000053089a0 @network="10.10.21.0", @netmask="255.255.255.0", @ipaddr=#<IPAddr: IPv4:10.10.21.0/255.255.255.0>, @options={}, @m=#<Monitor:0x0000000005309c60 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Thread::Mutex:0x0000000005303d60>>>, @ip="10.10.21.20", @mac="24:6e:96:1d:62:15", @options={:deleteable=>true, :hostname=>"waffles-f-1-mgmt.test.com", :nextServer=>"10.10.0.101", :filename=>"pxelinux.0", 81=>0}>
I, [2018-11-20T07:45:09.396609 0c121a6d] INFO -- : 10.100.0.107 - - [20/Nov/2018:07:45:09 -0600] "GET /dhcp/10.10.21.0/mac/24:6e:96:1d:62:15 HTTP/1.1" 200 263 0.0000
D, [2018-11-20T07:45:09.443488 ] DEBUG -- : close: 10.100.0.107:35118
D, [2018-11-20T07:45:09.505993 ] DEBUG -- : accept: 10.100.0.107:35120
D, [2018-11-20T07:45:09.552871 ] DEBUG -- : Rack::Handler::WEBrick is invoked.
D, [2018-11-20T07:45:09.552871 0c121a6d] DEBUG -- : #<Proxy::DHCP::Reservation:0x00000000051386e8 @type="reservation", @name="waffles-f-1.test.com-01", @subnet=#<Proxy::DHCP::Subnet:0x0000000005139548 @network="10.10.20.0", @netmask="255.255.255.0", @ipaddr=#<IPAddr: IPv4:10.10.20.0/255.255.255.0>, @options={}, @m=#<Monitor:0x0000000005138800 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Thread::Mutex:0x0000000005138738>>>, @ip="10.10.20.20", @mac="24:6e:96:1d:62:10", @options={:deleteable=>true, :hostname=>"waffles-f-1.test.com", 81=>0}>
D, [2018-11-20T07:45:09.552871 0c121a6d] DEBUG -- : Deleting 'waffles-f-1.test.com-01 (10.10.20.20 / 24:6e:96:1d:62:10)'
I, [2018-11-20T07:45:09.552871 0c121a6d] INFO -- : 10.100.0.107 - - [20/Nov/2018:07:45:09 -0600] "DELETE /dhcp/10.10.20.0/mac/24:6e:96:1d:62:10 HTTP/1.1" 200 - 0.0000
D, [2018-11-20T07:45:09.568498 ] DEBUG -- : close: 10.100.0.107:35120
D, [2018-11-20T07:45:09.568498 ] DEBUG -- : accept: 10.100.0.107:35122
D, [2018-11-20T07:45:09.615376 ] DEBUG -- : Rack::Handler::WEBrick is invoked.
I, [2018-11-20T07:45:09.615376 0c121a6d] INFO -- : 10.100.0.107 - - [20/Nov/2018:07:45:09 -0600] "DELETE /dhcp/10.10.20.0/mac/24:6e:96:1d:62:12 HTTP/1.1" 200 - 0.0000
D, [2018-11-20T07:45:09.631003 ] DEBUG -- : close: 10.100.0.107:35122
D, [2018-11-20T07:45:09.631003 ] DEBUG -- : accept: 10.100.0.107:35124
D, [2018-11-20T07:45:09.677881 ] DEBUG -- : Rack::Handler::WEBrick is invoked.
I, [2018-11-20T07:45:09.677881 0c121a6d] INFO -- : 10.100.0.107 - - [20/Nov/2018:07:45:09 -0600] "POST /dhcp/10.10.20.0 HTTP/1.1" 200 - 0.0000
D, [2018-11-20T07:45:09.693508 ] DEBUG -- : close: 10.100.0.107:35124
D, [2018-11-20T07:45:09.693508 ] DEBUG -- : accept: 10.100.0.107:35126
D, [2018-11-20T07:45:09.740386 ] DEBUG -- : Rack::Handler::WEBrick is invoked.
E, [2018-11-20T07:45:09.740386 0c121a6d] ERROR -- : Record 10.10.20.20/255.255.255.0 conflicts with an existing record.
D, [2018-11-20T07:45:09.740386 0c121a6d] DEBUG -- : Record 10.10.20.20/255.255.255.0 conflicts with an existing record. (Proxy::DHCP::Collision)
c:/Smart-Proxy/modules/dhcp_native_ms/dhcp_native_ms_main.rb:50:in `rescue in create_reservation'
c:/Smart-Proxy/modules/dhcp_native_ms/dhcp_native_ms_main.rb:38:in `create_reservation'
c:/Smart-Proxy/modules/dhcp_native_ms/dhcp_native_ms_main.rb:33:in `add_record'
c:/Smart-Proxy/modules/dhcp/dhcp_api.rb:98:in `block in <class:DhcpApi>'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1634:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1634:in `block in compile!'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:992:in `block (3 levels) in route!'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1011:in `route_eval'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:992:in `block (2 levels) in route!'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1039:in `block in process_route'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1037:in `catch'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1037:in `process_route'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:990:in `block in route!'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:989:in `each'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:989:in `route!'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1096:in `block in dispatch!'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1075:in `block in invoke'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1075:in `catch'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1075:in `invoke'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1093:in `dispatch!'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:924:in `block in call!'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1075:in `block in invoke'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1075:in `catch'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1075:in `invoke'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:924:in `call!'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:913:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-2.0.5/lib/rack/method_override.rb:22:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-2.0.5/lib/rack/common_logger.rb:33:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:231:in `call'
c:/Smart-Proxy/lib/proxy/log.rb:109:in `call'
c:/Smart-Proxy/lib/proxy/request_id_middleware.rb:9:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-protection-2.0.1/lib/rack/protection/xss_header.rb:18:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-protection-2.0.1/lib/rack/protection/path_traversal.rb:16:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-protection-2.0.1/lib/rack/protection/json_csrf.rb:26:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-protection-2.0.1/lib/rack/protection/base.rb:50:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-protection-2.0.1/lib/rack/protection/base.rb:50:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-protection-2.0.1/lib/rack/protection/frame_options.rb:31:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-2.0.5/lib/rack/null_logger.rb:9:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-2.0.5/lib/rack/head.rb:12:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/show_exceptions.rb:22:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:194:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1957:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1501:in `block in call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1728:in `synchronize'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1501:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-2.0.5/lib/rack/urlmap.rb:68:in `block in call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-2.0.5/lib/rack/urlmap.rb:53:in `each'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-2.0.5/lib/rack/urlmap.rb:53:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-2.0.5/lib/rack/builder.rb:153:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-2.0.5/lib/rack/handler/webrick.rb:86:in `service'
C:/Ruby24-x64/lib/ruby/2.4.0/webrick/httpserver.rb:140:in `service'
C:/Ruby24-x64/lib/ruby/2.4.0/webrick/httpserver.rb:96:in `run'
C:/Ruby24-x64/lib/ruby/2.4.0/webrick/server.rb:308:in `block in start_thread'
I, [2018-11-20T07:45:09.740386 0c121a6d] INFO -- : 10.100.0.107 - - [20/Nov/2018:07:45:09 -0600] "POST /dhcp/10.10.20.0 HTTP/1.1" 409 67 0.0000
D, [2018-11-20T07:45:09.787265 ] DEBUG -- : close: 10.100.0.107:35126
D, [2018-11-20T07:45:09.802891 ] DEBUG -- : accept: 10.100.0.107:35128
D, [2018-11-20T07:45:09.849770 ] DEBUG -- : Rack::Handler::WEBrick is invoked.
I, [2018-11-20T07:45:09.849770 0c121a6d] INFO -- : 10.100.0.107 - - [20/Nov/2018:07:45:09 -0600] "POST /dhcp/10.10.20.0 HTTP/1.1" 200 - 0.0000
D, [2018-11-20T07:45:09.865396 ] DEBUG -- : close: 10.100.0.107:35128
D, [2018-11-20T07:45:09.865396 ] DEBUG -- : accept: 10.100.0.107:35130
D, [2018-11-20T07:45:09.912275 ] DEBUG -- : Rack::Handler::WEBrick is invoked.
E, [2018-11-20T07:45:09.912275 0c121a6d] ERROR -- : Record 10.10.20.20/255.255.255.0 conflicts with an existing record.
D, [2018-11-20T07:45:09.912275 0c121a6d] DEBUG -- : Record 10.10.20.20/255.255.255.0 conflicts with an existing record. (Proxy::DHCP::Collision)
c:/Smart-Proxy/modules/dhcp_native_ms/dhcp_native_ms_main.rb:50:in `rescue in create_reservation'
c:/Smart-Proxy/modules/dhcp_native_ms/dhcp_native_ms_main.rb:38:in `create_reservation'
c:/Smart-Proxy/modules/dhcp_native_ms/dhcp_native_ms_main.rb:33:in `add_record'
c:/Smart-Proxy/modules/dhcp/dhcp_api.rb:98:in `block in <class:DhcpApi>'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1634:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1634:in `block in compile!'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:992:in `block (3 levels) in route!'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1011:in `route_eval'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:992:in `block (2 levels) in route!'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1039:in `block in process_route'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1037:in `catch'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1037:in `process_route'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:990:in `block in route!'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:989:in `each'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:989:in `route!'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1096:in `block in dispatch!'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1075:in `block in invoke'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1075:in `catch'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1075:in `invoke'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1093:in `dispatch!'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:924:in `block in call!'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1075:in `block in invoke'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1075:in `catch'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1075:in `invoke'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:924:in `call!'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:913:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-2.0.5/lib/rack/method_override.rb:22:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-2.0.5/lib/rack/common_logger.rb:33:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:231:in `call'
c:/Smart-Proxy/lib/proxy/log.rb:109:in `call'
c:/Smart-Proxy/lib/proxy/request_id_middleware.rb:9:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-protection-2.0.1/lib/rack/protection/xss_header.rb:18:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-protection-2.0.1/lib/rack/protection/path_traversal.rb:16:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-protection-2.0.1/lib/rack/protection/json_csrf.rb:26:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-protection-2.0.1/lib/rack/protection/base.rb:50:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-protection-2.0.1/lib/rack/protection/base.rb:50:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-protection-2.0.1/lib/rack/protection/frame_options.rb:31:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-2.0.5/lib/rack/null_logger.rb:9:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-2.0.5/lib/rack/head.rb:12:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/show_exceptions.rb:22:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:194:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1957:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1501:in `block in call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1728:in `synchronize'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/sinatra-2.0.1/lib/sinatra/base.rb:1501:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-2.0.5/lib/rack/urlmap.rb:68:in `block in call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-2.0.5/lib/rack/urlmap.rb:53:in `each'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-2.0.5/lib/rack/urlmap.rb:53:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-2.0.5/lib/rack/builder.rb:153:in `call'
C:/Ruby24-x64/lib/ruby/gems/2.4.0/gems/rack-2.0.5/lib/rack/handler/webrick.rb:86:in `service'
C:/Ruby24-x64/lib/ruby/2.4.0/webrick/httpserver.rb:140:in `service'
C:/Ruby24-x64/lib/ruby/2.4.0/webrick/httpserver.rb:96:in `run'
C:/Ruby24-x64/lib/ruby/2.4.0/webrick/server.rb:308:in `block in start_thread'
I, [2018-11-20T07:45:09.912275 0c121a6d] INFO -- : 10.100.0.107 - - [20/Nov/2018:07:45:09 -0600] "POST /dhcp/10.10.20.0 HTTP/1.1" 409 67 0.0000
D, [2018-11-20T07:45:09.959154 ] DEBUG -- : close: 10.100.0.107:35130