[maemo-developers] wlan drop (Re: x11vnc no response to taps on left of screen)

[From: Tuukka Tolvanen]

Kalle Valo wrote:
> "ext Jeffrey Barish" <jeff_barish at earthlink.net> writes:
> 
>> Also, the N800 has an annoying habit of dropping the WiFi connection
>> because it is not detecting any taps on the screen.
> 
> We don't have such functionality at all. We do have idle timer which
> disconnects the connection after a specified timeout if there's no
> traffic. But if I recall correctly, it should be disabled for WLAN by
> default
> 
> You must be seeing something else. What AP are you using and what are
> it's settings? 
> 
> And what do you mean by dropping? Does UI inform that connection is
> disconnected or is the WLAN connections just "jammed", ie. no data is
> transfered?

ip=x.x.x.x; s=290; while date -Is; ping -c 1 $ip; do sleep $s; 
s=$((s+10)); done

In my case, taps don't matter, if after network use the device is pinged 
at an interval increasing by 10s, it responds to the ping after the 
5min0s interval regardless of when blanking happened, but not after the 
subsequent 5min10s interval.

WLAN disconnect timeout not enabled, scan interval 10min (defaults). 
Same effect regardless of different dim/blank timeouts. AP is dlink 
DI-524, WPA-PSK (AES). No presence stuff is configured (I'd guesstimate 
that is the relevant difference between back when I didn't see this and 
now), no email polling.

Connection appears up in the ui, I usually just poke at the feed applet 
refresh to get the networking going again.

     timeline (accurate to ~1min):

2007-04-11T01:09 ping ok
2007-04-11T01:14 ping ok
2007-04-11T01:19 ping ok
2007-04-11T01:25 ping nok
2007-04-11T01:35 poked feed applet refresh

     dmesg:

[ 2122.964508] EAC mode: play enabled, rec enabled
[ 2125.465576] EAC mode: play disabled, rec disabled
[ 2153.398864] omapfb omapfb: s1d1374x: setting update mode to disabled
nothing 01:11--01:35
[ 3665.260162] omapfb omapfb: s1d1374x: setting update mode to manual
[ 3670.130920] EAC mode: play enabled, rec enabled
[ 3672.629699] EAC mode: play disabled, rec disabled
[ 3673.933410] EAC mode: play enabled, rec enabled
[ 3676.020690] DEAUTHENTICATE trap
[ 3676.020782] Active scanning on >null<
[ 3676.809539] EAC mode: play disabled, rec disabled
[ 3677.002227] sm_drv_transmit: sm_frame_tx returned error -9
[ 3677.846496] Scan complete, scanned 13 channels
[ 3678.002288] sm_drv_transmit: sm_frame_tx returned error -9
[ 3678.094787] cx3110x: PSM disabled
[ 3678.343963] cx3110x: PSM dynamic with 1000 ms CAM timeout
[ 3704.067565] omapfb omapfb: s1d1374x: setting update mode to disabled
[ 4220.713134] omapfb omapfb: s1d1374x: setting update mode to manual
[ 4221.450714] EAC mode: play enabled, rec enabled
[ 4226.745422] EAC mode: play disabled, rec disabled
[ 4228.003723] EAC mode: play enabled, rec enabled
[ 4230.039825] DEAUTHENTICATE trap
[ 4230.039916] Active scanning on >null<
[ 4230.879455] EAC mode: play disabled, rec disabled
[ 4231.025665] sm_drv_transmit: sm_frame_tx returned error -9
[ 4231.893402] Scan complete, scanned 13 channels
[ 4232.025787] sm_drv_transmit: sm_frame_tx returned error -9
[ 4232.110443] cx3110x: PSM disabled
[ 4232.349578] cx3110x: PSM dynamic with 1000 ms CAM timeout
[ 4258.145751] omapfb omapfb: s1d1374x: setting update mode to disabled
[ 4350.736602] omapfb omapfb: s1d1374x: setting update mode to manual

     dbus.session (the timestamps may lag due to buffering, mind)

01:10:14 signal sender=:1.31 -> dest=(null destination) 
interface=com.nokia.osso_rss_feed_reader; member=refresh_started
01:10:15 signal sender=:1.31 -> dest=(null destination) 
interface=com.nokia.osso_rss_feed_reader; member=refresh_finished
01:10:16 signal sender=org.freedesktop.DBus -> dest=(null destination) 
interface=org.freedesktop.DBus; member=NameOwnerChanged
01:10:16 string "com.nokia.osso_rss_feed_reader_refresh"
01:10:16 string ":1.31"
01:10:16 string ""
01:10:16 signal sender=org.freedesktop.DBus -> dest=(null destination) 
interface=org.freedesktop.DBus; member=NameOwnerChanged
01:10:16 string "com.nokia.osso_rss_feed_reader"
01:10:16 string ":1.31"
01:10:16 string ""
01:10:16 signal sender=org.freedesktop.DBus -> dest=(null destination) 
interface=org.freedesktop.DBus; member=NameOwnerChanged
01:10:16 string ":1.31"
01:10:16 string ":1.31"
01:10:16 string ""
01:36:03 signal sender=org.freedesktop.DBus -> dest=(null destination) 
interface=org.freedesktop.DBus; member=NameOwnerChanged
01:36:03 string ":1.33"
01:36:03 string ""
01:36:03 string ":1.33"
01:36:03 method call sender=:1.33 -> dest=org.freedesktop.DBus 
interface=org.freedesktop.DBus; member=Hello
01:36:03 signal sender=org.freedesktop.DBus -> dest=(null destination) 
interface=org.freedesktop.DBus; member=NameOwnerChanged
01:36:03 string "com.nokia.osso_rss_feed_reader"
01:36:03 string ""
01:36:03 string ":1.33"
01:36:03 method call sender=:1.33 -> dest=org.freedesktop.DBus 
interface=org.freedesktop.DBus; member=RequestName
01:36:04 string "com.nokia.osso_rss_feed_reader"
01:36:04 uint32 1
01:36:04 method call sender=:1.33 -> dest=org.freedesktop.DBus 
interface=org.freedesktop.DBus; member=RequestName
01:36:04 string "com.nokia.osso_rss_feed_reader"
01:36:04 uint32 7
01:36:04 signal sender=org.freedesktop.DBus -> dest=(null destination) 
interface=org.freedesktop.DBus; member=NameOwnerChanged
01:36:04 string "com.nokia.osso_rss_feed_reader_refresh"
01:36:04 string ""
01:36:04 string ":1.33"
01:36:04 method call sender=:1.33 -> dest=org.freedesktop.DBus 
interface=org.freedesktop.DBus; member=RequestName
01:36:04 string "com.nokia.osso_rss_feed_reader_refresh"
01:36:04 uint32 7
01:36:04 signal sender=org.freedesktop.DBus -> dest=(null destination) 
interface=org.freedesktop.DBus; member=NameOwnerChanged
01:36:04 string ":1.34"
01:36:04 string ""
01:36:04 string ":1.34"
01:36:05 method call sender=:1.34 -> dest=org.freedesktop.DBus 
interface=org.freedesktop.DBus; member=Hello
01:36:05 signal sender=org.freedesktop.DBus -> dest=(null destination) 
interface=org.freedesktop.DBus; member=NameOwnerChanged
01:36:05 string ":1.34"
01:36:05 string ":1.34"
01:36:05 string ""
01:36:05 signal sender=:1.33 -> dest=(null destination) 
interface=com.nokia.osso_rss_feed_reader; member=refresh_started
01:36:14 signal sender=:1.33 -> dest=(null destination) 
interface=com.nokia.osso_rss_feed_reader; member=refresh_finished

     dbus.system

01:10:42 signal sender=:1.1 -> dest=(null destination) 
interface=com.nokia.mce.signal; member=system_inactivity_ind
01:10:42 boolean true
01:10:42 signal sender=:1.1 -> dest=(null destination) 
interface=com.nokia.mce.signal; member=save_unsaved_data_ind
01:10:42 signal sender=:1.1 -> dest=(null destination) 
interface=com.nokia.mce.signal; member=tklock_mode_ind
01:10:42 string "locked"
01:10:42 signal sender=:1.1 -> dest=(null destination) 
interface=com.nokia.mce.signal; member=display_status_ind
01:10:42 string "off"
01:35:54 signal sender=:1.1 -> dest=(null destination) 
interface=com.nokia.mce.signal; member=system_inactivity_ind
01:35:54 boolean false
01:35:54 signal sender=:1.1 -> dest=(null destination) 
interface=com.nokia.mce.signal; member=system_inactivity_ind
01:35:54 boolean false
01:35:54 signal sender=:1.1 -> dest=(null destination) 
interface=com.nokia.mce.signal; member=display_status_ind
01:35:54 string "on"
01:35:55 signal sender=:1.1 -> dest=(null destination) 
interface=com.nokia.mce.signal; member=tklock_mode_ind
01:35:55 string "unlocked"
01:36:03 signal sender=org.freedesktop.DBus -> dest=(null destination) 
interface=org.freedesktop.DBus; member=NameOwnerChanged
01:36:03 string ":1.57"
01:36:03 string ""
01:36:03 string ":1.57"
01:36:03 signal sender=org.freedesktop.DBus -> dest=(null destination) 
interface=org.freedesktop.DBus; member=NameOwnerChanged
01:36:03 string "com.nokia.osso_rss_feed_reader"
01:36:03 string ""
01:36:03 string ":1.57"
01:36:03 signal sender=org.freedesktop.DBus -> dest=(null destination) 
interface=org.freedesktop.DBus; member=NameOwnerChanged
01:36:03 string ":1.58"
01:36:03 string ""
01:36:03 string ":1.58"
01:36:07 signal sender=:1.14 -> dest=(null destination) 
interface=com.nokia.wlancond.signal; member=connected
01:36:07 string "wlan0"
01:36:07 [byte 0
01:36:07 byte 23
01:36:07 byte 154
01:36:07 byte 244
01:36:07 byte 241
01:36:07 byte 161
01:36:07 ]int32 536870912
*01:36:07 signal sender=:1.19 -> dest=(null destination) 
interface=com.nokia.eap.signal; member=auth_status
01:36:07 uint32 4
01:36:12 signal sender=:1.1 -> dest=(null destination) 
interface=com.nokia.mce.signal; member=display_status_ind
01:36:12 string "dimmed"
01:36:15 signal sender=org.freedesktop.DBus -> dest=(null destination) 
interface=org.freedesktop.DBus; member=NameOwnerChanged
01:36:15 string "com.nokia.osso_rss_feed_reader"
01:36:15 string ":1.57"
01:36:15 string ""
01:36:15 signal sender=org.freedesktop.DBus -> dest=(null destination) 
interface=org.freedesktop.DBus; member=NameOwnerChanged
01:36:15 string ":1.57"
01:36:15 string ":1.57"
01:36:15 string ""
01:36:15 signal sender=org.freedesktop.DBus -> dest=(null destination) 
interface=org.freedesktop.DBus; member=NameOwnerChanged
01:36:15 string ":1.58"
01:36:15 string ":1.58"
01:36:15 string ""
01:36:33 signal sender=:1.1 -> dest=(null destination) 
interface=com.nokia.mce.signal; member=system_inactivity_ind
01:36:33 boolean true
01:36:33 signal sender=:1.1 -> dest=(null destination) 
interface=com.nokia.mce.signal; member=save_unsaved_data_ind
01:36:33 signal sender=:1.1 -> dest=(null destination) 
interface=com.nokia.mce.signal; member=tklock_mode_ind
01:36:33 string "locked"
01:36:33 signal sender=:1.1 -> dest=(null destination) 
interface=com.nokia.mce.signal; member=display_status_ind
01:36:33 string "off"

     syslog

Apr 11 01:10:42 Nokia-N800-10 ke_recv[893]: ke-recv.c:375: i|m|p: 
com.nokia.mce.signal|display_status_ind|/com/nokia/mce/signal
Apr 11 01:10:42 Nokia-N800-10 kernel: [ 2153.398864] omapfb omapfb: 
s1d1374x: setting update mode to disabled
Apr 11 01:10:55 Nokia-N800-10 init: Id "T0" respawning too fast: 
disabled for 5 minutes
Apr 11 01:17:36 Nokia-N800-10 init: Id "T0" respawning too fast: 
disabled for 5 minutes
Apr 11 01:24:18 Nokia-N800-10 init: Id "T0" respawning too fast: 
disabled for 5 minutes
Apr 11 01:30:59 Nokia-N800-10 init: Id "T0" respawning too fast: 
disabled for 5 minutes
Apr 11 01:35:54 Nokia-N800-10 ke_recv[893]: ke-recv.c:375: i|m|p: 
com.nokia.mce.signal|system_inactivity_ind|/com/nokia/mce/signal
Apr 11 01:35:54 Nokia-N800-10 ke_recv[893]: ke-recv.c:375: i|m|p: 
com.nokia.mce.signal|system_inactivity_ind|/com/nokia/mce/signal
Apr 11 01:35:54 Nokia-N800-10 ke_recv[893]: ke-recv.c:375: i|m|p: 
com.nokia.mce.signal|display_status_ind|/com/nokia/mce/signal
Apr 11 01:35:54 Nokia-N800-10 maemo_af_desktop[1018]: GLIB DEBUG default 
- HildonHome detected system inactivity: 0
Apr 11 01:35:54 Nokia-N800-10 kernel: [ 3665.260162] omapfb omapfb: 
s1d1374x: setting update mode to manual
Apr 11 01:35:55 Nokia-N800-10 ke_recv[893]: ke-recv.c:375: i|m|p: 
com.nokia.mce.signal|tklock_mode_ind|/com/nokia/mce/signal
Apr 11 01:35:59 Nokia-N800-10 kernel: [ 3670.130920] EAC mode: play 
enabled, rec enabled
Apr 11 01:36:01 Nokia-N800-10 kernel: [ 3672.629699] EAC mode: play 
disabled, rec disabled
Apr 11 01:36:02 Nokia-N800-10 kernel: [ 3673.933410] EAC mode: play 
enabled, rec enabled
Apr 11 01:36:03 Nokia-N800-10 maemo-launcher[1499]: invoking 
'/usr/bin/osso_rss_feed_reader.launch'
Apr 11 01:36:03 Nokia-N800-10 icd 1.1.26[910]: Service ':1.57' belongs 
now to base service ':1.57'.
Apr 11 01:36:03 Nokia-N800-10 icd 1.1.26[910]: Service 
'com.nokia.osso_rss_feed_reader' belongs now to base service ':1.57'.
Apr 11 01:36:03 Nokia-N800-10 icd 1.1.26[910]: Received 
com.nokia.icd.get_state () request
Apr 11 01:36:03 Nokia-N800-10 icd 1.1.26[910]: Service ':1.58' belongs 
now to base service ':1.58'.
Apr 11 01:36:03 Nokia-N800-10 iap_conndlg 1.3.48[1038]: 
NameownerChanged(:1.57, , :1.57)
Apr 11 01:36:03 Nokia-N800-10 iap_conndlg 1.3.48[1038]: 
NameownerChanged(com.nokia.osso_rss_feed_reader, , :1.57)
Apr 11 01:36:03 Nokia-N800-10 iap_conndlg 1.3.48[1038]: 
NameownerChanged(:1.58, , :1.58)
Apr 11 01:36:04 Nokia-N800-10 alarmd[1105]: Incoming get_event request
Apr 11 01:36:04 Nokia-N800-10 icd 1.1.26[910]: Received 
com.nokia.icd.connect (su) request
Apr 11 01:36:04 Nokia-N800-10 icd 1.1.26[910]: Sending ack to :1.57.
Apr 11 01:36:04 Nokia-N800-10 osso_rss_feed_reader[1499]: GLIB DEBUG 
ConIc - con_ic_connection_send_event(0x71a80, null, WLAN_INFRA, 0)
Apr 11 01:36:05 Nokia-N800-10 kernel: [ 3676.020690] DEAUTHENTICATE trap
Apr 11 01:36:05 Nokia-N800-10 kernel: [ 3676.020782] Active scanning on 
 >null<
Apr 11 01:36:05 Nokia-N800-10 osso_rss_feed_reader[1499]: GLIB DEBUG 
ConIc - con_ic_connection_send_event(0x71a80, null, WLAN_INFRA, 0)
Apr 11 01:36:05 Nokia-N800-10 wlancond 1.1.13[907]: Deauthenticated
Apr 11 01:36:05 Nokia-N800-10 kernel: [ 3676.809539] EAC mode: play 
disabled, rec disabled
Apr 11 01:36:05 Nokia-N800-10 kernel: [ 3677.002227] sm_drv_transmit: 
sm_frame_tx returned error -9
Apr 11 01:36:06 Nokia-N800-10 kernel: [ 3677.846496] Scan complete, 
scanned 13 channels
Apr 11 01:36:06 Nokia-N800-10 wlancond 1.1.13[907]: Scan results ready 
-- not requested
Apr 11 01:36:06 Nokia-N800-10 kernel: [ 3678.002288] sm_drv_transmit: 
sm_frame_tx returned error -9
Apr 11 01:36:07 Nokia-N800-10 kernel: [ 3678.094787] cx3110x: PSM disabled
Apr 11 01:36:07 Nokia-N800-10 wlancond 1.1.13[907]: SIOCGIWAP: New 
Access Point: 00:17:9a:f4:f1:a1
Apr 11 01:36:07 Nokia-N800-10 icd 1.1.26[910]: [null] Received WLAN 
connected event to 00:17:9a:f4:f1:a1, but was already associated.
Apr 11 01:36:07 Nokia-N800-10 icd 1.1.26[910]: handle_eap_message(): 
received com.nokia.eap.signal.auth_status signal
Apr 11 01:36:07 Nokia-N800-10 icd 1.1.26[910]: [null] Received 
EAP_AUTH_STATUS_SIG: 0x4.
Apr 11 01:36:07 Nokia-N800-10 icd 1.1.26[910]: Received EAP_SUCCESS, but 
not in state CONNECTING.
Apr 11 01:36:07 Nokia-N800-10 wlancond 1.1.13[907]: Received set_powersave
Apr 11 01:36:07 Nokia-N800-10 wlancond 1.1.13[907]: WLAN powersave on
Apr 11 01:36:07 Nokia-N800-10 kernel: [ 3678.343963] cx3110x: PSM 
dynamic with 1000 ms CAM timeout
Apr 11 01:36:12 Nokia-N800-10 ke_recv[893]: ke-recv.c:375: i|m|p: 
com.nokia.mce.signal|display_status_ind|/com/nokia/mce/signal
Apr 11 01:36:14 Nokia-N800-10 icd 1.1.26[910]: Service 
'com.nokia.osso_rss_feed_reader' no longer exists.
Apr 11 01:36:14 Nokia-N800-10 icd 1.1.26[910]: Base service ':1.57' no 
longer exists.
Apr 11 01:36:14 Nokia-N800-10 icd 1.1.26[910]: [null] Removing 
connection ':1.57'
Apr 11 01:36:14 Nokia-N800-10 icd 1.1.26[910]: Base service ':1.58' no 
longer exists.
Apr 11 01:36:14 Nokia-N800-10 maemo-launcher[948]: child (pid=1499) 
terminated due to exit()=0
Apr 11 01:36:14 Nokia-N800-10 iap_conndlg 1.3.48[1038]: 
NameownerChanged(com.nokia.osso_rss_feed_reader, :1.57, )
Apr 11 01:36:14 Nokia-N800-10 iap_conndlg 1.3.48[1038]: 
NameownerChanged(:1.57, :1.57, )
Apr 11 01:36:14 Nokia-N800-10 iap_conndlg 1.3.48[1038]: 
NameownerChanged(:1.58, :1.58, )
Apr 11 01:36:32 Nokia-N800-10 maemo_af_desktop[1018]: GLIB DEBUG default 
- HildonHome detected system inactivity: 1
Apr 11 01:36:32 Nokia-N800-10 ke_recv[893]: ke-recv.c:375: i|m|p: 
com.nokia.mce.signal|system_inactivity_ind|/com/nokia/mce/signal
Apr 11 01:36:32 Nokia-N800-10 ke_recv[893]: ke-recv.c:375: i|m|p: 
com.nokia.mce.signal|save_unsaved_data_ind|/com/nokia/mce/signal
Apr 11 01:36:33 Nokia-N800-10 ke_recv[893]: ke-recv.c:375: i|m|p: 
com.nokia.mce.signal|tklock_mode_ind|/com/nokia/mce/signal
Apr 11 01:36:33 Nokia-N800-10 ke_recv[893]: ke-recv.c:375: i|m|p: 
com.nokia.mce.signal|display_status_ind|/com/nokia/mce/signal
Apr 11 01:36:33 Nokia-N800-10 kernel: [ 3704.067565] omapfb omapfb: 
s1d1374x: setting update mode to disabled
Apr 11 01:37:40 Nokia-N800-10 init: Id "T0" respawning too fast: 
disabled for 5 minutes

(no I don't know wth /etc/inittab:T0:12345:respawn:/sbin/getty -L ttyS0 
115200 vt100 is on about there)

(you can poke me @n.c also if necessary)

't.