May 10 18:17:02 localhost icd2 0.98[5297]: Received com.nokia.icd2.select_req (u) request May 10 18:17:02 localhost icd2 0.98[5297]: tracking info sender ':1.25' and message (nil) added to request 0x49af38 May 10 18:17:02 localhost icd2 0.98[5297]: requesting request 0x49af38, attr 1, (null)/0/(null),(null)/0/[ASK] May 10 18:17:02 localhost icd2 0.98[5297]: running module 'libicd_policy_merge.so' new_request policy May 10 18:17:02 localhost icd2 0.98[5297]: running module 'libicd_policy_ask.so' new_request policy May 10 18:17:02 localhost icd2 0.98[5297]: Requesting 'Select connection' dialog May 10 18:17:02 localhost icd2 0.98[5297]: policy iap ask pending returned May 10 18:17:02 localhost icd2 0.98[5297]: 'Select connection' dialog responded (2) May 10 18:17:02 localhost icd2 0.98[5297]: policy returned ICD_POLICY_WAITING for request 0x49af38 May 10 18:17:02 localhost icd2 0.98[5297]: request 0x49af38 is waiting for actions May 10 18:17:02 localhost icd2 0.98[5297]: request 0x49af38 with status ICD_REQUEST_WAITING May 10 18:17:02 localhost icd2 0.98[5297]: Received com.nokia.icd2.scan_req (u) request May 10 18:17:02 localhost icd2 0.98[5297]: scan cache contains 0 elements May 10 18:17:02 localhost icd2 0.98[5297]: dbus api successfully started 'GPRS' scan for ':1.34' May 10 18:17:02 localhost icd2 0.98[5297]: scan start for type 'WLAN_INFRA' May 10 18:17:02 localhost icd2 0.98[5297]: '[SCAN]' type 'WLAN_INFRA' ICD_STATUS_CHANGED_SIG with status SCAN_START, '' sent to '(null)' May 10 18:17:02 localhost icd2 0.98[5297]: scan start for type 'WLAN_ADHOC' May 10 18:17:02 localhost icd2 0.98[5297]: '[SCAN]' type 'WLAN_ADHOC' ICD_STATUS_CHANGED_SIG with status SCAN_START, '' sent to '(null)' May 10 18:17:02 localhost icd2 0.98[5297]: libicd-network-wpasupplicant: wlan_start_search May 10 18:17:02 localhost icd2 0.98[5297]: libicd-network-wpasupplicant: try_open_wpa_control: 0x4a0b58 May 10 18:17:02 localhost icd2 0.98[5297]: libicd-network-wpasupplicant: close_wpa_control: 0x4a0b58 May 10 18:17:02 localhost icd2 0.98[5297]: libicd-network-wpasupplicant: try_open_wpa_control: 0x4a3c78 May 10 18:17:02 localhost icd2 0.98[5297]: libicd-network-wpasupplicant: close_wpa_control: 0x4a3c78 May 10 18:17:02 localhost icd2 0.98[5297]: dbus api successfully started 'WLAN_INFRA' scan for ':1.34' May 10 18:17:02 localhost icd2 0.98[5297]: dbus api successfully started 'WLAN_ADHOC' scan for ':1.34' May 10 18:17:02 localhost icd2 0.98[5297]: Received com.nokia.icd2.state_req () request May 10 18:17:02 localhost icd2 0.98[5297]: request 0x49af38 has no IAPs May 10 18:17:02 localhost icd2 0.98[5297]: libicd-network-wpasupplicant: wlan_state_change_cb: current state: scanning May 10 18:17:02 localhost icd2 0.98[5297]: libicd-network-wpasupplicant: Ignoring: BSSAdded May 10 18:17:02 localhost icd2 0.98[5297]: libicd-network-wpasupplicant: Ignoring: BSSAdded May 10 18:17:02 localhost icd2 0.98[5297]: libicd-network-wpasupplicant: Ignoring: BSSRemoved May 10 18:17:02 localhost icd2 0.98[5297]: libicd-network-wpasupplicant: Ignoring: BSSRemoved May 10 18:17:02 localhost icd2 0.98[5297]: libicd-network-wpasupplicant: Ignoring: BSSRemoved May 10 18:17:02 localhost icd2 0.98[5297]: libicd-network-wpasupplicant: Ignoring: BSSRemoved May 10 18:17:02 localhost icd2 0.98[5297]: libicd-network-wpasupplicant: Ignoring: BSSRemoved May 10 18:17:02 localhost icd2 0.98[5297]: libicd-network-wpasupplicant: Ignoring: BSSRemoved May 10 18:17:02 localhost icd2 0.98[5297]: libicd-network-wpasupplicant: on_scan_done. params: (true,) May 10 18:17:02 localhost icd2 0.98[5297]: libicd-network-wpasupplicant: SSID MATCH FOR: Tele2-3-4 | Tele2-3-4 May 10 18:17:02 localhost icd2 0.98[5297]: sending ICD_SCAN_NEW nw WLAN_INFRA/50000a1/f564fce5-6278-493e-aba7-54c0ab8803e0 srv -/-/- May 10 18:17:02 localhost icd2 0.98[5297]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/zolderkamers srv -/-/- May 10 18:17:02 localhost icd2 0.98[5297]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Sitecom26CD95 srv -/-/- May 10 18:17:02 localhost icd2 0.98[5297]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/KPNB5DC56 srv -/-/- May 10 18:17:02 localhost icd2 0.98[5297]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Ziggo7819743 srv -/-/- May 10 18:17:02 localhost icd2 0.98[5297]: sending ICD_SCAN_NEW nw WLAN_INFRA/c1/Ziggo srv -/-/- May 10 18:17:02 localhost icd2 0.98[5297]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/grote mannen huis 2 srv -/-/- May 10 18:17:02 localhost icd2 0.98[5297]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/TP-LINK_AP_2666_2 srv -/-/- May 10 18:17:02 localhost icd2 0.98[5297]: sending ICD_SCAN_NEW nw WLAN_INFRA/9/Bistro Balthazar srv -/-/- May 10 18:17:02 localhost icd2 0.98[5297]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Markt 16 srv -/-/- May 10 18:17:02 localhost icd2 0.98[5297]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Ziggo-ap-ad42704 srv -/-/- May 10 18:17:02 localhost icd2 0.98[5297]: libicd-network-wpasupplicant: SCAN DONE May 10 18:17:02 localhost icd2 0.98[5297]: libicd-network-wpasupplicant: wlan_scan_timeout May 10 18:17:02 localhost icd2 0.98[5297]: module 'libicd_network_wpasupplicant.so' scan completed May 10 18:17:02 localhost icd2 0.98[5297]: scan stop for type 'WLAN_INFRA' May 10 18:17:02 localhost icd2 0.98[5297]: '[SCAN]' type 'WLAN_INFRA' ICD_STATUS_CHANGED_SIG with status SCAN_STOP, '' sent to '(null)' May 10 18:17:02 localhost icd2 0.98[5297]: scan stop for type 'WLAN_ADHOC' May 10 18:17:02 localhost icd2 0.98[5297]: '[SCAN]' type 'WLAN_ADHOC' ICD_STATUS_CHANGED_SIG with status SCAN_STOP, '' sent to '(null)' May 10 18:17:02 localhost icd2 0.98[5297]: libicd-network-wpasupplicant: wlan_state_change_cb: current state: disconnected May 10 18:17:02 localhost icd2 0.98[5297]: libicd-network-wpasupplicant: wlan_set_state: 0 -> 0 May 10 18:17:02 localhost icd2 0.98[5297]: request 0x49af38 does not have iaps May 10 18:17:02 localhost icd2 0.98[5297]: disconnect requested for (null)/0/(null), but no matching IAP May 10 18:17:04 localhost icd2 0.98[5297]: Received com.nokia.icd2.scan_cancel_req () request May 10 18:17:04 localhost icd2 0.98[5297]: dbus api removed scanning for app ':1.34' May 10 18:17:04 localhost icd2 0.98[5297]: Received com.nokia.icd.activate (s) request May 10 18:17:04 localhost icd2 0.98[5297]: found request 0x49af38 with (null)/0/[ASK] May 10 18:17:04 localhost icd2 0.98[5297]: cancel pressed in UI May 10 18:17:04 localhost icd2 0.98[5297]: canceling policy request 0x49af48, state 1 May 10 18:17:04 localhost icd2 0.98[5297]: module 'libicd_policy_ask.so' cancel function called for request 0x49af48 May 10 18:17:04 localhost icd2 0.98[5297]: module 'libicd_policy_any.so' cancel function called for request 0x49af48 May 10 18:17:04 localhost icd2 0.98[5297]: request 0x49af38 with status ICD_REQUEST_DENIED May 10 18:17:04 localhost icd2 0.98[5297]: request 0x49af38 cancelled May 10 18:17:12 localhost icd2 0.98[5297]: module 'libicd_network_wpasupplicant.so' has no listeners, scan not restarted May 10 18:17:22 localhost icd2 0.98[5297]: network id 'Ziggo7819743' all entries expired May 10 18:17:22 localhost icd2 0.98[5297]: network id 'Ziggo-ap-ad42704' all entries expired May 10 18:17:22 localhost icd2 0.98[5297]: network id 'Sitecom26CD95' all entries expired May 10 18:17:22 localhost icd2 0.98[5297]: network id 'Ziggo' all entries expired May 10 18:17:22 localhost icd2 0.98[5297]: network id 'grote mannen huis 2' all entries expired May 10 18:17:22 localhost icd2 0.98[5297]: network id 'zolderkamers' all entries expired May 10 18:17:22 localhost icd2 0.98[5297]: network id 'KPNB5DC56' all entries expired May 10 18:17:22 localhost icd2 0.98[5297]: network id 'f564fce5-6278-493e-aba7-54c0ab8803e0' all entries expired May 10 18:17:22 localhost icd2 0.98[5297]: network id 'TP-LINK_AP_2666_2' all entries expired May 10 18:17:22 localhost icd2 0.98[5297]: network id 'Bistro Balthazar' all entries expired May 10 18:17:22 localhost icd2 0.98[5297]: network id 'Markt 16' all entries expired May 10 18:17:27 localhost icd2 0.98[5297]: signal received: Terminated May 10 18:17:27 localhost icd2 0.98[5297]: Cancelling all requests May 10 18:17:27 localhost icd2 0.98[5297]: icd context shutting down May 10 18:17:27 localhost icd2 0.98[5297]: unloading policy api modules May 10 18:17:27 localhost icd2 0.98[5297]: calling policy_destruct of module libicd_policy_any.so May 10 18:17:27 localhost icd2 0.98[5297]: calling policy_destruct of module libicd_policy_change.so May 10 18:17:27 localhost icd2 0.98[5297]: calling policy_destruct of module libicd_policy_always_online.so May 10 18:17:27 localhost icd2 0.98[5297]: Unloading service provider modules May 10 18:17:27 localhost icd2 0.98[5297]: Unloading network api modules May 10 18:17:27 localhost icd2 0.98[5297]: Calling network_destruct of module libicd_network_ofono.so May 10 18:17:27 localhost icd2 0.98[5297]: [OFONO] > ofono_network_destruct May 10 18:17:27 localhost icd2 0.98[5297]: [OFONO] > ofono_network_exit May 10 18:17:28 localhost icd2 0.98[5400]: icd2 version 0.98 starting May 10 18:17:28 localhost icd2 0.98[5400]: Loading plugin /usr/lib/icd2/libicd_network_wpasupplicant.so May 10 18:17:28 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: ICD2 WLAN network plugin 0.1.13+2m7.1 initializing May 10 18:17:28 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_set_state: 0 -> 0 May 10 18:17:28 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: try_open_wpa_control: 0x531a88 May 10 18:17:28 localhost icd2 0.98[5400]: Network module 0x51f6c8 'libicd_network_wpasupplicant.so' version 0.98 May 10 18:17:28 localhost icd2 0.98[5400]: Loading plugin /usr/lib/icd2/libicd_network_ipv4.so May 10 18:17:28 localhost icd2 0.98[5400]: Network module 0x5321d8 'libicd_network_ipv4.so' version 0.98 May 10 18:17:28 localhost icd2 0.98[5400]: Loading plugin /usr/lib/icd2/libicd_network_ofono.so May 10 18:17:28 localhost icd2 0.98[5400]: [OFONO] > icd_nw_init May 10 18:17:28 localhost icd2 0.98[5400]: [OFONO] new priv: 0x53f8f0 May 10 18:17:28 localhost icd2 0.98[5400]: [OFONO] > ofono_network_init May 10 18:17:28 localhost icd2 0.98[5400]: [OFONO] < ofono_network_init May 10 18:17:28 localhost icd2 0.98[5400]: [OFONO] < icd_nw_init May 10 18:17:28 localhost icd2 0.98[5400]: Network module 0x53f870 'libicd_network_ofono.so' version 0.98 May 10 18:17:28 localhost icd2 0.98[5400]: network type 'WLAN_ADHOC' uses module 'libicd_network_wpasupplicant.so' May 10 18:17:28 localhost icd2 0.98[5400]: network type 'WLAN_ADHOC' uses module 'libicd_network_ipv4.so' May 10 18:17:28 localhost icd2 0.98[5400]: network type 'TOR' has no modules defined May 10 18:17:28 localhost icd2 0.98[5400]: network type 'WLAN_INFRA' uses module 'libicd_network_wpasupplicant.so' May 10 18:17:28 localhost icd2 0.98[5400]: network type 'WLAN_INFRA' uses module 'libicd_network_ipv4.so' May 10 18:17:28 localhost icd2 0.98[5400]: network type 'GPRS' uses module 'libicd_network_ofono.so' May 10 18:17:28 localhost icd2 0.98[5400]: network type 'GPRS' uses module 'libicd_network_ipv4.so' May 10 18:17:28 localhost icd2 0.98[5400]: no service provider modules loaded May 10 18:17:28 localhost icd2 0.98[5400]: Loading plugin /usr/lib/icd2/libicd_policy_merge.so May 10 18:17:28 localhost icd2 0.98[5400]: Loading plugin /usr/lib/icd2/libicd_policy_ask.so May 10 18:17:28 localhost icd2 0.98[5400]: Loading plugin /usr/lib/icd2/libicd_policy_any.so May 10 18:17:28 localhost icd2 0.98[5400]: Loading plugin /usr/lib/icd2/libicd_policy_change.so May 10 18:17:28 localhost icd2 0.98[5400]: Loading plugin /usr/lib/icd2/libicd_policy_add.so May 10 18:17:28 localhost icd2 0.98[5400]: Loading plugin /usr/lib/icd2/libicd_policy_always_online.so May 10 18:17:28 localhost icd2 0.98[5400]: always online connect automatically: No May 10 18:17:28 localhost icd2 0.98[5400]: always online connection change: No May 10 18:17:28 localhost icd2 0.98[5400]: always online timeout defaults to 300 minute(s) May 10 18:17:28 localhost icd2 0.98[5400]: always online defaults to 4 IAPs in gconf May 10 18:17:28 localhost icd2 0.98[5400]: Loading plugin /usr/lib/icd2/libicd_policy_one.so May 10 18:17:28 localhost icd2 0.98[5400]: Loading plugin /usr/lib/icd2/libicd_policy_restart.so May 10 18:17:28 localhost icd2 0.98[5400]: Loading plugin /usr/lib/icd2/libicd_policy_nw_disconnect.so May 10 18:17:28 localhost icd2 0.98[5400]: listening on com.nokia.icd May 10 18:17:28 localhost icd2 0.98[5400]: listening for com.nokia.icd_ui messages May 10 18:17:28 localhost icd2 0.98[5400]: preferred srv type '(null)', srv id '(null)' May 10 18:17:28 localhost icd2 0.98[5400]: Running context... May 10 18:17:28 localhost icd2 0.98[5400]: [OFONO] > flightmode_changed May 10 18:17:28 localhost icd2 0.98[5400]: [OFONO] Device mode changed: online May 10 18:17:28 localhost icd2 0.98[5400]: [OFONO] < flightmode_changed May 10 18:17:28 localhost icd2 0.98[5400]: always online: normal mode May 10 18:17:28 localhost icd2 0.98[5400]: always online waiting 2s for the normal mode to propagate through the rest of the system, timer id is 43 May 10 18:17:28 localhost icd2 0.98[5400]: [OFONO] > manager_valid_cb May 10 18:17:28 localhost icd2 0.98[5400]: [OFONO] < manager_valid_cb May 10 18:17:30 localhost icd2 0.98[5400]: always online timer 43 triggered May 10 18:17:30 localhost icd2 0.98[5400]: always online timeout id 43 cancelled May 10 18:17:30 localhost icd2 0.98[5400]: always online doesn't run because iap count 4 <= 0; srv_provider FALSE; auto_conn is 'FALSE'; timeout 300 <= 0; number of connections 0 > 0 and always change FALSE; priority 0 May 10 18:17:30 localhost icd2 0.98[5400]: Received com.nokia.icd2.select_req (u) request May 10 18:17:30 localhost icd2 0.98[5400]: tracking info sender ':1.25' and message (nil) added to request 0x547440 May 10 18:17:30 localhost icd2 0.98[5400]: requesting request 0x547440, attr 1, (null)/0/(null),(null)/0/[ASK] May 10 18:17:30 localhost icd2 0.98[5400]: running module 'libicd_policy_merge.so' new_request policy May 10 18:17:30 localhost icd2 0.98[5400]: running module 'libicd_policy_ask.so' new_request policy May 10 18:17:30 localhost icd2 0.98[5400]: Requesting 'Select connection' dialog May 10 18:17:30 localhost icd2 0.98[5400]: policy iap ask pending returned May 10 18:17:30 localhost icd2 0.98[5400]: 'Select connection' dialog responded (2) May 10 18:17:30 localhost icd2 0.98[5400]: policy returned ICD_POLICY_WAITING for request 0x547440 May 10 18:17:30 localhost icd2 0.98[5400]: request 0x547440 is waiting for actions May 10 18:17:30 localhost icd2 0.98[5400]: request 0x547440 with status ICD_REQUEST_WAITING May 10 18:17:30 localhost icd2 0.98[5400]: Received com.nokia.icd2.scan_req (u) request May 10 18:17:30 localhost icd2 0.98[5400]: scan start for type 'GPRS' May 10 18:17:30 localhost icd2 0.98[5400]: '[SCAN]' type 'GPRS' ICD_STATUS_CHANGED_SIG with status SCAN_START, '' sent to '(null)' May 10 18:17:30 localhost icd2 0.98[5400]: [OFONO] > ofono_start_search May 10 18:17:30 localhost icd2 0.98[5400]: [OFONO] path /motmdm_0 May 10 18:17:30 localhost icd2 0.98[5400]: [OFONO] Token (nil) May 10 18:17:30 localhost icd2 0.98[5400]: [OFONO] < ofono_start_search May 10 18:17:30 localhost icd2 0.98[5400]: dbus api successfully started 'GPRS' scan for ':1.34' May 10 18:17:30 localhost icd2 0.98[5400]: scan start for type 'WLAN_INFRA' May 10 18:17:30 localhost icd2 0.98[5400]: '[SCAN]' type 'WLAN_INFRA' ICD_STATUS_CHANGED_SIG with status SCAN_START, '' sent to '(null)' May 10 18:17:30 localhost icd2 0.98[5400]: scan start for type 'WLAN_ADHOC' May 10 18:17:30 localhost icd2 0.98[5400]: '[SCAN]' type 'WLAN_ADHOC' ICD_STATUS_CHANGED_SIG with status SCAN_START, '' sent to '(null)' May 10 18:17:30 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_start_search May 10 18:17:30 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: try_disconnect_wpa_control failed with -1, reported buf len is 2147483648 May 10 18:17:30 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: close_wpa_control: 0x531a88 May 10 18:17:30 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: try_open_wpa_control: 0x54f6b0 May 10 18:17:30 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: close_wpa_control: 0x54f6b0 May 10 18:17:30 localhost icd2 0.98[5400]: dbus api successfully started 'WLAN_INFRA' scan for ':1.34' May 10 18:17:30 localhost icd2 0.98[5400]: dbus api successfully started 'WLAN_ADHOC' scan for ':1.34' May 10 18:17:30 localhost icd2 0.98[5400]: Received com.nokia.icd2.state_req () request May 10 18:17:30 localhost icd2 0.98[5400]: request 0x547440 has no IAPs May 10 18:17:30 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_state_change_cb: current state: scanning May 10 18:17:30 localhost icd2 0.98[5400]: [OFONO] > search_operation_check May 10 18:17:30 localhost icd2 0.98[5400]: [OFONO] Status 2 May 10 18:17:30 localhost icd2 0.98[5400]: [OFONO] < search_operation_check May 10 18:17:30 localhost icd2 0.98[5400]: [OFONO] > ofono_start_search_finish May 10 18:17:30 localhost icd2 0.98[5400]: [OFONO] Search group for path /motmdm_0 finished, status 2 May 10 18:17:30 localhost icd2 0.98[5400]: [OFONO] > add_search_result May 10 18:17:30 localhost icd2 0.98[5400]: [OFONO] SIM 204086485211992 seen for the very first time, provisioning. May 10 18:17:30 localhost icd2 0.98[5400]: [OFONO] Adding GPRS/ab4c7733-4a2e-4658-9b5a-2bc4f3b07670/Youfone/204086485211992 May 10 18:17:30 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw GPRS/5000000/ab4c7733-4a2e-4658-9b5a-2bc4f3b07670 srv -/-/- May 10 18:17:30 localhost icd2 0.98[5400]: [OFONO] < add_search_result May 10 18:17:30 localhost icd2 0.98[5400]: [OFONO] < ofono_start_search_finish May 10 18:17:30 localhost icd2 0.98[5400]: always online will soon check whether connections were added May 10 18:17:30 localhost icd2 0.98[5400]: [OFONO] > idle_check_group_list May 10 18:17:30 localhost icd2 0.98[5400]: [OFONO] Search finished May 10 18:17:30 localhost icd2 0.98[5400]: [OFONO] Calling search_cb to finish searching May 10 18:17:30 localhost icd2 0.98[5400]: module 'libicd_network_ofono.so' scan completed May 10 18:17:30 localhost icd2 0.98[5400]: scan stop for type 'GPRS' May 10 18:17:30 localhost icd2 0.98[5400]: '[SCAN]' type 'GPRS' ICD_STATUS_CHANGED_SIG with status SCAN_STOP, '' sent to '(null)' May 10 18:17:30 localhost icd2 0.98[5400]: [OFONO] < idle_check_group_list May 10 18:17:30 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: BSSAdded May 10 18:17:30 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: BSSAdded May 10 18:17:30 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: BSSAdded May 10 18:17:30 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: BSSAdded May 10 18:17:30 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: BSSAdded May 10 18:17:30 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: on_scan_done. params: (true,) May 10 18:17:30 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: SSID MATCH FOR: Tele2-3-4 | Tele2-3-4 May 10 18:17:30 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/50000a1/f564fce5-6278-493e-aba7-54c0ab8803e0 srv -/-/- May 10 18:17:30 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/zolderkamers srv -/-/- May 10 18:17:30 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Sitecom26CD95 srv -/-/- May 10 18:17:30 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/KPNB5DC56 srv -/-/- May 10 18:17:31 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Ziggo7819743 srv -/-/- May 10 18:17:31 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/c1/Ziggo srv -/-/- May 10 18:17:31 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/grote mannen huis 2 srv -/-/- May 10 18:17:31 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/TP-LINK_AP_2666_2 srv -/-/- May 10 18:17:31 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/9/Bistro Balthazar srv -/-/- May 10 18:17:31 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Markt 16 srv -/-/- May 10 18:17:31 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Ziggo-ap-ad42704 srv -/-/- May 10 18:17:31 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/KPN394346 srv -/-/- May 10 18:17:31 localhost icd2 0.98[5400]: sending ICD_SCAN_NOTIFY nw WLAN_INFRA/a1/grote mannen huis 2 srv -/-/- May 10 18:17:31 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/c1/Wageningen srv -/-/- May 10 18:17:31 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Wageningen-Raad srv -/-/- May 10 18:17:31 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/9/Wageningen-Guest srv -/-/- May 10 18:17:31 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: SCAN DONE May 10 18:17:31 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_scan_timeout May 10 18:17:31 localhost icd2 0.98[5400]: module 'libicd_network_wpasupplicant.so' scan completed May 10 18:17:31 localhost icd2 0.98[5400]: scan stop for type 'WLAN_INFRA' May 10 18:17:31 localhost icd2 0.98[5400]: '[SCAN]' type 'WLAN_INFRA' ICD_STATUS_CHANGED_SIG with status SCAN_STOP, '' sent to '(null)' May 10 18:17:31 localhost icd2 0.98[5400]: scan stop for type 'WLAN_ADHOC' May 10 18:17:31 localhost icd2 0.98[5400]: '[SCAN]' type 'WLAN_ADHOC' ICD_STATUS_CHANGED_SIG with status SCAN_STOP, '' sent to '(null)' May 10 18:17:31 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_state_change_cb: current state: disconnected May 10 18:17:31 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_set_state: 0 -> 0 May 10 18:17:31 localhost icd2 0.98[5400]: request 0x547440 does not have iaps May 10 18:17:31 localhost icd2 0.98[5400]: disconnect requested for (null)/0/(null), but no matching IAP May 10 18:17:31 localhost icd2 0.98[5400]: always online found 4 IAPs in gconf May 10 18:17:32 localhost icd2 0.98[5400]: Received com.nokia.icd2.scan_cancel_req () request May 10 18:17:32 localhost icd2 0.98[5400]: dbus api removed scanning for app ':1.34' May 10 18:17:32 localhost icd2 0.98[5400]: Received com.nokia.icd2.connect_req (ua(sussuay)) request May 10 18:17:32 localhost icd2 0.98[5400]: icd dbus got one nw only, /0/ srv GPRS/5000000/ab4c7733-4a2e-4658-9b5a-2bc4f3b07670 May 10 18:17:32 localhost icd2 0.98[5400]: tracking info sender ':1.34' and message (nil) added to request 0x54ae40 May 10 18:17:32 localhost icd2 0.98[5400]: found request 0x547440 with (null)/0/[ASK] May 10 18:17:32 localhost icd2 0.98[5400]: copying user ':1.25' and request (nil) from 0x547440 to 0x54ae40 May 10 18:17:32 localhost icd2 0.98[5400]: tracking info sender ':1.25' and message (nil) added to request 0x54ae40 May 10 18:17:32 localhost icd2 0.98[5400]: module 'libicd_policy_ask.so' cancel function called for request 0x547450 May 10 18:17:32 localhost icd2 0.98[5400]: module 'libicd_policy_any.so' cancel function called for request 0x547450 May 10 18:17:32 localhost icd2 0.98[5400]: request 0x547440 with status ICD_REQUEST_MERGED May 10 18:17:32 localhost icd2 0.98[5400]: Request 0x547440, attrs 1 merged with 0x54ae40, resulting attrs 1 May 10 18:17:32 localhost icd2 0.98[5400]: requesting request 0x54ae40, attr 1, /0/,GPRS/5000000/ab4c7733-4a2e-4658-9b5a-2bc4f3b07670 May 10 18:17:32 localhost icd2 0.98[5400]: running module 'libicd_policy_merge.so' new_request policy May 10 18:17:32 localhost icd2 0.98[5400]: running module 'libicd_policy_ask.so' new_request policy May 10 18:17:32 localhost icd2 0.98[5400]: running module 'libicd_policy_any.so' new_request policy May 10 18:17:32 localhost icd2 0.98[5400]: running module 'libicd_policy_change.so' new_request policy May 10 18:17:32 localhost icd2 0.98[5400]: running module 'libicd_policy_add.so' new_request policy May 10 18:17:32 localhost icd2 0.98[5400]: adding IAP /0/,GPRS/5000000/ab4c7733-4a2e-4658-9b5a-2bc4f3b07670 to request 0x54ae40 May 10 18:17:32 localhost icd2 0.98[5400]: all new request policies done May 10 18:17:32 localhost icd2 0.98[5400]: request 0x54ae40 with status ICD_REQUEST_CONNECTING_IAPS May 10 18:17:32 localhost icd2 0.98[5400]: Trying IAP 0x552128 May 10 18:17:32 localhost icd2 0.98[5400]: 'ab4c7733-4a2e-4658-9b5a-2bc4f3b07670' type 'GPRS' ICD_STATUS_CHANGED_SIG with status CONNECTING, '' sent to '(null)' May 10 18:17:32 localhost icd2 0.98[5400]: Request to connect iap 0x552128 May 10 18:17:32 localhost icd2 0.98[5408]: running pre-up scripts in /etc/network/if-pre-up.d, setting following env: May 10 18:17:32 localhost icd2 0.98[5400]: script timeout value not set, using default 15s May 10 18:17:32 localhost icd2 0.98[5408]: MODE=start May 10 18:17:32 localhost icd2 0.98[5408]: PHASE=pre-up May 10 18:17:32 localhost icd2 0.98[5408]: VERBOSITY=0 May 10 18:17:32 localhost icd2 0.98[5408]: PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin May 10 18:17:32 localhost icd2 0.98[5408]: ICD_CONNECTION_ID=ab4c7733-4a2e-4658-9b5a-2bc4f3b07670 May 10 18:17:32 localhost icd2 0.98[5408]: ICD_CONNECTION_TYPE=GPRS May 10 18:17:32 localhost icd2 0.98[5400]: signal received: Child exited May 10 18:17:32 localhost icd2 0.98[5400]: pid 5408 has exited with status 0 May 10 18:17:32 localhost icd2 0.98[5400]: script cb 0x4e66c1 with pid 5408, exit value 0, user data 0x552128 May 10 18:17:32 localhost icd2 0.98[5400]: iap 0x552128 in state ICD_IAP_STATE_SCRIPT_PRE_UP pre-up scripts run, continue connecting May 10 18:17:32 localhost icd2 0.98[5400]: connecting iap 0x552128 in state ICD_IAP_STATE_SCRIPT_PRE_UP: interface is '(null)' May 10 18:17:32 localhost icd2 0.98[5400]: calling module 'libicd_network_ofono.so' link_up May 10 18:17:32 localhost icd2 0.98[5400]: [OFONO] > ofono_link_up May 10 18:17:32 localhost icd2 0.98[5400]: [OFONO] Getting IMSI May 10 18:17:32 localhost icd2 0.98[5400]: [OFONO] Got IMSI: 204086485211992 May 10 18:17:32 localhost icd2 0.98[5400]: [OFONO] Got modem data May 10 18:17:32 localhost icd2 0.98[5400]: [OFONO] Got APN: May 10 18:17:32 localhost icd2 0.98[5400]: [OFONO] Got Ctx: 0x54b100 May 10 18:17:32 localhost icd2 0.98[5400]: [OFONO] Context is not yet active, activating May 10 18:17:32 localhost icd2 0.98[5400]: iap 0x552128 link_up callback did not set interface '(null)' May 10 18:17:32 localhost icd2 0.98[5400]: iap 0x552128 callback in state ICD_IAP_STATE_LINK_UP with status 3, error 'no_network', interface '(null)' May 10 18:17:32 localhost icd2 0.98[5400]: IAP reports error 'no_network' May 10 18:17:32 localhost icd2 0.98[5400]: no more link_down functions to call May 10 18:17:32 localhost icd2 0.98[5400]: no env vars for post-down script May 10 18:17:32 localhost icd2 0.98[5415]: running post-down scripts in /etc/network/if-post-down.d, setting following env: May 10 18:17:32 localhost icd2 0.98[5415]: MODE=stop May 10 18:17:32 localhost icd2 0.98[5415]: PHASE=post-down May 10 18:17:32 localhost icd2 0.98[5415]: VERBOSITY=0 May 10 18:17:32 localhost icd2 0.98[5415]: PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin May 10 18:17:32 localhost icd2 0.98[5415]: ICD_CONNECTION_ID=ab4c7733-4a2e-4658-9b5a-2bc4f3b07670 May 10 18:17:32 localhost icd2 0.98[5415]: ICD_CONNECTION_TYPE=GPRS May 10 18:17:32 localhost icd2 0.98[5400]: script timeout value not set, using default 15s May 10 18:17:32 localhost icd2 0.98[5400]: [OFONO] < ofono_link_up May 10 18:17:32 localhost icd2 0.98[5400]: signal received: Child exited May 10 18:17:32 localhost icd2 0.98[5400]: pid 5415 has exited with status 0 May 10 18:17:32 localhost icd2 0.98[5400]: script cb 0x4e6c95 with pid 5415, exit value 0, user data 0x552128 May 10 18:17:32 localhost icd2 0.98[5400]: iap disconnected, error is 'no_network' May 10 18:17:32 localhost icd2 0.98[5400]: IAP status is ICD_IAP_FAILED May 10 18:17:32 localhost icd2 0.98[5400]: 'ab4c7733-4a2e-4658-9b5a-2bc4f3b07670' type 'GPRS' ICD_STATUS_CHANGED_SIG with status IDLE, 'no_network' sent to '(null)' May 10 18:17:32 localhost icd2 0.98[5400]: running module 'libicd_policy_always_online.so' disconnected policy May 10 18:17:32 localhost icd2 0.98[5400]: request 0x54ae40 has no IAPs May 10 18:17:32 localhost icd2 0.98[5400]: always online sees network disconnected, but none connected May 10 18:17:32 localhost icd2 0.98[5400]: No more IAPs to try, request retry from user May 10 18:17:32 localhost icd2 0.98[5400]: request 0x54ae40 with status ICD_REQUEST_WAITING May 10 18:17:32 localhost icd2 0.98[5400]: 'show_retry_dlg' successfully requested from UI May 10 18:17:32 localhost icd2 0.98[5400]: icd UI callback 0x4eca35 called with success '1' user data 0x54ae40 May 10 18:17:32 localhost icd2 0.98[5400]: request dialog successfully requested May 10 18:17:34 localhost icd2 0.98[5400]: received 'com.nokia.icd_ui.retry' (sbb) signal from UI May 10 18:17:34 localhost icd2 0.98[5400]: searching for normal iap 'ab4c7733-4a2e-4658-9b5a-2bc4f3b07670' May 10 18:17:34 localhost icd2 0.98[5400]: IAP for GPRS/1000000/ab4c7733-4a2e-4658-9b5a-2bc4f3b07670 found May 10 18:17:34 localhost icd2 0.98[5400]: retry from UI: id 'ab4c7733-4a2e-4658-9b5a-2bc4f3b07670', retry 1, retry_this 0 May 10 18:17:34 localhost icd2 0.98[5400]: retry from UI: disconnected from 0x552128 May 10 18:17:34 localhost icd2 0.98[5400]: 'ab4c7733-4a2e-4658-9b5a-2bc4f3b07670' type 'GPRS' ICD_STATUS_CHANGED_SIG with status IDLE, '' sent to '(null)' May 10 18:17:34 localhost icd2 0.98[5400]: Removing active IAP 0x517f50/(nil)/(nil)/(nil) May 10 18:17:34 localhost icd2 0.98[5400]: IAP ab4c7733-4a2e-4658-9b5a-2bc4f3b07670/GPRS/0x5000000 cache check May 10 18:17:34 localhost icd2 0.98[5400]: IAP ab4c7733-4a2e-4658-9b5a-2bc4f3b07670 found in the cache list, removing it. May 10 18:17:34 localhost icd2 0.98[5400]: network id 'ab4c7733-4a2e-4658-9b5a-2bc4f3b07670' all entries (1) removed May 10 18:17:34 localhost icd2 0.98[5400]: Removed temp IAP 0x552128 from cache. May 10 18:17:34 localhost icd2 0.98[5400]: Freeing IAP 0x552128 May 10 18:17:34 localhost icd2 0.98[5400]: copying user ':1.25' and request (nil) from 0x54ae40 to 0x550348 May 10 18:17:34 localhost icd2 0.98[5400]: tracking info sender ':1.25' and message (nil) added to request 0x550348 May 10 18:17:34 localhost icd2 0.98[5400]: copying user ':1.34' and request (nil) from 0x54ae40 to 0x550348 May 10 18:17:34 localhost icd2 0.98[5400]: tracking info sender ':1.34' and message (nil) added to request 0x550348 May 10 18:17:34 localhost icd2 0.98[5400]: module 'libicd_policy_ask.so' cancel function called for request 0x54ae50 May 10 18:17:34 localhost icd2 0.98[5400]: module 'libicd_policy_any.so' cancel function called for request 0x54ae50 May 10 18:17:34 localhost icd2 0.98[5400]: request 0x54ae40 with status ICD_REQUEST_MERGED May 10 18:17:34 localhost icd2 0.98[5400]: Request 0x54ae40, attrs 9 merged with 0x550348, resulting attrs 1 May 10 18:17:34 localhost icd2 0.98[5400]: requesting request 0x550348, attr 1, (null)/0/(null),(null)/0/[ASK] May 10 18:17:34 localhost icd2 0.98[5400]: running module 'libicd_policy_merge.so' new_request policy May 10 18:17:34 localhost icd2 0.98[5400]: running module 'libicd_policy_ask.so' new_request policy May 10 18:17:34 localhost icd2 0.98[5400]: Requesting 'Select connection' dialog May 10 18:17:34 localhost icd2 0.98[5400]: policy iap ask pending returned May 10 18:17:34 localhost icd2 0.98[5400]: 'Select connection' dialog responded (2) May 10 18:17:34 localhost icd2 0.98[5400]: policy returned ICD_POLICY_WAITING for request 0x550348 May 10 18:17:34 localhost icd2 0.98[5400]: request 0x550348 is waiting for actions May 10 18:17:34 localhost icd2 0.98[5400]: request 0x550348 with status ICD_REQUEST_WAITING May 10 18:17:34 localhost icd2 0.98[5400]: Received com.nokia.icd2.scan_req (u) request May 10 18:17:34 localhost icd2 0.98[5400]: scan cache contains 0 elements May 10 18:17:34 localhost icd2 0.98[5400]: scan cache contains 0 elements May 10 18:17:34 localhost icd2 0.98[5400]: scan start for type 'GPRS' May 10 18:17:34 localhost icd2 0.98[5400]: '[SCAN]' type 'GPRS' ICD_STATUS_CHANGED_SIG with status SCAN_START, '' sent to '(null)' May 10 18:17:34 localhost icd2 0.98[5400]: [OFONO] > ofono_start_search May 10 18:17:34 localhost icd2 0.98[5400]: [OFONO] path /motmdm_0 May 10 18:17:34 localhost icd2 0.98[5400]: [OFONO] Token (nil) May 10 18:17:34 localhost icd2 0.98[5400]: [OFONO] < ofono_start_search May 10 18:17:34 localhost icd2 0.98[5400]: dbus api successfully started 'GPRS' scan for ':1.34' May 10 18:17:34 localhost icd2 0.98[5400]: scan cache contains 1 elements May 10 18:17:34 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/9/Wageningen-Guest srv -/-/- May 10 18:17:34 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/KPN394346 srv -/-/- May 10 18:17:34 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Ziggo7819743 srv -/-/- May 10 18:17:34 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Ziggo-ap-ad42704 srv -/-/- May 10 18:17:34 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Sitecom26CD95 srv -/-/- May 10 18:17:34 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/c1/Ziggo srv -/-/- May 10 18:17:34 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/grote mannen huis 2 srv -/-/- May 10 18:17:34 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/zolderkamers srv -/-/- May 10 18:17:34 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Wageningen-Raad srv -/-/- May 10 18:17:34 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/KPNB5DC56 srv -/-/- May 10 18:17:34 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/50000a1/f564fce5-6278-493e-aba7-54c0ab8803e0 srv -/-/- May 10 18:17:34 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/TP-LINK_AP_2666_2 srv -/-/- May 10 18:17:34 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/9/Bistro Balthazar srv -/-/- May 10 18:17:34 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/c1/Wageningen srv -/-/- May 10 18:17:34 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Markt 16 srv -/-/- May 10 18:17:34 localhost icd2 0.98[5400]: scan cache contains 1 elements May 10 18:17:34 localhost icd2 0.98[5400]: dbus api successfully started 'WLAN_INFRA' scan for ':1.34' May 10 18:17:34 localhost icd2 0.98[5400]: scan cache contains 1 elements May 10 18:17:34 localhost icd2 0.98[5400]: scan cache contains 1 elements May 10 18:17:34 localhost icd2 0.98[5400]: dbus api successfully started 'WLAN_ADHOC' scan for ':1.34' May 10 18:17:34 localhost icd2 0.98[5400]: Received com.nokia.icd2.state_req () request May 10 18:17:34 localhost icd2 0.98[5400]: request 0x550348 has no IAPs May 10 18:17:34 localhost icd2 0.98[5400]: [OFONO] > search_operation_check May 10 18:17:34 localhost icd2 0.98[5400]: [OFONO] Deactivating chosen context /motmdm_0/context1 May 10 18:17:34 localhost icd2 0.98[5400]: [OFONO] Status 1 May 10 18:17:34 localhost icd2 0.98[5400]: [OFONO] < search_operation_check May 10 18:17:35 localhost icd2 0.98[5400]: Received com.nokia.icd2.scan_cancel_req () request May 10 18:17:35 localhost icd2 0.98[5400]: dbus api removed scanning for app ':1.34' May 10 18:17:35 localhost icd2 0.98[5400]: Received com.nokia.icd.activate (s) request May 10 18:17:35 localhost icd2 0.98[5400]: found request 0x550348 with (null)/0/[ASK] May 10 18:17:35 localhost icd2 0.98[5400]: cancel pressed in UI May 10 18:17:35 localhost icd2 0.98[5400]: canceling policy request 0x550358, state 1 May 10 18:17:35 localhost icd2 0.98[5400]: module 'libicd_policy_ask.so' cancel function called for request 0x550358 May 10 18:17:35 localhost icd2 0.98[5400]: module 'libicd_policy_any.so' cancel function called for request 0x550358 May 10 18:17:35 localhost icd2 0.98[5400]: request 0x550348 with status ICD_REQUEST_DENIED May 10 18:17:35 localhost icd2 0.98[5400]: request 0x550348 cancelled May 10 18:17:41 localhost icd2 0.98[5400]: module 'libicd_network_wpasupplicant.so' has no listeners, scan not restarted May 10 18:17:50 localhost icd2 0.98[5400]: module 'libicd_network_ofono.so' has no listeners, scan not restarted May 10 18:17:51 localhost icd2 0.98[5400]: network id 'Wageningen-Guest' all entries expired May 10 18:17:51 localhost icd2 0.98[5400]: network id 'KPN394346' all entries expired May 10 18:17:51 localhost icd2 0.98[5400]: network id 'Ziggo7819743' all entries expired May 10 18:17:51 localhost icd2 0.98[5400]: network id 'Ziggo-ap-ad42704' all entries expired May 10 18:17:51 localhost icd2 0.98[5400]: network id 'Sitecom26CD95' all entries expired May 10 18:17:51 localhost icd2 0.98[5400]: network id 'Ziggo' all entries expired May 10 18:17:51 localhost icd2 0.98[5400]: network id 'grote mannen huis 2' all entries expired May 10 18:17:51 localhost icd2 0.98[5400]: network id 'zolderkamers' all entries expired May 10 18:17:51 localhost icd2 0.98[5400]: network id 'Wageningen-Raad' all entries expired May 10 18:17:51 localhost icd2 0.98[5400]: network id 'KPNB5DC56' all entries expired May 10 18:17:51 localhost icd2 0.98[5400]: network id 'f564fce5-6278-493e-aba7-54c0ab8803e0' all entries expired May 10 18:17:51 localhost icd2 0.98[5400]: network id 'TP-LINK_AP_2666_2' all entries expired May 10 18:17:51 localhost icd2 0.98[5400]: network id 'Bistro Balthazar' all entries expired May 10 18:17:51 localhost icd2 0.98[5400]: network id 'Wageningen' all entries expired May 10 18:17:51 localhost icd2 0.98[5400]: network id 'Markt 16' all entries expired May 10 18:17:54 localhost icd2 0.98[5400]: [OFONO] > operations_group_timeout May 10 18:17:54 localhost icd2 0.98[5400]: [OFONO] > ofono_start_search_finish May 10 18:17:54 localhost icd2 0.98[5400]: [OFONO] Search group for path /motmdm_0 finished, status 6 May 10 18:17:54 localhost icd2 0.98[5400]: [OFONO] < ofono_start_search_finish May 10 18:17:54 localhost icd2 0.98[5400]: [OFONO] < operations_group_timeout May 10 18:17:54 localhost icd2 0.98[5400]: [OFONO] > idle_check_group_list May 10 18:17:54 localhost icd2 0.98[5400]: [OFONO] < idle_check_group_list May 10 18:17:58 localhost icd2 0.98[5400]: Received com.nokia.icd2.select_req (u) request May 10 18:17:58 localhost icd2 0.98[5400]: tracking info sender ':1.25' and message (nil) added to request 0x547440 May 10 18:17:58 localhost icd2 0.98[5400]: requesting request 0x547440, attr 1, (null)/0/(null),(null)/0/[ASK] May 10 18:17:58 localhost icd2 0.98[5400]: running module 'libicd_policy_merge.so' new_request policy May 10 18:17:58 localhost icd2 0.98[5400]: running module 'libicd_policy_ask.so' new_request policy May 10 18:17:58 localhost icd2 0.98[5400]: Requesting 'Select connection' dialog May 10 18:17:58 localhost icd2 0.98[5400]: policy iap ask pending returned May 10 18:17:58 localhost icd2 0.98[5400]: 'Select connection' dialog responded (2) May 10 18:17:58 localhost icd2 0.98[5400]: policy returned ICD_POLICY_WAITING for request 0x547440 May 10 18:17:58 localhost icd2 0.98[5400]: request 0x547440 is waiting for actions May 10 18:17:58 localhost icd2 0.98[5400]: request 0x547440 with status ICD_REQUEST_WAITING May 10 18:17:58 localhost icd2 0.98[5400]: Received com.nokia.icd2.scan_req (u) request May 10 18:17:58 localhost icd2 0.98[5400]: scan cache contains 0 elements May 10 18:17:58 localhost icd2 0.98[5400]: dbus api successfully started 'GPRS' scan for ':1.34' May 10 18:17:58 localhost icd2 0.98[5400]: scan start for type 'WLAN_INFRA' May 10 18:17:58 localhost icd2 0.98[5400]: '[SCAN]' type 'WLAN_INFRA' ICD_STATUS_CHANGED_SIG with status SCAN_START, '' sent to '(null)' May 10 18:17:58 localhost icd2 0.98[5400]: scan start for type 'WLAN_ADHOC' May 10 18:17:58 localhost icd2 0.98[5400]: '[SCAN]' type 'WLAN_ADHOC' ICD_STATUS_CHANGED_SIG with status SCAN_START, '' sent to '(null)' May 10 18:17:58 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_start_search May 10 18:17:58 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: try_open_wpa_control: 0x54f6b0 May 10 18:17:58 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: close_wpa_control: 0x54f6b0 May 10 18:17:58 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: try_open_wpa_control: 0x551e38 May 10 18:17:58 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: close_wpa_control: 0x551e38 May 10 18:17:58 localhost icd2 0.98[5400]: dbus api successfully started 'WLAN_INFRA' scan for ':1.34' May 10 18:17:58 localhost icd2 0.98[5400]: dbus api successfully started 'WLAN_ADHOC' scan for ':1.34' May 10 18:17:58 localhost icd2 0.98[5400]: Received com.nokia.icd2.state_req () request May 10 18:17:58 localhost icd2 0.98[5400]: request 0x547440 has no IAPs May 10 18:17:58 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_state_change_cb: current state: scanning May 10 18:17:59 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: BSSAdded May 10 18:17:59 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: BSSAdded May 10 18:17:59 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: BSSAdded May 10 18:17:59 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: on_scan_done. params: (true,) May 10 18:17:59 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: SSID MATCH FOR: Tele2-3-4 | Tele2-3-4 May 10 18:17:59 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/50000a1/f564fce5-6278-493e-aba7-54c0ab8803e0 srv -/-/- May 10 18:17:59 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/zolderkamers srv -/-/- May 10 18:17:59 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Sitecom26CD95 srv -/-/- May 10 18:17:59 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/KPNB5DC56 srv -/-/- May 10 18:17:59 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Ziggo7819743 srv -/-/- May 10 18:17:59 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/c1/Ziggo srv -/-/- May 10 18:17:59 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/grote mannen huis 2 srv -/-/- May 10 18:17:59 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/TP-LINK_AP_2666_2 srv -/-/- May 10 18:17:59 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/9/Bistro Balthazar srv -/-/- May 10 18:17:59 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Markt 16 srv -/-/- May 10 18:17:59 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Ziggo-ap-ad42704 srv -/-/- May 10 18:17:59 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/KPN394346 srv -/-/- May 10 18:17:59 localhost icd2 0.98[5400]: sending ICD_SCAN_UPDATE nw WLAN_INFRA/a1/grote mannen huis 2 srv -/-/- May 10 18:17:59 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/c1/Wageningen srv -/-/- May 10 18:17:59 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Wageningen-Raad srv -/-/- May 10 18:17:59 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/9/Wageningen-Guest srv -/-/- May 10 18:17:59 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Grote mannen huis srv -/-/- May 10 18:17:59 localhost icd2 0.98[5400]: sending ICD_SCAN_NOTIFY nw WLAN_INFRA/c1/Ziggo srv -/-/- May 10 18:17:59 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Eijsink32769K5 srv -/-/- May 10 18:17:59 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: SCAN DONE May 10 18:17:59 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_scan_timeout May 10 18:17:59 localhost icd2 0.98[5400]: module 'libicd_network_wpasupplicant.so' scan completed May 10 18:17:59 localhost icd2 0.98[5400]: scan stop for type 'WLAN_INFRA' May 10 18:17:59 localhost icd2 0.98[5400]: '[SCAN]' type 'WLAN_INFRA' ICD_STATUS_CHANGED_SIG with status SCAN_STOP, '' sent to '(null)' May 10 18:17:59 localhost icd2 0.98[5400]: scan stop for type 'WLAN_ADHOC' May 10 18:17:59 localhost icd2 0.98[5400]: '[SCAN]' type 'WLAN_ADHOC' ICD_STATUS_CHANGED_SIG with status SCAN_STOP, '' sent to '(null)' May 10 18:17:59 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_state_change_cb: current state: disconnected May 10 18:17:59 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_set_state: 0 -> 0 May 10 18:17:59 localhost icd2 0.98[5400]: request 0x547440 does not have iaps May 10 18:17:59 localhost icd2 0.98[5400]: disconnect requested for (null)/0/(null), but no matching IAP May 10 18:18:00 localhost icd2 0.98[5400]: deferred scan cache expiration for 'libicd_network_ofono.so' due to new scan May 10 18:18:00 localhost icd2 0.98[5400]: Received com.nokia.icd2.scan_cancel_req () request May 10 18:18:00 localhost icd2 0.98[5400]: dbus api removed scanning for app ':1.34' May 10 18:18:00 localhost icd2 0.98[5400]: Received com.nokia.icd.activate (s) request May 10 18:18:00 localhost icd2 0.98[5400]: found request 0x547440 with (null)/0/[ASK] May 10 18:18:00 localhost icd2 0.98[5400]: cancel pressed in UI May 10 18:18:00 localhost icd2 0.98[5400]: canceling policy request 0x547450, state 1 May 10 18:18:00 localhost icd2 0.98[5400]: module 'libicd_policy_ask.so' cancel function called for request 0x547450 May 10 18:18:00 localhost icd2 0.98[5400]: module 'libicd_policy_any.so' cancel function called for request 0x547450 May 10 18:18:00 localhost icd2 0.98[5400]: request 0x547440 with status ICD_REQUEST_DENIED May 10 18:18:00 localhost icd2 0.98[5400]: request 0x547440 cancelled May 10 18:18:01 localhost icd2 0.98[5400]: Received com.nokia.icd2.select_req (u) request May 10 18:18:01 localhost icd2 0.98[5400]: tracking info sender ':1.25' and message (nil) added to request 0x5523d0 May 10 18:18:01 localhost icd2 0.98[5400]: requesting request 0x5523d0, attr 1, (null)/0/(null),(null)/0/[ASK] May 10 18:18:01 localhost icd2 0.98[5400]: running module 'libicd_policy_merge.so' new_request policy May 10 18:18:01 localhost icd2 0.98[5400]: running module 'libicd_policy_ask.so' new_request policy May 10 18:18:01 localhost icd2 0.98[5400]: Requesting 'Select connection' dialog May 10 18:18:01 localhost icd2 0.98[5400]: policy iap ask pending returned May 10 18:18:01 localhost icd2 0.98[5400]: 'Select connection' dialog responded (2) May 10 18:18:01 localhost icd2 0.98[5400]: policy returned ICD_POLICY_WAITING for request 0x5523d0 May 10 18:18:01 localhost icd2 0.98[5400]: request 0x5523d0 is waiting for actions May 10 18:18:01 localhost icd2 0.98[5400]: request 0x5523d0 with status ICD_REQUEST_WAITING May 10 18:18:01 localhost icd2 0.98[5400]: Received com.nokia.icd2.scan_req (u) request May 10 18:18:01 localhost icd2 0.98[5400]: scan cache contains 0 elements May 10 18:18:01 localhost icd2 0.98[5400]: dbus api successfully started 'GPRS' scan for ':1.34' May 10 18:18:01 localhost icd2 0.98[5400]: scan cache contains 1 elements May 10 18:18:01 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/9/Wageningen-Guest srv -/-/- May 10 18:18:01 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/KPN394346 srv -/-/- May 10 18:18:01 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Ziggo7819743 srv -/-/- May 10 18:18:01 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Ziggo-ap-ad42704 srv -/-/- May 10 18:18:01 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Sitecom26CD95 srv -/-/- May 10 18:18:01 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Grote mannen huis srv -/-/- May 10 18:18:01 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/c1/Ziggo srv -/-/- May 10 18:18:01 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Eijsink32769K5 srv -/-/- May 10 18:18:01 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/grote mannen huis 2 srv -/-/- May 10 18:18:01 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/zolderkamers srv -/-/- May 10 18:18:01 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Wageningen-Raad srv -/-/- May 10 18:18:01 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/KPNB5DC56 srv -/-/- May 10 18:18:01 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/50000a1/f564fce5-6278-493e-aba7-54c0ab8803e0 srv -/-/- May 10 18:18:02 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/TP-LINK_AP_2666_2 srv -/-/- May 10 18:18:02 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/9/Bistro Balthazar srv -/-/- May 10 18:18:02 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/c1/Wageningen srv -/-/- May 10 18:18:02 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Markt 16 srv -/-/- May 10 18:18:02 localhost icd2 0.98[5400]: scan cache contains 1 elements May 10 18:18:02 localhost icd2 0.98[5400]: dbus api successfully started 'WLAN_INFRA' scan for ':1.34' May 10 18:18:02 localhost icd2 0.98[5400]: scan cache contains 1 elements May 10 18:18:02 localhost icd2 0.98[5400]: scan cache contains 1 elements May 10 18:18:02 localhost icd2 0.98[5400]: dbus api successfully started 'WLAN_ADHOC' scan for ':1.34' May 10 18:18:02 localhost icd2 0.98[5400]: Received com.nokia.icd2.state_req () request May 10 18:18:02 localhost icd2 0.98[5400]: request 0x5523d0 has no IAPs May 10 18:18:02 localhost icd2 0.98[5400]: Received com.nokia.icd2.scan_cancel_req () request May 10 18:18:02 localhost icd2 0.98[5400]: dbus api removed scanning for app ':1.34' May 10 18:18:02 localhost icd2 0.98[5400]: Received com.nokia.icd2.connect_req (ua(sussuay)) request May 10 18:18:02 localhost icd2 0.98[5400]: icd dbus got one nw only, (none)/0/ srv WLAN_INFRA/50000a1/f564fce5-6278-493e-aba7-54c0ab8803e0 May 10 18:18:02 localhost icd2 0.98[5400]: tracking info sender ':1.34' and message (nil) added to request 0x547440 May 10 18:18:02 localhost icd2 0.98[5400]: found request 0x5523d0 with (null)/0/[ASK] May 10 18:18:02 localhost icd2 0.98[5400]: copying user ':1.25' and request (nil) from 0x5523d0 to 0x547440 May 10 18:18:02 localhost icd2 0.98[5400]: tracking info sender ':1.25' and message (nil) added to request 0x547440 May 10 18:18:02 localhost icd2 0.98[5400]: module 'libicd_policy_ask.so' cancel function called for request 0x5523e0 May 10 18:18:02 localhost icd2 0.98[5400]: module 'libicd_policy_any.so' cancel function called for request 0x5523e0 May 10 18:18:02 localhost icd2 0.98[5400]: request 0x5523d0 with status ICD_REQUEST_MERGED May 10 18:18:02 localhost icd2 0.98[5400]: Request 0x5523d0, attrs 1 merged with 0x547440, resulting attrs 1 May 10 18:18:02 localhost icd2 0.98[5400]: requesting request 0x547440, attr 1, (none)/0/,WLAN_INFRA/50000a1/f564fce5-6278-493e-aba7-54c0ab8803e0 May 10 18:18:02 localhost icd2 0.98[5400]: running module 'libicd_policy_merge.so' new_request policy May 10 18:18:02 localhost icd2 0.98[5400]: running module 'libicd_policy_ask.so' new_request policy May 10 18:18:02 localhost icd2 0.98[5400]: running module 'libicd_policy_any.so' new_request policy May 10 18:18:02 localhost icd2 0.98[5400]: running module 'libicd_policy_change.so' new_request policy May 10 18:18:02 localhost icd2 0.98[5400]: running module 'libicd_policy_add.so' new_request policy May 10 18:18:02 localhost icd2 0.98[5400]: adding IAP (none)/0/,WLAN_INFRA/50000a1/f564fce5-6278-493e-aba7-54c0ab8803e0 to request 0x547440 May 10 18:18:02 localhost icd2 0.98[5400]: all new request policies done May 10 18:18:02 localhost icd2 0.98[5400]: request 0x547440 with status ICD_REQUEST_CONNECTING_IAPS May 10 18:18:02 localhost icd2 0.98[5400]: Trying IAP 0x553820 May 10 18:18:02 localhost icd2 0.98[5400]: 'f564fce5-6278-493e-aba7-54c0ab8803e0' type 'WLAN_INFRA' ICD_STATUS_CHANGED_SIG with status CONNECTING, '' sent to '(null)' May 10 18:18:02 localhost icd2 0.98[5400]: Request to connect iap 0x553820 May 10 18:18:02 localhost icd2 0.98[5435]: running pre-up scripts in /etc/network/if-pre-up.d, setting following env: May 10 18:18:02 localhost icd2 0.98[5435]: MODE=start May 10 18:18:02 localhost icd2 0.98[5435]: PHASE=pre-up May 10 18:18:02 localhost icd2 0.98[5400]: script timeout value not set, using default 15s May 10 18:18:02 localhost icd2 0.98[5400]: always online will soon check whether connections were added May 10 18:18:02 localhost icd2 0.98[5435]: VERBOSITY=0 May 10 18:18:02 localhost icd2 0.98[5435]: PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin May 10 18:18:02 localhost icd2 0.98[5435]: ICD_CONNECTION_ID=f564fce5-6278-493e-aba7-54c0ab8803e0 May 10 18:18:02 localhost icd2 0.98[5435]: ICD_CONNECTION_TYPE=WLAN_INFRA May 10 18:18:02 localhost icd2 0.98[5400]: signal received: Child exited May 10 18:18:02 localhost icd2 0.98[5400]: pid 5435 has exited with status 0 May 10 18:18:02 localhost icd2 0.98[5400]: script cb 0x4e66c1 with pid 5435, exit value 0, user data 0x553820 May 10 18:18:02 localhost icd2 0.98[5400]: iap 0x553820 in state ICD_IAP_STATE_SCRIPT_PRE_UP pre-up scripts run, continue connecting May 10 18:18:02 localhost icd2 0.98[5400]: connecting iap 0x553820 in state ICD_IAP_STATE_SCRIPT_PRE_UP: interface is '(null)' May 10 18:18:02 localhost icd2 0.98[5400]: calling module 'libicd_network_wpasupplicant.so' link_up May 10 18:18:02 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_bring_up: f564fce5-6278-493e-aba7-54c0ab8803e0 May 10 18:18:02 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Got network: Tele2-3-4, Tele2-3-4 May 10 18:18:02 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: gconfnet_to_wpadbus: ({'ssid': <'Tele2-3-4'>, 'psk': <'g3h31mpj3'>, 'key_mgmt': <'WPA-PSK'>},) May 10 18:18:03 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_set_state: 0 -> 1 May 10 18:18:03 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: NetworkAdded May 10 18:18:03 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: NetworkSelected May 10 18:18:03 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_state_change_cb: current state: authenticating May 10 18:18:03 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_state_change_cb: current state: disconnected May 10 18:18:03 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_set_state: 1 -> 0 May 10 18:18:03 localhost icd2 0.98[5400]: IAP for WLAN_INFRA/50000a1/f564fce5-6278-493e-aba7-54c0ab8803e0 found May 10 18:18:03 localhost icd2 0.98[5400]: close requested for IAP 0x553820, WLAN_INFRA/50000a1/f564fce5-6278-493e-aba7-54c0ab8803e0 May 10 18:18:03 localhost icd2 0.98[5400]: 'f564fce5-6278-493e-aba7-54c0ab8803e0' type 'WLAN_INFRA' ICD_STATUS_CHANGED_SIG with status DISCONNECTING, 'com.nokia.icd.error.network_error' sent to '(null)' May 10 18:18:03 localhost icd2 0.98[5400]: disconnect requested for IAP 0x553820 in state ICD_IAP_STATE_LINK_UP, com.nokia.icd.error.network_error May 10 18:18:03 localhost icd2 0.98[5400]: idle timer iap 0x553820 interface is NULL May 10 18:18:03 localhost icd2 0.98[5400]: calling link_down function in last module 'libicd_network_wpasupplicant.so' when disconnecting May 10 18:18:03 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_take_down May 10 18:18:03 localhost icd2 0.98[5400]: IAP 0x553820 in state ICD_IAP_STATE_LINK_DOWN disconnected May 10 18:18:03 localhost icd2 0.98[5400]: no more link_down functions to call May 10 18:18:03 localhost icd2 0.98[5400]: no env vars for post-down script May 10 18:18:03 localhost icd2 0.98[5443]: running post-down scripts in /etc/network/if-post-down.d, setting following env: May 10 18:18:03 localhost icd2 0.98[5400]: script timeout value not set, using default 15s May 10 18:18:03 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: NetworkRemoved May 10 18:18:03 localhost icd2 0.98[5443]: MODE=stop May 10 18:18:03 localhost icd2 0.98[5443]: PHASE=post-down May 10 18:18:03 localhost icd2 0.98[5443]: VERBOSITY=0 May 10 18:18:03 localhost icd2 0.98[5443]: PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin May 10 18:18:03 localhost icd2 0.98[5443]: ICD_CONNECTION_ID=f564fce5-6278-493e-aba7-54c0ab8803e0 May 10 18:18:03 localhost icd2 0.98[5443]: ICD_CONNECTION_TYPE=WLAN_INFRA May 10 18:18:03 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_state_change_cb: current state: inactive May 10 18:18:03 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_set_state: 0 -> 0 May 10 18:18:03 localhost icd2 0.98[5400]: signal received: Child exited May 10 18:18:03 localhost icd2 0.98[5400]: pid 5443 has exited with status 0 May 10 18:18:03 localhost icd2 0.98[5400]: script cb 0x4e6c95 with pid 5443, exit value 0, user data 0x553820 May 10 18:18:03 localhost icd2 0.98[5400]: iap disconnected, error is 'com.nokia.icd.error.network_error' May 10 18:18:03 localhost icd2 0.98[5400]: IAP status is ICD_IAP_FAILED May 10 18:18:03 localhost icd2 0.98[5400]: 'f564fce5-6278-493e-aba7-54c0ab8803e0' type 'WLAN_INFRA' ICD_STATUS_CHANGED_SIG with status IDLE, 'com.nokia.icd.error.network_error' sent to '(null)' May 10 18:18:03 localhost icd2 0.98[5400]: running module 'libicd_policy_always_online.so' disconnected policy May 10 18:18:03 localhost icd2 0.98[5400]: request 0x547440 has no IAPs May 10 18:18:03 localhost icd2 0.98[5400]: always online sees network disconnected, but none connected May 10 18:18:03 localhost icd2 0.98[5400]: No more IAPs to try, request retry from user May 10 18:18:03 localhost icd2 0.98[5400]: request 0x547440 with status ICD_REQUEST_WAITING May 10 18:18:03 localhost icd2 0.98[5400]: 'show_retry_dlg' successfully requested from UI May 10 18:18:03 localhost icd2 0.98[5400]: icd UI callback 0x4eca35 called with success '1' user data 0x547440 May 10 18:18:03 localhost icd2 0.98[5400]: request dialog successfully requested May 10 18:18:03 localhost icd2 0.98[5400]: always online found 4 IAPs in gconf May 10 18:18:04 localhost icd2 0.98[5400]: received 'com.nokia.icd_ui.retry' (sbb) signal from UI May 10 18:18:04 localhost icd2 0.98[5400]: searching for normal iap 'f564fce5-6278-493e-aba7-54c0ab8803e0' May 10 18:18:04 localhost icd2 0.98[5400]: IAP for WLAN_INFRA/1000000/f564fce5-6278-493e-aba7-54c0ab8803e0 found May 10 18:18:04 localhost icd2 0.98[5400]: retry from UI: id 'f564fce5-6278-493e-aba7-54c0ab8803e0', retry 1, retry_this 0 May 10 18:18:04 localhost icd2 0.98[5400]: retry from UI: disconnected from 0x553820 May 10 18:18:04 localhost icd2 0.98[5400]: 'f564fce5-6278-493e-aba7-54c0ab8803e0' type 'WLAN_INFRA' ICD_STATUS_CHANGED_SIG with status IDLE, '' sent to '(null)' May 10 18:18:04 localhost icd2 0.98[5400]: Removing active IAP 0xb55019e0/(nil)/(nil)/(nil) May 10 18:18:04 localhost icd2 0.98[5400]: IAP f564fce5-6278-493e-aba7-54c0ab8803e0/WLAN_INFRA/0x50000a1 cache check May 10 18:18:04 localhost icd2 0.98[5400]: IAP f564fce5-6278-493e-aba7-54c0ab8803e0 found in the cache list, removing it. May 10 18:18:04 localhost icd2 0.98[5400]: network id 'f564fce5-6278-493e-aba7-54c0ab8803e0' all entries (1) removed May 10 18:18:04 localhost icd2 0.98[5400]: Removed temp IAP 0x553820 from cache. May 10 18:18:04 localhost icd2 0.98[5400]: Freeing IAP 0x553820 May 10 18:18:04 localhost icd2 0.98[5400]: copying user ':1.25' and request (nil) from 0x547440 to 0x51ad48 May 10 18:18:04 localhost icd2 0.98[5400]: tracking info sender ':1.25' and message (nil) added to request 0x51ad48 May 10 18:18:04 localhost icd2 0.98[5400]: copying user ':1.34' and request (nil) from 0x547440 to 0x51ad48 May 10 18:18:04 localhost icd2 0.98[5400]: tracking info sender ':1.34' and message (nil) added to request 0x51ad48 May 10 18:18:04 localhost icd2 0.98[5400]: module 'libicd_policy_ask.so' cancel function called for request 0x547450 May 10 18:18:04 localhost icd2 0.98[5400]: module 'libicd_policy_any.so' cancel function called for request 0x547450 May 10 18:18:04 localhost icd2 0.98[5400]: request 0x547440 with status ICD_REQUEST_MERGED May 10 18:18:04 localhost icd2 0.98[5400]: Request 0x547440, attrs 9 merged with 0x51ad48, resulting attrs 1 May 10 18:18:04 localhost icd2 0.98[5400]: requesting request 0x51ad48, attr 1, (null)/0/(null),(null)/0/[ASK] May 10 18:18:04 localhost icd2 0.98[5400]: running module 'libicd_policy_merge.so' new_request policy May 10 18:18:04 localhost icd2 0.98[5400]: running module 'libicd_policy_ask.so' new_request policy May 10 18:18:04 localhost icd2 0.98[5400]: Requesting 'Select connection' dialog May 10 18:18:04 localhost icd2 0.98[5400]: policy iap ask pending returned May 10 18:18:04 localhost icd2 0.98[5400]: 'Select connection' dialog responded (2) May 10 18:18:04 localhost icd2 0.98[5400]: policy returned ICD_POLICY_WAITING for request 0x51ad48 May 10 18:18:04 localhost icd2 0.98[5400]: request 0x51ad48 is waiting for actions May 10 18:18:04 localhost icd2 0.98[5400]: request 0x51ad48 with status ICD_REQUEST_WAITING May 10 18:18:04 localhost icd2 0.98[5400]: Received com.nokia.icd2.scan_req (u) request May 10 18:18:04 localhost icd2 0.98[5400]: scan cache contains 0 elements May 10 18:18:04 localhost icd2 0.98[5400]: dbus api successfully started 'GPRS' scan for ':1.34' May 10 18:18:04 localhost icd2 0.98[5400]: scan cache contains 1 elements May 10 18:18:04 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/9/Wageningen-Guest srv -/-/- May 10 18:18:04 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/KPN394346 srv -/-/- May 10 18:18:04 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Ziggo7819743 srv -/-/- May 10 18:18:04 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Ziggo-ap-ad42704 srv -/-/- May 10 18:18:04 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Sitecom26CD95 srv -/-/- May 10 18:18:04 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Grote mannen huis srv -/-/- May 10 18:18:04 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/c1/Ziggo srv -/-/- May 10 18:18:04 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Eijsink32769K5 srv -/-/- May 10 18:18:04 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/grote mannen huis 2 srv -/-/- May 10 18:18:04 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/zolderkamers srv -/-/- May 10 18:18:04 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Wageningen-Raad srv -/-/- May 10 18:18:04 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/KPNB5DC56 srv -/-/- May 10 18:18:04 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/TP-LINK_AP_2666_2 srv -/-/- May 10 18:18:04 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/9/Bistro Balthazar srv -/-/- May 10 18:18:04 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/c1/Wageningen srv -/-/- May 10 18:18:04 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Markt 16 srv -/-/- May 10 18:18:04 localhost icd2 0.98[5400]: scan cache contains 1 elements May 10 18:18:04 localhost icd2 0.98[5400]: dbus api successfully started 'WLAN_INFRA' scan for ':1.34' May 10 18:18:04 localhost icd2 0.98[5400]: scan cache contains 1 elements May 10 18:18:04 localhost icd2 0.98[5400]: scan cache contains 1 elements May 10 18:18:04 localhost icd2 0.98[5400]: dbus api successfully started 'WLAN_ADHOC' scan for ':1.34' May 10 18:18:04 localhost icd2 0.98[5400]: Received com.nokia.icd2.state_req () request May 10 18:18:04 localhost icd2 0.98[5400]: request 0x51ad48 has no IAPs May 10 18:18:09 localhost icd2 0.98[5400]: scan start for type 'WLAN_INFRA' May 10 18:18:09 localhost icd2 0.98[5400]: '[SCAN]' type 'WLAN_INFRA' ICD_STATUS_CHANGED_SIG with status SCAN_START, '' sent to '(null)' May 10 18:18:09 localhost icd2 0.98[5400]: scan start for type 'WLAN_ADHOC' May 10 18:18:09 localhost icd2 0.98[5400]: '[SCAN]' type 'WLAN_ADHOC' ICD_STATUS_CHANGED_SIG with status SCAN_START, '' sent to '(null)' May 10 18:18:09 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_start_search May 10 18:18:09 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: try_open_wpa_control: 0x51a6f0 May 10 18:18:09 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: try_disconnect_wpa_control failed with -1, reported buf len is 847268232 May 10 18:18:09 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: close_wpa_control: 0x51a6f0 May 10 18:18:09 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: try_open_wpa_control: 0x556998 May 10 18:18:09 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: close_wpa_control: 0x556998 May 10 18:18:09 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_state_change_cb: current state: disconnected May 10 18:18:09 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_set_state: 0 -> 0 May 10 18:18:09 localhost icd2 0.98[5400]: request 0x51ad48 does not have iaps May 10 18:18:09 localhost icd2 0.98[5400]: disconnect requested for (null)/0/(null), but no matching IAP May 10 18:18:09 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_state_change_cb: current state: scanning May 10 18:18:09 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: BSSAdded May 10 18:18:09 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: BSSAdded May 10 18:18:09 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: BSSAdded May 10 18:18:09 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: BSSAdded May 10 18:18:09 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: BSSAdded May 10 18:18:09 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: BSSAdded May 10 18:18:09 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: BSSAdded May 10 18:18:09 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: BSSRemoved May 10 18:18:09 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: BSSRemoved May 10 18:18:09 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: BSSRemoved May 10 18:18:09 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: on_scan_done. params: (true,) May 10 18:18:09 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: SSID MATCH FOR: Tele2-3-4 | Tele2-3-4 May 10 18:18:09 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/50000a1/f564fce5-6278-493e-aba7-54c0ab8803e0 srv -/-/- May 10 18:18:09 localhost icd2 0.98[5400]: sending ICD_SCAN_NOTIFY nw WLAN_INFRA/a1/zolderkamers srv -/-/- May 10 18:18:09 localhost icd2 0.98[5400]: sending ICD_SCAN_NOTIFY nw WLAN_INFRA/a1/Sitecom26CD95 srv -/-/- May 10 18:18:09 localhost icd2 0.98[5400]: sending ICD_SCAN_NOTIFY nw WLAN_INFRA/a1/KPNB5DC56 srv -/-/- May 10 18:18:09 localhost icd2 0.98[5400]: sending ICD_SCAN_NOTIFY nw WLAN_INFRA/a1/Ziggo7819743 srv -/-/- May 10 18:18:09 localhost icd2 0.98[5400]: sending ICD_SCAN_NOTIFY nw WLAN_INFRA/c1/Ziggo srv -/-/- May 10 18:18:09 localhost icd2 0.98[5400]: sending ICD_SCAN_NOTIFY nw WLAN_INFRA/a1/grote mannen huis 2 srv -/-/- May 10 18:18:09 localhost icd2 0.98[5400]: sending ICD_SCAN_UPDATE nw WLAN_INFRA/a1/TP-LINK_AP_2666_2 srv -/-/- May 10 18:18:09 localhost icd2 0.98[5400]: sending ICD_SCAN_NOTIFY nw WLAN_INFRA/a1/KPN394346 srv -/-/- May 10 18:18:09 localhost icd2 0.98[5400]: sending ICD_SCAN_NOTIFY nw WLAN_INFRA/a1/grote mannen huis 2 srv -/-/- May 10 18:18:09 localhost icd2 0.98[5400]: sending ICD_SCAN_NOTIFY nw WLAN_INFRA/c1/Wageningen srv -/-/- May 10 18:18:09 localhost icd2 0.98[5400]: sending ICD_SCAN_NOTIFY nw WLAN_INFRA/a1/Wageningen-Raad srv -/-/- May 10 18:18:09 localhost icd2 0.98[5400]: sending ICD_SCAN_NOTIFY nw WLAN_INFRA/9/Wageningen-Guest srv -/-/- May 10 18:18:09 localhost icd2 0.98[5400]: sending ICD_SCAN_NOTIFY nw WLAN_INFRA/a1/Grote mannen huis srv -/-/- May 10 18:18:09 localhost icd2 0.98[5400]: sending ICD_SCAN_NOTIFY nw WLAN_INFRA/c1/Ziggo srv -/-/- May 10 18:18:09 localhost icd2 0.98[5400]: sending ICD_SCAN_NOTIFY nw WLAN_INFRA/a1/Eijsink32769K5 srv -/-/- May 10 18:18:10 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/ srv -/-/- May 10 18:18:10 localhost icd2 0.98[5400]: sending ICD_SCAN_NOTIFY nw WLAN_INFRA/a1/ srv -/-/- May 10 18:18:10 localhost icd2 0.98[5400]: sending ICD_SCAN_NOTIFY nw WLAN_INFRA/a1/ srv -/-/- May 10 18:18:10 localhost icd2 0.98[5400]: sending ICD_SCAN_NOTIFY nw WLAN_INFRA/a1/ srv -/-/- May 10 18:18:10 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/TP-LINK_37D2 srv -/-/- May 10 18:18:10 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/HUMIDOR HUIS srv -/-/- May 10 18:18:10 localhost icd2 0.98[5400]: sending ICD_SCAN_NEW nw WLAN_INFRA/a1/Humidor Gast srv -/-/- May 10 18:18:10 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: SCAN DONE May 10 18:18:10 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_scan_timeout May 10 18:18:10 localhost icd2 0.98[5400]: module 'libicd_network_wpasupplicant.so' scan completed May 10 18:18:10 localhost icd2 0.98[5400]: scan stop for type 'WLAN_INFRA' May 10 18:18:10 localhost icd2 0.98[5400]: '[SCAN]' type 'WLAN_INFRA' ICD_STATUS_CHANGED_SIG with status SCAN_STOP, '' sent to '(null)' May 10 18:18:10 localhost icd2 0.98[5400]: scan stop for type 'WLAN_ADHOC' May 10 18:18:10 localhost icd2 0.98[5400]: '[SCAN]' type 'WLAN_ADHOC' ICD_STATUS_CHANGED_SIG with status SCAN_STOP, '' sent to '(null)' May 10 18:18:10 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_state_change_cb: current state: disconnected May 10 18:18:10 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_set_state: 0 -> 0 May 10 18:18:10 localhost icd2 0.98[5400]: request 0x51ad48 does not have iaps May 10 18:18:10 localhost icd2 0.98[5400]: disconnect requested for (null)/0/(null), but no matching IAP May 10 18:18:10 localhost icd2 0.98[5400]: Received com.nokia.icd2.scan_cancel_req () request May 10 18:18:10 localhost icd2 0.98[5400]: dbus api removed scanning for app ':1.34' May 10 18:18:10 localhost icd2 0.98[5400]: Received com.nokia.icd2.connect_req (ua(sussuay)) request May 10 18:18:10 localhost icd2 0.98[5400]: icd dbus got one nw only, (none)/0/ srv WLAN_INFRA/50000a1/f564fce5-6278-493e-aba7-54c0ab8803e0 May 10 18:18:10 localhost icd2 0.98[5400]: tracking info sender ':1.34' and message (nil) added to request 0x5523d0 May 10 18:18:10 localhost icd2 0.98[5400]: found request 0x51ad48 with (null)/0/[ASK] May 10 18:18:10 localhost icd2 0.98[5400]: copying user ':1.34' and request (nil) from 0x51ad48 to 0x5523d0 May 10 18:18:10 localhost icd2 0.98[5400]: tracking info sender ':1.34' and message (nil) added to request 0x5523d0 May 10 18:18:10 localhost icd2 0.98[5400]: copying user ':1.25' and request (nil) from 0x51ad48 to 0x5523d0 May 10 18:18:10 localhost icd2 0.98[5400]: tracking info sender ':1.25' and message (nil) added to request 0x5523d0 May 10 18:18:10 localhost icd2 0.98[5400]: module 'libicd_policy_ask.so' cancel function called for request 0x51ad58 May 10 18:18:10 localhost icd2 0.98[5400]: module 'libicd_policy_any.so' cancel function called for request 0x51ad58 May 10 18:18:10 localhost icd2 0.98[5400]: request 0x51ad48 with status ICD_REQUEST_MERGED May 10 18:18:10 localhost icd2 0.98[5400]: Request 0x51ad48, attrs 1 merged with 0x5523d0, resulting attrs 1 May 10 18:18:10 localhost icd2 0.98[5400]: requesting request 0x5523d0, attr 1, (none)/0/,WLAN_INFRA/50000a1/f564fce5-6278-493e-aba7-54c0ab8803e0 May 10 18:18:10 localhost icd2 0.98[5400]: running module 'libicd_policy_merge.so' new_request policy May 10 18:18:10 localhost icd2 0.98[5400]: running module 'libicd_policy_ask.so' new_request policy May 10 18:18:10 localhost icd2 0.98[5400]: running module 'libicd_policy_any.so' new_request policy May 10 18:18:10 localhost icd2 0.98[5400]: running module 'libicd_policy_change.so' new_request policy May 10 18:18:10 localhost icd2 0.98[5400]: running module 'libicd_policy_add.so' new_request policy May 10 18:18:10 localhost icd2 0.98[5400]: adding IAP (none)/0/,WLAN_INFRA/50000a1/f564fce5-6278-493e-aba7-54c0ab8803e0 to request 0x5523d0 May 10 18:18:10 localhost icd2 0.98[5400]: all new request policies done May 10 18:18:10 localhost icd2 0.98[5400]: request 0x5523d0 with status ICD_REQUEST_CONNECTING_IAPS May 10 18:18:10 localhost icd2 0.98[5400]: Trying IAP 0x553820 May 10 18:18:10 localhost icd2 0.98[5400]: 'f564fce5-6278-493e-aba7-54c0ab8803e0' type 'WLAN_INFRA' ICD_STATUS_CHANGED_SIG with status CONNECTING, '' sent to '(null)' May 10 18:18:10 localhost icd2 0.98[5400]: Request to connect iap 0x553820 May 10 18:18:10 localhost icd2 0.98[5464]: running pre-up scripts in /etc/network/if-pre-up.d, setting following env: May 10 18:18:10 localhost icd2 0.98[5400]: script timeout value not set, using default 15s May 10 18:18:10 localhost icd2 0.98[5464]: MODE=start May 10 18:18:10 localhost icd2 0.98[5464]: PHASE=pre-up May 10 18:18:10 localhost icd2 0.98[5464]: VERBOSITY=0 May 10 18:18:10 localhost icd2 0.98[5464]: PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin May 10 18:18:10 localhost icd2 0.98[5464]: ICD_CONNECTION_ID=f564fce5-6278-493e-aba7-54c0ab8803e0 May 10 18:18:10 localhost icd2 0.98[5464]: ICD_CONNECTION_TYPE=WLAN_INFRA May 10 18:18:11 localhost icd2 0.98[5400]: signal received: Child exited May 10 18:18:11 localhost icd2 0.98[5400]: pid 5464 has exited with status 0 May 10 18:18:11 localhost icd2 0.98[5400]: script cb 0x4e66c1 with pid 5464, exit value 0, user data 0x553820 May 10 18:18:11 localhost icd2 0.98[5400]: iap 0x553820 in state ICD_IAP_STATE_SCRIPT_PRE_UP pre-up scripts run, continue connecting May 10 18:18:11 localhost icd2 0.98[5400]: connecting iap 0x553820 in state ICD_IAP_STATE_SCRIPT_PRE_UP: interface is '(null)' May 10 18:18:11 localhost icd2 0.98[5400]: calling module 'libicd_network_wpasupplicant.so' link_up May 10 18:18:11 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_bring_up: f564fce5-6278-493e-aba7-54c0ab8803e0 May 10 18:18:11 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Got network: Tele2-3-4, Tele2-3-4 May 10 18:18:11 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: gconfnet_to_wpadbus: ({'ssid': <'Tele2-3-4'>, 'psk': <'g3h31mpj3'>, 'key_mgmt': <'WPA-PSK'>},) May 10 18:18:11 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_set_state: 0 -> 1 May 10 18:18:11 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: NetworkAdded May 10 18:18:11 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: Ignoring: NetworkSelected May 10 18:18:11 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_state_change_cb: current state: authenticating May 10 18:18:11 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_state_change_cb: current state: associating May 10 18:18:11 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_set_state: 1 -> 1 May 10 18:18:11 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_state_change_cb: current state: 4way_handshake May 10 18:18:11 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_state_change_cb: current state: completed May 10 18:18:11 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: WLAN: SENDING SUCCESS NEXT LAYER May 10 18:18:11 localhost icd2 0.98[5400]: starting with new script env set (nil) May 10 18:18:11 localhost icd2 0.98[5400]: iap 0x553820 link_up callback got 'wlan0', set to 'wlan0' May 10 18:18:11 localhost icd2 0.98[5400]: iap 0x553820 callback in state ICD_IAP_STATE_LINK_UP with status 1, error '(null)', interface 'wlan0' May 10 18:18:11 localhost icd2 0.98[5400]: module 'libicd_network_wpasupplicant.so' link_up callback May 10 18:18:11 localhost icd2 0.98[5400]: Added link_down 0xb68eec59 from 'libicd_network_wpasupplicant.so' to iap May 10 18:18:11 localhost icd2 0.98[5400]: 'libicd_network_wpasupplicant.so' requests ICd to start with next level May 10 18:18:11 localhost icd2 0.98[5400]: connecting iap 0x553820 in state ICD_IAP_STATE_LINK_POST_UP: interface is 'wlan0' May 10 18:18:11 localhost icd2 0.98[5400]: No other link_post_up functions found May 10 18:18:11 localhost icd2 0.98[5400]: calling module 'libicd_network_ipv4.so' ip_up May 10 18:18:11 localhost icd2 0.98[5400]: ipv4 dns autoconfig is 1 May 10 18:18:11 localhost icd2 0.98[5400]: ipv4 attempting to configure wlan0 via dhcp May 10 18:18:11 localhost icd2 0.98[5400]: ipv4 child pid 5502 May 10 18:18:11 localhost icd2 0.98[5400]: added pid 5502 to module 'libicd_network_ipv4.so' May 10 18:18:11 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_set_state: 1 -> 2 May 10 18:18:11 localhost icd2 0.98[5400]: ipv4 got autoconf signal with args 'wlan0' 'DHCP' 'DISCONNECTED', dhcp 0, linklocal 0 May 10 18:18:11 localhost icd2 0.98[5400]: ipv4 updating ip info May 10 18:18:11 localhost icd2 0.98[5400]: ipv4 trying 'wlan0' May 10 18:18:11 localhost icd2 0.98[5400]: ipv4 trying 'wlan0:1' May 10 18:18:11 localhost icd2 0.98[5400]: ipv4 trying '/var/run/resolv.conf.wlan0' May 10 18:18:11 localhost icd2 0.98[5400]: ipv4 trying '/var/run/resolv.conf.wlan0:1' May 10 18:18:11 localhost icd2 0.98[5400]: ipv4 trying '/var/run/resolv.conf' May 10 18:18:11 localhost icd2 0.98[5400]: ipv4 ignored first unsuccessful autoconf message May 10 18:18:12 localhost icd2 0.98[5400]: ipv4 got autoconf signal with args 'wlan0' 'DHCP' 'CONNECTED', dhcp 1, linklocal 0 May 10 18:18:12 localhost icd2 0.98[5400]: ipv4 updating ip info May 10 18:18:12 localhost icd2 0.98[5400]: ipv4 trying 'wlan0' May 10 18:18:12 localhost icd2 0.98[5400]: ipv4 trying '/var/run/resolv.conf.wlan0' May 10 18:18:12 localhost icd2 0.98[5400]: ipv4 trying '/var/run/resolv.conf.wlan0:1' May 10 18:18:12 localhost icd2 0.98[5400]: ipv4 trying '/var/run/resolv.conf' May 10 18:18:12 localhost icd2 0.98[5400]: starting with new script env set 0xb6f58ed0 May 10 18:18:12 localhost icd2 0.98[5400]: script identifying with ADDRFAM env var value 'inet' May 10 18:18:12 localhost icd2 0.98[5400]: address family 'inet' added to env May 10 18:18:12 localhost icd2 0.98[5400]: env set 0xb6f58ed0 handled May 10 18:18:12 localhost icd2 0.98[5400]: iap 0x553820 callback in state ICD_IAP_STATE_IP_UP with status 0, error '(null)', interface 'wlan0' May 10 18:18:12 localhost icd2 0.98[5400]: module 'libicd_network_ipv4.so' ip_up callback May 10 18:18:12 localhost icd2 0.98[5400]: Added ip_down 0xb6f46b0d from 'libicd_network_ipv4.so' to iap May 10 18:18:12 localhost icd2 0.98[5400]: checking for same layer _up functions in other modules May 10 18:18:12 localhost icd2 0.98[5400]: connecting iap 0x553820 in state ICD_IAP_STATE_IP_UP: interface is 'wlan0' May 10 18:18:12 localhost icd2 0.98[5400]: No other ip_up functions found May 10 18:18:12 localhost icd2 0.98[5400]: calling service provider module May 10 18:18:12 localhost icd2 0.98[5400]: srv type '(none)' unknown May 10 18:18:12 localhost icd2 0.98[5400]: script timeout value not set, using default 15s May 10 18:18:12 localhost icd2 0.98[5554]: running up scripts in /etc/network/if-up.d, setting following env: May 10 18:18:12 localhost icd2 0.98[5554]: IFACE=wlan0 May 10 18:18:12 localhost icd2 0.98[5554]: LOGICAL=wlan0 May 10 18:18:12 localhost icd2 0.98[5554]: ADDRFAM=inet May 10 18:18:12 localhost icd2 0.98[5554]: MODE=start May 10 18:18:12 localhost icd2 0.98[5554]: PHASE=post-up May 10 18:18:12 localhost icd2 0.98[5554]: VERBOSITY=0 May 10 18:18:12 localhost icd2 0.98[5554]: PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin May 10 18:18:12 localhost icd2 0.98[5554]: ICD_CONNECTION_ID=f564fce5-6278-493e-aba7-54c0ab8803e0 May 10 18:18:12 localhost icd2 0.98[5554]: ICD_CONNECTION_TYPE=WLAN_INFRA May 10 18:18:13 localhost icd2 0.98[5400]: signal received: Child exited May 10 18:18:13 localhost icd2 0.98[5400]: pid 5554 has exited with status 0 May 10 18:18:13 localhost icd2 0.98[5400]: script cb 0x4e6aed with pid 5554, exit value 0, user data 0x553820 May 10 18:18:13 localhost icd2 0.98[5400]: all post-up scripts done, iap can be connected May 10 18:18:13 localhost icd2 0.98[5400]: idle timer type 'WLAN_INFRA', key '/system/osso/connectivity/network_type/WLAN_INFRA/idle_timeout' May 10 18:18:13 localhost icd2 0.98[5400]: IAP status is ICD_IAP_CREATED May 10 18:18:13 localhost icd2 0.98[5400]: request 0x5523d0 with status ICD_REQUEST_SUCCEEDED May 10 18:18:13 localhost icd2 0.98[5400]: running module 'libicd_policy_always_online.so' connected policy May 10 18:18:13 localhost icd2 0.98[5400]: always online connection count 1 May 10 18:18:13 localhost icd2 0.98[5400]: running module 'libicd_policy_one.so' connected policy May 10 18:18:13 localhost icd2 0.98[5400]: policy one got connected notification May 10 18:18:13 localhost icd2 0.98[5400]: policy one found the same connection May 10 18:18:13 localhost icd2 0.98[5400]: 'f564fce5-6278-493e-aba7-54c0ab8803e0' type 'WLAN_INFRA' ICD_STATUS_CHANGED_SIG with status CONNECTED, '' sent to '(null)' May 10 18:18:13 localhost icd2 0.98[5400]: Received com.nokia.icd.get_statistics () request May 10 18:18:13 localhost icd2 0.98[5400]: no arguments, finding any/first iap May 10 18:18:13 localhost icd2 0.98[5400]: querying statistics from request 0x5523d0 May 10 18:18:13 localhost icd2 0.98[5400]: iap 0x553820 module 'libicd_network_wpasupplicant.so' has link statistics May 10 18:18:13 localhost icd2 0.98[5400]: libicd-network-wpasupplicant: wlan_statistics May 10 18:18:13 localhost icd2 0.98[5400]: IAP for WLAN_INFRA/50000a1/f564fce5-6278-493e-aba7-54c0ab8803e0 found May 10 18:18:13 localhost icd2 0.98[5400]: IAP for WLAN_INFRA/50000a1/f564fce5-6278-493e-aba7-54c0ab8803e0 found May 10 18:18:13 localhost icd2 0.98[5400]: iap 0x553820 module 'libicd_network_ipv4.so' has ip statistics May 10 18:18:13 localhost icd2 0.98[5400]: IAP for WLAN_INFRA/50000a1/f564fce5-6278-493e-aba7-54c0ab8803e0 found May 10 18:18:13 localhost icd2 0.98[5400]: returning statistics for iap 0x553820: 1, 5, 0, 0, 880, 4421 May 10 18:18:19 localhost icd2 0.98[5400]: network id 'Ziggo-ap-ad42704' all entries expired May 10 18:18:19 localhost icd2 0.98[5400]: network id 'Bistro Balthazar' all entries expired May 10 18:18:19 localhost icd2 0.98[5400]: network id 'Markt 16' all entries expired May 10 18:18:20 localhost icd2 0.98[5400]: module 'libicd_network_wpasupplicant.so' has no listeners, scan not restarted May 10 18:18:32 localhost icd2 0.98[5400]: network id 'Wageningen-Guest' all entries expired May 10 18:18:32 localhost icd2 0.98[5400]: network id 'KPN394346' all entries expired May 10 18:18:32 localhost icd2 0.98[5400]: network id 'Ziggo7819743' all entries expired May 10 18:18:32 localhost icd2 0.98[5400]: network id 'Sitecom26CD95' all entries expired May 10 18:18:32 localhost icd2 0.98[5400]: network id 'Grote mannen huis' all entries expired May 10 18:18:32 localhost icd2 0.98[5400]: network id 'Ziggo' all entries expired May 10 18:18:32 localhost icd2 0.98[5400]: network id 'Eijsink32769K5' all entries expired May 10 18:18:32 localhost icd2 0.98[5400]: network id 'Humidor Gast' all entries expired May 10 18:18:32 localhost icd2 0.98[5400]: network id 'grote mannen huis 2' all entries expired May 10 18:18:32 localhost icd2 0.98[5400]: network id 'zolderkamers' all entries expired May 10 18:18:32 localhost icd2 0.98[5400]: network id 'Wageningen-Raad' all entries expired May 10 18:18:32 localhost icd2 0.98[5400]: network id '' all entries expired May 10 18:18:32 localhost icd2 0.98[5400]: network id 'KPNB5DC56' all entries expired May 10 18:18:32 localhost icd2 0.98[5400]: network id 'TP-LINK_37D2' all entries expired May 10 18:18:32 localhost icd2 0.98[5400]: network id 'HUMIDOR HUIS' all entries expired May 10 18:18:32 localhost icd2 0.98[5400]: network id 'f564fce5-6278-493e-aba7-54c0ab8803e0' all entries expired May 10 18:18:32 localhost icd2 0.98[5400]: network id 'TP-LINK_AP_2666_2' all entries expired May 10 18:18:32 localhost icd2 0.98[5400]: network id 'Wageningen' all entries expired