Skip to content

Add necessary configs to support the EP_AGORA target #163

New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Merged
merged 4 commits into from
Oct 8, 2019

Conversation

trowbridgec
Copy link

This PR adds support for the Embedded Planet EP_AGORA target to this example app.

Relies on ARMmbed/mbed-os#11566

@trowbridgec
Copy link
Author

@ARMmbed/team-embeddedplanet @maclobdell

@40Grit
Copy link

40Grit commented Sep 26, 2019

| So, I guess you could argue we don't need to
| remove the CORDIO labels if we're already
| removing the BLE feature, but it doesn't hurt.

And if we do need to remove those features here, id say lets make the smallest change possible to keep our UX clean.

Copy link

@AnttiKauppila AnttiKauppila left a comment

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

For me it seems that none of those values are needed. Or is EP_AGORA IPv6 only (IPv4 not supported at all)? Our examples are very generic so we don't optimise in this level for any other targets either.

@trowbridgec
Copy link
Author

trowbridgec commented Sep 26, 2019

@AnttiKauppila I'm not certain why, but the example failed if I didn't enable IPv6. Could be because we set the cellular_properties for the Telit ME910 driver to enable the IPV6 and IPV4V6 stacks (see here):

static const intptr_t cellular_properties[AT_CellularBase::PROPERTY_MAX] = {
    AT_CellularNetwork::RegistrationModeLAC,    // C_EREG
    AT_CellularNetwork::RegistrationModeLAC,    // C_GREG
    AT_CellularNetwork::RegistrationModeLAC,    // C_REG
    0,  // AT_CGSN_WITH_TYPE
    0,  // AT_CGDATA
    1,  // AT_CGAUTH
    1,  // AT_CNMI
    1,  // AT_CSMP
    1,  // AT_CMGF
    1,  // AT_CSDH
    1,  // PROPERTY_IPV4_STACK
    1,  // PROPERTY_IPV6_STACK
    1,  // PROPERTY_IPV4V6_STACK
    0,  // PROPERTY_NON_IP_PDP_TYPE
    1,  // PROPERTY_AT_CGEREP
};

The Telit ME910 module we're using does support IPv6, so I would argue that it doesn't hurt to turn it on for our target.

@AnttiKauppila
Copy link

@trowbridgec You should of course enable IPv6 when needed, but your application config is not general for all users. There might be some other AGORA user who needs IPv4 with some different shield. We have chosen IPv4 as a default value for this example application and developers can override that value if needed.

@AnttiKauppila
Copy link

Also there is no more FEATURE_LWIP so no need to set "target.features_add". Or are you using some older version of Mbed OS which still has it?

@40Grit
Copy link

40Grit commented Sep 27, 2019

I would say this PR is a testament to the entire reason this example is now the default Pelion example.

Pending ARMmbed/mbed-os#11566, if this PR is closed and the example builds for EP_AGORA then this has all been an excellent thought experiment.

@40Grit
Copy link

40Grit commented Sep 27, 2019

Oh this is the cellular example... either way, good thought experiment

@trowbridgec
Copy link
Author

@AnttiKauppila Thanks for the hint regarding FEATURE_LWIP. I removed that line, and the example still works.

Regarding the lwip.ipv6-enabled setting, I agree with you that it shouldn't be necessary, but the example does not work if I don't set it to true.

With lwip.ipv6-enabled set to true:

mbed-os-example-cellular


Built: Sep 27 2019, 08:22:47
Establishing connection
........

Connection Established.
TCP: connected with echo.mbedcloudtesting.com server
TCP: Sent 4 Bytes to echo.mbedcloudtesting.com
Received from echo server 4 Bytes


Success. Exiting

Without lwip.ipv6-enabled set to true:

mbed-os-example-cellular


Built: Sep 27 2019, 08:28:25
Establishing connection
........

Connection Established.
Couldn't resolve remote host: echo.mbedcloudtesting.com, code: -3009


Failure. Exiting

Any thoughts as to why that might be happening?

@AnttiKauppila
Copy link

@trowbridgec I think that is a real issue because the modem supports both IPv4 and 6 and DNS resolving fails for IPv4. This needs to be investigated
@ARMmbed/mbed-os-wan

@trowbridgec
Copy link
Author

@AnttiKauppila Can we merge this PR in until the issue was been investigated (then we can remove the setting lwip.ipv6-enabled)?

@AriParkkila
Copy link

I think IPv6 should always be enabled on cellular. Can you provide AT debug logs?

@trowbridgec
Copy link
Author

@AriParkkila

With lwip.ipv6-enabled set to true:

mbed-os-example-cellular


Built: Sep 27 2019, 11:09:29
Establishing connection
[00000001ms][DBG ][CELL]: Modem flow control: RTS 14 CTS 40
[00000003ms][INFO][CELL]: New CellularContext  (0x2000a300)
[00000004ms][INFO][CELL]: CellularContext connect
[00000006ms][DBG ][CELL]: callback: 4106, err: 0, data: 4096
[00000014ms][INFO][CELL]: Start connecting (timeout 1000 ms)
[00000022ms][INFO][CELL]: AT TX ( 2): AT
[00000029ms][INFO][CELL]: AT TX ( 1): <cr>
[00001023ms][DBG ][CELL]: AT error -3012
[00001023ms][INFO][CELL]: AT TX ( 2): AT
[00001024ms][INFO][CELL]: AT TX ( 1): <cr>
[00002024ms][DBG ][CELL]: AT error -3012
[00002024ms][DBG ][CELL]: Init => Power
[00002025ms][DBG ][CELL]: callback: 4106, err: 0, data: 4096
[00002027ms][INFO][CELL]: Modem power ON (timeout 1000 ms)
[00002028ms][DBG ][CELL]: Power => Device ready
[00002032ms][DBG ][CELL]: callback: 4106, err: 0, data: 4096
[00002041ms][DBG ][CELL]: Device was not ready, calling soft_power_on()
[00027250ms][DBG ][CELL]: AT flush
[00027251ms][INFO][CELL]: AT RX (32): AT<cr><cr><ln>OK<cr><ln><cr><ln>#QSS: 1<cr                                                                                                                                                             ><ln><cr><ln>+PACSP0<cr><ln><cr>
[00027253ms][INFO][CELL]: AT RX (11): <ln>#PSNT: 4<cr><ln>
[00027254ms][INFO][CELL]: AT TX ( 4): ATE0
[00027257ms][INFO][CELL]: AT TX ( 1): <cr>
[00027263ms][INFO][CELL]: AT RX (11): ATE0<cr><cr><ln>OK<cr><ln>
[00027292ms][INFO][CELL]: AT TX ( 9): AT+CMEE=1
[00027293ms][INFO][CELL]: AT TX ( 1): <cr>
[00027299ms][INFO][CELL]: AT RX ( 6): <cr><ln>OK<cr><ln>
[00027320ms][INFO][CELL]: AT TX ( 9): AT+CFUN=1
[00027321ms][INFO][CELL]: AT TX ( 1): <cr>
[00027327ms][INFO][CELL]: AT RX ( 6): <cr><ln>OK<cr><ln>
[00027348ms][INFO][CELL]: AT TX (13): AT&K3;&C1;&D0
[00027349ms][INFO][CELL]: AT TX ( 1): <cr>
[00027356ms][INFO][CELL]: AT RX ( 6): <cr><ln>OK<cr><ln>
[00027377ms][INFO][CELL]: AT TX ( 8): AT#QSS=1
[00027378ms][INFO][CELL]: AT TX ( 1): <cr>
[00027384ms][INFO][CELL]: AT RX ( 4): <cr><ln>OK
[00027385ms][INFO][CELL]: AT RX ( 2): <cr><ln>
[00027406ms][INFO][CELL]: AT TX ( 9): AT#PSNT=1
[00027407ms][INFO][CELL]: AT TX ( 1): <cr>
[00027414ms][INFO][CELL]: AT RX ( 6): <cr><ln>OK<cr><ln>
[00027435ms][INFO][CELL]: AT TX ( 9): AT+CMER=2
[00027436ms][INFO][CELL]: AT TX ( 1): <cr>
[00027442ms][INFO][CELL]: AT RX ( 4): <cr><ln>OK
[00027443ms][INFO][CELL]: AT RX ( 2): <cr><ln>
[00027464ms][INFO][CELL]: AT TX ( 9): AT+CMEE=2
[00027465ms][INFO][CELL]: AT TX ( 1): <cr>
[00027471ms][INFO][CELL]: AT RX ( 6): <cr><ln>OK<cr><ln>
[00027492ms][INFO][CELL]: AT TX (12): AT#PORTCFG=3
[00027493ms][INFO][CELL]: AT TX ( 1): <cr>
[00027514ms][INFO][CELL]: AT RX ( 1): <cr>
[00027515ms][INFO][CELL]: AT RX ( 5): <ln>OK<cr><ln>
[00027536ms][INFO][CELL]: AT TX ( 6): AT&W&P
[00027537ms][INFO][CELL]: AT TX ( 1): <cr>
[00027621ms][INFO][CELL]: AT RX ( 5): <cr><ln>OK<cr>
[00027622ms][INFO][CELL]: AT RX ( 1): <ln>
[00027623ms][INFO][CELL]: Modem ready
[00027624ms][DBG ][CELL]: callback: 4096, err: 0, data: 4096
[00027625ms][DBG ][CELL]: Device ready => SIM pin
[00027629ms][DBG ][CELL]: callback: 4106, err: 0, data: 4097
[00027638ms][INFO][CELL]: Setup SIM (timeout 1000 ms)
[00027645ms][DBG ][CELL]: AT flush
[00027651ms][INFO][CELL]: AT TX ( 8): AT+CPIN?
[00027658ms][INFO][CELL]: AT TX ( 1): <cr>
[00027664ms][INFO][CELL]: AT RX (22): <cr><ln>+CPIN: READY<cr><ln><cr><ln>OK<cr>                                                                                                                                                             <ln>
[00027675ms][INFO][CELL]: SIM is ready
[00027681ms][DBG ][CELL]: callback: 4097, err: 0, data: 0
[00027689ms][DBG ][CELL]: Automatic network registration
[00027697ms][INFO][CELL]: AT TX ( 8): AT+COPS?
[00027704ms][INFO][CELL]: AT TX ( 1): <cr>
[00027711ms][INFO][CELL]: AT RX (18): <cr><ln>+COPS: 0,0,"AT&T
[00027719ms][INFO][CELL]: AT RX (11): ",8<cr><ln><cr><ln>OK<cr><ln>
[00027729ms][DBG ][CELL]: STM: set_registration: 0, plmn: NULL
[00027749ms][INFO][CELL]: AT TX ( 9): AT+CEREG=
[00027750ms][INFO][CELL]: AT TX ( 1): 2
[00027751ms][INFO][CELL]: AT TX ( 1): <cr>
[00027757ms][INFO][CELL]: AT RX ( 6): <cr><ln>OK<cr><ln>
[00027785ms][INFO][CELL]: AT TX ( 9): AT+CGREG=
[00027786ms][INFO][CELL]: AT TX ( 1): 2
[00027787ms][INFO][CELL]: AT TX ( 1): <cr>
[00027791ms][INFO][CELL]: AT RX ( 6): <cr><ln>OK<cr><ln>
[00027813ms][INFO][CELL]: AT TX ( 8): AT+CREG=
[00027814ms][INFO][CELL]: AT TX ( 1): 2
[00027815ms][INFO][CELL]: AT TX ( 1): <cr>
[00027818ms][INFO][CELL]: AT RX ( 4): <cr><ln>OK
[00027819ms][INFO][CELL]: AT RX ( 2): <cr><ln>
[00027846ms][INFO][CELL]: AT TX ( 9): AT+CGACT?
[00027847ms][INFO][CELL]: AT TX ( 1): <cr>
[00027852ms][INFO][CELL]: AT RX ( 4): <cr><ln>+C
[00027855ms][INFO][CELL]: AT RX (30): GACT: 1,1<cr><ln>+CGACT: 2,0<cr><ln>+CGACT
[00027859ms][DBG ][CELL]: Found active context
[00027865ms][INFO][CELL]: AT RX (26): : 3,0<cr><ln>+CGACT: 4,0<cr><ln>+CGACT
[00027875ms][INFO][CELL]: AT RX (26): : 5,0<cr><ln>+CGACT: 6,0<cr><ln><cr><ln>OK                                                                                                                                                             <cr><ln>
[00027887ms][DBG ][CELL]: Active context found.
[00027907ms][INFO][CELL]: AT TX ( 9): AT+CGATT?
[00027908ms][INFO][CELL]: AT TX ( 1): <cr>
[00027914ms][INFO][CELL]: AT RX ( 4): <cr><ln>+C
[00027916ms][INFO][CELL]: AT RX (15): GATT: 1<cr><ln><cr><ln>OK<cr><ln>
[00027924ms][DBG ][CELL]: Cellular already attached.
[00027944ms][INFO][CELL]: AT TX (10): AT+CGEREP=
[00027945ms][INFO][CELL]: AT TX ( 1): 1
[00027946ms][INFO][CELL]: AT TX ( 1): <cr>
[00027951ms][INFO][CELL]: AT RX ( 6): <cr><ln>OK<cr><ln>
[00027959ms][DBG ][CELL]: SIM pin => Signal quality
[00027979ms][INFO][CELL]: AT TX ( 6): AT+CSQ
[00027980ms][INFO][CELL]: AT TX ( 1): <cr>
[00027986ms][INFO][CELL]: AT RX (14): <cr><ln>+CSQ: 24,5<cr><ln>
[00027989ms][INFO][CELL]: AT RX ( 6): <cr><ln>OK<cr><ln>
[00027997ms][DBG ][CELL]: callback: 4104, err: 0, data: -1
[00028005ms][DBG ][CELL]: Signal quality => Registering network
[00028017ms][INFO][CELL]: AT TX ( 6): AT+CSQ
[00028021ms][INFO][CELL]: AT TX ( 1): <cr>
[00028027ms][INFO][CELL]: AT RX (20): <cr><ln>+CSQ: 24,5<cr><ln><cr><ln>OK<cr><l                                                                                                                                                             n>
[00028038ms][DBG ][CELL]: callback: 4104, err: 0, data: -1
[00028046ms][INFO][CELL]: RSSI -65 dBm
[00028052ms][DBG ][CELL]: callback: 4106, err: 0, data: 4098
[00028061ms][INFO][CELL]: AT TX ( 9): AT+CEREG?
[00028068ms][INFO][CELL]: AT TX ( 1): <cr>
[00028075ms][INFO][CELL]: AT RX (32): <cr><ln>+CEREG: 2,1,"5304","2986711",8
[00028084ms][INFO][CELL]: AT RX ( 8): <cr><ln><cr><ln>OK<cr><ln>
[00028093ms][DBG ][CELL]: +CEREG: RegisteredHomeNetwork, LAC 21252, cell 4354228                                                                                                                                                             9, CATM1
[00028105ms][DBG ][CELL]: callback: 4098, err: 0, data: 1
[00028113ms][INFO][CELL]: Registering network => Attaching network
[00028125ms][INFO][CELL]: AT TX ( 6): AT+CSQ
[00028129ms][INFO][CELL]: AT TX ( 1): <cr>
[00028135ms][INFO][CELL]: AT RX (20): <cr><ln>+CSQ: 24,5<cr><ln><cr><ln>OK<cr><l                                                                                                                                                             n>
[00028146ms][DBG ][CELL]: callback: 4104, err: 0, data: -1
[00028154ms][INFO][CELL]: RSSI -65 dBm
[00028160ms][DBG ][CELL]: callback: 4106, err: 0, data: 4102
[00028169ms][INFO][CELL]: Attaching network (timeout 60000 ms)
[00028177ms][INFO][CELL]: AT TX ( 9): AT+CGATT?
[00028184ms][INFO][CELL]: AT TX ( 1): <cr>
[00028191ms][INFO][CELL]: AT RX (19): <cr><ln>+CGATT: 1<cr><ln><cr><ln>OK<cr><ln                                                                                                                                                             >
[00028202ms][DBG ][CELL]: callback: 4102, err: 0, data: 1
[00028222ms][INFO][CELL]: AT TX (11): AT+CGDCONT?
[00028223ms][INFO][CELL]: AT TX ( 1): <cr>
[00028234ms][INFO][CELL]: AT RX ( 6): <cr><ln>+CGD
[00028238ms][INFO][CELL]: AT RX (28): CONT: 1,"IPV4V6","","0.0.0.0
[00028242ms][INFO][CELL]: AT RX (32): .0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,
[00028251ms][INFO][CELL]: AT RX (32): 0<cr><ln>+CGDCONT: 2,"IPV4V6","","0.0.
[00028260ms][INFO][CELL]: AT RX ( 3): 0.0
[00028267ms][ERR ][CELL]: AT overflow
[00028273ms][INFO][CELL]: AT ERR (32): +CGDCONT: 2,"IPV4V6","","0.0.0.0
[00028283ms][INFO][CELL]: AT RX (32): .0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,
[00028292ms][ERR ][CELL]: AT overflow
[00028298ms][INFO][CELL]: AT ERR (32): .0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,
[00028308ms][INFO][CELL]: AT RX (32): 0<cr><ln>+CGDCONT: 3,"IPV4V6","","0.0.
[00028318ms][INFO][CELL]: AT RX ( 3): 0.0
[00028324ms][ERR ][CELL]: AT overflow
[00028330ms][INFO][CELL]: AT ERR (32): +CGDCONT: 3,"IPV4V6","","0.0.0.0
[00028340ms][INFO][CELL]: AT RX (32): .0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,
[00028349ms][ERR ][CELL]: AT overflow
[00028355ms][INFO][CELL]: AT ERR (32): .0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,
[00028365ms][INFO][CELL]: AT RX (32): 0<cr><ln>+CGDCONT: 4,"IPV4V6","","0.0.
[00028375ms][INFO][CELL]: AT RX ( 3): 0.0
[00028382ms][ERR ][CELL]: AT overflow
[00028387ms][INFO][CELL]: AT ERR (32): +CGDCONT: 4,"IPV4V6","","0.0.0.0
[00028397ms][INFO][CELL]: AT RX (32): .0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,
[00028407ms][ERR ][CELL]: AT overflow
[00028413ms][INFO][CELL]: AT ERR (32): .0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,
[00028422ms][INFO][CELL]: AT RX (32): 0<cr><ln>+CGDCONT: 5,"IPV4V6","","0.0.
[00028432ms][INFO][CELL]: AT RX ( 3): 0.0
[00028439ms][ERR ][CELL]: AT overflow
[00028445ms][INFO][CELL]: AT ERR (32): +CGDCONT: 5,"IPV4V6","","0.0.0.0
[00028454ms][INFO][CELL]: AT RX (32): .0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,
[00028464ms][ERR ][CELL]: AT overflow
[00028470ms][INFO][CELL]: AT ERR (32): .0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,
[00028479ms][INFO][CELL]: AT RX (32): 0<cr><ln>+CGDCONT: 6,"IPV4V6","","0.0.
[00028490ms][INFO][CELL]: AT RX ( 3): 0.0
[00028496ms][ERR ][CELL]: AT overflow
[00028502ms][INFO][CELL]: AT ERR (32): +CGDCONT: 6,"IPV4V6","","0.0.0.0
[00028512ms][INFO][CELL]: AT RX (20): .0.0.0.0.0.0.0.0.0.0
[00088211ms][DBG ][CELL]: AT error -3012
[00088211ms][INFO][CELL]: Found PDP context 1
[00088212ms][DBG ][CELL]: AT OoB readable 0, len 20
[00088233ms][DBG ][CELL]: AT OoB done
[00088233ms][INFO][CELL]: CellularContext PPP connect
[00088235ms][INFO][CELL]: AT TX ( 9): ATD*99***
[00088236ms][INFO][CELL]: AT TX ( 1): 1
[00088237ms][INFO][CELL]: AT TX ( 1): #
[00088238ms][INFO][CELL]: AT TX ( 1): <cr>
[00088245ms][INFO][CELL]: AT RX (16): <cr><ln>CONNECT 150000
[00088462ms][DBG ][CELL]: ppp_status_cb: event 0, ptr 3
[00088466ms][DBG ][CELL]: callback: 0, ptr: 3
[00093523ms][DBG ][CELL]: ppp_status_cb: event 0, ptr 1
[00093524ms][DBG ][CELL]: callback: 0, ptr: 1
[00093524ms][INFO][CELL]: CellularContext IP 10.33.137.164
[00098526ms][INFO][CELL]: Cellular local IP: 10.33.137.164


Connection Established.
[00098529ms][DBG ][CELL]: process_oob, filehandle is not usable, return...
[00098531ms][DBG ][CELL]: process_oob, filehandle is not usable, return...
TCP: connected with echo.mbedcloudtesting.com server
TCP: Sent 4 Bytes to echo.mbedcloudtesting.com
Received from echo server 4 Bytes
[00100882ms][INFO][CELL]: CellularContext disconnect()
[00100883ms][DBG ][CELL]: ppp_status_cb: event 0, ptr 2
[00100893ms][DBG ][CELL]: AT sync
[00100894ms][INFO][CELL]: AT TX ( 8): AT+CMEE?
[00100896ms][INFO][CELL]: AT TX ( 1): <cr>
[00101895ms][DBG ][CELL]: AT error -3012
[00101896ms][INFO][CELL]: AT RX (11): <cr><ln>NO CARRIE
[00101897ms][INFO][CELL]: AT RX ( 3): R<cr><ln>
[00101898ms][WARN][CELL]: AT timeout
[00101899ms][DBG ][CELL]: AT error -3012
[00101900ms][DBG ][CELL]: consume_to_tag not found
[00101908ms][DBG ][CELL]: AT stop tag not found
[00101914ms][DBG ][CELL]: AT error -3012
[00101920ms][WARN][CELL]: AT timeout
[00101926ms][DBG ][CELL]: AT error -3012
[00101932ms][DBG ][CELL]: consume_to_tag not found
[00101939ms][DBG ][CELL]: AT stop tag not found
[00101945ms][DBG ][CELL]: AT error -3012
[00101951ms][INFO][CELL]: AT TX ( 8): AT+CMEE?
[00101958ms][INFO][CELL]: AT TX ( 1): <cr>
[00101964ms][INFO][CELL]: AT RX (18): <cr><ln>+CMEE: 2<cr><ln><cr><ln>OK<cr><ln>
[00101974ms][DBG ][CELL]: callback: 0, ptr: 2
[00101981ms][INFO][CELL]: cellular_callback: PPP mode and NSAPI_STATUS_DISCONNECTED
[00101991ms][DBG ][CELL]: AT sync
[00101996ms][INFO][CELL]: AT TX ( 8): AT+CMEE?
[00102003ms][INFO][CELL]: AT TX ( 1): <cr>
[00102009ms][INFO][CELL]: AT RX (18): <cr><ln>+CMEE: 2<cr><ln><cr><ln>OK<cr><ln>
[00102019ms][INFO][CELL]: CellularContext disconnected


Success. Exiting

Without lwip.ipv6-enabled set to true:

mbed-os-example-cellular


Built: Oct  1 2019, 16:36:27
Establishing connection
[00000001ms][DBG ][CELL]: Modem flow control: RTS 14 CTS 40
[00000003ms][INFO][CELL]: New CellularContext  (0x20009b20)
[00000004ms][INFO][CELL]: CellularContext connect
[00000006ms][DBG ][CELL]: callback: 4106, err: 0, data: 4096
[00000014ms][INFO][CELL]: Start connecting (timeout 1000 ms)
[00000022ms][INFO][CELL]: AT TX ( 2): AT
[00000029ms][INFO][CELL]: AT TX ( 1): <cr>
[00001023ms][DBG ][CELL]: AT error -3012
[00001023ms][INFO][CELL]: AT TX ( 2): AT
[00001024ms][INFO][CELL]: AT TX ( 1): <cr>
[00002024ms][DBG ][CELL]: AT error -3012
[00002024ms][DBG ][CELL]: Init => Power
[00002025ms][DBG ][CELL]: callback: 4106, err: 0, data: 4096
[00002027ms][INFO][CELL]: Modem power ON (timeout 1000 ms)
[00002028ms][DBG ][CELL]: Power => Device ready
[00002032ms][DBG ][CELL]: callback: 4106, err: 0, data: 4096
[00002041ms][DBG ][CELL]: Device was not ready, calling soft_power_on()
[00027250ms][DBG ][CELL]: AT flush
[00027251ms][INFO][CELL]: AT RX (32): AT<cr><cr><ln>OK<cr><ln><cr><ln>#QSS: 1<cr><ln><cr><ln>+PACSP0<cr><ln><cr>
[00027253ms][INFO][CELL]: AT RX (11): <ln>#PSNT: 4<cr><ln>
[00027254ms][INFO][CELL]: AT TX ( 4): ATE0
[00027257ms][INFO][CELL]: AT TX ( 1): <cr>
[00027263ms][INFO][CELL]: AT RX (11): ATE0<cr><cr><ln>OK<cr><ln>
[00027292ms][INFO][CELL]: AT TX ( 9): AT+CMEE=1
[00027293ms][INFO][CELL]: AT TX ( 1): <cr>
[00027299ms][INFO][CELL]: AT RX ( 6): <cr><ln>OK<cr><ln>
[00027320ms][INFO][CELL]: AT TX ( 9): AT+CFUN=1
[00027321ms][INFO][CELL]: AT TX ( 1): <cr>
[00027327ms][INFO][CELL]: AT RX ( 6): <cr><ln>OK<cr><ln>
[00027348ms][INFO][CELL]: AT TX (13): AT&K3;&C1;&D0
[00027349ms][INFO][CELL]: AT TX ( 1): <cr>
[00027356ms][INFO][CELL]: AT RX ( 6): <cr><ln>OK<cr><ln>
[00027377ms][INFO][CELL]: AT TX ( 8): AT#QSS=1
[00027378ms][INFO][CELL]: AT TX ( 1): <cr>
[00027384ms][INFO][CELL]: AT RX ( 5): <cr><ln>OK<cr>
[00027385ms][INFO][CELL]: AT RX ( 1): <ln>
[00027406ms][INFO][CELL]: AT TX ( 9): AT#PSNT=1
[00027407ms][INFO][CELL]: AT TX ( 1): <cr>
[00027414ms][INFO][CELL]: AT RX ( 6): <cr><ln>OK<cr><ln>
[00027435ms][INFO][CELL]: AT TX ( 9): AT+CMER=2
[00027436ms][INFO][CELL]: AT TX ( 1): <cr>
[00027442ms][INFO][CELL]: AT RX ( 3): <cr><ln>O
[00027443ms][INFO][CELL]: AT RX ( 3): K<cr><ln>
[00027464ms][INFO][CELL]: AT TX ( 9): AT+CMEE=2
[00027465ms][INFO][CELL]: AT TX ( 1): <cr>
[00027471ms][INFO][CELL]: AT RX ( 6): <cr><ln>OK<cr><ln>
[00027492ms][INFO][CELL]: AT TX (12): AT#PORTCFG=3
[00027493ms][INFO][CELL]: AT TX ( 1): <cr>
[00027514ms][INFO][CELL]: AT RX ( 6): <cr><ln>OK<cr><ln>
[00027535ms][INFO][CELL]: AT TX ( 6): AT&W&P
[00027536ms][INFO][CELL]: AT TX ( 1): <cr>
[00027615ms][INFO][CELL]: AT RX ( 5): <cr><ln>OK<cr>
[00027616ms][INFO][CELL]: AT RX ( 1): <ln>
[00027617ms][INFO][CELL]: Modem ready
[00027618ms][DBG ][CELL]: callback: 4096, err: 0, data: 4096
[00027619ms][DBG ][CELL]: Device ready => SIM pin
[00027623ms][DBG ][CELL]: callback: 4106, err: 0, data: 4097
[00027632ms][INFO][CELL]: Setup SIM (timeout 1000 ms)
[00027639ms][DBG ][CELL]: AT flush
[00027645ms][INFO][CELL]: AT TX ( 8): AT+CPIN?
[00027652ms][INFO][CELL]: AT TX ( 1): <cr>
[00027658ms][INFO][CELL]: AT RX (22): <cr><ln>+CPIN: READY<cr><ln><cr><ln>OK<cr><ln>
[00027669ms][INFO][CELL]: SIM is ready
[00027675ms][DBG ][CELL]: callback: 4097, err: 0, data: 0
[00027684ms][DBG ][CELL]: Automatic network registration
[00027692ms][INFO][CELL]: AT TX ( 8): AT+COPS?
[00027698ms][INFO][CELL]: AT TX ( 1): <cr>
[00027705ms][INFO][CELL]: AT RX (29): <cr><ln>+COPS: 0,0,"AT&T",8<cr><ln><cr><ln>OK<cr><ln>
[00027717ms][DBG ][CELL]: STM: set_registration: 0, plmn: NULL
[00027737ms][INFO][CELL]: AT TX ( 9): AT+CEREG=
[00027738ms][INFO][CELL]: AT TX ( 1): 2
[00027739ms][INFO][CELL]: AT TX ( 1): <cr>
[00027745ms][INFO][CELL]: AT RX ( 6): <cr><ln>OK<cr><ln>
[00027773ms][INFO][CELL]: AT TX ( 9): AT+CGREG=
[00027774ms][INFO][CELL]: AT TX ( 1): 2
[00027775ms][INFO][CELL]: AT TX ( 1): <cr>
[00027779ms][INFO][CELL]: AT RX ( 6): <cr><ln>OK<cr><ln>
[00027801ms][INFO][CELL]: AT TX ( 8): AT+CREG=
[00027802ms][INFO][CELL]: AT TX ( 1): 2
[00027803ms][INFO][CELL]: AT TX ( 1): <cr>
[00027806ms][INFO][CELL]: AT RX ( 6): <cr><ln>OK<cr><ln>
[00027828ms][INFO][CELL]: AT TX ( 9): AT+CGACT?
[00027829ms][INFO][CELL]: AT TX ( 1): <cr>
[00027833ms][INFO][CELL]: AT RX (10): <cr><ln>+CGACT:
[00027837ms][INFO][CELL]: AT RX (32): 1,1<cr><ln>+CGACT: 2,0<cr><ln>+CGACT: 3,0<cr><ln>+
[00027842ms][DBG ][CELL]: Found active context
[00027848ms][INFO][CELL]: AT RX (31): CGACT: 4,0<cr><ln>+CGACT: 5,0<cr><ln>+CGACT
[00027859ms][INFO][CELL]: AT RX (13): : 6,0<cr><ln><cr><ln>OK<cr><ln>
[00027869ms][DBG ][CELL]: Active context found.
[00027889ms][INFO][CELL]: AT TX ( 9): AT+CGATT?
[00027890ms][INFO][CELL]: AT TX ( 1): <cr>
[00027896ms][INFO][CELL]: AT RX (16): <cr><ln>+CGATT: 1<cr><ln><cr><ln>O
[00027899ms][INFO][CELL]: AT RX ( 3): K<cr><ln>
[00027906ms][DBG ][CELL]: Cellular already attached.
[00027926ms][INFO][CELL]: AT TX (10): AT+CGEREP=
[00027927ms][INFO][CELL]: AT TX ( 1): 1
[00027928ms][INFO][CELL]: AT TX ( 1): <cr>
[00027933ms][INFO][CELL]: AT RX ( 6): <cr><ln>OK<cr><ln>
[00027941ms][DBG ][CELL]: SIM pin => Signal quality
[00027961ms][INFO][CELL]: AT TX ( 6): AT+CSQ
[00027962ms][INFO][CELL]: AT TX ( 1): <cr>
[00027968ms][INFO][CELL]: AT RX ( 6): <cr><ln>+CSQ
[00027970ms][INFO][CELL]: AT RX (14): : 24,5<cr><ln><cr><ln>OK<cr><ln>
[00027979ms][DBG ][CELL]: callback: 4104, err: 0, data: -1
[00027987ms][DBG ][CELL]: Signal quality => Registering network
[00027999ms][INFO][CELL]: AT TX ( 6): AT+CSQ
[00028003ms][INFO][CELL]: AT TX ( 1): <cr>
[00028009ms][INFO][CELL]: AT RX (20): <cr><ln>+CSQ: 24,5<cr><ln><cr><ln>OK<cr><ln>
[00028020ms][DBG ][CELL]: callback: 4104, err: 0, data: -1
[00028028ms][INFO][CELL]: RSSI -65 dBm
[00028034ms][DBG ][CELL]: callback: 4106, err: 0, data: 4098
[00028043ms][INFO][CELL]: AT TX ( 9): AT+CEREG?
[00028050ms][INFO][CELL]: AT TX ( 1): <cr>
[00028059ms][INFO][CELL]: AT RX (18): <cr><ln>+CEREG: 2,1,"530
[00028065ms][INFO][CELL]: AT RX (22): 4","2986711",8<cr><ln><cr><ln>OK<cr><ln>
[00028075ms][DBG ][CELL]: +CEREG: RegisteredHomeNetwork, LAC 21252, cell 43542289, CATM1
[00028087ms][DBG ][CELL]: callback: 4098, err: 0, data: 1
[00028095ms][INFO][CELL]: Registering network => Attaching network
[00028107ms][INFO][CELL]: AT TX ( 6): AT+CSQ
[00028111ms][INFO][CELL]: AT TX ( 1): <cr>
[00028117ms][INFO][CELL]: AT RX (20): <cr><ln>+CSQ: 24,5<cr><ln><cr><ln>OK<cr><ln>
[00028128ms][DBG ][CELL]: callback: 4104, err: 0, data: -1
[00028136ms][INFO][CELL]: RSSI -65 dBm
[00028142ms][DBG ][CELL]: callback: 4106, err: 0, data: 4102
[00028151ms][INFO][CELL]: Attaching network (timeout 60000 ms)
[00028160ms][INFO][CELL]: AT TX ( 9): AT+CGATT?
[00028167ms][INFO][CELL]: AT TX ( 1): <cr>
[00028174ms][INFO][CELL]: AT RX ( 5): <cr><ln>+CG
[00028180ms][INFO][CELL]: AT RX (14): ATT: 1<cr><ln><cr><ln>OK<cr><ln>
[00028190ms][DBG ][CELL]: callback: 4102, err: 0, data: 1
[00028210ms][INFO][CELL]: AT TX (11): AT+CGDCONT?
[00028211ms][INFO][CELL]: AT TX ( 1): <cr>
[00028222ms][INFO][CELL]: AT RX (10): <cr><ln>+CGDCONT
[00028226ms][INFO][CELL]: AT RX (24): : 1,"IPV4V6","","0.0.0.0
[00028230ms][INFO][CELL]: AT RX (32): .0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,
[00028239ms][INFO][CELL]: AT RX (32): 0<cr><ln>+CGDCONT: 2,"IPV4V6","","0.0.
[00028250ms][INFO][CELL]: AT RX ( 3): 0.0
[00028255ms][ERR ][CELL]: AT overflow
[00028261ms][INFO][CELL]: AT ERR (32): +CGDCONT: 2,"IPV4V6","","0.0.0.0
[00028272ms][INFO][CELL]: AT RX (32): .0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,
[00028281ms][ERR ][CELL]: AT overflow
[00028287ms][INFO][CELL]: AT ERR (32): .0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,
[00028297ms][INFO][CELL]: AT RX (32): 0<cr><ln>+CGDCONT: 3,"IPV4V6","","0.0.
[00028307ms][INFO][CELL]: AT RX ( 3): 0.0
[00028313ms][ERR ][CELL]: AT overflow
[00028319ms][INFO][CELL]: AT ERR (32): +CGDCONT: 3,"IPV4V6","","0.0.0.0
[00028329ms][INFO][CELL]: AT RX (32): .0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,
[00028338ms][ERR ][CELL]: AT overflow
[00028344ms][INFO][CELL]: AT ERR (32): .0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,
[00028354ms][INFO][CELL]: AT RX (32): 0<cr><ln>+CGDCONT: 4,"IPV4V6","","0.0.
[00028364ms][INFO][CELL]: AT RX ( 3): 0.0
[00028370ms][ERR ][CELL]: AT overflow
[00028376ms][INFO][CELL]: AT ERR (32): +CGDCONT: 4,"IPV4V6","","0.0.0.0
[00028386ms][INFO][CELL]: AT RX (32): .0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,
[00028396ms][ERR ][CELL]: AT overflow
[00028402ms][INFO][CELL]: AT ERR (32): .0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,
[00028411ms][INFO][CELL]: AT RX (32): 0<cr><ln>+CGDCONT: 5,"IPV4V6","","0.0.
[00028421ms][INFO][CELL]: AT RX ( 3): 0.0
[00028428ms][ERR ][CELL]: AT overflow
[00028434ms][INFO][CELL]: AT ERR (32): +CGDCONT: 5,"IPV4V6","","0.0.0.0
[00028443ms][INFO][CELL]: AT RX (32): .0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,
[00028453ms][ERR ][CELL]: AT overflow
[00028459ms][INFO][CELL]: AT ERR (32): .0.0.0.0.0.0.0.0.0.0.0.0",0,0,0,
[00028468ms][INFO][CELL]: AT RX (32): 0<cr><ln>+CGDCONT: 6,"IPV4V6","","0.0.
[00028479ms][INFO][CELL]: AT RX ( 3): 0.0
[00028485ms][ERR ][CELL]: AT overflow
[00028491ms][INFO][CELL]: AT ERR (32): +CGDCONT: 6,"IPV4V6","","0.0.0.0
[00028501ms][INFO][CELL]: AT RX (20): .0.0.0.0.0.0.0.0.0.0
[00088199ms][DBG ][CELL]: AT error -3012
[00088199ms][INFO][CELL]: Found PDP context 1
[00088200ms][DBG ][CELL]: AT OoB readable 0, len 20
[00088221ms][DBG ][CELL]: AT OoB done
[00088221ms][INFO][CELL]: CellularContext PPP connect
[00088223ms][INFO][CELL]: AT TX ( 9): ATD*99***
[00088224ms][INFO][CELL]: AT TX ( 1): 1
[00088225ms][INFO][CELL]: AT TX ( 1): #
[00088226ms][INFO][CELL]: AT TX ( 1): <cr>
[00088233ms][INFO][CELL]: AT RX (12): <cr><ln>CONNECT 15
[00088448ms][DBG ][CELL]: ppp_status_cb: event 0, ptr 3
[00088453ms][DBG ][CELL]: callback: 0, ptr: 3
[00094500ms][DBG ][CELL]: ppp_status_cb: event 0, ptr 1
[00094501ms][DBG ][CELL]: callback: 0, ptr: 1
[00094502ms][INFO][CELL]: CellularContext IP 10.50.70.80
[00094503ms][INFO][CELL]: Cellular local IP: 10.50.70.80


Connection Established.
[00094509ms][DBG ][CELL]: process_oob, filehandle is not usable, return...
[00094516ms][DBG ][CELL]: process_oob, filehandle is not usable, return...
Couldn't resolve remote host: echo.mbedcloudtesting.com, code: -3009
[00194538ms][INFO][CELL]: CellularContext disconnect()
[00194539ms][DBG ][CELL]: ppp_status_cb: event 0, ptr 2
[00194552ms][DBG ][CELL]: AT sync
[00194553ms][INFO][CELL]: AT TX ( 8): AT+CMEE?
[00194554ms][INFO][CELL]: AT TX ( 1): <cr>
[00195553ms][DBG ][CELL]: AT error -3012
[00195553ms][WARN][CELL]: AT timeout
[00195554ms][DBG ][CELL]: AT error -3012
[00195555ms][DBG ][CELL]: consume_to_tag not found
[00195556ms][DBG ][CELL]: AT stop tag not found
[00195558ms][DBG ][CELL]: AT error -3012
[00195564ms][WARN][CELL]: AT timeout
[00195569ms][DBG ][CELL]: AT error -3012
[00195575ms][DBG ][CELL]: consume_to_tag not found
[00195582ms][DBG ][CELL]: AT stop tag not found
[00195589ms][DBG ][CELL]: AT error -3012
[00195595ms][INFO][CELL]: AT TX ( 8): AT+CMEE?
[00195601ms][INFO][CELL]: AT TX ( 1): <cr>
[00195607ms][INFO][CELL]: AT RX (14): <cr><ln>NO CARRIER<cr><ln>
[00196596ms][WARN][CELL]: AT timeout
[00196596ms][DBG ][CELL]: AT error -3012
[00196597ms][DBG ][CELL]: consume_to_tag not found
[00196598ms][DBG ][CELL]: AT stop tag not found
[00196599ms][DBG ][CELL]: AT error -3012
[00196601ms][WARN][CELL]: AT timeout
[00196606ms][DBG ][CELL]: AT error -3012
[00196612ms][DBG ][CELL]: consume_to_tag not found
[00196619ms][DBG ][CELL]: AT stop tag not found
[00196626ms][DBG ][CELL]: AT error -3012
[00196632ms][INFO][CELL]: AT TX ( 8): AT+CMEE?
[00196638ms][INFO][CELL]: AT TX ( 1): <cr>
[00196644ms][INFO][CELL]: AT RX (18): <cr><ln>+CMEE: 2<cr><ln><cr><ln>OK<cr><ln>
[00196654ms][DBG ][CELL]: callback: 0, ptr: 2
[00196661ms][INFO][CELL]: cellular_callback: PPP mode and NSAPI_STATUS_DISCONNECTED
[00196671ms][DBG ][CELL]: AT sync
[00196676ms][INFO][CELL]: AT TX ( 8): AT+CMEE?
[00196683ms][INFO][CELL]: AT TX ( 1): <cr>
[00196689ms][INFO][CELL]: AT RX (18): <cr><ln>+CMEE: 2<cr><ln><cr><ln>OK<cr><ln>
[00196699ms][INFO][CELL]: CellularContext disconnected


Failure. Exiting

@AriParkkila
Copy link

@trowbridgec Thanks for the logs. It's difficult to say actual reason, but as you have PROPERTY_IPV6_STACK or PROPERTY_IPV4V6_STACK defined the modem creates IPV4V6 context. If you want to stick to IPV4 then you need to remove IPV6 and IPV4V6 properties, but I'd say that for an IPV4V6 PDP context type you need to have lwip.ipv6-enabled. In this PR, I'd like to see lwip.ipv6-enabled for all targets to hear if someone has a good reason to disagree :)

@40Grit
Copy link

40Grit commented Oct 2, 2019

Agree. @chris, do it.

@trowbridgec
Copy link
Author

@AriParkkila I'll make the change for all targets :)

@40Grit
Copy link

40Grit commented Oct 3, 2019

@AnttiKauppila all good?

@0xc0170 who runs maintenance and tests for examples?

@AnttiKauppila
Copy link

Restarted tests

@kimlep01
Copy link
Contributor

kimlep01 commented Oct 7, 2019

Fixed target in Raas - smoke is passing now.

@AnttiKauppila AnttiKauppila merged commit 6cc5eaf into ARMmbed:master Oct 8, 2019
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

Successfully merging this pull request may close these issues.

5 participants