1. 0.04 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=ignore-reference&rev=daeaeaafce0a10dc45aa284da9ce3303561b96ec#packages.x86_64-linux.e2e-tests --print-build-logs
  2. 0.07 s error (ignored): SQLite database '/var/cache/private/nix-ci-worker/eval-cache-v6/9733329804502d584f24096c4a353ea4e2f308cbe0c9ce745b5190cb1aa46a10.sqlite' is busy
  3. 3.82 s
  4. 4.55 s Building go-app-starter-dev
  5. 4.57 s [go-app-starter-dev] Phase: unpackPhase
  6. 4.57 s [go-app-starter-dev] unpacking source archive /nix/store/r5qhm6rdj3vy2s02jdp2m3dvn33mxacb-source
  7. 4.59 s [go-app-starter-dev] source root is source
  8. 4.61 s [go-app-starter-dev] Phase: patchPhase
  9. 4.62 s [go-app-starter-dev] Phase: updateAutotoolsGnuConfigScriptsPhase
  10. 4.63 s [go-app-starter-dev] Phase: configurePhase
  11. 4.71 s [go-app-starter-dev] Phase: buildPhase
  12. 4.72 s [go-app-starter-dev] Building subPackage ./cmd/app
  13. 12.05 s [go-app-starter-dev] Phase: checkPhase
  14. 18.42 s [go-app-starter-dev] ? github.com/mtlynch/go-app-starter/cmd/app [no test files]
  15. 18.46 s [go-app-starter-dev] Phase: installPhase
  16. 18.46 s [go-app-starter-dev] Phase: fixupPhase
  17. 18.47 s [go-app-starter-dev] shrinking RPATHs of ELF executables and libraries in /nix/store/yz5sws63pi2bb9rc4gbbvp0zp6v1b11h-go-app-starter-dev-0.0.1
  18. 18.47 s [go-app-starter-dev] shrinking /nix/store/yz5sws63pi2bb9rc4gbbvp0zp6v1b11h-go-app-starter-dev-0.0.1/bin/app-dev
  19. 18.49 s [go-app-starter-dev] patchelf: cannot find section '.dynamic'. The input file is most likely statically linked
  20. 18.49 s [go-app-starter-dev] checking for references to /build/ in /nix/store/yz5sws63pi2bb9rc4gbbvp0zp6v1b11h-go-app-starter-dev-0.0.1...
  21. 18.52 s [go-app-starter-dev] patchelf: cannot find section '.dynamic'. The input file is most likely statically linked
  22. 18.52 s [go-app-starter-dev] patching script interpreter paths in /nix/store/yz5sws63pi2bb9rc4gbbvp0zp6v1b11h-go-app-starter-dev-0.0.1
  23. 18.53 s [go-app-starter-dev] stripping (with command strip and flags -S -p) in /nix/store/yz5sws63pi2bb9rc4gbbvp0zp6v1b11h-go-app-starter-dev-0.0.1/bin
  24. 18.74 s [post-build-hook] Uploading to the NixCI cache: /nix/store/yz5sws63pi2bb9rc4gbbvp0zp6v1b11h-go-app-starter-dev-0.0.1
  25. 18.78 s [post-build-hook] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead
  26. 18.79 s [post-build-hook] copying 1 paths...
  27. 18.79 s [post-build-hook] copying path '/nix/store/yz5sws63pi2bb9rc4gbbvp0zp6v1b11h-go-app-starter-dev-0.0.1' to 'https://cache.nix-ci.com'...
  28. 22.92 s [post-build-hook] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead
  29. 23.29 s [post-build-hook] copying 1 paths...
  30. 23.29 s [post-build-hook] copying path '/nix/store/47jnlzhg36iaw7960q4rz4km2b26256r-go-app-starter-dev-0.0.1.drv' to 'https://cache.nix-ci.com'...
  31. 23.57 s Progress: 1 of 3 built
  32. 23.65 s Building go-app-starter-e2e
  33. 23.69 s [go-app-starter-e2e] Phase: unpackPhase
  34. 23.70 s [go-app-starter-e2e] unpacking source archive /nix/store/r5qhm6rdj3vy2s02jdp2m3dvn33mxacb-source
  35. 23.71 s [go-app-starter-e2e] source root is source
  36. 23.72 s [go-app-starter-e2e] Phase: patchPhase
  37. 23.72 s [go-app-starter-e2e] Executing npmConfigHook
  38. 23.72 s [go-app-starter-e2e] Configuring npm
  39. 23.72 s [go-app-starter-e2e] Validating consistency between /build/source/package-lock.json and /nix/store/0dk8jcag6q4rgcgailggsm937psd1786-go-app-starter-e2e-0.0.1-npm-deps/package-lock.json
  40. 23.75 s [go-app-starter-e2e] Setting npm_config_cache to /nix/store/0dk8jcag6q4rgcgailggsm937psd1786-go-app-starter-e2e-0.0.1-npm-deps
  41. 23.75 s [go-app-starter-e2e] Installing dependencies
  42. 23.83 s [go-app-starter-e2e] npm warn Unknown env config "nodedir". This will stop working in the next major version of npm.
  43. 23.83 s [go-app-starter-e2e] npm warn Unknown env config "platform". This will stop working in the next major version of npm.
  44. 23.83 s [go-app-starter-e2e] npm warn Unknown env config "arch". This will stop working in the next major version of npm.
  45. 24.42 s [go-app-starter-e2e]
  46. 24.42 s [go-app-starter-e2e] added 100 packages, and audited 101 packages in 603ms
  47. 24.42 s [go-app-starter-e2e]
  48. 24.42 s [go-app-starter-e2e] 25 packages are looking for funding
  49. 24.42 s [go-app-starter-e2e] run `npm fund` for details
  50. 24.42 s [go-app-starter-e2e]
  51. 24.42 s [go-app-starter-e2e] found 0 vulnerabilities
  52. 24.46 s [go-app-starter-e2e] patching script interpreter paths in node_modules
  53. 24.47 s [go-app-starter-e2e] node_modules/ulid/bin/cli.js: interpreter directive changed from "#! /usr/bin/env node" to "/nix/store/lgggxsrdzisnbligi7irlh4qmqczs0xk-nodejs-24.11.1/bin/node"
  54. 24.48 s [go-app-starter-e2e] node_modules/which/bin/node-which: interpreter directive changed from "#!/usr/bin/env node" to "/nix/store/lgggxsrdzisnbligi7irlh4qmqczs0xk-nodejs-24.11.1/bin/node"
  55. 24.49 s [go-app-starter-e2e] node_modules/playwright-core/bin/reinstall_chrome_beta_mac.sh: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/rlq03x4cwf8zn73hxaxnx0zn5q9kifls-bash-5.3p3/bin/bash"
  56. 24.50 s [go-app-starter-e2e] node_modules/playwright-core/bin/reinstall_msedge_dev_mac.sh: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/rlq03x4cwf8zn73hxaxnx0zn5q9kifls-bash-5.3p3/bin/bash"
  57. 24.51 s [go-app-starter-e2e] node_modules/playwright-core/bin/reinstall_chrome_stable_mac.sh: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/rlq03x4cwf8zn73hxaxnx0zn5q9kifls-bash-5.3p3/bin/bash"
  58. 24.52 s [go-app-starter-e2e] node_modules/playwright-core/bin/reinstall_msedge_stable_mac.sh: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/rlq03x4cwf8zn73hxaxnx0zn5q9kifls-bash-5.3p3/bin/bash"
  59. 24.53 s [go-app-starter-e2e] node_modules/playwright-core/bin/reinstall_msedge_beta_mac.sh: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/rlq03x4cwf8zn73hxaxnx0zn5q9kifls-bash-5.3p3/bin/bash"
  60. 24.54 s [go-app-starter-e2e] node_modules/playwright-core/bin/reinstall_msedge_dev_linux.sh: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/rlq03x4cwf8zn73hxaxnx0zn5q9kifls-bash-5.3p3/bin/bash"
  61. 24.55 s [go-app-starter-e2e] node_modules/playwright-core/bin/reinstall_msedge_beta_linux.sh: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/rlq03x4cwf8zn73hxaxnx0zn5q9kifls-bash-5.3p3/bin/bash"
  62. 24.56 s [go-app-starter-e2e] node_modules/playwright-core/bin/reinstall_chrome_beta_linux.sh: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/rlq03x4cwf8zn73hxaxnx0zn5q9kifls-bash-5.3p3/bin/bash"
  63. 24.56 s [go-app-starter-e2e] node_modules/playwright-core/bin/reinstall_msedge_stable_linux.sh: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/rlq03x4cwf8zn73hxaxnx0zn5q9kifls-bash-5.3p3/bin/bash"
  64. 24.57 s [go-app-starter-e2e] node_modules/playwright-core/bin/reinstall_chrome_stable_linux.sh: interpreter directive changed from "#!/usr/bin/env bash" to "/nix/store/rlq03x4cwf8zn73hxaxnx0zn5q9kifls-bash-5.3p3/bin/bash"
  65. 24.58 s [go-app-starter-e2e] node_modules/playwright-core/cli.js: interpreter directive changed from "#!/usr/bin/env node" to "/nix/store/lgggxsrdzisnbligi7irlh4qmqczs0xk-nodejs-24.11.1/bin/node"
  66. 24.59 s [go-app-starter-e2e] node_modules/playwright-core/lib/utilsBundleImpl/xdg-open: interpreter directive changed from "#!/bin/sh" to "/nix/store/rlq03x4cwf8zn73hxaxnx0zn5q9kifls-bash-5.3p3/bin/sh"
  67. 24.60 s [go-app-starter-e2e] node_modules/eslint/bin/eslint.js: interpreter directive changed from "#!/usr/bin/env node" to "/nix/store/lgggxsrdzisnbligi7irlh4qmqczs0xk-nodejs-24.11.1/bin/node"
  68. 24.61 s [go-app-starter-e2e] node_modules/@playwright/test/cli.js: interpreter directive changed from "#!/usr/bin/env node" to "/nix/store/lgggxsrdzisnbligi7irlh4qmqczs0xk-nodejs-24.11.1/bin/node"
  69. 24.62 s [go-app-starter-e2e] node_modules/prettier/bin/prettier.cjs: interpreter directive changed from "#!/usr/bin/env node" to "/nix/store/lgggxsrdzisnbligi7irlh4qmqczs0xk-nodejs-24.11.1/bin/node"
  70. 24.63 s [go-app-starter-e2e] node_modules/js-yaml/bin/js-yaml.js: interpreter directive changed from "#!/usr/bin/env node" to "/nix/store/lgggxsrdzisnbligi7irlh4qmqczs0xk-nodejs-24.11.1/bin/node"
  71. 24.63 s [go-app-starter-e2e] node_modules/acorn/bin/acorn: interpreter directive changed from "#!/usr/bin/env node" to "/nix/store/lgggxsrdzisnbligi7irlh4qmqczs0xk-nodejs-24.11.1/bin/node"
  72. 24.64 s [go-app-starter-e2e] node_modules/playwright/cli.js: interpreter directive changed from "#!/usr/bin/env node" to "/nix/store/lgggxsrdzisnbligi7irlh4qmqczs0xk-nodejs-24.11.1/bin/node"
  73. 24.71 s [go-app-starter-e2e] npm warn Unknown env config "nodedir". This will stop working in the next major version of npm.
  74. 24.71 s [go-app-starter-e2e] npm warn Unknown env config "platform". This will stop working in the next major version of npm.
  75. 24.71 s [go-app-starter-e2e] npm warn Unknown env config "arch". This will stop working in the next major version of npm.
  76. 24.91 s [go-app-starter-e2e] rebuilt dependencies successfully
  77. 24.92 s [go-app-starter-e2e] patching script interpreter paths in node_modules
  78. 25.00 s [go-app-starter-e2e] Finished npmConfigHook
  79. 25.00 s [go-app-starter-e2e] Phase: updateAutotoolsGnuConfigScriptsPhase
  80. 25.02 s [go-app-starter-e2e] Phase: configurePhase
  81. 25.04 s [go-app-starter-e2e] no configure script, doing nothing
  82. 25.05 s [go-app-starter-e2e] Phase: buildPhase
  83. 25.05 s [go-app-starter-e2e] no Makefile or custom buildPhase, doing nothing
  84. 25.05 s [go-app-starter-e2e] Phase: checkPhase
  85. 25.17 s [go-app-starter-e2e] npm warn Unknown env config "nodedir". This will stop working in the next major version of npm.
  86. 25.17 s [go-app-starter-e2e] npm warn Unknown env config "platform". This will stop working in the next major version of npm.
  87. 25.17 s [go-app-starter-e2e] npm warn Unknown env config "arch". This will stop working in the next major version of npm.
  88. 25.96 s [go-app-starter-e2e] [WebServer] 2026/05/03 10:14:35 github.com/mtlynch/go-app-starter/cmd/app/main.go:18: starting go-app-starter server
  89. 25.96 s [go-app-starter-e2e] [WebServer] 2026/05/03 10:14:35 github.com/mtlynch/go-app-starter/store/sqlite/sqlite.go:23: reading DB from data/store.db
  90. 26.61 s [go-app-starter-e2e] [WebServer] 2026/05/03 10:14:35 github.com/mtlynch/go-app-starter/cmd/app/main.go:41: listening on http://localhost:6001
  91. 26.84 s [go-app-starter-e2e] [WebServer] 2026/05/03 10:14:35 github.com/mtlynch/go-app-starter/handlers/middleware.go:13: POST /api/debug/db/per-session 404 19
  92. 26.87 s [go-app-starter-e2e]
  93. 26.87 s [go-app-starter-e2e] Running 1 test using 1 worker
  94. 27.33 s [go-app-starter-e2e] Skipping host requirements validation logic because `PLAYWRIGHT_SKIP_VALIDATE_HOST_REQUIREMENTS` env variable is set.
  95. 27.44 s [go-app-starter-e2e] [WebServer] 2026/05/03 10:14:36 github.com/mtlynch/go-app-starter/handlers/middleware.go:13: GET / 200 4262
  96. 27.44 s [go-app-starter-e2e] [WebServer] 2026/05/03 10:14:36 github.com/mtlynch/go-app-starter/handlers/middleware.go:13: GET /static/third-party/bootstrap@5.2.2/css/bootstrap.min.css 200 194901
  97. 27.44 s [go-app-starter-e2e] [WebServer] 2026/05/03 10:14:36 github.com/mtlynch/go-app-starter/handlers/middleware.go:13: GET /static/third-party/fontawesome@6.2.0/css/solid.min.css 200 572
  98. 27.44 s [go-app-starter-e2e] [WebServer] 2026/05/03 10:14:36 github.com/mtlynch/go-app-starter/handlers/middleware.go:13: GET /static/third-party/fontawesome@6.2.0/css/fontawesome.min.css 200 80651
  99. 27.44 s [go-app-starter-e2e] [WebServer] 2026/05/03 10:14:36 github.com/mtlynch/go-app-starter/handlers/middleware.go:13: GET /static/css/style.css 200 25
  100. 27.44 s [go-app-starter-e2e] [WebServer] 2026/05/03 10:14:36 github.com/mtlynch/go-app-starter/handlers/middleware.go:13: GET /static/third-party/bootstrap@5.2.2/js/bootstrap.bundle.min.js 200 80496
  101. 27.44 s [go-app-starter-e2e] [WebServer] 2026/05/03 10:14:36 github.com/mtlynch/go-app-starter/handlers/middleware.go:13: GET /static/third-party/htmx@2.0.4/htmx.min.js 200 50917
  102. 27.44 s [go-app-starter-e2e] [WebServer] 2026/05/03 10:14:36 github.com/mtlynch/go-app-starter/handlers/middleware.go:13: GET /static/third-party/htmx-ext-response-targets@2.0.0/response-targets.js 200 3722
  103. 27.44 s [go-app-starter-e2e] [WebServer] 2026/05/03 10:14:36 github.com/mtlynch/go-app-starter/handlers/middleware.go:13: GET /static/js/htmx-settings.js 200 813
  104. 27.44 s [go-app-starter-e2e] [WebServer] 2026/05/03 10:14:36 github.com/mtlynch/go-app-starter/handlers/middleware.go:13: GET /static/js/htmx-ext/clear-before-send.js 200 775
  105. 27.47 s [go-app-starter-e2e] [WebServer] 2026/05/03 10:14:36 github.com/mtlynch/go-app-starter/handlers/middleware.go:13: GET /static/third-party/fontawesome@6.2.0/webfonts/fa-solid-900.woff2 200 150472
  106. 27.55 s [go-app-starter-e2e] [WebServer] 2026/05/03 10:14:36 github.com/mtlynch/go-app-starter/handlers/middleware.go:13: GET /api/visits 200 49
  107. 28.07 s [go-app-starter-e2e] [WebServer] 2026/05/03 10:14:37 github.com/mtlynch/go-app-starter/handlers/middleware.go:13: GET / 200 4266
  108. 28.38 s [go-app-starter-e2e] ยท
  109. 28.38 s [go-app-starter-e2e] 1 passed (2.4s)
  110. 28.44 s [go-app-starter-e2e] Phase: installPhase
  111. 28.45 s [go-app-starter-e2e] Phase: fixupPhase
  112. 28.46 s [go-app-starter-e2e] shrinking RPATHs of ELF executables and libraries in /nix/store/0fckl070czfa8lqh1gsvc8dba631v3jd-go-app-starter-e2e-0.0.1
  113. 28.47 s [go-app-starter-e2e] checking for references to /build/ in /nix/store/0fckl070czfa8lqh1gsvc8dba631v3jd-go-app-starter-e2e-0.0.1...
  114. 28.48 s [go-app-starter-e2e] patching script interpreter paths in /nix/store/0fckl070czfa8lqh1gsvc8dba631v3jd-go-app-starter-e2e-0.0.1
  115. 28.60 s [post-build-hook] Uploading to the NixCI cache: /nix/store/0fckl070czfa8lqh1gsvc8dba631v3jd-go-app-starter-e2e-0.0.1
  116. 28.68 s [post-build-hook] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead
  117. 28.68 s [post-build-hook] copying 1 paths...
  118. 28.68 s [post-build-hook] copying path '/nix/store/0fckl070czfa8lqh1gsvc8dba631v3jd-go-app-starter-e2e-0.0.1' to 'https://cache.nix-ci.com'...
  119. 28.80 s [post-build-hook] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead
  120. 29.16 s [post-build-hook] copying 2 paths...
  121. 29.17 s [post-build-hook] copying path '/nix/store/1rmacg3vq57dyrmlvvh3znch39k62wr7-go-app-starter-e2e-0.0.1-npm-deps.drv' to 'https://cache.nix-ci.com'...
  122. 29.37 s [post-build-hook] copying path '/nix/store/rnzbdjqsczx4bxgz39bhrnynp2q2vvcq-go-app-starter-e2e-0.0.1.drv' to 'https://cache.nix-ci.com'...
  123. 29.62 s Progress: 2 of 3 built