1. 0.07 s $ /nix/store/9ypz3flqsrl5xl495mm8h645gadjsxi1-coreutils-9.11/bin/timeout --kill-after=15s 7200s /nix/store/23zk8sgzamrbmj1fday15szf7f2279s8-nix-2.34.7/bin/nix --extra-experimental-features nix-command --extra-experimental-features flakes --log-format internal-json build --no-link --print-out-paths git+https://codeberg.org/mtlynch/little-moments?ref=about-header&rev=e238fe01c1a98a5afcd51a89e0b23e8502e774fa#packages.x86_64-linux.go-tests --print-build-logs
  2. 0.54 s error (ignored): SQLite database '/var/cache/nix-ci-worker/eval-cache-v6/dc175ae9b62711fa112a16f515f7efeda3f24d9aa36537e6c60d2323c8d1fb72.sqlite' is busy
  3. 1.00 s
  4. 1.20 s Downloading cached source from https://cache.nix-ci.com
  5. 11.99 s Progress: 1 of 1 downloaded from cache
  6. 14.17 s
  7. 14.18 s Downloading cached errcheck from https://cache.nix-ci.com
  8. 14.18 s Downloading cached gci from https://cache.nix-ci.com
  9. 14.18 s Downloading cached go-critic from https://cache.nix-ci.com
  10. 14.18 s Downloading cached go-tools from https://cache.nix-ci.com
  11. 14.18 s Downloading cached xgcc-15.2.0-libgcc from https://cache.nix-ci.com
  12. 14.18 s Downloading cached libunistring from https://cache.nix-ci.com
  13. 14.48 s Progress: 0 of 6 built, 1 of 12 downloaded from cache (5 downloading)
  14. 14.48 s Progress: 0 of 6 built, 2 of 12 downloaded from cache (4 downloading)
  15. 14.66 s Progress: 0 of 5 built, 3 of 12 downloaded from cache (3 downloading)
  16. 14.70 s Progress: 0 of 4 built, 4 of 12 downloaded from cache (2 downloading)
  17. 14.70 s Downloading cached libidn2 from https://cache.nix-ci.com
  18. 14.77 s Progress: 0 of 4 built, 5 of 12 downloaded from cache (2 downloading)
  19. 14.77 s Downloading cached glibc-2.40 from https://cache.nix-ci.com
  20. 14.87 s Progress: 0 of 4 built, 6 of 12 downloaded from cache (2 downloading)
  21. 15.48 s Progress: 0 of 3 built, 7 of 12 downloaded from cache (1 downloading)
  22. 15.48 s Downloading cached zlib from https://cache.nix-ci.com
  23. 15.50 s Progress: 0 of 3 built, 8 of 12 downloaded from cache (1 downloading)
  24. 15.50 s Downloading cached sqlite from https://cache.nix-ci.com
  25. 15.50 s Downloading cached sqlite-3.51.1-bin from https://cache.nix-ci.com
  26. 15.55 s Progress: 0 of 3 built, 9 of 12 downloaded from cache (2 downloading)
  27. 15.55 s Progress: 0 of 3 built, 10 of 12 downloaded from cache (1 downloading)
  28. 15.55 s Downloading cached sqlite-3.51.1-dev from https://cache.nix-ci.com
  29. 15.57 s Progress: 0 of 3 built, 11 of 12 downloaded from cache (1 downloading)
  30. 15.58 s Progress: 0 of 2 built, 12 of 12 downloaded from cache
  31. 15.71 s Building /nix/store/1vcmfik3cbjbisc8bzj1vxf5raq1vf3r-go-tests-0.0.0.drv
  32. 15.78 s [go-tests] Phase: unpackPhase
  33. 15.79 s [go-tests] unpacking source archive /nix/store/3r7nmmsn6pajj1pjfyb5pacmlsy08adp-source
  34. 15.81 s [go-tests] source root is source
  35. 15.83 s [go-tests] Phase: patchPhase
  36. 15.84 s [go-tests] Phase: updateAutotoolsGnuConfigScriptsPhase
  37. 15.86 s [go-tests] Phase: configurePhase
  38. 15.88 s [go-tests] no configure script, doing nothing
  39. 15.89 s [go-tests] Phase: buildPhase
  40. 15.90 s [go-tests] patching script interpreter paths in ./dev-scripts
  41. 15.90 s [go-tests] ./dev-scripts/run-go-tests: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  42. 15.93 s [go-tests] ./dev-scripts/check-go-formatting: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  43. 15.95 s [go-tests] ./dev-scripts/serve: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  44. 15.97 s [go-tests] ./dev-scripts/upload-prod-db: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  45. 16.00 s [go-tests] ./dev-scripts/run-e2e-tests: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  46. 16.02 s [go-tests] ./dev-scripts/download-prod-db: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  47. 16.05 s [go-tests] ./dev-scripts/populate-db: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  48. 16.08 s [go-tests] ./dev-scripts/build-backend: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  49. 16.12 s [go-tests] ./dev-scripts/check-trailing-whitespace: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  50. 16.16 s [go-tests] ./dev-scripts/serve-docker: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  51. 16.19 s [go-tests] ./dev-scripts/check-frontend: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  52. 16.23 s [go-tests] ./dev-scripts/run-single-go-test: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  53. 16.25 s [go-tests] ./dev-scripts/render-design-doc: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  54. 16.28 s [go-tests] ./dev-scripts/check-bash: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  55. 16.30 s [go-tests] ./dev-scripts/enable-git-hooks: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  56. 16.33 s [go-tests] ./dev-scripts/check-go-test-packages: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  57. 16.35 s [go-tests] ./dev-scripts/enable-multiarch-docker: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  58. 16.37 s [go-tests] ./dev-scripts/lint-sql: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  59. 16.40 s [go-tests] ./dev-scripts/package-binaries: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  60. 16.42 s [go-tests] ./dev-scripts/reset-db: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  61. 16.45 s [go-tests] ./dev-scripts/check-trailing-newline: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  62. 16.47 s [go-tests] ./dev-scripts/git-hooks/pre-commit: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  63. 16.64 s [go-tests] + set -o pipefail
  64. 16.64 s [go-tests] + full_test=
  65. 16.64 s [go-tests] + go_test_flags=("-tags=netgo,osusergo")
  66. 16.64 s [go-tests] + go_test_flags+=("-fullpath")
  67. 16.64 s [go-tests] + readonly COVERAGE_FILE_RAW=.coverage.out
  68. 16.64 s [go-tests] + COVERAGE_FILE_RAW=.coverage.out
  69. 16.64 s [go-tests] + readonly COVERAGE_FILE_HTML=.coverage.html
  70. 16.64 s [go-tests] + COVERAGE_FILE_HTML=.coverage.html
  71. 16.64 s [go-tests] + [[ '' = \-\-full ]]
  72. 16.64 s [go-tests] + set -u
  73. 16.64 s [go-tests] +++ dirname ./dev-scripts/run-go-tests
  74. 16.65 s [go-tests] ++ cd ./dev-scripts
  75. 16.65 s [go-tests] ++ pwd
  76. 16.65 s [go-tests] + SCRIPT_DIR=/build/source/dev-scripts
  77. 16.65 s [go-tests] + readonly SCRIPT_DIR
  78. 16.65 s [go-tests] + cd /build/source/dev-scripts/..
  79. 16.65 s [go-tests] + go test -tags=netgo,osusergo -fullpath ./...
  80. 22.69 s [go-tests] ? codeberg.org/mtlynch/little-moments/build [no test files]
  81. 29.35 s [go-tests] ? codeberg.org/mtlynch/little-moments/cmd/app [no test files]
  82. 35.78 s [go-tests] ? codeberg.org/mtlynch/little-moments/cmd/import-from-tinybeans [no test files]
  83. 35.79 s [go-tests] ? codeberg.org/mtlynch/little-moments/convert [no test files]
  84. 36.97 s [go-tests] 2026/06/22 17:30:09 reading DB from file:/TestAboutPageIncludesVersionMetadata_0x1c154187c488?vfs=memdb
  85. 36.97 s [go-tests] 2026/06/22 17:30:10 CSP media origin: ""
  86. 36.97 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  87. 36.97 s [go-tests] --- FAIL: TestAboutPageIncludesVersionMetadata (1.07s)
  88. 36.97 s [go-tests] /build/source/handlers/about_test.go:74: about heading not found
  89. 36.97 s [go-tests] 2026/06/22 17:30:10 failed to read auth session from context: session backend unavailable
  90. 36.97 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestAuthFlow_0x1c1544df4b48?vfs=memdb
  91. 36.97 s [go-tests] 2026/06/22 17:30:10 inserting magic login token for user 11111111-1111-4111-8111-111111111111
  92. 36.97 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  93. 36.97 s [go-tests] 2026/06/22 17:30:10 login confirm: consumed token for user 11111111-1111-4111-8111-111111111111
  94. 36.97 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRejectsOpenRedirectNextURL_0x1c1544df5208?vfs=memdb
  95. 36.97 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  96. 36.97 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginConfirmPost/missing_token_returns_400_0x1c1544df5688?vfs=memdb
  97. 36.97 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  98. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginConfirmPost/malformed_token_returns_400_0x1c1544df58c8?vfs=memdb
  99. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  100. 36.98 s [go-tests] 2026/06/22 17:30:10 login confirm: invalid token format: invalid login token: must be 32 alphanumeric characters
  101. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginConfirmPost/well-formed_token_that%27s_not_in_store_returns_401_0x1c1544df5b08?vfs=memdb
  102. 36.98 s [go-tests] 2026/06/22 17:30:10 inserting magic login token for user 11111111-1111-4111-8111-111111111111
  103. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  104. 36.98 s [go-tests] 2026/06/22 17:30:10 login confirm: invalid token attempt
  105. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginConfirmPost/valid_token_that%27s_expired_returns_401_0x1c1544df5d48?vfs=memdb
  106. 36.98 s [go-tests] 2026/06/22 17:30:10 inserting magic login token for user 11111111-1111-4111-8111-111111111111
  107. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  108. 36.98 s [go-tests] 2026/06/22 17:30:10 login confirm: expired token attempt
  109. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginConfirmPost/valid_token_that%27s_already_used_returns_401_0x1c1545310008?vfs=memdb
  110. 36.98 s [go-tests] 2026/06/22 17:30:10 inserting magic login token for user 11111111-1111-4111-8111-111111111111
  111. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  112. 36.98 s [go-tests] 2026/06/22 17:30:10 login confirm: already-used token attempt
  113. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginConfirmPost/valid_token_with_session_creation_failure_returns_500_0x1c1545310248?vfs=memdb
  114. 36.98 s [go-tests] 2026/06/22 17:30:10 inserting magic login token for user 11111111-1111-4111-8111-111111111111
  115. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  116. 36.98 s [go-tests] 2026/06/22 17:30:10 login confirm: consumed token for user 11111111-1111-4111-8111-111111111111
  117. 36.98 s [go-tests] 2026/06/22 17:30:10 login confirm: failed to confirm login: create auth session: session broken
  118. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginConfirmPost/valid_token_with_successful_session_creation_redirects_to_stored_next_path_0x1c15453106c8?vfs=memdb
  119. 36.98 s [go-tests] 2026/06/22 17:30:10 inserting magic login token for user 11111111-1111-4111-8111-111111111111
  120. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  121. 36.98 s [go-tests] 2026/06/22 17:30:10 login confirm: consumed token for user 11111111-1111-4111-8111-111111111111
  122. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRejectsMalformedFormBody_0x1c1545310908?vfs=memdb
  123. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  124. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRendersCheckEmailPageRegardlessOfRegistration/registered_email_shows_check-email_page_0x1c1545310d88?vfs=memdb
  125. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  126. 36.98 s [go-tests] 2026/06/22 17:30:10 inserting magic login token for user 11111111-1111-4111-8111-111111111111
  127. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRendersCheckEmailPageRegardlessOfRegistration/unregistered_email_shows_check-email_page_0x1c1545311448?vfs=memdb
  128. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  129. 36.98 s [go-tests] 2026/06/22 17:30:10 login attempt from unregistered email: unregistered@example.com
  130. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginPostDoesNotLeakTokenInProdMode_0x1c1545311b08?vfs=memdb
  131. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  132. 36.98 s [go-tests] 2026/06/22 17:30:10 inserting magic login token for user 11111111-1111-4111-8111-111111111111
  133. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRejectsInvalidNextPath/protocol-relative_next_path_is_invalid_0x1c15458f8488?vfs=memdb
  134. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  135. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRejectsInvalidNextPath/next_path_without_leading_slash_is_invalid_0x1c15458f86c8?vfs=memdb
  136. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  137. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRejectsInvalidNextPath/malformed_next_path_is_invalid_0x1c15458f8908?vfs=memdb
  138. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  139. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRejectsInvalidNextPath/http_next_path_is_invalid_0x1c15458f8008?vfs=memdb
  140. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  141. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRejectsInvalidNextPath/https_next_path_is_invalid_0x1c15458f8488?vfs=memdb
  142. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  143. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRejectsInvalidNextPath/non-http_absolute_next_path_is_invalid_0x1c15458f86c8?vfs=memdb
  144. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  145. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRejectsInvalidEmail_0x1c15458f8b48?vfs=memdb
  146. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  147. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginPostReturnsTooManyRequestsAfterIPv4Limit_0x1c15458f8d88?vfs=memdb
  148. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  149. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginPostDoesNotApplyIPv4LimitToIPv6_0x1c15458f9448?vfs=memdb
  150. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  151. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginPostReturnsTooManyRequestsWhenRateLimited_0x1c15458f9b08?vfs=memdb
  152. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  153. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestLoginPostReturnsErrorWhenTokenCreationFails_0x1c15458f9d48?vfs=memdb
  154. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  155. 36.98 s [go-tests] 2026/06/22 17:30:10 failed to create login token: database unavailable
  156. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestUploadGetRequiresOwner/unauthenticated_user_is_redirected_to_login_0x1c1542080488?vfs=memdb
  157. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  158. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestUploadGetRequiresOwner/subscriber_is_forbidden_0x1c15420806c8?vfs=memdb
  159. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  160. 36.98 s [go-tests] 2026/06/22 17:30:10 reading DB from file:/TestUploadGetRequiresOwner/owner_sees_the_upload_form_0x1c1542080008?vfs=memdb
  161. 36.98 s [go-tests] 2026/06/22 17:30:10 cleaning expired auth sessions from store
  162. 36.98 s [go-tests] FAIL
  163. 36.98 s [go-tests] FAIL codeberg.org/mtlynch/little-moments/handlers 1.186s
  164. 36.98 s [go-tests] ok codeberg.org/mtlynch/little-moments/imagepipe 0.022s
  165. 36.98 s [go-tests] ? codeberg.org/mtlynch/little-moments/images [no test files]
  166. 36.98 s [go-tests] ok codeberg.org/mtlynch/little-moments/importers 0.009s
  167. 36.98 s [go-tests] ok codeberg.org/mtlynch/little-moments/importers/tinybeans 0.011s
  168. 36.98 s [go-tests] ok codeberg.org/mtlynch/little-moments/importers/tinybeans/parse 0.013s
  169. 36.98 s [go-tests] ok codeberg.org/mtlynch/little-moments/little_moments 0.007s
  170. 36.98 s [go-tests] ok codeberg.org/mtlynch/little-moments/little_moments/login_token 0.005s
  171. 36.98 s [go-tests] ok codeberg.org/mtlynch/little-moments/magiclogin 0.008s
  172. 36.98 s [go-tests] ok codeberg.org/mtlynch/little-moments/magiclogin/loginmail 0.005s
  173. 36.98 s [go-tests] ok codeberg.org/mtlynch/little-moments/magiclogin/loginmail/smtp 0.008s
  174. 36.98 s [go-tests] ok codeberg.org/mtlynch/little-moments/mediastore 0.010s
  175. 36.98 s [go-tests] ? codeberg.org/mtlynch/little-moments/random [no test files]
  176. 36.98 s [go-tests] ok codeberg.org/mtlynch/little-moments/ratelimit 0.004s
  177. 36.98 s [go-tests] ? codeberg.org/mtlynch/little-moments/s3 [no test files]
  178. 36.98 s [go-tests] ok codeberg.org/mtlynch/little-moments/s3config 0.007s
  179. 36.98 s [go-tests] ? codeberg.org/mtlynch/little-moments/store [no test files]
  180. 36.98 s [go-tests] ok codeberg.org/mtlynch/little-moments/store/sqlite 1.179s
  181. 36.98 s [go-tests] ? codeberg.org/mtlynch/little-moments/store/test_sqlite [no test files]
  182. 36.98 s [go-tests] FAIL
  183. 37.28 s Progress: 0 of 1 built (1 failed), 12 of 12 downloaded from cache
  184. 37.29 s Cannot build '/nix/store/1vcmfik3cbjbisc8bzj1vxf5raq1vf3r-go-tests-0.0.0.drv'.
  185. 37.29 s Reason: builder failed with exit code 1.
  186. 37.29 s Output paths:
  187. 37.29 s /nix/store/706c0p0q7h66nzgy69lj936w2zycnfb6-go-tests-0.0.0
  188. 37.29 s Last 151 log lines:
  189. 37.29 s > Running phase: unpackPhase
  190. 37.29 s > unpacking source archive /nix/store/3r7nmmsn6pajj1pjfyb5pacmlsy08adp-source
  191. 37.29 s > source root is source
  192. 37.29 s > Running phase: patchPhase
  193. 37.29 s > Running phase: updateAutotoolsGnuConfigScriptsPhase
  194. 37.29 s > Running phase: configurePhase
  195. 37.29 s > no configure script, doing nothing
  196. 37.29 s > Running phase: buildPhase
  197. 37.29 s > patching script interpreter paths in ./dev-scripts
  198. 37.29 s > ./dev-scripts/run-go-tests: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  199. 37.29 s > ./dev-scripts/check-go-formatting: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  200. 37.29 s > ./dev-scripts/serve: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  201. 37.29 s > ./dev-scripts/upload-prod-db: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  202. 37.29 s > ./dev-scripts/run-e2e-tests: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  203. 37.29 s > ./dev-scripts/download-prod-db: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  204. 37.29 s > ./dev-scripts/populate-db: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  205. 37.29 s > ./dev-scripts/build-backend: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  206. 37.29 s > ./dev-scripts/check-trailing-whitespace: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  207. 37.29 s > ./dev-scripts/serve-docker: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  208. 37.29 s > ./dev-scripts/check-frontend: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  209. 37.29 s > ./dev-scripts/run-single-go-test: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  210. 37.29 s > ./dev-scripts/render-design-doc: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  211. 37.29 s > ./dev-scripts/check-bash: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  212. 37.29 s > ./dev-scripts/enable-git-hooks: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  213. 37.29 s > ./dev-scripts/check-go-test-packages: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  214. 37.29 s > ./dev-scripts/enable-multiarch-docker: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  215. 37.29 s > ./dev-scripts/lint-sql: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  216. 37.29 s > ./dev-scripts/package-binaries: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  217. 37.29 s > ./dev-scripts/reset-db: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  218. 37.29 s > ./dev-scripts/check-trailing-newline: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  219. 37.29 s > ./dev-scripts/git-hooks/pre-commit: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  220. 37.29 s > + set -o pipefail
  221. 37.29 s > + full_test=
  222. 37.29 s > + go_test_flags=("-tags=netgo,osusergo")
  223. 37.29 s > + go_test_flags+=("-fullpath")
  224. 37.29 s > + readonly COVERAGE_FILE_RAW=.coverage.out
  225. 37.29 s > + COVERAGE_FILE_RAW=.coverage.out
  226. 37.29 s > + readonly COVERAGE_FILE_HTML=.coverage.html
  227. 37.29 s > + COVERAGE_FILE_HTML=.coverage.html
  228. 37.29 s > + [[ '' = \-\-full ]]
  229. 37.29 s > + set -u
  230. 37.29 s > +++ dirname ./dev-scripts/run-go-tests
  231. 37.29 s > ++ cd ./dev-scripts
  232. 37.29 s > ++ pwd
  233. 37.29 s > + SCRIPT_DIR=/build/source/dev-scripts
  234. 37.29 s > + readonly SCRIPT_DIR
  235. 37.29 s > + cd /build/source/dev-scripts/..
  236. 37.29 s > + go test -tags=netgo,osusergo -fullpath ./...
  237. 37.29 s > ? codeberg.org/mtlynch/little-moments/build [no test files]
  238. 37.29 s > ? codeberg.org/mtlynch/little-moments/cmd/app [no test files]
  239. 37.29 s > ? codeberg.org/mtlynch/little-moments/cmd/import-from-tinybeans [no test files]
  240. 37.29 s > ? codeberg.org/mtlynch/little-moments/convert [no test files]
  241. 37.29 s > 2026/06/22 17:30:09 reading DB from file:/TestAboutPageIncludesVersionMetadata_0x1c154187c488?vfs=memdb
  242. 37.29 s > 2026/06/22 17:30:10 CSP media origin: ""
  243. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  244. 37.29 s > --- FAIL: TestAboutPageIncludesVersionMetadata (1.07s)
  245. 37.29 s > /build/source/handlers/about_test.go:74: about heading not found
  246. 37.29 s > 2026/06/22 17:30:10 failed to read auth session from context: session backend unavailable
  247. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestAuthFlow_0x1c1544df4b48?vfs=memdb
  248. 37.29 s > 2026/06/22 17:30:10 inserting magic login token for user 11111111-1111-4111-8111-111111111111
  249. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  250. 37.29 s > 2026/06/22 17:30:10 login confirm: consumed token for user 11111111-1111-4111-8111-111111111111
  251. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRejectsOpenRedirectNextURL_0x1c1544df5208?vfs=memdb
  252. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  253. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginConfirmPost/missing_token_returns_400_0x1c1544df5688?vfs=memdb
  254. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  255. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginConfirmPost/malformed_token_returns_400_0x1c1544df58c8?vfs=memdb
  256. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  257. 37.29 s > 2026/06/22 17:30:10 login confirm: invalid token format: invalid login token: must be 32 alphanumeric characters
  258. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginConfirmPost/well-formed_token_that%27s_not_in_store_returns_401_0x1c1544df5b08?vfs=memdb
  259. 37.29 s > 2026/06/22 17:30:10 inserting magic login token for user 11111111-1111-4111-8111-111111111111
  260. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  261. 37.29 s > 2026/06/22 17:30:10 login confirm: invalid token attempt
  262. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginConfirmPost/valid_token_that%27s_expired_returns_401_0x1c1544df5d48?vfs=memdb
  263. 37.29 s > 2026/06/22 17:30:10 inserting magic login token for user 11111111-1111-4111-8111-111111111111
  264. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  265. 37.29 s > 2026/06/22 17:30:10 login confirm: expired token attempt
  266. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginConfirmPost/valid_token_that%27s_already_used_returns_401_0x1c1545310008?vfs=memdb
  267. 37.29 s > 2026/06/22 17:30:10 inserting magic login token for user 11111111-1111-4111-8111-111111111111
  268. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  269. 37.29 s > 2026/06/22 17:30:10 login confirm: already-used token attempt
  270. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginConfirmPost/valid_token_with_session_creation_failure_returns_500_0x1c1545310248?vfs=memdb
  271. 37.29 s > 2026/06/22 17:30:10 inserting magic login token for user 11111111-1111-4111-8111-111111111111
  272. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  273. 37.29 s > 2026/06/22 17:30:10 login confirm: consumed token for user 11111111-1111-4111-8111-111111111111
  274. 37.29 s > 2026/06/22 17:30:10 login confirm: failed to confirm login: create auth session: session broken
  275. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginConfirmPost/valid_token_with_successful_session_creation_redirects_to_stored_next_path_0x1c15453106c8?vfs=memdb
  276. 37.29 s > 2026/06/22 17:30:10 inserting magic login token for user 11111111-1111-4111-8111-111111111111
  277. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  278. 37.29 s > 2026/06/22 17:30:10 login confirm: consumed token for user 11111111-1111-4111-8111-111111111111
  279. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRejectsMalformedFormBody_0x1c1545310908?vfs=memdb
  280. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  281. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRendersCheckEmailPageRegardlessOfRegistration/registered_email_shows_check-email_page_0x1c1545310d88?vfs=memdb
  282. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  283. 37.29 s > 2026/06/22 17:30:10 inserting magic login token for user 11111111-1111-4111-8111-111111111111
  284. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRendersCheckEmailPageRegardlessOfRegistration/unregistered_email_shows_check-email_page_0x1c1545311448?vfs=memdb
  285. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  286. 37.29 s > 2026/06/22 17:30:10 login attempt from unregistered email: unregistered@example.com
  287. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginPostDoesNotLeakTokenInProdMode_0x1c1545311b08?vfs=memdb
  288. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  289. 37.29 s > 2026/06/22 17:30:10 inserting magic login token for user 11111111-1111-4111-8111-111111111111
  290. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRejectsInvalidNextPath/protocol-relative_next_path_is_invalid_0x1c15458f8488?vfs=memdb
  291. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  292. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRejectsInvalidNextPath/next_path_without_leading_slash_is_invalid_0x1c15458f86c8?vfs=memdb
  293. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  294. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRejectsInvalidNextPath/malformed_next_path_is_invalid_0x1c15458f8908?vfs=memdb
  295. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  296. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRejectsInvalidNextPath/http_next_path_is_invalid_0x1c15458f8008?vfs=memdb
  297. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  298. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRejectsInvalidNextPath/https_next_path_is_invalid_0x1c15458f8488?vfs=memdb
  299. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  300. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRejectsInvalidNextPath/non-http_absolute_next_path_is_invalid_0x1c15458f86c8?vfs=memdb
  301. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  302. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginPostRejectsInvalidEmail_0x1c15458f8b48?vfs=memdb
  303. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  304. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginPostReturnsTooManyRequestsAfterIPv4Limit_0x1c15458f8d88?vfs=memdb
  305. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  306. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginPostDoesNotApplyIPv4LimitToIPv6_0x1c15458f9448?vfs=memdb
  307. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  308. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginPostReturnsTooManyRequestsWhenRateLimited_0x1c15458f9b08?vfs=memdb
  309. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  310. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestLoginPostReturnsErrorWhenTokenCreationFails_0x1c15458f9d48?vfs=memdb
  311. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  312. 37.29 s > 2026/06/22 17:30:10 failed to create login token: database unavailable
  313. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestUploadGetRequiresOwner/unauthenticated_user_is_redirected_to_login_0x1c1542080488?vfs=memdb
  314. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  315. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestUploadGetRequiresOwner/subscriber_is_forbidden_0x1c15420806c8?vfs=memdb
  316. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  317. 37.29 s > 2026/06/22 17:30:10 reading DB from file:/TestUploadGetRequiresOwner/owner_sees_the_upload_form_0x1c1542080008?vfs=memdb
  318. 37.29 s > 2026/06/22 17:30:10 cleaning expired auth sessions from store
  319. 37.29 s > FAIL
  320. 37.29 s > FAIL codeberg.org/mtlynch/little-moments/handlers 1.186s
  321. 37.29 s > ok codeberg.org/mtlynch/little-moments/imagepipe 0.022s
  322. 37.29 s > ? codeberg.org/mtlynch/little-moments/images [no test files]
  323. 37.29 s > ok codeberg.org/mtlynch/little-moments/importers 0.009s
  324. 37.29 s > ok codeberg.org/mtlynch/little-moments/importers/tinybeans 0.011s
  325. 37.29 s > ok codeberg.org/mtlynch/little-moments/importers/tinybeans/parse 0.013s
  326. 37.29 s > ok codeberg.org/mtlynch/little-moments/little_moments 0.007s
  327. 37.29 s > ok codeberg.org/mtlynch/little-moments/little_moments/login_token 0.005s
  328. 37.29 s > ok codeberg.org/mtlynch/little-moments/magiclogin 0.008s
  329. 37.29 s > ok codeberg.org/mtlynch/little-moments/magiclogin/loginmail 0.005s
  330. 37.29 s > ok codeberg.org/mtlynch/little-moments/magiclogin/loginmail/smtp 0.008s
  331. 37.29 s > ok codeberg.org/mtlynch/little-moments/mediastore 0.010s
  332. 37.29 s > ? codeberg.org/mtlynch/little-moments/random [no test files]
  333. 37.29 s > ok codeberg.org/mtlynch/little-moments/ratelimit 0.004s
  334. 37.29 s > ? codeberg.org/mtlynch/little-moments/s3 [no test files]
  335. 37.29 s > ok codeberg.org/mtlynch/little-moments/s3config 0.007s
  336. 37.29 s > ? codeberg.org/mtlynch/little-moments/store [no test files]
  337. 37.29 s > ok codeberg.org/mtlynch/little-moments/store/sqlite 1.179s
  338. 37.29 s > ? codeberg.org/mtlynch/little-moments/store/test_sqlite [no test files]
  339. 37.29 s > FAIL
  340. 37.29 s For full logs, run:
  341. 37.29 s nix log /nix/store/1vcmfik3cbjbisc8bzj1vxf5raq1vf3r-go-tests-0.0.0.drv
  342. 37.33 s Build failed.
Tail Raw Logs