Originally Posted by lemmyslender
(Post 566192)
zzzzzzz # is from contact with GV number added by me (different from GV number). autogv missed call is because I rejected callback.
Code:
(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/
|