[4.5.0.16] Hotspot stopped working on XperiaX after update

REPRODUCIBILITY: 100%
OS VERSION: 4.5.0.16
HARDWARE: XperiaX
UI LANGUAGE: Finnish
REGRESSION:

DESCRIPTION:

Hotspot stopped working after update. It can be switched on and phone seems to work, but no other device can see the network.

PRECONDITIONS:

Smoothly installed version. Tried to refresh repository and made several boots.

STEPS TO REPRODUCE:

  1. Switch hotspot on
  2. Try to connect

EXPECTED RESULT:

Connection is established

ACTUAL RESULT:

No connection

MODIFICATIONS:

No patches on the phone

ADDITIONAL INFORMATION:

5 Likes

Do you have an IPv4 address when using mobile data?

When testing webpages with my browser, it seems that both IPv4 and IPv6 are available.

Just to be sure. Is it a regression or not? I just tested on a X running SFOS 4.4 and it works. I’ll report later if it still works once I updated to the latest version.

Edit: It’s indeed a regression. I can reproduce your bug on the 4.5.0.18

3 Likes

Same problem for me with after upgrade to 4.5.0.18!

2 Likes

Same. It started with 4.5.0.16 and is still the same with 4.5.0.18.

In addition, if the wifi is on and I turn Internet sharing on and then off again, the wifi won’t connect to any network anymore. Not the network it was connected to before, nor any other. I have to turn WLAN off and then on again for the wifi to connect again. (If the WLAN was off before starting internet sharing, then turning Internet sharing on and off again correctly returns WLAN to off.)

1 Like

Thanks for reporting. A bug filed into Jolla Bugzilla.

I wonder if the network reset in the Utilities would help to bypass the issue.

Anyone willing to collect the oFono and journal logs as instructed here:

No, ‘restart network’ from the utilities does not help. I pressed the Restart button, waited for the OK message, pressed the Connect button from the top pulldown menu and selected a hotspot. But, after a couple of seconds watching the spinning wheel, I got the same error again: ‘Sorry. Could not connect to the selected network’.

I tried restarting the network a second time, and even a third time, but no difference. Only turning WLAN off and on works to let the wifi connect again. (Reboot works, too
)

The oFono logger from the Jolla store doesn’t seem to work. It installs, but says it can’t make logs, probably due to sandboxing.

But the journal I can provide:

Feb 27 18:25:32 ops mce[600]: powerkey.c: pwrkey_datapipe_keypress_event_cb(): powerkey pressed
Feb 27 18:25:32 ops mce[600]: powerkey.c: pwrkey_datapipe_keypress_event_cb(): powerkey released
Feb 27 18:25:32 ops mce[600]: modules/proximity.c: mp_datapipe_set_proximity_sensor_actual(): state: UNDEF -> OPEN
Feb 27 18:25:32 ops mce[600]: tklock.c: mce_tklock_unblank(): display state req: ON
Feb 27 18:25:32 ops mce[600]: modules/display.c: mdy_display_state_leave(): current display state = POWER_UP
Feb 27 18:25:33 ops lipstick[2382]: [D] unknown:0 - unsleepDisplay
Feb 27 18:25:33 ops kernel: @@@@ panel power on @@@@
Feb 27 18:25:33 ops kernel: mdss_dsi_panel_on: ctrl=ffffffc0ad558018 ndx=0
Feb 27 18:25:33 ops kernel: clearpad clearpad: (clearpad_initialize:2236) initialize device
Feb 27 18:25:33 ops kernel: clearpad clearpad: (clearpad_initialize:2251) device status 0x81
Feb 27 18:25:33 ops kernel: clearpad clearpad: (clearpad_initialize:2259) bootloader revision 7.003
Feb 27 18:25:33 ops kernel: clearpad clearpad: (clearpad_initialize:2281) FW status 0x40
Feb 27 18:25:33 ops kernel: clearpad clearpad: (clearpad_update_chip_id:5713) chip_id=0x3a
Feb 27 18:25:33 ops kernel: clearpad clearpad: (clearpad_touch_config_dt_for_chip_id:5538) read settings for S3330
Feb 27 18:25:33 ops kernel: clearpad clearpad: (clearpad_prepare_f12_2d:2209) x_max=1079, y_max=1919, n_fingers=10, n_bytes_per_object=8
Feb 27 18:25:33 ops kernel: clearpad clearpad: (clearpad_initialize:2349) result: S3330, family 0x90, fw rev 0x07.18, extra 0x06, (no fw update)
Feb 27 18:25:33 ops kernel: clearpad clearpad: (clearpad_process_F01_RMI:4032) device reset
Feb 27 18:25:33 ops kernel: clearpad clearpad: (clearpad_set_resume_mode:3254) ignore interrupt 0x00
Feb 27 18:25:33 ops kernel: clearpad clearpad: (clearpad_set_irq:966) irq was enabled
Feb 27 18:25:33 ops kernel: clearpad clearpad: (clearpad_set_resume_mode:3259) set resume mode (rc=0)
Feb 27 18:25:33 ops kernel: clearpad clearpad: (clearpad_process_irq:4152) no work, interrupt=[0x00]
Feb 27 18:25:33 ops mce[600]: modules/display.c: mdy_display_state_enter(): current display state = ON
Feb 27 18:25:35 ops mce[600]: tklock.c: tklock_dbus_notification_end_cb(): notification end from name=:1.82 owner=:1.82 pid=2382 uid=100000 gid=999 priv=1 cmd=/usr/bin/lipstick -plugin evdevtouch:/dev/touchscreen -plugin e
Feb 27 18:25:37 ops mce[600]: modules/proximity.c: mp_datapipe_set_proximity_sensor_actual(): state: OPEN -> UNDEF
Feb 27 18:25:37 ops invoker[3327]: WARNING: An inactive plugin is misbehaving - tried to show a window!
Feb 27 18:25:37 ops invoker[3327]: WARNING: requestActivate() called for  QQuickView(0x5fc5d8)  which has Qt::WindowDoesNotAcceptFocus set.
Feb 27 18:25:38 ops invoker[3327]: WARNING: An inactive plugin is misbehaving - tried to show a window!
Feb 27 18:25:38 ops invoker[3327]: WARNING: requestActivate() called for  QQuickView(0x5fc5d8)  which has Qt::WindowDoesNotAcceptFocus set.

This is probably where I turned Internet sharing on.
84:c7:ea:88:2d:1d is the wifi of the phone itself.

Feb 27 18:25:48 ops wpa_supplicant[24418]: p2p-dev-wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Feb 27 18:25:48 ops wpa_supplicant[24418]: nl80211: deinit ifname=p2p-dev-wlan0 disabled_11b_rates=0
Feb 27 18:25:48 ops kernel: WLC_E_IF: NO_IF set, event Ignored
Feb 27 18:25:48 ops kernel: CFGP2P-ERROR) wl_cfgp2p_del_p2p_disc_if : P2P interface unregistered
Feb 27 18:25:48 ops kernel: CFG80211-ERROR) wl_cfg80211_disconnect : Reason 3
Feb 27 18:25:48 ops kernel: CFG80211-ERROR) wl_is_linkdown : Link down Reason : WLC_E_LINK
Feb 27 18:25:48 ops kernel: CFG80211-ERROR) wl_notify_connect_status : link down if wlan0 may call cfg80211_disconnected. event : 16, reason=2 from 70:4f:57:d3:ae:63
Feb 27 18:25:48 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-DISCONNECTED bssid=70:4f:57:d3:ae:63 reason=3 locally_generated=1
Feb 27 18:25:48 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Feb 27 18:25:48 ops kernel: cfg80211: Calling CRDA to update world regulatory domain
Feb 27 18:25:48 ops kernel: CFG80211-ERROR) wl_cfg80211_reg_notifier : reg_notifier for intiator:0 not supported : set default
Feb 27 18:25:48 ops kernel: CFG80211-ERROR) wl_cfg80211_reg_notifier : Set country code 00 from User
Feb 27 18:25:48 ops kernel: WLDEV-ERROR) wldev_set_country : wldev_set_country: set country for 00 as 00 rev -1 failed
Feb 27 18:25:48 ops kernel: CFG80211-ERROR) wl_cfg80211_reg_notifier : set country Failed :-2
Feb 27 18:25:48 ops kernel: cfg80211: World regulatory domain updated:
Feb 27 18:25:48 ops kernel: cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
Feb 27 18:25:48 ops kernel: cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 27 18:25:48 ops kernel: cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Feb 27 18:25:48 ops kernel: cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
Feb 27 18:25:48 ops kernel: cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz), (300 mBi, 2000 mBm)
Feb 27 18:25:48 ops kernel: cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz), (300 mBi, 2000 mBm)
Feb 27 18:25:48 ops kernel: cfg80211:   (5490000 KHz - 5710000 KHz @ 80000 KHz), (300 mBi, 2000 mBm)
Feb 27 18:25:48 ops kernel: cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (300 mBi, 2000 mBm)
Feb 27 18:25:48 ops kernel: cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm)
Feb 27 18:25:48 ops systemd-udevd[27295]: Process '/sbin/crda' failed with exit code 249.
Feb 27 18:25:48 ops connmand[24420]: ntp: adjust (slew): +0.032520 sec
Feb 27 18:25:48 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Feb 27 18:25:48 ops wpa_supplicant[24418]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0
Feb 27 18:25:49 ops connmand[24420]: Failed to bind UDP listener socket
Feb 27 18:25:49 ops connmand[24420]: Failed to bind TCP listener socket
Feb 27 18:25:49 ops systemd-udevd[27298]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Feb 27 18:25:49 ops systemd-udevd[27298]: Could not generate persistent MAC address for tether: No such file or directory
Feb 27 18:25:49 ops connmand[24420]: tether DEVTYPE=bridge not supported, ignoring
Feb 27 18:25:49 ops connmand[24420]: ntp: adjust (slew): +0.029080 sec
Feb 27 18:25:49 ops kernel: CFGP2P-ERROR) wl_cfgp2p_add_p2p_disc_if : P2P interface registered
Feb 27 18:25:49 ops kernel: WLC_E_IF: NO_IF set, event Ignored
Feb 27 18:25:49 ops wpa_supplicant[24418]: Note: nl80211 driver interface is not designed to be used with ap_scan=2; this can result in connection failures
Feb 27 18:25:49 ops kernel: CFG80211-ERROR) check_dev_role_integrity : device role select failed
Feb 27 18:25:49 ops wpa_supplicant[24418]: wlan0: interface state UNINITIALIZED->ENABLED
Feb 27 18:25:49 ops wpa_supplicant[24418]: wlan0: AP-ENABLED
Feb 27 18:25:49 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-CONNECTED - Connection to 84:c7:ea:88:2d:1d completed [id=0 id_str=]
Feb 27 18:25:49 ops kernel: CFG80211-ERROR) wl_cfg80211_del_station : Disconnect STA : ff:ff:ff:ff:ff:ff scb_val.val 3

Here I must have turned Internet sharing off. Below, ‘default’
(70:4f:57:d3:ae:62) and ‘default-5’ (70:4f:57:d3:ae:63) are the names
of two hotspots. They are open, i.e., do not require authentication.
So the line below that says ‘authentication timed out’ is somewhat
misleading.

Feb 27 18:26:03 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-SCAN-FAILED ret=-22
Feb 27 18:26:03 ops kernel: CFG80211-ERROR) __wl_cfg80211_scan : Invalid Scan Command at SoftAP mode
Feb 27 18:26:03 ops kernel: CFG80211-ERROR) wl_cfg80211_scan : scan error (-22)
Feb 27 18:26:03 ops connmand[24420]: Inconsistent IP pool management (start not found)
Feb 27 18:26:03 ops wpa_supplicant[24418]: p2p-dev-wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Feb 27 18:26:03 ops wpa_supplicant[24418]: nl80211: deinit ifname=p2p-dev-wlan0 disabled_11b_rates=0
Feb 27 18:26:04 ops wpa_supplicant[24418]: wlan0: interface state ENABLED->DISABLED
Feb 27 18:26:04 ops wpa_supplicant[24418]: wlan0: AP-DISABLED
Feb 27 18:26:04 ops kernel: WLC_E_IF: NO_IF set, event Ignored
Feb 27 18:26:04 ops kernel: CFGP2P-ERROR) wl_cfgp2p_del_p2p_disc_if : P2P interface unregistered
Feb 27 18:26:04 ops kernel: CFG80211-ERROR) wl_cfg80211_del_station : Disconnect STA : ff:ff:ff:ff:ff:ff scb_val.val 3
Feb 27 18:26:04 ops kernel: CFG80211-ERROR) wl_cfg80211_stop_ap : setting AP mode failed -26 
Feb 27 18:26:04 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-DISCONNECTED bssid=84:c7:ea:88:2d:1d reason=3 locally_generated=1
Feb 27 18:26:04 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Feb 27 18:26:04 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Feb 27 18:26:04 ops wpa_supplicant[24418]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0
Feb 27 18:26:04 ops kernel: CFGP2P-ERROR) wl_cfgp2p_add_p2p_disc_if : P2P interface registered
Feb 27 18:26:04 ops kernel: WLC_E_IF: NO_IF set, event Ignored
Feb 27 18:26:08 ops wpa_supplicant[24418]: wlan0: Trying to associate with SSID 'default'
Feb 27 18:26:08 ops kernel: CFG80211-ERROR) wl_cfg80211_connect : Connecting to ff:ff:ff:ff:ff:ff with channel (6) ssid default
Feb 27 18:26:08 ops connmand[24420]: ntp: adjust (slew): +0.032691 sec
Feb 27 18:26:12 ops dbus-daemon[2112]: dbus-daemon[2112]: [session uid=100000 pid=2112] Activating service name='org.sailfishos.homescreen.ConnectionSelector' requested by ':1.2' (uid=100000 pid=2106 comm="/usr/libexec/sailfish-homescreen-services")
Feb 27 18:26:13 ops dbus-daemon[2112]: dbus-daemon[2112]: [session uid=100000 pid=2112] Successfully activated service 'org.sailfishos.homescreen.ConnectionSelector'
Feb 27 18:26:13 ops booster-silica-qt5[27331]: [D] unknown:0 - Using Wayland-EGL
Feb 27 18:26:18 ops connmand[24420]: Skipping disconnect of 64656661756c74_managed_none, network is connecting.
Feb 27 18:26:18 ops kernel: CFG80211-ERROR) wl_cfg80211_disconnect : Reason 3
Feb 27 18:26:18 ops kernel: CFG80211-ERROR) wl_cfg80211_disconnect : Disconnecting from connecting device: 00:00:00:00:00:00
Feb 27 18:26:18 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-DISCONNECTED bssid=70:4f:57:d3:ae:62 reason=3 locally_generated=1
Feb 27 18:26:18 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Feb 27 18:26:18 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-ASSOC-REJECT status_code=1
Feb 27 18:26:18 ops wpa_supplicant[24418]: wlan0: Reject scan trigger since one is already pending
Feb 27 18:26:18 ops wpa_supplicant[24418]: wlan0: Failed to initiate AP scan
Feb 27 18:26:18 ops connmand[24420]: ntp: adjust (slew): +0.037102 sec
Feb 27 18:26:19 ops wpa_supplicant[24418]: wlan0: Reject scan trigger since one is already pending
Feb 27 18:26:19 ops wpa_supplicant[24418]: wlan0: Failed to initiate AP scan
Feb 27 18:26:20 ops wpa_supplicant[24418]: wlan0: Reject scan trigger since one is already pending
Feb 27 18:26:20 ops wpa_supplicant[24418]: wlan0: Failed to initiate AP scan
Feb 27 18:26:21 ops wpa_supplicant[24418]: wlan0: Reject scan trigger since one is already pending
Feb 27 18:26:21 ops wpa_supplicant[24418]: wlan0: Failed to initiate AP scan
Feb 27 18:26:22 ops wpa_supplicant[24418]: wlan0: Trying to associate with SSID 'default-5'
Feb 27 18:26:22 ops kernel: CFG80211-ERROR) wl_cfg80211_connect : Connecting to ff:ff:ff:ff:ff:ff with channel (36) ssid default-5
Feb 27 18:26:32 ops wpa_supplicant[24418]: wlan0: Authentication with 70:4f:57:d3:ae:63 timed out.
Feb 27 18:26:32 ops kernel: CFG80211-ERROR) wl_cfg80211_disconnect : Reason 3
Feb 27 18:26:32 ops kernel: CFG80211-ERROR) wl_cfg80211_disconnect : Disconnecting from connecting device: 00:00:00:00:00:00
Feb 27 18:26:32 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-DISCONNECTED bssid=70:4f:57:d3:ae:63 reason=3 locally_generated=1
Feb 27 18:26:32 ops wpa_supplicant[24418]: BSSID 70:4f:57:d3:ae:63 ignore list count incremented to 2, ignoring for 10 seconds
Feb 27 18:26:32 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Feb 27 18:26:32 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-ASSOC-REJECT status_code=1
Feb 27 18:26:32 ops wpa_supplicant[24418]: wlan0: Reject scan trigger since one is already pending
Feb 27 18:26:32 ops wpa_supplicant[24418]: wlan0: Failed to initiate AP scan
Feb 27 18:26:33 ops wpa_supplicant[24418]: wlan0: Reject scan trigger since one is already pending
Feb 27 18:26:33 ops wpa_supplicant[24418]: wlan0: Failed to initiate AP scan
Feb 27 18:26:34 ops wpa_supplicant[24418]: wlan0: Reject scan trigger since one is already pending
Feb 27 18:26:34 ops wpa_supplicant[24418]: wlan0: Failed to initiate AP scan
Feb 27 18:26:35 ops wpa_supplicant[24418]: wlan0: Reject scan trigger since one is already pending
Feb 27 18:26:35 ops wpa_supplicant[24418]: wlan0: Failed to initiate AP scan
Feb 27 18:26:36 ops wpa_supplicant[24418]: wlan0: Trying to associate with SSID 'default-5'
Feb 27 18:26:36 ops kernel: CFG80211-ERROR) wl_cfg80211_connect : Connecting to ff:ff:ff:ff:ff:ff with channel (36) ssid default-5
Feb 27 18:26:46 ops wpa_supplicant[24418]: wlan0: Authentication with 70:4f:57:d3:ae:63 timed out.
Feb 27 18:26:46 ops kernel: CFG80211-ERROR) wl_cfg80211_disconnect : Reason 3
Feb 27 18:26:46 ops kernel: CFG80211-ERROR) wl_cfg80211_disconnect : Disconnecting from connecting device: 00:00:00:00:00:00
Feb 27 18:26:46 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-DISCONNECTED bssid=70:4f:57:d3:ae:63 reason=3 locally_generated=1
Feb 27 18:26:46 ops wpa_supplicant[24418]: BSSID 70:4f:57:d3:ae:63 ignore list count incremented to 2, ignoring for 10 seconds
Feb 27 18:26:46 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Feb 27 18:26:46 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-ASSOC-REJECT status_code=1
Feb 27 18:26:48 ops mce[600]: modules/display.c: mdy_display_state_enter(): current display state = DIM
Feb 27 18:26:48 ops connmand[24420]: ntp: adjust (slew): +0.032189 sec
Feb 27 18:26:50 ops mce[600]: modules/display.c: mdy_datapipe_device_inactive_cb(): display state req: ON
Feb 27 18:26:50 ops mce[600]: modules/display.c: mdy_display_state_enter(): current display state = ON
Feb 27 18:26:50 ops wpa_supplicant[24418]: wlan0: Trying to associate with SSID 'default-5'
Feb 27 18:26:51 ops kernel: CFG80211-ERROR) wl_cfg80211_connect : Connecting to ff:ff:ff:ff:ff:ff with channel (36) ssid default-5
Feb 27 18:27:01 ops wpa_supplicant[24418]: wlan0: Authentication with 70:4f:57:d3:ae:63 timed out.
Feb 27 18:27:01 ops kernel: CFG80211-ERROR) wl_cfg80211_disconnect : Reason 3
Feb 27 18:27:01 ops kernel: CFG80211-ERROR) wl_cfg80211_disconnect : Disconnecting from connecting device: 00:00:00:00:00:00
Feb 27 18:27:01 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-DISCONNECTED bssid=70:4f:57:d3:ae:63 reason=3 locally_generated=1
Feb 27 18:27:01 ops wpa_supplicant[24418]: BSSID 70:4f:57:d3:ae:63 ignore list count incremented to 2, ignoring for 10 seconds
Feb 27 18:27:01 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="default-5" auth_failures=1 duration=10 reason=CONN_FAILED
Feb 27 18:27:01 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Feb 27 18:27:01 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-ASSOC-REJECT status_code=1
Feb 27 18:27:01 ops wpa_supplicant[24418]: wlan0: Reject scan trigger since one is already pending
Feb 27 18:27:01 ops wpa_supplicant[24418]: wlan0: Failed to initiate AP scan
Feb 27 18:27:02 ops wpa_supplicant[24418]: wlan0: Reject scan trigger since one is already pending
Feb 27 18:27:02 ops wpa_supplicant[24418]: wlan0: Failed to initiate AP scan
Feb 27 18:27:03 ops wpa_supplicant[24418]: wlan0: Reject scan trigger since one is already pending
Feb 27 18:27:03 ops wpa_supplicant[24418]: wlan0: Failed to initiate AP scan
Feb 27 18:27:04 ops wpa_supplicant[24418]: wlan0: Reject scan trigger since one is already pending
Feb 27 18:27:04 ops wpa_supplicant[24418]: wlan0: Failed to initiate AP scan
Feb 27 18:27:06 ops connmand[24420]: ntp: adjust (slew): +0.034210 sec
Feb 27 18:27:11 ops connmand[24420]: ntp: adjust (slew): +0.008396 sec
Feb 27 18:27:13 ops wpa_supplicant[24418]: wlan0: Trying to associate with SSID 'default'
Feb 27 18:27:13 ops kernel: CFG80211-ERROR) wl_cfg80211_connect : Connecting to ff:ff:ff:ff:ff:ff with channel (6) ssid default
Feb 27 18:27:23 ops wpa_supplicant[24418]: wlan0: Authentication with 70:4f:57:d3:ae:62 timed out.
Feb 27 18:27:23 ops kernel: CFG80211-ERROR) wl_cfg80211_disconnect : Reason 3
Feb 27 18:27:23 ops kernel: CFG80211-ERROR) wl_cfg80211_disconnect : Disconnecting from connecting device: 00:00:00:00:00:00
Feb 27 18:27:23 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-DISCONNECTED bssid=70:4f:57:d3:ae:62 reason=3 locally_generated=1
Feb 27 18:27:23 ops wpa_supplicant[24418]: BSSID 70:4f:57:d3:ae:62 ignore list count incremented to 2, ignoring for 10 seconds
Feb 27 18:27:23 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="default" auth_failures=1 duration=10 reason=CONN_FAILED
Feb 27 18:27:23 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Feb 27 18:27:23 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-ASSOC-REJECT status_code=1
Feb 27 18:27:23 ops mce[600]: modules/battery-udev.c: mcebat_update(): battery_level : 43 -> 42
Feb 27 18:27:28 ops connmand[24420]: ntp: adjust (slew): +0.026649 sec

This is probably where I turned WLAN off.

Feb 27 18:27:29 ops kernel: WLC_E_IF: NO_IF set, event Ignored
Feb 27 18:27:29 ops kernel: wl_android_wifi_off in
Feb 27 18:27:29 ops kernel: dhd_wlfc_deinit():3311, maintain HOST RXRERODER flag in tvl
Feb 27 18:27:29 ops kernel: dhd_wlfc_deinit():3325 successfully disabled bdcv2 tlv signaling, 64
Feb 27 18:27:29 ops kernel: wifi_platform_set_power = 0
Feb 27 18:27:29 ops wpa_supplicant[24418]: p2p-dev-wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Feb 27 18:27:29 ops wpa_supplicant[24418]: p2p-dev-wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Feb 27 18:27:29 ops wpa_supplicant[24418]: nl80211: deinit ifname=p2p-dev-wlan0 disabled_11b_rates=0
Feb 27 18:27:29 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Feb 27 18:27:29 ops n-selector[26968]: [W] unknown:0 - out-of-band removal of network service QObject(0xab580db0)
Feb 27 18:27:29 ops n-selector[26968]: [W] unknown:0 - out-of-band removal of network service QObject(0xab57adf8)
Feb 27 18:27:29 ops kernel: CFGP2P-ERROR) wl_cfgp2p_del_p2p_disc_if : P2P interface unregistered
Feb 27 18:27:29 ops n-selector[26968]: [W] unknown:0 - out-of-band removal of network service QObject(0xab57b820)
Feb 27 18:27:29 ops n-selector[26968]: [W] unknown:0 - out-of-band removal of network service QObject(0xab579f90)
Feb 27 18:27:29 ops n-selector[26968]: [W] unknown:0 - out-of-band removal of network service QObject(0xab4e7808)
Feb 27 18:27:29 ops n-selector[26968]: [W] unknown:0 - out-of-band removal of network service QObject(0xab57ef18)
Feb 27 18:27:29 ops connmand[24420]: ntp: adjust (slew): +0.020678 sec
Feb 27 18:27:29 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all
Feb 27 18:27:29 ops wpa_supplicant[24418]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0

And I think here I turned WLAN on again. After which the wifi
connected to the hotspot ‘default’.

Feb 27 18:27:34 ops kernel: 
                            Dongle Host Driver, version 1.201.31 (r)
                            Compiled in drivers/net/wireless/bcmdhd on Feb 13 2023 at 15:52:42
Feb 27 18:27:34 ops kernel: wl_android_wifi_on in
Feb 27 18:27:34 ops kernel: wifi_platform_set_power = 1
Feb 27 18:27:34 ops kernel: mmc2: queuing unknown CIS tuple 0x80 (2 bytes)
Feb 27 18:27:34 ops kernel: mmc2: queuing unknown CIS tuple 0x80 (3 bytes)
Feb 27 18:27:34 ops kernel: mmc2: queuing unknown CIS tuple 0x80 (3 bytes)
Feb 27 18:27:34 ops kernel: mmc2: queuing unknown CIS tuple 0x80 (7 bytes)
Feb 27 18:27:34 ops kernel: mmc2: queuing unknown CIS tuple 0x80 (6 bytes)
Feb 27 18:27:34 ops kernel: F1 signature read @0x18000000=0x15264345
Feb 27 18:27:34 ops kernel: F1 signature OK, socitype:0x1 chip:0x4345 rev:0x6 pkg:0x2
Feb 27 18:27:34 ops kernel: DHD: dongle ram size is set to 819200(orig 819200) at 0x198000
Feb 27 18:27:35 ops kernel: dhdsdio_write_vars: Download, Upload and compare of NVRAM succeeded.
Feb 27 18:27:35 ops kernel: dhd_bus_init: enable 0x06, ready 0x06 (waited 0us)
Feb 27 18:27:35 ops kernel: wifi_platform_get_mac_addr
Feb 27 18:27:35 ops kernel: somc_wifi_get_mac_addr: READ MAC ADDRESS 84:C7:EA:88:2D:1D
Feb 27 18:27:35 ops kernel: Firmware up: op_mode=0x0005, MAC=84:c7:ea:88:2d:1d
Feb 27 18:27:35 ops kernel: dhd_preinit_ioctls Set txbf failed  -23
Feb 27 18:27:35 ops kernel: Firmware version = wl0: Feb 24 2017 11:28:48 version 7.45.59.15 (r682557) FWID 01-75cc3c71
Feb 27 18:27:35 ops kernel: dhd_wlfc_init(): successfully enabled bdcv2 tlv signaling, 79
Feb 27 18:27:35 ops kernel: dhd_wlfc_init: query wlfc_mode succeed, fw_caps=0x1c
Feb 27 18:27:35 ops kernel: dhd_wlfc_init(): wlfc_mode=0x1c, ret=0
Feb 27 18:27:35 ops kernel: dhd_ndo_get_version: failed, retcode = -23
Feb 27 18:27:35 ops kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc0ad55e000 drv_status 0x0 e_type 69 e_states 4
Feb 27 18:27:35 ops kernel: IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
Feb 27 18:27:35 ops kernel: CFGP2P-ERROR) wl_cfgp2p_add_p2p_disc_if : P2P interface registered
Feb 27 18:27:35 ops kernel: WLC_E_IF: NO_IF set, event Ignored
Feb 27 18:27:39 ops connmand[24420]: ntp: adjust (slew): +0.022729 sec
Feb 27 18:27:41 ops wpa_supplicant[24418]: wlan0: Trying to associate with SSID 'default'
Feb 27 18:27:41 ops kernel: CFG80211-ERROR) wl_cfg80211_connect : Connecting to ff:ff:ff:ff:ff:ff with channel (6) ssid default
Feb 27 18:27:42 ops kernel: wl_bss_connect_done succeeded with 70:4f:57:d3:ae:62
Feb 27 18:27:42 ops kernel: IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Feb 27 18:27:42 ops wpa_supplicant[24418]: wlan0: Associated with 70:4f:57:d3:ae:62
Feb 27 18:27:42 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-CONNECTED - Connection to 70:4f:57:d3:ae:62 completed [id=0 id_str=]
Feb 27 18:27:42 ops wpa_supplicant[24418]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Feb 27 18:27:42 ops kernel: wl_bss_connect_done succeeded with 70:4f:57:d3:ae:62
Feb 27 18:27:42 ops connmand[24420]: ntp: adjust (slew): +0.024891 sec
Feb 27 18:27:45 ops connmand[24420]: ntp: adjust (slew): -0.022859 sec
Feb 27 18:27:45 ops connmand[24420]: ntp: adjust (slew): -0.021122 sec
Feb 27 18:27:47 ops connmand[24420]: ntp: adjust (slew): -0.016281 sec
2 Likes

I started oFono-logging and pressed hotspot on. First is journal log and then follows oFono log.

Journal log:

helmi 28 17:12:04 Sailfish dbus-daemon[2690]: dbus-daemon[2690]: [session uid=100000 pid=2690] Activating via systemd: service name='org.nemo.transferengine' unit='transferengine.service' requested by ':1.9444' (uid=100000 pid=19818 comm="booster [silica-qt5]                             ")
helmi 28 17:12:04 Sailfish systemd[2675]: Starting Transfer engine...
helmi 28 17:12:04 Sailfish dbus-daemon[2690]: dbus-daemon[2690]: [session uid=100000 pid=2690] Successfully activated service 'org.nemo.transferengine'
helmi 28 17:12:04 Sailfish systemd[2675]: Started Transfer engine.
helmi 28 17:12:04 Sailfish r-ofono[19818]: [W] unknown:0 - QDBusError("org.freedesktop.DBus.Error.UnknownMethod", "No such method 'transferMethods2' in interface 'org.nemo.transferengine' at object path '/org/nemo/transferengine' (signature '')")
helmi 28 17:12:04 Sailfish invoker[3444]: WARNING: An inactive plugin is misbehaving - tried to show a window!
helmi 28 17:12:04 Sailfish invoker[3444]: WARNING: requestActivate() called for  QQuickView(0x4202e8)  which has Qt::WindowDoesNotAcceptFocus set.
helmi 28 17:12:04 Sailfish lipstick[2772]: [W] unknown:0 - WindowPixmapItem does not have a source texture, cover will be dropped..
helmi 28 17:12:04 Sailfish r-ofono[19818]: [W] unknown:0 - QDBusError("org.freedesktop.DBus.Error.UnknownMethod", "No such method 'transferMethods' in interface 'org.nemo.transferengine' at object path '/org/nemo/transferengine' (signature '')")
helmi 28 17:12:05 Sailfish lipstick[2772]: [D] onCompleted:264 - coverActionIndicators created sailfish-log-viewer-ofono.desktop
helmi 28 17:12:05 Sailfish booster-silica-qt5[20830]: [D] unknown:0 - Using Wayland-EGL
helmi 28 17:12:09 Sailfish ofonod[706]: RIL1> SIGNAL_STRENGTH
helmi 28 17:12:09 Sailfish ofonod[706]: RIL1> 0000: 01 00 00 00 f1 03 00 00  63 00 00 00 00 00 00 00    ........ c.......
helmi 28 17:12:09 Sailfish ofonod[706]: RIL1  0008: ff ff ff ff ff ff ff ff  ff ff ff ff ff ff ff ff    ........ ........
helmi 28 17:12:09 Sailfish ofonod[706]: RIL1  0018: ff ff ff ff 1d 00 00 00  60 00 00 00 12 00 00 00    ........ `.......
helmi 28 17:12:09 Sailfish ofonod[706]: RIL1  0028: ac 00 00 00 ff ff ff 7f  ff ff ff 7f                ........ ....
helmi 28 17:12:09 Sailfish ofonod[706]: src/ril_netreg.c:ril_netreg_get_signal_strength() gw: 99, lte: 29, qdbm: 0
helmi 28 17:12:09 Sailfish ofonod[706]: src/ril_netreg.c:ril_netreg_strength_notify() 93
helmi 28 17:12:09 Sailfish ofonod[706]: src/network.c:ofono_netreg_strength_notify() strength 93
helmi 28 17:12:12 Sailfish ofonod[706]: RIL1> SIGNAL_STRENGTH
helmi 28 17:12:12 Sailfish ofonod[706]: RIL1> 0000: 01 00 00 00 f1 03 00 00  63 00 00 00 00 00 00 00    ........ c.......
helmi 28 17:12:12 Sailfish ofonod[706]: RIL1  0008: ff ff ff ff ff ff ff ff  ff ff ff ff ff ff ff ff    ........ ........
helmi 28 17:12:12 Sailfish ofonod[706]: RIL1  0018: ff ff ff ff 1d 00 00 00  5d 00 00 00 11 00 00 00    ........ ].......
helmi 28 17:12:12 Sailfish ofonod[706]: RIL1  0028: 5a 00 00 00 ff ff ff 7f  ff ff ff 7f                Z....... ....
helmi 28 17:12:12 Sailfish ofonod[706]: src/ril_netreg.c:ril_netreg_get_signal_strength() gw: 99, lte: 29, qdbm: 0
helmi 28 17:12:12 Sailfish ofonod[706]: src/ril_netreg.c:ril_netreg_strength_notify() 93
helmi 28 17:12:14 Sailfish kernel: 
                                   Dongle Host Driver, version 1.201.31 (r)
                                   Compiled in drivers/net/wireless/bcmdhd on Feb 13 2023 at 15:52:42
helmi 28 17:12:14 Sailfish kernel: wl_android_wifi_on in
helmi 28 17:12:14 Sailfish kernel: wifi_platform_set_power = 1
helmi 28 17:12:14 Sailfish ofonod[706]: RIL1> SIGNAL_STRENGTH
helmi 28 17:12:14 Sailfish ofonod[706]: RIL1> 0000: 01 00 00 00 f1 03 00 00  63 00 00 00 00 00 00 00    ........ c.......
helmi 28 17:12:14 Sailfish ofonod[706]: RIL1  0008: ff ff ff ff ff ff ff ff  ff ff ff ff ff ff ff ff    ........ ........
helmi 28 17:12:14 Sailfish ofonod[706]: RIL1  0018: ff ff ff ff 1e 00 00 00  5a 00 00 00 10 00 00 00    ........ Z.......
helmi 28 17:12:14 Sailfish ofonod[706]: RIL1  0028: 72 00 00 00 ff ff ff 7f  ff ff ff 7f                r....... ....
helmi 28 17:12:14 Sailfish ofonod[706]: src/ril_netreg.c:ril_netreg_get_signal_strength() gw: 99, lte: 30, qdbm: 0
helmi 28 17:12:14 Sailfish ofonod[706]: src/ril_netreg.c:ril_netreg_strength_notify() 96
helmi 28 17:12:14 Sailfish ofonod[706]: src/network.c:ofono_netreg_strength_notify() strength 96
helmi 28 17:12:15 Sailfish kernel: mmc2: queuing unknown CIS tuple 0x80 (2 bytes)
helmi 28 17:12:15 Sailfish kernel: mmc2: queuing unknown CIS tuple 0x80 (3 bytes)
helmi 28 17:12:15 Sailfish kernel: mmc2: queuing unknown CIS tuple 0x80 (3 bytes)
helmi 28 17:12:15 Sailfish kernel: mmc2: queuing unknown CIS tuple 0x80 (7 bytes)
helmi 28 17:12:15 Sailfish kernel: mmc2: queuing unknown CIS tuple 0x80 (6 bytes)
helmi 28 17:12:15 Sailfish kernel: F1 signature read @0x18000000=0x15264345
helmi 28 17:12:15 Sailfish kernel: F1 signature OK, socitype:0x1 chip:0x4345 rev:0x6 pkg:0x2
helmi 28 17:12:15 Sailfish kernel: DHD: dongle ram size is set to 819200(orig 819200) at 0x198000
helmi 28 17:12:15 Sailfish kernel: dhdsdio_write_vars: Download, Upload and compare of NVRAM succeeded.
helmi 28 17:12:15 Sailfish kernel: dhd_bus_init: enable 0x06, ready 0x06 (waited 0us)
helmi 28 17:12:15 Sailfish kernel: wifi_platform_get_mac_addr
helmi 28 17:12:15 Sailfish kernel: somc_wifi_get_mac_addr: READ MAC ADDRESS 9C:5C:F9:1F:2E:C8
helmi 28 17:12:15 Sailfish kernel: Firmware up: op_mode=0x0005, MAC=9c:5c:f9:1f:2e:c8
helmi 28 17:12:15 Sailfish kernel: dhd_preinit_ioctls lpc fail WL_DOWN : 0, lpc = 1
helmi 28 17:12:15 Sailfish kernel: dhd_preinit_ioctls Set lpc ret --> 0
helmi 28 17:12:15 Sailfish kernel: dhd_preinit_ioctls Set txbf failed  -23
helmi 28 17:12:15 Sailfish kernel: Firmware version = wl0: Feb 24 2017 11:28:48 version 7.45.59.15 (r682557) FWID 01-75cc3c71
helmi 28 17:12:15 Sailfish kernel: dhd_wlfc_init(): successfully enabled bdcv2 tlv signaling, 79
helmi 28 17:12:15 Sailfish kernel: dhd_wlfc_init: query wlfc_mode succeed, fw_caps=0x1c
helmi 28 17:12:15 Sailfish kernel: dhd_wlfc_init(): wlfc_mode=0x1c, ret=0
helmi 28 17:12:15 Sailfish kernel: dhd_ndo_get_version: failed, retcode = -23
helmi 28 17:12:15 Sailfish kernel: IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
helmi 28 17:12:15 Sailfish kernel: CFGP2P-ERROR) wl_cfgp2p_add_p2p_disc_if : P2P interface registered
helmi 28 17:12:15 Sailfish kernel: WLC_E_IF: NO_IF set, event Ignored
helmi 28 17:12:16 Sailfish wpa_supplicant[10356]: p2p-dev-wlan0: CTRL-EVENT-DSCP-POLICY clear_all
helmi 28 17:12:16 Sailfish wpa_supplicant[10356]: nl80211: deinit ifname=p2p-dev-wlan0 disabled_11b_rates=0
helmi 28 17:12:16 Sailfish wpa_supplicant[10356]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all
helmi 28 17:12:16 Sailfish kernel: WLC_E_IF: NO_IF set, event Ignored
helmi 28 17:12:16 Sailfish kernel: CFGP2P-ERROR) wl_cfgp2p_del_p2p_disc_if : P2P interface unregistered
helmi 28 17:12:16 Sailfish wpa_supplicant[10356]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all
helmi 28 17:12:16 Sailfish wpa_supplicant[10356]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0
helmi 28 17:12:16 Sailfish systemd-udevd[20874]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
helmi 28 17:12:16 Sailfish connmand[10358]: Failed to bind UDP listener socket
helmi 28 17:12:16 Sailfish systemd-udevd[20874]: Could not generate persistent MAC address for tether: No such file or directory
helmi 28 17:12:16 Sailfish connmand[10358]: Failed to bind TCP listener socket
helmi 28 17:12:16 Sailfish connmand[10358]: tether DEVTYPE=bridge not supported, ignoring
helmi 28 17:12:17 Sailfish kernel: CFGP2P-ERROR) wl_cfgp2p_add_p2p_disc_if : P2P interface registered
helmi 28 17:12:17 Sailfish kernel: WLC_E_IF: NO_IF set, event Ignored
helmi 28 17:12:17 Sailfish wpa_supplicant[10356]: Note: nl80211 driver interface is not designed to be used with ap_scan=2; this can result in connection failures
helmi 28 17:12:17 Sailfish wpa_supplicant[10356]: wlan0: interface state UNINITIALIZED->ENABLED
helmi 28 17:12:17 Sailfish wpa_supplicant[10356]: wlan0: AP-ENABLED
helmi 28 17:12:17 Sailfish wpa_supplicant[10356]: wlan0: CTRL-EVENT-CONNECTED - Connection to 9c:5c:f9:1f:2e:c8 completed [id=0 id_str=]
helmi 28 17:12:17 Sailfish kernel: CFG80211-ERROR) check_dev_role_integrity : device role select failed
helmi 28 17:12:17 Sailfish kernel: CFG80211-ERROR) wl_cfg80211_del_station : Disconnect STA : ff:ff:ff:ff:ff:ff scb_val.val 3
helmi 28 17:12:17 Sailfish ofonod[706]: RIL1> SIGNAL_STRENGTH
helmi 28 17:12:17 Sailfish ofonod[706]: RIL1> 0000: 01 00 00 00 f1 03 00 00  63 00 00 00 00 00 00 00    ........ c.......
helmi 28 17:12:17 Sailfish ofonod[706]: RIL1  0008: ff ff ff ff ff ff ff ff  ff ff ff ff ff ff ff ff    ........ ........
helmi 28 17:12:17 Sailfish ofonod[706]: RIL1  0018: ff ff ff ff 1c 00 00 00  5d 00 00 00 11 00 00 00    ........ ].......
helmi 28 17:12:17 Sailfish ofonod[706]: RIL1  0028: ae 00 00 00 ff ff ff 7f  ff ff ff 7f                ........ ....
helmi 28 17:12:17 Sailfish ofonod[706]: src/ril_netreg.c:ril_netreg_get_signal_strength() gw: 99, lte: 28, qdbm: 0
helmi 28 17:12:17 Sailfish ofonod[706]: src/ril_netreg.c:ril_netreg_strength_notify() 90
helmi 28 17:12:17 Sailfish ofonod[706]: src/network.c:ofono_netreg_strength_notify() strength 90
helmi 28 17:12:19 Sailfish ofonod[706]: RIL1> SIGNAL_STRENGTH
helmi 28 17:12:19 Sailfish ofonod[706]: RIL1> 0000: 01 00 00 00 f1 03 00 00  63 00 00 00 00 00 00 00    ........ c.......
helmi 28 17:12:19 Sailfish ofonod[706]: RIL1  0008: ff ff ff ff ff ff ff ff  ff ff ff ff ff ff ff ff    ........ ........
helmi 28 17:12:19 Sailfish ofonod[706]: RIL1  0018: ff ff ff ff 1c 00 00 00  60 00 00 00 13 00 00 00    ........ `.......
helmi 28 17:12:19 Sailfish ofonod[706]: RIL1  0028: 98 00 00 00 ff ff ff 7f  ff ff ff 7f                ........ ....
helmi 28 17:12:19 Sailfish ofonod[706]: src/ril_netreg.c:ril_netreg_get_signal_strength() gw: 99, lte: 28, qdbm: 0
helmi 28 17:12:19 Sailfish ofonod[706]: src/ril_netreg.c:ril_netreg_strength_notify() 90
helmi 28 17:12:21 Sailfish invoker[3444]: WARNING: An inactive plugin is misbehaving - tried to show a window!
helmi 28 17:12:21 Sailfish invoker[3444]: WARNING: requestActivate() called for  QQuickView(0x4202e8)  which has Qt::WindowDoesNotAcceptFocus set.
helmi 28 17:12:22 Sailfish ofonod[706]: RIL1> SIGNAL_STRENGTH
helmi 28 17:12:22 Sailfish ofonod[706]: RIL1> 0000: 01 00 00 00 f1 03 00 00  63 00 00 00 00 00 00 00    ........ c.......
helmi 28 17:12:22 Sailfish ofonod[706]: RIL1  0008: ff ff ff ff ff ff ff ff  ff ff ff ff ff ff ff ff    ........ ........
helmi 28 17:12:22 Sailfish ofonod[706]: RIL1  0018: ff ff ff ff 1c 00 00 00  5e 00 00 00 13 00 00 00    ........ ^.......
helmi 28 17:12:22 Sailfish ofonod[706]: RIL1  0028: c0 00 00 00 ff ff ff 7f  ff ff ff 7f                ........ ....
helmi 28 17:12:22 Sailfish ofonod[706]: src/ril_netreg.c:ril_netreg_get_signal_strength() gw: 99, lte: 28, qdbm: 0
helmi 28 17:12:22 Sailfish ofonod[706]: src/ril_netreg.c:ril_netreg_strength_notify() 90
helmi 28 17:12:23 Sailfish mce[600]: modules/battery-udev.c: mcebat_update(): battery_level : 19 -> 18
helmi 28 17:12:23 Sailfish ofonod[706]: [mce] Battery level is 18
helmi 28 17:12:26 Sailfish ofonod[706]: RIL1> SIGNAL_STRENGTH
helmi 28 17:12:26 Sailfish ofonod[706]: RIL1> 0000: 01 00 00 00 f1 03 00 00  63 00 00 00 00 00 00 00    ........ c.......
helmi 28 17:12:26 Sailfish ofonod[706]: RIL1  0008: ff ff ff ff ff ff ff ff  ff ff ff ff ff ff ff ff    ........ ........
helmi 28 17:12:26 Sailfish ofonod[706]: RIL1  0018: ff ff ff ff 1e 00 00 00  5d 00 00 00 13 00 00 00    ........ ].......
helmi 28 17:12:26 Sailfish ofonod[706]: RIL1  0028: 8e 00 00 00 ff ff ff 7f  ff ff ff 7f                ........ ....
helmi 28 17:12:26 Sailfish ofonod[706]: src/ril_netreg.c:ril_netreg_get_signal_strength() gw: 99, lte: 30, qdbm: 0
helmi 28 17:12:26 Sailfish ofonod[706]: src/ril_netreg.c:ril_netreg_strength_notify() 96
helmi 28 17:12:26 Sailfish ofonod[706]: src/network.c:ofono_netreg_strength_notify() strength 96
helmi 28 17:12:28 Sailfish dbus-daemon[2690]: dbus-daemon[2690]: [session uid=100000 pid=2690] Activating via systemd: service name='org.freedesktop.Tracker3.Miner.Extract' unit='tracker-extract-3.service' requested by ':1.60' (uid=100000 pid=3854 comm="/usr/libexec/tracker-miner-fs-3")
helmi 28 17:12:28 Sailfish systemd[2675]: Starting Tracker metadata extractor...
helmi 28 17:12:28 Sailfish ofonod[706]: RIL1> SIGNAL_STRENGTH
helmi 28 17:12:28 Sailfish ofonod[706]: RIL1> 0000: 01 00 00 00 f1 03 00 00  63 00 00 00 00 00 00 00    ........ c.......
helmi 28 17:12:28 Sailfish ofonod[706]: RIL1  0008: ff ff ff ff ff ff ff ff  ff ff ff ff ff ff ff ff    ........ ........
helmi 28 17:12:28 Sailfish ofonod[706]: RIL1  0018: ff ff ff ff 1c 00 00 00  5b 00 00 00 0f 00 00 00    ........ [.......
helmi 28 17:12:28 Sailfish ofonod[706]: RIL1  0028: 94 00 00 00 ff ff ff 7f  ff ff ff 7f                ........ ....
helmi 28 17:12:28 Sailfish ofonod[706]: src/ril_netreg.c:ril_netreg_get_signal_strength() gw: 99, lte: 28, qdbm: 0
helmi 28 17:12:28 Sailfish ofonod[706]: src/ril_netreg.c:ril_netreg_strength_notify() 90
helmi 28 17:12:28 Sailfish ofonod[706]: src/network.c:ofono_netreg_strength_notify() strength 90
helmi 28 17:12:28 Sailfish dbus-daemon[2690]: dbus-daemon[2690]: [session uid=100000 pid=2690] Successfully activated service 'org.freedesktop.Tracker3.Miner.Extract'
helmi 28 17:12:28 Sailfish systemd[2675]: Started Tracker metadata extractor.
helmi 28 17:12:31 Sailfish ofonod[706]: RIL1> SIGNAL_STRENGTH
helmi 28 17:12:31 Sailfish ofonod[706]: RIL1> 0000: 01 00 00 00 f1 03 00 00  63 00 00 00 00 00 00 00    ........ c.......
helmi 28 17:12:31 Sailfish ofonod[706]: RIL1  0008: ff ff ff ff ff ff ff ff  ff ff ff ff ff ff ff ff    ........ ........
helmi 28 17:12:31 Sailfish ofonod[706]: RIL1  0018: ff ff ff ff 1d 00 00 00  5c 00 00 00 0f 00 00 00    ........ \.......
helmi 28 17:12:31 Sailfish ofonod[706]: RIL1  0028: a8 00 00 00 ff ff ff 7f  ff ff ff 7f                ........ ....
helmi 28 17:12:31 Sailfish ofonod[706]: src/ril_netreg.c:ril_netreg_get_signal_strength() gw: 99, lte: 29, qdbm: 0
helmi 28 17:12:31 Sailfish ofonod[706]: src/ril_netreg.c:ril_netreg_strength_notify() 93
helmi 28 17:12:31 Sailfish ofonod[706]: src/network.c:ofono_netreg_strength_notify() strength 93
helmi 28 17:12:34 Sailfish invoker[3444]: WARNING: An inactive plugin is misbehaving - tried to show a window!
helmi 28 17:12:34 Sailfish invoker[3444]: WARNING: requestActivate() called for  QQuickView(0x4202e8)  which has Qt::WindowDoesNotAcceptFocus set.
helmi 28 17:12:35 Sailfish fingerterm[7778]: [W] unknown:0 - Effect failed, id 122
helmi 28 17:12:37 Sailfish fingerterm[7778]: [W] unknown:0 - Effect failed, id 123
helmi 28 17:12:39 Sailfish ofonod[706]: RIL1> SIGNAL_STRENGTH
helmi 28 17:12:39 Sailfish ofonod[706]: RIL1> 0000: 01 00 00 00 f1 03 00 00  63 00 00 00 00 00 00 00    ........ c.......
helmi 28 17:12:39 Sailfish ofonod[706]: RIL1  0008: ff ff ff ff ff ff ff ff  ff ff ff ff ff ff ff ff    ........ ........
helmi 28 17:12:39 Sailfish ofonod[706]: RIL1  0018: ff ff ff ff 1c 00 00 00  5f 00 00 00 12 00 00 00    ........ _.......
helmi 28 17:12:39 Sailfish ofonod[706]: RIL1  0028: 70 00 00 00 ff ff ff 7f  ff ff ff 7f                p....... ....
helmi 28 17:12:39 Sailfish ofonod[706]: src/ril_netreg.c:ril_netreg_get_signal_strength() gw: 99, lte: 28, qdbm: 0
helmi 28 17:12:39 Sailfish ofonod[706]: src/ril_netreg.c:ril_netreg_strength_notify() 90
helmi 28 17:12:39 Sailfish ofonod[706]: src/network.c:ofono_netreg_strength_notify() strength 90
helmi 28 17:12:39 Sailfish fingerterm[7778]: [W] unknown:0 - Effect failed, id 124

And oFono Log

2023-02-28 17:12:09.689 RIL1> SIGNAL_STRENGTH
2023-02-28 17:12:09.689 RIL1> 0000: 01 00 00 00 f1 03 00 00  63 00 00 00 00 00 00 00    ........ c.......
2023-02-28 17:12:09.689 RIL1  0008: ff ff ff ff ff ff ff ff  ff ff ff ff ff ff ff ff    ........ ........
2023-02-28 17:12:09.689 RIL1  0018: ff ff ff ff 1d 00 00 00  60 00 00 00 12 00 00 00    ........ `.......
2023-02-28 17:12:09.689 RIL1  0028: ac 00 00 00 ff ff ff 7f  ff ff ff 7f                ........ ....
2023-02-28 17:12:09.689 src/ril_netreg.c: ril_netreg_get_signal_strength() gw: 99, lte: 29, qdbm: 0
2023-02-28 17:12:09.689 src/ril_netreg.c: ril_netreg_strength_notify() 93
2023-02-28 17:12:09.689 src/network.c: ofono_netreg_strength_notify() strength 93
2023-02-28 17:12:12.249 RIL1> SIGNAL_STRENGTH
2023-02-28 17:12:12.249 RIL1> 0000: 01 00 00 00 f1 03 00 00  63 00 00 00 00 00 00 00    ........ c.......
2023-02-28 17:12:12.249 RIL1  0008: ff ff ff ff ff ff ff ff  ff ff ff ff ff ff ff ff    ........ ........
2023-02-28 17:12:12.249 RIL1  0018: ff ff ff ff 1d 00 00 00  5d 00 00 00 11 00 00 00    ........ ].......
2023-02-28 17:12:12.249 RIL1  0028: 5a 00 00 00 ff ff ff 7f  ff ff ff 7f                Z....... ....
2023-02-28 17:12:12.249 src/ril_netreg.c: ril_netreg_get_signal_strength() gw: 99, lte: 29, qdbm: 0
2023-02-28 17:12:12.249 src/ril_netreg.c: ril_netreg_strength_notify() 93
2023-02-28 17:12:14.808 RIL1> SIGNAL_STRENGTH
2023-02-28 17:12:14.808 RIL1> 0000: 01 00 00 00 f1 03 00 00  63 00 00 00 00 00 00 00    ........ c.......
2023-02-28 17:12:14.808 RIL1  0008: ff ff ff ff ff ff ff ff  ff ff ff ff ff ff ff ff    ........ ........
2023-02-28 17:12:14.808 RIL1  0018: ff ff ff ff 1e 00 00 00  5a 00 00 00 10 00 00 00    ........ Z.......
2023-02-28 17:12:14.809 RIL1  0028: 72 00 00 00 ff ff ff 7f  ff ff ff 7f                r....... ....
2023-02-28 17:12:14.809 src/ril_netreg.c: ril_netreg_get_signal_strength() gw: 99, lte: 30, qdbm: 0
2023-02-28 17:12:14.809 src/ril_netreg.c: ril_netreg_strength_notify() 96
2023-02-28 17:12:14.809 src/network.c: ofono_netreg_strength_notify() strength 96
2023-02-28 17:12:17.370 RIL1> SIGNAL_STRENGTH
2023-02-28 17:12:17.370 RIL1> 0000: 01 00 00 00 f1 03 00 00  63 00 00 00 00 00 00 00    ........ c.......
2023-02-28 17:12:17.370 RIL1  0008: ff ff ff ff ff ff ff ff  ff ff ff ff ff ff ff ff    ........ ........
2023-02-28 17:12:17.370 RIL1  0018: ff ff ff ff 1c 00 00 00  5d 00 00 00 11 00 00 00    ........ ].......
2023-02-28 17:12:17.370 RIL1  0028: ae 00 00 00 ff ff ff 7f  ff ff ff 7f                ........ ....
2023-02-28 17:12:17.371 src/ril_netreg.c: ril_netreg_get_signal_strength() gw: 99, lte: 28, qdbm: 0
2023-02-28 17:12:17.371 src/ril_netreg.c: ril_netreg_strength_notify() 90
2023-02-28 17:12:17.371 src/network.c: ofono_netreg_strength_notify() strength 90
2023-02-28 17:12:19.844 RIL1> SIGNAL_STRENGTH
2023-02-28 17:12:19.844 RIL1> 0000: 01 00 00 00 f1 03 00 00  63 00 00 00 00 00 00 00    ........ c.......
2023-02-28 17:12:19.844 RIL1  0008: ff ff ff ff ff ff ff ff  ff ff ff ff ff ff ff ff    ........ ........
2023-02-28 17:12:19.844 RIL1  0018: ff ff ff ff 1c 00 00 00  60 00 00 00 13 00 00 00    ........ `.......
2023-02-28 17:12:19.845 RIL1  0028: 98 00 00 00 ff ff ff 7f  ff ff ff 7f                ........ ....
2023-02-28 17:12:19.845 src/ril_netreg.c: ril_netreg_get_signal_strength() gw: 99, lte: 28, qdbm: 0
2023-02-28 17:12:19.845 src/ril_netreg.c: ril_netreg_strength_notify() 90
2023-02-28 17:12:22.158 RIL1> SIGNAL_STRENGTH
2023-02-28 17:12:22.158 RIL1> 0000: 01 00 00 00 f1 03 00 00  63 00 00 00 00 00 00 00    ........ c.......
2023-02-28 17:12:22.158 RIL1  0008: ff ff ff ff ff ff ff ff  ff ff ff ff ff ff ff ff    ........ ........
2023-02-28 17:12:22.158 RIL1  0018: ff ff ff ff 1c 00 00 00  5e 00 00 00 13 00 00 00    ........ ^.......
2023-02-28 17:12:22.158 RIL1  0028: c0 00 00 00 ff ff ff 7f  ff ff ff 7f                ........ ....
2023-02-28 17:12:22.158 src/ril_netreg.c: ril_netreg_get_signal_strength() gw: 99, lte: 28, qdbm: 0
2023-02-28 17:12:22.158 src/ril_netreg.c: ril_netreg_strength_notify() 90
2023-02-28 17:12:23.694 mce: Battery level is 18
2 Likes

I have the same bug in my Xperia X

4 Likes

Oh Jolla you make it so difficult to like you :frowning:

I just relied on the hotspot for my holiday. I mean, I totally understand that sometimes things are breaking but releasing two updates after somebody posted a serious regression
 seriously?

The hotspot is a basic feature nowadays and was working perfectly.

Can somebody post the Bug ID in the bugzilla (is this public)?

3 Likes
paketti libgbinder ei ole asennettu
paketti libgbinder-radio ei ole asennettu
libglibutil-1.0.67-1.13.1.jolla.armv7hl
libgrilio-1.0.44-1.7.1.jolla.armv7hl
paketti libgrilio-binder ei ole asennettu
ofono-1.29+git6-1.13.1.jolla.armv7hl
paketti ofono-binder-plugin ei ole asennettu
ofono-ril-plugin-1.0.6-1.3.1.jolla.armv7hl
paketti ofono-ril-binder-plugin ei ole asennettu

According ofono log file ofono-packages not all packages are installed (“ei ole asennettu” means is not installed). Could that affect the hotspot functionality? Are they installed on other device types?
@PeterParker there is an untracked bug ID 14388 @pherjung message https://forum.sailfishos.org/t/community-meeting-on-irc-9th-march-2023/14658. I do not know if that is related to bugzilla ID.

On an Xperia X (F5121) and 4.5.0.19, it should be like this - all of them below shall be installed:

ThinkPad-T480s ~/Downloads $ cat rpm-all.txt |grep -E 'ofono|libgrilio|libgbinder'
libgbinder-1.1.30-1.7.1.jolla.armv7hl
libgofono-2.1.6-1.9.1.jolla.armv7hl
libgofonoext-1.0.14-1.7.1.jolla.armv7hl
libgrilio-1.0.44-1.7.1.jolla.armv7hl
libqofono-qt5-0.115.1-1.8.1.jolla.armv7hl
libqofono-qt5-declarative-0.115.1-1.8.1.jolla.armv7hl
libqofonoext-1.0.29-1.6.1.jolla.armv7hl
libqofonoext-declarative-1.0.29-1.6.1.jolla.armv7hl
ofono-1.29+git6-1.13.1.jolla.armv7hl
ofono-ril-plugin-1.0.6-1.3.1.jolla.armv7hl

If I am not mistaken, only ‘libgbinder’ is missing from your phone (depending on how you derived your list).
Note that on Xperia 10 II and III the set of packages is different. But this bug concerns Xperia X, so let’s stick to that.

2 Likes

I derived the list with Ofono Log App. I installed the missing
libgbinder-1.1.30-1.7.1.jolla.armv7hl, but it seems not to help.

1 Like

Have you tried (to ensure that your phone has a consistent and complete setup):

devel-su
ssu re 4.5.0.19
version --dup

[nemo@Sailfish ~]$ devel-su
Password:
[root@Sailfish nemo]# ssu re 4.5.0.19
Changing release from 4.5.0.19 to 4.5.0.19
Your device is now in release mode!
[root@Sailfish nemo]# version --dup
REFRESHING CACHE AND DOWNLOADING PACKAGES
Finished transaction (status=2, runtime=441
57ms)

NO UPDATES FOUND. Try again later.

[root@Sailfish nemo]#

It doesn’t help.

I have the same bug.
I am on xperia X. My computer doesn’t see wifi of hotspot, when it s actived on phone.
I try to use the register connection of computer, that s dont work. and wiki analyzer doesn’t see the hotspot.

The application wifi killer, indicate that hotspot option is actived. But we can’t used it :frowning:

Good luck to find the bug, i look the journalctl to try to find the bug.

I have sailfish command [1430] failed to bind udp listener socket
and the same with tcp ip

and

sailfish command[1430] Inconsistent ip pool management (start not found)

Just before all of that
kernel : : WLC_E_IF : NO_IF set event Ignored
kernel: CFGP2P-ERROR) wl_cfgp2p_del_p2p_deisc_if : P2P interface unregistred

I dont know if this is the cause of buf

1 Like

Shall I post the log as text, it is big? No possibility to attach a file here.

I can confirm for the latest SFOS 4.5.0.19 and the Volla Phone 22 that neither USB nor WLAN internet sharing do work.

The shared wlan remains invisible and a connection can not be established.

2 Likes

Same here. Hotspot stopped being visible or accessible. Installing the missing libgbinder did not change the effect.

2 Likes