| Summary: | Sent emails are stuck in outbox | ||
|---|---|---|---|
| Product: | [Frameworks and Libraries] Akonadi | Reporter: | Christophe Marin <christophe> |
| Component: | Mail Dispatcher Agent | Assignee: | kdepim bugs <kdepim-bugs> |
| Status: | RESOLVED FIXED | ||
| Severity: | normal | CC: | vkrause, winter |
| Priority: | NOR | ||
| Version: | GIT (master) | ||
| Target Milestone: | --- | ||
| Platform: | Compiled Sources | ||
| OS: | Linux | ||
| Latest Commit: | Version Fixed In: | ||
| Sentry Crash Report: | |||
| Attachments: |
gdb bt full
gdb thread apply all bt full |
||
|
Description
Christophe Marin
2017-08-09 08:36:50 UTC
Running fsck is not an option due to bug 379153 Log whem rmb'ing / send queued messages : -yuuko- krop 10:48 /kde/build/5/pim/pim-sieve-editor # 10:48:20 - akonadiserver(11158) - org.kde.pim.akonadiserver: Akonadi::Server::DataStore::open: Database "akonadi" opened using driver "QPSQL" 10:48:20 - akonadiserver(11158) - org.kde.pim.akonadiserver: Akonadi::Server::SearchRequest::exec: Executing search "searchUpdate-1502268500" 10:48:20 - akonadiserver(11158) - org.kde.pim.akonadiplugin_indexer: SearchPlugin::search: Got 0 results 10:48:20 - akonadiserver(11158) - org.kde.pim.akonadiserver: Akonadi::Server::SearchManager::searchUpdateResultsAvailable: searchUpdateResultsAvailable 494 0 results 10:48:20 - akonadiserver(11158) - org.kde.pim.akonadiserver: Akonadi::Server::SearchManager::searchUpdateResultsAvailable: Got 0 results, out of which 0 are already in the collection 10:48:20 - akonadiserver(11158) - org.kde.pim.akonadiserver: Akonadi::Server::SearchManager::searchUpdateResultsAvailable: Added results: 0 (fast path) 10:48:20 - akonadiserver(11158) - org.kde.pim.akonadiserver: Akonadi::Server::SearchRequest::exec: Search done "searchUpdate-1502268500" (without remote search) 10:48:20 - akonadiserver(11158) - org.kde.pim.akonadiserver: Akonadi::Server::SearchManager::updateSearchImpl: Search update finished 10:48:20 - akonadiserver(11158) - org.kde.pim.akonadiserver: Akonadi::Server::SearchManager::updateSearchImpl: All results: 0 10:48:20 - akonadiserver(11158) - org.kde.pim.akonadiserver: Akonadi::Server::SearchManager::updateSearchImpl: Removed results: 0 10:48:20 - akonadiserver(11158) - org.kde.pim.akonadiserver: Akonadi::Server::SearchRequest::exec: Executing search "searchUpdate-1502268500" 10:48:20 - akonadiserver(11158) - org.kde.pim.akonadiplugin_indexer: SearchPlugin::search: Got 0 results 10:48:20 - akonadiserver(11158) - org.kde.pim.akonadiserver: Akonadi::Server::SearchManager::searchUpdateResultsAvailable: searchUpdateResultsAvailable 495 0 results 10:48:20 - akonadiserver(11158) - org.kde.pim.akonadiserver: Akonadi::Server::SearchManager::searchUpdateResultsAvailable: Got 0 results, out of which 0 are already in the collection 10:48:20 - akonadiserver(11158) - org.kde.pim.akonadiserver: Akonadi::Server::SearchManager::searchUpdateResultsAvailable: Added results: 0 (fast path) 10:48:20 - akonadiserver(11158) - org.kde.pim.akonadiserver: Akonadi::Server::SearchRequest::exec: Search done "searchUpdate-1502268500" (without remote search) 10:48:20 - akonadiserver(11158) - org.kde.pim.akonadiserver: Akonadi::Server::SearchManager::updateSearchImpl: Search update finished 10:48:20 - akonadiserver(11158) - org.kde.pim.akonadiserver: Akonadi::Server::SearchManager::updateSearchImpl: All results: 0 10:48:20 - akonadiserver(11158) - org.kde.pim.akonadiserver: Akonadi::Server::SearchManager::updateSearchImpl: Removed results: 0 10:48:20 - akonadi_maildispatcher_agent(11226) - org.kde.pim.maildispatcher: OutboxQueue::Private::addIfComplete: Item 440844 is accepted into the queue (size 550 ). 10:48:20 - akonadi_maildispatcher_agent(11226) - org.kde.pim.maildispatcher: MailDispatcherAgent::Private::dispatch: Attempting to dispatch the next message. 10:48:20 - akonadi_maildispatcher_agent(11226) - org.kde.pim.maildispatcher: OutboxQueue::Private::addIfComplete: Item 440844 is ignored. 10:48:20 - akonadi_maildispatcher_agent(11226) - org.kde.pim.maildispatcher: OutboxQueue::Private::addIfComplete: Item 440844 is ignored. 10:48:20 - akonadi_maildispatcher_agent(11226) - org.kde.pim.maildispatcher: MailDispatcherAgent::Private::itemFetched: Fetched item 440844 ; creating SendJob. 10:48:20 - akonadi_maildispatcher_agent(11226) - org.kde.pim.maildispatcher: SendJob::Private::doTransport: Transporting message. 10:48:20 - akonadi_maildispatcher_agent(11226) - org.kde.pim.mailtransport: MailTransport::Transport::Transport: "1718429139" 10:48:20 - akonadi_maildispatcher_agent(11226) - org.kde.pim.maildispatcher: SendJob::Private::doPostJob: success false message "Server error" 10:48:20 - akonadi_maildispatcher_agent(11226) - org.kde.pim.maildispatcher: SendJob::Private::doPostJob: Error transporting. 10:48:20 - akonadi_maildispatcher_agent(11226) - org.kde.pim.maildispatcher: SendJob::Private::storeResult: success false message "Failed to transport message. Server error" 10:48:20 - akonadi_maildispatcher_agent(11226) - org.kde.pim.maildispatcher: StoreResultJob::Private::fetchDone: 10:48:20 - akonadi_maildispatcher_agent(11226) - org.kde.pim.maildispatcher: StoreResultJob::Private::modifyDone: 10:48:20 - akonadi_maildispatcher_agent(11226) - org.kde.pim.maildispatcher: SendJob::Private::doEmitResult: Success storing result. 10:48:20 - akonadi_maildispatcher_agent(11226) - org.kde.pim.maildispatcher: MailDispatcherAgent::Private::sendResult: Sending failed. error: "Failed to transport message. Server error" 10:48:20 - akonadi_maildispatcher_agent(11226) - org.kde.knotifications: KNotificationManager::notify: Calling notify on "Popup" 10:48:20 - akonadi_maildispatcher_agent(11226) - org.kde.pim.maildispatcher: MailDispatcherAgent::Private::dispatch: Empty queue. 10:48:20 - akonadi_maildispatcher_agent(11226) - org.kde.pim.maildispatcher: OutboxQueue::Private::addIfComplete: Item 440844 is queued to be sent manually. 10:48:20 - akonadi_maildispatcher_agent(11226) - org.kde.pim.maildispatcher: OutboxQueue::Private::addIfComplete: Item 440844 is queued to be sent manually. 10:48:20 - akonadi_maildispatcher_agent(11226) - org.kde.pim.ksmtp: : Socket error: 2 10:48:20 - akonadi_maildispatcher_agent(11226) - org.kde.pim.ksmtp: : Socket error: 2 I've had this as well since we changed over to the new ksmtp. although I really have no idea if that's just a coincidence. I've spent quite some time on it and never found any clues as to what might be happening. More things were rebuilt... KMail log on rmb / send queued messages : 20:32:20 - kmail2(1881) - org.kde.pim.messagecomposer: MessageComposer::AkonadiSender::doSendQueued: Sending queued message with custom transport: -1 20:32:20 - kmail2(1881) - org.kde.pim.mailtransportakonadi: Akonadi::FilterActionJob::doStart: Fetching collection 1385 20:32:20 - kmail2(1881) - org.kde.pim.mailtransportakonadi: Akonadi::FilterActionJob::Private::traverseItems: Traversing 1 items. 20:32:20 - kmail2(1881) - org.kde.pim.mailtransportakonadi: Akonadi::FilterActionJob::Private::traverseItems: Added subjob for item 441780 20:32:20 - kmail2(1881) - org.kde.pim.mailtransportakonadi: Akonadi::FilterActionJob::Private::traverseItems: Have subjobs; Done when last of them is 20:32:20 - kmail2(1881) - org.kde.pim.mailtransportakonadi: MailTransport::DispatcherInterfacePrivate::massModifyResult: succeeded. --- maildispatcher log : 20:32:20 - akonadi_maildispatcher_agent(32354) - org.kde.pim.maildispatcher: OutboxQueue::Private::addIfComplete: Item 441780 is accepted into the queue (size 529 ). 20:32:20 - akonadi_maildispatcher_agent(32354) - org.kde.pim.maildispatcher: MailDispatcherAgent::Private::dispatch: Attempting to dispatch the next message. 20:32:20 - akonadi_maildispatcher_agent(32354) - org.kde.pim.maildispatcher: OutboxQueue::Private::addIfComplete: Item 441780 is ignored. 20:32:20 - akonadi_maildispatcher_agent(32354) - org.kde.pim.maildispatcher: OutboxQueue::Private::addIfComplete: Item 441780 is ignored. 20:32:20 - akonadi_maildispatcher_agent(32354) - org.kde.pim.maildispatcher: MailDispatcherAgent::Private::itemFetched: Fetched item 441780 ; creating SendJob. 20:32:20 - akonadi_maildispatcher_agent(32354) - org.kde.pim.maildispatcher: SendJob::Private::doTransport: Transporting message. 20:32:20 - akonadi_maildispatcher_agent(32354) - org.kde.pim.mailtransport: MailTransport::Transport::Transport: "1468434794" 20:32:20 - akonadi_maildispatcher_agent(32354) - org.kde.pim.maildispatcher: SendJob::Private::doPostJob: success false message "Server error" 20:32:20 - akonadi_maildispatcher_agent(32354) - org.kde.pim.maildispatcher: SendJob::Private::doPostJob: Error transporting. 20:32:20 - akonadi_maildispatcher_agent(32354) - org.kde.pim.maildispatcher: SendJob::Private::storeResult: success false message "Failed to transport message. Server error" 20:32:20 - akonadi_maildispatcher_agent(32354) - org.kde.pim.maildispatcher: StoreResultJob::Private::fetchDone: 20:32:20 - akonadi_maildispatcher_agent(32354) - org.kde.pim.maildispatcher: StoreResultJob::Private::modifyDone: 20:32:20 - akonadi_maildispatcher_agent(32354) - org.kde.pim.maildispatcher: SendJob::Private::doEmitResult: Success storing result. 20:32:20 - akonadi_maildispatcher_agent(32354) - org.kde.pim.maildispatcher: MailDispatcherAgent::Private::sendResult: Sending failed. error: "Failed to transport message. Server error" 20:32:20 - akonadi_maildispatcher_agent(32354) - org.kde.knotifications: KNotificationManager::notify: Calling notify on "Popup" 20:32:20 - akonadi_maildispatcher_agent(32354) - org.kde.pim.maildispatcher: MailDispatcherAgent::Private::dispatch: Empty queue. 20:32:20 - akonadi_maildispatcher_agent(32354) - org.kde.pim.maildispatcher: OutboxQueue::Private::addIfComplete: Item 441780 is queued to be sent manually. 20:32:20 - akonadi_maildispatcher_agent(32354) - org.kde.pim.maildispatcher: OutboxQueue::Private::addIfComplete: Item 441780 is queued to be sent manually. I see: org.kde.pim.libkdepim: "Sending messages" and the message does seem to be sent ok. but never moved from outbox to sent-mail also I get a core from akonadi_maildispatcher_agent I will attach backtraces Created attachment 107204 [details]
gdb bt full
Created attachment 107205 [details]
gdb thread apply all bt full
if I comment out the Q_ASSERT(currentJob == job); lines in several places things work better. maybe another issue then ? It doesn't crash here. Dan fixed the assert problem so I'm good now. After wiping and reinstalling everything, I had the same crash as you and it's indeed gone since the last commit. |