Skip to content
Snippets Groups Projects

rails-production-server-boot-puma-example

Passed Started by
David Fernandez
@10io
Log timestamps in UTC.
107:29:59Running with gitlab-runner 17.4.0~pre.110.g27400594 (27400594)
207:29:59 on blue-2.private.runners-manager.gitlab.com/gitlab.com/gitlab-org QvBVRoXM, system ID: s_49b872f8ccf6
307:29:59 feature flags: FF_NETWORK_PER_BUILD:true, FF_TIMESTAMPS:true
407:29:59Resolving secrets
5 07:29:59 Preparing the "docker+machine" executor 00:07
607:29:59Using Docker executor with image registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bookworm-ruby-3.2.5-golang-1.23-rust-1.73-node-20.12-postgresql-14:rubygems-3.5-git-2.45-lfs-2.9-chrome-123-yarn-1.22-graphicsmagick-1.3.36 ...
707:30:01Starting service registry.gitlab.com/gitlab-org/gitlab-build-images:postgres-14-pgvector-0.4.1...
807:30:01Authenticating with credentials from job payload (GitLab Registry)
907:30:01Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images:postgres-14-pgvector-0.4.1 ...
1007:30:01Using docker image sha256:82f132c22567f8ce17cc132c14b2f9aa3eaf9bb5424d91c2d966912433f0257d for registry.gitlab.com/gitlab-org/gitlab-build-images:postgres-14-pgvector-0.4.1 with digest registry.gitlab.com/gitlab-org/gitlab-build-images@sha256:c55e1364ee4327b244a9cfa1750f19feea14fc774eaf792b725967d146eb45f5 ...
1107:30:02WARNING: Service registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 is already created. Ignoring.
1207:30:02WARNING: Service registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 is already created. Ignoring.
1307:30:02Starting service registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12...
1407:30:02Authenticating with credentials from job payload (GitLab Registry)
1507:30:02Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 ...
1607:30:02Using docker image sha256:5c5ba5b83d6c60cb0b225bd670b7a43be8c238cc72347d24af57e5027c3648f3 for registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 with digest registry.gitlab.com/gitlab-org/gitlab-build-images@sha256:46aceab84c42d0e819c8e7940f2f98ce9e184785cd7b22d95872024a35f52407 ...
1707:30:03Starting service redis:6.2-alpine...
1807:30:03Pulling docker image redis:6.2-alpine ...
1907:30:03Using docker image sha256:4100b5bd17430263e85ad9d8ab851959b234acaaf378e093f1f98400f4998815 for redis:6.2-alpine with digest redis@sha256:eaba718fecd1196d88533de7ba49bf903ad33664a92debb24660a922ecd9cac8 ...
2007:30:04Waiting for services to be up and running (timeout 30 seconds)...
2107:30:06Authenticating with credentials from job payload (GitLab Registry)
2207:30:06Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bookworm-ruby-3.2.5-golang-1.23-rust-1.73-node-20.12-postgresql-14:rubygems-3.5-git-2.45-lfs-2.9-chrome-123-yarn-1.22-graphicsmagick-1.3.36 ...
2307:30:06Using docker image sha256:e83f017c5ffd177beb4bc3b4bfabde989d741e04fef90cd764896cf9b670552f for registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bookworm-ruby-3.2.5-golang-1.23-rust-1.73-node-20.12-postgresql-14:rubygems-3.5-git-2.45-lfs-2.9-chrome-123-yarn-1.22-graphicsmagick-1.3.36 with digest registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bookworm-ruby-3.2.5-golang-1.23-rust-1.73-node-20.12-postgresql-14@sha256:770feb0a974e36f8b83d22a3cb18310d0cfeae11e02f6195b1577c73ce26b398 ...
24 07:30:06 Preparing environment 00:01
2507:30:07Running on runner-qvbvroxm-project-278964-concurrent-0 via runner-qvbvroxm-private-1731476680-ceb462ee...
26 07:30:07 Getting source from Git repository 00:35
2707:30:08Fetching changes with git depth set to 20...
2807:30:08Initialized empty Git repository in /builds/gitlab-org/gitlab/.git/
2907:30:08Created fresh repository.
3007:30:09remote: Enumerating objects: 173855, done.
3107:30:09remote: Counting objects: 100% (173855/173855), done.
3207:30:10remote: Compressing objects: 100% (114071/114071), done.
3307:30:10remote: Total 173855 (delta 77995), reused 124604 (delta 53275), pack-reused 0 (from 0)
3407:30:15Receiving objects: 100% (173855/173855), 149.32 MiB | 29.42 MiB/s, done.
3507:30:15Resolving deltas: 100% (77995/77995), done.
3607:30:24From https://us-east1-d.ci-gateway.int.gprd.gitlab.net:8989/gitlab-org/gitlab
3707:30:24 * [new ref] refs/pipelines/1539805919 -> refs/pipelines/1539805919
3807:30:24Checking out 834ded94 as detached HEAD (ref is refs/merge-requests/171036/merge)...
3907:30:38Skipping Git submodules setup
4007:30:38$ git remote set-url origin "${CI_REPOSITORY_URL}"
41 07:30:42 Restoring cache 00:16
4207:30:43Checking cache for ruby-gems-debian-bookworm-ruby-3.2.5-gemfile-Gemfile-20...
4307:30:43cache.zip is up to date
4407:30:52Successfully extracted cache
45 07:30:58 Executing "step_script" stage of the job script 02:26
4607:30:58Using docker image sha256:e83f017c5ffd177beb4bc3b4bfabde989d741e04fef90cd764896cf9b670552f for registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bookworm-ruby-3.2.5-golang-1.23-rust-1.73-node-20.12-postgresql-14:rubygems-3.5-git-2.45-lfs-2.9-chrome-123-yarn-1.22-graphicsmagick-1.3.36 with digest registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bookworm-ruby-3.2.5-golang-1.23-rust-1.73-node-20.12-postgresql-14@sha256:770feb0a974e36f8b83d22a3cb18310d0cfeae11e02f6195b1577c73ce26b398 ...
4707:30:59$ echo $FOSS_ONLY
4807:30:59$ [ "$FOSS_ONLY" = "1" ] && rm -rf ee/ qa/spec/ee/ qa/qa/specs/features/ee/ qa/qa/ee/ qa/qa/ee.rb
4907:30:59$ export GOPATH=$CI_PROJECT_DIR/.go
5007:30:59$ mkdir -p $GOPATH
5107:30:59$ source scripts/utils.sh
5207:30:59$ log_disk_usage "true"
5307:30:59*******************************************************
5407:30:59This runner currently has 78G free disk space.
5507:30:59*******************************************************
56 07:30:59 Disk usage detail 00:00
10607:30:59$ source scripts/prepare_build.sh
107 07:30:59 Installing gems 00:16
13807:31:15Using decomposed database config (config/database.yml.decomposed-postgresql)
13907:31:15Geo DB won't be set up.
14007:31:15Embedding DB won't be set up.
141 07:31:15 Setting up DBs 01:03
15707:32:18$ cp config/puma.rb.example config/puma.rb
15807:32:18$ sed --in-place "s:/home/git/gitlab:${PWD}:" config/puma.rb
15907:32:18$ echo 'bind "tcp://127.0.0.1:3000"' >> config/puma.rb
16007:32:18$ bundle exec puma --environment production --config config/puma.rb &
16107:32:18$ sleep 50
16207:32:21{"timestamp":"2024-11-13T07:32:21.300Z","pid":282,"message":"Puma starting in cluster mode..."}
16307:32:21{"timestamp":"2024-11-13T07:32:21.312Z","pid":282,"message":"* Puma version: 6.4.3 (ruby 3.2.5-p208) (\"The Eagle of Durango\")"}
16407:32:21{"timestamp":"2024-11-13T07:32:21.312Z","pid":282,"message":"* Min threads: 1"}
16507:32:21{"timestamp":"2024-11-13T07:32:21.312Z","pid":282,"message":"* Max threads: 16"}
16607:32:21{"timestamp":"2024-11-13T07:32:21.312Z","pid":282,"message":"* Environment: production"}
16707:32:21{"timestamp":"2024-11-13T07:32:21.312Z","pid":282,"message":"* Master PID: 282"}
16807:32:21{"timestamp":"2024-11-13T07:32:21.312Z","pid":282,"message":"* Workers: 3"}
16907:32:21{"timestamp":"2024-11-13T07:32:21.312Z","pid":282,"message":"* Restarts: (✔) hot (✖) phased"}
17007:32:21{"timestamp":"2024-11-13T07:32:21.312Z","pid":282,"message":"* Preloading application"}
17107:32:18DEPRECATION WARNING: Support for Rails versions < 7.1 is deprecated and will be removed from ViewComponent 4.0.0 (ViewComponent v4 will remove support for Rails versions < 7.1 no earlier than April 1, 2025) (called from <top (required)> at /builds/gitlab-org/gitlab/config/environment.rb:7)
17207:33:08$ retry_times_sleep 10 5 "curl http://127.0.0.1:3000"
17307:33:09 % Total % Received % Xferd Average Speed Time Time Time Current
17407:33:09 Dload Upload Total Spent Left Speed
17507:33:09 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
17607:33:09curl: (7) Failed to connect to 127.0.0.1 port 3000 after 11 ms: Couldn't connect to server
17707:33:10WARNING: Active Record does not support composite primary key.
17807:33:10security_findings has composite primary key. Composite primary key is ignored.
17907:33:14[07:33:14] Retry attempts left: 10...
18007:33:14 % Total % Received % Xferd Average Speed Time Time Time Current
18107:33:14 Dload Upload Total Spent Left Speed
18207:33:14 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
18307:33:14curl: (7) Failed to connect to 127.0.0.1 port 3000 after 15 ms: Couldn't connect to server
18407:33:19[07:33:19] Retry attempts left: 9...
18507:33:19 % Total % Received % Xferd Average Speed Time Time Time Current
18607:33:19 Dload Upload Total Spent Left Speed
18707:33:19 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0
18807:33:19curl: (7) Failed to connect to 127.0.0.1 port 3000 after 1 ms: Couldn't connect to server
18907:33:20DEPRECATION WARNING: The asset "no_avatar.png" is not present in the asset pipeline.
19007:33:20Falling back to an asset that may be in the public folder.
19107:33:20This behavior is deprecated and will be removed.
19207:33:20To bypass the asset pipeline and preserve this behavior,
19307:33:20use the `skip_pipeline: true` option.
19407:33:20 (called from default_avatar_url at /builds/gitlab-org/gitlab/lib/gitlab/gon_helper.rb:142)
19507:33:20DEPRECATION WARNING: The asset "gitlab_logo.png" is not present in the asset pipeline.
19607:33:20Falling back to an asset that may be in the public folder.
19707:33:20This behavior is deprecated and will be removed.
19807:33:20To bypass the asset pipeline and preserve this behavior,
19907:33:20use the `skip_pipeline: true` option.
20007:33:20 (called from add_gon_variables at /builds/gitlab-org/gitlab/lib/gitlab/gon_helper.rb:41)
20107:33:20DEPRECATION WARNING: The asset "icons.svg" is not present in the asset pipeline.
20207:33:20Falling back to an asset that may be in the public folder.
20307:33:20This behavior is deprecated and will be removed.
20407:33:20To bypass the asset pipeline and preserve this behavior,
20507:33:20use the `skip_pipeline: true` option.
20607:33:20 (called from sprite_icon_path at /builds/gitlab-org/gitlab/app/helpers/icons_helper.rb:21)
20707:33:20DEPRECATION WARNING: The asset "file_icons/file_icons.svg" is not present in the asset pipeline.
20807:33:20Falling back to an asset that may be in the public folder.
20907:33:20This behavior is deprecated and will be removed.
21007:33:20To bypass the asset pipeline and preserve this behavior,
21107:33:20use the `skip_pipeline: true` option.
21207:33:20 (called from sprite_file_icons_path at /builds/gitlab-org/gitlab/app/helpers/icons_helper.rb:29)
21307:33:20DEPRECATION WARNING: The asset "emoji_sprites.css" is not present in the asset pipeline.
21407:33:20Falling back to an asset that may be in the public folder.
21507:33:20This behavior is deprecated and will be removed.
21607:33:20To bypass the asset pipeline and preserve this behavior,
21707:33:20use the `skip_pipeline: true` option.
21807:33:20 (called from universal_path_to_stylesheet at /builds/gitlab-org/gitlab/app/helpers/vite_helper.rb:50)
21907:33:20DEPRECATION WARNING: The asset "lazy_bundles/gridstack.css" is not present in the asset pipeline.
22007:33:20Falling back to an asset that may be in the public folder.
22107:33:20This behavior is deprecated and will be removed.
22207:33:20To bypass the asset pipeline and preserve this behavior,
22307:33:20use the `skip_pipeline: true` option.
22407:33:20 (called from universal_path_to_stylesheet at /builds/gitlab-org/gitlab/app/helpers/vite_helper.rb:50)
22507:33:20{"timestamp":"2024-11-13T07:33:20.128Z","pid":282,"message":"* Listening on unix:///builds/gitlab-org/gitlab/tmp/sockets/gitlab.socket"}
22607:33:20{"timestamp":"2024-11-13T07:33:20.128Z","pid":282,"message":"* Listening on http://127.0.0.1:3000"}
22707:33:20{"timestamp":"2024-11-13T07:33:20.128Z","pid":282,"message":"! WARNING: Detected 2 Thread(s) started in app boot:"}
22807:33:20{"timestamp":"2024-11-13T07:33:20.128Z","pid":282,"message":"! #\u003cThread:0x0000785500461068 /builds/gitlab-org/gitlab/vendor/ruby/3.2.0/gems/rack-timeout-0.7.0/lib/rack/timeout/support/scheduler.rb:72 sleep\u003e - /builds/gitlab-org/gitlab/vendor/ruby/3.2.0/gems/rack-timeout-0.7.0/lib/rack/timeout/support/scheduler.rb:90:in `sleep'"}
22907:33:20{"timestamp":"2024-11-13T07:33:20.128Z","pid":282,"message":"! #\u003cThread:0x00007854faf9f9f8 /builds/gitlab-org/gitlab/vendor/ruby/3.2.0/gems/sentry-ruby-5.21.0/lib/sentry/threaded_periodic_worker.rb:18 sleep\u003e - /builds/gitlab-org/gitlab/vendor/ruby/3.2.0/gems/sentry-ruby-5.21.0/lib/sentry/threaded_periodic_worker.rb:20:in `sleep'"}
23007:33:20{"timestamp":"2024-11-13T07:33:20.129Z","pid":282,"message":"Use Ctrl-C to stop"}
23107:33:24[07:33:24] Retry attempts left: 8...
23207:33:24 % Total % Received % Xferd Average Speed Time Time Time Current
23307:33:24 Dload Upload Total Spent Left Speed
23407:33:24100 101 0 101 0 0 2318 0 --:--:-- --:--:-- --:--:-- 2348
23507:33:24<html><body>You are being <a href="http://127.0.0.1:3000/users/sign_in">redirected</a>.</body></html>$ kill $(jobs -p)
236 07:33:24 Saving cache for successful job 00:01
23707:33:24Not uploading cache ruby-gems-debian-bookworm-ruby-3.2.5-gemfile-Gemfile-20 due to policy
238 07:33:25 Uploading artifacts for successful job 00:02
23907:33:25Uploading artifacts...
24007:33:25log/: found 13 matching artifact files and directories
24107:33:25WARNING: Upload request redirected location=https://gitlab.com/api/v4/jobs/8343393336/artifacts?artifact_format=zip&artifact_type=archive&expire_in=7d new-url=https://gitlab.com
24207:33:25WARNING: Retrying... context=artifacts-uploader error=request redirected
24307:33:27Uploading artifacts as "archive" to coordinator... 201 Created id=8343393336 responseStatus=201 Created token=glcbt-66
244 07:33:27 Cleaning up project directory and file based variables 00:01
24507:33:34Job succeeded