Netgate Discussion Forum
    • Categories
    • Recent
    • Tags
    • Popular
    • Users
    • Search
    • Register
    • Login

    Huawei E220 USB 3G Modem - IPCP: parameter negotiation failed

    Hardware
    1
    1
    1.6k
    Loading More Posts
    • Oldest to Newest
    • Newest to Oldest
    • Most Votes
    Reply
    • Reply as topic
    Log in to reply
    This topic has been deleted. Only users with topic management privileges can see it.
    • M
      mickeyratt
      last edited by

      Dear All

      I'd like to test new pfSense.
      I'd like to connect to internet with a 3g modem, but it is failed.
      The same hardware under linux (Debian lenny) works perfectly.

      The 3G modem detected well, it seems to me, that it is a software-layer problem
      (maybe in mpd…?).

      I attach the pfsense and linux logs (sorry for long list):

      pfSense:

      Jun  8 22:00:36 pfSense kernel: ugen3.2: <huawei technologies="">at usbus3
      Jun  8 22:00:36 pfSense kernel: ugen3.2: <huawei technologies="">at usbus3 (disconnected)
      Jun  8 22:00:38 pfSense kernel: ugen3.2: <huawei technologies="">at usbus3
      Jun  8 22:00:38 pfSense kernel: u3g0: <data interface="">on usbus3
      Jun  8 22:00:38 pfSense kernel: u3g0: Found 2 ports.
      Jun  8 22:00:38 pfSense kernel: umass0: <huawei 0="" 2="" technologies="" huawei="" mobile,="" class="" 0,="" rev="" 1.10="" 0.00,="" addr="">on usbus3
      Jun  8 22:00:38 pfSense kernel: umass0:  SCSI over Bulk-Only; quirks = 0x0000
      Jun  8 22:00:39 pfSense kernel: umass0:0:0👎 Attached to scbus0
      Jun  8 22:00:40 pfSense kernel: (probe0:umass-sim0:0:0:0): TEST UNIT READY. CDB: 0 0 0 0 0 0
      Jun  8 22:00:40 pfSense kernel: (probe0:umass-sim0:0:0:0): CAM status: SCSI Status Error
      Jun  8 22:00:40 pfSense kernel: (probe0:umass-sim0:0:0:0): SCSI status: Check Condition
      Jun  8 22:00:40 pfSense kernel: (probe0:umass-sim0:0:0:0): SCSI sense: NOT READY asc:3a,0 (Medium not present)
      Jun  8 22:00:40 pfSense kernel: cd0 at umass-sim0 bus 0 scbus0 target 0 lun 0
      Jun  8 22:00:40 pfSense kernel: cd0: <huawei mass="" storage="" 2.31="">Removable CD-ROM SCSI-2 device
      Jun  8 22:00:40 pfSense kernel: cd0: 1.000MB/s transfers
      Jun  8 22:00:40 pfSense kernel: cd0: Attempt to query device size failed: NOT READY, Medium not present
      Jun  8 22:01:02 pfSense ppp: Multi-link PPP daemon for FreeBSD
      Jun  8 22:01:02 pfSense ppp:
      Jun  8 22:01:02 pfSense ppp: process 59235 started, version 5.5 (root@FreeBSD_8.0_pfSense_2.0-AMD64.snaps.pfsense.org 16:23 22-Feb-2011)
      Jun  8 22:01:02 pfSense ppp: web: web is not running
      Jun  8 22:01:02 pfSense ppp: [opt1] Bundle: Interface ng0 created
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] Link: OPEN event
      Jun  8 22:01:02 pfSense kernel: ng0: changing name to 'ppp0'
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: Open event
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: state change Initial –> Starting
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: LayerStart
      Jun  8 22:01:02 pfSense ppp: Multi-link PPP daemon for FreeBSD
      Jun  8 22:01:02 pfSense ppp:
      Jun  8 22:01:02 pfSense ppp: process 60160 started, version 5.5 (root@FreeBSD_8.0_pfSense_2.0-AMD64.snaps.pfsense.org 16:23 22-Feb-2011)
      Jun  8 22:01:02 pfSense ppp: waiting for process 59235 to die…
      Jun  8 22:01:02 pfSense ppp: caught fatal signal term
      Jun  8 22:01:02 pfSense ppp: [opt1] IFACE: Close event
      Jun  8 22:01:02 pfSense ppp: [opt1] IPCP: Close event
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] chat: Detected Hayes compatible modem.
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] chat: Dialing server at *99#…
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] chat: Connected at an unknown speed.
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] MODEM: chat script succeeded
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] Link: UP event
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: Up event
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: state change Starting –> Req-Sent
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: SendConfigReq #1
      Jun  8 22:01:02 pfSense ppp: [opt1_link0]  ACFCOMP
      Jun  8 22:01:02 pfSense ppp: [opt1_link0]  PROTOCOMP
      Jun  8 22:01:02 pfSense ppp: [opt1_link0]  ACCMAP 0x000a0000
      Jun  8 22:01:02 pfSense ppp: [opt1_link0]  MRU 1500
      Jun  8 22:01:02 pfSense ppp: [opt1_link0]  MAGICNUM fc154f72
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: rec'd Configure Request #0 (Req-Sent)
      Jun  8 22:01:02 pfSense ppp: [opt1_link0]  ACCMAP 0x00000000
      Jun  8 22:01:02 pfSense ppp: [opt1_link0]  AUTHPROTO CHAP MD5
      Jun  8 22:01:02 pfSense ppp: [opt1_link0]  MAGICNUM 00c89b82
      Jun  8 22:01:02 pfSense ppp: [opt1_link0]  PROTOCOMP
      Jun  8 22:01:02 pfSense ppp: [opt1_link0]  ACFCOMP
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: SendConfigAck #0
      Jun  8 22:01:02 pfSense ppp: [opt1_link0]  ACCMAP 0x00000000
      Jun  8 22:01:02 pfSense ppp: [opt1_link0]  AUTHPROTO CHAP MD5
      Jun  8 22:01:02 pfSense ppp: [opt1_link0]  MAGICNUM 00c89b82
      Jun  8 22:01:02 pfSense ppp: [opt1_link0]  PROTOCOMP
      Jun  8 22:01:02 pfSense ppp: [opt1_link0]  ACFCOMP
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: state change Req-Sent –> Ack-Sent
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: rec'd Configure Ack #1 (Ack-Sent)
      Jun  8 22:01:02 pfSense ppp: [opt1_link0]  ACFCOMP
      Jun  8 22:01:02 pfSense ppp: [opt1_link0]  PROTOCOMP
      Jun  8 22:01:02 pfSense ppp: [opt1_link0]  ACCMAP 0x000a0000
      Jun  8 22:01:02 pfSense ppp: [opt1_link0]  MRU 1500
      Jun  8 22:01:02 pfSense ppp: [opt1_link0]  MAGICNUM fc154f72
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: state change Ack-Sent –> Opened
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: auth: peer wants CHAP, I want nothing
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: LayerUp
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: rec'd Discard Request #1 (Opened)
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] CHAP: rec'd CHALLENGE #1 len: 35
      Jun  8 22:01:02 pfSense ppp: [opt1_link0]  Name: "UMTS_CHAP_SRVR"
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] CHAP: Using authname "admin"
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] CHAP: sending RESPONSE #1 len: 26
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] CHAP: rec'd SUCCESS #1 len: 4
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: authorization successful
      Jun  8 22:01:02 pfSense ppp: Shutdown sequence in progress, BundJoin() denied
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] link did not validate in bundle
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: parameter negotiation failed
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: state change Opened –> Stopping
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: SendTerminateReq #2
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: LayerDown
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: rec'd Terminate Ack #2 (Stopping)
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: state change Stopping –> Stopped
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: LayerFinish
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] Link: DOWN event
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] Link: giving up after 0 reconnection attempts
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: Close event
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: state change Stopped –> Closed
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: Down event
      Jun  8 22:01:02 pfSense ppp: [opt1_link0] LCP: state change Closed –> Initial
      Jun  8 22:01:04 pfSense ppp: [opt1] Bundle: Shutdown
      Jun  8 22:01:04 pfSense ppp: [opt1_link0] Link: Shutdown
      Jun  8 22:01:04 pfSense ppp: process 59235 terminated
      Jun  8 22:01:05 pfSense ppp: last message repeated 2 times
      Jun  8 22:01:05 pfSense ppp: web: web is not running
      Jun  8 22:01:05 pfSense ppp: [opt1] Bundle: Interface ng0 created
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] Link: OPEN event
      Jun  8 22:01:05 pfSense kernel: ng0: changing name to 'ppp0'
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] LCP: Open event
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] LCP: state change Initial –> Starting
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] LCP: LayerStart
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] chat: Detected Hayes compatible modem.
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] chat: Dialing server at *99#…
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] chat: Connected at an unknown speed.
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] MODEM: chat script succeeded
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] Link: UP event
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] LCP: Up event
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] LCP: state change Starting –> Req-Sent
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] LCP: SendConfigReq #1
      Jun  8 22:01:05 pfSense ppp: [opt1_link0]  ACFCOMP
      Jun  8 22:01:05 pfSense ppp: [opt1_link0]  PROTOCOMP
      Jun  8 22:01:05 pfSense ppp: [opt1_link0]  ACCMAP 0x000a0000
      Jun  8 22:01:05 pfSense ppp: [opt1_link0]  MRU 1500
      Jun  8 22:01:05 pfSense ppp: [opt1_link0]  MAGICNUM 16e32000
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] LCP: rec'd Configure Request #2 (Req-Sent)
      Jun  8 22:01:05 pfSense ppp: [opt1_link0]  ACCMAP 0x00000000
      Jun  8 22:01:05 pfSense ppp: [opt1_link0]  AUTHPROTO CHAP MD5
      Jun  8 22:01:05 pfSense ppp: [opt1_link0]  MAGICNUM 00c8a6e6
      Jun  8 22:01:05 pfSense ppp: [opt1_link0]  PROTOCOMP
      Jun  8 22:01:05 pfSense ppp: [opt1_link0]  ACFCOMP
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] LCP: SendConfigAck #2
      Jun  8 22:01:05 pfSense ppp: [opt1_link0]  ACCMAP 0x00000000
      Jun  8 22:01:05 pfSense ppp: [opt1_link0]  AUTHPROTO CHAP MD5
      Jun  8 22:01:05 pfSense ppp: [opt1_link0]  MAGICNUM 00c8a6e6
      Jun  8 22:01:05 pfSense ppp: [opt1_link0]  PROTOCOMP
      Jun  8 22:01:05 pfSense ppp: [opt1_link0]  ACFCOMP
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] LCP: state change Req-Sent –> Ack-Sent
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] LCP: rec'd Configure Ack #1 (Ack-Sent)
      Jun  8 22:01:05 pfSense ppp: [opt1_link0]  ACFCOMP
      Jun  8 22:01:05 pfSense ppp: [opt1_link0]  PROTOCOMP
      Jun  8 22:01:05 pfSense ppp: [opt1_link0]  ACCMAP 0x000a0000
      Jun  8 22:01:05 pfSense ppp: [opt1_link0]  MRU 1500
      Jun  8 22:01:05 pfSense ppp: [opt1_link0]  MAGICNUM 16e32000
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] LCP: state change Ack-Sent –> Opened
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] LCP: auth: peer wants CHAP, I want nothing
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] LCP: LayerUp
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] LCP: rec'd Discard Request #3 (Opened)
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] CHAP: rec'd CHALLENGE #1 len: 35
      Jun  8 22:01:05 pfSense ppp: [opt1_link0]  Name: "UMTS_CHAP_SRVR"
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] CHAP: Using authname "admin"
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] CHAP: sending RESPONSE #1 len: 26
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] CHAP: rec'd SUCCESS #1 len: 4
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] LCP: authorization successful
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] Link: Matched action 'bundle "opt1" ""'
      Jun  8 22:01:05 pfSense ppp: [opt1_link0] Link: Join bundle "opt1"
      Jun  8 22:01:05 pfSense ppp: [opt1] Bundle: Status update: up 1 link, total bandwidth 28800 bps
      Jun  8 22:01:05 pfSense ppp: [opt1] IPCP: Open event
      Jun  8 22:01:05 pfSense ppp: [opt1] IPCP: state change Initial –> Starting
      Jun  8 22:01:05 pfSense ppp: [opt1] IPCP: LayerStart
      Jun  8 22:01:05 pfSense ppp: [opt1] IPCP: Up event
      Jun  8 22:01:05 pfSense ppp: [opt1] IPCP: state change Starting –> Req-Sent
      Jun  8 22:01:05 pfSense ppp: [opt1] IPCP: SendConfigReq #1
      Jun  8 22:01:05 pfSense ppp: [opt1]  IPADDR 0.0.0.0
      Jun  8 22:01:05 pfSense ppp: [opt1]  COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
      Jun  8 22:01:05 pfSense ppp: [opt1]  PRIDNS 0.0.0.0
      Jun  8 22:01:05 pfSense ppp: [opt1]  SECDNS 0.0.0.0
      Jun  8 22:01:06 pfSense ppp: [opt1] IPCP: rec'd Configure Nak #1 (Req-Sent)
      Jun  8 22:01:06 pfSense ppp: [opt1]  PRIDNS 10.11.12.13
      Jun  8 22:01:06 pfSense ppp: [opt1]  SECDNS 10.11.12.14
      Jun  8 22:01:06 pfSense ppp: [opt1]  PRINBNS 10.11.12.13
      Jun  8 22:01:06 pfSense ppp: [opt1]  SECNBNS 10.11.12.14
      Jun  8 22:01:06 pfSense ppp: [opt1] IPCP: SendConfigReq #2
      Jun  8 22:01:06 pfSense ppp: [opt1]  IPADDR 0.0.0.0
      Jun  8 22:01:06 pfSense ppp: [opt1]  COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
      Jun  8 22:01:06 pfSense ppp: [opt1]  PRIDNS 10.11.12.13
      Jun  8 22:01:06 pfSense ppp: [opt1]  SECDNS 10.11.12.14
      Jun  8 22:01:08 pfSense ppp: [opt1] IPCP: SendConfigReq #3
      Jun  8 22:01:08 pfSense ppp: [opt1]  IPADDR 0.0.0.0
      Jun  8 22:01:08 pfSense ppp: [opt1]  COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
      Jun  8 22:01:08 pfSense ppp: [opt1]  PRIDNS 10.11.12.13
      Jun  8 22:01:08 pfSense ppp: [opt1]  SECDNS 10.11.12.14
      Jun  8 22:01:10 pfSense ppp: [opt1] IPCP: SendConfigReq #4
      Jun  8 22:01:10 pfSense ppp: [opt1]  IPADDR 0.0.0.0
      Jun  8 22:01:10 pfSense ppp: [opt1]  COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
      Jun  8 22:01:10 pfSense ppp: [opt1]  PRIDNS 10.11.12.13
      Jun  8 22:01:10 pfSense ppp: [opt1]  SECDNS 10.11.12.14
      Jun  8 22:01:12 pfSense ppp: [opt1] IPCP: SendConfigReq #5
      Jun  8 22:01:12 pfSense ppp: [opt1]  IPADDR 0.0.0.0
      Jun  8 22:01:12 pfSense ppp: [opt1]  COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
      Jun  8 22:01:12 pfSense ppp: [opt1]  PRIDNS 10.11.12.13
      Jun  8 22:01:12 pfSense ppp: [opt1]  SECDNS 10.11.12.14
      Jun  8 22:01:14 pfSense ppp: [opt1] IPCP: SendConfigReq #6
      Jun  8 22:01:14 pfSense ppp: [opt1]  IPADDR 0.0.0.0
      Jun  8 22:01:14 pfSense ppp: [opt1]  COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
      Jun  8 22:01:14 pfSense ppp: [opt1]  PRIDNS 10.11.12.13
      Jun  8 22:01:14 pfSense ppp: [opt1]  SECDNS 10.11.12.14
      Jun  8 22:01:16 pfSense ppp: [opt1] IPCP: SendConfigReq #7
      Jun  8 22:01:16 pfSense ppp: [opt1]  IPADDR 0.0.0.0
      Jun  8 22:01:16 pfSense ppp: [opt1]  COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
      Jun  8 22:01:16 pfSense ppp: [opt1]  PRIDNS 10.11.12.13
      Jun  8 22:01:16 pfSense ppp: [opt1]  SECDNS 10.11.12.14
      Jun  8 22:01:18 pfSense ppp: [opt1] IPCP: SendConfigReq #8
      Jun  8 22:01:18 pfSense ppp: [opt1]  IPADDR 0.0.0.0
      Jun  8 22:01:18 pfSense ppp: [opt1]  COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
      Jun  8 22:01:18 pfSense ppp: [opt1]  PRIDNS 10.11.12.13
      Jun  8 22:01:18 pfSense ppp: [opt1]  SECDNS 10.11.12.14
      Jun  8 22:01:20 pfSense ppp: [opt1] IPCP: SendConfigReq #9
      Jun  8 22:01:20 pfSense ppp: [opt1]  IPADDR 0.0.0.0
      Jun  8 22:01:20 pfSense ppp: [opt1]  COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
      Jun  8 22:01:20 pfSense ppp: [opt1]  PRIDNS 10.11.12.13
      Jun  8 22:01:20 pfSense ppp: [opt1]  SECDNS 10.11.12.14
      Jun  8 22:01:22 pfSense ppp: [opt1] IPCP: SendConfigReq #10
      Jun  8 22:01:22 pfSense ppp: [opt1]  IPADDR 0.0.0.0
      Jun  8 22:01:22 pfSense ppp: [opt1]  COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
      Jun  8 22:01:22 pfSense ppp: [opt1]  PRIDNS 10.11.12.13
      Jun  8 22:01:22 pfSense ppp: [opt1]  SECDNS 10.11.12.14
      Jun  8 22:01:24 pfSense ppp: [opt1] IPCP: SendConfigReq #11
      Jun  8 22:01:24 pfSense ppp: [opt1]  IPADDR 0.0.0.0
      Jun  8 22:01:24 pfSense ppp: [opt1]  COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
      Jun  8 22:01:24 pfSense ppp: [opt1]  PRIDNS 10.11.12.13
      Jun  8 22:01:24 pfSense ppp: [opt1]  SECDNS 10.11.12.14
      Jun  8 22:01:26 pfSense ppp: [opt1] IPCP: parameter negotiation failed
      Jun  8 22:01:26 pfSense ppp: [opt1] IPCP: state change Req-Sent –> Stopped
      Jun  8 22:01:26 pfSense ppp: [opt1] IPCP: LayerFinish
      Jun  8 22:01:26 pfSense ppp: [opt1] Bundle: No NCPs left. Closing links…
      Jun  8 22:01:26 pfSense ppp: [opt1] Bundle: closing link "opt1_link0"…
      Jun  8 22:01:26 pfSense ppp: [opt1_link0] Link: CLOSE event
      Jun  8 22:01:26 pfSense ppp: [opt1_link0] LCP: Close event
      Jun  8 22:01:26 pfSense ppp: [opt1_link0] LCP: state change Opened –> Closing
      Jun  8 22:01:26 pfSense ppp: [opt1_link0] Link: Leave bundle "opt1"
      Jun  8 22:01:26 pfSense ppp: [opt1] Bundle: Status update: up 0 links, total bandwidth 9600 bps
      Jun  8 22:01:26 pfSense ppp: [opt1] IPCP: Close event
      Jun  8 22:01:26 pfSense ppp: [opt1] IPCP: state change Stopped –> Closed
      Jun  8 22:01:26 pfSense ppp: [opt1] IPCP: Down event
      Jun  8 22:01:26 pfSense ppp: [opt1] IPCP: state change Closed –> Initial
      Jun  8 22:01:26 pfSense ppp: [opt1_link0] LCP: SendTerminateReq #2
      Jun  8 22:01:26 pfSense ppp: [opt1_link0] LCP: LayerDown
      Jun  8 22:01:28 pfSense ppp: [opt1_link0] LCP: SendTerminateReq #3
      Jun  8 22:01:30 pfSense ppp: [opt1_link0] LCP: state change Closing –> Closed
      Jun  8 22:01:30 pfSense ppp: [opt1_link0] LCP: LayerFinish
      Jun  8 22:01:30 pfSense ppp: [opt1_link0] Link: DOWN event
      Jun  8 22:01:30 pfSense ppp: [opt1_link0] LCP: Down event
      Jun  8 22:01:30 pfSense ppp: [opt1_link0] LCP: state change Closed –> Initial

      Under Linux (same hardware - works perfectly):

      Jun  5 15:10:47 voip chat[21726]: abort on (BUSY)
      Jun  5 15:10:47 voip chat[21726]: abort on (NO CARRIER)
      Jun  5 15:10:47 voip chat[21726]: abort on (VOICE)
      Jun  5 15:10:47 voip chat[21726]: abort on (NO DIALTONE)
      Jun  5 15:10:47 voip chat[21726]: abort on (NO DIAL TONE)
      Jun  5 15:10:47 voip chat[21726]: abort on (NO ANSWER)
      Jun  5 15:10:47 voip chat[21726]: abort on (DELAYED)
      Jun  5 15:10:47 voip chat[21726]: send (ATZ^M)
      Jun  5 15:10:47 voip chat[21726]: expect (OK)
      Jun  5 15:10:47 voip chat[21726]: ATZ^M^M
      Jun  5 15:10:47 voip chat[21726]: OK
      Jun  5 15:10:47 voip chat[21726]:  – got it
      Jun  5 15:10:47 voip chat[21726]: send (at+cgdcont=1,"IP","internet"^M)
      Jun  5 15:10:48 voip chat[21726]: expect (OK)
      Jun  5 15:10:48 voip chat[21726]: ^M
      Jun  5 15:10:48 voip chat[21726]: at+cgdcont=1,"IP","internet"^M^M
      Jun  5 15:10:48 voip chat[21726]: OK
      Jun  5 15:10:48 voip chat[21726]:  – got it
      Jun  5 15:10:48 voip chat[21726]: send (ATDT99#^M)
      Jun  5 15:10:48 voip chat[21726]: expect (CONNECT)
      Jun  5 15:10:48 voip chat[21726]: ^M
      Jun  5 15:10:48 voip chat[21726]: ATDT      99#^M^M
      Jun  5 15:10:48 voip chat[21726]: CONNECT
      Jun  5 15:10:48 voip chat[21726]:  – got it
      Jun  5 15:10:48 voip chat[21726]: send (\d)
      Jun  5 15:10:49 voip pppd[21343]: Serial connection established.
      Jun  5 15:10:49 voip pppd[21343]: using channel 5
      Jun  5 15:10:49 voip pppd[21343]: Using interface ppp0
      Jun  5 15:10:49 voip pppd[21343]: Connect: ppp0 <–> /dev/ttyUSB0
      Jun  5 15:10:50 voip pppd[21343]: sent [LCP ConfReq id=0x3 <asyncmap 0x0=""><magic 0xa3319297=""><pcomp><accomp>]
      Jun  5 15:10:50 voip pppd[21343]: rcvd [LCP ConfReq id=0xc <asyncmap 0x0=""><auth chap="" md5=""><magic 0x10cc66f=""><pcomp><accomp>]
      Jun  5 15:10:50 voip pppd[21343]: No auth is possible
      Jun  5 15:10:50 voip pppd[21343]: sent [LCP ConfRej id=0xc <auth chap="" md5="">]
      Jun  5 15:10:50 voip pppd[21343]: rcvd [LCP ConfAck id=0x3 <asyncmap 0x0=""><magic 0xa3319297=""><pcomp><accomp>]
      Jun  5 15:10:50 voip pppd[21343]: rcvd [LCP ConfReq id=0xd <asyncmap 0x0=""><magic 0x10cc66f=""><pcomp><accomp>]
      Jun  5 15:10:50 voip pppd[21343]: sent [LCP ConfAck id=0xd <asyncmap 0x0=""><magic 0x10cc66f=""><pcomp><accomp>]
      Jun  5 15:10:50 voip pppd[21343]: sent [LCP EchoReq id=0x0 magic=0xa3319297]
      Jun  5 15:10:50 voip pppd[21343]: sent [CCP ConfReq id=0x2 <deflate 15=""><deflate(old#) 15=""><bsd 15="" v1="">]
      Jun  5 15:10:50 voip pppd[21343]: sent [IPCP ConfReq id=0x6 <compress vj="" 0f="" 01=""><addr 0.0.0.0=""><ms-dns1 0.0.0.0=""><ms-dns3 0.0.0.0="">]
      Jun  5 15:10:50 voip pppd[21343]: rcvd [LCP DiscReq id=0xe magic=0x10cc66f]
      Jun  5 15:10:50 voip pppd[21343]: rcvd [LCP EchoRep id=0x0 magic=0x10cc66f a3 31 92 97]
      Jun  5 15:10:50 voip pppd[21343]: rcvd [LCP ProtRej id=0xf 80 fd 01 02 00 0f 1a 04 78 00 18 04 78 00 15 03 2f]
      Jun  5 15:10:50 voip pppd[21343]: Protocol-Reject for 'Compression Control Protocol' (0x80fd) received
      Jun  5 15:10:51 voip pppd[21343]: rcvd [IPCP ConfNak id=0x6 <ms-dns1 10.11.12.13=""><ms-dns3 10.11.12.14=""><ms-wins 10.11.12.13=""><ms-wins 10.11.12.14="">]
      Jun  5 15:10:51 voip pppd[21343]: sent [IPCP ConfReq id=0x7 <compress vj="" 0f="" 01=""><addr 0.0.0.0=""><ms-dns1 10.11.12.13=""><ms-dns3 10.11.12.14="">]
      Jun  5 15:10:52 voip pppd[21343]: rcvd [IPCP ConfNak id=0x7 <ms-dns1 10.11.12.13=""><ms-dns3 10.11.12.14=""><ms-wins 10.11.12.13=""><ms-wins 10.11.12.14="">]
      Jun  5 15:10:52 voip pppd[21343]: sent [IPCP ConfReq id=0x8 <compress vj="" 0f="" 01=""><addr 0.0.0.0=""><ms-dns1 10.11.12.13=""><ms-dns3 10.11.12.14="">]
      Jun  5 15:10:52 voip pppd[21343]: rcvd [IPCP ConfReq id=0x6]
      Jun  5 15:10:52 voip pppd[21343]: sent [IPCP ConfNak id=0x6 <addr 0.0.0.0="">]
      Jun  5 15:10:52 voip pppd[21343]: rcvd [IPCP ConfRej id=0x8 <compress vj="" 0f="" 01="">]
      Jun  5 15:10:52 voip pppd[21343]: sent [IPCP ConfReq id=0x9 <addr 0.0.0.0=""><ms-dns1 10.11.12.13=""><ms-dns3 10.11.12.14="">]
      Jun  5 15:10:52 voip pppd[21343]: rcvd [IPCP ConfReq id=0x7]
      Jun  5 15:10:52 voip pppd[21343]: sent [IPCP ConfAck id=0x7]
      Jun  5 15:10:52 voip pppd[21343]: rcvd [IPCP ConfNak id=0x9 <addr 94.27.223.95=""><ms-dns1 84.2.46.1=""><ms-dns3 84.2.44.1="">]
      Jun  5 15:10:52 voip pppd[21343]: sent [IPCP ConfReq id=0xa <addr 94.27.223.95=""><ms-dns1 84.2.46.1=""><ms-dns3 84.2.44.1="">]
      Jun  5 15:10:52 voip pppd[21343]: rcvd [IPCP ConfAck id=0xa <addr 94.27.223.95=""><ms-dns1 84.2.46.1=""><ms-dns3 84.2.44.1="">]
      Jun  5 15:10:52 voip pppd[21343]: Could not determine remote IP address: defaulting to 10.64.64.64
      Jun  5 15:10:52 voip pppd[21343]: Cannot determine ethernet address for proxy ARP
      Jun  5 15:10:52 voip pppd[21343]: local  IP address 94.27.223.95
      Jun  5 15:10:52 voip pppd[21343]: remote IP address 10.64.64.64
      Jun  5 15:10:52 voip pppd[21343]: primary  DNS address 84.2.46.1
      Jun  5 15:10:52 voip pppd[21343]: secondary DNS address 84.2.44.1

      Please help me, what can i do to eliminate:
      "IPCP: parameter negotiation failed" problem.

      Thank You in advance!</ms-dns3></ms-dns1></addr></ms-dns3></ms-dns1></addr></ms-dns3></ms-dns1></addr></ms-dns3></ms-dns1></addr></compress></addr></ms-dns3></ms-dns1></addr></compress></ms-wins></ms-wins></ms-dns3></ms-dns1></ms-dns3></ms-dns1></addr></compress></ms-wins></ms-wins></ms-dns3></ms-dns1></ms-dns3></ms-dns1></addr></compress></bsd></deflate(old#)></deflate></accomp></pcomp></magic></asyncmap></accomp></pcomp></magic></asyncmap></accomp></pcomp></magic></asyncmap></auth></accomp></pcomp></magic></auth></asyncmap></accomp></pcomp></magic></asyncmap></huawei></huawei></data></huawei></huawei></huawei>

      1 Reply Last reply Reply Quote 0
      • First post
        Last post
      Copyright 2025 Rubicon Communications LLC (Netgate). All rights reserved.