wwan on ubuntu 13.04 -> dns error? (X1 carbon)

[roberts]

I have a problem connecting on my x1 carbon - actually I didn' suceed to connect on win8 either even though I updated all drivers firmaware etc.

On windows I don't know how to see whats going on and I use ubuntu for my everday work anway. So thats what I see in syslog (I replaced the hardware adresses with dummy adresses to protect my privacy):

Code: Select all

Apr 22 13:59:46 myX1 NetworkManager[1336]: <info> Activation (wwan0) starting connection 'bob'
Apr 22 13:59:46 myX1 NetworkManager[1336]: <info> (wwan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Apr 22 13:59:46 myX1 NetworkManager[1336]: <info> Activation (wwan0) Stage 1 of 5 (Device Prepare) scheduled...
Apr 22 13:59:46 myX1 NetworkManager[1336]: <info> Activation (wwan0) Stage 1 of 5 (Device Prepare) started...
Apr 22 13:59:46 myX1 NetworkManager[1336]: <info> Activation (wwan0) Stage 1 of 5 (Device Prepare) complete.
Apr 22 13:59:46 myX1 NetworkManager[1336]: <warn> GSM modem enable failed: (32) SIM PIN required
Apr 22 13:59:46 myX1 modem-manager[1290]: <info>  (ttyACM0) opening serial port...
Apr 22 13:59:48 myX1 modem-manager[1290]: <info>  Modem /org/freedesktop/ModemManager/Modems/0: unlock no longer required
Apr 22 13:59:48 myX1 modem-manager[1290]: <info>  (ttyACM0) closing serial port...
Apr 22 13:59:48 myX1 modem-manager[1290]: <info>  (ttyACM0) serial port closed
Apr 22 13:59:52 myX1 modem-manager[1290]: <info>  (ttyACM0) opening serial port...
Apr 22 13:59:52 myX1 modem-manager[1290]: <info>  Modem /org/freedesktop/ModemManager/Modems/0: state changed (disabled -> enabling)
Apr 22 13:59:52 myX1 modem-manager[1290]: Invalid error code: 276
Apr 22 13:59:52 myX1 modem-manager[1290]: <info>  (ttyACM1) opening serial port...
Apr 22 13:59:53 myX1 modem-manager[1290]: <info>  (ttyACM0): using PDU mode for SMS
Apr 22 13:59:53 myX1 modem-manager[1290]: <info>  Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabling -> enabled)
Apr 22 13:59:53 myX1 NetworkManager[1336]: <info> WWAN now enabled by management service
Apr 22 13:59:53 myX1 modem-manager[1290]: <info>  Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabled -> searching)
Apr 22 13:59:53 myX1 modem-manager[1290]: <info>  Modem /org/freedesktop/ModemManager/Modems/0: state changed (searching -> enabled)
Apr 22 13:59:55 myX1 modem-manager[1290]: <info>  Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabled -> searching)
Apr 22 13:59:56 myX1 modem-manager[1290]: <info>  Modem /org/freedesktop/ModemManager/Modems/0: state changed (searching -> registered)
Apr 22 13:59:57 myX1 modem-manager[1290]: <info>  Modem /org/freedesktop/ModemManager/Modems/0: state changed (registered -> connecting)
Apr 22 14:00:00 myX1 modem-manager[1290]: <info>  Modem /org/freedesktop/ModemManager/Modems/0: state changed (connecting -> connected)
Apr 22 14:00:00 myX1 NetworkManager[1336]: <info> Activation (wwan0) Stage 2 of 5 (Device Configure) scheduled...
Apr 22 14:00:00 myX1 NetworkManager[1336]: <info> Activation (wwan0) Stage 2 of 5 (Device Configure) starting...
Apr 22 14:00:00 myX1 NetworkManager[1336]: <info> (wwan0): device state change: prepare -> config (reason 'none') [40 50 0]
Apr 22 14:00:00 myX1 NetworkManager[1336]: <info> (wwan0): bringing up device.
Apr 22 14:00:00 myX1 NetworkManager[1336]: <info> Activation (wwan0) Stage 2 of 5 (Device Configure) successful.
Apr 22 14:00:00 myX1 NetworkManager[1336]: <info> Activation (wwan0) Stage 3 of 5 (IP Configure Start) scheduled.
Apr 22 14:00:00 myX1 NetworkManager[1336]: <info> Activation (wwan0) Stage 2 of 5 (Device Configure) complete.
Apr 22 14:00:00 myX1 NetworkManager[1336]: <info> Activation (wwan0) Stage 3 of 5 (IP Configure Start) started...
Apr 22 14:00:00 myX1 NetworkManager[1336]: <info> (wwan0): device state change: config -> ip-config (reason 'none') [50 70 0]
Apr 22 14:00:00 myX1 NetworkManager[1336]: <info> Activation (wwan0) Beginning DHCPv4 transaction (timeout in 45 seconds)
Apr 22 14:00:00 myX1 avahi-daemon[1011]: Joining mDNS multicast group on interface wwan0.IPv6 with address aaaa::bbbb:cccc:dddd:eeee.
Apr 22 14:00:00 myX1 avahi-daemon[1011]: New relevant interface wwan0.IPv6 for mDNS.
Apr 22 14:00:00 myX1 avahi-daemon[1011]: Registering new address record for aaaa::bbbb:cccc:dddd:eeee on wwan0.*.
Apr 22 14:00:00 myX1 NetworkManager[1336]: <info> dhclient started with pid 2824
Apr 22 14:00:00 myX1 NetworkManager[1336]: <info> Activation (wwan0) Stage 4 of 5 (IPv6 Configure Timeout) scheduled...
Apr 22 14:00:00 myX1 NetworkManager[1336]: <info> Activation (wwan0) Stage 3 of 5 (IP Configure Start) complete.
Apr 22 14:00:00 myX1 dhclient: Internet Systems Consortium DHCP Client 4.2.4
Apr 22 14:00:00 myX1 dhclient: Copyright 2004-2012 Internet Systems Consortium.
Apr 22 14:00:00 myX1 dhclient: All rights reserved.
Apr 22 14:00:00 myX1 NetworkManager[1336]: <info> Activation (wwan0) Stage 4 of 5 (IPv6 Configure Timeout) started...
Apr 22 14:00:00 myX1 NetworkManager[1336]: <info> Activation (wwan0) Stage 4 of 5 (IPv6 Configure Timeout) complete.
Apr 22 14:00:00 myX1 dhclient: For info, please visit https://www.isc.org/software/dhcp/
Apr 22 14:00:00 myX1 dhclient: 
Apr 22 14:00:00 myX1 NetworkManager[1336]: <info> (wwan0): DHCPv4 state changed nbi -> preinit
Apr 22 14:00:00 myX1 dhclient: Listening on LPF/wwan0/aa:bb:cc:dd:ee:ff
Apr 22 14:00:00 myX1 dhclient: Sending on   LPF/wwan0/aa:bb:cc:dd:ee:ff
Apr 22 14:00:00 myX1 dhclient: Sending on   Socket/fallback
Apr 22 14:00:00 myX1 dhclient: DHCPDISCOVER on wwan0 to 255.255.255.255 port 67 interval 3 (xid=0x70b2056c)
Apr 22 14:00:03 myX1 dhclient: DHCPDISCOVER on wwan0 to 255.255.255.255 port 67 interval 4 (xid=0x70b2056c)
Apr 22 14:00:07 myX1 dhclient: DHCPDISCOVER on wwan0 to 255.255.255.255 port 67 interval 11 (xid=0x70b2056c)
Apr 22 14:00:18 myX1 dhclient: DHCPDISCOVER on wwan0 to 255.255.255.255 port 67 interval 19 (xid=0x70b2056c)
Apr 22 14:00:37 myX1 dhclient: DHCPDISCOVER on wwan0 to 255.255.255.255 port 67 interval 16 (xid=0x70b2056c)
Apr 22 14:00:45 myX1 NetworkManager[1336]: <warn> (wwan0): DHCPv4 request timed out.
Apr 22 14:00:45 myX1 NetworkManager[1336]: <info> (wwan0): canceled DHCP transaction, DHCP client pid 2824
Apr 22 14:00:45 myX1 NetworkManager[1336]: <info> Activation (wwan0) Stage 4 of 5 (IPv4 Configure Timeout) scheduled...
Apr 22 14:00:45 myX1 NetworkManager[1336]: <info> Activation (wwan0) Stage 4 of 5 (IPv4 Configure Timeout) started...
Apr 22 14:00:45 myX1 NetworkManager[1336]: <info> (wwan0): device state change: ip-config -> failed (reason 'ip-config-unavailable') [70 120 5]
Apr 22 14:00:45 myX1 NetworkManager[1336]: <warn> Activation (wwan0) failed for connection 'bob'
Apr 22 14:00:45 myX1 NetworkManager[1336]: <info> Activation (wwan0) Stage 4 of 5 (IPv4 Configure Timeout) complete.
Apr 22 14:00:45 myX1 NetworkManager[1336]: <info> (wwan0): device state change: failed -> disconnected (reason 'none') [120 30 0]
Apr 22 14:00:45 myX1 NetworkManager[1336]: <info> (wwan0): deactivating device (reason 'none') [0]
Apr 22 14:00:45 myX1 modem-manager[1290]: <info>  Modem /org/freedesktop/ModemManager/Modems/0: state changed (connected -> disconnecting)
Apr 22 14:00:45 myX1 avahi-daemon[1011]: Interface wwan0.IPv6 no longer relevant for mDNS.
Apr 22 14:00:45 myX1 avahi-daemon[1011]: Leaving mDNS multicast group on interface wwan0.IPv6 with address aaaa::bbbb:cccc:dddd:eeee.
Apr 22 14:00:45 myX1 avahi-daemon[1011]: Withdrawing address record for aaaa::bbbb:cccc:dddd:eeee on wwan0.
Apr 22 14:00:45 myX1 modem-manager[1290]: <info>  Modem /org/freedesktop/ModemManager/Modems/0: state changed (disconnecting -> registered)

So it seems that the DHCP client can't get a configuration? This is somewhat strange. I used the same SIM with the same configuration on another machine also with 13.04 and I had no problems.

Does anybody have an idea on what I could do to find out whats going on? Is there a way to manually connect to see what stae the modem is in when the error occurs?

cheers
robert