accel-ppp.org

check log, set [log] level=5 and accel-cmd reload.

Hi Dimka88
still can't over 256. please check log as below.

Thanks,


hinet@250-50-client:~$
hinet@250-50-client:~$ sudo more /var/log/accel-ppp/accel-ppp.log | tail -n300
[2017-12-22 08:56:50]: debug: eth1.258: auth_layer_start
[2017-12-22 08:56:50]: debug: ppp214: recv [LCP EchoReq id=3 <magic 0953b530>]
[2017-12-22 08:56:50]: debug: ppp214: send [LCP EchoRep id=3 <magic 59adea3d>]
[2017-12-22 08:56:50]: info: eth1.258: recv [PAP AuthReq id=1]
[2017-12-22 08:56:50]: info: ppp256: connect: ppp256 <--> pppoe(00:00:65:00:01:02)
[2017-12-22 08:56:50]: debug: ppp256: ppp connected
[2017-12-22 08:56:50]: info: ppp256: send [PAP AuthAck id=1 "Authentication succeeded"]
[2017-12-22 08:56:50]: debug: ppp256: auth_layer_started
[2017-12-22 08:56:50]: debug: ppp256: ccp_layer_start
[2017-12-22 08:56:50]: debug: ppp256: ipcp_layer_start
[2017-12-22 08:56:50]: warn: ppp256: ppp: no free IPv4 address
[2017-12-22 08:56:50]: debug: ppp256: terminate
[2017-12-22 08:56:50]: debug: ppp256: lcp_layer_finish
[2017-12-22 08:56:50]: info: ppp256: send [LCP TermReq id=3]
[2017-12-22 08:56:50]: debug: ppp256: auth_layer_finish
[2017-12-22 08:56:50]: debug: ppp256: auth_layer_finished
[2017-12-22 08:56:50]: debug: ppp256: ccp_layer_finish
[2017-12-22 08:56:50]: debug: ppp256: ccp_layer_finished
[2017-12-22 08:56:50]: debug: ppp256: ipcp_layer_finish
[2017-12-22 08:56:50]: debug: ppp256: ipcp_layer_finished
[2017-12-22 08:56:50]: info: ppp256: test1: authentication succeeded
[2017-12-22 08:56:50]: warn: ppp256: IPCP: discarding packet
[2017-12-22 08:56:50]: info: ppp256: recv [LCP TermAck id=3]
[2017-12-22 08:56:50]: debug: ppp256: lcp_layer_finished
[2017-12-22 08:56:50]: debug: ppp256: pppoe: ppp finished
[2017-12-22 08:56:50]: debug: ppp256: lcp_layer_free
[2017-12-22 08:56:50]: debug: ppp256: auth_layer_free
[2017-12-22 08:56:50]: debug: ppp256: ccp_layer_free
[2017-12-22 08:56:50]: debug: ppp256: ipcp_layer_free
[2017-12-22 08:56:50]: debug: ppp256: ipv6cp_layer_free
[2017-12-22 08:56:50]: debug: ppp256: ppp destablished
[2017-12-22 08:56:50]: info: eth1.258: send [PPPoE PADT 52:54:00:82:65:22 => 00:00:65:00:01:02 sid=2981 <AC-Name accel-ppp> <Service-Name AGILENT>]
[2017-12-22 08:56:50]: info: ppp256: disconnected
[2017-12-22 08:56:50]: info: eth1.258: recv [PPPoE PADT 00:00:65:00:01:02 => 52:54:00:82:65:22 sid=2981]
[2017-12-22 08:56:50]: info: eth1.257: recv [PPPoE PADI 00:00:65:00:01:01 => ff:ff:ff:ff:ff:ff sid=0000 <Service-Name AGILENT> <Host-Uniq 00060100>]
[2017-12-22 08:56:50]: info: eth1.257: send [PPPoE PADO 52:54:00:82:65:22 => 00:00:65:00:01:01 sid=0000 <AC-Name accel-ppp> <Service-Name AGILENT> <AC-Cookie 755729f67150b200febbfa19ebaf9939d9d27aff19604e7a> <Host-Uniq 00060100>]
[2017-12-22 08:56:50]: info: eth1.257: recv [PPPoE PADR 00:00:65:00:01:01 => 52:54:00:82:65:22 sid=0000 <AC-Name accel-ppp> <Service-Name AGILENT> <AC-Cookie 755729f67150b200febbfa19ebaf9939d9d27aff19604e7a> <Host-Uniq 00060100>]
[2017-12-22 08:56:50]: info: eth1.257: send [PPPoE PADS 52:54:00:82:65:22 => 00:00:65:00:01:01 sid=29c1 <AC-Name accel-ppp> <Service-Name AGILENT> <Host-Uniq 00060100>]
[2017-12-22 08:56:50]: debug: eth1.257: lcp_layer_init
[2017-12-22 08:56:50]: debug: eth1.257: auth_layer_init
[2017-12-22 08:56:50]: debug: eth1.257: ccp_layer_init
[2017-12-22 08:56:50]: debug: eth1.257: ipcp_layer_init
[2017-12-22 08:56:50]: debug: eth1.257: ipv6cp_layer_init
[2017-12-22 08:56:50]: debug: eth1.257: ppp establishing
[2017-12-22 08:56:50]: debug: eth1.257: lcp_layer_start
[2017-12-22 08:56:50]: info: eth1.257: send [LCP ConfReq id=1 <auth PAP> <mru 1400> <magic 70bb9983>]
[2017-12-22 08:56:50]: info: eth1.257: recv [LCP ConfReq id=1 <magic 08e44e40> <mru 65531>]
[2017-12-22 08:56:50]: info: eth1.257: send [LCP ConfNak id=1 <mru 1400>]
[2017-12-22 08:56:50]: info: eth1.257: recv [LCP ConfAck id=1 <auth PAP> <mru 1400> <magic 70bb9983>]
[2017-12-22 08:56:50]: info: eth1.257: recv [LCP ConfReq id=2 <magic 08e44e40> <mru 1400>]
[2017-12-22 08:56:50]: info: eth1.257: send [LCP ConfAck id=2 ]
[2017-12-22 08:56:50]: debug: eth1.257: lcp_layer_started
[2017-12-22 08:56:50]: debug: eth1.257: auth_layer_start
[2017-12-22 08:56:50]: debug: ppp217: recv [LCP EchoReq id=3 <magic 0b579308>]
[2017-12-22 08:56:50]: debug: ppp217: send [LCP EchoRep id=3 <magic 097e1b4e>]
[2017-12-22 08:56:50]: debug: ppp216: recv [LCP EchoReq id=3 <magic 037e6158>]
[2017-12-22 08:56:50]: debug: ppp216: send [LCP EchoRep id=3 <magic 2a155dbc>]
[2017-12-22 08:56:50]: debug: ppp215: recv [LCP EchoReq id=3 <magic 0cd883d8>]
[2017-12-22 08:56:50]: debug: ppp215: send [LCP EchoRep id=3 <magic 288f1a34>]
[2017-12-22 08:56:50]: debug: ppp220: recv [LCP EchoReq id=3 <magic 09e19598>]
[2017-12-22 08:56:50]: debug: ppp220: send [LCP EchoRep id=3 <magic 1d9f6e5f>]
[2017-12-22 08:56:50]: debug: ppp221: recv [LCP EchoReq id=3 <magic 0cdacf70>]
[2017-12-22 08:56:50]: debug: ppp221: send [LCP EchoRep id=3 <magic 53584bcb>]
[2017-12-22 08:56:50]: debug: ppp218: recv [LCP EchoReq id=3 <magic 08fae758>]
[2017-12-22 08:56:50]: debug: ppp218: send [LCP EchoRep id=3 <magic 51088277>]
[2017-12-22 08:56:50]: debug: ppp219: recv [LCP EchoReq id=3 <magic 0db209d0>]
[2017-12-22 08:56:50]: debug: ppp219: send [LCP EchoRep id=3 <magic 1ca0c5fa>]
[2017-12-22 08:56:50]: info: eth1.257: recv [PAP AuthReq id=1]
[2017-12-22 08:56:50]: info: ppp257: connect: ppp257 <--> pppoe(00:00:65:00:01:01)
[2017-12-22 08:56:50]: debug: ppp257: ppp connected
[2017-12-22 08:56:50]: info: ppp257: send [PAP AuthAck id=1 "Authentication succeeded"]
[2017-12-22 08:56:50]: debug: ppp257: auth_layer_started
[2017-12-22 08:56:50]: debug: ppp257: ccp_layer_start
[2017-12-22 08:56:50]: debug: ppp257: ipcp_layer_start
[2017-12-22 08:56:50]: warn: ppp257: ppp: no free IPv4 address
[2017-12-22 08:56:50]: debug: ppp257: terminate
[2017-12-22 08:56:50]: debug: ppp257: lcp_layer_finish
[2017-12-22 08:56:50]: info: ppp257: send [LCP TermReq id=3]
[2017-12-22 08:56:50]: debug: ppp257: auth_layer_finish
[2017-12-22 08:56:50]: debug: ppp257: auth_layer_finished
[2017-12-22 08:56:50]: debug: ppp257: ccp_layer_finish
[2017-12-22 08:56:50]: debug: ppp257: ccp_layer_finished
[2017-12-22 08:56:50]: debug: ppp257: ipcp_layer_finish
[2017-12-22 08:56:50]: debug: ppp257: ipcp_layer_finished
[2017-12-22 08:56:50]: info: ppp257: test1: authentication succeeded
[2017-12-22 08:56:50]: warn: ppp257: IPCP: discarding packet
[2017-12-22 08:56:50]: info: ppp257: recv [LCP TermAck id=3]
[2017-12-22 08:56:50]: debug: ppp257: lcp_layer_finished
[2017-12-22 08:56:50]: debug: ppp257: pppoe: ppp finished
[2017-12-22 08:56:50]: debug: ppp257: lcp_layer_free
[2017-12-22 08:56:50]: debug: ppp257: auth_layer_free
[2017-12-22 08:56:50]: debug: ppp257: ccp_layer_free
[2017-12-22 08:56:50]: debug: ppp257: ipcp_layer_free
[2017-12-22 08:56:50]: debug: ppp257: ipv6cp_layer_free
[2017-12-22 08:56:50]: debug: ppp257: ppp destablished
[2017-12-22 08:56:50]: info: eth1.257: send [PPPoE PADT 52:54:00:82:65:22 => 00:00:65:00:01:01 sid=29c1 <AC-Name accel-ppp> <Service-Name AGILENT>]
[2017-12-22 08:56:50]: info: ppp257: disconnected
[2017-12-22 08:56:50]: info: eth1.257: recv [PPPoE PADT 00:00:65:00:01:01 => 52:54:00:82:65:22 sid=29c1]
[2017-12-22 08:56:50]: info: eth1.258: recv [PPPoE PADI 00:00:65:00:01:02 => ff:ff:ff:ff:ff:ff sid=0000 <Service-Name AGILENT> <Host-Uniq 00060101>]
[2017-12-22 08:56:50]: info: eth1.258: send [PPPoE PADO 52:54:00:82:65:22 => 00:00:65:00:01:02 sid=0000 <AC-Name accel-ppp> <Service-Name AGILENT> <AC-Cookie 0601ed0769223daf9a62ae6a98b5d5a37a497b2b89ccf22d> <Host-Uniq 00060101>]
[2017-12-22 08:56:50]: info: eth1.258: recv [PPPoE PADR 00:00:65:00:01:02 => 52:54:00:82:65:22 sid=0000 <AC-Name accel-ppp> <Service-Name AGILENT> <AC-Cookie 0601ed0769223daf9a62ae6a98b5d5a37a497b2b89ccf22d> <Host-Uniq 00060101>]
[2017-12-22 08:56:50]: info: eth1.258: send [PPPoE PADS 52:54:00:82:65:22 => 00:00:65:00:01:02 sid=2a01 <AC-Name accel-ppp> <Service-Name AGILENT> <Host-Uniq 00060101>]
[2017-12-22 08:56:50]: debug: eth1.258: lcp_layer_init
[2017-12-22 08:56:50]: debug: eth1.258: auth_layer_init
[2017-12-22 08:56:50]: debug: eth1.258: ccp_layer_init
[2017-12-22 08:56:50]: debug: eth1.258: ipcp_layer_init
[2017-12-22 08:56:50]: debug: eth1.258: ipv6cp_layer_init
[2017-12-22 08:56:50]: debug: eth1.258: ppp establishing
[2017-12-22 08:56:50]: debug: eth1.258: lcp_layer_start
[2017-12-22 08:56:50]: info: eth1.258: send [LCP ConfReq id=1 <auth PAP> <mru 1400> <magic 51eebeea>]
[2017-12-22 08:56:50]: info: eth1.258: recv [LCP ConfReq id=1 <magic 03480528> <mru 65531>]
[2017-12-22 08:56:50]: info: eth1.258: send [LCP ConfNak id=1 <mru 1400>]
[2017-12-22 08:56:50]: info: eth1.258: recv [LCP ConfAck id=1 <auth PAP> <mru 1400> <magic 51eebeea>]
[2017-12-22 08:56:50]: info: eth1.258: recv [LCP ConfReq id=2 <magic 03480528> <mru 1400>]
[2017-12-22 08:56:50]: info: eth1.258: send [LCP ConfAck id=2 ]
[2017-12-22 08:56:50]: debug: eth1.258: lcp_layer_started
[2017-12-22 08:56:50]: debug: eth1.258: auth_layer_start
[2017-12-22 08:56:50]: info: eth1.258: recv [PAP AuthReq id=1]
[2017-12-22 08:56:50]: info: ppp256: connect: ppp256 <--> pppoe(00:00:65:00:01:02)
[2017-12-22 08:56:50]: debug: ppp256: ppp connected
[2017-12-22 08:56:50]: info: ppp256: send [PAP AuthAck id=1 "Authentication succeeded"]
[2017-12-22 08:56:50]: debug: ppp256: auth_layer_started
[2017-12-22 08:56:50]: debug: ppp256: ccp_layer_start
[2017-12-22 08:56:50]: debug: ppp256: ipcp_layer_start
[2017-12-22 08:56:50]: warn: ppp256: ppp: no free IPv4 address
[2017-12-22 08:56:50]: debug: ppp256: terminate
[2017-12-22 08:56:50]: debug: ppp256: lcp_layer_finish
[2017-12-22 08:56:50]: info: ppp256: send [LCP TermReq id=3]
[2017-12-22 08:56:50]: debug: ppp256: auth_layer_finish
[2017-12-22 08:56:50]: debug: ppp256: auth_layer_finished
[2017-12-22 08:56:50]: debug: ppp256: ccp_layer_finish
[2017-12-22 08:56:50]: debug: ppp256: ccp_layer_finished
[2017-12-22 08:56:50]: debug: ppp256: ipcp_layer_finish
[2017-12-22 08:56:50]: debug: ppp256: ipcp_layer_finished
[2017-12-22 08:56:50]: info: ppp256: test1: authentication succeeded
[2017-12-22 08:56:50]: warn: ppp256: IPCP: discarding packet
[2017-12-22 08:56:50]: info: ppp256: recv [LCP TermAck id=3]
[2017-12-22 08:56:50]: debug: ppp256: lcp_layer_finished
[2017-12-22 08:56:50]: debug: ppp256: pppoe: ppp finished
[2017-12-22 08:56:50]: debug: ppp256: lcp_layer_free
[2017-12-22 08:56:50]: debug: ppp256: auth_layer_free
[2017-12-22 08:56:50]: debug: ppp256: ccp_layer_free
[2017-12-22 08:56:50]: debug: ppp256: ipcp_layer_free
[2017-12-22 08:56:50]: debug: ppp256: ipv6cp_layer_free
[2017-12-22 08:56:50]: debug: ppp256: ppp destablished
[2017-12-22 08:56:50]: info: eth1.258: send [PPPoE PADT 52:54:00:82:65:22 => 00:00:65:00:01:02 sid=2a01 <AC-Name accel-ppp> <Service-Name AGILENT>]
[2017-12-22 08:56:50]: info: ppp256: disconnected
[2017-12-22 08:56:50]: info: eth1.258: recv [PPPoE PADT 00:00:65:00:01:02 => 52:54:00:82:65:22 sid=2a01]
[2017-12-22 08:56:50]: info: eth1.257: recv [PPPoE PADI 00:00:65:00:01:01 => ff:ff:ff:ff:ff:ff sid=0000 <Service-Name AGILENT> <Host-Uniq 00060100>]
[2017-12-22 08:56:50]: info: eth1.257: send [PPPoE PADO 52:54:00:82:65:22 => 00:00:65:00:01:01 sid=0000 <AC-Name accel-ppp> <Service-Name AGILENT> <AC-Cookie 755729f67150b200febbfa19ebaf9939d9d27aff19604e7a> <Host-Uniq 00060100>]
[2017-12-22 08:56:50]: info: eth1.257: recv [PPPoE PADR 00:00:65:00:01:01 => 52:54:00:82:65:22 sid=0000 <AC-Name accel-ppp> <Service-Name AGILENT> <AC-Cookie 755729f67150b200febbfa19ebaf9939d9d27aff19604e7a> <Host-Uniq 00060100>]
[2017-12-22 08:56:50]: info: eth1.257: send [PPPoE PADS 52:54:00:82:65:22 => 00:00:65:00:01:01 sid=2a41 <AC-Name accel-ppp> <Service-Name AGILENT> <Host-Uniq 00060100>]

you have ip-pool=pppoe1 which is 192.168.0.0/24 f.e. 256 addresses

Hi Dmitry,
Sorry, maybe it's my mistake, this function need with RADIUS right?
BR,

to @jalee
Set:
[pppoe]
#ip-pool=pppoe1
ip-pool=pppoe4

It will use 2 pools: "pppoe4" and then "pppoe1"

radius may only override default pool

Got it.
Thanks all.