Bug 307237

Summary:	Authentication fails with correct password on Jabber.org XMPP account
Product:	[Unmaintained] telepathy	Reporter:	Kubuntiac <user581>
Component:	auth-handler	Assignee:	Telepathy Bugs <kde-telepathy-bugs>
Status:	RESOLVED FIXED
Severity:	major	CC:	kde
Priority:	NOR
Version:	0.5.0
Target Milestone:	0.5.1
Platform:	Chakra
OS:	Linux
Latest Commit:		Version Fixed In:	0.5.1
Sentry Crash Report:

Description Kubuntiac 2012-09-23 01:32:06 UTC

Telepathy account manager attempts a connection for a few seconds and then tells me "Authentication failed" when I attempt to add my Jabber.org account in the account manager. Jitsi and thunderbird connect with the same credentials just fine.

Reproducible: Always

Steps to Reproduce:
1. Account manager > Add account
2. Click XMPP button and enter username@jabber.org and password
3. Click "Finish"
Actual Results:  
A completely stationary throbber (ie it doesn't spin) and the word "Connecting". After about 7 seconds I get a system notification saying "could not connect to username@jabber.org. Authentication failed. (Is your password correct?)" I've tried multiple times, so yes, I'm sure my password is correct.

Expected Results:  
Telepathy logs me in to my Jabber account.

Comment 1 David Edmundson 2012-09-23 01:40:13 UTC

Almost certainly a case of the ktp-auth-handler not existing/being found.

Are you using packages or self compiled?
If self compiled, please read: 
http://community.kde.org/Real-Time_Communication_and_Collaboration/Troubleshooting#I_keep_being_told_.22Authentication_Failed.22

Please run /usr/lib/kde4/libexec/ktp-auth-handler --debug --persist, then connect your account. 

If it fails, paste any output from this as an attachment.

Comment 2 Kubuntiac 2012-09-23 01:45:24 UTC

When I run that command, it just gives me:
ktp-auth-handler(5198)/Telepathy-Qt: Unable to register client: busName "org.freedesktop.Telepathy.Client.KTp.SASLHandler" already registered

before I even try to connect. After trying I get no further output.

Comment 3 David Edmundson 2012-09-23 01:50:15 UTC

interesting... so it's already running.
This could be an actual bug then.

run "killall ktp-auth-handler" and run that command again.

Comment 4 Kubuntiac 2012-09-23 01:53:23 UTC

Hey, I just tried logging out and logging in before running that command, and I got a more complete looking output (but still no login). I've replaced my username with USERNAME, but it doesn't have any special characters, spaces or anything unusual in it:

tp-auth-handler(5812)/Telepathy-Qt: Client registered - busName: "org.freedesktop.Telepathy.Client.KTp.SASLHandler" objectPath: "/org/freedesktop/Telepathy/Client/KTp/SASLHandler" interfaces: ("org.freedesktop.Telepathy.Client.Handler")
ktp-auth-handler(5812)/Telepathy-Qt: HandleChannels: account: "/org/freedesktop/Telepathy/Account/gabble/jabber/USERNAME_40jabber_2eorg0" , connection: "/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy"
ktp-auth-handler(5812)/Telepathy-Qt: Creating new DBusProxy
ktp-auth-handler(5812)/Telepathy-Qt: ReadinessHelper: new supportedStatuses = QSet(0)
ktp-auth-handler(5812)/Telepathy-Qt: ReadinessHelper: new supportedFeatures = QSet(QPair("Tp::Account",0) ,  QPair("Tp::Account",1) ,  QPair("Tp::Account",2) ,  QPair("Tp::Account",3) )
ktp-auth-handler(5812)/Telepathy-Qt: Inserting to factory cache proxy for QPair("org.freedesktop.Telepathy.AccountManager","/org/freedesktop/Telepathy/Account/gabble/jabber/USERNAME_40jabber_2eorg0")
ktp-auth-handler(5812)/Telepathy-Qt: Creating new DBusProxy
ktp-auth-handler(5812)/Telepathy-Qt: Connecting to ConnectionError()
ktp-auth-handler(5812)/Telepathy-Qt: Connecting to StatusChanged()
ktp-auth-handler(5812)/Telepathy-Qt: Connecting to SelfHandleChanged()
ktp-auth-handler(5812)/Telepathy-Qt: Creating new HandleContext for "/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy"
ktp-auth-handler(5812)/Telepathy-Qt: ReadinessHelper: new supportedStatuses = QSet(0, 4294967295, 1, 2)
ktp-auth-handler(5812)/Telepathy-Qt: ReadinessHelper: new supportedFeatures = QSet(QPair("Tp::Connection",6) ,  QPair("Tp::Connection",5) ,  QPair("Tp::Connection",4) ,  QPair("Tp::Connection",2) ,  QPair("Tp::Connection",1) ,  QPair("Tp::Connection",0) ,  QPair("Tp::Connection",7) )
ktp-auth-handler(5812)/Telepathy-Qt: Inserting to factory cache proxy for QPair(":1.137","/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy")
ktp-auth-handler(5812)/Telepathy-Qt: Creating new DBusProxy
ktp-auth-handler(5812)/Telepathy-Qt: Creating new Channel: "/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy/ServerSASLChannel"
ktp-auth-handler(5812)/Telepathy-Qt:  Connecting to Channel::Closed() signal
ktp-auth-handler(5812)/Telepathy-Qt:  Connection to owning connection's lifetime signals
ktp-auth-handler(5812)/Telepathy-Qt: ReadinessHelper: new supportedStatuses = QSet(0)
ktp-auth-handler(5812)/Telepathy-Qt: ReadinessHelper: new supportedFeatures = QSet(QPair("Tp::Channel",0) ,  QPair("Tp::Channel",1) )
ktp-auth-handler(5812)/Telepathy-Qt: ReadinessHelper: new supportedStatuses = QSet(0)
ktp-auth-handler(5812)/Telepathy-Qt: ReadinessHelper: new supportedFeatures = QSet(QPair("Tp::ServerAuthenticationChannel",0) ,  QPair("Tp::Channel",0) ,  QPair("Tp::Channel",1) )
ktp-auth-handler(5812)/Telepathy-Qt: Inserting to factory cache proxy for QPair(":1.137","/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy/ServerSASLChannel")
ktp-auth-handler(5812)/Telepathy-Qt: Preparing proxies for HandleChannels of 1 channels for client 0x10a8c70
ktp-auth-handler(5812)/Telepathy-Qt: Discovering if the Channel Dispatcher supports request hints
ktp-auth-handler(5812)/Telepathy-Qt: Calling Properties::GetAll(Connection)
ktp-auth-handler(5812)/Telepathy-Qt: Calling Connection::becomeReady()
ktp-auth-handler(5812)/Telepathy-Qt: Got reply to PendingVariant call
ktp-auth-handler(5812)/Telepathy-Qt: Discovered channel dispatcher support for request hints:  true
ktp-auth-handler(5812)/Telepathy-Qt: Calling Properties::GetAll(Account) on  "/org/freedesktop/Telepathy/Account/gabble/jabber/USERNAME_40jabber_2eorg0"
ktp-auth-handler(5812)/Telepathy-Qt: Got status: 1
ktp-auth-handler(5812)/Telepathy-Qt: Got interfaces: ("org.freedesktop.Telepathy.Connection.Interface.PowerSaving", "org.freedesktop.Telepathy.Connection.Interface.Aliasing", "org.freedesktop.Telepathy.Connection.Interface.Capabilities", "org.freedesktop.Telepathy.Connection.Interface.SimplePresence", "org.freedesktop.Telepathy.Connection.Interface.Presence", "org.freedesktop.Telepathy.Connection.Interface.Avatars", "org.freedesktop.Telepathy.Connection.Interface.ContactInfo", "org.freedesktop.Telepathy.Connection.Interface.Contacts", "org.freedesktop.Telepathy.Connection.Interface.ContactList", "org.freedesktop.Telepathy.Connection.Interface.ContactGroups", "org.freedesktop.Telepathy.Connection.Interface.Requests", "org.freedesktop.Telepathy.Connection.Interface.ContactCapabilities", "org.freedesktop.Telepathy.Connection.Interface.Location", "org.freedesktop.Telepathy.Connection.Interface.Gabble.Decloak", "org.freedesktop.Telepathy.Connection.FUTURE", "org.freedesktop.Telepathy.Connection.Interface.ClientTypes", "org.freedesktop.Telepathy.Connection.Interface.Addressing1")
ktp-auth-handler(5812)/Telepathy-Qt: Retrieving capabilities
ktp-auth-handler(5812)/Telepathy-Qt: Got reply to Properties.GetAll(Account) for "/org/freedesktop/Telepathy/Account/gabble/jabber/USERNAME_40jabber_2eorg0"                                                                                 
ktp-auth-handler(5812)/Telepathy-Qt: Account::updateProperties: changed:                                                                                                                                                                     
ktp-auth-handler(5812)/Telepathy-Qt:  Interfaces: ("org.freedesktop.Telepathy.Account", "org.freedesktop.Telepathy.Account.Interface.Avatar", "com.nokia.Account.Interface.Compat", "com.nokia.Account.Interface.Conditions", "org.freedesktop.Telepathy.Account.Interface.Storage", "org.freedesktop.Telepathy.Account.Interface.Addressing", "org.freedesktop.Telepathy.Account.Interface.Hidden.DRAFT1")                                                                               
ktp-auth-handler(5812)/Telepathy-Qt:  Service Name: "jabber"                                                                                                                                                                                 
ktp-auth-handler(5812)/Telepathy-Qt:  Display Name: "USERNAME@jabber.org"                                                                                                                                                                    
ktp-auth-handler(5812)/Telepathy-Qt:  Valid: true                                                                                                                                                                                            
ktp-auth-handler(5812)/Telepathy-Qt:  Enabled: true                                                                                                                                                                                          
ktp-auth-handler(5812)/Telepathy-Qt:  Automatic Presence: 2 - "available"                                                                                                                                                                    
ktp-auth-handler(5812)/Telepathy-Qt:  Current Presence: 1 - "offline"                                                                                                                                                                        
ktp-auth-handler(5812)/Telepathy-Qt:  Requested Presence: 2 - "available"                                                                                                                                                                    
ktp-auth-handler(5812)/Telepathy-Qt:  Changing Presence: true                                                                                                                                                                                
ktp-auth-handler(5812)/Telepathy-Qt:  Connection Object Path: "/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy"                                                                                
ktp-auth-handler(5812)/Telepathy-Qt: Building connection "/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy" for account "/org/freedesktop/Telepathy/Account/gabble/jabber/USERNAME_40jabber_2eorg0"                                                                                                                                                                                                                                          
ktp-auth-handler(5812)/Telepathy-Qt:  Connection Status: 1                                                                                                                                                                                   
ktp-auth-handler(5812)/Telepathy-Qt:  Connection StatusReason: 1                                                                                                                                                                             
ktp-auth-handler(5812)/Telepathy-Qt: Deferring finishing Account::FeatureCore until the connection is built                                                                                                                                  
ktp-auth-handler(5812)/Telepathy-Qt: Got capabilities                                                                                                                                                                                        
ktp-auth-handler(5812)/Telepathy-Qt: Retrieving contact attribute interfaces                                                                                                                                                                 
ktp-auth-handler(5812)/Telepathy-Qt: Got contact attribute interfaces                                                                                                                                                                        
ktp-auth-handler(5812)/Telepathy-Qt: ReadinessHelper::setIntrospectCompleted: feature: QPair("Tp::Connection",0) - success: true                                                                                                             
ktp-auth-handler(5812)/Telepathy-Qt: Channel has 2 optional interfaces: ("org.freedesktop.Telepathy.Channel.Interface.SASLAuthentication", "org.freedesktop.Telepathy.Channel.Interface.Securable")                                          
ktp-auth-handler(5812)/Telepathy-Qt: Have initiator handle: no                                                                                                                                                                               
ktp-auth-handler(5812)/Telepathy-Qt: Both the IS and the MCD queue empty for the first time. Ready.                                                                                                                                          
ktp-auth-handler(5812)/Telepathy-Qt: Channel fully ready
ktp-auth-handler(5812)/Telepathy-Qt:  Channel type "org.freedesktop.Telepathy.Channel.Type.ServerAuthentication"
ktp-auth-handler(5812)/Telepathy-Qt:  Target handle 0
ktp-auth-handler(5812)/Telepathy-Qt:  Target handle type 0
ktp-auth-handler(5812)/Telepathy-Qt: ReadinessHelper::setIntrospectCompleted: feature: QPair("Tp::Channel",0) - success: true
ktp-auth-handler(5812)/Telepathy-Qt: Connection "/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy" built for "/org/freedesktop/Telepathy/Account/gabble/jabber/USERNAME_40jabber_2eorg0"
ktp-auth-handler(5812)/Telepathy-Qt: Account "/org/freedesktop/Telepathy/Account/gabble/jabber/USERNAME_40jabber_2eorg0" basic functionality is ready (connections built)
ktp-auth-handler(5812)/Telepathy-Qt: ReadinessHelper::setIntrospectCompleted: feature: QPair("Tp::Account",0) - success: true
ktp-auth-handler(5812)/Telepathy-Qt: Invoking application handleChannels with 1 channels on 0x10a8c70
ktp-auth-handler(5812)/kdeui (Wallet): The kwalletd service has been disabled 
ktp-auth-handler(5812)/kdeui (Wallet): The kwalletd service has been disabled 
ktp-auth-handler(5812)/kdeui (Wallet): The kwalletd service has been disabled 
ktp-auth-handler(5812)/kdeui (Wallet): The kwalletd service has been disabled 
ktp-auth-handler(5812)/kdeui (Wallet): The kwalletd service has been disabled 
ktp-auth-handler(5812)/kdeui (Wallet): The kwalletd service has been disabled 
QObject::connect: Cannot connect (null)::walletOpened(bool) to KTp::PendingWallet::setFinished()
ktp-auth-handler(5812)/Telepathy-Qt: Got Channel::Closed
ktp-auth-handler(5812)/Telepathy-Qt: proxy invalidated: "org.freedesktop.Telepathy.Error.Cancelled": "channel closed"
ktp-auth-handler(5812)/Telepathy-Qt: Removing from factory cache invalidated proxy for QPair(":1.137","/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy/ServerSASLChannel")
ktp-auth-handler(5812)/Telepathy-Qt: Connection("/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy") got ConnectionError("org.freedesktop.Telepathy.Error.AuthenticationFailed") with 1 details
ktp-auth-handler(5812)/Telepathy-Qt: proxy invalidated: "org.freedesktop.Telepathy.Error.AuthenticationFailed": "WOCKY_AUTH_ERROR_FAILURE (#6): Client aborted authentication."
ktp-auth-handler(5812)/Telepathy-Qt: StatusChanged from 1 to 2 with reason 3
ktp-auth-handler(5812)/Telepathy-Qt: Tp::Connection(0x11b9020)  not emitting statusChanged because it has been invalidated
ktp-auth-handler(5812)/Telepathy-Qt: Already invalidated by "org.freedesktop.Telepathy.Error.AuthenticationFailed", not replacing with "org.freedesktop.Telepathy.Error.AuthenticationFailed" ""ConnectionStatusReason = 3""
ktp-auth-handler(5812)/Telepathy-Qt: Removing from factory cache invalidated proxy for QPair(":1.137","/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy")
ktp-auth-handler(5812)/Telepathy-Qt: Owning connection died leaving an orphan Channel, changing to closed
ktp-auth-handler(5812)/Telepathy-Qt: Already invalidated by "org.freedesktop.Telepathy.Error.Cancelled", not replacing with "org.freedesktop.Telepathy.Qt.Error.Orphaned" ""Connection given as the owner of this channel was invalidated""
ktp-auth-handler(5812)/Telepathy-Qt: Account::updateProperties: changed:
ktp-auth-handler(5812)/Telepathy-Qt:  Connection Object Path: "/"
ktp-auth-handler(5812)/Telepathy-Qt: Dropping connection for account "/org/freedesktop/Telepathy/Account/gabble/jabber/USERNAME_40jabber_2eorg0"
ktp-auth-handler(5812)/Telepathy-Qt:  Connection Status: 2
ktp-auth-handler(5812)/Telepathy-Qt:  Connection StatusReason: 3
ktp-auth-handler(5812)/Telepathy-Qt:  Connection Error: "org.freedesktop.Telepathy.Error.AuthenticationFailed"
ktp-auth-handler(5812)/Telepathy-Qt:  Connection Error Details: QMap(("debug-message", QVariant(QString, "WOCKY_AUTH_ERROR_FAILURE (#6): Client aborted authentication.") ) )

Comment 5 Kubuntiac 2012-09-23 01:55:36 UTC

Hmmm... I noticed all the instances of "ktp-auth-handler(5812)/kdeui (Wallet): The kwalletd service has been disabled" and checked, and sure enough there is neither a kwallet daemon running, nor is kwallet installed. In fact, now I think about it, I don't think I've *ever* seen kwallet come up in Chakra... I'll try installing it and see if that helps.

Comment 6 Kubuntiac 2012-09-23 02:05:33 UTC

Installing and enabling Kwallet makes the daemon appear and that one error disappear, but everything else still seems the same:

ktp-auth-handler(6641)/Telepathy-Qt: HandleChannels: account: "/org/freedesktop/Telepathy/Account/gabble/jabber/USERNAME_40jabber_2eorg0" , connection: "/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy"
ktp-auth-handler(6641)/Telepathy-Qt: Creating new DBusProxy
ktp-auth-handler(6641)/Telepathy-Qt: ReadinessHelper: new supportedStatuses = QSet(0)
ktp-auth-handler(6641)/Telepathy-Qt: ReadinessHelper: new supportedFeatures = QSet(QPair("Tp::Account",0) ,  QPair("Tp::Account",1) ,  QPair("Tp::Account",2) ,  QPair("Tp::Account",3) )
ktp-auth-handler(6641)/Telepathy-Qt: Inserting to factory cache proxy for QPair("org.freedesktop.Telepathy.AccountManager","/org/freedesktop/Telepathy/Account/gabble/jabber/USERNAME_40jabber_2eorg0")
ktp-auth-handler(6641)/Telepathy-Qt: Creating new DBusProxy
ktp-auth-handler(6641)/Telepathy-Qt: Connecting to ConnectionError()
ktp-auth-handler(6641)/Telepathy-Qt: Connecting to StatusChanged()
ktp-auth-handler(6641)/Telepathy-Qt: Connecting to SelfHandleChanged()
ktp-auth-handler(6641)/Telepathy-Qt: Reusing existing HandleContext for "/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy"
ktp-auth-handler(6641)/Telepathy-Qt: ReadinessHelper: new supportedStatuses = QSet(0, 4294967295, 1, 2)
ktp-auth-handler(6641)/Telepathy-Qt: ReadinessHelper: new supportedFeatures = QSet(QPair("Tp::Connection",6) ,  QPair("Tp::Connection",5) ,  QPair("Tp::Connection",4) ,  QPair("Tp::Connection",2) ,  QPair("Tp::Connection",1) ,  QPair("Tp::Connection",0) ,  QPair("Tp::Connection",7) )
ktp-auth-handler(6641)/Telepathy-Qt: Inserting to factory cache proxy for QPair(":1.157","/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy")
ktp-auth-handler(6641)/Telepathy-Qt: Creating new DBusProxy
ktp-auth-handler(6641)/Telepathy-Qt: Creating new Channel: "/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy/ServerSASLChannel"
ktp-auth-handler(6641)/Telepathy-Qt:  Connecting to Channel::Closed() signal
ktp-auth-handler(6641)/Telepathy-Qt:  Connection to owning connection's lifetime signals
ktp-auth-handler(6641)/Telepathy-Qt: ReadinessHelper: new supportedStatuses = QSet(0)
ktp-auth-handler(6641)/Telepathy-Qt: ReadinessHelper: new supportedFeatures = QSet(QPair("Tp::Channel",0) ,  QPair("Tp::Channel",1) )
ktp-auth-handler(6641)/Telepathy-Qt: ReadinessHelper: new supportedStatuses = QSet(0)
ktp-auth-handler(6641)/Telepathy-Qt: ReadinessHelper: new supportedFeatures = QSet(QPair("Tp::ServerAuthenticationChannel",0) ,  QPair("Tp::Channel",0) ,  QPair("Tp::Channel",1) )
ktp-auth-handler(6641)/Telepathy-Qt: Inserting to factory cache proxy for QPair(":1.157","/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy/ServerSASLChannel")
ktp-auth-handler(6641)/Telepathy-Qt: Preparing proxies for HandleChannels of 1 channels for client 0x1999350
ktp-auth-handler(6641)/Telepathy-Qt: Calling Properties::GetAll(Account) on  "/org/freedesktop/Telepathy/Account/gabble/jabber/USERNAME_40jabber_2eorg0"
ktp-auth-handler(6641)/Telepathy-Qt: Calling Properties::GetAll(Connection)
ktp-auth-handler(6641)/Telepathy-Qt: Calling Connection::becomeReady()
ktp-auth-handler(6641)/Telepathy-Qt: Got status: 1
ktp-auth-handler(6641)/Telepathy-Qt: Got interfaces: ("org.freedesktop.Telepathy.Connection.Interface.PowerSaving", "org.freedesktop.Telepathy.Connection.Interface.Aliasing", "org.freedesktop.Telepathy.Connection.Interface.Capabilities", "org.freedesktop.Telepathy.Connection.Interface.SimplePresence", "org.freedesktop.Telepathy.Connection.Interface.Presence", "org.freedesktop.Telepathy.Connection.Interface.Avatars", "org.freedesktop.Telepathy.Connection.Interface.ContactInfo", "org.freedesktop.Telepathy.Connection.Interface.Contacts", "org.freedesktop.Telepathy.Connection.Interface.ContactList", "org.freedesktop.Telepathy.Connection.Interface.ContactGroups", "org.freedesktop.Telepathy.Connection.Interface.Requests", "org.freedesktop.Telepathy.Connection.Interface.ContactCapabilities", "org.freedesktop.Telepathy.Connection.Interface.Location", "org.freedesktop.Telepathy.Connection.Interface.Gabble.Decloak", "org.freedesktop.Telepathy.Connection.FUTURE", "org.freedesktop.Telepathy.Connection.Interface.ClientTypes", "org.freedesktop.Telepathy.Connection.Interface.Addressing1")
ktp-auth-handler(6641)/Telepathy-Qt: Retrieving capabilities
ktp-auth-handler(6641)/Telepathy-Qt: Got reply to Properties.GetAll(Account) for "/org/freedesktop/Telepathy/Account/gabble/jabber/USERNAME_40jabber_2eorg0"
ktp-auth-handler(6641)/Telepathy-Qt: Account::updateProperties: changed:
ktp-auth-handler(6641)/Telepathy-Qt:  Interfaces: ("org.freedesktop.Telepathy.Account", "org.freedesktop.Telepathy.Account.Interface.Avatar", "com.nokia.Account.Interface.Compat", "com.nokia.Account.Interface.Conditions", "org.freedesktop.Telepathy.Account.Interface.Storage", "org.freedesktop.Telepathy.Account.Interface.Addressing", "org.freedesktop.Telepathy.Account.Interface.Hidden.DRAFT1")
ktp-auth-handler(6641)/Telepathy-Qt:  Service Name: "jabber"
ktp-auth-handler(6641)/Telepathy-Qt:  Display Name: "USERNAME@jabber.org"
ktp-auth-handler(6641)/Telepathy-Qt:  Valid: true
ktp-auth-handler(6641)/Telepathy-Qt:  Enabled: true
ktp-auth-handler(6641)/Telepathy-Qt:  Automatic Presence: 2 - "available"
ktp-auth-handler(6641)/Telepathy-Qt:  Current Presence: 1 - "offline"
ktp-auth-handler(6641)/Telepathy-Qt:  Requested Presence: 2 - "available"
ktp-auth-handler(6641)/Telepathy-Qt:  Changing Presence: true
ktp-auth-handler(6641)/Telepathy-Qt:  Connection Object Path: "/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy"
ktp-auth-handler(6641)/Telepathy-Qt: Building connection "/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy" for account "/org/freedesktop/Telepathy/Account/gabble/jabber/USERNAME_40jabber_2eorg0"
ktp-auth-handler(6641)/Telepathy-Qt:  Connection Status: 1
ktp-auth-handler(6641)/Telepathy-Qt:  Connection StatusReason: 1
ktp-auth-handler(6641)/Telepathy-Qt: Deferring finishing Account::FeatureCore until the connection is built
ktp-auth-handler(6641)/Telepathy-Qt: Got capabilities
ktp-auth-handler(6641)/Telepathy-Qt: Retrieving contact attribute interfaces
ktp-auth-handler(6641)/Telepathy-Qt: Got contact attribute interfaces
ktp-auth-handler(6641)/Telepathy-Qt: ReadinessHelper::setIntrospectCompleted: feature: QPair("Tp::Connection",0) - success: true
ktp-auth-handler(6641)/Telepathy-Qt: Channel has 2 optional interfaces: ("org.freedesktop.Telepathy.Channel.Interface.SASLAuthentication", "org.freedesktop.Telepathy.Channel.Interface.Securable")
ktp-auth-handler(6641)/Telepathy-Qt: Have initiator handle: no
ktp-auth-handler(6641)/Telepathy-Qt: Both the IS and the MCD queue empty for the first time. Ready.
ktp-auth-handler(6641)/Telepathy-Qt: Channel fully ready
ktp-auth-handler(6641)/Telepathy-Qt:  Channel type "org.freedesktop.Telepathy.Channel.Type.ServerAuthentication"
ktp-auth-handler(6641)/Telepathy-Qt:  Target handle 0
ktp-auth-handler(6641)/Telepathy-Qt:  Target handle type 0
ktp-auth-handler(6641)/Telepathy-Qt: ReadinessHelper::setIntrospectCompleted: feature: QPair("Tp::Channel",0) - success: true
ktp-auth-handler(6641)/Telepathy-Qt: Connection "/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy" built for "/org/freedesktop/Telepathy/Account/gabble/jabber/USERNAME_40jabber_2eorg0"
ktp-auth-handler(6641)/Telepathy-Qt: Account "/org/freedesktop/Telepathy/Account/gabble/jabber/USERNAME_40jabber_2eorg0" basic functionality is ready (connections built)
ktp-auth-handler(6641)/Telepathy-Qt: ReadinessHelper::setIntrospectCompleted: feature: QPair("Tp::Account",0) - success: true
ktp-auth-handler(6641)/Telepathy-Qt: Invoking application handleChannels with 1 channels on 0x1999350
QObject::connect: Cannot connect (null)::walletOpened(bool) to KTp::PendingWallet::setFinished()
ktp-auth-handler(6641)/Telepathy-Qt: Got Channel::Closed
ktp-auth-handler(6641)/Telepathy-Qt: proxy invalidated: "org.freedesktop.Telepathy.Error.Cancelled": "channel closed"
ktp-auth-handler(6641)/Telepathy-Qt: Removing from factory cache invalidated proxy for QPair(":1.157","/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy/ServerSASLChannel")
ktp-auth-handler(6641)/Telepathy-Qt: Connection("/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy") got ConnectionError("org.freedesktop.Telepathy.Error.AuthenticationFailed") with 1 details
ktp-auth-handler(6641)/Telepathy-Qt: proxy invalidated: "org.freedesktop.Telepathy.Error.AuthenticationFailed": "WOCKY_AUTH_ERROR_FAILURE (#6): Client aborted authentication."
ktp-auth-handler(6641)/Telepathy-Qt: StatusChanged from 1 to 2 with reason 3
ktp-auth-handler(6641)/Telepathy-Qt: Tp::Connection(0x1b3f880)  not emitting statusChanged because it has been invalidated
ktp-auth-handler(6641)/Telepathy-Qt: Already invalidated by "org.freedesktop.Telepathy.Error.AuthenticationFailed", not replacing with "org.freedesktop.Telepathy.Error.AuthenticationFailed" ""ConnectionStatusReason = 3""
ktp-auth-handler(6641)/Telepathy-Qt: Removing from factory cache invalidated proxy for QPair(":1.157","/org/freedesktop/Telepathy/Connection/gabble/jabber/USERNAME_40jabber_2eorg_2fkde_2dtelepathy")
ktp-auth-handler(6641)/Telepathy-Qt: Owning connection died leaving an orphan Channel, changing to closed
ktp-auth-handler(6641)/Telepathy-Qt: Already invalidated by "org.freedesktop.Telepathy.Error.Cancelled", not replacing with "org.freedesktop.Telepathy.Qt.Error.Orphaned" ""Connection given as the owner of this channel was invalidated""
ktp-auth-handler(6641)/Telepathy-Qt: Account::updateProperties: changed:
ktp-auth-handler(6641)/Telepathy-Qt:  Connection Object Path: "/"
ktp-auth-handler(6641)/Telepathy-Qt: Dropping connection for account "/org/freedesktop/Telepathy/Account/gabble/jabber/USERNAME_40jabber_2eorg0"
ktp-auth-handler(6641)/Telepathy-Qt:  Connection Status: 2
ktp-auth-handler(6641)/Telepathy-Qt:  Connection StatusReason: 3
ktp-auth-handler(6641)/Telepathy-Qt:  Connection Error: "org.freedesktop.Telepathy.Error.AuthenticationFailed"
ktp-auth-handler(6641)/Telepathy-Qt:  Connection Error Details: QMap(("debug-message", QVariant(QString, "WOCKY_AUTH_ERROR_FAILURE (#6): Client aborted authentication.") ) )

Comment 7 Kubuntiac 2012-09-23 02:09:30 UTC

Oh, and these are packages supplied by my distro. No compiling by me anywhere.

Comment 8 David Edmundson 2012-09-23 02:23:23 UTC

Ok, it's a wallet issue, and this is a bug.

@Kubuntiac 
There' still something wrong with your kwallet setup.
Try opening kwalletmanager, or something else that saves passwords.

@Ktp Devs
Turns out if KWallet is completely broken, the KWallet::openAsync will still return a null pointer, which means pending wallet never finishes. It needs to check and emit finished() immediately, otherwise everything deadlocks. Rest of WalletInterface can handle the null pointer.

Targeting a fix for 0.5.1

Comment 9 Kubuntiac 2012-09-23 02:41:02 UTC

Hmmm... I noticed when I opened kwallet manager that there weren't any wallets in there, so I created one (ie naming and double entering a new password). That seemed to go ok, but no change in telepathy. Now when I try to open kwalletmanager in konsole I get:
QDBusConnection: session D-Bus connection created before QCoreApplication. Application may misbehave.
QDBusConnection: session D-Bus connection created before QCoreApplication. Application may misbehave.

Comment 10 Kubuntiac 2012-09-23 02:46:03 UTC

Hah! Ok. When I went to delete the account and create it again, it asked me (for the first time ever) to open a kwallet and enter a password. I did, and now it connects and logs in.

So it seems the first problem was Kwallet not being installed. The second was not asking to create a new wallet. The third was how we report it when Kwallet is borked.

I'll also mention to the Chakra peeps that kwallet is a dependency of ktp. (This is correct, right?)

Comment 11 David Edmundson 2012-09-25 11:57:05 UTC

> Git commit b87a725b4e0e27d7280184de53b559b017641247 by David Edmundson.
> Committed on 25/09/2012 at 00:25.
> Pushed by davidedmundson into branch 'kde-telepathy-0.5'.
>
> Fix a bug in which the PendingWallet would hang forever if the wallet system is disabled
>
> This fixes bugs in the auth handler and AccountsKCM
> Related: bug 307302, bug 306953
>
> M  +3    -1    KTp/pending-wallet.cpp