<div dir="ltr"><div><div>Hello everyone, I decided to try the latest version from branch v3.0.x. However, the problem remains and the circuit ID is somehow lost during the processing of the request. Please let me know what do. I suppose I should create a bug report.<br>
<br></div>Here is the relevant output from v3.0.x:<br><br>Received DHCP-Discover of id fa86ba10 from <a href="http://10.180.1.1:67">10.180.1.1:67</a> to <a href="http://10.160.0.254:67">10.160.0.254:67</a><br>0: 01 01 06 01 fa 86 ba 10 00 08 00 00 00 00 00 00 <br>
16: 00 00 00 00 00 00 00 00 0a b4 01 01 50 af 73 18 <br>32: ed 98 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>48: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>64: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>
80: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>96: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>112: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>128: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>
144: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>160: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>176: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>192: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>
208: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>224: 00 00 00 00 00 00 00 00 00 00 00 00 63 82 53 63 <br>240: 35 01 01 0c 07 73 75 70 70 6f 72 74 37 0d 01 1c <br>256: 02 03 0f 06 77 0c 2c 2f 1a 79 2a 52 12 01 08 00 <br>
272: 06 04 b1 01 00 00 01 02 06 00 03 0f 1a e3 2c ff <br>288: 00 00 00 00 00 00 00 00 00 00 00 00 <br>ššš DHCP-Opcode = Client-Message<br>ššš DHCP-Hardware-Type = Ethernet<br>ššš DHCP-Hardware-Address-Length = 6<br>ššš DHCP-Hop-Count = 1<br>
ššš DHCP-Transaction-Id = 4203133456<br>ššš DHCP-Number-of-Seconds = 8<br>ššš DHCP-Flags = 0<br>ššš DHCP-Client-IP-Address = 0.0.0.0<br>ššš DHCP-Your-IP-Address = 0.0.0.0<br>ššš DHCP-Server-IP-Address = 0.0.0.0<br>ššš DHCP-Gateway-IP-Address = 10.180.1.1<br>
ššš DHCP-Client-Hardware-Address = 50:af:73:18:ed:98<br>ššš DHCP-Message-Type += DHCP-Discover<br>ššš DHCP-Hostname += 'support'<br>ššš DHCP-Parameter-Request-List += DHCP-Subnet-Mask<br>ššš DHCP-Parameter-Request-List += DHCP-Broadcast-Address<br>
ššš DHCP-Parameter-Request-List += DHCP-Time-Offset<br>ššš DHCP-Parameter-Request-List += DHCP-Router-Address<br>ššš DHCP-Parameter-Request-List += DHCP-Domain-Name<br>ššš DHCP-Parameter-Request-List += DHCP-Domain-Name-Server<br>
ššš DHCP-Parameter-Request-List += DHCP-Domain-Search<br>ššš DHCP-Parameter-Request-List += DHCP-Hostname<br>ššš DHCP-Parameter-Request-List += DHCP-NETBIOS-Name-Servers<br>ššš DHCP-Parameter-Request-List += DHCP-NETBIOS<br>
ššš DHCP-Parameter-Request-List += DHCP-Interface-MTU-Size<br>ššš DHCP-Parameter-Request-List += DHCP-Classless-Static-Route<br>ššš DHCP-Parameter-Request-List += DHCP-NTP-Servers<br>ššš DHCP-Relay-Circuit-Id = 0x000604b101000001<br>
Thu Feb 27 09:53:15 2014 : Debug: Trying sub-section dhcp DHCP-Discover {...}<br>Thu Feb 27 09:53:15 2014 : Debug: (1)š dhcp DHCP-Discover {<br>Thu Feb 27 09:53:15 2014 : Debug: (1)šš modsingle[post-auth]: calling linelog-dhcp (rlm_linelog) for request 1<br>
Thu Feb 27 09:53:15 2014 : Debug: %{%{reply:DHCP-Message-Type}:-%{request:DHCP-Message-Type}}<br>Thu Feb 27 09:53:15 2014 : Debug: Parsed xlat tree:<br>Thu Feb 27 09:53:15 2014 : Debug: if {<br>Thu Feb 27 09:53:15 2014 : Debug: ššš attribute: DHCP-Message-Type<br>
Thu Feb 27 09:53:15 2014 : Debug: ššš {<br>Thu Feb 27 09:53:15 2014 : Debug: ššš ššš refš 2<br>Thu Feb 27 09:53:15 2014 : Debug: ššš ššš list 2<br>Thu Feb 27 09:53:15 2014 : Debug: ššš ššš tag -128<br>Thu Feb 27 09:53:15 2014 : Debug: ššš }<br>
Thu Feb 27 09:53:15 2014 : Debug: }<br>Thu Feb 27 09:53:15 2014 : Debug: else {<br>Thu Feb 27 09:53:15 2014 : Debug: ššš attribute: DHCP-Message-Type<br>Thu Feb 27 09:53:15 2014 : Debug: ššš {<br>Thu Feb 27 09:53:15 2014 : Debug: ššš ššš refš 2<br>
Thu Feb 27 09:53:15 2014 : Debug: ššš ššš list 1<br>Thu Feb 27 09:53:15 2014 : Debug: ššš ššš tag -128<br>Thu Feb 27 09:53:15 2014 : Debug: ššš }<br>Thu Feb 27 09:53:15 2014 : Debug: }<br>Thu Feb 27 09:53:15 2014 : Debug: (1) linelog-dhcp : ššš expand: "%{%{reply:DHCP-Message-Type}:-%{request:DHCP-Message-Type}}" -> 'DHCP-Discover'<br>
Thu Feb 27 09:53:15 2014 : Debug: /usr/local/var/log/radius/linelog-dhcp.log<br>Thu Feb 27 09:53:15 2014 : Debug: Parsed xlat tree:<br>Thu Feb 27 09:53:15 2014 : Debug: literal: '/usr/local/var/log/radius/linelog-dhcp.log'<br>
Thu Feb 27 09:53:15 2014 : Debug: (1) linelog-dhcp : ššš expand: "/usr/local/var/log/radius/linelog-dhcp.log" -> '/usr/local/var/log/radius/linelog-dhcp.log'<br>Thu Feb 27 09:53:15 2014 : Debug: %S --> Transaction-ID: %{DHCP-Transaction-Id} DISCOVER: [%{DHCP-Client-Hardware-Address}] via (%{DHCP-Gateway-IP-Address}), hop count = %{DHCP-Hop-Count}, Relay = %{DHCP-Relay-Remote-Id} / %{DHCP-Relay-Circuit-Id}, Hostname =š %{DHCP-Hostname}<br>
Thu Feb 27 09:53:15 2014 : Debug: Parsed xlat tree:<br>Thu Feb 27 09:53:15 2014 : Debug: literal (with %): 'S'<br>Thu Feb 27 09:53:15 2014 : Debug: literal: ' --> Transaction-ID: '<br>Thu Feb 27 09:53:15 2014 : Debug: attribute: DHCP-Transaction-Id<br>
Thu Feb 27 09:53:15 2014 : Debug: {<br>Thu Feb 27 09:53:15 2014 : Debug: ššš refš 2<br>Thu Feb 27 09:53:15 2014 : Debug: ššš list 1<br>Thu Feb 27 09:53:15 2014 : Debug: ššš tag -128<br>Thu Feb 27 09:53:15 2014 : Debug: }<br>
Thu Feb 27 09:53:15 2014 : Debug: literal: ' DISCOVER: ['<br>Thu Feb 27 09:53:15 2014 : Debug: attribute: DHCP-Client-Hardware-Address<br>Thu Feb 27 09:53:15 2014 : Debug: {<br>Thu Feb 27 09:53:15 2014 : Debug: ššš refš 2<br>
Thu Feb 27 09:53:15 2014 : Debug: ššš list 1<br>Thu Feb 27 09:53:15 2014 : Debug: ššš tag -128<br>Thu Feb 27 09:53:15 2014 : Debug: }<br>Thu Feb 27 09:53:15 2014 : Debug: literal: '] via ('<br>Thu Feb 27 09:53:15 2014 : Debug: attribute: DHCP-Gateway-IP-Address<br>
Thu Feb 27 09:53:15 2014 : Debug: {<br>Thu Feb 27 09:53:15 2014 : Debug: ššš refš 2<br>Thu Feb 27 09:53:15 2014 : Debug: ššš list 1<br>Thu Feb 27 09:53:15 2014 : Debug: ššš tag -128<br>Thu Feb 27 09:53:15 2014 : Debug: }<br>
Thu Feb 27 09:53:15 2014 : Debug: literal: '), hop count = '<br>Thu Feb 27 09:53:15 2014 : Debug: attribute: DHCP-Hop-Count<br>Thu Feb 27 09:53:15 2014 : Debug: {<br>Thu Feb 27 09:53:15 2014 : Debug: ššš refš 2<br>
Thu Feb 27 09:53:15 2014 : Debug: ššš list 1<br>Thu Feb 27 09:53:15 2014 : Debug: ššš tag -128<br>Thu Feb 27 09:53:15 2014 : Debug: }<br>Thu Feb 27 09:53:15 2014 : Debug: literal: ', Relay = '<br>Thu Feb 27 09:53:15 2014 : Debug: attribute: DHCP-Relay-Remote-Id<br>
Thu Feb 27 09:53:15 2014 : Debug: {<br>Thu Feb 27 09:53:15 2014 : Debug: ššš refš 2<br>Thu Feb 27 09:53:15 2014 : Debug: ššš list 1<br>Thu Feb 27 09:53:15 2014 : Debug: ššš tag -128<br>Thu Feb 27 09:53:15 2014 : Debug: }<br>
Thu Feb 27 09:53:15 2014 : Debug: literal: ' / '<br>Thu Feb 27 09:53:15 2014 : Debug: attribute: DHCP-Relay-Circuit-Id<br>Thu Feb 27 09:53:15 2014 : Debug: {<br>Thu Feb 27 09:53:15 2014 : Debug: ššš refš 2<br>Thu Feb 27 09:53:15 2014 : Debug: ššš list 1<br>
Thu Feb 27 09:53:15 2014 : Debug: ššš tag -128<br>Thu Feb 27 09:53:15 2014 : Debug: }<br>Thu Feb 27 09:53:15 2014 : Debug: literal: ', Hostname =š '<br>Thu Feb 27 09:53:15 2014 : Debug: attribute: DHCP-Hostname<br>
Thu Feb 27 09:53:15 2014 : Debug: {<br>Thu Feb 27 09:53:15 2014 : Debug: ššš refš 2<br>Thu Feb 27 09:53:15 2014 : Debug: ššš list 1<br>Thu Feb 27 09:53:15 2014 : Debug: ššš tag -128<br>Thu Feb 27 09:53:15 2014 : Debug: }<br>
Thu Feb 27 09:53:15 2014 : Debug: (1) linelog-dhcp : ššš expand: "%S --> Transaction-ID: %{DHCP-Transaction-Id} DISCOVER: [%{DHCP-Client-Hardware-Address}] via (%{DHCP-Gateway-IP-Address}), hop count = %{DHCP-Hop-Count}, Relay = %{DHCP-Relay-Remote-Id} / %{DHCP-Relay-Circuit-Id}, Hostname =š %{DHCP-Hostname}" -> '2014-02-27 09:53:15 --> Transaction-ID: 4203133456 DISCOVER: [50:af:73:18:ed:98] via (10.180.1.1), hop count = 1, Relay = 0x00030f1ae32c / 0x202f200000000000, Hostname =š support'<br>
Thu Feb 27 09:53:15 2014 : Debug: (1)šš modsingle[post-auth]: returned from linelog-dhcp (rlm_linelog) for request 1<br>Thu Feb 27 09:53:15 2014 : Debug: (1)šš [linelog-dhcp] = ok<br>Thu Feb 27 09:53:15 2014 : Debug: (1)šš update reply {<br>
Thu Feb 27 09:53:15 2014 : Debug: (1) ššš DHCP-Flags = 0<br>Thu Feb 27 09:53:15 2014 : Debug: (1)šš } # update reply = noop<br><br></div>Note that the value 0x202f200000000000 for circuit id is not correct.<br><div><br></div>
</div><div class="gmail_extra"><br><br><div class="gmail_quote">On 26 February 2014 17:17, โลฮ ๔ฯอะำฯฮ <span dir="ltr"><<a href="mailto:b.thompson@latera.ru" target="_blank">b.thompson@latera.ru</a>></span> wrote:<br>
<blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex"><div dir="ltr"><div>Folks, I also noticed that the attribute DHCP-Relay-Remote-Id is not printed underneath the hex dumpbelow:<div>
<div class="h5"><br><br>Received DHCP-Request of id 721fc604 from <a href="http://10.180.1.1:67" target="_blank">10.180.1.1:67</a> to <a href="http://10.160.0.254:67" target="_blank">10.160.0.254:67</a><br>

0: 01 01 06 01 72 1f c6 04 00 a5 00 00 0a b4 01 05<br>16: 00 00 00 00 00 00 00 00 0a b4 01 01 50 af 73 18<br>32: ed 98 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>48: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>64: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>


80: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>96: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>112: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>128: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>


144: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>160: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>176: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>192: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>


208: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>224: 00 00 00 00 00 00 00 00 00 00 00 00 63 82 53 63<br>240: 35 01 03 0c 07 73 75 70 70 6f 72 74 37 0d 01 1c<br>256: 02 03 0f 06 77 0c 2c 2f 1a 79 2a 52 12 01 08 00<br>


272: 06 04 b1 01 00 00 01 02 06 00 03 0f 1a e3 2c ff<br>288: 00 00 00 00 00 00 00 00 00 00 00 00<br>ššš DHCP-Opcode = Client-Message<br>ššš DHCP-Hardware-Type = Ethernet<br>ššš DHCP-Hardware-Address-Length = 6<br>ššš DHCP-Hop-Count = 1<br>


ššš DHCP-Transaction-Id = 1914684932<br>ššš DHCP-Number-of-Seconds = 165<br>ššš DHCP-Flags = 0<br>ššš DHCP-Client-IP-Address = 10.180.1.5<br>ššš DHCP-Your-IP-Address = 0.0.0.0<br>ššš DHCP-Server-IP-Address = 0.0.0.0<br>ššš DHCP-Gateway-IP-Address = 10.180.1.1<br>


ššš DHCP-Client-Hardware-Address = 50:af:73:18:ed:98<br>ššš DHCP-Message-Type += DHCP-Request<br>ššš DHCP-Hostname += 'support'<br>ššš DHCP-Parameter-Request-List += DHCP-Subnet-Mask<br>ššš DHCP-Parameter-Request-List += DHCP-Broadcast-Address<br>


ššš DHCP-Parameter-Request-List += DHCP-Time-Offset<br>ššš DHCP-Parameter-Request-List += DHCP-Router-Address<br>ššš DHCP-Parameter-Request-List += DHCP-Domain-Name<br>ššš DHCP-Parameter-Request-List += DHCP-Domain-Name-Server<br>


ššš DHCP-Parameter-Request-List += DHCP-Domain-Search<br>ššš DHCP-Parameter-Request-List += DHCP-Hostname<br>ššš DHCP-Parameter-Request-List += DHCP-NETBIOS-Name-Servers<br>ššš DHCP-Parameter-Request-List += DHCP-NETBIOS<br>


ššš DHCP-Parameter-Request-List += DHCP-Interface-MTU-Size<br>ššš DHCP-Parameter-Request-List += DHCP-Classless-Static-Route<br>ššš DHCP-Parameter-Request-List += DHCP-NTP-Servers<br>ššš DHCP-Relay-Circuit-Id = 0x000604b101000001<br>


Mon Feb 24 16:51:36 2014 : Debug: Trying sub-section dhcp DHCP-Request {...}<br><br></div></div></div>It can be seen the the hex dump contains both Cicuit-Id (06 04 b1 01 00 00 01) and Remote-Id (00 03 0f 1a e3 2c):<div class="">
<br><div><br>
272: 06 04 b1 01 00 00 01 02 06 00 03 0f 1a e3 2c ff<br><br></div></div><div>But these are not printed underneath. If I can help to debug this please let me know what to do.<br><br></div><div>Thanks<br><br></div><div>Ben<br>
</div><div><div class="h5">
<div><br><br></div><div class="gmail_extra"><br><br><div class="gmail_quote">On 25 February 2014 07:00, โลฮ ๔ฯอะำฯฮ <span dir="ltr"><<a href="mailto:b.thompson@latera.ru" target="_blank">b.thompson@latera.ru</a>></span> wrote:<br>

<blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex"><div dir="ltr">Sorry, my previous email was not formatted correctly.<br><br>Everyone, I have a problem and would would be grateful if you could have a quick look at it for me. I am trying to use the Option 82 data from a DHCP request, but for some reason the Circuit ID is changing during the processing of the request.<div>

<div><br>
<br>Here is the reqest coming in and then getting processed by the linelog module:<br><br>Received DHCP-Request of id 721fc604 from <a href="http://10.180.1.1:67" target="_blank">10.180.1.1:67</a> to <a href="http://10.160.0.254:67" target="_blank">10.160.0.254:67</a><br>


0: 01 01 06 01 72 1f c6 04 00 a5 00 00 0a b4 01 05<br>16: 00 00 00 00 00 00 00 00 0a b4 01 01 50 af 73 18<br>32: ed 98 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>48: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>64: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>


80: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>96: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>112: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>128: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>


144: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>160: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>176: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>192: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>


208: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00<br>224: 00 00 00 00 00 00 00 00 00 00 00 00 63 82 53 63<br>240: 35 01 03 0c 07 73 75 70 70 6f 72 74 37 0d 01 1c<br>256: 02 03 0f 06 77 0c 2c 2f 1a 79 2a 52 12 01 08 00<br>


272: 06 04 b1 01 00 00 01 02 06 00 03 0f 1a e3 2c ff<br>288: 00 00 00 00 00 00 00 00 00 00 00 00<br>ššš DHCP-Opcode = Client-Message<br>ššš DHCP-Hardware-Type = Ethernet<br>ššš DHCP-Hardware-Address-Length = 6<br>ššš DHCP-Hop-Count = 1<br>


ššš DHCP-Transaction-Id = 1914684932<br>ššš DHCP-Number-of-Seconds = 165<br>ššš DHCP-Flags = 0<br>ššš DHCP-Client-IP-Address = 10.180.1.5<br>ššš DHCP-Your-IP-Address = 0.0.0.0<br>ššš DHCP-Server-IP-Address = 0.0.0.0<br>ššš DHCP-Gateway-IP-Address = 10.180.1.1<br>


ššš DHCP-Client-Hardware-Address = 50:af:73:18:ed:98<br>ššš DHCP-Message-Type += DHCP-Request<br>ššš DHCP-Hostname += 'support'<br>ššš DHCP-Parameter-Request-List += DHCP-Subnet-Mask<br>ššš DHCP-Parameter-Request-List += DHCP-Broadcast-Address<br>


ššš DHCP-Parameter-Request-List += DHCP-Time-Offset<br>ššš DHCP-Parameter-Request-List += DHCP-Router-Address<br>ššš DHCP-Parameter-Request-List += DHCP-Domain-Name<br>ššš DHCP-Parameter-Request-List += DHCP-Domain-Name-Server<br>


ššš DHCP-Parameter-Request-List += DHCP-Domain-Search<br>ššš DHCP-Parameter-Request-List += DHCP-Hostname<br>ššš DHCP-Parameter-Request-List += DHCP-NETBIOS-Name-Servers<br>ššš DHCP-Parameter-Request-List += DHCP-NETBIOS<br>


ššš DHCP-Parameter-Request-List += DHCP-Interface-MTU-Size<br>ššš DHCP-Parameter-Request-List += DHCP-Classless-Static-Route<br>ššš DHCP-Parameter-Request-List += DHCP-NTP-Servers<br>ššš DHCP-Relay-Circuit-Id = 0x000604b101000001<br>


Mon Feb 24 16:51:36 2014 : Debug: Trying sub-section dhcp DHCP-Request {...}<br>Mon Feb 24 16:51:36 2014 : Debug: (0)š dhcp DHCP-Request {<br>Mon Feb 24 16:51:36 2014 : Debug: (0)šš modsingle[post-auth]: calling linelog-dhcp (rlm_linelog) for request 0<br>


Mon Feb 24 16:51:36 2014 : Debug: %{%{reply:DHCP-Message-Type}:-<br>%{request:DHCP-Message-Type}}<br>Mon Feb 24 16:51:36 2014 : Debug: Parsed xlat tree:<br>Mon Feb 24 16:51:36 2014 : Debug: if {<br>Mon Feb 24 16:51:36 2014 : Debug:šššš attribute: DHCP-Message-Type<br>


Mon Feb 24 16:51:36 2014 : Debug:šššš {<br>Mon Feb 24 16:51:36 2014 : Debug:šššššššš refš 2<br>Mon Feb 24 16:51:36 2014 : Debug:šššššššš list 2<br>Mon Feb 24 16:51:36 2014 : Debug:šššššššš tag -128<br>Mon Feb 24 16:51:36 2014 : Debug:šššš }<br>


Mon Feb 24 16:51:36 2014 : Debug: }<br>Mon Feb 24 16:51:36 2014 : Debug: else {<br>Mon Feb 24 16:51:36 2014 : Debug:šššš attribute: DHCP-Message-Type<br>Mon Feb 24 16:51:36 2014 : Debug:šššš {<br>Mon Feb 24 16:51:36 2014 : Debug:šššššššš refš 2<br>


Mon Feb 24 16:51:36 2014 : Debug:šššššššš list 1<br>Mon Feb 24 16:51:36 2014 : Debug:šššššššš tag -128<br>Mon Feb 24 16:51:36 2014 : Debug:šššš }<br>Mon Feb 24 16:51:36 2014 : Debug: }<br>Mon Feb 24 16:51:36 2014 : Debug: (0) linelog-dhcp :šššš expand: "%{%{reply:DHCP-Message-Type}:-%{request:DHCP-Message-Type}}" -> 'DHCP-Request'<br>


Mon Feb 24 16:51:36 2014 : Debug: /usr/local/var/log/radius/linelog-dhcp.log<br>Mon Feb 24 16:51:36 2014 : Debug: Parsed xlat tree:<br>Mon Feb 24 16:51:36 2014 : Debug: literal: '/usr/local/var/log/radius/linelog-dhcp.log'<br>


Mon Feb 24 16:51:36 2014 : Debug: (0) linelog-dhcp :šššš expand: "/usr/local/var/log/radius/linelog-dhcp.log" -> '/usr/local/var/log/radius/linelog-dhcp.log'<br>Mon Feb 24 16:51:36 2014 : Debug: %S --> Transaction-ID: %{DHCP-Transaction-Id} REQUEST: [%{DHCP-Client-Hardware-Address}] via (%{DHCP-Gateway-IP-Address}), hop count = %{DHCP-Hop-Count}, Relay = %{DHCP-Relay-Remote-Id} / %{DHCP-Relay-Circuit-Id} ...<br>


Mon Feb 24 16:51:36 2014 : Debug: Parsed xlat tree:<br>Mon Feb 24 16:51:36 2014 : Debug: literal (with %): 'S'<br>Mon Feb 24 16:51:36 2014 : Debug: literal: ' --> Transaction-ID: '<br>Mon Feb 24 16:51:36 2014 : Debug: attribute: DHCP-Transaction-Id<br>


Mon Feb 24 16:51:36 2014 : Debug: {<br>Mon Feb 24 16:51:36 2014 : Debug:šššš refš 2<br>Mon Feb 24 16:51:36 2014 : Debug:šššš list 1<br>Mon Feb 24 16:51:36 2014 : Debug:šššš tag -128<br>Mon Feb 24 16:51:36 2014 : Debug: }<br>


Mon Feb 24 16:51:36 2014 : Debug: literal: ' REQUEST: ['<br>Mon Feb 24 16:51:36 2014 : Debug: attribute: DHCP-Client-Hardware-Address<br>Mon Feb 24 16:51:36 2014 : Debug: {<br>Mon Feb 24 16:51:36 2014 : Debug:šššš refš 2<br>


Mon Feb 24 16:51:36 2014 : Debug:šššš list 1<br>Mon Feb 24 16:51:36 2014 : Debug:šššš tag -128<br>Mon Feb 24 16:51:36 2014 : Debug: }<br>Mon Feb 24 16:51:36 2014 : Debug: literal: '] via ('<br>Mon Feb 24 16:51:36 2014 : Debug: attribute: DHCP-Gateway-IP-Address<br>


Mon Feb 24 16:51:36 2014 : Debug: {<br>Mon Feb 24 16:51:36 2014 : Debug:šššš refš 2<br>Mon Feb 24 16:51:36 2014 : Debug:šššš list 1<br>Mon Feb 24 16:51:36 2014 : Debug:šššš tag -128<br>Mon Feb 24 16:51:36 2014 : Debug: }<br>


Mon Feb 24 16:51:36 2014 : Debug: literal: '), hop count = '<br>Mon Feb 24 16:51:36 2014 : Debug: attribute: DHCP-Hop-Count<br>Mon Feb 24 16:51:36 2014 : Debug: {<br>Mon Feb 24 16:51:36 2014 : Debug:šššš refš 2<br>


Mon Feb 24 16:51:36 2014 : Debug:šššš list 1<br>Mon Feb 24 16:51:36 2014 : Debug:šššš tag -128<br>Mon Feb 24 16:51:36 2014 : Debug: }<br>Mon Feb 24 16:51:36 2014 : Debug: literal: ', Relay = '<br>Mon Feb 24 16:51:36 2014 : Debug: attribute: DHCP-Relay-Remote-Id<br>


Mon Feb 24 16:51:36 2014 : Debug: {<br>Mon Feb 24 16:51:36 2014 : Debug:šššš refš 2<br>Mon Feb 24 16:51:36 2014 : Debug:šššš list 1<br>Mon Feb 24 16:51:36 2014 : Debug:šššš tag -128<br>Mon Feb 24 16:51:36 2014 : Debug: }<br>


Mon Feb 24 16:51:36 2014 : Debug: literal: ' / '<br>Mon Feb 24 16:51:36 2014 : Debug: attribute: DHCP-Relay-Circuit-Id<br>Mon Feb 24 16:51:36 2014 : Debug: {<br>Mon Feb 24 16:51:36 2014 : Debug:šššš refš 2<br>Mon Feb 24 16:51:36 2014 : Debug:šššš list 1<br>


Mon Feb 24 16:51:36 2014 : Debug:šššš tag -128<br>Mon Feb 24 16:51:36 2014 : Debug: }<br>Mon Feb 24 16:51:36 2014 : Debug: literal: ' ...'<br>Mon Feb 24 16:51:36 2014 : Debug: (0) linelog-dhcp :šššš expand: "%S --> Transaction-ID: %{DHCP-Transaction-Id} REQUEST: [%{DHCP-Client-Hardware-Address}] via (%{DHCP-Gateway-IP-Address}), hop count = %{DHCP-Hop-Count}, Relay = %{DHCP-Relay-Remote-Id} / %{DHCP-Relay-Circuit-Id} ..." -> '2014-02-24 16:51:36 --> Transaction-ID: 1914684932 REQUEST: [50:af:73:18:ed:98] via (10.180.1.1), hop count = 1, Relay = 0x00030f1ae32c / 0x5d20766961202800 ...'<br>


Mon Feb 24 16:51:36 2014 : Debug: (0)šš modsingle[post-auth]: returned from linelog-dhcp (rlm_linelog) for request 0<br>Mon Feb 24 16:51:36 2014 : Debug: (0)šš [linelog-dhcp] = ok<br><br>As you can see, the attribute DHCP-Relay-Circuit-Id starts of with value "0x000604b101000001" but by the time it is processed by linelog it has value "0x5d20766961202800"<br>


<br>Here is the full debug output: <a href="http://pastebin.com/b9RXPRD0" target="_blank">http://pastebin.com/b9RXPRD0</a><br><br></div></div></div><div><div><div class="gmail_extra"><br><br><div class="gmail_quote">
On 24 February 2014 21:28, โลฮ ๔ฯอะำฯฮ <span dir="ltr"><<a href="mailto:b.thompson@latera.ru" target="_blank">b.thompson@latera.ru</a>></span> wrote:<br>
<blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex"><div dir="ltr"><div><div>olks, I have hit a problem and would would be grateful if
 you could have a quick look at it for me. I am trying to use the Option
 82 data from a DHCP request, but for some reason the Circuit ID is 
changing during the procession for the request.<br>
<br>Here is the reqest coming in and then getting processed by the linelog module:<br><br>Received DHCP-Request of id 721fc604 from <a href="http://10.180.1.1:67" target="_blank">10.180.1.1:67</a> to <a href="http://10.160.0.254:67" target="_blank">10.160.0.254:67</a><br>




0: 01 01 06 01 72 1f c6 04 00 a5 00 00 0a b4 01 05 <br>16: 00 00 00 00 00 00 00 00 0a b4 01 01 50 af 73 18 <br>32: ed 98 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>48: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>




64: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>80: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>96: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>112: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>




128: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>144: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>160: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>176: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>




192: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>208: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 <br>224: 00 00 00 00 00 00 00 00 00 00 00 00 63 82 53 63 <br>240: 35 01 03 0c 07 73 75 70 70 6f 72 74 37 0d 01 1c <br>




256: 02 03 0f 06 77 0c 2c 2f 1a 79 2a 52 12 01 08 00 <br>272: 06 04 b1 01 00 00 01 02 06 00 03 0f 1a e3 2c ff <br>288: 00 00 00 00 00 00 00 00 00 00 00 00 <br>ššš DHCP-Opcode = Client-Message<br>ššš DHCP-Hardware-Type = Ethernet<br>




ššš DHCP-Hardware-Address-Length = 6<br>ššš DHCP-Hop-Count = 1<br>ššš DHCP-Transaction-Id = 1914684932<br>ššš DHCP-Number-of-Seconds = 165<br>ššš DHCP-Flags = 0<br>ššš DHCP-Client-IP-Address = 10.180.1.5<br>ššš DHCP-Your-IP-Address = 0.0.0.0<br>




ššš DHCP-Server-IP-Address = 0.0.0.0<br>ššš DHCP-Gateway-IP-Address = 10.180.1.1<br>ššš DHCP-Client-Hardware-Address = 50:af:73:18:ed:98<br>ššš DHCP-Message-Type += DHCP-Request<br>ššš DHCP-Hostname += 'support'<br>




ššš DHCP-Parameter-Request-List += DHCP-Subnet-Mask<br>ššš DHCP-Parameter-Request-List += DHCP-Broadcast-Address<br>ššš DHCP-Parameter-Request-List += DHCP-Time-Offset<br>ššš DHCP-Parameter-Request-List += DHCP-Router-Address<br>




ššš DHCP-Parameter-Request-List += DHCP-Domain-Name<br>ššš DHCP-Parameter-Request-List += DHCP-Domain-Name-Server<br>ššš DHCP-Parameter-Request-List += DHCP-Domain-Search<br>ššš DHCP-Parameter-Request-List += DHCP-Hostname<br>




ššš DHCP-Parameter-Request-List += DHCP-NETBIOS-Name-Servers<br>ššš DHCP-Parameter-Request-List += DHCP-NETBIOS<br>ššš DHCP-Parameter-Request-List += DHCP-Interface-MTU-Size<br>ššš DHCP-Parameter-Request-List += DHCP-Classless-Static-Route<br>




ššš DHCP-Parameter-Request-List += DHCP-NTP-Servers<br>ššš DHCP-Relay-Circuit-Id = 0x000604b101000001<br>Mon Feb 24 16:51:36 2014 : Debug: Trying sub-section dhcp DHCP-Request {...}<br>Mon Feb 24 16:51:36 2014 : Debug: (0)š dhcp DHCP-Request {<br>




Mon Feb 24 16:51:36 2014 : Debug: (0)šš modsingle[post-auth]: calling linelog-dhcp (rlm_linelog) for request 0<br>Mon Feb 24 16:51:36 2014 : Debug: %{%{reply:DHCP-Message-Type}:-<div>%{request:DHCP-Message-Type}}<br>Mon Feb 24 16:51:36 2014 : Debug: Parsed xlat tree:<br>




Mon Feb 24 16:51:36 2014 : Debug: if {<br>Mon Feb 24 16:51:36 2014 : Debug: ššš attribute: DHCP-Message-Type<br>Mon Feb 24 16:51:36 2014 : Debug: ššš {<br>Mon Feb 24 16:51:36 2014 : Debug: ššš ššš refš 2<br>Mon Feb 24 16:51:36 2014 : Debug: ššš ššš list 2<br>




Mon Feb 24 16:51:36 2014 : Debug: ššš ššš tag -128<br>Mon Feb 24 16:51:36 2014 : Debug: ššš }<br>Mon Feb 24 16:51:36 2014 : Debug: }<br>Mon Feb 24 16:51:36 2014 : Debug: else {<br>Mon Feb 24 16:51:36 2014 : Debug: ššš attribute: DHCP-Message-Type<br>




Mon Feb 24 16:51:36 2014 : Debug: ššš {<br>Mon Feb 24 16:51:36 2014 : Debug: ššš ššš refš 2<br>Mon Feb 24 16:51:36 2014 : Debug: ššš ššš list 1<br>Mon Feb 24 16:51:36 2014 : Debug: ššš ššš tag -128<br>Mon Feb 24 16:51:36 2014 : Debug: ššš }<br>




Mon Feb 24 16:51:36 2014 : Debug: }<br>Mon Feb 24 16:51:36 2014 : Debug: (0) linelog-dhcp : ššš expand: "%{%{reply:DHCP-Message-Type}:-%{request:DHCP-Message-Type}}" -> 'DHCP-Request'<br>Mon Feb 24 16:51:36 2014 : Debug: /usr/local/var/log/radius/linelog-dhcp.log<br>




Mon Feb 24 16:51:36 2014 : Debug: Parsed xlat tree:<br>Mon Feb 24 16:51:36 2014 : Debug: literal: '/usr/local/var/log/radius/linelog-dhcp.log'<br>Mon Feb 24 16:51:36 2014 : Debug: (0) linelog-dhcp : ššš expand: "/usr/local/var/log/radius/linelog-dhcp.log" -> '/usr/local/var/log/radius/linelog-dhcp.log'<br>




Mon Feb 24 16:51:36 2014 : Debug: %S --> Transaction-ID: %{DHCP-Transaction-Id} REQUEST: [%{DHCP-Client-Hardware-Address}]
 via (%{DHCP-Gateway-IP-Address}), hop count = %{DHCP-Hop-Count}, Relay =
 %{DHCP-Relay-Remote-Id} / %{DHCP-Relay-Circuit-Id} ...<br>
Mon Feb 24 16:51:36 2014 : Debug: Parsed xlat tree:<br>Mon Feb 24 16:51:36 2014 : Debug: literal (with %): 'S'<br>Mon Feb 24 16:51:36 2014 : Debug: literal: ' --> Transaction-ID: '<br>Mon Feb 24 16:51:36 2014 : Debug: attribute: DHCP-Transaction-Id<br>




Mon Feb 24 16:51:36 2014 : Debug: {<br>Mon Feb 24 16:51:36 2014 : Debug: ššš refš 2<br>Mon Feb 24 16:51:36 2014 : Debug: ššš list 1<br>Mon Feb 24 16:51:36 2014 : Debug: ššš tag -128<br>Mon Feb 24 16:51:36 2014 : Debug: }<br>




Mon Feb 24 16:51:36 2014 : Debug: literal: ' REQUEST: ['<br>Mon Feb 24 16:51:36 2014 : Debug: attribute: DHCP-Client-Hardware-Address<br>Mon Feb 24 16:51:36 2014 : Debug: {<br>Mon Feb 24 16:51:36 2014 : Debug: ššš refš 2<br>




Mon Feb 24 16:51:36 2014 : Debug: ššš list 1<br>Mon Feb 24 16:51:36 2014 : Debug: ššš tag -128<br>Mon Feb 24 16:51:36 2014 : Debug: }<br>Mon Feb 24 16:51:36 2014 : Debug: literal: '] via ('<br>Mon Feb 24 16:51:36 2014 : Debug: attribute: DHCP-Gateway-IP-Address<br>




Mon Feb 24 16:51:36 2014 : Debug: {<br>Mon Feb 24 16:51:36 2014 : Debug: ššš refš 2<br>Mon Feb 24 16:51:36 2014 : Debug: ššš list 1<br>Mon Feb 24 16:51:36 2014 : Debug: ššš tag -128<br>Mon Feb 24 16:51:36 2014 : Debug: }<br>




Mon Feb 24 16:51:36 2014 : Debug: literal: '), hop count = '<br>Mon Feb 24 16:51:36 2014 : Debug: attribute: DHCP-Hop-Count<br>Mon Feb 24 16:51:36 2014 : Debug: {<br>Mon Feb 24 16:51:36 2014 : Debug: ššš refš 2<br>




Mon Feb 24 16:51:36 2014 : Debug: ššš list 1<br>Mon Feb 24 16:51:36 2014 : Debug: ššš tag -128<br>Mon Feb 24 16:51:36 2014 : Debug: }<br>Mon Feb 24 16:51:36 2014 : Debug: literal: ', Relay = '<br>Mon Feb 24 16:51:36 2014 : Debug: attribute: DHCP-Relay-Remote-Id<br>




Mon Feb 24 16:51:36 2014 : Debug: {<br>Mon Feb 24 16:51:36 2014 : Debug: ššš refš 2<br>Mon Feb 24 16:51:36 2014 : Debug: ššš list 1<br>Mon Feb 24 16:51:36 2014 : Debug: ššš tag -128<br>Mon Feb 24 16:51:36 2014 : Debug: }<br>




Mon Feb 24 16:51:36 2014 : Debug: literal: ' / '<br>Mon Feb 24 16:51:36 2014 : Debug: attribute: DHCP-Relay-Circuit-Id<br>Mon Feb 24 16:51:36 2014 : Debug: {<br>Mon Feb 24 16:51:36 2014 : Debug: ššš refš 2<br>Mon Feb 24 16:51:36 2014 : Debug: ššš list 1<br>




Mon Feb 24 16:51:36 2014 : Debug: ššš tag -128<br>Mon Feb 24 16:51:36 2014 : Debug: }<br>Mon Feb 24 16:51:36 2014 : Debug: literal: ' ...'<br>Mon
 Feb 24 16:51:36 2014 : Debug: (0) linelog-dhcp : ššš expand: "%S -->
 Transaction-ID: %{DHCP-Transaction-Id} REQUEST: 
[%{DHCP-Client-Hardware-Address}] via (%{DHCP-Gateway-IP-Address}),
 hop count = %{DHCP-Hop-Count}, Relay = %{DHCP-Relay-Remote-Id} / 
%{DHCP-Relay-Circuit-Id} ..." -> '2014-02-24 16:51:36 --> 
Transaction-ID: 1914684932 REQUEST: [50:af:73:18:ed:98] via 
(10.180.1.1), hop count = 1, Relay = 0x00030f1ae32c / 0x5d20766961202800
 ...'<br>
Mon Feb 24 16:51:36 2014 : Debug: (0)šš modsingle[post-auth]: returned from linelog-dhcp (rlm_linelog) for request 0<br>Mon Feb 24 16:51:36 2014 : Debug: (0)šš [linelog-dhcp] = ok<br><br></div>As
 you can see, the attribute DHCP-Relay-Circuit-Id starts of with value 
"0x000604b101000001" but by the time it is processed by linelog it has 
value "0x5d20766961202800"<br>
<br></div></div>Here is the full debug output: <a href="http://pastebin.com/b9RXPRD0" target="_blank">http://pastebin.com/b9RXPRD0</a><br></div><div><div><div class="gmail_extra"><br><br><div class="gmail_quote">
On 21 February 2014 19:02, โลฮ ๔ฯอะำฯฮ <span dir="ltr"><<a href="mailto:b.thompson@latera.ru" target="_blank">b.thompson@latera.ru</a>></span> wrote:<br>
<blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex"><div dir="ltr">Thanks for the info. It is looking better with 3.0.1. I will share my oracle configs once I have proved that they work.<br>



</div><div class="gmail_extra"><div><div><br><br><div class="gmail_quote">On 21 February 2014 16:41, Alan DeKok <span dir="ltr"><<a href="mailto:aland@deployingradius.com" target="_blank">aland@deployingradius.com</a>></span> wrote:<br>




<blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex"><div>โลฮ ๔ฯอะำฯฮ wrote:<br>
> radiusd: FreeRADIUS Version 3.1.0 (git #10ffd5b), for host<br>
<br>
</div>š Don't use the "master" branch. šUse an official release.<br>
<span><font color="#888888"><br>
š Alan DeKok.<br>
-<br>
List info/subscribe/unsubscribe? See <a href="http://www.freeradius.org/list/users.html" target="_blank">http://www.freeradius.org/list/users.html</a></font></span></blockquote></div><br><br clear="all"><br></div></div><span><font color="#888888">-- <br>



<div dir="ltr">
<div title="Hint: double-click to select code"><div><code>โลฮ ๔ฯอะำฯฮ,</code></div><div><code>ษฮึลฮลา ฯิฤลฬม ืฮลฤาลฮษั ษ ิลศะฯฤฤลาึหษ,</code></div><div><code>หฯอะมฮษั </code><code>"์มิลาม"</code> <code>| <a href="http://www.latera.ru" target="_blank">www.latera.ru</a></code></div>




<div>š</div><div><code>ิลฬ.: +7 (499) 940-95-05, ฤฯย. 221</code></div><div><code>E-mail: <a href="mailto:b.thompson@latera.ru" target="_blank">b.thompson@latera.ru</a></code></div></div></div>
</font></span></div>
</blockquote></div><br><br clear="all"><br>-- <br><div dir="ltr"><div title="Hint: double-click to select code"><div><code>โลฮ ๔ฯอะำฯฮ,</code></div><div><code>ษฮึลฮลา ฯิฤลฬม ืฮลฤาลฮษั ษ ิลศะฯฤฤลาึหษ,</code></div><div><code>หฯอะมฮษั </code><code>"์มิลาม"</code> <code>| <a href="http://www.latera.ru" target="_blank">www.latera.ru</a></code></div>



<div>š</div><div><code>ิลฬ.: +7 (499) 940-95-05, ฤฯย. 221</code></div><div><code>E-mail: <a href="mailto:b.thompson@latera.ru" target="_blank">b.thompson@latera.ru</a></code></div></div></div>
</div>
</div></div></blockquote></div><br><br clear="all"><br>-- <br><div dir="ltr"><div title="Hint: double-click to select code"><div><code>โลฮ ๔ฯอะำฯฮ,</code></div><div><code>ษฮึลฮลา ฯิฤลฬม ืฮลฤาลฮษั ษ ิลศะฯฤฤลาึหษ,</code></div>


<div><code>หฯอะมฮษั </code><code>"์มิลาม"</code> <code>| <a href="http://www.latera.ru" target="_blank">www.latera.ru</a></code></div><div>š</div><div><code>ิลฬ.: +7 (499) 940-95-05, ฤฯย. 221</code></div><div><code>E-mail: <a href="mailto:b.thompson@latera.ru" target="_blank">b.thompson@latera.ru</a></code></div>


</div></div>
</div>
</div></div></blockquote></div><br><br clear="all"><br></div></div></div></div>
</blockquote></div><br><br clear="all"><br>-- <br><div dir="ltr"><div title="Hint: double-click to select code"><div><code>โลฮ ๔ฯอะำฯฮ,</code></div><div><code>ษฮึลฮลา ฯิฤลฬม ืฮลฤาลฮษั ษ ิลศะฯฤฤลาึหษ,</code></div><div><code>หฯอะมฮษั </code><code>"์มิลาม"</code> <code>| <a href="http://www.latera.ru" target="_blank">www.latera.ru</a></code></div>
<div>š</div><div><code>ิลฬ.: +7 (499) 940-95-05, ฤฯย. 221</code></div><div><code>E-mail: <a href="mailto:b.thompson@latera.ru" target="_blank">b.thompson@latera.ru</a></code></div></div></div>
</div>