Huawei ME909S-120 Help



  • Hi everyone,

    I'm looking for information on this ME909S-120 card, i'm trying to set it up on an apu3c since i saw it in the known working list.
    Si i looked a lot of things to be familiar with it, and i think i'm all good with the setup, but it's still not working.

    What i've done and what i'm sure :

    • connected the card on the good slot, J15 with SIM1
    • connected to the good modem port /dev/cuau0.2, or 1.2 if it changes during tests
    • looking at the ppp log carefully with clog -f /var/log/ppp.log
    • followed theses instructions here and here , debugged with this. I also looked a lot of topic on the forum about huawei cards.
    • had data about dBm and signal in interface
    • connect to the modem port in cli with the command cu -l /dev/cuaU0.2 and run some of commands
    ATI
    Manufacturer: Huawei Technologies Co., Ltd.
    Model: ME909s-120
    Revision: 11.617.09.00.00
    IMEI: 867377***********
    +GCAP: +CGSM,+DS,+ES
    
    AT+COPS?
    +COPS: 0,0,"F SFR",7
    
    AT^IPINIT?
    ^IPINIT: 0
    
    Nov 22 17:56:55 pfSense ppp: Multi-link PPP daemon for FreeBSD
    Nov 22 17:56:55 pfSense ppp:
    Nov 22 17:56:55 pfSense ppp: process 18920 started, version 5.8 (nobody@pfSense_v2_4_4_amd64-pfSense_v2_4_4-job-04 23:36  4-Sep-2018)
    Nov 22 17:56:55 pfSense ppp: web: web is not running
    Nov 22 17:56:55 pfSense ppp: [opt1] Bundle: Interface ng0 created
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] Link: OPEN event
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] LCP: Open event
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] LCP: state change Initial -->
    ``` Starting
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] LCP: LayerStart
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] CHAT: +CGDCONT=1,"IP","websfr"
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] CHAT: Detected Custom modem.
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] CHAT: Dialing server at *99#...
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] CHAT: ATDT*99#
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] CHAT: Connected at 150000000.
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] MODEM: chat script succeeded
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] Link: UP event
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] LCP: Up event
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] LCP: state change Starting --> Req-Sent
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] LCP: SendConfigReq #1
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   ACFCOMP
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   PROTOCOMP
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   ACCMAP 0x000a0000
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   MRU 1500
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   MAGICNUM 0x4eb8ccb8
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] LCP: rec'd Configure Request #1 (Req-Sent)
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   ACFCOMP
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   PROTOCOMP
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   ACCMAP 0x00000000
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   MRU 1500
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   MAGICNUM 0x00000543
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   AUTHPROTO CHAP MD5
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] LCP: SendConfigAck #1
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   ACFCOMP
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   PROTOCOMP
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   ACCMAP 0x00000000
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   MRU 1500
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   MAGICNUM 0x00000543
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   AUTHPROTO CHAP MD5
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] LCP: state change Req-Sent --> Ack-Sent
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] LCP: rec'd Configure Ack #1 (Ack-Sent)
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   ACFCOMP
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   PROTOCOMP
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   ACCMAP 0x000a0000
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   MRU 1500
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   MAGICNUM 0x4eb8ccb8
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] LCP: state change Ack-Sent --> Opened
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] LCP: auth: peer wants CHAP, I want nothing
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] LCP: LayerUp
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] CHAP: rec'd CHALLENGE #1 len: 37
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   Name: "HUAWEI_CHAP_SRVR"
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] CHAP: Using authname "user"
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] CHAP: sending RESPONSE #1 len: 25
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] CHAP: rec'd SUCCESS #1 len: 13
    Nov 22 17:56:55 pfSense ppp: [opt1_link0]   MESG: Welcome!!
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] LCP: authorization successful
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] Link: Matched action 'bundle "opt1" ""'
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] Link: Join bundle "opt1"
    Nov 22 17:56:55 pfSense ppp: [opt1] Bundle: Status update: up 1 link, total bandwidth 150000000 bps
    Nov 22 17:56:55 pfSense ppp: [opt1] IPCP: Open event
    Nov 22 17:56:55 pfSense ppp: [opt1] IPCP: state change Initial --> Starting
    Nov 22 17:56:55 pfSense ppp: [opt1] IPCP: LayerStart
    Nov 22 17:56:55 pfSense ppp: [opt1] IPV6CP: Open event
    Nov 22 17:56:55 pfSense ppp: [opt1] IPV6CP: state change Initial --> Starting
    Nov 22 17:56:55 pfSense ppp: [opt1] IPV6CP: LayerStart
    Nov 22 17:56:55 pfSense ppp: [opt1] IPCP: Up event
    Nov 22 17:56:55 pfSense ppp: [opt1] IPCP: state change Starting --> Req-Sent
    Nov 22 17:56:55 pfSense ppp: [opt1] IPCP: SendConfigReq #1
    Nov 22 17:56:55 pfSense ppp: [opt1]   IPADDR 0.0.0.0
    Nov 22 17:56:55 pfSense ppp: [opt1]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
    Nov 22 17:56:55 pfSense ppp: [opt1]   PRIDNS 0.0.0.0
    Nov 22 17:56:55 pfSense ppp: [opt1]   SECDNS 0.0.0.0
    Nov 22 17:56:55 pfSense ppp: [opt1] IPV6CP: Up event
    Nov 22 17:56:55 pfSense ppp: [opt1] IPV6CP: state change Starting --> Req-Sent
    Nov 22 17:56:55 pfSense ppp: [opt1] IPV6CP: SendConfigReq #1
    Nov 22 17:56:55 pfSense ppp: [opt1] IPCP: rec'd Configure Request #1 (Req-Sent)
    Nov 22 17:56:55 pfSense ppp: [opt1] IPCP: SendConfigAck #1
    Nov 22 17:56:55 pfSense ppp: [opt1] IPCP: state change Req-Sent --> Ack-Sent
    Nov 22 17:56:55 pfSense ppp: [opt1] IPCP: rec'd Configure Nak #1 (Ack-Sent)
    Nov 22 17:56:55 pfSense ppp: [opt1] IPCP: SendConfigReq #2
    Nov 22 17:56:55 pfSense ppp: [opt1]   IPADDR 0.0.0.0
    Nov 22 17:56:55 pfSense ppp: [opt1]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
    Nov 22 17:56:55 pfSense ppp: [opt1]   PRIDNS 0.0.0.0
    Nov 22 17:56:55 pfSense ppp: [opt1]   SECDNS 0.0.0.0
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] LCP: rec'd Protocol Reject #2 (Opened)
    Nov 22 17:56:55 pfSense ppp: [opt1_link0] LCP: protocol IPV6CP was rejected
    Nov 22 17:56:55 pfSense ppp: [opt1] IPV6CP: protocol was rejected by peer
    Nov 22 17:56:55 pfSense ppp: [opt1] IPV6CP: state change Req-Sent --> Stopped
    Nov 22 17:56:55 pfSense ppp: [opt1] IPV6CP: LayerFinish
    Nov 22 17:56:57 pfSense ppp: [opt1] IPCP: SendConfigReq #3
    Nov 22 17:56:57 pfSense ppp: [opt1]   IPADDR 0.0.0.0
    Nov 22 17:56:57 pfSense ppp: [opt1]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
    Nov 22 17:56:57 pfSense ppp: [opt1]   PRIDNS 0.0.0.0
    Nov 22 17:56:57 pfSense ppp: [opt1]   SECDNS 0.0.0.0
    Nov 22 17:56:59 pfSense ppp: [opt1] IPCP: SendConfigReq #4
    Nov 22 17:56:59 pfSense ppp: [opt1]   IPADDR 0.0.0.0
    Nov 22 17:56:59 pfSense ppp: [opt1]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
    Nov 22 17:56:59 pfSense ppp: [opt1]   PRIDNS 0.0.0.0
    Nov 22 17:56:59 pfSense ppp: [opt1]   SECDNS 0.0.0.0
    Nov 22 17:57:01 pfSense ppp: [opt1] IPCP: SendConfigReq #5
    Nov 22 17:57:01 pfSense ppp: [opt1]   IPADDR 0.0.0.0
    Nov 22 17:57:01 pfSense ppp: [opt1]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
    Nov 22 17:57:01 pfSense ppp: [opt1]   PRIDNS 0.0.0.0
    Nov 22 17:57:01 pfSense ppp: [opt1]   SECDNS 0.0.0.0
    Nov 22 17:57:03 pfSense ppp: [opt1] IPCP: SendConfigReq #6
    Nov 22 17:57:03 pfSense ppp: [opt1]   IPADDR 0.0.0.0
    Nov 22 17:57:03 pfSense ppp: [opt1]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
    Nov 22 17:57:03 pfSense ppp: [opt1]   PRIDNS 0.0.0.0
    Nov 22 17:57:03 pfSense ppp: [opt1]   SECDNS 0.0.0.0
    Nov 22 17:57:05 pfSense ppp: [opt1] IPCP: SendConfigReq #7
    Nov 22 17:57:05 pfSense ppp: [opt1]   IPADDR 0.0.0.0
    Nov 22 17:57:05 pfSense ppp: [opt1]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
    Nov 22 17:57:05 pfSense ppp: [opt1]   PRIDNS 0.0.0.0
    Nov 22 17:57:05 pfSense ppp: [opt1]   SECDNS 0.0.0.0
    Nov 22 17:57:07 pfSense ppp: [opt1] IPCP: SendConfigReq #8
    Nov 22 17:57:07 pfSense ppp: [opt1]   IPADDR 0.0.0.0
    Nov 22 17:57:07 pfSense ppp: [opt1]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
    Nov 22 17:57:07 pfSense ppp: [opt1]   PRIDNS 0.0.0.0
    Nov 22 17:57:07 pfSense ppp: [opt1]   SECDNS 0.0.0.0
    Nov 22 17:57:09 pfSense ppp: [opt1] IPCP: SendConfigReq #9
    Nov 22 17:57:09 pfSense ppp: [opt1]   IPADDR 0.0.0.0
    Nov 22 17:57:09 pfSense ppp: [opt1]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
    Nov 22 17:57:09 pfSense ppp: [opt1]   PRIDNS 0.0.0.0
    Nov 22 17:57:09 pfSense ppp: [opt1]   SECDNS 0.0.0.0
    Nov 22 17:57:11 pfSense ppp: [opt1] IPCP: SendConfigReq #10
    Nov 22 17:57:11 pfSense ppp: [opt1]   IPADDR 0.0.0.0
    Nov 22 17:57:11 pfSense ppp: [opt1]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
    Nov 22 17:57:11 pfSense ppp: [opt1]   PRIDNS 0.0.0.0
    Nov 22 17:57:11 pfSense ppp: [opt1]   SECDNS 0.0.0.0
    Nov 22 17:57:13 pfSense ppp: [opt1] IPCP: SendConfigReq #11
    Nov 22 17:57:13 pfSense ppp: [opt1]   IPADDR 0.0.0.0
    Nov 22 17:57:13 pfSense ppp: [opt1]   COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
    Nov 22 17:57:13 pfSense ppp: [opt1]   PRIDNS 0.0.0.0
    Nov 22 17:57:13 pfSense ppp: [opt1]   SECDNS 0.0.0.0
    Nov 22 17:57:15 pfSense ppp: [opt1] IPCP: parameter negotiation failed
    Nov 22 17:57:15 pfSense ppp: [opt1] IPCP: state change Ack-Sent --> Stopped
    Nov 22 17:57:15 pfSense ppp: [opt1] IPCP: LayerFinish
    Nov 22 17:57:15 pfSense ppp: [opt1] Bundle: No NCPs left. Closing links...
    Nov 22 17:57:15 pfSense ppp: [opt1] Bundle: closing link "opt1_link0"...
    Nov 22 17:57:15 pfSense ppp: [opt1_link0] Link: CLOSE event
    Nov 22 17:57:15 pfSense ppp: [opt1_link0] LCP: Close event
    Nov 22 17:57:15 pfSense ppp: [opt1_link0] LCP: state change Opened --> Closing
    Nov 22 17:57:15 pfSense ppp: [opt1_link0] Link: Leave bundle "opt1"
    Nov 22 17:57:15 pfSense ppp: [opt1] Bundle: Status update: up 0 links, total bandwidth 9600 bps
    Nov 22 17:57:15 pfSense ppp: [opt1] IPCP: Close event
    Nov 22 17:57:15 pfSense ppp: [opt1] IPCP: state change Stopped --> Closed
    Nov 22 17:57:15 pfSense ppp: [opt1] IPV6CP: Close event
    Nov 22 17:57:15 pfSense ppp: [opt1] IPV6CP: state change Stopped --> Closed
    Nov 22 17:57:15 pfSense ppp: [opt1] IPCP: Down event
    Nov 22 17:57:15 pfSense ppp: [opt1] IPCP: state change Closed --> Initial
    Nov 22 17:57:15 pfSense ppp: [opt1] IPV6CP: Down event
    Nov 22 17:57:15 pfSense ppp: [opt1] IPV6CP: state change Closed --> Initial
    Nov 22 17:57:15 pfSense ppp: [opt1_link0] LCP: SendTerminateReq #2
    Nov 22 17:57:15 pfSense ppp: [opt1_link0] LCP: LayerDown
    Nov 22 17:57:17 pfSense ppp: [opt1_link0] LCP: SendTerminateReq #3
    Nov 22 17:57:19 pfSense ppp: [opt1_link0] LCP: state change Closing --> Closed
    Nov 22 17:57:19 pfSense ppp: [opt1_link0] LCP: LayerFinish
    Nov 22 17:57:19 pfSense ppp: [opt1_link0] Link: DOWN event
    Nov 22 17:57:19 pfSense ppp: [opt1_link0] LCP: Down event
    Nov 22 17:57:19 pfSense ppp: [opt1_link0] LCP: state change Closed --> Initial
    

    And here i am. I think there's a problem with the APN declaration since i can't get an ip address but i have no clue why.
    I called my provider when i tested the sim card on a cellphone and saw it wasn't working, and it was because it's a data only simcard and the APN wasn't the default usually used on classic plan. It set up the APN as the guy told me and it worked well, so i set up this same APN in the PPP configuration but nothing...

    Does someone have an idea ? I'm out of option, maybe a firmware upgrade on the card ?

    Version 2.4.4-RELEASE (amd64)
    built on Thu Sep 20 09:03:12 EDT 2018
    FreeBSD 11.2-RELEASE-p3


  • Netgate Administrator

    @lachagnasse said in Huawei ME909S-120 Help:

    /dev/cuau0.2

    That must be something USB connected like /dev/cuaU0.2 but I assume that's a typo since the port is working.

    It looks like it's just failing to negotiate a connection with the provider.

    I assume when you tested it in your phone it was not using PPP? Can you test PPP with it in anything else?

    Steve



  • @stephenw10

    Yes it's a typo. To be honnest i'm not familiar with this type of connection, on the phone i just set up the APN with the name and that's all.
    I just tried to put the sim in a router we got and it works fine :
    0_1543224940013_data.jpg


  • Netgate Administrator

    Can you get any logs from that? See how it's connecting?

    It may well be using MBIM which avoids PPP. It could be simply that your provider doesn't support PPP or at least not the options pfSense requires. Though that would be unusual. I have no problem connecting here in the UK for example.
    Are you able to test a different carrier?

    Steve



  • @stephenw10 So, we tested another carrier (Orange voice + data) and another sim card on a regular plan (SFR voice + data) and the two of them worked very well, it is the data plan only (SFR data only) which isn't working on our Pfsense.
    The data sim card is also the only one without pin code fiy
    Do you still need information about MBIM on the Dlink ? Is it something carrier side or something with this APN in pfsense ?

    Edit : enabled PIN on data sim card, doesn't work either


  • Netgate Administrator

    It is failing to negotiate with that particular carrier on a PPP connection. I expect the d-link is not using PPP but if it is then we might be able to see what it's doing differently.
    It's interesting that the SFR voice+data connection did work. You might be able to compare the PPP logs to see exactly what differs there.
    The scope for changing what pfSense does here is limited though.

    Steve



  • Here are the log for the two SIM card1_1544031931739_sfr_regular.txt 0_1544031931739_sfr_data.txt