[critical] Subtaskdate: Unable to migrate schema (duplicate column name: due_date)

[Heart1010]

Every x seconds I have this error in my log

Got error 'PHP message: [critical] Subtaskdate: Unable to migrate schema for the plugin: Subtaskdate => SQLSTATE[HY000]: General error: 1 duplicate column name: due_date'

...with debug set to true:

###################'
[Thu Feb 20 17:26:27.003980 2025] [proxy_fcgi:error] [pid 2044783:tid 2044786] [client 185.xxx.xxx.xxx:0] AH01071: Got error 'PHP message: [critical] Subtaskdate: Unable to migrate schema for the plugin: Subtaskdate => SQLSTATE[HY000]: General error: 1 duplicate column name: due_date; PHP message: [debug] Kanboard\\Core\\Controller\\Runner::executeMiddleware; PHP message: [debug] Subscriber executed: Kanboard\\Subscriber\\BootstrapSubscriber::execute; PHP message: [debug] Kanboard\\Core\\Controller\\BaseMiddleware::next => Kanboard\\Middleware\\AuthenticationMiddleware; PHP message: [debug] Kanboard\\Core\\Controller\\BaseMiddleware::next => Kanboard\\Middleware\\PostAuthenticationMiddleware; PHP message: [debug] Kanboard\\Core\\Controller\\BaseMiddleware::next => Kanboard\\Middleware\\ApplicationAuthorizationMiddleware; PHP message: [debug] Kanboard\\Core\\Controller\\BaseMiddleware::next => Kanboard\\Middleware\\ProjectAuthorizationMiddleware; PHP message: [debug] Kanboard\\Core\\Controller\\Runner::executeController => \\Kanboard\\Controller\\BoardAjaxController::check; PHP message: [debug] SQL: SELECT  "settings"."option", "settings"."value" FROM "settings"; PHP message: [debug] SQL: query_duration=7.1048736572266E-5; PHP message: [debug] SQL: total_execution_time=7.1048736572266E-5; PHP message: [debug] SQL: SELECT  "plugin_schema_versions"."version" FROM "plugin_schema_versions"   WHERE "plugin" = ?    LIMIT 1; PHP message: [debug] SQL: param[1]: 'trellojson2kanboard'; PHP message: [debug] SQL: query_duration=6.2942504882812E-5; PHP message: [debug] SQL: total_execution_time=0.00013399124145508; PHP message: [debug] SQL: SELECT  "plugin_schema_versions"."version" FROM "plugin_schema_versions"   WHERE "plugin" = ?    LIMIT 1; PHP message: [debug] SQL: param[1]: 'templatemanager'; PHP message: [debug] SQL: query_duration=9.3936920166016E-5; PHP message: [debug] SQL: total_execution_time=0.00022792816162109; PHP message: [debug] SQL: SELECT 1 FROM "settings"  WHERE "option" = ?; PHP message: [debug] SQL: param[1]: 'mailmagik_exclude_files_pattern'; PHP message: [debug] SQL: query_duration=4.1961669921875E-5; PHP message: [debug] SQL: total_execution_time=0.00026988983154297; PHP message: [debug] SQL: UPDATE "settings" SET "value"=?, "changed_on"=?, "changed_by"=?  WHERE "option" = ?; PHP message: [debug] SQL: param[1]: ''; PHP message: [debug] SQL: param[2]: '1740068786'; PHP message: [debug] SQL: param[3]: '0'; PHP message: [debug] SQL: param[4]: 'mailmagik_exclude_files_pattern'; PHP message: [debug] SQL: query_duration=3.2901763916016E-5; PHP message: [debug] SQL: total_execution_time=0.00030279159545898; PHP message: [debug] SQL: SELECT 1 FROM "settings"  WHERE "option" = ?; PHP message: [debug] SQL: param[1]: 'mailmagik_address'; PHP message: [debug] SQL: query_duration=1.2874603271484E-5; PHP message: [debug] SQL: total_execution_time=0.00031566619873047; PHP message: [debug] SQL: UPDATE "settings" SET "value"=?, "changed_on"=?, "changed_by"=?  WHERE "option" = ?; PHP message: [debug] SQL: param[1]: ''; PHP message: [debug] SQL: param[2]: '1740068786'; PHP message: [debug] SQL: param[3]: '0'; PHP message: [debug] SQL: param[4]: 'mailmagik_address'; PHP message: [debug] SQL: query_duration=1.5020370483398E-5; PHP message: [debug] SQL: total_execution_time=0.00033068656921387; PHP message: [debug] SQL: SELECT  "plugin_schema_versions"."version" FROM "plugin_schema_versions"   WHERE "plugin" = ?    LIMIT 1; PHP message: [debug] SQL: param[1]: 'subtaskdate'; PHP message: [debug] SQL: query_duration=4.2915344238281E-5; PHP message: [debug] SQL: total_execution_time=0.00037360191345215; PHP message: [debug] SQL: SELECT  "plugin_schema_versions"."version" FROM "plugin_schema_versions"   WHERE "plugin" = ?    LIMIT 1; PHP message: [debug] SQL: param[1]: 'starredprojects'; PHP message: [debug] SQL: query_duration=3.504753112793E-5; PHP message: [debug] SQL: total_execution_time=0.00040864944458008; PHP message: [debug] SQL: SELECT  "sessions"."data" FROM "sessions"   WHERE "id" = ? AND "expire_at" > ?    LIMIT 1; PHP message: [debug] SQL: param[1]: 'p8du4qdqa5nom548j6qshpnq52'; PHP message: [debug] SQL: param[2]: '1740068786'; PHP message: [debug] SQL: query_duration=5.793571472168E-5; PHP message: [debug] SQL: total_execution_time=0.00046658515930176; PHP message: [debug] SQL: SELECT  projects.id, projects.name FROM "projects" LEFT JOIN "project_has_users" ON "project_has_users"."project_id"="projects"."id"  WHERE project_has_users.user_id = ? AND projects.is_active IN (?); PHP message: [debug] SQL: param[1]: '1'; PHP message: [debug] SQL: param[2]: '1'; PHP message: [debug] SQL: query_duration=6.9856643676758E-5; PHP message: [debug] SQL: total_execution_time=0.00053644180297852; PHP message: [debug] SQL: SELECT  projects.id, projects.name FROM "projects" LEFT JOIN "project_has_groups" ON "project_has_groups"."project_id"="projects"."id" LEFT JOIN "group_has_users" ON "group_has_users"."group_id"="project_has_groups"."group_id"  WHERE group_has_users.user_id = ? AND projects.is_active IN (?); PHP message: [debug] SQL: param[1]: '1'; PHP message: [debug] SQL: param[2]: '1'; PHP message: [debug] SQL: query_duration=9.0122222900391E-5; PHP message: [debug] SQL: total_execution_time=0.00062656402587891; PHP message: [debug] SQL: SELECT  * FROM "actions"   WHERE "project_id" IN (?, ?, ?, ?); PHP message: [debug] SQL: param[1]: '4'; PHP message: [debug] SQL: param[2]: '3'; PHP message: [debug] SQL: param[3]: '2'; PHP message: [debug] SQL: param[4]: '1'; PHP message: [debug] SQL: query_duration=5.6028366088867E-5; PHP message: [debug] SQL: total_execution_time=0.00068259239196777; PHP message: [debug] SQL: SELECT  * FROM "action_has_params"   WHERE "action_id" IN (?, ?, ?, ?, ?, ?, ?); PHP message: [debug] SQL: param[1]: '3'; PHP message: [debug] SQL: param[2]: '4'; PHP message: [debug] SQL: param[3]: '5'; PHP message: [debug] SQL: param[4]: '6'; PHP message: [debug] SQL: param[5]: '7'; PHP message: [debug] SQL: param[6]: '8'; PHP message: [debug] SQL: param[7]: '9'; PHP message: [debug] SQL: query_duration=5.6982040405273E-5; PHP message: [debug] SQL: total_execution_time=0.00073957443237305; PHP message: [debug] SQL: SELECT  "user_has_metadata"."value" FROM "user_has_metadata"   WHERE "user_id" = ? AND "name" = ?    LIMIT 1; PHP message: [debug] SQL: param[1]: '1'; PHP message: [debug] SQL: param[2]: 'TR.color.scheme.user'; PHP message: [debug] SQL: query_duration=4.6014785766602E-5; PHP message: [debug] SQL: total_execution_time=0.00078558921813965; PHP message: [debug] SQL: SELECT 1 FROM "users"  WHERE "id" = ? AND "is_active" = ? AND "role" = ?; PHP message: [debug] SQL: param[1]: '1'; PHP message: [debug] SQL: param[2]: '1'; PHP message: [debug] SQL: param[3]: 'app-admin'; PHP message: [debug] SQL: query_duration=5.1021575927734E-5; PHP message: [debug] SQL: total_execution_time=0.00083661079406738; PHP message: [debug] SQL: SELECT COUNT(*) FROM "projects"  WHERE "id" = ? AND "last_modified" > ?; PHP message: [debug] SQL: param[1]: '4'; PHP message: [debug] SQL: param[2]: '1740040414'; PHP message: [debug] SQL: query_duration=3.1948089599609E-5; PHP message: [debug] SQL: total_execution_time=0.00086855888366699; PHP message: [debug] SQL: SELECT 1 FROM "sessions"  WHERE "id" = ?; PHP message: [debug] SQL: param[1]: 'p8du4qdqa5nom548j6qshpnq52'; PHP message: [debug] SQL: query_duration=2.4080276489258E-5; PHP message: [debug] SQL: total_execution_time=0.00089263916015625; PHP message: [debug] SQL: UPDATE "sessions" SET "expire_at"=?, "data"=?  WHERE "id" = ?; PHP message: [debug] SQL: param[1]: '1740070226'; PHP message: [debug] SQL: param[2]: 'user|a:24:{s:2:"id";i:1;s:8:"username";s:5:"admin";s:12:"is_ldap_user";b:0;s:4:"name";s:12:"My Name";s:5:"email";s:19:"my+email@gmail.com";s:9:"google_id";N;s:9:"github_id";N;s:21:"notifications_enabled";i:1;s:8:"timezone";s:13:"Europe/Berlin";s:8:"language";s:8:"de_DE_du";s:18:"disable_login_form";i:0;s:19:"twofactor_activated";b:0;s:16:"twofactor_secret";N;s:5:"token";s:0:"";s:20:"notifications_filter";i:4;s:15:"nb_failed_login";i:0;s:20:"lock_expiration_date";i:0;s:9:"gitlab_id";N;s:4:"
[Thu Feb 20 17:26:27.005205 2025] [proxy_fcgi:error] [pid 2044783:tid 2044786] [client 185.xxx.xxx.xxx:0] AH01071: Got error 'ilter";s:0:"";s:5:"theme";s:5:"light";}postAuthenticationValidated|b:1;pcsrf_key|s:64:"a3f8ae0962171ebf7b3223a771e934f6bda6544342808e0ddbcc0a663a7d3974";csrf_key|s:64:"ccc82093f0bff03d85298bb21c9e99c859c8472b0b5abc4968bb15278082b352";filters:4|s:11:"status:open";hasSubtaskInProgress|b:0;filters:3|s:11:"status:open";filters:2|s:11:...; PHP message: [debug] SQL: param[3]: 'p8du4qdqa5nom548j6qshpnq52'; PHP message: [debug] SQL: query_duration=3.3855438232422E-5; PHP message: [debug] SQL: total_execution_time=0.00092649459838867; PHP message: [debug] APP: nb_queries=19; PHP message: [debug] APP: rendering_time=0.070043802261353; PHP message: [debug] APP: memory_usage=1.37M; PHP message: [debug] APP: uri=/?controller=BoardAjaxController&action=check&project_id=4&timestamp=1740040414&csrf_token=95fe12db4b8a53746d8cd03c39b219a42fbaa3f6d5fd9d0c7447a0e239461bfc&_=1740040418504; PHP message: [debug] ###############################################'

[Heart1010]

The entry in plugin_schema_versions was missing - I've added it manually and the error message every x seconds is gone.

But why was that entry missing?
Can this happen if I clone the plugin from github instead of using the plugin manager?

[creecros]

No. Dont think so. What other plugins do you have. I remember writing code for a plugin that would screw with that...something like content cleaner or something.

[Heart1010]

You mean ContentCleaner plugin could have accidentally deleted that schema entry from Subtaskdate 🤔 ?

- AddSpentTime v1.7.2 by Tagirijus
- Auto Email Extended Actions v1.2.6 by Craig Crosby
- AutomaticActionUX v2.6.0 by aljawaid
- Calendar v1.5.0 by Frédéric Guillot, Alfred Bühler
- ContentCleaner v1.0.0 by aljawaid
- Coverimage v1.2.14.1 by BlueTeck + creecros
- DashboardTaskSorting v1.5.0 by Tagirijus
- Gantt v1.0.0 by Thomas DIJOUX
- Global search v1.0.5 by Valentino Pesce
- HighlightCodeSyntax v1.0.3 by Valentino Pesce
- Mailmagik v1.6.1 by Craig Crosby & Alfred Bühler
- MarkdownPlus v1.1.5 by Craig Crosby & Tomas Dittmann
- PasteImageToMarkdown v1.1.0 by Tomas Dittmann
- PluginManager v4.7.0 by aljawaid
- StarredProjects v0.5.0 by BibLibre
- SubtaskDueDate v1.1.3 by Manuel Raposo
- TableView v0.2.0 by Greyaz
- TagManager v1.6.0 by aljawaid
- Task2pdf v1.8.0 by Craig Crosby
- TaskAssignPriorityToCategory v0.8.1 by Manfred Hoffmann
- TaskOptionalUpdateStartDateOnMoveColumn v1.0.0 by Lasse Faber
- TaskSelector v1.0.2 by Tagirijus
- TemplateManager v2.9.0 by aljawaid
- ThemeRevision for Kanboard v1.1.12 by Greyaz
- URLCleaner v2.0.0 by aljawaid

P.S.: Thanks for the other tips you gave in that thread 😉

[creecros]

Yes, 100% it was content cleaner. Don't ask me why though, I've been out of the game too long to remember.