build packages.x86_64-linux.go-tests

Reproduce this run
  1. 0.09 s $ /nix/store/vzx1mi9c0xfadmsm9dhd83d005cb1qs9-coreutils-9.8/bin/timeout --kill-after=15s 1800s /nix/store/99b1z08awpxj8b6mzggn59gp1shljnff-nix-2.34.5/bin/nix --extra-experimental-features nix-command --extra-experimental-features flakes --log-format internal-json build --no-link git+https://codeberg.org/mtlynch/go-app-starter?ref=go-critic&rev=38681223e32cc766d983c83f4b9d10b868697022#packages.x86_64-linux.go-tests --print-build-logs
  2. 0.12 s error (ignored): SQLite database '/var/cache/private/nix-ci-worker/eval-cache-v6/7665804d7e652ed405cad91e3e8b8868c3725ea303a932a7ffcdfecc53e4d8ae.sqlite' is busy
  3. 2.33 s
  4. 2.45 s Downloading cached source from https://cache.nix-ci.com
  5. 19.66 s Progress: 1 of 1 downloaded from cache
  6. 20.86 s
  7. 20.87 s Downloading cached errcheck from https://cache.nix-ci.com
  8. 20.87 s Downloading cached expand-response-params from https://cache.nix-ci.com
  9. 20.87 s Downloading cached go-tools from https://cache.nix-ci.com
  10. 20.87 s Downloading cached linux-headers from https://cache.nix-ci.com
  11. 20.88 s Downloading cached binutils-2.44-lib from https://cache.nix-ci.com
  12. 20.88 s Downloading cached glibc-2.42-51-bin from https://cache.nix-ci.com
  13. 20.88 s Downloading cached sqlite-3.51.1-bin from https://cache.nix-ci.com
  14. 20.89 s Downloading cached gmp from https://cache.nix-ci.com
  15. 20.89 s Downloading cached go-critic-0.14.3-go-modules from https://cache.nix-ci.com
  16. 20.89 s Downloading cached nss-cacert from https://cache.nix-ci.com
  17. 20.89 s Downloading cached source from https://cache.nix-ci.com
  18. 20.89 s Downloading cached git-minimal from https://cache.nix-ci.com
  19. 20.91 s Progress: 0 of 13 built, 1 of 22 downloaded from cache (11 downloading)
  20. 21.00 s Progress: 0 of 13 built, 2 of 22 downloaded from cache (10 downloading)
  21. 21.01 s Progress: 0 of 12 built, 3 of 22 downloaded from cache (9 downloading)
  22. 21.01 s Downloading cached isl from https://cache.nix-ci.com
  23. 21.01 s Downloading cached mpfr from https://cache.nix-ci.com
  24. 21.03 s Progress: 0 of 12 built, 4 of 22 downloaded from cache (10 downloading)
  25. 21.03 s Progress: 0 of 12 built, 5 of 22 downloaded from cache (10 downloading)
  26. 21.03 s Downloading cached binutils from https://cache.nix-ci.com
  27. 21.05 s Progress: 0 of 12 built, 6 of 22 downloaded from cache (9 downloading)
  28. 21.05 s Downloading cached sqlite-3.51.1-dev from https://cache.nix-ci.com
  29. 21.05 s Progress: 0 of 12 built, 7 of 22 downloaded from cache (9 downloading)
  30. 21.05 s Downloading cached glibc-2.42-51-dev from https://cache.nix-ci.com
  31. 21.13 s Progress: 0 of 12 built, 8 of 22 downloaded from cache (9 downloading)
  32. 21.14 s Progress: 0 of 11 built, 9 of 22 downloaded from cache (8 downloading)
  33. 21.14 s Downloading cached libmpc from https://cache.nix-ci.com
  34. 21.16 s Progress: 0 of 11 built, 10 of 22 downloaded from cache (8 downloading)
  35. 21.19 s Progress: 0 of 11 built, 11 of 22 downloaded from cache (7 downloading)
  36. 21.28 s Progress: 0 of 10 built, 12 of 22 downloaded from cache (6 downloading)
  37. 21.29 s Progress: 0 of 9 built, 13 of 22 downloaded from cache (5 downloading)
  38. 21.33 s Progress: 0 of 8 built, 14 of 22 downloaded from cache (4 downloading)
  39. 21.36 s Progress: 0 of 8 built, 15 of 22 downloaded from cache (3 downloading)
  40. 21.36 s Downloading cached gcc from https://cache.nix-ci.com
  41. 21.40 s Progress: 0 of 8 built, 16 of 22 downloaded from cache (3 downloading)
  42. 21.41 s Progress: 0 of 7 built, 17 of 22 downloaded from cache (2 downloading)
  43. 21.41 s Downloading cached binutils-wrapper from https://cache.nix-ci.com
  44. 21.68 s Progress: 0 of 7 built, 18 of 22 downloaded from cache (2 downloading)
  45. 21.69 s Progress: 0 of 6 built, 19 of 22 downloaded from cache (1 downloading)
  46. 23.81 s Progress: 0 of 5 built, 20 of 22 downloaded from cache
  47. 23.81 s Downloading cached gcc-wrapper from https://cache.nix-ci.com
  48. 23.94 s Progress: 0 of 5 built, 21 of 22 downloaded from cache
  49. 23.94 s Downloading cached stdenv-linux from https://cache.nix-ci.com
  50. 24.04 s Progress: 0 of 4 built, 22 of 22 downloaded from cache
  51. 24.13 s Building go-app-starter-0.0.1-go-modules
  52. 24.16 s Building go-critic
  53. 24.18 s [go-app-starter-0.0.1-go-modules] Phase: unpackPhase
  54. 24.19 s [go-critic] Phase: unpackPhase
  55. 24.19 s [go-app-starter-0.0.1-go-modules] unpacking source archive /nix/store/rx1hcwnmczzmka7d5lhq2dzkn5zz9fw3-source
  56. 24.19 s [go-critic] unpacking source archive /nix/store/r6civw4hxi2ymazjnprg3x823a0yf6sr-source
  57. 24.21 s [go-app-starter-0.0.1-go-modules] source root is source
  58. 24.22 s [go-app-starter-0.0.1-go-modules] Phase: patchPhase
  59. 24.23 s [go-critic] source root is source
  60. 24.23 s [go-app-starter-0.0.1-go-modules] Phase: updateAutotoolsGnuConfigScriptsPhase
  61. 24.24 s [go-app-starter-0.0.1-go-modules] Phase: configurePhase
  62. 24.24 s [go-critic] Phase: patchPhase
  63. 24.25 s [go-app-starter-0.0.1-go-modules] Phase: buildPhase
  64. 24.25 s [go-critic] Phase: updateAutotoolsGnuConfigScriptsPhase
  65. 24.27 s [go-critic] Phase: configurePhase
  66. 24.27 s [go-app-starter-0.0.1-go-modules] go: downloading github.com/ncruces/go-sqlite3 v0.22.0
  67. 24.28 s [go-app-starter-0.0.1-go-modules] go: downloading codeberg.org/mtlynch/go-evolutionary-migrate v0.0.1
  68. 24.32 s [go-critic] Phase: buildPhase
  69. 24.32 s [go-critic] Building subPackage ./cmd/gocritic
  70. 24.40 s [go-app-starter-0.0.1-go-modules] go: downloading golang.org/x/sys v0.29.0
  71. 24.40 s [go-app-starter-0.0.1-go-modules] go: downloading github.com/ncruces/julianday v1.0.0
  72. 24.40 s [go-app-starter-0.0.1-go-modules] go: downloading github.com/tetratelabs/wazero v1.8.2
  73. 25.38 s [go-app-starter-0.0.1-go-modules] Phase: installPhase
  74. 25.96 s [post-build-hook] Uploading to the NixCI cache: /nix/store/sz5kd43jmv4xjh7gfrp9snqf0xc9fly8-go-app-starter-0.0.1-go-modules
  75. 26.00 s [post-build-hook] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead
  76. 26.01 s [post-build-hook] copying 1 paths...
  77. 26.01 s [post-build-hook] copying path '/nix/store/sz5kd43jmv4xjh7gfrp9snqf0xc9fly8-go-app-starter-0.0.1-go-modules' to 'https://cache.nix-ci.com'...
  78. 28.80 s [post-build-hook] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead
  79. 28.95 s [post-build-hook] copying 0 paths...
  80. 28.98 s Progress: 1 of 4 built (1 building), 22 of 22 downloaded from cache
  81. 29.88 s [go-critic] Phase: checkPhase
  82. 30.47 s [go-critic] ok github.com/go-critic/go-critic/cmd/gocritic 0.003s
  83. 30.51 s [go-critic] Phase: installPhase
  84. 30.51 s [go-critic] Phase: fixupPhase
  85. 30.51 s [go-critic] shrinking RPATHs of ELF executables and libraries in /nix/store/7acnrwak4y99hqqa29hnzdgrdw1im6rf-go-critic-0.14.3
  86. 30.52 s [go-critic] shrinking /nix/store/7acnrwak4y99hqqa29hnzdgrdw1im6rf-go-critic-0.14.3/bin/gocritic
  87. 30.54 s [go-critic] patchelf: cannot find section '.dynamic'. The input file is most likely statically linked
  88. 30.54 s [go-critic] checking for references to /build/ in /nix/store/7acnrwak4y99hqqa29hnzdgrdw1im6rf-go-critic-0.14.3...
  89. 30.56 s [go-critic] patchelf: cannot find section '.dynamic'. The input file is most likely statically linked
  90. 30.57 s [go-critic] patching script interpreter paths in /nix/store/7acnrwak4y99hqqa29hnzdgrdw1im6rf-go-critic-0.14.3
  91. 30.57 s [go-critic] stripping (with command strip and flags -S -p) in /nix/store/7acnrwak4y99hqqa29hnzdgrdw1im6rf-go-critic-0.14.3/bin
  92. 30.73 s [post-build-hook] Uploading to the NixCI cache: /nix/store/7acnrwak4y99hqqa29hnzdgrdw1im6rf-go-critic-0.14.3
  93. 30.76 s [post-build-hook] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead
  94. 30.86 s [post-build-hook] copying 1 paths...
  95. 30.86 s [post-build-hook] copying path '/nix/store/7acnrwak4y99hqqa29hnzdgrdw1im6rf-go-critic-0.14.3' to 'https://cache.nix-ci.com'...
  96. 33.64 s [post-build-hook] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead
  97. 33.88 s [post-build-hook] copying 3 paths...
  98. 33.88 s [post-build-hook] copying path '/nix/store/r068q9wwbr06lp54dmg4jnm0hcb6c8pf-source.drv' to 'https://cache.nix-ci.com'...
  99. 34.11 s [post-build-hook] copying path '/nix/store/1krqzrsbnhswa5pk3fpd9zsx3hwmz8y9-go-critic-0.14.3-go-modules.drv' to 'https://cache.nix-ci.com'...
  100. 34.34 s [post-build-hook] copying path '/nix/store/axjd8j8az9kg3rvgrgycidwgjjbx8rsd-go-critic-0.14.3.drv' to 'https://cache.nix-ci.com'...
  101. 34.55 s Progress: 2 of 4 built, 22 of 22 downloaded from cache
  102. 34.60 s Building go-tests
  103. 34.66 s [go-tests] Phase: unpackPhase
  104. 34.66 s [go-tests] unpacking source archive /nix/store/rx1hcwnmczzmka7d5lhq2dzkn5zz9fw3-source
  105. 34.68 s [go-tests] source root is source
  106. 34.69 s [go-tests] Phase: patchPhase
  107. 34.70 s [go-tests] Phase: updateAutotoolsGnuConfigScriptsPhase
  108. 34.71 s [go-tests] Phase: configurePhase
  109. 34.73 s [go-tests] no configure script, doing nothing
  110. 34.73 s [go-tests] Phase: buildPhase
  111. 34.74 s [go-tests] patching script interpreter paths in ./dev-scripts
  112. 34.75 s [go-tests] ./dev-scripts/serve: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/0550j0i8bmzxbcnzrg1g51zigj7y12ih-bash-interactive-5.3p9/bin/bash"
  113. 34.76 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"
  114. 34.78 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"
  115. 34.79 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"
  116. 34.81 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"
  117. 34.83 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"
  118. 34.84 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"
  119. 34.86 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"
  120. 34.88 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"
  121. 34.89 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"
  122. 34.91 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"
  123. 34.92 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"
  124. 34.94 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"
  125. 34.95 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"
  126. 34.97 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"
  127. 34.99 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"
  128. 35.00 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"
  129. 35.02 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"
  130. 35.03 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"
  131. 35.05 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"
  132. 35.06 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"
  133. 35.15 s [go-tests] + set -o pipefail
  134. 35.15 s [go-tests] + full_test=
  135. 35.15 s [go-tests] + go_test_flags=("-tags=netgo,osusergo")
  136. 35.15 s [go-tests] + go_test_flags+=("-fullpath")
  137. 35.15 s [go-tests] + readonly COVERAGE_FILE_RAW=.coverage.out
  138. 35.15 s [go-tests] + COVERAGE_FILE_RAW=.coverage.out
  139. 35.15 s [go-tests] + readonly COVERAGE_FILE_HTML=.coverage.html
  140. 35.15 s [go-tests] + COVERAGE_FILE_HTML=.coverage.html
  141. 35.15 s [go-tests] + [[ '' = \-\-full ]]
  142. 35.15 s [go-tests] + set -u
  143. 35.15 s [go-tests] +++ dirname ./dev-scripts/run-go-tests
  144. 35.15 s [go-tests] ++ cd ./dev-scripts
  145. 35.15 s [go-tests] ++ pwd
  146. 35.15 s [go-tests] + SCRIPT_DIR=/build/source/dev-scripts
  147. 35.15 s [go-tests] + readonly SCRIPT_DIR
  148. 35.15 s [go-tests] + cd /build/source/dev-scripts/..
  149. 35.15 s [go-tests] + go test -tags=netgo,osusergo -fullpath ./...
  150. 40.98 s [go-tests] ? github.com/mtlynch/go-app-starter/cmd/app [no test files]
  151. 41.01 s [go-tests] ok github.com/mtlynch/go-app-starter/handlers 0.006s
  152. 41.01 s [go-tests] ? github.com/mtlynch/go-app-starter/store/sqlite [no test files]
  153. 41.79 s [go-tests] ok github.com/mtlynch/go-app-starter/store/test_sqlite 0.662s
  154. 41.85 s [go-tests] + [[ -n '' ]]
  155. 41.85 s [go-tests] + go vet ./...
  156. 45.64 s [go-tests] ++ go env GOPATH
  157. 45.65 s [go-tests] + GOCRITIC_PATH=/build/go/bin/go-critic
  158. 45.65 s [go-tests] + readonly GOCRITIC_PATH
  159. 45.65 s [go-tests] + readonly GOCRITIC_VERSION=v0.14.3
  160. 45.65 s [go-tests] + GOCRITIC_VERSION=v0.14.3
  161. 45.65 s [go-tests] + [[ ! -f /build/go/bin/go-critic ]]
  162. 45.65 s [go-tests] + /build/go/bin/go-critic check ./...
  163. 46.17 s [go-tests] + /build/go/bin/go-critic check -enable=returnAfterHttpError ./...
  164. 46.61 s [go-tests] ++ go env GOPATH
  165. 46.62 s [go-tests] + STATICCHECK_PATH=/build/go/bin/staticcheck
  166. 46.62 s [go-tests] + readonly STATICCHECK_PATH
  167. 46.62 s [go-tests] + readonly STATICCHECK_VERSION=v0.6.1
  168. 46.62 s [go-tests] + STATICCHECK_VERSION=v0.6.1
  169. 46.62 s [go-tests] + [[ ! -f /build/go/bin/staticcheck ]]
  170. 46.62 s [go-tests] + /build/go/bin/staticcheck ./...
  171. 49.25 s [go-tests] ++ go env GOPATH
  172. 49.26 s [go-tests] + ERRCHECK_PATH=/build/go/bin/errcheck
  173. 49.26 s [go-tests] + readonly ERRCHECK_PATH
  174. 49.26 s [go-tests] + readonly ERRCHECK_VERSION=v1.10.0
  175. 49.26 s [go-tests] + ERRCHECK_VERSION=v1.10.0
  176. 49.26 s [go-tests] + [[ ! -f /build/go/bin/errcheck ]]
  177. 49.26 s [go-tests] + /build/go/bin/errcheck -ignoretests ./...
  178. 49.38 s [go-tests] Phase: installPhase
  179. 49.39 s [go-tests] Phase: fixupPhase
  180. 49.41 s [go-tests] shrinking RPATHs of ELF executables and libraries in /nix/store/zr2z8dwyi5g1h27s44sj5n6ayxfj34mg-go-tests-0.0.0
  181. 49.41 s [go-tests] checking for references to /build/ in /nix/store/zr2z8dwyi5g1h27s44sj5n6ayxfj34mg-go-tests-0.0.0...
  182. 49.42 s [go-tests] patching script interpreter paths in /nix/store/zr2z8dwyi5g1h27s44sj5n6ayxfj34mg-go-tests-0.0.0
  183. 49.59 s [post-build-hook] Uploading to the NixCI cache: /nix/store/zr2z8dwyi5g1h27s44sj5n6ayxfj34mg-go-tests-0.0.0
  184. 49.63 s [post-build-hook] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead
  185. 49.63 s [post-build-hook] copying 1 paths...
  186. 49.63 s [post-build-hook] copying path '/nix/store/zr2z8dwyi5g1h27s44sj5n6ayxfj34mg-go-tests-0.0.0' to 'https://cache.nix-ci.com'...
  187. 49.79 s [post-build-hook] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead
  188. 50.12 s [post-build-hook] copying 1 paths...
  189. 50.12 s [post-build-hook] copying path '/nix/store/yvyjb4vlf2axp6gx2fs8i98mkbi2xgy9-go-tests-0.0.0.drv' to 'https://cache.nix-ci.com'...
  190. 50.37 s Progress: 3 of 4 built, 22 of 22 downloaded from cache