Unable to get IPv4 over LTE
Vincent Bernat
bernat at luffy.cx
Tue Jan 19 23:20:29 PST 2016
❦ 19 janvier 2016 23:59 +0100, Aleksander Morgado <aleksander at aleksander.es> :
> Would be interesting to see what ModemManager says in each of those
> tries (--debug); and check which are the IP details given by the modem
> for each case, before we even try to run the DHCP client. Could you
> gather logs for both situations?
Well, luckily, it failed again this morning.
When failing:
[mm-iface-modem-simple.c:641] connect_auth_ready(): Simple connect started...
[mm-iface-modem-simple.c:651] connect_auth_ready(): PIN: 0000
[mm-iface-modem-simple.c:653] connect_auth_ready(): Operator ID: unspecified
[mm-iface-modem-simple.c:655] connect_auth_ready(): Allowed roaming: yes
[mm-iface-modem-simple.c:657] connect_auth_ready(): APN: internet
[mm-iface-modem-simple.c:662] connect_auth_ready(): IP family: ipv4v6
[mm-iface-modem-simple.c:673] connect_auth_ready(): Allowed authentication: unspecified
[mm-iface-modem-simple.c:675] connect_auth_ready(): User: unspecified
[mm-iface-modem-simple.c:677] connect_auth_ready(): Password: unspecified
[mm-iface-modem-simple.c:679] connect_auth_ready(): Number: *99#
[mm-iface-modem-simple.c:469] connection_step(): Simple connect state (4/8): Wait to get fully enabled
[mm-iface-modem-simple.c:478] connection_step(): Simple connect state (5/8): Register
[mm-iface-modem-3gpp.c:400] mm_iface_modem_3gpp_register_in_network(): Already registered in network '22802', automatic registration not launched...
[mm-iface-modem-simple.c:501] connection_step(): Simple connect state (6/8): Bearer
[mm-iface-modem-simple.c:521] connection_step(): Creating new bearer...
[mm-broadband-modem-mbim.c:1163] modem_create_bearer(): Creating MBIM bearer in MBIM modem
[mm-broadband-modem-mbim.c:1077] modem_create_bearer_finish(): New bearer created at DBus path '/org/freedesktop/ModemManager1/Bearer/0'
[mm-iface-modem-simple.c:583] connection_step(): Simple connect state (7/8): Connect
[mm-base-bearer.c:590] mm_base_bearer_connect(): Connecting bearer '/org/freedesktop/ModemManager1/Bearer/0'
[mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting)
[mm-bearer-mbim.c:897] _connect(): Launching connection with data port (net/wwan0)
[mm-bearer-mbim.c:655] connect_context_step(): Activating packet service...
ModemManager[12437]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 52
<<<<<< data = 03:00:00:00:34:00:00:00:1B:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0A:00:00:00:01:00:00:00:04:00:00:00:00:00:00:00
ModemManager[12437]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 52
<<<<<< type = command (0x00000003)
<<<<<< transaction = 27
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'packet-service' (0x0000000a)
<<<<<< type = 'set' (0x00000001)
ModemManager[12437]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 76
>>>>>> data = 03:00:00:80:4C:00:00:00:1B:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0A:00:00:00:00:00:00:00:1C:00:00:00:00:00:00:00:02:00:00:00:20:00:00:00:80:F0:FA:02:00:00:00:00:00:E1:F5:05:00:00:00:00
ModemManager[12437]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 76
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 27
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'packet-service' (0x0000000a)
[mm-bearer-mbim.c:594] packet_service_set_ready(): Packet service update:
[mm-bearer-mbim.c:595] packet_service_set_ready(): state: 'attached'
[mm-bearer-mbim.c:596] packet_service_set_ready(): data class: 'lte'
[mm-bearer-mbim.c:597] packet_service_set_ready(): uplink: '50000000' bps
[mm-bearer-mbim.c:598] packet_service_set_ready(): downlink: '100000000' bps
[mm-bearer-mbim.c:676] connect_context_step(): Listing provisioned contexts...
ModemManager[12437]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:1C:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0D:00:00:00:00:00:00:00:00:00:00:00
ModemManager[12437]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 28
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'provisioned-contexts' (0x0000000d)
<<<<<< type = 'query' (0x00000000)
ModemManager[12437]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 52
>>>>>> data = 03:00:00:80:34:00:00:00:1C:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0D:00:00:00:00:00:00:00:04:00:00:00:00:00:00:00
ModemManager[12437]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 52
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 28
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'provisioned-contexts' (0x0000000d)
[mm-bearer-mbim.c:529] provisioned_contexts_query_ready(): Provisioned contexts found (0):
[mm-bearer-mbim.c:772] connect_context_step(): Launching connection with APN 'internet'...
ModemManager[12437]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 124
<<<<<< data = 03:00:00:00:7C:00:00:00:1D:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0C:00:00:00:01:00:00:00:4C:00:00:00:00:00:00:00:01:00:00:00:3C:00:00:00:10:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:03:00:00:00:7E:5E:2A:7E:4E:6F:72:72:73:6B:65:6E:7E:5E:2A:7E:69:00:6E:00:74:00:65:00:72:00:6E:00:65:00:74:00
ModemManager[12437]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 124
<<<<<< type = command (0x00000003)
<<<<<< transaction = 29
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'connect' (0x0000000c)
<<<<<< type = 'set' (0x00000001)
ModemManager[12437]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 84
>>>>>> data = 03:00:00:80:54:00:00:00:1D:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0C:00:00:00:00:00:00:00:24:00:00:00:00:00:00:00:01:00:00:00:00:00:00:00:01:00:00:00:7E:5E:2A:7E:4E:6F:72:72:73:6B:65:6E:7E:5E:2A:7E:00:00:00:00
ModemManager[12437]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 84
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 29
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'connect' (0x0000000c)
[mm-bearer-mbim.c:484] connect_set_ready(): Session ID '0': activated (IP type: ipv4)
[mm-bearer-mbim.c:803] connect_context_step(): Querying IP configuration...
ModemManager[12437]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 108
<<<<<< data = 03:00:00:00:6C:00:00:00:1E:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0F:00:00:00:00:00:00:00:3C:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00
ModemManager[12437]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 108
<<<<<< type = command (0x00000003)
<<<<<< transaction = 30
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'ip-configuration' (0x0000000f)
<<<<<< type = 'query' (0x00000000)
ModemManager[12437]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 120
>>>>>> data = 03:00:00:80:78:00:00:00:1E:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0F:00:00:00:00:00:00:00:48:00:00:00:00:00:00:00:03:00:00:00:00:00:00:00:01:00:00:00:3C:00:00:00:00:00:00:00:00:00:00:00:44:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:18:00:00:00:0A:82:4E:44:0A:82:4E:01
ModemManager[12437]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 120
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 30
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'ip-configuration' (0x0000000f)
[mm-bearer-mbim.c:212] ip_configuration_query_ready(): IPv4 configuration available: 'address, gateway'
[mm-bearer-mbim.c:218] ip_configuration_query_ready(): IP addresses (1)
[mm-bearer-mbim.c:222] ip_configuration_query_ready(): IP [0]: '10.130.78.68/24'
[mm-bearer-mbim.c:231] ip_configuration_query_ready(): Gateway: '10.130.78.1'
[mm-bearer-mbim.c:258] ip_configuration_query_ready(): IPv6 configuration available: 'none'
[mm-port.c:95] mm_port_set_connected(): (wwan0): port now connected
[mm-base-bearer.c:488] connect_ready(): Connected bearer '/org/freedesktop/ModemManager1/Bearer/0'
[mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected)
[mm-iface-modem-simple.c:602] connection_step(): Simple connect state (8/8): All done
So, it gets an IP address!
When succeeding:
[mm-iface-modem-simple.c:641] connect_auth_ready(): Simple connect started...
[mm-iface-modem-simple.c:651] connect_auth_ready(): PIN: unspecified
[mm-iface-modem-simple.c:653] connect_auth_ready(): Operator ID: unspecified
[mm-iface-modem-simple.c:655] connect_auth_ready(): Allowed roaming: yes
[mm-iface-modem-simple.c:657] connect_auth_ready(): APN: internet
[mm-iface-modem-simple.c:662] connect_auth_ready(): IP family: ipv4v6
[mm-iface-modem-simple.c:673] connect_auth_ready(): Allowed authentication: unspecified
[mm-iface-modem-simple.c:675] connect_auth_ready(): User: unspecified
[mm-iface-modem-simple.c:677] connect_auth_ready(): Password: unspecified
[mm-iface-modem-simple.c:679] connect_auth_ready(): Number: *99#
[mm-iface-modem-simple.c:469] connection_step(): Simple connect state (4/8): Wait to get fully enabled
[mm-iface-modem-simple.c:478] connection_step(): Simple connect state (5/8): Register
[mm-iface-modem-3gpp.c:400] mm_iface_modem_3gpp_register_in_network(): Already registered in network '22802', automatic registration not launched...
[mm-iface-modem-simple.c:501] connection_step(): Simple connect state (6/8): Bearer
[mm-iface-modem-simple.c:574] connection_step(): Using already existing bearer at '/org/freedesktop/ModemManager1/Bearer/0'...
[mm-iface-modem-simple.c:583] connection_step(): Simple connect state (7/8): Connect
[mm-base-bearer.c:590] mm_base_bearer_connect(): Connecting bearer '/org/freedesktop/ModemManager1/Bearer/0'
[mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting)
[mm-bearer-mbim.c:897] _connect(): Launching connection with data port (net/wwan0)
[mm-bearer-mbim.c:655] connect_context_step(): Activating packet service...
ModemManager[12437]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 52
<<<<<< data = 03:00:00:00:34:00:00:00:39:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0A:00:00:00:01:00:00:00:04:00:00:00:00:00:00:00
ModemManager[12437]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 52
<<<<<< type = command (0x00000003)
<<<<<< transaction = 57
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'packet-service' (0x0000000a)
<<<<<< type = 'set' (0x00000001)
ModemManager[12437]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 76
>>>>>> data = 03:00:00:80:4C:00:00:00:39:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0A:00:00:00:00:00:00:00:1C:00:00:00:00:00:00:00:02:00:00:00:18:00:00:00:A0:F9:56:00:00:00:00:00:00:97:49:01:00:00:00:00
ModemManager[12437]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 76
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 57
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'packet-service' (0x0000000a)
[mm-bearer-mbim.c:594] packet_service_set_ready(): Packet service update:
[mm-bearer-mbim.c:595] packet_service_set_ready(): state: 'attached'
[mm-bearer-mbim.c:596] packet_service_set_ready(): data class: 'hsdpa, hsupa'
[mm-bearer-mbim.c:597] packet_service_set_ready(): uplink: '5700000' bps
[mm-bearer-mbim.c:598] packet_service_set_ready(): downlink: '21600000' bps
[mm-bearer-mbim.c:676] connect_context_step(): Listing provisioned contexts...
ModemManager[12437]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:3A:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0D:00:00:00:00:00:00:00:00:00:00:00
ModemManager[12437]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 58
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'provisioned-contexts' (0x0000000d)
<<<<<< type = 'query' (0x00000000)
ModemManager[12437]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 52
>>>>>> data = 03:00:00:80:34:00:00:00:3A:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0D:00:00:00:00:00:00:00:04:00:00:00:00:00:00:00
ModemManager[12437]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 52
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 58
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'provisioned-contexts' (0x0000000d)
[mm-bearer-mbim.c:529] provisioned_contexts_query_ready(): Provisioned contexts found (0):
[mm-bearer-mbim.c:772] connect_context_step(): Launching connection with APN 'internet'...
ModemManager[12437]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 124
<<<<<< data = 03:00:00:00:7C:00:00:00:3B:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0C:00:00:00:01:00:00:00:4C:00:00:00:00:00:00:00:01:00:00:00:3C:00:00:00:10:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:03:00:00:00:7E:5E:2A:7E:4E:6F:72:72:73:6B:65:6E:7E:5E:2A:7E:69:00:6E:00:74:00:65:00:72:00:6E:00:65:00:74:00
ModemManager[12437]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 124
<<<<<< type = command (0x00000003)
<<<<<< transaction = 59
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'connect' (0x0000000c)
<<<<<< type = 'set' (0x00000001)
ModemManager[12437]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 84
>>>>>> data = 03:00:00:80:54:00:00:00:3B:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0C:00:00:00:00:00:00:00:24:00:00:00:00:00:00:00:01:00:00:00:00:00:00:00:01:00:00:00:7E:5E:2A:7E:4E:6F:72:72:73:6B:65:6E:7E:5E:2A:7E:00:00:00:00
ModemManager[12437]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 84
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 59
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'connect' (0x0000000c)
[mm-bearer-mbim.c:484] connect_set_ready(): Session ID '0': activated (IP type: ipv4)
[mm-bearer-mbim.c:803] connect_context_step(): Querying IP configuration...
ModemManager[12437]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 108
<<<<<< data = 03:00:00:00:6C:00:00:00:3C:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0F:00:00:00:00:00:00:00:3C:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00
ModemManager[12437]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 108
<<<<<< type = command (0x00000003)
<<<<<< transaction = 60
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'ip-configuration' (0x0000000f)
<<<<<< type = 'query' (0x00000000)
ModemManager[12437]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 128
>>>>>> data = 03:00:00:80:80:00:00:00:3C:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0F:00:00:00:00:00:00:00:50:00:00:00:00:00:00:00:07:00:00:00:00:00:00:00:01:00:00:00:44:00:00:00:00:00:00:00:00:00:00:00:4C:00:00:00:00:00:00:00:02:00:00:00:3C:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:0A:C8:66:F4:0A:C8:66:F3:18:00:00:00:0A:93:74:D1:0A:93:74:01
ModemManager[12437]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 128
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 60
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'ip-configuration' (0x0000000f)
[mm-bearer-mbim.c:212] ip_configuration_query_ready(): IPv4 configuration available: 'address, gateway, dns'
[mm-bearer-mbim.c:218] ip_configuration_query_ready(): IP addresses (1)
[mm-bearer-mbim.c:222] ip_configuration_query_ready(): IP [0]: '10.147.116.209/24'
[mm-bearer-mbim.c:231] ip_configuration_query_ready(): Gateway: '10.147.116.1'
[mm-bearer-mbim.c:239] ip_configuration_query_ready(): DNS addresses (2)
[mm-bearer-mbim.c:244] ip_configuration_query_ready(): DNS [0]: '10.200.102.244'
[mm-bearer-mbim.c:244] ip_configuration_query_ready(): DNS [1]: '10.200.102.243'
[mm-bearer-mbim.c:258] ip_configuration_query_ready(): IPv6 configuration available: 'none'
[mm-port.c:95] mm_port_set_connected(): (wwan0): port now connected
[mm-base-bearer.c:488] connect_ready(): Connected bearer '/org/freedesktop/ModemManager1/Bearer/0'
[mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected)
[mm-iface-modem-simple.c:602] connection_step(): Simple connect state (8/8): All done
So, it also gets a DNS. Now, I put the computer to sleep and back, I
restart Modem Manager, unload and reload modules and reset the USB modem
(I always do this as otherwise, I get in a "sim-failed" state). I am now
over LTE again and I try to connect and it works:
[mm-iface-modem-simple.c:641] connect_auth_ready(): Simple connect started...
[mm-iface-modem-simple.c:651] connect_auth_ready(): PIN: unspecified
[mm-iface-modem-simple.c:653] connect_auth_ready(): Operator ID: unspecified
[mm-iface-modem-simple.c:655] connect_auth_ready(): Allowed roaming: yes
[mm-iface-modem-simple.c:657] connect_auth_ready(): APN: internet
[mm-iface-modem-simple.c:662] connect_auth_ready(): IP family: ipv4v6
[mm-iface-modem-simple.c:673] connect_auth_ready(): Allowed authentication: unspecified
[mm-iface-modem-simple.c:675] connect_auth_ready(): User: unspecified
[mm-iface-modem-simple.c:677] connect_auth_ready(): Password: unspecified
[mm-iface-modem-simple.c:679] connect_auth_ready(): Number: *99#
[mm-iface-modem-simple.c:469] connection_step(): Simple connect state (4/8): Wait to get fully enabled
[mm-iface-modem-simple.c:478] connection_step(): Simple connect state (5/8): Register
[mm-iface-modem-3gpp.c:400] mm_iface_modem_3gpp_register_in_network(): Already registered in network '22802', automatic registration not launched...
[mm-iface-modem-simple.c:501] connection_step(): Simple connect state (6/8): Bearer
[mm-iface-modem-simple.c:521] connection_step(): Creating new bearer...
[mm-broadband-modem-mbim.c:1163] modem_create_bearer(): Creating MBIM bearer in MBIM modem
[mm-broadband-modem-mbim.c:1077] modem_create_bearer_finish(): New bearer created at DBus path '/org/freedesktop/ModemManager1/Bearer/0'
[mm-iface-modem-simple.c:583] connection_step(): Simple connect state (7/8): Connect
[mm-base-bearer.c:590] mm_base_bearer_connect(): Connecting bearer '/org/freedesktop/ModemManager1/Bearer/0'
[mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/1: state changed (registered -> connecting)
[mm-bearer-mbim.c:897] _connect(): Launching connection with data port (net/wwan0)
[mm-bearer-mbim.c:655] connect_context_step(): Activating packet service...
ModemManager[14494]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 52
<<<<<< data = 03:00:00:00:34:00:00:00:1D:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0A:00:00:00:01:00:00:00:04:00:00:00:00:00:00:00
ModemManager[14494]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 52
<<<<<< type = command (0x00000003)
<<<<<< transaction = 29
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'packet-service' (0x0000000a)
<<<<<< type = 'set' (0x00000001)
ModemManager[14494]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 76
>>>>>> data = 03:00:00:80:4C:00:00:00:1D:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0A:00:00:00:00:00:00:00:1C:00:00:00:00:00:00:00:02:00:00:00:20:00:00:00:80:F0:FA:02:00:00:00:00:00:E1:F5:05:00:00:00:00
ModemManager[14494]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 76
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 29
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'packet-service' (0x0000000a)
[mm-bearer-mbim.c:594] packet_service_set_ready(): Packet service update:
[mm-bearer-mbim.c:595] packet_service_set_ready(): state: 'attached'
[mm-bearer-mbim.c:596] packet_service_set_ready(): data class: 'lte'
[mm-bearer-mbim.c:597] packet_service_set_ready(): uplink: '50000000' bps
[mm-bearer-mbim.c:598] packet_service_set_ready(): downlink: '100000000' bps
[mm-bearer-mbim.c:676] connect_context_step(): Listing provisioned contexts...
ModemManager[14494]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30:00:00:00:1E:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0D:00:00:00:00:00:00:00:00:00:00:00
ModemManager[14494]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 30
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'provisioned-contexts' (0x0000000d)
<<<<<< type = 'query' (0x00000000)
ModemManager[14494]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 52
>>>>>> data = 03:00:00:80:34:00:00:00:1E:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0D:00:00:00:00:00:00:00:04:00:00:00:00:00:00:00
ModemManager[14494]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 52
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 30
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'provisioned-contexts' (0x0000000d)
[mm-bearer-mbim.c:529] provisioned_contexts_query_ready(): Provisioned contexts found (0):
[mm-bearer-mbim.c:772] connect_context_step(): Launching connection with APN 'internet'...
ModemManager[14494]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 124
<<<<<< data = 03:00:00:00:7C:00:00:00:1F:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0C:00:00:00:01:00:00:00:4C:00:00:00:00:00:00:00:01:00:00:00:3C:00:00:00:10:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:03:00:00:00:7E:5E:2A:7E:4E:6F:72:72:73:6B:65:6E:7E:5E:2A:7E:69:00:6E:00:74:00:65:00:72:00:6E:00:65:00:74:00
ModemManager[14494]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 124
<<<<<< type = command (0x00000003)
<<<<<< transaction = 31
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'connect' (0x0000000c)
<<<<<< type = 'set' (0x00000001)
ModemManager[14494]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 84
>>>>>> data = 03:00:00:80:54:00:00:00:1F:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0C:00:00:00:00:00:00:00:24:00:00:00:00:00:00:00:01:00:00:00:00:00:00:00:01:00:00:00:7E:5E:2A:7E:4E:6F:72:72:73:6B:65:6E:7E:5E:2A:7E:00:00:00:00
ModemManager[14494]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 84
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 31
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'connect' (0x0000000c)
[mm-bearer-mbim.c:484] connect_set_ready(): Session ID '0': activated (IP type: ipv4)
[mm-bearer-mbim.c:803] connect_context_step(): Querying IP configuration...
ModemManager[14494]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 108
<<<<<< data = 03:00:00:00:6C:00:00:00:20:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0F:00:00:00:00:00:00:00:3C:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00
ModemManager[14494]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 108
<<<<<< type = command (0x00000003)
<<<<<< transaction = 32
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'ip-configuration' (0x0000000f)
<<<<<< type = 'query' (0x00000000)
ModemManager[14494]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 128
>>>>>> data = 03:00:00:80:80:00:00:00:20:00:00:00:01:00:00:00:00:00:00:00:A2:89:CC:33:BC:BB:8B:4F:B6:B0:13:3E:C2:AA:E6:DF:0F:00:00:00:00:00:00:00:50:00:00:00:00:00:00:00:07:00:00:00:00:00:00:00:01:00:00:00:44:00:00:00:00:00:00:00:00:00:00:00:4C:00:00:00:00:00:00:00:02:00:00:00:3C:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:00:0A:C8:66:F4:0A:C8:66:F3:18:00:00:00:0A:93:96:6F:0A:93:96:01
ModemManager[14494]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 128
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 32
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'ip-configuration' (0x0000000f)
[mm-bearer-mbim.c:212] ip_configuration_query_ready(): IPv4 configuration available: 'address, gateway, dns'
[mm-bearer-mbim.c:218] ip_configuration_query_ready(): IP addresses (1)
[mm-bearer-mbim.c:222] ip_configuration_query_ready(): IP [0]: '10.147.150.111/24'
[mm-bearer-mbim.c:231] ip_configuration_query_ready(): Gateway: '10.147.150.1'
[mm-bearer-mbim.c:239] ip_configuration_query_ready(): DNS addresses (2)
[mm-bearer-mbim.c:244] ip_configuration_query_ready(): DNS [0]: '10.200.102.244'
[mm-bearer-mbim.c:244] ip_configuration_query_ready(): DNS [1]: '10.200.102.243'
[mm-bearer-mbim.c:258] ip_configuration_query_ready(): IPv6 configuration available: 'none'
[mm-port.c:95] mm_port_set_connected(): (wwan0): port now connected
[mm-base-bearer.c:488] connect_ready(): Connected bearer '/org/freedesktop/ModemManager1/Bearer/0'
[mm-iface-modem.c:1392] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/1: state changed (connecting -> connected)
[mm-iface-modem-simple.c:602] connection_step(): Simple connect state (8/8): All done
As I said, I have the same behavior with different carriers. Maybe they
all use the same software though (carriers are Salt (CH), Sunrise (CH)
and Orange (FR)).
I have never updated the firmware of the modem (I think this is only
possible from Windows and no Windows). The modem is quite buggy and I
often use a "reset-all" script to get things in working order. When I
say I "reset" the modem, this includes a USB reset (ioctl
USBDEVFS_RESET).
I could totally live with 8.8.8.8 and 8.8.4.4 as DNS if this was
possible (who decides that IP configuration is incomplete?).
--
Test input for validity and plausibility.
- The Elements of Programming Style (Kernighan & Plauger)
More information about the ModemManager-devel
mailing list