"[Empty openid Team Cleanup Cron] Error removing empty openid team: database is locked" error when exporting data

Hello,

I tried using the “Export your Vikunja data” feature. I was notified via email that the export is successful, however, I see this error pop up every time I perform the export. Does this affect the exported data in any way?

2024-04-25T03:55:52.760848475Z: DEBUG   ▶ models/Handle 12fbd Starting to export user data for user 9...

2024-04-25T03:56:05.009576362Z: ERROR   ▶ openid/func1 12fe5 [Empty openid Team Cleanup Cron] Error removing empty openid team: database is locked

2024-04-25T03:57:00.675404246Z: DEBUG   ▶ models/Handle 1300f Done exporting user data for user 9...

Version: v0.23.0+564-42bfe107ae

Thanks!

The openid team cleanup happens periodically and is unrelated to the export itself.

Hello,

I just find it weird that it pops up whenever I trigger an export.

2024-04-25T03:41:00.008369875Z: DEBUG   ▶ models/func1 12d0a [Undone Overdue Tasks Reminder] Sending reminders to 0 users
**2024-04-25T03:41:37.533470386Z: DEBUG   ▶ models/Handle 12d1c Starting to export user data for user 9...**
2024-04-25T03:42:00.007545485Z: DEBUG   ▶ models/getTasksWithRemindersDueAndTheirUsers 12d3f [Task Reminder Cron] Looking for reminders between 2024-04-25 13:42:00 +1000 AEST and 2024-04-25 13:43:00 +1000 AEST to send...
2024-04-25T03:42:00.007743098Z: DEBUG   ▶ openid/RemoveEmptySSOTeams 12d41 Deleting empty teams: []
2024-04-25T03:42:00.008456887Z: DEBUG   ▶ models/getTasksWithRemindersDueAndTheirUsers 12d43 [Task Reminder Cron] Found 0 reminders
**2024-04-25T03:42:05.01427508Z: ERROR    ▶ openid/func1 12d48 [Empty openid Team Cleanup Cron] Error removing empty openid team: database is locked**
--
2024-04-25T03:55:00.030504801Z: DEBUG   ▶ models/func1 12fa7 [Undone Overdue Tasks Reminder] Sending reminders to 0 users
**2024-04-25T03:55:52.760848475Z: DEBUG   ▶ models/Handle 12fbd Starting to export user data for user 9...**
2024-04-25T03:56:00.001977723Z: DEBUG   ▶ models/getTasksWithRemindersDueAndTheirUsers 12fdc [Task Reminder Cron] Looking for reminders between 2024-04-25 13:56:00 +1000 AEST and 2024-04-25 13:57:00 +1000 AEST to send...
2024-04-25T03:56:00.003891076Z: DEBUG   ▶ openid/RemoveEmptySSOTeams 12fe0 Deleting empty teams: []
2024-04-25T03:56:00.004220396Z: DEBUG   ▶ models/getTasksWithRemindersDueAndTheirUsers 12fe1 [Task Reminder Cron] Found 0 reminders
**2024-04-25T03:56:05.009576362Z: ERROR   ▶ openid/func1 12fe5 [Empty openid Team Cleanup Cron] Error removing empty openid team: database is locked**
--
2024-04-25T04:08:00.026348351Z: DEBUG   ▶ models/getTasksWithRemindersDueAndTheirUsers 132a3 [Task Reminder Cron] Found 0 reminders
2024-04-25T04:08:00.039268908Z: DEBUG   ▶ models/func1 132a6 [Undone Overdue Tasks Reminder] Sending reminders to 0 users
**2024-04-25T04:08:51.01580216Z: DEBUG    ▶ models/Handle 132e2 Starting to export user data for user 9...**
2024-04-25T04:09:00.000815077Z: DEBUG   ▶ models/getTasksWithRemindersDueAndTheirUsers 13305 [Task Reminder Cron] Looking for reminders between 2024-04-25 14:09:00 +1000 AEST and 2024-04-25 14:10:00 +1000 AEST to send...
2024-04-25T04:09:00.002057426Z: DEBUG   ▶ openid/RemoveEmptySSOTeams 13308 Deleting empty teams: []
2024-04-25T04:09:05.007278512Z: ERROR   ▶ models/func1 1330b [Task Reminder Cron] Could not get tasks with reminders in the next minute: database is locked
**2024-04-25T04:09:05.007314985Z: ERROR   ▶ openid/func1 1330d [Empty openid Team Cleanup Cron] Error removing empty openid team: database is locked**
--
2024-04-25T06:06:14.663834146Z: DEBUG   ▶ initials/GetAvatar 14f5d Serving initials avatar for user 7 and size 25 from cache
2024-04-25T06:06:14.668775575Z: DEBUG   ▶ initials/GetAvatar 14f5f Serving initials avatar for user 12 and size 25 from cache
**2024-04-25T06:06:33.113051649Z: DEBUG   ▶ models/Handle 14f70 Starting to export user data for user 9...**
2024-04-25T06:07:00.002024512Z: DEBUG   ▶ models/getTasksWithRemindersDueAndTheirUsers 14f99 [Task Reminder Cron] Looking for reminders between 2024-04-25 16:07:00 +1000 AEST and 2024-04-25 16:08:00 +1000 AEST to send...
2024-04-25T06:07:00.00223646Z: DEBUG    ▶ openid/RemoveEmptySSOTeams 14f9b Deleting empty teams: []
2024-04-25T06:07:05.007893843Z: ERROR   ▶ openid/func1 14f9f [Empty openid Team Cleanup Cron] Error removing empty openid team: database is locked
--
2024-04-25T06:22:14.93302948Z: DEBUG    ▶ upload/GetAvatar 20d Serving uploaded avatar for user 13 and size 25 from cache.
2024-04-25T06:22:14.934118246Z: DEBUG   ▶ initials/GetAvatar 20f Serving initials avatar for user 7 and size 25 from cache
2024-04-25T06:22:22.659049069Z: DEBUG   ▶ models/Handle 21c Starting to export user data for user 9...
2024-04-25T06:23:00.002051389Z: DEBUG   ▶ models/getTasksWithRemindersDueAndTheirUsers 24b [Task Reminder Cron] Looking for reminders between 2024-04-25 16:23:00 +1000 AEST and 2024-04-25 16:24:00 +1000 AEST to send...
2024-04-25T06:23:00.002304045Z: DEBUG   ▶ openid/RemoveEmptySSOTeams 24d Deleting empty teams: []
**2024-04-25T06:23:05.007445072Z: ERROR   ▶ openid/func1 251 [Empty openid Team Cleanup Cron] Error removing empty openid team: database is locked**

On a related note, it seems that I cannot import the file I just exported. I don’t see anything in the logs related to it’s progress. Is it possible that this might be related to the error above?

I was able to export a file successfully (without any database locked error) from another test instance, and I was able to import it back.

Thanks

I’ve just pushed a change so that it won’t try to remove any teams when there are none to remove. This should remove the error message, but should not be related to the error you’re seeing, as both functions are responsible for completely different areas in Vikunja.

What do you mean by “cannot import the file” - what happens? What do you see in the interface? What did you expect to see?

what happens? What do you see in the interface?
It’s just stuck in the “Importing in progress…” page for a long time. Nothing appears in the logs.

What did you expect to see?
Logs to monitor the progress of importing data from “Vikunja Export”. I don’t see these logs when I imported the “Vikunja Export” data (from the instance that is having the openid error)

Example logs of a working import from “Vikunja Export” data (from my test instance).

2024-04-25T05:17:05.105393965Z: DEBUG   ▶ vikunja-file/Migrate 18779 [Vikunja File Import] Importing a zip file containing 5 files
2024-04-25T05:17:05.106568524Z: DEBUG   ▶ vikunja-file/Migrate 1877a [Vikunja File Import] Found a data file
2024-04-25T05:17:05.106612225Z: DEBUG   ▶ vikunja-file/Migrate 1877b [Vikunja File Import] Found a blob file
2024-04-25T05:17:05.106626285Z: DEBUG   ▶ vikunja-file/Migrate 1877c [Vikunja File Import] Found a blob file
2024-04-25T05:17:05.106636245Z: DEBUG   ▶ vikunja-file/Migrate 1877d [Vikunja File Import] Found a filter file
2024-04-25T05:17:05.106648895Z: DEBUG   ▶ vikunja-file/Migrate 1877e [Vikunja File Import] Found a version file
2024-04-25T05:17:05.106658265Z: DEBUG   ▶ vikunja-file/Migrate 1877f [Vikunja File Import]
2024-04-25T05:17:05.11583126Z: DEBUG    ▶ migration/insertFromStructure 18780 [creating structure] Creating 2 projects
2024-04-25T05:17:05.137391507Z: DEBUG   ▶ migration/createProjectWithEverything 1879f [creating structure] Created project 175
2024-04-25T05:17:05.13774111Z: DEBUG    ▶ migration/createProjectWithEverything 187a0 [creating structure] Creating 1 buckets
2024-04-25T05:17:05.141274159Z: DEBUG   ▶ migration/createProjectWithEverything 187a4 [creating structure] Created bucket 1003, old ID was 1
2024-04-25T05:17:05.15718286Z: DEBUG    ▶ models/Handle 187b6 Sending project created notifications to 0 subscribers for project 175

That’s normal. It will take a while to import everything.