500 error while creating new repo from template

[kreys]

• Gitea version (or commit ref): 1.13.6 (the same was on 1.12.6)
• Git version: 2.24.3 (Apple Git-128)
• Operating system: MacOS
• Gitea is installed by brew
• Database (use [x]):
  • [ ] PostgreSQL
  • [X] MySQL
  • [ ] MSSQL
  • [ ] SQLite
• Can you reproduce the bug at https://try.gitea.io:
  • [ ] Yes (provide example URL)
  • [X] No
• Log gist:

  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] SELECT `id`, `lower_name`, `name`, `full_name`, `email`, `keep_email_private`, `email_notifications_preference`, `passwd`, `passwd_hash_algo`, `must_change_password`, `login_type`, `login_source`, `login_name`, `type`, `location`, `website`, `rands`, `salt`, `language`, `description`, `created_unix`, `updated_unix`, `last_login_unix`, `last_repo_visibility`, `max_repo_creation`, `is_active`, `is_admin`, `is_restricted`, `allow_git_hook`, `allow_import_local`, `allow_create_organization`, `prohibit_login`, `avatar`, `avatar_email`, `use_custom_avatar`, `num_followers`, `num_following`, `num_stars`, `num_repos`, `num_teams`, `num_members`, `visibility`, `repo_admin_change_team_access`, `diff_view_style`, `theme`, `keep_activity_private` FROM `user` WHERE `id`=? LIMIT 1 [3] - 1.156403ms
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] SELECT `id`, `lower_name`, `name`, `full_name`, `email`, `keep_email_private`, `email_notifications_preference`, `passwd`, `passwd_hash_algo`, `must_change_password`, `login_type`, `login_source`, `login_name`, `type`, `location`, `website`, `rands`, `salt`, `language`, `description`, `created_unix`, `updated_unix`, `last_login_unix`, `last_repo_visibility`, `max_repo_creation`, `is_active`, `is_admin`, `is_restricted`, `allow_git_hook`, `allow_import_local`, `allow_create_organization`, `prohibit_login`, `avatar`, `avatar_email`, `use_custom_avatar`, `num_followers`, `num_following`, `num_stars`, `num_repos`, `num_teams`, `num_members`, `visibility`, `repo_admin_change_team_access`, `diff_view_style`, `theme`, `keep_activity_private` FROM `user` WHERE id IN (SELECT `user`.id FROM `user` INNER JOIN `team_user` ON `team_user`.org_id = `user`.id INNER JOIN `team` ON `team`.id = `team_user`.team_id WHERE `team_user`.uid=? AND (`team`.authorize=? OR `team`.can_create_org_repo=?)) ORDER BY `user`.`updated_unix` DESC [3 owner true] - 660.458µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] SELECT `id`, `owner_id`, `owner_name`, `lower_name`, `name`, `description`, `website`, `original_service_type`, `original_url`, `default_branch`, `num_watches`, `num_stars`, `num_forks`, `num_issues`, `num_closed_issues`, `num_pulls`, `num_closed_pulls`, `num_milestones`, `num_closed_milestones`, `num_projects`, `num_closed_projects`, `is_private`, `is_empty`, `is_archived`, `is_mirror`, `status`, `is_fork`, `fork_id`, `is_template`, `template_id`, `size`, `is_fsck_enabled`, `close_issues_via_commit_in_any_branch`, `topics`, `trust_model`, `avatar`, `created_unix`, `updated_unix` FROM `repository` WHERE `id`=? LIMIT 1 [6] - 323.688µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] SELECT `id`, `repo_id`, `user_id`, `mode`, `created_unix`, `updated_unix` FROM `collaboration` WHERE `repo_id`=? AND `user_id`=? LIMIT 1 [6 3] - 181.857µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] SELECT `id`, `lower_name`, `name`, `full_name`, `email`, `keep_email_private`, `email_notifications_preference`, `passwd`, `passwd_hash_algo`, `must_change_password`, `login_type`, `login_source`, `login_name`, `type`, `location`, `website`, `rands`, `salt`, `language`, `description`, `created_unix`, `updated_unix`, `last_login_unix`, `last_repo_visibility`, `max_repo_creation`, `is_active`, `is_admin`, `is_restricted`, `allow_git_hook`, `allow_import_local`, `allow_create_organization`, `prohibit_login`, `avatar`, `avatar_email`, `use_custom_avatar`, `num_followers`, `num_following`, `num_stars`, `num_repos`, `num_teams`, `num_members`, `visibility`, `repo_admin_change_team_access`, `diff_view_style`, `theme`, `keep_activity_private` FROM `user` WHERE `id`=? LIMIT 1 [2] - 222.577µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] SELECT `id`, `repo_id`, `type`, `config`, `created_unix` FROM `repo_unit` WHERE (repo_id = ?) [6] - 268.569µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] BEGIN TRANSACTION [] - 91.747µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] SELECT `id`, `owner_id`, `owner_name`, `lower_name`, `name`, `description`, `website`, `original_service_type`, `original_url`, `default_branch`, `num_watches`, `num_stars`, `num_forks`, `num_issues`, `num_closed_issues`, `num_pulls`, `num_closed_pulls`, `num_milestones`, `num_closed_milestones`, `num_projects`, `num_closed_projects`, `is_private`, `is_empty`, `is_archived`, `is_mirror`, `status`, `is_fork`, `fork_id`, `is_template`, `template_id`, `size`, `is_fsck_enabled`, `close_issues_via_commit_in_any_branch`, `topics`, `trust_model`, `avatar`, `created_unix`, `updated_unix` FROM `repository` WHERE `owner_id`=? AND `lower_name`=? LIMIT 1 [3 test2] - 316.229µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] INSERT INTO `repository` (`owner_id`,`owner_name`,`lower_name`,`name`,`description`,`website`,`original_service_type`,`original_url`,`default_branch`,`num_watches`,`num_stars`,`num_forks`,`num_issues`,`num_closed_issues`,`num_pulls`,`num_closed_pulls`,`num_milestones`,`num_closed_milestones`,`num_projects`,`num_closed_projects`,`is_private`,`is_empty`,`is_archived`,`is_mirror`,`status`,`is_fork`,`fork_id`,`is_template`,`template_id`,`size`,`is_fsck_enabled`,`close_issues_via_commit_in_any_branch`,`topics`,`trust_model`,`avatar`,`created_unix`,`updated_unix`) VALUES (?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?,?) [3 sj test2 test2   0   0 0 0 0 0 0 0 0 0 0 0 false false false false 0 false 0 false 6 0 false false null default  1616674413 1616674413] - 416.087µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] DELETE FROM `repo_redirect` WHERE `owner_id`=? AND `lower_name`=? [3 test2] - 212.951µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] INSERT INTO `repo_unit` (`repo_id`,`type`,`config`,`created_unix`) VALUES (?, ?, ?, ?),(?, ?, ?, ?),(?, ?, ?, ?),(?, ?, ?, ?),(?, ?, ?, ?),(?, ?, ?, ?) [23 UnitTypeCode <nil> 1616674413 23 UnitTypeIssues {"EnableTimetracker":true,"AllowOnlyContributorsToTrackTime":true,"EnableDependencies":true} 1616674413 23 UnitTypePullRequests {"IgnoreWhitespaceConflicts":false,"AllowMerge":true,"AllowRebase":true,"AllowRebaseMerge":true,"AllowSquash":true} 1616674413 23 UnitTypeReleases <nil> 1616674413 23 UnitTypeWiki <nil> 1616674413 23 UnitTypeProjects <nil> 1616674413] - 371.453µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] UPDATE `user` SET `last_repo_visibility` = ?, `updated_unix` = ? WHERE `id`=? [false 1616674413 3] - 334.672µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] UPDATE `user` SET `updated_unix` = ?, `num_repos` = `num_repos` + ? WHERE `id`=? [1616674413 1 3] - 256.744µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] SELECT `id`, `repo_id`, `user_id`, `mode`, `created_unix`, `updated_unix` FROM `collaboration` WHERE `repo_id`=? [23] - 252.375µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] DELETE FROM `access` WHERE `repo_id`=? [23] - 215.971µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] SELECT `id`, `user_id`, `repo_id`, `mode`, `created_unix`, `updated_unix` FROM `watch` WHERE `user_id`=? AND `repo_id`=? LIMIT 1 [3 23] - 205.22µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] INSERT INTO `watch` (`user_id`,`repo_id`,`mode`,`created_unix`,`updated_unix`) VALUES (?,?,?,?,?) [3 23 1 1616674413 1616674413] - 188.089µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] UPDATE `repository` SET num_watches = num_watches + ? WHERE id = ? [1 23] - 301.32µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] SELECT `id`, `repo_id`, `org_id`, `is_system_webhook`, `url`, `signature`, `http_method`, `content_type`, `secret`, `events`, `is_ssl`, `is_active`, `hook_task_type`, `meta`, `last_status`, `created_unix`, `updated_unix` FROM `webhook` WHERE (repo_id=? AND org_id=? AND is_system_webhook=?) [0 0 false] - 263.625µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] ROLLBACK [] - 870.307µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] BEGIN TRANSACTION [] - 142.498µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] SELECT `id`, `lower_name`, `name`, `full_name`, `email`, `keep_email_private`, `email_notifications_preference`, `passwd`, `passwd_hash_algo`, `must_change_password`, `login_type`, `login_source`, `login_name`, `type`, `location`, `website`, `rands`, `salt`, `language`, `description`, `created_unix`, `updated_unix`, `last_login_unix`, `last_repo_visibility`, `max_repo_creation`, `is_active`, `is_admin`, `is_restricted`, `allow_git_hook`, `allow_import_local`, `allow_create_organization`, `prohibit_login`, `avatar`, `avatar_email`, `use_custom_avatar`, `num_followers`, `num_following`, `num_stars`, `num_repos`, `num_teams`, `num_members`, `visibility`, `repo_admin_change_team_access`, `diff_view_style`, `theme`, `keep_activity_private` FROM `user` WHERE `id`=? LIMIT 1 [3] - 290.631µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] SELECT `id`, `owner_id`, `owner_name`, `lower_name`, `name`, `description`, `website`, `original_service_type`, `original_url`, `default_branch`, `num_watches`, `num_stars`, `num_forks`, `num_issues`, `num_closed_issues`, `num_pulls`, `num_closed_pulls`, `num_milestones`, `num_closed_milestones`, `num_projects`, `num_closed_projects`, `is_private`, `is_empty`, `is_archived`, `is_mirror`, `status`, `is_fork`, `fork_id`, `is_template`, `template_id`, `size`, `is_fsck_enabled`, `close_issues_via_commit_in_any_branch`, `topics`, `trust_model`, `avatar`, `created_unix`, `updated_unix` FROM `repository` WHERE `owner_id`=? AND `id`=? LIMIT 1 [3 23] - 449.914µs
  2021/03/25 13:13:33 ...m.io/xorm/core/db.go:286:afterProcess() [I] [SQL] ROLLBACK [] - 98.787µs
  2021/03/25 13:13:33 ...pository/generate.go:69:GenerateRepository() [E] Rollback deleteRepository: repository does not exist [id: 23, uid: 3, owner_name: , name: ]
  2021/03/25 13:13:33 routers/repo/repo.go:183:handleCreateError() [E] CreatePost: generateRepoCommit: git clone: exit status 128 - Cloning into '/var/folders/7c/gysgj3r14rl7txb_mm2nlw5m0000gn/T/gitea-test2323297272'...
  warning: --depth is ignored in local clones; use file:// instead.
  done.
  git-lfs filter-process: git-lfs: command not found
  fatal: the remote end hung up unexpectedly
  warning: Clone succeeded, but checkout failed.
  You can inspect what was checked out with 'git status'
  and retry with 'git restore --source=HEAD :/'

Description

I have created some template project for new repositories, it has some base structure and some githooks prepared, also for git-lfs usage. When I use it as a template and created new repository with this template I get 500 error. Repository looks like it wasn't created, however I can't find it in unadopted files. After adopting it is just empty repo, not based on my template.

From logs it looks like there is some issue with git lfs githooks probably?

Repro steps: 1) Create new repo, configure it for use with git-lfs 2) Mark it as template 3) Create new repo with this template

Forking such repo works normally.

[kreys]

One more thing worth mentioning, I thought that might be relevant - while creating template repo I was using custom git hooks path (located in .githooks directory) and git-lfs hooks went there.