decomposition-multiple-db 1/5
Passed Started
by
@gitlab-bot

🤖 GitLab Bot 🤖
1Running with gitlab-runner 15.11.0 (436955cb)2 on gitlab-org-qa-runner ss7o3c7p, system ID: s_6a73791243695Using Docker executor with image registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bullseye-ruby-3.0:bundler-2.3-docker-24.0.5 ...6Starting service docker:24.0.5-dind ...7Pulling docker image docker:24.0.5-dind ...8Using docker image sha256:7015f2c475d511a251955877c2862016a4042512ba625ed905e69202f87e1a21 for docker:24.0.5-dind with digest docker@sha256:3c6e4dca7a63c9a32a4e00da40461ce067f255987ccc9721cf18ffa087bcd1ef ...9Waiting for services to be up and running (timeout 30 seconds)...10Authenticating with credentials from job payload (GitLab Registry)11Pulling docker image registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bullseye-ruby-3.0:bundler-2.3-docker-24.0.5 ...12Using docker image sha256:d74b87fe019fa5fbfd87eb37c97409980b5fc6d12aa4c2b38f9a42c6b6603544 for registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bullseye-ruby-3.0:bundler-2.3-docker-24.0.5 with digest registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bullseye-ruby-3.0@sha256:325eeabf3c3941b666682edcc5f001411d6bc10f7851fdc5ffde58cd0c4327c8 ...14Running on runner-ss7o3c7p-project-278964-concurrent-0 via runner-ss7o3c7p-gitlab-org-qa-1695005294-876ac18e-gcp...16Fetching changes with git depth set to 20...17Initialized empty Git repository in /builds/gitlab-org/gitlab/.git/18Created fresh repository.19remote: Enumerating objects: 170809, done. 20remote: Counting objects: 100% (170809/170809), done. 21remote: Compressing objects: 100% (113574/113574), done. 22remote: Total 170809 (delta 80156), reused 114099 (delta 50441), pack-reused 0 23Receiving objects: 100% (170809/170809), 137.98 MiB | 43.09 MiB/s, done.24Resolving deltas: 100% (80156/80156), done.26 * [new ref] refs/pipelines/1007819091 -> refs/pipelines/100781909127 * [new branch] master -> origin/master28Checking out 9421296c as detached HEAD (ref is master)...29Skipping Git submodules setup31Checking cache for qa-e2e-ruby-3.0-a7315659c09a492e7e01a6e73f495ce6-16...32Downloading cache.zip from https://storage.googleapis.com/gitlab-qa-runner-cache-1/project/278964/qa-e2e-ruby-3.0-a7315659c09a492e7e01a6e73f495ce6-16 33WARNING: .gems/gems/deprecation_toolkit-2.0.3/gemfiles/test/deprecations: chmod .gems/gems/deprecation_toolkit-2.0.3/gemfiles/test/deprecations: no such file or directory (suppressing repeats) 34Successfully extracted cache36Downloading artifacts for download-knapsack-report (5107563339)...37Downloading artifacts from coordinator... ok host=storage.googleapis.com id=5107563339 responseStatus=200 OK token=64_27Fgs38Downloading artifacts for download-fast-quarantine-report (5107563340)...39Downloading artifacts from coordinator... ok host=storage.googleapis.com id=5107563340 responseStatus=200 OK token=64_27Fgs41Using docker image sha256:d74b87fe019fa5fbfd87eb37c97409980b5fc6d12aa4c2b38f9a42c6b6603544 for registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bullseye-ruby-3.0:bundler-2.3-docker-24.0.5 with digest registry.gitlab.com/gitlab-org/gitlab-build-images/debian-bullseye-ruby-3.0@sha256:325eeabf3c3941b666682edcc5f001411d6bc10f7851fdc5ffde58cd0c4327c8 ...42$ echo "SUITE_RAN=true" > $QA_SUITE_STATUS_ENV_FILE43$ export BUNDLE_PREFIX=$([ "$RUN_WITH_BUNDLE" != "true" ] || echo "bundle exec")44$ if [ "$RUN_WITH_BUNDLE" == "true" ]; then # collapsed multi-line command45Bundle complete! 38 Gemfile dependencies, 136 gems now installed.46Use `bundle info [gemname]` to see where a bundled gem is installed.47$ export RSPEC_FAST_QUARANTINE_PATH="/home/gitlab/qa/${RSPEC_FAST_QUARANTINE_PATH}"48$ export RSPEC_SKIPPED_TESTS_REPORT_PATH="/home/gitlab/qa/rspec/skipped_tests-${CI_JOB_ID}.txt"49$ export QA_COMMAND="$BUNDLE_PREFIX gitlab-qa ${QA_SCENARIO:=Test::Instance::Image} $RELEASE $GITLAB_QA_OPTS -- $QA_TESTS $QA_RSPEC_TAGS $RSPEC_REPORT_OPTS"50$ echo "Running - '$QA_COMMAND'"51Running - 'bundle exec gitlab-qa Test::Instance::Image registry.gitlab.com/gitlab-org/build/omnibus-gitlab-mirror/gitlab-ce:9421296c4a1e1a7dc4deb406a76aabc8810a3434 --omnibus-config decomposition_multiple_db -- --format QA::Support::JsonFormatter --out tmp/rspec-5107563359.json --format RspecJunitFormatter --out tmp/rspec-5107563359.xml --format html --out tmp/rspec-$(echo decomposition-multiple-db 1/5 | sed 's/[ /]/_/g').htm --color --format documentation'52$ eval "$QA_COMMAND"53[Sep 18 2023 02:52:51 UTC (Gitlab QA)] INFO -- Shell command: `docker container list --all --format '{{.Names}}' --filter name=^alpine-7fc7b8ae$`54[Sep 18 2023 02:52:51 UTC (Gitlab QA)] INFO -- Shell command: `docker run -d --name alpine-7fc7b8ae --volume authority:/etc/gitlab/trusted-certs:Z --volume gitlab-ssl:/etc/gitlab/ssl:Z alpine/curl:latest tail -f /dev/null`55[Sep 18 2023 02:52:53 UTC (Gitlab QA)] INFO -- Shell command: `docker cp /builds/gitlab-org/gitlab/.gems/gems/gitlab-qa-12.4.1/tls_certificates/authority/. alpine-7fc7b8ae:/etc/gitlab/trusted-certs`56[Sep 18 2023 02:52:53 UTC (Gitlab QA)] INFO -- Shell command: `docker cp /builds/gitlab-org/gitlab/.gems/gems/gitlab-qa-12.4.1/tls_certificates/gitlab/. alpine-7fc7b8ae:/etc/gitlab/ssl`57[Sep 18 2023 02:52:53 UTC (Gitlab QA)] INFO -- Shell command: `docker ps -f name=alpine-7fc7b8ae`58[Sep 18 2023 02:52:53 UTC (Gitlab QA)] INFO -- Shell command: `docker rm -f alpine-7fc7b8ae`59[Sep 18 2023 02:52:53 UTC (Gitlab QA)] INFO -- Shell command: `docker login --username "gitlab-ci-token" --password "*****" registry.gitlab.com`60[Sep 18 2023 02:52:53 UTC (Gitlab QA)] INFO -- Shell command: `docker pull -q registry.gitlab.com/gitlab-org/build/omnibus-gitlab-mirror/gitlab-ce:9421296c4a1e1a7dc4deb406a76aabc8810a3434`61[Sep 18 2023 02:53:33 UTC (Gitlab QA)] INFO -- Shell command: `docker container list --all --format '{{.Names}}' --filter name=^gitlab-ce-408a76fb$`62[Sep 18 2023 02:53:33 UTC (Gitlab QA)] INFO -- Shell command: `docker network list --format '{{.Name}}' --filter name=^test$`63[Sep 18 2023 02:53:33 UTC (Gitlab QA)] INFO -- Shell command: `docker network create test`64[Sep 18 2023 02:53:34 UTC (Gitlab QA)] INFO -- Shell command: `docker run -d --name gitlab-ce-408a76fb --net test --hostname gitlab-ce-408a76fb.test -p 80 --volume authority:/etc/gitlab/trusted-certs:Z --volume gitlab-ssl:/etc/gitlab/ssl:Z --volume /builds/gitlab-org/gitlab/gitlab-qa-run-2023-09-18-02-52-51-0e6275a9/gitlab-ce-408a76fb/logs:/var/log/gitlab:Z registry.gitlab.com/gitlab-org/build/omnibus-gitlab-mirror/gitlab-ce:9421296c4a1e1a7dc4deb406a76aabc8810a3434`65[Sep 18 2023 02:53:42 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitlab-ce-408a76fb bash -c "echo \"# Generated by GitLab QA Omnibus Configurator at 2023-09-18 02:52:5166gitlab_rails['gitlab_default_theme'] = 10 # Light Red Theme67gitlab_rails['gitlab_disable_animations'] = true # Disable animations68gitlab_rails['application_settings_cache_seconds'] = 0 # Settings cache expiry69gitlab_rails['initial_root_password'] = '5iveL!fe' # Initial root password70# Gitlab::QA::Runtime::OmnibusConfigurations::DecompositionMultipleDb71#gitlab_rails['databases']['main']['enable'] = true72#gitlab_rails['databases']['ci']['enable'] = true73#gitlab_rails['databases']['ci']['db_database'] = 'gitlabhq_production_ci'74gitlab_rails['env'] = {'GITLAB_LICENSE_MODE'=>'test', 'CUSTOMER_PORTAL_URL'=>'https://customers.staging.gitlab.com', 'GITLAB_QA_USER_AGENT'=>'*****', 'GITLAB_ALLOW_SEPARATE_CI_DATABASE'=>'true'}\" > /etc/gitlab/gitlab.rb;"`75[Sep 18 2023 02:53:42 UTC (Gitlab QA)] INFO -- Shell command: `docker attach --sig-proxy=false gitlab-ce-408a76fb`76[Sep 18 2023 02:56:59 UTC (Gitlab QA)] INFO -- Waiting for GitLab to become healthy ...77[Sep 18 2023 02:56:59 UTC (Gitlab QA)] INFO -- Shell command: `docker inspect --format='{{json .State.Health.Status}}' gitlab-ce-408a76fb`78[Sep 18 2023 02:56:59 UTC (Gitlab QA)] INFO -- Shell command: `docker port gitlab-ce-408a76fb 80/tcp`79[Sep 18 2023 02:56:59 UTC (Gitlab QA)] INFO -- -> GitLab is available at `http://docker:32768`!80[Sep 18 2023 02:56:59 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitlab-ce-408a76fb bash -c "mkdir -p /opt/gitlab/embedded/service/gitlab-shell/hooks/pre-receive.d"`81[Sep 18 2023 02:56:59 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitlab-ce-408a76fb bash -c "echo '#!/usr/bin/env bash82if [[ \$GL_PROJECT_PATH =~ 'reject-prereceive' ]]; then83 echo 'GL-HOOK-ERR: Custom error message rejecting prereceive hook for projects with GL_PROJECT_PATH matching pattern reject-prereceive'84 exit 185fi86' > /opt/gitlab/embedded/service/gitlab-shell/hooks/pre-receive.d/pre-receive.d;"`87[Sep 18 2023 02:56:59 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitlab-ce-408a76fb bash -c "chmod +x /opt/gitlab/embedded/service/gitlab-shell/hooks/pre-receive.d/*"`88[Sep 18 2023 02:56:59 UTC (Gitlab QA)] INFO -- Shell command: `docker cp /builds/gitlab-org/gitlab/.gems/gems/gitlab-qa-12.4.1/support/data gitlab-ce-408a76fb:/tmp/data-seeds`89[Sep 18 2023 02:56:59 UTC (Gitlab QA)] INFO -- Running exec_commands...90[Sep 18 2023 02:56:59 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitlab-ce-408a76fb bash -c "gitlab-rails runner /tmp/data-seeds/admin_access_token_seed.rb"`91[Sep 18 2023 02:57:44 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitlab-ce-408a76fb bash -c "sed -i 's/#gitlab_rails/gitlab_rails/g' /etc/gitlab/gitlab.rb"`92[Sep 18 2023 02:57:44 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitlab-ce-408a76fb bash -c "gitlab-ctl reconfigure"`93[Sep 18 2023 02:57:57 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitlab-ce-408a76fb bash -c "gitlab-psql -d gitlabhq_production_ci -c 'select 1' 2>1 > /dev/null || gitlab-psql -c 'create database gitlabhq_production_ci owner gitlab'"`94[Sep 18 2023 02:57:57 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitlab-ce-408a76fb bash -c "gitlab-psql -d gitlabhq_production_ci -c 'create extension if not exists btree_gist'"`95[Sep 18 2023 02:57:57 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitlab-ce-408a76fb bash -c "gitlab-psql -d gitlabhq_production_ci -c 'create extension if not exists pg_trgm'"`96[Sep 18 2023 02:57:58 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitlab-ce-408a76fb bash -c "gitlab-psql -d gitlabhq_production_ci -c \"select schema_name from information_schema.schemata where schema_name = 'gitlab_partitions_dynamic'\" | grep -q gitlab_partitions_dynamic || DISABLE_DATABASE_ENVIRONMENT_CHECK=1 gitlab-rake db:schema:load:ci"`97[Sep 18 2023 02:58:35 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitlab-ce-408a76fb bash -c "gitlab-ctl restart"`98[Sep 18 2023 02:59:04 UTC (Gitlab QA)] INFO -- Shell command: `docker login --username "gitlab-ci-token" --password "*****" registry.gitlab.com`99[Sep 18 2023 02:59:05 UTC (Gitlab QA)] INFO -- Shell command: `docker pull -q registry.gitlab.com/gitlab-org/gitlab/gitlab-ce-qa:9421296c4a1e1a7dc4deb406a76aabc8810a3434`100[Sep 18 2023 03:00:12 UTC (Gitlab QA)] INFO -- Running test suite `Test::Instance::All` for gitlab-ce101[Sep 18 2023 03:00:12 UTC (Gitlab QA)] INFO -- Shell command: `docker run -t --rm --net=test --hostname qa-e2e-specs.test --env QA_HOSTNAME="qa-e2e-specs.test" --env QA_AWS_S3_REGION="$QA_AWS_S3_REGION" --env QA_FACEBOOK_OAUTH_APP_ID="$QA_FACEBOOK_OAUTH_APP_ID" --env QA_GOOGLE_CDN_JSON_KEY="$QA_GOOGLE_CDN_JSON_KEY" --env QA_SUITE_STATUS_ENV_FILE="$QA_SUITE_STATUS_ENV_FILE" --env QA_THIRD_PARTY_DOCKER_REGISTRY="$QA_THIRD_PARTY_DOCKER_REGISTRY" --env QA_RSPEC_REPORT_PATH="$QA_RSPEC_REPORT_PATH" --env QA_SAVE_TEST_METRICS="$QA_SAVE_TEST_METRICS" --env QA_GOOGLE_CDN_SIGNURL_KEY_NAME="$QA_GOOGLE_CDN_SIGNURL_KEY_NAME" --env QA_1P_PASSWORD="$QA_1P_PASSWORD" --env QA_REMOTE_GRID_USERNAME="$QA_REMOTE_GRID_USERNAME" --env QA_GOOGLE_CDN_SIGNURL_KEY="$QA_GOOGLE_CDN_SIGNURL_KEY" --env QA_TEST_CASE_PROJECT_TOKEN="$QA_TEST_CASE_PROJECT_TOKEN" --env QA_GITHUB_USERNAME="$QA_GITHUB_USERNAME" --env QA_SLOW_CONNECTION_THROUGHPUT_KBPS="$QA_SLOW_CONNECTION_THROUGHPUT_KBPS" --env QA_GITHUB_PASSWORD="$QA_GITHUB_PASSWORD" --env QA_ARTIFACTS_DIR="$QA_ARTIFACTS_DIR" --env QA_GITLAB_TLS_CERTIFICATE="$QA_GITLAB_TLS_CERTIFICATE" --env QA_RUN_TYPE="$QA_RUN_TYPE" --env QA_JIRA_ADMIN_PASSWORD="$QA_JIRA_ADMIN_PASSWORD" --env QA_KNAPSACK_REPORT_PATH="$QA_KNAPSACK_REPORT_PATH" --env QA_GITHUB_OAUTH_APP_SECRET="$QA_GITHUB_OAUTH_APP_SECRET" --env QA_PATH="$QA_PATH" --env QA_JIRA_ADMIN_USERNAME="$QA_JIRA_ADMIN_USERNAME" --env QA_ADMIN_ACCESS_TOKEN="$QA_ADMIN_ACCESS_TOKEN" --env QA_COMMAND="$QA_COMMAND" --env QA_EE_LICENSE="$QA_EE_LICENSE" --env QA_1P_EMAIL="$QA_1P_EMAIL" --env QA_EE_ACTIVATION_CODE="$QA_EE_ACTIVATION_CODE" --env QA_GOOGLE_CLIENT_EMAIL="$QA_GOOGLE_CLIENT_EMAIL" --env QA_ALLURE_AWS_SECRET_ACCESS_KEY="$QA_ALLURE_AWS_SECRET_ACCESS_KEY" --env QA_GCS_BUCKET_NAME="$QA_GCS_BUCKET_NAME" --env QA_FACEBOOK_OAUTH_APP_SECRET="$QA_FACEBOOK_OAUTH_APP_SECRET" --env QA_GOOGLE_PROJECT="$QA_GOOGLE_PROJECT" --env QA_KNAPSACK_REPORT_GCS_CREDENTIALS="$QA_KNAPSACK_REPORT_GCS_CREDENTIALS" --env QA_AWS_S3_KEY_ID="$QA_AWS_S3_KEY_ID" --env QA_RUN_ALL_TESTS="$QA_RUN_ALL_TESTS" --env QA_GITLAB_CI_TOKEN="$QA_GITLAB_CI_TOKEN" --env QA_REMOTE_GRID_ACCESS_KEY="$QA_REMOTE_GRID_ACCESS_KEY" --env QA_FRAMEWORK_CHANGES="$QA_FRAMEWORK_CHANGES" --env QA_INTERCEPT_REQUESTS="$QA_INTERCEPT_REQUESTS" --env QA_INFLUXDB_URL="$QA_INFLUXDB_URL" --env QA_THIRD_PARTY_DOCKER_USER="$QA_THIRD_PARTY_DOCKER_USER" --env QA_THIRD_PARTY_DOCKER_PASSWORD="$QA_THIRD_PARTY_DOCKER_PASSWORD" --env QA_1P_SECRET="$QA_1P_SECRET" --env QA_AWS_S3_ACCESS_KEY="$QA_AWS_S3_ACCESS_KEY" --env QA_LOG_LEVEL="$QA_LOG_LEVEL" --env QA_GITHUB_OAUTH_APP_ID="$QA_GITHUB_OAUTH_APP_ID" --env QA_EXPORT_TEST_METRICS="$QA_EXPORT_TEST_METRICS" --env QA_GOOGLE_CDN_LB="$QA_GOOGLE_CDN_LB" --env QA_1P_GITHUB_UUID="$QA_1P_GITHUB_UUID" --env QA_FACEBOOK_PASSWORD="$QA_FACEBOOK_PASSWORD" --env QA_GCS_CDN_BUCKET_NAME="$QA_GCS_CDN_BUCKET_NAME" --env QA_SCENARIO="$QA_SCENARIO" --env QA_GOOGLE_JSON_KEY="$QA_GOOGLE_JSON_KEY" --env QA_TRIGGER_AUTO_QUARANTINE="$QA_TRIGGER_AUTO_QUARANTINE" --env QA_SUITES="$QA_SUITES" --env QA_RUN_ALL_E2E_LABEL="$QA_RUN_ALL_E2E_LABEL" --env QA_ALLURE_AWS_ACCESS_KEY_ID="$QA_ALLURE_AWS_ACCESS_KEY_ID" --env QA_AWS_S3_BUCKET_NAME="$QA_AWS_S3_BUCKET_NAME" --env QA_GENERATE_ALLURE_REPORT="$QA_GENERATE_ALLURE_REPORT" --env QA_CAN_TEST_PRAEFECT="$QA_CAN_TEST_PRAEFECT" --env QA_RUN_TESTS_ON_GDK="$QA_RUN_TESTS_ON_GDK" --env QA_INFLUXDB_TOKEN="$QA_INFLUXDB_TOKEN" --env QA_TEST_LICENSE_MODE="$QA_TEST_LICENSE_MODE" --env QA_TEST_SESSION_TOKEN="$QA_TEST_SESSION_TOKEN" --env QA_SLOW_CONNECTION_LATENCY_MS="$QA_SLOW_CONNECTION_LATENCY_MS" --env QA_RESULTS_ISSUE_PROJECT_TOKEN="$QA_RESULTS_ISSUE_PROJECT_TOKEN" --env QA_GITHUB_ACCESS_TOKEN="$QA_GITHUB_ACCESS_TOKEN" --env QA_FACEBOOK_USERNAME="$QA_FACEBOOK_USERNAME" --env QA_OMNIBUS_MR_TESTS="$QA_OMNIBUS_MR_TESTS" --env QA_THIRD_PARTY_DOCKER_REPOSITORY="$QA_THIRD_PARTY_DOCKER_REPOSITORY" --env QA_SELENOID_BROWSER_VERSION="111.0" --env QA_VIDEO_RECORDER_IMAGE="presidenten/selenoid-manual-video-recorder" --env QA_VIDEO_RECORDER_VERSION="latest" --env QA_SELENOID_BROWSER_IMAGE="selenoid/chrome" --env GITLAB_QA_ADMIN_ACCESS_TOKEN="$GITLAB_QA_ADMIN_ACCESS_TOKEN" --env GITLAB_QA_PASSWORD_1="$GITLAB_QA_PASSWORD_1" --env GITLAB_QA_PASSWORD_2="$GITLAB_QA_PASSWORD_2" --env RSPEC_FAST_QUARANTINE_PATH="$RSPEC_FAST_QUARANTINE_PATH" --env RSPEC_SKIPPED_TESTS_REPORT_PATH="$RSPEC_SKIPPED_TESTS_REPORT_PATH" --env CI="$CI" --env CI_JOB_NAME="$CI_JOB_NAME" --env CI_JOB_NAME_SLUG="$CI_JOB_NAME_SLUG" --env CI_JOB_URL="$CI_JOB_URL" --env CI_JOB_TOKEN="$CI_JOB_TOKEN" --env CI_RUNNER_ID="$CI_RUNNER_ID" --env CI_SERVER_HOST="$CI_SERVER_HOST" --env CI_NODE_INDEX="$CI_NODE_INDEX" --env CI_NODE_TOTAL="$CI_NODE_TOTAL" --env CI_PROJECT_NAME="$CI_PROJECT_NAME" --env CI_PROJECT_PATH="$CI_PROJECT_PATH" --env CI_PIPELINE_SOURCE="$CI_PIPELINE_SOURCE" --env CI_PIPELINE_URL="$CI_PIPELINE_URL" --env CI_PIPELINE_CREATED_AT="$CI_PIPELINE_CREATED_AT" --env GITLAB_CI="$GITLAB_CI" --env GITLAB_QA_USER_AGENT="$GITLAB_QA_USER_AGENT" --env GITLAB_INITIAL_ROOT_PASSWORD="5iveL!fe" --env COLORIZED_LOGS="$COLORIZED_LOGS" --env RELEASE="$RELEASE" --env RELEASE_REGISTRY_URL="registry.gitlab.com" --env RELEASE_REGISTRY_USERNAME="gitlab-ci-token" --env RELEASE_REGISTRY_PASSWORD="[MASKED]" --env SELENOID_DIRECTORY="/builds/gitlab-org/gitlab/gitlab-qa-run-2023-09-18-02-52-51-0e6275a9/selenoid" --env SCHEDULE_TYPE="$SCHEDULE_TYPE" --volume /builds/gitlab-org/gitlab/gitlab-qa-run-2023-09-18-02-52-51-0e6275a9/gitlab-ce-qa-e624cd95:/home/gitlab/qa/tmp:z --volume /var/run/docker.sock:/var/run/docker.sock:z --volume /builds/gitlab-org/gitlab/qa/rspec:/home/gitlab/qa/rspec:z --volume /builds/gitlab-org/gitlab/qa/knapsack:/home/gitlab/qa/knapsack:z --name gitlab-ce-qa-e624cd95 registry.gitlab.com/gitlab-org/gitlab/gitlab-ce-qa:9421296c4a1e1a7dc4deb406a76aabc8810a3434 Test::Instance::All http://gitlab-ce-408a76fb.test -- --format QA::Support::JsonFormatter --out tmp/rspec-5107563359.json --format RspecJunitFormatter --out tmp/rspec-5107563359.xml --format html --out tmp/rspec-decomposition-multiple-db_1_5.htm --color --format documentation`1022023-09-18 03:00:25 / CONF :: 103 ==> Base URL: http://gitlab-ce-408a76fb.test104 ==> Browser: #<Selenium::WebDriver::Chrome::Driver:0x00007f343ac634a8>105 ==> Libraries: Chemlab::Vendor106[Sep 18 2023 03:00:25 UTC (QA Tests)] INFO -- Caching token for username: root, last six chars of token:sixwPA107[Sep 18 2023 03:00:25 UTC (QA Tests)] INFO -- Browser: chrome108[Sep 18 2023 03:00:25 UTC (QA Tests)] INFO -- Performing sanity check for environment!109[Sep 18 2023 03:00:25 UTC (QA Tests)] INFO -- Downloading latest knapsack report for 'decomposition-multiple-db' to 'knapsack/decomposition-multiple-db.json'110[Sep 18 2023 03:00:25 UTC (QA Tests)] INFO -- Report already exists, skipping!111[Sep 18 2023 03:00:25 UTC (QA Tests)] INFO -- ==== Knapsack specs to execute =====112[Sep 18 2023 03:00:25 UTC (QA Tests)] INFO -- Report specs:113[Sep 18 2023 03:00:25 UTC (QA Tests)] INFO -- ["qa/specs/features/browser_ui/1_manage/login/login_via_oauth_and_oidc_with_gitlab_as_idp_spec.rb", "qa/specs/features/browser_ui/4_verify/pipeline/pipeline_with_image_pull_policy_spec.rb", "qa/specs/features/browser_ui/3_create/repository/protected_tags_spec.rb", "qa/specs/features/browser_ui/3_create/web_ide/upload_new_file_in_web_ide_spec.rb", "qa/specs/features/browser_ui/5_package/package_registry/conan_repository_spec.rb", "qa/specs/features/browser_ui/2_plan/milestone/assign_milestone_spec.rb", "qa/specs/features/browser_ui/1_manage/user/impersonation_token_spec.rb", "qa/specs/features/api/4_verify/api_variable_inheritance_with_forward_pipeline_variables_spec.rb", "qa/specs/features/browser_ui/3_create/snippet/clone_push_pull_project_snippet_spec.rb", "qa/specs/features/browser_ui/4_verify/pipeline/trigger_child_pipeline_with_manual_spec.rb", "qa/specs/features/browser_ui/3_create/snippet/add_comment_to_snippet_spec.rb", "qa/specs/features/browser_ui/4_verify/pipeline/include_multiple_files_from_a_project_spec.rb", "qa/specs/features/browser_ui/3_create/merge_request/create_merge_request_from_push_notification_spec.rb", "qa/specs/features/browser_ui/9_data_stores/user/user_inherited_access_spec.rb", "qa/specs/features/browser_ui/2_plan/project_wiki/project_based_content_manipulation_spec.rb", "qa/specs/features/browser_ui/14_analytics/performance_bar_spec.rb", "qa/specs/features/browser_ui/4_verify/ci_variable/raw_variables_defined_in_yaml_spec.rb", "qa/specs/features/browser_ui/1_manage/user/user_access_termination_spec.rb", "qa/specs/features/browser_ui/2_plan/design_management/archive_design_content_spec.rb", "qa/specs/features/browser_ui/4_verify/pipeline/run_pipeline_via_web_only_spec.rb", "qa/specs/features/browser_ui/3_create/repository/file/delete_file_via_web_spec.rb", "qa/specs/features/browser_ui/2_plan/issue/mentions_spec.rb", "qa/specs/features/browser_ui/2_plan/issue/check_mentions_for_xss_spec.rb", "qa/specs/features/browser_ui/2_plan/issue/collapse_comments_in_discussions_spec.rb", "qa/specs/features/browser_ui/3_create/repository/file/create_file_via_web_spec.rb", "qa/specs/features/browser_ui/3_create/repository/protocol_v2_push_ssh_spec.rb", "qa/specs/features/browser_ui/2_plan/project_wiki/project_based_directory_management_spec.rb", "qa/specs/features/api/3_create/repository/default_branch_name_setting_spec.rb", "qa/specs/features/browser_ui/14_analytics/service_ping_default_enabled_spec.rb", "qa/specs/features/api/3_create/merge_request/push_options_labels_spec.rb", "qa/specs/features/browser_ui/3_create/repository/clone_spec.rb", "qa/specs/features/browser_ui/6_release/deploy_token/add_deploy_token_spec.rb", "qa/specs/features/api/4_verify/cancel_pipeline_when_block_user_spec.rb"]114[Sep 18 2023 03:00:25 UTC (QA Tests)] INFO -- Leftover specs:115[Sep 18 2023 03:00:25 UTC (QA Tests)] INFO -- ["qa/specs/features/api/12_systems/gitaly/automatic_failover_and_recovery_spec.rb", "qa/specs/features/api/12_systems/gitaly/praefect_replication_queue_spec.rb", "qa/specs/features/api/1_manage/migration/gitlab_migration_issue_spec.rb", "qa/specs/features/api/1_manage/migration/gitlab_migration_release_spec.rb", "qa/specs/features/browser_ui/14_analytics/service_ping_disabled_spec.rb", "qa/specs/features/browser_ui/1_manage/integrations/pipeline_status_emails_spec.rb", "qa/specs/features/browser_ui/1_manage/login/oauth_login_with_facebook_spec.rb", "qa/specs/features/browser_ui/2_plan/transient/comment_on_discussion_spec.rb", "qa/specs/features/browser_ui/5_package/container_registry/saas/container_registry_spec.rb", "qa/specs/features/browser_ui/7_configure/auto_devops/auto_devops_templates_spec.rb", "qa/specs/features/sanity/framework_spec.rb"]116[Sep 18 2023 03:00:26 UTC (QA Tests)] INFO -- Knapsack time offset warning enabled!117[Sep 18 2023 03:00:26 UTC (QA Tests)] INFO -- Downloading latest knapsack report for 'decomposition-multiple-db' to 'knapsack/decomposition-multiple-db.json'118[Sep 18 2023 03:00:26 UTC (QA Tests)] INFO -- Report already exists, skipping!119Run options: exclude {:orchestrated=>true, :transient=>true, :sanity_feature_flags=>true, :geo=>true, :requires_praefect=>true}120Randomized with seed 49147121Data Stores122 User123 when added to sub-group124[Sep 18 2023 03:00:29 UTC (QA Tests)] INFO -- Starting test: Data Stores User when added to sub-group is not allowed to edit the parent group project files125[Sep 18 2023 03:00:29 UTC (QA Tests)] INFO -- Retrieved cached token for username: root, last six chars of token:sixwPA126[Sep 18 2023 03:00:29 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::PersonalAccessToken with name 'api-pat-root-l0xdgg1g' via cache in 0.0 seconds127[Sep 18 2023 03:00:31 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 1.58 seconds128[Sep 18 2023 03:00:36 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-2/parent-group-to-test-user-access-74bc6257a0d551f5/parent-group-project-to-test-user-access-0b1ec84334ee97aa' via api in 2.83 seconds129[Sep 18 2023 03:00:37 UTC (QA Tests)] INFO -- Adding user qa-user-c3ea63cd5f71fba9 to gitlab-qa-sandbox-group-2/parent-group-to-test-user-access-74bc6257a0d551f5/sub-group-to-test-user-access-306a548f81b33da5 QA::Resource::Group130[Sep 18 2023 03:00:37 UTC (QA Tests)] INFO -- filling :login_field with "qa-user-c3ea63cd5f71fba9"131[Sep 18 2023 03:00:37 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field132[Sep 18 2023 03:00:38 UTC (QA Tests)] INFO -- filling :password_field with "*****"133[Sep 18 2023 03:00:38 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field134[Sep 18 2023 03:00:38 UTC (QA Tests)] INFO -- clicking :sign_in_button135[Sep 18 2023 03:00:40 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.59s136[Sep 18 2023 03:00:41 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/parent-group-to-test-user-access-74bc6257a0d551f5/parent-group-project-to-test-user-access-0b1ec84334ee97aa137[Sep 18 2023 03:00:44 UTC (QA Tests)] INFO -- clicking :file_name_link138[Sep 18 2023 03:00:44 UTC (QA Tests)] INFO -- clicking :action_dropdown139[Sep 18 2023 03:00:45 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 0.549s140[Sep 18 2023 03:00:45 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element action_dropdown' took 0.639s141[Sep 18 2023 03:00:45 UTC (QA Tests)] INFO -- clicking :edit_menu_item142[Sep 18 2023 03:00:45 UTC (QA Tests)] INFO -- Removed a QA::Resource::User with username 'qa-user-c3ea63cd5f71fba9'143 is not allowed to edit the parent group project files144 when added to parent group145[Sep 18 2023 03:00:45 UTC (QA Tests)] INFO -- Starting test: Data Stores User when added to parent group is allowed to edit the sub-group project files146[Sep 18 2023 03:00:45 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.1 seconds147[Sep 18 2023 03:00:49 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-2/parent-group-to-test-user-access-ca0a318d2e2aed9e/sub-group-to-test-user-access-563de7c477b4c7a1/sub-group-project-to-test-user-access-498a9e004c17461e' via api in 1.57 seconds148[Sep 18 2023 03:00:49 UTC (QA Tests)] INFO -- Adding user qa-user-c444df0c5024902a to gitlab-qa-sandbox-group-2/parent-group-to-test-user-access-ca0a318d2e2aed9e QA::Resource::Group149[Sep 18 2023 03:00:50 UTC (QA Tests)] INFO -- filling :login_field with "qa-user-c444df0c5024902a"150[Sep 18 2023 03:00:50 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field151[Sep 18 2023 03:00:50 UTC (QA Tests)] INFO -- filling :password_field with "*****"152[Sep 18 2023 03:00:50 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field153[Sep 18 2023 03:00:50 UTC (QA Tests)] INFO -- clicking :sign_in_button154[Sep 18 2023 03:00:52 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.058s155[Sep 18 2023 03:00:53 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/parent-group-to-test-user-access-ca0a318d2e2aed9e/sub-group-to-test-user-access-563de7c477b4c7a1/sub-group-project-to-test-user-access-498a9e004c17461e156[Sep 18 2023 03:00:55 UTC (QA Tests)] INFO -- clicking :file_name_link157[Sep 18 2023 03:00:55 UTC (QA Tests)] INFO -- clicking :action_dropdown158[Sep 18 2023 03:00:56 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element action_dropdown' took 0.503s159[Sep 18 2023 03:00:56 UTC (QA Tests)] INFO -- clicking :edit_menu_item160[Sep 18 2023 03:00:57 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element edit_menu_item' took 1.179s161[Sep 18 2023 03:00:57 UTC (QA Tests)] INFO -- Removed a QA::Resource::User with username 'qa-user-c444df0c5024902a'162 is allowed to edit the sub-group project files163Package164 SaaS Container Registry165 pushes project image to the container registry and deletes tag (PENDING: Test is not compatible with this environment or pipeline)166Plan167 Milestones168 Group milestone169 behaves like milestone assigned to existing issue170[Sep 18 2023 03:00:57 UTC (QA Tests)] INFO -- Starting test: Plan Milestones Group milestone behaves like milestone assigned to existing issue is assigned to an existing issue171[Sep 18 2023 03:00:58 UTC (QA Tests)] INFO -- filling :login_field with "root"172[Sep 18 2023 03:00:58 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field173[Sep 18 2023 03:00:58 UTC (QA Tests)] INFO -- filling :password_field with "*****"174[Sep 18 2023 03:00:58 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field175[Sep 18 2023 03:00:59 UTC (QA Tests)] INFO -- clicking :sign_in_button176[Sep 18 2023 03:00:59 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.847s177[Sep 18 2023 03:01:01 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.07 seconds178[Sep 18 2023 03:01:04 UTC (QA Tests)] INFO -- Visiting QA::Resource::Issue at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/group-to-test-milestones-4b48d0a8/project-to-test-milestones-70983ccd-d26329b9c40a3864/-/issues/1179[Sep 18 2023 03:01:07 UTC (QA Tests)] INFO -- clicking :edit-button180[Sep 18 2023 03:01:08 UTC (QA Tests)] INFO -- refreshing http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/group-to-test-milestones-4b48d0a8/project-to-test-milestones-70983ccd-d26329b9c40a3864/-/issues/1181 is assigned to an existing issue182 behaves like milestone assigned to new issue183[Sep 18 2023 03:01:10 UTC (QA Tests)] INFO -- Starting test: Plan Milestones Group milestone behaves like milestone assigned to new issue is assigned to a new issue184[Sep 18 2023 03:01:11 UTC (QA Tests)] INFO -- filling :login_field with "root"185[Sep 18 2023 03:01:11 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field186[Sep 18 2023 03:01:11 UTC (QA Tests)] INFO -- filling :password_field with "*****"187[Sep 18 2023 03:01:11 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field188[Sep 18 2023 03:01:11 UTC (QA Tests)] INFO -- clicking :sign_in_button189[Sep 18 2023 03:01:12 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.754s190[Sep 18 2023 03:01:14 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds191[Sep 18 2023 03:01:16 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/group-to-test-milestones-7b88c748/project-to-test-milestones-7406e462-484f62f453cb1344192[Sep 18 2023 03:01:17 UTC (QA Tests)] INFO -- clicking :new-menu-toggle193[Sep 18 2023 03:01:17 UTC (QA Tests)] INFO -- clicking :create_menu_item194[Sep 18 2023 03:01:18 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element create_menu_item' took 0.911s195[Sep 18 2023 03:01:18 UTC (QA Tests)] INFO -- filling :issuable-form-title-field with "Issue title 0ebcc13e848f1397"196[Sep 18 2023 03:01:18 UTC (QA Tests)] INFO -- clicking the coordinates of :issuable-form-title-field197[Sep 18 2023 03:01:19 UTC (QA Tests)] INFO -- filling :issuable-form-description-field with "Issue description 8b27f06f711eb73c"198[Sep 18 2023 03:01:19 UTC (QA Tests)] INFO -- clicking the coordinates of :issuable-form-description-field199[Sep 18 2023 03:01:20 UTC (QA Tests)] INFO -- clicking :issuable-create-button and ensuring QA::Page::Project::Issue::Show is present200[Sep 18 2023 03:01:22 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element issuable-create-button' took 2.705s201[Sep 18 2023 03:01:22 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Issue via browser_ui in 6.39 seconds202 is assigned to a new issue203 Project milestone204 behaves like milestone assigned to new issue205[Sep 18 2023 03:01:22 UTC (QA Tests)] INFO -- Starting test: Plan Milestones Project milestone behaves like milestone assigned to new issue is assigned to a new issue206[Sep 18 2023 03:01:23 UTC (QA Tests)] INFO -- filling :login_field with "root"207[Sep 18 2023 03:01:23 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field208[Sep 18 2023 03:01:23 UTC (QA Tests)] INFO -- filling :password_field with "*****"209[Sep 18 2023 03:01:23 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field210[Sep 18 2023 03:01:24 UTC (QA Tests)] INFO -- clicking :sign_in_button211[Sep 18 2023 03:01:24 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.762s212[Sep 18 2023 03:01:26 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.07 seconds213[Sep 18 2023 03:01:28 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/group-to-test-milestones-73d0a324/project-to-test-milestones-a104a0de-31c76c0e1ffcfe35214[Sep 18 2023 03:01:28 UTC (QA Tests)] INFO -- clicking :new-menu-toggle215[Sep 18 2023 03:01:28 UTC (QA Tests)] INFO -- clicking :create_menu_item216[Sep 18 2023 03:01:29 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element create_menu_item' took 0.929s217[Sep 18 2023 03:01:29 UTC (QA Tests)] INFO -- filling :issuable-form-title-field with "Issue title e0498c482726450c"218[Sep 18 2023 03:01:29 UTC (QA Tests)] INFO -- clicking the coordinates of :issuable-form-title-field219[Sep 18 2023 03:01:30 UTC (QA Tests)] INFO -- filling :issuable-form-description-field with "Issue description d8514bc452768a81"220[Sep 18 2023 03:01:30 UTC (QA Tests)] INFO -- clicking the coordinates of :issuable-form-description-field221[Sep 18 2023 03:01:31 UTC (QA Tests)] INFO -- clicking :issuable-create-button and ensuring QA::Page::Project::Issue::Show is present222[Sep 18 2023 03:01:33 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element issuable-create-button' took 2.111s223[Sep 18 2023 03:01:33 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Issue via browser_ui in 5.11 seconds224 is assigned to a new issue225 behaves like milestone assigned to existing issue226[Sep 18 2023 03:01:33 UTC (QA Tests)] INFO -- Starting test: Plan Milestones Project milestone behaves like milestone assigned to existing issue is assigned to an existing issue227[Sep 18 2023 03:01:33 UTC (QA Tests)] INFO -- filling :login_field with "root"228[Sep 18 2023 03:01:33 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field229[Sep 18 2023 03:01:34 UTC (QA Tests)] INFO -- filling :password_field with "*****"230[Sep 18 2023 03:01:34 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field231[Sep 18 2023 03:01:34 UTC (QA Tests)] INFO -- clicking :sign_in_button232[Sep 18 2023 03:01:35 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.794s233[Sep 18 2023 03:01:37 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds234[Sep 18 2023 03:01:38 UTC (QA Tests)] INFO -- Visiting QA::Resource::Issue at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/group-to-test-milestones-195bb4f6/project-to-test-milestones-4ecd1666-362834da6bcdbddf/-/issues/1235[Sep 18 2023 03:01:40 UTC (QA Tests)] INFO -- clicking :edit-button236[Sep 18 2023 03:01:41 UTC (QA Tests)] INFO -- refreshing http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/group-to-test-milestones-195bb4f6/project-to-test-milestones-4ecd1666-362834da6bcdbddf/-/issues/1237 is assigned to an existing issue238Verify239 Pipeline API defined variable inheritance240[Sep 18 2023 03:01:43 UTC (QA Tests)] INFO -- Starting test: Verify Pipeline API defined variable inheritance is determined based on forward:pipeline_variables condition241[Sep 18 2023 03:01:43 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds242[Sep 18 2023 03:01:43 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::GroupRunner.243[Sep 18 2023 03:01:43 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`244[Sep 18 2023 03:01:47 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`245[Sep 18 2023 03:01:47 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name egeip8m7 --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach egeip8m7 sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name egeip8m7 --url http://gitlab-ce-408a76fb.test --registration-token **** --tag-list egeip8m7 --executor shell && gitlab-runner run" `246[Sep 18 2023 03:01:49 UTC (QA Tests)] INFO -- Executing: `docker logs egeip8m7`247[Sep 18 2023 03:01:49 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`248[Sep 18 2023 03:01:51 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::GroupRunner with name 'egeip8m7' via api in 7.33 seconds249[Sep 18 2023 03:01:51 UTC (QA Tests)] INFO -- filling :login_field with "root"250[Sep 18 2023 03:01:51 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field251[Sep 18 2023 03:01:51 UTC (QA Tests)] INFO -- filling :password_field with "*****"252[Sep 18 2023 03:01:51 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field253[Sep 18 2023 03:01:52 UTC (QA Tests)] INFO -- clicking :sign_in_button254[Sep 18 2023 03:01:53 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.7s255[Sep 18 2023 03:01:56 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.79 seconds256[Sep 18 2023 03:01:57 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.82 seconds257[Sep 18 2023 03:02:14 UTC (QA Tests)] INFO -- Removed a QA::Resource::GroupRunner with name 'egeip8m7'258[Sep 18 2023 03:02:14 UTC (QA Tests)] INFO -- Executing: `docker rm -f egeip8m7`259 is determined based on forward:pipeline_variables condition260Create261 Default branch name instance setting262[Sep 18 2023 03:02:14 UTC (QA Tests)] INFO -- Setting application settings: {:default_branch_name=>"main"}263[Sep 18 2023 03:02:14 UTC (QA Tests)] INFO -- Starting test: Create Default branch name instance setting sets the default branch name for a new project264[Sep 18 2023 03:02:14 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds265[Sep 18 2023 03:02:15 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.43 seconds266 sets the default branch name for a new project267[Sep 18 2023 03:02:17 UTC (QA Tests)] INFO -- Starting test: Create Default branch name instance setting allows a project to be created via the CLI with a different default branch name268[Sep 18 2023 03:02:17 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.06 seconds269[Sep 18 2023 03:02:18 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/default-branch-name-via-cli-82c6b1a7db04524a' via api in 0.22 seconds270 allows a project to be created via the CLI with a different default branch name271[Sep 18 2023 03:02:19 UTC (QA Tests)] INFO -- Setting application settings: {:default_branch_name=>nil}272Manage273 Impersonation tokens274[Sep 18 2023 03:02:19 UTC (QA Tests)] INFO -- Starting test: Manage Impersonation tokens can be created and revoked via the UI275[Sep 18 2023 03:02:30 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? user_avatar_content' took 11.035s276[Sep 18 2023 03:02:31 UTC (QA Tests)] INFO -- filling :login_field with "root"277[Sep 18 2023 03:02:31 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field278[Sep 18 2023 03:02:31 UTC (QA Tests)] INFO -- filling :password_field with "*****"279[Sep 18 2023 03:02:31 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field280[Sep 18 2023 03:02:32 UTC (QA Tests)] INFO -- clicking :sign_in_button281[Sep 18 2023 03:02:32 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.813s282[Sep 18 2023 03:02:34 UTC (QA Tests)] INFO -- clicking :super-sidebar-search-button283[Sep 18 2023 03:02:34 UTC (QA Tests)] INFO -- clicking :places-item-link284[Sep 18 2023 03:02:35 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element places-item-link' took 0.587s285[Sep 18 2023 03:02:36 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_text? Enter admin mode' took 1.124s286[Sep 18 2023 03:02:36 UTC (QA Tests)] INFO -- clicking :nav_item_link287[Sep 18 2023 03:02:37 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.631s288[Sep 18 2023 03:02:39 UTC (QA Tests)] INFO -- clicking :impersonation-tokens-tab289[Sep 18 2023 03:02:40 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element impersonation-tokens-tab' took 0.581s290[Sep 18 2023 03:02:40 UTC (QA Tests)] INFO -- clicking :add-new-token-button291[Sep 18 2023 03:02:40 UTC (QA Tests)] INFO -- filling :access_token_name_field with "*****"292[Sep 18 2023 03:02:40 UTC (QA Tests)] INFO -- clicking the coordinates of :access_token_name_field293[Sep 18 2023 03:02:40 UTC (QA Tests)] INFO -- clicking :api_label294[Sep 18 2023 03:02:40 UTC (QA Tests)] INFO -- filling :expiry_date_field with "2023-09-20"295[Sep 18 2023 03:02:40 UTC (QA Tests)] INFO -- clicking the coordinates of :expiry_date_field296[Sep 18 2023 03:02:41 UTC (QA Tests)] INFO -- clicking :create_token_button297[Sep 18 2023 03:02:41 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::ImpersonationToken with name 'api-impersonation-access-token-avmzu3uf' via browser_ui in 21.5 seconds298[Sep 18 2023 03:02:42 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? user_profile_link' took 1.041s299[Sep 18 2023 03:02:42 UTC (QA Tests)] INFO -- clicking :user_avatar_content300[Sep 18 2023 03:02:42 UTC (QA Tests)] INFO -- clicking :user_avatar_content301[Sep 18 2023 03:02:43 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? global-search-input' took 1.019s302[Sep 18 2023 03:02:45 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? user_profile_link' took 1.064s303[Sep 18 2023 03:02:45 UTC (QA Tests)] INFO -- clicking :user_avatar_content304[Sep 18 2023 03:02:45 UTC (QA Tests)] INFO -- clicking :sign_out_link305[Sep 18 2023 03:02:45 UTC (QA Tests)] INFO -- filling :login_field with "root"306[Sep 18 2023 03:02:45 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field307[Sep 18 2023 03:02:45 UTC (QA Tests)] INFO -- filling :password_field with "*****"308[Sep 18 2023 03:02:45 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field309[Sep 18 2023 03:02:46 UTC (QA Tests)] INFO -- clicking :sign_in_button310[Sep 18 2023 03:02:47 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.786s311[Sep 18 2023 03:02:48 UTC (QA Tests)] INFO -- clicking :super-sidebar-search-button312[Sep 18 2023 03:02:49 UTC (QA Tests)] INFO -- clicking :places-item-link313[Sep 18 2023 03:02:49 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element places-item-link' took 0.545s314[Sep 18 2023 03:02:50 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_text? Enter admin mode' took 1.123s315[Sep 18 2023 03:02:50 UTC (QA Tests)] INFO -- clicking :nav_item_link316[Sep 18 2023 03:02:51 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.603s317[Sep 18 2023 03:02:53 UTC (QA Tests)] INFO -- clicking :impersonation-tokens-tab318[Sep 18 2023 03:02:54 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element impersonation-tokens-tab' took 0.677s319[Sep 18 2023 03:02:54 UTC (QA Tests)] INFO -- clicking :revoke_button320[Sep 18 2023 03:02:54 UTC (QA Tests)] INFO -- clicking :confirm-ok-button321 can be created and revoked via the UI322Create323 Upload a file in Web IDE324 when the file is an image325 behaves like upload a file326[Sep 18 2023 03:02:55 UTC (QA Tests)] INFO -- Starting test: Create Upload a file in Web IDE when the file is an image behaves like upload a file verifies it successfully uploads and commits to a MR327[Sep 18 2023 03:02:56 UTC (QA Tests)] INFO -- filling :login_field with "root"328[Sep 18 2023 03:02:56 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field329[Sep 18 2023 03:02:56 UTC (QA Tests)] INFO -- filling :password_field with "*****"330[Sep 18 2023 03:02:56 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field331[Sep 18 2023 03:02:56 UTC (QA Tests)] INFO -- clicking :sign_in_button332[Sep 18 2023 03:02:57 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.823s333[Sep 18 2023 03:02:59 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds334[Sep 18 2023 03:02:59 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.11 seconds335[Sep 18 2023 03:03:01 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/upload-file-project-56eec4934346d566336[Sep 18 2023 03:03:02 UTC (QA Tests)] INFO -- clicking :action_dropdown337[Sep 18 2023 03:03:02 UTC (QA Tests)] INFO -- clicking :webide_menu_item338[Sep 18 2023 03:03:08 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? broadcast_notification_container' took 6.124s339 verifies it successfully uploads and commits to a MR340 when the file is a text file341 behaves like upload a file342[Sep 18 2023 03:03:12 UTC (QA Tests)] INFO -- Starting test: Create Upload a file in Web IDE when the file is a text file behaves like upload a file verifies it successfully uploads and commits to a MR343[Sep 18 2023 03:03:13 UTC (QA Tests)] INFO -- filling :login_field with "root"344[Sep 18 2023 03:03:13 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field345[Sep 18 2023 03:03:13 UTC (QA Tests)] INFO -- filling :password_field with "*****"346[Sep 18 2023 03:03:13 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field347[Sep 18 2023 03:03:14 UTC (QA Tests)] INFO -- clicking :sign_in_button348[Sep 18 2023 03:03:14 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.835s349[Sep 18 2023 03:03:16 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.06 seconds350[Sep 18 2023 03:03:16 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.11 seconds351[Sep 18 2023 03:03:17 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/upload-file-project-33fbe2a9d8197d15352[Sep 18 2023 03:03:19 UTC (QA Tests)] INFO -- clicking :action_dropdown353[Sep 18 2023 03:03:19 UTC (QA Tests)] INFO -- clicking :webide_menu_item354[Sep 18 2023 03:03:25 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? broadcast_notification_container' took 6.192s355 verifies it successfully uploads and commits to a MR356 when a file with the same name already exists357[Sep 18 2023 03:03:39 UTC (QA Tests)] INFO -- Starting test: Create Upload a file in Web IDE when a file with the same name already exists throws an error358[Sep 18 2023 03:03:40 UTC (QA Tests)] INFO -- filling :login_field with "root"359[Sep 18 2023 03:03:40 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field360[Sep 18 2023 03:03:40 UTC (QA Tests)] INFO -- filling :password_field with "*****"361[Sep 18 2023 03:03:40 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field362[Sep 18 2023 03:03:41 UTC (QA Tests)] INFO -- clicking :sign_in_button363[Sep 18 2023 03:03:41 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.819s364[Sep 18 2023 03:03:43 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds365[Sep 18 2023 03:03:43 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.1 seconds366[Sep 18 2023 03:03:44 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/upload-file-project-2ff5115334d713c0367[Sep 18 2023 03:03:46 UTC (QA Tests)] INFO -- clicking :action_dropdown368[Sep 18 2023 03:03:46 UTC (QA Tests)] INFO -- clicking :webide_menu_item369[Sep 18 2023 03:03:52 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? broadcast_notification_container' took 6.047s370 throws an error371Package372 Conan Repository373[Sep 18 2023 03:03:53 UTC (QA Tests)] INFO -- Starting test: Package Conan Repository publishes, installs, and deletes a Conan package374[Sep 18 2023 03:03:53 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds375[Sep 18 2023 03:03:53 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.1 seconds376[Sep 18 2023 03:03:54 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.377[Sep 18 2023 03:03:54 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`378[Sep 18 2023 03:03:54 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`379[Sep 18 2023 03:03:54 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`380[Sep 18 2023 03:03:54 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-1695006233 -v /var/run/docker.sock:/var/run/docker.sock --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-1695006233 sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-1695006233 --url http://gitlab-ce-408a76fb.test --registration-token **** --tag-list runner-for-conan-package-project-554ef4bbede93fda --executor docker --docker-image registry.gitlab.com/ gitlab-org/gitlab-build-images:gitlab-qa-alpine-ruby-2.7 --docker-tlsverify=false --docker-privileged=true --docker-network-mode=test --docker-volumes=/certs/client && gitlab-runner run" `381[Sep 18 2023 03:03:54 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-1695006233`382[Sep 18 2023 03:03:54 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`383[Sep 18 2023 03:03:55 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-1695006233' via api in 1.86 seconds384[Sep 18 2023 03:03:56 UTC (QA Tests)] INFO -- filling :login_field with "root"385[Sep 18 2023 03:03:56 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field386[Sep 18 2023 03:03:56 UTC (QA Tests)] INFO -- filling :password_field with "*****"387[Sep 18 2023 03:03:56 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field388[Sep 18 2023 03:03:57 UTC (QA Tests)] INFO -- clicking :sign_in_button389[Sep 18 2023 03:03:58 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.848s390[Sep 18 2023 03:04:00 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.81 seconds391[Sep 18 2023 03:04:00 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/conan-package-project-554ef4bbede93fda392[Sep 18 2023 03:04:02 UTC (QA Tests)] INFO -- clicking :menu_section_button393[Sep 18 2023 03:04:03 UTC (QA Tests)] INFO -- clicking :nav_item_link394[Sep 18 2023 03:04:03 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.688s395[Sep 18 2023 03:04:04 UTC (QA Tests)] INFO -- clicking :job_link and ensuring QA::Page::Project::Job::Show is present396[Sep 18 2023 03:04:06 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element job_link' took 1.199s397[Sep 18 2023 03:04:37 UTC (QA Tests)] INFO -- clicking :menu_section_button398[Sep 18 2023 03:04:37 UTC (QA Tests)] INFO -- clicking :nav_item_link399[Sep 18 2023 03:04:37 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.643s400[Sep 18 2023 03:04:37 UTC (QA Tests)] INFO -- clicking :details-link401[Sep 18 2023 03:04:38 UTC (QA Tests)] INFO -- clicking :delete-package402[Sep 18 2023 03:04:39 UTC (QA Tests)] INFO -- clicking :delete-modal-button403[Sep 18 2023 03:04:40 UTC (QA Tests)] INFO -- Removed a QA::Resource::ProjectRunner with name 'qa-runner-1695006233'404[Sep 18 2023 03:04:40 UTC (QA Tests)] INFO -- Executing: `docker rm -f qa-runner-1695006233`405 publishes, installs, and deletes a Conan package406Create407 Create a new merge request from the event notification after a push408[Sep 18 2023 03:04:41 UTC (QA Tests)] INFO -- Starting test: Create Create a new merge request from the event notification after a push creates a merge request after a push via the git CLI409[Sep 18 2023 03:04:41 UTC (QA Tests)] INFO -- filling :login_field with "root"410[Sep 18 2023 03:04:41 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field411[Sep 18 2023 03:04:41 UTC (QA Tests)] INFO -- filling :password_field with "*****"412[Sep 18 2023 03:04:41 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field413[Sep 18 2023 03:04:42 UTC (QA Tests)] INFO -- clicking :sign_in_button414[Sep 18 2023 03:04:43 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.89s415[Sep 18 2023 03:04:45 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds416[Sep 18 2023 03:04:45 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.1 seconds417[Sep 18 2023 03:04:47 UTC (QA Tests)] INFO -- QA::Resource::Project - wait_for_push with commit message "This is a test commit"418[Sep 18 2023 03:04:47 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::ProjectPush via browser_ui in 1.1 seconds419[Sep 18 2023 03:04:47 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/the_awesome_project-9c14bc3a7a196735420[Sep 18 2023 03:04:48 UTC (QA Tests)] INFO -- clicking :create_merge_request_button421[Sep 18 2023 03:04:49 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element create_merge_request_button' took 0.989s422[Sep 18 2023 03:04:49 UTC (QA Tests)] INFO -- filling :issuable-form-title-field with "Merge from push event notification test 07e1b3160732831b"423[Sep 18 2023 03:04:49 UTC (QA Tests)] INFO -- clicking the coordinates of :issuable-form-title-field424[Sep 18 2023 03:04:49 UTC (QA Tests)] INFO -- clicking :issuable-create-button and ensuring QA::Page::MergeRequest::Show is present425[Sep 18 2023 03:04:52 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element issuable-create-button' took 2.844s426 creates a merge request after a push via the git CLI427[Sep 18 2023 03:04:52 UTC (QA Tests)] INFO -- Starting test: Create Create a new merge request from the event notification after a push creates a merge request after a push via the API428[Sep 18 2023 03:04:53 UTC (QA Tests)] INFO -- filling :login_field with "root"429[Sep 18 2023 03:04:53 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field430[Sep 18 2023 03:04:53 UTC (QA Tests)] INFO -- filling :password_field with "*****"431[Sep 18 2023 03:04:53 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field432[Sep 18 2023 03:04:54 UTC (QA Tests)] INFO -- clicking :sign_in_button433[Sep 18 2023 03:04:55 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.902s434[Sep 18 2023 03:04:57 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds435[Sep 18 2023 03:04:57 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.11 seconds436[Sep 18 2023 03:04:58 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.61 seconds437[Sep 18 2023 03:04:58 UTC (QA Tests)] INFO -- QA::Resource::Project - wait_for_push with commit message "QA Test - Commit message"438[Sep 18 2023 03:04:58 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/the_awesome_project-650b23977ab02b51439[Sep 18 2023 03:05:00 UTC (QA Tests)] INFO -- clicking :create_merge_request_button440[Sep 18 2023 03:05:00 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element create_merge_request_button' took 0.835s441[Sep 18 2023 03:05:00 UTC (QA Tests)] INFO -- filling :issuable-form-title-field with "Merge from push event notification test 72427969bdae1cef"442[Sep 18 2023 03:05:00 UTC (QA Tests)] INFO -- clicking the coordinates of :issuable-form-title-field443[Sep 18 2023 03:05:01 UTC (QA Tests)] INFO -- clicking :issuable-create-button and ensuring QA::Page::MergeRequest::Show is present444[Sep 18 2023 03:05:03 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element issuable-create-button' took 2.284s445 creates a merge request after a push via the API446Plan447 mention448[Sep 18 2023 03:05:03 UTC (QA Tests)] INFO -- Starting test: Plan mention mentions another user in an issue449[Sep 18 2023 03:05:04 UTC (QA Tests)] INFO -- filling :login_field with "root"450[Sep 18 2023 03:05:04 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field451[Sep 18 2023 03:05:04 UTC (QA Tests)] INFO -- filling :password_field with "*****"452[Sep 18 2023 03:05:04 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field453[Sep 18 2023 03:05:05 UTC (QA Tests)] INFO -- clicking :sign_in_button454[Sep 18 2023 03:05:06 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.002s455[Sep 18 2023 03:05:08 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds456[Sep 18 2023 03:05:08 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.11 seconds457[Sep 18 2023 03:05:08 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/the_awesome_project-1f9bc6ec86bd8353' via api in 0.69 seconds458[Sep 18 2023 03:05:08 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/the_awesome_project-1f9bc6ec86bd8353459[Sep 18 2023 03:05:09 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::User with username 'gitlab-qa-user1' via api in 0.29 seconds460[Sep 18 2023 03:05:09 UTC (QA Tests)] INFO -- Adding user gitlab-qa-user1 to gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/the_awesome_project-1f9bc6ec86bd8353 QA::Resource::Project461[Sep 18 2023 03:05:10 UTC (QA Tests)] INFO -- Visiting QA::Resource::Issue at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/the_awesome_project-1f9bc6ec86bd8353/-/issues/1462[Sep 18 2023 03:05:11 UTC (QA Tests)] INFO -- clicking :issue-title463[Sep 18 2023 03:05:11 UTC (QA Tests)] INFO -- clicking :discussion_preferences_dropdown464[Sep 18 2023 03:05:12 UTC (QA Tests)] INFO -- clicking :close-button465[Sep 18 2023 03:05:12 UTC (QA Tests)] INFO -- clicking :issue-title466[Sep 18 2023 03:05:12 UTC (QA Tests)] INFO -- clicking :discussion_preferences_dropdown467[Sep 18 2023 03:05:12 UTC (QA Tests)] INFO -- filling :comment_field with "@gitlab-qa-user1468"469[Sep 18 2023 03:05:12 UTC (QA Tests)] INFO -- clicking the coordinates of :comment_field470[Sep 18 2023 03:05:13 UTC (QA Tests)] INFO -- clicking :comment_button471 mentions another user in an issue472Create473 Adding comments on snippets474 behaves like comments on snippets475[Sep 18 2023 03:05:13 UTC (QA Tests)] INFO -- Starting test: Create Adding comments on snippets behaves like comments on snippets adds, edits, and deletes a comment on a project_snippet476[Sep 18 2023 03:05:14 UTC (QA Tests)] INFO -- filling :login_field with "root"477[Sep 18 2023 03:05:14 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field478[Sep 18 2023 03:05:14 UTC (QA Tests)] INFO -- filling :password_field with "*****"479[Sep 18 2023 03:05:14 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field480[Sep 18 2023 03:05:14 UTC (QA Tests)] INFO -- clicking :sign_in_button481[Sep 18 2023 03:05:15 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.899s482[Sep 18 2023 03:05:17 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds483[Sep 18 2023 03:05:17 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.11 seconds484[Sep 18 2023 03:05:18 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-with-snippets-d8ce96cfcc4f3889' via api in 0.74 seconds485[Sep 18 2023 03:05:18 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::ProjectSnippet with id '1' via api in 1.13 seconds486[Sep 18 2023 03:05:19 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? global-search-input' took 1.029s487[Sep 18 2023 03:05:21 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? user_profile_link' took 1.056s488[Sep 18 2023 03:05:21 UTC (QA Tests)] INFO -- clicking :user_avatar_content489[Sep 18 2023 03:05:21 UTC (QA Tests)] INFO -- clicking :sign_out_link490[Sep 18 2023 03:05:21 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::User with username 'gitlab-qa-user1' via api in 0.13 seconds491[Sep 18 2023 03:05:22 UTC (QA Tests)] INFO -- filling :login_field with "gitlab-qa-user1"492[Sep 18 2023 03:05:22 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field493[Sep 18 2023 03:05:22 UTC (QA Tests)] INFO -- filling :password_field with "*****"494[Sep 18 2023 03:05:22 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field495[Sep 18 2023 03:05:22 UTC (QA Tests)] INFO -- clicking :sign_in_button496[Sep 18 2023 03:05:23 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.621s497[Sep 18 2023 03:05:25 UTC (QA Tests)] INFO -- Visiting QA::Resource::ProjectSnippet at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-with-snippets-d8ce96cfcc4f3889/-/snippets/1498[Sep 18 2023 03:05:25 UTC (QA Tests)] INFO -- filling :note_field with "Comment 123"499[Sep 18 2023 03:05:25 UTC (QA Tests)] INFO -- clicking the coordinates of :note_field500[Sep 18 2023 03:05:26 UTC (QA Tests)] INFO -- clicking :comment_button501[Sep 18 2023 03:05:27 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 0.552s502[Sep 18 2023 03:05:27 UTC (QA Tests)] INFO -- clicking :edit_comment_button503[Sep 18 2023 03:05:27 UTC (QA Tests)] INFO -- filling :edit_note_field with "Nice snippet!"504[Sep 18 2023 03:05:27 UTC (QA Tests)] INFO -- clicking the coordinates of :edit_note_field505[Sep 18 2023 03:05:27 UTC (QA Tests)] INFO -- clicking :save_comment_button506[Sep 18 2023 03:05:28 UTC (QA Tests)] INFO -- clicking :more_actions_dropdown507[Sep 18 2023 03:05:28 UTC (QA Tests)] INFO -- clicking :delete_comment_button508[Sep 18 2023 03:05:28 UTC (QA Tests)] INFO -- clicking :confirm-ok-button509 adds, edits, and deletes a comment on a project_snippet510 behaves like comments on snippets511[Sep 18 2023 03:05:28 UTC (QA Tests)] INFO -- Starting test: Create Adding comments on snippets behaves like comments on snippets adds, edits, and deletes a comment on a personal_snippet512[Sep 18 2023 03:05:29 UTC (QA Tests)] INFO -- filling :login_field with "root"513[Sep 18 2023 03:05:29 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field514[Sep 18 2023 03:05:29 UTC (QA Tests)] INFO -- filling :password_field with "*****"515[Sep 18 2023 03:05:29 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field516[Sep 18 2023 03:05:30 UTC (QA Tests)] INFO -- clicking :sign_in_button517[Sep 18 2023 03:05:30 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.887s518[Sep 18 2023 03:05:33 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Snippet with id '2' via api in 0.32 seconds519[Sep 18 2023 03:05:34 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? global-search-input' took 1.031s520[Sep 18 2023 03:05:35 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? user_profile_link' took 1.042s521[Sep 18 2023 03:05:35 UTC (QA Tests)] INFO -- clicking :user_avatar_content522[Sep 18 2023 03:05:35 UTC (QA Tests)] INFO -- clicking :sign_out_link523[Sep 18 2023 03:05:36 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::User with username 'gitlab-qa-user1' via api in 0.13 seconds524[Sep 18 2023 03:05:36 UTC (QA Tests)] INFO -- filling :login_field with "gitlab-qa-user1"525[Sep 18 2023 03:05:36 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field526[Sep 18 2023 03:05:36 UTC (QA Tests)] INFO -- filling :password_field with "*****"527[Sep 18 2023 03:05:36 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field528[Sep 18 2023 03:05:37 UTC (QA Tests)] INFO -- clicking :sign_in_button529[Sep 18 2023 03:05:38 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.921s530[Sep 18 2023 03:05:39 UTC (QA Tests)] INFO -- Visiting QA::Resource::Snippet at http://gitlab-ce-408a76fb.test/-/snippets/2531[Sep 18 2023 03:05:40 UTC (QA Tests)] INFO -- filling :note_field with "Comment 123"532[Sep 18 2023 03:05:40 UTC (QA Tests)] INFO -- clicking the coordinates of :note_field533[Sep 18 2023 03:05:40 UTC (QA Tests)] INFO -- clicking :comment_button534[Sep 18 2023 03:05:41 UTC (QA Tests)] INFO -- clicking :edit_comment_button535[Sep 18 2023 03:05:41 UTC (QA Tests)] INFO -- filling :edit_note_field with "Nice snippet!"536[Sep 18 2023 03:05:41 UTC (QA Tests)] INFO -- clicking the coordinates of :edit_note_field537[Sep 18 2023 03:05:41 UTC (QA Tests)] INFO -- clicking :save_comment_button538[Sep 18 2023 03:05:42 UTC (QA Tests)] INFO -- clicking :more_actions_dropdown539[Sep 18 2023 03:05:42 UTC (QA Tests)] INFO -- clicking :delete_comment_button540[Sep 18 2023 03:05:42 UTC (QA Tests)] INFO -- clicking :confirm-ok-button541 adds, edits, and deletes a comment on a personal_snippet542Verify543 When user is blocked544[Sep 18 2023 03:05:42 UTC (QA Tests)] INFO -- Starting test: Verify When user is blocked pipeline schedule is canceled545[Sep 18 2023 03:05:43 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.06 seconds546[Sep 18 2023 03:05:43 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.11 seconds547[Sep 18 2023 03:05:43 UTC (QA Tests)] INFO -- Adding user qa-user-2a12a56f24cccbbf to gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-canceled-schedule-c057c7e115db98d8 QA::Resource::Project548[Sep 18 2023 03:05:43 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.06 seconds549[Sep 18 2023 03:05:43 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.12 seconds550[Sep 18 2023 03:05:44 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-with-pipeline-schedule-3e87e5b7bb23551a' via api in 0.76 seconds551[Sep 18 2023 03:05:44 UTC (QA Tests)] INFO -- No cached token found for username: qa-user-2a12a56f24cccbbf552[Sep 18 2023 03:05:44 UTC (QA Tests)] INFO -- Caching token for username: qa-user-2a12a56f24cccbbf, last six chars of token:MfmAAs553[Sep 18 2023 03:05:44 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::PersonalAccessToken with name 'api-pat-qa-user-2a12a56f24cccbbf-3a4cpjpb' via api in 0.06 seconds554[Sep 18 2023 03:05:45 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::PipelineSchedules with id '1' via api in 0.38 seconds555[Sep 18 2023 03:05:45 UTC (QA Tests)] INFO -- Removed a QA::Resource::User with username 'qa-user-2a12a56f24cccbbf'556[Sep 18 2023 03:05:45 UTC (QA Tests)] INFO -- Removed a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-canceled-schedule-c057c7e115db98d8'557 pipeline schedule is canceled558Plan559 A project wiki560[Sep 18 2023 03:05:45 UTC (QA Tests)] INFO -- Starting test: Plan A project wiki can change the directory path of a page561[Sep 18 2023 03:05:46 UTC (QA Tests)] INFO -- filling :login_field with "root"562[Sep 18 2023 03:05:46 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field563[Sep 18 2023 03:05:46 UTC (QA Tests)] INFO -- filling :password_field with "*****"564[Sep 18 2023 03:05:46 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field565[Sep 18 2023 03:05:46 UTC (QA Tests)] INFO -- clicking :sign_in_button566[Sep 18 2023 03:05:47 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.944s567[Sep 18 2023 03:05:49 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds568[Sep 18 2023 03:05:50 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.1 seconds569[Sep 18 2023 03:05:50 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/wiki_testing-e1247967a165a887' via api in 0.7 seconds570[Sep 18 2023 03:05:51 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Wiki::ProjectPage via api in 1.31 seconds571[Sep 18 2023 03:05:51 UTC (QA Tests)] INFO -- Visiting QA::Resource::Wiki::ProjectPage at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/wiki_testing-e1247967a165a887/-/wikis/Home572[Sep 18 2023 03:05:51 UTC (QA Tests)] INFO -- clicking :edit_page_button573[Sep 18 2023 03:05:52 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element edit_page_button' took 0.781s574[Sep 18 2023 03:05:52 UTC (QA Tests)] INFO -- filling :wiki_title_textbox with "a/new/path-with-spaces/home"575[Sep 18 2023 03:05:52 UTC (QA Tests)] INFO -- clicking the coordinates of :wiki_title_textbox576[Sep 18 2023 03:05:53 UTC (QA Tests)] INFO -- filling :wiki_message_textbox with "changing the path of the home page"577[Sep 18 2023 03:05:53 UTC (QA Tests)] INFO -- clicking the coordinates of :wiki_message_textbox578[Sep 18 2023 03:05:54 UTC (QA Tests)] INFO -- clicking :wiki_submit_button579[Sep 18 2023 03:05:55 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element wiki_submit_button' took 1.163s580 can change the directory path of a page581Analytics582 Performance bar display583 when logged in as an admin user584[Sep 18 2023 03:05:55 UTC (QA Tests)] INFO -- Starting test: Analytics Performance bar display when logged in as an admin user shows results for the original request and AJAX requests585[Sep 18 2023 03:05:56 UTC (QA Tests)] INFO -- filling :login_field with "root"586[Sep 18 2023 03:05:56 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field587[Sep 18 2023 03:05:56 UTC (QA Tests)] INFO -- filling :password_field with "*****"588[Sep 18 2023 03:05:56 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field589[Sep 18 2023 03:05:56 UTC (QA Tests)] INFO -- clicking :sign_in_button590[Sep 18 2023 03:05:57 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.013s591[Sep 18 2023 03:05:59 UTC (QA Tests)] INFO -- clicking :super-sidebar-search-button592[Sep 18 2023 03:05:59 UTC (QA Tests)] INFO -- clicking :places-item-link593[Sep 18 2023 03:06:00 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element places-item-link' took 0.565s594[Sep 18 2023 03:06:01 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_text? Enter admin mode' took 1.261s595[Sep 18 2023 03:06:01 UTC (QA Tests)] INFO -- clicking :menu_section_button596[Sep 18 2023 03:06:01 UTC (QA Tests)] INFO -- clicking :nav_item_link597[Sep 18 2023 03:06:02 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.518s598[Sep 18 2023 03:06:03 UTC (QA Tests)] INFO -- checking via JS :enable_performance_bar_checkbox with args {}599[Sep 18 2023 03:06:03 UTC (QA Tests)] INFO -- clicking :save_changes_button600[Sep 18 2023 03:06:04 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element save_changes_button' took 1.007s601[Sep 18 2023 03:06:04 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds602[Sep 18 2023 03:06:04 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.11 seconds603[Sep 18 2023 03:06:05 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-issues-20964f565a70326e' via api in 0.83 seconds604[Sep 18 2023 03:06:05 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-issues-20964f565a70326e605[Sep 18 2023 03:06:06 UTC (QA Tests)] INFO -- clicking :new-menu-toggle606[Sep 18 2023 03:06:06 UTC (QA Tests)] INFO -- clicking :create_menu_item607[Sep 18 2023 03:06:07 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element create_menu_item' took 0.951s608[Sep 18 2023 03:06:07 UTC (QA Tests)] INFO -- filling :issuable-form-title-field with "Performance bar test"609[Sep 18 2023 03:06:07 UTC (QA Tests)] INFO -- clicking the coordinates of :issuable-form-title-field610[Sep 18 2023 03:06:08 UTC (QA Tests)] INFO -- filling :issuable-form-description-field with "Issue description 92fca52548f2dbb9"611[Sep 18 2023 03:06:08 UTC (QA Tests)] INFO -- clicking the coordinates of :issuable-form-description-field612[Sep 18 2023 03:06:08 UTC (QA Tests)] INFO -- clicking :issuable-create-button and ensuring QA::Page::Project::Issue::Show is present613[Sep 18 2023 03:06:11 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element issuable-create-button' took 2.865s614[Sep 18 2023 03:06:11 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Issue via browser_ui in 6.78 seconds615[Sep 18 2023 03:06:11 UTC (QA Tests)] INFO -- clicking :request_dropdown616[Sep 18 2023 03:06:12 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? request_dropdown_option' took 0.674s617 shows results for the original request and AJAX requests618Manage619 OAuth620 behaves like Instance OAuth Application621[Sep 18 2023 03:06:12 UTC (QA Tests)] INFO -- Starting test: Manage OAuth behaves like Instance OAuth Application creates oauth application and uses it to login622[Sep 18 2023 03:06:13 UTC (QA Tests)] INFO -- filling :login_field with "root"623[Sep 18 2023 03:06:13 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field624[Sep 18 2023 03:06:13 UTC (QA Tests)] INFO -- filling :password_field with "*****"625[Sep 18 2023 03:06:13 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field626[Sep 18 2023 03:06:13 UTC (QA Tests)] INFO -- clicking :sign_in_button627[Sep 18 2023 03:06:14 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.968s628[Sep 18 2023 03:06:16 UTC (QA Tests)] INFO -- clicking :super-sidebar-search-button629[Sep 18 2023 03:06:16 UTC (QA Tests)] INFO -- clicking :places-item-link630[Sep 18 2023 03:06:17 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element places-item-link' took 0.518s631[Sep 18 2023 03:06:18 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_text? Enter admin mode' took 1.253s632[Sep 18 2023 03:06:18 UTC (QA Tests)] INFO -- clicking :nav_item_link633[Sep 18 2023 03:06:19 UTC (QA Tests)] INFO -- clicking :new_application_button634[Sep 18 2023 03:06:19 UTC (QA Tests)] INFO -- filling :name_field with "Instance OAuth Application 2611035ff054b0b0"635[Sep 18 2023 03:06:19 UTC (QA Tests)] INFO -- clicking the coordinates of :name_field636[Sep 18 2023 03:06:19 UTC (QA Tests)] INFO -- filling :redirect_uri_field with "http://gitlab-oauth-consumer.test/users/auth/gitlab/callback"637[Sep 18 2023 03:06:19 UTC (QA Tests)] INFO -- clicking the coordinates of :redirect_uri_field638[Sep 18 2023 03:06:20 UTC (QA Tests)] INFO -- checking via JS :trusted_checkbox with args {}639[Sep 18 2023 03:06:20 UTC (QA Tests)] INFO -- clicking :read_user_label640[Sep 18 2023 03:06:20 UTC (QA Tests)] INFO -- clicking :save_application_button641[Sep 18 2023 03:06:21 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::InstanceOauthApplication with name 'Instance OAuth Application 2611035ff054b0b0' via browser_ui in 8.31 seconds642[Sep 18 2023 03:06:22 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? global-search-input' took 1.016s643[Sep 18 2023 03:06:23 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? user_profile_link' took 1.052s644[Sep 18 2023 03:06:23 UTC (QA Tests)] INFO -- clicking :user_avatar_content645[Sep 18 2023 03:06:23 UTC (QA Tests)] INFO -- clicking :sign_out_link646[Sep 18 2023 03:06:23 UTC (QA Tests)] INFO -- Executing: `docker login --username "gitlab-ci-token" --password "****" registry.gitlab.com`647[Sep 18 2023 03:06:23 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/build/omnibus-gitlab-mirror/gitlab-ce:9421296c4a1e1a7dc4deb406a76aabc8810a3434`648[Sep 18 2023 03:06:24 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`649[Sep 18 2023 03:06:24 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`650[Sep 18 2023 03:06:24 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --hostname gitlab-oauth-consumer.test --publish 80:80 --env GITLAB_OMNIBUS_CONFIG="gitlab_rails['initial_root_password']='5iveL!fe'; gitlab_rails['omniauth_enabled'] = true; gitlab_rails['omniauth_allow_single_sign_on'] = true; gitlab_rails['omniauth_block_auto_created_users'] = false; gitlab_rails['omniauth_providers'] = [ { name: 'gitlab', label: 'GitLab OAuth', app_id: '9d69405573ae90c559f273d8034a6497a473c47a533982bbf11c644ecf23fba5', app_secret: 'gloas-2d54e78385e1115c001397e469205677ef1341867d860b5ed9d184f1726eb870', args: { scope: 'read_user', client_options: { site: 'http://gitlab-ce-408a76fb.test' } } } ]; " --name gitlab-oauth-consumer registry.gitlab.com/gitlab-org/build/omnibus-gitlab-mirror/gitlab-ce:9421296c4a1e1a7dc4deb406a76aabc8810a3434 `651[Sep 18 2023 03:06:24 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`652[Sep 18 2023 03:06:29 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`653[Sep 18 2023 03:06:34 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`654[Sep 18 2023 03:06:39 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`655[Sep 18 2023 03:06:44 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`656[Sep 18 2023 03:06:49 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`657[Sep 18 2023 03:06:54 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`658[Sep 18 2023 03:06:59 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`659[Sep 18 2023 03:07:04 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`660[Sep 18 2023 03:07:09 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`661[Sep 18 2023 03:07:14 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`662[Sep 18 2023 03:07:19 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`663[Sep 18 2023 03:07:24 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`664[Sep 18 2023 03:07:29 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`665[Sep 18 2023 03:07:35 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`666[Sep 18 2023 03:07:40 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`667[Sep 18 2023 03:07:45 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`668[Sep 18 2023 03:07:50 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`669[Sep 18 2023 03:07:55 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`670[Sep 18 2023 03:08:00 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`671[Sep 18 2023 03:08:05 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`672[Sep 18 2023 03:08:10 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`673[Sep 18 2023 03:08:15 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`674[Sep 18 2023 03:08:20 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`675[Sep 18 2023 03:08:25 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`676[Sep 18 2023 03:08:30 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`677[Sep 18 2023 03:08:35 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`678[Sep 18 2023 03:08:40 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`679[Sep 18 2023 03:08:45 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`680[Sep 18 2023 03:08:50 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`681[Sep 18 2023 03:08:55 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`682[Sep 18 2023 03:09:00 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`683[Sep 18 2023 03:09:05 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`684[Sep 18 2023 03:09:10 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`685[Sep 18 2023 03:09:15 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`686[Sep 18 2023 03:09:20 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`687[Sep 18 2023 03:09:25 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oauth-consumer`688[Sep 18 2023 03:09:36 UTC (QA Tests)] INFO -- clicking :gitlab_oauth_login_button689[Sep 18 2023 03:09:37 UTC (QA Tests)] INFO -- filling :login_field with "qa-user-c0319d8f1a41dae8"690[Sep 18 2023 03:09:37 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field691[Sep 18 2023 03:09:37 UTC (QA Tests)] INFO -- filling :password_field with "*****"692[Sep 18 2023 03:09:37 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field693[Sep 18 2023 03:09:37 UTC (QA Tests)] INFO -- clicking :sign_in_button694[Sep 18 2023 03:09:39 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 2.073s695[Sep 18 2023 03:09:40 UTC (QA Tests)] INFO -- selecting "Other" in :role_dropdown696[Sep 18 2023 03:09:40 UTC (QA Tests)] INFO -- clicking :get_started_button697[Sep 18 2023 03:09:41 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element get_started_button' took 1.413s698[Sep 18 2023 03:09:42 UTC (QA Tests)] INFO -- Removed a QA::Resource::InstanceOauthApplication with name 'Instance OAuth Application 2611035ff054b0b0'699[Sep 18 2023 03:09:42 UTC (QA Tests)] INFO -- Executing: `docker rm -f gitlab-oauth-consumer`700 creates oauth application and uses it to login701 OIDC702 behaves like Instance OAuth Application703[Sep 18 2023 03:09:44 UTC (QA Tests)] INFO -- Starting test: Manage OIDC behaves like Instance OAuth Application creates oidc application and uses it to login704[Sep 18 2023 03:09:44 UTC (QA Tests)] INFO -- filling :login_field with "root"705[Sep 18 2023 03:09:44 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field706[Sep 18 2023 03:09:45 UTC (QA Tests)] INFO -- filling :password_field with "*****"707[Sep 18 2023 03:09:45 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field708[Sep 18 2023 03:09:45 UTC (QA Tests)] INFO -- clicking :sign_in_button709[Sep 18 2023 03:09:46 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.104s710[Sep 18 2023 03:09:48 UTC (QA Tests)] INFO -- clicking :super-sidebar-search-button711[Sep 18 2023 03:09:48 UTC (QA Tests)] INFO -- clicking :places-item-link712[Sep 18 2023 03:09:50 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_text? Enter admin mode' took 1.124s713[Sep 18 2023 03:09:50 UTC (QA Tests)] INFO -- clicking :nav_item_link714[Sep 18 2023 03:09:50 UTC (QA Tests)] INFO -- clicking :new_application_button715[Sep 18 2023 03:09:51 UTC (QA Tests)] INFO -- filling :name_field with "Instance OAuth Application c2bda31a03332241"716[Sep 18 2023 03:09:51 UTC (QA Tests)] INFO -- clicking the coordinates of :name_field717[Sep 18 2023 03:09:51 UTC (QA Tests)] INFO -- filling :redirect_uri_field with "http://gitlab-oidc-consumer.test/users/auth/openid_connect/callback"718[Sep 18 2023 03:09:51 UTC (QA Tests)] INFO -- clicking the coordinates of :redirect_uri_field719[Sep 18 2023 03:09:52 UTC (QA Tests)] INFO -- checking via JS :trusted_checkbox with args {}720[Sep 18 2023 03:09:52 UTC (QA Tests)] INFO -- clicking :openid_label721[Sep 18 2023 03:09:52 UTC (QA Tests)] INFO -- clicking :profile_label722[Sep 18 2023 03:09:52 UTC (QA Tests)] INFO -- clicking :email_label723[Sep 18 2023 03:09:52 UTC (QA Tests)] INFO -- clicking :save_application_button724[Sep 18 2023 03:09:52 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::InstanceOauthApplication with name 'Instance OAuth Application c2bda31a03332241' via browser_ui in 8.64 seconds725[Sep 18 2023 03:09:54 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? global-search-input' took 1.02s726[Sep 18 2023 03:09:55 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? user_profile_link' took 1.027s727[Sep 18 2023 03:09:55 UTC (QA Tests)] INFO -- clicking :user_avatar_content728[Sep 18 2023 03:09:55 UTC (QA Tests)] INFO -- clicking :sign_out_link729[Sep 18 2023 03:09:55 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/build/omnibus-gitlab-mirror/gitlab-ce:9421296c4a1e1a7dc4deb406a76aabc8810a3434`730[Sep 18 2023 03:09:59 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`731[Sep 18 2023 03:10:00 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`732[Sep 18 2023 03:10:00 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --hostname gitlab-oidc-consumer.test --publish 80:80 --env GITLAB_OMNIBUS_CONFIG="gitlab_rails['initial_root_password']='5iveL!fe'; gitlab_rails['omniauth_enabled'] = true; gitlab_rails['omniauth_allow_single_sign_on'] = true; gitlab_rails['omniauth_block_auto_created_users'] = false; gitlab_rails['omniauth_providers'] = [ { name: 'openid_connect', label: 'GitLab OIDC', args: { name: 'openid_connect', scope: ['openid','profile','email'], response_type: 'code', issuer: 'http://gitlab-ce-408a76fb.test', discovery: false, uid_field: 'preferred_username', send_scope_to_token_endpoint: 'false', client_options: { identifier: 'd073b9983fa1a12fef1947efcdedd75203c8854763220db6fbe5d652b7fb8349', secret: 'gloas-acee6d5d30a796a979616b72df97dc73ac2b81a575720153f4e571d4842925b0', redirect_uri: 'http://gitlab-oidc-consumer.test/users/auth/openid_connect/callback', jwks_uri: 'http://gitlab-ce-408a76fb.test/oauth/discovery/keys', userinfo_endpoint: 'http://gitlab-ce-408a76fb.test/oauth/userinfo', token_endpoint: 'http://gitlab-ce-408a76fb.test/oauth/token', authorization_endpoint: 'http://gitlab-ce-408a76fb.test/oauth/authorize' } } } ]; " --name gitlab-oidc-consumer registry.gitlab.com/gitlab-org/build/omnibus-gitlab-mirror/gitlab-ce:9421296c4a1e1a7dc4deb406a76aabc8810a3434 `733[Sep 18 2023 03:10:00 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`734[Sep 18 2023 03:10:05 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`735[Sep 18 2023 03:10:10 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`736[Sep 18 2023 03:10:15 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`737[Sep 18 2023 03:10:20 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`738[Sep 18 2023 03:10:25 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`739[Sep 18 2023 03:10:30 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`740[Sep 18 2023 03:10:35 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`741[Sep 18 2023 03:10:40 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`742[Sep 18 2023 03:10:45 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`743[Sep 18 2023 03:10:50 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`744[Sep 18 2023 03:10:55 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`745[Sep 18 2023 03:11:00 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`746[Sep 18 2023 03:11:05 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`747[Sep 18 2023 03:11:10 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`748[Sep 18 2023 03:11:15 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`749[Sep 18 2023 03:11:20 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`750[Sep 18 2023 03:11:25 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`751[Sep 18 2023 03:11:30 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`752[Sep 18 2023 03:11:35 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`753[Sep 18 2023 03:11:40 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`754[Sep 18 2023 03:11:45 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`755[Sep 18 2023 03:11:50 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`756[Sep 18 2023 03:11:56 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`757[Sep 18 2023 03:12:01 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`758[Sep 18 2023 03:12:06 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`759[Sep 18 2023 03:12:11 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`760[Sep 18 2023 03:12:16 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`761[Sep 18 2023 03:12:21 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`762[Sep 18 2023 03:12:26 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`763[Sep 18 2023 03:12:31 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`764[Sep 18 2023 03:12:36 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`765[Sep 18 2023 03:12:41 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`766[Sep 18 2023 03:12:46 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`767[Sep 18 2023 03:12:51 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`768[Sep 18 2023 03:12:56 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`769[Sep 18 2023 03:13:01 UTC (QA Tests)] INFO -- Executing: `docker inspect --format='{{json .State.Health.Status}}' gitlab-oidc-consumer`770[Sep 18 2023 03:13:12 UTC (QA Tests)] INFO -- clicking :oidc_login_button771[Sep 18 2023 03:13:12 UTC (QA Tests)] INFO -- filling :login_field with "qa-user-ea613b91d98f013f"772[Sep 18 2023 03:13:12 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field773[Sep 18 2023 03:13:13 UTC (QA Tests)] INFO -- filling :password_field with "*****"774[Sep 18 2023 03:13:13 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field775[Sep 18 2023 03:13:13 UTC (QA Tests)] INFO -- clicking :sign_in_button776[Sep 18 2023 03:13:15 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 2.173s777[Sep 18 2023 03:13:15 UTC (QA Tests)] INFO -- selecting "Other" in :role_dropdown778[Sep 18 2023 03:13:16 UTC (QA Tests)] INFO -- clicking :get_started_button779[Sep 18 2023 03:13:17 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element get_started_button' took 1.751s780[Sep 18 2023 03:13:19 UTC (QA Tests)] INFO -- Removed a QA::Resource::InstanceOauthApplication with name 'Instance OAuth Application c2bda31a03332241'781[Sep 18 2023 03:13:19 UTC (QA Tests)] INFO -- Executing: `docker rm -f gitlab-oidc-consumer`782 creates oidc application and uses it to login783Verify784 Trigger child pipeline with 'when:manual'785[Sep 18 2023 03:13:20 UTC (QA Tests)] INFO -- Starting test: Verify Trigger child pipeline with 'when:manual' can trigger bridge job786[Sep 18 2023 03:13:20 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds787[Sep 18 2023 03:13:20 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.11 seconds788[Sep 18 2023 03:13:20 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.789[Sep 18 2023 03:13:20 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`790[Sep 18 2023 03:13:25 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`791[Sep 18 2023 03:13:25 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-onry43qr --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-onry43qr sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-onry43qr --url http://gitlab-ce-408a76fb.test --registration-token **** --tag-list qa-runner-onry43qr --executor shell && gitlab-runner run" `792[Sep 18 2023 03:13:25 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-onry43qr`793[Sep 18 2023 03:13:25 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`794[Sep 18 2023 03:13:26 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-onry43qr' via api in 5.82 seconds795[Sep 18 2023 03:13:27 UTC (QA Tests)] INFO -- filling :login_field with "root"796[Sep 18 2023 03:13:27 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field797[Sep 18 2023 03:13:27 UTC (QA Tests)] INFO -- filling :password_field with "*****"798[Sep 18 2023 03:13:27 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field799[Sep 18 2023 03:13:28 UTC (QA Tests)] INFO -- clicking :sign_in_button800[Sep 18 2023 03:13:28 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.984s801[Sep 18 2023 03:13:31 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.73 seconds802[Sep 18 2023 03:13:31 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-with-pipeline-daa6f6f04efcd597803[Sep 18 2023 03:13:32 UTC (QA Tests)] INFO -- clicking :menu_section_button804[Sep 18 2023 03:13:33 UTC (QA Tests)] INFO -- clicking :nav_item_link805[Sep 18 2023 03:13:33 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.691s806[Sep 18 2023 03:13:45 UTC (QA Tests)] INFO -- clicking :job_action_button807[Sep 18 2023 03:13:55 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? linked_pipeline_container' took 9.824s808[Sep 18 2023 03:13:55 UTC (QA Tests)] INFO -- clicking :expand_linked_pipeline_button809[Sep 18 2023 03:13:56 UTC (QA Tests)] INFO -- Removed a QA::Resource::ProjectRunner with name 'qa-runner-onry43qr'810[Sep 18 2023 03:13:56 UTC (QA Tests)] INFO -- Executing: `docker rm -f qa-runner-onry43qr`811 can trigger bridge job812Create813 Push over SSH using Git protocol version 2814[Sep 18 2023 03:13:56 UTC (QA Tests)] INFO -- filling :login_field with "root"815[Sep 18 2023 03:13:56 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field816[Sep 18 2023 03:13:57 UTC (QA Tests)] INFO -- filling :password_field with "*****"817[Sep 18 2023 03:13:57 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field818[Sep 18 2023 03:13:57 UTC (QA Tests)] INFO -- clicking :sign_in_button819[Sep 18 2023 03:13:58 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.976s820[Sep 18 2023 03:14:00 UTC (QA Tests)] INFO -- Executing: `ssh-keygen -t rsa -b 4096 -f /tmp/d20230918-39-txblf4/id_rsa -N `821[Sep 18 2023 03:14:00 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::SSHKey with id '1' via api in 0.28 seconds822[Sep 18 2023 03:14:00 UTC (QA Tests)] INFO -- Starting test: Create Push over SSH using Git protocol version 2 user pushes to the repository823[Sep 18 2023 03:14:00 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds824[Sep 18 2023 03:14:00 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.11 seconds825[Sep 18 2023 03:14:03 UTC (QA Tests)] INFO -- QA::Resource::Project - wait_for_push_new_branch with branch_name "main"826[Sep 18 2023 03:14:04 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/git-protocol-project-5cc5bb1dd24d5322827[Sep 18 2023 03:14:05 UTC (QA Tests)] INFO -- Removed a QA::Resource::SSHKey with id '1'828 user pushes to the repository829Plan830 Design Management831[Sep 18 2023 03:14:05 UTC (QA Tests)] INFO -- Starting test: Plan Design Management user archives a design832[Sep 18 2023 03:14:06 UTC (QA Tests)] INFO -- filling :login_field with "root"833[Sep 18 2023 03:14:06 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field834[Sep 18 2023 03:14:06 UTC (QA Tests)] INFO -- filling :password_field with "*****"835[Sep 18 2023 03:14:06 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field836[Sep 18 2023 03:14:06 UTC (QA Tests)] INFO -- clicking :sign_in_button837[Sep 18 2023 03:14:07 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.994s838[Sep 18 2023 03:14:09 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds839[Sep 18 2023 03:14:10 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.1 seconds840[Sep 18 2023 03:14:10 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-issues-06ae932e273e9243' via api in 0.72 seconds841[Sep 18 2023 03:14:11 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Issue with id '7' via api in 1.22 seconds842[Sep 18 2023 03:14:11 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Design with full_path 'designs/issue-1/banana_sample.gif' via api in 1.74 seconds843[Sep 18 2023 03:14:12 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Design with full_path 'designs/issue-1/values.png' via api in 0.51 seconds844[Sep 18 2023 03:14:12 UTC (QA Tests)] INFO -- Visiting QA::Resource::Issue at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-issues-06ae932e273e9243/-/issues/1845[Sep 18 2023 03:14:14 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 0.675s846[Sep 18 2023 03:14:14 UTC (QA Tests)] WARN -- Potentially Slow Code 'find_element design_image' took 0.692s847[Sep 18 2023 03:14:14 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Design via browser_ui in 2.71 seconds848[Sep 18 2023 03:14:14 UTC (QA Tests)] INFO -- Visiting QA::Resource::Issue at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-issues-06ae932e273e9243/-/issues/1849[Sep 18 2023 03:14:16 UTC (QA Tests)] INFO -- clicking :design_checkbox850[Sep 18 2023 03:14:16 UTC (QA Tests)] INFO -- clicking :archive_button851[Sep 18 2023 03:14:17 UTC (QA Tests)] INFO -- clicking :confirm_archiving_button852[Sep 18 2023 03:14:17 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 0.615s853[Sep 18 2023 03:14:17 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_no_element? design_file_name' took 0.657s854[Sep 18 2023 03:14:17 UTC (QA Tests)] INFO -- clicking :design_checkbox855[Sep 18 2023 03:14:18 UTC (QA Tests)] INFO -- clicking :design_checkbox856[Sep 18 2023 03:14:18 UTC (QA Tests)] INFO -- clicking :archive_button857[Sep 18 2023 03:14:18 UTC (QA Tests)] INFO -- clicking :confirm_archiving_button858 user archives a design859Analytics860 Service ping default enabled861 when using default enabled from gitlab.yml config862[Sep 18 2023 03:14:19 UTC (QA Tests)] INFO -- Starting test: Analytics Service ping default enabled when using default enabled from gitlab.yml config has service ping toggle enabled863[Sep 18 2023 03:14:19 UTC (QA Tests)] INFO -- filling :login_field with "root"864[Sep 18 2023 03:14:19 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field865[Sep 18 2023 03:14:19 UTC (QA Tests)] INFO -- filling :password_field with "*****"866[Sep 18 2023 03:14:19 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field867[Sep 18 2023 03:14:20 UTC (QA Tests)] INFO -- clicking :sign_in_button868[Sep 18 2023 03:14:21 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.07s869[Sep 18 2023 03:14:23 UTC (QA Tests)] INFO -- clicking :super-sidebar-search-button870[Sep 18 2023 03:14:23 UTC (QA Tests)] INFO -- clicking :places-item-link871[Sep 18 2023 03:14:23 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element places-item-link' took 0.619s872[Sep 18 2023 03:14:25 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_text? Enter admin mode' took 1.125s873[Sep 18 2023 03:14:25 UTC (QA Tests)] INFO -- clicking :menu_section_button874[Sep 18 2023 03:14:25 UTC (QA Tests)] INFO -- clicking :nav_item_link875 has service ping toggle enabled876Verify877 Pipeline with raw variables in YAML878[Sep 18 2023 03:14:27 UTC (QA Tests)] INFO -- Starting test: Verify Pipeline with raw variables in YAML expands variables according to expand: true/false879[Sep 18 2023 03:14:27 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds880[Sep 18 2023 03:14:27 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.11 seconds881[Sep 18 2023 03:14:27 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.882[Sep 18 2023 03:14:27 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`883[Sep 18 2023 03:14:28 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`884[Sep 18 2023 03:14:28 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-1695006867 --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-1695006867 sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-1695006867 --url http://gitlab-ce-408a76fb.test --registration-token **** --tag-list qa-runner-1695006867 --executor shell && gitlab-runner run" `885[Sep 18 2023 03:14:28 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-1695006867`886[Sep 18 2023 03:14:28 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`887[Sep 18 2023 03:14:29 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-1695006867' via api in 2.04 seconds888[Sep 18 2023 03:14:30 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.71 seconds889[Sep 18 2023 03:14:31 UTC (QA Tests)] INFO -- filling :login_field with "root"890[Sep 18 2023 03:14:31 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field891[Sep 18 2023 03:14:31 UTC (QA Tests)] INFO -- filling :password_field with "*****"892[Sep 18 2023 03:14:31 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field893[Sep 18 2023 03:14:31 UTC (QA Tests)] INFO -- clicking :sign_in_button894[Sep 18 2023 03:14:32 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.118s895[Sep 18 2023 03:14:34 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-with-raw-variable-pipeline-2f284cbbc8de0f7b896[Sep 18 2023 03:14:36 UTC (QA Tests)] INFO -- clicking :menu_section_button897[Sep 18 2023 03:14:36 UTC (QA Tests)] INFO -- clicking :nav_item_link898[Sep 18 2023 03:14:36 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.694s899[Sep 18 2023 03:14:37 UTC (QA Tests)] INFO -- clicking :job_link and ensuring QA::Page::Project::Job::Show is present900[Sep 18 2023 03:14:39 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element job_link' took 1.186s901[Sep 18 2023 03:14:40 UTC (QA Tests)] INFO -- Removed a QA::Resource::ProjectRunner with name 'qa-runner-1695006867'902[Sep 18 2023 03:14:40 UTC (QA Tests)] INFO -- Executing: `docker rm -f qa-runner-1695006867`903 expands variables according to expand: true/false904Configure905 AutoDevOps Templates906 using express template907 works with Auto DevOps (PENDING: Test is not compatible with this environment or pipeline)908Verify909 Run pipeline910 with web only rule911[Sep 18 2023 03:14:40 UTC (QA Tests)] INFO -- Starting test: Verify Run pipeline with web only rule can trigger pipeline912[Sep 18 2023 03:14:40 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds913[Sep 18 2023 03:14:40 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.1 seconds914[Sep 18 2023 03:14:42 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.75 seconds915[Sep 18 2023 03:14:42 UTC (QA Tests)] INFO -- filling :login_field with "root"916[Sep 18 2023 03:14:42 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field917[Sep 18 2023 03:14:43 UTC (QA Tests)] INFO -- filling :password_field with "*****"918[Sep 18 2023 03:14:43 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field919[Sep 18 2023 03:14:43 UTC (QA Tests)] INFO -- clicking :sign_in_button920[Sep 18 2023 03:14:44 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.998s921[Sep 18 2023 03:14:46 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/web-only-pipeline-2dc36751df64ca68922[Sep 18 2023 03:14:47 UTC (QA Tests)] INFO -- clicking :menu_section_button923[Sep 18 2023 03:14:47 UTC (QA Tests)] INFO -- clicking :nav_item_link924[Sep 18 2023 03:14:48 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.617s925[Sep 18 2023 03:14:48 UTC (QA Tests)] INFO -- clicking :run_pipeline_button and ensuring QA::Page::Project::Pipeline::New is present926[Sep 18 2023 03:14:49 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element run_pipeline_button' took 0.823s927[Sep 18 2023 03:14:49 UTC (QA Tests)] INFO -- clicking :run_pipeline_button and ensuring QA::Page::Project::Pipeline::Show is present928[Sep 18 2023 03:14:50 UTC (QA Tests)] WARN -- Potentially Slow Code 'finished_loading? ' took 1.01s929[Sep 18 2023 03:14:51 UTC (QA Tests)] WARN -- Potentially Slow Code 'finished_loading? ' took 0.716s930[Sep 18 2023 03:14:51 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 1.837s931[Sep 18 2023 03:14:52 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? pipeline_details_header' took 0.922s932[Sep 18 2023 03:14:52 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element run_pipeline_button' took 3.117s933 can trigger pipeline934Create935 File management936[Sep 18 2023 03:14:52 UTC (QA Tests)] INFO -- Starting test: Create File management user creates a file via the Web937[Sep 18 2023 03:14:53 UTC (QA Tests)] INFO -- filling :login_field with "root"938[Sep 18 2023 03:14:53 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field939[Sep 18 2023 03:14:53 UTC (QA Tests)] INFO -- filling :password_field with "*****"940[Sep 18 2023 03:14:53 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field941[Sep 18 2023 03:14:53 UTC (QA Tests)] INFO -- clicking :sign_in_button942[Sep 18 2023 03:14:54 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.998s943[Sep 18 2023 03:14:56 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds944[Sep 18 2023 03:14:56 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.11 seconds945[Sep 18 2023 03:14:57 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-with-new-file-3e254d35a3faa086' via api in 1.03 seconds946[Sep 18 2023 03:14:57 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-with-new-file-3e254d35a3faa086947[Sep 18 2023 03:14:59 UTC (QA Tests)] INFO -- clicking :add_to_tree_dropdown948[Sep 18 2023 03:14:59 UTC (QA Tests)] INFO -- clicking :new_file_menu_item949[Sep 18 2023 03:15:00 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element new_file_menu_item' took 1.071s950[Sep 18 2023 03:15:00 UTC (QA Tests)] INFO -- filling :file_name_field with "QA Test - File name"951[Sep 18 2023 03:15:00 UTC (QA Tests)] INFO -- clicking the coordinates of :file_name_field952[Sep 18 2023 03:15:00 UTC (QA Tests)] INFO -- filling :commit_message_field with "QA Test - Create new file"953[Sep 18 2023 03:15:00 UTC (QA Tests)] INFO -- clicking the coordinates of :commit_message_field954[Sep 18 2023 03:15:01 UTC (QA Tests)] INFO -- clicking :commit_button955[Sep 18 2023 03:15:02 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element commit_button' took 1.157s956[Sep 18 2023 03:15:02 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::File with name 'QA Test - File name' via browser_ui in 4.7 seconds957[Sep 18 2023 03:15:02 UTC (QA Tests)] ERROR -- Interceptor Api Errors958[200] POST http://gitlab-ce-408a76fb.test/api/graphql -- Correlation Id: 01HAK4HHNJ0FRX182166Q38QQJ959error-messages: Variable $refType of type RefType was provided invalid value960 user creates a file via the Web961Release962 Deploy token creation963[Sep 18 2023 03:15:02 UTC (QA Tests)] INFO -- Starting test: Release Deploy token creation user adds a deploy token964[Sep 18 2023 03:15:03 UTC (QA Tests)] INFO -- filling :login_field with "root"965[Sep 18 2023 03:15:03 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field966[Sep 18 2023 03:15:03 UTC (QA Tests)] INFO -- filling :password_field with "*****"967[Sep 18 2023 03:15:03 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field968[Sep 18 2023 03:15:04 UTC (QA Tests)] INFO -- clicking :sign_in_button969[Sep 18 2023 03:15:05 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.01s970[Sep 18 2023 03:15:07 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds971[Sep 18 2023 03:15:07 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.1 seconds972[Sep 18 2023 03:15:07 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-to-deploy-8229e3872bc72475' via api in 0.72 seconds973[Sep 18 2023 03:15:07 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::ProjectDeployToken with username 'gitlab+deploy-token-1' via api in 0.81 seconds974 user adds a deploy token975Verify976 Pipeline with image:pull_policy977 when policy is not allowed978[Sep 18 2023 03:15:07 UTC (QA Tests)] INFO -- Starting test: Verify Pipeline with image:pull_policy when policy is not allowed fails job with policy not allowed message979[Sep 18 2023 03:15:07 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds980[Sep 18 2023 03:15:07 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.11 seconds981[Sep 18 2023 03:15:08 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.982[Sep 18 2023 03:15:08 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`983[Sep 18 2023 03:15:08 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`984[Sep 18 2023 03:15:08 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`985[Sep 18 2023 03:15:08 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-cjymdeau -v /var/run/docker.sock:/var/run/docker.sock --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-cjymdeau sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-cjymdeau --url http://gitlab-ce-408a76fb.test --registration-token **** --tag-list qa-runner-cjymdeau --executor docker --docker-image registry.gitlab.com/ gitlab-org/gitlab-build-images:gitlab-qa-alpine-ruby-2.7 --docker-tlsverify=false --docker-privileged=true --docker-network-mode=test --docker-volumes=/certs/client && gitlab-runner run" `986[Sep 18 2023 03:15:09 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-cjymdeau`987[Sep 18 2023 03:15:09 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`988[Sep 18 2023 03:15:10 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-cjymdeau' via api in 2.02 seconds989[Sep 18 2023 03:15:10 UTC (QA Tests)] INFO -- Updating runner config to allow pull policies...990[Sep 18 2023 03:15:10 UTC (QA Tests)] INFO -- Executing: `docker cp qa-runner-cjymdeau:/etc/gitlab-runner/config.toml /tmp/config.toml20230918-39-cbj9py`991[Sep 18 2023 03:15:10 UTC (QA Tests)] INFO -- Executing: `docker cp /tmp/config.toml20230918-39-cbj9py qa-runner-cjymdeau:/etc/gitlab-runner/config.toml`992[Sep 18 2023 03:15:10 UTC (QA Tests)] INFO -- Restarting runner container qa-runner-cjymdeau...993[Sep 18 2023 03:15:10 UTC (QA Tests)] INFO -- Executing: `docker restart qa-runner-cjymdeau`994[Sep 18 2023 03:15:10 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-cjymdeau`995[Sep 18 2023 03:15:11 UTC (QA Tests)] INFO -- Waiting for runner to come online...996[Sep 18 2023 03:15:11 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.68 seconds997[Sep 18 2023 03:15:12 UTC (QA Tests)] INFO -- filling :login_field with "root"998[Sep 18 2023 03:15:12 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field999[Sep 18 2023 03:15:12 UTC (QA Tests)] INFO -- filling :password_field with "*****"1000[Sep 18 2023 03:15:12 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1001[Sep 18 2023 03:15:13 UTC (QA Tests)] INFO -- clicking :sign_in_button1002[Sep 18 2023 03:15:14 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.012s1003[Sep 18 2023 03:15:16 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/pipeline-with-image-pull-policy-866f0b3652527aeb1004[Sep 18 2023 03:15:17 UTC (QA Tests)] INFO -- clicking :menu_section_button1005[Sep 18 2023 03:15:17 UTC (QA Tests)] INFO -- clicking :nav_item_link1006[Sep 18 2023 03:15:18 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.701s1007[Sep 18 2023 03:15:31 UTC (QA Tests)] INFO -- clicking :job_link and ensuring QA::Page::Project::Job::Show is present1008[Sep 18 2023 03:15:32 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element job_link' took 1.076s1009[Sep 18 2023 03:15:33 UTC (QA Tests)] INFO -- Removed a QA::Resource::ProjectRunner with name 'gitlab-runner'1010[Sep 18 2023 03:15:33 UTC (QA Tests)] INFO -- Executing: `docker rm -f qa-runner-cjymdeau`1011 fails job with policy not allowed message1012 when policy is allowed1013 with [if-not-present] policy1014[Sep 18 2023 03:15:33 UTC (QA Tests)] INFO -- Starting test: Verify Pipeline with image:pull_policy when policy is allowed with [if-not-present] policy applies pull policy in job correctly1015[Sep 18 2023 03:15:33 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds1016[Sep 18 2023 03:15:33 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.11 seconds1017[Sep 18 2023 03:15:34 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.1018[Sep 18 2023 03:15:34 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`1019[Sep 18 2023 03:15:34 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1020[Sep 18 2023 03:15:34 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1021[Sep 18 2023 03:15:34 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-r250z4h9 -v /var/run/docker.sock:/var/run/docker.sock --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-r250z4h9 sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-r250z4h9 --url http://gitlab-ce-408a76fb.test --registration-token **** --tag-list qa-runner-r250z4h9 --executor docker --docker-image registry.gitlab.com/ gitlab-org/gitlab-build-images:gitlab-qa-alpine-ruby-2.7 --docker-tlsverify=false --docker-privileged=true --docker-network-mode=test --docker-volumes=/certs/client && gitlab-runner run" `1022[Sep 18 2023 03:15:34 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-r250z4h9`1023[Sep 18 2023 03:15:34 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1024[Sep 18 2023 03:15:35 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-r250z4h9' via api in 1.78 seconds1025[Sep 18 2023 03:15:35 UTC (QA Tests)] INFO -- Updating runner config to allow pull policies...1026[Sep 18 2023 03:15:35 UTC (QA Tests)] INFO -- Executing: `docker cp qa-runner-r250z4h9:/etc/gitlab-runner/config.toml /tmp/config.toml20230918-39-6if3hk`1027[Sep 18 2023 03:15:35 UTC (QA Tests)] INFO -- Executing: `docker cp /tmp/config.toml20230918-39-6if3hk qa-runner-r250z4h9:/etc/gitlab-runner/config.toml`1028[Sep 18 2023 03:15:36 UTC (QA Tests)] INFO -- Restarting runner container qa-runner-r250z4h9...1029[Sep 18 2023 03:15:36 UTC (QA Tests)] INFO -- Executing: `docker restart qa-runner-r250z4h9`1030[Sep 18 2023 03:15:36 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-r250z4h9`1031[Sep 18 2023 03:15:36 UTC (QA Tests)] INFO -- Waiting for runner to come online...1032[Sep 18 2023 03:15:37 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.77 seconds1033[Sep 18 2023 03:15:37 UTC (QA Tests)] INFO -- filling :login_field with "root"1034[Sep 18 2023 03:15:37 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1035[Sep 18 2023 03:15:38 UTC (QA Tests)] INFO -- filling :password_field with "*****"1036[Sep 18 2023 03:15:38 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1037[Sep 18 2023 03:15:38 UTC (QA Tests)] INFO -- clicking :sign_in_button1038[Sep 18 2023 03:15:39 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.019s1039[Sep 18 2023 03:15:41 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/pipeline-with-image-pull-policy-2607599c783050d81040[Sep 18 2023 03:15:43 UTC (QA Tests)] INFO -- clicking :menu_section_button1041[Sep 18 2023 03:15:43 UTC (QA Tests)] INFO -- clicking :nav_item_link1042[Sep 18 2023 03:15:44 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.867s1043[Sep 18 2023 03:16:07 UTC (QA Tests)] INFO -- clicking :job_link and ensuring QA::Page::Project::Job::Show is present1044[Sep 18 2023 03:16:08 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element job_link' took 0.88s1045[Sep 18 2023 03:16:08 UTC (QA Tests)] INFO -- Removed a QA::Resource::ProjectRunner with name 'gitlab-runner'1046[Sep 18 2023 03:16:08 UTC (QA Tests)] INFO -- Executing: `docker rm -f qa-runner-r250z4h9`1047[Sep 18 2023 03:16:08 UTC (QA Tests)] INFO -- Saving screenshot..1048[Sep 18 2023 03:16:09 UTC (QA Tests)] INFO -- Starting test: Verify Pipeline with image:pull_policy when policy is allowed with [if-not-present] policy applies pull policy in job correctly1049[Sep 18 2023 03:16:09 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds1050[Sep 18 2023 03:16:09 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.11 seconds1051[Sep 18 2023 03:16:09 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.1052[Sep 18 2023 03:16:09 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`1053[Sep 18 2023 03:16:10 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1054[Sep 18 2023 03:16:10 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1055[Sep 18 2023 03:16:10 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-u57g2t8r -v /var/run/docker.sock:/var/run/docker.sock --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-u57g2t8r sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-u57g2t8r --url http://gitlab-ce-408a76fb.test --registration-token **** --tag-list qa-runner-u57g2t8r --executor docker --docker-image registry.gitlab.com/ gitlab-org/gitlab-build-images:gitlab-qa-alpine-ruby-2.7 --docker-tlsverify=false --docker-privileged=true --docker-network-mode=test --docker-volumes=/certs/client && gitlab-runner run" `1056[Sep 18 2023 03:16:10 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-u57g2t8r`1057[Sep 18 2023 03:16:10 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1058[Sep 18 2023 03:16:11 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-u57g2t8r' via api in 1.81 seconds1059[Sep 18 2023 03:16:11 UTC (QA Tests)] INFO -- Updating runner config to allow pull policies...1060[Sep 18 2023 03:16:11 UTC (QA Tests)] INFO -- Executing: `docker cp qa-runner-u57g2t8r:/etc/gitlab-runner/config.toml /tmp/config.toml20230918-39-elyunp`1061[Sep 18 2023 03:16:11 UTC (QA Tests)] INFO -- Executing: `docker cp /tmp/config.toml20230918-39-elyunp qa-runner-u57g2t8r:/etc/gitlab-runner/config.toml`1062[Sep 18 2023 03:16:11 UTC (QA Tests)] INFO -- Restarting runner container qa-runner-u57g2t8r...1063[Sep 18 2023 03:16:11 UTC (QA Tests)] INFO -- Executing: `docker restart qa-runner-u57g2t8r`1064[Sep 18 2023 03:16:12 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-u57g2t8r`1065[Sep 18 2023 03:16:12 UTC (QA Tests)] INFO -- Waiting for runner to come online...1066[Sep 18 2023 03:16:13 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.77 seconds1067[Sep 18 2023 03:16:13 UTC (QA Tests)] INFO -- filling :login_field with "root"1068[Sep 18 2023 03:16:13 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1069[Sep 18 2023 03:16:14 UTC (QA Tests)] INFO -- filling :password_field with "*****"1070[Sep 18 2023 03:16:14 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1071[Sep 18 2023 03:16:14 UTC (QA Tests)] INFO -- clicking :sign_in_button1072[Sep 18 2023 03:16:15 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.133s1073[Sep 18 2023 03:16:17 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/pipeline-with-image-pull-policy-c67dee587475bb461074[Sep 18 2023 03:16:19 UTC (QA Tests)] INFO -- clicking :menu_section_button1075[Sep 18 2023 03:16:19 UTC (QA Tests)] INFO -- clicking :nav_item_link1076[Sep 18 2023 03:16:20 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.644s1077[Sep 18 2023 03:16:21 UTC (QA Tests)] INFO -- clicking :job_link and ensuring QA::Page::Project::Job::Show is present1078[Sep 18 2023 03:16:22 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element job_link' took 0.88s1079[Sep 18 2023 03:16:22 UTC (QA Tests)] INFO -- Removed a QA::Resource::ProjectRunner with name 'gitlab-runner'1080[Sep 18 2023 03:16:22 UTC (QA Tests)] INFO -- Executing: `docker rm -f qa-runner-u57g2t8r`1081 applies pull policy in job correctly10831st Try error in ./qa/specs/features/browser_ui/4_verify/pipeline/pipeline_with_image_pull_policy_spec.rb:63:1084Expected to find Using locally found image version due to "if-not-present" pull policy in 1Running with gitlab-runner 16.3.1 (d240d5bb)10852 on qa-runner-r250z4h9 fBV_W67C, system ID: r_ibyppAJBhyHH108631087Preparing the "docker" executor108800:1410894Using Docker executor with image ruby:2.6 ...10905Pulling docker image ruby:2.6 ...10916Using docker image sha256:b71cca836fff8e4f14f8575e25a157f3e253bcd1a039432f4980728c846603f7 for ruby:2.6 with digest ruby@sha256:a79c8ddb7f3d3748427e2d3a45dcae6d42f1d80d9ae3b98959b3a27b220bf434 ...109281093Preparing environment109400:0710959Running on runner-fbvw67c-project-31-concurrent-0 via ab1ea61118e4...1096111097Getting source from Git repository109800:00109912Fetching changes with git depth set to 20...110013Initialized empty Git repository in /builds/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/pipeline-with-image-pull-policy-2607599c783050d8/.git/110114Created fresh repository.110215Checking out 80666f31 as detached HEAD (ref is main)...110316Skipping Git submodules setup1104181105Executing "step_script" stage of the job script110600:00110719Using docker image sha256:b71cca836fff8e4f14f8575e25a157f3e253bcd1a039432f4980728c846603f7 for ruby:2.6 with digest ruby@sha256:a79c8ddb7f3d3748427e2d3a45dcae6d42f1d80d9ae3b98959b3a27b220bf434 ...110820$ echo "Using pull policies ["if-not-present"]"110921Using pull policies [if-not-present]111023Job succeeded, but didn't.1112RSpec::Retry: 2nd try ./qa/specs/features/browser_ui/4_verify/pipeline/pipeline_with_image_pull_policy_spec.rb:631113 with [always if-not-present] policies1114[Sep 18 2023 03:16:22 UTC (QA Tests)] INFO -- Starting test: Verify Pipeline with image:pull_policy when policy is allowed with [always if-not-present] policies applies pull policy in job correctly1115[Sep 18 2023 03:16:22 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds1116[Sep 18 2023 03:16:22 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.1 seconds1117[Sep 18 2023 03:16:23 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.1118[Sep 18 2023 03:16:23 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`1119[Sep 18 2023 03:16:27 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1120[Sep 18 2023 03:16:27 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1121[Sep 18 2023 03:16:27 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-o0ygb6l1 -v /var/run/docker.sock:/var/run/docker.sock --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-o0ygb6l1 sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-o0ygb6l1 --url http://gitlab-ce-408a76fb.test --registration-token **** --tag-list qa-runner-o0ygb6l1 --executor docker --docker-image registry.gitlab.com/ gitlab-org/gitlab-build-images:gitlab-qa-alpine-ruby-2.7 --docker-tlsverify=false --docker-privileged=true --docker-network-mode=test --docker-volumes=/certs/client && gitlab-runner run" `1122[Sep 18 2023 03:16:28 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-o0ygb6l1`1123[Sep 18 2023 03:16:28 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1124[Sep 18 2023 03:16:29 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-o0ygb6l1' via api in 5.83 seconds1125[Sep 18 2023 03:16:29 UTC (QA Tests)] INFO -- Updating runner config to allow pull policies...1126[Sep 18 2023 03:16:29 UTC (QA Tests)] INFO -- Executing: `docker cp qa-runner-o0ygb6l1:/etc/gitlab-runner/config.toml /tmp/config.toml20230918-39-hq3f3s`1127[Sep 18 2023 03:16:29 UTC (QA Tests)] INFO -- Executing: `docker cp /tmp/config.toml20230918-39-hq3f3s qa-runner-o0ygb6l1:/etc/gitlab-runner/config.toml`1128[Sep 18 2023 03:16:29 UTC (QA Tests)] INFO -- Restarting runner container qa-runner-o0ygb6l1...1129[Sep 18 2023 03:16:29 UTC (QA Tests)] INFO -- Executing: `docker restart qa-runner-o0ygb6l1`1130[Sep 18 2023 03:16:29 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-o0ygb6l1`1131[Sep 18 2023 03:16:29 UTC (QA Tests)] INFO -- Waiting for runner to come online...1132[Sep 18 2023 03:16:30 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.65 seconds1133[Sep 18 2023 03:16:31 UTC (QA Tests)] INFO -- filling :login_field with "root"1134[Sep 18 2023 03:16:31 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1135[Sep 18 2023 03:16:31 UTC (QA Tests)] INFO -- filling :password_field with "*****"1136[Sep 18 2023 03:16:31 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1137[Sep 18 2023 03:16:31 UTC (QA Tests)] INFO -- clicking :sign_in_button1138[Sep 18 2023 03:16:32 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.118s1139[Sep 18 2023 03:16:35 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/pipeline-with-image-pull-policy-b11db5a380f5927d1140[Sep 18 2023 03:16:36 UTC (QA Tests)] INFO -- clicking :menu_section_button1141[Sep 18 2023 03:16:36 UTC (QA Tests)] INFO -- clicking :nav_item_link1142[Sep 18 2023 03:16:37 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.695s1143[Sep 18 2023 03:16:38 UTC (QA Tests)] INFO -- clicking :job_link and ensuring QA::Page::Project::Job::Show is present1144[Sep 18 2023 03:16:39 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element job_link' took 0.9s1145[Sep 18 2023 03:16:39 UTC (QA Tests)] INFO -- Removed a QA::Resource::ProjectRunner with name 'gitlab-runner'1146[Sep 18 2023 03:16:39 UTC (QA Tests)] INFO -- Executing: `docker rm -f qa-runner-o0ygb6l1`1147 applies pull policy in job correctly1148 with [never] policy1149[Sep 18 2023 03:16:40 UTC (QA Tests)] INFO -- Starting test: Verify Pipeline with image:pull_policy when policy is allowed with [never] policy applies pull policy in job correctly1150[Sep 18 2023 03:16:40 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds1151[Sep 18 2023 03:16:40 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.11 seconds1152[Sep 18 2023 03:16:40 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.1153[Sep 18 2023 03:16:40 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`1154[Sep 18 2023 03:16:41 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1155[Sep 18 2023 03:16:41 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1156[Sep 18 2023 03:16:41 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-58d49aqs -v /var/run/docker.sock:/var/run/docker.sock --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-58d49aqs sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-58d49aqs --url http://gitlab-ce-408a76fb.test --registration-token **** --tag-list qa-runner-58d49aqs --executor docker --docker-image registry.gitlab.com/ gitlab-org/gitlab-build-images:gitlab-qa-alpine-ruby-2.7 --docker-tlsverify=false --docker-privileged=true --docker-network-mode=test --docker-volumes=/certs/client && gitlab-runner run" `1157[Sep 18 2023 03:16:41 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-58d49aqs`1158[Sep 18 2023 03:16:41 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1159[Sep 18 2023 03:16:42 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-58d49aqs' via api in 1.85 seconds1160[Sep 18 2023 03:16:42 UTC (QA Tests)] INFO -- Updating runner config to allow pull policies...1161[Sep 18 2023 03:16:42 UTC (QA Tests)] INFO -- Executing: `docker cp qa-runner-58d49aqs:/etc/gitlab-runner/config.toml /tmp/config.toml20230918-39-c0u3yk`1162[Sep 18 2023 03:16:42 UTC (QA Tests)] INFO -- Executing: `docker cp /tmp/config.toml20230918-39-c0u3yk qa-runner-58d49aqs:/etc/gitlab-runner/config.toml`1163[Sep 18 2023 03:16:42 UTC (QA Tests)] INFO -- Restarting runner container qa-runner-58d49aqs...1164[Sep 18 2023 03:16:42 UTC (QA Tests)] INFO -- Executing: `docker restart qa-runner-58d49aqs`1165[Sep 18 2023 03:16:43 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-58d49aqs`1166[Sep 18 2023 03:16:43 UTC (QA Tests)] INFO -- Waiting for runner to come online...1167[Sep 18 2023 03:16:44 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.71 seconds1168[Sep 18 2023 03:16:44 UTC (QA Tests)] INFO -- filling :login_field with "root"1169[Sep 18 2023 03:16:44 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1170[Sep 18 2023 03:16:45 UTC (QA Tests)] INFO -- filling :password_field with "*****"1171[Sep 18 2023 03:16:45 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1172[Sep 18 2023 03:16:45 UTC (QA Tests)] INFO -- clicking :sign_in_button1173[Sep 18 2023 03:16:46 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.06s1174[Sep 18 2023 03:16:48 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/pipeline-with-image-pull-policy-7f1bf25815d51a5d1175[Sep 18 2023 03:16:49 UTC (QA Tests)] INFO -- clicking :menu_section_button1176[Sep 18 2023 03:16:50 UTC (QA Tests)] INFO -- clicking :nav_item_link1177[Sep 18 2023 03:16:50 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.654s1178[Sep 18 2023 03:16:51 UTC (QA Tests)] INFO -- clicking :job_link and ensuring QA::Page::Project::Job::Show is present1179[Sep 18 2023 03:16:52 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element job_link' took 0.914s1180[Sep 18 2023 03:16:53 UTC (QA Tests)] INFO -- Removed a QA::Resource::ProjectRunner with name 'gitlab-runner'1181[Sep 18 2023 03:16:53 UTC (QA Tests)] INFO -- Executing: `docker rm -f qa-runner-58d49aqs`1182 applies pull policy in job correctly1183 with [always] policy1184[Sep 18 2023 03:16:53 UTC (QA Tests)] INFO -- Starting test: Verify Pipeline with image:pull_policy when policy is allowed with [always] policy applies pull policy in job correctly1185[Sep 18 2023 03:16:53 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds1186[Sep 18 2023 03:16:53 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.1 seconds1187[Sep 18 2023 03:16:54 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.1188[Sep 18 2023 03:16:54 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`1189[Sep 18 2023 03:16:54 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1190[Sep 18 2023 03:16:54 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1191[Sep 18 2023 03:16:54 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-see84ebv -v /var/run/docker.sock:/var/run/docker.sock --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-see84ebv sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-see84ebv --url http://gitlab-ce-408a76fb.test --registration-token **** --tag-list qa-runner-see84ebv --executor docker --docker-image registry.gitlab.com/ gitlab-org/gitlab-build-images:gitlab-qa-alpine-ruby-2.7 --docker-tlsverify=false --docker-privileged=true --docker-network-mode=test --docker-volumes=/certs/client && gitlab-runner run" `1192[Sep 18 2023 03:16:54 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-see84ebv`1193[Sep 18 2023 03:16:54 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1194[Sep 18 2023 03:16:56 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-see84ebv' via api in 1.81 seconds1195[Sep 18 2023 03:16:56 UTC (QA Tests)] INFO -- Updating runner config to allow pull policies...1196[Sep 18 2023 03:16:56 UTC (QA Tests)] INFO -- Executing: `docker cp qa-runner-see84ebv:/etc/gitlab-runner/config.toml /tmp/config.toml20230918-39-1b7jt6`1197[Sep 18 2023 03:16:56 UTC (QA Tests)] INFO -- Executing: `docker cp /tmp/config.toml20230918-39-1b7jt6 qa-runner-see84ebv:/etc/gitlab-runner/config.toml`1198[Sep 18 2023 03:16:56 UTC (QA Tests)] INFO -- Restarting runner container qa-runner-see84ebv...1199[Sep 18 2023 03:16:56 UTC (QA Tests)] INFO -- Executing: `docker restart qa-runner-see84ebv`1200[Sep 18 2023 03:16:56 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-see84ebv`1201[Sep 18 2023 03:16:56 UTC (QA Tests)] INFO -- Waiting for runner to come online...1202[Sep 18 2023 03:16:57 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.66 seconds1203[Sep 18 2023 03:16:57 UTC (QA Tests)] INFO -- filling :login_field with "root"1204[Sep 18 2023 03:16:57 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1205[Sep 18 2023 03:16:58 UTC (QA Tests)] INFO -- filling :password_field with "*****"1206[Sep 18 2023 03:16:58 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1207[Sep 18 2023 03:16:58 UTC (QA Tests)] INFO -- clicking :sign_in_button1208[Sep 18 2023 03:16:59 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.053s1209[Sep 18 2023 03:17:01 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/pipeline-with-image-pull-policy-dadc9fd484acd0261210[Sep 18 2023 03:17:03 UTC (QA Tests)] INFO -- clicking :menu_section_button1211[Sep 18 2023 03:17:03 UTC (QA Tests)] INFO -- clicking :nav_item_link1212[Sep 18 2023 03:17:04 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.661s1213[Sep 18 2023 03:17:05 UTC (QA Tests)] INFO -- clicking :job_link and ensuring QA::Page::Project::Job::Show is present1214[Sep 18 2023 03:17:06 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element job_link' took 0.87s1215[Sep 18 2023 03:17:06 UTC (QA Tests)] INFO -- Removed a QA::Resource::ProjectRunner with name 'gitlab-runner'1216[Sep 18 2023 03:17:06 UTC (QA Tests)] INFO -- Executing: `docker rm -f qa-runner-see84ebv`1217 applies pull policy in job correctly1218Plan1219 check xss occurence in @mentions in issues1220[Sep 18 2023 03:17:06 UTC (QA Tests)] INFO -- Starting test: Plan check xss occurence in @mentions in issues mentions a user in a comment1221[Sep 18 2023 03:17:07 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds1222[Sep 18 2023 03:17:07 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.1 seconds1223[Sep 18 2023 03:17:08 UTC (QA Tests)] INFO -- filling :login_field with "root"1224[Sep 18 2023 03:17:08 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1225[Sep 18 2023 03:17:08 UTC (QA Tests)] INFO -- filling :password_field with "*****"1226[Sep 18 2023 03:17:08 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1227[Sep 18 2023 03:17:09 UTC (QA Tests)] INFO -- clicking :sign_in_button1228[Sep 18 2023 03:17:10 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.011s1229[Sep 18 2023 03:17:12 UTC (QA Tests)] INFO -- Adding user qa-user-b5733a5d5780fe1d to gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/xss-test-for-mentions-project-871e037ce28eaae4 QA::Resource::Project1230[Sep 18 2023 03:17:12 UTC (QA Tests)] INFO -- Visiting QA::Resource::Issue at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/xss-test-for-mentions-project-871e037ce28eaae4/-/issues/11231[Sep 18 2023 03:17:14 UTC (QA Tests)] INFO -- clicking :issue-title1232[Sep 18 2023 03:17:14 UTC (QA Tests)] INFO -- clicking :discussion_preferences_dropdown1233[Sep 18 2023 03:17:14 UTC (QA Tests)] INFO -- clicking :issue-title1234[Sep 18 2023 03:17:14 UTC (QA Tests)] INFO -- clicking :discussion_preferences_dropdown1235[Sep 18 2023 03:17:15 UTC (QA Tests)] INFO -- filling :comment_field with "cc-ing you here @qa-user-b5733a5d5780fe1d1236"1237[Sep 18 2023 03:17:15 UTC (QA Tests)] INFO -- clicking the coordinates of :comment_field1238[Sep 18 2023 03:17:15 UTC (QA Tests)] INFO -- clicking :comment_button1239[Sep 18 2023 03:17:16 UTC (QA Tests)] INFO -- Removed a QA::Resource::User with username 'qa-user-b5733a5d5780fe1d'1240 mentions a user in a comment1241Plan1242 collapse comments in issue discussions1243[Sep 18 2023 03:17:16 UTC (QA Tests)] INFO -- Starting test: Plan collapse comments in issue discussions collapses and expands reply for comments in an issue1244[Sep 18 2023 03:17:16 UTC (QA Tests)] INFO -- filling :login_field with "root"1245[Sep 18 2023 03:17:16 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1246[Sep 18 2023 03:17:17 UTC (QA Tests)] INFO -- filling :password_field with "*****"1247[Sep 18 2023 03:17:17 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1248[Sep 18 2023 03:17:17 UTC (QA Tests)] INFO -- clicking :sign_in_button1249[Sep 18 2023 03:17:18 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.022s1250[Sep 18 2023 03:17:20 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds1251[Sep 18 2023 03:17:20 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.1 seconds1252[Sep 18 2023 03:17:21 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-issues-7bc0e93f65b1c707' via api in 0.7 seconds1253[Sep 18 2023 03:17:21 UTC (QA Tests)] INFO -- Visiting QA::Resource::Issue at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-issues-7bc0e93f65b1c707/-/issues/11254[Sep 18 2023 03:17:23 UTC (QA Tests)] INFO -- clicking :issue-title1255[Sep 18 2023 03:17:23 UTC (QA Tests)] INFO -- clicking :discussion_preferences_dropdown1256[Sep 18 2023 03:17:23 UTC (QA Tests)] INFO -- filling :comment_field with "My first discussion"1257[Sep 18 2023 03:17:23 UTC (QA Tests)] INFO -- clicking the coordinates of :comment_field1258[Sep 18 2023 03:17:24 UTC (QA Tests)] INFO -- clicking :discussion_menu_item1259[Sep 18 2023 03:17:24 UTC (QA Tests)] INFO -- clicking :comment_button1260[Sep 18 2023 03:17:24 UTC (QA Tests)] INFO -- filling :reply_field with "My first reply"1261[Sep 18 2023 03:17:24 UTC (QA Tests)] INFO -- clicking the coordinates of :reply_field1262[Sep 18 2023 03:17:25 UTC (QA Tests)] INFO -- clicking :reply_comment_button1263[Sep 18 2023 03:17:25 UTC (QA Tests)] INFO -- clicking :collapse_replies_button1264[Sep 18 2023 03:17:26 UTC (QA Tests)] INFO -- clicking :expand_replies_button1265 collapses and expands reply for comments in an issue1266Create1267 Version control for project snippets1268[Sep 18 2023 03:17:26 UTC (QA Tests)] INFO -- Starting test: Create Version control for project snippets clones, pushes, and pulls a project snippet over HTTP, edits via UI1269[Sep 18 2023 03:17:27 UTC (QA Tests)] INFO -- filling :login_field with "root"1270[Sep 18 2023 03:17:27 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1271[Sep 18 2023 03:17:27 UTC (QA Tests)] INFO -- filling :password_field with "*****"1272[Sep 18 2023 03:17:27 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1273[Sep 18 2023 03:17:27 UTC (QA Tests)] INFO -- clicking :sign_in_button1274[Sep 18 2023 03:17:28 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.018s1275[Sep 18 2023 03:17:30 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds1276[Sep 18 2023 03:17:30 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.1 seconds1277[Sep 18 2023 03:17:31 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-with-snippets-8c475babe6b015a8' via api in 0.67 seconds1278[Sep 18 2023 03:17:31 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::ProjectSnippet with id '3' via api in 1.06 seconds1279[Sep 18 2023 03:17:31 UTC (QA Tests)] INFO -- Visiting QA::Resource::ProjectSnippet at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-with-snippets-8c475babe6b015a8/-/snippets/31280[Sep 18 2023 03:17:32 UTC (QA Tests)] INFO -- clicking :clone_button1281[Sep 18 2023 03:17:33 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Push via browser_ui in 0.94 seconds1282[Sep 18 2023 03:17:35 UTC (QA Tests)] INFO -- clicking :snippet_action_button and ensuring QA::Page::Dashboard::Snippet::Edit is present1283[Sep 18 2023 03:17:36 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element snippet_action_button' took 1.16s1284[Sep 18 2023 03:17:46 UTC (QA Tests)] INFO -- clicking the coordinates of :submit_button1285[Sep 18 2023 03:17:47 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 1.261s1286[Sep 18 2023 03:17:47 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_no_element? file_name_field' took 1.273s1287[Sep 18 2023 03:17:48 UTC (QA Tests)] INFO -- Removed a QA::Resource::ProjectSnippet with id '3'1288[Sep 18 2023 03:17:48 UTC (QA Tests)] INFO -- Executing: `ssh-keygen -t rsa -b 4096 -f /tmp/d20230918-39-fwdc25/id_rsa -N `1289[Sep 18 2023 03:17:48 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::SSHKey with id '2' via api in 0.47 seconds1290[Sep 18 2023 03:17:49 UTC (QA Tests)] INFO -- Removed a QA::Resource::SSHKey with id '2'1291 clones, pushes, and pulls a project snippet over HTTP, edits via UI1292[Sep 18 2023 03:17:49 UTC (QA Tests)] INFO -- Starting test: Create Version control for project snippets clones, pushes, and pulls a project snippet over SSH, deletes via UI1293[Sep 18 2023 03:17:49 UTC (QA Tests)] INFO -- filling :login_field with "root"1294[Sep 18 2023 03:17:49 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1295[Sep 18 2023 03:17:49 UTC (QA Tests)] INFO -- filling :password_field with "*****"1296[Sep 18 2023 03:17:49 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1297[Sep 18 2023 03:17:50 UTC (QA Tests)] INFO -- clicking :sign_in_button1298[Sep 18 2023 03:17:51 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.021s1299[Sep 18 2023 03:17:53 UTC (QA Tests)] INFO -- Executing: `ssh-keygen -t rsa -b 4096 -f /tmp/d20230918-39-tkac3h/id_rsa -N `1300[Sep 18 2023 03:17:53 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::SSHKey with id '3' via api in 0.28 seconds1301[Sep 18 2023 03:17:53 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds1302[Sep 18 2023 03:17:53 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.11 seconds1303[Sep 18 2023 03:17:54 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-with-snippets-3e1c946e1a51ffb3' via api in 0.7 seconds1304[Sep 18 2023 03:17:54 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::ProjectSnippet with id '4' via api in 1.06 seconds1305[Sep 18 2023 03:17:54 UTC (QA Tests)] INFO -- Visiting QA::Resource::ProjectSnippet at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-with-snippets-3e1c946e1a51ffb3/-/snippets/41306[Sep 18 2023 03:17:55 UTC (QA Tests)] INFO -- clicking :clone_button1307[Sep 18 2023 03:17:56 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Push via browser_ui in 0.89 seconds1308[Sep 18 2023 03:17:57 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 0.857s1309[Sep 18 2023 03:17:57 UTC (QA Tests)] INFO -- clicking :snippet_action_button1310[Sep 18 2023 03:17:57 UTC (QA Tests)] INFO -- clicking :delete_snippet_button1311[Sep 18 2023 03:17:58 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 0.672s1312[Sep 18 2023 03:17:58 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_no_element? delete_snippet_button' took 0.679s1313[Sep 18 2023 03:17:58 UTC (QA Tests)] INFO -- Removed a QA::Resource::SSHKey with id '3'1314 clones, pushes, and pulls a project snippet over SSH, deletes via UI1315Verify1316 Include multiple files from a project1317[Sep 18 2023 03:17:58 UTC (QA Tests)] INFO -- Starting test: Verify Include multiple files from a project runs the pipeline with composed config1318[Sep 18 2023 03:17:59 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds1319[Sep 18 2023 03:17:59 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.1 seconds1320[Sep 18 2023 03:17:59 UTC (QA Tests)] INFO -- Runner api_get exception caught and handled: No value was computed for id of QA::Resource::ProjectRunner.1321[Sep 18 2023 03:17:59 UTC (QA Tests)] INFO -- Executing: `docker pull registry.gitlab.com/gitlab-org/gitlab-runner:alpine`1322[Sep 18 2023 03:17:59 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1323[Sep 18 2023 03:17:59 UTC (QA Tests)] INFO -- Executing: `docker run -d --rm --network test --name qa-runner-ezmzd6d2 --privileged registry.gitlab.com/gitlab-org/gitlab-runner:alpine && docker exec --detach qa-runner-ezmzd6d2 sh -c "printf 'concurrent = 1\ncheck_interval = 0\n\n[session_server]\n session_timeout = 1800' > /etc/gitlab-runner/config.toml && gitlab-runner register --non-interactive --name qa-runner-ezmzd6d2 --url http://gitlab-ce-408a76fb.test --registration-token **** --tag-list qa-runner-ezmzd6d2 --executor shell && gitlab-runner run" `1324[Sep 18 2023 03:18:00 UTC (QA Tests)] INFO -- Executing: `docker logs qa-runner-ezmzd6d2`1325[Sep 18 2023 03:18:00 UTC (QA Tests)] INFO -- Executing: `docker network inspect test`1326[Sep 18 2023 03:18:01 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::ProjectRunner with name 'qa-runner-ezmzd6d2' via api in 1.95 seconds1327[Sep 18 2023 03:18:02 UTC (QA Tests)] INFO -- filling :login_field with "root"1328[Sep 18 2023 03:18:02 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1329[Sep 18 2023 03:18:02 UTC (QA Tests)] INFO -- filling :password_field with "*****"1330[Sep 18 2023 03:18:02 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1331[Sep 18 2023 03:18:02 UTC (QA Tests)] INFO -- clicking :sign_in_button1332[Sep 18 2023 03:18:03 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.004s1333[Sep 18 2023 03:18:05 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds1334[Sep 18 2023 03:18:05 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.1 seconds1335[Sep 18 2023 03:18:07 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.67 seconds1336[Sep 18 2023 03:18:08 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::Commit via api in 0.76 seconds1337[Sep 18 2023 03:18:08 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-with-pipeline-1-a353ae032bf4dc1b1338[Sep 18 2023 03:18:09 UTC (QA Tests)] INFO -- clicking :menu_section_button1339[Sep 18 2023 03:18:09 UTC (QA Tests)] INFO -- clicking :nav_item_link1340[Sep 18 2023 03:18:10 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.661s1341[Sep 18 2023 03:18:21 UTC (QA Tests)] INFO -- clicking :job_link and ensuring QA::Page::Project::Job::Show is present1342[Sep 18 2023 03:18:22 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element job_link' took 0.87s1343[Sep 18 2023 03:18:23 UTC (QA Tests)] INFO -- Removed a QA::Resource::ProjectRunner with name 'qa-runner-ezmzd6d2'1344[Sep 18 2023 03:18:23 UTC (QA Tests)] INFO -- Executing: `docker rm -f qa-runner-ezmzd6d2`1345 runs the pipeline with composed config1346Create1347 Repository tags1348 when protected1349 behaves like successful tag creation1350[Sep 18 2023 03:18:23 UTC (QA Tests)] INFO -- Starting test: Create Repository tags when protected behaves like successful tag creation can be created by maintainer_user1351[Sep 18 2023 03:18:23 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds1352[Sep 18 2023 03:18:23 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.1 seconds1353[Sep 18 2023 03:18:24 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::User with username 'gitlab-qa-user1' via api in 0.13 seconds1354[Sep 18 2023 03:18:24 UTC (QA Tests)] INFO -- Adding user gitlab-qa-user1 to gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-tags-1a5cd039ae9ee871 QA::Resource::Project1355[Sep 18 2023 03:18:25 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::User with username 'gitlab-qa-user2' via api in 0.36 seconds1356[Sep 18 2023 03:18:25 UTC (QA Tests)] INFO -- Adding user gitlab-qa-user2 to gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-tags-1a5cd039ae9ee871 QA::Resource::Project1357[Sep 18 2023 03:18:25 UTC (QA Tests)] INFO -- filling :login_field with "root"1358[Sep 18 2023 03:18:25 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1359[Sep 18 2023 03:18:26 UTC (QA Tests)] INFO -- filling :password_field with "*****"1360[Sep 18 2023 03:18:26 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1361[Sep 18 2023 03:18:26 UTC (QA Tests)] INFO -- clicking :sign_in_button1362[Sep 18 2023 03:18:27 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.014s1363[Sep 18 2023 03:18:29 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-tags-1a5cd039ae9ee8711364[Sep 18 2023 03:18:30 UTC (QA Tests)] INFO -- clicking :menu_section_button1365[Sep 18 2023 03:18:31 UTC (QA Tests)] INFO -- clicking :nav_item_link1366[Sep 18 2023 03:18:32 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 1.041s1367[Sep 18 2023 03:18:33 UTC (QA Tests)] INFO -- clicking :tags_dropdown1368[Sep 18 2023 03:18:34 UTC (QA Tests)] INFO -- clicking :allowed_to_create_dropdown1369[Sep 18 2023 03:18:34 UTC (QA Tests)] INFO -- clicking :allowed_to_create_dropdown1370[Sep 18 2023 03:18:34 UTC (QA Tests)] INFO -- clicking :protect_tag_button1371[Sep 18 2023 03:18:35 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 1.422s1372[Sep 18 2023 03:18:36 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? global-search-input' took 2.429s1373[Sep 18 2023 03:18:38 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? user_profile_link' took 1.05s1374[Sep 18 2023 03:18:38 UTC (QA Tests)] INFO -- clicking :user_avatar_content1375[Sep 18 2023 03:18:38 UTC (QA Tests)] INFO -- clicking :sign_out_link1376[Sep 18 2023 03:18:39 UTC (QA Tests)] INFO -- filling :login_field with "gitlab-qa-user2"1377[Sep 18 2023 03:18:39 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1378[Sep 18 2023 03:18:39 UTC (QA Tests)] INFO -- filling :password_field with "*****"1379[Sep 18 2023 03:18:39 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1380[Sep 18 2023 03:18:39 UTC (QA Tests)] INFO -- clicking :sign_in_button1381[Sep 18 2023 03:18:42 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-tags-1a5cd039ae9ee8711382[Sep 18 2023 03:18:43 UTC (QA Tests)] INFO -- clicking :menu_section_button1383[Sep 18 2023 03:18:43 UTC (QA Tests)] INFO -- clicking :nav_item_link1384[Sep 18 2023 03:18:44 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.609s1385[Sep 18 2023 03:18:44 UTC (QA Tests)] INFO -- clicking :new_tag_button1386[Sep 18 2023 03:18:44 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element new_tag_button' took 0.629s1387[Sep 18 2023 03:18:44 UTC (QA Tests)] INFO -- filling :tag_name_field with "v0.0.1"1388[Sep 18 2023 03:18:44 UTC (QA Tests)] INFO -- clicking the coordinates of :tag_name_field1389[Sep 18 2023 03:18:45 UTC (QA Tests)] INFO -- filling :tag_message_field with "Version 0.0.1"1390[Sep 18 2023 03:18:45 UTC (QA Tests)] INFO -- clicking the coordinates of :tag_message_field1391[Sep 18 2023 03:18:45 UTC (QA Tests)] INFO -- clicking :create_tag_button1392[Sep 18 2023 03:18:46 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element create_tag_button' took 0.931s1393 can be created by maintainer_user1394 behaves like unsuccessful tag creation1395[Sep 18 2023 03:18:46 UTC (QA Tests)] INFO -- Starting test: Create Repository tags when protected behaves like unsuccessful tag creation cannot be created by an unauthorized developer_user1396[Sep 18 2023 03:18:46 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.06 seconds1397[Sep 18 2023 03:18:46 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.11 seconds1398[Sep 18 2023 03:18:47 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::User with username 'gitlab-qa-user1' via api in 0.18 seconds1399[Sep 18 2023 03:18:47 UTC (QA Tests)] INFO -- Adding user gitlab-qa-user1 to gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-tags-09a6f2853d2c217d QA::Resource::Project1400[Sep 18 2023 03:18:48 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::User with username 'gitlab-qa-user2' via api in 0.12 seconds1401[Sep 18 2023 03:18:48 UTC (QA Tests)] INFO -- Adding user gitlab-qa-user2 to gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-tags-09a6f2853d2c217d QA::Resource::Project1402[Sep 18 2023 03:18:48 UTC (QA Tests)] INFO -- filling :login_field with "root"1403[Sep 18 2023 03:18:48 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1404[Sep 18 2023 03:18:49 UTC (QA Tests)] INFO -- filling :password_field with "*****"1405[Sep 18 2023 03:18:49 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1406[Sep 18 2023 03:18:49 UTC (QA Tests)] INFO -- clicking :sign_in_button1407[Sep 18 2023 03:18:50 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.035s1408[Sep 18 2023 03:18:52 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-tags-09a6f2853d2c217d1409[Sep 18 2023 03:18:53 UTC (QA Tests)] INFO -- clicking :menu_section_button1410[Sep 18 2023 03:18:54 UTC (QA Tests)] INFO -- clicking :nav_item_link1411[Sep 18 2023 03:18:55 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 1.234s1412[Sep 18 2023 03:18:56 UTC (QA Tests)] INFO -- clicking :tags_dropdown1413[Sep 18 2023 03:18:56 UTC (QA Tests)] INFO -- clicking :allowed_to_create_dropdown1414[Sep 18 2023 03:18:57 UTC (QA Tests)] INFO -- clicking :allowed_to_create_dropdown1415[Sep 18 2023 03:18:57 UTC (QA Tests)] INFO -- clicking :protect_tag_button1416[Sep 18 2023 03:18:58 UTC (QA Tests)] WARN -- Potentially Slow Code 'wait_for_requests ' took 1.153s1417[Sep 18 2023 03:18:59 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? global-search-input' took 2.162s1418[Sep 18 2023 03:19:01 UTC (QA Tests)] WARN -- Potentially Slow Code 'has_element? user_profile_link' took 1.028s1419[Sep 18 2023 03:19:01 UTC (QA Tests)] INFO -- clicking :user_avatar_content1420[Sep 18 2023 03:19:01 UTC (QA Tests)] INFO -- clicking :sign_out_link1421[Sep 18 2023 03:19:01 UTC (QA Tests)] INFO -- filling :login_field with "gitlab-qa-user1"1422[Sep 18 2023 03:19:01 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1423[Sep 18 2023 03:19:02 UTC (QA Tests)] INFO -- filling :password_field with "*****"1424[Sep 18 2023 03:19:02 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1425[Sep 18 2023 03:19:02 UTC (QA Tests)] INFO -- clicking :sign_in_button1426[Sep 18 2023 03:19:04 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-tags-09a6f2853d2c217d1427[Sep 18 2023 03:19:05 UTC (QA Tests)] INFO -- clicking :menu_section_button1428[Sep 18 2023 03:19:06 UTC (QA Tests)] INFO -- clicking :nav_item_link1429[Sep 18 2023 03:19:06 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.648s1430[Sep 18 2023 03:19:06 UTC (QA Tests)] INFO -- clicking :new_tag_button1431[Sep 18 2023 03:19:07 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element new_tag_button' took 0.596s1432[Sep 18 2023 03:19:07 UTC (QA Tests)] INFO -- filling :tag_name_field with "v0.0.1"1433[Sep 18 2023 03:19:07 UTC (QA Tests)] INFO -- clicking the coordinates of :tag_name_field1434[Sep 18 2023 03:19:07 UTC (QA Tests)] INFO -- filling :tag_message_field with "Version 0.0.1"1435[Sep 18 2023 03:19:07 UTC (QA Tests)] INFO -- clicking the coordinates of :tag_message_field1436[Sep 18 2023 03:19:08 UTC (QA Tests)] INFO -- clicking :create_tag_button1437[Sep 18 2023 03:19:08 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element create_tag_button' took 0.679s1438 cannot be created by an unauthorized developer_user1439 when not protected1440 behaves like successful tag creation1441[Sep 18 2023 03:19:09 UTC (QA Tests)] INFO -- Starting test: Create Repository tags when not protected behaves like successful tag creation can be created by maintainer_user1442[Sep 18 2023 03:19:09 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds1443[Sep 18 2023 03:19:09 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.1 seconds1444[Sep 18 2023 03:19:10 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::User with username 'gitlab-qa-user1' via api in 0.12 seconds1445[Sep 18 2023 03:19:10 UTC (QA Tests)] INFO -- Adding user gitlab-qa-user1 to gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-tags-1e0d8ce369e44f2e QA::Resource::Project1446[Sep 18 2023 03:19:10 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::User with username 'gitlab-qa-user2' via api in 0.12 seconds1447[Sep 18 2023 03:19:10 UTC (QA Tests)] INFO -- Adding user gitlab-qa-user2 to gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-tags-1e0d8ce369e44f2e QA::Resource::Project1448[Sep 18 2023 03:19:11 UTC (QA Tests)] INFO -- filling :login_field with "gitlab-qa-user2"1449[Sep 18 2023 03:19:11 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1450[Sep 18 2023 03:19:11 UTC (QA Tests)] INFO -- filling :password_field with "*****"1451[Sep 18 2023 03:19:11 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1452[Sep 18 2023 03:19:11 UTC (QA Tests)] INFO -- clicking :sign_in_button1453[Sep 18 2023 03:19:12 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.609s1454[Sep 18 2023 03:19:13 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-tags-1e0d8ce369e44f2e1455[Sep 18 2023 03:19:15 UTC (QA Tests)] INFO -- clicking :menu_section_button1456[Sep 18 2023 03:19:15 UTC (QA Tests)] INFO -- clicking :nav_item_link1457[Sep 18 2023 03:19:15 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.604s1458[Sep 18 2023 03:19:15 UTC (QA Tests)] INFO -- clicking :new_tag_button1459[Sep 18 2023 03:19:16 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element new_tag_button' took 0.624s1460[Sep 18 2023 03:19:16 UTC (QA Tests)] INFO -- filling :tag_name_field with "v0.0.1"1461[Sep 18 2023 03:19:16 UTC (QA Tests)] INFO -- clicking the coordinates of :tag_name_field1462[Sep 18 2023 03:19:17 UTC (QA Tests)] INFO -- filling :tag_message_field with "Version 0.0.1"1463[Sep 18 2023 03:19:17 UTC (QA Tests)] INFO -- clicking the coordinates of :tag_message_field1464[Sep 18 2023 03:19:17 UTC (QA Tests)] INFO -- clicking :create_tag_button1465[Sep 18 2023 03:19:18 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element create_tag_button' took 0.905s1466 can be created by maintainer_user1467 behaves like successful tag creation1468[Sep 18 2023 03:19:18 UTC (QA Tests)] INFO -- Starting test: Create Repository tags when not protected behaves like successful tag creation can be created by developer_user1469[Sep 18 2023 03:19:18 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds1470[Sep 18 2023 03:19:18 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.1 seconds1471[Sep 18 2023 03:19:19 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::User with username 'gitlab-qa-user1' via api in 0.11 seconds1472[Sep 18 2023 03:19:19 UTC (QA Tests)] INFO -- Adding user gitlab-qa-user1 to gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-tags-27a076ceaf469d6b QA::Resource::Project1473[Sep 18 2023 03:19:19 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::User with username 'gitlab-qa-user2' via api in 0.12 seconds1474[Sep 18 2023 03:19:19 UTC (QA Tests)] INFO -- Adding user gitlab-qa-user2 to gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-tags-27a076ceaf469d6b QA::Resource::Project1475[Sep 18 2023 03:19:20 UTC (QA Tests)] INFO -- filling :login_field with "gitlab-qa-user1"1476[Sep 18 2023 03:19:20 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1477[Sep 18 2023 03:19:20 UTC (QA Tests)] INFO -- filling :password_field with "*****"1478[Sep 18 2023 03:19:20 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1479[Sep 18 2023 03:19:21 UTC (QA Tests)] INFO -- clicking :sign_in_button1480[Sep 18 2023 03:19:21 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.653s1481[Sep 18 2023 03:19:23 UTC (QA Tests)] INFO -- Visiting QA::Resource::Project at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-for-tags-27a076ceaf469d6b1482[Sep 18 2023 03:19:24 UTC (QA Tests)] INFO -- clicking :menu_section_button1483[Sep 18 2023 03:19:24 UTC (QA Tests)] INFO -- clicking :nav_item_link1484[Sep 18 2023 03:19:25 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element nav_item_link' took 0.556s1485[Sep 18 2023 03:19:25 UTC (QA Tests)] INFO -- clicking :new_tag_button1486[Sep 18 2023 03:19:26 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element new_tag_button' took 0.589s1487[Sep 18 2023 03:19:26 UTC (QA Tests)] INFO -- filling :tag_name_field with "v0.0.1"1488[Sep 18 2023 03:19:26 UTC (QA Tests)] INFO -- clicking the coordinates of :tag_name_field1489[Sep 18 2023 03:19:26 UTC (QA Tests)] INFO -- filling :tag_message_field with "Version 0.0.1"1490[Sep 18 2023 03:19:26 UTC (QA Tests)] INFO -- clicking the coordinates of :tag_message_field1491[Sep 18 2023 03:19:26 UTC (QA Tests)] INFO -- clicking :create_tag_button1492[Sep 18 2023 03:19:27 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element create_tag_button' took 1.024s1493 can be created by developer_user1494Create1495 File management1496[Sep 18 2023 03:19:28 UTC (QA Tests)] INFO -- Starting test: Create File management user deletes a file via the Web1497[Sep 18 2023 03:19:28 UTC (QA Tests)] INFO -- filling :login_field with "root"1498[Sep 18 2023 03:19:28 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1499[Sep 18 2023 03:19:28 UTC (QA Tests)] INFO -- filling :password_field with "*****"1500[Sep 18 2023 03:19:28 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1501[Sep 18 2023 03:19:29 UTC (QA Tests)] INFO -- clicking :sign_in_button1502[Sep 18 2023 03:19:30 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.025s1503[Sep 18 2023 03:19:32 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.06 seconds1504[Sep 18 2023 03:19:32 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.11 seconds1505[Sep 18 2023 03:19:33 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-with-new-file-ae719c02b0566667' via api in 1.08 seconds1506[Sep 18 2023 03:19:34 UTC (QA Tests)] INFO -- Visiting QA::Resource::File at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-with-new-file-ae719c02b0566667/-/blob/main/QA+Test+-+File+name1507[Sep 18 2023 03:19:35 UTC (QA Tests)] INFO -- filling :commit_message_field with "QA Test - Delete file"1508[Sep 18 2023 03:19:35 UTC (QA Tests)] INFO -- clicking the coordinates of :commit_message_field1509[Sep 18 2023 03:19:37 UTC (QA Tests)] ERROR -- Interceptor Api Errors1510[200] POST http://gitlab-ce-408a76fb.test/api/graphql -- Correlation Id: 01HAK4SVT1Y6AK6C2WKWSJXY4W1511error-messages: Variable $refType of type RefType was provided invalid value1512 user deletes a file via the Web1513Plan1514 Testing wiki content manipulation inside a project1515[Sep 18 2023 03:19:37 UTC (QA Tests)] INFO -- Starting test: Plan Testing wiki content manipulation inside a project by manipulating content on the page1516[Sep 18 2023 03:19:37 UTC (QA Tests)] INFO -- filling :login_field with "root"1517[Sep 18 2023 03:19:37 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1518[Sep 18 2023 03:19:38 UTC (QA Tests)] INFO -- filling :password_field with "*****"1519[Sep 18 2023 03:19:38 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1520[Sep 18 2023 03:19:38 UTC (QA Tests)] INFO -- clicking :sign_in_button1521[Sep 18 2023 03:19:39 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 0.99s1522[Sep 18 2023 03:19:41 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds1523[Sep 18 2023 03:19:41 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.1 seconds1524[Sep 18 2023 03:19:42 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/wiki_testing-62545623e3ba8141' via api in 0.69 seconds1525[Sep 18 2023 03:19:42 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Wiki::ProjectPage via api in 1.24 seconds1526[Sep 18 2023 03:19:42 UTC (QA Tests)] INFO -- Visiting QA::Resource::Wiki::ProjectPage at http://gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/wiki_testing-62545623e3ba8141/-/wikis/Home1527[Sep 18 2023 03:19:43 UTC (QA Tests)] INFO -- clicking :edit_page_button1528[Sep 18 2023 03:19:44 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element edit_page_button' took 0.72s1529[Sep 18 2023 03:19:44 UTC (QA Tests)] INFO -- filling :wiki_title_textbox with "just_another_wiki_page"1530[Sep 18 2023 03:19:44 UTC (QA Tests)] INFO -- clicking the coordinates of :wiki_title_textbox1531[Sep 18 2023 03:19:44 UTC (QA Tests)] INFO -- filling :markdown_editor_form_field with "this content is changed or added"1532[Sep 18 2023 03:19:44 UTC (QA Tests)] INFO -- clicking the coordinates of :markdown_editor_form_field1533[Sep 18 2023 03:19:45 UTC (QA Tests)] INFO -- filling :wiki_message_textbox with "this is a new addition to the wiki"1534[Sep 18 2023 03:19:45 UTC (QA Tests)] INFO -- clicking the coordinates of :wiki_message_textbox1535[Sep 18 2023 03:19:46 UTC (QA Tests)] INFO -- clicking :wiki_submit_button1536[Sep 18 2023 03:19:47 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element wiki_submit_button' took 1.041s1537 by manipulating content on the page1538[Sep 18 2023 03:19:47 UTC (QA Tests)] INFO -- Starting test: Plan Testing wiki content manipulation inside a project by manipulating content on the page using git push1539[Sep 18 2023 03:19:47 UTC (QA Tests)] INFO -- filling :login_field with "root"1540[Sep 18 2023 03:19:47 UTC (QA Tests)] INFO -- clicking the coordinates of :login_field1541[Sep 18 2023 03:19:48 UTC (QA Tests)] INFO -- filling :password_field with "*****"1542[Sep 18 2023 03:19:48 UTC (QA Tests)] INFO -- clicking the coordinates of :password_field1543[Sep 18 2023 03:19:48 UTC (QA Tests)] INFO -- clicking :sign_in_button1544[Sep 18 2023 03:19:49 UTC (QA Tests)] WARN -- Potentially Slow Code 'click_element sign_in_button' took 1.086s1545[Sep 18 2023 03:19:51 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds1546[Sep 18 2023 03:19:51 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.1 seconds1547[Sep 18 2023 03:19:52 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/wiki_testing-7fd55eee1a4d54e9' via api in 0.7 seconds1548[Sep 18 2023 03:19:52 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Wiki::ProjectPage via api in 1.26 seconds1549[Sep 18 2023 03:19:53 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::WikiPush via browser_ui in 0.88 seconds1550[Sep 18 2023 03:19:53 UTC (QA Tests)] INFO -- Visiting QA::Resource::Repository::WikiPush at http://root@gitlab-ce-408a76fb.test/gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/wiki_testing-7fd55eee1a4d54e9/-/wikis/Home1551 by manipulating content on the page using git push1552Manage1553 User1554[Sep 18 2023 03:19:55 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Sandbox with full_path 'sandbox-for-access-termination-a8122112' via api in 0.3 seconds1555[Sep 18 2023 03:19:55 UTC (QA Tests)] INFO -- Adding user qa-user-b3cb02b9265a5f8d to sandbox-for-access-termination-a8122112 QA::Resource::Sandbox1556 when parent group membership is terminated1557[Sep 18 2023 03:19:56 UTC (QA Tests)] INFO -- Starting test: Manage User when parent group membership is terminated is not allowed to create a file via the API1558[Sep 18 2023 03:19:56 UTC (QA Tests)] INFO -- Removing user qa-user-b3cb02b9265a5f8d from sandbox-for-access-termination-a8122112 QA::Resource::Sandbox1559[Sep 18 2023 03:19:57 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.06 seconds1560[Sep 18 2023 03:19:57 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.12 seconds1561[Sep 18 2023 03:19:58 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Project with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48/project-with-new-file-d12d186dec225de1' via api in 1.1 seconds1562[Sep 18 2023 03:19:58 UTC (QA Tests)] INFO -- No cached token found for username: qa-user-b3cb02b9265a5f8d1563[Sep 18 2023 03:19:58 UTC (QA Tests)] INFO -- Caching token for username: qa-user-b3cb02b9265a5f8d, last six chars of token:u3E6Ga1564[Sep 18 2023 03:19:58 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::PersonalAccessToken with name 'api-pat-qa-user-b3cb02b9265a5f8d-j6bc4xbh' via api in 0.06 seconds1565 is not allowed to create a file via the API1566[Sep 18 2023 03:19:58 UTC (QA Tests)] INFO -- Starting test: Manage User when parent group membership is terminated is not allowed to push code via the CLI1567[Sep 18 2023 03:19:58 UTC (QA Tests)] INFO -- Removing user qa-user-b3cb02b9265a5f8d from sandbox-for-access-termination-a8122112 QA::Resource::Sandbox1568 is not allowed to push code via the CLI1569[Sep 18 2023 03:19:59 UTC (QA Tests)] INFO -- Starting test: Manage User when parent group membership is terminated is not allowed to commit via the API1570[Sep 18 2023 03:19:59 UTC (QA Tests)] INFO -- Removing user qa-user-b3cb02b9265a5f8d from sandbox-for-access-termination-a8122112 QA::Resource::Sandbox1571 is not allowed to commit via the API1572[Sep 18 2023 03:19:59 UTC (QA Tests)] INFO -- Removed a QA::Resource::Sandbox with full_path 'sandbox-for-access-termination-a8122112'1573Create1574 Merge request push options1575[Sep 18 2023 03:19:59 UTC (QA Tests)] INFO -- Starting test: Create Merge request push options sets labels1576[Sep 18 2023 03:19:59 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.06 seconds1577[Sep 18 2023 03:19:59 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.12 seconds1578[Sep 18 2023 03:20:01 UTC (QA Tests)] INFO -- QA::Resource::Project - wait_for_push with commit message "Add README.md"1579[Sep 18 2023 03:20:02 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::ProjectPush via browser_ui in 1.81 seconds1580 sets labels1581 when labels are set already1582[Sep 18 2023 03:20:02 UTC (QA Tests)] INFO -- Starting test: Create Merge request push options when labels are set already removes them on subsequent push1583[Sep 18 2023 03:20:02 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.06 seconds1584[Sep 18 2023 03:20:02 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.12 seconds1585[Sep 18 2023 03:20:04 UTC (QA Tests)] INFO -- QA::Resource::Project - wait_for_push with commit message "Add README.md"1586[Sep 18 2023 03:20:05 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::ProjectPush via browser_ui in 1.82 seconds1587[Sep 18 2023 03:20:06 UTC (QA Tests)] INFO -- QA::Resource::Project - wait_for_push with commit message "Add README.md"1588[Sep 18 2023 03:20:06 UTC (QA Tests)] INFO -- ==> Built a QA::Resource::Repository::ProjectPush via browser_ui in 1.3 seconds1589 removes them on subsequent push1590Create1591 Git clone over HTTP1592[Sep 18 2023 03:20:06 UTC (QA Tests)] INFO -- Starting test: Create Git clone over HTTP user performs a shallow clone1593[Sep 18 2023 03:20:06 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds1594[Sep 18 2023 03:20:07 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.12 seconds1595[Sep 18 2023 03:20:08 UTC (QA Tests)] INFO -- QA::Resource::Project - wait_for_push_new_branch with branch_name "main"1596 user performs a shallow clone1597[Sep 18 2023 03:20:09 UTC (QA Tests)] INFO -- Starting test: Create Git clone over HTTP user performs a deep clone1598[Sep 18 2023 03:20:09 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Sandbox with full_path 'gitlab-qa-sandbox-group-2' via api in 0.05 seconds1599[Sep 18 2023 03:20:09 UTC (QA Tests)] INFO -- ==> Retrieved a QA::Resource::Group with full_path 'gitlab-qa-sandbox-group-2/qa-test-2023-09-18-03-00-29-a34e9abe34e29a48' via api in 0.1 seconds1600[Sep 18 2023 03:20:10 UTC (QA Tests)] INFO -- QA::Resource::Project - wait_for_push_new_branch with branch_name "main"1601 user performs a deep clone1602[Sep 18 2023 03:20:11 UTC (QA Tests)] INFO -- 1603========= Knapsack Time Offset Warning ==========1604Time offset: 30s1605Max allowed node time execution: 21m 20s1606Exceeded time: -01m 38s1608Global time execution for this CI node is fine.1609Happy testing!1610Need explanation? See FAQ:1612=================================================1613Read up on the benefits of a dynamic test split with Knapsack Pro Queue Mode:1614https://docs.knapsackpro.com/2020/how-to-speed-up-ruby-and-javascript-tests-with-ci-parallelisation1615Sign up for Knapsack Pro here:1617=================================================1618[Sep 18 2023 03:20:11 UTC (QA Tests)] INFO -- 1619Knapsack global time execution for tests: 19m 41s1620Pending: (Failures listed here are expected and do not affect your suite's status)1621 1) Package SaaS Container Registry pushes project image to the container registry and deletes tag1622 # Test is not compatible with this environment or pipeline1623 # ./qa/specs/features/browser_ui/5_package/container_registry/saas/container_registry_spec.rb:491624 2) Configure AutoDevOps Templates using express template works with Auto DevOps1625 # Test is not compatible with this environment or pipeline1626 # ./qa/specs/features/browser_ui/7_configure/auto_devops/auto_devops_templates_spec.rb:471627Finished in 19 minutes 46 seconds (files took 2.29 seconds to load)162858 examples, 0 failures, 2 pending1629Randomized with seed 491471630[Sep 18 2023 03:20:12 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitlab-ce-408a76fb bash -c "gitlab-psql -c 'select n_live_tup, n_dead_tup, relname from pg_stat_all_tables order by n_live_tup DESC, n_dead_tup DESC;'"`1631[Sep 18 2023 03:20:12 UTC (Gitlab QA)] INFO -- Shell command: `docker exec gitlab-ce-408a76fb bash -c "gitlab-psql -c 'select * from pg_stat_user_tables;'"`1632[Sep 18 2023 03:20:12 UTC (Gitlab QA)] INFO -- Shell command: `docker ps -f name=gitlab-ce-408a76fb`1633[Sep 18 2023 03:20:12 UTC (Gitlab QA)] INFO -- Shell command: `docker rm -f gitlab-ce-408a76fb`1635Running after script...1636$ if [ "$CI_JOB_STATUS" == "failed" ]; then # collapsed multi-line command1637$ export BUNDLE_PREFIX=$([ "$RUN_WITH_BUNDLE" != "true" ] || echo "bundle exec")1638$ echo -e "\e[0Ksection_start:`date +%s`:report_results_section[collapsed=true]\r\e[0KReport results"1762Not uploading cache qa-e2e-ruby-3.0-a7315659c09a492e7e01a6e73f495ce6-16 due to policy1764Uploading artifacts...1765gitlab-qa-run-*: found 327 matching artifact files and directories 1766Uploading artifacts as "archive" to coordinator... 201 Created id=5107563359 responseStatus=201 Created token=64_27Fgs1767Uploading artifacts...1768gitlab-qa-run-*/**/rspec-*.xml: found 1 matching artifact files and directories 1769Uploading artifacts as "junit" to coordinator... 201 Created id=5107563359 responseStatus=201 Created token=64_27Fgs1770Uploading artifacts...1771/builds/gitlab-org/gitlab/suite_status.env: found 1 matching artifact files and directories 1772Uploading artifacts as "dotenv" to coordinator... 201 Created id=5107563359 responseStatus=201 Created token=64_27Fgs1774Job succeeded