[Freedombox-discuss] Network manager auto-upgraded this morning, ppp no longer connects.

A. F. Cano afc at shibaya.lonestar.org
Sat Dec 31 20:18:01 UTC 2016


Hello everyone,

In the latest automatic software upgrade, I noticed that network-manager was
upgraded.  I no longer can get ppp started like it did before.

I think the relevant log lines are:

Dec 31 13:12:33 fbx NetworkManager[370]: <warn>  [1483207953.9875] modem-broadband[ttyACM0]: failed to connect modem: Network timeout
...
Dec 31 13:12:34 fbx NetworkManager[370]: <warn>  [1483207953.9924] device (ttyACM0): Activation: failed for connection 'ppp'

The complete log is appended below.

If I start ppp the old-fashined way, via "sudo pon cell" it works fine, I get
the connection established, local and remote ip addresses set and the name
servers set.

I even tried putting back all the ppp.* options that I once thought were
necessary (they weren't) and it didn't make a difference.

The "nmcli con show ppp" is appended at the end.

This line (just <info>) should not be a problem, but who knows.  This is a
cdma connection, not gsm.

Dec 31 13:12:33 fbx NetworkManager[370]: <info>  [1483207953.9877] device (ttyACM0): state change: prepare -> failed (reason 'gsm-registration-timeout') [40 120 32]

I used to get a CONNECTED_GLOBAL message and now I only get the CONNECTED_LOCAL
one.

Does anyone know what happened?  Any hints as to what to change or where to
look? I'm running the testing version of FreedomBox, with plinth 0.12
(just recently upgraded).

Thank you and happy new year.

Augustine


Dec 31 13:11:33 fbx NetworkManager[370]: <info>  [1483207893.0539] manager: (ttyACM0): new Broadband device (/org/freedesktop/NetworkManager/Devices/8)
Dec 31 13:11:33 fbx NetworkManager[370]: <info>  [1483207893.0555] device (ttyACM0): state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Dec 31 13:11:33 fbx NetworkManager[370]: <info>  [1483207893.0577] device (ttyACM0): modem state 'enabling'
Dec 31 13:11:33 fbx NetworkManager[370]: <info>  [1483207893.0582] modem-broadband[ttyACM0]: failed to retrieve SIM object: No SIM object available
Dec 31 13:11:33 fbx NetworkManager[370]: <info>  [1483207893.0599] device (ttyACM0): state change: unavailable -> disconnected (reason 'none') [20 30 0]
Dec 31 13:11:33 fbx NetworkManager[370]: <info>  [1483207893.0618] policy: auto-activating connection 'ppp'
Dec 31 13:11:33 fbx NetworkManager[370]: <info>  [1483207893.0664] device (ttyACM0): Activation: starting connection 'ppp' (f2cc6f30-1726-42c2-b580-3ac8a98a21ec)
Dec 31 13:11:33 fbx NetworkManager[370]: <info>  [1483207893.0670] device (ttyACM0): state change: disconnected -> prepare (reason 'none') [30 40 0]
Dec 31 13:11:33 fbx NetworkManager[370]: <info>  [1483207893.0675] manager: NetworkManager state is now CONNECTING
Dec 31 13:11:33 fbx NetworkManager[370]: <info>  [1483207893.0747] device (ttyACM0): state change: prepare -> need-auth (reason 'none') [40 60 0]
Dec 31 13:11:33 fbx NetworkManager[370]: <info>  [1483207893.0839] device (ttyACM0): state change: need-auth -> prepare (reason 'none') [60 40 0]
Dec 31 13:12:33 fbx NetworkManager[370]: <warn>  [1483207953.9875] modem-broadband[ttyACM0]: failed to connect modem: Network timeout
Dec 31 13:12:33 fbx NetworkManager[370]: <info>  [1483207953.9877] device (ttyACM0): state change: prepare -> failed (reason 'gsm-registration-timeout') [40 120 32]
Dec 31 13:12:33 fbx NetworkManager[370]: <info>  [1483207953.9885] manager: NetworkManager state is now CONNECTED_LOCAL
Dec 31 13:12:34 fbx NetworkManager[370]: <warn>  [1483207953.9924] device (ttyACM0): Activation: failed for connection 'ppp'
Dec 31 13:12:34 fbx NetworkManager[370]: <info>  [1483207953.9957] device (ttyACM0): state change: failed -> disconnected (reason 'none') [120 30 0]
Dec 31 13:12:34 fbx NetworkManager[370]: <info>  [1483207954.0054] policy: auto-activating connection 'ppp'
Dec 31 13:12:34 fbx NetworkManager[370]: <info>  [1483207954.0135] device (ttyACM0): Activation: starting connection 'ppp' (f2cc6f30-1726-42c2-b580-3ac8a98a21ec)
Dec 31 13:12:34 fbx NetworkManager[370]: <info>  [1483207954.0142] device (ttyACM0): state change: disconnected -> prepare (reason 'none') [30 40 0]
Dec 31 13:12:34 fbx NetworkManager[370]: <info>  [1483207954.0146] manager: NetworkManager state is now CONNECTING
Dec 31 13:12:34 fbx NetworkManager[370]: <info>  [1483207954.0180] device (ttyACM0): state change: prepare -> need-auth (reason 'none') [40 60 0]
Dec 31 13:12:34 fbx NetworkManager[370]: <warn>  [1483207954.0347] firewall: [0x55f13cf2c8f0,remove:"ttyACM0"]: complete: request failed (UNKNOWN_INTERFACE: 'ttyACM0' is not in any zone)
Dec 31 13:12:34 fbx NetworkManager[370]: <info>  [1483207954.0353] device (ttyACM0): state change: need-auth -> prepare (reason 'none') [60 40 0]

Dec 31 13:13:36 fbx NetworkManager[370]: <warn>  [1483208016.9931] modem-broadband[ttyACM0]: failed to connect modem: Network timeout
Dec 31 13:13:36 fbx NetworkManager[370]: <info>  [1483208016.9933] device (ttyACM0): state change: prepare -> failed (reason 'gsm-registration-timeout') [40 120 32]
Dec 31 13:13:36 fbx NetworkManager[370]: <info>  [1483208016.9941] manager: NetworkManager state is now CONNECTED_LOCAL
Dec 31 13:13:36 fbx NetworkManager[370]: <warn>  [1483208016.9967] device (ttyACM0): Activation: failed for connection 'ppp'
Dec 31 13:13:37 fbx NetworkManager[370]: <info>  [1483208017.0010] device (ttyACM0): state change: failed -> disconnected (reason 'none') [120 30 0]
Dec 31 13:13:37 fbx NetworkManager[370]: <info>  [1483208017.0120] policy: auto-activating connection 'ppp'
Dec 31 13:13:37 fbx NetworkManager[370]: <info>  [1483208017.0318] device (ttyACM0): Activation: starting connection 'ppp' (f2cc6f30-1726-42c2-b580-3ac8a98a21ec)
Dec 31 13:13:37 fbx NetworkManager[370]: <warn>  [1483208017.0323] firewall: [0x55f13cefd600,remove:"ttyACM0"]: complete: request failed (UNKNOWN_INTERFACE: 'ttyACM0' is not in any zone)
Dec 31 13:13:37 fbx NetworkManager[370]: <info>  [1483208017.0369] device (ttyACM0): state change: disconnected -> prepare (reason 'none') [30 40 0]
Dec 31 13:13:37 fbx NetworkManager[370]: <info>  [1483208017.0379] manager: NetworkManager state is now CONNECTING
Dec 31 13:13:37 fbx NetworkManager[370]: <info>  [1483208017.0436] device (ttyACM0): state change: prepare -> need-auth (reason 'none') [40 60 0]
Dec 31 13:13:37 fbx NetworkManager[370]: <info>  [1483208017.0618] device (ttyACM0): state change: need-auth -> prepare (reason 'none') [60 40 0]
Dec 31 13:14:39 fbx NetworkManager[370]: <warn>  [1483208079.9893] modem-broadband[ttyACM0]: failed to connect modem: Network timeout
Dec 31 13:14:39 fbx NetworkManager[370]: <info>  [1483208079.9895] device (ttyACM0): state change: prepare -> failed (reason 'gsm-registration-timeout') [40 120 32]
Dec 31 13:14:39 fbx NetworkManager[370]: <info>  [1483208079.9904] manager: NetworkManager state is now CONNECTED_LOCAL
Dec 31 13:14:39 fbx NetworkManager[370]: <warn>  [1483208079.9928] device (ttyACM0): Activation: failed for connection 'ppp'
Dec 31 13:14:40 fbx NetworkManager[370]: <info>  [1483208080.0037] device (ttyACM0): state change: failed -> disconnected (reason 'none') [120 30 0]
Dec 31 13:14:40 fbx NetworkManager[370]: <info>  [1483208080.0120] policy: auto-activating connection 'ppp'
Dec 31 13:14:40 fbx NetworkManager[370]: <info>  [1483208080.0153] device (ttyACM0): Activation: starting connection 'ppp' (f2cc6f30-1726-42c2-b580-3ac8a98a21ec)
Dec 31 13:14:40 fbx NetworkManager[370]: <info>  [1483208080.0158] device (ttyACM0): state change: disconnected -> prepare (reason 'none') [30 40 0]
Dec 31 13:14:40 fbx NetworkManager[370]: <info>  [1483208080.0163] manager: NetworkManager state is now CONNECTING
Dec 31 13:14:40 fbx NetworkManager[370]: <info>  [1483208080.0180] device (ttyACM0): state change: prepare -> need-auth (reason 'none') [40 60 0]
Dec 31 13:14:40 fbx NetworkManager[370]: <warn>  [1483208080.0339] firewall: [0x7ff0d00054c0,remove:"ttyACM0"]: complete: request failed (UNKNOWN_INTERFACE: 'ttyACM0' is not in any zone)
Dec 31 13:14:40 fbx NetworkManager[370]: <info>  [1483208080.0349] device (ttyACM0): state change: need-auth -> prepare (reason 'none') [60 40 0]
Dec 31 13:15:42 fbx NetworkManager[370]: <warn>  [1483208142.9909] modem-broadband[ttyACM0]: failed to connect modem: Network timeout
Dec 31 13:15:42 fbx NetworkManager[370]: <info>  [1483208142.9911] device (ttyACM0): state change: prepare -> failed (reason 'gsm-registration-timeout') [40 120 32]
Dec 31 13:15:42 fbx NetworkManager[370]: <info>  [1483208142.9919] manager: NetworkManager state is now CONNECTED_LOCAL
Dec 31 13:15:42 fbx NetworkManager[370]: <info>  [1483208142.9929] policy: disabling autoconnect for connection 'ppp'.
Dec 31 13:15:43 fbx NetworkManager[370]: <warn>  [1483208142.9952] device (ttyACM0): Activation: failed for connection 'ppp'
Dec 31 13:15:43 fbx NetworkManager[370]: <info>  [1483208143.0065] device (ttyACM0): state change: failed -> disconnected (reason 'none') [120 30 0]
Dec 31 13:15:43 fbx NetworkManager[370]: <warn>  [1483208143.0169] firewall: [0x55f13cf5c720,remove:"ttyACM0"]: complete: request failed (UNKNOWN_INTERFACE: 'ttyACM0' is not in any zone)

$ nmcli con show ppp 
connection.id:                          ppp
connection.uuid:                        f2cc6f30-1726-42c2-b580-3ac8a98a21ec
connection.stable-id:                   --
connection.interface-name:              --
connection.type:                        cdma
connection.autoconnect:                 yes
connection.autoconnect-priority:        0
connection.timestamp:                   1483189433
connection.read-only:                   no
connection.permissions:                 
connection.zone:                        external
connection.master:                      --
connection.slave-type:                  --
connection.autoconnect-slaves:          -1 (default)
connection.secondaries:                 
connection.gateway-ping-timeout:        0
connection.metered:                     unknown
connection.lldp:                        -1 (default)
ipv4.method:                            auto
ipv4.dns:                               
ipv4.dns-search:                        
ipv4.dns-options:                       (default)
ipv4.dns-priority:                      0
ipv4.addresses:                         
ipv4.gateway:                           --
ipv4.routes:                            
ipv4.route-metric:                      -1
ipv4.ignore-auto-routes:                no
ipv4.ignore-auto-dns:                   no
ipv4.dhcp-client-id:                    --
ipv4.dhcp-timeout:                      0
ipv4.dhcp-send-hostname:                yes
ipv4.dhcp-hostname:                     --
ipv4.dhcp-fqdn:                         --
ipv4.never-default:                     no
ipv4.may-fail:                          yes
ipv4.dad-timeout:                       -1 (default)
ipv6.method:                            auto
ipv6.dns:                               
ipv6.dns-search:                        
ipv6.dns-options:                       (default)
ipv6.dns-priority:                      0
ipv6.addresses:                         
ipv6.gateway:                           --
ipv6.routes:                            
ipv6.route-metric:                      -1
ipv6.ignore-auto-routes:                no
ipv6.ignore-auto-dns:                   no
ipv6.never-default:                     no
ipv6.may-fail:                          yes
ipv6.ip6-privacy:                       -1 (unknown)
ipv6.addr-gen-mode:                     stable-privacy
ipv6.dhcp-send-hostname:                yes
ipv6.dhcp-hostname:                     --
ipv6.token:                             --
cdma.number:                            #777
cdma.username:                          qnc
cdma.password:                          <hidden>
cdma.password-flags:                    0 (none)




More information about the Freedombox-discuss mailing list