Missing Push-Notifications via VPN



  • There should be I think ~/.cache/upstart/ubuntu-push-client.log can you check it please?



  • 2019/04/30 21:51:56 INFO connectivity check passed.
    2019/04/30 22:00:08 ERROR session error'ed out with read tcp 192.168.178.204:41869->188.166.175.79:5001: use of closed network connection
    2019/04/30 22:00:11 INFO connectivity check passed.
    2019/04/30 22:00:16 ERROR session error'ed out with read tcp 10.146.93.73:35134->188.166.175.79:5001: use of closed network connection
    2019/04/30 22:00:28 ERROR while GETting http://start.ubuntu.com/connectivity-check.html: Get http://start.ubuntu.com/connectivity-check.html: read tcp 10.146.93.73:48921->91.189.90.41:80: use of closed network connection
    2019/04/30 22:12:30 INFO dekko2.dekkoproject_dekko-notify_0.1.8-21b84 helper output: {"notification":{"card":{"actions":["appid://dekko2.dekkoproject/dekko/current-user-version"],"body":"Test2\n\n\nOutlook für Android<https://aka.ms/ghei36> herunterladen\n\n","persist":true,"popup":true,"summary":"Miriam Schaeffer"},"sound":true,"tag":"dekko-802","vibrate":{"duration":200,"pattern":[200,100],"repeat":2}}}
    2019/04/30 22:12:30 ERROR GetWindowStack call returned org.freedesktop.DBus.Error.ServiceUnknown: The name com.canonical.Unity.WindowStack was not provided by any .service files
    2019/04/30 22:16:14 INFO connectivity check passed.
    2019/04/30 22:16:16 INFO unicast app:com.ubuntu.telegram_telegram msg:JMDrV2uDEemtb4Z7KvMZ8A== payload:{"message":{"loc_key":"MESSAGE_TEXT","loc_args":["Miriam Sch\u00e4ffer","Test1"],"custom":{"msg_id":"1165","from_id":"730800194"}},"notification":{"tag":"chat","card":{"summary":"Miriam Sch\u00e4ffer","body":"Test1","popup":true,"persist":true},"sound":"buzz.mp3","vibrate":{"pattern":[200,100],"duration":200,"repeat":2},"emblem-counter":{"count":1,"visible":true}}}
    2019/04/30 22:16:17 INFO com.ubuntu.telegram_push_2.5.5.0 helper output: {
        "notification": {
            "card": {
                "actions": [
                    "telegram://chat/730800194"
                ],
                "body": "Test1",
                "icon": "",
                "persist": true,
                "popup": true,
                "summary": "Miriam Schäffer"
            },
            "emblem-counter": {
                "count": 1,
                "visible": true
            },
            "sound": true,
            "tag": "730800194",
            "vibrate": true
        }
    }
    2019/04/30 22:16:17 ERROR GetWindowStack call returned org.freedesktop.DBus.Error.ServiceUnknown: The name com.canonical.Unity.WindowStack was not provided by any .service files
    2019/04/30 22:20:46 INFO unicast app:com.ubuntu.telegram_telegram msg:b28JKWuFEemtb4Z7KvMZ8A== payload:{"message":{"loc_key":"MESSAGE_TEXT","loc_args":["Miriam Sch\u00e4ffer","Test3"],"custom":{"msg_id":"1166","from_id":"730800194"}},"notification":{"tag":"chat","card":{"summary":"Miriam Sch\u00e4ffer","body":"Test3","popup":true,"persist":true},"sound":"buzz.mp3","vibrate":{"pattern":[200,100],"duration":200,"repeat":2},"emblem-counter":{"count":1,"visible":true}}}
    2019/04/30 22:20:48 INFO com.ubuntu.telegram_push_2.5.5.0 helper output: {
        "notification": {
            "card": {
                "actions": [
                    "telegram://chat/730800194"
                ],
                "body": "Test3",
                "icon": "",
                "persist": true,
                "popup": true,
                "summary": "Miriam Schäffer"
            },
            "emblem-counter": {
                "count": 1,
                "visible": true
            },
            "sound": true,
            "tag": "730800194",
            "vibrate": true
        }
    }
    2019/04/30 22:20:48 ERROR GetWindowStack call returned org.freedesktop.DBus.Error.ServiceUnknown: The name com.canonical.Unity.WindowStack was not provided by any .service files
    2019/04/30 22:21:17 INFO dekko2.dekkoproject_dekko-notify_0.1.8-21b84 helper output: {"notification":{"card":{"actions":["appid://dekko2.dekkoproject/dekko/current-user-version"],"body":"Test4\n","persist":true,"popup":true,"summary":"Miriam Schaeffer"},"sound":true,"tag":"dekko-803","vibrate":{"duration":200,"pattern":[200,100],"repeat":2}}}
    2019/04/30 22:21:17 ERROR GetWindowStack call returned org.freedesktop.DBus.Error.ServiceUnknown: The name com.canonical.Unity.WindowStack was not provided by any .service files
    2019/04/30 22:21:46 ERROR session error'ed out with read tcp 10.146.93.73:35199->188.166.175.79:5001: use of closed network connection
    2019/04/30 22:21:58 ERROR while GETting http://start.ubuntu.com/connectivity-check.html: Get http://start.ubuntu.com/connectivity-check.html: net/http: request canceled while waiting for connection
    2019/04/30 22:31:59 INFO connectivity check passed.
    
    


  • @thilov It looks like you've got a somewhat cropped version of that, but it does seem there is some errors in there with a little more info that didn't get included in your copy/paste.



  • @dobey I fixed my copy and paste mistake.



  • And this is what I did/got:
    22:00 start VPN
    22:04 sent test mail and telegram-mail
    22:08 opend Dekko2
    22:12 opend Telegram and got Dekko2-push
    22:16 stopped VPN and got Telegram-push
    22:19 got same Telegram-push again
    22:20 sent testmails again and got the push



  • OK. First, to clarify, dekko does not use push notifications. It has another daemon running locally which polls to download e-mail, and then uses the local push notifications API to pop a notification, but it does not go through the push.ubports.com server.

    Telegram does send notifications via the push server, but even when working properly, can be very slow to arrive.

    As you see in the logs, there is some connectivity issue when switching between the network interfaces, and it can take many minutes before the client reconnects to the server. I would say that to test it properly, you need to stay connected to the VPN for quite some time, and not use the applications on the device while testing if push works, but instead send some telegram messages to your user on the phone, from a different account on a different device.

    If dekko is also having issues, the cause may be somehow related as it's with network issues, but it is probably a separate fix that would be needed, if the problem is in the client software rather than network config.



  • I tested ProtonVPN with similar results.

    Is a hardware issue possible? Sadly I doesn't have a second UT device for more testing.



  • @thilov said in Missing Push-Notifications via VPN:

    I tested ProtonVPN with similar results.

    Is a hardware issue possible? Sadly I doesn't have a second UT device for more testing.

    I doubt it's a hardware issue. It's most likely some configuration issue preventing connection to the services when you connect to VPN.

    You don't need a second UT device to test sending messages via telegram. You can have someone else send you messages (probably after 20 min or so), or use a reminder bot like https://t.me/SkeddyBot to schedule a few reminders.

    Also note however, that Telegram push notifications can be slow on the Telegram side at times, so to test it would be best to leave the phone connected and not use Telegram on it, for at least an hour, and have multiple reminders set to be sent to you over that time period.

    Another option is to install and set up https://caxton.herokuapp.com/ to send push notifications from a PC to test.



  • I tested that at the weekend.
    I rebooted the phone, connected to vpn and sent a telegram message from my wife's phone (a message of the UBports News Channel came also in this time).
    I waited 5! hours and nothing happend. The .log was similar to the one I posted before.



  • I just did what @circ did here: https://forums.ubports.com/topic/2693/where-are-vpn-logs-solved

    • I started the log, started the vpn and opend telegram

    I can't find any error but I'm just a noob. Might someone tell me if something can be found out here?

    t@t-ESPRIMO:~$ adb shell
    * daemon not running; starting now at tcp:5037
    * daemon started successfully
    phablet@ubuntu-phablet:~$ tail -f  /var/log/syslog
    May 10 08:21:35 ubuntu-phablet repowerd[905]: LibsuspendSuspendControl: allow_suspend(UPowerPowerSource121)
    May 10 08:21:37 ubuntu-phablet repowerd[905]: DefaultStateMachine: handle_user_activity_extending_power_state
    May 10 08:21:39 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: new_autobrightness_value(0.17)
    May 10 08:21:39 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: Transitioning brightness 0.14 => 0.17 in 3.00 steps 33333.33us each
    May 10 08:21:39 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: Transitioning brightness 0.14 => 0.17 done
    May 10 08:21:39 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_emit_brightness(0.166031), brightness_value=42
    May 10 08:21:43 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: new_autobrightness_value(0.10)
    May 10 08:21:43 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: Transitioning brightness 0.17 => 0.10 in 7.00 steps 14285.71us each
    May 10 08:21:43 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: Transitioning brightness 0.17 => 0.10 done
    May 10 08:21:44 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_emit_brightness(0.103096), brightness_value=26
    May 10 08:22:03 ubuntu-phablet repowerd[905]: DefaultStateMachine: handle_user_activity_extending_power_state
    May 10 08:22:03 ubuntu-phablet repowerd[905]: DefaultStateMachine: handle_user_activity_extending_power_state
    May 10 08:22:04 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: new_autobrightness_value(0.06)
    May 10 08:22:04 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: Transitioning brightness 0.10 => 0.06 in 4.00 steps 25000.00us each
    May 10 08:22:04 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: Transitioning brightness 0.10 => 0.06 done
    May 10 08:22:04 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_emit_brightness(0.063242), brightness_value=16
    May 10 08:22:08 ubuntu-phablet repowerd[905]: DefaultStateMachine: handle_user_activity_extending_power_state
    May 10 08:22:08 ubuntu-phablet NetworkManager[1978]: <info>  [1557469328.6664] audit: op="connection-activate" uuid="1b6418e0-1eaa-479c-8e6d-4610961953a5" name="Thilo" pid=3512 uid=32011 result="success"
    May 10 08:22:08 ubuntu-phablet NetworkManager[1978]: <info>  [1557469328.6984] vpn-connection[0x1d09108,1b6418e0-1eaa-479c-8e6d-4610961953a5,"Thilo",0]: Started the VPN service, PID 9099
    May 10 08:22:08 ubuntu-phablet NetworkManager[1978]: <info>  [1557469328.7825] vpn-connection[0x1d09108,1b6418e0-1eaa-479c-8e6d-4610961953a5,"Thilo",0]: Saw the service appear; activating connection
    May 10 08:22:09 ubuntu-phablet NetworkManager[1978]: <info>  [1557469329.0924] vpn-connection[0x1d09108,1b6418e0-1eaa-479c-8e6d-4610961953a5,"Thilo",0]: VPN plugin: state changed: starting (3)
    May 10 08:22:09 ubuntu-phablet nm-openvpn[9126]: OpenVPN 2.3.10 arm-unknown-linux-gnueabihf [SSL (OpenSSL)] [LZO] [EPOLL] [PKCS11] [MH] [IPv6] built on Jun 22 2017
    May 10 08:22:09 ubuntu-phablet nm-openvpn[9126]: library versions: OpenSSL 1.0.2g  1 Mar 2016, LZO 2.08
    May 10 08:22:09 ubuntu-phablet nm-openvpn[9126]: WARNING: No server certificate verification method has been enabled.  See http://openvpn.net/howto.html#mitm for more info.
    May 10 08:22:09 ubuntu-phablet nm-openvpn[9126]: NOTE: the current --script-security setting may allow this configuration to call user-defined scripts
    May 10 08:22:09 ubuntu-phablet nm-openvpn[9126]: WARNING: file '/home/phablet/Downloads/openvpn/Thilo.key' is group or others accessible
    May 10 08:22:09 ubuntu-phablet nm-openvpn[9126]: WARNING: file '/home/phablet/Downloads/openvpn/ta.key' is group or others accessible
    May 10 08:22:09 ubuntu-phablet nm-openvpn[9126]: Control Channel Authentication: using '/home/phablet/Downloads/openvpn/ta.key' as a OpenVPN static key file
    May 10 08:22:09 ubuntu-phablet repowerd[905]: UPowerPowerSource: change_device(/org/freedesktop/UPower/devices/battery_battery), is_present=1, state=1, percentage=99.00, temperature=23.80
    May 10 08:22:09 ubuntu-phablet nm-openvpn[9126]: NOTE: chroot will be delayed because of --client, --pull, or --up-delay
    May 10 08:22:09 ubuntu-phablet nm-openvpn[9126]: NOTE: UID/GID downgrade will be delayed because of --client, --pull, or --up-delay
    May 10 08:22:09 ubuntu-phablet nm-openvpn[9126]: UDPv4 link local: [undef]
    May 10 08:22:09 ubuntu-phablet nm-openvpn[9126]: UDPv4 link remote: [AF_INET]77.7.9.186:1194
    May 10 08:22:09 ubuntu-phablet nm-openvpn[9126]: [server_wOT8t17Vb1mk0jke] Peer Connection Initiated with [AF_INET]77.7.9.186:1194
    May 10 08:22:12 ubuntu-phablet nm-openvpn[9126]: Options error: Unrecognized option or missing parameter(s) in [PUSH-OPTIONS]:3: block-outside-dns (2.3.10)
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: nm_device_get_device_type: assertion 'NM_IS_DEVICE (self)' failed
    May 10 08:22:12 ubuntu-phablet nm-openvpn[9126]: TUN/TAP device tun0 opened
    May 10 08:22:12 ubuntu-phablet nm-openvpn[9126]: /usr/lib/NetworkManager/nm-openvpn-service-openvpn-helper --bus-name org.freedesktop.NetworkManager.openvpn.Connection_8 --tun -- tun0 1500 1572 10.8.0.4 255.255.255.0 init
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.2322] manager: (tun0): new Tun device (/org/freedesktop/NetworkManager/Devices/4)
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.2926] vpn-connection[0x1d09108,1b6418e0-1eaa-479c-8e6d-4610961953a5,"Thilo",0]: VPN connection: (IP Config Get) reply received.
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3019] vpn-connection[0x1d09108,1b6418e0-1eaa-479c-8e6d-4610961953a5,"Thilo",27:(tun0)]: VPN connection: (IP4 Config Get) reply received
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3044] vpn-connection[0x1d09108,1b6418e0-1eaa-479c-8e6d-4610961953a5,"Thilo",27:(tun0)]: Data: VPN Gateway: 77.7.9.186
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3046] vpn-connection[0x1d09108,1b6418e0-1eaa-479c-8e6d-4610961953a5,"Thilo",27:(tun0)]: Data: Tunnel Device: tun0
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3047] vpn-connection[0x1d09108,1b6418e0-1eaa-479c-8e6d-4610961953a5,"Thilo",27:(tun0)]: Data: IPv4 configuration:
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3048] vpn-connection[0x1d09108,1b6418e0-1eaa-479c-8e6d-4610961953a5,"Thilo",27:(tun0)]: Data:   Internal Gateway: 10.8.0.1
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3050] vpn-connection[0x1d09108,1b6418e0-1eaa-479c-8e6d-4610961953a5,"Thilo",27:(tun0)]: Data:   Internal Address: 10.8.0.4
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3051] vpn-connection[0x1d09108,1b6418e0-1eaa-479c-8e6d-4610961953a5,"Thilo",27:(tun0)]: Data:   Internal Prefix: 24
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3052] vpn-connection[0x1d09108,1b6418e0-1eaa-479c-8e6d-4610961953a5,"Thilo",27:(tun0)]: Data:   Internal Point-to-Point Address: 10.8.0.4
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3053] vpn-connection[0x1d09108,1b6418e0-1eaa-479c-8e6d-4610961953a5,"Thilo",27:(tun0)]: Data:   Maximum Segment Size (MSS): 0
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3054] vpn-connection[0x1d09108,1b6418e0-1eaa-479c-8e6d-4610961953a5,"Thilo",27:(tun0)]: Data:   Static Route: 192.168.178.1/24   Next Hop: 10.8.0.1
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3056] vpn-connection[0x1d09108,1b6418e0-1eaa-479c-8e6d-4610961953a5,"Thilo",27:(tun0)]: Data:   Forbid Default Route: no
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3057] vpn-connection[0x1d09108,1b6418e0-1eaa-479c-8e6d-4610961953a5,"Thilo",27:(tun0)]: Data:   Internal DNS: 192.168.178.1
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3058] vpn-connection[0x1d09108,1b6418e0-1eaa-479c-8e6d-4610961953a5,"Thilo",27:(tun0)]: Data:   DNS Domain: '(none)'
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3059] vpn-connection[0x1d09108,1b6418e0-1eaa-479c-8e6d-4610961953a5,"Thilo",27:(tun0)]: Data: No IPv6 configuration
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <error> [1557469332.3109] platform-linux: do-add-ip4-address[2: 10.69.85.211/24,0.0.0.0]: failure 17 (File exists)
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3120] platform-linux: do_add_addroute: seq_restul == -EEXISTS; treating as OK
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3130] vpn-connection[0x1d09108,1b6418e0-1eaa-479c-8e6d-4610961953a5,"Thilo",27:(tun0)]: VPN connection: (IP Config Get) complete
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3141] vpn-connection[0x1d09108,1b6418e0-1eaa-479c-8e6d-4610961953a5,"Thilo",27:(tun0)]: VPN plugin: state changed: started (4)
    May 10 08:22:12 ubuntu-phablet nm-openvpn[9126]: chroot to '/var/lib/openvpn/chroot' and cd to '/' succeeded
    May 10 08:22:12 ubuntu-phablet nm-openvpn[9126]: GID set to nm-openvpn
    May 10 08:22:12 ubuntu-phablet nm-openvpn[9126]: UID set to nm-openvpn
    May 10 08:22:12 ubuntu-phablet nm-openvpn[9126]: Initialization Sequence Completed
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3289] manager: NetworkManager state is now CONNECTED_LOCAL
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3293] manager: NetworkManager state is now CONNECTED_GLOBAL
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3299] dns-mgr: Writing DNS information to /sbin/resolvconf
    May 10 08:22:12 ubuntu-phablet dnsmasq[3202]: setting upstream servers from DBus
    May 10 08:22:12 ubuntu-phablet dnsmasq[3202]: using nameserver 192.168.178.1#53
    May 10 08:22:12 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_clearWakeup(:1.100,248)
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3831] devices added (path: /sys/devices/virtual/net/tun0, iface: tun0)
    May 10 08:22:12 ubuntu-phablet dbus[762]: [system] Activating service name='org.freedesktop.nm_dispatcher' (using servicehelper)
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3862] device added (path: /sys/devices/virtual/net/tun0, iface: tun0): no ifupdown configuration found.
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.3910] device (tun0): state change: unmanaged -> unavailable (reason 'connection-assumed') [10 20 41]
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.4016] keyfile: add connection in-memory (5f6fe794-ab81-44ae-9800-7f6b27290ca0,"tun0")
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.4073] device (tun0): state change: unavailable -> disconnected (reason 'connection-assumed') [20 30 41]
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.4084] policy: Device 'tun0' has no connection; scheduling activate_check in 0 seconds.
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.4139] device (tun0): Activation: starting connection 'tun0' (5f6fe794-ab81-44ae-9800-7f6b27290ca0)
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.4172] device (tun0): state change: disconnected -> prepare (reason 'none') [30 40 0]
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.4196] device (tun0): state change: prepare -> config (reason 'none') [40 50 0]
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.4214] device (tun0): state change: config -> ip-config (reason 'none') [50 70 0]
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <error> [1557469332.4237] platform-linux: do-add-ip4-address[27: 10.8.0.4/24]: failure 17 (File exists)
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.4238] platform-linux: do_add_addroute: seq_restul == -EEXISTS; treating as OK
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.4239] device (tun0): state change: ip-config -> ip-check (reason 'none') [70 80 0]
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.4260] device (tun0): state change: ip-check -> secondaries (reason 'none') [80 90 0]
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.4277] device (tun0): state change: secondaries -> activated (reason 'none') [90 100 0]
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.4372] manager: NetworkManager state is now CONNECTED_LOCAL
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.4377] manager: NetworkManager state is now CONNECTED_GLOBAL
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.4381] policy: set 'tun0' (tun0) as default for IPv4 routing and DNS
    May 10 08:22:12 ubuntu-phablet NetworkManager[1978]: <info>  [1557469332.4385] device (tun0): Activation: successful, device activated.
    May 10 08:22:12 ubuntu-phablet dbus[762]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
    May 10 08:22:12 ubuntu-phablet nm-dispatcher: req:1 'vpn-up' [tun0]: new request (3 scripts)
    May 10 08:22:12 ubuntu-phablet nm-dispatcher: req:1 'vpn-up' [tun0]: start running ordered scripts...
    May 10 08:22:12 ubuntu-phablet nm-dispatcher: req:2 'up' [tun0]: new request (3 scripts)
    May 10 08:22:12 ubuntu-phablet root: 02default_route_workaround: (tun0): vpn-up: flushing routing table (proto boot)
    May 10 08:22:12 ubuntu-phablet nm-dispatcher: req:2 'up' [tun0]: start running ordered scripts...
    May 10 08:22:13 ubuntu-phablet root: 02default_route_workaround: (tun0): up: flushing routing table (proto boot)
    May 10 08:22:14 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: new_autobrightness_value(0.11)
    May 10 08:22:14 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: Transitioning brightness 0.06 => 0.11 in 5.00 steps 20000.00us each
    May 10 08:22:14 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_requestWakeup(:1.100,ubuntu push client,1557469337)
    May 10 08:22:14 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_requestWakeup(:1.100,ubuntu push client,1557469337) => 249
    May 10 08:22:14 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: Transitioning brightness 0.06 => 0.11 done
    May 10 08:22:14 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_emit_brightness(0.105389), brightness_value=27
    May 10 08:22:17 ubuntu-phablet repowerd[905]: LibsuspendSuspendControl: disallow_suspend(Wakeup_249122)
    May 10 08:22:17 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_emit_Wakeup()
    May 10 08:22:17 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_clearWakeup(:1.84,247)
    May 10 08:22:17 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_requestWakeup(:1.84,indicator-datetime,1557478800)
    May 10 08:22:17 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_requestWakeup(:1.84,indicator-datetime,1557478800) => 250
    May 10 08:22:17 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_requestSysState(:1.100,ubuntu push client,1)
    May 10 08:22:17 ubuntu-phablet repowerd[905]: LibsuspendSuspendControl: disallow_suspend(UnityScreenService)
    May 10 08:22:17 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_requestSysState(:1.100,ubuntu push client,1) => 138
    May 10 08:22:18 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: new_autobrightness_value(0.09)
    May 10 08:22:18 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: Transitioning brightness 0.11 => 0.09 in 2.00 steps 50000.00us each
    May 10 08:22:19 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: Transitioning brightness 0.11 => 0.09 done
    May 10 08:22:19 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_emit_brightness(0.087549), brightness_value=22
    May 10 08:22:20 ubuntu-phablet repowerd[905]: LibsuspendSuspendControl: allow_suspend(Wakeup_249122)
    May 10 08:22:21 ubuntu-phablet ntpdate[9205]: adjust time server 91.189.89.199 offset -0.258938 sec
    May 10 08:22:25 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_requestWakeup(:1.100,ubuntu push client,1557469645)
    May 10 08:22:25 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_requestWakeup(:1.100,ubuntu push client,1557469645) => 251
    May 10 08:22:25 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_clearSysState(:1.100,138)
    May 10 08:22:25 ubuntu-phablet repowerd[905]: LibsuspendSuspendControl: allow_suspend(UnityScreenService)
    May 10 08:22:47 ubuntu-phablet signond[9298]: QObject::disconnect: Unexpected null parameter
    May 10 08:22:49 ubuntu-phablet repowerd[905]: UPowerPowerSource: change_device(/org/freedesktop/UPower/devices/battery_battery), is_present=1, state=1, percentage=99.00, temperature=24.00
    May 10 08:23:04 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: new_autobrightness_value(0.11)
    May 10 08:23:04 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: Transitioning brightness 0.09 => 0.11 in 2.00 steps 50000.00us each
    May 10 08:23:04 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: Transitioning brightness 0.09 => 0.11 done
    May 10 08:23:04 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_emit_brightness(0.105905), brightness_value=27
    May 10 08:23:29 ubuntu-phablet repowerd[905]: UPowerPowerSource: change_device(/org/freedesktop/UPower/devices/battery_battery), is_present=1, state=1, percentage=99.00, temperature=24.10
    May 10 08:24:09 ubuntu-phablet repowerd[905]: UPowerPowerSource: change_device(/org/freedesktop/UPower/devices/battery_battery), is_present=1, state=1, percentage=99.00, temperature=24.30
    May 10 08:24:30 ubuntu-phablet repowerd[905]: DefaultStateMachine: handle_user_activity_extending_power_state
    May 10 08:24:30 ubuntu-phablet repowerd[905]: DefaultStateMachine: handle_user_activity_extending_power_state
    May 10 08:24:38 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: new_autobrightness_value(0.09)
    May 10 08:24:38 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: Transitioning brightness 0.11 => 0.09 in 2.00 steps 50000.00us each
    May 10 08:24:38 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: Transitioning brightness 0.11 => 0.09 done
    May 10 08:24:38 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_emit_brightness(0.087364), brightness_value=22
    May 10 08:24:39 ubuntu-phablet repowerd[905]: DefaultStateMachine: handle_user_activity_extending_power_state
    May 10 08:24:39 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_requestSysState(:1.77,active,1)
    May 10 08:24:39 ubuntu-phablet repowerd[905]: LibsuspendSuspendControl: disallow_suspend(UnityScreenService)
    May 10 08:24:39 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_requestSysState(:1.77,active,1) => 139
    May 10 08:24:41 ubuntu-phablet dbus[2190]: apparmor="DENIED" operation="dbus_method_call"  bus="session" path="/com/ubuntu/connectivity1/Private" interface="org.freedesktop.DBus.Properties" member="GetAll" mask="send" name="com.ubuntu.connectivity1" pid=9870 label="com.ubuntu.telegram_telegram_2.5.5.0" peer_pid=3512 peer_label="unconfined"
    May 10 08:24:41 ubuntu-phablet dbus[2190]: apparmor="DENIED" operation="dbus_method_call"  bus="session" path="/com/canonical/libertine/Service/Operations" interface="com.canonical.libertine.Service.Operations" member="list" mask="send" name="com.canonical.libertine.Service" pid=9870 label="com.ubuntu.telegram_telegram_2.5.5.0" peer_pid=3363 peer_label="unconfined"
    May 10 08:24:41 ubuntu-phablet dbus[2190]: apparmor="DENIED" operation="dbus_method_call"  bus="session" path="/com/canonical/libertine/Service/OperationsMonitor" interface="com.canonical.libertine.Service.OperationsMonitor" member="running" mask="send" name="com.canonical.libertine.Service" pid=9870 label="com.ubuntu.telegram_telegram_2.5.5.0" peer_pid=3363 peer_label="unconfined"
    May 10 08:24:41 ubuntu-phablet dbus[2190]: apparmor="DENIED" operation="dbus_method_call"  bus="session" path="/com/canonical/libertine/Service/OperationsMonitor" interface="com.canonical.libertine.Service.OperationsMonitor" member="last_error" mask="send" name="com.canonical.libertine.Service" pid=9870 label="com.ubuntu.telegram_telegram_2.5.5.0" peer_pid=3363 peer_label="unconfined"
    May 10 08:24:41 ubuntu-phablet dbus[2190]: apparmor="DENIED" operation="dbus_method_call"  bus="session" path="/com/canonical/libertine/Service/OperationsMonitor" interface="com.canonical.libertine.Service.OperationsMonitor" member="result" mask="send" name="com.canonical.libertine.Service" pid=9870 label="com.ubuntu.telegram_telegram_2.5.5.0" peer_pid=3363 peer_label="unconfined"
    May 10 08:24:42 ubuntu-phablet dbus[2190]: apparmor="DENIED" operation="dbus_method_call"  bus="session" path="/com/ubuntu/connectivity1/Private" interface="org.freedesktop.DBus.Properties" member="GetAll" mask="send" name="com.ubuntu.connectivity1" pid=9870 label="com.ubuntu.telegram_telegram_2.5.5.0" peer_pid=3512 peer_label="unconfined"
    May 10 08:24:45 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: new_autobrightness_value(0.06)
    May 10 08:24:45 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: Transitioning brightness 0.09 => 0.06 in 3.00 steps 33333.33us each
    May 10 08:24:45 ubuntu-phablet repowerd[905]: BacklightBrightnessControl: Transitioning brightness 0.09 => 0.06 done
    May 10 08:24:45 ubuntu-phablet repowerd[905]: UnityScreenService: dbus_emit_brightness(0.062878), brightness_value=16
    May 10 08:24:49 ubuntu-phablet repowerd[905]: UPowerPowerSource: change_device(/org/freedesktop/UPower/devices/battery_battery), is_present=1, state=1, percentage=99.00, temperature=24.40
    May 10 08:25:14 ubuntu-phablet signond[9941]: QObject::disconnect: Unexpected null parameter
    May 10 08:25:29 ubuntu-phablet repowerd[905]: UPowerPowerSource: change_device(/org/freedesktop/UPower/devices/battery_battery), is_present=1, state=1, percentage=99.00, temperature=24.60
    
    
    

Log in to reply