Nov 9 22:39:11 om-gta02 user.info 2008.11.09 22:39:11 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to idle Nov 9 22:39:11 om-gta02 user.info 2008.11.09 22:39:11 oeventsd INFO Receive IdleState, status = idle Nov 9 22:39:11 om-gta02 user.debug 2008.11.09 22:39:11 oeventsd DEBUG trigger IdleState Nov 9 22:39:11 om-gta02 user.info 2008.11.09 22:39:11 oeventsd INFO Receive IdleState, status = idle Nov 9 22:39:11 om-gta02 user.debug 2008.11.09 22:39:11 oeventsd DEBUG trigger IdleState Nov 9 22:39:11 om-gta02 user.info 2008.11.09 22:39:11 oeventsd INFO Receive IdleState, status = idle Nov 9 22:39:11 om-gta02 user.debug 2008.11.09 22:39:11 oeventsd DEBUG trigger IdleState Nov 9 22:39:15 om-gta02 user.info 2008.11.09 22:39:15 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to busy Nov 9 22:39:15 om-gta02 user.info 2008.11.09 22:39:15 oeventsd INFO Receive IdleState, status = busy Nov 9 22:39:15 om-gta02 user.debug 2008.11.09 22:39:15 oeventsd DEBUG trigger IdleState Nov 9 22:39:15 om-gta02 user.debug 2008.11.09 22:39:15 oeventsd DEBUG trigger on IdleState if status == busy then SetBrightness((90,)) Nov 9 22:39:15 om-gta02 user.info 2008.11.09 22:39:15 oeventsd INFO call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((90,)) Nov 9 22:39:15 om-gta02 user.info 2008.11.09 22:39:15 oeventsd INFO Receive IdleState, status = busy Nov 9 22:39:15 om-gta02 user.debug 2008.11.09 22:39:15 oeventsd DEBUG trigger IdleState Nov 9 22:39:15 om-gta02 user.info 2008.11.09 22:39:15 oeventsd INFO Receive IdleState, status = busy Nov 9 22:39:15 om-gta02 user.debug 2008.11.09 22:39:15 oeventsd DEBUG trigger IdleState Nov 9 22:39:16 om-gta02 user.info 2008.11.09 22:39:16 oeventsd INFO signal SetBrightness responded : () Nov 9 22:39:21 om-gta02 user.debug 2008.11.09 22:39:21 frameworkd.controller DEBUG alive and kicking Nov 9 22:39:26 om-gta02 user.info 2008.11.09 22:39:26 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to idle Nov 9 22:39:26 om-gta02 user.info 2008.11.09 22:39:26 oeventsd INFO Receive IdleState, status = idle Nov 9 22:39:26 om-gta02 user.debug 2008.11.09 22:39:26 oeventsd DEBUG trigger IdleState Nov 9 22:39:26 om-gta02 user.info 2008.11.09 22:39:26 oeventsd INFO Receive IdleState, status = idle Nov 9 22:39:26 om-gta02 user.debug 2008.11.09 22:39:26 oeventsd DEBUG trigger IdleState Nov 9 22:39:26 om-gta02 user.info 2008.11.09 22:39:26 oeventsd INFO Receive IdleState, status = idle Nov 9 22:39:26 om-gta02 user.debug 2008.11.09 22:39:26 oeventsd DEBUG trigger IdleState Nov 9 22:39:26 om-gta02 user.info 2008.11.09 22:39:26 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to busy Nov 9 22:39:26 om-gta02 user.info 2008.11.09 22:39:26 oeventsd INFO Receive IdleState, status = busy Nov 9 22:39:26 om-gta02 user.debug 2008.11.09 22:39:26 oeventsd DEBUG trigger IdleState Nov 9 22:39:26 om-gta02 user.debug 2008.11.09 22:39:26 oeventsd DEBUG trigger on IdleState if status == busy then SetBrightness((90,)) Nov 9 22:39:26 om-gta02 user.info 2008.11.09 22:39:26 oeventsd INFO call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((90,)) Nov 9 22:39:26 om-gta02 user.info 2008.11.09 22:39:26 oeventsd INFO Receive IdleState, status = busy Nov 9 22:39:26 om-gta02 user.debug 2008.11.09 22:39:26 oeventsd DEBUG trigger IdleState Nov 9 22:39:26 om-gta02 user.info 2008.11.09 22:39:26 oeventsd INFO Receive IdleState, status = busy Nov 9 22:39:26 om-gta02 user.debug 2008.11.09 22:39:26 oeventsd DEBUG trigger IdleState Nov 9 22:39:26 om-gta02 user.info 2008.11.09 22:39:26 oeventsd INFO signal SetBrightness responded : () Nov 9 22:39:36 om-gta02 user.info 2008.11.09 22:39:36 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to idle Nov 9 22:39:36 om-gta02 user.info 2008.11.09 22:39:36 oeventsd INFO Receive IdleState, status = idle Nov 9 22:39:36 om-gta02 user.debug 2008.11.09 22:39:36 oeventsd DEBUG trigger IdleState Nov 9 22:39:36 om-gta02 user.info 2008.11.09 22:39:36 oeventsd INFO Receive IdleState, status = idle Nov 9 22:39:36 om-gta02 user.debug 2008.11.09 22:39:36 oeventsd DEBUG trigger IdleState Nov 9 22:39:36 om-gta02 user.info 2008.11.09 22:39:36 oeventsd INFO Receive IdleState, status = idle Nov 9 22:39:36 om-gta02 user.debug 2008.11.09 22:39:36 oeventsd DEBUG trigger IdleState Nov 9 22:39:46 om-gta02 user.info 2008.11.09 22:39:46 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to busy Nov 9 22:39:46 om-gta02 user.info 2008.11.09 22:39:46 oeventsd INFO Receive IdleState, status = busy Nov 9 22:39:46 om-gta02 user.debug 2008.11.09 22:39:46 oeventsd DEBUG trigger IdleState Nov 9 22:39:46 om-gta02 user.debug 2008.11.09 22:39:46 oeventsd DEBUG trigger on IdleState if status == busy then SetBrightness((90,)) Nov 9 22:39:46 om-gta02 user.info 2008.11.09 22:39:46 oeventsd INFO call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((90,)) Nov 9 22:39:46 om-gta02 user.info 2008.11.09 22:39:46 oeventsd INFO Receive IdleState, status = busy Nov 9 22:39:46 om-gta02 user.debug 2008.11.09 22:39:46 oeventsd DEBUG trigger IdleState Nov 9 22:39:46 om-gta02 user.info 2008.11.09 22:39:46 oeventsd INFO Receive IdleState, status = busy Nov 9 22:39:46 om-gta02 user.debug 2008.11.09 22:39:46 oeventsd DEBUG trigger IdleState Nov 9 22:39:46 om-gta02 user.info 2008.11.09 22:39:46 oeventsd INFO signal SetBrightness responded : () Nov 9 22:39:57 om-gta02 user.info 2008.11.09 22:39:57 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to idle Nov 9 22:39:57 om-gta02 user.info 2008.11.09 22:39:57 oeventsd INFO Receive IdleState, status = idle Nov 9 22:39:57 om-gta02 user.debug 2008.11.09 22:39:57 oeventsd DEBUG trigger IdleState Nov 9 22:39:57 om-gta02 user.info 2008.11.09 22:39:57 oeventsd INFO Receive IdleState, status = idle Nov 9 22:39:57 om-gta02 user.debug 2008.11.09 22:39:57 oeventsd DEBUG trigger IdleState Nov 9 22:39:57 om-gta02 user.info 2008.11.09 22:39:57 oeventsd INFO Receive IdleState, status = idle Nov 9 22:39:57 om-gta02 user.debug 2008.11.09 22:39:57 oeventsd DEBUG trigger IdleState Nov 9 22:40:00 om-gta02 user.debug 2008.11.09 22:40:00 otimed DEBUG Minute 22:40 Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 frameworkd.controller DEBUG alive and kicking Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freesmartphone.Device.Input': {'signals': {u'Event': ([{'type': u's', 'name': u'name'}, {'type': u's', 'name': u'action'}, {'type': u'i', 'name': u'seconds'}],)}, 'methods': {}, 'p Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freesmartphone.Preferences': {'signals': {}, 'methods': {u'GetProfiles': ([], [{'type': u'as', 'name': None}]), u'GetService': ([{'type': u's', 'name': u'name'}], [{'type': u'o', ' Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freedesktop.DBus.Introspectable': {'signals': {}, 'methods': {u'Introspect': ([], [{'type': u's', 'name': None}])}, 'properties': {}}, u'org.freesmartphone.Device.LED': {'signals': Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freedesktop.DBus.Introspectable': {'signals': {}, 'methods': {u'Introspect': ([], [{'type': u's', 'name': None}])}, 'properties': {}}, u'org.freesmartphone.Device.PowerSupply': {'s Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freedesktop.DBus.Introspectable': {'signals': {}, 'methods': {u'Introspect': ([], [{'type': u's', 'name': None}])}, 'properties': {}}, u'org.freesmartphone.Device.Audio': {'signals Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freesmartphone.GSM.Call': {'signals': {u'CallStatus': ([{'type': u'i', 'name': u'index'}, {'type': u's', 'name': u'status'}, {'type': u'a{sv}', 'name': u'properties'}],)}, 'methods Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freesmartphone.Device.PowerControl': {'signals': {u'Power': ([{'type': u's', 'name': u'device'}, {'type': u'b', 'name': u'power'}],)}, 'methods': {u'Reset': ([], []), u'GetName': ( Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freedesktop.DBus.Introspectable': {'signals': {}, 'methods': {u'Introspect': ([], [{'type': u's', 'name': None}])}, 'properties': {}}, u'org.freesmartphone.Device.LED': {'signals': Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freedesktop.DBus.Introspectable': {'signals': {}, 'methods': {u'Introspect': ([], [{'type': u's', 'name': None}])}, 'properties': {}}, u'org.freesmartphone.Device.LED': {'signals': Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freesmartphone.Usage': {'signals': {u'ResourceAvailable': ([{'type': u's', 'name': u'resourcename'}, {'type': u'b', 'name': u'state'}],), u'ResourceChanged': ([{'type': u's', 'name Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freesmartphone.Device.PowerControl': {'signals': {u'Power': ([{'type': u's', 'name': u'device'}, {'type': u'b', 'name': u'power'}],)}, 'methods': {u'Reset': ([], []), u'GetName': ( Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freedesktop.DBus.Introspectable': {'signals': {}, 'methods': {u'Introspect': ([], [{'type': u's', 'name': None}])}, 'properties': {}}, u'org.freesmartphone.Device.RealTimeClock': { Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freedesktop.DBus.Introspectable': {'signals': {}, 'methods': {u'Introspect': ([], [{'type': u's', 'name': None}])}, 'properties': {}}, u'org.freesmartphone.Framework': {'signals': Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freedesktop.DBus.Introspectable': {'signals': {}, 'methods': {u'Introspect': ([], [{'type': u's', 'name': None}])}, 'properties': {}}, u'org.freesmartphone.Device.Display': {'signa Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freesmartphone.Device.PowerControl': {'signals': {u'Power': ([{'type': u's', 'name': u'device'}, {'type': u'b', 'name': u'power'}],)}, 'methods': {u'Reset': ([], []), u'GetName': ( Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freesmartphone.Device.PowerControl': {'signals': {u'Power': ([{'type': u's', 'name': u'device'}, {'type': u'b', 'name': u'power'}],)}, 'methods': {u'Reset': ([], []), u'GetName': ( Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freedesktop.DBus.Introspectable': {'signals': {}, 'methods': {u'Introspect': ([], [{'type': u's', 'name': None}])}, 'properties': {}}, u'org.freesmartphone.Device.IdleNotifier': {' Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freesmartphone.PIM.Sources': {'signals': {}, 'methods': {u'GetEntryCount': ([], [{'type': u'i', 'name': None}]), u'InitAllEntries': ([], [])}, 'properties': {}}, u'org.freedesktop. Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freedesktop.DBus.Introspectable': {'signals': {}, 'methods': {u'Introspect': ([], [{'type': u's', 'name': None}])}, 'properties': {}}, u'org.freesmartphone.Time': {'signals': {u'Mi Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freedesktop.DBus.Introspectable': {'signals': {}, 'methods': {u'Introspect': ([], [{'type': u's', 'name': None}])}, 'properties': {}}, u'org.freesmartphone.GSM.HZ': {'signals': {u' Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freedesktop.DBus.Introspectable': {'signals': {}, 'methods': {u'Introspect': ([], [{'type': u's', 'name': None}])}, 'properties': {}}, u'org.freesmartphone.Events': {'signals': {}, Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freedesktop.DBus.Introspectable': {'signals': {}, 'methods': {u'Introspect': ([], [{'type': u's', 'name': None}])}, 'properties': {}}, u'org.freesmartphone.Phone': {'signals': {u'I Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freedesktop.DBus.Introspectable': {'signals': {}, 'methods': {u'Introspect': ([], [{'type': u's', 'name': None}])}, 'properties': {}}, u'org.freesmartphone.Device.LED': {'signals': Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freedesktop.Gypsy.Time': {'signals': {u'TimeChanged': ([{'type': u'i', 'name': u'time'}],)}, 'methods': {u'GetTime': ([], [{'type': u'i', 'name': None}])}, 'properties': {}}, u'org Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freedesktop.DBus.Introspectable': {'signals': {}, 'methods': {u'Introspect': ([], [{'type': u's', 'name': None}])}, 'properties': {}}, u'org.freesmartphone.Time.Alarm': {'signals': Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freedesktop.DBus.Introspectable': {'signals': {}, 'methods': {u'Introspect': ([], [{'type': u's', 'name': None}])}, 'properties': {}}, u'org.freesmartphone.Device.Info': {'signals' Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freesmartphone.Device.PowerControl': {'signals': {u'Power': ([{'type': u's', 'name': u'device'}, {'type': u'b', 'name': u'power'}],)}, 'methods': {u'Reset': ([], []), u'GetName': ( Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG interfaces for object are {u'org.freedesktop.DBus.Introspectable': {'signals': {}, 'methods': {u'Introspect': ([], [{'type': u's', 'name': None}])}, 'properties': {}}, u'org.freesmartphone.Device.PowerSupply': {'s Nov 9 22:40:11 om-gta02 user.debug 2008.11.09 22:40:11 root DEBUG introspection fully done, result is ['/org/freesmartphone/Device/IdleNotifier/0'] Nov 9 22:40:12 om-gta02 user.debug 2008.11.09 22:40:12 ousaged DEBUG Enabling GSM Nov 9 22:40:12 om-gta02 user.info 2008.11.09 22:40:12 frameworkd.resource INFO setting resource status for GSM from disabled to enabling Nov 9 22:40:17 om-gta02 user.debug 2008.11.09 22:40:17 ogsmd DEBUG |...|...|...|...|...|...> TiCalypso.__init__: ENTER (, ),{} Nov 9 22:40:17 om-gta02 user.debug 2008.11.09 22:40:17 ogsmd DEBUG |...|...|...|...|...|...|...|...> TiCalypso.__init__: ENTER (, ),{} Nov 9 22:40:17 om-gta02 user.debug 2008.11.09 22:40:17 ogsmd DEBUG |...|...|...|...|...|...|...|...> TiCalypso.__init__: LEAVE Nov 9 22:40:17 om-gta02 user.debug 2008.11.09 22:40:17 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...|...|...|...> CallChannel.__init__: ENTER (>, 'ogsmd. Nov 9 22:40:17 om-gta02 user.debug 2008.11.09 22:40:17 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...|...|...|...> CallChannel.__init__: LEAVE Nov 9 22:40:17 om-gta02 user.info 2008.11.09 22:40:17 ogsmd INFO : Creating channel with timeout = 3600 seconds Nov 9 22:40:17 om-gta02 user.debug 2008.11.09 22:40:17 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...|...|...|...> UnsolicitedResponseChannel.__init__: ENTER ( UnsolicitedResponseChannel.__init__: LEAVE Nov 9 22:40:17 om-gta02 user.info 2008.11.09 22:40:17 ogsmd INFO : Creating channel with timeout = 5 seconds Nov 9 22:40:17 om-gta02 user.debug 2008.11.09 22:40:17 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...|...|...> MiscChannel.__init__: ENTER (>, 'ogsmd.misc Nov 9 22:40:17 om-gta02 user.debug 2008.11.09 22:40:17 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...|...|...> MiscChannel.__init__: LEAVE Nov 9 22:40:17 om-gta02 user.info 2008.11.09 22:40:17 ogsmd INFO : Creating channel with timeout = 5 seconds Nov 9 22:40:17 om-gta02 user.debug 2008.11.09 22:40:17 ogsmd DEBUG |...|...|...|...|...|...> TiCalypso.__init__: LEAVE Nov 9 22:40:17 om-gta02 user.info 2008.11.09 22:40:17 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to idle_dim Nov 9 22:40:17 om-gta02 user.info 2008.11.09 22:40:17 oeventsd INFO Receive IdleState, status = idle_dim Nov 9 22:40:18 om-gta02 user.debug 2008.11.09 22:40:18 oeventsd DEBUG trigger IdleState Nov 9 22:40:18 om-gta02 user.info 2008.11.09 22:40:18 oeventsd INFO Receive IdleState, status = idle_dim Nov 9 22:40:18 om-gta02 user.debug 2008.11.09 22:40:18 oeventsd DEBUG trigger IdleState Nov 9 22:40:18 om-gta02 user.debug 2008.11.09 22:40:18 oeventsd DEBUG trigger on IdleState if status == idle_dim then SetBrightness((20,)) Nov 9 22:40:18 om-gta02 user.info 2008.11.09 22:40:18 oeventsd INFO call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((20,)) Nov 9 22:40:18 om-gta02 user.info 2008.11.09 22:40:18 oeventsd INFO Receive IdleState, status = idle_dim Nov 9 22:40:18 om-gta02 user.debug 2008.11.09 22:40:18 oeventsd DEBUG trigger IdleState Nov 9 22:40:18 om-gta02 user.debug 2008.11.09 22:40:18 odeviced DEBUG (writing '13' to '/sys/class/backlight/pcf50633-bl/brightness') Nov 9 22:40:18 om-gta02 user.info 2008.11.09 22:40:18 oeventsd INFO signal SetBrightness responded : () Nov 9 22:40:18 om-gta02 user.debug 2008.11.09 22:40:18 ogsmd.modem.abstract DEBUG trying to open channel MISC Nov 9 22:40:18 om-gta02 user.debug 2008.11.09 22:40:18 ogsmd DEBUG |...|...|...|...> MiscChannel.open: ENTER (),{} Nov 9 22:40:18 om-gta02 local0.info /usr/sbin/gsm0710muxd[1384]: gsm0710muxd.c:693:c_alloc_channel(): Connecting /dev/pts/0 to virtual channel 1 for ogsmd.misc on /dev/ttySAC0 Nov 9 22:40:18 om-gta02 user.info 2008.11.09 22:40:18 ogsmd INFO : initializing Nov 9 22:40:18 om-gta02 user.debug 2008.11.09 22:40:18 ogsmd DEBUG |...|...|...|...|...|...> MiscChannel._hookLowLevelInit: ENTER (),{} Nov 9 22:40:18 om-gta02 user.debug 2008.11.09 22:40:18 ogsmd DEBUG (modem init... try #1) Nov 9 22:40:18 om-gta02 local0.warn /usr/sbin/gsm0710muxd[1384]: gsm0710muxd.c:569:pseudo_device_read(): Write to a channel which wasn't acked to be open. Nov 9 22:40:18 om-gta02 local0.info /usr/sbin/gsm0710muxd[1384]: gsm0710muxd.c:1410:extract_frames(): Logical channel 1 opened Nov 9 22:40:18 om-gta02 user.debug 2008.11.09 22:40:18 ogsmd DEBUG (modem not responding) Nov 9 22:40:18 om-gta02 user.debug 2008.11.09 22:40:18 ogsmd DEBUG (modem init... try #2) Nov 9 22:40:18 om-gta02 user.debug 2008.11.09 22:40:18 ogsmd DEBUG read: OK Nov 9 22:40:18 om-gta02 user.info 2008.11.09 22:40:18 ogsmd INFO : responding OK Nov 9 22:40:18 om-gta02 user.debug 2008.11.09 22:40:18 ogsmd DEBUG |...|...|...|...|...|...> MiscChannel._hookLowLevelInit: LEAVE Nov 9 22:40:18 om-gta02 user.debug 2008.11.09 22:40:18 ogsmd DEBUG |...|...|...|...> MiscChannel.open: LEAVE Nov 9 22:40:18 om-gta02 user.debug 2008.11.09 22:40:18 ogsmd.modem.abstract DEBUG trying to open channel UNSOL Nov 9 22:40:18 om-gta02 user.debug 2008.11.09 22:40:18 ogsmd DEBUG |...|...|...|...> UnsolicitedResponseChannel.open: ENTER (),{} Nov 9 22:40:19 om-gta02 local0.info /usr/sbin/gsm0710muxd[1384]: gsm0710muxd.c:693:c_alloc_channel(): Connecting /dev/pts/1 to virtual channel 2 for ogsmd.unsolicited on /dev/ttySAC0 Nov 9 22:40:19 om-gta02 local0.info /usr/sbin/gsm0710muxd[1384]: gsm0710muxd.c:1410:extract_frames(): Logical channel 2 opened Nov 9 22:40:19 om-gta02 user.info 2008.11.09 22:40:19 ogsmd INFO : initializing Nov 9 22:40:19 om-gta02 user.debug 2008.11.09 22:40:19 ogsmd DEBUG |...|...|...|...|...|...> UnsolicitedResponseChannel._hookLowLevelInit: ENTER (),{} Nov 9 22:40:19 om-gta02 user.debug 2008.11.09 22:40:19 ogsmd DEBUG (modem init... try #1) Nov 9 22:40:19 om-gta02 user.debug 2008.11.09 22:40:19 ogsmd DEBUG read: OK Nov 9 22:40:19 om-gta02 user.info 2008.11.09 22:40:19 ogsmd INFO : responding OK Nov 9 22:40:19 om-gta02 user.debug 2008.11.09 22:40:19 ogsmd DEBUG |...|...|...|...|...|...> UnsolicitedResponseChannel._hookLowLevelInit: LEAVE Nov 9 22:40:19 om-gta02 user.debug 2008.11.09 22:40:19 ogsmd DEBUG |...|...|...|...> UnsolicitedResponseChannel.open: LEAVE Nov 9 22:40:19 om-gta02 user.debug 2008.11.09 22:40:19 ogsmd.modem.abstract DEBUG trying to open channel CALL Nov 9 22:40:19 om-gta02 user.debug 2008.11.09 22:40:19 ogsmd DEBUG |...|...|...|...> CallChannel.open: ENTER (),{} Nov 9 22:40:19 om-gta02 local0.info /usr/sbin/gsm0710muxd[1384]: gsm0710muxd.c:693:c_alloc_channel(): Connecting /dev/pts/2 to virtual channel 3 for ogsmd.call on /dev/ttySAC0 Nov 9 22:40:19 om-gta02 local0.info /usr/sbin/gsm0710muxd[1384]: gsm0710muxd.c:1410:extract_frames(): Logical channel 3 opened Nov 9 22:40:19 om-gta02 user.info 2008.11.09 22:40:19 ogsmd INFO : initializing Nov 9 22:40:19 om-gta02 user.debug 2008.11.09 22:40:19 ogsmd DEBUG |...|...|...|...|...|...> CallChannel._hookLowLevelInit: ENTER (),{} Nov 9 22:40:19 om-gta02 user.debug 2008.11.09 22:40:19 ogsmd DEBUG (modem init... try #1) Nov 9 22:40:19 om-gta02 user.debug 2008.11.09 22:40:19 ogsmd DEBUG read: OK Nov 9 22:40:19 om-gta02 user.info 2008.11.09 22:40:19 ogsmd INFO : responding OK Nov 9 22:40:19 om-gta02 user.debug 2008.11.09 22:40:19 ogsmd DEBUG |...|...|...|...|...|...> CallChannel._hookLowLevelInit: LEAVE Nov 9 22:40:19 om-gta02 user.debug 2008.11.09 22:40:19 ogsmd DEBUG |...|...|...|...> CallChannel.open: LEAVE Nov 9 22:40:19 om-gta02 user.info 2008.11.09 22:40:19 frameworkd.resource INFO setting resource status for GSM from enabling to enabled Nov 9 22:40:19 om-gta02 user.debug 2008.11.09 22:40:19 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__init__: ENTER (, at 0x5ee0f0>, NetworkGetSignalStrength.__init__: LEAVE Nov 9 22:40:19 om-gta02 user.debug 2008.11.09 22:40:19 ogsmd DEBUG : sending 5 bytes: 'ATZ\r\n' Nov 9 22:40:19 om-gta02 user.debug 2008.11.09 22:40:19 ogsmd DEBUG : sending 5 bytes: 'ATZ\r\n' Nov 9 22:40:19 om-gta02 user.debug 2008.11.09 22:40:19 ogsmd DEBUG : sending 5 bytes: 'ATZ\r\n' Nov 9 22:40:20 om-gta02 user.debug 2008.11.09 22:40:20 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: ENTER (, at 0x6ea270>, at Nov 9 22:40:20 om-gta02 user.debug 2008.11.09 22:40:20 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: LEAVE Nov 9 22:40:20 om-gta02 user.debug 2008.11.09 22:40:20 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:20 om-gta02 user.debug 2008.11.09 22:40:20 ogsmd DEBUG : COMPLETED 'ATZ' => ['OK'] Nov 9 22:40:20 om-gta02 user.debug 2008.11.09 22:40:20 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:20 om-gta02 user.debug 2008.11.09 22:40:20 ogsmd DEBUG : COMPLETED 'ATZ' => ['OK'] Nov 9 22:40:20 om-gta02 user.info 2008.11.09 22:40:20 ousaged INFO Enabled GSM in 7.4 seconds Nov 9 22:40:20 om-gta02 user.debug 2008.11.09 22:40:20 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:20 om-gta02 user.debug 2008.11.09 22:40:20 ogsmd DEBUG : COMPLETED 'ATZ' => ['OK'] Nov 9 22:40:20 om-gta02 user.debug 2008.11.09 22:40:20 ogsmd DEBUG : sending 8 bytes: 'ATE0V1\r\n' Nov 9 22:40:20 om-gta02 user.debug 2008.11.09 22:40:20 ogsmd DEBUG : sending 8 bytes: 'ATE0V1\r\n' Nov 9 22:40:20 om-gta02 user.debug 2008.11.09 22:40:20 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__init__: ENTER (, at 0x5ee070>, NetworkGetSignalStrength.__init__: LEAVE Nov 9 22:40:20 om-gta02 user.debug 2008.11.09 22:40:20 ogsmd DEBUG : sending 8 bytes: 'ATE0V1\r\n' Nov 9 22:40:21 om-gta02 user.debug 2008.11.09 22:40:21 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: ENTER (, at 0x58ff70>, at Nov 9 22:40:21 om-gta02 user.debug 2008.11.09 22:40:21 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: LEAVE Nov 9 22:40:21 om-gta02 user.debug 2008.11.09 22:40:21 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:21 om-gta02 user.debug 2008.11.09 22:40:21 ogsmd DEBUG : COMPLETED 'ATE0V1' => ['OK'] Nov 9 22:40:21 om-gta02 user.debug 2008.11.09 22:40:21 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:21 om-gta02 user.debug 2008.11.09 22:40:21 ogsmd DEBUG : COMPLETED 'ATE0V1' => ['OK'] Nov 9 22:40:21 om-gta02 user.debug 2008.11.09 22:40:21 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:21 om-gta02 user.debug 2008.11.09 22:40:21 ogsmd DEBUG : COMPLETED 'ATE0V1' => ['OK'] Nov 9 22:40:21 om-gta02 user.debug 2008.11.09 22:40:21 ogsmd DEBUG : sending 11 bytes: 'AT+CMEE=1\r\n' Nov 9 22:40:21 om-gta02 user.debug 2008.11.09 22:40:21 ogsmd DEBUG : sending 11 bytes: 'AT+CMEE=1\r\n' Nov 9 22:40:21 om-gta02 user.debug 2008.11.09 22:40:21 ogsmd DEBUG |...|...|...|...|...|...|...|...> DeviceSetAntennaPower.__init__: ENTER (, at 0x58feb0>, DeviceSetAntennaPower.__init__: LEAVE Nov 9 22:40:21 om-gta02 user.debug 2008.11.09 22:40:21 ogsmd DEBUG : sending 11 bytes: 'AT+CMEE=1\r\n' Nov 9 22:40:21 om-gta02 user.debug 2008.11.09 22:40:21 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__init__: ENTER (, at 0x58fe70>, NetworkGetSignalStrength.__init__: LEAVE Nov 9 22:40:21 om-gta02 user.debug 2008.11.09 22:40:21 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:21 om-gta02 user.debug 2008.11.09 22:40:21 ogsmd DEBUG : COMPLETED 'AT+CMEE=1' => ['OK'] Nov 9 22:40:21 om-gta02 user.debug 2008.11.09 22:40:21 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:21 om-gta02 user.debug 2008.11.09 22:40:21 ogsmd DEBUG : COMPLETED 'AT+CMEE=1' => ['OK'] Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: ENTER (, at 0x58fdf0>, at Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: LEAVE Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : COMPLETED 'AT+CMEE=1' => ['OK'] Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : sending 10 bytes: 'AT+CRC=1\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : sending 10 bytes: 'AT+CRC=1\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : COMPLETED 'AT+CRC=1' => ['OK'] Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : sending 10 bytes: 'AT+CRC=1\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : COMPLETED 'AT+CRC=1' => ['OK'] Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : sending 16 bytes: 'AT+CSCS="UCS2"\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__init__: ENTER (, at 0x58fdb0>, NetworkGetSignalStrength.__init__: LEAVE Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : COMPLETED 'AT+CRC=1' => ['OK'] Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : sending 16 bytes: 'AT+CSCS="UCS2"\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: ENTER (, at 0x6ea330>, at Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: LEAVE Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : COMPLETED 'AT+CSCS="UCS2"' => ['OK'] Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : sending 16 bytes: 'AT+CSCS="UCS2"\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : COMPLETED 'AT+CSCS="UCS2"' => ['OK'] Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : sending 11 bytes: 'AT+CSDH=1\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : COMPLETED 'AT+CSCS="UCS2"' => ['OK'] Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : sending 11 bytes: 'AT+CSDH=1\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : COMPLETED 'AT+CSDH=1' => ['OK'] Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : sending 11 bytes: 'AT+CSDH=1\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : COMPLETED 'AT+CSDH=1' => ['OK'] Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : sending 11 bytes: 'AT+CSNS=0\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : COMPLETED 'AT+CSDH=1' => ['OK'] Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : sending 11 bytes: 'AT+CSNS=0\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : COMPLETED 'AT+CSNS=0' => ['OK'] Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : sending 11 bytes: 'AT+CSNS=0\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : COMPLETED 'AT+CSNS=0' => ['OK'] Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : sending 11 bytes: 'AT+CMGF=0\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : COMPLETED 'AT+CSNS=0' => ['OK'] Nov 9 22:40:22 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : sending 11 bytes: 'AT+CMGF=0\r\n' Nov 9 22:40:23 om-gta02 user.debug 2008.11.09 22:40:22 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:23 om-gta02 user.debug 2008.11.09 22:40:23 ogsmd DEBUG : COMPLETED 'AT+CMGF=0' => ['OK'] Nov 9 22:40:23 om-gta02 user.debug 2008.11.09 22:40:23 ogsmd DEBUG : sending 11 bytes: 'AT+CMGF=0\r\n' Nov 9 22:40:23 om-gta02 user.debug 2008.11.09 22:40:23 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:23 om-gta02 user.debug 2008.11.09 22:40:23 ogsmd DEBUG : COMPLETED 'AT+CMGF=0' => ['OK'] Nov 9 22:40:23 om-gta02 user.debug 2008.11.09 22:40:23 ogsmd DEBUG : sending 11 bytes: 'AT+CSMS=1\r\n' Nov 9 22:40:23 om-gta02 user.debug 2008.11.09 22:40:23 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:23 om-gta02 user.debug 2008.11.09 22:40:23 ogsmd DEBUG : COMPLETED 'AT+CMGF=0' => ['OK'] Nov 9 22:40:23 om-gta02 user.debug 2008.11.09 22:40:23 ogsmd DEBUG : sending 11 bytes: 'AT+CSMS=1\r\n' Nov 9 22:40:23 om-gta02 user.debug 2008.11.09 22:40:23 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__init__: ENTER (, at 0x6ea3b0>, NetworkGetSignalStrength.__init__: LEAVE Nov 9 22:40:23 om-gta02 user.debug 2008.11.09 22:40:23 ogsmd DEBUG : got 22 bytes from: '\r\n+CSMS: 1,1,1\r\n\r\nOK\r\n' Nov 9 22:40:23 om-gta02 user.debug 2008.11.09 22:40:23 ogsmd DEBUG : COMPLETED 'AT+CSMS=1' => ['+CSMS: 1,1,1', 'OK'] Nov 9 22:40:23 om-gta02 user.debug 2008.11.09 22:40:23 ogsmd DEBUG : sending 11 bytes: 'AT+CSMS=1\r\n' Nov 9 22:40:24 om-gta02 user.debug 2008.11.09 22:40:24 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: ENTER (, at 0x6ea430>, at Nov 9 22:40:24 om-gta02 user.debug 2008.11.09 22:40:24 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: LEAVE Nov 9 22:40:24 om-gta02 user.debug 2008.11.09 22:40:24 ogsmd DEBUG : got 22 bytes from: '\r\n+CSMS: 1,1,1\r\n\r\nOK\r\n' Nov 9 22:40:24 om-gta02 user.debug 2008.11.09 22:40:24 ogsmd DEBUG : COMPLETED 'AT+CSMS=1' => ['+CSMS: 1,1,1', 'OK'] Nov 9 22:40:24 om-gta02 user.debug 2008.11.09 22:40:24 ogsmd DEBUG : sending 11 bytes: 'AT+CLIP=0\r\n' Nov 9 22:40:24 om-gta02 user.debug 2008.11.09 22:40:24 ogsmd DEBUG : got 22 bytes from: '\r\n+CSMS: 1,1,1\r\n\r\nOK\r\n' Nov 9 22:40:24 om-gta02 user.debug 2008.11.09 22:40:24 ogsmd DEBUG : COMPLETED 'AT+CSMS=1' => ['+CSMS: 1,1,1', 'OK'] Nov 9 22:40:24 om-gta02 user.debug 2008.11.09 22:40:24 ogsmd DEBUG : sending 11 bytes: 'AT+CLIP=0\r\n' Nov 9 22:40:24 om-gta02 user.debug 2008.11.09 22:40:24 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__init__: ENTER (, at 0x6ea4b0>, NetworkGetSignalStrength.__init__: LEAVE Nov 9 22:40:24 om-gta02 user.debug 2008.11.09 22:40:24 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:24 om-gta02 user.debug 2008.11.09 22:40:24 ogsmd DEBUG : COMPLETED 'AT+CLIP=0' => ['OK'] Nov 9 22:40:24 om-gta02 user.debug 2008.11.09 22:40:24 ogsmd DEBUG : sending 11 bytes: 'AT+CLIP=0\r\n' Nov 9 22:40:25 om-gta02 user.debug 2008.11.09 22:40:25 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: ENTER (, at 0x6ea530>, at Nov 9 22:40:25 om-gta02 user.debug 2008.11.09 22:40:25 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: LEAVE Nov 9 22:40:25 om-gta02 user.debug 2008.11.09 22:40:25 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:25 om-gta02 user.debug 2008.11.09 22:40:25 ogsmd DEBUG : COMPLETED 'AT+CLIP=0' => ['OK'] Nov 9 22:40:25 om-gta02 user.debug 2008.11.09 22:40:25 ogsmd DEBUG : sending 11 bytes: 'AT+COLP=0\r\n' Nov 9 22:40:25 om-gta02 user.debug 2008.11.09 22:40:25 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:25 om-gta02 user.debug 2008.11.09 22:40:25 ogsmd DEBUG : COMPLETED 'AT+CLIP=0' => ['OK'] Nov 9 22:40:25 om-gta02 user.debug 2008.11.09 22:40:25 ogsmd DEBUG : sending 11 bytes: 'AT+COLP=0\r\n' Nov 9 22:40:25 om-gta02 user.debug 2008.11.09 22:40:25 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__init__: ENTER (, at 0x6ea5b0>, NetworkGetSignalStrength.__init__: LEAVE Nov 9 22:40:25 om-gta02 user.debug 2008.11.09 22:40:25 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:25 om-gta02 user.debug 2008.11.09 22:40:25 ogsmd DEBUG : COMPLETED 'AT+COLP=0' => ['OK'] Nov 9 22:40:25 om-gta02 user.debug 2008.11.09 22:40:25 ogsmd DEBUG : sending 11 bytes: 'AT+COLP=0\r\n' Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: ENTER (, at 0x6ea630>, at Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: LEAVE Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : COMPLETED 'AT+COLP=0' => ['OK'] Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : sending 11 bytes: 'AT+CCWA=0\r\n' Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : COMPLETED 'AT+COLP=0' => ['OK'] Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : sending 11 bytes: 'AT+CCWA=0\r\n' Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : COMPLETED 'AT+CCWA=0' => ['OK'] Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : sending 11 bytes: 'AT+CCWA=0\r\n' Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : COMPLETED 'AT+CCWA=0' => ['OK'] Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : COMPLETED 'AT+CCWA=0' => ['OK'] Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : sending 11 bytes: 'AT+CLIP=1\r\n' Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : got 22 bytes from: '\r\n+CSQ: 19,99 \r\n\r\nOK\r\n' Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 19,99 ', 'OK'] Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetSignalStrength.responseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 19,99 ', 'OK']),{} Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetSignalStrength.responseFromChannel: LEAVE Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__del__: ENTER (),{} Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__del__: LEAVE Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : COMPLETED 'AT+CLIP=1' => ['OK'] Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__init__: ENTER (, at 0x5ee0f0>, NetworkGetSignalStrength.__init__: LEAVE Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : sending 11 bytes: 'AT+COLP=1\r\n' Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: ENTER (, at 0x6f41f0>, at Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: LEAVE Nov 9 22:40:26 om-gta02 user.debug 2008.11.09 22:40:26 ogsmd DEBUG : got 22 bytes from: '\r\n+CSQ: 19,99 \r\n\r\nOK\r\n' Nov 9 22:40:27 om-gta02 user.debug 2008.11.09 22:40:27 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 19,99 ', 'OK'] Nov 9 22:40:27 om-gta02 user.debug 2008.11.09 22:40:27 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 19,99 ', 'OK']),{} Nov 9 22:40:27 om-gta02 user.debug 2008.11.09 22:40:27 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:27 om-gta02 user.debug 2008.11.09 22:40:27 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:27 om-gta02 user.debug 2008.11.09 22:40:27 ogsmd DEBUG : COMPLETED 'AT+COLP=1' => ['OK'] Nov 9 22:40:27 om-gta02 user.debug 2008.11.09 22:40:27 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:40:27 om-gta02 user.debug 2008.11.09 22:40:27 ogsmd DEBUG : sending 11 bytes: 'AT+CCWA=1\r\n' Nov 9 22:40:27 om-gta02 user.debug 2008.11.09 22:40:27 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__init__: ENTER (, at 0x6f4270>, NetworkGetSignalStrength.__init__: LEAVE Nov 9 22:40:27 om-gta02 user.debug 2008.11.09 22:40:27 ogsmd DEBUG : got 22 bytes from: '\r\n+CSQ: 19,99 \r\n\r\nOK\r\n' Nov 9 22:40:27 om-gta02 user.debug 2008.11.09 22:40:27 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 19,99 ', 'OK'] Nov 9 22:40:27 om-gta02 user.debug 2008.11.09 22:40:27 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetSignalStrength.responseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 19,99 ', 'OK']),{} Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:27 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetSignalStrength.responseFromChannel: LEAVE Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__del__: ENTER (),{} Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__del__: LEAVE Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: ENTER (, at 0x5ee070>, at Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: LEAVE Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : COMPLETED 'AT+CCWA=1' => ['OK'] Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : sending 13 bytes: 'AT+CSSN=1,1\r\n' Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : got 22 bytes from: '\r\n+CSQ: 19,99 \r\n\r\nOK\r\n' Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 19,99 ', 'OK'] Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 19,99 ', 'OK']),{} Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : COMPLETED 'AT+CSSN=1,1' => ['OK'] Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : sending 10 bytes: 'AT+CPIN?\r\n' Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : sending 11 bytes: 'AT+CTZU=1\r\n' Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : got 16 bytes from: '\r\n+CPIN: READY\r\n' Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : COMPLETED 'AT+CPIN?' => ['+CPIN: READY', 'OK'] Nov 9 22:40:28 om-gta02 user.info 2008.11.09 22:40:28 ogsmd.objects INFO auth status changed to READY Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : COMPLETED 'AT+CTZU=1' => ['OK'] Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : sending 11 bytes: 'AT+CTZR=1\r\n' Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : got 16 bytes from: '\r\n+CSQ: 19,99 \r\n' Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 19,99 ', 'OK'] Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetSignalStrength.responseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 19,99 ', 'OK']),{} Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetSignalStrength.responseFromChannel: LEAVE Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__del__: ENTER (),{} Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__del__: LEAVE Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : COMPLETED 'AT+CTZR=1' => ['OK'] Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:40:28 om-gta02 user.debug 2008.11.09 22:40:28 ogsmd DEBUG : sending 11 bytes: 'AT+CREG=2\r\n' Nov 9 22:40:29 om-gta02 user.debug 2008.11.09 22:40:29 ogsmd DEBUG : got 22 bytes from: '\r\n+CSQ: 19,99 \r\n\r\nOK\r\n' Nov 9 22:40:29 om-gta02 user.debug 2008.11.09 22:40:29 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 19,99 ', 'OK'] Nov 9 22:40:29 om-gta02 user.debug 2008.11.09 22:40:29 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 19,99 ', 'OK']),{} Nov 9 22:40:29 om-gta02 user.debug 2008.11.09 22:40:29 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:29 om-gta02 user.debug 2008.11.09 22:40:29 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:29 om-gta02 user.debug 2008.11.09 22:40:29 ogsmd DEBUG : COMPLETED 'AT+CREG=2' => ['OK'] Nov 9 22:40:29 om-gta02 user.debug 2008.11.09 22:40:29 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:40:29 om-gta02 user.debug 2008.11.09 22:40:29 ogsmd DEBUG : sending 11 bytes: 'AT+CAOC=2\r\n' Nov 9 22:40:29 om-gta02 user.debug 2008.11.09 22:40:29 ogsmd DEBUG : got 22 bytes from: '\r\n+CSQ: 19,99 \r\n\r\nOK\r\n' Nov 9 22:40:29 om-gta02 user.debug 2008.11.09 22:40:29 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 19,99 ', 'OK'] Nov 9 22:40:29 om-gta02 user.debug 2008.11.09 22:40:29 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetSignalStrength.responseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 19,99 ', 'OK']),{} Nov 9 22:40:29 om-gta02 user.debug 2008.11.09 22:40:29 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetSignalStrength.responseFromChannel: LEAVE Nov 9 22:40:29 om-gta02 user.debug 2008.11.09 22:40:29 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__del__: ENTER (),{} Nov 9 22:40:29 om-gta02 user.debug 2008.11.09 22:40:29 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__del__: LEAVE Nov 9 22:40:29 om-gta02 user.debug 2008.11.09 22:40:29 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:29 om-gta02 user.debug 2008.11.09 22:40:29 ogsmd DEBUG : COMPLETED 'AT+CAOC=2' => ['OK'] Nov 9 22:40:29 om-gta02 user.debug 2008.11.09 22:40:29 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:40:29 om-gta02 user.debug 2008.11.09 22:40:29 ogsmd DEBUG : sending 15 bytes: 'AT+CGEREP=2,1\r\n' Nov 9 22:40:29 om-gta02 user.debug 2008.11.09 22:40:29 ogsmd DEBUG : got 22 bytes from: '\r\n+CSQ: 19,99 \r\n\r\nOK\r\n' Nov 9 22:40:29 om-gta02 user.debug 2008.11.09 22:40:29 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 19,99 ', 'OK'] Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 19,99 ', 'OK']),{} Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:30 om-gta02 user.info 2008.11.09 22:40:30 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to busy Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 ogsmd DEBUG : COMPLETED 'AT+CGEREP=2,1' => ['OK'] Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 ogsmd DEBUG : sending 12 bytes: 'AT+CGREG=2\r\n' Nov 9 22:40:30 om-gta02 user.info 2008.11.09 22:40:30 oeventsd INFO Receive IdleState, status = busy Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 oeventsd DEBUG trigger IdleState Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 oeventsd DEBUG trigger on IdleState if status == busy then SetBrightness((90,)) Nov 9 22:40:30 om-gta02 user.info 2008.11.09 22:40:30 oeventsd INFO call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((90,)) Nov 9 22:40:30 om-gta02 user.info 2008.11.09 22:40:30 oeventsd INFO Receive IdleState, status = busy Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 oeventsd DEBUG trigger IdleState Nov 9 22:40:30 om-gta02 user.info 2008.11.09 22:40:30 oeventsd INFO Receive IdleState, status = busy Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 oeventsd DEBUG trigger IdleState Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 ogsmd DEBUG : got 22 bytes from: '\r\n+CSQ: 19,99 \r\n\r\nOK\r\n' Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 19,99 ', 'OK'] Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetSignalStrength.responseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 19,99 ', 'OK']),{} Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetSignalStrength.responseFromChannel: LEAVE Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__del__: ENTER (),{} Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__del__: LEAVE Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 ogsmd DEBUG : COMPLETED 'AT+CGREG=2' => ['OK'] Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 ogsmd DEBUG : sending 10 bytes: 'AT%CPI=3\r\n' Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 ogsmd DEBUG : got 22 bytes from: '\r\n+CSQ: 19,99 \r\n\r\nOK\r\n' Nov 9 22:40:30 om-gta02 user.debug 2008.11.09 22:40:30 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 19,99 ', 'OK'] Nov 9 22:40:31 om-gta02 user.debug 2008.11.09 22:40:31 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 19,99 ', 'OK']),{} Nov 9 22:40:31 om-gta02 user.debug 2008.11.09 22:40:31 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:31 om-gta02 user.debug 2008.11.09 22:40:31 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:31 om-gta02 user.debug 2008.11.09 22:40:31 ogsmd DEBUG : COMPLETED 'AT%CPI=3' => ['OK'] Nov 9 22:40:31 om-gta02 user.debug 2008.11.09 22:40:31 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:40:31 om-gta02 user.debug 2008.11.09 22:40:31 ogsmd DEBUG : sending 17 bytes: 'AT%CSCN=1,2,1,2\r\n' Nov 9 22:40:31 om-gta02 user.debug 2008.11.09 22:40:31 odeviced DEBUG (writing '57' to '/sys/class/backlight/pcf50633-bl/brightness') Nov 9 22:40:31 om-gta02 user.debug 2008.11.09 22:40:31 ogsmd DEBUG : got 22 bytes from: '\r\n+CSQ: 19,99 \r\n\r\nOK\r\n' Nov 9 22:40:31 om-gta02 user.debug 2008.11.09 22:40:31 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 19,99 ', 'OK'] Nov 9 22:40:31 om-gta02 user.debug 2008.11.09 22:40:31 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetSignalStrength.responseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 19,99 ', 'OK']),{} Nov 9 22:40:31 om-gta02 user.debug 2008.11.09 22:40:31 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetSignalStrength.responseFromChannel: LEAVE Nov 9 22:40:31 om-gta02 user.debug 2008.11.09 22:40:31 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__del__: ENTER (),{} Nov 9 22:40:31 om-gta02 user.debug 2008.11.09 22:40:31 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__del__: LEAVE Nov 9 22:40:31 om-gta02 user.debug 2008.11.09 22:40:31 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:31 om-gta02 user.debug 2008.11.09 22:40:31 ogsmd DEBUG : COMPLETED 'AT%CSCN=1,2,1,2' => ['OK'] Nov 9 22:40:31 om-gta02 user.debug 2008.11.09 22:40:31 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:40:31 om-gta02 user.info 2008.11.09 22:40:31 oeventsd INFO signal SetBrightness responded : () Nov 9 22:40:31 om-gta02 user.debug 2008.11.09 22:40:31 ogsmd DEBUG : sending 10 bytes: 'AT%CSQ=1\r\n' Nov 9 22:40:31 om-gta02 user.debug 2008.11.09 22:40:31 ogsmd DEBUG : got 22 bytes from: '\r\n+CSQ: 19,99 \r\n\r\nOK\r\n' Nov 9 22:40:31 om-gta02 user.debug 2008.11.09 22:40:31 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 19,99 ', 'OK'] Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 19,99 ', 'OK']),{} Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG : got 18 bytes from: '\r\n%CSQ: 1 \r\n\r\nOK\r\n' Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG : COMPLETED 'AT%CSQ=1' => ['%CSQ: 1 ', 'OK'] Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG : sending 11 bytes: 'AT%CNIV=1\r\n' Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG : got 22 bytes from: '\r\n+CSQ: 19,99 \r\n\r\nOK\r\n' Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 19,99 ', 'OK'] Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetSignalStrength.responseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 19,99 ', 'OK']),{} Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetSignalStrength.responseFromChannel: LEAVE Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__del__: ENTER (),{} Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__del__: LEAVE Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG : COMPLETED 'AT%CNIV=1' => ['OK'] Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG : sending 13 bytes: 'AT%CGEREP=1\r\n' Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG : got 22 bytes from: '\r\n+CSQ: 19,99 \r\n\r\nOK\r\n' Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 19,99 ', 'OK'] Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 19,99 ', 'OK']),{} Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG : COMPLETED 'AT%CGEREP=1' => ['OK'] Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG : sending 12 bytes: 'AT%CGREG=3\r\n' Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG : got 22 bytes from: '\r\n+CSQ: 19,99 \r\n\r\nOK\r\n' Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 19,99 ', 'OK'] Nov 9 22:40:32 om-gta02 user.debug 2008.11.09 22:40:32 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetSignalStrength.responseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 19,99 ', 'OK']),{} Nov 9 22:40:33 om-gta02 user.debug 2008.11.09 22:40:33 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetSignalStrength.responseFromChannel: LEAVE Nov 9 22:40:33 om-gta02 user.debug 2008.11.09 22:40:33 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__del__: ENTER (),{} Nov 9 22:40:33 om-gta02 user.debug 2008.11.09 22:40:33 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__del__: LEAVE Nov 9 22:40:33 om-gta02 user.debug 2008.11.09 22:40:33 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:33 om-gta02 user.debug 2008.11.09 22:40:33 ogsmd DEBUG : COMPLETED 'AT%CGREG=3' => ['OK'] Nov 9 22:40:33 om-gta02 user.debug 2008.11.09 22:40:33 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:40:33 om-gta02 user.debug 2008.11.09 22:40:33 ogsmd DEBUG : sending 12 bytes: 'AT%CSTAT=1\r\n' Nov 9 22:40:33 om-gta02 user.debug 2008.11.09 22:40:33 ogsmd DEBUG : got 22 bytes from: '\r\n+CSQ: 19,99 \r\n\r\nOK\r\n' Nov 9 22:40:33 om-gta02 user.debug 2008.11.09 22:40:33 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 19,99 ', 'OK'] Nov 9 22:40:33 om-gta02 user.debug 2008.11.09 22:40:33 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 19,99 ', 'OK']),{} Nov 9 22:40:33 om-gta02 user.debug 2008.11.09 22:40:33 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:33 om-gta02 user.debug 2008.11.09 22:40:33 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:33 om-gta02 user.debug 2008.11.09 22:40:33 ogsmd DEBUG : COMPLETED 'AT%CSTAT=1' => ['OK'] Nov 9 22:40:33 om-gta02 user.debug 2008.11.09 22:40:33 ogsmd DEBUG : sending 17 bytes: 'AT+CREG?;+COPS?\r\n' Nov 9 22:40:33 om-gta02 user.debug 2008.11.09 22:40:33 ogsmd DEBUG : sending 13 bytes: 'AT@ST="-26"\r\n' Nov 9 22:40:33 om-gta02 user.debug 2008.11.09 22:40:33 ogsmd DEBUG : got 14 bytes from: '\r\n+CREG: 0,1\r\n' Nov 9 22:40:33 om-gta02 user.debug 2008.11.09 22:40:33 ogsmd DEBUG : got 31 bytes from: '\r\n+COPS: 0,0,"SpeakOut"\r\n\r\nOK\r\n' Nov 9 22:40:33 om-gta02 user.debug 2008.11.09 22:40:33 ogsmd DEBUG : COMPLETED 'AT+CREG?;+COPS?' => ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK'] Nov 9 22:40:33 om-gta02 user.debug 2008.11.09 22:40:33 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CREG?;+COPS?', ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK']),{} Nov 9 22:40:33 om-gta02 user.debug 2008.11.09 22:40:33 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: ENTER (),{} Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: LEAVE Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG : COMPLETED 'AT@ST="-26"' => ['OK'] Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG : sending 10 bytes: 'AT%N028B\r\n' Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG : got 22 bytes from: '\r\n+CSQ: 19,99 \r\n\r\nOK\r\n' Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 19,99 ', 'OK'] Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetSignalStrength.responseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 19,99 ', 'OK']),{} Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetSignalStrength.responseFromChannel: LEAVE Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__del__: ENTER (),{} Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetSignalStrength.__del__: LEAVE Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG : got 42 bytes from: '\r\nEXT: I\r\nLong AEC -6 dB is active\r\n\r\nOK\r\n' Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG : COMPLETED 'AT%N028B' => ['EXT: I', 'Long AEC -6 dB is active', 'OK'] Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG : sending 10 bytes: 'AT%N0125\r\n' Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG : got 22 bytes from: '\r\n+CSQ: 19,99 \r\n\r\nOK\r\n' Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 19,99 ', 'OK'] Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 19,99 ', 'OK']),{} Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG : got 49 bytes from: '\r\nEXT: I\r\nNoise reduction -6 dB is active\r\n\r\nOK\r\n' Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG : COMPLETED 'AT%N0125' => ['EXT: I', 'Noise reduction -6 dB is active', 'OK'] Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG : sending 17 bytes: 'AT+CREG?;+COPS?\r\n' Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG : sending 12 bytes: 'AT%SLEEP=4\r\n' Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG : got 45 bytes from: '\r\n+CREG: 0,1\r\n\r\n+COPS: 0,0,"SpeakOut"\r\n\r\nOK\r\n' Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG : COMPLETED 'AT+CREG?;+COPS?' => ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK'] Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CREG?;+COPS?', ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK']),{} Nov 9 22:40:34 om-gta02 user.debug 2008.11.09 22:40:34 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:35 om-gta02 user.debug 2008.11.09 22:40:35 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: ENTER (),{} Nov 9 22:40:35 om-gta02 user.debug 2008.11.09 22:40:35 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: LEAVE Nov 9 22:40:35 om-gta02 user.debug 2008.11.09 22:40:35 ogsmd DEBUG : got 16 bytes from: '\r\nEXT: I\r\n\r\nOK\r\n' Nov 9 22:40:35 om-gta02 user.debug 2008.11.09 22:40:35 ogsmd DEBUG : COMPLETED 'AT%SLEEP=4' => ['EXT: I', 'OK'] Nov 9 22:40:35 om-gta02 user.debug 2008.11.09 22:40:35 ogsmd DEBUG : sending 11 bytes: 'AT+CFUN=1\r\n' Nov 9 22:40:35 om-gta02 user.debug 2008.11.09 22:40:35 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:35 om-gta02 user.debug 2008.11.09 22:40:35 ogsmd DEBUG : COMPLETED 'AT+CFUN=1' => ['OK'] Nov 9 22:40:35 om-gta02 user.debug 2008.11.09 22:40:35 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> DeviceSetAntennaPower.responseFromChannel: ENTER ('AT+CFUN=1', ['OK']),{} Nov 9 22:40:35 om-gta02 user.debug 2008.11.09 22:40:35 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> DeviceSetAntennaPower.responseFromChannel: LEAVE Nov 9 22:40:35 om-gta02 user.debug 2008.11.09 22:40:35 ogsmd DEBUG : sending 17 bytes: 'AT+CREG?;+COPS?\r\n' Nov 9 22:40:35 om-gta02 user.debug 2008.11.09 22:40:35 ogsmd DEBUG : got 14 bytes from: '\r\n+CREG: 0,1\r\n' Nov 9 22:40:35 om-gta02 user.debug 2008.11.09 22:40:35 ogsmd DEBUG : got 31 bytes from: '\r\n+COPS: 0,0,"SpeakOut"\r\n\r\nOK\r\n' Nov 9 22:40:35 om-gta02 user.debug 2008.11.09 22:40:35 ogsmd DEBUG : COMPLETED 'AT+CREG?;+COPS?' => ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK'] Nov 9 22:40:35 om-gta02 user.debug 2008.11.09 22:40:35 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CREG?;+COPS?', ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK']),{} Nov 9 22:40:35 om-gta02 user.debug 2008.11.09 22:40:35 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:35 om-gta02 user.debug 2008.11.09 22:40:35 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: ENTER (),{} Nov 9 22:40:35 om-gta02 user.debug 2008.11.09 22:40:35 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: LEAVE Nov 9 22:40:36 om-gta02 user.debug 2008.11.09 22:40:35 ogsmd DEBUG : sending 17 bytes: 'AT+CREG?;+COPS?\r\n' Nov 9 22:40:36 om-gta02 user.debug 2008.11.09 22:40:36 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkRegister.__init__: ENTER (, at 0x5ee0f0>, at Nov 9 22:40:36 om-gta02 user.debug 2008.11.09 22:40:36 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkRegister.__init__: LEAVE Nov 9 22:40:36 om-gta02 user.debug 2008.11.09 22:40:36 ogsmd DEBUG : got 45 bytes from: '\r\n+CREG: 0,1\r\n\r\n+COPS: 0,0,"SpeakOut"\r\n\r\nOK\r\n' Nov 9 22:40:36 om-gta02 user.debug 2008.11.09 22:40:36 ogsmd DEBUG : COMPLETED 'AT+CREG?;+COPS?' => ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK'] Nov 9 22:40:36 om-gta02 user.debug 2008.11.09 22:40:36 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CREG?;+COPS?', ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK']),{} Nov 9 22:40:36 om-gta02 user.debug 2008.11.09 22:40:36 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:36 om-gta02 user.debug 2008.11.09 22:40:36 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: ENTER (),{} Nov 9 22:40:36 om-gta02 user.debug 2008.11.09 22:40:36 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: LEAVE Nov 9 22:40:36 om-gta02 user.debug 2008.11.09 22:40:36 ogsmd DEBUG : sending 17 bytes: 'AT+CREG?;+COPS?\r\n' Nov 9 22:40:36 om-gta02 user.debug 2008.11.09 22:40:36 ogsmd DEBUG : got 14 bytes from: '\r\n+CREG: 0,1\r\n' Nov 9 22:40:36 om-gta02 user.debug 2008.11.09 22:40:36 ogsmd DEBUG : got 31 bytes from: '\r\n+COPS: 0,0,"SpeakOut"\r\n\r\nOK\r\n' Nov 9 22:40:36 om-gta02 user.debug 2008.11.09 22:40:36 ogsmd DEBUG : COMPLETED 'AT+CREG?;+COPS?' => ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK'] Nov 9 22:40:36 om-gta02 user.debug 2008.11.09 22:40:36 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CREG?;+COPS?', ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK']),{} Nov 9 22:40:36 om-gta02 user.debug 2008.11.09 22:40:36 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:36 om-gta02 user.debug 2008.11.09 22:40:36 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: ENTER (),{} Nov 9 22:40:36 om-gta02 user.debug 2008.11.09 22:40:36 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: LEAVE Nov 9 22:40:36 om-gta02 user.debug 2008.11.09 22:40:36 ogsmd DEBUG : sending 17 bytes: 'AT+CREG?;+COPS?\r\n' Nov 9 22:40:36 om-gta02 user.debug 2008.11.09 22:40:36 ogsmd DEBUG : got 14 bytes from: '\r\n+CREG: 0,1\r\n' Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG : got 31 bytes from: '\r\n+COPS: 0,0,"SpeakOut"\r\n\r\nOK\r\n' Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG : COMPLETED 'AT+CREG?;+COPS?' => ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK'] Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CREG?;+COPS?', ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK']),{} Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: ENTER (),{} Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: LEAVE Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG : sending 17 bytes: 'AT+CREG?;+COPS?\r\n' Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG : got 14 bytes from: '\r\n+CREG: 0,1\r\n' Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG : got 31 bytes from: '\r\n+COPS: 0,0,"SpeakOut"\r\n\r\nOK\r\n' Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG : COMPLETED 'AT+CREG?;+COPS?' => ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK'] Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CREG?;+COPS?', ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK']),{} Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: ENTER (),{} Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: LEAVE Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG : sending 17 bytes: 'AT+CREG?;+COPS?\r\n' Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG : got 14 bytes from: '\r\n+CREG: 0,1\r\n' Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG : got 31 bytes from: '\r\n+COPS: 0,0,"SpeakOut"\r\n\r\nOK\r\n' Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG : COMPLETED 'AT+CREG?;+COPS?' => ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK'] Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CREG?;+COPS?', ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK']),{} Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: ENTER (),{} Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: LEAVE Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG : sending 17 bytes: 'AT+CREG?;+COPS?\r\n' Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG : got 14 bytes from: '\r\n+CREG: 0,1\r\n' Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG : got 31 bytes from: '\r\n+COPS: 0,0,"SpeakOut"\r\n\r\nOK\r\n' Nov 9 22:40:37 om-gta02 user.debug 2008.11.09 22:40:37 ogsmd DEBUG : COMPLETED 'AT+CREG?;+COPS?' => ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK'] Nov 9 22:40:38 om-gta02 user.debug 2008.11.09 22:40:38 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CREG?;+COPS?', ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK']),{} Nov 9 22:40:38 om-gta02 user.debug 2008.11.09 22:40:38 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:38 om-gta02 user.debug 2008.11.09 22:40:38 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: ENTER (),{} Nov 9 22:40:38 om-gta02 user.debug 2008.11.09 22:40:38 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: LEAVE Nov 9 22:40:38 om-gta02 user.debug 2008.11.09 22:40:38 ogsmd DEBUG : sending 10 bytes: 'AT+CPIN?\r\n' Nov 9 22:40:38 om-gta02 user.debug 2008.11.09 22:40:38 ogsmd DEBUG : got 16 bytes from: '\r\n+CPIN: READY\r\n' Nov 9 22:40:38 om-gta02 user.debug 2008.11.09 22:40:38 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:38 om-gta02 user.debug 2008.11.09 22:40:38 ogsmd DEBUG : COMPLETED 'AT+CPIN?' => ['+CPIN: READY', 'OK'] Nov 9 22:40:38 om-gta02 user.debug 2008.11.09 22:40:38 ogsmd DEBUG |...|...|...|...|...|...|...|...> DeviceSetAntennaPower.__del__: ENTER (),{} Nov 9 22:40:38 om-gta02 user.debug 2008.11.09 22:40:38 ogsmd DEBUG |...|...|...|...|...|...|...|...> DeviceSetAntennaPower.__del__: LEAVE Nov 9 22:40:38 om-gta02 user.debug 2008.11.09 22:40:38 ogsmd DEBUG : sending 13 bytes: 'AT+COPS=0,0\r\n' Nov 9 22:40:38 om-gta02 user.debug 2008.11.09 22:40:38 ogsmd DEBUG : got 12 bytes from: '\r\n+CREG: 2\r\n' Nov 9 22:40:38 om-gta02 user.debug 2008.11.09 22:40:38 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: ENTER (, NetworkGetStatus.__init__: LEAVE Nov 9 22:40:39 om-gta02 user.debug 2008.11.09 22:40:39 ogsmd DEBUG : sending 19 bytes: 'AT+CNMI=2,1,2,1,1\r\n' Nov 9 22:40:39 om-gta02 user.debug 2008.11.09 22:40:39 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:39 om-gta02 user.debug 2008.11.09 22:40:39 ogsmd DEBUG : COMPLETED 'AT+CNMI=2,1,2,1,1' => ['OK'] Nov 9 22:40:40 om-gta02 user.info 2008.11.09 22:40:40 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to idle Nov 9 22:40:40 om-gta02 user.info 2008.11.09 22:40:40 oeventsd INFO Receive IdleState, status = idle Nov 9 22:40:40 om-gta02 user.debug 2008.11.09 22:40:40 oeventsd DEBUG trigger IdleState Nov 9 22:40:40 om-gta02 user.info 2008.11.09 22:40:40 oeventsd INFO Receive IdleState, status = idle Nov 9 22:40:40 om-gta02 user.debug 2008.11.09 22:40:40 oeventsd DEBUG trigger IdleState Nov 9 22:40:40 om-gta02 user.info 2008.11.09 22:40:40 oeventsd INFO Receive IdleState, status = idle Nov 9 22:40:40 om-gta02 user.debug 2008.11.09 22:40:40 oeventsd DEBUG trigger IdleState Nov 9 22:40:43 om-gta02 user.debug 2008.11.09 22:40:43 ogsmd DEBUG : got 26 bytes from: '\r\n+CREG: 1,"2774","D9C9"\r\n' Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: ENTER (, NetworkGetStatus.__init__: LEAVE Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG : COMPLETED 'AT+COPS=0,0' => ['OK'] Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkRegister.responseFromChannel: ENTER ('AT+COPS=0,0', ['OK']),{} Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkRegister.responseFromChannel: LEAVE Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkRegister.__del__: ENTER (),{} Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkRegister.__del__: LEAVE Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG : got 16 bytes from: '\r\n+CSQ: 19,99 \r\n' Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 19,99 ', 'OK'] Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 19,99 ', 'OK']),{} Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG : got 16 bytes from: '\r\n+CSQ: 19,99 \r\n' Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 19,99 ', 'OK'] Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 19,99 ', 'OK']),{} Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG : sending 17 bytes: 'AT+CREG?;+COPS?\r\n' Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG : got 14 bytes from: '\r\n+CREG: 0,1\r\n' Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG : got 31 bytes from: '\r\n+COPS: 0,0,"SpeakOut"\r\n\r\nOK\r\n' Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG : COMPLETED 'AT+CREG?;+COPS?' => ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK'] Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CREG?;+COPS?', ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK']),{} Nov 9 22:40:44 om-gta02 user.info 2008.11.09 22:40:44 ogsmd.objects INFO org.freesmartphone.GSM.Network.Status: {'strength': 86, 'cid': 'D9C9', 'registration': 'home', 'lac': '2774', 'mode': 'automatic', 'provider': 'SpeakOut'} Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: ENTER (),{} Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: LEAVE Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG : sending 17 bytes: 'AT+CREG?;+COPS?\r\n' Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG : got 45 bytes from: '\r\n+CREG: 0,1\r\n\r\n+COPS: 0,0,"SpeakOut"\r\n\r\nOK\r\n' Nov 9 22:40:44 om-gta02 user.debug 2008.11.09 22:40:44 ogsmd DEBUG : COMPLETED 'AT+CREG?;+COPS?' => ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK'] Nov 9 22:40:45 om-gta02 user.debug 2008.11.09 22:40:45 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CREG?;+COPS?', ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK']),{} Nov 9 22:40:45 om-gta02 user.info 2008.11.09 22:40:45 ogsmd.objects INFO org.freesmartphone.GSM.Network.Status: {'strength': 86, 'cid': 'D9C9', 'registration': 'home', 'lac': '2774', 'mode': 'automatic', 'provider': 'SpeakOut'} Nov 9 22:40:45 om-gta02 user.debug 2008.11.09 22:40:45 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:40:45 om-gta02 user.debug 2008.11.09 22:40:45 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: ENTER (),{} Nov 9 22:40:45 om-gta02 user.debug 2008.11.09 22:40:45 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: LEAVE Nov 9 22:40:45 om-gta02 user.info 2008.11.09 22:40:45 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to busy Nov 9 22:40:45 om-gta02 user.info 2008.11.09 22:40:45 oeventsd INFO Receive IdleState, status = busy Nov 9 22:40:45 om-gta02 user.debug 2008.11.09 22:40:45 oeventsd DEBUG trigger IdleState Nov 9 22:40:45 om-gta02 user.debug 2008.11.09 22:40:45 oeventsd DEBUG trigger on IdleState if status == busy then SetBrightness((90,)) Nov 9 22:40:45 om-gta02 user.info 2008.11.09 22:40:45 oeventsd INFO call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((90,)) Nov 9 22:40:45 om-gta02 user.info 2008.11.09 22:40:45 oeventsd INFO Receive IdleState, status = busy Nov 9 22:40:45 om-gta02 user.debug 2008.11.09 22:40:45 oeventsd DEBUG trigger IdleState Nov 9 22:40:45 om-gta02 user.info 2008.11.09 22:40:45 oeventsd INFO Receive IdleState, status = busy Nov 9 22:40:45 om-gta02 user.debug 2008.11.09 22:40:45 oeventsd DEBUG trigger IdleState Nov 9 22:40:46 om-gta02 user.info 2008.11.09 22:40:46 oeventsd INFO signal SetBrightness responded : () Nov 9 22:40:56 om-gta02 user.info 2008.11.09 22:40:56 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to idle Nov 9 22:40:56 om-gta02 user.info 2008.11.09 22:40:56 oeventsd INFO Receive IdleState, status = idle Nov 9 22:40:56 om-gta02 user.debug 2008.11.09 22:40:56 oeventsd DEBUG trigger IdleState Nov 9 22:40:56 om-gta02 user.info 2008.11.09 22:40:56 oeventsd INFO Receive IdleState, status = idle Nov 9 22:40:56 om-gta02 user.debug 2008.11.09 22:40:56 oeventsd DEBUG trigger IdleState Nov 9 22:40:56 om-gta02 user.info 2008.11.09 22:40:56 oeventsd INFO Receive IdleState, status = idle Nov 9 22:40:56 om-gta02 user.debug 2008.11.09 22:40:56 oeventsd DEBUG trigger IdleState Nov 9 22:41:00 om-gta02 user.debug 2008.11.09 22:41:00 otimed DEBUG Minute 22:41 Nov 9 22:41:01 om-gta02 user.debug 2008.11.09 22:41:01 frameworkd.controller DEBUG alive and kicking Nov 9 22:41:03 om-gta02 user.debug 2008.11.09 22:41:03 ogsmd DEBUG |...|...|...|...|...|...|...|...> SimRetrieveMessagebook.__init__: ENTER (, at 0x5ee0f0>, SimRetrieveMessagebook.__init__: LEAVE Nov 9 22:41:03 om-gta02 user.debug 2008.11.09 22:41:03 ogsmd DEBUG (: last communication with modem was 17 seconds ago. Sending EOF to wakeup) Nov 9 22:41:03 om-gta02 user.debug 2008.11.09 22:41:03 ogsmd DEBUG : sending 11 bytes: 'AT+CMGL=2\r\n' Nov 9 22:41:03 om-gta02 user.debug 2008.11.09 22:41:03 ogsmd DEBUG : got 19 bytes from: '\r\n+CMS ERROR: 321\r\n' Nov 9 22:41:03 om-gta02 user.debug 2008.11.09 22:41:03 ogsmd DEBUG : COMPLETED 'AT+CMGL=2' => ['+CMS ERROR: 321'] Nov 9 22:41:03 om-gta02 user.debug 2008.11.09 22:41:03 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> SimRetrieveMessagebook.responseFromChannel: ENTER ('AT+CMGL=2', ['+CMS ERROR: 321']),{} Nov 9 22:41:03 om-gta02 user.debug 2008.11.09 22:41:03 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> SimRetrieveMessagebook.responseFromChannel: LEAVE Nov 9 22:41:03 om-gta02 user.debug 2008.11.09 22:41:03 ogsmd DEBUG |...|...|...|...|...|...|...|...> SimRetrieveMessagebook.__del__: ENTER (),{} Nov 9 22:41:03 om-gta02 user.debug 2008.11.09 22:41:03 ogsmd DEBUG |...|...|...|...|...|...|...|...> SimRetrieveMessagebook.__del__: LEAVE Nov 9 22:41:13 om-gta02 user.info 2008.11.09 22:41:13 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to busy Nov 9 22:41:13 om-gta02 user.info 2008.11.09 22:41:13 oeventsd INFO Receive IdleState, status = busy Nov 9 22:41:13 om-gta02 user.debug 2008.11.09 22:41:13 oeventsd DEBUG trigger IdleState Nov 9 22:41:13 om-gta02 user.debug 2008.11.09 22:41:13 oeventsd DEBUG trigger on IdleState if status == busy then SetBrightness((90,)) Nov 9 22:41:13 om-gta02 user.info 2008.11.09 22:41:13 oeventsd INFO call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((90,)) Nov 9 22:41:14 om-gta02 user.info 2008.11.09 22:41:14 oeventsd INFO Receive IdleState, status = busy Nov 9 22:41:14 om-gta02 user.debug 2008.11.09 22:41:14 oeventsd DEBUG trigger IdleState Nov 9 22:41:14 om-gta02 user.info 2008.11.09 22:41:14 oeventsd INFO Receive IdleState, status = busy Nov 9 22:41:14 om-gta02 user.debug 2008.11.09 22:41:14 oeventsd DEBUG trigger IdleState Nov 9 22:41:14 om-gta02 user.info 2008.11.09 22:41:14 oeventsd INFO signal SetBrightness responded : () Nov 9 22:41:24 om-gta02 user.info 2008.11.09 22:41:24 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to idle Nov 9 22:41:24 om-gta02 user.info 2008.11.09 22:41:24 oeventsd INFO Receive IdleState, status = idle Nov 9 22:41:24 om-gta02 user.debug 2008.11.09 22:41:24 oeventsd DEBUG trigger IdleState Nov 9 22:41:24 om-gta02 user.info 2008.11.09 22:41:24 oeventsd INFO Receive IdleState, status = idle Nov 9 22:41:24 om-gta02 user.debug 2008.11.09 22:41:24 oeventsd DEBUG trigger IdleState Nov 9 22:41:24 om-gta02 user.info 2008.11.09 22:41:24 oeventsd INFO Receive IdleState, status = idle Nov 9 22:41:24 om-gta02 user.debug 2008.11.09 22:41:24 oeventsd DEBUG trigger IdleState Nov 9 22:41:35 om-gta02 user.info 2008.11.09 22:41:35 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to busy Nov 9 22:41:35 om-gta02 user.info 2008.11.09 22:41:35 oeventsd INFO Receive IdleState, status = busy Nov 9 22:41:35 om-gta02 user.debug 2008.11.09 22:41:35 oeventsd DEBUG trigger IdleState Nov 9 22:41:35 om-gta02 user.debug 2008.11.09 22:41:35 oeventsd DEBUG trigger on IdleState if status == busy then SetBrightness((90,)) Nov 9 22:41:35 om-gta02 user.info 2008.11.09 22:41:35 oeventsd INFO call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((90,)) Nov 9 22:41:35 om-gta02 user.info 2008.11.09 22:41:35 oeventsd INFO Receive IdleState, status = busy Nov 9 22:41:35 om-gta02 user.debug 2008.11.09 22:41:35 oeventsd DEBUG trigger IdleState Nov 9 22:41:35 om-gta02 user.info 2008.11.09 22:41:35 oeventsd INFO Receive IdleState, status = busy Nov 9 22:41:35 om-gta02 user.debug 2008.11.09 22:41:35 oeventsd DEBUG trigger IdleState Nov 9 22:41:35 om-gta02 user.info 2008.11.09 22:41:35 oeventsd INFO signal SetBrightness responded : () Nov 9 22:41:46 om-gta02 user.info 2008.11.09 22:41:46 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to idle Nov 9 22:41:46 om-gta02 user.info 2008.11.09 22:41:46 oeventsd INFO Receive IdleState, status = idle Nov 9 22:41:46 om-gta02 user.debug 2008.11.09 22:41:46 oeventsd DEBUG trigger IdleState Nov 9 22:41:46 om-gta02 user.info 2008.11.09 22:41:46 oeventsd INFO Receive IdleState, status = idle Nov 9 22:41:46 om-gta02 user.debug 2008.11.09 22:41:46 oeventsd DEBUG trigger IdleState Nov 9 22:41:46 om-gta02 user.info 2008.11.09 22:41:46 oeventsd INFO Receive IdleState, status = idle Nov 9 22:41:46 om-gta02 user.debug 2008.11.09 22:41:46 oeventsd DEBUG trigger IdleState Nov 9 22:41:51 om-gta02 user.debug 2008.11.09 22:41:51 frameworkd.controller DEBUG alive and kicking Nov 9 22:42:00 om-gta02 user.debug 2008.11.09 22:42:00 otimed DEBUG Minute 22:42 Nov 9 22:42:00 om-gta02 user.info 2008.11.09 22:42:00 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to busy Nov 9 22:42:00 om-gta02 user.info 2008.11.09 22:42:00 oeventsd INFO Receive IdleState, status = busy Nov 9 22:42:00 om-gta02 user.debug 2008.11.09 22:42:00 oeventsd DEBUG trigger IdleState Nov 9 22:42:00 om-gta02 user.debug 2008.11.09 22:42:00 oeventsd DEBUG trigger on IdleState if status == busy then SetBrightness((90,)) Nov 9 22:42:00 om-gta02 user.info 2008.11.09 22:42:00 oeventsd INFO call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((90,)) Nov 9 22:42:00 om-gta02 user.info 2008.11.09 22:42:00 oeventsd INFO Receive IdleState, status = busy Nov 9 22:42:00 om-gta02 user.debug 2008.11.09 22:42:00 oeventsd DEBUG trigger IdleState Nov 9 22:42:00 om-gta02 user.info 2008.11.09 22:42:00 oeventsd INFO Receive IdleState, status = busy Nov 9 22:42:00 om-gta02 user.debug 2008.11.09 22:42:00 oeventsd DEBUG trigger IdleState Nov 9 22:42:00 om-gta02 user.info 2008.11.09 22:42:00 oeventsd INFO signal SetBrightness responded : () Nov 9 22:42:03 om-gta02 user.debug 2008.11.09 22:42:03 ogsmd DEBUG |...|...|...|...|...|...|...|...> SimRetrieveMessagebook.__init__: ENTER (, at 0x5ee0f0>, SimRetrieveMessagebook.__init__: LEAVE Nov 9 22:42:03 om-gta02 user.debug 2008.11.09 22:42:03 ogsmd DEBUG (: last communication with modem was 59 seconds ago. Sending EOF to wakeup) Nov 9 22:42:03 om-gta02 user.debug 2008.11.09 22:42:03 ogsmd DEBUG : sending 11 bytes: 'AT+CMGL=2\r\n' Nov 9 22:42:03 om-gta02 user.debug 2008.11.09 22:42:03 ogsmd DEBUG : got 19 bytes from: '\r\n+CMS ERROR: 321\r\n' Nov 9 22:42:03 om-gta02 user.debug 2008.11.09 22:42:03 ogsmd DEBUG : COMPLETED 'AT+CMGL=2' => ['+CMS ERROR: 321'] Nov 9 22:42:03 om-gta02 user.debug 2008.11.09 22:42:03 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> SimRetrieveMessagebook.responseFromChannel: ENTER ('AT+CMGL=2', ['+CMS ERROR: 321']),{} Nov 9 22:42:03 om-gta02 user.debug 2008.11.09 22:42:03 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> SimRetrieveMessagebook.responseFromChannel: LEAVE Nov 9 22:42:03 om-gta02 user.debug 2008.11.09 22:42:03 ogsmd DEBUG |...|...|...|...|...|...|...|...> SimRetrieveMessagebook.__del__: ENTER (),{} Nov 9 22:42:03 om-gta02 user.debug 2008.11.09 22:42:03 ogsmd DEBUG |...|...|...|...|...|...|...|...> SimRetrieveMessagebook.__del__: LEAVE Nov 9 22:42:05 om-gta02 user.debug 2008.11.09 22:42:05 ogsmd DEBUG |...|...|...|...|...|...|...|...> CallInitiate.__init__: ENTER (, at 0x5ee0f0>, at 0x6 Nov 9 22:42:05 om-gta02 user.debug 2008.11.09 22:42:05 ogsmd DEBUG |...|...|...|...|...|...|...|...> CallInitiate.__init__: LEAVE Nov 9 22:42:05 om-gta02 user.warn 2008.11.09 22:42:05 ogsmd WARNING : Got unicode input. Trying to convert to plain string... Nov 9 22:42:05 om-gta02 user.debug 2008.11.09 22:42:05 ogsmd DEBUG |...|...|...|...|...|...|...> CallInitiate.__del__: ENTER (),{} Nov 9 22:42:05 om-gta02 user.debug 2008.11.09 22:42:05 ogsmd DEBUG |...|...|...|...|...|...|...> CallInitiate.__del__: LEAVE Nov 9 22:42:05 om-gta02 user.debug 2008.11.09 22:42:05 ogsmd DEBUG : sending 9 bytes: 'ATD611;\r\n' Nov 9 22:42:07 om-gta02 user.debug 2008.11.09 22:42:07 ogsmd DEBUG : got 35 bytes from: '\r\n%CPI: 1,3,0,0,0,0,"611",129,,,0\r\n' Nov 9 22:42:08 om-gta02 user.debug 2008.11.09 22:42:08 ogsmd DEBUG : got 35 bytes from: '\r\n%CPI: 1,4,0,1,0,0,"611",129,,,0\r\n' Nov 9 22:42:10 om-gta02 user.info 2008.11.09 22:42:10 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to idle Nov 9 22:42:10 om-gta02 user.info 2008.11.09 22:42:10 oeventsd INFO Receive IdleState, status = idle Nov 9 22:42:10 om-gta02 user.debug 2008.11.09 22:42:10 oeventsd DEBUG trigger IdleState Nov 9 22:42:10 om-gta02 user.info 2008.11.09 22:42:10 oeventsd INFO Receive IdleState, status = idle Nov 9 22:42:10 om-gta02 user.debug 2008.11.09 22:42:10 oeventsd DEBUG trigger IdleState Nov 9 22:42:10 om-gta02 user.info 2008.11.09 22:42:10 oeventsd INFO Receive IdleState, status = idle Nov 9 22:42:10 om-gta02 user.debug 2008.11.09 22:42:10 oeventsd DEBUG trigger IdleState Nov 9 22:42:10 om-gta02 user.debug 2008.11.09 22:42:10 ogsmd DEBUG : got 35 bytes from: '\r\n%CPI: 1,5,1,1,0,0,"611",129,,,0\r\n' Nov 9 22:42:11 om-gta02 user.debug 2008.11.09 22:42:11 ogsmd DEBUG : got 35 bytes from: '\r\n%CPI: 1,6,1,1,0,0,"611",129,,,0\r\n' Nov 9 22:42:11 om-gta02 user.info 2008.11.09 22:42:11 ogsmd.objects INFO org.freesmartphone.GSM.Call.CallStatus: 1 active {'status': 'active', 'peer': '611', 'line': 0} Nov 9 22:42:11 om-gta02 user.debug 2008.11.09 22:42:11 ogsmd DEBUG : got 23 bytes from: '\r\n+COLP: "",128\r\n\r\nOK\r\n' Nov 9 22:42:11 om-gta02 user.debug 2008.11.09 22:42:11 ogsmd DEBUG : COMPLETED 'ATD611;' => ['+COLP: "",128', 'OK'] Nov 9 22:42:11 om-gta02 user.info 2008.11.09 22:42:11 oeventsd INFO Receive CallStatus, status = active Nov 9 22:42:11 om-gta02 user.debug 2008.11.09 22:42:11 oeventsd DEBUG trigger CallStatus Nov 9 22:42:11 om-gta02 user.debug 2008.11.09 22:42:11 oeventsd DEBUG Trigger CallListContains(incoming) Nov 9 22:42:11 om-gta02 user.info 2008.11.09 22:42:11 oeventsd INFO Receive CallStatus, status = active Nov 9 22:42:11 om-gta02 user.debug 2008.11.09 22:42:11 oeventsd DEBUG trigger CallStatus Nov 9 22:42:11 om-gta02 user.debug 2008.11.09 22:42:11 oeventsd DEBUG trigger While CallStatus if Or(status == outgoing,status == active) then SetScenario(gsmhandset) Nov 9 22:42:11 om-gta02 user.info 2008.11.09 22:42:11 oeventsd INFO Set Audio Scenario gsmhandset Nov 9 22:42:11 om-gta02 user.info 2008.11.09 22:42:11 oeventsd INFO call dbus signal /org/freesmartphone/Device/Audio SetScenario(('gsmhandset',)) Nov 9 22:42:13 om-gta02 user.info 2008.11.09 22:42:13 odeviced.audio INFO sound scenario gsmhandset user Nov 9 22:42:13 om-gta02 user.info 2008.11.09 22:42:13 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to busy Nov 9 22:42:13 om-gta02 user.debug 2008.11.09 22:42:13 mppl.asyncworker DEBUG no elements in queue: starting idle task. Nov 9 22:42:13 om-gta02 user.info 2008.11.09 22:42:13 oeventsd INFO signal SetScenario responded : () Nov 9 22:42:13 om-gta02 user.info 2008.11.09 22:42:13 oeventsd INFO Receive IdleState, status = busy Nov 9 22:42:13 om-gta02 user.debug 2008.11.09 22:42:13 oeventsd DEBUG trigger IdleState Nov 9 22:42:13 om-gta02 user.debug 2008.11.09 22:42:13 oeventsd DEBUG trigger on IdleState if status == busy then SetBrightness((90,)) Nov 9 22:42:13 om-gta02 user.info 2008.11.09 22:42:13 oeventsd INFO call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((90,)) Nov 9 22:42:13 om-gta02 user.info 2008.11.09 22:42:13 oeventsd INFO Receive IdleState, status = busy Nov 9 22:42:13 om-gta02 user.debug 2008.11.09 22:42:13 oeventsd DEBUG trigger IdleState Nov 9 22:42:13 om-gta02 user.info 2008.11.09 22:42:13 oeventsd INFO Receive IdleState, status = busy Nov 9 22:42:13 om-gta02 user.debug 2008.11.09 22:42:13 oeventsd DEBUG trigger IdleState Nov 9 22:42:13 om-gta02 user.info 2008.11.09 22:42:13 oeventsd INFO signal SetBrightness responded : () Nov 9 22:42:13 om-gta02 user.debug 2008.11.09 22:42:13 mppl.asyncworker DEBUG _processElement() Nov 9 22:42:13 om-gta02 user.debug 2008.11.09 22:42:13 mppl.asyncworker DEBUG got an element from the queue Nov 9 22:42:13 om-gta02 user.debug 2008.11.09 22:42:13 mppl.asyncworker DEBUG _processElement() Nov 9 22:42:13 om-gta02 user.debug 2008.11.09 22:42:13 mppl.asyncworker DEBUG no more elements: stopping idle task. Nov 9 22:42:13 om-gta02 user.debug 2008.11.09 22:42:13 odeviced.idlenotifier DEBUG state already active. ignoring request Nov 9 22:42:16 om-gta02 user.debug 2008.11.09 22:42:16 ogsmd DEBUG : got 20 bytes from: '\r\n%CSQ: 13, 99, 1\r\n' Nov 9 22:42:16 om-gta02 user.info 2008.11.09 22:42:16 ogsmd.objects INFO org.freesmartphone.GSM.Network.SignalStrength: 75 Nov 9 22:42:23 om-gta02 user.info 2008.11.09 22:42:23 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to idle Nov 9 22:42:23 om-gta02 user.info 2008.11.09 22:42:23 oeventsd INFO Receive IdleState, status = idle Nov 9 22:42:23 om-gta02 user.debug 2008.11.09 22:42:23 oeventsd DEBUG trigger IdleState Nov 9 22:42:23 om-gta02 user.info 2008.11.09 22:42:23 oeventsd INFO Receive IdleState, status = idle Nov 9 22:42:23 om-gta02 user.debug 2008.11.09 22:42:23 oeventsd DEBUG trigger IdleState Nov 9 22:42:23 om-gta02 user.info 2008.11.09 22:42:23 oeventsd INFO Receive IdleState, status = idle Nov 9 22:42:23 om-gta02 user.debug 2008.11.09 22:42:23 oeventsd DEBUG trigger IdleState Nov 9 22:42:26 om-gta02 user.debug 2008.11.09 22:42:26 ogsmd DEBUG : got 19 bytes from: '\r\n%CSQ: 8, 99, 0\r\n' Nov 9 22:42:26 om-gta02 user.info 2008.11.09 22:42:26 ogsmd.objects INFO org.freesmartphone.GSM.Network.SignalStrength: 61 Nov 9 22:42:35 om-gta02 user.debug 2008.11.09 22:42:35 ogsmd DEBUG : got 20 bytes from: '\r\n%CSQ: 11, 99, 1\r\n' Nov 9 22:42:35 om-gta02 user.info 2008.11.09 22:42:35 ogsmd.objects INFO org.freesmartphone.GSM.Network.SignalStrength: 70 Nov 9 22:42:36 om-gta02 user.info 2008.11.09 22:42:36 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to busy Nov 9 22:42:36 om-gta02 user.info 2008.11.09 22:42:36 oeventsd INFO Receive IdleState, status = busy Nov 9 22:42:36 om-gta02 user.debug 2008.11.09 22:42:36 oeventsd DEBUG trigger IdleState Nov 9 22:42:36 om-gta02 user.debug 2008.11.09 22:42:36 oeventsd DEBUG trigger on IdleState if status == busy then SetBrightness((90,)) Nov 9 22:42:36 om-gta02 user.info 2008.11.09 22:42:36 oeventsd INFO call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((90,)) Nov 9 22:42:36 om-gta02 user.info 2008.11.09 22:42:36 oeventsd INFO Receive IdleState, status = busy Nov 9 22:42:36 om-gta02 user.debug 2008.11.09 22:42:36 oeventsd DEBUG trigger IdleState Nov 9 22:42:36 om-gta02 user.info 2008.11.09 22:42:36 oeventsd INFO Receive IdleState, status = busy Nov 9 22:42:36 om-gta02 user.debug 2008.11.09 22:42:36 oeventsd DEBUG trigger IdleState Nov 9 22:42:37 om-gta02 user.info 2008.11.09 22:42:37 oeventsd INFO signal SetBrightness responded : () Nov 9 22:42:41 om-gta02 user.debug 2008.11.09 22:42:41 frameworkd.controller DEBUG alive and kicking Nov 9 22:42:47 om-gta02 user.info 2008.11.09 22:42:47 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to idle Nov 9 22:42:47 om-gta02 user.info 2008.11.09 22:42:47 oeventsd INFO Receive IdleState, status = idle Nov 9 22:42:47 om-gta02 user.debug 2008.11.09 22:42:47 oeventsd DEBUG trigger IdleState Nov 9 22:42:47 om-gta02 user.info 2008.11.09 22:42:47 oeventsd INFO Receive IdleState, status = idle Nov 9 22:42:47 om-gta02 user.debug 2008.11.09 22:42:47 oeventsd DEBUG trigger IdleState Nov 9 22:42:47 om-gta02 user.info 2008.11.09 22:42:47 oeventsd INFO Receive IdleState, status = idle Nov 9 22:42:47 om-gta02 user.debug 2008.11.09 22:42:47 oeventsd DEBUG trigger IdleState Nov 9 22:42:47 om-gta02 user.info 2008.11.09 22:42:47 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to busy Nov 9 22:42:47 om-gta02 user.info 2008.11.09 22:42:47 oeventsd INFO Receive IdleState, status = busy Nov 9 22:42:47 om-gta02 user.debug 2008.11.09 22:42:47 oeventsd DEBUG trigger IdleState Nov 9 22:42:47 om-gta02 user.debug 2008.11.09 22:42:47 oeventsd DEBUG trigger on IdleState if status == busy then SetBrightness((90,)) Nov 9 22:42:47 om-gta02 user.info 2008.11.09 22:42:47 oeventsd INFO call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((90,)) Nov 9 22:42:47 om-gta02 user.info 2008.11.09 22:42:47 oeventsd INFO Receive IdleState, status = busy Nov 9 22:42:47 om-gta02 user.debug 2008.11.09 22:42:47 oeventsd DEBUG trigger IdleState Nov 9 22:42:47 om-gta02 user.info 2008.11.09 22:42:47 oeventsd INFO Receive IdleState, status = busy Nov 9 22:42:47 om-gta02 user.debug 2008.11.09 22:42:47 oeventsd DEBUG trigger IdleState Nov 9 22:42:47 om-gta02 user.debug 2008.11.09 22:42:47 ogsmd DEBUG |...|...|...|...|...|...|...|...> CallRelease.__init__: ENTER (, at 0x5ee0f0>, at 0x6f Nov 9 22:42:47 om-gta02 user.debug 2008.11.09 22:42:47 ogsmd DEBUG |...|...|...|...|...|...|...|...> CallRelease.__init__: LEAVE Nov 9 22:42:47 om-gta02 user.debug 2008.11.09 22:42:47 ogsmd DEBUG |...|...|...|...|...|...|...> CallRelease.__del__: ENTER (),{} Nov 9 22:42:47 om-gta02 user.debug 2008.11.09 22:42:47 ogsmd DEBUG |...|...|...|...|...|...|...> CallRelease.__del__: LEAVE Nov 9 22:42:47 om-gta02 user.debug 2008.11.09 22:42:47 ogsmd DEBUG (: last communication with modem was 12 seconds ago. Sending EOF to wakeup) Nov 9 22:42:48 om-gta02 user.debug 2008.11.09 22:42:48 ogsmd DEBUG : sending 5 bytes: 'ATH\r\n' Nov 9 22:42:48 om-gta02 user.info 2008.11.09 22:42:48 oeventsd INFO signal SetBrightness responded : () Nov 9 22:42:48 om-gta02 user.debug 2008.11.09 22:42:48 ogsmd DEBUG : got 37 bytes from: '\r\n%CPI: 1,1,1,0,0,0,"611",129,,16,0\r\n' Nov 9 22:42:48 om-gta02 user.info 2008.11.09 22:42:48 ogsmd.objects INFO org.freesmartphone.GSM.Call.CallStatus: 1 release {'status': 'release'} Nov 9 22:42:48 om-gta02 user.debug 2008.11.09 22:42:48 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:42:48 om-gta02 user.debug 2008.11.09 22:42:48 ogsmd DEBUG : COMPLETED 'ATH' => ['OK'] Nov 9 22:42:48 om-gta02 user.debug 2008.11.09 22:42:48 ogsmd DEBUG : got 37 bytes from: '\r\n%CPI: 1,7,1,0,0,0,"611",129,,16,0\r\n' Nov 9 22:42:48 om-gta02 user.info 2008.11.09 22:42:48 oeventsd INFO Receive CallStatus, status = release Nov 9 22:42:48 om-gta02 user.debug 2008.11.09 22:42:48 oeventsd DEBUG trigger CallStatus Nov 9 22:42:48 om-gta02 user.debug 2008.11.09 22:42:48 oeventsd DEBUG Trigger CallListContains(incoming) Nov 9 22:42:48 om-gta02 user.info 2008.11.09 22:42:48 oeventsd INFO Receive CallStatus, status = release Nov 9 22:42:48 om-gta02 user.debug 2008.11.09 22:42:48 oeventsd DEBUG trigger CallStatus Nov 9 22:42:48 om-gta02 user.debug 2008.11.09 22:42:48 oeventsd DEBUG untrigger While CallStatus if Or(status == outgoing,status == active) then SetScenario(gsmhandset) Nov 9 22:42:48 om-gta02 user.info 2008.11.09 22:42:48 oeventsd INFO Revert Audio Scenario to stereoout Nov 9 22:42:48 om-gta02 user.info 2008.11.09 22:42:48 oeventsd INFO call dbus signal /org/freesmartphone/Device/Audio SetScenario(('stereoout',)) Nov 9 22:42:49 om-gta02 user.info 2008.11.09 22:42:49 odeviced.audio INFO sound scenario stereoout user Nov 9 22:42:49 om-gta02 user.debug 2008.11.09 22:42:49 mppl.asyncworker DEBUG no elements in queue: starting idle task. Nov 9 22:42:49 om-gta02 user.debug 2008.11.09 22:42:49 odeviced.idlenotifier DEBUG state already active. ignoring request Nov 9 22:42:49 om-gta02 user.info 2008.11.09 22:42:49 oeventsd INFO signal SetScenario responded : () Nov 9 22:42:49 om-gta02 user.debug 2008.11.09 22:42:49 mppl.asyncworker DEBUG _processElement() Nov 9 22:42:49 om-gta02 user.debug 2008.11.09 22:42:49 mppl.asyncworker DEBUG got an element from the queue Nov 9 22:42:49 om-gta02 user.debug 2008.11.09 22:42:49 mppl.asyncworker DEBUG _processElement() Nov 9 22:42:49 om-gta02 user.debug 2008.11.09 22:42:49 mppl.asyncworker DEBUG no more elements: stopping idle task. Nov 9 22:42:50 om-gta02 user.debug 2008.11.09 22:42:50 ogsmd DEBUG : got 26 bytes from: '\r\n+CREG: 1,"2774","D9CF"\r\n' Nov 9 22:42:50 om-gta02 user.debug 2008.11.09 22:42:50 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: ENTER (, NetworkGetStatus.__init__: LEAVE Nov 9 22:42:50 om-gta02 user.debug 2008.11.09 22:42:50 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:42:50 om-gta02 user.debug 2008.11.09 22:42:50 ogsmd DEBUG : got 22 bytes from: '\r\n+CSQ: 14,99 \r\n\r\nOK\r\n' Nov 9 22:42:50 om-gta02 user.debug 2008.11.09 22:42:50 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 14,99 ', 'OK'] Nov 9 22:42:50 om-gta02 user.debug 2008.11.09 22:42:50 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 14,99 ', 'OK']),{} Nov 9 22:42:50 om-gta02 user.debug 2008.11.09 22:42:50 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:42:50 om-gta02 user.debug 2008.11.09 22:42:50 ogsmd DEBUG : sending 17 bytes: 'AT+CREG?;+COPS?\r\n' Nov 9 22:42:50 om-gta02 user.debug 2008.11.09 22:42:50 ogsmd DEBUG : got 14 bytes from: '\r\n+CREG: 0,1\r\n' Nov 9 22:42:50 om-gta02 user.debug 2008.11.09 22:42:50 ogsmd DEBUG : got 31 bytes from: '\r\n+COPS: 0,0,"SpeakOut"\r\n\r\nOK\r\n' Nov 9 22:42:50 om-gta02 user.debug 2008.11.09 22:42:50 ogsmd DEBUG : COMPLETED 'AT+CREG?;+COPS?' => ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK'] Nov 9 22:42:50 om-gta02 user.debug 2008.11.09 22:42:50 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CREG?;+COPS?', ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK']),{} Nov 9 22:42:50 om-gta02 user.info 2008.11.09 22:42:50 ogsmd.objects INFO org.freesmartphone.GSM.Network.Status: {'strength': 77, 'cid': 'D9CF', 'registration': 'home', 'lac': '2774', 'mode': 'automatic', 'provider': 'SpeakOut'} Nov 9 22:42:50 om-gta02 user.debug 2008.11.09 22:42:50 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:42:50 om-gta02 user.debug 2008.11.09 22:42:50 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: ENTER (),{} Nov 9 22:42:50 om-gta02 user.debug 2008.11.09 22:42:50 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: LEAVE Nov 9 22:42:58 om-gta02 user.info 2008.11.09 22:42:58 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to idle Nov 9 22:42:58 om-gta02 user.info 2008.11.09 22:42:58 oeventsd INFO Receive IdleState, status = idle Nov 9 22:42:58 om-gta02 user.debug 2008.11.09 22:42:58 oeventsd DEBUG trigger IdleState Nov 9 22:42:58 om-gta02 user.info 2008.11.09 22:42:58 oeventsd INFO Receive IdleState, status = idle Nov 9 22:42:58 om-gta02 user.debug 2008.11.09 22:42:58 oeventsd DEBUG trigger IdleState Nov 9 22:42:58 om-gta02 user.info 2008.11.09 22:42:58 oeventsd INFO Receive IdleState, status = idle Nov 9 22:42:58 om-gta02 user.debug 2008.11.09 22:42:58 oeventsd DEBUG trigger IdleState Nov 9 22:43:00 om-gta02 user.debug 2008.11.09 22:43:00 otimed DEBUG Minute 22:43 Nov 9 22:43:03 om-gta02 user.debug 2008.11.09 22:43:03 ogsmd DEBUG |...|...|...|...|...|...|...|...> SimRetrieveMessagebook.__init__: ENTER (, at 0x5ee0f0>, SimRetrieveMessagebook.__init__: LEAVE Nov 9 22:43:03 om-gta02 user.debug 2008.11.09 22:43:03 ogsmd DEBUG (: last communication with modem was 12 seconds ago. Sending EOF to wakeup) Nov 9 22:43:03 om-gta02 user.debug 2008.11.09 22:43:03 ogsmd DEBUG : sending 11 bytes: 'AT+CMGL=2\r\n' Nov 9 22:43:03 om-gta02 user.debug 2008.11.09 22:43:03 ogsmd DEBUG : got 19 bytes from: '\r\n+CMS ERROR: 321\r\n' Nov 9 22:43:03 om-gta02 user.debug 2008.11.09 22:43:03 ogsmd DEBUG : COMPLETED 'AT+CMGL=2' => ['+CMS ERROR: 321'] Nov 9 22:43:03 om-gta02 user.debug 2008.11.09 22:43:03 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> SimRetrieveMessagebook.responseFromChannel: ENTER ('AT+CMGL=2', ['+CMS ERROR: 321']),{} Nov 9 22:43:03 om-gta02 user.debug 2008.11.09 22:43:03 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> SimRetrieveMessagebook.responseFromChannel: LEAVE Nov 9 22:43:03 om-gta02 user.debug 2008.11.09 22:43:03 ogsmd DEBUG |...|...|...|...|...|...|...|...> SimRetrieveMessagebook.__del__: ENTER (),{} Nov 9 22:43:03 om-gta02 user.debug 2008.11.09 22:43:03 ogsmd DEBUG |...|...|...|...|...|...|...|...> SimRetrieveMessagebook.__del__: LEAVE Nov 9 22:43:04 om-gta02 user.info 2008.11.09 22:43:04 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to busy Nov 9 22:43:04 om-gta02 user.info 2008.11.09 22:43:04 oeventsd INFO Receive IdleState, status = busy Nov 9 22:43:04 om-gta02 user.debug 2008.11.09 22:43:04 oeventsd DEBUG trigger IdleState Nov 9 22:43:04 om-gta02 user.debug 2008.11.09 22:43:04 oeventsd DEBUG trigger on IdleState if status == busy then SetBrightness((90,)) Nov 9 22:43:04 om-gta02 user.info 2008.11.09 22:43:04 oeventsd INFO call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((90,)) Nov 9 22:43:04 om-gta02 user.info 2008.11.09 22:43:04 oeventsd INFO Receive IdleState, status = busy Nov 9 22:43:04 om-gta02 user.debug 2008.11.09 22:43:04 oeventsd DEBUG trigger IdleState Nov 9 22:43:04 om-gta02 user.info 2008.11.09 22:43:04 oeventsd INFO Receive IdleState, status = busy Nov 9 22:43:04 om-gta02 user.debug 2008.11.09 22:43:04 oeventsd DEBUG trigger IdleState Nov 9 22:43:04 om-gta02 user.info 2008.11.09 22:43:04 oeventsd INFO signal SetBrightness responded : () Nov 9 22:43:07 om-gta02 user.debug 2008.11.09 22:43:07 ogsmd DEBUG : got 26 bytes from: '\r\n+CREG: 1,"2774","D9C9"\r\n' Nov 9 22:43:07 om-gta02 user.debug 2008.11.09 22:43:07 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.__init__: ENTER (, NetworkGetStatus.__init__: LEAVE Nov 9 22:43:07 om-gta02 user.debug 2008.11.09 22:43:07 ogsmd DEBUG : sending 8 bytes: 'AT+CSQ\r\n' Nov 9 22:43:07 om-gta02 user.debug 2008.11.09 22:43:07 ogsmd DEBUG : got 16 bytes from: '\r\n+CSQ: 10,99 \r\n' Nov 9 22:43:07 om-gta02 user.debug 2008.11.09 22:43:07 ogsmd DEBUG : got 6 bytes from: '\r\nOK\r\n' Nov 9 22:43:07 om-gta02 user.debug 2008.11.09 22:43:07 ogsmd DEBUG : COMPLETED 'AT+CSQ' => ['+CSQ: 10,99 ', 'OK'] Nov 9 22:43:07 om-gta02 user.debug 2008.11.09 22:43:07 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CSQ', ['+CSQ: 10,99 ', 'OK']),{} Nov 9 22:43:07 om-gta02 user.debug 2008.11.09 22:43:07 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:43:07 om-gta02 user.debug 2008.11.09 22:43:07 ogsmd DEBUG : sending 17 bytes: 'AT+CREG?;+COPS?\r\n' Nov 9 22:43:07 om-gta02 user.debug 2008.11.09 22:43:07 ogsmd DEBUG : got 14 bytes from: '\r\n+CREG: 0,1\r\n' Nov 9 22:43:07 om-gta02 user.debug 2008.11.09 22:43:07 ogsmd DEBUG : got 31 bytes from: '\r\n+COPS: 0,0,"SpeakOut"\r\n\r\nOK\r\n' Nov 9 22:43:07 om-gta02 user.debug 2008.11.09 22:43:07 ogsmd DEBUG : COMPLETED 'AT+CREG?;+COPS?' => ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK'] Nov 9 22:43:07 om-gta02 user.debug 2008.11.09 22:43:07 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: ENTER ('AT+CREG?;+COPS?', ['+CREG: 0,1', '+COPS: 0,0,"SpeakOut"', 'OK']),{} Nov 9 22:43:07 om-gta02 user.info 2008.11.09 22:43:07 ogsmd.objects INFO org.freesmartphone.GSM.Network.Status: {'strength': 67, 'cid': 'D9C9', 'registration': 'home', 'lac': '2774', 'mode': 'automatic', 'provider': 'SpeakOut'} Nov 9 22:43:07 om-gta02 user.debug 2008.11.09 22:43:07 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> NetworkGetStatus.genResponseFromChannel: LEAVE Nov 9 22:43:07 om-gta02 user.debug 2008.11.09 22:43:07 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: ENTER (),{} Nov 9 22:43:07 om-gta02 user.debug 2008.11.09 22:43:07 ogsmd DEBUG |...|...|...|...|...|...|...|...> NetworkGetStatus.__del__: LEAVE Nov 9 22:43:12 om-gta02 user.debug 2008.11.09 22:43:12 mppl.asyncworker DEBUG no elements in queue: starting idle task. Nov 9 22:43:12 om-gta02 user.debug 2008.11.09 22:43:12 mppl.asyncworker DEBUG _processElement() Nov 9 22:43:12 om-gta02 user.debug 2008.11.09 22:43:12 mppl.asyncworker DEBUG got an element from the queue Nov 9 22:43:12 om-gta02 user.info 2008.11.09 22:43:12 odeviced.input INFO name USB released 0 Nov 9 22:43:12 om-gta02 user.warn 2008.11.09 22:43:12 odeviced.input WARNING potential logic problem, key released before pressed. watches are {(5, 2): 'HEADSET', (1, 169): 'AUX', (1, 356): 'USB', (1, 116): 'POWER'} events are {} Nov 9 22:43:12 om-gta02 user.debug 2008.11.09 22:43:12 oeventsd DEBUG InputTrigger triggered Nov 9 22:43:12 om-gta02 user.debug 2008.11.09 22:43:12 oeventsd DEBUG trigger InputTrigger Nov 9 22:43:12 om-gta02 user.debug 2008.11.09 22:43:12 oeventsd DEBUG InputTrigger triggered Nov 9 22:43:12 om-gta02 user.debug 2008.11.09 22:43:12 oeventsd DEBUG trigger InputTrigger Nov 9 22:43:12 om-gta02 user.debug 2008.11.09 22:43:12 mppl.asyncworker DEBUG _processElement() Nov 9 22:43:12 om-gta02 user.debug 2008.11.09 22:43:12 mppl.asyncworker DEBUG no more elements: stopping idle task. Nov 9 22:43:13 om-gta02 user.debug 2008.11.09 22:43:13 odeviced.kernel26 DEBUG got data from uevent socket: 'change@/devices/platform/bq27000-battery.0/power_supply/bat\x00ACTION=change\x00DEVPATH=/devices/platform/bq27000-battery.0/power_supply/bat\x00SUBSYSTEM=power_supply\x00POWE Nov 9 22:43:13 om-gta02 user.debug 2008.11.09 22:43:13 odeviced DEBUG (read '1' from '/sys/class/power_supply/bat/present') Nov 9 22:43:13 om-gta02 user.debug 2008.11.09 22:43:13 odeviced.kernel26 DEBUG got property change from uevent socket: {'SUBSYSTEM': 'power_supply', 'POWER_SUPPLY_NAME': 'bat', 'POWER_SUPPLY_TIME_TO_FULL_NOW': '0', 'POWER_SUPPLY_TYPE': 'Battery', 'SEQNUM': '540', 'DEVPATH': '/device Nov 9 22:43:13 om-gta02 user.info 2008.11.09 22:43:13 odeviced.kernel26 INFO power status now discharging Nov 9 22:43:13 om-gta02 user.info 2008.11.09 22:43:13 oeventsd INFO Receive PowerStatus, status = discharging Nov 9 22:43:13 om-gta02 user.debug 2008.11.09 22:43:13 oeventsd DEBUG trigger PowerStatus Nov 9 22:43:13 om-gta02 user.debug 2008.11.09 22:43:13 oeventsd DEBUG untrigger While PowerStatus if status == charging then SetLed(gta02_power_orange, light) Nov 9 22:43:13 om-gta02 user.info 2008.11.09 22:43:13 oeventsd INFO call dbus signal /org/freesmartphone/Device/LED/gta02_power_orange SetBrightness((0,)) Nov 9 22:43:13 om-gta02 user.info 2008.11.09 22:43:13 oeventsd INFO Receive PowerStatus, status = discharging Nov 9 22:43:13 om-gta02 user.debug 2008.11.09 22:43:13 oeventsd DEBUG trigger PowerStatus Nov 9 22:43:13 om-gta02 user.info 2008.11.09 22:43:13 oeventsd INFO Receive PowerStatus, status = discharging Nov 9 22:43:13 om-gta02 user.debug 2008.11.09 22:43:13 oeventsd DEBUG trigger PowerStatus Nov 9 22:43:13 om-gta02 user.info 2008.11.09 22:43:13 oeventsd INFO Receive PowerStatus, status = discharging Nov 9 22:43:13 om-gta02 user.debug 2008.11.09 22:43:13 oeventsd DEBUG trigger PowerStatus Nov 9 22:43:13 om-gta02 user.debug 2008.11.09 22:43:13 odeviced DEBUG (writing 'none' to '/sys/class/leds/gta02-power:orange/trigger') Nov 9 22:43:13 om-gta02 user.debug 2008.11.09 22:43:13 odeviced DEBUG (writing '0' to '/sys/class/leds/gta02-power:orange/brightness') Nov 9 22:43:13 om-gta02 user.info 2008.11.09 22:43:13 oeventsd INFO signal SetBrightness responded : () Nov 9 22:43:13 om-gta02 user.debug 2008.11.09 22:43:13 odeviced.kernel26 DEBUG got data from uevent socket: 'change@/devices/platform/bq27000-battery.0/power_supply/bat\x00ACTION=change\x00DEVPATH=/devices/platform/bq27000-battery.0/power_supply/bat\x00SUBSYSTEM=power_supply\x00POWE Nov 9 22:43:13 om-gta02 user.debug 2008.11.09 22:43:13 odeviced DEBUG (read '1' from '/sys/class/power_supply/bat/present') Nov 9 22:43:13 om-gta02 user.debug 2008.11.09 22:43:13 odeviced.kernel26 DEBUG got property change from uevent socket: {'SUBSYSTEM': 'power_supply', 'POWER_SUPPLY_NAME': 'bat', 'POWER_SUPPLY_TIME_TO_FULL_NOW': '0', 'POWER_SUPPLY_TYPE': 'Battery', 'SEQNUM': '541', 'DEVPATH': '/device Nov 9 22:43:15 om-gta02 user.info 2008.11.09 22:43:15 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to idle Nov 9 22:43:15 om-gta02 user.info 2008.11.09 22:43:15 oeventsd INFO Receive IdleState, status = idle Nov 9 22:43:15 om-gta02 user.debug 2008.11.09 22:43:15 oeventsd DEBUG trigger IdleState Nov 9 22:43:15 om-gta02 user.info 2008.11.09 22:43:15 oeventsd INFO Receive IdleState, status = idle Nov 9 22:43:15 om-gta02 user.debug 2008.11.09 22:43:15 oeventsd DEBUG trigger IdleState Nov 9 22:43:15 om-gta02 user.info 2008.11.09 22:43:15 oeventsd INFO Receive IdleState, status = idle Nov 9 22:43:15 om-gta02 user.debug 2008.11.09 22:43:15 oeventsd DEBUG trigger IdleState Nov 9 22:43:19 om-gta02 user.info 2008.11.09 22:43:19 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to busy Nov 9 22:43:19 om-gta02 user.debug 2008.11.09 22:43:19 mppl.asyncworker DEBUG no elements in queue: starting idle task. Nov 9 22:43:19 om-gta02 user.info 2008.11.09 22:43:19 oeventsd INFO Receive IdleState, status = busy Nov 9 22:43:19 om-gta02 user.debug 2008.11.09 22:43:19 oeventsd DEBUG trigger IdleState Nov 9 22:43:19 om-gta02 user.debug 2008.11.09 22:43:19 oeventsd DEBUG trigger on IdleState if status == busy then SetBrightness((90,)) Nov 9 22:43:19 om-gta02 user.info 2008.11.09 22:43:19 oeventsd INFO call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((90,)) Nov 9 22:43:19 om-gta02 user.info 2008.11.09 22:43:19 oeventsd INFO Receive IdleState, status = busy Nov 9 22:43:19 om-gta02 user.debug 2008.11.09 22:43:19 oeventsd DEBUG trigger IdleState Nov 9 22:43:19 om-gta02 user.info 2008.11.09 22:43:19 oeventsd INFO Receive IdleState, status = busy Nov 9 22:43:19 om-gta02 user.debug 2008.11.09 22:43:19 oeventsd DEBUG trigger IdleState Nov 9 22:43:19 om-gta02 user.info 2008.11.09 22:43:19 oeventsd INFO signal SetBrightness responded : () Nov 9 22:43:19 om-gta02 user.debug 2008.11.09 22:43:19 mppl.asyncworker DEBUG _processElement() Nov 9 22:43:19 om-gta02 user.debug 2008.11.09 22:43:19 mppl.asyncworker DEBUG got an element from the queue Nov 9 22:43:19 om-gta02 user.info 2008.11.09 22:43:19 odeviced.input INFO name USB pressed 0 Nov 9 22:43:19 om-gta02 user.debug 2008.11.09 22:43:19 oeventsd DEBUG InputTrigger triggered Nov 9 22:43:19 om-gta02 user.debug 2008.11.09 22:43:19 oeventsd DEBUG trigger InputTrigger Nov 9 22:43:19 om-gta02 user.debug 2008.11.09 22:43:19 oeventsd DEBUG InputTrigger triggered Nov 9 22:43:19 om-gta02 user.debug 2008.11.09 22:43:19 oeventsd DEBUG trigger InputTrigger Nov 9 22:43:19 om-gta02 user.debug 2008.11.09 22:43:19 mppl.asyncworker DEBUG _processElement() Nov 9 22:43:19 om-gta02 user.debug 2008.11.09 22:43:19 mppl.asyncworker DEBUG no more elements: stopping idle task. Nov 9 22:43:20 om-gta02 user.info kernel: usb0: full speed config #1: 500 mA, Ethernet Gadget, using CDC Ethernet Nov 9 22:43:20 om-gta02 user.debug 2008.11.09 22:43:20 odeviced.kernel26 DEBUG got data from uevent socket: 'change@/devices/platform/bq27000-battery.0/power_supply/bat\x00ACTION=change\x00DEVPATH=/devices/platform/bq27000-battery.0/power_supply/bat\x00SUBSYSTEM=power_supply\x00POWE Nov 9 22:43:20 om-gta02 user.debug 2008.11.09 22:43:20 odeviced DEBUG (read '1' from '/sys/class/power_supply/bat/present') Nov 9 22:43:20 om-gta02 user.debug 2008.11.09 22:43:20 odeviced.kernel26 DEBUG got property change from uevent socket: {'SUBSYSTEM': 'power_supply', 'POWER_SUPPLY_NAME': 'bat', 'POWER_SUPPLY_TIME_TO_FULL_NOW': '3932100', 'POWER_SUPPLY_TYPE': 'Battery', 'SEQNUM': '542', 'DEVPATH': '/ Nov 9 22:43:20 om-gta02 user.debug 2008.11.09 22:43:20 odeviced.kernel26 DEBUG got data from uevent socket: 'change@/devices/platform/bq27000-battery.0/power_supply/bat\x00ACTION=change\x00DEVPATH=/devices/platform/bq27000-battery.0/power_supply/bat\x00SUBSYSTEM=power_supply\x00POWE Nov 9 22:43:21 om-gta02 user.debug 2008.11.09 22:43:21 odeviced DEBUG (read '1' from '/sys/class/power_supply/bat/present') Nov 9 22:43:21 om-gta02 user.debug 2008.11.09 22:43:21 odeviced.kernel26 DEBUG got property change from uevent socket: {'SUBSYSTEM': 'power_supply', 'POWER_SUPPLY_NAME': 'bat', 'POWER_SUPPLY_TIME_TO_FULL_NOW': '3932100', 'POWER_SUPPLY_TYPE': 'Battery', 'SEQNUM': '543', 'DEVPATH': '/ Nov 9 22:43:21 om-gta02 user.info 2008.11.09 22:43:21 odeviced.kernel26 INFO power status now charging Nov 9 22:43:21 om-gta02 user.debug 2008.11.09 22:43:21 odeviced.kernel26 DEBUG got data from uevent socket: 'change@/devices/platform/bq27000-battery.0/power_supply/bat\x00ACTION=change\x00DEVPATH=/devices/platform/bq27000-battery.0/power_supply/bat\x00SUBSYSTEM=power_supply\x00POWE Nov 9 22:43:21 om-gta02 user.info 2008.11.09 22:43:21 oeventsd INFO Receive PowerStatus, status = charging Nov 9 22:43:21 om-gta02 user.debug 2008.11.09 22:43:21 oeventsd DEBUG trigger PowerStatus Nov 9 22:43:21 om-gta02 user.debug 2008.11.09 22:43:21 oeventsd DEBUG trigger While PowerStatus if status == charging then SetLed(gta02_power_orange, light) Nov 9 22:43:21 om-gta02 user.info 2008.11.09 22:43:21 oeventsd INFO call dbus signal /org/freesmartphone/Device/LED/gta02_power_orange SetBrightness((100,)) Nov 9 22:43:21 om-gta02 user.info 2008.11.09 22:43:21 oeventsd INFO Receive PowerStatus, status = charging Nov 9 22:43:21 om-gta02 user.debug 2008.11.09 22:43:21 oeventsd DEBUG trigger PowerStatus Nov 9 22:43:21 om-gta02 user.info 2008.11.09 22:43:21 oeventsd INFO Receive PowerStatus, status = charging Nov 9 22:43:21 om-gta02 user.debug 2008.11.09 22:43:21 oeventsd DEBUG trigger PowerStatus Nov 9 22:43:21 om-gta02 user.info 2008.11.09 22:43:21 oeventsd INFO Receive PowerStatus, status = charging Nov 9 22:43:21 om-gta02 user.debug 2008.11.09 22:43:21 oeventsd DEBUG trigger PowerStatus Nov 9 22:43:21 om-gta02 user.debug 2008.11.09 22:43:21 odeviced DEBUG (writing 'none' to '/sys/class/leds/gta02-power:orange/trigger') Nov 9 22:43:21 om-gta02 user.debug 2008.11.09 22:43:21 odeviced DEBUG (writing '255' to '/sys/class/leds/gta02-power:orange/brightness') Nov 9 22:43:21 om-gta02 user.info 2008.11.09 22:43:21 oeventsd INFO signal SetBrightness responded : () Nov 9 22:43:21 om-gta02 user.debug 2008.11.09 22:43:21 odeviced DEBUG (read '1' from '/sys/class/power_supply/bat/present') Nov 9 22:43:21 om-gta02 user.debug 2008.11.09 22:43:21 odeviced.kernel26 DEBUG got property change from uevent socket: {'SUBSYSTEM': 'power_supply', 'POWER_SUPPLY_NAME': 'bat', 'POWER_SUPPLY_TIME_TO_FULL_NOW': '3932100', 'POWER_SUPPLY_TYPE': 'Battery', 'SEQNUM': '544', 'DEVPATH': '/ Nov 9 22:43:30 om-gta02 user.info 2008.11.09 22:43:30 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to idle Nov 9 22:43:30 om-gta02 user.info 2008.11.09 22:43:30 oeventsd INFO Receive IdleState, status = idle Nov 9 22:43:30 om-gta02 user.debug 2008.11.09 22:43:30 oeventsd DEBUG trigger IdleState Nov 9 22:43:30 om-gta02 user.info 2008.11.09 22:43:30 oeventsd INFO Receive IdleState, status = idle Nov 9 22:43:30 om-gta02 user.debug 2008.11.09 22:43:30 oeventsd DEBUG trigger IdleState Nov 9 22:43:30 om-gta02 user.info 2008.11.09 22:43:30 oeventsd INFO Receive IdleState, status = idle Nov 9 22:43:30 om-gta02 user.debug 2008.11.09 22:43:30 oeventsd DEBUG trigger IdleState Nov 9 22:43:31 om-gta02 user.debug 2008.11.09 22:43:31 frameworkd.controller DEBUG alive and kicking Nov 9 22:43:33 om-gta02 user.debug 2008.11.09 22:43:33 odeviced DEBUG (read '1' from '/sys/class/power_supply/bat/present') Nov 9 22:43:33 om-gta02 user.debug 2008.11.09 22:43:33 odeviced DEBUG (read '1' from '/sys/class/power_supply/bat/present') Nov 9 22:43:33 om-gta02 user.debug 2008.11.09 22:43:33 odeviced DEBUG (read '100' from '/sys/class/power_supply/bat/capacity') Nov 9 22:43:33 om-gta02 user.info 2008.11.09 22:43:33 odeviced.kernel26 INFO capacity now 100 Nov 9 22:43:33 om-gta02 user.info 2008.11.09 22:43:33 odeviced.kernel26 INFO power status now full Nov 9 22:43:33 om-gta02 user.info 2008.11.09 22:43:33 oeventsd INFO Receive PowerStatus, status = full Nov 9 22:43:33 om-gta02 user.debug 2008.11.09 22:43:33 oeventsd DEBUG trigger PowerStatus Nov 9 22:43:33 om-gta02 user.debug 2008.11.09 22:43:33 oeventsd DEBUG untrigger While PowerStatus if status == charging then SetLed(gta02_power_orange, light) Nov 9 22:43:33 om-gta02 user.info 2008.11.09 22:43:33 oeventsd INFO call dbus signal /org/freesmartphone/Device/LED/gta02_power_orange SetBrightness((0,)) Nov 9 22:43:33 om-gta02 user.info 2008.11.09 22:43:33 oeventsd INFO Receive PowerStatus, status = full Nov 9 22:43:33 om-gta02 user.debug 2008.11.09 22:43:33 oeventsd DEBUG trigger PowerStatus Nov 9 22:43:33 om-gta02 user.info 2008.11.09 22:43:33 oeventsd INFO Receive PowerStatus, status = full Nov 9 22:43:33 om-gta02 user.debug 2008.11.09 22:43:33 oeventsd DEBUG trigger PowerStatus Nov 9 22:43:33 om-gta02 user.debug 2008.11.09 22:43:33 oeventsd DEBUG trigger While PowerStatus if status == full then SetLed(gta02_power_blue, light) Nov 9 22:43:33 om-gta02 user.info 2008.11.09 22:43:33 oeventsd INFO call dbus signal /org/freesmartphone/Device/LED/gta02_power_blue SetBrightness((100,)) Nov 9 22:43:33 om-gta02 user.info 2008.11.09 22:43:33 oeventsd INFO Receive PowerStatus, status = full Nov 9 22:43:33 om-gta02 user.debug 2008.11.09 22:43:33 oeventsd DEBUG trigger PowerStatus Nov 9 22:43:33 om-gta02 user.debug 2008.11.09 22:43:33 odeviced DEBUG (writing 'none' to '/sys/class/leds/gta02-power:orange/trigger') Nov 9 22:43:33 om-gta02 user.debug 2008.11.09 22:43:33 odeviced DEBUG (writing '0' to '/sys/class/leds/gta02-power:orange/brightness') Nov 9 22:43:33 om-gta02 user.debug 2008.11.09 22:43:33 odeviced DEBUG (writing 'none' to '/sys/class/leds/gta02-power:blue/trigger') Nov 9 22:43:33 om-gta02 user.debug 2008.11.09 22:43:33 odeviced DEBUG (writing '255' to '/sys/class/leds/gta02-power:blue/brightness') Nov 9 22:43:33 om-gta02 user.info 2008.11.09 22:43:33 oeventsd INFO signal SetBrightness responded : () Nov 9 22:43:33 om-gta02 user.info 2008.11.09 22:43:33 oeventsd INFO signal SetBrightness responded : () Nov 9 22:43:41 om-gta02 user.info 2008.11.09 22:43:41 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to busy Nov 9 22:43:41 om-gta02 user.info 2008.11.09 22:43:41 oeventsd INFO Receive IdleState, status = busy Nov 9 22:43:41 om-gta02 user.debug 2008.11.09 22:43:41 oeventsd DEBUG trigger IdleState Nov 9 22:43:41 om-gta02 user.debug 2008.11.09 22:43:41 oeventsd DEBUG trigger on IdleState if status == busy then SetBrightness((90,)) Nov 9 22:43:41 om-gta02 user.info 2008.11.09 22:43:41 oeventsd INFO call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((90,)) Nov 9 22:43:41 om-gta02 user.info 2008.11.09 22:43:41 oeventsd INFO Receive IdleState, status = busy Nov 9 22:43:41 om-gta02 user.debug 2008.11.09 22:43:41 oeventsd DEBUG trigger IdleState Nov 9 22:43:41 om-gta02 user.info 2008.11.09 22:43:41 oeventsd INFO Receive IdleState, status = busy Nov 9 22:43:41 om-gta02 user.debug 2008.11.09 22:43:41 oeventsd DEBUG trigger IdleState Nov 9 22:43:41 om-gta02 user.info 2008.11.09 22:43:41 oeventsd INFO signal SetBrightness responded : () Nov 9 22:43:52 om-gta02 user.info 2008.11.09 22:43:52 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to idle Nov 9 22:43:52 om-gta02 user.info 2008.11.09 22:43:52 oeventsd INFO Receive IdleState, status = idle Nov 9 22:43:52 om-gta02 user.debug 2008.11.09 22:43:52 oeventsd DEBUG trigger IdleState Nov 9 22:43:52 om-gta02 user.info 2008.11.09 22:43:52 oeventsd INFO Receive IdleState, status = idle Nov 9 22:43:52 om-gta02 user.debug 2008.11.09 22:43:52 oeventsd DEBUG trigger IdleState Nov 9 22:43:52 om-gta02 user.info 2008.11.09 22:43:52 oeventsd INFO Receive IdleState, status = idle Nov 9 22:43:52 om-gta02 user.debug 2008.11.09 22:43:52 oeventsd DEBUG trigger IdleState Nov 9 22:43:58 om-gta02 user.info 2008.11.09 22:43:58 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to busy Nov 9 22:43:58 om-gta02 user.info 2008.11.09 22:43:58 oeventsd INFO Receive IdleState, status = busy Nov 9 22:43:58 om-gta02 user.debug 2008.11.09 22:43:58 oeventsd DEBUG trigger IdleState Nov 9 22:43:58 om-gta02 user.debug 2008.11.09 22:43:58 oeventsd DEBUG trigger on IdleState if status == busy then SetBrightness((90,)) Nov 9 22:43:58 om-gta02 user.info 2008.11.09 22:43:58 oeventsd INFO call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((90,)) Nov 9 22:43:58 om-gta02 user.info 2008.11.09 22:43:58 oeventsd INFO Receive IdleState, status = busy Nov 9 22:43:58 om-gta02 user.debug 2008.11.09 22:43:58 oeventsd DEBUG trigger IdleState Nov 9 22:43:58 om-gta02 user.info 2008.11.09 22:43:58 oeventsd INFO Receive IdleState, status = busy Nov 9 22:43:58 om-gta02 user.debug 2008.11.09 22:43:58 oeventsd DEBUG trigger IdleState Nov 9 22:43:59 om-gta02 user.info 2008.11.09 22:43:59 oeventsd INFO signal SetBrightness responded : () Nov 9 22:44:00 om-gta02 user.debug 2008.11.09 22:44:00 otimed DEBUG Minute 22:44 Nov 9 22:44:03 om-gta02 user.debug 2008.11.09 22:44:03 ogsmd DEBUG |...|...|...|...|...|...|...|...> SimRetrieveMessagebook.__init__: ENTER (, at 0x5ee0f0>, SimRetrieveMessagebook.__init__: LEAVE Nov 9 22:44:03 om-gta02 user.debug 2008.11.09 22:44:03 ogsmd DEBUG (: last communication with modem was 55 seconds ago. Sending EOF to wakeup) Nov 9 22:44:03 om-gta02 user.debug 2008.11.09 22:44:03 ogsmd DEBUG : sending 11 bytes: 'AT+CMGL=2\r\n' Nov 9 22:44:03 om-gta02 user.debug 2008.11.09 22:44:03 ogsmd DEBUG : got 19 bytes from: '\r\n+CMS ERROR: 321\r\n' Nov 9 22:44:03 om-gta02 user.debug 2008.11.09 22:44:03 ogsmd DEBUG : COMPLETED 'AT+CMGL=2' => ['+CMS ERROR: 321'] Nov 9 22:44:03 om-gta02 user.debug 2008.11.09 22:44:03 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> SimRetrieveMessagebook.responseFromChannel: ENTER ('AT+CMGL=2', ['+CMS ERROR: 321']),{} Nov 9 22:44:03 om-gta02 user.debug 2008.11.09 22:44:03 ogsmd DEBUG |...|...|...|...|...|...|...|...|...|...> SimRetrieveMessagebook.responseFromChannel: LEAVE Nov 9 22:44:03 om-gta02 user.debug 2008.11.09 22:44:03 ogsmd DEBUG |...|...|...|...|...|...|...|...> SimRetrieveMessagebook.__del__: ENTER (),{} Nov 9 22:44:03 om-gta02 user.debug 2008.11.09 22:44:03 ogsmd DEBUG |...|...|...|...|...|...|...|...> SimRetrieveMessagebook.__del__: LEAVE Nov 9 22:44:09 om-gta02 user.info 2008.11.09 22:44:09 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to idle Nov 9 22:44:09 om-gta02 user.info 2008.11.09 22:44:09 oeventsd INFO Receive IdleState, status = idle Nov 9 22:44:09 om-gta02 user.debug 2008.11.09 22:44:09 oeventsd DEBUG trigger IdleState Nov 9 22:44:09 om-gta02 user.info 2008.11.09 22:44:09 oeventsd INFO Receive IdleState, status = idle Nov 9 22:44:09 om-gta02 user.debug 2008.11.09 22:44:09 oeventsd DEBUG trigger IdleState Nov 9 22:44:09 om-gta02 user.info 2008.11.09 22:44:09 oeventsd INFO Receive IdleState, status = idle Nov 9 22:44:09 om-gta02 user.debug 2008.11.09 22:44:09 oeventsd DEBUG trigger IdleState Nov 9 22:44:10 om-gta02 user.info 2008.11.09 22:44:10 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to busy Nov 9 22:44:10 om-gta02 user.info 2008.11.09 22:44:10 oeventsd INFO Receive IdleState, status = busy Nov 9 22:44:10 om-gta02 user.debug 2008.11.09 22:44:10 oeventsd DEBUG trigger IdleState Nov 9 22:44:10 om-gta02 user.debug 2008.11.09 22:44:10 oeventsd DEBUG trigger on IdleState if status == busy then SetBrightness((90,)) Nov 9 22:44:10 om-gta02 user.info 2008.11.09 22:44:10 oeventsd INFO call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((90,)) Nov 9 22:44:10 om-gta02 user.info 2008.11.09 22:44:10 oeventsd INFO Receive IdleState, status = busy Nov 9 22:44:10 om-gta02 user.debug 2008.11.09 22:44:10 oeventsd DEBUG trigger IdleState Nov 9 22:44:10 om-gta02 user.info 2008.11.09 22:44:10 oeventsd INFO Receive IdleState, status = busy Nov 9 22:44:10 om-gta02 user.debug 2008.11.09 22:44:10 oeventsd DEBUG trigger IdleState Nov 9 22:44:10 om-gta02 user.info 2008.11.09 22:44:10 oeventsd INFO signal SetBrightness responded : () Nov 9 22:44:21 om-gta02 user.info 2008.11.09 22:44:21 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to idle Nov 9 22:44:21 om-gta02 user.debug 2008.11.09 22:44:21 frameworkd.controller DEBUG alive and kicking Nov 9 22:44:21 om-gta02 user.info 2008.11.09 22:44:21 oeventsd INFO Receive IdleState, status = idle Nov 9 22:44:21 om-gta02 user.debug 2008.11.09 22:44:21 oeventsd DEBUG trigger IdleState Nov 9 22:44:21 om-gta02 user.info 2008.11.09 22:44:21 oeventsd INFO Receive IdleState, status = idle Nov 9 22:44:21 om-gta02 user.debug 2008.11.09 22:44:21 oeventsd DEBUG trigger IdleState Nov 9 22:44:21 om-gta02 user.info 2008.11.09 22:44:21 oeventsd INFO Receive IdleState, status = idle Nov 9 22:44:21 om-gta02 user.debug 2008.11.09 22:44:21 oeventsd DEBUG trigger IdleState Nov 9 22:44:30 om-gta02 user.info 2008.11.09 22:44:30 odeviced.idlenotifier INFO framework.subsystems.odeviced.idlenotifier state change to busy Nov 9 22:44:30 om-gta02 user.info 2008.11.09 22:44:30 oeventsd INFO Receive IdleState, status = busy Nov 9 22:44:30 om-gta02 user.debug 2008.11.09 22:44:30 oeventsd DEBUG trigger IdleState Nov 9 22:44:30 om-gta02 user.debug 2008.11.09 22:44:30 oeventsd DEBUG trigger on IdleState if status == busy then SetBrightness((90,)) Nov 9 22:44:30 om-gta02 user.info 2008.11.09 22:44:30 oeventsd INFO call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((90,)) Nov 9 22:44:30 om-gta02 user.info 2008.11.09 22:44:30 oeventsd INFO Receive IdleState, status = busy Nov 9 22:44:30 om-gta02 user.debug 2008.11.09 22:44:30 oeventsd DEBUG trigger IdleState Nov 9 22:44:30 om-gta02 user.info 2008.11.09 22:44:30 oeventsd INFO Receive IdleState, status = busy Nov 9 22:44:30 om-gta02 user.debug 2008.11.09 22:44:30 oeventsd DEBUG trigger IdleState Nov 9 22:44:30 om-gta02 user.info 2008.11.09 22:44:30 oeventsd INFO signal SetBrightness responded : ()