Skip to content
Snippets Groups Projects

rspec migration pg14 single-db 16/26

Passed Started by
Simon Tomlinson
@stomlinson
Log timestamps in UTC.
121:21:44Running with gitlab-runner 17.4.0~pre.110.g27400594 (27400594)
221:21:44 on blue-3.shared-gitlab-org.runners-manager.gitlab.com/default sUrYYgEG, system ID: s_35f98e2af465
321:21:44 feature flags: FF_NETWORK_PER_BUILD:true, FF_TIMESTAMPS:true
421:21:44Resolving secrets
5 21:21:44 Preparing the "docker+machine" executor 00:11
621:21:44Using 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 ...
721:21:47Starting service registry.gitlab.com/gitlab-org/gitlab-build-images:postgres-14-pgvector-0.4.1...
821:21:47Authenticating with credentials from job payload (GitLab Registry)
921:21:47Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images:postgres-14-pgvector-0.4.1 ...
1021:21:47Using 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 ...
1121:21:48WARNING: Service registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 is already created. Ignoring.
1221:21:48WARNING: Service registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 is already created. Ignoring.
1321:21:48Starting service registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12...
1421:21:48Authenticating with credentials from job payload (GitLab Registry)
1521:21:48Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 ...
1621:21:48Using 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 ...
1721:21:49Starting service redis:6.2-alpine...
1821:21:49Pulling docker image redis:6.2-alpine ...
1921:21:50Using docker image sha256:4100b5bd17430263e85ad9d8ab851959b234acaaf378e093f1f98400f4998815 for redis:6.2-alpine with digest redis@sha256:eaba718fecd1196d88533de7ba49bf903ad33664a92debb24660a922ecd9cac8 ...
2021:21:50Waiting for services to be up and running (timeout 30 seconds)...
2121:21:55Authenticating with credentials from job payload (GitLab Registry)
2221:21:55Pulling 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 ...
2321:21:55Using 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 21:21:55 Preparing environment 00:01
2521:21:56Running on runner-suryygeg-project-278964-concurrent-0 via runner-suryygeg-shared-gitlab-org-1731615459-0a28d66c...
26 21:21:56 Getting source from Git repository 00:01
2721:21:56Skipping Git repository setup
2821:21:56Skipping Git checkout
2921:21:56Skipping Git submodules setup
30 21:21:57 Restoring cache 00:19
3121:21:57Checking cache for ruby-gems-debian-bookworm-ruby-3.2.5-gemfile-Gemfile-20...
3221:21:57cache.zip is up to date
3321:22:12Successfully extracted cache
34 21:22:16 Downloading artifacts 00:53
3521:22:17Downloading artifacts for clone-gitlab-repo (8368443091)...
3621:22:22Downloading artifacts from coordinator... ok host=storage.googleapis.com id=8368443091 responseStatus=200 OK token=glcbt-66
3721:22:22WARNING: Part of .git directory is on the list of files to extract
3821:22:22WARNING: This may introduce unexpected problems
3921:22:38Downloading artifacts for compile-test-assets (8368443337)...
4021:22:41Downloading artifacts from coordinator... ok host=storage.googleapis.com id=8368443337 responseStatus=200 OK token=glcbt-66
4121:22:49Downloading artifacts for detect-tests (8368443460)...
4221:22:50Downloading artifacts from coordinator... ok host=storage.googleapis.com id=8368443460 responseStatus=200 OK token=glcbt-66
4321:22:50Downloading artifacts for retrieve-tests-metadata (8368443480)...
4421:22:50Downloading artifacts from coordinator... ok host=storage.googleapis.com id=8368443480 responseStatus=200 OK token=glcbt-66
4521:22:50Downloading artifacts for setup-test-env (8368443411)...
4621:22:55Downloading artifacts from coordinator... ok host=storage.googleapis.com id=8368443411 responseStatus=200 OK token=glcbt-66
47 21:23:09 Executing "step_script" stage of the job script
4821:23:09Using 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 ...
4921:23:09$ echo $FOSS_ONLY
5021:23:09$ [ "$FOSS_ONLY" = "1" ] && rm -rf ee/ qa/spec/ee/ qa/qa/specs/features/ee/ qa/qa/ee/ qa/qa/ee.rb
5121:23:09$ export GOPATH=$CI_PROJECT_DIR/.go
5221:23:09$ mkdir -p $GOPATH
5321:23:09$ source scripts/utils.sh
5421:23:09$ log_disk_usage "true"
5521:23:09*******************************************************
5621:23:09This runner currently has 26G free disk space.
5721:23:09*******************************************************
58 21:23:09 Disk usage detail 00:10
5921:23:09df -h
6021:23:09Filesystem Size Used Avail Use% Mounted on
6121:23:09overlay 46G 20G 26G 44% /
6221:23:09tmpfs 64M 0 64M 0% /dev
6321:23:09shm 256M 0 256M 0% /dev/shm
6421:23:09/dev/sda1 46G 20G 26G 44% /cache
6521:23:09tmpfs 3.9G 0 3.9G 0% /sys/devices/virtual/dmi/id
6621:23:09tmpfs 3.9G 0 3.9G 0% /proc/acpi
6721:23:09tmpfs 3.9G 0 3.9G 0% /proc/scsi
6821:23:09tmpfs 3.9G 0 3.9G 0% /sys/firmware
6921:23:09du -h -d 1
7021:23:097.4M ./workhorse
7121:23:09148K ./bin
7221:23:091.2M ./.gitlab
7321:23:09177M ./.git
7421:23:094.0K ./builds
7521:23:0928M ./lib
7621:23:098.0K ./.vscode
7721:23:09560K ./storybook
7821:23:0924K ./log
7921:23:091.8M ./data
8021:23:0911M ./qa
8121:23:093.2M ./.rubocop_todo
8221:23:09856M ./vendor
8321:23:101023M ./public
8421:23:1062M ./doc
8521:23:10484K ./danger
8621:23:1032K ./rspec
8721:23:10556K ./tooling
8821:23:10146M ./ee
8921:23:101.3M ./knapsack
9021:23:10300K ./patches
9121:23:104.3M ./changelogs
9221:23:1020K ./haml_lint
9321:23:1028K ./metrics_server
9421:23:10108K ./keeps
9521:23:1036K ./shared
9621:23:1044K ./generator_templates
9721:23:101.3M ./scripts
9821:23:10763M ./tmp
9921:23:10127M ./spec
10021:23:1020K ./file_hooks
10121:23:1032K ./crystalball
10221:23:1016K ./sidekiq_cluster
10321:23:1017M ./gems
10421:23:101.2M ./fixtures
10521:23:10964K ./rubocop
10621:23:104.0K ./.go
10721:23:1033M ./db
10821:23:1012K ./.github
10921:23:10129M ./locale
11021:23:1020M ./config
11121:23:1082M ./app
11221:23:1020K ./.lefthook
11321:23:103.5G .
11421:23:10$ source scripts/prepare_build.sh
115 21:23:10 Installing gems 00:24
14621:23:34Using two connections, single database config (config/database.yml.postgresql)
14721:23:34Disabling ci connection in config/database.yml
14821:23:34Geo DB won't be set up.
14921:23:34Embedding DB won't be set up.
150 21:23:34 Setting up DBs 00:55
17521:24:29$ source ./scripts/rspec_helpers.sh
17621:24:29$ run_timed_command "gem install knapsack --no-document"
17721:24:29$ gem install knapsack --no-document
17821:24:31Successfully installed knapsack-4.0.0
17921:24:311 gem installed
18021:24:29==> 'gem install knapsack --no-document' succeeded in 2 seconds.
18121:24:31$ section_start "gitaly-test-spawn" "Spawning Gitaly"; scripts/gitaly-test-spawn; section_end "gitaly-test-spawn"
182 21:24:31 Spawning Gitaly 00:04
18621:24:35$ export RSPEC_SKIPPED_TESTS_REPORT_PATH="rspec/skipped_tests-${CI_JOB_ID}.txt"
18721:24:35$ export RSPEC_RETRIED_TESTS_REPORT_PATH="rspec/retried_tests-${CI_JOB_ID}.txt"
18821:24:35$ tooling/bin/create_job_metrics_file || true
18921:24:38[job-metrics] Creating the job metrics file for the CI/CD job.
19021:24:38$ rspec_section rspec_parallelized_job "--fail-fast=${RSPEC_FAIL_FAST_THRESHOLD} --tag ~quarantine --tag ~zoekt --tag ~click_house"
191 21:24:38 RSpec 03:53
19221:24:38[21:24:38] Starting rspec_parallelized_job
19321:24:31RETRY_FAILED_TESTS_IN_NEW_PROCESS: true
19421:24:38KNAPSACK_GENERATE_REPORT: true
19521:24:38FLAKY_RSPEC_GENERATE_REPORT: true
19621:24:38KNAPSACK_TEST_FILE_PATTERN: spec/{migrations}{,/**/}*_spec.rb
19721:24:38KNAPSACK_LOG_LEVEL: debug
19821:24:38KNAPSACK_REPORT_PATH: knapsack/rspec_migration_pg14_single-db_16_26_278964_report.json
19921:24:38FLAKY_RSPEC_SUITE_REPORT_PATH: rspec/flaky/report-suite.json
20021:24:38FLAKY_RSPEC_REPORT_PATH: rspec/flaky/all_rspec_migration_pg14_single-db_16_26_278964_report.json
20121:24:38NEW_FLAKY_RSPEC_REPORT_PATH: rspec/flaky/new_rspec_migration_pg14_single-db_16_26_278964_report.json
20221:24:38RSPEC_SKIPPED_TESTS_REPORT_PATH: rspec/skipped_tests-8368445631.txt
20321:24:38CRYSTALBALL:
20421:24:38RSPEC_TESTS_MAPPING_ENABLED:
20521:24:38RSPEC_TESTS_FILTER_FILE:
20621:24:38Shell set options (set -o) enabled:
20721:24:38braceexpand on
20821:24:38hashall on
20921:24:38interactive-comments on
21021:24:38pipefail on
21121:24:45Knapsack report generator started!
21221:24:38/builds/gitlab-org/gitlab/vendor/ruby/3.2.0/gems/io-event-1.6.5/lib/io/event/support.rb:27: warning: IO::Buffer is experimental and both the Ruby and C interface may change in the future!
21321:24:55 ██  ██  █████  ██████  ███  ██ ██ ███  ██  ██████ 
21421:24:55 ██  ██ ██   ██ ██   ██ ████  ██ ██ ████  ██ ██      
21521:24:55 ██  █  ██ ███████ ██████  ██ ██  ██ ██ ██ ██  ██ ██  ███ 
21621:24:55 ██ ███ ██ ██   ██ ██   ██ ██  ██ ██ ██ ██  ██ ██ ██  ██ 
21721:24:55  ███ ███  ██  ██ ██  ██ ██   ████ ██ ██   ████  ██████  
21821:24:55******************************************************************************
21921:24:55 Your database has a single connection, and single connections were
22021:24:55 deprecated in GitLab 15.9 https://docs.gitlab.com/ee/update/deprecations.html#single-database-connection-is-deprecated.
22121:24:55 In GitLab 17.0 and later, you must have the two main: and ci: sections in your database.yml.
22221:24:55 Please add a :ci section to your database, following these instructions:
22321:24:55 https://docs.gitlab.com/ee/install/installation.html#configure-gitlab-db-settings.
22421:24:55******************************************************************************
22521:25:25DEPRECATION 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)
22621:25:37warning: parser/current is loading parser/ruby32, which recognizes 3.2.6-compliant syntax, but you are running 3.2.5.
22721:25:37Please see https://github.com/whitequark/parser#compatibility-with-ruby-mri.
22821:25:41Run options: exclude {:quarantine=>true, :zoekt=>true, :click_house=>true}
22921:25:41# [RSpecRunTime] Starting RSpec timer...
23021:25:41[TEST PROF INFO] EventProf enabled (sql.active_record)
23121:25:41unknown OID 2249: failed to recognize type of 'pg_stat_file'. It will be treated as String.
23221:25:45Test environment set up in 1.292328816 seconds
23321:25:45# [RSpecRunTime] Starting example group spec/migrations/20241004100956_queue_restore_opt_in_to_gitlab_com_spec.rb. Expected to take 26.6 seconds.
23421:25:45QueueRestoreOptInToGitlabCom
23521:25:52main: == [advisory_lock_connection] object_id: 1683000, pg_backend_pid: 114
23621:25:52main: == 20241004100956 QueueRestoreOptInToGitlabCom: migrating =====================
23721:25:52main: == 20241004100956 QueueRestoreOptInToGitlabCom: migrated (0.0087s) ============
23821:25:52main: == [advisory_lock_connection] object_id: 1683000, pg_backend_pid: 114
23921:25:55 does not schedule a new batched migration
24021:25:55 when SaaS
24121:25:56main: == [advisory_lock_connection] object_id: 2347900, pg_backend_pid: 117
24221:25:56main: == 20241004100956 QueueRestoreOptInToGitlabCom: migrating =====================
24321:25:56main: == 20241004100956 QueueRestoreOptInToGitlabCom: migrated (0.0103s) ============
24421:25:56main: == [advisory_lock_connection] object_id: 2347900, pg_backend_pid: 117
24521:25:59 does not schedule a new batched migration
24621:25:59 when the temporary table exists
24721:26:00main: == [advisory_lock_connection] object_id: 2850640, pg_backend_pid: 120
24821:26:00main: == 20241004100956 QueueRestoreOptInToGitlabCom: migrating =====================
24921:26:00main: == 20241004100956 QueueRestoreOptInToGitlabCom: migrated (0.1192s) ============
25021:26:00main: == [advisory_lock_connection] object_id: 2850640, pg_backend_pid: 120
25121:26:03 schedules a new batched migration
25221:26:17# [RSpecRunTime] Finishing example group spec/migrations/20241004100956_queue_restore_opt_in_to_gitlab_com_spec.rb. It took 31.65 seconds. Expected to take 26.6 seconds.
25321:26:17# [RSpecRunTime] RSpec elapsed time: 35.83 seconds. Current RSS: ~1217M. Threads: 1. load average: 1.04 1.33 1.33 1/281 387
25421:26:17.
25521:26:17# [RSpecRunTime] Starting example group spec/migrations/20241016131601_queue_delete_orphaned_pipeline_variable_records_spec.rb. Expected to take 16.76 seconds.
25621:26:17QueueDeleteOrphanedPipelineVariableRecords
25721:26:22main: == [advisory_lock_connection] object_id: 5247840, pg_backend_pid: 127
25821:26:22main: == 20241016131601 QueueDeleteOrphanedPipelineVariableRecords: migrating =======
25921:26:22main: == 20241016131601 QueueDeleteOrphanedPipelineVariableRecords: migrated (0.0869s)
26021:26:22main: == [advisory_lock_connection] object_id: 5247840, pg_backend_pid: 127
26121:26:25 schedules a new batched migration
26221:26:34# [RSpecRunTime] Finishing example group spec/migrations/20241016131601_queue_delete_orphaned_pipeline_variable_records_spec.rb. It took 17.37 seconds. Expected to take 16.76 seconds.
26321:26:34# [RSpecRunTime] RSpec elapsed time: 53.44 seconds. Current RSS: ~1202M. Threads: 1. load average: 1.18 1.34 1.34 1/280 388
26421:26:34.
26521:26:34# [RSpecRunTime] Starting example group spec/migrations/20241028141411_requeue_backfill_approval_project_rules_protected_branches_project_id_spec.rb. Expected to take 12.93 seconds.
26621:26:34RequeueBackfillApprovalProjectRulesProtectedBranchesProjectId
26721:26:37main: == [advisory_lock_connection] object_id: 7311760, pg_backend_pid: 133
26821:26:37main: == 20241028141411 RequeueBackfillApprovalProjectRulesProtectedBranchesProjectId: migrating
26921:26:37main: == 20241028141411 RequeueBackfillApprovalProjectRulesProtectedBranchesProjectId: migrated (0.0228s)
27021:26:37main: == [advisory_lock_connection] object_id: 7311760, pg_backend_pid: 133
27121:26:41 does not schedule a new batched migratio
27221:26:41 when executed on .com
27321:26:41main: == [advisory_lock_connection] object_id: 7990580, pg_backend_pid: 137
27421:26:41main: == 20241028141411 RequeueBackfillApprovalProjectRulesProtectedBranchesProjectId: migrating
27521:26:42main: == 20241028141411 RequeueBackfillApprovalProjectRulesProtectedBranchesProjectId: migrated (0.0801s)
27621:26:42main: == [advisory_lock_connection] object_id: 7990580, pg_backend_pid: 137
27721:26:45 schedules a new batched migration
27821:26:45# [RSpecRunTime] RSpec elapsed time: 1 minute 3.99 seconds. Current RSS: ~1205M. Threads: 1. load average: 1.15 1.33 1.33 1/280 389
27921:26:45.
28021:26:51# [RSpecRunTime] Finishing example group spec/migrations/20241028141411_requeue_backfill_approval_project_rules_protected_branches_project_id_spec.rb. It took 16.92 seconds. Expected to take 12.93 seconds.
28121:26:51# [RSpecRunTime] RSpec elapsed time: 1 minute 10.42 seconds. Current RSS: ~1199M. Threads: 1. load average: 1.14 1.32 1.33 1/280 390
28221:26:51.
28321:26:51# [RSpecRunTime] Starting example group spec/migrations/20231019145202_add_status_to_packages_npm_metadata_caches_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20231019145202_add_status_to_packages_npm_metadata_caches_spec.rb.
28421:26:51AddStatusToPackagesNpmMetadataCaches
28521:26:51 correctly migrates up and down (PENDING: Skipping because migration AddStatusToPackagesNpmMetadataCaches is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
28621:26:51# [RSpecRunTime] Finishing example group spec/migrations/20231019145202_add_status_to_packages_npm_metadata_caches_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20231019145202_add_status_to_packages_npm_metadata_caches_spec.rb.
28721:26:51# [RSpecRunTime] Starting example group spec/migrations/20240110090352_queue_backfill_partition_id_ci_pipeline_config_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240110090352_queue_backfill_partition_id_ci_pipeline_config_spec.rb.
28821:26:51QueueBackfillPartitionIdCiPipelineConfig
28921:26:51 #up
29021:26:51 with migration present
29121:26:51 when migration finished successfully
29221:26:51 does not raise exception (PENDING: Skipping because migration QueueBackfillPartitionIdCiPipelineConfig is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
29321:26:51 schedules background jobs for each batch of ci_pipelines_config (PENDING: Skipping because migration QueueBackfillPartitionIdCiPipelineConfig is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
29421:26:51 #down
29521:26:51 deletes all batched migration records (PENDING: Skipping because migration QueueBackfillPartitionIdCiPipelineConfig is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
29621:26:51# [RSpecRunTime] Finishing example group spec/migrations/20240110090352_queue_backfill_partition_id_ci_pipeline_config_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240110090352_queue_backfill_partition_id_ci_pipeline_config_spec.rb.
29721:26:51# [RSpecRunTime] Starting example group spec/migrations/20240327214545_add_development_widget_to_work_item_types_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240327214545_add_development_widget_to_work_item_types_spec.rb.
29821:26:51AddDevelopmentWidgetToWorkItemTypes
29921:26:51 behaves like migration that adds widget to work items definitions
30021:26:51 #up
30121:26:51 creates widget definition in all types (PENDING: Skipping because migration AddDevelopmentWidgetToWorkItemTypes is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
30221:26:51 when the widget already exists
30321:26:51 upserts the widget definitions and raises no error (PENDING: Skipping because migration AddDevelopmentWidgetToWorkItemTypes is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
30421:26:51 #down
30521:26:51 removes definitions for widget (PENDING: Skipping because migration AddDevelopmentWidgetToWorkItemTypes is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
30621:26:51# [RSpecRunTime] Finishing example group spec/migrations/20240327214545_add_development_widget_to_work_item_types_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240327214545_add_development_widget_to_work_item_types_spec.rb.
30721:26:51# [RSpecRunTime] Starting example group spec/migrations/20240515094240_delete_invalid_path_locks_records_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240515094240_delete_invalid_path_locks_records_spec.rb.
30821:26:51DeleteInvalidPathLocksRecords
30921:26:51 #up
31021:26:51 deletes records without a project_id (PENDING: Skipping because migration DeleteInvalidPathLocksRecords is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
31121:26:51 does nothing on gitlab.com (PENDING: Skipping because migration DeleteInvalidPathLocksRecords is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
31221:26:51# [RSpecRunTime] Finishing example group spec/migrations/20240515094240_delete_invalid_path_locks_records_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240515094240_delete_invalid_path_locks_records_spec.rb.
31321:26:51# [RSpecRunTime] Starting example group spec/migrations/20240603152046_delete_bitbucket_identities_with_untrusted_extern_uid_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240603152046_delete_bitbucket_identities_with_untrusted_extern_uid_spec.rb.
31421:26:51DeleteBitbucketIdentitiesWithUntrustedExternUid
31521:26:51 #up
31621:26:51 deletes Bitbucket identities with untrusted extern_uid (PENDING: Skipping because migration DeleteBitbucketIdentitiesWithUntrustedExternUid is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
31721:26:51# [RSpecRunTime] Finishing example group spec/migrations/20240603152046_delete_bitbucket_identities_with_untrusted_extern_uid_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240603152046_delete_bitbucket_identities_with_untrusted_extern_uid_spec.rb.
31821:26:51# [RSpecRunTime] Starting example group spec/migrations/20240611202115_add_cargo_purl_type_to_application_setting_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240611202115_add_cargo_purl_type_to_application_setting_spec.rb.
31921:26:51AddCargoPurlTypeToApplicationSetting
32021:26:51 #up
32121:26:51 updates setting (PENDING: Skipping because migration AddCargoPurlTypeToApplicationSetting is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
32221:26:51 #down
32321:26:51 with default value
32421:26:51 updates setting (PENDING: Skipping because migration AddCargoPurlTypeToApplicationSetting is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
32521:26:51# [RSpecRunTime] Finishing example group spec/migrations/20240611202115_add_cargo_purl_type_to_application_setting_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240611202115_add_cargo_purl_type_to_application_setting_spec.rb.
32621:26:51# [RSpecRunTime] Starting example group spec/migrations/20240626141557_queue_backfill_packages_dependency_links_project_id_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240626141557_queue_backfill_packages_dependency_links_project_id_spec.rb.
32721:26:51QueueBackfillPackagesDependencyLinksProjectId
32821:26:51 schedules a new batched migration (PENDING: Skipping because migration QueueBackfillPackagesDependencyLinksProjectId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
32921:26:51# [RSpecRunTime] Finishing example group spec/migrations/20240626141557_queue_backfill_packages_dependency_links_project_id_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240626141557_queue_backfill_packages_dependency_links_project_id_spec.rb.
33021:26:51# [RSpecRunTime] Starting example group spec/migrations/20240717040239_requeue_backfill_deploy_tokens_sharding_key_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240717040239_requeue_backfill_deploy_tokens_sharding_key_spec.rb.
33121:26:51RequeueBackfillDeployTokensShardingKey
33221:26:51 schedules a new batched migration (PENDING: Skipping because migration RequeueBackfillDeployTokensShardingKey is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
33321:26:51# [RSpecRunTime] Finishing example group spec/migrations/20240717040239_requeue_backfill_deploy_tokens_sharding_key_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240717040239_requeue_backfill_deploy_tokens_sharding_key_spec.rb.
33421:26:51# [RSpecRunTime] Starting example group spec/migrations/20240814052751_cleanup_bigint_conversion_for_packages_build_infos_pipeline_id_spec.rb. Missing expected duration from Knapsack report for spec/migrations/20240814052751_cleanup_bigint_conversion_for_packages_build_infos_pipeline_id_spec.rb.
33521:26:51CleanupBigintConversionForPackagesBuildInfosPipelineId
33621:26:51 correctly migrates up and down (PENDING: Skipping because migration CleanupBigintConversionForPackagesBuildInfosPipelineId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
33721:26:52# [RSpecRunTime] Finishing example group spec/migrations/20240814052751_cleanup_bigint_conversion_for_packages_build_infos_pipeline_id_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/20240814052751_cleanup_bigint_conversion_for_packages_build_infos_pipeline_id_spec.rb.
33821:26:52# [RSpecRunTime] Starting example group spec/migrations/add_work_items_related_link_restrictions_spec.rb. Missing expected duration from Knapsack report for spec/migrations/add_work_items_related_link_restrictions_spec.rb.
33921:26:52AddWorkItemsRelatedLinkRestrictions
34021:26:52 creates default restrictions (PENDING: Skipping because migration AddWorkItemsRelatedLinkRestrictions is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
34121:26:52 when work item types are missing
34221:26:52 does not add restrictions (PENDING: Skipping because migration AddWorkItemsRelatedLinkRestrictions is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
34321:26:52# [RSpecRunTime] Finishing example group spec/migrations/add_work_items_related_link_restrictions_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/add_work_items_related_link_restrictions_spec.rb.
34421:26:52# [RSpecRunTime] Starting example group spec/migrations/fix_broken_user_achievements_awarded_spec.rb. Missing expected duration from Knapsack report for spec/migrations/fix_broken_user_achievements_awarded_spec.rb.
34521:26:52FixBrokenUserAchievementsAwarded
34621:26:52 #up
34721:26:52 when ghost user exists
34821:26:52 migrates the invalid user achievement (PENDING: Skipping because migration FixBrokenUserAchievementsAwarded is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
34921:26:52 does not migrate the valid user achievement (PENDING: Skipping because migration FixBrokenUserAchievementsAwarded is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
35021:26:52 when ghost user does not exist
35121:26:52 does not migrate the invalid user achievement (PENDING: Skipping because migration FixBrokenUserAchievementsAwarded is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.)
35221:26:52# [RSpecRunTime] Finishing example group spec/migrations/fix_broken_user_achievements_awarded_spec.rb. It took 0.02 second. Missing expected duration from Knapsack report for spec/migrations/fix_broken_user_achievements_awarded_spec.rb.
35321:26:55auto_explain log contains 837 entries for main, writing to /builds/gitlab-org/gitlab/auto_explain/rspec-migration-pg14-single-db-16-26.342.main.ndjson.gz
35421:26:55took 3.691922038
35521:26:55[TEST PROF INFO] EventProf results for sql.active_record
35621:26:55Total time: 00:32.175 of 01:06.472 (48.4%)
35721:26:55Total events: 26295
35821:26:55Top 5 slowest suites (by time):
35921:26:55QueueRestoreOptInToGitlabCom (./spec/migrations/20241004100956_queue_restore_opt_in_to_gitlab_com_spec.rb:6) – 00:15.000 (12309 / 3) of 00:31.889 (47.04%)
36021:26:55QueueDeleteOr...ariableRecords (./spec/migrations/20241016131601_queue_delete_orphaned_pipeline_variable_records_spec.rb:6) – 00:09.436 (7232 / 1) of 00:17.425 (54.16%)
36121:26:55RequeueBackfi...nchesProjectId (./spec/migrations/20241028141411_requeue_backfill_approval_project_rules_protected_branches_project_id_spec.rb:6) – 00:07.702 (6677 / 2) of 00:16.978 (45.37%)
36221:26:55RequeueBackfi...ensShardingKey (./spec/migrations/20240717040239_requeue_backfill_deploy_tokens_sharding_key_spec.rb:6) – 00:00.003 (7 / 1) of 00:00.017 (20.73%)
36321:26:55QueueBackfill...PipelineConfig (./spec/migrations/20240110090352_queue_backfill_partition_id_ci_pipeline_config_spec.rb:6) – 00:00.003 (7 / 3) of 00:00.016 (20.93%)
36421:26:55Knapsack report was generated. Preview:
36521:26:55{
36621:26:55 "spec/migrations/20241004100956_queue_restore_opt_in_to_gitlab_com_spec.rb": 19.849616073000107,
36721:26:55 "spec/migrations/20241016131601_queue_delete_orphaned_pipeline_variable_records_spec.rb": 8.532086186000015,
36821:26:55 "spec/migrations/20241028141411_requeue_backfill_approval_project_rules_protected_branches_project_id_spec.rb": 10.575501700999666
36921:26:55}
37021:26:55Knapsack global time execution for tests: 38s
37121:26:55Pending: (Failures listed here are expected and do not affect your suite's status)
37221:26:55 1) AddStatusToPackagesNpmMetadataCaches correctly migrates up and down
37321:26:55 # Skipping because migration AddStatusToPackagesNpmMetadataCaches is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
37421:26:55 # ./spec/migrations/20231019145202_add_status_to_packages_npm_metadata_caches_spec.rb:9
37521:26:55 2) QueueBackfillPartitionIdCiPipelineConfig#up with migration present when migration finished successfully does not raise exception
37621:26:55 # Skipping because migration QueueBackfillPartitionIdCiPipelineConfig is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
37721:26:55 # ./spec/migrations/20240110090352_queue_backfill_partition_id_ci_pipeline_config_spec.rb:29
37821:26:55 3) QueueBackfillPartitionIdCiPipelineConfig#up with migration present when migration finished successfully schedules background jobs for each batch of ci_pipelines_config
37921:26:55 # Skipping because migration QueueBackfillPartitionIdCiPipelineConfig is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
38021:26:55 # ./spec/migrations/20240110090352_queue_backfill_partition_id_ci_pipeline_config_spec.rb:33
38121:26:55 4) QueueBackfillPartitionIdCiPipelineConfig#down deletes all batched migration records
38221:26:55 # Skipping because migration QueueBackfillPartitionIdCiPipelineConfig is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
38321:26:55 # ./spec/migrations/20240110090352_queue_backfill_partition_id_ci_pipeline_config_spec.rb:49
38421:26:55 5) AddDevelopmentWidgetToWorkItemTypes behaves like migration that adds widget to work items definitions #up creates widget definition in all types
38521:26:55 # Skipping because migration AddDevelopmentWidgetToWorkItemTypes is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
38621:26:55 # ./spec/support/shared_examples/migrations/add_work_item_widget_shared_examples.rb:12
38721:26:55 6) AddDevelopmentWidgetToWorkItemTypes behaves like migration that adds widget to work items definitions #up when the widget already exists upserts the widget definitions and raises no error
38821:26:55 # Skipping because migration AddDevelopmentWidgetToWorkItemTypes is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
38921:26:55 # ./spec/support/shared_examples/migrations/add_work_item_widget_shared_examples.rb:33
39021:26:55 7) AddDevelopmentWidgetToWorkItemTypes behaves like migration that adds widget to work items definitions #down removes definitions for widget
39121:26:55 # Skipping because migration AddDevelopmentWidgetToWorkItemTypes is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
39221:26:55 # ./spec/support/shared_examples/migrations/add_work_item_widget_shared_examples.rb:42
39321:26:55 8) DeleteInvalidPathLocksRecords#up deletes records without a project_id
39421:26:55 # Skipping because migration DeleteInvalidPathLocksRecords is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
39521:26:55 # ./spec/migrations/20240515094240_delete_invalid_path_locks_records_spec.rb:22
39621:26:55 9) DeleteInvalidPathLocksRecords#up does nothing on gitlab.com
39721:26:55 # Skipping because migration DeleteInvalidPathLocksRecords is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
39821:26:55 # ./spec/migrations/20240515094240_delete_invalid_path_locks_records_spec.rb:33
39921:26:55 10) DeleteBitbucketIdentitiesWithUntrustedExternUid#up deletes Bitbucket identities with untrusted extern_uid
40021:26:55 # Skipping because migration DeleteBitbucketIdentitiesWithUntrustedExternUid is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
40121:26:55 # ./spec/migrations/20240603152046_delete_bitbucket_identities_with_untrusted_extern_uid_spec.rb:48
40221:26:55 11) AddCargoPurlTypeToApplicationSetting#up updates setting
40321:26:55 # Skipping because migration AddCargoPurlTypeToApplicationSetting is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
40421:26:55 # ./spec/migrations/20240611202115_add_cargo_purl_type_to_application_setting_spec.rb:10
40521:26:55 12) AddCargoPurlTypeToApplicationSetting#down with default value updates setting
40621:26:55 # Skipping because migration AddCargoPurlTypeToApplicationSetting is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
40721:26:55 # ./spec/migrations/20240611202115_add_cargo_purl_type_to_application_setting_spec.rb:23
40821:26:55 13) QueueBackfillPackagesDependencyLinksProjectId schedules a new batched migration
40921:26:55 # Skipping because migration QueueBackfillPackagesDependencyLinksProjectId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
41021:26:55 # ./spec/migrations/20240626141557_queue_backfill_packages_dependency_links_project_id_spec.rb:10
41121:26:55 14) RequeueBackfillDeployTokensShardingKey schedules a new batched migration
41221:26:55 # Skipping because migration RequeueBackfillDeployTokensShardingKey is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
41321:26:55 # ./spec/migrations/20240717040239_requeue_backfill_deploy_tokens_sharding_key_spec.rb:9
41421:26:55 15) CleanupBigintConversionForPackagesBuildInfosPipelineId correctly migrates up and down
41521:26:55 # Skipping because migration CleanupBigintConversionForPackagesBuildInfosPipelineId is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
41621:26:55 # ./spec/migrations/20240814052751_cleanup_bigint_conversion_for_packages_build_infos_pipeline_id_spec.rb:9
41721:26:55 16) AddWorkItemsRelatedLinkRestrictions creates default restrictions
41821:26:55 # Skipping because migration AddWorkItemsRelatedLinkRestrictions is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
41921:26:55 # ./spec/migrations/add_work_items_related_link_restrictions_spec.rb:11
42021:26:55 17) AddWorkItemsRelatedLinkRestrictions when work item types are missing does not add restrictions
42121:26:55 # Skipping because migration AddWorkItemsRelatedLinkRestrictions is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
42221:26:55 # ./spec/migrations/add_work_items_related_link_restrictions_spec.rb:30
42321:26:55 18) FixBrokenUserAchievementsAwarded#up when ghost user exists migrates the invalid user achievement
42421:26:55 # Skipping because migration FixBrokenUserAchievementsAwarded is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
42521:26:55 # ./spec/migrations/fix_broken_user_achievements_awarded_spec.rb:40
42621:26:55 19) FixBrokenUserAchievementsAwarded#up when ghost user exists does not migrate the valid user achievement
42721:26:55 # Skipping because migration FixBrokenUserAchievementsAwarded is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
42821:26:55 # ./spec/migrations/fix_broken_user_achievements_awarded_spec.rb:46
42921:26:55 20) FixBrokenUserAchievementsAwarded#up when ghost user does not exist does not migrate the invalid user achievement
43021:26:55 # Skipping because migration FixBrokenUserAchievementsAwarded is outside the test window. Run with `RUN_ALL_MIGRATION_TESTS=1 bundle exec rspec <spec> if you need to run this spec.
43121:26:55 # ./spec/migrations/fix_broken_user_achievements_awarded_spec.rb:53
43221:26:55Finished in 1 minute 14.42 seconds (files took 59.21 seconds to load)
43321:26:5526 examples, 0 failures, 20 pending
43421:26:55Randomized with seed 35109
43521:27:01[TEST PROF INFO] Time spent in factories: 00:00.226 (0.29% of total time)
43621:27:02RSpec exited with 0.
43721:27:02No examples to retry, congrats!
438 21:27:02 Running after_script 00:20
43921:27:03Running after script...
44021:27:03$ source scripts/utils.sh
44121:27:03$ log_disk_usage
44221:27:03*******************************************************
44321:27:03This runner currently has 25G free disk space.
44421:27:03*******************************************************
445 21:27:03 Disk usage detail 00:10
50421:27:13$ bundle exec gem list gitlab_quality-test_tooling
50521:27:16gitlab_quality-test_tooling (2.1.0)
50621:27:16$ section_start "failed-test-issues" "Report test failures" # collapsed multi-line command
507 21:27:16 Report test failures 00:00
50921:27:16$ section_start "flaky-test-issues" "Report test flakiness" # collapsed multi-line command
510 21:27:16 Report test flakiness 00:00
51221:27:16$ section_start "slow-test-issues" "Report test slowness" # collapsed multi-line command
513 21:27:16 Report test slowness 00:00
51521:27:16$ section_start "slow-test-merge-request-report-note" "Report test slowness in MR note" # collapsed multi-line command
516 21:27:16 Report test slowness in MR note 00:02
51921:27:18$ section_start "knapsack-report-issues" "Report test files close to timing out" # collapsed multi-line command
520 21:27:18 Report test files close to timing out 00:02
52321:27:20$ tooling/bin/push_job_metrics || true
52421:27:22[job-metrics] Pushing job metrics file for the CI/CD job.
52521:27:22[job-metrics] Pushed 4 CI job metric entries to InfluxDB.
526 21:27:22 Saving cache for successful job 00:01
52721:27:23Not uploading cache ruby-gems-debian-bookworm-ruby-3.2.5-gemfile-Gemfile-20 due to policy
528 21:27:23 Uploading artifacts for successful job 00:06
52921:27:23Uploading artifacts...
53021:27:23auto_explain/: found 2 matching artifact files and directories
53121:27:23coverage/: found 5 matching artifact files and directories
53221:27:23crystalball/: found 2 matching artifact files and directories
53321:27:23WARNING: deprecations/: no matching files. Ensure that the artifact path is relative to the working directory (/builds/gitlab-org/gitlab)
53421:27:23knapsack/: found 4 matching artifact files and directories
53521:27:23rspec/: found 16 matching artifact files and directories
53621:27:23WARNING: tmp/capybara/: no matching files. Ensure that the artifact path is relative to the working directory (/builds/gitlab-org/gitlab)
53721:27:23log/*.log: found 13 matching artifact files and directories
53821:27:24WARNING: Upload request redirected location=https://gitlab.com/api/v4/jobs/8368445631/artifacts?artifact_format=zip&artifact_type=archive&expire_in=31d new-url=https://gitlab.com
53921:27:24WARNING: Retrying... context=artifacts-uploader error=request redirected
54021:27:26Uploading artifacts as "archive" to coordinator... 201 Created id=8368445631 responseStatus=201 Created token=glcbt-66
54121:27:26Uploading artifacts...
54221:27:27rspec/rspec-*.xml: found 1 matching artifact files and directories
54321:27:27WARNING: Upload request redirected location=https://gitlab.com/api/v4/jobs/8368445631/artifacts?artifact_format=gzip&artifact_type=junit&expire_in=31d new-url=https://gitlab.com
54421:27:27WARNING: Retrying... context=artifacts-uploader error=request redirected
54521:27:28Uploading artifacts as "junit" to coordinator... 201 Created id=8368445631 responseStatus=201 Created token=glcbt-66
546 21:27:29 Cleaning up project directory and file based variables 00:00
54721:27:38Job succeeded