BiTel

radius 02-26/16:28:22 INFO [rdsLstnr-p-8-t-1] RadiusListenerWorker - REQUEST:
Packet type: Access-Request
Identifier: 73
Authenticator: {4E 89 1B BD F0 1D 19 C2 9D 07 7B 41 5E 33 4D 0C}
Attributes:
User-Name=14:da:e9:46:fc:a8
NAS-Port-Id=2/2 vlan-id 2000:11 clips 160070
NAS-Identifier=SE100-Lenina93-CLIPS
User-Password=Redback
NAS-IP-Address=10.0.0.11
NAS-Port=578617355
Service-Type=5
NAS-Port-Type=5
Platform-Type=4
Medium-Type=11
Agent-Remote-Id={00 06 00 1F CE 10 48 FD}
UNKNOWN[2352-202]={3D 3D 07 01 14 DA E9 46 FC A8}
UNKNOWN[2352-202]={0C 0C 08 41 6E 74 6F 6E 2D 4E 42}
Agent-Circuit-Id={00 04 00 0B 00 01}
OS-Version=12.1.1.5
Mac-Addr=14:da:e9:46:fc:a8
UNKNOWN[2352-125]={4D 53 46 54 20 35 2E 30}
NAS-Real-Port=578617355
UNKNOWN[3561--1]={02 0A 00 06 00 1F CE 10 48 FD}
UNKNOWN[3561--1]={01 08 00 04 00 0B 00 01}

radius 02-26/16:28:22 INFO [rdsLstnr-p-8-t-1] InetRadiusProcessor - REQUEST_AFTER_PREPROCESS:
Packet type: Access-Request
Identifier: 73
Authenticator: {4E 89 1B BD F0 1D 19 C2 9D 07 7B 41 5E 33 4D 0C}
Attributes:
User-Name=0006001fce1048fd:0004000b0001
NAS-Port-Id=2/2 vlan-id 2000:11 clips 160070
NAS-Identifier=SE100-Lenina93-CLIPS
User-Password=Redback
NAS-IP-Address=10.0.0.11
NAS-Port=578617355
Service-Type=5
Calling-Station-Id=14:da:e9:46:fc:a8
NAS-Port-Type=5
Platform-Type=4
Medium-Type=11
Agent-Remote-Id={00 06 00 1F CE 10 48 FD}
UNKNOWN[2352-202]={3D 3D 07 01 14 DA E9 46 FC A8}
UNKNOWN[2352-202]={0C 0C 08 41 6E 74 6F 6E 2D 4E 42}
Agent-Circuit-Id={00 04 00 0B 00 01}
OS-Version=12.1.1.5
Mac-Addr=14:da:e9:46:fc:a8
UNKNOWN[2352-125]={4D 53 46 54 20 35 2E 30}
NAS-Real-Port=578617355
UNKNOWN[3561--1]={02 0A 00 06 00 1F CE 10 48 FD}
UNKNOWN[3561--1]={01 08 00 04 00 0B 00 01}
Common options: {agentRemoteId={001fce1048fd}, macAddress=14:da:e9:46:fc:a8, agentCircuitId={000b0001}}
radius 02-26/16:28:22 DEBUG [rdsLstnr-p-8-t-1] RadiusProcessor - Create new radius session.
radius 02-26/16:28:22 DEBUG [rdsLstnr-p-8-t-1] InetNas - agentRemoteId=java.nio.DirectByteBufferR[pos=0 lim=6 cap=6]
radius 02-26/16:28:22 INFO [rdsLstnr-p-8-t-1] InetNas - Found agentDevice:48
radius 02-26/16:28:22 DEBUG [rdsLstnr-p-8-t-1] InetNas - findServ agentDeviceRuntime=ru.bitel.bgbilling.modules.inet.runtime.device.InetDeviceRuntime@fd50fd2
radius 02-26/16:28:22 INFO [rdsLstnr-p-8-t-1] InetNas - Search serv on deviceId=48; interfaceId=1
radius 02-26/16:28:22 DEBUG [rdsLstnr-p-8-t-1] InetRadiusProcessor - Password verification disabled.
radius 02-26/16:28:22 INFO [rdsLstnr-p-8-t-1] InetRadiusProcessor - [username=0006001fce1048fd:0004000b0001] Authenticated as inetServId:45
radius 02-26/16:28:22 DEBUG [rdsLstnr-p-8-t-1] InetRadiusProcessor - Identifier from request: null
radius 02-26/16:28:22 DEBUG [rdsLstnr-p-8-t-1] InetRadiusProcessor - MAC-address from request: 14DAE946FCA8
radius 02-26/16:28:22 DEBUG [rdsLstnr-p-8-t-1] InetAccountingPeriodList - Create:
AccountingPeriod: 12: 06.02.2014 00:00:00.0 - 28.02.2014 23:59:59.999
radius 02-26/16:28:22 INFO [rdsLstnr-p-8-t-1] InetApplication - inetServ[id=45] balance ok: 0.00 [0]
radius 02-26/16:28:22 INFO [rdsLstnr-p-8-t-1] InetApplication - TariffOptionMap: {}
radius 02-26/16:28:22 INFO [rdsLstnr-p-8-t-1] InetApplication - OptionSet: []
radius 02-26/16:28:22 INFO [rdsLstnr-p-8-t-1] InetRadiusProcessor - Write new waiting connection to DB
radius 02-26/16:28:22 INFO [rdsLstnr-p-8-t-1] InetRadiusProcessor - New connection id=54425
radius 02-26/16:28:22 INFO [rdsLstnr-p-8-t-1] InetRadiusProcessor - Return code=0
radius 02-26/16:28:22 INFO [rdsLstnr-p-8-t-1] InetDhcpHelperProcessor - Put auth accept 3:14DAE946FCA8
radius 02-26/16:28:22 INFO [rdsLstnr-p-8-t-1] InetRadiusProcessor - RESPONSE_BEFORE_POSTPROCESS:
Packet type: Access-Accept
Identifier: 73
Authenticator: {}
Attributes:
Acct-Interim-Interval=900
DHCP-Max-Leases=1
IP-Interface-Name=CLIENTS

Process time auth: 30

radius 02-26/16:28:22 DEBUG [rdsLstnr-p-8-t-1] HourlyDataLogger - Create log file...
radius 02-26/16:28:22 DEBUG [rdsLstnr-p-8-t-1] HourlyLogFileUtils - Next log file: /opt/bgbilling/BGInetAccess/data/radius/source_3/2014/2014-02/2014-02-26/log_2014-02-26-16.001.bgdl
radius 02-26/16:28:22 INFO [rdsLstnr-p-8-t-1] HourlyDataLogEntry - Create dataLog file: /opt/bgbilling/BGInetAccess/data/radius/source_3/2014/2014-02/2014-02-26/log_2014-02-26-16.001.bgdl
radius 02-26/16:28:22 DEBUG [rdsLstnr-p-8-t-1] BGDataLog - DataLog file [data/radius/source_3/2014/2014-02/2014-02-26/log_2014-02-26-16.001.bgdl] was opened
radius 02-26/16:28:22 DEBUG [rdsLstnr-p-8-t-1] DataLog - Writing TLV finished(3)=[0]
radius 02-26/16:28:22 DEBUG [rdsLstnr-p-8-t-1] DataLog - Writing TLV buffer(4)=[type=chunked, size=262144]
radius 02-26/16:28:22 DEBUG [rdsLstnr-p-8-t-1] DataLog - Writing TLV compression(5)=[type=zlib, level=1, strategy=1]
radius 02-26/16:28:22 DEBUG [rdsLstnr-p-8-t-1] DataLog - Writing TLV distributed(6)=[1]
radius 02-26/16:28:22 DEBUG [rdsLstnr-p-8-t-1] DataLog - Writing TLV streaming(7)=[1]
radius 02-26/16:28:22 DEBUG [rdsLstnr-p-8-t-1] BGDataLog - Header length=51
radius 02-26/16:28:22 DEBUG [rdsLstnr-p-8-t-1] ZLIBWritableChannel - ZLIBWritableChannel bufferLength=262160
radius 02-26/16:28:22 DEBUG [rdsLstnr-p-8-t-1] ProcessorRequest - Sending to /10.0.0.11:1812
radius 02-26/16:28:22 INFO [rdsLstnr-p-8-t-1] InetRadiusListenerWorker - RESPONSE:
Packet type: Access-Accept
Identifier: 73
Authenticator: {1D FA 66 EE F7 1E 4C F9 6F 43 D8 72 4C F0 3E 9D}
Attributes:
Acct-Interim-Interval=900
DHCP-Max-Leases=1
IP-Interface-Name=CLIENTS

Process time auth: 94

connection 02-26/16:28:22 INFO [sa-p-13-t-1] ServiceActivatorSet - Connecting to device
connection 02-26/16:28:22 DEBUG [sa-p-13-t-1] AcknowledgeConsumer - Caught BGInetAccounting:Event[ru.bitel.bgbilling.modules.inet.access.sa.event.InetSaAccountingEvent] moduleId: 1; pluginId: no; cid: 2; scid: -1; userId: 0; type: 1; deviceId: 3; connectionId: 54425; timestamp: 1393410502777
connection 02-26/16:28:22 INFO [sa-p-13-t-1] ServiceActivatorDeviceWorker - Do task deviceId: 3; Event[ru.bitel.bgbilling.modules.inet.access.sa.event.InetSaAccountingEvent] moduleId: 1; pluginId: no; cid: 2; scid: -1; userId: 0; type: 1; deviceId: 3; connectionId: 54425; timestamp: 1393410502777
connection 02-26/16:28:22 INFO [sa-p-13-t-1] InetApplication - TariffOptionMap: {}
connection 02-26/16:28:22 INFO [sa-p-13-t-1] InetApplication - OptionSet: []
connection 02-26/16:28:22 INFO [sa-p-13-t-1] ServiceActivatorDeviceWorker - Command result event: ServiceActivatorEvent type=4; inetServId: 45; call: true; oldState: 1; newState: 1; oldOptionSet: ; newOptionSet:
connection 02-26/16:28:22 INFO [sa-p-13-t-1] ServiceActivatorDeviceWorker - Processing deviceId:3; command ServiceActivatorEvent type=4; inetServId: 45; call: true; oldState: 1; newState: 1; oldOptionSet: ; newOptionSet:
connection 02-26/16:28:22 INFO [sa-p-13-t-1] ServiceActivatorSet - Invoking onAccountingStart
connection 02-26/16:28:22 INFO [sa-p-13-t-1] ServiceActivatorDeviceWorker - Process event type[4] result=true
dhcp 02-26/16:28:22 INFO [dhcpLstnr-p-10-t-3] InetAbstractDhcpProcessor - REQUEST:
Message type: BOOT_REQUEST
Dhcp message type: DHCP Discover{1}
htype: 1, hlen: 6, hops: 1
xid: 811090097, secs: 0, flags: -32768
Client IP: 0.0.0.0
Your IP: 0.0.0.0
Server IP: 0.0.0.0
Relay IP: 222.222.222.1
Client MAC: {14DAE946FCA8}
{61}={0114DAE946FCA8}
Requested IP Address{50}=222.222.222.10
Host name{12}={Anton-NB}
{60}={4D53465420352E30}
Parameter request list{55}={1, 15, 3, 6, 44, 46, 47, 31, 33, 121, -7, 43}
Agent information{82}=
sub{1}={0004000B0001}
sub{2}={0006001FCE1048FD}

mq 02-26/16:28:22 DEBUG [event-proc-p-2-t-1] Consumer - Caught BGInetAccounting:Event[ru.bitel.bgbilling.modules.inet.accounting.event.InetAccountingEvent] moduleId: 1; pluginId: no; cid: 2; scid: -1; userId: 0; type: 1; deviceId: 3; connectionId: 54425; timestamp: 1393410502777
mq 02-26/16:28:22 INFO [event-proc-p-2-t-1] InetConnectionManager - Add connection: InetConnection [id=54425-0, iface=3:578617355, sessId=0101FFFF78007146-530DC1C6, start=26.02.2014 16:28:22, uname=0006001fce1048fd:0004000b0001, addr=[IpAddress:null]]
mq 02-26/16:28:22 INFO [event-proc-p-2-t-1] InetDhcpHelperProcessor - IP is null 3:14DAE946FCA8
dhcp 02-26/16:28:22 DEBUG [dhcpLstnr-p-10-t-3] InetAbstractDhcpProcessor - OP_BOOT_REQUEST
dhcp 02-26/16:28:22 DEBUG [dhcpLstnr-p-10-t-3] InetAbstractDhcpProcessor - Found device by giaddr id=3
dhcp 02-26/16:28:22 INFO [dhcpLstnr-p-10-t-3] InetAbstractDhcpProcessor - REQUEST_AFTER_PREPROCESS:
Message type: BOOT_REQUEST
Dhcp message type: DHCP Discover{1}
htype: 1, hlen: 6, hops: 1
xid: 811090097, secs: 0, flags: -32768
Client IP: 0.0.0.0
Your IP: 0.0.0.0
Server IP: 0.0.0.0
Relay IP: 222.222.222.1
Client MAC: {14DAE946FCA8}
{61}={0114DAE946FCA8}
Requested IP Address{50}=222.222.222.10
Host name{12}={Anton-NB}
{60}={4D53465420352E30}
Parameter request list{55}={1, 15, 3, 6, 44, 46, 47, 31, 33, 121, -7, 43}
Agent information{82}=
sub{1}={0004000B0001}
sub{2}={0006001FCE1048FD}

dhcp 02-26/16:28:22 DEBUG [dhcpLstnr-p-10-t-3] InetAbstractDhcpProcessor - Found subDevice by identifier id=48
dhcp 02-26/16:28:22 DEBUG [dhcpLstnr-p-10-t-3] InetDhcpHelperProcessor - request.giaddr = 222.222.222.1
dhcp 02-26/16:28:22 DEBUG [dhcpLstnr-p-10-t-3] InetAbstractDhcpProcessor - DHCP_DISCOVER
dhcp 02-26/16:28:22 INFO [dhcpLstnr-p-10-t-3] InetAbstractDhcpProcessor - RESPONSE_BEFORE_POSTPROCESS:
Message type: BOOT_RESPONSE
Dhcp message type: DHCP Offer{2}
htype: 1, hlen: 6, hops: 1
xid: 811090097, secs: 0, flags: -32768
Client IP: 0.0.0.0
Your IP: 0.0.0.0
Server IP: 0.0.0.0
Relay IP: 222.222.222.1
Client MAC: {14DAE946FCA8}
Agent information{82}=
sub{1}={0004000B0001}
sub{2}={0006001FCE1048FD}
IP Address Lease Time{51}=300
Server Identifier{54}={00000000}

dhcp 02-26/16:28:22 INFO [dhcpLstnr-p-10-t-3] InetAbstractDhcpProcessor - RESPONSE:
Message type: BOOT_RESPONSE
Dhcp message type: DHCP Offer{2}
htype: 1, hlen: 6, hops: 1
xid: 811090097, secs: 0, flags: -32768
Client IP: 0.0.0.0
Your IP: 0.0.0.0
Server IP: 0.0.0.0
Relay IP: 222.222.222.1
Client MAC: {14DAE946FCA8}
Agent information{82}=
sub{1}={0004000B0001}
sub{2}={0006001FCE1048FD}
IP Address Lease Time{51}=300
Server Identifier{54}={00000000}

dhcp 02-26/16:28:22 DEBUG [dhcpLstnr-p-10-t-3] ProcessorRequest - Sending to /10.0.0.11:67
connection 02-26/16:28:26 DEBUG [sa-p-13-t-1] AcknowledgeConsumer - Caught BGInetAccounting:Event[ru.bitel.bgbilling.modules.inet.access.sa.event.InetSaAccountingEvent] moduleId: 1; pluginId: no; cid: 2; scid: -1; userId: 0; type: 2; deviceId: 3; connectionId: 54425; timestamp: 1393410506675
connection 02-26/16:28:26 INFO [sa-p-13-t-1] ServiceActivatorDeviceWorker - Do task deviceId: 3; Event[ru.bitel.bgbilling.modules.inet.access.sa.event.InetSaAccountingEvent] moduleId: 1; pluginId: no; cid: 2; scid: -1; userId: 0; type: 2; deviceId: 3; connectionId: 54425; timestamp: 1393410506675
connection 02-26/16:28:26 INFO [sa-p-13-t-1] InetApplication - TariffOptionMap: {}
connection 02-26/16:28:26 INFO [sa-p-13-t-1] InetApplication - OptionSet: []
connection 02-26/16:28:26 INFO [sa-p-13-t-1] ServiceActivatorDeviceWorker - Command result event: ServiceActivatorEvent type=5; inetServId: 45; call: true; oldState: 1; newState: 1; oldOptionSet: ; newOptionSet:
connection 02-26/16:28:26 INFO [sa-p-13-t-1] ServiceActivatorDeviceWorker - Processing deviceId:3; command ServiceActivatorEvent type=5; inetServId: 45; call: true; oldState: 1; newState: 1; oldOptionSet: ; newOptionSet:
connection 02-26/16:28:26 INFO [sa-p-13-t-1] ServiceActivatorSet - Invoking onAccountingStop
connection 02-26/16:28:26 INFO [sa-p-13-t-1] ServiceActivatorDeviceWorker - Process event type[5] result=true
mq 02-26/16:28:27 DEBUG [event-proc-p-2-t-1] Consumer - Caught BGInetAccounting:Event[ru.bitel.bgbilling.modules.inet.accounting.event.InetAccountingEvent] moduleId: 1; pluginId: no; cid: 2; scid: -1; userId: 0; type: 2; deviceId: 3; connectionId: 54425; timestamp: 1393410506675
mq 02-26/16:28:27 INFO [event-proc-p-2-t-1] InetConnectionManager - Remove connection: InetConnection [id=54425-0, iface=3:578617355, sessId=0101FFFF78007146-530DC1C6, start=26.02.2014 16:28:22, uname=0006001fce1048fd:0004000b0001, addr=[IpAddress:null]]
mq 02-26/16:28:27 INFO [event-proc-p-2-t-1] InetDhcpHelperProcessor - Remove connection remove 3:14DAE946FCA8
connection 02-26/16:28:31 INFO [sa-p-13-t-1] ServiceActivatorSet - Disconnecting from device

Т. е. смысл задачи - создаю VLAN на роутере, вешаю на него, например /29 сетку. Эту сетку указываю в сервисе.