[Pkg-utopia-maintainers] Bug#828820: Dell DW5811e should be working with the latest MM and supporting packages
Luc Bégault
luc at begault.net
Thu Aug 25 15:13:27 UTC 2016
On 25/08/2016 10:10, Bjørn Mork wrote:
>
> Try to collect the MM debug logs and see if it provides more hints:
>
> systemctl stop ModemManager
> /usr/sbin/ModemManager --debug
> nmcli c up SFR
The dump file is attached, everything looks fine except I don't receive
any datagrams. tcpdump on the interface only shows outgoing packets
without any answer.
>
>
> This should print lots of details of what MM is doing and how if fails.
> It can also be useful to rerun the "mmcli -m .." command after the
> connection attempt, note the number of the created "bearer" object, and
> then run "mmcli -b X" with this number to inspect it.
Bearer '/org/freedesktop/ModemManager1/Bearer/0'
-------------------------
Status | connected: 'yes'
| suspended: 'no'
| interface: 'wwp0s20f0u2i12'
| IP timeout: '20'
-------------------------
Properties | apn: 'websfr'
| roaming: 'allowed'
| IP type: 'ipv4v6'
| user: 'none'
| password: 'none'
| number: '*99#'
| Rm protocol: 'unknown'
-------------------------
IPv4 configuration | method: 'static'
| address: '10.142.166.49'
| prefix: '30'
| gateway: '10.142.166.50'
| DNS: '172.20.2.10', '172.20.2.39'
| MTU: '1500'
-------------------------
IPv6 configuration | method: 'dhcp'
| address: 'unknown'
| prefix: '0'
| gateway: 'unknown'
| DNS: none
-------------------------
Stats | Duration: '0'
| Bytes received: 'N/A'
| Bytes transmitted: 'N/A'
> Just one additional warning for later when you are able to connect (or
> for anyone else reading this and stopping at the next step): You will
> need a kernel update to consistently get IP packets through. There is an
> odd timing issue in the firmware of these modems, which sometimes cause
> a silent failure if the driver probe is "too fast". The workaround for
> this issue is present in kernels v4.7 and later, and also in stable
> kernels v4.6.5 and later. I believe the first Debian kernel package
> version with this fix will be the soon upcoming "4.7.2-1"
>
I looking for this kernel.
Regards,
Luc.
-------------- next part --------------
ModemManager[17786]: <info> [1472137605.516131] [mm-iface-modem-simple.c:641] connect_auth_ready(): Simple connect started...
ModemManager[17786]: <debug> [1472137605.516176] [mm-iface-modem-simple.c:651] connect_auth_ready(): PIN: unspecified
ModemManager[17786]: <debug> [1472137605.516190] [mm-iface-modem-simple.c:653] connect_auth_ready(): Operator ID: unspecified
ModemManager[17786]: <debug> [1472137605.516199] [mm-iface-modem-simple.c:655] connect_auth_ready(): Allowed roaming: yes
ModemManager[17786]: <debug> [1472137605.516208] [mm-iface-modem-simple.c:657] connect_auth_ready(): APN: websfr
ModemManager[17786]: <debug> [1472137605.516217] [mm-iface-modem-simple.c:662] connect_auth_ready(): IP family: ipv4v6
ModemManager[17786]: <debug> [1472137605.516230] [mm-iface-modem-simple.c:670] connect_auth_ready(): Allowed authentication: none, pap, chap, mschap, mschapv2, eap
ModemManager[17786]: <debug> [1472137605.516241] [mm-iface-modem-simple.c:675] connect_auth_ready(): User: unspecified
ModemManager[17786]: <debug> [1472137605.516249] [mm-iface-modem-simple.c:677] connect_auth_ready(): Password: unspecified
ModemManager[17786]: <debug> [1472137605.516256] [mm-iface-modem-simple.c:679] connect_auth_ready(): Number: *99#
ModemManager[17786]: <info> [1472137605.516265] [mm-iface-modem-simple.c:469] connection_step(): Simple connect state (4/8): Wait to get fully enabled
ModemManager[17786]: <info> [1472137605.516314] [mm-iface-modem-simple.c:478] connection_step(): Simple connect state (5/8): Register
ModemManager[17786]: <debug> [1472137605.516340] [mm-iface-modem-3gpp.c:400] mm_iface_modem_3gpp_register_in_network(): Already registered in network '20810', automatic registration not launched...
ModemManager[17786]: <info> [1472137605.516362] [mm-iface-modem-simple.c:501] connection_step(): Simple connect state (6/8): Bearer
ModemManager[17786]: <debug> [1472137605.516377] [mm-iface-modem-simple.c:574] connection_step(): Using already existing bearer at '/org/freedesktop/ModemManager1/Bearer/0'...
ModemManager[17786]: <info> [1472137605.516386] [mm-iface-modem-simple.c:583] connection_step(): Simple connect state (7/8): Connect
ModemManager[17786]: <debug> [1472137605.516398] [mm-base-bearer.c:703] mm_base_bearer_connect(): Connecting bearer '/org/freedesktop/ModemManager1/Bearer/0'
ModemManager[17786]: <info> [1472137605.516421] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (registered -> connecting)
ModemManager[17786]: <debug> [1472137605.516609] [mm-bearer-mbim.c:1026] _connect(): Launching connection with data port (net/wwp0s20f0u2i12)
ModemManager[17786]: <debug> [1472137605.516631] [mm-bearer-mbim.c:785] connect_context_step(): Activating packet service...
ModemManager[17786]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 52
<<<<<< data = 03:00:00:00:34:00:00:00:1A: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[17786]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 52
<<<<<< type = command (0x00000003)
<<<<<< transaction = 26
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'packet-service' (0x0000000a)
<<<<<< type = 'set' (0x00000001)
ModemManager[17786]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 76
>>>>>> data = 03:00:00:80:4C:00:00:00:1A: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:A3:E1:11:00:00:00:00
ModemManager[17786]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 76
>>>>>> type = command-done (0x80000003)
>>>>>> transaction = 26
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> status error = 'None' (0x00000000)
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'packet-service' (0x0000000a)
ModemManager[17786]: <debug> [1472137605.551327] [mm-bearer-mbim.c:724] packet_service_set_ready(): Packet service update:
ModemManager[17786]: <debug> [1472137605.551343] [mm-bearer-mbim.c:725] packet_service_set_ready(): state: 'attached'
ModemManager[17786]: <debug> [1472137605.551350] [mm-bearer-mbim.c:726] packet_service_set_ready(): data class: 'lte'
ModemManager[17786]: <debug> [1472137605.551358] [mm-bearer-mbim.c:727] packet_service_set_ready(): uplink: '50000000' bps
ModemManager[17786]: <debug> [1472137605.551365] [mm-bearer-mbim.c:728] packet_service_set_ready(): downlink: '300000000' bps
ModemManager[17786]: <debug> [1472137605.551374] [mm-bearer-mbim.c:806] connect_context_step(): Listing provisioned contexts...
ModemManager[17786]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 48
<<<<<< data = 03:00:00:00:30: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:0D:00:00:00:00:00:00:00:00:00:00:00
ModemManager[17786]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 48
<<<<<< type = command (0x00000003)
<<<<<< transaction = 27
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'provisioned-contexts' (0x0000000d)
<<<<<< type = 'query' (0x00000000)
ModemManager[17786]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 112
>>>>>> data = 03:00:00:80:70: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:0D:00:00:00:00:00:00:00:40:00:00:00:01:00:00:00:0C:00:00:00:34: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: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[17786]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 112
>>>>>> 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 = 'provisioned-contexts' (0x0000000d)
ModemManager[17786]: <debug> [1472137605.615349] [mm-bearer-mbim.c:659] provisioned_contexts_query_ready(): Provisioned contexts found (1):
ModemManager[17786]: <debug> [1472137605.615365] [mm-bearer-mbim.c:665] provisioned_contexts_query_ready(): [1] context type: internet
ModemManager[17786]: <debug> [1472137605.615374] [mm-bearer-mbim.c:666] provisioned_contexts_query_ready(): uuid: 7e5e2a7e-4e6f-7272-736b-656e7e5e2a7e
ModemManager[17786]: <debug> [1472137605.615382] [mm-bearer-mbim.c:667] provisioned_contexts_query_ready(): access string:
ModemManager[17786]: <debug> [1472137605.615391] [mm-bearer-mbim.c:668] provisioned_contexts_query_ready(): username:
ModemManager[17786]: <debug> [1472137605.615400] [mm-bearer-mbim.c:669] provisioned_contexts_query_ready(): password:
ModemManager[17786]: <debug> [1472137605.615409] [mm-bearer-mbim.c:670] provisioned_contexts_query_ready(): compression: none
ModemManager[17786]: <debug> [1472137605.615418] [mm-bearer-mbim.c:671] provisioned_contexts_query_ready(): auth: none
ModemManager[17786]: <debug> [1472137605.615430] [mm-bearer-mbim.c:901] connect_context_step(): Launching ipv4v6 connection with APN 'websfr'...
ModemManager[17786]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 120
<<<<<< data = 03:00:00:00:78: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:0C:00:00:00:01:00:00:00:48:00:00:00:00:00:00:00:01:00:00:00:3C:00:00:00:0C: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:77:00:65:00:62:00:73:00:66:00:72:00
ModemManager[17786]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 120
<<<<<< type = command (0x00000003)
<<<<<< transaction = 28
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'connect' (0x0000000c)
<<<<<< type = 'set' (0x00000001)
ModemManager[17786]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 80
>>>>>> data = 07:00:00:80:50:00:00:00:00: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:24:00:00:00:00:00:00:00:02: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:00:00:00:00
ModemManager[17786]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 80
>>>>>> type = indicate-status (0x80000007)
>>>>>> transaction = 0
>>>>>> Fragment header:
>>>>>> total = 1
>>>>>> current = 0
>>>>>> Contents:
>>>>>> service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
>>>>>> cid = 'connect' (0x0000000c)
ModemManager[17786]: <debug> [1472137605.679390] [mm-broadband-modem-mbim.c:2249] device_notification_cb(): Received notification (service 'basic-connect', command 'connect')
ModemManager[17786]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 84
>>>>>> data = 03:00:00:80:54: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: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[17786]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 84
>>>>>> 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 = 'connect' (0x0000000c)
ModemManager[17786]: <debug> [1472137605.743333] [mm-bearer-mbim.c:614] connect_set_ready(): Session ID '0': activated (IP type: ipv4v6)
ModemManager[17786]: <debug> [1472137605.743346] [mm-bearer-mbim.c:932] connect_context_step(): Querying IP configuration...
ModemManager[17786]: [/dev/cdc-wdm0] Sent message...
<<<<<< RAW:
<<<<<< length = 108
<<<<<< data = 03:00:00:00:6C: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: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[17786]: [/dev/cdc-wdm0] Sent message (translated)...
<<<<<< Header:
<<<<<< length = 108
<<<<<< type = command (0x00000003)
<<<<<< transaction = 29
<<<<<< Fragment header:
<<<<<< total = 1
<<<<<< current = 0
<<<<<< Contents:
<<<<<< service = 'basic-connect' (a289cc33-bcbb-8b4f-b6b0-133ec2aae6df)
<<<<<< cid = 'ip-configuration' (0x0000000f)
<<<<<< type = 'query' (0x00000000)
ModemManager[17786]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 128
>>>>>> data = 03:00:00:80:80: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:0F:00:00:00:00:00:00:00:50:00:00:00:00:00:00:00:0F: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:02:00:00:00:48:00:00:00:00:00:00:00:00:00:00:00:DC:05:00:00:00:00:00:00:1E:00:00:00:0A:8E:A6:31:0A:8E:A6:32:AC:14:02:0A:AC:14:02:27
ModemManager[17786]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 128
>>>>>> 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 = 'ip-configuration' (0x0000000f)
ModemManager[17786]: <debug> [1472137605.807445] [mm-bearer-mbim.c:319] ip_configuration_query_ready(): IPv4 configuration available: 'address, gateway, dns, mtu'
ModemManager[17786]: <debug> [1472137605.807461] [mm-bearer-mbim.c:325] ip_configuration_query_ready(): IP addresses (1)
ModemManager[17786]: <debug> [1472137605.807492] [mm-bearer-mbim.c:329] ip_configuration_query_ready(): IP [0]: '10.142.166.49/30'
ModemManager[17786]: <debug> [1472137605.807513] [mm-bearer-mbim.c:338] ip_configuration_query_ready(): Gateway: '10.142.166.50'
ModemManager[17786]: <debug> [1472137605.807525] [mm-bearer-mbim.c:346] ip_configuration_query_ready(): DNS addresses (2)
ModemManager[17786]: <debug> [1472137605.807542] [mm-bearer-mbim.c:351] ip_configuration_query_ready(): DNS [0]: '172.20.2.10'
ModemManager[17786]: <debug> [1472137605.807558] [mm-bearer-mbim.c:351] ip_configuration_query_ready(): DNS [1]: '172.20.2.39'
ModemManager[17786]: <debug> [1472137605.807570] [mm-bearer-mbim.c:359] ip_configuration_query_ready(): MTU: '1500'
ModemManager[17786]: <debug> [1472137605.807581] [mm-bearer-mbim.c:365] ip_configuration_query_ready(): IPv6 configuration available: 'none'
ModemManager[17786]: <debug> [1472137605.807625] [mm-port.c:95] mm_port_set_connected(): (wwp0s20f0u2i12): port now connected
ModemManager[17786]: <debug> [1472137605.807653] [mm-base-bearer.c:601] connect_ready(): Connected bearer '/org/freedesktop/ModemManager1/Bearer/0'
ModemManager[17786]: [/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:14:00:00:00:00:00:00:00:00:00:00:00
ModemManager[17786]: [/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 = 'packet-statistics' (0x00000014)
<<<<<< type = 'query' (0x00000000)
ModemManager[17786]: <info> [1472137605.807877] [mm-iface-modem.c:1431] __iface_modem_update_state_internal(): Modem /org/freedesktop/ModemManager1/Modem/0: state changed (connecting -> connected)
ModemManager[17786]: <info> [1472137605.808102] [mm-iface-modem-simple.c:602] connection_step(): Simple connect state (8/8): All done
ModemManager[17786]: [/dev/cdc-wdm0] Received message...
>>>>>> RAW:
>>>>>> length = 96
>>>>>> data = 03:00:00:80:60: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:14:00:00:00:00:00:00:00:30: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[17786]: [/dev/cdc-wdm0] Received message (translated)...
>>>>>> Header:
>>>>>> length = 96
>>>>>> 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 = 'packet-statistics' (0x00000014)
More information about the Pkg-utopia-maintainers
mailing list