Skip to content
Snippets Groups Projects

rspec migration pg14 2/8

Passed Started by
Siddharth Asthana
@edith007
1Running with gitlab-runner 16.1.0~beta.59.g83c66823 (83c66823)
2 on green-4.shared-gitlab-org.runners-manager.gitlab.com/default x5QiHUKw, system ID: s_b9637080a79e
3 feature flags: FF_NETWORK_PER_BUILD:true, FF_USE_FASTZIP:true, FF_USE_IMPROVED_URL_MASKING:true
4 Resolving secrets 00:00
5 Preparing the "docker+machine" executor 00:09
6Using Docker executor with image registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bullseye-ruby-3.0.patched-golang-1.20-rust-1.65-node-18.17-postgresql-14:rubygems-3.4-git-2.36-lfs-2.9-chrome-113-yarn-1.22-graphicsmagick-1.3.36 ...
7Starting service registry.gitlab.com/gitlab-org/gitlab-build-images:postgres-14-pgvector-0.4.1 ...
8Authenticating with credentials from job payload (GitLab Registry)
9Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images:postgres-14-pgvector-0.4.1 ...
10Using docker image sha256:2e09e9db92541ed81b1c00f1d5186f8c262d8b84e8d1755676ea4b25614f30c4 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:afc7bd7a60824044709543a6a700385e412d750d9ab4fc72b427e335e1d0f3ec ...
11WARNING: Service registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 is already created. Ignoring.
12WARNING: Service registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 is already created. Ignoring.
13Starting service registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 ...
14Authenticating with credentials from job payload (GitLab Registry)
15Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images:redis-cluster-6.2.12 ...
16Using docker image sha256:a9a90ece30d9630d694ab1997cd103ea8ec729789451b983a75c7b58b0062d45 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:7ef36177d5d0bc554fbb63d8210ae751bcc538bea7905b51d078d9ab90a755fa ...
17Starting service redis:6.2-alpine ...
18Pulling docker image redis:6.2-alpine ...
19Using docker image sha256:d0675d033b87382205d08b598a004a99a1f6c4bd377cc86bb6df8957ce7dbb1c for redis:6.2-alpine with digest redis@sha256:740b5c973d1c9eea6e124a3905ba73d32354d0549f98ccc9e67af1af2a9ba478 ...
20Waiting for services to be up and running (timeout 30 seconds)...
21Authenticating with credentials from job payload (GitLab Registry)
22Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bullseye-ruby-3.0.patched-golang-1.20-rust-1.65-node-18.17-postgresql-14:rubygems-3.4-git-2.36-lfs-2.9-chrome-113-yarn-1.22-graphicsmagick-1.3.36 ...
23Using docker image sha256:24a9e92645b17c878623efd51b7564f81e480bd281e94d7f33971082e0ca80e0 for registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bullseye-ruby-3.0.patched-golang-1.20-rust-1.65-node-18.17-postgresql-14:rubygems-3.4-git-2.36-lfs-2.9-chrome-113-yarn-1.22-graphicsmagick-1.3.36 with digest registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bullseye-ruby-3.0.patched-golang-1.20-rust-1.65-node-18.17-postgresql-14@sha256:ca349d228348f199cb57f574476584f42aca338747393ed93a9032a0261afc4d ...
24 Preparing environment 00:00
25Running on runner-x5qihukw-project-27783254-concurrent-0 via runner-x5qihukw-shared-gitlab-org-1691907244-4a37770a...
26 Getting source from Git repository 00:28
27Fetching changes with git depth set to 20...
28Initialized empty Git repository in /builds/edith007/gitlab/.git/
29Created fresh repository.
30Checking out 199b254b as detached HEAD (ref is master)...
31Skipping Git submodules setup
32$ git remote set-url origin "${CI_REPOSITORY_URL}"
33 Restoring cache 00:00
34Checking cache for ruby-gems-debian-bullseye-ruby-3.0-protected...
35WARNING: file does not exist
36Failed to extract cache
37 Downloading artifacts 00:22
38Downloading artifacts for compile-test-assets (4863613909)...
39Downloading artifacts from coordinator... ok host=storage.googleapis.com id=4863613909 responseStatus=200 OK token=64_EFAxe
40Downloading artifacts for retrieve-tests-metadata (4863613915)...
41Downloading artifacts from coordinator... ok host=storage.googleapis.com id=4863613915 responseStatus=200 OK token=64_EFAxe
42Downloading artifacts for setup-test-env (4863613912)...
43Downloading artifacts from coordinator... ok host=storage.googleapis.com id=4863613912 responseStatus=200 OK token=64_EFAxe
44 Executing "step_script" stage of the job script 49:17
45Using docker image sha256:24a9e92645b17c878623efd51b7564f81e480bd281e94d7f33971082e0ca80e0 for registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bullseye-ruby-3.0.patched-golang-1.20-rust-1.65-node-18.17-postgresql-14:rubygems-3.4-git-2.36-lfs-2.9-chrome-113-yarn-1.22-graphicsmagick-1.3.36 with digest registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bullseye-ruby-3.0.patched-golang-1.20-rust-1.65-node-18.17-postgresql-14@sha256:ca349d228348f199cb57f574476584f42aca338747393ed93a9032a0261afc4d ...
46$ echo $FOSS_ONLY
47$ [ "$FOSS_ONLY" = "1" ] && rm -rf ee/ qa/spec/ee/ qa/qa/specs/features/ee/ qa/qa/ee/ qa/qa/ee.rb
48$ export GOPATH=$CI_PROJECT_DIR/.go
49$ mkdir -p $GOPATH
50$ source scripts/utils.sh
51$ source scripts/prepare_build.sh
52 Installing gems 05:20
1362Using decomposed database config (config/database.yml.decomposed-postgresql)
1363Geo DB won't be set up.
1364Embedding DB won't be set up.
1365 Setting up DBs 01:02
1376$ source ./scripts/rspec_helpers.sh
1377$ run_timed_command "gem install knapsack --no-document"
1378$ gem install knapsack --no-document
1379Successfully installed knapsack-4.0.0
13801 gem installed
1381==> 'gem install knapsack --no-document' succeeded in 1 seconds.
1382$ section_start "gitaly-test-spawn" "Spawning Gitaly"; scripts/gitaly-test-spawn; section_end "gitaly-test-spawn"
1383 Spawning Gitaly 00:11
1387$ export RSPEC_SKIPPED_TESTS_REPORT_PATH="rspec/skipped_tests-${CI_JOB_ID}.txt"
1388$ export RSPEC_RETRIED_TESTS_REPORT_PATH="rspec/retried_tests-${CI_JOB_ID}.txt"
1389$ rspec_paralellized_job "--fail-fast=${RSPEC_FAIL_FAST_THRESHOLD} --tag ~quarantine --tag ~zoekt --tag ~click_house"
1390SKIP_FLAKY_TESTS_AUTOMATICALLY:
1391RETRY_FAILED_TESTS_IN_NEW_PROCESS: true
1392KNAPSACK_GENERATE_REPORT: true
1393FLAKY_RSPEC_GENERATE_REPORT: true
1394KNAPSACK_TEST_FILE_PATTERN: spec/{migrations}{,/**/}*_spec.rb
1395KNAPSACK_LOG_LEVEL: debug
1396KNAPSACK_REPORT_PATH: knapsack/rspec_migration_pg14_2_8_report.json
1397FLAKY_RSPEC_SUITE_REPORT_PATH: rspec/flaky/report-suite.json
1398FLAKY_RSPEC_REPORT_PATH: rspec/flaky/all_rspec_migration_pg14_2_8_report.json
1399NEW_FLAKY_RSPEC_REPORT_PATH: rspec/flaky/new_rspec_migration_pg14_2_8_report.json
1400RSPEC_SKIPPED_TESTS_REPORT_PATH: rspec/skipped_tests-4863613999.txt
1401CRYSTALBALL:
1402RSPEC_TESTS_MAPPING_ENABLED:
1403RSPEC_TESTS_FILTER_FILE:
1404Shell set options (set -o) enabled:
1405braceexpand on
1406hashall on
1407interactive-comments on
1408pipefail on
1409Knapsack report generator started!
1410/builds/edith007/gitlab/ee/app/services/remote_development/service_response_factory.rb:41: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1411/builds/edith007/gitlab/ee/app/services/remote_development/workspaces/create_service.rb:28: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1412/builds/edith007/gitlab/ee/app/services/remote_development/workspaces/reconcile_service.rb:38: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1413/builds/edith007/gitlab/ee/app/services/remote_development/workspaces/update_service.rb:28: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1414/builds/edith007/gitlab/ee/lib/remote_development/agent_config/main.rb:32: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1415/builds/edith007/gitlab/ee/lib/remote_development/agent_config/updater.rb:11: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1416/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/authorizer.rb:12: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1417/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/authorizer.rb:13: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1418/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/creator.rb:17: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1419/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/creator.rb:24: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1420/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/creator.rb:25: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1421/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/creator.rb:28: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1422/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/devfile_fetcher.rb:15: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1423/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/devfile_fetcher.rb:16: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1424/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/devfile_flattener.rb:12: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1425/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/editor_component_injector.rb:12: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1426/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/editor_component_injector.rb:17: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1427/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/editor_component_injector.rb:18: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1428/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/post_flatten_devfile_validator.rb:43: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1429/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/post_flatten_devfile_validator.rb:54: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1430/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/post_flatten_devfile_validator.rb:102: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1431/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/post_flatten_devfile_validator.rb:126: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1432/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/post_flatten_devfile_validator.rb:159: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1433/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/post_flatten_devfile_validator.rb:202: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1434/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/post_flatten_devfile_validator.rb:235: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1435/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/pre_flatten_devfile_validator.rb:24: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1436/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/pre_flatten_devfile_validator.rb:52: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1437/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/project_cloner_component_injector.rb:12: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1438/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/project_cloner_component_injector.rb:17: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1439/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/project_cloner_component_injector.rb:18: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1440/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/project_cloner_component_injector.rb:23: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1441/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/volume_component_injector.rb:12: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1442/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/volume_component_injector.rb:13: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1443/builds/edith007/gitlab/ee/lib/remote_development/workspaces/create/volume_component_injector.rb:14: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1444/builds/edith007/gitlab/ee/lib/remote_development/workspaces/reconcile/main.rb:43: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1445/builds/edith007/gitlab/ee/lib/remote_development/workspaces/update/authorizer.rb:12: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1446/builds/edith007/gitlab/ee/lib/remote_development/workspaces/update/updater.rb:12: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1447/builds/edith007/gitlab/ee/lib/remote_development/workspaces/reconcile/input/agent_infos_observer.rb:15: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1448/builds/edith007/gitlab/ee/lib/remote_development/workspaces/reconcile/input/params_extractor.rb:14: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1449/builds/edith007/gitlab/ee/lib/remote_development/workspaces/reconcile/input/params_extractor.rb:16: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1450/builds/edith007/gitlab/ee/lib/remote_development/workspaces/reconcile/input/params_to_infos_converter.rb:14: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1451/builds/edith007/gitlab/ee/lib/remote_development/workspaces/reconcile/input/params_validator.rb:15: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1452/builds/edith007/gitlab/ee/lib/remote_development/workspaces/reconcile/output/rails_infos_observer.rb:11: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1453/builds/edith007/gitlab/ee/lib/remote_development/workspaces/reconcile/output/workspaces_to_rails_infos_converter.rb:15: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1454/builds/edith007/gitlab/ee/lib/remote_development/workspaces/reconcile/persistence/orphaned_workspaces_observer.rb:12: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1455/builds/edith007/gitlab/ee/lib/remote_development/workspaces/reconcile/persistence/workspaces_from_agent_infos_updater.rb:15: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1456/builds/edith007/gitlab/ee/lib/remote_development/workspaces/reconcile/persistence/workspaces_to_be_returned_finder.rb:16: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1457/builds/edith007/gitlab/ee/lib/remote_development/workspaces/reconcile/persistence/workspaces_to_be_returned_updater.rb:11: warning: One-line pattern matching is experimental, and the behavior may change in future versions of Ruby!
1458Run options: exclude {:quarantine=>true, :zoekt=>true, :click_house=>true}
1459Test environment set up in 0.63798534 seconds
1460SyncNewAmountUsedWithAmountUsed
1461 # order random
1462 #down
1463 updates `new_amount_used` with values from `amount_used`
1464 #up
1465 doesnt change new_amount_used values
1466I, [2023-08-13T07:13:50.862235 #45746] INFO -- : Database: 'main', Table: 'ci_runner_machines': Lock Writes
1467I, [2023-08-13T07:13:57.002894 #45746] INFO -- : Database: 'main', Table: 'p_ci_runner_machine_builds': Lock Writes
1468I, [2023-08-13T07:13:57.320527 #45746] INFO -- : Database: 'main', Table: 'ci_cost_settings': Lock Writes
1469I, [2023-08-13T07:14:08.830751 #45746] INFO -- : Database: 'main', Table: 'ci_editor_ai_conversation_messages': Lock Writes
1470I, [2023-08-13T07:14:12.082547 #45746] INFO -- : Database: 'main', Table: 'p_ci_builds': Lock Writes
1471I, [2023-08-13T07:14:12.083754 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1472I, [2023-08-13T07:14:12.084556 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1473I, [2023-08-13T07:14:26.831855 #45746] INFO -- : Database: 'main', Table: 'p_ci_job_annotations': Lock Writes
1474I, [2023-08-13T07:14:48.544800 #45746] INFO -- : Database: 'ci', Table: 'analytics_dashboards_pointers': Lock Writes
1475I, [2023-08-13T07:14:48.545972 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1476I, [2023-08-13T07:14:48.546743 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1477I, [2023-08-13T07:14:48.624008 #45746] INFO -- : Database: 'ci', Table: 'workspaces': Lock Writes
1478I, [2023-08-13T07:14:48.800428 #45746] INFO -- : Database: 'ci', Table: 'remote_development_agent_configs': Lock Writes
1479I, [2023-08-13T07:14:49.790947 #45746] INFO -- : Database: 'ci', Table: 'zoekt_shards': Lock Writes
1480I, [2023-08-13T07:14:49.792933 #45746] INFO -- : Database: 'ci', Table: 'zoekt_indexed_namespaces': Lock Writes
1481I, [2023-08-13T07:14:50.282413 #45746] INFO -- : Database: 'ci', Table: 'dast_profiles_tags': Lock Writes
1482I, [2023-08-13T07:14:50.352774 #45746] INFO -- : Database: 'ci', Table: 'namespaces_storage_limit_exclusions': Lock Writes
1483I, [2023-08-13T07:14:51.427314 #45746] INFO -- : Database: 'ci', Table: 'namespace_ldap_settings': Lock Writes
1484I, [2023-08-13T07:14:52.078612 #45746] INFO -- : Database: 'ci', Table: 'project_data_transfers': Lock Writes
1485I, [2023-08-13T07:14:52.079737 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1486I, [2023-08-13T07:14:52.080537 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1487I, [2023-08-13T07:14:52.272887 #45746] INFO -- : Database: 'ci', Table: 'service_desk_custom_email_verifications': Lock Writes
1488I, [2023-08-13T07:14:52.899529 #45746] INFO -- : Database: 'ci', Table: 'pm_checkpoints': Lock Writes
1489I, [2023-08-13T07:14:53.014558 #45746] INFO -- : Database: 'ci', Table: 'scan_result_policies': Lock Writes
1490I, [2023-08-13T07:14:54.680297 #45746] INFO -- : Database: 'ci', Table: 'work_item_widget_definitions': Lock Writes
1491I, [2023-08-13T07:14:55.839763 #45746] INFO -- : Database: 'ci', Table: 'container_repository_states': Lock Writes
1492I, [2023-08-13T07:14:55.840891 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1493I, [2023-08-13T07:14:55.841653 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1494I, [2023-08-13T07:14:56.213785 #45746] INFO -- : Database: 'ci', Table: 'automation_rules': Lock Writes
1495I, [2023-08-13T07:14:57.384244 #45746] INFO -- : Database: 'ci', Table: 'bulk_import_export_batches': Lock Writes
1496I, [2023-08-13T07:14:57.496457 #45746] INFO -- : Database: 'ci', Table: 'bulk_import_batch_trackers': Lock Writes
1497I, [2023-08-13T07:14:59.133151 #45746] INFO -- : Database: 'ci', Table: 'catalog_resources': Lock Writes
1498I, [2023-08-13T07:15:01.375275 #45746] INFO -- : Database: 'ci', Table: 'design_management_repositories': Lock Writes
1499I, [2023-08-13T07:15:01.924202 #45746] INFO -- : Database: 'ci', Table: 'container_registry_data_repair_details': Lock Writes
1500I, [2023-08-13T07:15:02.388526 #45746] INFO -- : Database: 'ci', Table: 'search_indices': Lock Writes
1501I, [2023-08-13T07:15:02.420271 #45746] INFO -- : Database: 'ci', Table: 'search_namespace_index_assignments': Lock Writes
1502I, [2023-08-13T07:15:02.492350 #45746] INFO -- : Database: 'ci', Table: 'resource_link_events': Lock Writes
1503I, [2023-08-13T07:15:02.794069 #45746] INFO -- : Database: 'ci', Table: 'packages_npm_metadata_caches': Lock Writes
1504I, [2023-08-13T07:15:03.206251 #45746] INFO -- : Database: 'ci', Table: 'service_desk_custom_email_credentials': Lock Writes
1505I, [2023-08-13T07:15:05.184699 #45746] INFO -- : Database: 'ci', Table: 'design_management_repository_states': Lock Writes
1506I, [2023-08-13T07:15:05.630729 #45746] INFO -- : Database: 'ci', Table: 'dora_performance_scores': Lock Writes
1507I, [2023-08-13T07:15:10.329778 #45746] INFO -- : Database: 'ci', Table: 'audit_events_instance_external_audit_event_destinations': Lock Writes
1508I, [2023-08-13T07:15:10.501886 #45746] INFO -- : Database: 'ci', Table: 'agent_user_access_project_authorizations': Lock Writes
1509I, [2023-08-13T07:15:10.528765 #45746] INFO -- : Database: 'ci', Table: 'agent_user_access_group_authorizations': Lock Writes
1510I, [2023-08-13T07:15:10.860047 #45746] INFO -- : Database: 'ci', Table: 'abuse_trust_scores': Lock Writes
1511I, [2023-08-13T07:15:10.892564 #45746] INFO -- : Database: 'ci', Table: 'pm_advisories': Lock Writes
1512I, [2023-08-13T07:15:10.894606 #45746] INFO -- : Database: 'ci', Table: 'pm_affected_packages': Lock Writes
1513I, [2023-08-13T07:15:10.941622 #45746] INFO -- : Database: 'ci', Table: 'issue_assignment_events': Lock Writes
1514I, [2023-08-13T07:15:11.960442 #45746] INFO -- : Database: 'ci', Table: 'merge_request_assignment_events': Lock Writes
1515I, [2023-08-13T07:15:12.998765 #45746] INFO -- : Database: 'ci', Table: 'project_states': Lock Writes
1516I, [2023-08-13T07:15:14.127545 #45746] INFO -- : Database: 'ci', Table: 'organizations': Lock Writes
1517I, [2023-08-13T07:15:14.426778 #45746] INFO -- : Database: 'ci', Table: 'value_stream_dashboard_counts': Lock Writes
1518I, [2023-08-13T07:15:14.528803 #45746] INFO -- : Database: 'ci', Table: 'note_metadata': Lock Writes
1519I, [2023-08-13T07:15:14.883339 #45746] INFO -- : Database: 'ci', Table: 'merge_request_diff_llm_summaries': Lock Writes
1520I, [2023-08-13T07:15:15.289426 #45746] INFO -- : Database: 'ci', Table: 'value_stream_dashboard_aggregations': Lock Writes
1521I, [2023-08-13T07:15:15.470683 #45746] INFO -- : Database: 'ci', Table: 'abuse_report_events': Lock Writes
1522I, [2023-08-13T07:15:16.511495 #45746] INFO -- : Database: 'ci', Table: 'audit_events_google_cloud_logging_configurations': Lock Writes
1523I, [2023-08-13T07:15:19.220370 #45746] INFO -- : Database: 'ci', Table: 'dependency_proxy_packages_settings': Lock Writes
1524I, [2023-08-13T07:15:19.221434 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1525I, [2023-08-13T07:15:19.222186 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1526I, [2023-08-13T07:15:19.309200 #45746] INFO -- : Database: 'ci', Table: 'instance_audit_events_streaming_headers': Lock Writes
1527I, [2023-08-13T07:15:21.602451 #45746] INFO -- : Database: 'ci', Table: 'abuse_events': Lock Writes
1528I, [2023-08-13T07:15:33.347545 #45746] INFO -- : Database: 'ci', Table: 'subscription_add_ons': Lock Writes
1529I, [2023-08-13T07:15:33.385469 #45746] INFO -- : Database: 'ci', Table: 'subscription_add_on_purchases': Lock Writes
1530I, [2023-08-13T07:15:33.726408 #45746] INFO -- : Database: 'ci', Table: 'project_compliance_standards_adherence': Lock Writes
1531I, [2023-08-13T07:15:35.754789 #45746] INFO -- : Database: 'ci', Table: 'organization_settings': Lock Writes
1532I, [2023-08-13T07:15:36.021699 #45746] INFO -- : Database: 'ci', Table: 'organization_users': Lock Writes
1533I, [2023-08-13T07:15:36.531081 #45746] INFO -- : Database: 'ci', Table: 'audit_events_streaming_instance_event_type_filters': Lock Writes
1534I, [2023-08-13T07:15:38.748149 #45746] INFO -- : Database: 'ci', Table: 'subscription_user_add_on_assignments': Lock Writes
1535I, [2023-08-13T07:15:38.875718 #45746] INFO -- : Database: 'ci', Table: 'system_access_microsoft_applications': Lock Writes
1536I, [2023-08-13T07:15:38.904343 #45746] INFO -- : Database: 'ci', Table: 'system_access_microsoft_graph_access_tokens': Lock Writes
1537I, [2023-08-13T07:15:40.225246 #45746] INFO -- : Database: 'ci', Table: 'merge_request_review_llm_summaries': Lock Writes
1538I, [2023-08-13T07:15:40.931338 #45746] INFO -- : Database: 'ci', Table: 'catalog_resource_versions': Lock Writes
1539I, [2023-08-13T07:15:42.171095 #45746] INFO -- : Database: 'ci', Table: 'p_batched_git_ref_updates_deletions': Lock Writes
1540I, [2023-08-13T07:15:42.197686 #45746] INFO -- : Database: 'ci', Table: 'service_access_tokens': Lock Writes
1541I, [2023-08-13T07:15:42.228703 #45746] INFO -- : Database: 'ci', Table: 'ml_models': Lock Writes
1542I, [2023-08-13T07:15:42.714336 #45746] INFO -- : Database: 'ci', Table: 'ml_model_versions': Lock Writes
1543I, [2023-08-13T07:15:45.152131 #45746] INFO -- : Database: 'ci', Table: 'group_wiki_repository_states': Lock Writes
1544I, [2023-08-13T07:15:45.435791 #45746] INFO -- : Database: 'ci', Table: 'target_branch_rules': Lock Writes
1545FixPartitionIdsForCiBuildReportResult
1546 # order random
1547 when on saas
1548 #up
1549ci: == [advisory_lock_connection] object_id: 83868900, pg_backend_pid: 3577
1550ci: == 20230209090702 FixPartitionIdsForCiBuildReportResult: migrating ============
1551ci: == 20230209090702 FixPartitionIdsForCiBuildReportResult: migrated (0.0702s) ===
1552ci: == [advisory_lock_connection] object_id: 83868900, pg_backend_pid: 3577
1553 schedules background jobs for each batch of ci_build_report_results
1554 #down
1555ci: == [advisory_lock_connection] object_id: 84898740, pg_backend_pid: 3583
1556ci: == 20230209090702 FixPartitionIdsForCiBuildReportResult: migrating ============
1557ci: == 20230209090702 FixPartitionIdsForCiBuildReportResult: migrated (0.0687s) ===
1558ci: == [advisory_lock_connection] object_id: 84898740, pg_backend_pid: 3583
1559 deletes all batched migration records
1560 when on self-managed instance
1561 #up
1562 does not schedule background job
1563 #down
1564 does not delete background job
1565I, [2023-08-13T07:17:46.337728 #45746] INFO -- : Database: 'main', Table: 'p_ci_runner_machine_builds': Lock Writes
1566I, [2023-08-13T07:17:46.579656 #45746] INFO -- : Database: 'main', Table: 'ci_cost_settings': Lock Writes
1567I, [2023-08-13T07:17:57.667490 #45746] INFO -- : Database: 'main', Table: 'ci_editor_ai_conversation_messages': Lock Writes
1568I, [2023-08-13T07:18:01.021843 #45746] INFO -- : Database: 'main', Table: 'p_ci_builds': Lock Writes
1569I, [2023-08-13T07:18:01.022967 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1570I, [2023-08-13T07:18:01.023765 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1571I, [2023-08-13T07:18:15.830006 #45746] INFO -- : Database: 'main', Table: 'p_ci_job_annotations': Lock Writes
1572I, [2023-08-13T07:18:38.677787 #45746] INFO -- : Database: 'ci', Table: 'bulk_import_export_batches': Lock Writes
1573I, [2023-08-13T07:18:38.802622 #45746] INFO -- : Database: 'ci', Table: 'bulk_import_batch_trackers': Lock Writes
1574I, [2023-08-13T07:18:40.324976 #45746] INFO -- : Database: 'ci', Table: 'catalog_resources': Lock Writes
1575I, [2023-08-13T07:18:42.510374 #45746] INFO -- : Database: 'ci', Table: 'design_management_repositories': Lock Writes
1576I, [2023-08-13T07:18:43.065463 #45746] INFO -- : Database: 'ci', Table: 'container_registry_data_repair_details': Lock Writes
1577I, [2023-08-13T07:18:43.528413 #45746] INFO -- : Database: 'ci', Table: 'search_indices': Lock Writes
1578I, [2023-08-13T07:18:43.561983 #45746] INFO -- : Database: 'ci', Table: 'search_namespace_index_assignments': Lock Writes
1579I, [2023-08-13T07:18:43.640182 #45746] INFO -- : Database: 'ci', Table: 'resource_link_events': Lock Writes
1580I, [2023-08-13T07:18:43.938564 #45746] INFO -- : Database: 'ci', Table: 'packages_npm_metadata_caches': Lock Writes
1581I, [2023-08-13T07:18:44.363957 #45746] INFO -- : Database: 'ci', Table: 'service_desk_custom_email_credentials': Lock Writes
1582I, [2023-08-13T07:18:46.380686 #45746] INFO -- : Database: 'ci', Table: 'design_management_repository_states': Lock Writes
1583I, [2023-08-13T07:18:46.830037 #45746] INFO -- : Database: 'ci', Table: 'dora_performance_scores': Lock Writes
1584I, [2023-08-13T07:18:51.637467 #45746] INFO -- : Database: 'ci', Table: 'audit_events_instance_external_audit_event_destinations': Lock Writes
1585I, [2023-08-13T07:18:51.815076 #45746] INFO -- : Database: 'ci', Table: 'agent_user_access_project_authorizations': Lock Writes
1586I, [2023-08-13T07:18:51.840839 #45746] INFO -- : Database: 'ci', Table: 'agent_user_access_group_authorizations': Lock Writes
1587I, [2023-08-13T07:18:52.151449 #45746] INFO -- : Database: 'ci', Table: 'abuse_trust_scores': Lock Writes
1588I, [2023-08-13T07:18:52.182343 #45746] INFO -- : Database: 'ci', Table: 'pm_advisories': Lock Writes
1589I, [2023-08-13T07:18:52.184258 #45746] INFO -- : Database: 'ci', Table: 'pm_affected_packages': Lock Writes
1590I, [2023-08-13T07:18:52.225861 #45746] INFO -- : Database: 'ci', Table: 'issue_assignment_events': Lock Writes
1591I, [2023-08-13T07:18:53.239700 #45746] INFO -- : Database: 'ci', Table: 'merge_request_assignment_events': Lock Writes
1592I, [2023-08-13T07:18:54.727286 #45746] INFO -- : Database: 'ci', Table: 'project_states': Lock Writes
1593I, [2023-08-13T07:18:55.301737 #45746] INFO -- : Database: 'ci', Table: 'organizations': Lock Writes
1594I, [2023-08-13T07:18:55.613489 #45746] INFO -- : Database: 'ci', Table: 'value_stream_dashboard_counts': Lock Writes
1595I, [2023-08-13T07:18:55.716211 #45746] INFO -- : Database: 'ci', Table: 'note_metadata': Lock Writes
1596I, [2023-08-13T07:18:56.058602 #45746] INFO -- : Database: 'ci', Table: 'merge_request_diff_llm_summaries': Lock Writes
1597I, [2023-08-13T07:18:56.426259 #45746] INFO -- : Database: 'ci', Table: 'value_stream_dashboard_aggregations': Lock Writes
1598I, [2023-08-13T07:18:56.602218 #45746] INFO -- : Database: 'ci', Table: 'abuse_report_events': Lock Writes
1599I, [2023-08-13T07:18:57.512936 #45746] INFO -- : Database: 'ci', Table: 'audit_events_google_cloud_logging_configurations': Lock Writes
1600I, [2023-08-13T07:19:00.213427 #45746] INFO -- : Database: 'ci', Table: 'dependency_proxy_packages_settings': Lock Writes
1601I, [2023-08-13T07:19:00.214707 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1602I, [2023-08-13T07:19:00.215520 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1603I, [2023-08-13T07:19:00.359914 #45746] INFO -- : Database: 'ci', Table: 'instance_audit_events_streaming_headers': Lock Writes
1604I, [2023-08-13T07:19:02.490642 #45746] INFO -- : Database: 'ci', Table: 'abuse_events': Lock Writes
1605I, [2023-08-13T07:19:14.391270 #45746] INFO -- : Database: 'ci', Table: 'subscription_add_ons': Lock Writes
1606I, [2023-08-13T07:19:14.419152 #45746] INFO -- : Database: 'ci', Table: 'subscription_add_on_purchases': Lock Writes
1607I, [2023-08-13T07:19:14.705808 #45746] INFO -- : Database: 'ci', Table: 'project_compliance_standards_adherence': Lock Writes
1608I, [2023-08-13T07:19:16.724216 #45746] INFO -- : Database: 'ci', Table: 'organization_settings': Lock Writes
1609I, [2023-08-13T07:19:17.010606 #45746] INFO -- : Database: 'ci', Table: 'organization_users': Lock Writes
1610I, [2023-08-13T07:19:17.578779 #45746] INFO -- : Database: 'ci', Table: 'audit_events_streaming_instance_event_type_filters': Lock Writes
1611I, [2023-08-13T07:19:20.022973 #45746] INFO -- : Database: 'ci', Table: 'subscription_user_add_on_assignments': Lock Writes
1612I, [2023-08-13T07:19:20.148952 #45746] INFO -- : Database: 'ci', Table: 'system_access_microsoft_applications': Lock Writes
1613I, [2023-08-13T07:19:20.177641 #45746] INFO -- : Database: 'ci', Table: 'system_access_microsoft_graph_access_tokens': Lock Writes
1614I, [2023-08-13T07:19:21.490569 #45746] INFO -- : Database: 'ci', Table: 'merge_request_review_llm_summaries': Lock Writes
1615I, [2023-08-13T07:19:22.234010 #45746] INFO -- : Database: 'ci', Table: 'catalog_resource_versions': Lock Writes
1616I, [2023-08-13T07:19:23.408667 #45746] INFO -- : Database: 'ci', Table: 'p_batched_git_ref_updates_deletions': Lock Writes
1617I, [2023-08-13T07:19:23.435964 #45746] INFO -- : Database: 'ci', Table: 'service_access_tokens': Lock Writes
1618I, [2023-08-13T07:19:23.465251 #45746] INFO -- : Database: 'ci', Table: 'ml_models': Lock Writes
1619I, [2023-08-13T07:19:23.968519 #45746] INFO -- : Database: 'ci', Table: 'ml_model_versions': Lock Writes
1620I, [2023-08-13T07:19:26.448107 #45746] INFO -- : Database: 'ci', Table: 'group_wiki_repository_states': Lock Writes
1621I, [2023-08-13T07:19:26.750568 #45746] INFO -- : Database: 'ci', Table: 'target_branch_rules': Lock Writes
1622FinalizeInvalidMemberCleanup
1623 # order random
1624 #up
1625 when migration is missing
1626main: == [advisory_lock_connection] object_id: 113987580, pg_backend_pid: 4568
1627main: == 20221006070927 FinalizeInvalidMemberCleanup: migrating =====================
1628main: == 20221006070927 FinalizeInvalidMemberCleanup: migrated (0.0094s) ============
1629main: == [advisory_lock_connection] object_id: 113987580, pg_backend_pid: 4568
1630 warns migration not found
1631 with migration present
1632 when migration finished successfully
1633main: == [advisory_lock_connection] object_id: 115104140, pg_backend_pid: 4570
1634main: == 20221006070927 FinalizeInvalidMemberCleanup: migrating =====================
1635main: == 20221006070927 FinalizeInvalidMemberCleanup: migrated (0.0189s) ============
1636main: == [advisory_lock_connection] object_id: 115104140, pg_backend_pid: 4570
1637 does not raise exception
1638 with different migration statuses
1639 status: 0, description: "paused"
1640 behaves like finalizes the migration
1641 finalizes the migration
1642 status: 1, description: "active"
1643 behaves like finalizes the migration
1644 finalizes the migration
1645 status: 4, description: "failed"
1646 behaves like finalizes the migration
1647 finalizes the migration
1648 status: 5, description: "finalizing"
1649 behaves like finalizes the migration
1650 finalizes the migration
1651I, [2023-08-13T07:20:47.499644 #45746] INFO -- : Database: 'main', Table: 'ci_runner_machines': Lock Writes
1652I, [2023-08-13T07:20:54.255050 #45746] INFO -- : Database: 'main', Table: 'p_ci_runner_machine_builds': Lock Writes
1653I, [2023-08-13T07:20:54.479074 #45746] INFO -- : Database: 'main', Table: 'ci_cost_settings': Lock Writes
1654I, [2023-08-13T07:21:06.081943 #45746] INFO -- : Database: 'main', Table: 'ci_editor_ai_conversation_messages': Lock Writes
1655I, [2023-08-13T07:21:10.461726 #45746] INFO -- : Database: 'main', Table: 'p_ci_builds': Lock Writes
1656I, [2023-08-13T07:21:10.462781 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1657I, [2023-08-13T07:21:10.463470 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1658I, [2023-08-13T07:21:25.837229 #45746] INFO -- : Database: 'main', Table: 'p_ci_job_annotations': Lock Writes
1659AddDefaultPreferredLanguageToApplicationSettings
1660 # order random
1661 #down
1662main: == [advisory_lock_connection] object_id: 138842520, pg_backend_pid: 4590
1663main: == 20221101032521 AddDefaultPreferredLanguageToApplicationSettings: migrating =
1664main: -- add_column(:application_settings, :default_preferred_language, :text, {:default=>"en", :null=>false})
1665main: -> 0.0052s
1666main: == 20221101032521 AddDefaultPreferredLanguageToApplicationSettings: migrated (0.0056s)
1667main: == [advisory_lock_connection] object_id: 138842520, pg_backend_pid: 4590
1668 deletes default_preferred_language field
1669 #up
1670main: == [advisory_lock_connection] object_id: 140210960, pg_backend_pid: 4593
1671main: == 20221101032521 AddDefaultPreferredLanguageToApplicationSettings: migrating =
1672main: -- add_column(:application_settings, :default_preferred_language, :text, {:default=>"en", :null=>false})
1673main: -> 0.0043s
1674main: == 20221101032521 AddDefaultPreferredLanguageToApplicationSettings: migrated (0.0048s)
1675main: == [advisory_lock_connection] object_id: 140210960, pg_backend_pid: 4593
1676 allows to read default_preferred_language field
1677I, [2023-08-13T07:22:48.405065 #45746] INFO -- : Database: 'main', Table: 'ci_runner_machines': Lock Writes
1678I, [2023-08-13T07:22:55.220774 #45746] INFO -- : Database: 'main', Table: 'p_ci_runner_machine_builds': Lock Writes
1679I, [2023-08-13T07:22:55.462605 #45746] INFO -- : Database: 'main', Table: 'ci_cost_settings': Lock Writes
1680I, [2023-08-13T07:23:08.007518 #45746] INFO -- : Database: 'main', Table: 'ci_editor_ai_conversation_messages': Lock Writes
1681I, [2023-08-13T07:23:12.314728 #45746] INFO -- : Database: 'main', Table: 'p_ci_builds': Lock Writes
1682I, [2023-08-13T07:23:12.316012 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1683I, [2023-08-13T07:23:12.316864 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1684I, [2023-08-13T07:23:28.872738 #45746] INFO -- : Database: 'main', Table: 'p_ci_job_annotations': Lock Writes
1685CreateSecondPartitionForBuildsMetadata
1686 # order random
1687 #up
1688 when on sass
1689main: == [advisory_lock_connection] object_id: 161524160, pg_backend_pid: 4608
1690main: == 20221102090943 CreateSecondPartitionForBuildsMetadata: migrating ===========
1691main: == 20221102090943 CreateSecondPartitionForBuildsMetadata: migrated (0.0110s) ==
1692main: == [advisory_lock_connection] object_id: 161524160, pg_backend_pid: 4608
1693 creates a new partition
1694 when self-managed
1695main: == [advisory_lock_connection] object_id: 162418280, pg_backend_pid: 4610
1696main: == 20221102090943 CreateSecondPartitionForBuildsMetadata: migrating ===========
1697main: == 20221102090943 CreateSecondPartitionForBuildsMetadata: migrated (0.0002s) ==
1698main: == [advisory_lock_connection] object_id: 162418280, pg_backend_pid: 4610
1699 does not create the partition
1700 #down
1701 when on sass
1702main: == [advisory_lock_connection] object_id: 162969560, pg_backend_pid: 4612
1703main: == 20221102090943 CreateSecondPartitionForBuildsMetadata: migrating ===========
1704main: == 20221102090943 CreateSecondPartitionForBuildsMetadata: migrated (0.0067s) ==
1705main: == [advisory_lock_connection] object_id: 162969560, pg_backend_pid: 4612
1706 removes the partition
1707 when self-managed
1708main: == [advisory_lock_connection] object_id: 163212220, pg_backend_pid: 4614
1709main: == 20221102090943 CreateSecondPartitionForBuildsMetadata: migrating ===========
1710main: == 20221102090943 CreateSecondPartitionForBuildsMetadata: migrated (0.0003s) ==
1711main: == [advisory_lock_connection] object_id: 163212220, pg_backend_pid: 4614
1712 does not change the partitions count
1713I, [2023-08-13T07:24:56.186896 #45746] INFO -- : Database: 'main', Table: 'ci_runner_machines': Lock Writes
1714I, [2023-08-13T07:25:02.782128 #45746] INFO -- : Database: 'main', Table: 'p_ci_runner_machine_builds': Lock Writes
1715I, [2023-08-13T07:25:03.034403 #45746] INFO -- : Database: 'main', Table: 'ci_cost_settings': Lock Writes
1716I, [2023-08-13T07:25:14.601510 #45746] INFO -- : Database: 'main', Table: 'ci_editor_ai_conversation_messages': Lock Writes
1717I, [2023-08-13T07:25:18.996092 #45746] INFO -- : Database: 'main', Table: 'p_ci_builds': Lock Writes
1718I, [2023-08-13T07:25:18.997266 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1719I, [2023-08-13T07:25:18.998120 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1720I, [2023-08-13T07:25:33.951426 #45746] INFO -- : Database: 'main', Table: 'p_ci_job_annotations': Lock Writes
1721QueueResetStatusOnContainerRepositories
1722 # order random
1723main: == [advisory_lock_connection] object_id: 184391140, pg_backend_pid: 4629
1724main: == 20221123133054 QueueResetStatusOnContainerRepositories: migrating ==========
1725main: == 20221123133054 QueueResetStatusOnContainerRepositories: migrated (0.0463s) =
1726main: == [advisory_lock_connection] object_id: 184391140, pg_backend_pid: 4629
1727 schedules a new batched migration
1728 with the container registry disabled
1729main: == [advisory_lock_connection] object_id: 185601740, pg_backend_pid: 4632
1730main: == 20221123133054 QueueResetStatusOnContainerRepositories: migrating ==========
1731main: == 20221123133054 QueueResetStatusOnContainerRepositories: migrated (0.0003s) =
1732main: == [advisory_lock_connection] object_id: 185601740, pg_backend_pid: 4632
1733 does not schedule a new batched migration
1734I, [2023-08-13T07:26:54.128671 #45746] INFO -- : Database: 'main', Table: 'ci_runner_machines': Lock Writes
1735I, [2023-08-13T07:27:00.504418 #45746] INFO -- : Database: 'main', Table: 'p_ci_runner_machine_builds': Lock Writes
1736I, [2023-08-13T07:27:00.747346 #45746] INFO -- : Database: 'main', Table: 'ci_cost_settings': Lock Writes
1737I, [2023-08-13T07:27:12.085752 #45746] INFO -- : Database: 'main', Table: 'ci_editor_ai_conversation_messages': Lock Writes
1738I, [2023-08-13T07:27:16.327969 #45746] INFO -- : Database: 'main', Table: 'p_ci_builds': Lock Writes
1739I, [2023-08-13T07:27:16.329119 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1740I, [2023-08-13T07:27:16.329860 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1741I, [2023-08-13T07:27:31.648005 #45746] INFO -- : Database: 'main', Table: 'p_ci_job_annotations': Lock Writes
1742UpdateActiveBillableUsersIndex
1743 # order random
1744main: -- indexes("users")
1745main: -> 0.0335s
1746main: -- current_schema()
1747main: -> 0.0008s
1748main: -- indexes("users")
1749main: -> 0.0326s
1750main: == [advisory_lock_connection] object_id: 205619300, pg_backend_pid: 4648
1751main: == 20221210154044 UpdateActiveBillableUsersIndex: migrating ===================
1752main: -- view_exists?(:postgres_partitions)
1753main: -> 0.0015s
1754main: -- index_exists?("users", [:id], {:where=>"((state)::text = 'active'::text) AND ((user_type IS NULL)\nOR (user_type = ANY (ARRAY[NULL::integer, 6, 4]))) AND ((user_type IS NULL)\nOR (user_type <> ALL ('{1,2,3,4,5,6,7,8,9,11}'::smallint[])))\n", :name=>"index_users_for_active_billable", :algorithm=>:concurrently})
1755main: -> 0.0315s
1756main: -- add_index("users", [:id], {:where=>"((state)::text = 'active'::text) AND ((user_type IS NULL)\nOR (user_type = ANY (ARRAY[NULL::integer, 6, 4]))) AND ((user_type IS NULL)\nOR (user_type <> ALL ('{1,2,3,4,5,6,7,8,9,11}'::smallint[])))\n", :name=>"index_users_for_active_billable", :algorithm=>:concurrently})
1757main: -> 0.0031s
1758main: -- view_exists?(:postgres_partitions)
1759main: -> 0.0013s
1760main: -- indexes("users")
1761main: -> 0.0322s
1762main: -- remove_index("users", {:algorithm=>:concurrently, :name=>"active_billable_users"})
1763main: -> 0.0021s
1764main: == 20221210154044 UpdateActiveBillableUsersIndex: migrated (0.1075s) ==========
1765main: == [advisory_lock_connection] object_id: 205619300, pg_backend_pid: 4648
1766main: -- indexes("users")
1767main: -> 0.0336s
1768main: -- current_schema()
1769main: -> 0.0007s
1770main: -- indexes("users")
1771main: -> 0.0321s
1772main: -- indexes("users")
1773main: -> 0.0317s
1774main: -- current_schema()
1775main: -> 0.0007s
1776main: -- indexes("users")
1777main: -> 0.0308s
1778 correctly migrates up and down
1779The application_settings (main) table has 1224 columns.
1780Recreating the database
1781Dropped database 'gitlabhq_test'
1782Dropped database 'gitlabhq_test_ci'
1783Created database 'gitlabhq_test'
1784Created database 'gitlabhq_test_ci'
1785main: == [advisory_lock_connection] object_id: 206531600, pg_backend_pid: 4660
1786main: == [advisory_lock_connection] object_id: 206531600, pg_backend_pid: 4660
1787ci: == [advisory_lock_connection] object_id: 206671820, pg_backend_pid: 4662
1788ci: == [advisory_lock_connection] object_id: 206671820, pg_backend_pid: 4662
1789Databases re-creation done in 11.673692051999751
1790AddOkrHierarchyRestrictions
1791 # order random
1792main: == [advisory_lock_connection] object_id: 214837860, pg_backend_pid: 4669
1793main: == 20221116143854 AddOkrHierarchyRestrictions: migrating ======================
1794main: == 20221116143854 AddOkrHierarchyRestrictions: migrated (0.0251s) =============
1795main: == [advisory_lock_connection] object_id: 214837860, pg_backend_pid: 4669
1796 creates default restrictions
1797 when work items are missing
1798main: == [advisory_lock_connection] object_id: 216050880, pg_backend_pid: 4672
1799main: == 20221116143854 AddOkrHierarchyRestrictions: migrating ======================
1800main: == 20221116143854 AddOkrHierarchyRestrictions: migrated (0.0142s) =============
1801main: == [advisory_lock_connection] object_id: 216050880, pg_backend_pid: 4672
1802 does nothing
1803I, [2023-08-13T07:29:51.621620 #45746] INFO -- : Database: 'main', Table: 'ci_runner_machines': Lock Writes
1804I, [2023-08-13T07:29:57.827337 #45746] INFO -- : Database: 'main', Table: 'p_ci_runner_machine_builds': Lock Writes
1805I, [2023-08-13T07:29:58.061907 #45746] INFO -- : Database: 'main', Table: 'ci_cost_settings': Lock Writes
1806I, [2023-08-13T07:30:09.460396 #45746] INFO -- : Database: 'main', Table: 'ci_editor_ai_conversation_messages': Lock Writes
1807I, [2023-08-13T07:30:13.465642 #45746] INFO -- : Database: 'main', Table: 'p_ci_builds': Lock Writes
1808I, [2023-08-13T07:30:13.466704 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1809I, [2023-08-13T07:30:13.467423 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1810I, [2023-08-13T07:30:27.184816 #45746] INFO -- : Database: 'main', Table: 'p_ci_job_annotations': Lock Writes
1811DeleteQueuedJobsForVulnerabilitiesFeedbackMigration
1812 # order random
1813 #up
1814 deletes all batched migration records
1815I, [2023-08-13T07:31:35.384336 #45746] INFO -- : Database: 'main', Table: 'ci_runner_machines': Lock Writes
1816I, [2023-08-13T07:31:41.520165 #45746] INFO -- : Database: 'main', Table: 'p_ci_runner_machine_builds': Lock Writes
1817I, [2023-08-13T07:31:41.752723 #45746] INFO -- : Database: 'main', Table: 'ci_cost_settings': Lock Writes
1818I, [2023-08-13T07:31:52.964430 #45746] INFO -- : Database: 'main', Table: 'ci_editor_ai_conversation_messages': Lock Writes
1819I, [2023-08-13T07:31:57.141917 #45746] INFO -- : Database: 'main', Table: 'p_ci_builds': Lock Writes
1820I, [2023-08-13T07:31:57.143369 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1821I, [2023-08-13T07:31:57.144130 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1822I, [2023-08-13T07:32:11.228989 #45746] INFO -- : Database: 'main', Table: 'p_ci_job_annotations': Lock Writes
1823ScheduleMigrationForRemediation
1824 # order random
1825 #up
1826main: == [advisory_lock_connection] object_id: 255252480, pg_backend_pid: 4699
1827main: == 20230118144623 ScheduleMigrationForRemediation: migrating ==================
1828main: == 20230118144623 ScheduleMigrationForRemediation: migrated (0.0073s) =========
1829main: == [advisory_lock_connection] object_id: 255252480, pg_backend_pid: 4699
1830 schedules a batched background migration
1831 #down
1832main: == [advisory_lock_connection] object_id: 255911140, pg_backend_pid: 4701
1833main: == 20230118144623 ScheduleMigrationForRemediation: migrating ==================
1834main: == 20230118144623 ScheduleMigrationForRemediation: migrated (0.0077s) =========
1835main: == [advisory_lock_connection] object_id: 255911140, pg_backend_pid: 4701
1836 deletes all batched migration records
1837I, [2023-08-13T07:33:23.723467 #45746] INFO -- : Database: 'main', Table: 'p_ci_runner_machine_builds': Lock Writes
1838I, [2023-08-13T07:33:24.005033 #45746] INFO -- : Database: 'main', Table: 'ci_cost_settings': Lock Writes
1839I, [2023-08-13T07:33:35.133296 #45746] INFO -- : Database: 'main', Table: 'ci_editor_ai_conversation_messages': Lock Writes
1840I, [2023-08-13T07:33:39.200269 #45746] INFO -- : Database: 'main', Table: 'p_ci_builds': Lock Writes
1841I, [2023-08-13T07:33:39.201358 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1842I, [2023-08-13T07:33:39.202103 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1843I, [2023-08-13T07:33:53.152190 #45746] INFO -- : Database: 'main', Table: 'p_ci_job_annotations': Lock Writes
1844SwapTimelogsNoteIdToBigintForGitlabDotCom
1845 # order random
1846 #up
1847 swaps the integer and bigint columns for GitLab.com, dev, or test
1848 is a no-op for other instances
1849I, [2023-08-13T07:35:08.477059 #45746] INFO -- : Database: 'main', Table: 'ci_editor_ai_conversation_messages': Lock Writes
1850I, [2023-08-13T07:35:11.596222 #45746] INFO -- : Database: 'main', Table: 'p_ci_builds': Lock Writes
1851I, [2023-08-13T07:35:11.597304 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1852I, [2023-08-13T07:35:11.598029 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1853I, [2023-08-13T07:35:26.641839 #45746] INFO -- : Database: 'main', Table: 'p_ci_job_annotations': Lock Writes
1854SwapEpicUserMentionsNoteIdToBigintForGitlabDotCom
1855 # order random
1856 #up
1857 swaps the integer and bigint columns for GitLab.com, dev, or test
1858 is a no-op for other instances
1859I, [2023-08-13T07:36:32.600779 #45746] INFO -- : Database: 'main', Table: 'ci_editor_ai_conversation_messages': Lock Writes
1860I, [2023-08-13T07:36:35.783479 #45746] INFO -- : Database: 'main', Table: 'p_ci_builds': Lock Writes
1861I, [2023-08-13T07:36:35.784525 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1862I, [2023-08-13T07:36:35.785269 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1863I, [2023-08-13T07:36:50.327144 #45746] INFO -- : Database: 'main', Table: 'p_ci_job_annotations': Lock Writes
1864SwapIssueUserMentionsNoteIdToBigintForGitlabDotCom2
1865 # order random
1866 #up
1867 swaps the integer and bigint columns for GitLab.com, dev, or test
1868 is a no-op for other instances
1869main: == [advisory_lock_connection] object_id: 302454440, pg_backend_pid: 4757
1870main: == 20230413041917 SwapIssueUserMentionsNoteIdToBigintForGitlabDotCom2: migrating
1871main: -- columns("issue_user_mentions")
1872main: -> 0.0031s
1873main: == 20230413041917 SwapIssueUserMentionsNoteIdToBigintForGitlabDotCom2: migrated (0.0101s)
1874main: == [advisory_lock_connection] object_id: 302454440, pg_backend_pid: 4757
1875 is a no-op if columns are already swapped
1876I, [2023-08-13T07:37:55.229220 #45746] INFO -- : Database: 'main', Table: 'ci_editor_ai_conversation_messages': Lock Writes
1877I, [2023-08-13T07:37:58.248708 #45746] INFO -- : Database: 'main', Table: 'p_ci_builds': Lock Writes
1878I, [2023-08-13T07:37:58.249810 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1879I, [2023-08-13T07:37:58.250562 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1880I, [2023-08-13T07:38:12.968269 #45746] INFO -- : Database: 'main', Table: 'p_ci_job_annotations': Lock Writes
1881BackfillProductAnalyticsDataCollectorHost
1882 # order random
1883 #up
1884 when jitsu host is present
1885main: == [advisory_lock_connection] object_id: 314769280, pg_backend_pid: 4770
1886main: == 20230327123333 BackfillProductAnalyticsDataCollectorHost: migrating ========
1887main: -- execute("UPDATE application_settings\nSET product_analytics_data_collector_host = regexp_replace(jitsu_host, '://(.+?\\.)', '://collector.', 'g')\nWHERE jitsu_host IS NOT NULL AND product_analytics_data_collector_host IS NULL\n")
1888main: -> 0.0021s
1889main: == 20230327123333 BackfillProductAnalyticsDataCollectorHost: migrated (0.0092s)
1890main: == [advisory_lock_connection] object_id: 314769280, pg_backend_pid: 4770
1891 backfills missing product_analytics_data_collector_host
1892main: == [advisory_lock_connection] object_id: 315496220, pg_backend_pid: 4772
1893main: == 20230327123333 BackfillProductAnalyticsDataCollectorHost: migrating ========
1894main: -- execute("UPDATE application_settings\nSET product_analytics_data_collector_host = regexp_replace(jitsu_host, '://(.+?\\.)', '://collector.', 'g')\nWHERE jitsu_host IS NOT NULL AND product_analytics_data_collector_host IS NULL\n")
1895main: -> 0.0021s
1896main: == 20230327123333 BackfillProductAnalyticsDataCollectorHost: migrated (0.0102s)
1897main: == [advisory_lock_connection] object_id: 315496220, pg_backend_pid: 4772
1898 does not modify existing product_analytics_data_collector_host
1899 when jitsu host is not present
1900main: == [advisory_lock_connection] object_id: 315780780, pg_backend_pid: 4775
1901main: == 20230327123333 BackfillProductAnalyticsDataCollectorHost: migrating ========
1902main: -- execute("UPDATE application_settings\nSET product_analytics_data_collector_host = regexp_replace(jitsu_host, '://(.+?\\.)', '://collector.', 'g')\nWHERE jitsu_host IS NOT NULL AND product_analytics_data_collector_host IS NULL\n")
1903main: -> 0.0022s
1904main: == 20230327123333 BackfillProductAnalyticsDataCollectorHost: migrated (0.0097s)
1905main: == [advisory_lock_connection] object_id: 315780780, pg_backend_pid: 4775
1906 does not backfill product_analytics_data_collector_host
1907I, [2023-08-13T07:39:26.180178 #45746] INFO -- : Database: 'main', Table: 'ci_editor_ai_conversation_messages': Lock Writes
1908I, [2023-08-13T07:39:29.340229 #45746] INFO -- : Database: 'main', Table: 'p_ci_builds': Lock Writes
1909I, [2023-08-13T07:39:29.341356 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1910I, [2023-08-13T07:39:29.342384 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1911I, [2023-08-13T07:39:45.218732 #45746] INFO -- : Database: 'main', Table: 'p_ci_job_annotations': Lock Writes
1912SwapAwardEmojiNoteIdToBigintForGitlabDotCom
1913 # order random
1914 #up
1915 swaps the integer and bigint columns for GitLab.com, dev, or test
1916 is a no-op for other instances
1917The application_settings (main) table has 1203 columns.
1918Recreating the database
1919Dropped database 'gitlabhq_test'
1920Dropped database 'gitlabhq_test_ci'
1921Created database 'gitlabhq_test'
1922Created database 'gitlabhq_test_ci'
1923main: == [advisory_lock_connection] object_id: 329125460, pg_backend_pid: 4802
1924main: == [advisory_lock_connection] object_id: 329125460, pg_backend_pid: 4802
1925ci: == [advisory_lock_connection] object_id: 329198660, pg_backend_pid: 4804
1926ci: == [advisory_lock_connection] object_id: 329198660, pg_backend_pid: 4804
1927Databases re-creation done in 11.462091708000116
1928RemoveIncorrectlyOnboardedNamespacesFromOnboardingProgress
1929 # order random
1930 #up
1931main: == [advisory_lock_connection] object_id: 334950940, pg_backend_pid: 4811
1932main: == 20230221214519 RemoveIncorrectlyOnboardedNamespacesFromOnboardingProgress: migrating
1933main: == 20230221214519 RemoveIncorrectlyOnboardedNamespacesFromOnboardingProgress: migrated (0.0251s)
1934main: == [advisory_lock_connection] object_id: 334950940, pg_backend_pid: 4811
1935 deletes the onboarding for namespaces without learn gitlab
1936I, [2023-08-13T07:41:47.101052 #45746] INFO -- : Database: 'main', Table: 'ci_editor_ai_conversation_messages': Lock Writes
1937I, [2023-08-13T07:41:50.971358 #45746] INFO -- : Database: 'main', Table: 'p_ci_builds': Lock Writes
1938I, [2023-08-13T07:41:50.972461 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1939I, [2023-08-13T07:41:50.973208 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1940I, [2023-08-13T07:42:05.132164 #45746] INFO -- : Database: 'main', Table: 'p_ci_job_annotations': Lock Writes
1941QueueBackfillDesignManagementRepositories
1942 # order random
1943main: == [advisory_lock_connection] object_id: 349489480, pg_backend_pid: 4825
1944main: == 20230406121544 QueueBackfillDesignManagementRepositories: migrating ========
1945main: == 20230406121544 QueueBackfillDesignManagementRepositories: migrated (0.0529s)
1946main: == [advisory_lock_connection] object_id: 349489480, pg_backend_pid: 4825
1947 schedules a new batched migration
1948I, [2023-08-13T07:43:03.491473 #45746] INFO -- : Database: 'main', Table: 'ci_editor_ai_conversation_messages': Lock Writes
1949I, [2023-08-13T07:43:06.555625 #45746] INFO -- : Database: 'main', Table: 'p_ci_builds': Lock Writes
1950I, [2023-08-13T07:43:06.556831 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1951I, [2023-08-13T07:43:06.557549 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1952I, [2023-08-13T07:43:19.812313 #45746] INFO -- : Database: 'main', Table: 'p_ci_job_annotations': Lock Writes
1953SwapTodosNoteIdToBigintForGitlabDotCom
1954 # order random
1955 #up
1956 swaps the integer and bigint columns for GitLab.com, dev, or test
1957 is a no-op for other instances
1958I, [2023-08-13T07:44:18.495164 #45746] INFO -- : Database: 'main', Table: 'ci_editor_ai_conversation_messages': Lock Writes
1959I, [2023-08-13T07:44:21.657870 #45746] INFO -- : Database: 'main', Table: 'p_ci_builds': Lock Writes
1960I, [2023-08-13T07:44:21.658941 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1961I, [2023-08-13T07:44:21.659664 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1962I, [2023-08-13T07:44:35.030962 #45746] INFO -- : Database: 'main', Table: 'p_ci_job_annotations': Lock Writes
1963InsertDailyInvitesTrialPlanLimits
1964 # order random
1965 when on gitlab.com
1966main: == [advisory_lock_connection] object_id: 375331820, pg_backend_pid: 4855
1967main: == 20230316093433 InsertDailyInvitesTrialPlanLimits: migrating ================
1968main: -- quote_column_name("daily_invites")
1969main: -> 0.0000s
1970main: -- quote("premium_trial")
1971main: -> 0.0001s
1972main: -- quote(50)
1973main: -> 0.0000s
1974main: -- execute("INSERT INTO plan_limits (plan_id, \"daily_invites\")\nSELECT id, '50' FROM plans WHERE name = 'premium_trial' LIMIT 1\nON CONFLICT (plan_id) DO UPDATE SET \"daily_invites\" = EXCLUDED.\"daily_invites\";\n")
1975main: -> 0.0021s
1976main: -- quote_column_name("daily_invites")
1977main: -> 0.0000s
1978main: -- quote("ultimate_trial")
1979main: -> 0.0000s
1980main: -- quote(50)
1981main: -> 0.0000s
1982main: -- execute("INSERT INTO plan_limits (plan_id, \"daily_invites\")\nSELECT id, '50' FROM plans WHERE name = 'ultimate_trial' LIMIT 1\nON CONFLICT (plan_id) DO UPDATE SET \"daily_invites\" = EXCLUDED.\"daily_invites\";\n")
1983main: -> 0.0015s
1984main: == 20230316093433 InsertDailyInvitesTrialPlanLimits: migrated (0.0116s) =======
1985main: == [advisory_lock_connection] object_id: 375331820, pg_backend_pid: 4855
1986 correctly migrates up and down
1987 when on self-managed
1988main: == [advisory_lock_connection] object_id: 376178180, pg_backend_pid: 4858
1989main: == 20230316093433 InsertDailyInvitesTrialPlanLimits: migrating ================
1990main: == 20230316093433 InsertDailyInvitesTrialPlanLimits: migrated (0.0069s) =======
1991main: == [advisory_lock_connection] object_id: 376178180, pg_backend_pid: 4858
1992 correctly migrates up and down
1993I, [2023-08-13T07:45:44.402218 #45746] INFO -- : Database: 'main', Table: 'ci_editor_ai_conversation_messages': Lock Writes
1994I, [2023-08-13T07:45:48.365991 #45746] INFO -- : Database: 'main', Table: 'p_ci_builds': Lock Writes
1995I, [2023-08-13T07:45:48.367068 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
1996I, [2023-08-13T07:45:48.367888 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
1997I, [2023-08-13T07:46:02.567760 #45746] INFO -- : Database: 'main', Table: 'p_ci_job_annotations': Lock Writes
1998RescheduleIncidentWorkItemTypeIdBackfill
1999 # order random
2000 #up
2001main: == [advisory_lock_connection] object_id: 388962800, pg_backend_pid: 4872
2002main: == 20230414200202 RescheduleIncidentWorkItemTypeIdBackfill: migrating =========
2003main: == 20230414200202 RescheduleIncidentWorkItemTypeIdBackfill: migrated (0.0604s)
2004main: == [advisory_lock_connection] object_id: 388962800, pg_backend_pid: 4872
2005 correctly reschedules background migration only for incidents
2006main: == [advisory_lock_connection] object_id: 389729920, pg_backend_pid: 4875
2007main: == 20230414200202 RescheduleIncidentWorkItemTypeIdBackfill: migrating =========
2008main: -- Incident work item type not found. Make sure the work_item_types table is populatedbefore running this migration
2009main: == 20230414200202 RescheduleIncidentWorkItemTypeIdBackfill: migrated (0.0093s)
2010main: == [advisory_lock_connection] object_id: 389729920, pg_backend_pid: 4875
2011 doesn't fail if work item types don't exist on the DB
2012I, [2023-08-13T07:47:02.430270 #45746] INFO -- : Database: 'main', Table: 'ci_editor_ai_conversation_messages': Lock Writes
2013I, [2023-08-13T07:47:05.362647 #45746] INFO -- : Database: 'main', Table: 'p_ci_builds': Lock Writes
2014I, [2023-08-13T07:47:05.363706 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
2015I, [2023-08-13T07:47:05.364463 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
2016I, [2023-08-13T07:47:19.527123 #45746] INFO -- : Database: 'main', Table: 'p_ci_job_annotations': Lock Writes
2017RemoveGitlabImportSource
2018 # order random
2019 #up
2020main: == [advisory_lock_connection] object_id: 400840840, pg_backend_pid: 4887
2021main: == 20230504084524 RemoveGitlabImportSource: migrating =========================
2022main: == 20230504084524 RemoveGitlabImportSource: migrated (0.2147s) ================
2023main: == [advisory_lock_connection] object_id: 400840840, pg_backend_pid: 4887
2024 removes gitlab and preserves existing valid import sources
2025I, [2023-08-13T07:48:18.367907 #45746] INFO -- : Database: 'main', Table: 'p_ci_builds': Lock Writes
2026I, [2023-08-13T07:48:18.369018 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
2027I, [2023-08-13T07:48:18.369749 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
2028I, [2023-08-13T07:48:32.399244 #45746] INFO -- : Database: 'main', Table: 'p_ci_job_annotations': Lock Writes
2029EnsureMergeRequestMetricsIdBigintBackfillIsFinishedForSelfHosts
2030 # order random
2031 #up
2032main: == [advisory_lock_connection] object_id: 412442580, pg_backend_pid: 4900
2033main: == 20230419094535 EnsureMergeRequestMetricsIdBigintBackfillIsFinishedForSelfHosts: migrating
2034main: == 20230419094535 EnsureMergeRequestMetricsIdBigintBackfillIsFinishedForSelfHosts: migrated (0.0068s)
2035main: == [advisory_lock_connection] object_id: 412442580, pg_backend_pid: 4900
2036 ensures the migration is completed
2037I, [2023-08-13T07:49:30.806267 #45746] INFO -- : Database: 'main', Table: 'ci_editor_ai_conversation_messages': Lock Writes
2038I, [2023-08-13T07:49:33.797955 #45746] INFO -- : Database: 'main', Table: 'p_ci_builds': Lock Writes
2039I, [2023-08-13T07:49:33.799152 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Lock timeout is set", :current_iteration=>1, :lock_timeout_in_ms=>100}
2040I, [2023-08-13T07:49:33.800226 #45746] INFO -- : {:method=>"with_lock_retries", :class=>"gitlab:db:lock_writes", :message=>"Migration finished", :current_iteration=>1, :lock_timeout_in_ms=>100}
2041I, [2023-08-13T07:49:48.109789 #45746] INFO -- : Database: 'main', Table: 'p_ci_job_annotations': Lock Writes
2042SwapNotesIdToBigintForGitlabDotCom
2043 # order random
2044 #up
2045 swaps the integer and bigint columns for GitLab.com, dev, or test
2046 is a no-op for other instances
2047I, [2023-08-13T07:50:43.204706 #45746] INFO -- : Database: 'main', Table: 'p_ci_job_annotations': Lock Writes
2048AddUniqueIndexForNpmPackagesOnProjectIdNameVersion
2049 # order random
2050main: == [advisory_lock_connection] object_id: 431468540, pg_backend_pid: 4928
2051main: == 20230616082958 AddUniqueIndexForNpmPackagesOnProjectIdNameVersion: migrating
2052main: -- view_exists?(:postgres_partitions)
2053main: -> 0.0019s
2054main: -- index_exists?(:packages_packages, [:project_id, :name, :version], {:name=>"idx_packages_on_project_id_name_version_unique_when_npm", :unique=>true, :where=>"package_type = 2 AND status <> 4", :algorithm=>:concurrently})
2055main: -> 0.0246s
2056main: -- add_index(:packages_packages, [:project_id, :name, :version], {:name=>"idx_packages_on_project_id_name_version_unique_when_npm", :unique=>true, :where=>"package_type = 2 AND status <> 4", :algorithm=>:concurrently})
2057main: -> 0.0023s
2058main: == 20230616082958 AddUniqueIndexForNpmPackagesOnProjectIdNameVersion: migrated (0.0551s)
2059main: == [advisory_lock_connection] object_id: 431468540, pg_backend_pid: 4928
2060 schedules an index creation
2061EnsureEventsBigintBackfillIsFinishedForGitlabDotCom
2062 # order random
2063 #up
2064main: == [advisory_lock_connection] object_id: 436041140, pg_backend_pid: 4940
2065main: == 20230629024032 EnsureEventsBigintBackfillIsFinishedForGitlabDotCom: migrating
2066main: == 20230629024032 EnsureEventsBigintBackfillIsFinishedForGitlabDotCom: migrated (0.0070s)
2067main: == [advisory_lock_connection] object_id: 436041140, pg_backend_pid: 4940
2068 ensures the migration is completed for GitLab.com, dev, or test
2069main: == [advisory_lock_connection] object_id: 436860020, pg_backend_pid: 4942
2070main: == 20230629024032 EnsureEventsBigintBackfillIsFinishedForGitlabDotCom: migrating
2071main: == 20230629024032 EnsureEventsBigintBackfillIsFinishedForGitlabDotCom: migrated (0.0066s)
2072main: == [advisory_lock_connection] object_id: 436860020, pg_backend_pid: 4942
2073 skips the check for other instances
2074QueueDeleteOrphanedTransferredProjectApprovalRules
2075 # order random
2076main: == [advisory_lock_connection] object_id: 439789440, pg_backend_pid: 4953
2077main: == 20230724164745 QueueDeleteOrphanedTransferredProjectApprovalRules: migrating
2078main: == 20230724164745 QueueDeleteOrphanedTransferredProjectApprovalRules: migrated (0.0480s)
2079main: == [advisory_lock_connection] object_id: 439789440, pg_backend_pid: 4953
2080 schedules a new batched migration
2081Knapsack report was generated. Preview:
2082{
2083 "spec/migrations/20221222092958_sync_new_amount_used_with_amount_used_spec.rb": 114.0514319670001,
2084 "spec/migrations/20230209090702_fix_partition_ids_for_ci_build_report_result_spec.rb": 104.01569993300018,
2085 "spec/migrations/finalize_invalid_member_cleanup_spec.rb": 57.5611132680001,
2086 "spec/migrations/20221101032521_add_default_preferred_language_to_application_settings_spec.rb": 51.835357036000005,
2087 "spec/migrations/20221102090943_create_second_partition_for_builds_metadata_spec.rb": 55.12946194599954,
2088 "spec/migrations/20221123133054_queue_reset_status_on_container_repositories_spec.rb": 50.76940871500028,
2089 "spec/migrations/20221210154044_update_active_billable_users_index_spec.rb": 50.28013313300016,
2090 "spec/migrations/add_okr_hierarchy_restrictions_spec.rb": 47.569636278999496,
2091 "spec/migrations/20221223123019_delete_queued_jobs_for_vulnerabilities_feedback_migration_spec.rb": 43.371856536999985,
2092 "spec/migrations/20230118144623_schedule_migration_for_remediation_spec.rb": 43.775803327000176,
2093 "spec/migrations/swap_timelogs_note_id_to_bigint_for_gitlab_dot_com_spec.rb": 40.678822029,
2094 "spec/migrations/swap_epic_user_mentions_note_id_to_bigint_for_gitlab_dot_com_spec.rb": 37.907401749999735,
2095 "spec/migrations/swap_issue_user_mentions_note_id_to_bigint_for_gitlab_dot_com_2_spec.rb": 38.346850025000094,
2096 "spec/migrations/20230327123333_backfill_product_analytics_data_collector_host_spec.rb": 41.96614544000022,
2097 "spec/migrations/swap_award_emoji_note_id_to_bigint_for_gitlab_dot_com_spec.rb": 36.738024874000075,
2098 "spec/migrations/20230221214519_remove_incorrectly_onboarded_namespaces_from_onboarding_progress_spec.rb": 37.03675913799998,
2099 "spec/migrations/20230406121544_queue_backfill_design_management_repositories_spec.rb": 32.679571453999415,
2100 "spec/migrations/swap_todos_note_id_to_bigint_for_gitlab_dot_com_spec.rb": 34.283297916000265,
2101 "spec/migrations/insert_daily_invites_trial_plan_limits_spec.rb": 37.93509700699997,
2102 "spec/migrations/reschedule_incident_work_item_type_id_backfill_spec.rb": 34.5995151369998,
2103 "spec/migrations/20230504084524_remove_gitlab_import_source_spec.rb": 32.041028779000044,
2104 "spec/migrations/ensure_merge_request_metrics_id_bigint_backfill_is_finished_for_self_hosts_spec.rb": 33.3907251239998,
2105 "spec/migrations/swap_notes_id_to_bigint_for_gitlab_dot_com_spec.rb": 26.299771582000176,
2106 "spec/migrations/20230616082958_add_unique_index_for_npm_packages_on_project_id_name_version_spec.rb": 17.38788271700014,
2107 "spec/migrations/ensure_events_bigint_backfill_is_finished_for_gitlab_dot_com_spec.rb": 17.420149433000006,
2108 "spec/migrations/20230724164745_queue_delete_orphaned_transferred_project_approval_rules_spec.rb": 13.068399866999243
2109}
2110Knapsack global time execution for tests: 18m 50s
2111Finished in 41 minutes 6 seconds (files took 1 minute 30.45 seconds to load)
211254 examples, 0 failures
2113Randomized with seed 44642
2114[TEST PROF INFO] Time spent in factories: 00:00.364 (0.01% of total time)
2115RSpec exited with 0.
2116No examples to retry, congrats!
2117 Running after_script
2118Running after script...
2119$ echo -e "\e[0Ksection_start:`date +%s`:report_results_section[collapsed=true]\r\e[0KReport results"
2120 Report results 00:01
2143 Saving cache for successful job 00:01
2144Not uploading cache ruby-gems-debian-bullseye-ruby-3.0-protected due to policy
2145 Uploading artifacts for successful job 00:04
2146Uploading artifacts...
2147WARNING: auto_explain/: no matching files. Ensure that the artifact path is relative to the working directory (/builds/edith007/gitlab)
2148coverage/: found 5 matching artifact files and directories
2149WARNING: crystalball/: no matching files. Ensure that the artifact path is relative to the working directory (/builds/edith007/gitlab)
2150WARNING: deprecations/: no matching files. Ensure that the artifact path is relative to the working directory (/builds/edith007/gitlab)
2151knapsack/: found 4 matching artifact files and directories
2152rspec/: found 10 matching artifact files and directories
2153WARNING: tmp/capybara/: no matching files. Ensure that the artifact path is relative to the working directory (/builds/edith007/gitlab)
2154log/*.log: found 13 matching artifact files and directories
2155WARNING: Upload request redirected location=https://gitlab.com/api/v4/jobs/4863613999/artifacts?artifact_format=zip&artifact_type=archive&expire_in=31d new-url=https://gitlab.com
2156WARNING: Retrying... context=artifacts-uploader error=request redirected
2157Uploading artifacts as "archive" to coordinator... 201 Created id=4863613999 responseStatus=201 Created token=64_EFAxe
2158Uploading artifacts...
2159rspec/rspec-*.xml: found 1 matching artifact files and directories
2160WARNING: Upload request redirected location=https://gitlab.com/api/v4/jobs/4863613999/artifacts?artifact_format=gzip&artifact_type=junit&expire_in=31d new-url=https://gitlab.com
2161WARNING: Retrying... context=artifacts-uploader error=request redirected
2162Uploading artifacts as "junit" to coordinator... 201 Created id=4863613999 responseStatus=201 Created token=64_EFAxe
2163 Cleaning up project directory and file based variables 00:01
2164Job succeeded