[Kde-pim] akonadi_ical_resource problem

[Kevin Krammer]

On Wednesday, 2009-05-27, Douglas Harms wrote:
> I don't know if this is helpful to any of the akonadi folks, but just in
> case it is here's some more information about what's happening for me.

This is indeed helpful.

> I inserted some more kDebug statements into the akonadi code so I could
> see what's happening.  I start with an empty akonadi database and a
> handheld with 519 records, and I use kpilot to sync.  Looking at the
> log, I see the following entries 519 times (with different IDs (4, 5,
> etc.)) (this is from a kDebug statement I added at the beginning of
> handleResponse)
>
>     daemon(19853)/libakonadi Akonadi::JobPrivate::handleResponse:  "4"
> "[UIDNEXT 1 DATETIME "27-May-2009 15:21:41 +0000"]
>     daemon(19853)/libakonadi Akonadi::JobPrivate::handleResponse:  "4"
> "OK Append completed
>
> I'm pretty sure this is what I would expect to happen, since kpilot
> would have inserted 519 records into the akonadi database.

Exactly

> There are also 344 of the following entries in the log:
>
>     akonadi_ical_resource_0(19832)/libakonadi
> Akonadi::AgentBasePrivate::itemAdded: mObserver= 0x88246f0 this= 0x8824508

That is the notification the resource gets about the added items.

> And 344 of the following too (with IDs 1-344):
>
>     akonadi_ical_resource_0(19832)/libakonadi
> Akonadi::JobPrivate::handleResponse: "*" "1 FETCH (UID 1 REV 0 REMOTEID
> "" MIMETYPE

I think this is where the resource gets the data for the newly added items.

> There are 178 of the following entries in the log (from a kDebug
> statement I added):
>
>     akonadi_ical_resource_0(19832)/libakonadi
> Akonadi::ExpungeJob::doStart: Expunging???  "1400"
>
> And each of these is followed by an entry like (with different IDs):
>
>     akonadi_ical_resource_0(19832)/libakonadi
> Akonadi::JobPrivate::handleResponse: "*" "242 EXPUNGE

This is the second part of an ItemDeleteJob, so the question is why is 
something deleting the entries.

> Eventually the following entry appears and shortly afterwards
> akonadi_ical_resource quits:
>
>     akonadi_ical_resource_0(19832)/libakonadi
> Akonadi::MonitorPrivate::slotItemJobFinished: Error on fetching item:
> "No item found"

Most likely the result of an ItemFetchJob which has been started as part of 
the itemAdded notification (the monitor/changerecorder is configured to fetch 
full item payload).

> I've tested this in a "testing" account I created that uses the latest
> kde version distributed for fedora 10, and I've also tested it in my
> kde-devel account using everything compiled from sources in
> svn://anonsvn.kde.org/home/kde/branches/KDE/4.2/* .  The results are the
> same in both situations.
>
> Any thoughts/ideas/whatever?  Am I doing something completely wrong?

Would be interesting to check this with trunk.

One idea of what could go wrong is the following:
the ICAL resource writes to the file when it gets change notifications using a 
configurable delay.
My guess is that it does that while your sync is in progress.
By itself this wouldn't be a problem, however, writing the file will result in 
a file change notification, triggering a reload of the file and an explicit 
syncing in the other direction.

You could check if disabling file change monitoring or increasing the write 
delay to something a lot higher than your sync time helps to avoid this 
problem.

Cheers,
Kevin

-- 
Kevin Krammer, KDE developer, xdg-utils developer
KDE user support, developer mentoring


-------------- next part --------------
A non-text attachment was scrubbed...
Name: signature.asc
Type: application/pgp-signature
Size: 189 bytes
Desc: This is a digitally signed message part.
URL: <http://mail.kde.org/pipermail/kde-pim/attachments/20090528/7b59537a/attachment.sig>
-------------- next part --------------
_______________________________________________
KDE PIM mailing list kde-pim at kde.org
https://mail.kde.org/mailman/listinfo/kde-pim
KDE PIM home page at http://pim.kde.org/