(12:35:13) INFO:root:telepathy-theonering 0.8.6-0 (12:35:13) DEBUG:root:OS: Linux (12:35:13) DEBUG:root:Kernel: 2.6.28-omap1 (#1 PREEMPT Thu Dec 17 09:40:52 EET 2009) for armv7l (12:35:13) DEBUG:root:Hostname: Nokia-N900-42-11 (12:35:13) INFO:connection_manager:Connection manager created (12:35:13) DEBUG:handle:Created Handle: <ConnectionHandle id=1 name='myusername'> (Is New!) (12:35:13) INFO:connection:Connection to the account myusername created (12:35:13) INFO:connection:Kicking off connect (12:35:13) INFO:connection:Connecting... (12:35:13) INFO:gvoice.conversations:'get_texts' Loaded cache (12:35:13) INFO:gvoice.conversations:'get_voicemails' Loaded cache (12:35:13) DEBUG:gvoice.browser_emu:Performing download of https://www.google.com/voice/m (12:35:14) DEBUG:gvoice.browser_emu:Performing download of https://www.google.com/accounts/ServiceLoginAuth (12:35:16) INFO:gvoice.state_machine:Addressbook Starting State Machine (12:35:16) INFO:gvoice.state_machine:Voicemail Starting State Machine (12:35:16) INFO:gvoice.state_machine:Texting Starting State Machine (12:35:16) INFO:gvoice.backend:Callback number changed: '+1747gizm05' (12:35:16) DEBUG:handle:Created Handle: <ListHandle id=2 name='subscribe'> (Is New!) (12:35:16) DEBUG:channel_manager:New contact list channel (12:35:16) INFO:channel.contact_list:subscribe Added: 0, Removed: 0 (12:35:16) DEBUG:handle:Created Handle: <ListHandle id=3 name='publish'> (Is New!) (12:35:16) DEBUG:channel_manager:New contact list channel (12:35:16) INFO:channel.contact_list:publish Added: 0, Removed: 0 (12:35:17) INFO:connection:Connected (12:35:17) DEBUG:gvoice.browser_emu:Performing download of https://www.google.com/voice/m/donotdisturb (12:35:18) DEBUG:aliasing:Called GetAliases (12:35:18) DEBUG:aliasing:Called SetAliases (12:35:18) INFO:gvoice.backend:Callback number changed: u'+1747gizm05' (12:35:18) DEBUG:handle:Created Handle: <ListHandle id=4 name='stored'> (Is New!) (12:35:18) DEBUG:handle:Created Handle: <ListHandle id=5 name='allow'> (Is New!) (12:35:18) DEBUG:handle:Created Handle: <ListHandle id=6 name='deny'> (Is New!) (12:35:18) INFO:connection:RequestChannel Object Path (ContactList): /org/freedesktop/Telepathy/Connection/theonering/gv/myusername/channel0 (12:35:18) INFO:connection:RequestChannel Object Path (ContactList): /org/freedesktop/Telepathy/Connection/theonering/gv/myusername/channel1 (12:35:19) DEBUG:channel_manager:New contact list channel (12:35:19) INFO:channel.contact_list:stored Added: 0, Removed: 0 (12:35:19) INFO:connection:RequestChannel Object Path (ContactList): /org/freedesktop/Telepathy/Connection/theonering/gv/myusername/channel2 (12:35:19) DEBUG:channel_manager:New contact list channel (12:35:19) ERROR:connection:RequestChannel Traceback (most recent call last): File "/usr/lib/theonering/util/misc.py", line 48, in wrapper return func(*args, **kwds) File "/usr/lib/theonering/connection.py", line 262, in RequestChannel chan = self.__channelManager.channel_for_props(props, signal=True) File "/usr/lib/theonering/tp/channelmanager.py", line 106, in channel_for_props return self.create_channel_for_props(props, signal, **args) File "/usr/lib/theonering/tp/channelmanager.py", line 91, in create_channel_for_props props, **args) File "/usr/lib/theonering/channel_manager.py", line 66, in _get_list_channel chan = channel.contact_list.create_contact_list_channel(self._conn, self, props, h) File "/usr/lib/theonering/channel/contact_list.py", line 174, in create_contact_list_channel raise telepathy.errors.NotCapable("Unsuported type %s" % h.get_name()) NotCapable: org.freedesktop.Telepathy.Error.NotCapable: Unsuported type allow (12:35:19) DEBUG:channel_manager:New contact list channel (12:35:19) INFO:channel.contact_list:deny Added: 0, Removed: 0 (12:35:19) INFO:connection:RequestChannel Object Path (ContactList): /org/freedesktop/Telepathy/Connection/theonering/gv/myusername/channel3 (12:35:19) INFO:gvoice.state_machine:Addressbook No further updates (timeout is 86400 seconds) (12:35:19) DEBUG:gvoice.browser_emu:Performing download of http://www.google.com/voice/inbox/search/contact (12:35:21) INFO:channel.contact_list:subscribe Added: 14, Removed: 0 (12:35:21) DEBUG:handle:Created Handle: <ContactHandle id=7 name='+1219xxxxxxx'> (Is New!) cut other numbers (12:35:21) INFO:channel.contact_list:publish Added: 14, Removed: 0 (12:35:21) INFO:channel.contact_list:stored Added: 14, Removed: 0 (12:35:21) INFO:channel.contact_list:deny Added: 14, Removed: 0 (12:35:21) INFO:gvoice.state_machine:Voicemail Next update in 7200 seconds (12:35:21) DEBUG:gvoice.browser_emu:Performing download of https://www.google.com/voice/inbox/recent/voicemail/ (12:35:21) INFO:gvoice.state_machine:Texting Next update in 600 seconds (12:35:21) DEBUG:gvoice.browser_emu:Performing download of https://www.google.com/voice/inbox/recent/sms/ (12:35:23) DEBUG:handle:Created Handle: <ContactHandle id=21 name='+1330yyyyyyy'> (Is New!) (12:35:23) DEBUG:aliasing:Called GetAliases (12:35:23) INFO:tp_utils:SecondaryVCardFields Set (12:35:31) DEBUG:autogv:Error: <util.tp_utils.WasMissedCall object at 0x40c60190> claims 'wrong direction' (12:37:45) DEBUG:handle:Created Handle: <ContactHandle id=22 name='+1330yyyyyyy'> (Is New!) (12:40:10) DEBUG:channel_manager:New media channel (12:40:10) WARNING:channel.call:InitiatorID or InitiatorHandle not set on new channel, assuming locally initiated (12:40:11) DEBUG:autogv:Ignoring channels from self to prevent deadlock (12:40:11) DEBUG:gvoice.browser_emu:Performing download of https://www.google.com/voice/mobile/phones (12:40:20) INFO:gvoice.backend:{'subscriberNumber': 'undefined', 'remember': '1', 'phoneType': '7', 'forwardingNumber': u'+1747gizm05', 'outgoingNumber': '+1330yyyyyyy'} (12:40:20) DEBUG:gvoice.browser_emu:Performing download of https://www.google.com/voice/call/connect (12:40:21) ERROR:autogv:_on_new_channel Traceback (most recent call last): File "/usr/lib/theonering/util/misc.py", line 48, in wrapper return func(*args, **kwds) File "/usr/lib/theonering/autogv.py", line 123, in _on_new_channel chan = telepathy.client.Channel(serviceName, channelObjectPath) File "/usr/lib/python2.5/site-packages/telepathy/client/channel.py", line 44, in __init__ type = self.GetChannelType() File "/usr/lib/pymodules/python2.5/dbus/proxies.py", line 68, in __call__ return self._proxy_method(*args, **keywords) File "/usr/lib/pymodules/python2.5/dbus/proxies.py", line 140, in __call__ **keywords) File "/usr/lib/pymodules/python2.5/dbus/connection.py", line 622, in call_blocking message, timeout) DBusException: org.freedesktop.DBus.Error.UnknownMethod: Method "GetChannelType" with signature "" on interface "org.freedesktop.Telepathy.Channel" doesn't exist (12:40:21) ERROR:tp_utils:Blocking exception from being passed up Traceback (most recent call last): File "/usr/lib/theonering/util/tp_utils.py", line 133, in _on_new_channel self._sessionBus, serviceName, connObjectPath, channelObjectPath, channelType File "/usr/lib/theonering/util/misc.py", line 48, in wrapper return func(*args, **kwds) File "/usr/lib/theonering/autogv.py", line 123, in _on_new_channel chan = telepathy.client.Channel(serviceName, channelObjectPath) File "/usr/lib/python2.5/site-packages/telepathy/client/channel.py", line 44, in __init__ type = self.GetChannelType() File "/usr/lib/pymodules/python2.5/dbus/proxies.py", line 68, in __call__ return self._proxy_method(*args, **keywords) File "/usr/lib/pymodules/python2.5/dbus/proxies.py", line 140, in __call__ **keywords) File "/usr/lib/pymodules/python2.5/dbus/connection.py", line 622, in call_blocking message, timeout) DBusException: org.freedesktop.DBus.Error.UnknownMethod: Method "GetChannelType" with signature "" on interface "org.freedesktop.Telepathy.Channel" doesn't exist (12:40:21) DEBUG:channel.call:Cancel now disallowed (12:40:21) DEBUG:channel.call:Closing call (12:40:40) DEBUG:channel_manager:New media channel (12:40:40) WARNING:channel.call:InitiatorID or InitiatorHandle not set on new channel, assuming locally initiated (12:40:41) DEBUG:autogv:Ignoring channels from self to prevent deadlock (12:40:42) INFO:gvoice.backend:{'subscriberNumber': 'undefined', 'remember': '1', 'phoneType': '7', 'forwardingNumber': u'+1747gizm05', 'outgoingNumber': '+1330yyyyyyy'} (12:40:42) DEBUG:gvoice.browser_emu:Performing download of https://www.google.com/voice/call/connect (12:40:43) DEBUG:channel.call:Cancel now disallowed (12:40:43) DEBUG:channel.call:Closing call (12:40:53) DEBUG:channel_manager:New media channel (12:40:53) WARNING:channel.call:InitiatorID or InitiatorHandle not set on new channel, assuming locally initiated (12:40:53) DEBUG:autogv:Ignoring channels from self to prevent deadlock (12:40:55) INFO:gvoice.backend:{'subscriberNumber': 'undefined', 'remember': '1', 'phoneType': '7', 'forwardingNumber': u'+1747gizm05', 'outgoingNumber': '+1330yyyyyyy'} (12:40:55) DEBUG:gvoice.browser_emu:Performing download of https://www.google.com/voice/call/connect (12:40:56) DEBUG:channel.call:Cancel now disallowed (12:40:56) DEBUG:channel.call:Closing call (12:41:24) DEBUG:handle:Created Handle: <ContactHandle id=23 name='+1330zzzzzz'> (Is New!) (12:41:24) DEBUG:channel_manager:New media channel (12:41:24) WARNING:channel.call:InitiatorID or InitiatorHandle not set on new channel, assuming locally initiated (12:41:24) DEBUG:autogv:Ignoring channels from self to prevent deadlock (12:41:25) INFO:gvoice.backend:{'subscriberNumber': 'undefined', 'remember': '1', 'phoneType': '7', 'forwardingNumber': u'+1747gizm05', 'outgoingNumber': '+1330zzzzzz'} (12:41:26) DEBUG:gvoice.browser_emu:Performing download of https://www.google.com/voice/call/connect (12:41:26) DEBUG:channel.call:Cancel now disallowed (12:41:26) DEBUG:channel.call:Closing call (12:41:32) INFO:autogv:Missed a call (12:41:33) INFO:gvoice.state_machine:Voicemail Resetting State Machine (12:41:33) INFO:gvoice.state_machine:Voicemail Next update in 60 seconds (12:41:41) DEBUG:channel_manager:New media channel (12:41:41) WARNING:channel.call:InitiatorID or InitiatorHandle not set on new channel, assuming locally initiated (12:41:41) DEBUG:autogv:Ignoring channels from self to prevent deadlock (12:41:43) INFO:gvoice.backend:{'subscriberNumber': 'undefined', 'remember': '1', 'phoneType': '7', 'forwardingNumber': u'+1747gizm05', 'outgoingNumber': '+1330yyyyyyy'} (12:41:43) DEBUG:gvoice.browser_emu:Performing download of https://www.google.com/voice/call/connect (12:41:43) DEBUG:channel.call:Cancel now disallowed (12:41:43) DEBUG:channel.call:Closing call (12:42:03) DEBUG:channel_manager:New media channel (12:42:03) WARNING:channel.call:InitiatorID or InitiatorHandle not set on new channel, assuming locally initiated (12:42:03) DEBUG:autogv:Ignoring channels from self to prevent deadlock (12:42:05) INFO:gvoice.backend:{'subscriberNumber': 'undefined', 'remember': '1', 'phoneType': '7', 'forwardingNumber': u'+1747gizm05', 'outgoingNumber': '+1330zzzzzz'} (12:42:05) DEBUG:gvoice.browser_emu:Performing download of https://www.google.com/voice/call/connect (12:42:05) DEBUG:channel.call:Cancel now disallowed (12:42:05) DEBUG:channel.call:Closing call (12:42:09) INFO:autogv:Missed a call (12:42:09) INFO:gvoice.state_machine:Voicemail Resetting State Machine (12:42:09) INFO:gvoice.state_machine:Voicemail Next update in 60 seconds (12:42:28) DEBUG:handle:Created Handle: <ContactHandle id=24 name='+1330wwwwwww'> (Is New!) (12:42:28) DEBUG:channel_manager:New media channel (12:42:28) WARNING:channel.call:InitiatorID or InitiatorHandle not set on new channel, assuming locally initiated (12:42:28) DEBUG:autogv:Ignoring channels from self to prevent deadlock (12:42:36) DEBUG:gvoice.browser_emu:Performing download of https://www.google.com/voice/mobile/phones (12:42:37) INFO:gvoice.backend:{'subscriberNumber': 'undefined', 'remember': '1', 'phoneType': '7', 'forwardingNumber': u'+1747gizm05', 'outgoingNumber': '+1330wwwwwww'} (12:42:37) DEBUG:gvoice.browser_emu:Performing download of https://www.google.com/voice/call/connect (12:42:38) DEBUG:channel.call:Cancel now disallowed (12:42:38) DEBUG:channel.call:Closing call (12:43:09) INFO:gvoice.state_machine:Voicemail Next update in 60 seconds (12:43:09) DEBUG:gvoice.browser_emu:Performing download of https://www.google.com/voice/inbox/recent/voicemail/